INFO: task syz.0.448:8668 blocked for more than 143 seconds.
      Not tainted syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz.0.448       state:D stack:13960 pid:8668  tgid:8667  ppid:5858   task_flags:0x400140 flags:0x00004006
Call Trace:
 <TASK>
 __schedule+0x1798/0x4cc0
 schedule+0x165/0x360
 schedule_preempt_disabled+0x13/0x30
 rwsem_down_write_slowpath+0x872/0xfe0
 down_write+0x1ab/0x1f0
 bch2_direct_write+0x192/0x2ce0
 bch2_write_iter+0x18f/0x2b90
 iter_file_splice_write+0x975/0x10e0
 direct_splice_actor+0x101/0x160
 splice_direct_to_actor+0x5a8/0xcc0
 do_splice_direct+0x181/0x270
 do_sendfile+0x4da/0x7e0
 __se_sys_sendfile64+0x13e/0x190
 do_syscall_64+0xfa/0x3b0
 entry_SYSCALL_64_after_hwframe+0x77/0x7f
RIP: 0033:0x7f572898ebe9
RSP: 002b:00007f5729835038 EFLAGS: 00000246 ORIG_RAX: 0000000000000028
RAX: ffffffffffffffda RBX: 00007f5728bc5fa0 RCX: 00007f572898ebe9
RDX: 0000000000000000 RSI: 0000000000000008 RDI: 0000000000000007
RBP: 00007f5728a11e19 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000020fffe82 R11: 0000000000000246 R12: 0000000000000000
R13: 00007f5728bc6038 R14: 00007f5728bc5fa0 R15: 00007ffea690d6c8
 </TASK>
INFO: task syz.0.448:8679 blocked for more than 144 seconds.
      Not tainted syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz.0.448       state:D stack:18024 pid:8679  tgid:8667  ppid:5858   task_flags:0x400140 flags:0x00004004
Call Trace:
 <TASK>
 __schedule+0x1798/0x4cc0
 schedule+0x165/0x360
 __bch2_two_state_lock+0x1ea/0x370
 bch2_read_iter+0x20a/0x1440
 __kernel_read+0x4cf/0x960
 integrity_kernel_read+0x89/0xd0
 ima_calc_file_hash+0x85e/0x16f0
 ima_collect_measurement+0x428/0x8e0
 process_measurement+0x1121/0x1a40
 ima_file_check+0xd7/0x120
 security_file_post_open+0xbb/0x290
 path_openat+0x2f26/0x3830
 do_filp_open+0x1fa/0x410
 do_sys_openat2+0x121/0x1c0
 __x64_sys_openat+0x138/0x170
 do_syscall_64+0xfa/0x3b0
 entry_SYSCALL_64_after_hwframe+0x77/0x7f
RIP: 0033:0x7f572898ebe9
RSP: 002b:00007f5729814038 EFLAGS: 00000246 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 00007f5728bc6090 RCX: 00007f572898ebe9
RDX: 00000000001c1842 RSI: 0000200000000300 RDI: ffffffffffffff9c
RBP: 00007f5728a11e19 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007f5728bc6128 R14: 00007f5728bc6090 R15: 00007ffea690d6c8
 </TASK>

Showing all locks held in the system:
1 lock held by khungtaskd/34:
 #0: ffffffff8e139f20 (rcu_read_lock){....}-{1:3}, at: debug_show_all_locks+0x2e/0x180
3 locks held by kworker/u9:4/79:
 #0: ffff88801a489148 ((wq_completion)events_unbound){+.+.}-{0:0}, at: process_scheduled_works+0x9b4/0x17b0
 #1: ffffc9000179fbc0 ((linkwatch_work).work){+.+.}-{0:0}, at: process_scheduled_works+0x9ef/0x17b0
 #2: ffffffff8f538c48 (rtnl_mutex){+.+.}-{4:4}, at: linkwatch_event+0xe/0x60
5 locks held by kworker/0:2/974:
 #0: ffff88801bbc8548 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_scheduled_works+0x9b4/0x17b0
 #1: ffffc9000676fbc0 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_scheduled_works+0x9ef/0x17b0
 #2: ffff888109fee198 (&dev->mutex){....}-{4:4}, at: hub_event+0x184/0x4a20
 #3: ffff88810a041518 (&port_dev->status_lock){+.+.}-{4:4}, at: hub_event+0x21b8/0x4a20
 #4: ffff8881089f1368 (hcd->address0_mutex){+.+.}-{4:4}, at: hub_event+0x21e5/0x4a20
1 lock held by dhcpcd/5594:
 #0: ffffffff8f538c48 (rtnl_mutex){+.+.}-{4:4}, at: inet6_rtm_newaddr+0x5b7/0xd20
2 locks held by getty/5680:
 #0: ffff8880284ba0a0 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x25/0x70
 #1: ffffc900024b82f0 (&ldata->atomic_read_lock){+.+.}-{4:4}, at: n_tty_read+0x43e/0x1400
3 locks held by kworker/u8:4/6424:
2 locks held by syz.0.448/8668:
 #0: ffff88810a172428 (sb_writers#15){.+.+}-{0:0}, at: direct_splice_actor+0x49/0x160
 #1: ffff8881127ebe08 (&sb->s_type->i_mutex_key#22){++++}-{4:4}, at: bch2_direct_write+0x192/0x2ce0
1 lock held by syz.0.448/8679:
 #0: ffff888125969d28 (&ima_iint_mutex_key[depth]){+.+.}-{4:4}, at: process_measurement+0x74b/0x1a40
3 locks held by syz.0.448/8681:
1 lock held by syz.8.532/9246:
 #0: ffffffff8e13f880 (rcu_state.barrier_mutex){+.+.}-{4:4}, at: rcu_barrier+0x4c/0x570
1 lock held by syz-executor/9331:
 #0: ffffffff8f538c48 (rtnl_mutex){+.+.}-{4:4}, at: tun_chr_close+0x3e/0x1c0
1 lock held by syz-executor/9555:
 #0: ffffffff8f538c48 (rtnl_mutex){+.+.}-{4:4}, at: tun_chr_close+0x3e/0x1c0
3 locks held by syz.5.705/10593:
 #0: ffff88802a5e4dc0 (&hdev->req_lock){+.+.}-{4:4}, at: hci_unregister_dev+0x212/0x510
 #1: ffff88802a5e40b8 (&hdev->lock){+.+.}-{4:4}, at: hci_dev_close_sync+0x66a/0x1330
 #2: ffffffff8e13f9b8 (rcu_state.exp_mutex){+.+.}-{4:4}, at: synchronize_rcu_expedited+0x3b9/0x730

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

NMI backtrace for cpu 0
CPU: 0 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 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 UID: 0 PID: 8687 Comm: kworker/u13:5 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
Workqueue: bcachefs_journal bch2_journal_write
RIP: 0010:__lock_acquire+0x5e7/0xd20
Code: 00 00 0f 8c fc fe ff ff 44 89 e0 41 38 c5 76 1a e8 6e 4e 27 03 48 8b 3c 24 85 c0 74 0d 83 3d 93 5a 06 0e 00 0f 84 1a 05 00 00 <83> 7c 24 0c 00 0f 84 a9 00 00 00 41 8b 46 20 66 85 c0 0f 88 8d 00
RSP: 0018:ffffc900037ceff0 EFLAGS: 00000097
RAX: 0000000000000003 RBX: 0000000000000005 RCX: 0000000000000005
RDX: 0000000000000003 RSI: 0000000000000003 RDI: ffff8881061ad640
RBP: 0000000000000000 R08: 0000000000000000 R09: ffffffff8190cef7
R10: dffffc0000000000 R11: fffffbfff1f47207 R12: 0000000000000003
R13: 0000000000000002 R14: ffff8881061ae1f8 R15: ffff8881061ae218
FS:  0000000000000000(0000) GS:ffff8881a3c18000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00005582edb0fa18 CR3: 000000003c566000 CR4: 00000000000006f0
Call Trace:
 <TASK>
 lock_acquire+0x120/0x360
 _raw_spin_lock_irqsave+0xa7/0xf0
 try_to_wake_up+0x67/0x12b0
 closure_sync_fn+0x11c/0x1e0
 __closure_wake_up+0x81/0xb0
 bch2_journal_space_available+0x19a6/0x1d90
 bch2_journal_write+0x4509/0x5570
 process_scheduled_works+0xae1/0x17b0
 worker_thread+0x8a0/0xda0
 kthread+0x711/0x8a0
 ret_from_fork+0x3fc/0x770
 ret_from_fork_asm+0x1a/0x30
 </TASK>
