INFO: task syz-executor165:3686 blocked for more than 143 seconds.
Not tainted 6.0.0-rc7-syzkaller-00081-gc3e0e1e23c70 #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor165 state:D
stack:27184 pid: 3686 ppid: 3662 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:5182 [inline]
__schedule+0xadf/0x52b0 kernel/sched/core.c:6494
schedule+0xda/0x1b0 kernel/sched/core.c:6570
exp_funnel_lock kernel/rcu/tree_exp.h:315 [inline]
synchronize_rcu_expedited+0x5f9/0x670 kernel/rcu/tree_exp.h:940
synchronize_rcu+0x2c3/0x370 kernel/rcu/tree.c:3519
vhost_net_release+0x13d/0x2d0 drivers/vhost/net.c:1409
__fput+0x277/0x9d0 fs/file_table.c:320
task_work_run+0xdd/0x1a0 kernel/task_work.c:177
resume_user_mode_work include/linux/resume_user_mode.h:49 [inline]
exit_to_user_mode_loop kernel/entry/common.c:169 [inline]
exit_to_user_mode_prepare+0x23c/0x250 kernel/entry/common.c:201
__syscall_exit_to_user_mode_work kernel/entry/common.c:283 [inline]
syscall_exit_to_user_mode+0x19/0x50 kernel/entry/common.c:294
do_syscall_64+0x42/0xb0 arch/x86/entry/common.c:86
entry_SYSCALL_64_after_hwframe+0x63/0xcd
RIP: 0033:0x7ff60421032b
RSP: 002b:00007ff6043ffcb0 EFLAGS: 00000293 ORIG_RAX: 0000000000000003
RAX: 0000000000000000 RBX: 0000000000000005 RCX: 00007ff60421032b
RDX: 0000000000000000 RSI: 0000000000000080 RDI: 0000000000000004
RBP: 0000000000000032 R08: 0000000000000000 R09: 0000000000000000
R10: 00007ff6043ffd00 R11: 0000000000000293 R12: 00007ff6042f002c
R13: 00007ff6043ffd00 R14: 00007ff6043ffd20 R15: 00007ff60420ae70
INFO: task dhcpcd:3690 blocked for more than 144 seconds.
Not tainted 6.0.0-rc7-syzkaller-00081-gc3e0e1e23c70 #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:dhcpcd state:D stack:29096 pid: 3690 ppid: 3186 flags:0x00000000
Call Trace:
context_switch kernel/sched/core.c:5182 [inline]
__schedule+0xadf/0x52b0 kernel/sched/core.c:6494
schedule+0xda/0x1b0 kernel/sched/core.c:6570
exp_funnel_lock kernel/rcu/tree_exp.h:315 [inline]
synchronize_rcu_expedited+0x5f9/0x670 kernel/rcu/tree_exp.h:940
synchronize_rcu+0x2c3/0x370 kernel/rcu/tree.c:3519
synchronize_net+0x4a/0x50 net/core/dev.c:10766
__unregister_prot_hook+0x48a/0x5a0 net/packet/af_packet.c:382
packet_do_bind+0x8bc/0xdc0 net/packet/af_packet.c:3227
packet_bind+0x152/0x1b0 net/packet/af_packet.c:3311
__sys_bind+0x1e9/0x250 net/socket.c:1776
__do_sys_bind net/socket.c:1787 [inline]
__se_sys_bind net/socket.c:1785 [inline]
__x64_sys_bind+0x6f/0xb0 net/socket.c:1785
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x63/0xcd
RIP: 0033:0x7fe26c4cdce7
RSP: 002b:00007fffc0c51ea8 EFLAGS: 00000217
ORIG_RAX: 0000000000000031
RAX: ffffffffffffffda RBX: 000055566c3adb60 RCX: 00007fe26c4cdce7
RDX: 0000000000000014 RSI: 00007fffc0c51eb8 RDI: 0000000000000005
RBP: 0000000000000000 R08: 000055566c4a4610 R09: 00007fe26c58ea60
R10: 0000000000040000 R11: 0000000000000217 R12: 000055566c4a2a60
R13: 000055566c4a44f8 R14: 00007fffc0c7278c R15: 00007fffc0c727b4
INFO: task dhcpcd:3691 blocked for more than 145 seconds.
Not tainted 6.0.0-rc7-syzkaller-00081-gc3e0e1e23c70 #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:dhcpcd state:D
stack:29144 pid: 3691 ppid: 3186 flags:0x00000000
Call Trace:
context_switch kernel/sched/core.c:5182 [inline]
__schedule+0xadf/0x52b0 kernel/sched/core.c:6494
schedule+0xda/0x1b0 kernel/sched/core.c:6570
exp_funnel_lock kernel/rcu/tree_exp.h:315 [inline]
synchronize_rcu_expedited+0x5f9/0x670 kernel/rcu/tree_exp.h:940
synchronize_rcu+0x2c3/0x370 kernel/rcu/tree.c:3519
synchronize_net+0x4a/0x50 net/core/dev.c:10766
__unregister_prot_hook+0x48a/0x5a0 net/packet/af_packet.c:382
packet_do_bind+0x8bc/0xdc0 net/packet/af_packet.c:3227
packet_bind+0x152/0x1b0 net/packet/af_packet.c:3311
__sys_bind+0x1e9/0x250 net/socket.c:1776
__do_sys_bind net/socket.c:1787 [inline]
__se_sys_bind net/socket.c:1785 [inline]
__x64_sys_bind+0x6f/0xb0 net/socket.c:1785
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x63/0xcd
RIP: 0033:0x7fe26c4cdce7
RSP: 002b:00007fffc0c51ea8 EFLAGS: 00000217 ORIG_RAX: 0000000000000031
RAX: ffffffffffffffda RBX: 000055566c3adb60 RCX: 00007fe26c4cdce7
RDX: 0000000000000014 RSI: 00007fffc0c51eb8 RDI: 0000000000000005
RBP: 0000000000000000 R08: 000055566c4a4e20 R09: 00007fe26c58ea60
R10: 0000000000040000 R11: 0000000000000217 R12: 000055566c4a2a60
R13: 000055566c4a4a68 R14: 00007fffc0c7278c R15: 00007fffc0c727b4
INFO: task dhcpcd:3692 blocked for more than 146 seconds.
Not tainted 6.0.0-rc7-syzkaller-00081-gc3e0e1e23c70 #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:dhcpcd state:D stack:29144 pid: 3692 ppid: 3186 flags:0x00000000
Call Trace:
context_switch kernel/sched/core.c:5182 [inline]
__schedule+0xadf/0x52b0 kernel/sched/core.c:6494
schedule+0xda/0x1b0 kernel/sched/core.c:6570
exp_funnel_lock kernel/rcu/tree_exp.h:315 [inline]
synchronize_rcu_expedited+0x5f9/0x670 kernel/rcu/tree_exp.h:940
synchronize_rcu+0x2c3/0x370 kernel/rcu/tree.c:3519
synchronize_net+0x4a/0x50 net/core/dev.c:10766
__unregister_prot_hook+0x48a/0x5a0 net/packet/af_packet.c:382
packet_do_bind+0x8bc/0xdc0 net/packet/af_packet.c:3227
packet_bind+0x152/0x1b0 net/packet/af_packet.c:3311
__sys_bind+0x1e9/0x250 net/socket.c:1776
__do_sys_bind net/socket.c:1787 [inline]
__se_sys_bind net/socket.c:1785 [inline]
__x64_sys_bind+0x6f/0xb0 net/socket.c:1785
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x63/0xcd
RIP: 0033:0x7fe26c4cdce7
RSP: 002b:00007fffc0c51ea8 EFLAGS: 00000217 ORIG_RAX: 0000000000000031
RAX: ffffffffffffffda RBX: 000055566c3adb60 RCX: 00007fe26c4cdce7
RDX: 0000000000000014 RSI: 00007fffc0c51eb8 RDI: 0000000000000005
RBP: 0000000000000000 R08: 000055566c4a4490 R09: 00007fe26c58ea60
R10: 0000000000040000 R11: 0000000000000217 R12: 000055566c4a2a60
R13: 000055566c4a4be8 R14: 00007fffc0c7278c R15: 00007fffc0c727b4
INFO: task dhcpcd:3693 blocked for more than 147 seconds.
Not tainted 6.0.0-rc7-syzkaller-00081-gc3e0e1e23c70 #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:dhcpcd state:D stack:29144 pid: 3693 ppid: 3186 flags:0x00000000
Call Trace:
context_switch kernel/sched/core.c:5182 [inline]
__schedule+0xadf/0x52b0 kernel/sched/core.c:6494
schedule+0xda/0x1b0 kernel/sched/core.c:6570
exp_funnel_lock kernel/rcu/tree_exp.h:315 [inline]
synchronize_rcu_expedited+0x5f9/0x670 kernel/rcu/tree_exp.h:940
synchronize_rcu+0x2c3/0x370 kernel/rcu/tree.c:3519
synchronize_net+0x4a/0x50 net/core/dev.c:10766
__unregister_prot_hook+0x48a/0x5a0 net/packet/af_packet.c:382
packet_do_bind+0x8bc/0xdc0 net/packet/af_packet.c:3227
packet_bind+0x152/0x1b0 net/packet/af_packet.c:3311
__sys_bind+0x1e9/0x250 net/socket.c:1776
__do_sys_bind net/socket.c:1787 [inline]
__se_sys_bind net/socket.c:1785 [inline]
__x64_sys_bind+0x6f/0xb0 net/socket.c:1785
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x63/0xcd
RIP: 0033:0x7fe26c4cdce7
RSP: 002b:00007fffc0c51ea8 EFLAGS: 00000217
ORIG_RAX: 0000000000000031
RAX: ffffffffffffffda RBX: 000055566c3adb60 RCX: 00007fe26c4cdce7
RDX: 0000000000000014 RSI: 00007fffc0c51eb8 RDI: 0000000000000005
RBP: 0000000000000000 R08: 000055566c4a4490 R09: 00007fe26c58ea60
R10: 0000000000020000 R11: 0000000000000217 R12: 000055566c4a2a60
R13: 000055566c4a4e88 R14: 00007fffc0c7278c R15: 00007fffc0c727b4
Showing all locks held in the system:
1 lock held by rcu_tasks_kthre/13:
#0:
ffffffff8bf888b0
(
rcu_tasks.tasks_gp_mutex
){+.+.}-{3:3}
, at: rcu_tasks_one_gp+0x26/0xc70 kernel/rcu/tasks.h:507
1 lock held by rcu_tasks_trace/14:
#0: ffffffff8bf885b0 (rcu_tasks_trace.tasks_gp_mutex){+.+.}-{3:3}, at: rcu_tasks_one_gp+0x26/0xc70 kernel/rcu/tasks.h:507
1 lock held by khungtaskd/29:
#0:
ffffffff8bf89400
(
rcu_read_lock
){....}-{1:2}
, at: debug_show_all_locks+0x53/0x260 kernel/locking/lockdep.c:6492
3 locks held by kworker/1:2/145:
2 locks held by getty/3290:
#0:
ffff88814a8f8098 (&tty->ldisc_sem){++++}-{0:0}
, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:244
#1:
ffffc90002d232f0
(
&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0xef0/0x13e0 drivers/tty/n_tty.c:2177
4 locks held by kworker/0:1/3668:
1 lock held by syz-executor165/3687:
#0:
ffffffff8bf940b8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock kernel/rcu/tree_exp.h:324 [inline]
ffffffff8bf940b8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: synchronize_rcu_expedited+0x24a/0x670 kernel/rcu/tree_exp.h:940
1 lock held by dhcpcd/3690:
#0:
ffff88807e356130 (sk_lock-AF_PACKET){+.+.}-{0:0}
, at: lock_sock include/net/sock.h:1712 [inline]
, at: packet_do_bind+0x2f/0xdc0 net/packet/af_packet.c:3194
1 lock held by dhcpcd/3691:
#0: ffff88807e97c130 (
sk_lock-AF_PACKET
){+.+.}-{0:0}
, at: lock_sock include/net/sock.h:1712 [inline]
, at: packet_do_bind+0x2f/0xdc0 net/packet/af_packet.c:3194
1 lock held by dhcpcd/3692:
#0:
ffff88807e10e130
(
sk_lock-AF_PACKET
){+.+.}-{0:0}
, at: lock_sock include/net/sock.h:1712 [inline]
, at: packet_do_bind+0x2f/0xdc0 net/packet/af_packet.c:3194
1 lock held by dhcpcd/3693:
#0: ffff88807e044130 (sk_lock-AF_PACKET){+.+.}-{0:0}
, at: lock_sock include/net/sock.h:1712 [inline]
, at: packet_do_bind+0x2f/0xdc0 net/packet/af_packet.c:3194
1 lock held by dhcpcd/3694:
#0:
ffff88807e334130
(
sk_lock-AF_PACKET){+.+.}-{0:0}, at: lock_sock include/net/sock.h:1712 [inline]
sk_lock-AF_PACKET){+.+.}-{0:0}, at: packet_do_bind+0x2f/0xdc0 net/packet/af_packet.c:3194
1 lock held by dhcpcd/3695:
#0: ffff8880758d6130 (sk_lock-AF_PACKET){+.+.}-{0:0}, at: lock_sock include/net/sock.h:1712 [inline]
#0: ffff8880758d6130 (sk_lock-AF_PACKET){+.+.}-{0:0}, at: packet_do_bind+0x2f/0xdc0 net/packet/af_packet.c:3194
1 lock held by syz-executor165/3703:
#0: ffffffff8bf940b8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock kernel/rcu/tree_exp.h:324 [inline]
#0: ffffffff8bf940b8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: synchronize_rcu_expedited+0x24a/0x670 kernel/rcu/tree_exp.h:940
=============================================
NMI backtrace for cpu 0
CPU: 0 PID: 29 Comm: khungtaskd Not tainted 6.0.0-rc7-syzkaller-00081-gc3e0e1e23c70 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/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+0x46/0x14f lib/nmi_backtrace.c:111
nmi_trigger_cpumask_backtrace+0x206/0x250 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:148 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:212 [inline]
watchdog+0xc18/0xf50 kernel/hung_task.c:369
kthread+0x2e4/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: 145 Comm: kworker/1:2 Not tainted 6.0.0-rc7-syzkaller-00081-gc3e0e1e23c70 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/22/2022
Workqueue: events uhid_device_add_worker
RIP: 0010:__sanitizer_cov_trace_pc+0x37/0x60 kernel/kcov.c:200
Code: 81 e1 00 01 00 00 65 48 8b 14 25 80 6f 02 00 a9 00 01 ff 00 74 0e 85 c9 74 35 8b 82 bc 15 00 00 85 c0 74 2b 8b 82 98 15 00 00 <83> f8 02 75 20 48 8b 8a a0 15 00 00 8b 92 9c 15 00 00 48 8b 01 48
RSP: 0018:ffffc900029eedb0 EFLAGS: 00000246
RAX: 0000000000000000 RBX: 0000000000000000 RCX: 0000000000000000
RDX: ffff88801bcfd880 RSI: ffffffff84230da0 RDI: 0000000000000001
RBP: ffffc900029eeed0 R08: 0000000000000001 R09: 0000000000000078
R10: 0000000000000073 R11: 0000000000000000 R12: 0000000000000003
R13: ffffffff89ed78a1 R14: 1ffff9200053ddba R15: 0000000000000001
FS: 0000000000000000(0000) GS:ffff8880b9b00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00005555555b12b8 CR3: 000000000bc8e000 CR4: 00000000003506e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
format_decode+0x230/0xad0 lib/vsprintf.c:2523
vsnprintf+0x155/0x14f0 lib/vsprintf.c:2734
sprintf+0xc0/0x100 lib/vsprintf.c:2986
print_caller kernel/printk/printk.c:1288 [inline]
info_print_prefix+0x12e/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
__dev_printk+0xcf/0xf5 drivers/base/core.c:4759
_dev_warn+0xd7/0x109 drivers/base/core.c:4803
hid_parser_main.cold+0x4f/0xf1 drivers/hid/hid-core.c:633
hid_open_report+0x37f/0x650 drivers/hid/hid-core.c:1265
hid_parse include/linux/hid.h:1100 [inline]
hid_generic_probe+0x4a/0x90 drivers/hid/hid-generic.c:63
hid_device_probe+0x2bd/0x3f0 drivers/hid/hid-core.c:2598
call_driver_probe drivers/base/dd.c:560 [inline]
really_probe+0x249/0xb90 drivers/base/dd.c:639
__driver_probe_device+0x1df/0x4d0 drivers/base/dd.c:778
driver_probe_device+0x4c/0x1a0 drivers/base/dd.c:808
__device_attach_driver+0x1d0/0x2e0 drivers/base/dd.c:936
bus_for_each_drv+0x15f/0x1e0 drivers/base/bus.c:427
__device_attach+0x1e4/0x530 drivers/base/dd.c:1008
bus_probe_device+0x1e4/0x290 drivers/base/bus.c:487
device_add+0xbd5/0x1e90 drivers/base/core.c:3517
hid_add_device+0x344/0x9d0 drivers/hid/hid-core.c:2748
uhid_device_add_worker+0x36/0x60 drivers/hid/uhid.c:73
process_one_work+0x991/0x1610 kernel/workqueue.c:2289
worker_thread+0x665/0x1080 kernel/workqueue.c:2436
kthread+0x2e4/0x3a0 kernel/kthread.c:376
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:306
INFO: NMI handler (nmi_cpu_backtrace_handler) took too long to run: 2.086 msecs