Extracting prog: 8m55.468251238s Minimizing prog: 31m1.47676683s Simplifying prog options: 0s Extracting C: 3m29.644994866s Simplifying C: 26m5.659395858s extracting reproducer from 1 programs testing a last program of every proc single: executing 1 programs separately with timeout 30s testing program (duration=30s, {Threaded:true Repeat:true RepeatTimes:0 Procs:5 Slowdown:1 Sandbox:none SandboxArg:0 Leak:false NetInjection:true NetDevices:true NetReset:true Cgroups:true BinfmtMisc:true CloseFDs:true KCSAN:false DevlinkPCI:false NicVF:false USB:true VhciInjection:true Wifi:true IEEE802154:true Sysctl:true Swap:true UseTmpDir:true HandleSegv:true Trace:false LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$uhid-write$UHID_CREATE detailed listing: executing program 0: r0 = openat$uhid(0xffffffffffffff9c, &(0x7f0000000000), 0x2, 0x0) write$UHID_CREATE(r0, &(0x7f0000000300)={0x0, {'syz1\x00', 'syz1\x00', 'syz0\x00', &(0x7f0000000780)=""/4096, 0x1000, 0x8, 0x6700, 0x53, 0x3, 0x492}}, 0x120) program did not crash single: failed to extract reproducer single: executing 1 programs separately with timeout 1m40s testing program (duration=1m40s, {Threaded:true Repeat:true RepeatTimes:0 Procs:5 Slowdown:1 Sandbox:none SandboxArg:0 Leak:false NetInjection:true NetDevices:true NetReset:true Cgroups:true BinfmtMisc:true CloseFDs:true KCSAN:false DevlinkPCI:false NicVF:false USB:true VhciInjection:true Wifi:true IEEE802154:true Sysctl:true Swap:true UseTmpDir:true HandleSegv:true Trace:false LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$uhid-write$UHID_CREATE detailed listing: executing program 0: r0 = openat$uhid(0xffffffffffffff9c, &(0x7f0000000000), 0x2, 0x0) write$UHID_CREATE(r0, &(0x7f0000000300)={0x0, {'syz1\x00', 'syz1\x00', 'syz0\x00', &(0x7f0000000780)=""/4096, 0x1000, 0x8, 0x6700, 0x53, 0x3, 0x492}}, 0x120) program did not crash single: failed to extract reproducer single: executing 1 programs separately with timeout 6m0s testing program (duration=6m0s, {Threaded:true Repeat:true RepeatTimes:0 Procs:5 Slowdown:1 Sandbox:none SandboxArg:0 Leak:false NetInjection:true NetDevices:true NetReset:true Cgroups:true BinfmtMisc:true CloseFDs:true KCSAN:false DevlinkPCI:false NicVF:false USB:true VhciInjection:true Wifi:true IEEE802154:true Sysctl:true Swap:true UseTmpDir:true HandleSegv:true Trace:false LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$uhid-write$UHID_CREATE detailed listing: executing program 0: r0 = openat$uhid(0xffffffffffffff9c, &(0x7f0000000000), 0x2, 0x0) write$UHID_CREATE(r0, &(0x7f0000000300)={0x0, {'syz1\x00', 'syz1\x00', 'syz0\x00', &(0x7f0000000780)=""/4096, 0x1000, 0x8, 0x6700, 0x53, 0x3, 0x492}}, 0x120) program crashed: INFO: task hung in uevent_show single: successfully extracted reproducer found reproducer with 2 syscalls minimizing guilty program testing program (duration=6m0s, {Threaded:true Repeat:true RepeatTimes:0 Procs:5 Slowdown:1 Sandbox:none SandboxArg:0 Leak:false NetInjection:true NetDevices:true NetReset:true Cgroups:true BinfmtMisc:true CloseFDs:true KCSAN:false DevlinkPCI:false NicVF:false USB:true VhciInjection:true Wifi:true IEEE802154:true Sysctl:true Swap:true UseTmpDir:true HandleSegv:true Trace:false LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$uhid detailed listing: executing program 0: openat$uhid(0xffffffffffffff9c, &(0x7f0000000000), 0x2, 0x0) program did not crash testing program (duration=6m0s, {Threaded:true Repeat:true RepeatTimes:0 Procs:5 Slowdown:1 Sandbox:none SandboxArg:0 Leak:false NetInjection:true NetDevices:true NetReset:true Cgroups:true BinfmtMisc:true CloseFDs:true KCSAN:false DevlinkPCI:false NicVF:false USB:true VhciInjection:true Wifi:true IEEE802154:true Sysctl:true Swap:true UseTmpDir:true HandleSegv:true Trace:false LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): write$UHID_CREATE detailed listing: executing program 0: write$UHID_CREATE(0xffffffffffffffff, &(0x7f0000000300)={0x0, {'syz1\x00', 'syz1\x00', 'syz0\x00', &(0x7f0000000780)=""/4096, 0x1000, 0x8, 0x6700, 0x53, 0x3, 0x492}}, 0x120) program did not crash testing program (duration=6m0s, {Threaded:true Repeat:true RepeatTimes:0 Procs:5 Slowdown:1 Sandbox:none SandboxArg:0 Leak:false NetInjection:true NetDevices:true NetReset:true Cgroups:true BinfmtMisc:true CloseFDs:true KCSAN:false DevlinkPCI:false NicVF:false USB:true VhciInjection:true Wifi:true IEEE802154:true Sysctl:true Swap:true UseTmpDir:true HandleSegv:true Trace:false LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$uhid-write$UHID_CREATE detailed listing: executing program 0: r0 = openat$uhid(0xffffffffffffff9c, 0x0, 0x2, 0x0) write$UHID_CREATE(r0, &(0x7f0000000300)={0x0, {'syz1\x00', 'syz1\x00', 'syz0\x00', &(0x7f0000000780)=""/4096, 0x1000, 0x8, 0x6700, 0x53, 0x3, 0x492}}, 0x120) program did not crash testing program (duration=6m0s, {Threaded:true Repeat:true RepeatTimes:0 Procs:5 Slowdown:1 Sandbox:none SandboxArg:0 Leak:false NetInjection:true NetDevices:true NetReset:true Cgroups:true BinfmtMisc:true CloseFDs:true KCSAN:false DevlinkPCI:false NicVF:false USB:true VhciInjection:true Wifi:true IEEE802154:true Sysctl:true Swap:true UseTmpDir:true HandleSegv:true Trace:false LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$uhid-write$UHID_CREATE detailed listing: executing program 0: r0 = openat$uhid(0xffffffffffffff9c, &(0x7f0000000000), 0x2, 0x0) write$UHID_CREATE(r0, 0x0, 0x0) program did not crash testing program (duration=6m0s, {Threaded:true Repeat:true RepeatTimes:0 Procs:5 Slowdown:1 Sandbox:none SandboxArg:0 Leak:false NetInjection:true NetDevices:true NetReset:true Cgroups:true BinfmtMisc:true CloseFDs:true KCSAN:false DevlinkPCI:false NicVF:false USB:true VhciInjection:true Wifi:true IEEE802154:true Sysctl:true Swap:true UseTmpDir:true HandleSegv:true Trace:false LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$uhid-write$UHID_CREATE detailed listing: executing program 0: r0 = openat$uhid(0xffffffffffffff9c, &(0x7f0000000000), 0x2, 0x0) write$UHID_CREATE(r0, &(0x7f0000000300)={0x0, {'syz1\x00', 'syz1\x00', 'syz0\x00', 0x0, 0x0, 0x8, 0x6700, 0x53, 0x3, 0x492}}, 0x120) program did not crash extracting C reproducer testing compiled C program (duration=6m0s, {Threaded:true Repeat:true RepeatTimes:0 Procs:5 Slowdown:1 Sandbox:none SandboxArg:0 Leak:false NetInjection:true NetDevices:true NetReset:true Cgroups:true BinfmtMisc:true CloseFDs:true KCSAN:false DevlinkPCI:false NicVF:false USB:true VhciInjection:true Wifi:true IEEE802154:true Sysctl:true Swap:true UseTmpDir:true HandleSegv:true Trace:false LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$uhid-write$UHID_CREATE program crashed: INFO: task hung in uevent_show simplifying C reproducer testing compiled C program (duration=6m0s, {Threaded:false Repeat:true RepeatTimes:0 Procs:5 Slowdown:1 Sandbox:none SandboxArg:0 Leak:false NetInjection:true NetDevices:true NetReset:true Cgroups:true BinfmtMisc:true CloseFDs:true KCSAN:false DevlinkPCI:false NicVF:false USB:true VhciInjection:true Wifi:true IEEE802154:true Sysctl:true Swap:true UseTmpDir:true HandleSegv:true Trace:false LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$uhid-write$UHID_CREATE program crashed: no output from test machine a never seen crash title: no output from test machine, ignore testing compiled C program (duration=6m0s, {Threaded:true Repeat:true RepeatTimes:0 Procs:1 Slowdown:1 Sandbox:none SandboxArg:0 Leak:false NetInjection:true NetDevices:true NetReset:true Cgroups:true BinfmtMisc:true CloseFDs:true KCSAN:false DevlinkPCI:false NicVF:false USB:true VhciInjection:true Wifi:true IEEE802154:true Sysctl:true Swap:true UseTmpDir:true HandleSegv:true Trace:false LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$uhid-write$UHID_CREATE program crashed: no output from test machine a never seen crash title: no output from test machine, ignore testing compiled C program (duration=6m0s, {Threaded:true Repeat:true RepeatTimes:0 Procs:5 Slowdown:1 Sandbox: SandboxArg:0 Leak:false NetInjection:false NetDevices:false NetReset:false Cgroups:false BinfmtMisc:false CloseFDs:false KCSAN:false DevlinkPCI:false NicVF:false USB:false VhciInjection:false Wifi:false IEEE802154:true Sysctl:true Swap:false UseTmpDir:true HandleSegv:true Trace:false LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$uhid-write$UHID_CREATE program crashed: INFO: task hung in uevent_show testing compiled C program (duration=6m0s, {Threaded:true Repeat:true RepeatTimes:0 Procs:5 Slowdown:1 Sandbox: SandboxArg:0 Leak:false NetInjection:false NetDevices:false NetReset:false Cgroups:false BinfmtMisc:false CloseFDs:false KCSAN:false DevlinkPCI:false NicVF:false USB:false VhciInjection:false Wifi:false IEEE802154:false Sysctl:true Swap:false UseTmpDir:true HandleSegv:true Trace:false LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$uhid-write$UHID_CREATE program crashed: INFO: task hung in uhid_char_release a never seen crash title: INFO: task hung in uhid_char_release, ignore testing compiled C program (duration=6m0s, {Threaded:true Repeat:true RepeatTimes:0 Procs:5 Slowdown:1 Sandbox: SandboxArg:0 Leak:false NetInjection:false NetDevices:false NetReset:false Cgroups:false BinfmtMisc:false CloseFDs:false KCSAN:false DevlinkPCI:false NicVF:false USB:false VhciInjection:false Wifi:false IEEE802154:true Sysctl:true Swap:false UseTmpDir:false HandleSegv:true Trace:false LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$uhid-write$UHID_CREATE program crashed: INFO: task hung in uhid_char_release a never seen crash title: INFO: task hung in uhid_char_release, ignore testing compiled C program (duration=6m0s, {Threaded:true Repeat:true RepeatTimes:0 Procs:5 Slowdown:1 Sandbox: SandboxArg:0 Leak:false NetInjection:false NetDevices:false NetReset:false Cgroups:false BinfmtMisc:false CloseFDs:false KCSAN:false DevlinkPCI:false NicVF:false USB:false VhciInjection:false Wifi:false IEEE802154:true Sysctl:true Swap:false UseTmpDir:true HandleSegv:false Trace:false LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$uhid-write$UHID_CREATE program crashed: INFO: task hung in uevent_show testing compiled C program (duration=6m0s, {Threaded:true Repeat:true RepeatTimes:0 Procs:5 Slowdown:1 Sandbox: SandboxArg:0 Leak:false NetInjection:false NetDevices:false NetReset:false Cgroups:false BinfmtMisc:false CloseFDs:false KCSAN:false DevlinkPCI:false NicVF:false USB:false VhciInjection:false Wifi:false IEEE802154:true Sysctl:false Swap:false UseTmpDir:true HandleSegv:false Trace:false LegacyOptions:{Collide:false Fault:false FaultCall:0 FaultNth:0}}): openat$uhid-write$UHID_CREATE program crashed: INFO: task hung in uevent_show reproducing took 1h9m32.249439542s repro crashed as (corrupted=false): INFO: task udevd:5193 blocked for more than 143 seconds. Not tainted 6.13.0-syzkaller-00164-g100ceb4817a2 #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. task:udevd state:D stack:24464 pid:5193 tgid:5193 ppid:1 flags:0x00000002 Call Trace: context_switch kernel/sched/core.c:5369 [inline] __schedule+0x17fb/0x4be0 kernel/sched/core.c:6756 __schedule_loop kernel/sched/core.c:6833 [inline] schedule+0x14b/0x320 kernel/sched/core.c:6848 schedule_preempt_disabled+0x13/0x30 kernel/sched/core.c:6905 __mutex_lock_common kernel/locking/mutex.c:665 [inline] __mutex_lock+0x7e7/0xee0 kernel/locking/mutex.c:735 device_lock include/linux/device.h:1014 [inline] uevent_show+0x17d/0x340 drivers/base/core.c:2729 dev_attr_show+0x55/0xc0 drivers/base/core.c:2423 sysfs_kf_seq_show+0x331/0x4c0 fs/sysfs/file.c:59 seq_read_iter+0x43f/0xd70 fs/seq_file.c:230 new_sync_read fs/read_write.c:484 [inline] vfs_read+0x991/0xb70 fs/read_write.c:565 ksys_read+0x18f/0x2b0 fs/read_write.c:708 do_syscall_x64 arch/x86/entry/common.c:52 [inline] do_syscall_64+0xf3/0x230 arch/x86/entry/common.c:83 entry_SYSCALL_64_after_hwframe+0x77/0x7f RIP: 0033:0x7f5863f16b6a RSP: 002b:00007ffc48135288 EFLAGS: 00000246 ORIG_RAX: 0000000000000000 RAX: ffffffffffffffda RBX: 0000557c13bebde0 RCX: 00007f5863f16b6a RDX: 0000000000001000 RSI: 0000557c13c70020 RDI: 000000000000000c RBP: 0000557c13bebde0 R08: 000000000000000c R09: 0000000000000010 R10: 000000000000010f R11: 0000000000000246 R12: 0000000000000000 R13: 0000000000003fff R14: 00007ffc48135768 R15: 000000000000000a INFO: task syz-executor278:5844 blocked for more than 144 seconds. Not tainted 6.13.0-syzkaller-00164-g100ceb4817a2 #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. task:syz-executor278 state:D stack:26448 pid:5844 tgid:5839 ppid:5836 flags:0x00004002 Call Trace: context_switch kernel/sched/core.c:5369 [inline] __schedule+0x17fb/0x4be0 kernel/sched/core.c:6756 __schedule_loop kernel/sched/core.c:6833 [inline] schedule+0x14b/0x320 kernel/sched/core.c:6848 schedule_timeout+0xb0/0x290 kernel/time/sleep_timeout.c:75 do_wait_for_common kernel/sched/completion.c:95 [inline] __wait_for_common kernel/sched/completion.c:116 [inline] wait_for_common kernel/sched/completion.c:127 [inline] wait_for_completion+0x355/0x620 kernel/sched/completion.c:148 __flush_work+0xa47/0xc60 kernel/workqueue.c:4242 __cancel_work_sync+0xbc/0x110 kernel/workqueue.c:4362 uhid_dev_destroy drivers/hid/uhid.c:584 [inline] uhid_char_release+0xac/0x600 drivers/hid/uhid.c:662 __fput+0x23c/0xa50 fs/file_table.c:450 task_work_run+0x24f/0x310 kernel/task_work.c:239 exit_task_work include/linux/task_work.h:43 [inline] do_exit+0xa2a/0x28e0 kernel/exit.c:938 do_group_exit+0x207/0x2c0 kernel/exit.c:1087 get_signal+0x16b2/0x1750 kernel/signal.c:3036 arch_do_signal_or_restart+0x96/0x860 arch/x86/kernel/signal.c:337 exit_to_user_mode_loop kernel/entry/common.c:111 [inline] exit_to_user_mode_prepare include/linux/entry-common.h:329 [inline] __syscall_exit_to_user_mode_work kernel/entry/common.c:207 [inline] syscall_exit_to_user_mode+0xce/0x340 kernel/entry/common.c:218 do_syscall_64+0x100/0x230 arch/x86/entry/common.c:89 entry_SYSCALL_64_after_hwframe+0x77/0x7f RIP: 0033:0x7f1d7cc48b79 RSP: 002b:00007f1d7cbfb238 EFLAGS: 00000246 ORIG_RAX: 00000000000000ca RAX: fffffffffffffe00 RBX: 00007f1d7cccb3c8 RCX: 00007f1d7cc48b79 RDX: 0000000000000000 RSI: 0000000000000080 RDI: 00007f1d7cccb3c8 RBP: 00007f1d7cccb3c0 R08: 00007f1d7cbfb6c0 R09: 00007f1d7cbfb6c0 R10: 0000000000000000 R11: 0000000000000246 R12: 6968752f7665642f R13: 0000000000000000 R14: 00007fffebf50170 R15: 00007fffebf50258 INFO: task syz-executor278:5852 blocked for more than 146 seconds. Not tainted 6.13.0-syzkaller-00164-g100ceb4817a2 #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. task:syz-executor278 state:D stack:26448 pid:5852 tgid:5847 ppid:5834 flags:0x00004002 Call Trace: context_switch kernel/sched/core.c:5369 [inline] __schedule+0x17fb/0x4be0 kernel/sched/core.c:6756 __schedule_loop kernel/sched/core.c:6833 [inline] schedule+0x14b/0x320 kernel/sched/core.c:6848 schedule_timeout+0xb0/0x290 kernel/time/sleep_timeout.c:75 do_wait_for_common kernel/sched/completion.c:95 [inline] __wait_for_common kernel/sched/completion.c:116 [inline] wait_for_common kernel/sched/completion.c:127 [inline] wait_for_completion+0x355/0x620 kernel/sched/completion.c:148 __flush_work+0xa47/0xc60 kernel/workqueue.c:4242 __cancel_work_sync+0xbc/0x110 kernel/workqueue.c:4362 uhid_dev_destroy drivers/hid/uhid.c:584 [inline] uhid_char_release+0xac/0x600 drivers/hid/uhid.c:662 __fput+0x23c/0xa50 fs/file_table.c:450 task_work_run+0x24f/0x310 kernel/task_work.c:239 exit_task_work include/linux/task_work.h:43 [inline] do_exit+0xa2a/0x28e0 kernel/exit.c:938 do_group_exit+0x207/0x2c0 kernel/exit.c:1087 get_signal+0x16b2/0x1750 kernel/signal.c:3036 arch_do_signal_or_restart+0x96/0x860 arch/x86/kernel/signal.c:337 exit_to_user_mode_loop kernel/entry/common.c:111 [inline] exit_to_user_mode_prepare include/linux/entry-common.h:329 [inline] __syscall_exit_to_user_mode_work kernel/entry/common.c:207 [inline] syscall_exit_to_user_mode+0xce/0x340 kernel/entry/common.c:218 do_syscall_64+0x100/0x230 arch/x86/entry/common.c:89 entry_SYSCALL_64_after_hwframe+0x77/0x7f RIP: 0033:0x7f1d7cc48b79 RSP: 002b:00007f1d7cbfb238 EFLAGS: 00000246 ORIG_RAX: 00000000000000ca RAX: fffffffffffffe00 RBX: 00007f1d7cccb3c8 RCX: 00007f1d7cc48b79 RDX: 0000000000000000 RSI: 0000000000000080 RDI: 00007f1d7cccb3c8 RBP: 00007f1d7cccb3c0 R08: 00007f1d7cbfb6c0 R09: 00007f1d7cbfb6c0 R10: 0000000000000000 R11: 0000000000000246 R12: 6968752f7665642f R13: 0000000000000016 R14: 00007fffebf50170 R15: 00007fffebf50258 INFO: task syz-executor278:5856 blocked for more than 148 seconds. Not tainted 6.13.0-syzkaller-00164-g100ceb4817a2 #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. task:syz-executor278 state:D stack:25936 pid:5856 tgid:5855 ppid:5832 flags:0x00004002 Call Trace: context_switch kernel/sched/core.c:5369 [inline] __schedule+0x17fb/0x4be0 kernel/sched/core.c:6756 __schedule_loop kernel/sched/core.c:6833 [inline] schedule+0x14b/0x320 kernel/sched/core.c:6848 schedule_timeout+0xb0/0x290 kernel/time/sleep_timeout.c:75 do_wait_for_common kernel/sched/completion.c:95 [inline] __wait_for_common kernel/sched/completion.c:116 [inline] wait_for_common kernel/sched/completion.c:127 [inline] wait_for_completion+0x355/0x620 kernel/sched/completion.c:148 __flush_work+0xa47/0xc60 kernel/workqueue.c:4242 __cancel_work_sync+0xbc/0x110 kernel/workqueue.c:4362 uhid_dev_destroy drivers/hid/uhid.c:584 [inline] uhid_char_release+0xac/0x600 drivers/hid/uhid.c:662 __fput+0x23c/0xa50 fs/file_table.c:450 task_work_run+0x24f/0x310 kernel/task_work.c:239 exit_task_work include/linux/task_work.h:43 [inline] do_exit+0xa2a/0x28e0 kernel/exit.c:938 do_group_exit+0x207/0x2c0 kernel/exit.c:1087 get_signal+0x16b2/0x1750 kernel/signal.c:3036 arch_do_signal_or_restart+0x96/0x860 arch/x86/kernel/signal.c:337 exit_to_user_mode_loop kernel/entry/common.c:111 [inline] exit_to_user_mode_prepare include/linux/entry-common.h:329 [inline] __syscall_exit_to_user_mode_work kernel/entry/common.c:207 [inline] syscall_exit_to_user_mode+0xce/0x340 kernel/entry/common.c:218 do_syscall_64+0x100/0x230 arch/x86/entry/common.c:89 entry_SYSCALL_64_after_hwframe+0x77/0x7f RIP: 0033:0x7f1d7cc48b79 RSP: 002b:00007f1d7cbfb238 EFLAGS: 00000246 ORIG_RAX: 00000000000000ca RAX: fffffffffffffe00 RBX: 00007f1d7cccb3c8 RCX: 00007f1d7cc48b79 RDX: 0000000000000000 RSI: 0000000000000080 RDI: 00007f1d7cccb3c8 RBP: 00007f1d7cccb3c0 R08: 00007f1d7cbfb6c0 R09: 00007f1d7cbfb6c0 R10: 0000000000000000 R11: 0000000000000246 R12: 6968752f7665642f R13: 0000000000000016 R14: 00007fffebf50170 R15: 00007fffebf50258 Showing all locks held in the system: 3 locks held by kworker/0:0/8: 3 locks held by kworker/0:1/9: 1 lock held by khungtaskd/30: #0: ffffffff8e937da0 ( rcu_read_lock ){....}-{1:3} , at: rcu_lock_acquire include/linux/rcupdate.h:337 [inline] , at: rcu_read_lock include/linux/rcupdate.h:849 [inline] , at: debug_show_all_locks+0x55/0x2a0 kernel/locking/lockdep.c:6744 5 locks held by kworker/u8:5/1131: 3 locks held by kworker/1:2/3160: 4 locks held by udevd/5193: #0: ffff88802f63c790 ( &p->lock ){+.+.}-{4:4}, at: seq_read_iter+0xb4/0xd70 fs/seq_file.c:182 #1: ffff888030438088 (&of->mutex #2 ){+.+.}-{4:4} , at: kernfs_seq_start+0x53/0x3b0 fs/kernfs/file.c:154 #2: ffff888031f09968 (kn->active#5){++++}-{0:0} , at: kernfs_seq_start+0x72/0x3b0 fs/kernfs/file.c:155 #3: ffff8880772a1a20 ( &dev->mutex ){....}-{4:4}, at: device_lock include/linux/device.h:1014 [inline] ){....}-{4:4}, at: uevent_show+0x17d/0x340 drivers/base/core.c:2729 3 locks held by kworker/0:3/5209: 2 locks held by getty/5578: #0: ffff88814d6320a0 ( &tty->ldisc_sem ){++++}-{0:0} , at: tty_ldisc_ref_wait+0x25/0x70 drivers/tty/tty_ldisc.c:243 #1: ffffc9000332b2f0 ( &ldata->atomic_read_lock ){+.+.}-{4:4} , at: n_tty_read+0x6a6/0x1e00 drivers/tty/n_tty.c:2211 3 locks held by kworker/0:4/5858: ============================================= NMI backtrace for cpu 1 CPU: 1 UID: 0 PID: 30 Comm: khungtaskd Not tainted 6.13.0-syzkaller-00164-g100ceb4817a2 #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 12/27/2024 Call Trace: __dump_stack lib/dump_stack.c:94 [inline] dump_stack_lvl+0x241/0x360 lib/dump_stack.c:120 nmi_cpu_backtrace+0x49c/0x4d0 lib/nmi_backtrace.c:113 nmi_trigger_cpumask_backtrace+0x198/0x320 lib/nmi_backtrace.c:62 trigger_all_cpu_backtrace include/linux/nmi.h:162 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:234 [inline] watchdog+0xff6/0x1040 kernel/hung_task.c:397 kthread+0x2f0/0x390 kernel/kthread.c:389 ret_from_fork+0x4b/0x80 arch/x86/kernel/process.c:147 ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:244 Sending NMI from CPU 1 to CPUs 0: NMI backtrace for cpu 0 CPU: 0 UID: 0 PID: 9 Comm: kworker/0:1 Not tainted 6.13.0-syzkaller-00164-g100ceb4817a2 #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 12/27/2024 Workqueue: events uhid_device_add_worker RIP: 0010:__printk_safe_enter+0x0/0x20 kernel/printk/printk_safe.c:37 Code: 26 42 20 00 85 db 0f 95 c0 5b c3 cc cc cc cc 66 2e 0f 1f 84 00 00 00 00 00 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 <66> 0f 1f 00 e8 b7 3d 20 00 65 ff 05 e8 55 83 7e c3 cc cc cc cc 66 RSP: 0018:ffffc900000e6e78 EFLAGS: 00000002 RAX: 0000000000000001 RBX: 1ffff9200001cdec RCX: ffffffff81a72ffc RDX: 0000000000000000 RSI: ffffffff8c5f27c0 RDI: ffffffff8c5f2780 RBP: ffffc900000e7030 R08: ffffffff9018d4f7 R09: 1ffffffff2031a9e R10: dffffc0000000000 R11: fffffbfff2031a9f R12: ffffffff8f16a020 R13: dffffc0000000000 R14: 0000000000000200 R15: 0000000000000030 FS: 0000000000000000(0000) GS:ffff8880b8600000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 0000000020001000 CR3: 000000007b3de000 CR4: 00000000003526f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: console_emit_next_record kernel/printk/printk.c:3115 [inline] console_flush_all+0x763/0xeb0 kernel/printk/printk.c:3210 __console_flush_and_unlock kernel/printk/printk.c:3269 [inline] console_unlock+0x14f/0x3b0 kernel/printk/printk.c:3309 vprintk_emit+0x730/0xa10 kernel/printk/printk.c:2432 dev_vprintk_emit+0x2ae/0x330 drivers/base/core.c:4935 dev_printk_emit+0xdd/0x120 drivers/base/core.c:4946 _dev_warn+0x122/0x170 drivers/base/core.c:5002 hid_parser_main+0x71f/0xaa0 drivers/hid/hid-core.c:660 hid_open_report+0xbd8/0x1580 drivers/hid/hid-core.c:1322 hid_parse include/linux/hid.h:1123 [inline] hid_generic_probe+0x3d/0x90 drivers/hid/hid-generic.c:66 __hid_device_probe drivers/hid/hid-core.c:2718 [inline] hid_device_probe+0x3bf/0x710 drivers/hid/hid-core.c:2755 really_probe+0x2b8/0xad0 drivers/base/dd.c:658 __driver_probe_device+0x1a2/0x390 drivers/base/dd.c:800 driver_probe_device+0x50/0x430 drivers/base/dd.c:830 __device_attach_driver+0x2d6/0x530 drivers/base/dd.c:958 bus_for_each_drv+0x24e/0x2e0 drivers/base/bus.c:459 __device_attach+0x333/0x520 drivers/base/dd.c:1030 bus_probe_device+0x189/0x260 drivers/base/bus.c:534 device_add+0x856/0xbf0 drivers/base/core.c:3665 hid_add_device+0x3b6/0x520 drivers/hid/hid-core.c:2901 uhid_device_add_worker+0x44/0xf0 drivers/hid/uhid.c:73 process_one_work kernel/workqueue.c:3236 [inline] process_scheduled_works+0xa66/0x1840 kernel/workqueue.c:3317 worker_thread+0x870/0xd30 kernel/workqueue.c:3398 kthread+0x2f0/0x390 kernel/kthread.c:389 ret_from_fork+0x4b/0x80 arch/x86/kernel/process.c:147 ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:244 INFO: NMI handler (nmi_cpu_backtrace_handler) took too long to run: 1.742 msecs final repro crashed as (corrupted=false): INFO: task udevd:5193 blocked for more than 143 seconds. Not tainted 6.13.0-syzkaller-00164-g100ceb4817a2 #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. task:udevd state:D stack:24464 pid:5193 tgid:5193 ppid:1 flags:0x00000002 Call Trace: context_switch kernel/sched/core.c:5369 [inline] __schedule+0x17fb/0x4be0 kernel/sched/core.c:6756 __schedule_loop kernel/sched/core.c:6833 [inline] schedule+0x14b/0x320 kernel/sched/core.c:6848 schedule_preempt_disabled+0x13/0x30 kernel/sched/core.c:6905 __mutex_lock_common kernel/locking/mutex.c:665 [inline] __mutex_lock+0x7e7/0xee0 kernel/locking/mutex.c:735 device_lock include/linux/device.h:1014 [inline] uevent_show+0x17d/0x340 drivers/base/core.c:2729 dev_attr_show+0x55/0xc0 drivers/base/core.c:2423 sysfs_kf_seq_show+0x331/0x4c0 fs/sysfs/file.c:59 seq_read_iter+0x43f/0xd70 fs/seq_file.c:230 new_sync_read fs/read_write.c:484 [inline] vfs_read+0x991/0xb70 fs/read_write.c:565 ksys_read+0x18f/0x2b0 fs/read_write.c:708 do_syscall_x64 arch/x86/entry/common.c:52 [inline] do_syscall_64+0xf3/0x230 arch/x86/entry/common.c:83 entry_SYSCALL_64_after_hwframe+0x77/0x7f RIP: 0033:0x7f5863f16b6a RSP: 002b:00007ffc48135288 EFLAGS: 00000246 ORIG_RAX: 0000000000000000 RAX: ffffffffffffffda RBX: 0000557c13bebde0 RCX: 00007f5863f16b6a RDX: 0000000000001000 RSI: 0000557c13c70020 RDI: 000000000000000c RBP: 0000557c13bebde0 R08: 000000000000000c R09: 0000000000000010 R10: 000000000000010f R11: 0000000000000246 R12: 0000000000000000 R13: 0000000000003fff R14: 00007ffc48135768 R15: 000000000000000a INFO: task syz-executor278:5844 blocked for more than 144 seconds. Not tainted 6.13.0-syzkaller-00164-g100ceb4817a2 #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. task:syz-executor278 state:D stack:26448 pid:5844 tgid:5839 ppid:5836 flags:0x00004002 Call Trace: context_switch kernel/sched/core.c:5369 [inline] __schedule+0x17fb/0x4be0 kernel/sched/core.c:6756 __schedule_loop kernel/sched/core.c:6833 [inline] schedule+0x14b/0x320 kernel/sched/core.c:6848 schedule_timeout+0xb0/0x290 kernel/time/sleep_timeout.c:75 do_wait_for_common kernel/sched/completion.c:95 [inline] __wait_for_common kernel/sched/completion.c:116 [inline] wait_for_common kernel/sched/completion.c:127 [inline] wait_for_completion+0x355/0x620 kernel/sched/completion.c:148 __flush_work+0xa47/0xc60 kernel/workqueue.c:4242 __cancel_work_sync+0xbc/0x110 kernel/workqueue.c:4362 uhid_dev_destroy drivers/hid/uhid.c:584 [inline] uhid_char_release+0xac/0x600 drivers/hid/uhid.c:662 __fput+0x23c/0xa50 fs/file_table.c:450 task_work_run+0x24f/0x310 kernel/task_work.c:239 exit_task_work include/linux/task_work.h:43 [inline] do_exit+0xa2a/0x28e0 kernel/exit.c:938 do_group_exit+0x207/0x2c0 kernel/exit.c:1087 get_signal+0x16b2/0x1750 kernel/signal.c:3036 arch_do_signal_or_restart+0x96/0x860 arch/x86/kernel/signal.c:337 exit_to_user_mode_loop kernel/entry/common.c:111 [inline] exit_to_user_mode_prepare include/linux/entry-common.h:329 [inline] __syscall_exit_to_user_mode_work kernel/entry/common.c:207 [inline] syscall_exit_to_user_mode+0xce/0x340 kernel/entry/common.c:218 do_syscall_64+0x100/0x230 arch/x86/entry/common.c:89 entry_SYSCALL_64_after_hwframe+0x77/0x7f RIP: 0033:0x7f1d7cc48b79 RSP: 002b:00007f1d7cbfb238 EFLAGS: 00000246 ORIG_RAX: 00000000000000ca RAX: fffffffffffffe00 RBX: 00007f1d7cccb3c8 RCX: 00007f1d7cc48b79 RDX: 0000000000000000 RSI: 0000000000000080 RDI: 00007f1d7cccb3c8 RBP: 00007f1d7cccb3c0 R08: 00007f1d7cbfb6c0 R09: 00007f1d7cbfb6c0 R10: 0000000000000000 R11: 0000000000000246 R12: 6968752f7665642f R13: 0000000000000000 R14: 00007fffebf50170 R15: 00007fffebf50258 INFO: task syz-executor278:5852 blocked for more than 146 seconds. Not tainted 6.13.0-syzkaller-00164-g100ceb4817a2 #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. task:syz-executor278 state:D stack:26448 pid:5852 tgid:5847 ppid:5834 flags:0x00004002 Call Trace: context_switch kernel/sched/core.c:5369 [inline] __schedule+0x17fb/0x4be0 kernel/sched/core.c:6756 __schedule_loop kernel/sched/core.c:6833 [inline] schedule+0x14b/0x320 kernel/sched/core.c:6848 schedule_timeout+0xb0/0x290 kernel/time/sleep_timeout.c:75 do_wait_for_common kernel/sched/completion.c:95 [inline] __wait_for_common kernel/sched/completion.c:116 [inline] wait_for_common kernel/sched/completion.c:127 [inline] wait_for_completion+0x355/0x620 kernel/sched/completion.c:148 __flush_work+0xa47/0xc60 kernel/workqueue.c:4242 __cancel_work_sync+0xbc/0x110 kernel/workqueue.c:4362 uhid_dev_destroy drivers/hid/uhid.c:584 [inline] uhid_char_release+0xac/0x600 drivers/hid/uhid.c:662 __fput+0x23c/0xa50 fs/file_table.c:450 task_work_run+0x24f/0x310 kernel/task_work.c:239 exit_task_work include/linux/task_work.h:43 [inline] do_exit+0xa2a/0x28e0 kernel/exit.c:938 do_group_exit+0x207/0x2c0 kernel/exit.c:1087 get_signal+0x16b2/0x1750 kernel/signal.c:3036 arch_do_signal_or_restart+0x96/0x860 arch/x86/kernel/signal.c:337 exit_to_user_mode_loop kernel/entry/common.c:111 [inline] exit_to_user_mode_prepare include/linux/entry-common.h:329 [inline] __syscall_exit_to_user_mode_work kernel/entry/common.c:207 [inline] syscall_exit_to_user_mode+0xce/0x340 kernel/entry/common.c:218 do_syscall_64+0x100/0x230 arch/x86/entry/common.c:89 entry_SYSCALL_64_after_hwframe+0x77/0x7f RIP: 0033:0x7f1d7cc48b79 RSP: 002b:00007f1d7cbfb238 EFLAGS: 00000246 ORIG_RAX: 00000000000000ca RAX: fffffffffffffe00 RBX: 00007f1d7cccb3c8 RCX: 00007f1d7cc48b79 RDX: 0000000000000000 RSI: 0000000000000080 RDI: 00007f1d7cccb3c8 RBP: 00007f1d7cccb3c0 R08: 00007f1d7cbfb6c0 R09: 00007f1d7cbfb6c0 R10: 0000000000000000 R11: 0000000000000246 R12: 6968752f7665642f R13: 0000000000000016 R14: 00007fffebf50170 R15: 00007fffebf50258 INFO: task syz-executor278:5856 blocked for more than 148 seconds. Not tainted 6.13.0-syzkaller-00164-g100ceb4817a2 #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. task:syz-executor278 state:D stack:25936 pid:5856 tgid:5855 ppid:5832 flags:0x00004002 Call Trace: context_switch kernel/sched/core.c:5369 [inline] __schedule+0x17fb/0x4be0 kernel/sched/core.c:6756 __schedule_loop kernel/sched/core.c:6833 [inline] schedule+0x14b/0x320 kernel/sched/core.c:6848 schedule_timeout+0xb0/0x290 kernel/time/sleep_timeout.c:75 do_wait_for_common kernel/sched/completion.c:95 [inline] __wait_for_common kernel/sched/completion.c:116 [inline] wait_for_common kernel/sched/completion.c:127 [inline] wait_for_completion+0x355/0x620 kernel/sched/completion.c:148 __flush_work+0xa47/0xc60 kernel/workqueue.c:4242 __cancel_work_sync+0xbc/0x110 kernel/workqueue.c:4362 uhid_dev_destroy drivers/hid/uhid.c:584 [inline] uhid_char_release+0xac/0x600 drivers/hid/uhid.c:662 __fput+0x23c/0xa50 fs/file_table.c:450 task_work_run+0x24f/0x310 kernel/task_work.c:239 exit_task_work include/linux/task_work.h:43 [inline] do_exit+0xa2a/0x28e0 kernel/exit.c:938 do_group_exit+0x207/0x2c0 kernel/exit.c:1087 get_signal+0x16b2/0x1750 kernel/signal.c:3036 arch_do_signal_or_restart+0x96/0x860 arch/x86/kernel/signal.c:337 exit_to_user_mode_loop kernel/entry/common.c:111 [inline] exit_to_user_mode_prepare include/linux/entry-common.h:329 [inline] __syscall_exit_to_user_mode_work kernel/entry/common.c:207 [inline] syscall_exit_to_user_mode+0xce/0x340 kernel/entry/common.c:218 do_syscall_64+0x100/0x230 arch/x86/entry/common.c:89 entry_SYSCALL_64_after_hwframe+0x77/0x7f RIP: 0033:0x7f1d7cc48b79 RSP: 002b:00007f1d7cbfb238 EFLAGS: 00000246 ORIG_RAX: 00000000000000ca RAX: fffffffffffffe00 RBX: 00007f1d7cccb3c8 RCX: 00007f1d7cc48b79 RDX: 0000000000000000 RSI: 0000000000000080 RDI: 00007f1d7cccb3c8 RBP: 00007f1d7cccb3c0 R08: 00007f1d7cbfb6c0 R09: 00007f1d7cbfb6c0 R10: 0000000000000000 R11: 0000000000000246 R12: 6968752f7665642f R13: 0000000000000016 R14: 00007fffebf50170 R15: 00007fffebf50258 Showing all locks held in the system: 3 locks held by kworker/0:0/8: 3 locks held by kworker/0:1/9: 1 lock held by khungtaskd/30: #0: ffffffff8e937da0 ( rcu_read_lock ){....}-{1:3} , at: rcu_lock_acquire include/linux/rcupdate.h:337 [inline] , at: rcu_read_lock include/linux/rcupdate.h:849 [inline] , at: debug_show_all_locks+0x55/0x2a0 kernel/locking/lockdep.c:6744 5 locks held by kworker/u8:5/1131: 3 locks held by kworker/1:2/3160: 4 locks held by udevd/5193: #0: ffff88802f63c790 ( &p->lock ){+.+.}-{4:4}, at: seq_read_iter+0xb4/0xd70 fs/seq_file.c:182 #1: ffff888030438088 (&of->mutex #2 ){+.+.}-{4:4} , at: kernfs_seq_start+0x53/0x3b0 fs/kernfs/file.c:154 #2: ffff888031f09968 (kn->active#5){++++}-{0:0} , at: kernfs_seq_start+0x72/0x3b0 fs/kernfs/file.c:155 #3: ffff8880772a1a20 ( &dev->mutex ){....}-{4:4}, at: device_lock include/linux/device.h:1014 [inline] ){....}-{4:4}, at: uevent_show+0x17d/0x340 drivers/base/core.c:2729 3 locks held by kworker/0:3/5209: 2 locks held by getty/5578: #0: ffff88814d6320a0 ( &tty->ldisc_sem ){++++}-{0:0} , at: tty_ldisc_ref_wait+0x25/0x70 drivers/tty/tty_ldisc.c:243 #1: ffffc9000332b2f0 ( &ldata->atomic_read_lock ){+.+.}-{4:4} , at: n_tty_read+0x6a6/0x1e00 drivers/tty/n_tty.c:2211 3 locks held by kworker/0:4/5858: ============================================= NMI backtrace for cpu 1 CPU: 1 UID: 0 PID: 30 Comm: khungtaskd Not tainted 6.13.0-syzkaller-00164-g100ceb4817a2 #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 12/27/2024 Call Trace: __dump_stack lib/dump_stack.c:94 [inline] dump_stack_lvl+0x241/0x360 lib/dump_stack.c:120 nmi_cpu_backtrace+0x49c/0x4d0 lib/nmi_backtrace.c:113 nmi_trigger_cpumask_backtrace+0x198/0x320 lib/nmi_backtrace.c:62 trigger_all_cpu_backtrace include/linux/nmi.h:162 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:234 [inline] watchdog+0xff6/0x1040 kernel/hung_task.c:397 kthread+0x2f0/0x390 kernel/kthread.c:389 ret_from_fork+0x4b/0x80 arch/x86/kernel/process.c:147 ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:244 Sending NMI from CPU 1 to CPUs 0: NMI backtrace for cpu 0 CPU: 0 UID: 0 PID: 9 Comm: kworker/0:1 Not tainted 6.13.0-syzkaller-00164-g100ceb4817a2 #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 12/27/2024 Workqueue: events uhid_device_add_worker RIP: 0010:__printk_safe_enter+0x0/0x20 kernel/printk/printk_safe.c:37 Code: 26 42 20 00 85 db 0f 95 c0 5b c3 cc cc cc cc 66 2e 0f 1f 84 00 00 00 00 00 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 <66> 0f 1f 00 e8 b7 3d 20 00 65 ff 05 e8 55 83 7e c3 cc cc cc cc 66 RSP: 0018:ffffc900000e6e78 EFLAGS: 00000002 RAX: 0000000000000001 RBX: 1ffff9200001cdec RCX: ffffffff81a72ffc RDX: 0000000000000000 RSI: ffffffff8c5f27c0 RDI: ffffffff8c5f2780 RBP: ffffc900000e7030 R08: ffffffff9018d4f7 R09: 1ffffffff2031a9e R10: dffffc0000000000 R11: fffffbfff2031a9f R12: ffffffff8f16a020 R13: dffffc0000000000 R14: 0000000000000200 R15: 0000000000000030 FS: 0000000000000000(0000) GS:ffff8880b8600000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 0000000020001000 CR3: 000000007b3de000 CR4: 00000000003526f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: console_emit_next_record kernel/printk/printk.c:3115 [inline] console_flush_all+0x763/0xeb0 kernel/printk/printk.c:3210 __console_flush_and_unlock kernel/printk/printk.c:3269 [inline] console_unlock+0x14f/0x3b0 kernel/printk/printk.c:3309 vprintk_emit+0x730/0xa10 kernel/printk/printk.c:2432 dev_vprintk_emit+0x2ae/0x330 drivers/base/core.c:4935 dev_printk_emit+0xdd/0x120 drivers/base/core.c:4946 _dev_warn+0x122/0x170 drivers/base/core.c:5002 hid_parser_main+0x71f/0xaa0 drivers/hid/hid-core.c:660 hid_open_report+0xbd8/0x1580 drivers/hid/hid-core.c:1322 hid_parse include/linux/hid.h:1123 [inline] hid_generic_probe+0x3d/0x90 drivers/hid/hid-generic.c:66 __hid_device_probe drivers/hid/hid-core.c:2718 [inline] hid_device_probe+0x3bf/0x710 drivers/hid/hid-core.c:2755 really_probe+0x2b8/0xad0 drivers/base/dd.c:658 __driver_probe_device+0x1a2/0x390 drivers/base/dd.c:800 driver_probe_device+0x50/0x430 drivers/base/dd.c:830 __device_attach_driver+0x2d6/0x530 drivers/base/dd.c:958 bus_for_each_drv+0x24e/0x2e0 drivers/base/bus.c:459 __device_attach+0x333/0x520 drivers/base/dd.c:1030 bus_probe_device+0x189/0x260 drivers/base/bus.c:534 device_add+0x856/0xbf0 drivers/base/core.c:3665 hid_add_device+0x3b6/0x520 drivers/hid/hid-core.c:2901 uhid_device_add_worker+0x44/0xf0 drivers/hid/uhid.c:73 process_one_work kernel/workqueue.c:3236 [inline] process_scheduled_works+0xa66/0x1840 kernel/workqueue.c:3317 worker_thread+0x870/0xd30 kernel/workqueue.c:3398 kthread+0x2f0/0x390 kernel/kthread.c:389 ret_from_fork+0x4b/0x80 arch/x86/kernel/process.c:147 ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:244 INFO: NMI handler (nmi_cpu_backtrace_handler) took too long to run: 1.742 msecs