INFO: rcu detected stall in garp_join_timer

[syzbot]

Hello,

syzbot found the following crash on:

HEAD commit: 9a95f252 Linux 4.14.168
git tree: linux-4.14.y
console output: https://syzkaller.appspot.com/x/log.txt?x=177d2bc9e00000
kernel config: https://syzkaller.appspot.com/x/.config?x=95dfa265154d35c3
dashboard link: https://syzkaller.appspot.com/bug?extid=e3431279540f468dc0bc
compiler: gcc (GCC) 9.0.0 20181231 (experimental)

Unfortunately, I don't have any reproducer for this crash yet.

IMPORTANT: if you fix the bug, please add the following tag to the commit:
Reported-by: syzbot+e34312...@syzkaller.appspotmail.com

INFO: rcu_preempt self-detected stall on CPU
1-...: (10500 ticks this GP) idle=022/140000000000002/0 softirq=220189/220189 fqs=18
(t=10500 jiffies g=73031 c=73030 q=3483)
NMI backtrace for cpu 1
CPU: 1 PID: 14686 Comm: syz-executor.3 Not tainted 4.14.168-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:17 [inline]
dump_stack+0x142/0x197 lib/dump_stack.c:58
nmi_cpu_backtrace.cold+0x57/0x94 lib/nmi_backtrace.c:101
nmi_trigger_cpumask_backtrace+0x141/0x189 lib/nmi_backtrace.c:62
arch_trigger_cpumask_backtrace+0x14/0x20 arch/x86/kernel/apic/hw_nmi.c:38
trigger_single_cpu_backtrace include/linux/nmi.h:158 [inline]
rcu_dump_cpu_stacks+0x186/0x1d2 kernel/rcu/tree.c:1396
print_cpu_stall kernel/rcu/tree.c:1542 [inline]
check_cpu_stall kernel/rcu/tree.c:1610 [inline]
__rcu_pending kernel/rcu/tree.c:3390 [inline]
rcu_pending kernel/rcu/tree.c:3452 [inline]
rcu_check_callbacks.cold+0x43d/0xd0a kernel/rcu/tree.c:2792
update_process_times+0x31/0x70 kernel/time/timer.c:1590
tick_sched_handle+0x85/0x160 kernel/time/tick-sched.c:165
tick_sched_timer+0x43/0x130 kernel/time/tick-sched.c:1223
__run_hrtimer kernel/time/hrtimer.c:1223 [inline]
__hrtimer_run_queues+0x270/0xbc0 kernel/time/hrtimer.c:1287
hrtimer_interrupt+0x1d8/0x5d0 kernel/time/hrtimer.c:1321
local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1075 [inline]
smp_apic_timer_interrupt+0x11c/0x5e0 arch/x86/kernel/apic/apic.c:1100
apic_timer_interrupt+0x96/0xa0 arch/x86/entry/entry_64.S:792
RIP: 0010:rb_first+0x2d/0x80 lib/rbtree.c:507
RSP: 0018:ffff8880aed07cd8 EFLAGS: 00000246 ORIG_RAX: ffffffffffffff10
RAX: 0000000000000000 RBX: dffffc0000000000 RCX: 00000000ec89ef84
RDX: 1ffff1100aa96a2e RSI: 0000000000000007 RDI: ffff8880554b5170
RBP: ffff8880aed07ce8 R08: 0000000000002bd8 R09: ffffffff89565740
R10: ffff8881e660ece8 R11: ffff8881e660e440 R12: ffff8880554b5080
R13: 0000000000000007 R14: ffff8880aed239c0 R15: 0000000000000001
garp_gid_event+0x23/0x60 net/802/garp.c:388
garp_join_timer+0x33/0x80 net/802/garp.c:409
call_timer_fn+0x161/0x670 kernel/time/timer.c:1279
expire_timers kernel/time/timer.c:1318 [inline]
__run_timers kernel/time/timer.c:1636 [inline]
__run_timers kernel/time/timer.c:1604 [inline]
run_timer_softirq+0x5b7/0x1520 kernel/time/timer.c:1649
__do_softirq+0x244/0x9a0 kernel/softirq.c:288
invoke_softirq kernel/softirq.c:368 [inline]
irq_exit+0x160/0x1b0 kernel/softirq.c:409
exiting_irq arch/x86/include/asm/apic.h:648 [inline]
smp_apic_timer_interrupt+0x146/0x5e0 arch/x86/kernel/apic/apic.c:1102
apic_timer_interrupt+0x96/0xa0 arch/x86/entry/entry_64.S:792
</IRQ>
RIP: 0010:update_stack_state+0xb/0x590 arch/x86/kernel/unwind_frame.c:208
RSP: 0018:ffff8881dd56f8e8 EFLAGS: 00000246 ORIG_RAX: ffffffffffffff10
RAX: dffffc0000000000 RBX: ffff8881dd56f9b0 RCX: ffff8881dd56f960
RDX: 1ffff1103baadfdd RSI: ffff8881dd56ff48 RDI: ffff8881dd56f9b0
RBP: ffff8881dd56f988 R08: 0000000000000001 R09: ffff8881dd56fa08
R10: ffff8881dd56f9d8 R11: ffff8881dd56f9e8 R12: 1ffff1103baadf24
R13: 0000000000000000 R14: ffff8881dd56fee8 R15: ffff8881dd56ff48
unwind_next_frame+0x3b/0x50 arch/x86/kernel/unwind_frame.c:287
__save_stack_trace+0x6b/0xd0 arch/x86/kernel/stacktrace.c:44
save_stack_trace+0x16/0x20 arch/x86/kernel/stacktrace.c:59
save_stack+0x45/0xd0 mm/kasan/kasan.c:447
set_track mm/kasan/kasan.c:459 [inline]
kasan_kmalloc mm/kasan/kasan.c:551 [inline]
kasan_kmalloc+0xce/0xf0 mm/kasan/kasan.c:529
kasan_slab_alloc+0xf/0x20 mm/kasan/kasan.c:489
slab_post_alloc_hook mm/slab.h:442 [inline]
slab_alloc mm/slab.c:3390 [inline]
kmem_cache_alloc_trace+0x13b/0x790 mm/slab.c:3616
kmalloc include/linux/slab.h:488 [inline]
sock_alloc_inode+0x63/0x260 net/socket.c:254
alloc_inode+0x64/0x180 fs/inode.c:209
new_inode_pseudo+0x19/0xf0 fs/inode.c:898
sock_alloc+0x41/0x280 net/socket.c:569
__sock_create+0x8f/0x620 net/socket.c:1239
sock_create net/socket.c:1315 [inline]
SYSC_socketpair net/socket.c:1387 [inline]
SyS_socketpair+0xf1/0x4d0 net/socket.c:1366
do_syscall_64+0x1e8/0x640 arch/x86/entry/common.c:292
entry_SYSCALL_64_after_hwframe+0x42/0xb7
RIP: 0033:0x45b349
RSP: 002b:00007fb15d193c78 EFLAGS: 00000246 ORIG_RAX: 0000000000000035
RAX: ffffffffffffffda RBX: 00007fb15d1946d4 RCX: 000000000045b349
RDX: 0000000000000000 RSI: 0000000000000000 RDI: 000000000000001e
RBP: 000000000075bf20 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 00000000ffffffff
R13: 0000000000000b63 R14: 00000000004cc464 R15: 000000000075bf2c
INFO: rcu_sched detected stalls on CPUs/tasks:
1-...: (10501 ticks this GP) idle=022/140000000000001/0 softirq=220189/220189 fqs=19
(detected by 0, t=10554 jiffies, g=54435, c=54434, q=8)


---
This bug is generated by a bot. It may contain errors.
See https://goo.gl/tpsmEJ for more information about syzbot.
syzbot engineers can be reached at syzk...@googlegroups.com.

syzbot will keep track of this bug report. See:
https://goo.gl/tpsmEJ#status for how to communicate with syzbot.

[syzbot]

Auto-closing this bug as obsolete.
Crashes did not happen for a while, no reproducer and no activity.