syzbot


INFO: rcu detected stall in usbdev_ioctl (3)

Status: auto-obsoleted due to no activity on 2025/03/23 18:26
Subsystems: kernel
[Documentation on labels]
First crash: 265d, last: 252d
Similar bugs (2)
Kernel Title Rank 🛈 Repro Cause bisect Fix bisect Count Last Reported Patched Status
upstream INFO: rcu detected stall in usbdev_ioctl (2) kernel 1 1 1361d 1361d 0/29 closed as invalid on 2022/02/08 10:10
upstream INFO: rcu detected stall in usbdev_ioctl mm 1 1 2064d 2063d 0/29 closed as invalid on 2020/01/09 08:13

Sample crash report:
rcu: INFO: rcu_preempt detected stalls on CPUs/tasks:
rcu: 	0-...!: (1 GPs behind) idle=e7d4/1/0x4000000000000000 softirq=34421/34422 fqs=20
rcu: 	(detected by 1, t=10502 jiffies, g=30373, q=214 ncpus=2)
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 UID: 0 PID: 10325 Comm: syz.4.1161 Not tainted 6.13.0-rc4-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/13/2024
RIP: 0010:debug_smp_processor_id+0x0/0x20 lib/smp_processor_id.c:59
Code: e8 45 7c 4f f6 e8 d0 81 f4 ff 90 65 ff 0d 50 09 da 74 e9 40 ff ff ff 0f 1f 00 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 <f3> 0f 1e fa 48 c7 c6 a0 ec d1 8b 48 c7 c7 e0 ec d1 8b e9 f9 fe ff
RSP: 0018:ffffc90000007cd0 EFLAGS: 00000003
RAX: 0000000000000001 RBX: 0000000000000000 RCX: ffffffff8175dcac
RDX: fffffbfff20be6d3 RSI: 0000000000000008 RDI: ffffffff905f3690
RBP: 0000000000000000 R08: 0000000000000000 R09: fffffbfff20be6d2
R10: ffffffff905f3697 R11: 0000000000000003 R12: 0000000000000000
R13: 000000000003d90c R14: 0000000000000000 R15: 0000000000000000
FS:  00007f1680d3d6c0(0000) GS:ffff8880b8600000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 000000110c349ee9 CR3: 0000000012dac000 CR4: 00000000003526f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <NMI>
 </NMI>
 <IRQ>
 rcu_is_watching_curr_cpu include/linux/context_tracking.h:128 [inline]
 rcu_is_watching+0x12/0xc0 kernel/rcu/tree.c:737
 trace_lock_acquire+0x14e/0x1f0 include/trace/events/lock.h:24
 lock_acquire+0x2f/0xb0 kernel/locking/lockdep.c:5820
 rcu_lock_acquire include/linux/rcupdate.h:337 [inline]
 rcu_read_lock include/linux/rcupdate.h:849 [inline]
 advance_sched+0x67f/0xc60 net/sched/sch_taprio.c:985
 __run_hrtimer kernel/time/hrtimer.c:1739 [inline]
 __hrtimer_run_queues+0x20a/0xae0 kernel/time/hrtimer.c:1803
 hrtimer_interrupt+0x392/0x8e0 kernel/time/hrtimer.c:1865
 local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1038 [inline]
 __sysvec_apic_timer_interrupt+0x10f/0x400 arch/x86/kernel/apic/apic.c:1055
 instr_sysvec_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1049 [inline]
 sysvec_apic_timer_interrupt+0x9f/0xc0 arch/x86/kernel/apic/apic.c:1049
 </IRQ>
 <TASK>
 asm_sysvec_apic_timer_interrupt+0x1a/0x20 arch/x86/include/asm/idtentry.h:702
RIP: 0010:console_flush_all+0x9a4/0xc60 kernel/printk/printk.c:3211
Code: 00 e8 b0 09 28 00 9c 5b 81 e3 00 02 00 00 31 ff 48 89 de e8 1e 69 20 00 48 85 db 0f 85 55 01 00 00 e8 a0 66 20 00 fb 4c 89 e0 <48> c1 e8 03 42 80 3c 38 00 0f 84 11 ff ff ff 4c 89 e7 e8 55 12 83
RSP: 0018:ffffc9000433f768 EFLAGS: 00000283
RAX: ffffffff8ee937b8 RBX: 0000000000000000 RCX: ffffc9000c1f9000
RDX: 0000000000080000 RSI: ffffffff8179af10 RDI: 0000000000000007
RBP: 0000000000000000 R08: 0000000000000007 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000004 R12: ffffffff8ee937b8
R13: ffffffff8ee93760 R14: ffffc9000433f7f8 R15: dffffc0000000000
 __console_flush_and_unlock kernel/printk/printk.c:3269 [inline]
 console_unlock+0xd9/0x210 kernel/printk/printk.c:3309
 vprintk_emit+0x424/0x6f0 kernel/printk/printk.c:2432
 dev_vprintk_emit drivers/base/core.c:4935 [inline]
 dev_printk_emit+0xfb/0x140 drivers/base/core.c:4946
 __dev_printk+0xf5/0x270 drivers/base/core.c:4958
 _dev_warn+0xe5/0x120 drivers/base/core.c:5002
 proc_setconfig drivers/usb/core/devio.c:1566 [inline]
 usbdev_do_ioctl drivers/usb/core/devio.c:2698 [inline]
 usbdev_ioctl+0x1376/0x4010 drivers/usb/core/devio.c:2827
 vfs_ioctl fs/ioctl.c:51 [inline]
 __do_sys_ioctl fs/ioctl.c:906 [inline]
 __se_sys_ioctl fs/ioctl.c:892 [inline]
 __x64_sys_ioctl+0x190/0x200 fs/ioctl.c:892
 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:0x7f167ff85d29
Code: ff ff c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 40 00 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 c7 c1 a8 ff ff ff f7 d8 64 89 01 48
RSP: 002b:00007f1680d3d038 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 00007f1680175fa0 RCX: 00007f167ff85d29
RDX: 00000000200000c0 RSI: 0000000080045505 RDI: 0000000000000004
RBP: 00007f1680001aa8 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 0000000000000000 R14: 00007f1680175fa0 R15: 00007ffd1385cc88
 </TASK>
rcu: rcu_preempt kthread starved for 10462 jiffies! g30373 f0x0 RCU_GP_WAIT_FQS(5) ->state=0x0 ->cpu=1
rcu: 	Unless rcu_preempt kthread gets sufficient CPU time, OOM is now expected behavior.
rcu: RCU grace-period kthread stack dump:
task:rcu_preempt     state:R  running task     stack:28424 pid:17    tgid:17    ppid:2      flags:0x00004000
Call Trace:
 <TASK>
 context_switch kernel/sched/core.c:5369 [inline]
 __schedule+0xe58/0x5ad0 kernel/sched/core.c:6756
 __schedule_loop kernel/sched/core.c:6833 [inline]
 schedule+0xe7/0x350 kernel/sched/core.c:6848
 schedule_timeout+0x124/0x280 kernel/time/sleep_timeout.c:99
 rcu_gp_fqs_loop+0x1eb/0xb00 kernel/rcu/tree.c:2045
 rcu_gp_kthread+0x271/0x380 kernel/rcu/tree.c:2247
 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>
rcu: Stack dump where RCU GP kthread last ran:
CPU: 1 UID: 0 PID: 253 Comm: kworker/u8:5 Not tainted 6.13.0-rc4-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/13/2024
Workqueue: events_unbound toggle_allocation_gate
RIP: 0010:csd_lock_wait kernel/smp.c:340 [inline]
RIP: 0010:smp_call_function_many_cond+0x45d/0x1300 kernel/smp.c:884
Code: 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 ba 0e 0c 00 f3 90 41 0f b6 04 24 <40> 38 c5 7c 08 84 c0 0f 85 a7 0c 00 00 8b 43 08 31 ff 83 e0 01 41
RSP: 0018:ffffc90002e57998 EFLAGS: 00000293
RAX: 0000000000000000 RBX: ffff8880b86469c0 RCX: ffffffff818e071c
RDX: ffff88802275a440 RSI: ffffffff818e06f6 RDI: 0000000000000005
RBP: 0000000000000003 R08: 0000000000000005 R09: 0000000000000000
R10: 0000000000000001 R11: 0000000000000006 R12: ffffed10170c8d39
R13: 0000000000000001 R14: ffff8880b86469c8 R15: ffff8880b873fe40
FS:  0000000000000000(0000) GS:ffff8880b8700000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f1680d1aff0 CR3: 000000000df7e000 CR4: 00000000003526f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <IRQ>
 </IRQ>
 <TASK>
 on_each_cpu_cond_mask+0x40/0x90 kernel/smp.c:1051
 on_each_cpu include/linux/smp.h:71 [inline]
 text_poke_sync arch/x86/kernel/alternative.c:2114 [inline]
 text_poke_bp_batch+0x22b/0x760 arch/x86/kernel/alternative.c:2324
 text_poke_flush arch/x86/kernel/alternative.c:2515 [inline]
 text_poke_flush arch/x86/kernel/alternative.c:2512 [inline]
 text_poke_finish+0x30/0x40 arch/x86/kernel/alternative.c:2522
 arch_jump_label_transform_apply+0x1c/0x30 arch/x86/kernel/jump_label.c:146
 jump_label_update+0x1d7/0x400 kernel/jump_label.c:920
 static_key_enable_cpuslocked+0x1b7/0x270 kernel/jump_label.c:210
 static_key_enable+0x1a/0x20 kernel/jump_label.c:223
 toggle_allocation_gate mm/kfence/core.c:849 [inline]
 toggle_allocation_gate+0xfc/0x260 mm/kfence/core.c:841
 process_one_work+0x9c5/0x1ba0 kernel/workqueue.c:3229
 process_scheduled_works kernel/workqueue.c:3310 [inline]
 worker_thread+0x6c8/0xf00 kernel/workqueue.c:3391
 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>
watchdog: BUG: soft lockup - CPU#1 stuck for 246s! [kworker/u8:5:253]
Modules linked in:
irq event stamp: 25067836
hardirqs last  enabled at (25067835): [<ffffffff8b29c32b>] irqentry_exit+0x3b/0x90 kernel/entry/common.c:357
hardirqs last disabled at (25067836): [<ffffffff8b29aaae>] sysvec_apic_timer_interrupt+0xe/0xc0 arch/x86/kernel/apic/apic.c:1049
softirqs last  enabled at (25067834): [<ffffffff815c51db>] softirq_handle_end kernel/softirq.c:407 [inline]
softirqs last  enabled at (25067834): [<ffffffff815c51db>] handle_softirqs+0x5bb/0x8f0 kernel/softirq.c:589
softirqs last disabled at (25067821): [<ffffffff815c56a9>] __do_softirq kernel/softirq.c:595 [inline]
softirqs last disabled at (25067821): [<ffffffff815c56a9>] invoke_softirq kernel/softirq.c:435 [inline]
softirqs last disabled at (25067821): [<ffffffff815c56a9>] __irq_exit_rcu+0x109/0x170 kernel/softirq.c:662
CPU: 1 UID: 0 PID: 253 Comm: kworker/u8:5 Not tainted 6.13.0-rc4-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/13/2024
Workqueue: events_unbound toggle_allocation_gate
RIP: 0010:csd_lock_wait kernel/smp.c:340 [inline]
RIP: 0010:smp_call_function_many_cond+0x472/0x1300 kernel/smp.c:884
Code: 83 e5 07 49 01 c4 83 c5 03 e8 ba 0e 0c 00 f3 90 41 0f b6 04 24 40 38 c5 7c 08 84 c0 0f 85 a7 0c 00 00 8b 43 08 31 ff 83 e0 01 <41> 89 c5 89 c6 e8 d4 10 0c 00 45 85 ed 75 d0 e8 8a 0e 0c 00 e8 85
RSP: 0018:ffffc90002e57998 EFLAGS: 00000202
RAX: 0000000000000001 RBX: ffff8880b86469c0 RCX: ffffffff818e071c
RDX: ffff88802275a440 RSI: ffffffff818e06f6 RDI: 0000000000000000
RBP: 0000000000000003 R08: 0000000000000005 R09: 0000000000000000
R10: 0000000000000001 R11: 0000000000000006 R12: ffffed10170c8d39
R13: 0000000000000001 R14: ffff8880b86469c8 R15: ffff8880b873fe40
FS:  0000000000000000(0000) GS:ffff8880b8700000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f1680d1aff0 CR3: 000000000df7e000 CR4: 00000000003526f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <IRQ>
 </IRQ>
 <TASK>
 on_each_cpu_cond_mask+0x40/0x90 kernel/smp.c:1051
 on_each_cpu include/linux/smp.h:71 [inline]
 text_poke_sync arch/x86/kernel/alternative.c:2114 [inline]
 text_poke_bp_batch+0x22b/0x760 arch/x86/kernel/alternative.c:2324
 text_poke_flush arch/x86/kernel/alternative.c:2515 [inline]
 text_poke_flush arch/x86/kernel/alternative.c:2512 [inline]
 text_poke_finish+0x30/0x40 arch/x86/kernel/alternative.c:2522
 arch_jump_label_transform_apply+0x1c/0x30 arch/x86/kernel/jump_label.c:146
 jump_label_update+0x1d7/0x400 kernel/jump_label.c:920
 static_key_enable_cpuslocked+0x1b7/0x270 kernel/jump_label.c:210
 static_key_enable+0x1a/0x20 kernel/jump_label.c:223
 toggle_allocation_gate mm/kfence/core.c:849 [inline]
 toggle_allocation_gate+0xfc/0x260 mm/kfence/core.c:841
 process_one_work+0x9c5/0x1ba0 kernel/workqueue.c:3229
 process_scheduled_works kernel/workqueue.c:3310 [inline]
 worker_thread+0x6c8/0xf00 kernel/workqueue.c:3391
 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>
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 UID: 0 PID: 10325 Comm: syz.4.1161 Not tainted 6.13.0-rc4-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/13/2024
RIP: 0010:rcu_is_watching_curr_cpu include/linux/context_tracking.h:128 [inline]
RIP: 0010:rcu_is_watching+0x3d/0xc0 kernel/rcu/tree.c:737
Code: c7 c3 68 7f 03 00 83 f8 07 89 c5 0f 87 82 00 00 00 48 8d 3c ed e0 6c a7 8d 48 b8 00 00 00 00 00 fc ff df 48 89 fa 48 c1 ea 03 <80> 3c 02 00 75 5c 48 03 1c ed e0 6c a7 8d 48 b8 00 00 00 00 00 fc
RSP: 0018:ffffc90000007e18 EFLAGS: 00000806
RAX: dffffc0000000000 RBX: 0000000000037f68 RCX: ffffffff81874a90
RDX: 1ffffffff1b4ed9c RSI: ffffffff8bd1eca0 RDI: ffffffff8da76ce0
RBP: 0000000000000000 R08: 0000000000000001 R09: 0000000000000000
R10: 0000000000000001 R11: 0000000000000004 R12: ffff8880781ce340
R13: ffff8880b862cb00 R14: ffff8880b862ca00 R15: ffffffff894153a0
FS:  00007f1680d3d6c0(0000) GS:ffff8880b8600000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 000000110c349ee9 CR3: 0000000012dac000 CR4: 00000000003526f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <NMI>
 </NMI>
 <IRQ>
 trace_hrtimer_expire_entry include/trace/events/timer.h:259 [inline]
 __run_hrtimer kernel/time/hrtimer.c:1736 [inline]
 __hrtimer_run_queues+0x80b/0xae0 kernel/time/hrtimer.c:1803
 hrtimer_interrupt+0x392/0x8e0 kernel/time/hrtimer.c:1865
 local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1038 [inline]
 __sysvec_apic_timer_interrupt+0x10f/0x400 arch/x86/kernel/apic/apic.c:1055
 instr_sysvec_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1049 [inline]
 sysvec_apic_timer_interrupt+0x9f/0xc0 arch/x86/kernel/apic/apic.c:1049
 </IRQ>
 <TASK>
 asm_sysvec_apic_timer_interrupt+0x1a/0x20 arch/x86/include/asm/idtentry.h:702
RIP: 0010:console_flush_all+0x9a4/0xc60 kernel/printk/printk.c:3211
Code: 00 e8 b0 09 28 00 9c 5b 81 e3 00 02 00 00 31 ff 48 89 de e8 1e 69 20 00 48 85 db 0f 85 55 01 00 00 e8 a0 66 20 00 fb 4c 89 e0 <48> c1 e8 03 42 80 3c 38 00 0f 84 11 ff ff ff 4c 89 e7 e8 55 12 83
RSP: 0018:ffffc9000433f768 EFLAGS: 00000283
RAX: ffffffff8ee937b8 RBX: 0000000000000000 RCX: ffffc9000c1f9000
RDX: 0000000000080000 RSI: ffffffff8179af10 RDI: 0000000000000007
RBP: 0000000000000000 R08: 0000000000000007 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000004 R12: ffffffff8ee937b8
R13: ffffffff8ee93760 R14: ffffc9000433f7f8 R15: dffffc0000000000
 __console_flush_and_unlock kernel/printk/printk.c:3269 [inline]
 console_unlock+0xd9/0x210 kernel/printk/printk.c:3309
 vprintk_emit+0x424/0x6f0 kernel/printk/printk.c:2432
 dev_vprintk_emit drivers/base/core.c:4935 [inline]
 dev_printk_emit+0xfb/0x140 drivers/base/core.c:4946
 __dev_printk+0xf5/0x270 drivers/base/core.c:4958
 _dev_warn+0xe5/0x120 drivers/base/core.c:5002
 proc_setconfig drivers/usb/core/devio.c:1566 [inline]
 usbdev_do_ioctl drivers/usb/core/devio.c:2698 [inline]
 usbdev_ioctl+0x1376/0x4010 drivers/usb/core/devio.c:2827
 vfs_ioctl fs/ioctl.c:51 [inline]
 __do_sys_ioctl fs/ioctl.c:906 [inline]
 __se_sys_ioctl fs/ioctl.c:892 [inline]
 __x64_sys_ioctl+0x190/0x200 fs/ioctl.c:892
 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:0x7f167ff85d29
Code: ff ff c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 40 00 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 c7 c1 a8 ff ff ff f7 d8 64 89 01 48
RSP: 002b:00007f1680d3d038 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 00007f1680175fa0 RCX: 00007f167ff85d29
RDX: 00000000200000c0 RSI: 0000000080045505 RDI: 0000000000000004
RBP: 00007f1680001aa8 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 0000000000000000 R14: 00007f1680175fa0 R15: 00007ffd1385cc88
 </TASK>

Crashes (2):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2024/12/23 18:21 upstream 4bbf9020becb 444551c4 .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-kasan-gce-selinux-root INFO: rcu detected stall in usbdev_ioctl
2024/12/10 15:12 upstream 7cb1b4663150 cfc402b4 .config console log report info [disk image] [vmlinux] [kernel image] ci-upstream-kasan-gce-smack-root INFO: rcu detected stall in usbdev_ioctl
* Struck through repros no longer work on HEAD.