Groups > linux.debian.kernel > #63122 > unrolled thread

Bug#908216: btrfs blocked for more than 120 seconds

Started by	"Russell Mosemann" <rmosemann@futurefoam.com>
First post	2019-01-20 02:30 +0100
Last post	2019-01-20 02:30 +0100
Articles	1 — 1 participant

Back to article view | Back to linux.debian.kernel

This discussion starts older than the indexed window; earlier articles aren't shown. The article labeled Started by below is the oldest one visible, not the original post.

  Bug#908216: btrfs blocked for more than 120 seconds "Russell Mosemann" <rmosemann@futurefoam.com> - 2019-01-20 02:30 +0100

#63122 — Bug#908216: btrfs blocked for more than 120 seconds

From	"Russell Mosemann" <rmosemann@futurefoam.com>
Date	2019-01-20 02:30 +0100
Subject	Bug#908216: btrfs blocked for more than 120 seconds
Message-ID	<xia5Y-54O-9@gated-at.bofh.it>

[Multipart message — attachments visible in raw view] — view raw

Package: src:linux
Version: 4.19.12-1~bpo9+1
Severity: important
 
The only solution is to revert to 4.17.
 
Jan 19 18:14:35 vhost004 kernel: INFO: task btrfs-transacti:691 blocked for more than 120 seconds.
Jan 19 18:14:35 vhost004 kernel:       Tainted: G          I E     4.19.0-0.bpo.1-amd64 #1 Debian 4.19.12-1~bpo9+1
Jan 19 18:14:35 vhost004 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Jan 19 18:14:35 vhost004 kernel: btrfs-transacti D    0   691      2 0x80000000
Jan 19 18:14:35 vhost004 kernel: Call Trace:
Jan 19 18:14:35 vhost004 kernel:  ? __schedule+0x3f5/0x880
Jan 19 18:14:35 vhost004 kernel:  schedule+0x32/0x80
Jan 19 18:14:35 vhost004 kernel:  btrfs_start_ordered_extent+0xed/0x120 [btrfs]
Jan 19 18:14:35 vhost004 kernel:  ? remove_wait_queue+0x60/0x60
Jan 19 18:14:35 vhost004 kernel:  btrfs_wait_ordered_range+0xa0/0x100 [btrfs]
Jan 19 18:14:35 vhost004 kernel:  __btrfs_wait_cache_io+0x46/0x1c0 [btrfs]
Jan 19 18:14:35 vhost004 kernel:  btrfs_start_dirty_block_groups+0x1ad/0x4b0 [btrfs]
Jan 19 18:14:35 vhost004 kernel:  btrfs_commit_transaction+0xc8/0x8a0 [btrfs]
Jan 19 18:14:35 vhost004 kernel:  ? start_transaction+0x8f/0x3e0 [btrfs]
Jan 19 18:14:35 vhost004 kernel:  transaction_kthread+0x157/0x180 [btrfs]
Jan 19 18:14:35 vhost004 kernel:  kthread+0xf8/0x130
Jan 19 18:14:35 vhost004 kernel:  ? btrfs_cleanup_transaction+0x500/0x500 [btrfs]
Jan 19 18:14:35 vhost004 kernel:  ? kthread_create_worker_on_cpu+0x70/0x70
Jan 19 18:14:35 vhost004 kernel:  ret_from_fork+0x35/0x40
Jan 19 18:16:35 vhost004 kernel: INFO: task btrfs-transacti:691 blocked for more than 120 seconds.
Jan 19 18:16:35 vhost004 kernel:       Tainted: G          I E     4.19.0-0.bpo.1-amd64 #1 Debian 4.19.12-1~bpo9+1
Jan 19 18:16:35 vhost004 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Jan 19 18:16:35 vhost004 kernel: btrfs-transacti D    0   691      2 0x80000000
Jan 19 18:16:35 vhost004 kernel: Call Trace:
Jan 19 18:16:35 vhost004 kernel:  ? __schedule+0x3f5/0x880
Jan 19 18:16:35 vhost004 kernel:  schedule+0x32/0x80
Jan 19 18:16:35 vhost004 kernel:  btrfs_start_ordered_extent+0xed/0x120 [btrfs]
Jan 19 18:16:35 vhost004 kernel:  ? remove_wait_queue+0x60/0x60
Jan 19 18:16:35 vhost004 kernel:  btrfs_wait_ordered_range+0xa0/0x100 [btrfs]
Jan 19 18:16:35 vhost004 kernel:  __btrfs_wait_cache_io+0x46/0x1c0 [btrfs]
Jan 19 18:16:35 vhost004 kernel:  btrfs_start_dirty_block_groups+0x1ad/0x4b0 [btrfs]
Jan 19 18:16:35 vhost004 kernel:  btrfs_commit_transaction+0xc8/0x8a0 [btrfs]
Jan 19 18:16:35 vhost004 kernel:  ? start_transaction+0x8f/0x3e0 [btrfs]
Jan 19 18:16:35 vhost004 kernel:  transaction_kthread+0x157/0x180 [btrfs]
Jan 19 18:16:35 vhost004 kernel:  kthread+0xf8/0x130
Jan 19 18:16:35 vhost004 kernel:  ? btrfs_cleanup_transaction+0x500/0x500 [btrfs]
Jan 19 18:16:35 vhost004 kernel:  ? kthread_create_worker_on_cpu+0x70/0x70
Jan 19 18:16:35 vhost004 kernel:  ret_from_fork+0x35/0x40
Jan 19 18:16:37 vhost004 crmd[1539]:   notice: High CPU load detected: 55.700001
Jan 19 18:17:01 vhost004 CRON[15470]: pam_unix(cron:session): session opened for user root by (uid=0)
Jan 19 18:17:01 vhost004 CRON[15471]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
Jan 19 18:17:01 vhost004 CRON[15470]: pam_unix(cron:session): session closed for user root
Jan 19 18:17:07 vhost004 crmd[1539]:   notice: High CPU load detected: 41.509998
Jan 19 18:17:37 vhost004 crmd[1539]:   notice: High CPU load detected: 32.639999
Jan 19 18:18:07 vhost004 crmd[1539]:   notice: High CPU load detected: 27.270000
Jan 19 18:18:36 vhost004 kernel: INFO: task btrfs-transacti:691 blocked for more than 120 seconds.
Jan 19 18:18:36 vhost004 kernel:       Tainted: G          I E     4.19.0-0.bpo.1-amd64 #1 Debian 4.19.12-1~bpo9+1
Jan 19 18:18:36 vhost004 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Jan 19 18:18:36 vhost004 kernel: btrfs-transacti D    0   691      2 0x80000000
Jan 19 18:18:36 vhost004 kernel: Call Trace:
Jan 19 18:18:36 vhost004 kernel:  ? __schedule+0x3f5/0x880
Jan 19 18:18:36 vhost004 kernel:  schedule+0x32/0x80
Jan 19 18:18:36 vhost004 kernel:  btrfs_start_ordered_extent+0xed/0x120 [btrfs]
Jan 19 18:18:36 vhost004 kernel:  ? remove_wait_queue+0x60/0x60
Jan 19 18:18:36 vhost004 kernel:  btrfs_wait_ordered_range+0xa0/0x100 [btrfs]
Jan 19 18:18:36 vhost004 kernel:  __btrfs_wait_cache_io+0x46/0x1c0 [btrfs]
Jan 19 18:18:36 vhost004 kernel:  btrfs_start_dirty_block_groups+0x1ad/0x4b0 [btrfs]
Jan 19 18:18:36 vhost004 kernel:  btrfs_commit_transaction+0xc8/0x8a0 [btrfs]
Jan 19 18:18:36 vhost004 kernel:  ? start_transaction+0x8f/0x3e0 [btrfs]
Jan 19 18:18:36 vhost004 kernel:  transaction_kthread+0x157/0x180 [btrfs]
Jan 19 18:18:36 vhost004 kernel:  kthread+0xf8/0x130
Jan 19 18:18:36 vhost004 kernel:  ? btrfs_cleanup_transaction+0x500/0x500 [btrfs]
Jan 19 18:18:36 vhost004 kernel:  ? kthread_create_worker_on_cpu+0x70/0x70
Jan 19 18:18:36 vhost004 kernel:  ret_from_fork+0x35/0x40
Jan 19 18:20:37 vhost004 kernel: INFO: task btrfs-transacti:691 blocked for more than 120 seconds.
Jan 19 18:20:37 vhost004 kernel:       Tainted: G          I E     4.19.0-0.bpo.1-amd64 #1 Debian 4.19.12-1~bpo9+1
Jan 19 18:20:37 vhost004 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Jan 19 18:20:37 vhost004 kernel: btrfs-transacti D    0   691      2 0x80000000
Jan 19 18:20:37 vhost004 kernel: Call Trace:
Jan 19 18:20:37 vhost004 kernel:  ? __schedule+0x3f5/0x880
Jan 19 18:20:37 vhost004 kernel:  schedule+0x32/0x80
Jan 19 18:20:37 vhost004 kernel:  btrfs_start_ordered_extent+0xed/0x120 [btrfs]
Jan 19 18:20:37 vhost004 kernel:  ? remove_wait_queue+0x60/0x60
Jan 19 18:20:37 vhost004 kernel:  btrfs_wait_ordered_range+0xa0/0x100 [btrfs]
Jan 19 18:20:37 vhost004 kernel:  __btrfs_wait_cache_io+0x46/0x1c0 [btrfs]
Jan 19 18:20:37 vhost004 kernel:  btrfs_start_dirty_block_groups+0x1ad/0x4b0 [btrfs]
Jan 19 18:20:37 vhost004 kernel:  btrfs_commit_transaction+0xc8/0x8a0 [btrfs]
Jan 19 18:20:37 vhost004 kernel:  ? start_transaction+0x8f/0x3e0 [btrfs]
Jan 19 18:20:37 vhost004 kernel:  transaction_kthread+0x157/0x180 [btrfs]
Jan 19 18:20:37 vhost004 kernel:  kthread+0xf8/0x130
Jan 19 18:20:37 vhost004 kernel:  ? btrfs_cleanup_transaction+0x500/0x500 [btrfs]
Jan 19 18:20:37 vhost004 kernel:  ? kthread_create_worker_on_cpu+0x70/0x70
Jan 19 18:20:37 vhost004 kernel:  ret_from_fork+0x35/0x40
Jan 19 18:22:38 vhost004 kernel: INFO: task btrfs-transacti:691 blocked for more than 120 seconds.
Jan 19 18:22:38 vhost004 kernel:       Tainted: G          I E     4.19.0-0.bpo.1-amd64 #1 Debian 4.19.12-1~bpo9+1
Jan 19 18:22:38 vhost004 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Jan 19 18:22:38 vhost004 kernel: btrfs-transacti D    0   691      2 0x80000000
Jan 19 18:22:38 vhost004 kernel: Call Trace:
Jan 19 18:22:38 vhost004 kernel:  ? __schedule+0x3f5/0x880
Jan 19 18:22:38 vhost004 kernel:  schedule+0x32/0x80
Jan 19 18:22:38 vhost004 kernel:  btrfs_start_ordered_extent+0xed/0x120 [btrfs]
Jan 19 18:22:38 vhost004 kernel:  ? remove_wait_queue+0x60/0x60
Jan 19 18:22:38 vhost004 kernel:  btrfs_wait_ordered_range+0xa0/0x100 [btrfs]
Jan 19 18:22:38 vhost004 kernel:  __btrfs_wait_cache_io+0x46/0x1c0 [btrfs]
Jan 19 18:22:38 vhost004 kernel:  btrfs_start_dirty_block_groups+0x1ad/0x4b0 [btrfs]
Jan 19 18:22:38 vhost004 kernel:  btrfs_commit_transaction+0xc8/0x8a0 [btrfs]
Jan 19 18:22:38 vhost004 kernel:  ? start_transaction+0x8f/0x3e0 [btrfs]
Jan 19 18:22:38 vhost004 kernel:  transaction_kthread+0x157/0x180 [btrfs]
Jan 19 18:22:38 vhost004 kernel:  kthread+0xf8/0x130
Jan 19 18:22:38 vhost004 kernel:  ? btrfs_cleanup_transaction+0x500/0x500 [btrfs]
Jan 19 18:22:38 vhost004 kernel:  ? kthread_create_worker_on_cpu+0x70/0x70
Jan 19 18:22:38 vhost004 kernel:  ret_from_fork+0x35/0x40
Jan 19 18:24:39 vhost004 kernel: INFO: task btrfs-transacti:691 blocked for more than 120 seconds.
Jan 19 18:24:39 vhost004 kernel:       Tainted: G          I E     4.19.0-0.bpo.1-amd64 #1 Debian 4.19.12-1~bpo9+1
Jan 19 18:24:39 vhost004 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Jan 19 18:24:39 vhost004 kernel: btrfs-transacti D    0   691      2 0x80000000
Jan 19 18:24:39 vhost004 kernel: Call Trace:
Jan 19 18:24:39 vhost004 kernel:  ? __schedule+0x3f5/0x880
Jan 19 18:24:39 vhost004 kernel:  schedule+0x32/0x80
Jan 19 18:24:39 vhost004 kernel:  btrfs_start_ordered_extent+0xed/0x120 [btrfs]
Jan 19 18:24:39 vhost004 kernel:  ? remove_wait_queue+0x60/0x60
Jan 19 18:24:39 vhost004 kernel:  btrfs_wait_ordered_range+0xa0/0x100 [btrfs]
Jan 19 18:24:39 vhost004 kernel:  __btrfs_wait_cache_io+0x46/0x1c0 [btrfs]
Jan 19 18:24:39 vhost004 kernel:  btrfs_start_dirty_block_groups+0x1ad/0x4b0 [btrfs]
Jan 19 18:24:39 vhost004 kernel:  btrfs_commit_transaction+0xc8/0x8a0 [btrfs]
Jan 19 18:24:39 vhost004 kernel:  ? start_transaction+0x8f/0x3e0 [btrfs]
Jan 19 18:24:39 vhost004 kernel:  transaction_kthread+0x157/0x180 [btrfs]
Jan 19 18:24:39 vhost004 kernel:  kthread+0xf8/0x130
Jan 19 18:24:39 vhost004 kernel:  ? btrfs_cleanup_transaction+0x500/0x500 [btrfs]
Jan 19 18:24:39 vhost004 kernel:  ? kthread_create_worker_on_cpu+0x70/0x70
Jan 19 18:24:39 vhost004 kernel:  ret_from_fork+0x35/0x40
Jan 19 18:26:40 vhost004 kernel: INFO: task btrfs-transacti:691 blocked for more than 120 seconds.
Jan 19 18:26:40 vhost004 kernel:       Tainted: G          I E     4.19.0-0.bpo.1-amd64 #1 Debian 4.19.12-1~bpo9+1
Jan 19 18:26:40 vhost004 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Jan 19 18:26:40 vhost004 kernel: btrfs-transacti D    0   691      2 0x80000000
Jan 19 18:26:40 vhost004 kernel: Call Trace:
Jan 19 18:26:40 vhost004 kernel:  ? __schedule+0x3f5/0x880
Jan 19 18:26:40 vhost004 kernel:  schedule+0x32/0x80
Jan 19 18:26:40 vhost004 kernel:  btrfs_start_ordered_extent+0xed/0x120 [btrfs]
Jan 19 18:26:40 vhost004 kernel:  ? remove_wait_queue+0x60/0x60
Jan 19 18:26:40 vhost004 kernel:  btrfs_wait_ordered_range+0xa0/0x100 [btrfs]
Jan 19 18:26:40 vhost004 kernel:  __btrfs_wait_cache_io+0x46/0x1c0 [btrfs]
Jan 19 18:26:40 vhost004 kernel:  btrfs_start_dirty_block_groups+0x1ad/0x4b0 [btrfs]
Jan 19 18:26:40 vhost004 kernel:  btrfs_commit_transaction+0xc8/0x8a0 [btrfs]
Jan 19 18:26:40 vhost004 kernel:  ? start_transaction+0x8f/0x3e0 [btrfs]
Jan 19 18:26:40 vhost004 kernel:  transaction_kthread+0x157/0x180 [btrfs]
Jan 19 18:26:40 vhost004 kernel:  kthread+0xf8/0x130
Jan 19 18:26:40 vhost004 kernel:  ? btrfs_cleanup_transaction+0x500/0x500 [btrfs]
Jan 19 18:26:40 vhost004 kernel:  ? kthread_create_worker_on_cpu+0x70/0x70
Jan 19 18:26:40 vhost004 kernel:  ret_from_fork+0x35/0x40
Jan 19 18:28:40 vhost004 kernel: INFO: task btrfs-transacti:691 blocked for more than 120 seconds.
Jan 19 18:28:40 vhost004 kernel:       Tainted: G          I E     4.19.0-0.bpo.1-amd64 #1 Debian 4.19.12-1~bpo9+1
Jan 19 18:28:40 vhost004 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Jan 19 18:28:40 vhost004 kernel: btrfs-transacti D    0   691      2 0x80000000
Jan 19 18:28:40 vhost004 kernel: Call Trace:
Jan 19 18:28:40 vhost004 kernel:  ? __schedule+0x3f5/0x880
Jan 19 18:28:40 vhost004 kernel:  schedule+0x32/0x80
Jan 19 18:28:40 vhost004 kernel:  btrfs_start_ordered_extent+0xed/0x120 [btrfs]
Jan 19 18:28:40 vhost004 kernel:  ? remove_wait_queue+0x60/0x60
Jan 19 18:28:40 vhost004 kernel:  btrfs_wait_ordered_range+0xa0/0x100 [btrfs]
Jan 19 18:28:40 vhost004 kernel:  __btrfs_wait_cache_io+0x46/0x1c0 [btrfs]
Jan 19 18:28:40 vhost004 kernel:  btrfs_start_dirty_block_groups+0x1ad/0x4b0 [btrfs]
Jan 19 18:28:40 vhost004 kernel:  btrfs_commit_transaction+0xc8/0x8a0 [btrfs]
Jan 19 18:28:40 vhost004 kernel:  ? start_transaction+0x8f/0x3e0 [btrfs]
Jan 19 18:28:40 vhost004 kernel:  transaction_kthread+0x157/0x180 [btrfs]
Jan 19 18:28:40 vhost004 kernel:  kthread+0xf8/0x130
Jan 19 18:28:40 vhost004 kernel:  ? btrfs_cleanup_transaction+0x500/0x500 [btrfs]
Jan 19 18:28:40 vhost004 kernel:  ? kthread_create_worker_on_cpu+0x70/0x70
Jan 19 18:28:40 vhost004 kernel:  ret_from_fork+0x35/0x40
Jan 19 18:30:41 vhost004 kernel: INFO: task btrfs-transacti:691 blocked for more than 120 seconds.
Jan 19 18:30:41 vhost004 kernel:       Tainted: G          I E     4.19.0-0.bpo.1-amd64 #1 Debian 4.19.12-1~bpo9+1
Jan 19 18:30:41 vhost004 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Jan 19 18:30:41 vhost004 kernel: btrfs-transacti D    0   691      2 0x80000000
Jan 19 18:30:41 vhost004 kernel: Call Trace:
Jan 19 18:30:41 vhost004 kernel:  ? __schedule+0x3f5/0x880
Jan 19 18:30:41 vhost004 kernel:  schedule+0x32/0x80
Jan 19 18:30:41 vhost004 kernel:  btrfs_start_ordered_extent+0xed/0x120 [btrfs]
Jan 19 18:30:41 vhost004 kernel:  ? remove_wait_queue+0x60/0x60
Jan 19 18:30:41 vhost004 kernel:  btrfs_wait_ordered_range+0xa0/0x100 [btrfs]
Jan 19 18:30:41 vhost004 kernel:  __btrfs_wait_cache_io+0x46/0x1c0 [btrfs]
Jan 19 18:30:41 vhost004 kernel:  btrfs_start_dirty_block_groups+0x1ad/0x4b0 [btrfs]
Jan 19 18:30:41 vhost004 kernel:  btrfs_commit_transaction+0xc8/0x8a0 [btrfs]
Jan 19 18:30:41 vhost004 kernel:  ? start_transaction+0x8f/0x3e0 [btrfs]
Jan 19 18:30:41 vhost004 kernel:  transaction_kthread+0x157/0x180 [btrfs]
Jan 19 18:30:41 vhost004 kernel:  kthread+0xf8/0x130
Jan 19 18:30:41 vhost004 kernel:  ? btrfs_cleanup_transaction+0x500/0x500 [btrfs]
Jan 19 18:30:41 vhost004 kernel:  ? kthread_create_worker_on_cpu+0x70/0x70
Jan 19 18:30:41 vhost004 kernel:  ret_from_fork+0x35/0x40
Jan 19 18:32:42 vhost004 kernel: INFO: task btrfs-transacti:691 blocked for more than 120 seconds.
Jan 19 18:32:42 vhost004 kernel:       Tainted: G          I E     4.19.0-0.bpo.1-amd64 #1 Debian 4.19.12-1~bpo9+1
Jan 19 18:32:42 vhost004 kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
Jan 19 18:32:42 vhost004 kernel: btrfs-transacti D    0   691      2 0x80000000
Jan 19 18:32:42 vhost004 kernel: Call Trace:
Jan 19 18:32:42 vhost004 kernel:  ? __schedule+0x3f5/0x880
Jan 19 18:32:42 vhost004 kernel:  schedule+0x32/0x80
Jan 19 18:32:42 vhost004 kernel:  btrfs_start_ordered_extent+0xed/0x120 [btrfs]
Jan 19 18:32:42 vhost004 kernel:  ? remove_wait_queue+0x60/0x60
Jan 19 18:32:42 vhost004 kernel:  btrfs_wait_ordered_range+0xa0/0x100 [btrfs]
Jan 19 18:32:42 vhost004 kernel:  __btrfs_wait_cache_io+0x46/0x1c0 [btrfs]
Jan 19 18:32:42 vhost004 kernel:  btrfs_start_dirty_block_groups+0x1ad/0x4b0 [btrfs]
Jan 19 18:32:42 vhost004 kernel:  btrfs_commit_transaction+0xc8/0x8a0 [btrfs]
Jan 19 18:32:42 vhost004 kernel:  ? start_transaction+0x8f/0x3e0 [btrfs]
Jan 19 18:32:42 vhost004 kernel:  transaction_kthread+0x157/0x180 [btrfs]
Jan 19 18:32:42 vhost004 kernel:  kthread+0xf8/0x130
Jan 19 18:32:42 vhost004 kernel:  ? btrfs_cleanup_transaction+0x500/0x500 [btrfs]
Jan 19 18:32:42 vhost004 kernel:  ? kthread_create_worker_on_cpu+0x70/0x70
Jan 19 18:32:42 vhost004 kernel:  ret_from_fork+0x35/0x40

[toc] | [standalone]

csiph-web

Bug#908216: btrfs blocked for more than 120 seconds

Contents

#63122 — Bug#908216: btrfs blocked for more than 120 seconds