INFO: task kworker/u8:5:7229 blocked for more than 143 seconds.
      Not tainted syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/u8:5    state:D stack:22488 pid:7229  tgid:7229  ppid:2      task_flags:0x4208060 flags:0x00004000
Workqueue: btree_node_rewrite async_btree_node_rewrite_work
Call Trace:
 <TASK>
 __schedule+0x1798/0x4cc0
 schedule+0x165/0x360
 __closure_sync+0x163/0x220
 bch2_btree_update_start+0x18dc/0x1de0
 bch2_btree_node_rewrite+0x17e/0x1120
 bch2_btree_node_rewrite_key+0x273/0x320
 async_btree_node_rewrite_work+0x110/0x4f0
 process_scheduled_works+0xae1/0x17b0
 worker_thread+0x8a0/0xda0
 kthread+0x711/0x8a0
 ret_from_fork+0x3fc/0x770
 ret_from_fork_asm+0x1a/0x30
 </TASK>
INFO: task syz.3.445:9007 blocked for more than 143 seconds.
      Not tainted syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz.3.445       state:D stack:19408 pid:9007  tgid:9006  ppid:8127   task_flags:0x400140 flags:0x00004006
Call Trace:
 <TASK>
 __schedule+0x1798/0x4cc0
 schedule+0x165/0x360
 __closure_sync+0x163/0x220
 bch2_btree_update_start+0x18dc/0x1de0
 bch2_btree_split_leaf+0x14b/0x8e0
 bch2_trans_commit_error+0x1b7/0x1130
 __bch2_trans_commit+0x1bb5/0x8870
 bch2_journal_replay+0x1e85/0x2630
 __bch2_run_recovery_passes+0x3bd/0x1060
 bch2_run_recovery_passes+0x184/0x210
 bch2_fs_recovery+0x2690/0x3a50
 bch2_fs_start+0xaaf/0xda0
 bch2_fs_get_tree+0xb39/0x1520
 vfs_get_tree+0x92/0x2b0
 do_new_mount+0x2a2/0x9e0
 __se_sys_mount+0x317/0x410
 do_syscall_64+0xfa/0x3b0
 entry_SYSCALL_64_after_hwframe+0x77/0x7f
RIP: 0033:0x7f89ab79038a
RSP: 002b:00007f89ac525e68 EFLAGS: 00000246 ORIG_RAX: 00000000000000a5
RAX: ffffffffffffffda RBX: 00007f89ac525ef0 RCX: 00007f89ab79038a
RDX: 00002000000003c0 RSI: 0000200000000000 RDI: 00007f89ac525eb0
RBP: 00002000000003c0 R08: 00007f89ac525ef0 R09: 000000000180c844
R10: 000000000180c844 R11: 0000000000000246 R12: 0000200000000000
R13: 00007f89ac525eb0 R14: 0000000000005960 R15: 0000200000000140
 </TASK>
INFO: task bch-reclaim/loo:9019 blocked for more than 143 seconds.
      Not tainted syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:bch-reclaim/loo state:D stack:22568 pid:9019  tgid:9019  ppid:2      task_flags:0x200840 flags:0x00004000
Call Trace:
 <TASK>
 __schedule+0x1798/0x4cc0
 schedule+0x165/0x360
 __closure_sync+0x163/0x220
 bch2_btree_update_start+0x18dc/0x1de0
 bch2_btree_split_leaf+0x14b/0x8e0
 bch2_trans_commit_error+0x1b7/0x1130
 __bch2_trans_commit+0x1bb5/0x8870
 bch2_btree_write_buffer_flush_locked+0x451f/0x4dd0
 btree_write_buffer_flush_seq+0x18c7/0x1a40
 bch2_btree_write_buffer_journal_flush+0x69/0xb0
 journal_flush_pins+0x8e3/0xe90
 __bch2_journal_reclaim+0x910/0xed0
 bch2_journal_reclaim_thread+0x177/0x4f0
 kthread+0x711/0x8a0
 ret_from_fork+0x3fc/0x770
 ret_from_fork_asm+0x1a/0x30
 </TASK>

Showing all locks held in the system:
1 lock held by pool_workqueue_/3:
 #0: ffffffff8e13f978 (rcu_state.exp_mutex){+.+.}-{4:4}, at: synchronize_rcu_expedited+0x3b9/0x730
1 lock held by rcu_tasks_trace/32:
 #0: ffffffff8e13ac10 (rcu_tasks_trace.tasks_gp_mutex){+.+.}-{4:4}, at: rcu_tasks_one_gp+0xaf9/0xdf0
1 lock held by khungtaskd/34:
 #0: ffffffff8e139ee0 (rcu_read_lock){....}-{1:3}, at: debug_show_all_locks+0x2e/0x180
1 lock held by kcompactd0/38:
2 locks held by getty/5673:
 #0: ffff88810e4260a0 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x25/0x70
 #1: ffffc900029062f0 (&ldata->atomic_read_lock){+.+.}-{4:4}, at: n_tty_read+0x43e/0x1400
4 locks held by kworker/u8:5/7229:
 #0: ffff88810e86d148 ((wq_completion)btree_node_rewrite){+.+.}-{0:0}, at: process_scheduled_works+0x9b4/0x17b0
 #1: ffffc9000307fbc0 ((work_completion)(&a->work)){+.+.}-{0:0}, at: process_scheduled_works+0x9ef/0x17b0
 #2: ffff88811f684398 (&c->btree_trans_barrier){.+.+}-{0:0}, at: bch2_trans_srcu_lock+0xaf/0x220
 #3: ffff88811f6a6710 (&c->gc_lock
){++++}-{4:4}
, at: bch2_btree_update_start+0x542/0x1de0
2 locks held by syz.3.445/9007:
 #0: 
ffff88811f684398
 (
&c->btree_trans_barrier
){.+.+}-{0:0}, at: bch2_trans_srcu_lock+0xaf/0x220
 #1: ffff88811f6a6710 (&c->gc_lock){++++}-{4:4}, at: bch2_btree_update_start+0x542/0x1de0
4 locks held by bch-reclaim/loo/9019:
 #0: ffff88811f6caf68 (&j->reclaim_lock
){+.+.}-{4:4}
, at: bch2_journal_reclaim_thread+0x16b/0x4f0
 #1: ffff88811f684398 (&c->btree_trans_barrier){.+.+}-{0:0}, at: __bch2_trans_get+0x7f4/0xd80
 #2: ffff88811f684740 (&wb->flushing.lock){+.+.}-{4:4}, at: btree_write_buffer_flush_seq+0x18bd/0x1a40
 #3: 
ffff88811f6a6710 (&c->gc_lock){++++}-{4:4}, at: bch2_btree_update_start+0x542/0x1de0
8 locks held by syz.5.1098/13691:
1 lock held by syz.4.1099/13694:
 #0: ffffffff8e13f840 (rcu_state.barrier_mutex){+.+.}-{4:4}, at: rcu_barrier+0x4c/0x570

=============================================

NMI backtrace for cpu 1
CPU: 1 UID: 0 PID: 34 Comm: khungtaskd Not tainted syzkaller #0 PREEMPT(full) 
Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.16.2-debian-1.16.2-1 04/01/2014
Call Trace:
 <TASK>
 dump_stack_lvl+0x189/0x250
 nmi_cpu_backtrace+0x39e/0x3d0
 nmi_trigger_cpumask_backtrace+0x17a/0x300
 watchdog+0xf93/0xfe0
 kthread+0x711/0x8a0
 ret_from_fork+0x3fc/0x770
 ret_from_fork_asm+0x1a/0x30
 </TASK>
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 UID: 0 PID: 13691 Comm: syz.5.1098 Not tainted syzkaller #0 PREEMPT(full) 
Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 1.16.2-debian-1.16.2-1 04/01/2014
RIP: 0010:match_held_lock+0xe/0xc0
Code: ff 66 66 2e 0f 1f 84 00 00 00 00 00 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 41 56 53 bb 01 00 00 00 48 39 77 10 74 6a <81> 7f 20 00 00 20 00 72 5f 48 8b 46 08 48 85 c0 75 17 31 db 49 89
RSP: 0018:ffffc900000079b8 EFLAGS: 00000087
RAX: 0000000000000008 RBX: 0000000000000001 RCX: ebd9659f0d300500
RDX: 0000000000000088 RSI: ffff88804b039f98 RDI: ffff8881111ea8a0
RBP: 00000000ffffffff R08: 0000000000000003 R09: 0000000000000004
R10: dffffc0000000000 R11: fffff52000000f38 R12: 0000000000000046
R13: ffff8881111e9cc0 R14: ffff88804b039f98 R15: 0000000000000006
FS:  00007f912ed836c0(0000) GS:ffff8880b861b000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007feb9b474932 CR3: 000000012338e000 CR4: 00000000000006f0
Call Trace:
 <IRQ>
 lock_is_held_type+0xa8/0x190
 ttwu_do_activate+0x93/0x870
 try_to_wake_up+0x721/0x12b0
 autoremove_wake_function+0x17/0x100
 __wake_up_common_lock+0x137/0x1f0
 irq_work_single+0xe1/0x240
 irq_work_tick+0x2c2/0x360
 update_process_times+0x264/0x2f0
 tick_nohz_handler+0x39a/0x520
 __hrtimer_run_queues+0x4e0/0xc60
 hrtimer_interrupt+0x45b/0xaa0
 __sysvec_apic_timer_interrupt+0x10b/0x410
 sysvec_apic_timer_interrupt+0xa1/0xc0
 </IRQ>
 <TASK>
 asm_sysvec_apic_timer_interrupt+0x1a/0x20
RIP: 0010:vprintk_emit+0x58f/0x7a0
Code: 85 32 01 00 00 e8 11 87 1f 00 41 89 df 4d 85 f6 48 8b 1c 24 75 07 e8 00 87 1f 00 eb 06 e8 f9 86 1f 00 fb 48 c7 c7 80 e1 12 8e <31> f6 ba 01 00 00 00 31 c9 41 b8 01 00 00 00 45 31 c9 53 e8 b9 35
RSP: 0018:ffffc90003cce6e0 EFLAGS: 00000246
RAX: ffffffff81a02497 RBX: ffffffff81a02354 RCX: 0000000000080000
RDX: ffffc90003fe1000 RSI: 000000000007ffff RDI: ffffffff8e12e180
RBP: ffffc90003cce7f0 R08: ffffffff8fa38a37 R09: 1ffffffff1f47146
R10: dffffc0000000000 R11: fffffbfff1f47147 R12: dffffc0000000000
R13: 1ffff92000799ce0 R14: 0000000000000200 R15: 000000000000006a
 _printk+0xcf/0x120
 bch2_print_string_as_lines+0x135/0x250
 __bch2_fsck_err+0xb99/0x1000
 bch2_check_allocations+0x4471/0x57b0
 __bch2_run_recovery_passes+0x3bd/0x1060
 bch2_run_recovery_passes+0x184/0x210
 bch2_fs_recovery+0x2690/0x3a50
 bch2_fs_start+0xaaf/0xda0
 bch2_fs_get_tree+0xb39/0x1520
 vfs_get_tree+0x92/0x2b0
 do_new_mount+0x2a2/0x9e0
 __se_sys_mount+0x317/0x410
 do_syscall_64+0xfa/0x3b0
 entry_SYSCALL_64_after_hwframe+0x77/0x7f
RIP: 0033:0x7f912df9038a
Code: d8 64 89 02 48 c7 c0 ff ff ff ff eb a6 e8 de 1a 00 00 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 40 00 49 89 ca b8 a5 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 c7 c1 a8 ff ff ff f7 d8 64 89 01 48
RSP: 002b:00007f912ed82e68 EFLAGS: 00000246 ORIG_RAX: 00000000000000a5
RAX: ffffffffffffffda RBX: 00007f912ed82ef0 RCX: 00007f912df9038a
RDX: 0000200000000000 RSI: 0000200000005900 RDI: 00007f912ed82eb0
RBP: 0000200000000000 R08: 00007f912ed82ef0 R09: 0000000000010000
R10: 0000000000010000 R11: 0000000000000246 R12: 0000200000005900
R13: 00007f912ed82eb0 R14: 00000000000058b4 R15: 0000200000000240
 </TASK>
