rcu: INFO: rcu_preempt detected expedited stalls on CPUs/tasks: { 1-...D } 2652 jiffies s: 103405 root: 0x2/. rcu: blocking rcu_node structures (internal RCU debug): Sending NMI from CPU 0 to CPUs 1: wait_for_common kernel/sched/completion.c:127 [inline] wait_for_completion_state+0x1c/0x40 kernel/sched/completion.c:264 call_usermodehelper_exec+0x3c4/0x4d0 kernel/umh.c:442 NMI backtrace for cpu 1 CPU: 1 UID: 0 PID: 16864 Comm: modprobe Not tainted 6.12.0-rc3-syzkaller-00051-g07b887f8236e #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/13/2024 RIP: 0010:io_serial_out+0x8f/0xb0 drivers/tty/serial/8250/8250_port.c:413 Code: 48 8d 7d 40 44 89 e1 48 b8 00 00 00 00 00 fc ff df 48 89 fa d3 e3 48 c1 ea 03 80 3c 02 00 75 1c 66 03 5d 40 44 89 e8 89 da ee <5b> 5d 41 5c 41 5d c3 cc cc cc cc e8 b1 ef 0d ff eb a0 e8 3a f0 0d RSP: 0018:ffffc900001b7f60 EFLAGS: 00000002 RAX: 0000000000000030 RBX: 00000000000003f8 RCX: 0000000000000000 RDX: 00000000000003f8 RSI: ffffffff82a06b75 RDI: ffffffff93635660 RBP: ffffffff93635620 R08: 0000000000000001 R09: 000000000000001f R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000 R13: 0000000000000030 R14: ffffffff82a06b10 R15: 0000000000000000 FS: 0000000000000000(0000) GS:ffff8881f5900000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007f6432e1d440 CR3: 0000000008ca0000 CR4: 00000000003506f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: serial_out drivers/tty/serial/8250/8250.h:142 [inline] serial8250_console_fifo_write drivers/tty/serial/8250/8250_port.c:3322 [inline] serial8250_console_write+0xf9e/0x17c0 drivers/tty/serial/8250/8250_port.c:3393 console_emit_next_record kernel/printk/printk.c:3092 [inline] console_flush_all+0x800/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 printk_stack_address arch/x86/kernel/dumpstack.c:72 [inline] show_trace_log_lvl+0x21f/0x3d0 arch/x86/kernel/dumpstack.c:285 sched_show_task kernel/sched/core.c:7589 [inline] sched_show_task+0x3f0/0x5f0 kernel/sched/core.c:7564 show_state_filter+0xee/0x320 kernel/sched/core.c:7634 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+0x17c3/0x38d0 drivers/usb/gadget/udc/dummy_hcd.c:1988 __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:1037 [inline] sysvec_apic_timer_interrupt+0x90/0xb0 arch/x86/kernel/apic/apic.c:1037 asm_sysvec_apic_timer_interrupt+0x1a/0x20 arch/x86/include/asm/idtentry.h:702 RIP: 0010:csd_lock_wait kernel/smp.c:340 [inline] RIP: 0010:smp_call_function_many_cond+0x458/0x1300 kernel/smp.c:884 Code: 0b 00 85 ed 74 4d 48 b8 00 00 00 00 00 fc ff df 4d 89 f4 4c 89 f5 49 c1 ec 03 83 e5 07 49 01 c4 83 c5 03 e8 4a ea 0b 00 f3 90 <41> 0f b6 04 24 40 38 c5 7c 08 84 c0 0f 85 a4 0c 00 00 8b 43 08 31 RSP: 0018:ffffc9000433fab0 EFLAGS: 00000293 RAX: 0000000000000000 RBX: ffff8881f5844900 RCX: ffffffff8149f4fc RDX: ffff88813b2657c0 RSI: ffffffff8149f4d6 RDI: 0000000000000005 RBP: 0000000000000003 R08: 0000000000000005 R09: 0000000000000000 R10: 0000000000000001 R11: 0000000000000000 R12: ffffed103eb08921 R13: 0000000000000001 R14: ffff8881f5844908 R15: ffff8881f593e7c0 on_each_cpu_cond_mask+0x40/0x90 kernel/smp.c:1051 __flush_tlb_multi arch/x86/include/asm/paravirt.h:91 [inline] flush_tlb_multi arch/x86/mm/tlb.c:938 [inline] flush_tlb_mm_range+0x289/0x330 arch/x86/mm/tlb.c:1024 tlb_flush arch/x86/include/asm/tlb.h:20 [inline] tlb_flush_mmu_tlbonly include/asm-generic/tlb.h:465 [inline] tlb_flush_mmu_tlbonly include/asm-generic/tlb.h:455 [inline] tlb_flush_mmu mm/mmu_gather.c:372 [inline] tlb_finish_mmu+0x3c9/0x7b0 mm/mmu_gather.c:465 exit_mmap+0x3df/0xb30 mm/mmap.c:1877 __mmput kernel/fork.c:1347 [inline] mmput+0xdb/0x3e0 kernel/fork.c:1369 exit_mm kernel/exit.c:571 [inline] do_exit+0x9bf/0x2ce0 kernel/exit.c:926 do_group_exit+0xd3/0x2a0 kernel/exit.c:1088 __do_sys_exit_group kernel/exit.c:1099 [inline] __se_sys_exit_group kernel/exit.c:1097 [inline] __x64_sys_exit_group+0x3e/0x50 kernel/exit.c:1097 x64_sys_call+0x14a9/0x16a0 arch/x86/include/generated/asm/syscalls_64.h:232 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:0x7f6432edba90 Code: Unable to access opcode bytes at 0x7f6432edba66. RSP: 002b:00007ffd2bde2358 EFLAGS: 00000246 ORIG_RAX: 00000000000000e7 RAX: ffffffffffffffda RBX: 00007f6432fcc860 RCX: 00007f6432edba90 RDX: 00000000000000e7 RSI: 000000000000003c RDI: 0000000000000001 RBP: 00007f6432fcc860 R08: 0000000000000001 R09: e7e96efd675d4c6b R10: 00007ffd2bde2210 R11: 0000000000000246 R12: 0000000000000000 R13: 0000000000000001 R14: 00007f6432fd0658 R15: 0000000000000001 call_modprobe kernel/module/kmod.c:103 [inline] __request_module+0x3f6/0x6c0 kernel/module/kmod.c:173 dev_load+0x1ff/0x240 net/core/dev_ioctl.c:645 dev_ioctl+0x473/0x10c0 net/core/dev_ioctl.c:709 sock_do_ioctl+0x19e/0x280 net/socket.c:1241 task:kworker/u8:4 state:I stack:30928 pid:16991 tgid:16991 ppid:2 flags:0x00004000 Call Trace: context_switch kernel/sched/core.c:5322 [inline] __schedule+0x105f/0x34b0 kernel/sched/core.c:6682 __schedule_loop kernel/sched/core.c:6759 [inline] schedule+0xe7/0x350 kernel/sched/core.c:6774 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 task:kworker/u8:2 state:R running task stack:32568 pid:17165 tgid:17165 ppid:10232 flags:0x00004000 Call Trace: __switch_to_asm+0x70/0x70 Showing all locks held in the system: 3 locks held by kworker/0:1/9: 2 locks held by getty/2609: #0: ffff88810f7320a0 (&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/0:3/4921: #0: ffff888105adf548 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x129b/0x1ba0 kernel/workqueue.c:3204 #1: ffffc9000243fd80 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work+0x921/0x1ba0 kernel/workqueue.c:3205 #2: ffff888109b65190 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:1014 [inline] #2: ffff888109b65190 (&dev->mutex){....}-{3:3}, at: hub_event+0x1be/0x4f40 drivers/usb/core/hub.c:5849 #3: ffff888123208190 (&dev->mutex){....}-{3:3} , at: device_lock include/linux/device.h:1014 [inline] , at: usb_disconnect+0x10a/0x920 drivers/usb/core/hub.c:2295 #4: ffff8881215a9160 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:1014 [inline] #4: ffff8881215a9160 (&dev->mutex){....}-{3:3}, at: __device_driver_lock drivers/base/dd.c:1095 [inline] #4: ffff8881215a9160 (&dev->mutex){....}-{3:3}, at: device_release_driver_internal+0xa4/0x610 drivers/base/dd.c:1293 #5: ffff888138e7da20 (&dev->mutex){....}-{3:3}, at: device_lock include/linux/device.h:1014 [inline] #5: ffff888138e7da20 (&dev->mutex){....}-{3:3}, at: __device_driver_lock drivers/base/dd.c:1095 [inline] #5: ffff888138e7da20 (&dev->mutex){....}-{3:3}, at: device_release_driver_internal+0xa4/0x610 drivers/base/dd.c:1293 2 locks held by kworker/u8:2/10232: #0: ffff888100089148 ((wq_completion)events_unbound){+.+.}-{0:0}, at: process_one_work+0x129b/0x1ba0 kernel/workqueue.c:3204 #1: ffff8881f583d858 (&cfs_rq->removed.lock){-.-.}-{2:2} , at: update_cfs_rq_load_avg kernel/sched/fair.c:4677 [inline] , at: update_load_avg+0xe2f/0x1f80 kernel/sched/fair.c:4836 2 locks held by kworker/0:0/14229: 3 locks held by kworker/0:5/24847: 2 locks held by kworker/u8:1/26342: #0: ffff888100089148 ((wq_completion)events_unbound){+.+.}-{0:0}, at: process_one_work+0x129b/0x1ba0 kernel/workqueue.c:3204 #1: ffffc900058dfd80 ((work_completion)(&sub_info->work) ){+.+.}-{0:0}, at: process_one_work+0x921/0x1ba0 kernel/workqueue.c:3205 6 locks held by kworker/1:3/30635: #0: ffff888105adf548 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work+0x129b/0x1ba0 kernel/workqueue.c:3204 #1: ffffc90001bc7d80 ((work_completion)(&hub->events)){+.+.}-{0:0} , at: process_one_work+0x921/0x1ba0 kernel/workqueue.c:3205 #2: ffff888109b33190 (&dev->mutex){....}-{3:3} , at: device_lock include/linux/device.h:1014 [inline] , at: hub_event+0x1be/0x4f40 drivers/usb/core/hub.c:5849 #3: ffff888109b36508 (&port_dev->status_lock){+.+.}-{3:3}, at: usb_lock_port drivers/usb/core/hub.c:3206 [inline] #3: ffff888109b36508 (&port_dev->status_lock){+.+.}-{3:3}, at: hub_port_connect drivers/usb/core/hub.c:5418 [inline] #3: ffff888109b36508 (&port_dev->status_lock){+.+.}-{3:3}, at: hub_port_connect_change drivers/usb/core/hub.c:5661 [inline] #3: ffff888109b36508 (&port_dev->status_lock){+.+.}-{3:3}, at: port_event drivers/usb/core/hub.c:5821 [inline] #3: ffff888109b36508 (&port_dev->status_lock){+.+.}-{3:3}, at: hub_event+0x28aa/0x4f40 drivers/usb/core/hub.c:5903 #4: ffff88810933fc68 (hcd->address0_mutex){+.+.}-{3:3} , at: hub_port_connect drivers/usb/core/hub.c:5419 [inline] , at: hub_port_connect_change drivers/usb/core/hub.c:5661 [inline] , at: port_event drivers/usb/core/hub.c:5821 [inline] , at: hub_event+0x28d0/0x4f40 drivers/usb/core/hub.c:5903 #5: ffffffff899cc810 (ehci_cf_port_reset_rwsem){.+.+}-{3:3}, at: hub_port_reset+0x1a7/0x1e60 drivers/usb/core/hub.c:3021 2 locks held by kworker/0:6/2330: 1 lock held by syz.2.6882/16799: #0: ffffffff88ec69f8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock+0x282/0x3b0 kernel/rcu/tree_exp.h:297 1 lock held by syz.3.6885/16827: #0: ffffffff88ec69f8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock+0x1a4/0x3b0 kernel/rcu/tree_exp.h:329 5 locks held by modprobe/16864: #0: ffff88811c6b4b98 (&mm->mmap_lock){++++}-{3:3}, at: mmap_write_lock include/linux/mmap_lock.h:106 [inline] (&mm->mmap_lock){++++}-{3:3}, at: exit_mmap+0x208/0xb30 mm/mmap.c:1872 #1: ffff88812c717230 ( &dev->event_lock){..-.}-{2:2}, at: input_event drivers/input/input.c:397 [inline] &dev->event_lock){..-.}-{2:2}, at: input_event+0x70/0xa0 drivers/input/input.c:390 #2: ffffffff88ebb100 (rcu_read_lock){....}-{1:2} , at: rcu_lock_acquire include/linux/rcupdate.h:337 [inline] , at: rcu_read_lock include/linux/rcupdate.h:849 [inline] , at: input_pass_values+0x8b/0x8e0 drivers/input/input.c:118 #3: ffffffff893879d8 (kbd_event_lock){..-.}-{2:2}, at: spin_lock include/linux/spinlock.h:351 [inline] #3: ffffffff893879d8 (kbd_event_lock){..-.}-{2:2}, at: kbd_event+0x8a/0x17a0 drivers/tty/vt/keyboard.c:1535 #4: ffffffff88ebb100 (rcu_read_lock){....}-{1:2} , 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+0x7f/0x390 kernel/locking/lockdep.c:6720 3 locks held by syz-executor/16868: #0: ffff88811c6b2698 (&mm->mmap_lock){++++}-{3:3}, at: mmap_write_lock_killable include/linux/mmap_lock.h:122 [inline] (&mm->mmap_lock){++++}-{3:3}, at: vm_mmap_pgoff+0x160/0x350 mm/util.c:586 #1: ffff888113e843f8 (sb_writers#5){.+.+}-{0:0}, at: file_accessed include/linux/fs.h:2528 [inline] #1: ffff888113e843f8 (sb_writers#5){.+.+}-{0:0}, at: ext4_file_mmap+0x1c8/0x240 fs/ext4/file.c:797 #2: ffff888113f10958 (jbd2_handle){++++}-{0:0} , at: start_this_handle+0xf6c/0x1430 fs/jbd2/transaction.c:448 3 locks held by syz-executor/16887: #0: ffff888126bd8198 (&mm->mmap_lock){++++}-{3:3} , at: mmap_write_lock_killable include/linux/mmap_lock.h:122 [inline] , at: vm_mmap_pgoff+0x160/0x350 mm/util.c:586 #1: ffff888113e843f8 (sb_writers#5){.+.+}-{0:0} , at: file_accessed include/linux/fs.h:2528 [inline] , at: ext4_file_mmap+0x1c8/0x240 fs/ext4/file.c:797 #2: ffff888113f10958 (jbd2_handle){++++}-{0:0} , at: start_this_handle+0xf6c/0x1430 fs/jbd2/transaction.c:448 ============================================= keytouch 0003:0926:3333.03A8: can't resubmit intr, dummy_hcd.4-1/input0, status -19