* [PULL] Btrfs fixes, part 3
@ 2016-08-24 13:42 David Sterba
2016-08-24 21:14 ` Chris Mason
` (2 more replies)
0 siblings, 3 replies; 5+ messages in thread
From: David Sterba @ 2016-08-24 13:42 UTC (permalink / raw)
To: clm; +Cc: linux-btrfs, David Sterba
Hi,
this pull request contains part 2 and adds more that arrived in the meantime
(new fixes or updated versions of patches). Assorted fixes. Please pull,
thanks.
----------------------------------------------------------------
The following changes since commit 10838816547a28696ca10e038b3b32f2efec5a42:
Merge branch 'integration-4.8' of git://git.kernel.org/pub/scm/linux/kernel/git/fdmanana/linux into for-linus-4.8 (2016-08-05 12:25:05 -0700)
are available in the git repository at:
git://git.kernel.org/pub/scm/linux/kernel/git/kdave/linux.git for-chris-4.8
for you to fetch changes up to 79354fc603184885b50cf935b8b2085c2b3e0535:
Btrfs: fix lockdep warning on deadlock against an inode's log mutex (2016-08-24 14:54:42 +0200)
----------------------------------------------------------------
Alex Lyakas (1):
btrfs: flush_space: treat return value of do_chunk_alloc properly
Anand Jain (1):
btrfs: do not background blkdev_put()
Filipe Manana (1):
Btrfs: fix lockdep warning on deadlock against an inode's log mutex
Jeff Mahoney (3):
btrfs: properly track when rescan worker is running
btrfs: waiting on qgroup rescan should not always be interruptible
btrfs: don't create or leak aliased root while cleaning up orphans
Josef Bacik (2):
Btrfs: fix em leak in find_first_block_group
Btrfs: handle pending renames with recycled inodes properly
Liu Bo (6):
Btrfs: fix memory leak of reloc_root
Btrfs: add ASSERT for block group's memory leak
Btrfs: clarify do_chunk_alloc()'s return value
Btrfs: check btree node's nritems
Btrfs: detect corruption when non-root leaf has zero item
Btrfs: remove BUG() in raid56
Qu Wenruo (4):
btrfs: backref: Fix soft lockup in __merge_refs function
btrfs: qgroup: Refactor btrfs_qgroup_insert_dirty_extent()
btrfs: relocation: Fix leaking qgroups numbers on data extents
btrfs: qgroup: Fix qgroup incorrectness caused by log replay
Wang Xiaoguang (5):
btrfs: use correct offset for reloc_inode in prealloc_file_extent_cluster()
btrfs: divide btrfs_update_reserved_bytes() into two functions
btrfs: update btrfs_space_info's bytes_may_use timely
btrfs: should block unused block groups deletion work when allocating data space
btrfs: fix fsfreeze hang caused by delayed iputs deal
fs/btrfs/backref.c | 1 +
fs/btrfs/ctree.h | 7 +-
fs/btrfs/delayed-ref.c | 7 +-
fs/btrfs/disk-io.c | 69 ++++++++++++---
fs/btrfs/disk-io.h | 2 +
fs/btrfs/extent-tree.c | 227 ++++++++++++++++++++++++++-----------------------
fs/btrfs/extent_io.h | 1 +
fs/btrfs/file.c | 28 +++---
fs/btrfs/inode-map.c | 3 +-
fs/btrfs/inode.c | 37 +++++---
fs/btrfs/ioctl.c | 2 +-
fs/btrfs/qgroup.c | 62 +++++++++++---
fs/btrfs/qgroup.h | 36 ++++++--
fs/btrfs/raid56.c | 5 +-
fs/btrfs/relocation.c | 126 ++++++++++++++++++++++++---
fs/btrfs/root-tree.c | 27 ++++--
fs/btrfs/send.c | 36 ++++++--
fs/btrfs/super.c | 16 ++++
fs/btrfs/transaction.c | 7 +-
fs/btrfs/tree-log.c | 21 ++++-
fs/btrfs/tree-log.h | 5 +-
fs/btrfs/volumes.c | 69 ++++++++-------
22 files changed, 566 insertions(+), 228 deletions(-)
^ permalink raw reply [flat|nested] 5+ messages in thread* Re: [PULL] Btrfs fixes, part 3 2016-08-24 13:42 [PULL] Btrfs fixes, part 3 David Sterba @ 2016-08-24 21:14 ` Chris Mason 2016-08-25 6:14 ` Wang Xiaoguang 2016-08-25 10:54 ` Chris Mason 2 siblings, 0 replies; 5+ messages in thread From: Chris Mason @ 2016-08-24 21:14 UTC (permalink / raw) To: David Sterba; +Cc: linux-btrfs On Wed, Aug 24, 2016 at 03:42:54PM +0200, David Sterba wrote: >Hi, > >this pull request contains part 2 and adds more that arrived in the meantime >(new fixes or updated versions of patches). Assorted fixes. Please pull, >thanks. Thanks Dave, since this patch got turned into a v2: Btrfs: handle pending renames with recycled inodes properly I shuffled things a bit to leave it out. -chris ^ permalink raw reply [flat|nested] 5+ messages in thread
* Re: [PULL] Btrfs fixes, part 3 2016-08-24 13:42 [PULL] Btrfs fixes, part 3 David Sterba 2016-08-24 21:14 ` Chris Mason @ 2016-08-25 6:14 ` Wang Xiaoguang 2016-08-25 10:54 ` Chris Mason 2 siblings, 0 replies; 5+ messages in thread From: Wang Xiaoguang @ 2016-08-25 6:14 UTC (permalink / raw) To: David Sterba, clm; +Cc: linux-btrfs [-- Attachment #1: Type: text/plain, Size: 4151 bytes --] Hi david and chris, On 08/24/2016 09:42 PM, David Sterba wrote: > Hi, > > this pull request contains part 2 and adds more that arrived in the meantime > (new fixes or updated versions of patches). Assorted fixes. Please pull, > thanks. > > ---------------------------------------------------------------- > The following changes since commit 10838816547a28696ca10e038b3b32f2efec5a42: > > Merge branch 'integration-4.8' of git://git.kernel.org/pub/scm/linux/kernel/git/fdmanana/linux into for-linus-4.8 (2016-08-05 12:25:05 -0700) > > are available in the git repository at: > > git://git.kernel.org/pub/scm/linux/kernel/git/kdave/linux.git for-chris-4.8 > > for you to fetch changes up to 79354fc603184885b50cf935b8b2085c2b3e0535: > > Btrfs: fix lockdep warning on deadlock against an inode's log mutex (2016-08-24 14:54:42 +0200) > > ---------------------------------------------------------------- > Alex Lyakas (1): > btrfs: flush_space: treat return value of do_chunk_alloc properly > > Anand Jain (1): > btrfs: do not background blkdev_put() > > Filipe Manana (1): > Btrfs: fix lockdep warning on deadlock against an inode's log mutex > > Jeff Mahoney (3): > btrfs: properly track when rescan worker is running > btrfs: waiting on qgroup rescan should not always be interruptible > btrfs: don't create or leak aliased root while cleaning up orphans > > Josef Bacik (2): > Btrfs: fix em leak in find_first_block_group > Btrfs: handle pending renames with recycled inodes properly > > Liu Bo (6): > Btrfs: fix memory leak of reloc_root > Btrfs: add ASSERT for block group's memory leak > Btrfs: clarify do_chunk_alloc()'s return value > Btrfs: check btree node's nritems > Btrfs: detect corruption when non-root leaf has zero item > Btrfs: remove BUG() in raid56 > > Qu Wenruo (4): > btrfs: backref: Fix soft lockup in __merge_refs function > btrfs: qgroup: Refactor btrfs_qgroup_insert_dirty_extent() > btrfs: relocation: Fix leaking qgroups numbers on data extents > btrfs: qgroup: Fix qgroup incorrectness caused by log replay > > Wang Xiaoguang (5): > btrfs: use correct offset for reloc_inode in prealloc_file_extent_cluster() > btrfs: divide btrfs_update_reserved_bytes() into two functions > btrfs: update btrfs_space_info's bytes_may_use timely When I tested patch "btrfs: update btrfs_space_info's bytes_may_use timely", I forgot to run dm-flakey related fstests test cases: generic/056 generic/057 generic/059 generic/065 and generic/073, they will report a WARN about bytes_may_use, sorry. I prepared a patch to fix this issue, please see the attachment, with this patch, these 5 cases will pass. Regards, Xiaoguang Wang > btrfs: should block unused block groups deletion work when allocating data space > btrfs: fix fsfreeze hang caused by delayed iputs deal > > fs/btrfs/backref.c | 1 + > fs/btrfs/ctree.h | 7 +- > fs/btrfs/delayed-ref.c | 7 +- > fs/btrfs/disk-io.c | 69 ++++++++++++--- > fs/btrfs/disk-io.h | 2 + > fs/btrfs/extent-tree.c | 227 ++++++++++++++++++++++++++----------------------- > fs/btrfs/extent_io.h | 1 + > fs/btrfs/file.c | 28 +++--- > fs/btrfs/inode-map.c | 3 +- > fs/btrfs/inode.c | 37 +++++--- > fs/btrfs/ioctl.c | 2 +- > fs/btrfs/qgroup.c | 62 +++++++++++--- > fs/btrfs/qgroup.h | 36 ++++++-- > fs/btrfs/raid56.c | 5 +- > fs/btrfs/relocation.c | 126 ++++++++++++++++++++++++--- > fs/btrfs/root-tree.c | 27 ++++-- > fs/btrfs/send.c | 36 ++++++-- > fs/btrfs/super.c | 16 ++++ > fs/btrfs/transaction.c | 7 +- > fs/btrfs/tree-log.c | 21 ++++- > fs/btrfs/tree-log.h | 5 +- > fs/btrfs/volumes.c | 69 ++++++++------- > 22 files changed, 566 insertions(+), 228 deletions(-) > -- > To unsubscribe from this list: send the line "unsubscribe linux-btrfs" in > the body of a message to majordomo@vger.kernel.org > More majordomo info at http://vger.kernel.org/majordomo-info.html > > [-- Attachment #2: 0001-btrfs-do-not-decrease-bytes_may_use-when-replaying-e.patch --] [-- Type: text/x-patch, Size: 1701 bytes --] >From 37a68c327b8090ecf59e7019433638d7a569d3ab Mon Sep 17 00:00:00 2001 From: Wang Xiaoguang <wangxg.fnst@cn.fujitsu.com> Date: Thu, 25 Aug 2016 10:09:09 +0800 Subject: [PATCH] btrfs: do not decrease bytes_may_use when replaying extents When replaying extents, there is no need to update bytes_may_use in btrfs_alloc_logged_file_extent(), otherwise it'll trigger a WARN_ON about bytes_may_use. Fixes: ("btrfs: update btrfs_space_info's bytes_may_use timely") Signed-off-by: Wang Xiaoguang <wangxg.fnst@cn.fujitsu.com> --- fs/btrfs/extent-tree.c | 12 +++++++++--- 1 file changed, 9 insertions(+), 3 deletions(-) diff --git a/fs/btrfs/extent-tree.c b/fs/btrfs/extent-tree.c index ae8f9aa..7a15990 100644 --- a/fs/btrfs/extent-tree.c +++ b/fs/btrfs/extent-tree.c @@ -8242,6 +8242,7 @@ int btrfs_alloc_logged_file_extent(struct btrfs_trans_handle *trans, { int ret; struct btrfs_block_group_cache *block_group; + struct btrfs_space_info *space_info; /* * Mixed block groups will exclude before processing the log so we only @@ -8257,9 +8258,14 @@ int btrfs_alloc_logged_file_extent(struct btrfs_trans_handle *trans, if (!block_group) return -EINVAL; - ret = btrfs_add_reserved_bytes(block_group, ins->offset, - ins->offset, 0); - BUG_ON(ret); /* logic error */ + space_info = block_group->space_info; + spin_lock(&space_info->lock); + spin_lock(&block_group->lock); + space_info->bytes_reserved += ins->offset; + block_group->reserved += ins->offset; + spin_unlock(&block_group->lock); + spin_unlock(&space_info->lock); + ret = alloc_reserved_file_extent(trans, root, 0, root_objectid, 0, owner, offset, ins, 1); btrfs_put_block_group(block_group); -- 2.9.0 ^ permalink raw reply related [flat|nested] 5+ messages in thread
* Re: [PULL] Btrfs fixes, part 3 2016-08-24 13:42 [PULL] Btrfs fixes, part 3 David Sterba 2016-08-24 21:14 ` Chris Mason 2016-08-25 6:14 ` Wang Xiaoguang @ 2016-08-25 10:54 ` Chris Mason 2016-08-25 12:04 ` Wang Xiaoguang 2 siblings, 1 reply; 5+ messages in thread From: Chris Mason @ 2016-08-25 10:54 UTC (permalink / raw) To: David Sterba; +Cc: linux-btrfs On Wed, Aug 24, 2016 at 03:42:54PM +0200, David Sterba wrote: >Hi, > >this pull request contains part 2 and adds more that arrived in the meantime >(new fixes or updated versions of patches). Assorted fixes. Please pull, >thanks. Looks like this commit is deadlocking btrfs/071, I'm double checking with it removed: commit 9711669d602004f7658cf7fe003181de69e5ae6d Author: Wang Xiaoguang <wangxg.fnst@cn.fujitsu.com> Date: Wed Jul 27 13:50:21 2016 +0800 btrfs: should block unused block groups deletion work when allocating data space There's a lockdep splat: [ 400.354652] run fstests btrfs/013 at 2016-08-24 14:36:41 [ 400.939980] BTRFS: device fsid 6dd1d6e7-e6a7-4754-b1da-6ae12db06087 devid 1 transid 3 /dev/vdh [ 400.982129] BTRFS info (device vdh): disk space caching is enabled [ 400.983470] BTRFS info (device vdh): has skinny extents [ 400.984706] BTRFS info (device vdh): flagging fs with big metadata feature [ 400.993415] BTRFS info (device vdh): creating UUID tree [ 411.057401] BTRFS info (device vdh): relocating block group 29360128 flags 36 [ 411.080278] BTRFS info (device vdh): found 2 extents [ 411.092704] BTRFS info (device vdh): relocating block group 20971520 flags 34 [ 411.105887] BTRFS info (device vdh): found 1 extents [ 411.117528] BTRFS info (device vdh): relocating block group 12582912 flags 1 [ 411.119023] ============================================= [ 411.119283] [ INFO: possible recursive locking detected ] [ 411.119283] 4.8.0-rc3-13125-gff57150 #231 Not tainted [ 411.119283] --------------------------------------------- [ 411.119283] btrfs/12261 is trying to acquire lock: [ 411.119283] (&fs_info->bg_delete_sem){++++..}, at: [<ffffffffa0a2aeef>] btrfs_alloc_data_chunk_ondemand+0x9f/0x560 [btrfs] [ 411.119283] but task is already holding lock: [ 411.119283] (&fs_info->bg_delete_sem){++++..}, at: [<ffffffffa0a727e4>] __btrfs_balance+0x374/0xe70 [btrfs] [ 411.119283] other info that might help us debug this: [ 411.119283] Possible unsafe locking scenario: [ 411.119283] CPU0 [ 411.119283] ---- [ 411.119283] lock(&fs_info->bg_delete_sem); [ 411.119283] lock(&fs_info->bg_delete_sem); [ 411.119283] *** DEADLOCK *** [ 411.119283] May be due to missing lock nesting notation [ 411.119283] 6 locks held by btrfs/12261: [ 411.119283] #0: (sb_writers#9){.+.+.+}, at: [<ffffffff8122f273>] __sb_start_write+0xd3/0xf0 [ 411.119283] #1: (&fs_info->volume_mutex){+.+.+.}, at: [<ffffffffa0a7db28>] btrfs_ioctl_balance+0x118/0x370 [btrfs] [ 411.119283] #2: (&fs_info->bg_delete_sem){++++..}, at: [<ffffffffa0a727e4>] __btrfs_balance+0x374/0xe70 [btrfs] [ 411.119283] #3: (&fs_info->cleaner_mutex){+.+...}, at: [<ffffffffa0aa620f>] btrfs_relocate_block_group+0x17f/0x2a0 [btrfs] [ 411.119283] #4: (sb_internal){.+.+.+}, at: [<ffffffff8122f231>] __sb_start_write+0x91/0xf0 [ 411.119283] #5: (&cur_trans->cache_write_mutex){+.+...}, at: [<ffffffffa0a2bf3c>] btrfs_start_dirty_block_groups+0x1ac/0x550 [btrfs] [ 411.119283] stack backtrace: [ 411.119283] CPU: 6 PID: 12261 Comm: btrfs Not tainted 4.8.0-rc3-13125-gff57150 #231 [ 411.119283] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.0-1.fc24 04/01/2014 [ 411.119283] 0000000000000000 ffff880fd72371f8 ffffffff8149def7 0000000000000007 [ 411.119283] 0000000000000006 ffffffff8256a580 ffff880fe67a5d00 ffff880fd72372f8 [ 411.119283] ffffffff810c6a4b ffff880fd7237308 0000000000000046 ffff880fe67a6580 [ 411.119283] Call Trace: [ 411.119283] [<ffffffff8149def7>] dump_stack+0x6b/0xa4 [ 411.119283] [<ffffffff810c6a4b>] __lock_acquire+0x73b/0x1800 [ 411.119283] [<ffffffffa0a0cc5a>] ? btrfs_free_path+0x2a/0x40 [btrfs] [ 411.119283] [<ffffffffa0a0cc5a>] ? btrfs_free_path+0x2a/0x40 [btrfs] [ 411.119283] [<ffffffff814bcb47>] ? debug_smp_processor_id+0x17/0x20 [ 411.119283] [<ffffffff810c7bc9>] lock_acquire+0xb9/0x290 [ 411.119283] [<ffffffffa0a2aeef>] ? btrfs_alloc_data_chunk_ondemand+0x9f/0x560 [btrfs] [ 411.119283] [<ffffffffa0a2aedb>] ? btrfs_alloc_data_chunk_ondemand+0x8b/0x560 [btrfs] [ 411.119283] [<ffffffff81992574>] down_read+0x34/0x60 [ 411.119283] [<ffffffffa0a2aeef>] ? btrfs_alloc_data_chunk_ondemand+0x9f/0x560 [btrfs] [ 411.119283] [<ffffffff819942d5>] ? _raw_spin_unlock+0x35/0x60 [ 411.119283] [<ffffffffa0a2aeef>] btrfs_alloc_data_chunk_ondemand+0x9f/0x560 [btrfs] [ 411.119283] [<ffffffffa0a2b619>] ? cache_save_setup+0x1f9/0x390 [btrfs] [ 411.119283] [<ffffffffa0a2b3f8>] btrfs_check_data_free_space+0x48/0x70 [btrfs] [ 411.119283] [<ffffffffa0a2b659>] cache_save_setup+0x239/0x390 [btrfs] [ 411.119283] [<ffffffffa0a2c027>] btrfs_start_dirty_block_groups+0x297/0x550 [btrfs] [ 411.119283] [<ffffffff810c5f91>] ? trace_hardirqs_on_caller+0x101/0x1d0 [ 411.119283] [<ffffffff810c5cbe>] ? mark_held_locks+0x6e/0x90 [ 411.119283] [<ffffffff8198ff7a>] ? __mutex_unlock_slowpath+0x10a/0x1b0 [ 411.119283] [<ffffffff810c5f91>] ? trace_hardirqs_on_caller+0x101/0x1d0 [ 411.119283] [<ffffffff8198ff63>] ? __mutex_unlock_slowpath+0xf3/0x1b0 [ 411.119283] [<ffffffffa0a40a4d>] btrfs_commit_transaction+0x16d/0xd80 [btrfs] [ 411.119283] [<ffffffff814bcb23>] ? __this_cpu_preempt_check+0x13/0x20 [ 411.119283] [<ffffffff810c11a8>] ? percpu_down_read_trylock+0x48/0xa0 [ 411.119283] [<ffffffff8122f231>] ? __sb_start_write+0x91/0xf0 [ 411.119283] [<ffffffff8122f231>] ? __sb_start_write+0x91/0xf0 [ 411.119283] [<ffffffffa0a41b8b>] ? start_transaction+0xab/0x4b0 [btrfs] [ 411.119283] [<ffffffffa0a9e8d4>] prepare_to_relocate+0xe4/0x110 [btrfs] [ 411.119283] [<ffffffffa0aa5337>] relocate_block_group+0x47/0x7a0 [btrfs] [ 411.119283] [<ffffffff810c606d>] ? trace_hardirqs_on+0xd/0x10 [ 411.119283] [<ffffffff81990791>] ? mutex_lock_nested+0x2b1/0x400 [ 411.119283] [<ffffffffa0aa620f>] ? btrfs_relocate_block_group+0x17f/0x2a0 [btrfs] [ 411.119283] [<ffffffff810c0f23>] ? up_write+0x23/0x50 [ 411.119283] [<ffffffffa0aa6217>] btrfs_relocate_block_group+0x187/0x2a0 [btrfs] [ 411.119283] [<ffffffffa0a71afa>] btrfs_relocate_chunk+0x8a/0x120 [btrfs] [ 411.119283] [<ffffffffa0a72ee7>] __btrfs_balance+0xa77/0xe70 [btrfs] [ 411.119283] [<ffffffff8198ff63>] ? __mutex_unlock_slowpath+0xf3/0x1b0 [ 411.119283] [<ffffffffa0a736d9>] btrfs_balance+0x3f9/0x690 [btrfs] [ 411.119283] [<ffffffffa0a7dd33>] ? btrfs_ioctl_balance+0x323/0x370 [btrfs] [ 411.119283] [<ffffffff810dcb8f>] ? rcu_read_lock_sched_held+0x4f/0x90 [ 411.119283] [<ffffffffa0a7d9ff>] ? kzalloc+0xf/0x20 [btrfs] [ 411.119283] [<ffffffffa0a7dd33>] btrfs_ioctl_balance+0x323/0x370 [btrfs] [ 411.119283] [<ffffffff8198df11>] ? __schedule+0x341/0xc00 [ 411.119283] [<ffffffff81994287>] ? _raw_spin_unlock_irqrestore+0x67/0x80 [ 411.119283] [<ffffffffa0a852ab>] btrfs_ioctl+0x60b/0x1460 [btrfs] [ 411.119283] [<ffffffff8112cfde>] ? __audit_syscall_entry+0xae/0x110 [ 411.119283] [<ffffffff810f2e2f>] ? current_kernel_time64+0x9f/0xb0 [ 411.119283] [<ffffffff810c5f91>] ? trace_hardirqs_on_caller+0x101/0x1d0 [ 411.119283] [<ffffffff810c606d>] ? trace_hardirqs_on+0xd/0x10 [ 411.119283] [<ffffffff8112cfde>] ? __audit_syscall_entry+0xae/0x110 [ 411.119283] [<ffffffff81240c38>] vfs_ioctl+0x18/0x30 [ 411.119283] [<ffffffff8124135e>] do_vfs_ioctl+0x8e/0x670 [ 411.119283] [<ffffffff8112cfde>] ? __audit_syscall_entry+0xae/0x110 [ 411.119283] [<ffffffff8112d268>] ? __audit_syscall_exit+0x228/0x2b0 [ 411.119283] [<ffffffff810024c3>] ? syscall_trace_enter+0x213/0x3e0 [ 411.119283] [<ffffffff812419d2>] SyS_ioctl+0x92/0xa0 [ 411.119283] [<ffffffff81003013>] do_syscall_64+0x63/0x130 [ 411.119283] [<ffffffff8100201a>] ? trace_hardirqs_on_thunk+0x1a/0x1c [ 411.119283] [<ffffffff8199451a>] entry_SYSCALL64_slow_path+0x25/0x25 But we make it through btrfs/013 up to btrfs/071 and then: [ 1721.312198] INFO: task btrfs-cleaner:28544 blocked for more than 120 seconds. [ 1721.312995] Tainted: G W 4.8.0-rc3-13125-gff57150 #231 [ 1721.313710] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1721.315255] btrfs-cleaner D ffff880fd6753b28 0 28544 2 0x00000080 [ 1721.316148] ffff880fd6753b28 0000000000000046 0000000000000046 0000000000000000 [ 1721.316989] 0000000000000246 ffff880f12bdc5c0 ffff880fe476c5c0 0000000000000000 [ 1721.317832] ffff880fdb48c500 0000000000000282 0000000000000282 0000000000000000 [ 1721.318695] Call Trace: [ 1721.318857] [<ffffffff810c606d>] ? trace_hardirqs_on+0xd/0x10 [ 1721.319445] [<ffffffff8198eaba>] schedule+0x4a/0xc0 [ 1721.319945] [<ffffffffa0a3f07d>] wait_current_trans+0xbd/0x130 [btrfs] [ 1721.320629] [<ffffffff810b97f0>] ? woken_wake_function+0x20/0x20 [ 1721.321308] [<ffffffff8122f273>] ? __sb_start_write+0xd3/0xf0 [ 1721.321884] [<ffffffffa0a41dca>] start_transaction+0x2ea/0x4b0 [btrfs] [ 1721.322593] [<ffffffffa0a422d8>] btrfs_start_transaction+0x18/0x20 [btrfs] [ 1721.323329] [<ffffffffa0a423ce>] btrfs_start_transaction_fallback_global_rsv+0x2e/0xe0 [btrfs] [ 1721.324276] [<ffffffffa0a182a4>] btrfs_start_trans_remove_block_group+0x84/0xc0 [btrfs] [ 1721.325140] [<ffffffffa0a1e6ac>] btrfs_delete_unused_bgs+0x1fc/0x520 [btrfs] [ 1721.325856] [<ffffffff8198ff63>] ? __mutex_unlock_slowpath+0xf3/0x1b0 [ 1721.326613] [<ffffffffa0a36400>] cleaner_kthread+0x1a0/0x1e0 [btrfs] [ 1721.327301] [<ffffffffa0a36260>] ? btree_readpage+0x30/0x30 [btrfs] [ 1721.327929] [<ffffffff8109058e>] kthread+0xde/0x100 [ 1721.328413] [<ffffffff8109b015>] ? schedule_tail+0x35/0xf0 [ 1721.328979] [<ffffffff8199467f>] ret_from_fork+0x1f/0x40 [ 1721.329526] [<ffffffff810904b0>] ? __init_kthread_worker+0x70/0x70 [ 1721.330165] INFO: lockdep is turned off. [ 1721.330499] INFO: task btrfs-transacti:28545 blocked for more than 120 seconds. [ 1721.331254] Tainted: G W 4.8.0-rc3-13125-gff57150 #231 [ 1721.331971] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1721.332804] btrfs-transacti D ffff880fd70bfc88 0 28545 2 0x00000080 [ 1721.333571] ffff880fd70bfc88 0000000000000046 0000000000000046 0000000000000000 [ 1721.334411] 0000000000000246 ffff880f12bddd00 ffff880fe84c0000 ffff880f00000000 [ 1721.335299] ffff880fdb48c500 0000000000000282 0000000000000282 0000000000000000 [ 1721.336139] Call Trace: [ 1721.336298] [<ffffffff810c606d>] ? trace_hardirqs_on+0xd/0x10 [ 1721.336855] [<ffffffff8198eaba>] schedule+0x4a/0xc0 [ 1721.337348] [<ffffffffa0a3f07d>] wait_current_trans+0xbd/0x130 [btrfs] [ 1721.338076] [<ffffffff810b97f0>] ? woken_wake_function+0x20/0x20 [ 1721.338684] [<ffffffffa0a41d3a>] start_transaction+0x25a/0x4b0 [btrfs] [ 1721.339377] [<ffffffffa0a41fa7>] btrfs_attach_transaction+0x17/0x20 [btrfs] [ 1721.340312] [<ffffffffa0a3987d>] transaction_kthread+0x19d/0x210 [btrfs] [ 1721.341142] [<ffffffffa0a396e0>] ? close_ctree+0x380/0x380 [btrfs] [ 1721.341757] [<ffffffff8109058e>] kthread+0xde/0x100 [ 1721.342406] [<ffffffff8109b015>] ? schedule_tail+0x35/0xf0 [ 1721.343047] [<ffffffff8199467f>] ret_from_fork+0x1f/0x40 [ 1721.343553] [<ffffffff810904b0>] ? __init_kthread_worker+0x70/0x70 [ 1721.344243] INFO: lockdep is turned off. [ 1721.344582] INFO: task fsstress:28551 blocked for more than 120 seconds. [ 1721.345270] Tainted: G W 4.8.0-rc3-13125-gff57150 #231 [ 1721.345947] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1721.346757] fsstress D ffff880fd777fc78 0 28551 28548 0x00000080 [ 1721.347590] ffff880fd777fc78 0000000000000046 0000000000000046 0000000000000000 [ 1721.348506] 0000000000000246 ffff880ef7835d00 ffff880fe84845c0 0000000000000000 [ 1721.349349] ffff880fdb48c500 0000000000000286 0000000000000286 0000000000000000 [ 1721.350243] Call Trace: [ 1721.350404] [<ffffffff810c606d>] ? trace_hardirqs_on+0xd/0x10 [ 1721.350970] [<ffffffff8198eaba>] schedule+0x4a/0xc0 [ 1721.351474] [<ffffffffa0a3f07d>] wait_current_trans+0xbd/0x130 [btrfs] [ 1721.352178] [<ffffffff810b97f0>] ? woken_wake_function+0x20/0x20 [ 1721.352775] [<ffffffff819900de>] ? mutex_unlock+0xe/0x10 [ 1721.353349] [<ffffffffa0a41d3a>] start_transaction+0x25a/0x4b0 [btrfs] [ 1721.354050] [<ffffffff81992d15>] ? rwsem_down_read_failed+0xc5/0x120 [ 1721.354682] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 [ 1721.355368] [<ffffffffa0a424a7>] btrfs_attach_transaction_barrier+0x27/0x60 [btrfs] [ 1721.356210] [<ffffffffa0a02d6a>] btrfs_sync_fs+0x7a/0x250 [btrfs] [ 1721.356813] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 [ 1721.357489] [<ffffffff81269210>] sync_fs_one_sb+0x20/0x30 [ 1721.358132] [<ffffffff8122fe3f>] iterate_supers+0xaf/0xe0 [ 1721.358889] [<ffffffff81269705>] sys_sync+0x55/0x90 [ 1721.359428] [<ffffffff81003013>] do_syscall_64+0x63/0x130 [ 1721.360058] [<ffffffff8100201a>] ? trace_hardirqs_on_thunk+0x1a/0x1c [ 1721.360696] [<ffffffff8199451a>] entry_SYSCALL64_slow_path+0x25/0x25 [ 1721.361414] INFO: lockdep is turned off. [ 1721.361751] INFO: task fsstress:28552 blocked for more than 120 seconds. [ 1721.362445] Tainted: G W 4.8.0-rc3-13125-gff57150 #231 [ 1721.363210] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1721.364051] fsstress D ffff880fdb077c78 0 28552 28548 0x00000080 [ 1721.364793] ffff880fdb077c78 0000000000000046 0000000000000046 0000000000000000 [ 1721.365653] 0000000000000246 ffff880ef7830000 ffff880fe84a0000 0000000000000000 [ 1721.366508] ffff880fdb48c500 0000000000000286 0000000000000286 0000000000000000 [ 1721.367362] Call Trace: [ 1721.367521] [<ffffffff810c606d>] ? trace_hardirqs_on+0xd/0x10 [ 1721.368112] [<ffffffff8198eaba>] schedule+0x4a/0xc0 [ 1721.368588] [<ffffffffa0a3f07d>] wait_current_trans+0xbd/0x130 [btrfs] [ 1721.369280] [<ffffffff810b97f0>] ? woken_wake_function+0x20/0x20 [ 1721.369867] [<ffffffff819900de>] ? mutex_unlock+0xe/0x10 [ 1721.370502] [<ffffffffa0a41d3a>] start_transaction+0x25a/0x4b0 [btrfs] [ 1721.371221] [<ffffffff81992d15>] ? rwsem_down_read_failed+0xc5/0x120 [ 1721.371846] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 [ 1721.372534] [<ffffffffa0a424a7>] btrfs_attach_transaction_barrier+0x27/0x60 [btrfs] [ 1721.373372] [<ffffffffa0a02d6a>] btrfs_sync_fs+0x7a/0x250 [btrfs] [ 1721.373986] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 [ 1721.374649] [<ffffffff81269210>] sync_fs_one_sb+0x20/0x30 [ 1721.375291] [<ffffffff8122fe3f>] iterate_supers+0xaf/0xe0 [ 1721.375811] [<ffffffff81269705>] sys_sync+0x55/0x90 [ 1721.376305] [<ffffffff81003013>] do_syscall_64+0x63/0x130 [ 1721.376832] [<ffffffff8100201a>] ? trace_hardirqs_on_thunk+0x1a/0x1c [ 1721.377503] [<ffffffff8199451a>] entry_SYSCALL64_slow_path+0x25/0x25 [ 1721.378222] INFO: lockdep is turned off. [ 1721.378558] INFO: task fsstress:28553 blocked for more than 120 seconds. [ 1721.379246] Tainted: G W 4.8.0-rc3-13125-gff57150 #231 [ 1721.379914] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1721.380764] fsstress D ffff880f198efc78 0 28553 28548 0x00000080 [ 1721.381599] ffff880f198efc78 0000000000000046 0000000000000046 0000000000000000 [ 1721.382452] 0000000000000246 ffff880ef7832e80 ffff880f03029740 0000000000000000 [ 1721.383302] ffff880fdb48c500 0000000000000286 0000000000000286 0000000000000000 [ 1721.384209] Call Trace: [ 1721.384368] [<ffffffff810c606d>] ? trace_hardirqs_on+0xd/0x10 [ 1721.384932] [<ffffffff8198eaba>] schedule+0x4a/0xc0 [ 1721.385436] [<ffffffffa0a3f07d>] wait_current_trans+0xbd/0x130 [btrfs] [ 1721.386135] [<ffffffff810b97f0>] ? woken_wake_function+0x20/0x20 [ 1721.386723] [<ffffffff819900de>] ? mutex_unlock+0xe/0x10 [ 1721.387338] [<ffffffffa0a41d3a>] start_transaction+0x25a/0x4b0 [btrfs] [ 1721.388049] [<ffffffff81992d15>] ? rwsem_down_read_failed+0xc5/0x120 [ 1721.388675] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 [ 1721.389361] [<ffffffffa0a424a7>] btrfs_attach_transaction_barrier+0x27/0x60 [btrfs] [ 1721.390257] [<ffffffffa0a02d6a>] btrfs_sync_fs+0x7a/0x250 [btrfs] [ 1721.390875] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 [ 1721.391555] [<ffffffff81269210>] sync_fs_one_sb+0x20/0x30 [ 1721.392115] [<ffffffff8122fe3f>] iterate_supers+0xaf/0xe0 [ 1721.392636] [<ffffffff81269705>] sys_sync+0x55/0x90 [ 1721.393192] [<ffffffff81003013>] do_syscall_64+0x63/0x130 [ 1721.393710] [<ffffffff8100201a>] ? trace_hardirqs_on_thunk+0x1a/0x1c [ 1721.394376] [<ffffffff8199451a>] entry_SYSCALL64_slow_path+0x25/0x25 [ 1721.395038] INFO: lockdep is turned off. [ 1721.395378] INFO: task fsstress:28554 blocked for more than 120 seconds. [ 1721.396076] Tainted: G W 4.8.0-rc3-13125-gff57150 #231 [ 1721.396742] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1721.397572] fsstress D ffff880fd4953c78 0 28554 28548 0x00000080 [ 1721.398360] ffff880fd4953c78 0000000000000046 0000000000000046 0000000000000000 [ 1721.399295] 0000000000000246 ffff880ef7831740 ffff880fe2fb8000 0000000000000002 [ 1721.400162] ffff880fdb48c500 0000000000000286 0000000000000286 0000000000000000 [ 1721.400983] Call Trace: [ 1721.401180] [<ffffffff810c606d>] ? trace_hardirqs_on+0xd/0x10 [ 1721.401739] [<ffffffff8198eaba>] schedule+0x4a/0xc0 [ 1721.402323] [<ffffffffa0a3f07d>] wait_current_trans+0xbd/0x130 [btrfs] [ 1721.402992] [<ffffffff810b97f0>] ? woken_wake_function+0x20/0x20 [ 1721.403613] [<ffffffff819900de>] ? mutex_unlock+0xe/0x10 [ 1721.404171] [<ffffffffa0a41d3a>] start_transaction+0x25a/0x4b0 [btrfs] [ 1721.404824] [<ffffffff81992d15>] ? rwsem_down_read_failed+0xc5/0x120 [ 1721.405548] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 [ 1721.406251] [<ffffffffa0a424a7>] btrfs_attach_transaction_barrier+0x27/0x60 [btrfs] [ 1721.407094] [<ffffffffa0a02d6a>] btrfs_sync_fs+0x7a/0x250 [btrfs] [ 1721.407694] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 [ 1721.408427] [<ffffffff81269210>] sync_fs_one_sb+0x20/0x30 [ 1721.408954] [<ffffffff8122fe3f>] iterate_supers+0xaf/0xe0 [ 1721.409497] [<ffffffff81269705>] sys_sync+0x55/0x90 [ 1721.409958] [<ffffffff81003013>] do_syscall_64+0x63/0x130 [ 1721.410502] [<ffffffff8100201a>] ? trace_hardirqs_on_thunk+0x1a/0x1c [ 1721.411219] [<ffffffff8199451a>] entry_SYSCALL64_slow_path+0x25/0x25 [ 1721.411856] INFO: lockdep is turned off. [ 1721.412285] INFO: task fsstress:28555 blocked for more than 120 seconds. [ 1721.412964] Tainted: G W 4.8.0-rc3-13125-gff57150 #231 [ 1721.413667] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1721.414506] fsstress D ffff880fc5f93898 0 28555 28548 0x00000080 [ 1721.415408] ffff880fc5f93898 0000000000000000 0000000000000000 ffff880fc5f938c8 [ 1721.416280] 0000000000000046 ffff880ef78345c0 ffff880fe2fbdd00 ffff880f00000000 [ 1721.417137] 0000000000000000 0000000000000246 ffffffff00000000 0000000000000000 [ 1721.417961] Call Trace: [ 1721.418156] [<ffffffff8198eaba>] schedule+0x4a/0xc0 [ 1721.418614] [<ffffffff810c606d>] ? trace_hardirqs_on+0xd/0x10 [ 1721.419206] [<ffffffff819941fb>] ? _raw_spin_unlock_irq+0x3b/0x60 [ 1721.419813] [<ffffffff81992d15>] rwsem_down_read_failed+0xc5/0x120 [ 1721.420560] [<ffffffff814aceb8>] call_rwsem_down_read_failed+0x18/0x30 [ 1721.421261] [<ffffffff81992582>] down_read+0x42/0x60 [ 1721.421763] [<ffffffffa0a2aeef>] ? btrfs_alloc_data_chunk_ondemand+0x9f/0x560 [btrfs] [ 1721.422606] [<ffffffff819942d5>] ? _raw_spin_unlock+0x35/0x60 [ 1721.423212] [<ffffffffa0a2aeef>] btrfs_alloc_data_chunk_ondemand+0x9f/0x560 [btrfs] [ 1721.424070] [<ffffffffa0a9470d>] ? btrfs_truncate_free_space_cache+0x17d/0x1d0 [btrfs] [ 1721.424901] [<ffffffffa0a2b3f8>] btrfs_check_data_free_space+0x48/0x70 [btrfs] [ 1721.425779] [<ffffffffa0a2b659>] cache_save_setup+0x239/0x390 [btrfs] [ 1721.426486] [<ffffffffa0a6b564>] ? free_extent_buffer+0x44/0xb0 [btrfs] [ 1721.427198] [<ffffffffa0a2b875>] btrfs_setup_space_cache+0xc5/0xe0 [btrfs] [ 1721.427909] [<ffffffffa0a3e0ca>] commit_cowonly_roots+0xfa/0x310 [btrfs] [ 1721.428706] [<ffffffffa0a3dfb4>] ? commit_fs_roots+0x1b4/0x1d0 [btrfs] [ 1721.429426] [<ffffffffa0aba38a>] ? btrfs_qgroup_account_extents+0x4a/0x270 [btrfs] [ 1721.430265] [<ffffffffa0a40ec8>] btrfs_commit_transaction+0x5e8/0xd80 [btrfs] [ 1721.431092] [<ffffffff812065e4>] ? kmem_cache_alloc+0x1f4/0x320 [ 1721.431685] [<ffffffffa0a41c0a>] ? start_transaction+0x12a/0x4b0 [btrfs] [ 1721.432391] [<ffffffff819900de>] ? mutex_unlock+0xe/0x10 [ 1721.432911] [<ffffffffa0a41b8b>] ? start_transaction+0xab/0x4b0 [btrfs] [ 1721.433610] [<ffffffff81992d15>] ? rwsem_down_read_failed+0xc5/0x120 [ 1721.434349] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 [ 1721.434994] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 [ 1721.435667] [<ffffffffa0a02d81>] btrfs_sync_fs+0x91/0x250 [btrfs] [ 1721.436318] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 [ 1721.437040] [<ffffffff81269210>] sync_fs_one_sb+0x20/0x30 [ 1721.437563] [<ffffffff8122fe3f>] iterate_supers+0xaf/0xe0 [ 1721.438115] [<ffffffff81269705>] sys_sync+0x55/0x90 [ 1721.438570] [<ffffffff81003013>] do_syscall_64+0x63/0x130 [ 1721.439123] [<ffffffff8100201a>] ? trace_hardirqs_on_thunk+0x1a/0x1c [ 1721.439758] [<ffffffff8199451a>] entry_SYSCALL64_slow_path+0x25/0x25 [ 1721.440669] INFO: lockdep is turned off. [ 1721.441200] INFO: task fsstress:28556 blocked for more than 120 seconds. [ 1721.442201] Tainted: G W 4.8.0-rc3-13125-gff57150 #231 [ 1721.443187] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1721.444087] fsstress D ffff880fd9c7bc78 0 28556 28548 0x00000080 [ 1721.444842] ffff880fd9c7bc78 0000000000000046 0000000000000046 0000000000000000 [ 1721.445707] 0000000000000246 ffff880fe2fbae80 ffff880ef7832e80 0000000000000000 [ 1721.446568] ffff880fdb48c500 0000000000000286 0000000000000286 0000000000000000 [ 1721.447466] Call Trace: [ 1721.447626] [<ffffffff810c606d>] ? trace_hardirqs_on+0xd/0x10 [ 1721.448208] [<ffffffff8198eaba>] schedule+0x4a/0xc0 [ 1721.448674] [<ffffffffa0a3f07d>] wait_current_trans+0xbd/0x130 [btrfs] [ 1721.449349] [<ffffffff810b97f0>] ? woken_wake_function+0x20/0x20 [ 1721.449913] [<ffffffff819900de>] ? mutex_unlock+0xe/0x10 [ 1721.450454] [<ffffffffa0a41d3a>] start_transaction+0x25a/0x4b0 [btrfs] [ 1721.451119] [<ffffffff81992d15>] ? rwsem_down_read_failed+0xc5/0x120 [ 1721.451727] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 [ 1721.452506] [<ffffffffa0a424a7>] btrfs_attach_transaction_barrier+0x27/0x60 [btrfs] [ 1721.453556] [<ffffffffa0a02d6a>] btrfs_sync_fs+0x7a/0x250 [btrfs] [ 1721.454227] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 [ 1721.454868] [<ffffffff81269210>] sync_fs_one_sb+0x20/0x30 [ 1721.455431] [<ffffffff8122fe3f>] iterate_supers+0xaf/0xe0 [ 1721.455959] [<ffffffff81269705>] sys_sync+0x55/0x90 [ 1721.456450] [<ffffffff81003013>] do_syscall_64+0x63/0x130 [ 1721.456982] [<ffffffff8100201a>] ? trace_hardirqs_on_thunk+0x1a/0x1c [ 1721.457653] [<ffffffff8199451a>] entry_SYSCALL64_slow_path+0x25/0x25 [ 1721.458327] INFO: lockdep is turned off. [ 1721.458666] INFO: task fsstress:28557 blocked for more than 120 seconds. [ 1721.459371] Tainted: G W 4.8.0-rc3-13125-gff57150 #231 [ 1721.460173] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1721.461042] fsstress D ffff880f18f67c78 0 28557 28548 0x00000080 [ 1721.461798] ffff880f18f67c78 0000000000000046 0000000000000046 0000000000000000 [ 1721.462663] 0000000000000246 ffff880fe2fb9740 ffff880ef7830000 0000000000000000 [ 1721.463523] ffff880fdb48c500 0000000000000286 0000000000000286 0000000000000000 [ 1721.464393] Call Trace: [ 1721.464553] [<ffffffff810c606d>] ? trace_hardirqs_on+0xd/0x10 [ 1721.465225] [<ffffffff8198eaba>] schedule+0x4a/0xc0 [ 1721.465726] [<ffffffffa0a3f07d>] wait_current_trans+0xbd/0x130 [btrfs] [ 1721.466427] [<ffffffff810b97f0>] ? woken_wake_function+0x20/0x20 [ 1721.467059] [<ffffffff819900de>] ? mutex_unlock+0xe/0x10 [ 1721.467587] [<ffffffffa0a41d3a>] start_transaction+0x25a/0x4b0 [btrfs] [ 1721.468365] [<ffffffff81992d15>] ? rwsem_down_read_failed+0xc5/0x120 [ 1721.469042] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 [ 1721.469703] [<ffffffffa0a424a7>] btrfs_attach_transaction_barrier+0x27/0x60 [btrfs] [ 1721.470552] [<ffffffffa0a02d6a>] btrfs_sync_fs+0x7a/0x250 [btrfs] [ 1721.471280] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 [ 1721.471947] [<ffffffff81269210>] sync_fs_one_sb+0x20/0x30 [ 1721.472502] [<ffffffff8122fe3f>] iterate_supers+0xaf/0xe0 [ 1721.473066] [<ffffffff81269705>] sys_sync+0x55/0x90 [ 1721.473528] [<ffffffff81003013>] do_syscall_64+0x63/0x130 [ 1721.474141] [<ffffffff8100201a>] ? trace_hardirqs_on_thunk+0x1a/0x1c [ 1721.474802] [<ffffffff8199451a>] entry_SYSCALL64_slow_path+0x25/0x25 [ 1721.475475] INFO: lockdep is turned off. [ 1721.475815] INFO: task fsstress:28558 blocked for more than 120 seconds. [ 1721.476521] Tainted: G W 4.8.0-rc3-13125-gff57150 #231 [ 1721.477316] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 1721.478166] fsstress D ffff880fdb39bc78 0 28558 28548 0x00000080 [ 1721.478928] ffff880fdb39bc78 0000000000000046 0000000000000046 0000000000000000 [ 1721.479791] 0000000000000246 ffff880fe2fb8000 ffff880fe5c31740 0000000000000000 [ 1721.480730] ffff880fdb48c500 0000000000000286 0000000000000286 0000000000000000 [ 1721.481600] Call Trace: [ 1721.481760] [<ffffffff810c606d>] ? trace_hardirqs_on+0xd/0x10 [ 1721.482366] [<ffffffff8198eaba>] schedule+0x4a/0xc0 [ 1721.482846] [<ffffffffa0a3f07d>] wait_current_trans+0xbd/0x130 [btrfs] [ 1721.483620] [<ffffffff810b97f0>] ? woken_wake_function+0x20/0x20 [ 1721.484260] [<ffffffff819900de>] ? mutex_unlock+0xe/0x10 [ 1721.484794] [<ffffffffa0a41d3a>] start_transaction+0x25a/0x4b0 [btrfs] [ 1721.485496] [<ffffffff81992d15>] ? rwsem_down_read_failed+0xc5/0x120 [ 1721.486232] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 [ 1721.486917] [<ffffffffa0a424a7>] btrfs_attach_transaction_barrier+0x27/0x60 [btrfs] [ 1721.487769] [<ffffffffa0a02d6a>] btrfs_sync_fs+0x7a/0x250 [btrfs] [ 1721.488427] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 [ 1721.489177] [<ffffffff81269210>] sync_fs_one_sb+0x20/0x30 [ 1721.489706] [<ffffffff8122fe3f>] iterate_supers+0xaf/0xe0 [ 1721.490268] [<ffffffff81269705>] sys_sync+0x55/0x90 [ 1721.490733] [<ffffffff81003013>] do_syscall_64+0x63/0x130 [ 1721.491289] [<ffffffff8100201a>] ? trace_hardirqs_on_thunk+0x1a/0x1c [ 1721.491935] [<ffffffff8199451a>] entry_SYSCALL64_slow_path+0x25/0x25 ^ permalink raw reply [flat|nested] 5+ messages in thread
* Re: [PULL] Btrfs fixes, part 3 2016-08-25 10:54 ` Chris Mason @ 2016-08-25 12:04 ` Wang Xiaoguang 0 siblings, 0 replies; 5+ messages in thread From: Wang Xiaoguang @ 2016-08-25 12:04 UTC (permalink / raw) To: Chris Mason, David Sterba, linux-btrfs Hi david and chris, On 08/25/2016 06:54 PM, Chris Mason wrote: > On Wed, Aug 24, 2016 at 03:42:54PM +0200, David Sterba wrote: >> Hi, >> >> this pull request contains part 2 and adds more that arrived in the >> meantime >> (new fixes or updated versions of patches). Assorted fixes. Please pull, >> thanks. > > Looks like this commit is deadlocking btrfs/071, I'm double checking > with it removed: > > commit 9711669d602004f7658cf7fe003181de69e5ae6d > Author: Wang Xiaoguang <wangxg.fnst@cn.fujitsu.com> > Date: Wed Jul 27 13:50:21 2016 +0800 > > btrfs: should block unused block groups deletion work when > allocating data space I've reproduced this issue when running btrfs/071 multiple times, sorry again. Also I have known the reason, currently please ignore this patch. Regards, Xiaoguang Wang > > There's a lockdep splat: > > [ 400.354652] run fstests btrfs/013 at 2016-08-24 14:36:41 > [ 400.939980] BTRFS: device fsid 6dd1d6e7-e6a7-4754-b1da-6ae12db06087 > devid 1 transid 3 /dev/vdh > [ 400.982129] BTRFS info (device vdh): disk space caching is enabled > [ 400.983470] BTRFS info (device vdh): has skinny extents > [ 400.984706] BTRFS info (device vdh): flagging fs with big metadata > feature > [ 400.993415] BTRFS info (device vdh): creating UUID tree > [ 411.057401] BTRFS info (device vdh): relocating block group > 29360128 flags 36 > [ 411.080278] BTRFS info (device vdh): found 2 extents > [ 411.092704] BTRFS info (device vdh): relocating block group > 20971520 flags 34 > [ 411.105887] BTRFS info (device vdh): found 1 extents > [ 411.117528] BTRFS info (device vdh): relocating block group > 12582912 flags 1 > > [ 411.119023] ============================================= > [ 411.119283] [ INFO: possible recursive locking detected ] > [ 411.119283] 4.8.0-rc3-13125-gff57150 #231 Not tainted > [ 411.119283] --------------------------------------------- > [ 411.119283] btrfs/12261 is trying to acquire lock: > [ 411.119283] (&fs_info->bg_delete_sem){++++..}, at: > [<ffffffffa0a2aeef>] btrfs_alloc_data_chunk_ondemand+0x9f/0x560 [btrfs] > [ 411.119283] but task is already holding lock: > [ 411.119283] (&fs_info->bg_delete_sem){++++..}, at: > [<ffffffffa0a727e4>] __btrfs_balance+0x374/0xe70 [btrfs] > [ 411.119283] other info that might help us debug this: > [ 411.119283] Possible unsafe locking scenario: > > [ 411.119283] CPU0 > [ 411.119283] ---- > [ 411.119283] lock(&fs_info->bg_delete_sem); > [ 411.119283] lock(&fs_info->bg_delete_sem); > [ 411.119283] *** DEADLOCK *** > > [ 411.119283] May be due to missing lock nesting notation > > [ 411.119283] 6 locks held by btrfs/12261: > [ 411.119283] #0: (sb_writers#9){.+.+.+}, at: [<ffffffff8122f273>] > __sb_start_write+0xd3/0xf0 > [ 411.119283] #1: (&fs_info->volume_mutex){+.+.+.}, at: > [<ffffffffa0a7db28>] btrfs_ioctl_balance+0x118/0x370 [btrfs] > [ 411.119283] #2: (&fs_info->bg_delete_sem){++++..}, at: > [<ffffffffa0a727e4>] __btrfs_balance+0x374/0xe70 [btrfs] > [ 411.119283] #3: (&fs_info->cleaner_mutex){+.+...}, at: > [<ffffffffa0aa620f>] btrfs_relocate_block_group+0x17f/0x2a0 [btrfs] > [ 411.119283] #4: (sb_internal){.+.+.+}, at: [<ffffffff8122f231>] > __sb_start_write+0x91/0xf0 > [ 411.119283] #5: (&cur_trans->cache_write_mutex){+.+...}, at: > [<ffffffffa0a2bf3c>] btrfs_start_dirty_block_groups+0x1ac/0x550 [btrfs] > [ 411.119283] stack backtrace: > [ 411.119283] CPU: 6 PID: 12261 Comm: btrfs Not tainted > 4.8.0-rc3-13125-gff57150 #231 > [ 411.119283] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), > BIOS 1.9.0-1.fc24 04/01/2014 > [ 411.119283] 0000000000000000 ffff880fd72371f8 ffffffff8149def7 > 0000000000000007 > [ 411.119283] 0000000000000006 ffffffff8256a580 ffff880fe67a5d00 > ffff880fd72372f8 > [ 411.119283] ffffffff810c6a4b ffff880fd7237308 0000000000000046 > ffff880fe67a6580 > [ 411.119283] Call Trace: > [ 411.119283] [<ffffffff8149def7>] dump_stack+0x6b/0xa4 > [ 411.119283] [<ffffffff810c6a4b>] __lock_acquire+0x73b/0x1800 > [ 411.119283] [<ffffffffa0a0cc5a>] ? btrfs_free_path+0x2a/0x40 [btrfs] > [ 411.119283] [<ffffffffa0a0cc5a>] ? btrfs_free_path+0x2a/0x40 [btrfs] > [ 411.119283] [<ffffffff814bcb47>] ? debug_smp_processor_id+0x17/0x20 > [ 411.119283] [<ffffffff810c7bc9>] lock_acquire+0xb9/0x290 > [ 411.119283] [<ffffffffa0a2aeef>] ? > btrfs_alloc_data_chunk_ondemand+0x9f/0x560 [btrfs] > [ 411.119283] [<ffffffffa0a2aedb>] ? > btrfs_alloc_data_chunk_ondemand+0x8b/0x560 [btrfs] > [ 411.119283] [<ffffffff81992574>] down_read+0x34/0x60 > [ 411.119283] [<ffffffffa0a2aeef>] ? > btrfs_alloc_data_chunk_ondemand+0x9f/0x560 [btrfs] > [ 411.119283] [<ffffffff819942d5>] ? _raw_spin_unlock+0x35/0x60 > [ 411.119283] [<ffffffffa0a2aeef>] > btrfs_alloc_data_chunk_ondemand+0x9f/0x560 [btrfs] > [ 411.119283] [<ffffffffa0a2b619>] ? cache_save_setup+0x1f9/0x390 > [btrfs] > [ 411.119283] [<ffffffffa0a2b3f8>] > btrfs_check_data_free_space+0x48/0x70 [btrfs] > [ 411.119283] [<ffffffffa0a2b659>] cache_save_setup+0x239/0x390 [btrfs] > [ 411.119283] [<ffffffffa0a2c027>] > btrfs_start_dirty_block_groups+0x297/0x550 [btrfs] > [ 411.119283] [<ffffffff810c5f91>] ? > trace_hardirqs_on_caller+0x101/0x1d0 > [ 411.119283] [<ffffffff810c5cbe>] ? mark_held_locks+0x6e/0x90 > [ 411.119283] [<ffffffff8198ff7a>] ? > __mutex_unlock_slowpath+0x10a/0x1b0 > [ 411.119283] [<ffffffff810c5f91>] ? > trace_hardirqs_on_caller+0x101/0x1d0 > [ 411.119283] [<ffffffff8198ff63>] ? __mutex_unlock_slowpath+0xf3/0x1b0 > [ 411.119283] [<ffffffffa0a40a4d>] > btrfs_commit_transaction+0x16d/0xd80 [btrfs] > [ 411.119283] [<ffffffff814bcb23>] ? __this_cpu_preempt_check+0x13/0x20 > [ 411.119283] [<ffffffff810c11a8>] ? percpu_down_read_trylock+0x48/0xa0 > [ 411.119283] [<ffffffff8122f231>] ? __sb_start_write+0x91/0xf0 > [ 411.119283] [<ffffffff8122f231>] ? __sb_start_write+0x91/0xf0 > [ 411.119283] [<ffffffffa0a41b8b>] ? start_transaction+0xab/0x4b0 > [btrfs] > [ 411.119283] [<ffffffffa0a9e8d4>] prepare_to_relocate+0xe4/0x110 > [btrfs] > [ 411.119283] [<ffffffffa0aa5337>] relocate_block_group+0x47/0x7a0 > [btrfs] > [ 411.119283] [<ffffffff810c606d>] ? trace_hardirqs_on+0xd/0x10 > [ 411.119283] [<ffffffff81990791>] ? mutex_lock_nested+0x2b1/0x400 > [ 411.119283] [<ffffffffa0aa620f>] ? > btrfs_relocate_block_group+0x17f/0x2a0 [btrfs] > [ 411.119283] [<ffffffff810c0f23>] ? up_write+0x23/0x50 > [ 411.119283] [<ffffffffa0aa6217>] > btrfs_relocate_block_group+0x187/0x2a0 [btrfs] > [ 411.119283] [<ffffffffa0a71afa>] btrfs_relocate_chunk+0x8a/0x120 > [btrfs] > [ 411.119283] [<ffffffffa0a72ee7>] __btrfs_balance+0xa77/0xe70 [btrfs] > [ 411.119283] [<ffffffff8198ff63>] ? __mutex_unlock_slowpath+0xf3/0x1b0 > [ 411.119283] [<ffffffffa0a736d9>] btrfs_balance+0x3f9/0x690 [btrfs] > [ 411.119283] [<ffffffffa0a7dd33>] ? btrfs_ioctl_balance+0x323/0x370 > [btrfs] > [ 411.119283] [<ffffffff810dcb8f>] ? rcu_read_lock_sched_held+0x4f/0x90 > [ 411.119283] [<ffffffffa0a7d9ff>] ? kzalloc+0xf/0x20 [btrfs] > [ 411.119283] [<ffffffffa0a7dd33>] btrfs_ioctl_balance+0x323/0x370 > [btrfs] > [ 411.119283] [<ffffffff8198df11>] ? __schedule+0x341/0xc00 > [ 411.119283] [<ffffffff81994287>] ? > _raw_spin_unlock_irqrestore+0x67/0x80 > [ 411.119283] [<ffffffffa0a852ab>] btrfs_ioctl+0x60b/0x1460 [btrfs] > [ 411.119283] [<ffffffff8112cfde>] ? __audit_syscall_entry+0xae/0x110 > [ 411.119283] [<ffffffff810f2e2f>] ? current_kernel_time64+0x9f/0xb0 > [ 411.119283] [<ffffffff810c5f91>] ? > trace_hardirqs_on_caller+0x101/0x1d0 > [ 411.119283] [<ffffffff810c606d>] ? trace_hardirqs_on+0xd/0x10 > [ 411.119283] [<ffffffff8112cfde>] ? __audit_syscall_entry+0xae/0x110 > [ 411.119283] [<ffffffff81240c38>] vfs_ioctl+0x18/0x30 > [ 411.119283] [<ffffffff8124135e>] do_vfs_ioctl+0x8e/0x670 > [ 411.119283] [<ffffffff8112cfde>] ? __audit_syscall_entry+0xae/0x110 > [ 411.119283] [<ffffffff8112d268>] ? __audit_syscall_exit+0x228/0x2b0 > [ 411.119283] [<ffffffff810024c3>] ? syscall_trace_enter+0x213/0x3e0 > [ 411.119283] [<ffffffff812419d2>] SyS_ioctl+0x92/0xa0 > [ 411.119283] [<ffffffff81003013>] do_syscall_64+0x63/0x130 > [ 411.119283] [<ffffffff8100201a>] ? trace_hardirqs_on_thunk+0x1a/0x1c > [ 411.119283] [<ffffffff8199451a>] entry_SYSCALL64_slow_path+0x25/0x25 > > But we make it through btrfs/013 up to btrfs/071 and then: > > [ 1721.312198] INFO: task btrfs-cleaner:28544 blocked for more than > 120 seconds. > [ 1721.312995] Tainted: G W 4.8.0-rc3-13125-gff57150 #231 > [ 1721.313710] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" > disables this message. > [ 1721.315255] btrfs-cleaner D ffff880fd6753b28 0 28544 2 > 0x00000080 > [ 1721.316148] ffff880fd6753b28 0000000000000046 0000000000000046 > 0000000000000000 > [ 1721.316989] 0000000000000246 ffff880f12bdc5c0 ffff880fe476c5c0 > 0000000000000000 > [ 1721.317832] ffff880fdb48c500 0000000000000282 0000000000000282 > 0000000000000000 > [ 1721.318695] Call Trace: > [ 1721.318857] [<ffffffff810c606d>] ? trace_hardirqs_on+0xd/0x10 > [ 1721.319445] [<ffffffff8198eaba>] schedule+0x4a/0xc0 > [ 1721.319945] [<ffffffffa0a3f07d>] wait_current_trans+0xbd/0x130 > [btrfs] > [ 1721.320629] [<ffffffff810b97f0>] ? woken_wake_function+0x20/0x20 > [ 1721.321308] [<ffffffff8122f273>] ? __sb_start_write+0xd3/0xf0 > [ 1721.321884] [<ffffffffa0a41dca>] start_transaction+0x2ea/0x4b0 > [btrfs] > [ 1721.322593] [<ffffffffa0a422d8>] btrfs_start_transaction+0x18/0x20 > [btrfs] > [ 1721.323329] [<ffffffffa0a423ce>] > btrfs_start_transaction_fallback_global_rsv+0x2e/0xe0 [btrfs] > [ 1721.324276] [<ffffffffa0a182a4>] > btrfs_start_trans_remove_block_group+0x84/0xc0 [btrfs] > [ 1721.325140] [<ffffffffa0a1e6ac>] > btrfs_delete_unused_bgs+0x1fc/0x520 [btrfs] > [ 1721.325856] [<ffffffff8198ff63>] ? __mutex_unlock_slowpath+0xf3/0x1b0 > [ 1721.326613] [<ffffffffa0a36400>] cleaner_kthread+0x1a0/0x1e0 [btrfs] > [ 1721.327301] [<ffffffffa0a36260>] ? btree_readpage+0x30/0x30 [btrfs] > [ 1721.327929] [<ffffffff8109058e>] kthread+0xde/0x100 > [ 1721.328413] [<ffffffff8109b015>] ? schedule_tail+0x35/0xf0 > [ 1721.328979] [<ffffffff8199467f>] ret_from_fork+0x1f/0x40 > [ 1721.329526] [<ffffffff810904b0>] ? __init_kthread_worker+0x70/0x70 > [ 1721.330165] INFO: lockdep is turned off. > [ 1721.330499] INFO: task btrfs-transacti:28545 blocked for more than > 120 seconds. > [ 1721.331254] Tainted: G W 4.8.0-rc3-13125-gff57150 #231 > [ 1721.331971] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" > disables this message. > [ 1721.332804] btrfs-transacti D ffff880fd70bfc88 0 28545 2 > 0x00000080 > [ 1721.333571] ffff880fd70bfc88 0000000000000046 0000000000000046 > 0000000000000000 > [ 1721.334411] 0000000000000246 ffff880f12bddd00 ffff880fe84c0000 > ffff880f00000000 > [ 1721.335299] ffff880fdb48c500 0000000000000282 0000000000000282 > 0000000000000000 > [ 1721.336139] Call Trace: > [ 1721.336298] [<ffffffff810c606d>] ? trace_hardirqs_on+0xd/0x10 > [ 1721.336855] [<ffffffff8198eaba>] schedule+0x4a/0xc0 > [ 1721.337348] [<ffffffffa0a3f07d>] wait_current_trans+0xbd/0x130 > [btrfs] > [ 1721.338076] [<ffffffff810b97f0>] ? woken_wake_function+0x20/0x20 > [ 1721.338684] [<ffffffffa0a41d3a>] start_transaction+0x25a/0x4b0 > [btrfs] > [ 1721.339377] [<ffffffffa0a41fa7>] > btrfs_attach_transaction+0x17/0x20 [btrfs] > [ 1721.340312] [<ffffffffa0a3987d>] transaction_kthread+0x19d/0x210 > [btrfs] > [ 1721.341142] [<ffffffffa0a396e0>] ? close_ctree+0x380/0x380 [btrfs] > [ 1721.341757] [<ffffffff8109058e>] kthread+0xde/0x100 > [ 1721.342406] [<ffffffff8109b015>] ? schedule_tail+0x35/0xf0 > [ 1721.343047] [<ffffffff8199467f>] ret_from_fork+0x1f/0x40 > [ 1721.343553] [<ffffffff810904b0>] ? __init_kthread_worker+0x70/0x70 > [ 1721.344243] INFO: lockdep is turned off. > [ 1721.344582] INFO: task fsstress:28551 blocked for more than 120 > seconds. > [ 1721.345270] Tainted: G W 4.8.0-rc3-13125-gff57150 #231 > [ 1721.345947] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" > disables this message. > [ 1721.346757] fsstress D ffff880fd777fc78 0 28551 28548 > 0x00000080 > [ 1721.347590] ffff880fd777fc78 0000000000000046 0000000000000046 > 0000000000000000 > [ 1721.348506] 0000000000000246 ffff880ef7835d00 ffff880fe84845c0 > 0000000000000000 > [ 1721.349349] ffff880fdb48c500 0000000000000286 0000000000000286 > 0000000000000000 > [ 1721.350243] Call Trace: > [ 1721.350404] [<ffffffff810c606d>] ? trace_hardirqs_on+0xd/0x10 > [ 1721.350970] [<ffffffff8198eaba>] schedule+0x4a/0xc0 > [ 1721.351474] [<ffffffffa0a3f07d>] wait_current_trans+0xbd/0x130 > [btrfs] > [ 1721.352178] [<ffffffff810b97f0>] ? woken_wake_function+0x20/0x20 > [ 1721.352775] [<ffffffff819900de>] ? mutex_unlock+0xe/0x10 > [ 1721.353349] [<ffffffffa0a41d3a>] start_transaction+0x25a/0x4b0 > [btrfs] > [ 1721.354050] [<ffffffff81992d15>] ? rwsem_down_read_failed+0xc5/0x120 > [ 1721.354682] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 > [ 1721.355368] [<ffffffffa0a424a7>] > btrfs_attach_transaction_barrier+0x27/0x60 [btrfs] > [ 1721.356210] [<ffffffffa0a02d6a>] btrfs_sync_fs+0x7a/0x250 [btrfs] > [ 1721.356813] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 > [ 1721.357489] [<ffffffff81269210>] sync_fs_one_sb+0x20/0x30 > [ 1721.358132] [<ffffffff8122fe3f>] iterate_supers+0xaf/0xe0 > [ 1721.358889] [<ffffffff81269705>] sys_sync+0x55/0x90 > [ 1721.359428] [<ffffffff81003013>] do_syscall_64+0x63/0x130 > [ 1721.360058] [<ffffffff8100201a>] ? trace_hardirqs_on_thunk+0x1a/0x1c > [ 1721.360696] [<ffffffff8199451a>] entry_SYSCALL64_slow_path+0x25/0x25 > [ 1721.361414] INFO: lockdep is turned off. > [ 1721.361751] INFO: task fsstress:28552 blocked for more than 120 > seconds. > [ 1721.362445] Tainted: G W 4.8.0-rc3-13125-gff57150 #231 > [ 1721.363210] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" > disables this message. > [ 1721.364051] fsstress D ffff880fdb077c78 0 28552 28548 > 0x00000080 > [ 1721.364793] ffff880fdb077c78 0000000000000046 0000000000000046 > 0000000000000000 > [ 1721.365653] 0000000000000246 ffff880ef7830000 ffff880fe84a0000 > 0000000000000000 > [ 1721.366508] ffff880fdb48c500 0000000000000286 0000000000000286 > 0000000000000000 > [ 1721.367362] Call Trace: > [ 1721.367521] [<ffffffff810c606d>] ? trace_hardirqs_on+0xd/0x10 > [ 1721.368112] [<ffffffff8198eaba>] schedule+0x4a/0xc0 > [ 1721.368588] [<ffffffffa0a3f07d>] wait_current_trans+0xbd/0x130 > [btrfs] > [ 1721.369280] [<ffffffff810b97f0>] ? woken_wake_function+0x20/0x20 > [ 1721.369867] [<ffffffff819900de>] ? mutex_unlock+0xe/0x10 > [ 1721.370502] [<ffffffffa0a41d3a>] start_transaction+0x25a/0x4b0 > [btrfs] > [ 1721.371221] [<ffffffff81992d15>] ? rwsem_down_read_failed+0xc5/0x120 > [ 1721.371846] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 > [ 1721.372534] [<ffffffffa0a424a7>] > btrfs_attach_transaction_barrier+0x27/0x60 [btrfs] > [ 1721.373372] [<ffffffffa0a02d6a>] btrfs_sync_fs+0x7a/0x250 [btrfs] > [ 1721.373986] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 > [ 1721.374649] [<ffffffff81269210>] sync_fs_one_sb+0x20/0x30 > [ 1721.375291] [<ffffffff8122fe3f>] iterate_supers+0xaf/0xe0 > [ 1721.375811] [<ffffffff81269705>] sys_sync+0x55/0x90 > [ 1721.376305] [<ffffffff81003013>] do_syscall_64+0x63/0x130 > [ 1721.376832] [<ffffffff8100201a>] ? trace_hardirqs_on_thunk+0x1a/0x1c > [ 1721.377503] [<ffffffff8199451a>] entry_SYSCALL64_slow_path+0x25/0x25 > [ 1721.378222] INFO: lockdep is turned off. > [ 1721.378558] INFO: task fsstress:28553 blocked for more than 120 > seconds. > [ 1721.379246] Tainted: G W 4.8.0-rc3-13125-gff57150 #231 > [ 1721.379914] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" > disables this message. > [ 1721.380764] fsstress D ffff880f198efc78 0 28553 28548 > 0x00000080 > [ 1721.381599] ffff880f198efc78 0000000000000046 0000000000000046 > 0000000000000000 > [ 1721.382452] 0000000000000246 ffff880ef7832e80 ffff880f03029740 > 0000000000000000 > [ 1721.383302] ffff880fdb48c500 0000000000000286 0000000000000286 > 0000000000000000 > [ 1721.384209] Call Trace: > [ 1721.384368] [<ffffffff810c606d>] ? trace_hardirqs_on+0xd/0x10 > [ 1721.384932] [<ffffffff8198eaba>] schedule+0x4a/0xc0 > [ 1721.385436] [<ffffffffa0a3f07d>] wait_current_trans+0xbd/0x130 > [btrfs] > [ 1721.386135] [<ffffffff810b97f0>] ? woken_wake_function+0x20/0x20 > [ 1721.386723] [<ffffffff819900de>] ? mutex_unlock+0xe/0x10 > [ 1721.387338] [<ffffffffa0a41d3a>] start_transaction+0x25a/0x4b0 > [btrfs] > [ 1721.388049] [<ffffffff81992d15>] ? rwsem_down_read_failed+0xc5/0x120 > [ 1721.388675] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 > [ 1721.389361] [<ffffffffa0a424a7>] > btrfs_attach_transaction_barrier+0x27/0x60 [btrfs] > [ 1721.390257] [<ffffffffa0a02d6a>] btrfs_sync_fs+0x7a/0x250 [btrfs] > [ 1721.390875] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 > [ 1721.391555] [<ffffffff81269210>] sync_fs_one_sb+0x20/0x30 > [ 1721.392115] [<ffffffff8122fe3f>] iterate_supers+0xaf/0xe0 > [ 1721.392636] [<ffffffff81269705>] sys_sync+0x55/0x90 > [ 1721.393192] [<ffffffff81003013>] do_syscall_64+0x63/0x130 > [ 1721.393710] [<ffffffff8100201a>] ? trace_hardirqs_on_thunk+0x1a/0x1c > [ 1721.394376] [<ffffffff8199451a>] entry_SYSCALL64_slow_path+0x25/0x25 > [ 1721.395038] INFO: lockdep is turned off. > [ 1721.395378] INFO: task fsstress:28554 blocked for more than 120 > seconds. > [ 1721.396076] Tainted: G W 4.8.0-rc3-13125-gff57150 #231 > [ 1721.396742] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" > disables this message. > [ 1721.397572] fsstress D ffff880fd4953c78 0 28554 28548 > 0x00000080 > [ 1721.398360] ffff880fd4953c78 0000000000000046 0000000000000046 > 0000000000000000 > [ 1721.399295] 0000000000000246 ffff880ef7831740 ffff880fe2fb8000 > 0000000000000002 > [ 1721.400162] ffff880fdb48c500 0000000000000286 0000000000000286 > 0000000000000000 > [ 1721.400983] Call Trace: > [ 1721.401180] [<ffffffff810c606d>] ? trace_hardirqs_on+0xd/0x10 > [ 1721.401739] [<ffffffff8198eaba>] schedule+0x4a/0xc0 > [ 1721.402323] [<ffffffffa0a3f07d>] wait_current_trans+0xbd/0x130 > [btrfs] > [ 1721.402992] [<ffffffff810b97f0>] ? woken_wake_function+0x20/0x20 > [ 1721.403613] [<ffffffff819900de>] ? mutex_unlock+0xe/0x10 > [ 1721.404171] [<ffffffffa0a41d3a>] start_transaction+0x25a/0x4b0 > [btrfs] > [ 1721.404824] [<ffffffff81992d15>] ? rwsem_down_read_failed+0xc5/0x120 > [ 1721.405548] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 > [ 1721.406251] [<ffffffffa0a424a7>] > btrfs_attach_transaction_barrier+0x27/0x60 [btrfs] > [ 1721.407094] [<ffffffffa0a02d6a>] btrfs_sync_fs+0x7a/0x250 [btrfs] > [ 1721.407694] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 > [ 1721.408427] [<ffffffff81269210>] sync_fs_one_sb+0x20/0x30 > [ 1721.408954] [<ffffffff8122fe3f>] iterate_supers+0xaf/0xe0 > [ 1721.409497] [<ffffffff81269705>] sys_sync+0x55/0x90 > [ 1721.409958] [<ffffffff81003013>] do_syscall_64+0x63/0x130 > [ 1721.410502] [<ffffffff8100201a>] ? trace_hardirqs_on_thunk+0x1a/0x1c > [ 1721.411219] [<ffffffff8199451a>] entry_SYSCALL64_slow_path+0x25/0x25 > [ 1721.411856] INFO: lockdep is turned off. > [ 1721.412285] INFO: task fsstress:28555 blocked for more than 120 > seconds. > [ 1721.412964] Tainted: G W 4.8.0-rc3-13125-gff57150 #231 > [ 1721.413667] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" > disables this message. > [ 1721.414506] fsstress D ffff880fc5f93898 0 28555 28548 > 0x00000080 > [ 1721.415408] ffff880fc5f93898 0000000000000000 0000000000000000 > ffff880fc5f938c8 > [ 1721.416280] 0000000000000046 ffff880ef78345c0 ffff880fe2fbdd00 > ffff880f00000000 > [ 1721.417137] 0000000000000000 0000000000000246 ffffffff00000000 > 0000000000000000 > [ 1721.417961] Call Trace: > [ 1721.418156] [<ffffffff8198eaba>] schedule+0x4a/0xc0 > [ 1721.418614] [<ffffffff810c606d>] ? trace_hardirqs_on+0xd/0x10 > [ 1721.419206] [<ffffffff819941fb>] ? _raw_spin_unlock_irq+0x3b/0x60 > [ 1721.419813] [<ffffffff81992d15>] rwsem_down_read_failed+0xc5/0x120 > [ 1721.420560] [<ffffffff814aceb8>] > call_rwsem_down_read_failed+0x18/0x30 > [ 1721.421261] [<ffffffff81992582>] down_read+0x42/0x60 > [ 1721.421763] [<ffffffffa0a2aeef>] ? > btrfs_alloc_data_chunk_ondemand+0x9f/0x560 [btrfs] > [ 1721.422606] [<ffffffff819942d5>] ? _raw_spin_unlock+0x35/0x60 > [ 1721.423212] [<ffffffffa0a2aeef>] > btrfs_alloc_data_chunk_ondemand+0x9f/0x560 [btrfs] > [ 1721.424070] [<ffffffffa0a9470d>] ? > btrfs_truncate_free_space_cache+0x17d/0x1d0 [btrfs] > [ 1721.424901] [<ffffffffa0a2b3f8>] > btrfs_check_data_free_space+0x48/0x70 [btrfs] > [ 1721.425779] [<ffffffffa0a2b659>] cache_save_setup+0x239/0x390 [btrfs] > [ 1721.426486] [<ffffffffa0a6b564>] ? free_extent_buffer+0x44/0xb0 > [btrfs] > [ 1721.427198] [<ffffffffa0a2b875>] btrfs_setup_space_cache+0xc5/0xe0 > [btrfs] > [ 1721.427909] [<ffffffffa0a3e0ca>] commit_cowonly_roots+0xfa/0x310 > [btrfs] > [ 1721.428706] [<ffffffffa0a3dfb4>] ? commit_fs_roots+0x1b4/0x1d0 > [btrfs] > [ 1721.429426] [<ffffffffa0aba38a>] ? > btrfs_qgroup_account_extents+0x4a/0x270 [btrfs] > [ 1721.430265] [<ffffffffa0a40ec8>] > btrfs_commit_transaction+0x5e8/0xd80 [btrfs] > [ 1721.431092] [<ffffffff812065e4>] ? kmem_cache_alloc+0x1f4/0x320 > [ 1721.431685] [<ffffffffa0a41c0a>] ? start_transaction+0x12a/0x4b0 > [btrfs] > [ 1721.432391] [<ffffffff819900de>] ? mutex_unlock+0xe/0x10 > [ 1721.432911] [<ffffffffa0a41b8b>] ? start_transaction+0xab/0x4b0 > [btrfs] > [ 1721.433610] [<ffffffff81992d15>] ? rwsem_down_read_failed+0xc5/0x120 > [ 1721.434349] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 > [ 1721.434994] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 > [ 1721.435667] [<ffffffffa0a02d81>] btrfs_sync_fs+0x91/0x250 [btrfs] > [ 1721.436318] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 > [ 1721.437040] [<ffffffff81269210>] sync_fs_one_sb+0x20/0x30 > [ 1721.437563] [<ffffffff8122fe3f>] iterate_supers+0xaf/0xe0 > [ 1721.438115] [<ffffffff81269705>] sys_sync+0x55/0x90 > [ 1721.438570] [<ffffffff81003013>] do_syscall_64+0x63/0x130 > [ 1721.439123] [<ffffffff8100201a>] ? trace_hardirqs_on_thunk+0x1a/0x1c > [ 1721.439758] [<ffffffff8199451a>] entry_SYSCALL64_slow_path+0x25/0x25 > [ 1721.440669] INFO: lockdep is turned off. > [ 1721.441200] INFO: task fsstress:28556 blocked for more than 120 > seconds. > [ 1721.442201] Tainted: G W 4.8.0-rc3-13125-gff57150 #231 > [ 1721.443187] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" > disables this message. > [ 1721.444087] fsstress D ffff880fd9c7bc78 0 28556 28548 > 0x00000080 > [ 1721.444842] ffff880fd9c7bc78 0000000000000046 0000000000000046 > 0000000000000000 > [ 1721.445707] 0000000000000246 ffff880fe2fbae80 ffff880ef7832e80 > 0000000000000000 > [ 1721.446568] ffff880fdb48c500 0000000000000286 0000000000000286 > 0000000000000000 > [ 1721.447466] Call Trace: > [ 1721.447626] [<ffffffff810c606d>] ? trace_hardirqs_on+0xd/0x10 > [ 1721.448208] [<ffffffff8198eaba>] schedule+0x4a/0xc0 > [ 1721.448674] [<ffffffffa0a3f07d>] wait_current_trans+0xbd/0x130 > [btrfs] > [ 1721.449349] [<ffffffff810b97f0>] ? woken_wake_function+0x20/0x20 > [ 1721.449913] [<ffffffff819900de>] ? mutex_unlock+0xe/0x10 > [ 1721.450454] [<ffffffffa0a41d3a>] start_transaction+0x25a/0x4b0 > [btrfs] > [ 1721.451119] [<ffffffff81992d15>] ? rwsem_down_read_failed+0xc5/0x120 > [ 1721.451727] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 > [ 1721.452506] [<ffffffffa0a424a7>] > btrfs_attach_transaction_barrier+0x27/0x60 [btrfs] > [ 1721.453556] [<ffffffffa0a02d6a>] btrfs_sync_fs+0x7a/0x250 [btrfs] > [ 1721.454227] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 > [ 1721.454868] [<ffffffff81269210>] sync_fs_one_sb+0x20/0x30 > [ 1721.455431] [<ffffffff8122fe3f>] iterate_supers+0xaf/0xe0 > [ 1721.455959] [<ffffffff81269705>] sys_sync+0x55/0x90 > [ 1721.456450] [<ffffffff81003013>] do_syscall_64+0x63/0x130 > [ 1721.456982] [<ffffffff8100201a>] ? trace_hardirqs_on_thunk+0x1a/0x1c > [ 1721.457653] [<ffffffff8199451a>] entry_SYSCALL64_slow_path+0x25/0x25 > [ 1721.458327] INFO: lockdep is turned off. > [ 1721.458666] INFO: task fsstress:28557 blocked for more than 120 > seconds. > [ 1721.459371] Tainted: G W 4.8.0-rc3-13125-gff57150 #231 > [ 1721.460173] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" > disables this message. > [ 1721.461042] fsstress D ffff880f18f67c78 0 28557 28548 > 0x00000080 > [ 1721.461798] ffff880f18f67c78 0000000000000046 0000000000000046 > 0000000000000000 > [ 1721.462663] 0000000000000246 ffff880fe2fb9740 ffff880ef7830000 > 0000000000000000 > [ 1721.463523] ffff880fdb48c500 0000000000000286 0000000000000286 > 0000000000000000 > [ 1721.464393] Call Trace: > [ 1721.464553] [<ffffffff810c606d>] ? trace_hardirqs_on+0xd/0x10 > [ 1721.465225] [<ffffffff8198eaba>] schedule+0x4a/0xc0 > [ 1721.465726] [<ffffffffa0a3f07d>] wait_current_trans+0xbd/0x130 > [btrfs] > [ 1721.466427] [<ffffffff810b97f0>] ? woken_wake_function+0x20/0x20 > [ 1721.467059] [<ffffffff819900de>] ? mutex_unlock+0xe/0x10 > [ 1721.467587] [<ffffffffa0a41d3a>] start_transaction+0x25a/0x4b0 > [btrfs] > [ 1721.468365] [<ffffffff81992d15>] ? rwsem_down_read_failed+0xc5/0x120 > [ 1721.469042] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 > [ 1721.469703] [<ffffffffa0a424a7>] > btrfs_attach_transaction_barrier+0x27/0x60 [btrfs] > [ 1721.470552] [<ffffffffa0a02d6a>] btrfs_sync_fs+0x7a/0x250 [btrfs] > [ 1721.471280] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 > [ 1721.471947] [<ffffffff81269210>] sync_fs_one_sb+0x20/0x30 > [ 1721.472502] [<ffffffff8122fe3f>] iterate_supers+0xaf/0xe0 > [ 1721.473066] [<ffffffff81269705>] sys_sync+0x55/0x90 > [ 1721.473528] [<ffffffff81003013>] do_syscall_64+0x63/0x130 > [ 1721.474141] [<ffffffff8100201a>] ? trace_hardirqs_on_thunk+0x1a/0x1c > [ 1721.474802] [<ffffffff8199451a>] entry_SYSCALL64_slow_path+0x25/0x25 > [ 1721.475475] INFO: lockdep is turned off. > [ 1721.475815] INFO: task fsstress:28558 blocked for more than 120 > seconds. > [ 1721.476521] Tainted: G W 4.8.0-rc3-13125-gff57150 #231 > [ 1721.477316] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" > disables this message. > [ 1721.478166] fsstress D ffff880fdb39bc78 0 28558 28548 > 0x00000080 > [ 1721.478928] ffff880fdb39bc78 0000000000000046 0000000000000046 > 0000000000000000 > [ 1721.479791] 0000000000000246 ffff880fe2fb8000 ffff880fe5c31740 > 0000000000000000 > [ 1721.480730] ffff880fdb48c500 0000000000000286 0000000000000286 > 0000000000000000 > [ 1721.481600] Call Trace: > [ 1721.481760] [<ffffffff810c606d>] ? trace_hardirqs_on+0xd/0x10 > [ 1721.482366] [<ffffffff8198eaba>] schedule+0x4a/0xc0 > [ 1721.482846] [<ffffffffa0a3f07d>] wait_current_trans+0xbd/0x130 > [btrfs] > [ 1721.483620] [<ffffffff810b97f0>] ? woken_wake_function+0x20/0x20 > [ 1721.484260] [<ffffffff819900de>] ? mutex_unlock+0xe/0x10 > [ 1721.484794] [<ffffffffa0a41d3a>] start_transaction+0x25a/0x4b0 > [btrfs] > [ 1721.485496] [<ffffffff81992d15>] ? rwsem_down_read_failed+0xc5/0x120 > [ 1721.486232] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 > [ 1721.486917] [<ffffffffa0a424a7>] > btrfs_attach_transaction_barrier+0x27/0x60 [btrfs] > [ 1721.487769] [<ffffffffa0a02d6a>] btrfs_sync_fs+0x7a/0x250 [btrfs] > [ 1721.488427] [<ffffffff812691f0>] ? iter_file_splice_write+0x400/0x400 > [ 1721.489177] [<ffffffff81269210>] sync_fs_one_sb+0x20/0x30 > [ 1721.489706] [<ffffffff8122fe3f>] iterate_supers+0xaf/0xe0 > [ 1721.490268] [<ffffffff81269705>] sys_sync+0x55/0x90 > [ 1721.490733] [<ffffffff81003013>] do_syscall_64+0x63/0x130 > [ 1721.491289] [<ffffffff8100201a>] ? trace_hardirqs_on_thunk+0x1a/0x1c > [ 1721.491935] [<ffffffff8199451a>] entry_SYSCALL64_slow_path+0x25/0x25 > -- > To unsubscribe from this list: send the line "unsubscribe linux-btrfs" in > the body of a message to majordomo@vger.kernel.org > More majordomo info at http://vger.kernel.org/majordomo-info.html > > ^ permalink raw reply [flat|nested] 5+ messages in thread
end of thread, other threads:[~2016-08-25 12:09 UTC | newest] Thread overview: 5+ messages (download: mbox.gz follow: Atom feed -- links below jump to the message on this page -- 2016-08-24 13:42 [PULL] Btrfs fixes, part 3 David Sterba 2016-08-24 21:14 ` Chris Mason 2016-08-25 6:14 ` Wang Xiaoguang 2016-08-25 10:54 ` Chris Mason 2016-08-25 12:04 ` Wang Xiaoguang
This is a public inbox, see mirroring instructions for how to clone and mirror all data and code used for this inbox; as well as URLs for NNTP newsgroup(s).