--- Begin Message ---
- To: Debian Bug Tracking System <submit@bugs.debian.org>
- Subject: btrfs-tools: btrfs lockup after upgrade
- From: Osamu Aoki <osamu@debian.org>
- Date: Sun, 5 Jan 2014 12:22:02 +0900
- Message-id: <20140105032202.GA6212@goofy>
Package: btrfs-tools
Version: 3.12-1
Severity: normal
After upgrading btrfs-tools, my secondary disk with btrfs experiences
hard lockup when accessed by obnam to backup my main harddisk.
I am filing this bug here since symptom is very similar to the
previously fixed bug. (also I see flush-btrfs-1 in dmsg)
Once this happens, obnam freeze. After this, enen running "sync"
hang-up hard. No shoutdown. Since this happens on my secondary disk, I
have running system and here is dmesg after this lock up:
[ 484.240088] INFO: task kworker/u16:5:271 blocked for more than 120 seconds.
[ 484.240092] Not tainted 3.12-1-rt-amd64 #1
[ 484.240093] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 484.240095] kworker/u16:5 D ffff880036667390 0 271 2 0x00000000
[ 484.240103] Workqueue: writeback bdi_writeback_workfn (flush-btrfs-1)
[ 484.240107] ffff880036667020 0000000000000046 ffff8800367effd8 ffff8800367effd8
[ 484.240108] ffff8800367effd8 ffff8800367effd8 ffff880036667020 ffff880036667678
[ 484.240109] ffff8800367ef9f8 ffff8800367effd8 ffff8803f4183a98 ffff880036667020
[ 484.240111] Call Trace:
[ 484.240117] [<ffffffff814afa81>] ? schedule+0x21/0x90
[ 484.240119] [<ffffffff814b0a35>] ? rt_spin_lock_slowlock+0xc5/0x290
[ 484.240143] [<ffffffffa0285d54>] ? btrfs_try_tree_write_lock+0x34/0xa0 [btrfs]
[ 484.240152] [<ffffffffa0271228>] ? btree_write_cache_pages+0x258/0x860 [btrfs]
[ 484.240160] [<ffffffffa026ac90>] ? end_extent_buffer_writeback+0x20/0x20 [btrfs]
[ 484.240162] [<ffffffff811acb68>] ? __writeback_single_inode+0x38/0x360
[ 484.240165] [<ffffffff8105ee6d>] ? unpin_current_cpu+0xd/0x60
[ 484.240167] [<ffffffff811ad40e>] ? writeback_sb_inodes+0x28e/0x4b0
[ 484.240168] [<ffffffff811ad7e9>] ? wb_writeback+0xf9/0x3c0
[ 484.240170] [<ffffffff811ae1aa>] ? bdi_writeback_workfn+0x12a/0x530
[ 484.240172] [<ffffffff814b1415>] ? _raw_spin_unlock_irq+0x15/0x40
[ 484.240174] [<ffffffff8108ba50>] ? finish_task_switch+0x40/0xe0
[ 484.240175] [<ffffffff8108e669>] ? get_parent_ip+0x9/0x20
[ 484.240177] [<ffffffff8105ee6d>] ? unpin_current_cpu+0xd/0x60
[ 484.240179] [<ffffffff8107a41d>] ? process_one_work+0x16d/0x4b0
[ 484.240180] [<ffffffff8107a875>] ? worker_thread+0x115/0x380
[ 484.240182] [<ffffffff8107a760>] ? process_one_work+0x4b0/0x4b0
[ 484.240183] [<ffffffff81081571>] ? kthread+0xa1/0xb0
[ 484.240184] [<ffffffff810814d0>] ? kthread_worker_fn+0x190/0x190
[ 484.240186] [<ffffffff814b880c>] ? ret_from_fork+0x7c/0xb0
[ 484.240187] [<ffffffff810814d0>] ? kthread_worker_fn+0x190/0x190
[ 484.240193] INFO: task btrfs-endio-wri:885 blocked for more than 120 seconds.
[ 484.240202] Not tainted 3.12-1-rt-amd64 #1
[ 484.240203] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 484.240204] btrfs-endio-wri D ffff880035dc0c10 0 885 2 0x00000000
[ 484.240207] ffff880035dc08a0 0000000000000046 ffff88041a0d5fd8 ffff88041a0d5fd8
[ 484.240208] ffff88041a0d5fd8 ffff88041a0d5fd8 ffff880035dc08a0 ffff880035dc0ef8
[ 484.240210] ffff88041a0d5b20 ffff88041a0d5fd8 ffff880035623c60 ffff880035dc08a0
[ 484.240211] Call Trace:
[ 484.240214] [<ffffffff814afa81>] ? schedule+0x21/0x90
[ 484.240215] [<ffffffff814b0a35>] ? rt_spin_lock_slowlock+0xc5/0x290
[ 484.240221] [<ffffffffa0227f01>] ? unlock_up+0x91/0x1a0 [btrfs]
[ 484.240228] [<ffffffffa0285d54>] ? btrfs_try_tree_write_lock+0x34/0xa0 [btrfs]
[ 484.240235] [<ffffffffa022ea58>] ? btrfs_search_slot+0x358/0x990 [btrfs]
[ 484.240241] [<ffffffffa0230993>] ? btrfs_insert_empty_items+0x63/0xb0 [btrfs]
[ 484.240248] [<ffffffffa026b2fe>] ? release_extent_buffer+0xae/0xd0 [btrfs]
[ 484.240255] [<ffffffffa0246111>] ? btrfs_csum_file_blocks+0x2e1/0x670 [btrfs]
[ 484.240263] [<ffffffffa02544f6>] ? add_pending_csums.isra.38+0x46/0x70 [btrfs]
[ 484.240271] [<ffffffffa025d8a9>] ? btrfs_finish_ordered_io+0x419/0xa50 [btrfs]
[ 484.240273] [<ffffffff8106aa50>] ? ftrace_raw_output_tick_stop+0x60/0x60
[ 484.240274] [<ffffffff8105ed40>] ? pin_current_cpu+0x90/0x1b0
[ 484.240276] [<ffffffff8108e669>] ? get_parent_ip+0x9/0x20
[ 484.240277] [<ffffffff8105ee6d>] ? unpin_current_cpu+0xd/0x60
[ 484.240285] [<ffffffffa027e9f3>] ? worker_loop+0x153/0x5b0 [btrfs]
[ 484.240292] [<ffffffffa027e8a0>] ? btrfs_queue_worker+0x350/0x350 [btrfs]
[ 484.240293] [<ffffffff81081571>] ? kthread+0xa1/0xb0
[ 484.240294] [<ffffffff810814d0>] ? kthread_worker_fn+0x190/0x190
[ 484.240296] [<ffffffff814b880c>] ? ret_from_fork+0x7c/0xb0
[ 484.240297] [<ffffffff810814d0>] ? kthread_worker_fn+0x190/0x190
[ 484.240299] INFO: task btrfs-flush_del:890 blocked for more than 120 seconds.
[ 484.240307] Not tainted 3.12-1-rt-amd64 #1
[ 484.240308] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 484.240309] btrfs-flush_del D ffff880417b51d50 0 890 2 0x00000000
[ 484.240312] ffff880417b519e0 0000000000000046 ffff88041a0dffd8 ffff88041a0dffd8
[ 484.240313] ffff88041a0dffd8 ffff88041a0dffd8 ffff880417b519e0 ffff8803ed158ea0
[ 484.240314] ffff8803edec7180 0000000000000001 0000000000001000 0000000000001000
[ 484.240316] Call Trace:
[ 484.240318] [<ffffffff814afa81>] ? schedule+0x21/0x90
[ 484.240326] [<ffffffffa0269c05>] ? btrfs_start_ordered_extent+0x75/0x150 [btrfs]
[ 484.240327] [<ffffffff81081fb0>] ? wake_up_atomic_t+0x30/0x30
[ 484.240334] [<ffffffffa026a411>] ? btrfs_wait_ordered_range+0x81/0xf0 [btrfs]
[ 484.240342] [<ffffffffa02571dd>] ? btrfs_run_delalloc_work+0x1d/0x70 [btrfs]
[ 484.240349] [<ffffffffa027e9f3>] ? worker_loop+0x153/0x5b0 [btrfs]
[ 484.240355] [<ffffffffa027e8a0>] ? btrfs_queue_worker+0x350/0x350 [btrfs]
[ 484.240357] [<ffffffff81081571>] ? kthread+0xa1/0xb0
[ 484.240358] [<ffffffff810814d0>] ? kthread_worker_fn+0x190/0x190
[ 484.240359] [<ffffffff814b880c>] ? ret_from_fork+0x7c/0xb0
[ 484.240360] [<ffffffff810814d0>] ? kthread_worker_fn+0x190/0x190
[ 484.240362] INFO: task btrfs-transacti:931 blocked for more than 120 seconds.
[ 484.240367] Not tainted 3.12-1-rt-amd64 #1
[ 484.240368] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 484.240369] btrfs-transacti D ffff880036532e90 0 931 2 0x00000000
[ 484.240372] ffff880036532b20 0000000000000046 ffff880419d05fd8 ffff880419d05fd8
[ 484.240373] ffff880419d05fd8 ffff880419d05fd8 ffff880036532b20 ffff880419d05d88
[ 484.240374] ffff8803df649010 ffff880036532b20 ffff8800bf3b4228 ffff880419d05df0
[ 484.240376] Call Trace:
[ 484.240378] [<ffffffff814afa81>] ? schedule+0x21/0x90
[ 484.240380] [<ffffffff814ae191>] ? schedule_timeout+0x291/0x3b0
[ 484.240381] [<ffffffff8108df00>] ? resched_task+0x40/0x70
[ 484.240383] [<ffffffff8108e375>] ? check_preempt_curr+0x65/0x90
[ 484.240384] [<ffffffff814aec65>] ? wait_for_completion+0x95/0xd0
[ 484.240392] [<ffffffffa026177d>] ? btrfs_wait_and_free_delalloc_work+0xd/0x20 [btrfs]
[ 484.240399] [<ffffffffa0269aae>] ? btrfs_run_ordered_operations+0x1fe/0x2e0 [btrfs]
[ 484.240407] [<ffffffffa025179b>] ? btrfs_commit_transaction+0x22b/0xa20 [btrfs]
[ 484.240414] [<ffffffffa025201b>] ? start_transaction+0x8b/0x530 [btrfs]
[ 484.240415] [<ffffffff8105ee6d>] ? unpin_current_cpu+0xd/0x60
[ 484.240423] [<ffffffffa02487f5>] ? transaction_kthread+0x1a5/0x230 [btrfs]
[ 484.240429] [<ffffffffa0248650>] ? verify_parent_transid+0x140/0x140 [btrfs]
[ 484.240430] [<ffffffff81081571>] ? kthread+0xa1/0xb0
[ 484.240431] [<ffffffff810814d0>] ? kthread_worker_fn+0x190/0x190
[ 484.240433] [<ffffffff814b880c>] ? ret_from_fork+0x7c/0xb0
[ 484.240434] [<ffffffff810814d0>] ? kthread_worker_fn+0x190/0x190
[ 484.240454] INFO: task obnam:3833 blocked for more than 120 seconds.
[ 484.240461] Not tainted 3.12-1-rt-amd64 #1
[ 484.240462] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 484.240463] obnam D ffff880419593730 0 3833 3690 0x00000080
[ 484.240466] ffff8804195933c0 0000000000000086 ffff8803f0eaffd8 ffff8803f0eaffd8
[ 484.240467] ffff8803f0eaffd8 ffff8803f0eaffd8 ffff8804195933c0 ffff880419593a18
[ 484.240468] ffff8803f0eaf8d0 ffff8803f0eaffd8 ffff8803f4183a98 ffff8804195933c0
[ 484.240470] Call Trace:
[ 484.240472] [<ffffffff814afa81>] ? schedule+0x21/0x90
[ 484.240473] [<ffffffff814b0a35>] ? rt_spin_lock_slowlock+0xc5/0x290
[ 484.240475] [<ffffffff814b136f>] ? rt_read_lock+0x1f/0x30
[ 484.240483] [<ffffffffa0285bc4>] ? btrfs_tree_read_lock+0x54/0x140 [btrfs]
[ 484.240485] [<ffffffff811b90d2>] ? bio_alloc_bioset+0x1a2/0x270
[ 484.240491] [<ffffffffa0229e43>] ? btrfs_read_lock_root_node+0x33/0x40 [btrfs]
[ 484.240497] [<ffffffffa022ec0f>] ? btrfs_search_slot+0x50f/0x990 [btrfs]
[ 484.240505] [<ffffffffa0269e72>] ? btrfs_lookup_ordered_extent+0x162/0x1b0 [btrfs]
[ 484.240512] [<ffffffffa0244b3a>] ? btrfs_lookup_csum+0x5a/0x170 [btrfs]
[ 484.240530] [<ffffffffa0244e23>] ? __btrfs_lookup_bio_sums.isra.8+0x1d3/0x4f0 [btrfs]
[ 484.240531] [<ffffffff81080004>] ? SyS_timer_create+0x184/0x540
[ 484.240539] [<ffffffffa024b8e2>] ? btrfs_bio_wq_end_io+0x22/0x70 [btrfs]
[ 484.240546] [<ffffffffa024538d>] ? btrfs_lookup_bio_sums+0x2d/0x40 [btrfs]
[ 484.240554] [<ffffffffa0254bc5>] ? btrfs_submit_bio_hook+0x135/0x1c0 [btrfs]
[ 484.240567] [<ffffffff8108e669>] ? get_parent_ip+0x9/0x20
[ 484.240574] [<ffffffffa026ab73>] ? submit_one_bio+0x63/0x90 [btrfs]
[ 484.240582] [<ffffffffa02706e7>] ? extent_readpages+0x107/0x190 [btrfs]
[ 484.240589] [<ffffffffa0256350>] ? btrfs_submit_direct+0x6b0/0x6b0 [btrfs]
[ 484.240592] [<ffffffff8112fc76>] ? __do_page_cache_readahead+0x1b6/0x260
[ 484.240593] [<ffffffff8113012a>] ? ondemand_readahead+0x14a/0x2a0
[ 484.240596] [<ffffffff81125096>] ? generic_file_aio_read+0x4b6/0x700
[ 484.240598] [<ffffffff8115335f>] ? mmap_region+0x15f/0x5e0
[ 484.240600] [<ffffffff81183627>] ? do_sync_read+0x57/0x90
[ 484.240602] [<ffffffff81183bc4>] ? vfs_read+0x94/0x160
[ 484.240604] [<ffffffff811846b3>] ? SyS_read+0x43/0xa0
[ 484.240606] [<ffffffff810e63b6>] ? __audit_syscall_exit+0x1f6/0x2a0
[ 484.240608] [<ffffffff814b88b9>] ? system_call_fastpath+0x16/0x1b
[ 484.240609] INFO: task btrfs-endio-wri:3861 blocked for more than 120 seconds.
[ 484.240620] Not tainted 3.12-1-rt-amd64 #1
[ 484.240621] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 484.240622] btrfs-endio-wri D ffff8800c4928370 0 3861 2 0x00000080
[ 484.240625] ffff8800c4928000 0000000000000046 ffff8800bfd0ffd8 ffff8800bfd0ffd8
[ 484.240626] ffff8800bfd0ffd8 ffff8800bfd0ffd8 ffff8800c4928000 ffff8800c4928658
[ 484.240627] ffff8800bfd0faf0 ffff8800bfd0ffd8 ffff8803f413bb38 ffff8800c4928000
[ 484.240629] Call Trace:
[ 484.240631] [<ffffffff814afa81>] ? schedule+0x21/0x90
[ 484.240632] [<ffffffff814b0a35>] ? rt_spin_lock_slowlock+0xc5/0x290
[ 484.240634] [<ffffffff814b136f>] ? rt_read_lock+0x1f/0x30
[ 484.240642] [<ffffffffa0285ce4>] ? btrfs_try_tree_read_lock+0x34/0x70 [btrfs]
[ 484.240648] [<ffffffffa022ec65>] ? btrfs_search_slot+0x565/0x990 [btrfs]
[ 484.240655] [<ffffffffa02adc6a>] ? btrfs_qgroup_record_ref+0x2a/0x60 [btrfs]
[ 484.240662] [<ffffffffa0244b3a>] ? btrfs_lookup_csum+0x5a/0x170 [btrfs]
[ 484.240664] [<ffffffff8117221c>] ? kmem_cache_alloc+0x1ec/0x200
[ 484.240670] [<ffffffffa0245e6f>] ? btrfs_csum_file_blocks+0x3f/0x670 [btrfs]
[ 484.240677] [<ffffffffa0245ef0>] ? btrfs_csum_file_blocks+0xc0/0x670 [btrfs]
[ 484.240678] [<ffffffff8117147c>] ? kmem_cache_free+0x9c/0x210
[ 484.240680] [<ffffffff8105ee6d>] ? unpin_current_cpu+0xd/0x60
[ 484.240687] [<ffffffffa02544f6>] ? add_pending_csums.isra.38+0x46/0x70 [btrfs]
[ 484.240695] [<ffffffffa025d8a9>] ? btrfs_finish_ordered_io+0x419/0xa50 [btrfs]
[ 484.240697] [<ffffffff814b13d8>] ? _raw_spin_unlock_irqrestore+0x18/0x40
[ 484.240698] [<ffffffff8109168b>] ? try_to_wake_up+0x5b/0x350
[ 484.240700] [<ffffffff8105ed40>] ? pin_current_cpu+0x90/0x1b0
[ 484.240701] [<ffffffff8108e669>] ? get_parent_ip+0x9/0x20
[ 484.240703] [<ffffffff8105ee6d>] ? unpin_current_cpu+0xd/0x60
[ 484.240710] [<ffffffffa027e9f3>] ? worker_loop+0x153/0x5b0 [btrfs]
[ 484.240717] [<ffffffffa027e8a0>] ? btrfs_queue_worker+0x350/0x350 [btrfs]
[ 484.240718] [<ffffffff81081571>] ? kthread+0xa1/0xb0
[ 484.240719] [<ffffffff810814d0>] ? kthread_worker_fn+0x190/0x190
[ 484.240721] [<ffffffff814b880c>] ? ret_from_fork+0x7c/0xb0
[ 484.240722] [<ffffffff810814d0>] ? kthread_worker_fn+0x190/0x190
[ 484.240723] INFO: task btrfs-flush_del:3867 blocked for more than 120 seconds.
[ 484.240733] Not tainted 3.12-1-rt-amd64 #1
[ 484.240734] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 484.240735] btrfs-flush_del D ffff880035622e90 0 3867 2 0x00000080
[ 484.240738] ffff880035622b20 0000000000000046 ffff8800bfd41fd8 ffff8800bfd41fd8
[ 484.240739] ffff8800bfd41fd8 ffff8800bfd41fd8 ffff880035622b20 ffff8800b8a2e220
[ 484.240740] ffff8803d8bc9480 0000000000000001 0000000000031000 0000000000001000
[ 484.240742] Call Trace:
[ 484.240744] [<ffffffff814afa81>] ? schedule+0x21/0x90
[ 484.240751] [<ffffffffa0269c05>] ? btrfs_start_ordered_extent+0x75/0x150 [btrfs]
[ 484.240753] [<ffffffff81081fb0>] ? wake_up_atomic_t+0x30/0x30
[ 484.240760] [<ffffffffa026a411>] ? btrfs_wait_ordered_range+0x81/0xf0 [btrfs]
[ 484.240767] [<ffffffffa02571dd>] ? btrfs_run_delalloc_work+0x1d/0x70 [btrfs]
[ 484.240774] [<ffffffffa027e9f3>] ? worker_loop+0x153/0x5b0 [btrfs]
[ 484.240780] [<ffffffffa027e8a0>] ? btrfs_queue_worker+0x350/0x350 [btrfs]
[ 484.240781] [<ffffffff81081571>] ? kthread+0xa1/0xb0
[ 484.240783] [<ffffffff810814d0>] ? kthread_worker_fn+0x190/0x190
[ 484.240784] [<ffffffff814b880c>] ? ret_from_fork+0x7c/0xb0
[ 484.240785] [<ffffffff810814d0>] ? kthread_worker_fn+0x190/0x190
[ 484.240786] INFO: task btrfs-endio-wri:3869 blocked for more than 120 seconds.
[ 484.240791] Not tainted 3.12-1-rt-amd64 #1
[ 484.240792] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 484.240793] btrfs-endio-wri D ffff880035623fd0 0 3869 2 0x00000080
[ 484.240796] ffff880035623c60 0000000000000046 ffff8803f413bfd8 ffff8803f413bfd8
[ 484.240797] ffff8803f413bfd8 ffff8803f413bfd8 ffff880035623c60 ffff8800356242b8
[ 484.240798] ffff8803f413bb38 ffff8803f413bfd8 ffff880035dc08a0 ffff880035623c60
[ 484.240800] Call Trace:
[ 484.240802] [<ffffffff814afa81>] ? schedule+0x21/0x90
[ 484.240804] [<ffffffff814b0a35>] ? rt_spin_lock_slowlock+0xc5/0x290
[ 484.240805] [<ffffffff814b136f>] ? rt_read_lock+0x1f/0x30
[ 484.240812] [<ffffffffa0285a3f>] ? btrfs_clear_lock_blocking_rw+0x4f/0x180 [btrfs]
[ 484.240818] [<ffffffffa0229ca1>] ? btrfs_clear_path_blocking+0x31/0x70 [btrfs]
[ 484.240824] [<ffffffffa022edcc>] ? btrfs_search_slot+0x6cc/0x990 [btrfs]
[ 484.240831] [<ffffffffa02462a2>] ? btrfs_csum_file_blocks+0x472/0x670 [btrfs]
[ 484.240833] [<ffffffff8105ee6d>] ? unpin_current_cpu+0xd/0x60
[ 484.240840] [<ffffffffa02544f6>] ? add_pending_csums.isra.38+0x46/0x70 [btrfs]
[ 484.240847] [<ffffffffa025d8a9>] ? btrfs_finish_ordered_io+0x419/0xa50 [btrfs]
[ 484.240848] [<ffffffff8106aa50>] ? ftrace_raw_output_tick_stop+0x60/0x60
[ 484.240850] [<ffffffff8105ed40>] ? pin_current_cpu+0x90/0x1b0
[ 484.240851] [<ffffffff8108e669>] ? get_parent_ip+0x9/0x20
[ 484.240853] [<ffffffff8105ee6d>] ? unpin_current_cpu+0xd/0x60
[ 484.240860] [<ffffffffa027e9f3>] ? worker_loop+0x153/0x5b0 [btrfs]
[ 484.240866] [<ffffffffa027e8a0>] ? btrfs_queue_worker+0x350/0x350 [btrfs]
[ 484.240867] [<ffffffff81081571>] ? kthread+0xa1/0xb0
[ 484.240869] [<ffffffff810814d0>] ? kthread_worker_fn+0x190/0x190
[ 484.240870] [<ffffffff814b880c>] ? ret_from_fork+0x7c/0xb0
[ 484.240871] [<ffffffff810814d0>] ? kthread_worker_fn+0x190/0x190
[ 484.240872] INFO: task btrfs-endio-wri:3891 blocked for more than 120 seconds.
[ 484.240881] Not tainted 3.12-1-rt-amd64 #1
[ 484.240881] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 484.240882] btrfs-endio-wri D ffff8804174ed9b0 0 3891 2 0x00000080
[ 484.240885] ffff8804174ed640 0000000000000046 ffff8803f4183fd8 ffff8803f4183fd8
[ 484.240886] ffff8803f4183fd8 ffff8803f4183fd8 ffff8804174ed640 ffff8804174edc98
[ 484.240887] ffff8803f4183a98 ffff8803f4183fd8 ffff8800c4928000 ffff8804174ed640
[ 484.240889] Call Trace:
[ 484.240891] [<ffffffff814afa81>] ? schedule+0x21/0x90
[ 484.240893] [<ffffffff814b0a35>] ? rt_spin_lock_slowlock+0xc5/0x290
[ 484.240895] [<ffffffff814b136f>] ? rt_read_lock+0x1f/0x30
[ 484.240901] [<ffffffffa0285bc4>] ? btrfs_tree_read_lock+0x54/0x140 [btrfs]
[ 484.240907] [<ffffffffa0229e43>] ? btrfs_read_lock_root_node+0x33/0x40 [btrfs]
[ 484.240913] [<ffffffffa022ec0f>] ? btrfs_search_slot+0x50f/0x990 [btrfs]
[ 484.240920] [<ffffffffa02adc6a>] ? btrfs_qgroup_record_ref+0x2a/0x60 [btrfs]
[ 484.240927] [<ffffffffa0244b3a>] ? btrfs_lookup_csum+0x5a/0x170 [btrfs]
[ 484.240928] [<ffffffff8117221c>] ? kmem_cache_alloc+0x1ec/0x200
[ 484.240935] [<ffffffffa0245e6f>] ? btrfs_csum_file_blocks+0x3f/0x670 [btrfs]
[ 484.240941] [<ffffffffa0245ef0>] ? btrfs_csum_file_blocks+0xc0/0x670 [btrfs]
[ 484.240942] [<ffffffff8117147c>] ? kmem_cache_free+0x9c/0x210
[ 484.240944] [<ffffffff8105ee6d>] ? unpin_current_cpu+0xd/0x60
[ 484.240951] [<ffffffffa02544f6>] ? add_pending_csums.isra.38+0x46/0x70 [btrfs]
[ 484.240958] [<ffffffffa025d8a9>] ? btrfs_finish_ordered_io+0x419/0xa50 [btrfs]
[ 484.240960] [<ffffffff8106aa50>] ? ftrace_raw_output_tick_stop+0x60/0x60
[ 484.240961] [<ffffffff8105ed40>] ? pin_current_cpu+0x90/0x1b0
[ 484.240963] [<ffffffff8108e669>] ? get_parent_ip+0x9/0x20
[ 484.240964] [<ffffffff8105ee6d>] ? unpin_current_cpu+0xd/0x60
[ 484.240971] [<ffffffffa027e9f3>] ? worker_loop+0x153/0x5b0 [btrfs]
[ 484.240978] [<ffffffffa027e8a0>] ? btrfs_queue_worker+0x350/0x350 [btrfs]
[ 484.240979] [<ffffffff81081571>] ? kthread+0xa1/0xb0
[ 484.240980] [<ffffffff810814d0>] ? kthread_worker_fn+0x190/0x190
[ 484.240982] [<ffffffff814b880c>] ? ret_from_fork+0x7c/0xb0
[ 484.240983] [<ffffffff810814d0>] ? kthread_worker_fn+0x190/0x190
[ 484.240984] INFO: task sync:3955 blocked for more than 120 seconds.
[ 484.240995] Not tainted 3.12-1-rt-amd64 #1
[ 484.240996] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 484.240997] sync D ffff8800c492b730 0 3955 3907 0x00000080
[ 484.241000] ffff8800c492b3c0 0000000000000086 ffff880406901fd8 ffff880406901fd8
[ 484.241001] ffff880406901fd8 ffff880406901fd8 ffff8800c492b3c0 ffff880406901e68
[ 484.241002] ffff880406901eb8 ffff8800c492b3c0 ffffffff811b1c20 0000000000000000
[ 484.241004] Call Trace:
[ 484.241006] [<ffffffff811b1c20>] ? generic_write_sync+0x60/0x60
[ 484.241008] [<ffffffff814afa81>] ? schedule+0x21/0x90
[ 484.241009] [<ffffffff814ae191>] ? schedule_timeout+0x291/0x3b0
[ 484.241010] [<ffffffff8108ec9f>] ? ttwu_do_wakeup+0xf/0x120
[ 484.241012] [<ffffffff814b13d8>] ? _raw_spin_unlock_irqrestore+0x18/0x40
[ 484.241014] [<ffffffff8109168b>] ? try_to_wake_up+0x5b/0x350
[ 484.241015] [<ffffffff8108e669>] ? get_parent_ip+0x9/0x20
[ 484.241017] [<ffffffff811b1c20>] ? generic_write_sync+0x60/0x60
[ 484.241018] [<ffffffff814aec65>] ? wait_for_completion+0x95/0xd0
[ 484.241019] [<ffffffff811ac74f>] ? sync_inodes_sb+0x9f/0x1f0
[ 484.241021] [<ffffffff811b1c20>] ? generic_write_sync+0x60/0x60
[ 484.241022] [<ffffffff8118770a>] ? iterate_supers+0xba/0x120
[ 484.241024] [<ffffffff811b1e6d>] ? sys_sync+0x2d/0x90
[ 484.241025] [<ffffffff814b88b9>] ? system_call_fastpath+0x16/0x1b
...
The upgrade involving btrfs problem also did followings.
Install:
linux-image-3.12-1-rt-amd64:amd64 (3.12.6-2, automatic),
linux-image-3.12-1-amd64:amd64 (3.12.6-2, automatic),
linux-tools-3.12:amd64 (3.12.6-1, automatic),
sysvinit-core:amd64 (2.88dsf-45, automatic),
Upgrade:
initscripts:amd64 (2.88dsf-43, 2.88dsf-45),
sysvinit:amd64 (2.88dsf-43, 2.88dsf-45),
linux-image-rt-amd64:amd64 (3.10+52, 3.12+55),
libsystemd-daemon0:amd64 (204-5, 204-6),
sysv-rc:amd64 (2.88dsf-43, 2.88dsf-45),
btrfs-tools:amd64 (0.19+20130705-3, 3.12-1),
linux-libc-dev:amd64 (3.12.6-1, 3.12.6-2),
Soi others may be the cause.
-- System Information:
Debian Release: jessie/sid
APT prefers unstable
APT policy: (500, 'unstable'), (500, 'testing')
Architecture: amd64 (x86_64)
Foreign Architectures: i386
Kernel: Linux 3.12-1-rt-amd64 (SMP w/8 CPU cores; PREEMPT)
Locale: LANG=en_US.utf8, LC_CTYPE=en_US.utf8 (charmap=UTF-8)
Shell: /bin/sh linked to /bin/dash
Versions of packages btrfs-tools depends on:
ii e2fslibs 1.42.9-2
ii libblkid1 2.20.1-5.5
ii libc6 2.17-97
ii libcomerr2 1.42.9-2
ii liblzo2-2 2.06-1.2
ii libuuid1 2.20.1-5.5
ii zlib1g 1:1.2.8.dfsg-1
btrfs-tools recommends no packages.
btrfs-tools suggests no packages.
-- no debconf information
--- End Message ---
--- Begin Message ---
- To: 734370-done@bugs.debian.org
- Subject: Re: Bug#734237: btrfs-tools: btrfs lockup with 3.12 RT kernel
- From: Hideki Yamane <henrich@gmail.com>
- Date: Mon, 06 Feb 2017 22:51:12 +0900
- Message-id: <1486389072.11965.17.camel@gmail.com>
- In-reply-to: <20140105112458.GA3874@goofy>
- References: <20140105032202.GA6212@goofy> <handler.734237.B.13888921292794.ack@bugs.debian.org> <20140105112458.GA3874@goofy>
control: fixed -1 4.0.5-1
> linux-image btrfs-tools:amd64
> NG: ,,-3.12-1-rt-amd64(3.12.6-2) (3.12-1)
> NG: ,,-3.12-1-rt-amd64(3.12.6-2) (0.19+20130705-3)
>
> GOOD: ,,-3.11-2-amd64 (3.11.10-1) (0.19+20130705-3)
> GOOD: ,,-3.12-1-amd64 (3.12.6-2) (0.19+20130705-3)
> GOOD: ,,-3.12-1-amd64 (3.12.6-2) (3.12-1)
GOOD -4.0.0-2-rt-amd64 (4.0.5-1) (0.19+20130705-3)
So, it was fixed in 4.0.5-1.
--- End Message ---