INFO: rcu detected stall in garp_join_timer (3)

Status: auto-closed as invalid on 2021/05/13 13:34
Reported-by: syzbot+ac3c9e28cc9e7e1c35be@syzkaller.appspotmail.com
First crash: 2028d, last: 2028d
▶ ▼ Similar bugs (8)
Kernel Title Rank 🛈 Repro Cause bisect Fix bisect Count Last Reported Patched Status
linux-5.15 INFO: rcu detected stall in garp_join_timer 1 1 25d 25d 0/3 upstream: reported on 2026/07/10 02:05
linux-4.19 INFO: rcu detected stall in garp_join_timer 1 7 2368d 2400d 0/1 auto-closed as invalid on 2020/06/07 13:30
upstream INFO: rcu detected stall in garp_join_timer (3) net 1 3 759d 829d 0/29 auto-obsoleted due to no activity on 2024/10/03 12:56
linux-4.19 BUG: soft lockup in garp_join_timer 1 19 1372d 1880d 0/1 auto-obsoleted due to no activity on 2023/03/01 00:21
upstream INFO: rcu detected stall in garp_join_timer net 1 1 2440d 2440d 0/29 closed as invalid on 2019/11/29 14:24
upstream INFO: rcu detected stall in garp_join_timer (2) net 1 25 1661d 2361d 0/29 auto-closed as invalid on 2022/05/15 13:33
linux-4.14 INFO: rcu detected stall in garp_join_timer 1 4 2364d 2379d 0/1 auto-closed as invalid on 2020/06/12 11:13
linux-4.19 INFO: rcu detected stall in garp_join_timer (2) 1 1 2235d 2235d 0/1 auto-closed as invalid on 2020/10/18 11:34

Sample crash report:
audit: type=1326 audit(1610544719.569:243): auid=0 uid=0 gid=0 ses=4 subj==unconfined pid=8496 comm="syz-executor.0" exe="/root/syz-executor.0" sig=31 arch=c000003e syscall=228 compat=0 ip=0x46107a code=0xffff0000
rcu: INFO: rcu_preempt self-detected stall on CPU
rcu: 	0-...!: (1 GPs behind) idle=812/1/0x4000000000000004 softirq=193096/193098 fqs=5 
rcu: 	 (t=10501 jiffies g=242485 q=168)
rcu: rcu_preempt kthread starved for 10193 jiffies! g242485 f0x0 RCU_GP_WAIT_FQS(5) ->state=0x0 ->cpu=1
rcu: RCU grace-period kthread stack dump:
rcu_preempt     R  running task    29208    10      2 0x80000000
Call Trace:
 context_switch kernel/sched/core.c:2828 [inline]
 __schedule+0x887/0x2040 kernel/sched/core.c:3517
 schedule+0x8d/0x1b0 kernel/sched/core.c:3561
 schedule_timeout+0x4cf/0xfe0 kernel/time/timer.c:1818
 rcu_gp_kthread+0xdad/0x21c0 kernel/rcu/tree.c:2202
 kthread+0x33f/0x460 kernel/kthread.c:259
 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415
NMI backtrace for cpu 0
CPU: 0 PID: 8485 Comm: syz-executor.3 Not tainted 4.19.167-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Call Trace:
 <IRQ>
 __dump_stack lib/dump_stack.c:77 [inline]
 dump_stack+0x1fc/0x2fe lib/dump_stack.c:118
 nmi_cpu_backtrace.cold+0x63/0xa2 lib/nmi_backtrace.c:101
 nmi_trigger_cpumask_backtrace+0x1a6/0x1eb lib/nmi_backtrace.c:62
 trigger_single_cpu_backtrace include/linux/nmi.h:164 [inline]
 rcu_dump_cpu_stacks+0x15f/0x19c kernel/rcu/tree.c:1340
 print_cpu_stall kernel/rcu/tree.c:1478 [inline]
 check_cpu_stall kernel/rcu/tree.c:1550 [inline]
 __rcu_pending kernel/rcu/tree.c:3293 [inline]
 rcu_pending kernel/rcu/tree.c:3336 [inline]
 rcu_check_callbacks.cold+0x62d/0xe19 kernel/rcu/tree.c:2682
 update_process_times+0x2a/0x70 kernel/time/timer.c:1650
 tick_sched_handle+0x9b/0x180 kernel/time/tick-sched.c:168
 tick_sched_timer+0xfc/0x290 kernel/time/tick-sched.c:1278
 __run_hrtimer kernel/time/hrtimer.c:1401 [inline]
 __hrtimer_run_queues+0x3f6/0xe60 kernel/time/hrtimer.c:1463
 hrtimer_interrupt+0x32a/0x930 kernel/time/hrtimer.c:1521
 local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1067 [inline]
 smp_apic_timer_interrupt+0x10c/0x550 arch/x86/kernel/apic/apic.c:1092
 apic_timer_interrupt+0xf/0x20 arch/x86/entry/entry_64.S:894
RIP: 0010:arch_local_irq_restore arch/x86/include/asm/paravirt.h:789 [inline]
RIP: 0010:__raw_spin_unlock_irqrestore include/linux/spinlock_api_smp.h:160 [inline]
RIP: 0010:_raw_spin_unlock_irqrestore+0xa3/0xe0 kernel/locking/spinlock.c:184
Code: 48 c7 c0 88 81 f1 89 48 ba 00 00 00 00 00 fc ff df 48 c1 e8 03 80 3c 10 00 75 2f 48 83 3d 2c 7a db 01 00 74 15 48 89 df 57 9d <0f> 1f 44 00 00 eb b2 e8 da 3b ea f8 eb c0 0f 0b 0f 0b 48 c7 c7 88
RSP: 0018:ffff8880ba007ca0 EFLAGS: 00000286 ORIG_RAX: ffffffffffffff13
RAX: 1ffffffff13e3031 RBX: 0000000000000286 RCX: 1ffff11012f2f525
RDX: dffffc0000000000 RSI: ffff88809797a908 RDI: 0000000000000286
RBP: ffff888099574f28 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000
R13: ffff888099574f28 R14: 0000000000000000 R15: 0000000000000000
 spin_unlock_irqrestore include/linux/spinlock.h:384 [inline]
 skb_dequeue+0x125/0x180 net/core/skbuff.c:2821
 garp_queue_xmit net/802/garp.c:261 [inline]
 garp_join_timer+0xc3/0xf0 net/802/garp.c:413
 call_timer_fn+0x177/0x700 kernel/time/timer.c:1338
 expire_timers+0x243/0x4e0 kernel/time/timer.c:1375
 __run_timers kernel/time/timer.c:1696 [inline]
 run_timer_softirq+0x21c/0x670 kernel/time/timer.c:1709
 __do_softirq+0x26c/0x9a0 kernel/softirq.c:292
 invoke_softirq kernel/softirq.c:372 [inline]
 irq_exit+0x215/0x260 kernel/softirq.c:412
 exiting_irq arch/x86/include/asm/apic.h:545 [inline]
 smp_apic_timer_interrupt+0x136/0x550 arch/x86/kernel/apic/apic.c:1094
 apic_timer_interrupt+0xf/0x20 arch/x86/entry/entry_64.S:894
 </IRQ>
RIP: 0010:arch_local_irq_restore arch/x86/include/asm/paravirt.h:789 [inline]
RIP: 0010:lock_release+0x429/0x8b0 kernel/locking/lockdep.c:3929
Code: 84 08 00 00 00 00 00 00 48 c1 e8 03 80 3c 10 00 0f 85 95 03 00 00 48 83 3d fb e6 a4 08 00 0f 84 cc 01 00 00 48 8b 3c 24 57 9d <0f> 1f 44 00 00 48 b8 00 00 00 00 00 fc ff df 49 c7 04 04 00 00 00
RSP: 0018:ffff88801f5f7420 EFLAGS: 00000286 ORIG_RAX: ffffffffffffff13
RAX: 1ffffffff13e3031 RBX: ffff88809797a080 RCX: 1ffff11012f2f521
RDX: dffffc0000000000 RSI: 0000000000000001 RDI: 0000000000000286
RBP: 0000000000000000 R08: ffffffff8cd1b380 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000000 R12: 1ffff11003ebee87
R13: 0000000000000000 R14: ffff88809797a080 R15: 0000000000000001
 prepare_alloc_pages mm/page_alloc.c:4342 [inline]
 __alloc_pages_nodemask+0x1bf/0x2890 mm/page_alloc.c:4393
 alloc_pages_current+0x193/0x2a0 mm/mempolicy.c:2197
 alloc_pages include/linux/gfp.h:532 [inline]
 __page_cache_alloc+0x76/0x90 mm/filemap.c:969
 __do_page_cache_readahead+0x1a1/0x6c0 mm/readahead.c:195
 ra_submit mm/internal.h:66 [inline]
 ondemand_readahead.isra.0+0x575/0xd40 mm/readahead.c:493
 page_cache_async_readahead mm/readahead.c:575 [inline]
 page_cache_async_readahead+0x406/0x750 mm/readahead.c:548
 generic_file_buffered_read mm/filemap.c:2123 [inline]
 generic_file_read_iter+0x16ac/0x2b60 mm/filemap.c:2385
 ext4_file_read_iter+0x17b/0x3a0 fs/ext4/file.c:78
 call_read_iter include/linux/fs.h:1815 [inline]
 generic_file_splice_read+0x44a/0x6d0 fs/splice.c:308
 do_splice_to+0x10e/0x160 fs/splice.c:881
 splice_direct_to_actor+0x2b9/0x8d0 fs/splice.c:959
 do_splice_direct+0x1a7/0x270 fs/splice.c:1068
 do_sendfile+0x550/0xc30 fs/read_write.c:1447
 __do_sys_sendfile64 fs/read_write.c:1508 [inline]
 __se_sys_sendfile64+0x147/0x160 fs/read_write.c:1494
 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
 entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x45e219
Code: 0d b4 fb ff c3 66 2e 0f 1f 84 00 00 00 00 00 66 90 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 0f 83 db b3 fb ff c3 66 2e 0f 1f 84 00 00 00 00
RSP: 002b:00007f7573b2fc68 EFLAGS: 00000246 ORIG_RAX: 0000000000000028
RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 000000000045e219
RDX: 0000000000000000 RSI: 0000000000000008 RDI: 0000000000000007
RBP: 000000000119bfc8 R08: 0000000000000000 R09: 0000000000000000
R10: 000080001d00c0d1 R11: 0000000000000246 R12: 000000000119bf8c
R13: 00007fffe5021e7f R14: 00007f7573b309c0 R15: 000000000119bf8c
Left network mode
batman_adv: batadv0: Interface deactivated: batadv_slave_0
batman_adv: batadv0: Removing interface: batadv_slave_0
batman_adv: batadv0: Interface deactivated: batadv_slave_1
batman_adv: batadv0: Removing interface: batadv_slave_1
device bridge_slave_1 left promiscuous mode
bridge0: port 2(bridge_slave_1) entered disabled state
device bridge_slave_0 left promiscuous mode
bridge0: port 1(bridge_slave_0) entered disabled state
device veth1_macvtap left promiscuous mode
device veth0_macvtap left promiscuous mode
device veth1_vlan left promiscuous mode
device veth0_vlan left promiscuous mode
device hsr_slave_1 left promiscuous mode
device hsr_slave_0 left promiscuous mode
team0 (unregistering): Port device team_slave_1 removed
team0 (unregistering): Port device team_slave_0 removed

Crashes (1):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2021/01/13 13:33 linux-4.19.y 675cc038067f a945f0a3 .config console log report info ci2-linux-4-19
* Struck through repros no longer work on HEAD.