rcu: INFO: rcu_preempt detected expedited stalls on CPUs/tasks: { 0-...D } 2675 jiffies s: 61221 root: 0x1/. rcu: blocking rcu_node structures (internal RCU debug): Sending NMI from CPU 1 to CPUs 0: RDX: 00000000000000e7 RSI: 000000000000003c RDI: 0000000000000001 NMI backtrace for cpu 0 CPU: 0 UID: 0 PID: 17895 Comm: udevd Not tainted 6.12.0-rc4-syzkaller-00059-gc67e9601e29a #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/13/2024 RIP: 0010:format_decode+0x25e/0xba0 lib/vsprintf.c:2554 Code: 44 6f fa 41 88 5c 24 04 48 89 eb e8 ac 44 6f fa 48 8d 6b 01 48 89 e8 48 89 ea 48 c1 e8 03 83 e2 07 42 0f b6 04 30 38 d0 7f 08 <84> c0 0f 85 b3 08 00 00 0f b6 7d 00 48 c7 c6 00 c0 10 88 49 89 ff RSP: 0018:ffffc90000006a90 EFLAGS: 00000093 RAX: 0000000000000000 RBX: ffffffff8728c781 RCX: ffffc90001001000 RDX: 0000000000000002 RSI: ffffffff86e6ae14 RDI: 0000000000000001 RBP: ffffffff8728c782 R08: 0000000000000001 R09: 0000000000000000 R10: 0000000000000025 R11: 000000000096b328 R12: ffffc90000006b90 R13: ffffffff8728c781 R14: dffffc0000000000 R15: dffffc0000000000 FS: 00007fec37092c80(0000) GS:ffff8881f5800000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007f145ac56d58 CR3: 000000011f872000 CR4: 00000000003506f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: vsnprintf+0x13d/0x1880 lib/vsprintf.c:2755 sprintf+0xcd/0x110 lib/vsprintf.c:3007 print_time kernel/printk/printk.c:1362 [inline] info_print_prefix+0x25c/0x350 kernel/printk/printk.c:1388 record_print_text+0x141/0x400 kernel/printk/printk.c:1437 printk_get_next_message+0x2a6/0x670 kernel/printk/printk.c:2978 console_emit_next_record kernel/printk/printk.c:3046 [inline] console_flush_all+0x6ec/0xc60 kernel/printk/printk.c:3180 __console_flush_and_unlock kernel/printk/printk.c:3239 [inline] console_unlock+0xd9/0x210 kernel/printk/printk.c:3279 vprintk_emit+0x424/0x6f0 kernel/printk/printk.c:2407 vprintk+0x7f/0xa0 kernel/printk/printk_safe.c:68 _printk+0xc8/0x100 kernel/printk/printk.c:2432 __show_regs+0x16f/0x750 arch/x86/kernel/process_64.c:85 show_trace_log_lvl+0x26c/0x3d0 arch/x86/kernel/dumpstack.c:301 sched_show_task kernel/sched/core.c:7604 [inline] sched_show_task+0x3f0/0x5f0 kernel/sched/core.c:7579 show_state_filter+0xee/0x320 kernel/sched/core.c:7649 k_spec drivers/tty/vt/keyboard.c:667 [inline] k_spec+0xed/0x150 drivers/tty/vt/keyboard.c:656 kbd_keycode drivers/tty/vt/keyboard.c:1522 [inline] kbd_event+0xcbd/0x17a0 drivers/tty/vt/keyboard.c:1541 input_handler_events_default+0x116/0x1b0 drivers/input/input.c:2549 input_pass_values+0x777/0x8e0 drivers/input/input.c:126 input_event_dispose drivers/input/input.c:352 [inline] input_handle_event+0xb30/0x14d0 drivers/input/input.c:369 input_event drivers/input/input.c:398 [inline] input_event+0x83/0xa0 drivers/input/input.c:390 hidinput_hid_event+0xa12/0x2410 drivers/hid/hid-input.c:1719 hid_process_event+0x4b7/0x5e0 drivers/hid/hid-core.c:1540 hid_input_array_field+0x535/0x710 drivers/hid/hid-core.c:1652 hid_process_report drivers/hid/hid-core.c:1694 [inline] hid_report_raw_event+0xa02/0x11c0 drivers/hid/hid-core.c:2040 __hid_input_report.constprop.0+0x341/0x440 drivers/hid/hid-core.c:2110 hid_irq_in+0x35e/0x870 drivers/hid/usbhid/hid-core.c:285 __usb_hcd_giveback_urb+0x389/0x6e0 drivers/usb/core/hcd.c:1650 usb_hcd_giveback_urb+0x396/0x450 drivers/usb/core/hcd.c:1734 dummy_timer+0x17f0/0x3930 drivers/usb/gadget/udc/dummy_hcd.c:1993 __run_hrtimer kernel/time/hrtimer.c:1691 [inline] __hrtimer_run_queues+0x20a/0xae0 kernel/time/hrtimer.c:1755 hrtimer_run_softirq+0x17d/0x350 kernel/time/hrtimer.c:1772 handle_softirqs+0x206/0x8d0 kernel/softirq.c:554 __do_softirq kernel/softirq.c:588 [inline] invoke_softirq kernel/softirq.c:428 [inline] __irq_exit_rcu kernel/softirq.c:637 [inline] irq_exit_rcu+0xac/0x110 kernel/softirq.c:649 instr_sysvec_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1049 [inline] sysvec_apic_timer_interrupt+0x90/0xb0 arch/x86/kernel/apic/apic.c:1049 asm_sysvec_apic_timer_interrupt+0x1a/0x20 arch/x86/include/asm/idtentry.h:702 RIP: 0010:arch_atomic_read arch/x86/include/asm/atomic.h:23 [inline] RIP: 0010:raw_atomic_read include/linux/atomic/atomic-arch-fallback.h:457 [inline] RIP: 0010:rcu_is_watching_curr_cpu include/linux/context_tracking.h:128 [inline] RIP: 0010:rcu_is_watching+0x71/0xc0 kernel/rcu/tree.c:737 Code: 60 ca 92 88 48 b8 00 00 00 00 00 fc ff df 48 89 da 48 c1 ea 03 0f b6 14 02 48 89 d8 83 e0 07 83 c0 03 38 d0 7c 04 84 d2 75 24 <8b> 03 c1 e8 02 83 e0 01 65 ff 0d 18 86 c7 7e 74 07 5b 5d c3 cc cc RSP: 0018:ffffc9000272fa28 EFLAGS: 00000246 RAX: 0000000000000003 RBX: ffff8881f5837ec8 RCX: ffffffff81bc4a2c RDX: 0000000000000000 RSI: ffffffff8746eb40 RDI: ffffffff8892ca60 RBP: 0000000000000000 R08: 0000000000000005 R09: 0000000000000000 R10: 0000000000000001 R11: 0000000000000000 R12: 0000000000000000 R13: ffffc9000272fdd8 R14: ffffc9000272fc30 R15: 0000000000000000 rcu_read_lock include/linux/rcupdate.h:850 [inline] dput.part.0+0x2de/0x9b0 fs/dcache.c:850 dput+0x1f/0x30 fs/dcache.c:847 path_put fs/namei.c:568 [inline] terminate_walk+0x1a8/0x680 fs/namei.c:692 path_openat+0x1e53/0x2d60 fs/namei.c:3934 do_filp_open+0x1dc/0x430 fs/namei.c:3960 do_sys_openat2+0x17a/0x1e0 fs/open.c:1415 do_sys_open fs/open.c:1430 [inline] __do_sys_openat fs/open.c:1446 [inline] __se_sys_openat fs/open.c:1441 [inline] __x64_sys_openat+0x175/0x210 fs/open.c:1441 do_syscall_x64 arch/x86/entry/common.c:52 [inline] do_syscall_64+0xcd/0x250 arch/x86/entry/common.c:83 entry_SYSCALL_64_after_hwframe+0x77/0x7f RIP: 0033:0x7fec371bd9a4 Code: 24 20 48 8d 44 24 30 48 89 44 24 28 64 8b 04 25 18 00 00 00 85 c0 75 2c 44 89 e2 48 89 ee bf 9c ff ff ff b8 01 01 00 00 0f 05 <48> 3d 00 f0 ff ff 76 60 48 8b 15 55 a4 0d 00 f7 d8 64 89 02 48 83 RSP: 002b:00007ffd1e35f220 EFLAGS: 00000246 ORIG_RAX: 0000000000000101 RAX: ffffffffffffffda RBX: 000055f48a031a50 RCX: 00007fec371bd9a4 RDX: 0000000000080000 RSI: 00007ffd1e35f338 RDI: 00000000ffffff9c RBP: 00007ffd1e35f338 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000080000 R13: 000055f48a031b40 R14: 00007ffd1e35f338 R15: 000055f48a01f1e0 RBP: 00007fefa8ec3860 R08: 0000000000000001 R09: f5414e357c92373e R10: 00007ffc991cfc70 R11: 0000000000000246 R12: 0000000000000000 R13: 0000000000000001 R14: 00007fefa8ec7658 R15: 0000000000000001 task:modprobe state:R running task stack:25136 pid:23919 tgid:23919 ppid:23709 flags:0x00000002 Call Trace: context_switch kernel/sched/core.c:5328 [inline] __schedule+0x105f/0x34b0 kernel/sched/core.c:6690 task:kworker/u8:5 state:I stack:30928 pid:23927 tgid:23927 ppid:2 flags:0x00004000 Call Trace: context_switch kernel/sched/core.c:5328 [inline] __schedule+0x105f/0x34b0 kernel/sched/core.c:6690 __schedule_loop kernel/sched/core.c:6767 [inline] schedule+0xe7/0x350 kernel/sched/core.c:6782 worker_thread+0x2de/0xf00 kernel/workqueue.c:3406 kthread+0x2c1/0x3a0 kernel/kthread.c:389 ret_from_fork+0x45/0x80 arch/x86/kernel/process.c:147 ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:244 Showing all locks held in the system: 2 locks held by getty/2919: #0: ffff8881157a10a0 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x24/0x80 drivers/tty/tty_ldisc.c:243 #1: ffffc900000432f0 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0xfba/0x1480 drivers/tty/n_tty.c:2211 6 locks held by kworker/1:4/15415: #0: ffff8881062f4148 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x129b/0x1ba0 kernel/workqueue.c:3204 #1: ffffc90001adfd80 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x921/0x1ba0 kernel/workqueue.c:3205 #2: ffff88810abf2190 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:1014 [inline] #2: ffff88810abf2190 (&dev->mutex){....}-{3:3}, at: hub_event+0x1be/0x4f40 drivers/usb/core/hub.c:5849 #3: ffff888114346190 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:1014 [inline] ffff888114346190 (&dev->mutex){....}-{3:3}, at: usb_disconnect+0x10a/0x920 drivers/usb/core/hub.c:2295 #4: ffff88811262b160 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:1014 [inline] #4: ffff88811262b160 (&dev->mutex){....}-{3:3}, at: __device_driver_lock drivers/base/dd.c:1095 [inline] #4: ffff88811262b160 (&dev->mutex){....}-{3:3}, at: device_release_driver_internal+0xa4/0x610 drivers/base/dd.c:1293 #5: ffff888127a31a20 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:1014 [inline] #5: ffff888127a31a20 (&dev->mutex){....}-{3:3}, at: __device_driver_lock drivers/base/dd.c:1095 [inline] #5: ffff888127a31a20 (&dev->mutex){....}-{3:3}, at: device_release_driver_internal+0xa4/0x610 drivers/base/dd.c:1293 5 locks held by udevd/17895: #0: ffffffff88ebb140 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire include/linux/rcupdate.h:337 [inline] ffffffff88ebb140 (rcu_read_lock){....}-{1:2}, at: rcu_read_lock include/linux/rcupdate.h:849 [inline] ffffffff88ebb140 (rcu_read_lock){....}-{1:2}, at: dput.part.0+0x46/0x9b0 fs/dcache.c:850 #1: ffff888132cf2230 (&dev->event_lock){..-.}-{2:2}, at: input_event drivers/input/input.c:397 [inline] #1: ffff888132cf2230 (&dev->event_lock){..-.}-{2:2}, at: input_event+0x70/0xa0 drivers/input/input.c:390 #2: ffffffff88ebb140 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire include/linux/rcupdate.h:337 [inline] #2: ffffffff88ebb140 (rcu_read_lock){....}-{1:2}, at: rcu_read_lock include/linux/rcupdate.h:849 [inline] #2: ffffffff88ebb140 (rcu_read_lock){....}-{1:2}, at: input_pass_values+0x8b/0x8e0 drivers/input/input.c:118 #3: ffffffff89387a58 (kbd_event_lock){..-.}-{2:2}, at: spin_lock include/linux/spinlock.h:351 [inline] #3: ffffffff89387a58 (kbd_event_lock){..-.}-{2:2}, at: kbd_event+0x8a/0x17a0 drivers/tty/vt/keyboard.c:1535 #4: ffffffff88ebb140 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire include/linux/rcupdate.h:337 [inline] #4: ffffffff88ebb140 (rcu_read_lock){....}-{1:2}, at: rcu_read_lock include/linux/rcupdate.h:849 [inline] #4: ffffffff88ebb140 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x7f/0x390 kernel/locking/lockdep.c:6720 6 locks held by kworker/1:6/23461: #0: ffff8881062f4148 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x129b/0x1ba0 kernel/workqueue.c:3204 #1: ffffc900044b7d80 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x921/0x1ba0 kernel/workqueue.c:3205 #2: ffff88810af83190 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:1014 [inline] #2: ffff88810af83190 (&dev->mutex){....}-{3:3}, at: hub_event+0x1be/0x4f40 drivers/usb/core/hub.c:5849 #3: ffff88811f184190 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:1014 [inline] #3: ffff88811f184190 (&dev->mutex){....}-{3:3}, at: usb_disconnect+0x10a/0x920 drivers/usb/core/hub.c:2295 #4: ffff8881380c5160 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:1014 [inline] ffff8881380c5160 (&dev->mutex){....}-{3:3}, at: __device_driver_lock drivers/base/dd.c:1095 [inline] ffff8881380c5160 (&dev->mutex){....}-{3:3}, at: device_release_driver_internal+0xa4/0x610 drivers/base/dd.c:1293 #5: ffffffff89bd7768 (input_mutex){+.+.}-{3:3}, at: __input_unregister_device+0x136/0x450 drivers/input/input.c:2272 1 lock held by syz.5.3859/23540: #0: ffffffff88ec6a38 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock+0x1a4/0x3b0 kernel/rcu/tree_exp.h:329 1 lock held by syz.3.3866/23542: #0: ffffffff88ec6a38 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock+0x282/0x3b0 kernel/rcu/tree_exp.h:297 ============================================= keytouch 0003:0926:3333.0249: can't resubmit intr, dummy_hcd.2-1/input0, status -19 keytouch 0003:0926:3333.0249: usb_submit_urb(ctrl) failed: -19