INFO: task kworker/1:5:4530 blocked for more than 143 seconds.
Not tainted 5.6.0-rc5-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
kworker/1:5 D25720 4530 2 0x80004000
Workqueue: usb_hub_wq hub_event
Call Trace:
schedule+0xcd/0x2b0 kernel/sched/core.c:4154
schedule_timeout+0x682/0xb20 kernel/time/timer.c:1871
do_wait_for_common kernel/sched/completion.c:83 [inline]
__wait_for_common kernel/sched/completion.c:104 [inline]
wait_for_common kernel/sched/completion.c:115 [inline]
wait_for_completion+0x26f/0x3c0 kernel/sched/completion.c:136
kthread_stop+0x17a/0x780 kernel/kthread.c:559
hwrng_unregister+0x24f/0x330 drivers/char/hw_random/core.c:556
chaoskey_disconnect+0x216/0x290 drivers/usb/misc/chaoskey.c:232
usb_unbind_interface+0x1bd/0x8a0 drivers/usb/core/driver.c:436
__device_release_driver drivers/base/dd.c:1137 [inline]
device_release_driver_internal+0x42f/0x500 drivers/base/dd.c:1168
bus_remove_device+0x2eb/0x5a0 drivers/base/bus.c:533
device_del+0x481/0xd30 drivers/base/core.c:2677
usb_disable_device+0x23d/0x790 drivers/usb/core/message.c:1237
usb_disconnect+0x293/0x900 drivers/usb/core/hub.c:2211
hub_port_connect drivers/usb/core/hub.c:5046 [inline]
hub_port_connect_change drivers/usb/core/hub.c:5335 [inline]
port_event drivers/usb/core/hub.c:5481 [inline]
hub_event+0x1a1d/0x4300 drivers/usb/core/hub.c:5563
process_one_work+0x94b/0x1620 kernel/workqueue.c:2264
worker_thread+0x96/0xe20 kernel/workqueue.c:2410
kthread+0x318/0x420 kernel/kthread.c:255
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:352
Showing all locks held in the system:
3 locks held by kworker/1:0/17:
1 lock held by khungtaskd/23:
#0: ffffffff87109060 (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x264 kernel/locking/lockdep.c:5331
5 locks held by kworker/0:2/102:
1 lock held by rsyslogd/1671:
2 locks held by getty/1761:
#0: ffff8881cede3090 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:267
#1: ffffc9000084b2e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21d/0x1b30 drivers/tty/n_tty.c:2156
2 locks held by getty/1762:
#0: ffff8881cede4090 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:267
#1: ffffc9000084f2e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21d/0x1b30 drivers/tty/n_tty.c:2156
2 locks held by getty/1763:
#0: ffff8881ce8f9090 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:267
#1: ffffc9000086f2e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21d/0x1b30 drivers/tty/n_tty.c:2156
2 locks held by getty/1764:
#0: ffff8881ce9c3090 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:267
#1: ffffc900008672e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21d/0x1b30 drivers/tty/n_tty.c:2156
2 locks held by getty/1765:
#0: ffff8881ced4c090 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:267
#1: ffffc900008572e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21d/0x1b30 drivers/tty/n_tty.c:2156
2 locks held by getty/1766:
#0: ffff8881cedc2090 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:267
#1: ffffc9000085f2e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21d/0x1b30 drivers/tty/n_tty.c:2156
2 locks held by getty/1767:
#0: ffff8881ced44090 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:267
#1: ffffc900008372e0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x21d/0x1b30 drivers/tty/n_tty.c:2156
5 locks held by kworker/1:5/4530:
#0: ffff8881d8d2c928 ((wq_completion)usb_hub_wq){+.+.}, at: __write_once_size include/linux/compiler.h:226 [inline]
#0: ffff8881d8d2c928 ((wq_completion)usb_hub_wq){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
#0: ffff8881d8d2c928 ((wq_completion)usb_hub_wq){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:855 [inline]
#0: ffff8881d8d2c928 ((wq_completion)usb_hub_wq){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:40 [inline]
#0: ffff8881d8d2c928 ((wq_completion)usb_hub_wq){+.+.}, at: set_work_data kernel/workqueue.c:615 [inline]
#0: ffff8881d8d2c928 ((wq_completion)usb_hub_wq){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:642 [inline]
#0: ffff8881d8d2c928 ((wq_completion)usb_hub_wq){+.+.}, at: process_one_work+0x82a/0x1620 kernel/workqueue.c:2235
#1: ffff8881abf87dd0 ((work_completion)(&hub->events)){+.+.}, at: process_one_work+0x85e/0x1620 kernel/workqueue.c:2239
#2: ffff8881d4944200 (&dev->mutex){....}, at: device_lock include/linux/device.h:771 [inline]
#2: ffff8881d4944200 (&dev->mutex){....}, at: hub_event+0x1be/0x4300 drivers/usb/core/hub.c:5509
#3: ffff8881cc5e2200 (&dev->mutex){....}, at: device_lock include/linux/device.h:771 [inline]
#3: ffff8881cc5e2200 (&dev->mutex){....}, at: usb_disconnect+0x91/0x900 drivers/usb/core/hub.c:2202
#4: ffff8881cc5e4190 (&dev->mutex){....}, at: device_release_driver_internal+0x23/0x500 drivers/base/dd.c:1165
6 locks held by kworker/1:8/5874:
#0: ffff8881d8d2c928 ((wq_completion)usb_hub_wq){+.+.}, at: __write_once_size include/linux/compiler.h:226 [inline]
#0: ffff8881d8d2c928 ((wq_completion)usb_hub_wq){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
#0: ffff8881d8d2c928 ((wq_completion)usb_hub_wq){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:855 [inline]
#0: ffff8881d8d2c928 ((wq_completion)usb_hub_wq){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:40 [inline]
#0: ffff8881d8d2c928 ((wq_completion)usb_hub_wq){+.+.}, at: set_work_data kernel/workqueue.c:615 [inline]
#0: ffff8881d8d2c928 ((wq_completion)usb_hub_wq){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:642 [inline]
#0: ffff8881d8d2c928 ((wq_completion)usb_hub_wq){+.+.}, at: process_one_work+0x82a/0x1620 kernel/workqueue.c:2235
#1: ffff8881c0d0fdd0 ((work_completion)(&hub->events)){+.+.}, at: process_one_work+0x85e/0x1620 kernel/workqueue.c:2239
#2: ffff8881d48ee200 (&dev->mutex){....}, at: device_lock include/linux/device.h:771 [inline]
#2: ffff8881d48ee200 (&dev->mutex){....}, at: hub_event+0x1be/0x4300 drivers/usb/core/hub.c:5509
#3: ffff8881d4918540 (&port_dev->status_lock){+.+.}, at: usb_lock_port drivers/usb/core/hub.c:3008 [inline]
#3: ffff8881d4918540 (&port_dev->status_lock){+.+.}, at: hub_port_connect drivers/usb/core/hub.c:5126 [inline]
#3: ffff8881d4918540 (&port_dev->status_lock){+.+.}, at: hub_port_connect_change drivers/usb/core/hub.c:5335 [inline]
#3: ffff8881d4918540 (&port_dev->status_lock){+.+.}, at: port_event drivers/usb/core/hub.c:5481 [inline]
#3: ffff8881d4918540 (&port_dev->status_lock){+.+.}, at: hub_event+0x1fae/0x4300 drivers/usb/core/hub.c:5563
#4: ffff8881d53ff760 (hcd->address0_mutex){+.+.}, at: hub_port_init+0x1b6/0x2e60 drivers/usb/core/hub.c:4550
#5: ffff8881db334658 (&rq->lock){-.-.}, at: rq_lock kernel/sched/sched.h:1215 [inline]
#5: ffff8881db334658 (&rq->lock){-.-.}, at: __schedule+0x21c/0x1d80 kernel/sched/core.c:4028
=============================================
NMI backtrace for cpu 0
CPU: 0 PID: 23 Comm: khungtaskd Not tainted 5.6.0-rc5-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
__dump_stack lib/dump_stack.c:77 [inline]
dump_stack+0xef/0x16e lib/dump_stack.c:118
nmi_cpu_backtrace.cold+0x70/0xb1 lib/nmi_backtrace.c:101
nmi_trigger_cpumask_backtrace+0x1db/0x207 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:205 [inline]
watchdog+0xa99/0xfd0 kernel/hung_task.c:289
kthread+0x318/0x420 kernel/kthread.c:255
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:352
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 21 Comm: kworker/1:1 Not tainted 5.6.0-rc5-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Workqueue: usb_hub_wq hub_event
RIP: 0010:__kasan_check_read+0x4/0x10 mm/kasan/common.c:95
Code: 73 ff ff ff 44 89 e6 48 c7 c7 10 0f de 86 e8 7c 6d c1 ff 48 c7 c7 40 0f de 86 e8 70 6d c1 ff e9 fd e9 ff ff cc cc 48 8b 0c 24 <89> f6 31 d2 e9 c3 25 00 00 0f 1f 00 48 8b 0c 24 89 f6 ba 01 00 00
RSP: 0018:ffff8881db309b80 EFLAGS: 00000002
RAX: 0000000000000002 RBX: 0000000000000005 RCX: ffffffff812604eb
RDX: 0000000000000004 RSI: 0000000000000008 RDI: ffffffff89337430
RBP: ffff8881da24e200 R08: 0000000000000001 R09: fffffbfff1266e87
R10: fffffbfff1266e86 R11: ffffffff89337437 R12: 0000000000000084
R13: 0000000000000084 R14: 0000000000000040 R15: ffff8881da24eb18
FS: 0000000000000000(0000) GS:ffff8881db300000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00000000004d8718 CR3: 00000001d91e9000 CR4: 00000000001406e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
test_bit include/asm-generic/bitops/instrumented-non-atomic.h:110 [inline]
__lock_acquire+0x133b/0x3b60 kernel/locking/lockdep.c:3924
lock_acquire+0x130/0x340 kernel/locking/lockdep.c:4484
__raw_spin_lock_irqsave include/linux/spinlock_api_smp.h:110 [inline]
_raw_spin_lock_irqsave+0x32/0x50 kernel/locking/spinlock.c:159
try_to_wake_up+0x99/0x1690 kernel/sched/core.c:2547
hrtimer_wakeup+0x43/0x60 kernel/time/hrtimer.c:1769
__run_hrtimer kernel/time/hrtimer.c:1517 [inline]
__hrtimer_run_queues+0x32c/0xd20 kernel/time/hrtimer.c:1579
hrtimer_interrupt+0x2e8/0x730 kernel/time/hrtimer.c:1641
local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1119 [inline]
smp_apic_timer_interrupt+0xfe/0x540 arch/x86/kernel/apic/apic.c:1144
apic_timer_interrupt+0xf/0x20 arch/x86/entry/entry_64.S:829
RIP: 0010:arch_local_irq_restore arch/x86/include/asm/irqflags.h:85 [inline]
RIP: 0010:console_trylock_spinning kernel/printk/printk.c:1751 [inline]
RIP: 0010:vprintk_emit+0x3c8/0x3d0 kernel/printk/printk.c:1995
Code: 00 83 fb ff 75 d6 e9 e0 fc ff ff e8 e2 01 16 00 e8 dd 4a 1b 00 41 56 9d e9 b6 fd ff ff e8 d0 01 16 00 e8 cb 4a 1b 00 41 56 9d 2a ff ff ff 0f 1f 00 55 48 89 f5 53 48 89 fb e8 b3 01 16 00 49
RSP: 0018:ffff8881da3176a0 EFLAGS: 00000212 ORIG_RAX: ffffffffffffff13
RAX: 0000000000000007 RBX: 0000000000000200 RCX: 0000000000000006
RDX: 0000000000000000 RSI: 0000000000000008 RDI: ffff8881da24ea4c
RBP: ffff8881da3176e8 R08: ffff8881da24e200 R09: fffffbfff1266e96
R10: fffffbfff1266e95 R11: ffffffff893374af R12: 000000000000003c
R13: ffff8881d8c78000 R14: 0000000000000212 R15: 0000000000000000
dev_vprintk_emit+0x4fc/0x541 drivers/base/core.c:3616
dev_printk_emit+0xba/0xf1 drivers/base/core.c:3627
__dev_printk+0x1db/0x203 drivers/base/core.c:3639
_dev_info+0xd7/0x109 drivers/base/core.c:3685
hub_port_init.cold+0x110/0x362 drivers/usb/core/hub.c:4615
hub_port_connect drivers/usb/core/hub.c:5127 [inline]
hub_port_connect_change drivers/usb/core/hub.c:5335 [inline]
port_event drivers/usb/core/hub.c:5481 [inline]
hub_event+0x1fc6/0x4300 drivers/usb/core/hub.c:5563
process_one_work+0x94b/0x1620 kernel/workqueue.c:2264
worker_thread+0x96/0xe20 kernel/workqueue.c:2410
kthread+0x318/0x420 kernel/kthread.c:255
ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:352