Re: [syzbot] INFO: task hung in port100_probe

5 views

Skip to first unread message

syzbot

unread,

Jul 21, 2021, 2:04:07 PM7/21/21

to krzysztof...@canonical.com, syzkall...@googlegroups.com

Hello,

syzbot has tested the proposed patch but the reproducer is still triggering an issue:
INFO: task hung in port100_probe

INFO: task kworker/0:2:2963 blocked for more than 143 seconds.
Not tainted 5.14.0-rc2-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/0:2 state:D stack:25984 pid: 2963 ppid: 2 flags:0x00004000
Workqueue: usb_hub_wq hub_event
Call Trace:
context_switch kernel/sched/core.c:4683 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5940
schedule+0xd3/0x270 kernel/sched/core.c:6019
schedule_timeout+0x1db/0x2a0 kernel/time/timer.c:1854
do_wait_for_common kernel/sched/completion.c:85 [inline]
__wait_for_common kernel/sched/completion.c:106 [inline]
wait_for_common kernel/sched/completion.c:117 [inline]
wait_for_completion+0x176/0x280 kernel/sched/completion.c:138
port100_send_cmd_sync drivers/nfc/port100.c:923 [inline]
port100_get_command_type_mask drivers/nfc/port100.c:1008 [inline]
port100_probe+0x9e4/0x1340 drivers/nfc/port100.c:1554
usb_probe_interface+0x315/0x7f0 drivers/usb/core/driver.c:396
call_driver_probe drivers/base/dd.c:517 [inline]
really_probe+0x23c/0xcd0 drivers/base/dd.c:595
__driver_probe_device+0x338/0x4d0 drivers/base/dd.c:747
driver_probe_device+0x4c/0x1a0 drivers/base/dd.c:777
__device_attach_driver+0x20b/0x2f0 drivers/base/dd.c:894
bus_for_each_drv+0x15f/0x1e0 drivers/base/bus.c:427
__device_attach+0x228/0x4a0 drivers/base/dd.c:965
bus_probe_device+0x1e4/0x290 drivers/base/bus.c:487
device_add+0xc2f/0x2180 drivers/base/core.c:3352
usb_set_configuration+0x113f/0x1910 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:517 [inline]
really_probe+0x23c/0xcd0 drivers/base/dd.c:595
__driver_probe_device+0x338/0x4d0 drivers/base/dd.c:747
driver_probe_device+0x4c/0x1a0 drivers/base/dd.c:777
__device_attach_driver+0x20b/0x2f0 drivers/base/dd.c:894
bus_for_each_drv+0x15f/0x1e0 drivers/base/bus.c:427
__device_attach+0x228/0x4a0 drivers/base/dd.c:965
bus_probe_device+0x1e4/0x290 drivers/base/bus.c:487
device_add+0xc2f/0x2180 drivers/base/core.c:3352
usb_new_device.cold+0x63f/0x108e drivers/usb/core/hub.c:2559
hub_port_connect drivers/usb/core/hub.c:5300 [inline]
hub_port_connect_change drivers/usb/core/hub.c:5440 [inline]
port_event drivers/usb/core/hub.c:5586 [inline]
hub_event+0x2357/0x4330 drivers/usb/core/hub.c:5668
process_one_work+0x98d/0x1630 kernel/workqueue.c:2276
worker_thread+0x658/0x11f0 kernel/workqueue.c:2422
kthread+0x3e5/0x4d0 kernel/kthread.c:319
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
INFO: task kworker/0:5:8677 blocked for more than 143 seconds.
Not tainted 5.14.0-rc2-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/0:5 state:D stack:26232 pid: 8677 ppid: 2 flags:0x00004000
Workqueue: usb_hub_wq hub_event
Call Trace:
context_switch kernel/sched/core.c:4683 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5940
schedule+0xd3/0x270 kernel/sched/core.c:6019
schedule_timeout+0x1db/0x2a0 kernel/time/timer.c:1854
do_wait_for_common kernel/sched/completion.c:85 [inline]
__wait_for_common kernel/sched/completion.c:106 [inline]
wait_for_common kernel/sched/completion.c:117 [inline]
wait_for_completion+0x176/0x280 kernel/sched/completion.c:138
port100_send_cmd_sync drivers/nfc/port100.c:923 [inline]
port100_get_command_type_mask drivers/nfc/port100.c:1008 [inline]
port100_probe+0x9e4/0x1340 drivers/nfc/port100.c:1554
usb_probe_interface+0x315/0x7f0 drivers/usb/core/driver.c:396
call_driver_probe drivers/base/dd.c:517 [inline]
really_probe+0x23c/0xcd0 drivers/base/dd.c:595
__driver_probe_device+0x338/0x4d0 drivers/base/dd.c:747
driver_probe_device+0x4c/0x1a0 drivers/base/dd.c:777
__device_attach_driver+0x20b/0x2f0 drivers/base/dd.c:894
bus_for_each_drv+0x15f/0x1e0 drivers/base/bus.c:427
__device_attach+0x228/0x4a0 drivers/base/dd.c:965
bus_probe_device+0x1e4/0x290 drivers/base/bus.c:487
device_add+0xc2f/0x2180 drivers/base/core.c:3352
usb_set_configuration+0x113f/0x1910 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:517 [inline]
really_probe+0x23c/0xcd0 drivers/base/dd.c:595
__driver_probe_device+0x338/0x4d0 drivers/base/dd.c:747
driver_probe_device+0x4c/0x1a0 drivers/base/dd.c:777
__device_attach_driver+0x20b/0x2f0 drivers/base/dd.c:894
bus_for_each_drv+0x15f/0x1e0 drivers/base/bus.c:427
__device_attach+0x228/0x4a0 drivers/base/dd.c:965
bus_probe_device+0x1e4/0x290 drivers/base/bus.c:487
device_add+0xc2f/0x2180 drivers/base/core.c:3352
usb_new_device.cold+0x63f/0x108e drivers/usb/core/hub.c:2559
hub_port_connect drivers/usb/core/hub.c:5300 [inline]
hub_port_connect_change drivers/usb/core/hub.c:5440 [inline]
port_event drivers/usb/core/hub.c:5586 [inline]
hub_event+0x2357/0x4330 drivers/usb/core/hub.c:5668
process_one_work+0x98d/0x1630 kernel/workqueue.c:2276
worker_thread+0x658/0x11f0 kernel/workqueue.c:2422
kthread+0x3e5/0x4d0 kernel/kthread.c:319
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
INFO: task kworker/0:7:10134 blocked for more than 144 seconds.
Not tainted 5.14.0-rc2-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/0:7 state:D stack:26232 pid:10134 ppid: 2 flags:0x00004000
Workqueue: usb_hub_wq hub_event
Call Trace:
context_switch kernel/sched/core.c:4683 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5940
schedule+0xd3/0x270 kernel/sched/core.c:6019
schedule_timeout+0x1db/0x2a0 kernel/time/timer.c:1854
do_wait_for_common kernel/sched/completion.c:85 [inline]
__wait_for_common kernel/sched/completion.c:106 [inline]
wait_for_common kernel/sched/completion.c:117 [inline]
wait_for_completion+0x176/0x280 kernel/sched/completion.c:138
port100_send_cmd_sync drivers/nfc/port100.c:923 [inline]
port100_get_command_type_mask drivers/nfc/port100.c:1008 [inline]
port100_probe+0x9e4/0x1340 drivers/nfc/port100.c:1554
usb_probe_interface+0x315/0x7f0 drivers/usb/core/driver.c:396
call_driver_probe drivers/base/dd.c:517 [inline]
really_probe+0x23c/0xcd0 drivers/base/dd.c:595
__driver_probe_device+0x338/0x4d0 drivers/base/dd.c:747
driver_probe_device+0x4c/0x1a0 drivers/base/dd.c:777
__device_attach_driver+0x20b/0x2f0 drivers/base/dd.c:894
bus_for_each_drv+0x15f/0x1e0 drivers/base/bus.c:427
__device_attach+0x228/0x4a0 drivers/base/dd.c:965
bus_probe_device+0x1e4/0x290 drivers/base/bus.c:487
device_add+0xc2f/0x2180 drivers/base/core.c:3352
usb_set_configuration+0x113f/0x1910 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:517 [inline]
really_probe+0x23c/0xcd0 drivers/base/dd.c:595
__driver_probe_device+0x338/0x4d0 drivers/base/dd.c:747
driver_probe_device+0x4c/0x1a0 drivers/base/dd.c:777
__device_attach_driver+0x20b/0x2f0 drivers/base/dd.c:894
bus_for_each_drv+0x15f/0x1e0 drivers/base/bus.c:427
__device_attach+0x228/0x4a0 drivers/base/dd.c:965
bus_probe_device+0x1e4/0x290 drivers/base/bus.c:487
device_add+0xc2f/0x2180 drivers/base/core.c:3352
usb_new_device.cold+0x63f/0x108e drivers/usb/core/hub.c:2559
hub_port_connect drivers/usb/core/hub.c:5300 [inline]
hub_port_connect_change drivers/usb/core/hub.c:5440 [inline]
port_event drivers/usb/core/hub.c:5586 [inline]
hub_event+0x2357/0x4330 drivers/usb/core/hub.c:5668
process_one_work+0x98d/0x1630 kernel/workqueue.c:2276
worker_thread+0x658/0x11f0 kernel/workqueue.c:2422
kthread+0x3e5/0x4d0 kernel/kthread.c:319
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
INFO: task syz-executor.1:10238 blocked for more than 144 seconds.
Not tainted 5.14.0-rc2-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.1 state:D stack:27528 pid:10238 ppid: 8848 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:4683 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5940
schedule+0xd3/0x270 kernel/sched/core.c:6019
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6078
__mutex_lock_common kernel/locking/mutex.c:1036 [inline]
__mutex_lock+0x7b6/0x10a0 kernel/locking/mutex.c:1104
misc_open+0x55/0x4a0 drivers/char/misc.c:107
chrdev_open+0x266/0x770 fs/char_dev.c:414
do_dentry_open+0x4c8/0x11d0 fs/open.c:826
do_open fs/namei.c:3374 [inline]
path_openat+0x1c23/0x27f0 fs/namei.c:3507
do_filp_open+0x1aa/0x400 fs/namei.c:3534
do_sys_openat2+0x16d/0x420 fs/open.c:1204
do_sys_open fs/open.c:1220 [inline]
__do_sys_openat fs/open.c:1236 [inline]
__se_sys_openat fs/open.c:1231 [inline]
__x64_sys_openat+0x13f/0x1f0 fs/open.c:1231
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+0x44/0xae
RIP: 0033:0x4196c4
RSP: 002b:00007fce23ab6040 EFLAGS: 00000293 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 000000000056bf80 RCX: 00000000004196c4
RDX: 0000000000000002 RSI: 00000000004bea81 RDI: 00000000ffffff9c
RBP: 00000000004bea81 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000002
R13: 0000000000000000 R14: 00000000200000c0 R15: 0000000000022000
INFO: task syz-executor.5:10274 blocked for more than 145 seconds.
Not tainted 5.14.0-rc2-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.5 state:D stack:27528 pid:10274 ppid: 8846 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:4683 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5940
schedule+0xd3/0x270 kernel/sched/core.c:6019
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6078
__mutex_lock_common kernel/locking/mutex.c:1036 [inline]
__mutex_lock+0x7b6/0x10a0 kernel/locking/mutex.c:1104
misc_open+0x55/0x4a0 drivers/char/misc.c:107
chrdev_open+0x266/0x770 fs/char_dev.c:414
do_dentry_open+0x4c8/0x11d0 fs/open.c:826
do_open fs/namei.c:3374 [inline]
path_openat+0x1c23/0x27f0 fs/namei.c:3507
do_filp_open+0x1aa/0x400 fs/namei.c:3534
do_sys_openat2+0x16d/0x420 fs/open.c:1204
do_sys_open fs/open.c:1220 [inline]
__do_sys_openat fs/open.c:1236 [inline]
__se_sys_openat fs/open.c:1231 [inline]
__x64_sys_openat+0x13f/0x1f0 fs/open.c:1231
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+0x44/0xae
RIP: 0033:0x4196c4
RSP: 002b:00007fc10a07c040 EFLAGS: 00000293 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 000000000056bf80 RCX: 00000000004196c4
RDX: 0000000000000002 RSI: 00000000004bea81 RDI: 00000000ffffff9c
RBP: 00000000004bea81 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000002
R13: 0000000000000000 R14: 00000000200000c0 R15: 0000000000022000
INFO: task syz-executor.4:10283 blocked for more than 145 seconds.
Not tainted 5.14.0-rc2-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.4 state:D stack:27528 pid:10283 ppid: 8847 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:4683 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5940
schedule+0xd3/0x270 kernel/sched/core.c:6019
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6078
__mutex_lock_common kernel/locking/mutex.c:1036 [inline]
__mutex_lock+0x7b6/0x10a0 kernel/locking/mutex.c:1104
misc_open+0x55/0x4a0 drivers/char/misc.c:107
chrdev_open+0x266/0x770 fs/char_dev.c:414
do_dentry_open+0x4c8/0x11d0 fs/open.c:826
do_open fs/namei.c:3374 [inline]
path_openat+0x1c23/0x27f0 fs/namei.c:3507
do_filp_open+0x1aa/0x400 fs/namei.c:3534
do_sys_openat2+0x16d/0x420 fs/open.c:1204
do_sys_open fs/open.c:1220 [inline]
__do_sys_openat fs/open.c:1236 [inline]
__se_sys_openat fs/open.c:1231 [inline]
__x64_sys_openat+0x13f/0x1f0 fs/open.c:1231
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+0x44/0xae
RIP: 0033:0x4196c4
RSP: 002b:00007feb111ec040 EFLAGS: 00000293 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 000000000056bf80 RCX: 00000000004196c4
RDX: 0000000000000002 RSI: 00000000004bea81 RDI: 00000000ffffff9c
RBP: 00000000004bea81 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000002
R13: 0000000000000000 R14: 00000000200000c0 R15: 0000000000022000
INFO: task syz-executor.0:10301 blocked for more than 145 seconds.
Not tainted 5.14.0-rc2-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.0 state:D stack:28480 pid:10301 ppid: 8841 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:4683 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5940
schedule+0xd3/0x270 kernel/sched/core.c:6019
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6078
__mutex_lock_common kernel/locking/mutex.c:1036 [inline]
__mutex_lock+0x7b6/0x10a0 kernel/locking/mutex.c:1104
misc_open+0x55/0x4a0 drivers/char/misc.c:107
chrdev_open+0x266/0x770 fs/char_dev.c:414
do_dentry_open+0x4c8/0x11d0 fs/open.c:826
do_open fs/namei.c:3374 [inline]
path_openat+0x1c23/0x27f0 fs/namei.c:3507
do_filp_open+0x1aa/0x400 fs/namei.c:3534
do_sys_openat2+0x16d/0x420 fs/open.c:1204
do_sys_open fs/open.c:1220 [inline]
__do_sys_openat fs/open.c:1236 [inline]
__se_sys_openat fs/open.c:1231 [inline]
__x64_sys_openat+0x13f/0x1f0 fs/open.c:1231
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+0x44/0xae
RIP: 0033:0x4196c4
RSP: 002b:00007fce09cb1040 EFLAGS: 00000293 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 000000000056c038 RCX: 00000000004196c4
RDX: 0000000000000002 RSI: 00000000004bea81 RDI: 00000000ffffff9c
RBP: 00000000004bea81 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000002
R13: 0000000000000000 R14: 0000000020000140 R15: 0000000000022000
INFO: task syz-executor.3:10308 blocked for more than 146 seconds.
Not tainted 5.14.0-rc2-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.3 state:D stack:27528 pid:10308 ppid: 8849 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:4683 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5940
schedule+0xd3/0x270 kernel/sched/core.c:6019
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6078
__mutex_lock_common kernel/locking/mutex.c:1036 [inline]
__mutex_lock+0x7b6/0x10a0 kernel/locking/mutex.c:1104
misc_open+0x55/0x4a0 drivers/char/misc.c:107
chrdev_open+0x266/0x770 fs/char_dev.c:414
do_dentry_open+0x4c8/0x11d0 fs/open.c:826
do_open fs/namei.c:3374 [inline]
path_openat+0x1c23/0x27f0 fs/namei.c:3507
do_filp_open+0x1aa/0x400 fs/namei.c:3534
do_sys_openat2+0x16d/0x420 fs/open.c:1204
do_sys_open fs/open.c:1220 [inline]
__do_sys_openat fs/open.c:1236 [inline]
__se_sys_openat fs/open.c:1231 [inline]
__x64_sys_openat+0x13f/0x1f0 fs/open.c:1231
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+0x44/0xae
RIP: 0033:0x4665d9
RSP: 002b:00007f01179cc188 EFLAGS: 00000246 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 000000000056bf80 RCX: 00000000004665d9
RDX: 0000000000020601 RSI: 00000000200003c0 RDI: ffffffffffffff9c
RBP: 00000000004bfcb9 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056bf80
R13: 00007ffd1532732f R14: 00007f01179cc300 R15: 0000000000022000
INFO: task syz-executor.3:10309 blocked for more than 146 seconds.
Not tainted 5.14.0-rc2-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.3 state:D stack:27528 pid:10309 ppid: 8849 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:4683 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5940
schedule+0xd3/0x270 kernel/sched/core.c:6019
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6078
__mutex_lock_common kernel/locking/mutex.c:1036 [inline]
__mutex_lock+0x7b6/0x10a0 kernel/locking/mutex.c:1104
misc_open+0x55/0x4a0 drivers/char/misc.c:107
chrdev_open+0x266/0x770 fs/char_dev.c:414
do_dentry_open+0x4c8/0x11d0 fs/open.c:826
do_open fs/namei.c:3374 [inline]
path_openat+0x1c23/0x27f0 fs/namei.c:3507
do_filp_open+0x1aa/0x400 fs/namei.c:3534
do_sys_openat2+0x16d/0x420 fs/open.c:1204
do_sys_open fs/open.c:1220 [inline]
__do_sys_openat fs/open.c:1236 [inline]
__se_sys_openat fs/open.c:1231 [inline]
__x64_sys_openat+0x13f/0x1f0 fs/open.c:1231
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+0x44/0xae
RIP: 0033:0x4196c4
RSP: 002b:00007f01179a9040 EFLAGS: 00000293 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 000000000056c038 RCX: 00000000004196c4
RDX: 0000000000000002 RSI: 00000000004bea81 RDI: 00000000ffffff9c
RBP: 00000000004bea81 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000002
R13: 0000000000000000 R14: 0000000020000140 R15: 0000000000022000
INFO: task syz-executor.2:10311 blocked for more than 146 seconds.
Not tainted 5.14.0-rc2-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.2 state:D stack:27528 pid:10311 ppid: 8850 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:4683 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5940
schedule+0xd3/0x270 kernel/sched/core.c:6019
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6078
__mutex_lock_common kernel/locking/mutex.c:1036 [inline]
__mutex_lock+0x7b6/0x10a0 kernel/locking/mutex.c:1104
misc_open+0x55/0x4a0 drivers/char/misc.c:107
chrdev_open+0x266/0x770 fs/char_dev.c:414
do_dentry_open+0x4c8/0x11d0 fs/open.c:826
do_open fs/namei.c:3374 [inline]
path_openat+0x1c23/0x27f0 fs/namei.c:3507
do_filp_open+0x1aa/0x400 fs/namei.c:3534
do_sys_openat2+0x16d/0x420 fs/open.c:1204
do_sys_open fs/open.c:1220 [inline]
__do_sys_openat fs/open.c:1236 [inline]
__se_sys_openat fs/open.c:1231 [inline]
__x64_sys_openat+0x13f/0x1f0 fs/open.c:1231
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+0x44/0xae
RIP: 0033:0x4665d9
RSP: 002b:00007fb932866188 EFLAGS: 00000246 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 000000000056bf80 RCX: 00000000004665d9
RDX: 0000000000020601 RSI: 00000000200003c0 RDI: ffffffffffffff9c
RBP: 00000000004bfcb9 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056bf80
R13: 00007fffbae5da0f R14: 00007fb932866300 R15: 0000000000022000

Showing all locks held in the system:
1 lock held by khungtaskd/1650:
#0: ffffffff8b97b9c0 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x53/0x260 kernel/locking/lockdep.c:6446
5 locks held by kworker/0:2/2963:
#0: ffff888018dd0538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
#0: ffff888018dd0538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: atomic64_set include/asm-generic/atomic-instrumented.h:620 [inline]
#0: ffff888018dd0538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: atomic_long_set include/asm-generic/atomic-long.h:41 [inline]
#0: ffff888018dd0538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_data kernel/workqueue.c:617 [inline]
#0: ffff888018dd0538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_pool_and_clear_pending kernel/workqueue.c:644 [inline]
#0: ffff888018dd0538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x871/0x1630 kernel/workqueue.c:2247
#1: ffffc90002367db0 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x8a5/0x1630 kernel/workqueue.c:2251
#2: ffff8880220b5220 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:754 [inline]
#2: ffff8880220b5220 (&dev->mutex){....}-{3:3}, at: hub_event+0x1c1/0x4330 drivers/usb/core/hub.c:5614
#3: ffff888036ee1220 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:754 [inline]
#3: ffff888036ee1220 (&dev->mutex){....}-{3:3}, at: __device_attach+0x7a/0x4a0 drivers/base/dd.c:940
#4: ffff88802c6aa1a8 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:754 [inline]
#4: ffff88802c6aa1a8 (&dev->mutex){....}-{3:3}, at: __device_attach+0x7a/0x4a0 drivers/base/dd.c:940
1 lock held by in:imklog/8165:
#0: ffff888029c420f0 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0xe9/0x100 fs/file.c:974
5 locks held by kworker/0:5/8677:
#0: ffff888018dd0538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
#0: ffff888018dd0538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: atomic64_set include/asm-generic/atomic-instrumented.h:620 [inline]
#0: ffff888018dd0538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: atomic_long_set include/asm-generic/atomic-long.h:41 [inline]
#0: ffff888018dd0538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_data kernel/workqueue.c:617 [inline]
#0: ffff888018dd0538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_pool_and_clear_pending kernel/workqueue.c:644 [inline]
#0: ffff888018dd0538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x871/0x1630 kernel/workqueue.c:2247
#1: ffffc9000257fdb0 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x8a5/0x1630 kernel/workqueue.c:2251
#2: ffff8881466bc220 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:754 [inline]
#2: ffff8881466bc220 (&dev->mutex){....}-{3:3}, at: hub_event+0x1c1/0x4330 drivers/usb/core/hub.c:5614
#3: ffff88802d41b220 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:754 [inline]
#3: ffff88802d41b220 (&dev->mutex){....}-{3:3}, at: __device_attach+0x7a/0x4a0 drivers/base/dd.c:940
#4: ffff888032fbb1a8 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:754 [inline]
#4: ffff888032fbb1a8 (&dev->mutex){....}-{3:3}, at: __device_attach+0x7a/0x4a0 drivers/base/dd.c:940
5 locks held by kworker/0:7/10134:
#0: ffff888018dd0538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
#0: ffff888018dd0538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: atomic64_set include/asm-generic/atomic-instrumented.h:620 [inline]
#0: ffff888018dd0538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: atomic_long_set include/asm-generic/atomic-long.h:41 [inline]
#0: ffff888018dd0538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_data kernel/workqueue.c:617 [inline]
#0: ffff888018dd0538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_pool_and_clear_pending kernel/workqueue.c:644 [inline]
#0: ffff888018dd0538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x871/0x1630 kernel/workqueue.c:2247
#1: ffffc9000a1f7db0 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x8a5/0x1630 kernel/workqueue.c:2251
#2: ffff88802217c220 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:754 [inline]
#2: ffff88802217c220 (&dev->mutex){....}-{3:3}, at: hub_event+0x1c1/0x4330 drivers/usb/core/hub.c:5614
#3: ffff88802afb8220 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:754 [inline]
#3: ffff88802afb8220 (&dev->mutex){....}-{3:3}, at: __device_attach+0x7a/0x4a0 drivers/base/dd.c:940
#4: ffff88803d8de1a8 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:754 [inline]
#4: ffff88803d8de1a8 (&dev->mutex){....}-{3:3}, at: __device_attach+0x7a/0x4a0 drivers/base/dd.c:940
1 lock held by syz-executor.1/10238:
#0: ffffffff8c3b3fa8 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107
1 lock held by syz-executor.5/10274:
#0: ffffffff8c3b3fa8 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107
1 lock held by syz-executor.4/10283:
#0: ffffffff8c3b3fa8 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107
2 locks held by syz-executor.0/10296:
#0: ffffffff8c3b3fa8 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107
#1: ffffffff8b84bc28 (system_transition_mutex){+.+.}-{3:3}, at: snapshot_open+0x3b/0x2a0 kernel/power/user.c:54
1 lock held by syz-executor.0/10301:
#0: ffffffff8c3b3fa8 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107
1 lock held by syz-executor.3/10308:
#0: ffffffff8c3b3fa8 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107
1 lock held by syz-executor.3/10309:
#0: ffffffff8c3b3fa8 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107
1 lock held by syz-executor.2/10311:
#0: ffffffff8c3b3fa8 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107
1 lock held by syz-executor.2/10313:
#0: ffffffff8c3b3fa8 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107

=============================================

NMI backtrace for cpu 1
CPU: 1 PID: 1650 Comm: khungtaskd Not tainted 5.14.0-rc2-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+0xcd/0x134 lib/dump_stack.c:105
nmi_cpu_backtrace.cold+0x44/0xd7 lib/nmi_backtrace.c:105
nmi_trigger_cpumask_backtrace+0x1b3/0x230 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:210 [inline]
watchdog+0xd0a/0xfc0 kernel/hung_task.c:295
kthread+0x3e5/0x4d0 kernel/kthread.c:319
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 84 Comm: kworker/u4:2 Not tainted 5.14.0-rc2-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Workqueue: bat_events batadv_nc_worker
RIP: 0010:match_held_lock+0xe/0xc0 kernel/locking/lockdep.c:5077
Code: 48 c7 c7 40 db 8b 89 e8 96 75 be ff e8 d3 15 cd ff 31 c0 5d c3 0f 1f 80 00 00 00 00 53 48 89 fb 48 83 ec 08 48 39 77 10 74 6a <66> f7 47 22 f0 ff 74 5a 48 8b 46 08 48 89 f7 48 85 c0 74 42 8b 15
RSP: 0018:ffffc900010bfad0 EFLAGS: 00000083
RAX: 0000000000000005 RBX: ffff888014b8a658 RCX: 0000000000000001
RDX: 0000000000000000 RSI: ffffffff8b97b900 RDI: ffff888014b8a658
RBP: ffffffff8b97b900 R08: 0000000000000000 R09: ffffffff8d6c3b97
R10: fffffbfff1ad8772 R11: 0000000000000000 R12: ffff888014b89c40
R13: ffff888014b8a630 R14: 00000000ffffffff R15: ffff888014b8a658
FS: 0000000000000000(0000) GS:ffff8880b9c00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f596bb47000 CR3: 000000000b68e000 CR4: 00000000001506f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
__lock_is_held kernel/locking/lockdep.c:5368 [inline]
lock_is_held_type+0xa7/0x140 kernel/locking/lockdep.c:5668
lock_is_held include/linux/lockdep.h:283 [inline]
rcu_read_lock_sched_held+0x3a/0x70 kernel/rcu/update.c:125
trace_lock_acquire include/trace/events/lock.h:13 [inline]
lock_acquire+0x442/0x510 kernel/locking/lockdep.c:5596
rcu_lock_acquire include/linux/rcupdate.h:267 [inline]
rcu_read_lock include/linux/rcupdate.h:687 [inline]
batadv_nc_process_nc_paths.part.0+0xec/0x3c0 net/batman-adv/network-coding.c:683
batadv_nc_process_nc_paths net/batman-adv/network-coding.c:675 [inline]
batadv_nc_worker+0xafa/0xe50 net/batman-adv/network-coding.c:724
process_one_work+0x98d/0x1630 kernel/workqueue.c:2276
worker_thread+0x658/0x11f0 kernel/workqueue.c:2422
kthread+0x3e5/0x4d0 kernel/kthread.c:319
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295

Tested on:

commit: 8cae8cd8 seq_file: disallow extremely large seq buffer..
git tree: upstream
console output: https://syzkaller.appspot.com/x/log.txt?x=174ff77c300000
kernel config: https://syzkaller.appspot.com/x/.config?x=4374ef2865daa37d
dashboard link: https://syzkaller.appspot.com/bug?extid=abd2e0dafb481b621869
compiler: gcc (Debian 10.2.1-6) 10.2.1 20210110, GNU ld (GNU Binutils for Debian) 2.35.1

syzbot

unread,

Jul 21, 2021, 2:18:19 PM7/21/21

to krzysztof...@canonical.com, syzkall...@googlegroups.com

Hello,

syzbot has tested the proposed patch but the reproducer is still triggering an issue:
INFO: task hung in port100_probe

INFO: task kworker/0:0:5 blocked for more than 143 seconds.
Not tainted 5.14.0-rc2-next-20210721-syzkaller #0

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

task:kworker/0:0 state:D stack:25616 pid: 5 ppid: 2 flags:0x00004000

Workqueue: usb_hub_wq hub_event
Call Trace:

context_switch kernel/sched/core.c:4700 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5957
schedule+0xd3/0x270 kernel/sched/core.c:6036
schedule_timeout+0x1db/0x2a0 kernel/time/timer.c:1855

do_wait_for_common kernel/sched/completion.c:85 [inline]
__wait_for_common kernel/sched/completion.c:106 [inline]
wait_for_common kernel/sched/completion.c:117 [inline]
wait_for_completion+0x176/0x280 kernel/sched/completion.c:138
port100_send_cmd_sync drivers/nfc/port100.c:923 [inline]
port100_get_command_type_mask drivers/nfc/port100.c:1008 [inline]
port100_probe+0x9e4/0x1340 drivers/nfc/port100.c:1554
usb_probe_interface+0x315/0x7f0 drivers/usb/core/driver.c:396
call_driver_probe drivers/base/dd.c:517 [inline]
really_probe+0x23c/0xcd0 drivers/base/dd.c:595
__driver_probe_device+0x338/0x4d0 drivers/base/dd.c:747
driver_probe_device+0x4c/0x1a0 drivers/base/dd.c:777
__device_attach_driver+0x20b/0x2f0 drivers/base/dd.c:894
bus_for_each_drv+0x15f/0x1e0 drivers/base/bus.c:427
__device_attach+0x228/0x4a0 drivers/base/dd.c:965
bus_probe_device+0x1e4/0x290 drivers/base/bus.c:487

device_add+0xc35/0x21b0 drivers/base/core.c:3354

usb_set_configuration+0x113f/0x1910 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:517 [inline]
really_probe+0x23c/0xcd0 drivers/base/dd.c:595
__driver_probe_device+0x338/0x4d0 drivers/base/dd.c:747
driver_probe_device+0x4c/0x1a0 drivers/base/dd.c:777
__device_attach_driver+0x20b/0x2f0 drivers/base/dd.c:894
bus_for_each_drv+0x15f/0x1e0 drivers/base/bus.c:427
__device_attach+0x228/0x4a0 drivers/base/dd.c:965
bus_probe_device+0x1e4/0x290 drivers/base/bus.c:487

device_add+0xc35/0x21b0 drivers/base/core.c:3354

usb_new_device.cold+0x63f/0x108e drivers/usb/core/hub.c:2559
hub_port_connect drivers/usb/core/hub.c:5300 [inline]
hub_port_connect_change drivers/usb/core/hub.c:5440 [inline]
port_event drivers/usb/core/hub.c:5586 [inline]
hub_event+0x2357/0x4330 drivers/usb/core/hub.c:5668
process_one_work+0x98d/0x1630 kernel/workqueue.c:2276

process_scheduled_works kernel/workqueue.c:2338 [inline]
worker_thread+0x85c/0x11f0 kernel/workqueue.c:2424

kthread+0x3e5/0x4d0 kernel/kthread.c:319
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295

INFO: task kworker/0:8:10942 blocked for more than 143 seconds.
Not tainted 5.14.0-rc2-next-20210721-syzkaller #0

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

task:kworker/0:8 state:D stack:25992 pid:10942 ppid: 2 flags:0x00004000

Workqueue: usb_hub_wq hub_event
Call Trace:

context_switch kernel/sched/core.c:4700 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5957
schedule+0xd3/0x270 kernel/sched/core.c:6036
schedule_timeout+0x1db/0x2a0 kernel/time/timer.c:1855

device_add+0xc35/0x21b0 drivers/base/core.c:3354

process_scheduled_works kernel/workqueue.c:2338 [inline]
worker_thread+0x85c/0x11f0 kernel/workqueue.c:2424

kthread+0x3e5/0x4d0 kernel/kthread.c:319
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295

INFO: task syz-executor.0:11204 can't die for more than 144 seconds.
task:syz-executor.0 state:D stack:27904 pid:11204 ppid: 8978 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:4700 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5957
schedule+0xd3/0x270 kernel/sched/core.c:6036
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6095
__mutex_lock_common kernel/locking/mutex.c:1036 [inline]
__mutex_lock+0xa46/0x1300 kernel/locking/mutex.c:1096

misc_open+0x55/0x4a0 drivers/char/misc.c:107
chrdev_open+0x266/0x770 fs/char_dev.c:414
do_dentry_open+0x4c8/0x11d0 fs/open.c:826
do_open fs/namei.c:3374 [inline]
path_openat+0x1c23/0x27f0 fs/namei.c:3507
do_filp_open+0x1aa/0x400 fs/namei.c:3534
do_sys_openat2+0x16d/0x420 fs/open.c:1204
do_sys_open fs/open.c:1220 [inline]
__do_sys_openat fs/open.c:1236 [inline]
__se_sys_openat fs/open.c:1231 [inline]
__x64_sys_openat+0x13f/0x1f0 fs/open.c:1231
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+0x44/0xae
RIP: 0033:0x4665d9

RSP: 002b:00007f240689e188 EFLAGS: 00000246 ORIG_RAX: 0000000000000101

RAX: ffffffffffffffda RBX: 000000000056bf80 RCX: 00000000004665d9
RDX: 0000000000020601 RSI: 00000000200003c0 RDI: ffffffffffffff9c
RBP: 00000000004bfcb9 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056bf80

R13: 00007ffd1ba85f0f R14: 00007f240689e300 R15: 0000000000022000
INFO: task syz-executor.0:11204 blocked for more than 144 seconds.
Not tainted 5.14.0-rc2-next-20210721-syzkaller #0

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

task:syz-executor.0 state:D stack:27904 pid:11204 ppid: 8978 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:4700 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5957
schedule+0xd3/0x270 kernel/sched/core.c:6036
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6095
__mutex_lock_common kernel/locking/mutex.c:1036 [inline]
__mutex_lock+0xa46/0x1300 kernel/locking/mutex.c:1096

RSP: 002b:00007f240689e188 EFLAGS: 00000246 ORIG_RAX: 0000000000000101

R13: 00007ffd1ba85f0f R14: 00007f240689e300 R15: 0000000000022000
INFO: task syz-executor.0:11289 can't die for more than 144 seconds.
task:syz-executor.0 state:D stack:28480 pid:11289 ppid: 8978 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:4700 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5957
schedule+0xd3/0x270 kernel/sched/core.c:6036
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6095
__mutex_lock_common kernel/locking/mutex.c:1036 [inline]
__mutex_lock+0xa46/0x1300 kernel/locking/mutex.c:1096

RSP: 002b:00007f240685a040 EFLAGS: 00000293 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 000000000056c0f0 RCX: 00000000004196c4

RDX: 0000000000000002 RSI: 00000000004bea81 RDI: 00000000ffffff9c
RBP: 00000000004bea81 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000002
R13: 0000000000000000 R14: 0000000020000140 R15: 0000000000022000

INFO: task syz-executor.0:11289 blocked for more than 145 seconds.
Not tainted 5.14.0-rc2-next-20210721-syzkaller #0

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

task:syz-executor.0 state:D stack:28480 pid:11289 ppid: 8978 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:4700 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5957
schedule+0xd3/0x270 kernel/sched/core.c:6036
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6095
__mutex_lock_common kernel/locking/mutex.c:1036 [inline]
__mutex_lock+0xa46/0x1300 kernel/locking/mutex.c:1096

RSP: 002b:00007f240685a040 EFLAGS: 00000293 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 000000000056c0f0 RCX: 00000000004196c4

INFO: task syz-executor.5:11271 can't die for more than 145 seconds.
task:syz-executor.5 state:D stack:28480 pid:11271 ppid: 8980 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:4700 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5957
schedule+0xd3/0x270 kernel/sched/core.c:6036
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6095
__mutex_lock_common kernel/locking/mutex.c:1036 [inline]
__mutex_lock+0xa46/0x1300 kernel/locking/mutex.c:1096

RSP: 002b:00007fd809300040 EFLAGS: 00000293 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 000000000056c1a8 RCX: 00000000004196c4

INFO: task syz-executor.5:11271 blocked for more than 145 seconds.
Not tainted 5.14.0-rc2-next-20210721-syzkaller #0

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

task:syz-executor.5 state:D stack:28480 pid:11271 ppid: 8980 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:4700 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5957
schedule+0xd3/0x270 kernel/sched/core.c:6036
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6095
__mutex_lock_common kernel/locking/mutex.c:1036 [inline]
__mutex_lock+0xa46/0x1300 kernel/locking/mutex.c:1096

RSP: 002b:00007fd809300040 EFLAGS: 00000293 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 000000000056c1a8 RCX: 00000000004196c4

INFO: task syz-executor.3:11215 can't die for more than 146 seconds.
task:syz-executor.3 state:D stack:28248 pid:11215 ppid: 8974 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:4700 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5957
schedule+0xd3/0x270 kernel/sched/core.c:6036
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6095
__mutex_lock_common kernel/locking/mutex.c:1036 [inline]
__mutex_lock+0xa46/0x1300 kernel/locking/mutex.c:1096

RSP: 002b:00007f0ac6dee040 EFLAGS: 00000293 ORIG_RAX: 0000000000000101

RAX: ffffffffffffffda RBX: 000000000056bf80 RCX: 00000000004196c4
RDX: 0000000000000002 RSI: 00000000004bea81 RDI: 00000000ffffff9c
RBP: 00000000004bea81 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000002
R13: 0000000000000000 R14: 00000000200000c0 R15: 0000000000022000

INFO: task syz-executor.3:11215 blocked for more than 146 seconds.
Not tainted 5.14.0-rc2-next-20210721-syzkaller #0

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

task:syz-executor.3 state:D stack:28248 pid:11215 ppid: 8974 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:4700 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5957
schedule+0xd3/0x270 kernel/sched/core.c:6036
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6095
__mutex_lock_common kernel/locking/mutex.c:1036 [inline]
__mutex_lock+0xa46/0x1300 kernel/locking/mutex.c:1096

RSP: 002b:00007f0ac6dee040 EFLAGS: 00000293 ORIG_RAX: 0000000000000101

INFO: task syz-executor.1:11219 can't die for more than 146 seconds.
task:syz-executor.1 state:D stack:28480 pid:11219 ppid: 8982 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:4700 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5957
schedule+0xd3/0x270 kernel/sched/core.c:6036
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6095
__mutex_lock_common kernel/locking/mutex.c:1036 [inline]
__mutex_lock+0xa46/0x1300 kernel/locking/mutex.c:1096

RSP: 002b:00007fb9378f5188 EFLAGS: 00000246 ORIG_RAX: 0000000000000101

R13: 00007ffc4a8a844f R14: 00007fb9378f5300 R15: 0000000000022000
INFO: task syz-executor.1:11219 blocked for more than 147 seconds.
Not tainted 5.14.0-rc2-next-20210721-syzkaller #0

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

task:syz-executor.1 state:D stack:28480 pid:11219 ppid: 8982 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:4700 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5957
schedule+0xd3/0x270 kernel/sched/core.c:6036
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6095
__mutex_lock_common kernel/locking/mutex.c:1036 [inline]
__mutex_lock+0xa46/0x1300 kernel/locking/mutex.c:1096

RSP: 002b:00007fb9378f5188 EFLAGS: 00000246 ORIG_RAX: 0000000000000101

R13: 00007ffc4a8a844f R14: 00007fb9378f5300 R15: 0000000000022000
INFO: task syz-executor.1:11280 can't die for more than 147 seconds.
task:syz-executor.1 state:D stack:28480 pid:11280 ppid: 8982 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:4700 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5957
schedule+0xd3/0x270 kernel/sched/core.c:6036
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6095
__mutex_lock_common kernel/locking/mutex.c:1036 [inline]
__mutex_lock+0xa46/0x1300 kernel/locking/mutex.c:1096

RSP: 002b:00007fb937890040 EFLAGS: 00000293 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 000000000056c1a8 RCX: 00000000004196c4

INFO: task syz-executor.1:11280 blocked for more than 147 seconds.
Not tainted 5.14.0-rc2-next-20210721-syzkaller #0

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

task:syz-executor.1 state:D stack:28480 pid:11280 ppid: 8982 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:4700 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5957
schedule+0xd3/0x270 kernel/sched/core.c:6036
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6095
__mutex_lock_common kernel/locking/mutex.c:1036 [inline]
__mutex_lock+0xa46/0x1300 kernel/locking/mutex.c:1096

RSP: 002b:00007fb937890040 EFLAGS: 00000293 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 000000000056c1a8 RCX: 00000000004196c4

INFO: task syz-executor.2:11223 can't die for more than 148 seconds.
task:syz-executor.2 state:D stack:28048 pid:11223 ppid: 8981 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:4700 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5957
schedule+0xd3/0x270 kernel/sched/core.c:6036
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6095
__mutex_lock_common kernel/locking/mutex.c:1036 [inline]
__mutex_lock+0xa46/0x1300 kernel/locking/mutex.c:1096

RSP: 002b:00007fd4d6fcc040 EFLAGS: 00000293 ORIG_RAX: 0000000000000101

INFO: task syz-executor.2:11223 blocked for more than 148 seconds.
Not tainted 5.14.0-rc2-next-20210721-syzkaller #0

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

task:syz-executor.2 state:D stack:28048 pid:11223 ppid: 8981 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:4700 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5957
schedule+0xd3/0x270 kernel/sched/core.c:6036
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6095
__mutex_lock_common kernel/locking/mutex.c:1036 [inline]
__mutex_lock+0xa46/0x1300 kernel/locking/mutex.c:1096

RSP: 002b:00007fd4d6fcc040 EFLAGS: 00000293 ORIG_RAX: 0000000000000101

INFO: task syz-executor.4:11229 can't die for more than 148 seconds.
task:syz-executor.4 state:D stack:28392 pid:11229 ppid: 8979 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:4700 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5957
schedule+0xd3/0x270 kernel/sched/core.c:6036
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6095
__mutex_lock_common kernel/locking/mutex.c:1036 [inline]
__mutex_lock+0xa46/0x1300 kernel/locking/mutex.c:1096

RSP: 002b:00007f87cff62188 EFLAGS: 00000246 ORIG_RAX: 0000000000000101

R13: 00007ffe721339cf R14: 00007f87cff62300 R15: 0000000000022000
INFO: task syz-executor.4:11229 blocked for more than 149 seconds.
Not tainted 5.14.0-rc2-next-20210721-syzkaller #0

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

task:syz-executor.4 state:D stack:28392 pid:11229 ppid: 8979 flags:0x00000004
Call Trace:
context_switch kernel/sched/core.c:4700 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5957
schedule+0xd3/0x270 kernel/sched/core.c:6036
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6095
__mutex_lock_common kernel/locking/mutex.c:1036 [inline]
__mutex_lock+0xa46/0x1300 kernel/locking/mutex.c:1096

RSP: 002b:00007f87cff62188 EFLAGS: 00000246 ORIG_RAX: 0000000000000101

R13: 00007ffe721339cf R14: 00007f87cff62300 R15: 0000000000022000
INFO: task syz-executor.4:11286 can't die for more than 149 seconds.
task:syz-executor.4 state:D stack:28480 pid:11286 ppid: 8979 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:4700 [inline]
__schedule+0x93a/0x26f0 kernel/sched/core.c:5957
schedule+0xd3/0x270 kernel/sched/core.c:6036
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6095
__mutex_lock_common kernel/locking/mutex.c:1036 [inline]
__mutex_lock+0xa46/0x1300 kernel/locking/mutex.c:1096

RSP: 002b:00007f87cff1e040 EFLAGS: 00000293 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 000000000056c0f0 RCX: 00000000004196c4

Showing all locks held in the system:

5 locks held by kworker/0:0/5:
#0: ffff888140bc6538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
#0: ffff888140bc6538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: atomic64_set include/asm-generic/atomic-instrumented.h:620 [inline]
#0: ffff888140bc6538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: atomic_long_set include/asm-generic/atomic-long.h:41 [inline]
#0: ffff888140bc6538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_data kernel/workqueue.c:617 [inline]
#0: ffff888140bc6538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_pool_and_clear_pending kernel/workqueue.c:644 [inline]
#0: ffff888140bc6538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x871/0x1630 kernel/workqueue.c:2247
#1: ffffc90000ca7db0 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x8a5/0x1630 kernel/workqueue.c:2251
#2: ffff888021401220 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:758 [inline]
#2: ffff888021401220 (&dev->mutex){....}-{3:3}, at: hub_event+0x1c1/0x4330 drivers/usb/core/hub.c:5614
#3: ffff888046820220 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:758 [inline]
#3: ffff888046820220 (&dev->mutex){....}-{3:3}, at: __device_attach+0x7a/0x4a0 drivers/base/dd.c:940
#4: ffff88802d56e1a8 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:758 [inline]
#4: ffff88802d56e1a8 (&dev->mutex){....}-{3:3}, at: __device_attach+0x7a/0x4a0 drivers/base/dd.c:940
2 locks held by kworker/u4:4/133:

1 lock held by khungtaskd/1650:

#0: ffffffff8b97eb40 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x53/0x260 kernel/locking/lockdep.c:6446
1 lock held by in:imklog/8175:
#0: ffff8880339eaff0 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0xe9/0x100 fs/file.c:990
5 locks held by kworker/0:8/10942:
#0: ffff888140bc6538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
#0: ffff888140bc6538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: atomic64_set include/asm-generic/atomic-instrumented.h:620 [inline]
#0: ffff888140bc6538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: atomic_long_set include/asm-generic/atomic-long.h:41 [inline]
#0: ffff888140bc6538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_data kernel/workqueue.c:617 [inline]
#0: ffff888140bc6538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_pool_and_clear_pending kernel/workqueue.c:644 [inline]
#0: ffff888140bc6538 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x871/0x1630 kernel/workqueue.c:2247
#1: ffffc9000c69fdb0 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x8a5/0x1630 kernel/workqueue.c:2251
#2: ffff888021399220 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:758 [inline]
#2: ffff888021399220 (&dev->mutex){....}-{3:3}, at: hub_event+0x1c1/0x4330 drivers/usb/core/hub.c:5614
#3: ffff888046bef220 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:758 [inline]
#3: ffff888046bef220 (&dev->mutex){....}-{3:3}, at: __device_attach+0x7a/0x4a0 drivers/base/dd.c:940
#4: ffff88802d56d1a8 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:758 [inline]
#4: ffff88802d56d1a8 (&dev->mutex){....}-{3:3}, at: __device_attach+0x7a/0x4a0 drivers/base/dd.c:940
1 lock held by syz-executor.0/11204:
#0: ffffffff8c3ba808 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107
1 lock held by syz-executor.0/11289:
#0: ffffffff8c3ba808 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107
2 locks held by syz-executor.5/11212:
#0: ffffffff8c3ba808 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107
#1: ffffffff8b84edc8 (system_transition_mutex){+.+.}-{3:3}, at: snapshot_open+0x3b/0x2a0 kernel/power/user.c:54
1 lock held by syz-executor.5/11271:
#0: ffffffff8c3ba808 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107
1 lock held by syz-executor.3/11215:
#0: ffffffff8c3ba808 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107
1 lock held by syz-executor.1/11219:
#0: ffffffff8c3ba808 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107
1 lock held by syz-executor.1/11280:
#0: ffffffff8c3ba808 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107
1 lock held by syz-executor.2/11223:
#0: ffffffff8c3ba808 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107
1 lock held by syz-executor.4/11229:
#0: ffffffff8c3ba808 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107
1 lock held by syz-executor.4/11286:
#0: ffffffff8c3ba808 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107

=============================================

NMI backtrace for cpu 1

CPU: 1 PID: 1650 Comm: khungtaskd Not tainted 5.14.0-rc2-next-20210721-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+0xcd/0x134 lib/dump_stack.c:105
nmi_cpu_backtrace.cold+0x44/0xd7 lib/nmi_backtrace.c:105
nmi_trigger_cpumask_backtrace+0x1b3/0x230 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline]

check_hung_uninterruptible_tasks kernel/hung_task.c:254 [inline]
watchdog+0xd3e/0xf50 kernel/hung_task.c:339

kthread+0x3e5/0x4d0 kernel/kthread.c:319
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0

CPU: 0 PID: 4855 Comm: systemd-journal Not tainted 5.14.0-rc2-next-20210721-syzkaller #0

Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011

RIP: 0010:check_kcov_mode+0x2e/0x40 kernel/kcov.c:174
Code: 36 8c 7e 89 c2 81 e2 00 01 00 00 a9 00 01 ff 00 74 10 31 c0 85 d2 74 15 8b 96 3c 15 00 00 85 d2 74 0b 8b 86 18 15 00 00 39 f8 <0f> 94 c0 c3 66 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 00 31 c0 65 8b
RSP: 0018:ffffc900010efa30 EFLAGS: 00000293
RAX: 0000000000000000 RBX: 0000000000000001 RCX: ffff88802cad8000
RDX: 0000000000000000 RSI: ffff88802cad8000 RDI: 0000000000000003
RBP: 00007f5316ca99c7 R08: 0000000000000000 R09: 0000000000000001
R10: ffffffff818212ff R11: 0000000000000000 R12: ffffc900010efb00
R13: 0000000000000000 R14: ffff88802cad8000 R15: 0000000000000cc0
FS: 00007f53179ee8c0(0000) GS:ffff8880b9c00000(0000) knlGS:0000000000000000

CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033

CR2: 00007f5314e64000 CR3: 0000000020539000 CR4: 00000000001506f0

DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:

write_comp_data kernel/kcov.c:218 [inline]
__sanitizer_cov_trace_const_cmp1+0x22/0x80 kernel/kcov.c:270
rcu_read_unlock include/linux/rcupdate.h:716 [inline]
is_bpf_text_address+0x6f/0x170 kernel/bpf/core.c:706
kernel_text_address kernel/extable.c:151 [inline]
kernel_text_address+0xbd/0xf0 kernel/extable.c:120
__kernel_text_address+0x9/0x30 kernel/extable.c:105
unwind_get_return_address arch/x86/kernel/unwind_orc.c:318 [inline]
unwind_get_return_address+0x51/0x90 arch/x86/kernel/unwind_orc.c:313
arch_stack_walk+0x93/0xe0 arch/x86/kernel/stacktrace.c:26
stack_trace_save+0x8c/0xc0 kernel/stacktrace.c:121
kasan_save_stack+0x1b/0x40 mm/kasan/common.c:38
kasan_set_track mm/kasan/common.c:46 [inline]
set_alloc_info mm/kasan/common.c:434 [inline]
__kasan_slab_alloc+0x84/0xa0 mm/kasan/common.c:467
kasan_slab_alloc include/linux/kasan.h:254 [inline]
slab_post_alloc_hook mm/slab.h:519 [inline]
slab_alloc_node mm/slub.c:2958 [inline]
slab_alloc mm/slub.c:2966 [inline]
kmem_cache_alloc+0x285/0x4a0 mm/slub.c:2971
prepare_creds+0x3f/0x7b0 kernel/cred.c:262
access_override_creds fs/open.c:355 [inline]
do_faccessat+0x3f4/0x850 fs/open.c:419

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+0x44/0xae

RIP: 0033:0x7f5316ca99c7
Code: 83 c4 08 48 3d 01 f0 ff ff 73 01 c3 48 8b 0d c8 d4 2b 00 f7 d8 64 89 01 48 83 c8 ff c3 66 0f 1f 44 00 00 b8 15 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d a1 d4 2b 00 f7 d8 64 89 01 48
RSP: 002b:00007ffd273275d8 EFLAGS: 00000246 ORIG_RAX: 0000000000000015
RAX: ffffffffffffffda RBX: 00007ffd2732a600 RCX: 00007f5316ca99c7
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000564dcff2f9a3
RBP: 00007ffd27327720 R08: 0000564dcff253e5 R09: 0000000000000018
R10: 0000000000000069 R11: 0000000000000246 R12: 0000000000000000
R13: 0000000000000000 R14: 0000564dd1e7f8a0 R15: 00007ffd27327c10

Tested on:

commit: b1347210 Add linux-next specific files for 20210721
git tree: https://git.kernel.org/pub/scm/linux/kernel/git/next/linux-next.git
console output: https://syzkaller.appspot.com/x/log.txt?x=17721f12300000
kernel config: https://syzkaller.appspot.com/x/.config?x=672957b6944224e7

Krzysztof Kozlowski

unread,

Oct 20, 2021, 11:45:47 AM10/20/21

to syzbot, syzkall...@googlegroups.com

#syz test:
https://git.kernel.org/pub/scm/linux/kernel/git/next/linux-next.git
60e8840126bdcb60bccef74c3f962742183c681f

Best regards,
Krzysztof

syzbot

unread,

Oct 20, 2021, 12:00:12 PM10/20/21

to krzysztof...@canonical.com, syzkall...@googlegroups.com

Hello,

syzbot has tested the proposed patch but the reproducer is still triggering an issue:
INFO: task hung in port100_probe

INFO: task kworker/1:3:2969 blocked for more than 143 seconds.
Not tainted 5.15.0-rc5-next-20211018-syzkaller #0

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

task:kworker/1:3 state:D stack:25528 pid: 2969 ppid: 2 flags:0x00004000

Workqueue: usb_hub_wq hub_event
Call Trace:

<TASK>
context_switch kernel/sched/core.c:4965 [inline]
__schedule+0x940/0x26f0 kernel/sched/core.c:6246
schedule+0xd2/0x260 kernel/sched/core.c:6319
schedule_timeout+0x1db/0x2a0 kernel/time/timer.c:1857

do_wait_for_common kernel/sched/completion.c:85 [inline]
__wait_for_common kernel/sched/completion.c:106 [inline]
wait_for_common kernel/sched/completion.c:117 [inline]

wait_for_completion+0x174/0x270 kernel/sched/completion.c:138
port100_send_cmd_sync drivers/nfc/port100.c:926 [inline]
port100_get_command_type_mask drivers/nfc/port100.c:1011 [inline]
port100_probe+0x9e4/0x1340 drivers/nfc/port100.c:1557

usb_probe_interface+0x315/0x7f0 drivers/usb/core/driver.c:396
call_driver_probe drivers/base/dd.c:517 [inline]

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:517 [inline]

really_probe+0x245/0xcc0 drivers/base/dd.c:596
__driver_probe_device+0x338/0x4d0 drivers/base/dd.c:751
driver_probe_device+0x4c/0x1a0 drivers/base/dd.c:781
__device_attach_driver+0x20b/0x2f0 drivers/base/dd.c:898
bus_for_each_drv+0x15f/0x1e0 drivers/base/bus.c:427
__device_attach+0x228/0x4a0 drivers/base/dd.c:969
bus_probe_device+0x1e4/0x290 drivers/base/bus.c:487
device_add+0xc17/0x1ee0 drivers/base/core.c:3394
usb_new_device.cold+0x63f/0x108e drivers/usb/core/hub.c:2563
hub_port_connect drivers/usb/core/hub.c:5348 [inline]
hub_port_connect_change drivers/usb/core/hub.c:5488 [inline]
port_event drivers/usb/core/hub.c:5634 [inline]
hub_event+0x2357/0x4330 drivers/usb/core/hub.c:5716
process_one_work+0x9b2/0x1690 kernel/workqueue.c:2297
worker_thread+0x658/0x11f0 kernel/workqueue.c:2444
kthread+0x405/0x4f0 kernel/kthread.c:327
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
</TASK>
INFO: task kworker/1:5:6891 blocked for more than 143 seconds.
Not tainted 5.15.0-rc5-next-20211018-syzkaller #0

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

task:kworker/1:5 state:D stack:26024 pid: 6891 ppid: 2 flags:0x00004000

Workqueue: usb_hub_wq hub_event
Call Trace:

do_wait_for_common kernel/sched/completion.c:85 [inline]
__wait_for_common kernel/sched/completion.c:106 [inline]
wait_for_common kernel/sched/completion.c:117 [inline]

usb_probe_interface+0x315/0x7f0 drivers/usb/core/driver.c:396
call_driver_probe drivers/base/dd.c:517 [inline]

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:517 [inline]

really_probe+0x245/0xcc0 drivers/base/dd.c:596
__driver_probe_device+0x338/0x4d0 drivers/base/dd.c:751
driver_probe_device+0x4c/0x1a0 drivers/base/dd.c:781
__device_attach_driver+0x20b/0x2f0 drivers/base/dd.c:898
bus_for_each_drv+0x15f/0x1e0 drivers/base/bus.c:427
__device_attach+0x228/0x4a0 drivers/base/dd.c:969
bus_probe_device+0x1e4/0x290 drivers/base/bus.c:487
device_add+0xc17/0x1ee0 drivers/base/core.c:3394
usb_new_device.cold+0x63f/0x108e drivers/usb/core/hub.c:2563
hub_port_connect drivers/usb/core/hub.c:5348 [inline]
hub_port_connect_change drivers/usb/core/hub.c:5488 [inline]
port_event drivers/usb/core/hub.c:5634 [inline]
hub_event+0x2357/0x4330 drivers/usb/core/hub.c:5716
process_one_work+0x9b2/0x1690 kernel/workqueue.c:2297
worker_thread+0x658/0x11f0 kernel/workqueue.c:2444
kthread+0x405/0x4f0 kernel/kthread.c:327
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
</TASK>
INFO: task kworker/1:6:7084 blocked for more than 144 seconds.
Not tainted 5.15.0-rc5-next-20211018-syzkaller #0

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

task:kworker/1:6 state:D stack:26632 pid: 7084 ppid: 2 flags:0x00004000

Workqueue: usb_hub_wq hub_event
Call Trace:

do_wait_for_common kernel/sched/completion.c:85 [inline]
__wait_for_common kernel/sched/completion.c:106 [inline]
wait_for_common kernel/sched/completion.c:117 [inline]

usb_probe_interface+0x315/0x7f0 drivers/usb/core/driver.c:396
call_driver_probe drivers/base/dd.c:517 [inline]

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:517 [inline]

really_probe+0x245/0xcc0 drivers/base/dd.c:596
__driver_probe_device+0x338/0x4d0 drivers/base/dd.c:751
driver_probe_device+0x4c/0x1a0 drivers/base/dd.c:781
__device_attach_driver+0x20b/0x2f0 drivers/base/dd.c:898
bus_for_each_drv+0x15f/0x1e0 drivers/base/bus.c:427
__device_attach+0x228/0x4a0 drivers/base/dd.c:969
bus_probe_device+0x1e4/0x290 drivers/base/bus.c:487
device_add+0xc17/0x1ee0 drivers/base/core.c:3394
usb_new_device.cold+0x63f/0x108e drivers/usb/core/hub.c:2563
hub_port_connect drivers/usb/core/hub.c:5348 [inline]
hub_port_connect_change drivers/usb/core/hub.c:5488 [inline]
port_event drivers/usb/core/hub.c:5634 [inline]
hub_event+0x2357/0x4330 drivers/usb/core/hub.c:5716
process_one_work+0x9b2/0x1690 kernel/workqueue.c:2297
worker_thread+0x658/0x11f0 kernel/workqueue.c:2444
kthread+0x405/0x4f0 kernel/kthread.c:327
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
</TASK>
INFO: task syz-executor.5:9094 can't die for more than 144 seconds.
task:syz-executor.5 state:D stack:27504 pid: 9094 ppid: 7061 flags:0x00000004
Call Trace:
<TASK>
context_switch kernel/sched/core.c:4965 [inline]
__schedule+0x940/0x26f0 kernel/sched/core.c:6246
schedule+0xd2/0x260 kernel/sched/core.c:6319
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6378
__mutex_lock_common kernel/locking/mutex.c:672 [inline]
__mutex_lock+0xa32/0x12f0 kernel/locking/mutex.c:732

misc_open+0x55/0x4a0 drivers/char/misc.c:107
chrdev_open+0x266/0x770 fs/char_dev.c:414

do_dentry_open+0x4c8/0x11d0 fs/open.c:822
do_open fs/namei.c:3428 [inline]
path_openat+0x1c9a/0x2740 fs/namei.c:3561
do_filp_open+0x1aa/0x400 fs/namei.c:3588
do_sys_openat2+0x16d/0x4d0 fs/open.c:1200
do_sys_open fs/open.c:1216 [inline]
__do_sys_openat fs/open.c:1232 [inline]
__se_sys_openat fs/open.c:1227 [inline]
__x64_sys_openat+0x13f/0x1f0 fs/open.c:1227

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+0x44/0xae

RIP: 0033:0x4196d4
RSP: 002b:00007fa2021bf040 EFLAGS: 00000293 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 000000000056c038 RCX: 00000000004196d4
RDX: 0000000000000002 RSI: 00000000004beaa1 RDI: 00000000ffffff9c
RBP: 00000000004beaa1 R08: 0000000000000000 R09: 0000000000000000

R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000002
R13: 0000000000000000 R14: 0000000020000140 R15: 0000000000022000

</TASK>
INFO: task syz-executor.5:9094 blocked for more than 145 seconds.
Not tainted 5.15.0-rc5-next-20211018-syzkaller #0

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

task:syz-executor.5 state:D stack:27504 pid: 9094 ppid: 7061 flags:0x00000004
Call Trace:
<TASK>
context_switch kernel/sched/core.c:4965 [inline]
__schedule+0x940/0x26f0 kernel/sched/core.c:6246
schedule+0xd2/0x260 kernel/sched/core.c:6319
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6378
__mutex_lock_common kernel/locking/mutex.c:672 [inline]
__mutex_lock+0xa32/0x12f0 kernel/locking/mutex.c:732

misc_open+0x55/0x4a0 drivers/char/misc.c:107
chrdev_open+0x266/0x770 fs/char_dev.c:414

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+0x44/0xae

R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000002
R13: 0000000000000000 R14: 0000000020000140 R15: 0000000000022000

</TASK>
INFO: task syz-executor.5:9195 can't die for more than 145 seconds.
task:syz-executor.5 state:D stack:28472 pid: 9195 ppid: 7061 flags:0x00000004
Call Trace:
<TASK>
context_switch kernel/sched/core.c:4965 [inline]
__schedule+0x940/0x26f0 kernel/sched/core.c:6246
schedule+0xd2/0x260 kernel/sched/core.c:6319
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6378
__mutex_lock_common kernel/locking/mutex.c:672 [inline]
__mutex_lock+0xa32/0x12f0 kernel/locking/mutex.c:732

misc_open+0x55/0x4a0 drivers/char/misc.c:107
chrdev_open+0x266/0x770 fs/char_dev.c:414

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+0x44/0xae

RIP: 0033:0x4196d4
RSP: 002b:00007fa20219e040 EFLAGS: 00000293 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 000000000056c0f0 RCX: 00000000004196d4
RDX: 0000000000000002 RSI: 00000000004beaa1 RDI: 00000000ffffff9c
RBP: 00000000004beaa1 R08: 0000000000000000 R09: 0000000000000000

R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000002
R13: 0000000000000000 R14: 00000000200000c0 R15: 0000000000022000

</TASK>
INFO: task syz-executor.5:9195 blocked for more than 145 seconds.
Not tainted 5.15.0-rc5-next-20211018-syzkaller #0

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

task:syz-executor.5 state:D stack:28472 pid: 9195 ppid: 7061 flags:0x00000004
Call Trace:
<TASK>
context_switch kernel/sched/core.c:4965 [inline]
__schedule+0x940/0x26f0 kernel/sched/core.c:6246
schedule+0xd2/0x260 kernel/sched/core.c:6319
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6378
__mutex_lock_common kernel/locking/mutex.c:672 [inline]
__mutex_lock+0xa32/0x12f0 kernel/locking/mutex.c:732

misc_open+0x55/0x4a0 drivers/char/misc.c:107
chrdev_open+0x266/0x770 fs/char_dev.c:414

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+0x44/0xae

R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000002
R13: 0000000000000000 R14: 00000000200000c0 R15: 0000000000022000

</TASK>
INFO: task syz-executor.0:9119 can't die for more than 145 seconds.
task:syz-executor.0 state:D stack:27504 pid: 9119 ppid: 7057 flags:0x00000004
Call Trace:
<TASK>
context_switch kernel/sched/core.c:4965 [inline]
__schedule+0x940/0x26f0 kernel/sched/core.c:6246
schedule+0xd2/0x260 kernel/sched/core.c:6319
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6378
__mutex_lock_common kernel/locking/mutex.c:672 [inline]
__mutex_lock+0xa32/0x12f0 kernel/locking/mutex.c:732

misc_open+0x55/0x4a0 drivers/char/misc.c:107
chrdev_open+0x266/0x770 fs/char_dev.c:414

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+0x44/0xae

RIP: 0033:0x4665e9
RSP: 002b:00007f5eb159e188 EFLAGS: 00000246 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 000000000056bf80 RCX: 00000000004665e9

RDX: 0000000000020601 RSI: 00000000200003c0 RDI: ffffffffffffff9c

RBP: 00000000004bfcc4 R08: 0000000000000000 R09: 0000000000000000

R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056bf80

R13: 00007ffc87b0efdf R14: 00007f5eb159e300 R15: 0000000000022000
</TASK>
INFO: task syz-executor.0:9119 blocked for more than 146 seconds.
Not tainted 5.15.0-rc5-next-20211018-syzkaller #0

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

task:syz-executor.0 state:D stack:27504 pid: 9119 ppid: 7057 flags:0x00000004
Call Trace:
<TASK>
context_switch kernel/sched/core.c:4965 [inline]
__schedule+0x940/0x26f0 kernel/sched/core.c:6246
schedule+0xd2/0x260 kernel/sched/core.c:6319
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6378
__mutex_lock_common kernel/locking/mutex.c:672 [inline]
__mutex_lock+0xa32/0x12f0 kernel/locking/mutex.c:732

misc_open+0x55/0x4a0 drivers/char/misc.c:107
chrdev_open+0x266/0x770 fs/char_dev.c:414

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+0x44/0xae

RIP: 0033:0x4665e9
RSP: 002b:00007f5eb159e188 EFLAGS: 00000246 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 000000000056bf80 RCX: 00000000004665e9

RDX: 0000000000020601 RSI: 00000000200003c0 RDI: ffffffffffffff9c

RBP: 00000000004bfcc4 R08: 0000000000000000 R09: 0000000000000000

R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056bf80

R13: 00007ffc87b0efdf R14: 00007f5eb159e300 R15: 0000000000022000
</TASK>
INFO: task syz-executor.0:9200 can't die for more than 146 seconds.
task:syz-executor.0 state:D stack:28472 pid: 9200 ppid: 7057 flags:0x00000004
Call Trace:
<TASK>
context_switch kernel/sched/core.c:4965 [inline]
__schedule+0x940/0x26f0 kernel/sched/core.c:6246
schedule+0xd2/0x260 kernel/sched/core.c:6319
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6378
__mutex_lock_common kernel/locking/mutex.c:672 [inline]
__mutex_lock+0xa32/0x12f0 kernel/locking/mutex.c:732

misc_open+0x55/0x4a0 drivers/char/misc.c:107
chrdev_open+0x266/0x770 fs/char_dev.c:414

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+0x44/0xae

RIP: 0033:0x4196d4
RSP: 002b:00007f5eb157b040 EFLAGS: 00000293 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 000000000056c038 RCX: 00000000004196d4
RDX: 0000000000000002 RSI: 00000000004beaa1 RDI: 00000000ffffff9c
RBP: 00000000004beaa1 R08: 0000000000000000 R09: 0000000000000000

R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000002
R13: 0000000000000000 R14: 0000000020000140 R15: 0000000000022000

</TASK>
INFO: task syz-executor.0:9200 blocked for more than 146 seconds.
Not tainted 5.15.0-rc5-next-20211018-syzkaller #0

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

task:syz-executor.0 state:D stack:28472 pid: 9200 ppid: 7057 flags:0x00000004
Call Trace:
<TASK>
context_switch kernel/sched/core.c:4965 [inline]
__schedule+0x940/0x26f0 kernel/sched/core.c:6246
schedule+0xd2/0x260 kernel/sched/core.c:6319
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6378
__mutex_lock_common kernel/locking/mutex.c:672 [inline]
__mutex_lock+0xa32/0x12f0 kernel/locking/mutex.c:732

misc_open+0x55/0x4a0 drivers/char/misc.c:107
chrdev_open+0x266/0x770 fs/char_dev.c:414

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+0x44/0xae

R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000002
R13: 0000000000000000 R14: 0000000020000140 R15: 0000000000022000

</TASK>
INFO: task syz-executor.0:9201 can't die for more than 147 seconds.
task:syz-executor.0 state:D stack:28472 pid: 9201 ppid: 7057 flags:0x00000004
Call Trace:
<TASK>
context_switch kernel/sched/core.c:4965 [inline]
__schedule+0x940/0x26f0 kernel/sched/core.c:6246
schedule+0xd2/0x260 kernel/sched/core.c:6319
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6378
__mutex_lock_common kernel/locking/mutex.c:672 [inline]
__mutex_lock+0xa32/0x12f0 kernel/locking/mutex.c:732

misc_open+0x55/0x4a0 drivers/char/misc.c:107
chrdev_open+0x266/0x770 fs/char_dev.c:414

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+0x44/0xae

RIP: 0033:0x4196d4
RSP: 002b:00007f5eb155a040 EFLAGS: 00000293 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 000000000056c0f0 RCX: 00000000004196d4
RDX: 0000000000000002 RSI: 00000000004beaa1 RDI: 00000000ffffff9c
RBP: 00000000004beaa1 R08: 0000000000000000 R09: 0000000000000000

R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000002
R13: 0000000000000000 R14: 00000000200000c0 R15: 0000000000022000

</TASK>
INFO: task syz-executor.0:9201 blocked for more than 147 seconds.
Not tainted 5.15.0-rc5-next-20211018-syzkaller #0

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

task:syz-executor.0 state:D stack:28472 pid: 9201 ppid: 7057 flags:0x00000004
Call Trace:
<TASK>
context_switch kernel/sched/core.c:4965 [inline]
__schedule+0x940/0x26f0 kernel/sched/core.c:6246
schedule+0xd2/0x260 kernel/sched/core.c:6319
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6378
__mutex_lock_common kernel/locking/mutex.c:672 [inline]
__mutex_lock+0xa32/0x12f0 kernel/locking/mutex.c:732

misc_open+0x55/0x4a0 drivers/char/misc.c:107
chrdev_open+0x266/0x770 fs/char_dev.c:414

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+0x44/0xae

R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000002
R13: 0000000000000000 R14: 00000000200000c0 R15: 0000000000022000

</TASK>
INFO: task kworker/0:8:9123 blocked for more than 147 seconds.
Not tainted 5.15.0-rc5-next-20211018-syzkaller #0

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

task:kworker/0:8 state:D stack:25728 pid: 9123 ppid: 2 flags:0x00004000

Workqueue: usb_hub_wq hub_event
Call Trace:

do_wait_for_common kernel/sched/completion.c:85 [inline]
__wait_for_common kernel/sched/completion.c:106 [inline]
wait_for_common kernel/sched/completion.c:117 [inline]

usb_probe_interface+0x315/0x7f0 drivers/usb/core/driver.c:396
call_driver_probe drivers/base/dd.c:517 [inline]

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:517 [inline]

really_probe+0x245/0xcc0 drivers/base/dd.c:596
__driver_probe_device+0x338/0x4d0 drivers/base/dd.c:751
driver_probe_device+0x4c/0x1a0 drivers/base/dd.c:781
__device_attach_driver+0x20b/0x2f0 drivers/base/dd.c:898
bus_for_each_drv+0x15f/0x1e0 drivers/base/bus.c:427
__device_attach+0x228/0x4a0 drivers/base/dd.c:969
bus_probe_device+0x1e4/0x290 drivers/base/bus.c:487
device_add+0xc17/0x1ee0 drivers/base/core.c:3394
usb_new_device.cold+0x63f/0x108e drivers/usb/core/hub.c:2563
hub_port_connect drivers/usb/core/hub.c:5348 [inline]
hub_port_connect_change drivers/usb/core/hub.c:5488 [inline]
port_event drivers/usb/core/hub.c:5634 [inline]
hub_event+0x2357/0x4330 drivers/usb/core/hub.c:5716
process_one_work+0x9b2/0x1690 kernel/workqueue.c:2297
worker_thread+0x658/0x11f0 kernel/workqueue.c:2444
kthread+0x405/0x4f0 kernel/kthread.c:327
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
</TASK>
INFO: task syz-executor.3:9156 can't die for more than 148 seconds.
task:syz-executor.3 state:D stack:27504 pid: 9156 ppid: 7058 flags:0x00000004
Call Trace:
<TASK>
context_switch kernel/sched/core.c:4965 [inline]
__schedule+0x940/0x26f0 kernel/sched/core.c:6246
schedule+0xd2/0x260 kernel/sched/core.c:6319
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6378
__mutex_lock_common kernel/locking/mutex.c:672 [inline]
__mutex_lock+0xa32/0x12f0 kernel/locking/mutex.c:732

misc_open+0x55/0x4a0 drivers/char/misc.c:107
chrdev_open+0x266/0x770 fs/char_dev.c:414

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+0x44/0xae

RIP: 0033:0x4196d4
RSP: 002b:00007f4368751040 EFLAGS: 00000293 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 000000000056bf80 RCX: 00000000004196d4
RDX: 0000000000000002 RSI: 00000000004beaa1 RDI: 00000000ffffff9c
RBP: 00000000004beaa1 R08: 0000000000000000 R09: 0000000000000000

R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000002
R13: 0000000000000000 R14: 00000000200000c0 R15: 0000000000022000

</TASK>
INFO: task syz-executor.3:9156 blocked for more than 148 seconds.
Not tainted 5.15.0-rc5-next-20211018-syzkaller #0

"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.

task:syz-executor.3 state:D stack:27504 pid: 9156 ppid: 7058 flags:0x00000004
Call Trace:
<TASK>
context_switch kernel/sched/core.c:4965 [inline]
__schedule+0x940/0x26f0 kernel/sched/core.c:6246
schedule+0xd2/0x260 kernel/sched/core.c:6319
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6378
__mutex_lock_common kernel/locking/mutex.c:672 [inline]
__mutex_lock+0xa32/0x12f0 kernel/locking/mutex.c:732

misc_open+0x55/0x4a0 drivers/char/misc.c:107
chrdev_open+0x266/0x770 fs/char_dev.c:414

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+0x44/0xae

R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000002
R13: 0000000000000000 R14: 00000000200000c0 R15: 0000000000022000

</TASK>
INFO: task syz-executor.2:9163 can't die for more than 148 seconds.
task:syz-executor.2 state:D stack:27504 pid: 9163 ppid: 7056 flags:0x00000004
Call Trace:
<TASK>
context_switch kernel/sched/core.c:4965 [inline]
__schedule+0x940/0x26f0 kernel/sched/core.c:6246
schedule+0xd2/0x260 kernel/sched/core.c:6319
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6378
__mutex_lock_common kernel/locking/mutex.c:672 [inline]
__mutex_lock+0xa32/0x12f0 kernel/locking/mutex.c:732

misc_open+0x55/0x4a0 drivers/char/misc.c:107
chrdev_open+0x266/0x770 fs/char_dev.c:414

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+0x44/0xae

RIP: 0033:0x4196d4
RSP: 002b:00007f11e420c040 EFLAGS: 00000293 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 000000000056bf80 RCX: 00000000004196d4
RDX: 0000000000000002 RSI: 00000000004beaa1 RDI: 00000000ffffff9c
RBP: 00000000004beaa1 R08: 0000000000000000 R09: 0000000000000000

R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000002
R13: 0000000000000000 R14: 00000000200000c0 R15: 0000000000022000

</TASK>
INFO: task syz-executor.4:9165 can't die for more than 149 seconds.
task:syz-executor.4 state:D stack:27504 pid: 9165 ppid: 7059 flags:0x00000004
Call Trace:
<TASK>
context_switch kernel/sched/core.c:4965 [inline]
__schedule+0x940/0x26f0 kernel/sched/core.c:6246
schedule+0xd2/0x260 kernel/sched/core.c:6319
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6378
__mutex_lock_common kernel/locking/mutex.c:672 [inline]
__mutex_lock+0xa32/0x12f0 kernel/locking/mutex.c:732

misc_open+0x55/0x4a0 drivers/char/misc.c:107
chrdev_open+0x266/0x770 fs/char_dev.c:414

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+0x44/0xae

RIP: 0033:0x4196d4
RSP: 002b:00007effab6e8040 EFLAGS: 00000293 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 000000000056bf80 RCX: 00000000004196d4
RDX: 0000000000000002 RSI: 00000000004beaa1 RDI: 00000000ffffff9c
RBP: 00000000004beaa1 R08: 0000000000000000 R09: 0000000000000000

R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000002
R13: 0000000000000000 R14: 00000000200000c0 R15: 0000000000022000

</TASK>
INFO: task syz-executor.1:9166 can't die for more than 149 seconds.
task:syz-executor.1 state:D stack:27504 pid: 9166 ppid: 7062 flags:0x00000004
Call Trace:
<TASK>
context_switch kernel/sched/core.c:4965 [inline]
__schedule+0x940/0x26f0 kernel/sched/core.c:6246
schedule+0xd2/0x260 kernel/sched/core.c:6319
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6378
__mutex_lock_common kernel/locking/mutex.c:672 [inline]
__mutex_lock+0xa32/0x12f0 kernel/locking/mutex.c:732

misc_open+0x55/0x4a0 drivers/char/misc.c:107
chrdev_open+0x266/0x770 fs/char_dev.c:414

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+0x44/0xae

RIP: 0033:0x4196d4
RSP: 002b:00007f4693719040 EFLAGS: 00000293 ORIG_RAX: 0000000000000101
RAX: ffffffffffffffda RBX: 000000000056bf80 RCX: 00000000004196d4
RDX: 0000000000000002 RSI: 00000000004beaa1 RDI: 00000000ffffff9c
RBP: 00000000004beaa1 R08: 0000000000000000 R09: 0000000000000000

R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000002
R13: 0000000000000000 R14: 00000000200000c0 R15: 0000000000022000

</TASK>

Showing all locks held in the system:

2 locks held by kworker/u4:0/8:
#0: ffff8880b9d39a98 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested+0x1e/0x30 kernel/sched/core.c:478
#1: ffffc90000cd7db0 ((work_completion)(&(&bat_priv->nc.work)->work)){+.+.}-{0:0}, at: process_one_work+0x8ca/0x1690 kernel/workqueue.c:2272
1 lock held by khungtaskd/27:
#0: ffffffff8bb81ae0 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x53/0x260 kernel/locking/lockdep.c:6458
5 locks held by kworker/1:3/2969:
#0: ffff8880153f3938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
#0: ffff8880153f3938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: arch_atomic_long_set include/linux/atomic/atomic-long.h:41 [inline]
#0: ffff8880153f3938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: atomic_long_set include/linux/atomic/atomic-instrumented.h:1198 [inline]
#0: ffff8880153f3938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_data kernel/workqueue.c:634 [inline]
#0: ffff8880153f3938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_pool_and_clear_pending kernel/workqueue.c:661 [inline]
#0: ffff8880153f3938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x896/0x1690 kernel/workqueue.c:2268
#1: ffffc90001acfdb0 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x8ca/0x1690 kernel/workqueue.c:2272
#2: ffff88801dc8d220 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:760 [inline]
#2: ffff88801dc8d220 (&dev->mutex){....}-{3:3}, at: hub_event+0x1c1/0x4330 drivers/usb/core/hub.c:5662
#3: ffff888017eb9220 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:760 [inline]
#3: ffff888017eb9220 (&dev->mutex){....}-{3:3}, at: __device_attach+0x7a/0x4a0 drivers/base/dd.c:944
#4: ffff88807ceaa1a8 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:760 [inline]
#4: ffff88807ceaa1a8 (&dev->mutex){....}-{3:3}, at: __device_attach+0x7a/0x4a0 drivers/base/dd.c:944
1 lock held by in:imklog/6246:
#0: ffff88807f6f8870 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0xe9/0x100 fs/file.c:990
5 locks held by kworker/1:5/6891:
#0: ffff8880153f3938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
#0: ffff8880153f3938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: arch_atomic_long_set include/linux/atomic/atomic-long.h:41 [inline]
#0: ffff8880153f3938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: atomic_long_set include/linux/atomic/atomic-instrumented.h:1198 [inline]
#0: ffff8880153f3938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_data kernel/workqueue.c:634 [inline]
#0: ffff8880153f3938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_pool_and_clear_pending kernel/workqueue.c:661 [inline]
#0: ffff8880153f3938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x896/0x1690 kernel/workqueue.c:2268
#1: ffffc900049dfdb0 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x8ca/0x1690 kernel/workqueue.c:2272
#2: ffff88801dbfd220 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:760 [inline]
#2: ffff88801dbfd220 (&dev->mutex){....}-{3:3}, at: hub_event+0x1c1/0x4330 drivers/usb/core/hub.c:5662
#3: ffff88806ce0f220 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:760 [inline]
#3: ffff88806ce0f220 (&dev->mutex){....}-{3:3}, at: __device_attach+0x7a/0x4a0 drivers/base/dd.c:944
#4: ffff88807d02e1a8 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:760 [inline]
#4: ffff88807d02e1a8 (&dev->mutex){....}-{3:3}, at: __device_attach+0x7a/0x4a0 drivers/base/dd.c:944
5 locks held by kworker/1:6/7084:
#0: ffff8880153f3938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
#0: ffff8880153f3938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: arch_atomic_long_set include/linux/atomic/atomic-long.h:41 [inline]
#0: ffff8880153f3938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: atomic_long_set include/linux/atomic/atomic-instrumented.h:1198 [inline]
#0: ffff8880153f3938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_data kernel/workqueue.c:634 [inline]
#0: ffff8880153f3938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_pool_and_clear_pending kernel/workqueue.c:661 [inline]
#0: ffff8880153f3938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x896/0x1690 kernel/workqueue.c:2268
#1: ffffc90002aefdb0 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x8ca/0x1690 kernel/workqueue.c:2272
#2: ffff888147032220 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:760 [inline]
#2: ffff888147032220 (&dev->mutex){....}-{3:3}, at: hub_event+0x1c1/0x4330 drivers/usb/core/hub.c:5662
#3: ffff888017eba220 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:760 [inline]
#3: ffff888017eba220 (&dev->mutex){....}-{3:3}, at: __device_attach+0x7a/0x4a0 drivers/base/dd.c:944
#4: ffff88801a9ef1a8 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:760 [inline]
#4: ffff88801a9ef1a8 (&dev->mutex){....}-{3:3}, at: __device_attach+0x7a/0x4a0 drivers/base/dd.c:944
2 locks held by syz-executor.5/9093:
#0: ffffffff8c5d8208 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107
#1: ffffffff8ba51468 (system_transition_mutex){+.+.}-{3:3}, at: snapshot_open+0x3b/0x2a0 kernel/power/user.c:54
1 lock held by syz-executor.5/9094:
#0: ffffffff8c5d8208 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107
1 lock held by syz-executor.5/9195:
#0: ffffffff8c5d8208 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107
1 lock held by syz-executor.0/9119:
#0: ffffffff8c5d8208 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107
1 lock held by syz-executor.0/9200:
#0: ffffffff8c5d8208 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107
1 lock held by syz-executor.0/9201:
#0: ffffffff8c5d8208 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107
5 locks held by kworker/0:8/9123:
#0: ffff8880153f3938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline]
#0: ffff8880153f3938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: arch_atomic_long_set include/linux/atomic/atomic-long.h:41 [inline]
#0: ffff8880153f3938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: atomic_long_set include/linux/atomic/atomic-instrumented.h:1198 [inline]
#0: ffff8880153f3938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_data kernel/workqueue.c:634 [inline]
#0: ffff8880153f3938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: set_work_pool_and_clear_pending kernel/workqueue.c:661 [inline]
#0: ffff8880153f3938 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x896/0x1690 kernel/workqueue.c:2268
#1: ffffc9000d0f7db0 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x8ca/0x1690 kernel/workqueue.c:2272
#2: ffff888147035220 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:760 [inline]
#2: ffff888147035220 (&dev->mutex){....}-{3:3}, at: hub_event+0x1c1/0x4330 drivers/usb/core/hub.c:5662
#3: ffff8880773ae220 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:760 [inline]
#3: ffff8880773ae220 (&dev->mutex){....}-{3:3}, at: __device_attach+0x7a/0x4a0 drivers/base/dd.c:944
#4: ffff88801abe01a8 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:760 [inline]
#4: ffff88801abe01a8 (&dev->mutex){....}-{3:3}, at: __device_attach+0x7a/0x4a0 drivers/base/dd.c:944
1 lock held by syz-executor.3/9156:
#0: ffffffff8c5d8208 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107
1 lock held by syz-executor.2/9163:
#0: ffffffff8c5d8208 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107
1 lock held by syz-executor.4/9165:
#0: ffffffff8c5d8208 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107
1 lock held by syz-executor.1/9166:
#0: ffffffff8c5d8208 (misc_mtx){+.+.}-{3:3}, at: misc_open+0x55/0x4a0 drivers/char/misc.c:107

=============================================

NMI backtrace for cpu 0
CPU: 0 PID: 27 Comm: khungtaskd Not tainted 5.15.0-rc5-next-20211018-syzkaller #0

Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:

<TASK>
__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:105
nmi_trigger_cpumask_backtrace+0x1ae/0x220 lib/nmi_backtrace.c:62

trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:254 [inline]

watchdog+0xcb7/0xed0 kernel/hung_task.c:339
kthread+0x405/0x4f0 kernel/kthread.c:327
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
</TASK>
Sending NMI from CPU 0 to CPUs 1:

NMI backtrace for cpu 1

CPU: 1 PID: 55 Comm: kworker/u4:3 Not tainted 5.15.0-rc5-next-20211018-syzkaller #0

Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011

Workqueue: events_unbound toggle_allocation_gate
RIP: 0010:__lock_release kernel/locking/lockdep.c:5323 [inline]
RIP: 0010:lock_release+0x202/0x720 kernel/locking/lockdep.c:5657
Code: ed 0f 84 e0 02 00 00 48 8d 4c 24 50 44 89 ea 4c 89 e6 4c 89 ff e8 6e 08 ff ff 48 85 c0 48 89 c3 0f 84 85 03 00 00 48 8d 78 24 <48> b8 00 00 00 00 00 fc ff df 48 89 fa 48 c1 ea 03 0f b6 14 02 48
RSP: 0018:ffffc90001a3fb20 EFLAGS: 00000086
RAX: ffff888017924378 RBX: ffff888017924378 RCX: ffffc90001a3fb70
RDX: 0000000000000004 RSI: ffffffff8bcc9a38 RDI: ffff88801792439c
RBP: 1ffff92000347f66 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000001 R11: 0000000000000000 R12: ffffffff8bcc9a38
R13: 0000000000000003 R14: ffff888017924320 R15: ffff888017923900
FS: 0000000000000000(0000) GS:ffff8880b9d00000(0000) knlGS:0000000000000000

CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033

CR2: 00007f327bbc8020 CR3: 000000000b88e000 CR4: 00000000003506e0

DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:

<TASK>
__raw_spin_unlock_irqrestore include/linux/spinlock_api_smp.h:158 [inline]
_raw_spin_unlock_irqrestore+0x16/0x70 kernel/locking/spinlock.c:194
spin_unlock_irqrestore include/linux/spinlock.h:422 [inline]
prepare_to_wait_event+0xc8/0x690 kernel/sched/wait.c:325
toggle_allocation_gate mm/kfence/core.c:738 [inline]
toggle_allocation_gate+0x321/0x390 mm/kfence/core.c:723
process_one_work+0x9b2/0x1690 kernel/workqueue.c:2297
worker_thread+0x658/0x11f0 kernel/workqueue.c:2444
kthread+0x405/0x4f0 kernel/kthread.c:327
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295
</TASK>
----------------
Code disassembly (best guess):
0: ed in (%dx),%eax
1: 0f 84 e0 02 00 00 je 0x2e7
7: 48 8d 4c 24 50 lea 0x50(%rsp),%rcx
c: 44 89 ea mov %r13d,%edx
f: 4c 89 e6 mov %r12,%rsi
12: 4c 89 ff mov %r15,%rdi
15: e8 6e 08 ff ff callq 0xffff0888
1a: 48 85 c0 test %rax,%rax
1d: 48 89 c3 mov %rax,%rbx
20: 0f 84 85 03 00 00 je 0x3ab
26: 48 8d 78 24 lea 0x24(%rax),%rdi
* 2a: 48 b8 00 00 00 00 00 movabs $0xdffffc0000000000,%rax <-- trapping instruction
31: fc ff df
34: 48 89 fa mov %rdi,%rdx
37: 48 c1 ea 03 shr $0x3,%rdx
3b: 0f b6 14 02 movzbl (%rdx,%rax,1),%edx
3f: 48 rex.W

Tested on:

commit: 60e88401 Add linux-next specific files for 20211018
git tree: https://git.kernel.org/pub/scm/linux/kernel/git/next/linux-next.git
console output: https://syzkaller.appspot.com/x/log.txt?x=11f31742b00000
kernel config: https://syzkaller.appspot.com/x/.config?x=f125c5a9265365ae
dashboard link: https://syzkaller.appspot.com/bug?extid=abd2e0dafb481b621869
compiler: gcc (Debian 10.2.1-6) 10.2.1 20210110, GNU ld (GNU Binutils for Debian) 2.35.2

Reply all

Reply to author

Forward

0 new messages