INFO: task kworker/0:5:18556 blocked for more than 143 seconds.
Not tainted 5.19.0-rc1-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/0:5 state:D stack:22168 pid:18556 ppid: 2 flags:0x00004000
Workqueue: usb_hub_wq hub_event
Call Trace:
context_switch kernel/sched/core.c:5116 [inline]
__schedule+0x957/0xec0 kernel/sched/core.c:6428
schedule+0xeb/0x1b0 kernel/sched/core.c:6500
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6559
__mutex_lock_common+0xecf/0x26c0 kernel/locking/mutex.c:679
__mutex_lock kernel/locking/mutex.c:747 [inline]
mutex_lock_nested+0x17/0x20 kernel/locking/mutex.c:799
add_early_randomness drivers/char/hw_random/core.c:69 [inline]
hwrng_register+0x3bf/0x680 drivers/char/hw_random/core.c:599
chaoskey_probe+0x7f0/0xb10 drivers/usb/misc/chaoskey.c:205
usb_probe_interface+0x66e/0xb60 drivers/usb/core/driver.c:396
call_driver_probe+0x96/0x250
really_probe+0x220/0x940 drivers/base/dd.c:634
__driver_probe_device+0x1f4/0x3f0 drivers/base/dd.c:764
driver_probe_device+0x50/0x240 drivers/base/dd.c:794
__device_attach_driver+0x273/0x3d0 drivers/base/dd.c:917
bus_for_each_drv+0x18a/0x210 drivers/base/bus.c:427
__device_attach+0x372/0x5a0 drivers/base/dd.c:989
bus_probe_device+0xb8/0x1f0 drivers/base/bus.c:487
device_add+0xb20/0xf90 drivers/base/core.c:3417
usb_set_configuration+0x1a5f/0x20e0 drivers/usb/core/message.c:2170
usb_generic_driver_probe+0x83/0x140 drivers/usb/core/generic.c:238
usb_probe_device+0x131/0x260 drivers/usb/core/driver.c:293
call_driver_probe+0x96/0x250
really_probe+0x220/0x940 drivers/base/dd.c:634
__driver_probe_device+0x1f4/0x3f0 drivers/base/dd.c:764
driver_probe_device+0x50/0x240 drivers/base/dd.c:794
__device_attach_driver+0x273/0x3d0 drivers/base/dd.c:917
bus_for_each_drv+0x18a/0x210 drivers/base/bus.c:427
__device_attach+0x372/0x5a0 drivers/base/dd.c:989
bus_probe_device+0xb8/0x1f0 drivers/base/bus.c:487
device_add+0xb20/0xf90 drivers/base/core.c:3417
usb_new_device+0xbfc/0x18a0 drivers/usb/core/hub.c:2566
hub_port_connect+0x106b/0x2930 drivers/usb/core/hub.c:5363
hub_port_connect_change+0x619/0xbe0 drivers/usb/core/hub.c:5507
port_event+0xeb7/0x1390 drivers/usb/core/hub.c:5663
hub_event+0x5be/0xd70 drivers/usb/core/hub.c:5745
process_one_work+0x81c/0xd10 kernel/workqueue.c:2289
worker_thread+0xb14/0x1330 kernel/workqueue.c:2436
kthread+0x266/0x300 kernel/kthread.c:376
ret_from_fork+0x1f/0x30
INFO: task syz-executor.5:19379 blocked for more than 143 seconds.
Not tainted 5.19.0-rc1-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.5 state:D stack:27328 pid:19379 ppid: 3649 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:5116 [inline]
__schedule+0x957/0xec0 kernel/sched/core.c:6428
schedule+0xeb/0x1b0 kernel/sched/core.c:6500
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6559
__mutex_lock_common+0xecf/0x26c0 kernel/locking/mutex.c:679
__mutex_lock kernel/locking/mutex.c:747 [inline]
mutex_lock_nested+0x17/0x20 kernel/locking/mutex.c:799
misc_open+0x57/0x3c0 drivers/char/misc.c:107
chrdev_open+0x5fb/0x680 fs/char_dev.c:414
do_dentry_open+0x789/0x1040 fs/open.c:848
do_open fs/namei.c:3520 [inline]
path_openat+0x26c0/0x2ec0 fs/namei.c:3653
do_filp_open+0x277/0x4f0 fs/namei.c:3680
do_sys_openat2+0x13b/0x500 fs/open.c:1278
do_sys_open fs/open.c:1294 [inline]
__do_sys_openat fs/open.c:1310 [inline]
__se_sys_openat fs/open.c:1305 [inline]
__x64_sys_openat+0x243/0x290 fs/open.c:1305
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x2b/0x70 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x46/0xb0
RIP: 0033:0x7f4ae983c024
RSP: 002b:00007f4aea9e3020 EFLAGS: 00000293 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 00007f4ae999bf60 RCX: 00007f4ae983c024
RDX: 0000000000000002 RSI: 00007f4ae98e1ee8 RDI: 00000000ffffff9c
RBP: 00007f4ae98e1ee8 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000002
R13: 0000000000000000 R14: 0000000020000900 R15: 0000000000022000
INFO: task syz-executor.3:19383 blocked for more than 144 seconds.
Not tainted 5.19.0-rc1-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.3 state:D stack:27328 pid:19383 ppid: 3650 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:5116 [inline]
__schedule+0x957/0xec0 kernel/sched/core.c:6428
schedule+0xeb/0x1b0 kernel/sched/core.c:6500
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6559
__mutex_lock_common+0xecf/0x26c0 kernel/locking/mutex.c:679
__mutex_lock kernel/locking/mutex.c:747 [inline]
mutex_lock_nested+0x17/0x20 kernel/locking/mutex.c:799
misc_open+0x57/0x3c0 drivers/char/misc.c:107
chrdev_open+0x5fb/0x680 fs/char_dev.c:414
do_dentry_open+0x789/0x1040 fs/open.c:848
do_open fs/namei.c:3520 [inline]
path_openat+0x26c0/0x2ec0 fs/namei.c:3653
do_filp_open+0x277/0x4f0 fs/namei.c:3680
do_sys_openat2+0x13b/0x500 fs/open.c:1278
do_sys_open fs/open.c:1294 [inline]
__do_sys_openat fs/open.c:1310 [inline]
__se_sys_openat fs/open.c:1305 [inline]
__x64_sys_openat+0x243/0x290 fs/open.c:1305
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x2b/0x70 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x46/0xb0
RIP: 0033:0x7fbb2b489109
RSP: 002b:00007fbb2c5ff168 EFLAGS: 00000246 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 00007fbb2b59bf60 RCX: 00007fbb2b489109
RDX: 0000000000000002 RSI: 0000000020000040 RDI: ffffffffffffff9c
RBP: 00007fbb2b4e308d R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffe5eb9448f R14: 00007fbb2c5ff300 R15: 0000000000022000
Showing all locks held in the system:
2 locks held by pr/ttyS0/16:
1 lock held by khungtaskd/29:
#0: ffffffff8cb1eb60 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire+0x0/0x30
1 lock held by hwrng/755:
#0: ffffffff8d24c948 (reading_mutex){+.+.}-{3:3}, at: hwrng_fillfn+0xec/0x470 drivers/char/hw_random/core.c:503
2 locks held by getty/3296:
#0: ffff88814a789098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x21/0x70 drivers/tty/tty_ldisc.c:244
#1: ffffc90002cd62e8 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x6e8/0x1e50 drivers/tty/n_tty.c:2124
3 locks held by kworker/u4:1/12612:
3 locks held by udevd/16928:
#0: ffff88807d110088 (&of->mutex){+.+.}-{3:3}, at: kernfs_file_read_iter fs/kernfs/file.c:197 [inline]
#0: ffff88807d110088 (&of->mutex){+.+.}-{3:3}, at: kernfs_fop_read_iter+0x19b/0x570 fs/kernfs/file.c:236
#1: ffff888024b790f0 (kn->active#86){++++}-{0:0}, at: kernfs_file_read_iter fs/kernfs/file.c:198 [inline]
#1: ffff888024b790f0 (kn->active#86){++++}-{0:0}, at: kernfs_fop_read_iter+0x1b3/0x570 fs/kernfs/file.c:236
#2: ffff88801fdab190 (&dev->mutex){....}-{3:3}, at: device_lock_interruptible include/linux/device.h:840 [inline]
#2: ffff88801fdab190 (&dev->mutex){....}-{3:3}, at: read_descriptors+0x30/0x390 drivers/usb/core/sysfs.c:873
6 locks held by kworker/0:5/18556:
#0: ffff888011f39938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x796/0xd10 kernel/workqueue.c:2262
#1: ffffc9000c277d00 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x7d0/0xd10 kernel/workqueue.c:2264
#2: ffff888021b99190 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:835 [inline]
#2: ffff888021b99190 (&dev->mutex){....}-{3:3}, at: hub_event+0x1bf/0xd70 drivers/usb/core/hub.c:5691
#3: ffff88801fdab190 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:835 [inline]
#3: ffff88801fdab190 (&dev->mutex){....}-{3:3}, at: __device_attach+0x8a/0x5a0 drivers/base/dd.c:964
#4: ffff88802ed28118 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:835 [inline]
#4: ffff88802ed28118 (&dev->mutex){....}-{3:3}, at: __device_attach+0x8a/0x5a0 drivers/base/dd.c:964
#5: ffffffff8d24c948 (reading_mutex){+.+.}-{3:3}, at: add_early_randomness drivers/char/hw_random/core.c:69 [inline]
#5: ffffffff8d24c948 (reading_mutex){+.+.}-{3:3}, at: hwrng_register+0x3bf/0x680 drivers/char/hw_random/core.c:599
2 locks held by syz-executor.0/19375:
#0: ffffffff8d248b28 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x57/0x3c0 drivers/char/misc.c:107
#1: ffffffff8c9d5008 (system_transition_mutex){+.+.}-{3:3}, at: snapshot_open+0x23/0x260 kernel/power/user.c:54
1 lock held by syz-executor.5/19379:
#0: ffffffff8d248b28 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x57/0x3c0 drivers/char/misc.c:107
1 lock held by syz-executor.3/19383:
#0: ffffffff8d248b28 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x57/0x3c0 drivers/char/misc.c:107
=============================================
NMI backtrace for cpu 0
CPU: 0 PID: 29 Comm: khungtaskd Not tainted 5.19.0-rc1-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
__dump_stack lib/dump_stack.c:88 [inline]
dump_stack_lvl+0x1e3/0x2cb lib/dump_stack.c:106
nmi_cpu_backtrace+0x473/0x4a0 lib/nmi_backtrace.c:111
nmi_trigger_cpumask_backtrace+0x168/0x280 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:220 [inline]
watchdog+0xd18/0xd60 kernel/hung_task.c:378
kthread+0x266/0x300 kernel/kthread.c:376
ret_from_fork+0x1f/0x30
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 16 Comm: pr/ttyS0 Not tainted 5.19.0-rc1-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
RIP: 0010:preempt_count_add+0xc9/0x180 kernel/sched/core.c:5584
Code: 25 00 6f 02 00 48 81 c3 58 14 00 00 48 89 d8 48 c1 e8 03 42 80 3c 38 00 74 08 48 89 df e8 4f 7d 7e 00 4c 89 33 5b 41 5e 41 5f e8 31 50 d1 02 85 c0 74 9d 48 c7 c0 98 b1 03 8e 48 c1 e8 03 42
RSP: 0018:ffffc90000157950 EFLAGS: 00000002
RAX: 0000000000000002 RBX: 000002e0d42e8892 RCX: ffffffff9153ce03
RDX: 00000000000002e0 RSI: ffffffff8ae98800 RDI: 0000000000000001
RBP: 0000000000000562 R08: ffffffff84b0d959 R09: ffffed1003ba6047
R10: ffffed1003ba6047 R11: 1ffff11003ba6046 R12: 0000000000000000
R13: ffff888140198830 R14: 0000000000000899 R15: 0000000000000001
FS: 0000000000000000(0000) GS:ffff8880b9b00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f4d13f20000 CR3: 000000002791d000 CR4: 00000000003506e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
delay_tsc+0x71/0xe0 arch/x86/lib/delay.c:79
wait_for_lsr drivers/tty/serial/8250/8250_port.c:2093 [inline]
serial8250_console_fifo_write drivers/tty/serial/8250/8250_port.c:3354 [inline]
serial8250_console_write+0x109c/0x16d0 drivers/tty/serial/8250/8250_port.c:3436
call_console_driver kernel/printk/printk.c:2075 [inline]
__console_emit_next_record+0x82c/0xb30 kernel/printk/printk.c:2916
console_emit_next_record kernel/printk/printk.c:3721 [inline]
printk_kthread_func+0x9d8/0xd20 kernel/printk/printk.c:3837
kthread+0x266/0x300 kernel/kthread.c:376
ret_from_fork+0x1f/0x30
----------------
Code disassembly (best guess):
0: 25 00 6f 02 00 and $0x26f00,%eax
5: 48 81 c3 58 14 00 00 add $0x1458,%rbx
c: 48 89 d8 mov %rbx,%rax
f: 48 c1 e8 03 shr $0x3,%rax
13: 42 80 3c 38 00 cmpb $0x0,(%rax,%r15,1)
18: 74 08 je 0x22
1a: 48 89 df mov %rbx,%rdi
1d: e8 4f 7d 7e 00 callq 0x7e7d71
22: 4c 89 33 mov %r14,(%rbx)
25: 5b pop %rbx
26: 41 5e pop %r14
28: 41 5f pop %r15
* 2a: c3 retq <-- trapping instruction
2b: e8 31 50 d1 02 callq 0x2d15061
30: 85 c0 test %eax,%eax
32: 74 9d je 0xffffffd1
34: 48 c7 c0 98 b1 03 8e mov $0xffffffff8e03b198,%rax
3b: 48 c1 e8 03 shr $0x3,%rax
3f: 42 rex.X