syzbot


INFO: rcu detected stall in bcm_release

Status: auto-obsoleted due to no activity on 2022/09/12 21:23
Reported-by: syzbot+134211789a81bb26e963@syzkaller.appspotmail.com
First crash: 655d, last: 655d

Sample crash report:
GRED: Unable to relocate VQ 0x0 after dequeue, screwing up backlog
GRED: Unable to relocate VQ 0x0 after dequeue, screwing up backlog
GRED: Unable to relocate VQ 0x0 after dequeue, screwing up backlog
INFO: rcu_preempt detected stalls on CPUs/tasks:
	(detected by 0, t=10502 jiffies, g=1789, c=1788, q=895)
All QSes seen, last rcu_preempt kthread activity 10502 (4294961108-4294950606), jiffies_till_next_fqs=1, root ->qsmask 0x0
syz-executor.2  R  running task    28560  9930   7986 0x80000002
Call Trace:
 <IRQ>
 sched_show_task.cold+0x333/0x39a kernel/sched/core.c:5168
 print_other_cpu_stall kernel/rcu/tree.c:1501 [inline]
 check_cpu_stall kernel/rcu/tree.c:1616 [inline]
 __rcu_pending kernel/rcu/tree.c:3390 [inline]
 rcu_pending kernel/rcu/tree.c:3452 [inline]
 rcu_check_callbacks.cold+0xd29/0xd8d kernel/rcu/tree.c:2792
 update_process_times+0x29/0x60 kernel/time/timer.c:1591
 tick_sched_handle+0x7d/0x150 kernel/time/tick-sched.c:165
 tick_sched_timer+0x92/0x200 kernel/time/tick-sched.c:1223
 __run_hrtimer kernel/time/hrtimer.c:1223 [inline]
 __hrtimer_run_queues+0x30b/0xc80 kernel/time/hrtimer.c:1287
 hrtimer_interrupt+0x1e6/0x5e0 kernel/time/hrtimer.c:1321
 local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1079 [inline]
 smp_apic_timer_interrupt+0x117/0x5e0 arch/x86/kernel/apic/apic.c:1104
 apic_timer_interrupt+0x93/0xa0 arch/x86/entry/entry_64.S:793
 </IRQ>
RIP: 0010:__raw_spin_unlock_irq include/linux/spinlock_api_smp.h:169 [inline]
RIP: 0010:_raw_spin_unlock_irq+0x50/0x80 kernel/locking/spinlock.c:200
RSP: 0018:ffff88808d2afaa8 EFLAGS: 00000282 ORIG_RAX: ffffffffffffff10
RAX: 1ffffffff11e1313 RBX: dffffc0000000000 RCX: 1ffff1101244c97a
RDX: dffffc0000000000 RSI: ffff888092264bb0 RDI: ffff888092264b84
RBP: ffff8880ba434380 R08: ffff8880ba434be0 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000000 R12: ffff888092264300
R13: ffff8880ba434380 R14: ffffffff8789ba80 R15: ffff888092264300
 rq_unlock_irq kernel/sched/sched.h:1766 [inline]
 __schedule+0x1450/0x1de0 kernel/sched/core.c:3390
 schedule+0x8d/0x1b0 kernel/sched/core.c:3431
 sys_sched_yield+0x11a/0x1a0 kernel/sched/core.c:4836
 yield+0x94/0xc0 kernel/sched/core.c:4920
 tasklet_kill+0x3f/0xc0 kernel/softirq.c:583
 bcm_remove_op+0x74/0x250 net/can/bcm.c:766
 bcm_release+0x255/0x900 net/can/bcm.c:1571
 __sock_release+0xcd/0x2b0 net/socket.c:602
 sock_close+0x15/0x20 net/socket.c:1139
 __fput+0x25f/0x7a0 fs/file_table.c:210
 task_work_run+0x11f/0x190 kernel/task_work.c:113
 exit_task_work include/linux/task_work.h:22 [inline]
 do_exit+0xa44/0x2850 kernel/exit.c:868
 SYSC_exit kernel/exit.c:934 [inline]
 SyS_exit+0x1e/0x20 kernel/exit.c:932
 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292
 entry_SYSCALL_64_after_hwframe+0x46/0xbb
RIP: 0033:0x7fe0c28340e9
RSP: 002b:00007fe0c11a9118 EFLAGS: 00000246 ORIG_RAX: 000000000000003c
RAX: ffffffffffffffda RBX: 00007fe0c2946f60 RCX: 00007fe0c28340e9
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000
RBP: 00007fe0c288e08d R08: 0000000020003a40 R09: 0000000020003a40
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffc9825a75f R14: 00007fe0c11a9300 R15: 0000000000022000
rcu_preempt kthread starved for 10502 jiffies! g1789 c1788 f0x2 RCU_GP_WAIT_FQS(3) ->state=0x0 ->cpu=0
rcu_preempt     R  running task    30008     8      2 0x80000000
Call Trace:
 context_switch kernel/sched/core.c:2811 [inline]
 __schedule+0x88b/0x1de0 kernel/sched/core.c:3387
 schedule+0x8d/0x1b0 kernel/sched/core.c:3431
 schedule_timeout+0x4af/0xe90 kernel/time/timer.c:1747
 rcu_gp_kthread+0xc0a/0x1e60 kernel/rcu/tree.c:2255
 kthread+0x30d/0x420 kernel/kthread.c:232
 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404
INFO: rcu_sched detected stalls on CPUs/tasks:
	(detected by 0, t=10541 jiffies, g=816, c=815, q=4)
All QSes seen, last rcu_sched kthread activity 10541 (4294961148-4294950607), jiffies_till_next_fqs=1, root ->qsmask 0x0
syz-executor.2  R  running task    28560  9930   7986 0x80000002
Call Trace:
 <IRQ>
 sched_show_task.cold+0x333/0x39a kernel/sched/core.c:5168
 print_other_cpu_stall kernel/rcu/tree.c:1501 [inline]
 check_cpu_stall kernel/rcu/tree.c:1616 [inline]
 __rcu_pending kernel/rcu/tree.c:3390 [inline]
 rcu_pending kernel/rcu/tree.c:3452 [inline]
 rcu_check_callbacks.cold+0xd29/0xd8d kernel/rcu/tree.c:2792
 update_process_times+0x29/0x60 kernel/time/timer.c:1591
 tick_sched_handle+0x7d/0x150 kernel/time/tick-sched.c:165
 tick_sched_timer+0x92/0x200 kernel/time/tick-sched.c:1223
 __run_hrtimer kernel/time/hrtimer.c:1223 [inline]
 __hrtimer_run_queues+0x30b/0xc80 kernel/time/hrtimer.c:1287
 hrtimer_interrupt+0x1e6/0x5e0 kernel/time/hrtimer.c:1321
 local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1079 [inline]
 smp_apic_timer_interrupt+0x117/0x5e0 arch/x86/kernel/apic/apic.c:1104
 apic_timer_interrupt+0x93/0xa0 arch/x86/entry/entry_64.S:793
 </IRQ>
RIP: 0010:__raw_spin_unlock_irq include/linux/spinlock_api_smp.h:169 [inline]
RIP: 0010:_raw_spin_unlock_irq+0x50/0x80 kernel/locking/spinlock.c:200
RSP: 0018:ffff88808d2afaa8 EFLAGS: 00000282 ORIG_RAX: ffffffffffffff10
RAX: 1ffffffff11e1313 RBX: dffffc0000000000 RCX: 1ffff1101244c97a
RDX: dffffc0000000000 RSI: ffff888092264bb0 RDI: ffff888092264b84
RBP: ffff8880ba434380 R08: ffff8880ba434be0 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000000 R12: ffff888092264300
R13: ffff8880ba434380 R14: ffffffff8789ba80 R15: ffff888092264300
 rq_unlock_irq kernel/sched/sched.h:1766 [inline]
 __schedule+0x1450/0x1de0 kernel/sched/core.c:3390
 schedule+0x8d/0x1b0 kernel/sched/core.c:3431
 sys_sched_yield+0x11a/0x1a0 kernel/sched/core.c:4836
 yield+0x94/0xc0 kernel/sched/core.c:4920
 tasklet_kill+0x3f/0xc0 kernel/softirq.c:583
 bcm_remove_op+0x74/0x250 net/can/bcm.c:766
 bcm_release+0x255/0x900 net/can/bcm.c:1571
 __sock_release+0xcd/0x2b0 net/socket.c:602
 sock_close+0x15/0x20 net/socket.c:1139
 __fput+0x25f/0x7a0 fs/file_table.c:210
 task_work_run+0x11f/0x190 kernel/task_work.c:113
 exit_task_work include/linux/task_work.h:22 [inline]
 do_exit+0xa44/0x2850 kernel/exit.c:868
 SYSC_exit kernel/exit.c:934 [inline]
 SyS_exit+0x1e/0x20 kernel/exit.c:932
 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292
 entry_SYSCALL_64_after_hwframe+0x46/0xbb
RIP: 0033:0x7fe0c28340e9
RSP: 002b:00007fe0c11a9118 EFLAGS: 00000246 ORIG_RAX: 000000000000003c
RAX: ffffffffffffffda RBX: 00007fe0c2946f60 RCX: 00007fe0c28340e9
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000
RBP: 00007fe0c288e08d R08: 0000000020003a40 R09: 0000000020003a40
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffc9825a75f R14: 00007fe0c11a9300 R15: 0000000000022000
rcu_sched kthread starved for 10541 jiffies! g816 c815 f0x2 RCU_GP_WAIT_FQS(3) ->state=0x0 ->cpu=0
rcu_sched       R  running task    30008     9      2 0x80000000
Call Trace:
 context_switch kernel/sched/core.c:2811 [inline]
 __schedule+0x88b/0x1de0 kernel/sched/core.c:3387
 schedule+0x8d/0x1b0 kernel/sched/core.c:3431
 schedule_timeout+0x4af/0xe90 kernel/time/timer.c:1747
 rcu_gp_kthread+0xc0a/0x1e60 kernel/rcu/tree.c:2255
 kthread+0x30d/0x420 kernel/kthread.c:232
 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404

Crashes (1):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2022/05/15 21:22 linux-4.14.y 690285a9380d 744a39e2 .config console log report info ci2-linux-4-14 INFO: rcu detected stall in bcm_release
* Struck through repros no longer work on HEAD.