[Date Prev][Date Next] [Thread Prev][Thread Next] [Date Index] [Thread Index]

Bug#908216: btrfs blocked for more than 120 seconds



Package: src:linux
Version: 4.18.20-2~bpo9+1
Severity: important

 

This problem was so bad with 4.18.6-1~bpo9+1 that I had to revert to 4.17.0. When saw that 4.18.20 was out, I wanted to give it a try. Big mistake. Please fix this problem, already.

 

Dec 22 18:14:11 vhost004 kernel: INFO: task btrfs-transacti:708 blocked for more than 120 seconds.
Dec 22 18:14:11 vhost004 kernel:       Tainted: G          I       4.18.0-0.bpo.3-amd64 #1 Debian 4.18.20-2~bpo9+1
Dec 22 18:14:11 vhost004 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Dec 22 18:14:11 vhost004 kernel: btrfs-transacti D    0   708      2 0x80000000
Dec 22 18:14:11 vhost004 kernel: Call Trace:
Dec 22 18:14:11 vhost004 kernel:  ? __schedule+0x3f5/0x880
Dec 22 18:14:11 vhost004 kernel:  schedule+0x32/0x80
Dec 22 18:14:11 vhost004 kernel:  btrfs_start_ordered_extent+0xed/0x120 [btrfs]
Dec 22 18:14:11 vhost004 kernel:  ? remove_wait_queue+0x60/0x60
Dec 22 18:14:11 vhost004 kernel:  btrfs_wait_ordered_range+0xa0/0x100 [btrfs]
Dec 22 18:14:11 vhost004 kernel:  __btrfs_wait_cache_io+0x46/0x1c0 [btrfs]
Dec 22 18:14:11 vhost004 kernel:  btrfs_start_dirty_block_groups+0x1ad/0x4b0 [btrfs]
Dec 22 18:14:11 vhost004 kernel:  btrfs_commit_transaction+0xc8/0x8a0 [btrfs]
Dec 22 18:14:11 vhost004 kernel:  ? start_transaction+0x8f/0x3e0 [btrfs]
Dec 22 18:14:11 vhost004 kernel:  transaction_kthread+0x157/0x180 [btrfs]
Dec 22 18:14:11 vhost004 kernel:  kthread+0xf8/0x130
Dec 22 18:14:11 vhost004 kernel:  ? btrfs_cleanup_transaction+0x500/0x500 [btrfs]
Dec 22 18:14:11 vhost004 kernel:  ? kthread_create_worker_on_cpu+0x70/0x70
Dec 22 18:14:11 vhost004 kernel:  ret_from_fork+0x35/0x40

Dec 22 18:16:12 vhost004 kernel: INFO: task btrfs-transacti:708 blocked for more than 120 seconds.
Dec 22 18:16:12 vhost004 kernel:       Tainted: G          I       4.18.0-0.bpo.3-amd64 #1 Debian 4.18.20-2~bpo9+1
Dec 22 18:16:12 vhost004 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Dec 22 18:16:12 vhost004 kernel: btrfs-transacti D    0   708      2 0x80000000
Dec 22 18:16:12 vhost004 kernel: Call Trace:
Dec 22 18:16:12 vhost004 kernel:  ? __schedule+0x3f5/0x880
Dec 22 18:16:12 vhost004 kernel:  schedule+0x32/0x80
Dec 22 18:16:12 vhost004 kernel:  btrfs_start_ordered_extent+0xed/0x120 [btrfs]
Dec 22 18:16:12 vhost004 kernel:  ? remove_wait_queue+0x60/0x60
Dec 22 18:16:12 vhost004 kernel:  btrfs_wait_ordered_range+0xa0/0x100 [btrfs]
Dec 22 18:16:12 vhost004 kernel:  __btrfs_wait_cache_io+0x46/0x1c0 [btrfs]
Dec 22 18:16:12 vhost004 kernel:  btrfs_start_dirty_block_groups+0x1ad/0x4b0 [btrfs]
Dec 22 18:16:12 vhost004 kernel:  btrfs_commit_transaction+0xc8/0x8a0 [btrfs]
Dec 22 18:16:12 vhost004 kernel:  ? start_transaction+0x8f/0x3e0 [btrfs]
Dec 22 18:16:12 vhost004 kernel:  transaction_kthread+0x157/0x180 [btrfs]
Dec 22 18:16:12 vhost004 kernel:  kthread+0xf8/0x130
Dec 22 18:16:12 vhost004 kernel:  ? btrfs_cleanup_transaction+0x500/0x500 [btrfs]
Dec 22 18:16:12 vhost004 kernel:  ? kthread_create_worker_on_cpu+0x70/0x70
Dec 22 18:16:12 vhost004 kernel:  ret_from_fork+0x35/0x40

Dec 22 18:18:13 vhost004 kernel: INFO: task btrfs-transacti:708 blocked for more than 120 seconds.
Dec 22 18:18:13 vhost004 kernel:       Tainted: G          I       4.18.0-0.bpo.3-amd64 #1 Debian 4.18.20-2~bpo9+1
Dec 22 18:18:13 vhost004 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Dec 22 18:18:13 vhost004 kernel: btrfs-transacti D    0   708      2 0x80000000
Dec 22 18:18:13 vhost004 kernel: Call Trace:
Dec 22 18:18:13 vhost004 kernel:  ? __schedule+0x3f5/0x880
Dec 22 18:18:13 vhost004 kernel:  schedule+0x32/0x80
Dec 22 18:18:13 vhost004 kernel:  btrfs_start_ordered_extent+0xed/0x120 [btrfs]
Dec 22 18:18:13 vhost004 kernel:  ? remove_wait_queue+0x60/0x60
Dec 22 18:18:13 vhost004 kernel:  btrfs_wait_ordered_range+0xa0/0x100 [btrfs]
Dec 22 18:18:13 vhost004 kernel:  __btrfs_wait_cache_io+0x46/0x1c0 [btrfs]
Dec 22 18:18:13 vhost004 kernel:  btrfs_start_dirty_block_groups+0x1ad/0x4b0 [btrfs]
Dec 22 18:18:13 vhost004 kernel:  btrfs_commit_transaction+0xc8/0x8a0 [btrfs]
Dec 22 18:18:13 vhost004 kernel:  ? start_transaction+0x8f/0x3e0 [btrfs]
Dec 22 18:18:13 vhost004 kernel:  transaction_kthread+0x157/0x180 [btrfs]
Dec 22 18:18:13 vhost004 kernel:  kthread+0xf8/0x130
Dec 22 18:18:13 vhost004 kernel:  ? btrfs_cleanup_transaction+0x500/0x500 [btrfs]
Dec 22 18:18:13 vhost004 kernel:  ? kthread_create_worker_on_cpu+0x70/0x70
Dec 22 18:18:14 vhost004 kernel:  ret_from_fork+0x35/0x40

Dec 22 18:20:14 vhost004 kernel: INFO: task btrfs-transacti:708 blocked for more than 120 seconds.
Dec 22 18:20:14 vhost004 kernel:       Tainted: G          I       4.18.0-0.bpo.3-amd64 #1 Debian 4.18.20-2~bpo9+1
Dec 22 18:20:14 vhost004 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Dec 22 18:20:14 vhost004 kernel: btrfs-transacti D    0   708      2 0x80000000
Dec 22 18:20:14 vhost004 kernel: Call Trace:
Dec 22 18:20:14 vhost004 kernel:  ? __schedule+0x3f5/0x880
Dec 22 18:20:14 vhost004 kernel:  schedule+0x32/0x80
Dec 22 18:20:14 vhost004 kernel:  btrfs_start_ordered_extent+0xed/0x120 [btrfs]
Dec 22 18:20:14 vhost004 kernel:  ? remove_wait_queue+0x60/0x60
Dec 22 18:20:14 vhost004 kernel:  btrfs_wait_ordered_range+0xa0/0x100 [btrfs]
Dec 22 18:20:14 vhost004 kernel:  __btrfs_wait_cache_io+0x46/0x1c0 [btrfs]
Dec 22 18:20:14 vhost004 kernel:  btrfs_start_dirty_block_groups+0x1ad/0x4b0 [btrfs]
Dec 22 18:20:14 vhost004 kernel:  btrfs_commit_transaction+0xc8/0x8a0 [btrfs]
Dec 22 18:20:14 vhost004 kernel:  ? start_transaction+0x8f/0x3e0 [btrfs]
Dec 22 18:20:14 vhost004 kernel:  transaction_kthread+0x157/0x180 [btrfs]
Dec 22 18:20:14 vhost004 kernel:  kthread+0xf8/0x130
Dec 22 18:20:14 vhost004 kernel:  ? btrfs_cleanup_transaction+0x500/0x500 [btrfs]
Dec 22 18:20:14 vhost004 kernel:  ? kthread_create_worker_on_cpu+0x70/0x70
Dec 22 18:20:14 vhost004 kernel:  ret_from_fork+0x35/0x40
Dec 22 18:22:15 vhost004 kernel: INFO: task btrfs-transacti:708 blocked for more than 120 seconds.
Dec 22 18:22:15 vhost004 kernel:       Tainted: G          I       4.18.0-0.bpo.3-amd64 #1 Debian 4.18.20-2~bpo9+1
Dec 22 18:22:15 vhost004 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Dec 22 18:22:15 vhost004 kernel: btrfs-transacti D    0   708      2 0x80000000
Dec 22 18:22:15 vhost004 kernel: Call Trace:
Dec 22 18:22:15 vhost004 kernel:  ? __schedule+0x3f5/0x880
Dec 22 18:22:15 vhost004 kernel:  schedule+0x32/0x80
Dec 22 18:22:15 vhost004 kernel:  btrfs_start_ordered_extent+0xed/0x120 [btrfs]
Dec 22 18:22:15 vhost004 kernel:  ? remove_wait_queue+0x60/0x60
Dec 22 18:22:15 vhost004 kernel:  btrfs_wait_ordered_range+0xa0/0x100 [btrfs]
Dec 22 18:22:15 vhost004 kernel:  __btrfs_wait_cache_io+0x46/0x1c0 [btrfs]
Dec 22 18:22:15 vhost004 kernel:  btrfs_start_dirty_block_groups+0x1ad/0x4b0 [btrfs]
Dec 22 18:22:15 vhost004 kernel:  btrfs_commit_transaction+0xc8/0x8a0 [btrfs]
Dec 22 18:22:15 vhost004 kernel:  ? start_transaction+0x8f/0x3e0 [btrfs]
Dec 22 18:22:15 vhost004 kernel:  transaction_kthread+0x157/0x180 [btrfs]
Dec 22 18:22:15 vhost004 kernel:  kthread+0xf8/0x130
Dec 22 18:22:15 vhost004 kernel:  ? btrfs_cleanup_transaction+0x500/0x500 [btrfs]
Dec 22 18:22:15 vhost004 kernel:  ? kthread_create_worker_on_cpu+0x70/0x70
Dec 22 18:22:15 vhost004 kernel:  ret_from_fork+0x35/0x40

Dec 22 18:24:16 vhost004 kernel: INFO: task btrfs-transacti:708 blocked for more than 120 seconds.
Dec 22 18:24:16 vhost004 kernel:       Tainted: G          I       4.18.0-0.bpo.3-amd64 #1 Debian 4.18.20-2~bpo9+1
Dec 22 18:24:16 vhost004 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Dec 22 18:24:16 vhost004 kernel: btrfs-transacti D    0   708      2 0x80000000
Dec 22 18:24:16 vhost004 kernel: Call Trace:
Dec 22 18:24:16 vhost004 kernel:  ? __schedule+0x3f5/0x880
Dec 22 18:24:16 vhost004 kernel:  schedule+0x32/0x80
Dec 22 18:24:16 vhost004 kernel:  btrfs_start_ordered_extent+0xed/0x120 [btrfs]
Dec 22 18:24:16 vhost004 kernel:  ? remove_wait_queue+0x60/0x60
Dec 22 18:24:16 vhost004 kernel:  btrfs_wait_ordered_range+0xa0/0x100 [btrfs]
Dec 22 18:24:16 vhost004 kernel:  __btrfs_wait_cache_io+0x46/0x1c0 [btrfs]
Dec 22 18:24:16 vhost004 kernel:  btrfs_start_dirty_block_groups+0x1ad/0x4b0 [btrfs]
Dec 22 18:24:16 vhost004 kernel:  btrfs_commit_transaction+0xc8/0x8a0 [btrfs]
Dec 22 18:24:16 vhost004 kernel:  ? start_transaction+0x8f/0x3e0 [btrfs]
Dec 22 18:24:16 vhost004 kernel:  transaction_kthread+0x157/0x180 [btrfs]
Dec 22 18:24:16 vhost004 kernel:  kthread+0xf8/0x130
Dec 22 18:24:16 vhost004 kernel:  ? btrfs_cleanup_transaction+0x500/0x500 [btrfs]
Dec 22 18:24:16 vhost004 kernel:  ? kthread_create_worker_on_cpu+0x70/0x70
Dec 22 18:24:16 vhost004 kernel:  ret_from_fork+0x35/0x40
Dec 22 18:26:16 vhost004 kernel: INFO: task btrfs-transacti:708 blocked for more than 120 seconds.
Dec 22 18:26:16 vhost004 kernel:       Tainted: G          I       4.18.0-0.bpo.3-amd64 #1 Debian 4.18.20-2~bpo9+1
Dec 22 18:26:16 vhost004 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Dec 22 18:26:16 vhost004 kernel: btrfs-transacti D    0   708      2 0x80000000
Dec 22 18:26:16 vhost004 kernel: Call Trace:
Dec 22 18:26:16 vhost004 kernel:  ? __schedule+0x3f5/0x880
Dec 22 18:26:16 vhost004 kernel:  schedule+0x32/0x80
Dec 22 18:26:16 vhost004 kernel:  btrfs_start_ordered_extent+0xed/0x120 [btrfs]
Dec 22 18:26:16 vhost004 kernel:  ? remove_wait_queue+0x60/0x60
Dec 22 18:26:16 vhost004 kernel:  btrfs_wait_ordered_range+0xa0/0x100 [btrfs]
Dec 22 18:26:16 vhost004 kernel:  __btrfs_wait_cache_io+0x46/0x1c0 [btrfs]
Dec 22 18:26:16 vhost004 kernel:  btrfs_start_dirty_block_groups+0x1ad/0x4b0 [btrfs]
Dec 22 18:26:16 vhost004 kernel:  btrfs_commit_transaction+0xc8/0x8a0 [btrfs]
Dec 22 18:26:16 vhost004 kernel:  ? start_transaction+0x8f/0x3e0 [btrfs]
Dec 22 18:26:16 vhost004 kernel:  transaction_kthread+0x157/0x180 [btrfs]
Dec 22 18:26:16 vhost004 kernel:  kthread+0xf8/0x130
Dec 22 18:26:16 vhost004 kernel:  ? btrfs_cleanup_transaction+0x500/0x500 [btrfs]
Dec 22 18:26:16 vhost004 kernel:  ? kthread_create_worker_on_cpu+0x70/0x70
Dec 22 18:26:16 vhost004 kernel:  ret_from_fork+0x35/0x40

Dec 22 18:28:17 vhost004 kernel: INFO: task btrfs-transacti:708 blocked for more than 120 seconds.
Dec 22 18:28:17 vhost004 kernel:       Tainted: G          I       4.18.0-0.bpo.3-amd64 #1 Debian 4.18.20-2~bpo9+1
Dec 22 18:28:17 vhost004 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Dec 22 18:28:17 vhost004 kernel: btrfs-transacti D    0   708      2 0x80000000
Dec 22 18:28:17 vhost004 kernel: Call Trace:
Dec 22 18:28:17 vhost004 kernel:  ? __schedule+0x3f5/0x880
Dec 22 18:28:17 vhost004 kernel:  schedule+0x32/0x80
Dec 22 18:28:17 vhost004 kernel:  btrfs_start_ordered_extent+0xed/0x120 [btrfs]
Dec 22 18:28:17 vhost004 kernel:  ? remove_wait_queue+0x60/0x60
Dec 22 18:28:17 vhost004 kernel:  btrfs_wait_ordered_range+0xa0/0x100 [btrfs]
Dec 22 18:28:17 vhost004 kernel:  __btrfs_wait_cache_io+0x46/0x1c0 [btrfs]
Dec 22 18:28:17 vhost004 kernel:  btrfs_start_dirty_block_groups+0x1ad/0x4b0 [btrfs]
Dec 22 18:28:17 vhost004 kernel:  btrfs_commit_transaction+0xc8/0x8a0 [btrfs]
Dec 22 18:28:17 vhost004 kernel:  ? start_transaction+0x8f/0x3e0 [btrfs]
Dec 22 18:28:17 vhost004 kernel:  transaction_kthread+0x157/0x180 [btrfs]
Dec 22 18:28:17 vhost004 kernel:  kthread+0xf8/0x130
Dec 22 18:28:17 vhost004 kernel:  ? btrfs_cleanup_transaction+0x500/0x500 [btrfs]
Dec 22 18:28:17 vhost004 kernel:  ? kthread_create_worker_on_cpu+0x70/0x70
Dec 22 18:28:17 vhost004 kernel:  ret_from_fork+0x35/0x40
Dec 22 18:30:18 vhost004 kernel: INFO: task btrfs-transacti:708 blocked for more than 120 seconds.
Dec 22 18:30:18 vhost004 kernel:       Tainted: G          I       4.18.0-0.bpo.3-amd64 #1 Debian 4.18.20-2~bpo9+1
Dec 22 18:30:18 vhost004 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Dec 22 18:30:18 vhost004 kernel: btrfs-transacti D    0   708      2 0x80000000
Dec 22 18:30:18 vhost004 kernel: Call Trace:
Dec 22 18:30:18 vhost004 kernel:  ? __schedule+0x3f5/0x880
Dec 22 18:30:18 vhost004 kernel:  schedule+0x32/0x80
Dec 22 18:30:18 vhost004 kernel:  btrfs_start_ordered_extent+0xed/0x120 [btrfs]
Dec 22 18:30:18 vhost004 kernel:  ? remove_wait_queue+0x60/0x60
Dec 22 18:30:18 vhost004 kernel:  btrfs_wait_ordered_range+0xa0/0x100 [btrfs]
Dec 22 18:30:18 vhost004 kernel:  __btrfs_wait_cache_io+0x46/0x1c0 [btrfs]
Dec 22 18:30:18 vhost004 kernel:  btrfs_start_dirty_block_groups+0x1ad/0x4b0 [btrfs]
Dec 22 18:30:18 vhost004 kernel:  btrfs_commit_transaction+0xc8/0x8a0 [btrfs]
Dec 22 18:30:18 vhost004 kernel:  ? start_transaction+0x8f/0x3e0 [btrfs]
Dec 22 18:30:18 vhost004 kernel:  transaction_kthread+0x157/0x180 [btrfs]
Dec 22 18:30:18 vhost004 kernel:  kthread+0xf8/0x130
Dec 22 18:30:18 vhost004 kernel:  ? btrfs_cleanup_transaction+0x500/0x500 [btrfs]
Dec 22 18:30:18 vhost004 kernel:  ? kthread_create_worker_on_cpu+0x70/0x70
Dec 22 18:30:18 vhost004 kernel:  ret_from_fork+0x35/0x40

Dec 22 18:32:19 vhost004 kernel: INFO: task btrfs-transacti:708 blocked for more than 120 seconds.
Dec 22 18:32:19 vhost004 kernel:       Tainted: G          I       4.18.0-0.bpo.3-amd64 #1 Debian 4.18.20-2~bpo9+1
Dec 22 18:32:19 vhost004 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Dec 22 18:32:19 vhost004 kernel: btrfs-transacti D    0   708      2 0x80000000
Dec 22 18:32:19 vhost004 kernel: Call Trace:
Dec 22 18:32:19 vhost004 kernel:  ? __schedule+0x3f5/0x880
Dec 22 18:32:19 vhost004 kernel:  schedule+0x32/0x80
Dec 22 18:32:19 vhost004 kernel:  btrfs_start_ordered_extent+0xed/0x120 [btrfs]
Dec 22 18:32:19 vhost004 kernel:  ? remove_wait_queue+0x60/0x60
Dec 22 18:32:19 vhost004 kernel:  btrfs_wait_ordered_range+0xa0/0x100 [btrfs]
Dec 22 18:32:19 vhost004 kernel:  __btrfs_wait_cache_io+0x46/0x1c0 [btrfs]
Dec 22 18:32:19 vhost004 kernel:  btrfs_start_dirty_block_groups+0x1ad/0x4b0 [btrfs]
Dec 22 18:32:19 vhost004 kernel:  btrfs_commit_transaction+0xc8/0x8a0 [btrfs]
Dec 22 18:32:19 vhost004 kernel:  ? start_transaction+0x8f/0x3e0 [btrfs]
Dec 22 18:32:19 vhost004 kernel:  transaction_kthread+0x157/0x180 [btrfs]
Dec 22 18:32:19 vhost004 kernel:  kthread+0xf8/0x130
Dec 22 18:32:19 vhost004 kernel:  ? btrfs_cleanup_transaction+0x500/0x500 [btrfs]
Dec 22 18:32:19 vhost004 kernel:  ? kthread_create_worker_on_cpu+0x70/0x70
Dec 22 18:32:19 vhost004 kernel:  ret_from_fork+0x35/0x40

 


Reply to: