From: Konstantinos Skarlatos <k.skarlatos@gmail.com>
To: Chris Mason <chris.mason@oracle.com>
Cc: Tobias <tracer@robotech.de>, linux-btrfs@vger.kernel.org
Subject: Re: Blocked for more than 120 seconds
Date: Sun, 25 Dec 2011 03:06:56 +0200 [thread overview]
Message-ID: <4EF67730.5050108@gmail.com> (raw)
In-Reply-To: <20111205131252.GB26622@shiny>
I got the same message on a new btrfs filesystem on a raid5 volume=20
(without loop this time). kernel is 3.2rc6
this happened after a day of rsyncing at about 10mbyte/sec, only way to=
=20
reboot is with echo b > /proc/sysrq-trigger
[181201.285259] INFO: task btrfs-submit-1:768 blocked for more than 120=
=20
seconds.
[181201.285297] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs"=20
disables this message.
[181201.285332] btrfs-submit-1 D 0000000021102920 0 768 2=20
0x00000000
[181201.285368] ffff88006d1b7aa0 0000000000000046 0000000100000000=20
0000000300000001
[181201.285406] ffff880072c64020 ffff88006d1b7fd8 ffff88006d1b7fd8=20
ffff88006d1b7fd8
[181201.285443] ffff88006d900000 ffff880072c64020 ffff88006d1b7a00=20
ffffffff8104e053
[181201.285481] Call Trace:
[181201.285498] [<ffffffff8104e053>] ? __wake_up+0x53/0x70
[181201.285524] [<ffffffff8114e95b>] ? kfree+0x3b/0x170
[181201.285552] [<ffffffffa053535b>] ? plugger_unplug+0x3b/0x50=20
[md_mod]
[181201.285583] [<ffffffff8121ca57>] ? blk_flush_plug_list+0xa7/0x250
[181201.285612] [<ffffffff814158bf>] schedule+0x3f/0x60
[181201.285637] [<ffffffffa058b209>] get_active_stripe+0x2e9/0x600=20
[raid456]
[181201.285669] [<ffffffffa0534400>] ? max_sync_store+0xc0/0xe0=20
[md_mod]
[181201.285700] [<ffffffff8105cf10>] ? try_to_wake_up+0x290/0x290
[181201.285727] [<ffffffffa058ee22>] make_request+0x192/0x430 [raid456=
]
[181201.285758] [<ffffffff81086850>] ? abort_exclusive_wait+0xb0/0xb0
[181201.285787] [<ffffffffa053752a>] md_make_request+0xfa/0x240=20
[md_mod]
[181201.285816] [<ffffffff8114e95b>] ? kfree+0x3b/0x170
[181201.285840] [<ffffffff8121af47>] generic_make_request+0xc7/0x100
[181201.285868] [<ffffffff8121b007>] submit_bio+0x87/0x110
[181201.285900] [<ffffffffa074dcfb>] run_scheduled_bios+0x26b/0x590=20
[btrfs]
[181201.285936] [<ffffffffa074e035>] pending_bios_fn+0x15/0x20 [btrfs]
[181201.285969] [<ffffffffa0754870>] worker_loop+0x150/0x520 [btrfs]
[181201.285997] [<ffffffff8104c568>] ? __wake_up_common+0x58/0x90
[181201.286029] [<ffffffffa0754720>] ? btrfs_queue_worker+0x300/0x300=20
[btrfs]
[181201.286060] [<ffffffff81085f0c>] kthread+0x8c/0xa0
[181201.286084] [<ffffffff8141b234>] kernel_thread_helper+0x4/0x10
[181201.286111] [<ffffffff81085e80>] ? kthread_worker_fn+0x190/0x190
[181201.286139] [<ffffffff8141b230>] ? gs_change+0x13/0x13
[181201.286164] INFO: task btrfs-transacti:780 blocked for more than=20
120 seconds.
[181201.286195] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs"=20
disables this message.
[181201.286230] btrfs-transacti D 00000001033b48f7 0 780 2=20
0x00000000
[181201.286264] ffff88006d1e9430 0000000000000046 ffff880000000000=20
ffffffff810146ef
[181201.286301] ffff88006d905ca0 ffff88006d1e9fd8 ffff88006d1e9fd8=20
ffff88006d1e9fd8
[181201.286338] ffff880073e97200 ffff88006d905ca0 ffff88006d1e9380=20
ffffffff8108cb65
[181201.287224] Call Trace:
[181201.288093] [<ffffffff810146ef>] ? __switch_to+0xbf/0x2f0
[181201.288986] [<ffffffff8108cb65>] ? sched_clock_local+0x25/0x90
[181201.289867] [<ffffffffa0726640>] ? btrfs_buffer_uptodate+0x50/0x70=
=20
[btrfs]
[181201.290744] [<ffffffffa070c48c>] ? comp_keys+0x2c/0x30 [btrfs]
[181201.291613] [<ffffffff814158bf>] schedule+0x3f/0x60
[181201.292470] [<ffffffffa058b209>] get_active_stripe+0x2e9/0x600=20
[raid456]
[181201.293317] [<ffffffff8105cf10>] ? try_to_wake_up+0x290/0x290
[181201.294170] [<ffffffffa058ee22>] make_request+0x192/0x430 [raid456=
]
[181201.295030] [<ffffffff81086850>] ? abort_exclusive_wait+0xb0/0xb0
[181201.295897] [<ffffffffa053752a>] md_make_request+0xfa/0x240=20
[md_mod]
[181201.296764] [<ffffffffa074e14e>] ? __btrfs_map_block+0x10e/0x840=20
[btrfs]
[181201.297620] [<ffffffff8121af47>] generic_make_request+0xc7/0x100
[181201.298463] [<ffffffff8121b007>] submit_bio+0x87/0x110
[181201.299303] [<ffffffffa0751ebe>] btrfs_map_bio+0x13e/0x1d0 [btrfs]
[181201.300137] [<ffffffffa072d799>] btrfs_submit_bio_hook+0xa9/0x170=20
[btrfs]
[181201.300966] [<ffffffff81199eb1>] ?=20
__bio_add_page.part.14+0x101/0x240
[181201.301803] [<ffffffffa0745c9a>] submit_one_bio+0x6a/0xa0 [btrfs]
[181201.302644] [<ffffffffa07492fd>]=20
submit_extent_page.isra.28+0xdd/0x200 [btrfs]
[181201.302651] [<ffffffffa074a0ac>] __extent_writepage+0x52c/0x740=20
[btrfs]
[181201.302658] [<ffffffffa0746e80>] ? clear_extent_bit+0x3d0/0x3d0=20
[btrfs]
[181201.302666] [<ffffffffa074a58a>]=20
extent_write_cache_pages.isra.22.constprop.30+0x2ca/0x3f0 [btrfs]
[181201.302674] [<ffffffffa074a8f5>] extent_writepages+0x45/0x60=20
[btrfs]
[181201.302681] [<ffffffffa072f780>] ?=20
uncompress_inline.isra.47+0x1d0/0x1d0 [btrfs]
[181201.302687] [<ffffffffa0746c7a>] ? clear_extent_bit+0x1ca/0x3d0=20
[btrfs]
[181201.302694] [<ffffffffa072ea68>] btrfs_writepages+0x28/0x30 [btrfs=
]
[181201.302697] [<ffffffff8110eb64>] do_writepages+0x24/0x40
[181201.302700] [<ffffffff811043cb>]=20
__filemap_fdatawrite_range+0x5b/0x60
[181201.302702] [<ffffffff811043ef>] filemap_fdatawrite+0x1f/0x30
[181201.302704] [<ffffffff81104435>] filemap_write_and_wait+0x35/0x60
[181201.302711] [<ffffffffa07616c7>]=20
__btrfs_write_out_cache+0x807/0xa80 [btrfs]
[181201.302717] [<ffffffffa0767008>] ?=20
btrfs_find_ref_cluster+0x68/0x190 [btrfs]
[181201.302723] [<ffffffffa07619d5>] btrfs_write_out_cache+0x95/0xf0=20
[btrfs]
[181201.302729] [<ffffffffa071abe1>]=20
btrfs_write_dirty_block_groups+0x481/0x580 [btrfs]
[181201.302736] [<ffffffffa0729c05>] commit_cowonly_roots+0x115/0x1e0=20
[btrfs]
[181201.302742] [<ffffffffa072b3ec>]=20
btrfs_commit_transaction+0x3fc/0x880 [btrfs]
[181201.302745] [<ffffffff81086850>] ? abort_exclusive_wait+0xb0/0xb0
[181201.302751] [<ffffffffa072bcc4>] ? start_transaction+0x94/0x2b0=20
[btrfs]
[181201.302758] [<ffffffffa0723e6d>] transaction_kthread+0x26d/0x290=20
[btrfs]
[181201.302764] [<ffffffffa0723c00>] ? btrfs_congested_fn+0xd0/0xd0=20
[btrfs]
[181201.302766] [<ffffffff81085f0c>] kthread+0x8c/0xa0
[181201.302768] [<ffffffff8141b234>] kernel_thread_helper+0x4/0x10
[181201.302770] [<ffffffff81085e80>] ? kthread_worker_fn+0x190/0x190
[181201.302772] [<ffffffff8141b230>] ? gs_change+0x13/0x13
[181201.302775] INFO: task rsync:30933 blocked for more than 120=20
seconds.
[181201.302776] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs"=20
disables this message.
[181201.302777] rsync D 00000001033b48f2 0 30933 30932=20
0x00000000
[181201.302779] ffff880072ce5b98 0000000000000082 0000000000000000=20
0000000000000001
[181201.302781] ffff88006d9023a0 ffff880072ce5fd8 ffff880072ce5fd8=20
ffff880072ce5fd8
[181201.302783] ffffffff8180d020 ffff88006d9023a0 ffffffff81177b50=20
00000000000000db
[181201.302785] Call Trace:
[181201.302788] [<ffffffff81177b50>] ? poll_freewait+0xe0/0xe0
[181201.302790] [<ffffffff81177c40>] ? __pollwait+0xf0/0xf0
[181201.302792] [<ffffffff81051970>] ? select_task_rq_fair+0x540/0xa60
[181201.302794] [<ffffffff814158bf>] schedule+0x3f/0x60
[181201.302800] [<ffffffffa072a705>]=20
wait_current_trans.isra.22+0xa5/0xf0 [btrfs]
[181201.302803] [<ffffffff81086850>] ? abort_exclusive_wait+0xb0/0xb0
[181201.302809] [<ffffffffa072be20>] start_transaction+0x1f0/0x2b0=20
[btrfs]
[181201.302816] [<ffffffffa072bf35>] btrfs_join_transaction+0x15/0x20=20
[btrfs]
[181201.302823] [<ffffffffa0736980>] btrfs_dirty_inode+0x50/0xd0=20
[btrfs]
[181201.302830] [<ffffffffa0736c86>] btrfs_update_time+0xd6/0x170=20
[btrfs]
[181201.302837] [<ffffffffa073aee8>] btrfs_file_aio_write+0x1c8/0x520=20
[btrfs]
[181201.302840] [<ffffffff8116e8f2>] ? pipe_read+0x2d2/0x4e0
[181201.302842] [<ffffffff81164302>] do_sync_write+0xd2/0x110
[181201.302844] [<ffffffff81051019>] ? finish_task_switch+0x49/0xd0
[181201.302848] [<ffffffff811f266c>] ?=20
security_file_permission+0x2c/0xb0
[181201.302849] [<ffffffff811648b1>] ? rw_verify_area+0x61/0xf0
[181201.302851] [<ffffffff81164c0f>] vfs_write+0xaf/0x180
[181201.302853] [<ffffffff81164f3a>] sys_write+0x4a/0x90
[181201.302856] [<ffffffff814190c2>] system_call_fastpath+0x16/0x1b
[181201.302858] INFO: task flush-btrfs-1:30940 blocked for more than=20
120 seconds.
[181201.302859] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs"=20
disables this message.
[181201.302860] flush-btrfs-1 D 00000001033b5a85 0 30940 2=20
0x00000000
[181201.302862] ffff8800236218d0 0000000000000046 ffff880000000000=20
ffffffffa075460e
[181201.302864] ffff88007222b1e0 ffff880023621fd8 ffff880023621fd8=20
ffff880023621fd8
[181201.302866] ffff880073e97200 ffff88007222b1e0 ffff88000dad1550=20
ffff880023621870
[181201.302868] Call Trace:
[181201.302874] [<ffffffffa075460e>] ? btrfs_queue_worker+0x1ee/0x300=20
[btrfs]
[181201.302881] [<ffffffffa07330b5>] ? run_delalloc_range+0x185/0x360=20
[btrfs]
[181201.302883] [<ffffffff8101d639>] ? read_tsc+0x9/0x20
[181201.302885] [<ffffffff81103140>] ? __lock_page+0x70/0x70
[181201.302887] [<ffffffff814158bf>] schedule+0x3f/0x60
[181201.302889] [<ffffffff8141596f>] io_schedule+0x8f/0xd0
[181201.302891] [<ffffffff8110314e>] sleep_on_page+0xe/0x20
[181201.302892] [<ffffffff8141623a>] __wait_on_bit_lock+0x5a/0xc0
[181201.302894] [<ffffffff81103137>] __lock_page+0x67/0x70
[181201.302897] [<ffffffff81086890>] ?=20
autoremove_wake_function+0x40/0x40
[181201.302903] [<ffffffffa074a4d5>]=20
extent_write_cache_pages.isra.22.constprop.30+0x215/0x3f0 [btrfs]
[181201.302911] [<ffffffffa074a8f5>] extent_writepages+0x45/0x60=20
[btrfs]
[181201.302917] [<ffffffffa072f780>] ?=20
uncompress_inline.isra.47+0x1d0/0x1d0 [btrfs]
[181201.302924] [<ffffffffa072ea68>] btrfs_writepages+0x28/0x30 [btrfs=
]
[181201.302926] [<ffffffff8110eb64>] do_writepages+0x24/0x40
[181201.302928] [<ffffffff8118ce0f>] writeback_single_inode+0x10f/0x3f=
0
[181201.302930] [<ffffffff8118d4ea>] writeback_sb_inodes+0x1aa/0x270
[181201.302932] [<ffffffff8118d64e>] __writeback_inodes_wb+0x9e/0xd0
[181201.302934] [<ffffffff8118dc6b>] wb_writeback+0x37b/0x3b0
[181201.302937] [<ffffffff8117ebd2>] ? get_nr_inodes+0x52/0x70
[181201.302939] [<ffffffff8117f8d2>] ? get_nr_dirty_inodes+0x52/0x80
[181201.302941] [<ffffffff8118dd3f>] wb_check_old_data_flush+0x9f/0xb0
[181201.302943] [<ffffffff8118f21c>] wb_do_writeback+0x19c/0x230
[181201.302944] [<ffffffff81415e43>] ? schedule_timeout+0x173/0x390
[181201.302947] [<ffffffff81072c10>] ?=20
init_timer_deferrable_key+0x30/0x30
[181201.302949] [<ffffffff8118f33c>] bdi_writeback_thread+0x8c/0x340
[181201.302951] [<ffffffff8118f2b0>] ? wb_do_writeback+0x230/0x230
[181201.302953] [<ffffffff81085f0c>] kthread+0x8c/0xa0
[181201.302955] [<ffffffff8141b234>] kernel_thread_helper+0x4/0x10
[181201.302957] [<ffffffff81085e80>] ? kthread_worker_fn+0x190/0x190
[181201.302959] [<ffffffff8141b230>] ? gs_change+0x13/0x13
[181201.302960] INFO: task btrfs-delalloc-:30957 blocked for more than=20
120 seconds.
[181201.302962] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs"=20
disables this message.
[181201.302963] btrfs-delalloc- D 00000001033b5a86 0 30957 2=20
0x00000000
[181201.302965] ffff88005147fc50 0000000000000046 0080004000000000=20
0800040002000100
[181201.302967] ffff880072ab8e40 ffff88005147ffd8 ffff88005147ffd8=20
ffff88005147ffd8
[181201.302969] ffff880073f09c80 ffff880072ab8e40 0000000000000001=20
0000000000000000
[181201.302970] Call Trace:
[181201.302973] [<ffffffffa06fea84>] ? zlib_tr_flush_block+0x5f4/0x6f0=
=20
[zlib_deflate]
[181201.302975] [<ffffffffa06fb6cc>] ? flush_pending+0x4c/0x90=20
[zlib_deflate]
[181201.302978] [<ffffffffa06fb6cc>] ? flush_pending+0x4c/0x90=20
[zlib_deflate]
[181201.302980] [<ffffffffa06fc506>] ? zlib_deflate+0x1b6/0x410=20
[zlib_deflate]
[181201.302982] [<ffffffff814158bf>] schedule+0x3f/0x60
[181201.302988] [<ffffffffa072a705>]=20
wait_current_trans.isra.22+0xa5/0xf0 [btrfs]
[181201.302990] [<ffffffff81086850>] ? abort_exclusive_wait+0xb0/0xb0
[181201.302997] [<ffffffffa072be20>] start_transaction+0x1f0/0x2b0=20
[btrfs]
[181201.303003] [<ffffffffa072bf35>] btrfs_join_transaction+0x15/0x20=20
[btrfs]
[181201.303010] [<ffffffffa0733a55>] compress_file_range+0x2c5/0x660=20
[btrfs]
[181201.303017] [<ffffffffa0733e25>] async_cow_start+0x35/0x50 [btrfs]
[181201.303023] [<ffffffffa0754870>] worker_loop+0x150/0x520 [btrfs]
[181201.303029] [<ffffffffa0754720>] ? btrfs_queue_worker+0x300/0x300=20
[btrfs]
[181201.303032] [<ffffffff81085f0c>] kthread+0x8c/0xa0
[181201.303033] [<ffffffff8141b234>] kernel_thread_helper+0x4/0x10
[181201.303036] [<ffffffff81085e80>] ? kthread_worker_fn+0x190/0x190
[181201.303037] [<ffffffff8141b230>] ? gs_change+0x13/0x13
[181321.301930] INFO: task btrfs-submit-1:768 blocked for more than 120=
=20
seconds.
[181321.302761] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs"=20
disables this message.
[181321.303594] btrfs-submit-1 D 0000000021102920 0 768 2=20
0x00000000
[181321.304428] ffff88006d1b7aa0 0000000000000046 0000000100000000=20
0000000300000001
[181321.305272] ffff880072c64020 ffff88006d1b7fd8 ffff88006d1b7fd8=20
ffff88006d1b7fd8
[181321.306110] ffff88006d900000 ffff880072c64020 ffff88006d1b7a00=20
ffffffff8104e053
[181321.306940] Call Trace:
[181321.307759] [<ffffffff8104e053>] ? __wake_up+0x53/0x70
[181321.308595] [<ffffffff8114e95b>] ? kfree+0x3b/0x170
[181321.309428] [<ffffffffa053535b>] ? plugger_unplug+0x3b/0x50=20
[md_mod]
[181321.310266] [<ffffffff8121ca57>] ? blk_flush_plug_list+0xa7/0x250
[181321.311107] [<ffffffff814158bf>] schedule+0x3f/0x60
[181321.311951] [<ffffffffa058b209>] get_active_stripe+0x2e9/0x600=20
[raid456]
[181321.312805] [<ffffffffa0534400>] ? max_sync_store+0xc0/0xe0=20
[md_mod]
[181321.313657] [<ffffffff8105cf10>] ? try_to_wake_up+0x290/0x290
[181321.314510] [<ffffffffa058ee22>] make_request+0x192/0x430 [raid456=
]
[181321.315376] [<ffffffff81086850>] ? abort_exclusive_wait+0xb0/0xb0
[181321.316234] [<ffffffffa053752a>] md_make_request+0xfa/0x240=20
[md_mod]
[181321.317094] [<ffffffff8114e95b>] ? kfree+0x3b/0x170
[181321.317952] [<ffffffff8121af47>] generic_make_request+0xc7/0x100
[181321.318821] [<ffffffff8121b007>] submit_bio+0x87/0x110
[181321.319690] [<ffffffffa074dcfb>] run_scheduled_bios+0x26b/0x590=20
[btrfs]
[181321.320564] [<ffffffffa074e035>] pending_bios_fn+0x15/0x20 [btrfs]
[181321.321441] [<ffffffffa0754870>] worker_loop+0x150/0x520 [btrfs]
[181321.322311] [<ffffffff8104c568>] ? __wake_up_common+0x58/0x90
[181321.323167] [<ffffffffa0754720>] ? btrfs_queue_worker+0x300/0x300=20
[btrfs]
[181321.324015] [<ffffffff81085f0c>] kthread+0x8c/0xa0
[181321.324856] [<ffffffff8141b234>] kernel_thread_helper+0x4/0x10
[181321.325700] [<ffffffff81085e80>] ? kthread_worker_fn+0x190/0x190
[181321.326537] [<ffffffff8141b230>] ? gs_change+0x13/0x13
[181321.327360] INFO: task btrfs-transacti:780 blocked for more than=20
120 seconds.
[181321.328189] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs"=20
disables this message.
[181321.329035] btrfs-transacti D 00000001033b48f7 0 780 2=20
0x00000000
[181321.329900] ffff88006d1e9430 0000000000000046 ffff880000000000=20
ffffffff810146ef
[181321.330774] ffff88006d905ca0 ffff88006d1e9fd8 ffff88006d1e9fd8=20
ffff88006d1e9fd8
[181321.331646] ffff880073e97200 ffff88006d905ca0 ffff88006d1e9380=20
ffffffff8108cb65
[181321.332527] Call Trace:
[181321.333375] [<ffffffff810146ef>] ? __switch_to+0xbf/0x2f0
[181321.334238] [<ffffffff8108cb65>] ? sched_clock_local+0x25/0x90
[181321.335104] [<ffffffffa0726640>] ? btrfs_buffer_uptodate+0x50/0x70=
=20
[btrfs]
[181321.335980] [<ffffffffa070c48c>] ? comp_keys+0x2c/0x30 [btrfs]
[181321.336843] [<ffffffff814158bf>] schedule+0x3f/0x60
[181321.337704] [<ffffffffa058b209>] get_active_stripe+0x2e9/0x600=20
[raid456]
[181321.338581] [<ffffffff8105cf10>] ? try_to_wake_up+0x290/0x290
[181321.339447] [<ffffffffa058ee22>] make_request+0x192/0x430 [raid456=
]
[181321.340320] [<ffffffff81086850>] ? abort_exclusive_wait+0xb0/0xb0
[181321.341194] [<ffffffffa053752a>] md_make_request+0xfa/0x240=20
[md_mod]
[181321.342084] [<ffffffffa074e14e>] ? __btrfs_map_block+0x10e/0x840=20
[btrfs]
[181321.342958] [<ffffffff8121af47>] generic_make_request+0xc7/0x100
[181321.343818] [<ffffffff8121b007>] submit_bio+0x87/0x110
[181321.344668] [<ffffffffa0751ebe>] btrfs_map_bio+0x13e/0x1d0 [btrfs]
[181321.345524] [<ffffffffa072d799>] btrfs_submit_bio_hook+0xa9/0x170=20
[btrfs]
[181321.346365] [<ffffffff81199eb1>] ?=20
__bio_add_page.part.14+0x101/0x240
[181321.347216] [<ffffffffa0745c9a>] submit_one_bio+0x6a/0xa0 [btrfs]
[181321.348059] [<ffffffffa07492fd>]=20
submit_extent_page.isra.28+0xdd/0x200 [btrfs]
[181321.348912] [<ffffffffa074a0ac>] __extent_writepage+0x52c/0x740=20
[btrfs]
[181321.349763] [<ffffffffa0746e80>] ? clear_extent_bit+0x3d0/0x3d0=20
[btrfs]
[181321.350613] [<ffffffffa074a58a>]=20
extent_write_cache_pages.isra.22.constprop.30+0x2ca/0x3f0 [btrfs]
[181321.351480] [<ffffffffa074a8f5>] extent_writepages+0x45/0x60=20
[btrfs]
[181321.352351] [<ffffffffa072f780>] ?=20
uncompress_inline.isra.47+0x1d0/0x1d0 [btrfs]
[181321.353220] [<ffffffffa0746c7a>] ? clear_extent_bit+0x1ca/0x3d0=20
[btrfs]
[181321.354089] [<ffffffffa072ea68>] btrfs_writepages+0x28/0x30 [btrfs=
]
[181321.354955] [<ffffffff8110eb64>] do_writepages+0x24/0x40
[181321.355823] [<ffffffff811043cb>]=20
__filemap_fdatawrite_range+0x5b/0x60
[181321.356688] [<ffffffff811043ef>] filemap_fdatawrite+0x1f/0x30
[181321.357546] [<ffffffff81104435>] filemap_write_and_wait+0x35/0x60
[181321.358408] [<ffffffffa07616c7>]=20
__btrfs_write_out_cache+0x807/0xa80 [btrfs]
[181321.359281] [<ffffffffa0767008>] ?=20
btrfs_find_ref_cluster+0x68/0x190 [btrfs]
[181321.360147] [<ffffffffa07619d5>] btrfs_write_out_cache+0x95/0xf0=20
[btrfs]
[181321.361012] [<ffffffffa071abe1>]=20
btrfs_write_dirty_block_groups+0x481/0x580 [btrfs]
[181321.361888] [<ffffffffa0729c05>] commit_cowonly_roots+0x115/0x1e0=20
[btrfs]
[181321.362759] [<ffffffffa072b3ec>]=20
btrfs_commit_transaction+0x3fc/0x880 [btrfs]
[181321.363632] [<ffffffff81086850>] ? abort_exclusive_wait+0xb0/0xb0
[181321.364508] [<ffffffffa072bcc4>] ? start_transaction+0x94/0x2b0=20
[btrfs]
[181321.365388] [<ffffffffa0723e6d>] transaction_kthread+0x26d/0x290=20
[btrfs]
[181321.366265] [<ffffffffa0723c00>] ? btrfs_congested_fn+0xd0/0xd0=20
[btrfs]
[181321.367138] [<ffffffff81085f0c>] kthread+0x8c/0xa0
[181321.368005] [<ffffffff8141b234>] kernel_thread_helper+0x4/0x10
[181321.368875] [<ffffffff81085e80>] ? kthread_worker_fn+0x190/0x190
[181321.369726] [<ffffffff8141b230>] ? gs_change+0x13/0x13
[181321.370560] INFO: task rsync:30933 blocked for more than 120=20
seconds.
[181321.371399] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs"=20
disables this message.
[181321.372258] rsync D 00000001033b48f2 0 30933 30932=20
0x00000000
[181321.373125] ffff880072ce5b98 0000000000000082 0000000000000000=20
0000000000000001
[181321.373990] ffff88006d9023a0 ffff880072ce5fd8 ffff880072ce5fd8=20
ffff880072ce5fd8
[181321.374857] ffffffff8180d020 ffff88006d9023a0 ffffffff81177b50=20
00000000000000db
[181321.375735] Call Trace:
[181321.376591] [<ffffffff81177b50>] ? poll_freewait+0xe0/0xe0
[181321.377461] [<ffffffff81177c40>] ? __pollwait+0xf0/0xf0
[181321.378325] [<ffffffff81051970>] ? select_task_rq_fair+0x540/0xa60
[181321.379197] [<ffffffff814158bf>] schedule+0x3f/0x60
[181321.380058] [<ffffffffa072a705>]=20
wait_current_trans.isra.22+0xa5/0xf0 [btrfs]
[181321.380929] [<ffffffff81086850>] ? abort_exclusive_wait+0xb0/0xb0
[181321.381802] [<ffffffffa072be20>] start_transaction+0x1f0/0x2b0=20
[btrfs]
[181321.382684] [<ffffffffa072bf35>] btrfs_join_transaction+0x15/0x20=20
[btrfs]
[181321.383561] [<ffffffffa0736980>] btrfs_dirty_inode+0x50/0xd0=20
[btrfs]
[181321.384434] [<ffffffffa0736c86>] btrfs_update_time+0xd6/0x170=20
[btrfs]
[181321.385311] [<ffffffffa073aee8>] btrfs_file_aio_write+0x1c8/0x520=20
[btrfs]
[181321.386179] [<ffffffff8116e8f2>] ? pipe_read+0x2d2/0x4e0
[181321.387043] [<ffffffff81164302>] do_sync_write+0xd2/0x110
[181321.387899] [<ffffffff81051019>] ? finish_task_switch+0x49/0xd0
[181321.388763] [<ffffffff811f266c>] ?=20
security_file_permission+0x2c/0xb0
[181321.389623] [<ffffffff811648b1>] ? rw_verify_area+0x61/0xf0
[181321.390475] [<ffffffff81164c0f>] vfs_write+0xaf/0x180
[181321.391324] [<ffffffff81164f3a>] sys_write+0x4a/0x90
[181321.392163] [<ffffffff814190c2>] system_call_fastpath+0x16/0x1b
[181321.392993] INFO: task flush-btrfs-1:30940 blocked for more than=20
120 seconds.
[181321.393826] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs"=20
disables this message.
[181321.394670] flush-btrfs-1 D 00000001033b5a85 0 30940 2=20
0x00000000
[181321.395531] ffff8800236218d0 0000000000000046 ffff880000000000=20
ffffffffa075460e
[181321.396394] ffff88007222b1e0 ffff880023621fd8 ffff880023621fd8=20
ffff880023621fd8
[181321.397258] ffff880073e97200 ffff88007222b1e0 ffff88000dad1550=20
ffff880023621870
[181321.398118] Call Trace:
[181321.398977] [<ffffffffa075460e>] ? btrfs_queue_worker+0x1ee/0x300=20
[btrfs]
[181321.399856] [<ffffffffa07330b5>] ? run_delalloc_range+0x185/0x360=20
[btrfs]
[181321.400728] [<ffffffff8101d639>] ? read_tsc+0x9/0x20
[181321.401593] [<ffffffff81103140>] ? __lock_page+0x70/0x70
[181321.402460] [<ffffffff814158bf>] schedule+0x3f/0x60
[181321.403310] [<ffffffff8141596f>] io_schedule+0x8f/0xd0
[181321.404153] [<ffffffff8110314e>] sleep_on_page+0xe/0x20
[181321.404988] [<ffffffff8141623a>] __wait_on_bit_lock+0x5a/0xc0
[181321.405829] [<ffffffff81103137>] __lock_page+0x67/0x70
[181321.406660] [<ffffffff81086890>] ?=20
autoremove_wake_function+0x40/0x40
[181321.407500] [<ffffffffa074a4d5>]=20
extent_write_cache_pages.isra.22.constprop.30+0x215/0x3f0 [btrfs]
[181321.408359] [<ffffffffa074a8f5>] extent_writepages+0x45/0x60=20
[btrfs]
[181321.409220] [<ffffffffa072f780>] ?=20
uncompress_inline.isra.47+0x1d0/0x1d0 [btrfs]
[181321.410085] [<ffffffffa072ea68>] btrfs_writepages+0x28/0x30 [btrfs=
]
[181321.410946] [<ffffffff8110eb64>] do_writepages+0x24/0x40
[181321.411799] [<ffffffff8118ce0f>] writeback_single_inode+0x10f/0x3f=
0
[181321.412651] [<ffffffff8118d4ea>] writeback_sb_inodes+0x1aa/0x270
[181321.413480] [<ffffffff8118d64e>] __writeback_inodes_wb+0x9e/0xd0
[181321.414304] [<ffffffff8118dc6b>] wb_writeback+0x37b/0x3b0
[181321.415118] [<ffffffff8117ebd2>] ? get_nr_inodes+0x52/0x70
[181321.415934] [<ffffffff8117f8d2>] ? get_nr_dirty_inodes+0x52/0x80
[181321.416731] [<ffffffff8118dd3f>] wb_check_old_data_flush+0x9f/0xb0
[181321.417525] [<ffffffff8118f21c>] wb_do_writeback+0x19c/0x230
[181321.418322] [<ffffffff81415e43>] ? schedule_timeout+0x173/0x390
[181321.419127] [<ffffffff81072c10>] ?=20
init_timer_deferrable_key+0x30/0x30
[181321.419928] [<ffffffff8118f33c>] bdi_writeback_thread+0x8c/0x340
[181321.420724] [<ffffffff8118f2b0>] ? wb_do_writeback+0x230/0x230
[181321.421513] [<ffffffff81085f0c>] kthread+0x8c/0xa0
[181321.422300] [<ffffffff8141b234>] kernel_thread_helper+0x4/0x10
[181321.423086] [<ffffffff81085e80>] ? kthread_worker_fn+0x190/0x190
[181321.423868] [<ffffffff8141b230>] ? gs_change+0x13/0x13
[181321.424650] INFO: task btrfs-delalloc-:30957 blocked for more than=20
120 seconds.
[181321.425455] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs"=20
disables this message.
[181321.426264] btrfs-delalloc- D 00000001033b5a86 0 30957 2=20
0x00000000
[181321.427088] ffff88005147fc50 0000000000000046 0080004000000000=20
0800040002000100
[181321.427922] ffff880072ab8e40 ffff88005147ffd8 ffff88005147ffd8=20
ffff88005147ffd8
[181321.428764] ffff880073f09c80 ffff880072ab8e40 0000000000000001=20
0000000000000000
[181321.429604] Call Trace:
[181321.430433] [<ffffffffa06fea84>] ? zlib_tr_flush_block+0x5f4/0x6f0=
=20
[zlib_deflate]
[181321.431299] [<ffffffffa06fb6cc>] ? flush_pending+0x4c/0x90=20
[zlib_deflate]
[181321.432176] [<ffffffffa06fb6cc>] ? flush_pending+0x4c/0x90=20
[zlib_deflate]
[181321.433026] [<ffffffffa06fc506>] ? zlib_deflate+0x1b6/0x410=20
[zlib_deflate]
[181321.433865] [<ffffffff814158bf>] schedule+0x3f/0x60
[181321.434692] [<ffffffffa072a705>]=20
wait_current_trans.isra.22+0xa5/0xf0 [btrfs]
[181321.435529] [<ffffffff81086850>] ? abort_exclusive_wait+0xb0/0xb0
[181321.436362] [<ffffffffa072be20>] start_transaction+0x1f0/0x2b0=20
[btrfs]
[181321.437204] [<ffffffffa072bf35>] btrfs_join_transaction+0x15/0x20=20
[btrfs]
[181321.438039] [<ffffffffa0733a55>] compress_file_range+0x2c5/0x660=20
[btrfs]
[181321.438876] [<ffffffffa0733e25>] async_cow_start+0x35/0x50 [btrfs]
[181321.439707] [<ffffffffa0754870>] worker_loop+0x150/0x520 [btrfs]
[181321.440535] [<ffffffffa0754720>] ? btrfs_queue_worker+0x300/0x300=20
[btrfs]
[181321.441366] [<ffffffff81085f0c>] kthread+0x8c/0xa0
[181321.442202] [<ffffffff8141b234>] kernel_thread_helper+0x4/0x10
[181321.443039] [<ffffffff81085e80>] ? kthread_worker_fn+0x190/0x190
[181321.443880] [<ffffffff8141b230>] ? gs_change+0x13/0x13
On =CE=94=CE=B5=CF=85=CF=84=CE=AD=CF=81=CE=B1, 5 =CE=94=CE=B5=CE=BA=CE=AD=
=CE=BC=CE=B2=CF=81=CE=B9=CE=BF=CF=82 2011 3:12:52 =CE=BC=CE=BC, Chris M=
ason wrote:
> On Sat, Dec 03, 2011 at 04:36:44PM +0200, Konstantinos Skarlatos wrot=
e:
>> unfortunately i was wrong. rc4 does not fix this issue for me when
>> rsyncing large amounts of data...
>>
>> my mount options:
>> mount -o loop,compress=3Dzlib,compress-force btrfs_test /storage/btr=
fs
>> the filesystem is a file on a raid5 xfs volume.
>
> Oh, the loop + raid5 + xfs is going to cause problems. The loop driv=
er
> is fine for testing but I wouldn't be using it in a production
> environment.
>
> -chris
--
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
prev parent reply other threads:[~2011-12-25 1:06 UTC|newest]
Thread overview: 15+ messages / expand[flat|nested] mbox.gz Atom feed top
2011-11-28 8:16 Blcoked for more than 120 seconds Tobias
2011-11-28 9:29 ` Chris Samuel
2011-11-30 9:44 ` Blocked " Tobias
2011-11-30 14:10 ` Chris Mason
[not found] ` <4ED738E5.3080200@robotech.de>
2011-12-01 18:41 ` Chris Mason
2011-12-02 13:46 ` Tobias
2011-12-02 14:01 ` Chris Mason
2011-12-04 12:11 ` Konstantinos Skarlatos
2011-12-02 15:22 ` Konstantinos Skarlatos
2011-12-02 15:48 ` Tobias
2011-12-02 19:53 ` Konstantinos Skarlatos
2011-12-03 0:35 ` Konstantinos Skarlatos
2011-12-03 14:36 ` Konstantinos Skarlatos
2011-12-05 13:12 ` Chris Mason
2011-12-25 1:06 ` Konstantinos Skarlatos [this message]
Reply instructions:
You may reply publicly to this message via plain-text email
using any one of the following methods:
* Save the following mbox file, import it into your mail client,
and reply-to-all from there: mbox
Avoid top-posting and favor interleaved quoting:
https://en.wikipedia.org/wiki/Posting_style#Interleaved_style
* Reply using the --to, --cc, and --in-reply-to
switches of git-send-email(1):
git send-email \
--in-reply-to=4EF67730.5050108@gmail.com \
--to=k.skarlatos@gmail.com \
--cc=chris.mason@oracle.com \
--cc=linux-btrfs@vger.kernel.org \
--cc=tracer@robotech.de \
/path/to/YOUR_REPLY
https://kernel.org/pub/software/scm/git/docs/git-send-email.html
* If your mail client supports setting the In-Reply-To header
via mailto: links, try the mailto: link
Be sure your reply has a Subject: header at the top and a blank line
before the message body.
This is an external index of several public inboxes,
see mirroring instructions on how to clone and mirror
all data and code used by this external index.