INFO: task kworker/0:3:29482 blocked for more than 143 seconds.
Not tainted 5.19.0-syzkaller-10391-gb2a88c212e65 #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/0:3 state:D stack:23128 pid:29482 ppid: 2 flags:0x00004000
Workqueue: events console_callback
Call Trace:
context_switch kernel/sched/core.c:5178 [inline]
__schedule+0x93f/0x26e0 kernel/sched/core.c:6490
schedule+0xda/0x1b0 kernel/sched/core.c:6566
schedule_timeout+0x1db/0x2a0 kernel/time/timer.c:1911
___down_common kernel/locking/semaphore.c:225 [inline]
__down_common+0x363/0x770 kernel/locking/semaphore.c:246
down+0x70/0x90 kernel/locking/semaphore.c:63
console_lock+0x28/0x80 kernel/printk/printk.c:2568
console_callback+0x5f/0x4c0 drivers/tty/vt/vt.c:2980
process_one_work+0x996/0x1610 kernel/workqueue.c:2289
worker_thread+0x665/0x1080 kernel/workqueue.c:2436
kthread+0x2ef/0x3a0 kernel/kthread.c:376
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:306
Showing all locks held in the system:
1 lock held by rcu_tasks_kthre/11:
#0: ffffffff87a95310 (rcu_tasks.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x26/0xc70 kernel/rcu/tasks.h:507
1 lock held by khungtaskd/26:
#0: ffffffff87a95e60 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x53/0x260 kernel/locking/lockdep.c:6492
2 locks held by getty/1237:
#0:
ffff88810020f098 (&tty->ldisc_sem
){++++}-{0:0}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:244
#1: ffffc900000432e8 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0xe50/0x13c0 drivers/tty/n_tty.c:2124
2 locks held by kworker/1:5/4218:
#0: ffff888100066538 ((wq_completion)rcu_gp){+.+.}-{0:0}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
#0: ffff888100066538 ((wq_completion)rcu_gp){+.+.}-{0:0}, at: arch_atomic_long_set include/linux/atomic/atomic-long.h:41 [inline]
#0: ffff888100066538 ((wq_completion)rcu_gp){+.+.}-{0:0}, at: atomic_long_set include/linux/atomic/atomic-instrumented.h:1280 [inline]
#0: ffff888100066538 ((wq_completion)rcu_gp){+.+.}-{0:0}, at: set_work_data kernel/workqueue.c:636 [inline]
#0: ffff888100066538 ((wq_completion)rcu_gp){+.+.}-{0:0}, at: set_work_pool_and_clear_pending kernel/workqueue.c:663 [inline]
#0: ffff888100066538 ((wq_completion)rcu_gp){+.+.}-{0:0}, at: process_one_work+0x87a/0x1610 kernel/workqueue.c:2260
#1: ffffc9000235fda8 ((work_completion)(&rew->rew_work)){+.+.}-{0:0}, at: process_one_work+0x8ae/0x1610 kernel/workqueue.c:2264
6 locks held by kworker/0:8/5041:
7 locks held by kworker/1:1/10344:
5 locks held by kworker/1:6/19858:
#0: ffff888109b23138 ((wq_completion)usb_hub_wq
){+.+.}-{0:0}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
){+.+.}-{0:0}, at: arch_atomic_long_set include/linux/atomic/atomic-long.h:41 [inline]
){+.+.}-{0:0}, at: atomic_long_set include/linux/atomic/atomic-instrumented.h:1280 [inline]
){+.+.}-{0:0}, at: set_work_data kernel/workqueue.c:636 [inline]
){+.+.}-{0:0}, at: set_work_pool_and_clear_pending kernel/workqueue.c:663 [inline]
){+.+.}-{0:0}, at: process_one_work+0x87a/0x1610 kernel/workqueue.c:2260
#1:
ffffc9000109fda8 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x8ae/0x1610 kernel/workqueue.c:2264
#2: ffff88810f650190 (
&dev->mutex){....}-{3:3}
, at: device_lock include/linux/device.h:835 [inline]
, at: hub_event+0x1c1/0x4690 drivers/usb/core/hub.c:5681
#3: ffff88811d3c3190 (&dev->mutex){....}-{3:3}
, at: device_lock include/linux/device.h:835 [inline]
, at: __device_attach+0x76/0x530 drivers/base/dd.c:948
#4:
ffff888112396118 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:835 [inline]
ffff888112396118 (&dev->mutex){....}-{3:3}, at: __device_attach+0x76/0x530 drivers/base/dd.c:948
3 locks held by kworker/1:9/25978:
#0:
ffff888109b23138
((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: arch_atomic_long_set include/linux/atomic/atomic-long.h:41 [inline]
((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: atomic_long_set include/linux/atomic/atomic-instrumented.h:1280 [inline]
((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_data kernel/workqueue.c:636 [inline]
((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_pool_and_clear_pending kernel/workqueue.c:663 [inline]
((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x87a/0x1610 kernel/workqueue.c:2260
#1: ffffc9000e5c7da8 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x8ae/0x1610 kernel/workqueue.c:2264
#2: ffff88810f4a8190 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:835 [inline]
#2: ffff88810f4a8190 (&dev->mutex){....}-{3:3}, at: hub_event+0x1c1/0x4690 drivers/usb/core/hub.c:5681
3 locks held by udevd/26618:
#0: ffff88813f8cb488 (&of->mutex){+.+.}-{3:3}, at: kernfs_file_read_iter fs/kernfs/file.c:253 [inline]
#0: ffff88813f8cb488 (&of->mutex){+.+.}-{3:3}, at: kernfs_fop_read_iter+0x189/0x710 fs/kernfs/file.c:300
#1: ffff88810ea813a8 (kn->active
#51){++++}-{0:0}, at: kernfs_file_read_iter fs/kernfs/file.c:254 [inline]
#51){++++}-{0:0}, at: kernfs_fop_read_iter+0x1ac/0x710 fs/kernfs/file.c:300
#2: ffff88813a874190 (&dev->mutex){....}-{3:3}, at: device_lock_interruptible include/linux/device.h:840 [inline]
#2: ffff88813a874190 (&dev->mutex){....}-{3:3}, at: read_descriptors+0x3c/0x2c0 drivers/usb/core/sysfs.c:873
1 lock held by udevd/26634:
#0: ffffffff87a9ffb8 (rcu_state.exp_mutex){+.+.}-{3:3}
, at: exp_funnel_lock kernel/rcu/tree_exp.h:324 [inline]
, at: synchronize_rcu_expedited+0x24a/0x670 kernel/rcu/tree_exp.h:940
2 locks held by kworker/0:3/29482:
#0: ffff888100064d38 ((wq_completion)events){+.+.}-{0:0}
, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
, at: arch_atomic_long_set include/linux/atomic/atomic-long.h:41 [inline]
, at: atomic_long_set include/linux/atomic/atomic-instrumented.h:1280 [inline]
, at: set_work_data kernel/workqueue.c:636 [inline]
, at: set_work_pool_and_clear_pending kernel/workqueue.c:663 [inline]
, at: process_one_work+0x87a/0x1610 kernel/workqueue.c:2260
#1: ffffc900013efda8 (console_work){+.+.}-{0:0}, at: process_one_work+0x8ae/0x1610 kernel/workqueue.c:2264
=============================================
NMI backtrace for cpu 0
CPU: 0 PID: 26 Comm: khungtaskd Not tainted 5.19.0-syzkaller-10391-gb2a88c212e65 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 07/22/2022
Call Trace:
__dump_stack lib/dump_stack.c:88 [inline]
dump_stack_lvl+0xcd/0x134 lib/dump_stack.c:106
nmi_cpu_backtrace.cold+0x47/0x144 lib/nmi_backtrace.c:111
nmi_trigger_cpumask_backtrace+0x1e6/0x230 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:212 [inline]
watchdog+0xc1d/0xf50 kernel/hung_task.c:369
kthread+0x2ef/0x3a0 kernel/kthread.c:376
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:306
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 10344 Comm: kworker/1:1 Not tainted 5.19.0-syzkaller-10391-gb2a88c212e65 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 07/22/2022
Workqueue: usb_hub_wq hub_event
RIP: 0010:__sanitizer_cov_trace_pc+0x37/0x60 kernel/kcov.c:200
Code: 81 e1 00 01 00 00 65 48 8b 14 25 c0 6e 02 00 a9 00 01 ff 00 74 0e 85 c9 74 35 8b 82 bc 14 00 00 85 c0 74 2b 8b 82 98 14 00 00 <83> f8 02 75 20 48 8b 8a a0 14 00 00 8b 92 9c 14 00 00 48 8b 01 48
RSP: 0018:ffffc9000f66e578 EFLAGS: 00000246
RAX: 0000000000000002 RBX: dffffc0000000000 RCX: 0000000000000000
RDX: ffff888112c70000 RSI: ffffffff82288043 RDI: 0000000000000005
RBP: 0000000000000020 R08: 0000000000000005 R09: 000000000000002f
R10: 0000000000000020 R11: 0000000000000001 R12: ffffc9000f66e771
R13: ffffffff864872a4 R14: 000000000000000f R15: ffffc9000f66e680
FS: 0000000000000000(0000) GS:ffff8881f6900000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007fa407284110 CR3: 000000013797a000 CR4: 00000000003506e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
vsnprintf+0xea3/0x14f0 lib/vsprintf.c:2845
snprintf+0xbb/0xf0 lib/vsprintf.c:2917
print_caller kernel/printk/printk.c:1286 [inline]
info_print_prefix+0x11c/0x340 kernel/printk/printk.c:1305
record_print_text+0x14d/0x3e0 kernel/printk/printk.c:1352
console_emit_next_record.constprop.0+0x6bf/0x840 kernel/printk/printk.c:2715
console_flush_all kernel/printk/printk.c:2794 [inline]
console_unlock+0x37a/0x5a0 kernel/printk/printk.c:2861
vprintk_emit+0x1b9/0x5f0 kernel/printk/printk.c:2271
dev_vprintk_emit+0x36e/0x3b2 drivers/base/core.c:4736
dev_printk_emit+0xba/0xf1 drivers/base/core.c:4747
__netdev_printk+0x1c6/0x27a net/core/dev.c:11228
netdev_err+0xd7/0x109 net/core/dev.c:11280
asix_set_sw_mii drivers/net/usb/asix_common.c:78 [inline]
asix_check_host_enable.cold+0x22/0x66 drivers/net/usb/asix_common.c:98
__asix_mdio_read+0x93/0x220 drivers/net/usb/asix_common.c:506
asix_phy_reset+0x104/0x170 drivers/net/usb/asix_devices.c:215
ax88172_bind+0x437/0x5f0 drivers/net/usb/asix_devices.c:275
usbnet_probe+0xaf8/0x25b0 drivers/net/usb/usbnet.c:1740
usb_probe_interface+0x315/0x7f0 drivers/usb/core/driver.c:396
call_driver_probe drivers/base/dd.c:530 [inline]
really_probe+0x24e/0xbb0 drivers/base/dd.c:609
__driver_probe_device+0x338/0x4d0 drivers/base/dd.c:748
driver_probe_device+0x4c/0x1a0 drivers/base/dd.c:778
__device_attach_driver+0x20b/0x2f0 drivers/base/dd.c:901
bus_for_each_drv+0x15f/0x1e0 drivers/base/bus.c:427
__device_attach+0x1e4/0x530 drivers/base/dd.c:973
bus_probe_device+0x1e4/0x290 drivers/base/bus.c:487
device_add+0xbda/0x1ea0 drivers/base/core.c:3517
usb_set_configuration+0x101e/0x1900 drivers/usb/core/message.c:2170
usb_generic_driver_probe+0xba/0x100 drivers/usb/core/generic.c:238
usb_probe_device+0xd9/0x2c0 drivers/usb/core/driver.c:293
call_driver_probe drivers/base/dd.c:530 [inline]
really_probe+0x24e/0xbb0 drivers/base/dd.c:609
__driver_probe_device+0x338/0x4d0 drivers/base/dd.c:748
driver_probe_device+0x4c/0x1a0 drivers/base/dd.c:778
__device_attach_driver+0x20b/0x2f0 drivers/base/dd.c:901
bus_for_each_drv+0x15f/0x1e0 drivers/base/bus.c:427
__device_attach+0x1e4/0x530 drivers/base/dd.c:973
bus_probe_device+0x1e4/0x290 drivers/base/bus.c:487
device_add+0xbda/0x1ea0 drivers/base/core.c:3517
usb_new_device.cold+0x641/0x1091 drivers/usb/core/hub.c:2573
hub_port_connect drivers/usb/core/hub.c:5353 [inline]
hub_port_connect_change drivers/usb/core/hub.c:5497 [inline]
port_event drivers/usb/core/hub.c:5653 [inline]
hub_event+0x25d5/0x4690 drivers/usb/core/hub.c:5735
process_one_work+0x996/0x1610 kernel/workqueue.c:2289
process_scheduled_works kernel/workqueue.c:2352 [inline]
worker_thread+0x854/0x1080 kernel/workqueue.c:2438
kthread+0x2ef/0x3a0 kernel/kthread.c:376
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:306