INFO: task syz.5.355:7431 blocked for more than 143 seconds.
      Not tainted syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz.5.355       state:D stack:28712 pid:7431  tgid:7420  ppid:7307   task_flags:0x400040 flags:0x00004004
Call Trace:
 <TASK>
 __schedule+0x1798/0x4cc0
 schedule+0x165/0x360
 schedule_preempt_disabled+0x13/0x30
 rwsem_down_write_slowpath+0x872/0xfe0
 down_write+0x1ab/0x1f0
 path_openat+0x8da/0x3830
 do_filp_open+0x1fa/0x410
 do_sys_openat2+0x121/0x1c0
 __x64_sys_creat+0x8f/0xc0
 do_syscall_64+0xfa/0x3b0
 entry_SYSCALL_64_after_hwframe+0x77/0x7f
RIP: 0033:0x7f828898ebe9
RSP: 002b:00007f8286bf6038 EFLAGS: 00000246 ORIG_RAX: 0000000000000055
RAX: ffffffffffffffda RBX: 00007f8288bc6090 RCX: 00007f828898ebe9
RDX: 0000000000000000 RSI: 0000000000000090 RDI: 0000200000000bc0
RBP: 00007f8288a11e19 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007f8288bc6128 R14: 00007f8288bc6090 R15: 00007ffc775ffc98
 </TASK>
INFO: task syz.5.355:7432 blocked for more than 143 seconds.
      Not tainted syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz.5.355       state:D stack:28936 pid:7432  tgid:7420  ppid:7307   task_flags:0x400040 flags:0x00004004
Call Trace:
 <TASK>
 __schedule+0x1798/0x4cc0
 schedule+0x165/0x360
 schedule_preempt_disabled+0x13/0x30
 rwsem_down_read_slowpath+0x5fd/0x8f0
 down_read+0x98/0x2e0
 lookup_slow+0x46/0x70
 walk_component+0x2d2/0x400
 path_lookupat+0x163/0x430
 filename_lookup+0x212/0x570
 user_path_at+0x3a/0x60
 __se_sys_mount+0x2d3/0x410
 do_syscall_64+0xfa/0x3b0
 entry_SYSCALL_64_after_hwframe+0x77/0x7f
RIP: 0033:0x7f828898ebe9
RSP: 002b:00007f8286bd5038 EFLAGS: 00000246 ORIG_RAX: 00000000000000a5
RAX: ffffffffffffffda RBX: 00007f8288bc6180 RCX: 00007f828898ebe9
RDX: 0000200000000100 RSI: 00002000000000c0 RDI: 0000000000000000
RBP: 00007f8288a11e19 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007f8288bc6218 R14: 00007f8288bc6180 R15: 00007ffc775ffc98
 </TASK>
INFO: task syz.5.355:7433 blocked for more than 143 seconds.
      Not tainted syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz.5.355       state:D stack:28936 pid:7433  tgid:7420  ppid:7307   task_flags:0x400040 flags:0x00004004
Call Trace:
 <TASK>
 __schedule+0x1798/0x4cc0
 schedule+0x165/0x360
 schedule_preempt_disabled+0x13/0x30
 rwsem_down_write_slowpath+0x872/0xfe0
 down_write+0x1ab/0x1f0
 path_openat+0x8da/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:0x7f828898ebe9
RSP: 002b:00007f82867b2038 EFLAGS: 00000246 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 00007f8288bc6270 RCX: 00007f828898ebe9
RDX: 000000000000275a RSI: 0000200000000000 RDI: ffffffffffffff9c
RBP: 00007f8288a11e19 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007f8288bc6308 R14: 00007f8288bc6270 R15: 00007ffc775ffc98
 </TASK>
INFO: task syz.5.355:7434 blocked for more than 144 seconds.
      Not tainted syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz.5.355       state:D stack:28936 pid:7434  tgid:7420  ppid:7307   task_flags:0x400040 flags:0x00004004
Call Trace:
 <TASK>
 __schedule+0x1798/0x4cc0
 schedule+0x165/0x360
 schedule_preempt_disabled+0x13/0x30
 rwsem_down_write_slowpath+0x872/0xfe0
 down_write_nested+0x1b5/0x200
 filename_create+0x1f8/0x3c0
 do_mknodat+0x184/0x4d0
 __x64_sys_mknod+0x8c/0xa0
 do_syscall_64+0xfa/0x3b0
 entry_SYSCALL_64_after_hwframe+0x77/0x7f
RIP: 0033:0x7f828898ebe9
RSP: 002b:00007f828638f038 EFLAGS: 00000246 ORIG_RAX: 0000000000000085
RAX: ffffffffffffffda RBX: 00007f8288bc6360 RCX: 00007f828898ebe9
RDX: 000000000000070a RSI: 0000000000000080 RDI: 0000200000000080
RBP: 00007f8288a11e19 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007f8288bc63f8 R14: 00007f8288bc6360 R15: 00007ffc775ffc98
 </TASK>

Showing all locks held in the system:
2 locks held by kworker/0:0/9:
1 lock held by khungtaskd/34:
 #0: ffffffff8e139f20 (rcu_read_lock){....}-{1:3}, at: debug_show_all_locks+0x2e/0x180
4 locks held by kworker/u10:3/64:
 #0: ffff8881012e6948 ((wq_completion)writeback){+.+.}-{0:0}, at: process_scheduled_works+0x9b4/0x17b0
 #1: ffffc9000172fbc0 ((work_completion)(&(&wb->dwork)->work)){+.+.}-{0:0}, at: process_scheduled_works+0x9ef/0x17b0
 #2: ffff888117c040e0 (&type->s_umount_key#70){++++}-{4:4}, at: super_trylock_shared+0x20/0xf0
 #3: ffff888120112fe0 (&jfs_ip->commit_mutex){+.+.}-{4:4}, at: jfs_commit_inode+0x1ca/0x530
2 locks held by getty/5673:
 #0: ffff8880229e20a0 (&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 syz.5.355/7421:
2 locks held by syz.5.355/7431:
 #0: ffff888117c04428 (sb_writers#28){.+.+}-{0:0}, at: mnt_want_write+0x41/0x90
 #1: ffff888120113390 (&type->i_mutex_dir_key#20){++++}-{4:4}, at: path_openat+0x8da/0x3830
1 lock held by syz.5.355/7432:
 #0: ffff888120113390 (&type->i_mutex_dir_key#20){++++}-{4:4}, at: lookup_slow+0x46/0x70
2 locks held by syz.5.355/7433:
 #0: ffff888117c04428 (sb_writers#28){.+.+}-{0:0}, at: mnt_want_write+0x41/0x90
 #1: ffff888120113390 (&type->i_mutex_dir_key#20){++++}-{4:4}, at: path_openat+0x8da/0x3830
2 locks held by syz.5.355/7434:
 #0: ffff888117c04428 (sb_writers#28){.+.+}-{0:0}, at: mnt_want_write+0x41/0x90
 #1: ffff888120113390 (&type->i_mutex_dir_key#20/1){+.+.}-{4:4}, at: filename_create+0x1f8/0x3c0
8 locks held by kworker/0:6/9294:

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

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: 9294 Comm: kworker/0:6 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: usb_hub_wq hub_event
RIP: 0010:lock_release+0x296/0x3e0
Code: 24 08 48 c7 c7 96 76 ba 8d e8 e6 71 dc 09 b8 ff ff ff ff 65 0f c1 05 89 4f 03 11 83 f8 01 75 51 48 c7 44 24 20 00 00 00 00 9c <8f> 44 24 20 f7 44 24 20 00 02 00 00 75 56 f7 c3 00 02 00 00 74 01
RSP: 0018:ffffc90000006348 EFLAGS: 00000046
RAX: 0000000000000001 RBX: 0000000000000202 RCX: a00a68b7806a0a00
RDX: 0000000000000009 RSI: ffffffff8dba7696 RDI: ffffffff8be33880
RBP: ffff888022802918 R08: ffffc90000006ec8 R09: 0000000000000000
R10: ffffc900000064d8 R11: fffff52000000c9d R12: 0000000000000009
R13: 0000000000000009 R14: ffffffff8e139f20 R15: ffff888022801cc0
FS:  0000000000000000(0000) GS:ffff8880b8618000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000200000001680 CR3: 000000000df36000 CR4: 00000000000006f0
Call Trace:
 <IRQ>
 unwind_next_frame+0x19a9/0x2390
 arch_stack_walk+0x11c/0x150
 stack_trace_save+0x9c/0xe0
 kasan_save_track+0x3e/0x80
 kasan_save_free_info+0x46/0x50
 __kasan_slab_free+0x5b/0x80
 kmem_cache_free+0x18f/0x400
 br_nf_dev_queue_xmit+0x4ee/0x24a0
 NF_HOOK+0x61b/0x6b0
 br_nf_post_routing+0xb66/0xfe0
 nf_hook_slow+0xc5/0x220
 NF_HOOK+0x215/0x3c0
 br_forward_finish+0xd3/0x130
 br_nf_forward_finish+0xa40/0xe60
 NF_HOOK+0x61b/0x6b0
 br_nf_forward_ip+0x647/0x7e0
 nf_hook_slow+0xc5/0x220
 NF_HOOK+0x215/0x3c0
 __br_forward+0x41e/0x600
 br_handle_frame_finish+0x14b4/0x19b0
 br_nf_hook_thresh+0x3c6/0x4a0
 br_nf_pre_routing_finish_ipv6+0x948/0xd00
 br_nf_pre_routing_ipv6+0x37e/0x6b0
 br_handle_frame+0x982/0x14c0
 __netif_receive_skb_core+0x10b9/0x4020
 __netif_receive_skb+0x72/0x380
 process_backlog+0x60e/0x14f0
 __napi_poll+0xc7/0x360
 net_rx_action+0x707/0xe30
 handle_softirqs+0x286/0x870
 __irq_exit_rcu+0xca/0x1f0
 irq_exit_rcu+0x9/0x30
 sysvec_call_function_single+0xa3/0xc0
 </IRQ>
 <TASK>
 asm_sysvec_call_function_single+0x1a/0x20
RIP: 0010:console_flush_all+0x7f7/0xc40
Code: 48 21 c3 0f 85 e9 01 00 00 e8 65 49 1f 00 48 8b 5c 24 20 4d 85 f6 75 07 e8 56 49 1f 00 eb 06 e8 4f 49 1f 00 fb 48 8b 44 24 28 <42> 80 3c 20 00 74 08 48 89 df e8 5a b7 82 00 48 8b 1b 48 8b 44 24
RSP: 0018:ffffc9000448eb20 EFLAGS: 00000283
RAX: 1ffffffff1d3684f RBX: ffffffff8e9b4278 RCX: 0000000000100000
RDX: ffffc90027929000 RSI: 000000000001b82b RDI: 000000000001b82c
RBP: ffffc9000448ec70 R08: ffffffff8fa39037 R09: 1ffffffff1f47206
R10: dffffc0000000000 R11: fffffbfff1f47207 R12: dffffc0000000000
R13: 0000000000000001 R14: 0000000000000200 R15: ffffffff8e9b4220
 console_unlock+0xc4/0x270
 vprintk_emit+0x5b7/0x7a0
 dev_vprintk_emit+0x337/0x3f0
 dev_printk_emit+0xe0/0x130
 _dev_warn+0x10a/0x160
 usb_set_configuration+0x1f1e/0x20e0
 usb_generic_driver_probe+0x8d/0x150
 usb_probe_device+0x1c4/0x390
 really_probe+0x26d/0x9e0
 __driver_probe_device+0x18c/0x2f0
 driver_probe_device+0x4f/0x430
 __device_attach_driver+0x2ce/0x530
 bus_for_each_drv+0x251/0x2e0
 __device_attach+0x2b8/0x400
 bus_probe_device+0x185/0x260
 device_add+0x7b6/0xb50
 usb_new_device+0xa39/0x16f0
 hub_event+0x2958/0x4a20
 process_scheduled_works+0xae1/0x17b0
 worker_thread+0x8a0/0xda0
 kthread+0x711/0x8a0
 ret_from_fork+0x3fc/0x770
 ret_from_fork_asm+0x1a/0x30
 </TASK>
sched: DL replenish lagged too much
