INFO: task kworker/1:14:21850 blocked for more than 143 seconds.
Not tainted 6.6.0-rc2-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/1:14 state:D stack:23632 pid:21850 ppid:2 flags:0x00004000
Workqueue: events console_callback
Call Trace:
context_switch kernel/sched/core.c:5382 [inline]
__schedule+0xc79/0x30a0 kernel/sched/core.c:6695
schedule+0xe7/0x1b0 kernel/sched/core.c:6771
schedule_timeout+0x278/0x2c0 kernel/time/timer.c:2143
___down_common kernel/locking/semaphore.c:225 [inline]
__down_common+0x327/0x6c0 kernel/locking/semaphore.c:246
down+0x74/0xa0 kernel/locking/semaphore.c:63
console_lock+0x96/0x150 kernel/printk/printk.c:2652
console_callback+0x63/0x4c0 drivers/tty/vt/vt.c:2933
process_one_work+0x884/0x15c0 kernel/workqueue.c:2630
process_scheduled_works kernel/workqueue.c:2703 [inline]
worker_thread+0x8b9/0x1290 kernel/workqueue.c:2784
kthread+0x33c/0x440 kernel/kthread.c:388
ret_from_fork+0x45/0x80 arch/x86/kernel/process.c:147
ret_from_fork_asm+0x11/0x20 arch/x86/entry/entry_64.S:304
Showing all locks held in the system:
1 lock held by khungtaskd/29:
#0:
ffffffff87eac820
(rcu_read_lock){....}-{1:2}
, at: rcu_lock_acquire include/linux/rcupdate.h:303 [inline]
, at: rcu_read_lock include/linux/rcupdate.h:749 [inline]
, at: debug_show_all_locks+0x75/0x340 kernel/locking/lockdep.c:6613
3 locks held by kworker/0:2/733:
#0:
ffff88810ae6d138 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x787/0x15c0 kernel/workqueue.c:2605
#1:
ffffc900021efd80 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x7e9/0x15c0 kernel/workqueue.c:2606
#2: ffff8881063ca190 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:992 [inline]
#2: ffff8881063ca190 (&dev->mutex){....}-{3:3}, at: hub_event+0x1be/0x4f30 drivers/usb/core/hub.c:5768
2 locks held by getty/2442:
#0: ffff88811311a0a0 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x24/0x80 drivers/tty/tty_ldisc.c:243
#1: ffffc900000432f0 (&ldata->atomic_read_lock){+.+.}-{3:3}
, at: n_tty_read+0xfc5/0x1480 drivers/tty/n_tty.c:2206
6 locks held by kworker/1:6/5361:
#0: ffff88810ae6d138 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x787/0x15c0 kernel/workqueue.c:2605
#1:
ffffc9000256fd80 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x7e9/0x15c0 kernel/workqueue.c:2606
#2: ffff8881067fa190 (&dev->mutex
){....}-{3:3}
, at: device_lock include/linux/device.h:992 [inline]
, at: hub_event+0x1be/0x4f30 drivers/usb/core/hub.c:5768
#3:
ffff8881067fd500
(&port_dev->status_lock
){+.+.}-{3:3}
, at: usb_lock_port drivers/usb/core/hub.c:3138 [inline]
, at: hub_port_connect drivers/usb/core/hub.c:5337 [inline]
, at: hub_port_connect_change drivers/usb/core/hub.c:5580 [inline]
, at: port_event drivers/usb/core/hub.c:5740 [inline]
, at: hub_event+0x28b4/0x4f30 drivers/usb/core/hub.c:5822
#4: ffff8881057f9668 (hcd->address0_mutex){+.+.}-{3:3}, at: hub_port_connect drivers/usb/core/hub.c:5338 [inline]
#4: ffff8881057f9668 (hcd->address0_mutex){+.+.}-{3:3}, at: hub_port_connect_change drivers/usb/core/hub.c:5580 [inline]
#4: ffff8881057f9668 (hcd->address0_mutex){+.+.}-{3:3}, at: port_event drivers/usb/core/hub.c:5740 [inline]
#4: ffff8881057f9668 (hcd->address0_mutex){+.+.}-{3:3}, at: hub_event+0x28da/0x4f30 drivers/usb/core/hub.c:5822
#5:
ffff8881f673b558
(
&rq->__lock
){-.-.}-{2:2}
, at: raw_spin_rq_lock_nested kernel/sched/core.c:558 [inline]
, at: raw_spin_rq_lock kernel/sched/sched.h:1372 [inline]
, at: rq_lock kernel/sched/sched.h:1681 [inline]
, at: __schedule+0x290/0x30a0 kernel/sched/core.c:6612
3 locks held by kworker/1:9/15799:
5 locks held by kworker/0:10/17857:
2 locks held by kworker/1:5/19137:
#0: ffff888100072938 ((wq_completion)rcu_gp){+.+.}-{0:0}
, at: process_one_work+0x787/0x15c0 kernel/workqueue.c:2605
#1: ffffc90002a37d80 ((work_completion)(&rew->rew_work)
){+.+.}-{0:0}
, at: process_one_work+0x7e9/0x15c0 kernel/workqueue.c:2606
7 locks held by kworker/1:13/21848:
#0: ffff88810ae6d138 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x787/0x15c0 kernel/workqueue.c:2605
#1: ffffc900067b7d80
(
(work_completion)(&hub->events)
){+.+.}-{0:0}, at: process_one_work+0x7e9/0x15c0 kernel/workqueue.c:2606
#2: ffff8881067ca190 (&dev->mutex){....}-{3:3}
, at: device_lock include/linux/device.h:992 [inline]
, at: hub_event+0x1be/0x4f30 drivers/usb/core/hub.c:5768
#3: ffff88811bdf9190 (&dev->mutex){....}-{3:3}
, at: device_lock include/linux/device.h:992 [inline]
, at: usb_disconnect+0x10a/0x890 drivers/usb/core/hub.c:2243
#4: ffff8881128bb160 (&dev->mutex){....}-{3:3}
, at: device_lock include/linux/device.h:992 [inline]
, at: __device_driver_lock drivers/base/dd.c:1095 [inline]
, at: device_release_driver_internal+0xa4/0x610 drivers/base/dd.c:1292
#5: ffffffff88aa3668 (input_mutex){+.+.}-{3:3}, at: __input_unregister_device+0x136/0x450 drivers/input/input.c:2219
#6:
ffffffff87eb80f8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock kernel/rcu/tree_exp.h:293 [inline]
ffffffff87eb80f8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: synchronize_rcu_expedited+0x69e/0x7e0 kernel/rcu/tree_exp.h:992
2 locks held by kworker/1:14/21850:
#0: ffff888100070d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x787/0x15c0 kernel/workqueue.c:2605
#1: ffffc900068c7d80 (console_work){+.+.}-{0:0}
, at: process_one_work+0x7e9/0x15c0 kernel/workqueue.c:2606
6 locks held by kworker/0:14/22358:
#0: ffff88810ae6d138 ((wq_completion)usb_hub_wq
){+.+.}-{0:0}, at: process_one_work+0x787/0x15c0 kernel/workqueue.c:2605
#1: ffffc9000cf87d80 ((work_completion)(&hub->events)){+.+.}-{0:0}
, at: process_one_work+0x7e9/0x15c0 kernel/workqueue.c:2606
#2: ffff88810677a190
(&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:992 [inline]
(&dev->mutex){....}-{3:3}, at: hub_event+0x1be/0x4f30 drivers/usb/core/hub.c:5768
#3: ffff88811b663190 (&dev->mutex){....}-{3:3}
, at: device_lock include/linux/device.h:992 [inline]
, at: __device_attach+0x7f/0x4b0 drivers/base/dd.c:1005
#4: ffff888117673160 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:992 [inline]
#4: ffff888117673160 (&dev->mutex){....}-{3:3}, at: __device_attach+0x7f/0x4b0 drivers/base/dd.c:1005
#5:
ffff888106321868
(hcd->bandwidth_mutex){+.+.}-{3:3}, at: usb_set_interface+0x29b/0xea0 drivers/usb/core/message.c:1561
1 lock held by udevd/24082:
#0: ffffffff87eb80f8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock kernel/rcu/tree_exp.h:325 [inline]
#0: ffffffff87eb80f8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: synchronize_rcu_expedited+0x404/0x7e0 kernel/rcu/tree_exp.h:992
4 locks held by udevd/24083:
#0: ffff8881428f5d58 (&p->lock
){+.+.}-{3:3}
, at: seq_read_iter+0xda/0x1280 fs/seq_file.c:182
#1:
ffff8881179b3088
(&of->mutex
){+.+.}-{3:3}, at: kernfs_seq_start+0x4b/0x460 fs/kernfs/file.c:154
#2: ffff888115ca6bd0 (kn->active#21){++++}-{0:0}, at: kernfs_seq_start+0x6f/0x460 fs/kernfs/file.c:155
#3: ffff88811b663190 (&dev->mutex){....}-{3:3}, at: device_lock_interruptible include/linux/device.h:997 [inline]
#3: ffff88811b663190 (&dev->mutex){....}-{3:3}, at: serial_show+0x26/0xa0 drivers/usb/core/sysfs.c:143
=============================================
NMI backtrace for cpu 0
CPU: 0 PID: 29 Comm: khungtaskd Not tainted 6.6.0-rc2-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 08/04/2023
Call Trace:
__dump_stack lib/dump_stack.c:88 [inline]
dump_stack_lvl+0xd9/0x1b0 lib/dump_stack.c:106
nmi_cpu_backtrace+0x277/0x380 lib/nmi_backtrace.c:113
nmi_trigger_cpumask_backtrace+0x26c/0x2d0 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:160 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:222 [inline]
watchdog+0xf87/0x1210 kernel/hung_task.c:379
kthread+0x33c/0x440 kernel/kthread.c:388
ret_from_fork+0x45/0x80 arch/x86/kernel/process.c:147
ret_from_fork_asm+0x11/0x20 arch/x86/entry/entry_64.S:304
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 5361 Comm: kworker/1:6 Not tainted 6.6.0-rc2-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 08/04/2023
Workqueue: usb_hub_wq hub_event
RIP: 0010:mark_lock+0x2a/0x1950 kernel/locking/lockdep.c:4638
Code: 55 48 89 e5 41 57 41 56 41 55 41 89 d5 48 ba 00 00 00 00 00 fc ff df 41 54 53 48 83 e4 f0 48 81 ec 40 01 00 00 48 8d 44 24 40 <48> 89 7c 24 30 48 c7 44 24 40 b3 8a b5 41 48 c1 e8 03 48 c7 44 24
RSP: 0018:ffffc90000198ae0 EFLAGS: 00000082
RAX: ffffc90000198b20 RBX: 000000000000004d RCX: 1ffffffff16de99a
RDX: dffffc0000000000 RSI: ffff888102e88b20 RDI: ffff888102e88000
RBP: ffffc90000198c48 R08: 0000000000000000 R09: fffffbfff16de139
R10: ffffffff8b6f09cf R11: ffffc90000198ff8 R12: ffff888102e88b42
R13: 0000000000000008 R14: 0000000000000000 R15: 0000000000000000
FS: 0000000000000000(0000) GS:ffff8881f6700000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00005561af437950 CR3: 0000000112fa5000 CR4: 00000000003506e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
mark_usage kernel/locking/lockdep.c:4598 [inline]
__lock_acquire+0x975/0x5de0 kernel/locking/lockdep.c:5090
lock_acquire kernel/locking/lockdep.c:5753 [inline]
lock_acquire+0x1ae/0x510 kernel/locking/lockdep.c:5718
seqcount_lockdep_reader_access include/linux/seqlock.h:102 [inline]
ktime_get_update_offsets_now+0x84/0x610 kernel/time/timekeeping.c:2317
hrtimer_update_base kernel/time/hrtimer.c:633 [inline]
hrtimer_interrupt+0x142/0x800 kernel/time/hrtimer.c:1796
local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1063 [inline]
__sysvec_apic_timer_interrupt+0x105/0x3f0 arch/x86/kernel/apic/apic.c:1080
sysvec_apic_timer_interrupt+0x89/0xb0 arch/x86/kernel/apic/apic.c:1074
asm_sysvec_apic_timer_interrupt+0x1a/0x20 arch/x86/include/asm/idtentry.h:645
RIP: 0010:console_trylock_spinning kernel/printk/printk.c:1979 [inline]
RIP: 0010:vprintk_emit+0x3aa/0x5f0 kernel/printk/printk.c:2306
Code: 00 4d 85 e4 0f 85 e4 01 00 00 e8 11 20 1c 00 9c 5d 81 e5 00 02 00 00 31 ff 48 89 ee e8 8f 1b 1c 00 48 85 ed 0f 85 f0 01 00 00 f1 1f 1c 00 45 31 c9 41 b8 01 00 00 00 31 c9 48 8d 05 00 00 00
RSP: 0018:ffffc9000256f460 EFLAGS: 00000246
RAX: 0000000000040000 RBX: 000000000000003c RCX: ffffc9000d3d1000
RDX: 0000000000040000 RSI: ffffffff81315524 RDI: 0000000000000007
RBP: 0000000000000000 R08: 0000000000000007 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000627375 R12: 0000000000000200
R13: ffff888104e5d700 R14: ffffffff86c8ab60 R15: ffffc9000256f4c0
dev_vprintk_emit drivers/base/core.c:4849 [inline]
dev_printk_emit+0xfb/0x140 drivers/base/core.c:4860
__dev_printk+0xf5/0x270 drivers/base/core.c:4872
_dev_err+0xe5/0x120 drivers/base/core.c:4915
usb_get_configuration+0x4b6b/0x5640 drivers/usb/core/config.c:901
usb_enumerate_device drivers/usb/core/hub.c:2421 [inline]
usb_new_device+0x1115/0x1960 drivers/usb/core/hub.c:2559
hub_port_connect drivers/usb/core/hub.c:5440 [inline]
hub_port_connect_change drivers/usb/core/hub.c:5580 [inline]
port_event drivers/usb/core/hub.c:5740 [inline]
hub_event+0x2e62/0x4f30 drivers/usb/core/hub.c:5822
process_one_work+0x884/0x15c0 kernel/workqueue.c:2630
process_scheduled_works kernel/workqueue.c:2703 [inline]
worker_thread+0x8b9/0x1290 kernel/workqueue.c:2784
kthread+0x33c/0x440 kernel/kthread.c:388
ret_from_fork+0x45/0x80 arch/x86/kernel/process.c:147
ret_from_fork_asm+0x11/0x20 arch/x86/entry/entry_64.S:304