INFO: rcu detected stall in mld_dad_timer_expire

9 views
Skip to first unread message

syzbot

unread,
Aug 30, 2020, 8:26:23 PM8/30/20
to syzkaller...@googlegroups.com
Hello,

syzbot found the following issue on:

HEAD commit: f6d5cb9e Linux 4.19.142
git tree: linux-4.19.y
console output: https://syzkaller.appspot.com/x/log.txt?x=157912c1900000
kernel config: https://syzkaller.appspot.com/x/.config?x=30067df04d3254aa
dashboard link: https://syzkaller.appspot.com/bug?extid=940ee26c3891b7531422
compiler: gcc (GCC) 10.1.0-syz 20200507

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

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

NOHZ: local_softirq_pending 08
NOHZ: local_softirq_pending 08
NOHZ: local_softirq_pending 08
NOHZ: local_softirq_pending 08
rcu: INFO: rcu_preempt self-detected stall on CPU
rcu: 0-...!: (10500 ticks this GP) idle=15a/1/0x4000000000000004 softirq=9338/9338 fqs=0
rcu: (t=10500 jiffies g=7125 q=1787)
rcu: rcu_preempt kthread starved for 10500 jiffies! g7125 f0x0 RCU_GP_WAIT_FQS(5) ->state=0x402 ->cpu=0
rcu: RCU grace-period kthread stack dump:
rcu_preempt I29208 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:1825
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: 7904 Comm: syz-executor.2 Not tainted 4.19.142-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/0xb0 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:kfree+0x123/0x210 mm/slab.c:3823
Code: 89 ea 48 89 ee 4c 89 e7 e8 da ee ff ff f6 c7 02 74 ca e8 d0 3f cf ff 48 83 3d 20 b7 32 07 00 0f 84 eb 00 00 00 48 89 df 57 9d <0f> 1f 44 00 00 5b 5d 41 5c 41 5d c3 65 8b 05 ea dc 61 7e 83 f8 3f
RSP: 0018:ffff8880ae606c70 EFLAGS: 00000282 ORIG_RAX: ffffffffffffff13
RAX: 0000000000000007 RBX: 0000000000000282 RCX: 1ffff11012347d67
RDX: 0000000000000000 RSI: ffff888091a3ec08 RDI: 0000000000000282
RBP: ffff88808f567780 R08: 0000000000400000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000000 R12: ffff88812c39c940
R13: ffffffff85b33ece R14: 0000000000000000 R15: ffff88808f567870
skb_free_head net/core/skbuff.c:554 [inline]
skb_release_data+0x6de/0x920 net/core/skbuff.c:574
skb_release_all net/core/skbuff.c:631 [inline]
__kfree_skb net/core/skbuff.c:645 [inline]
kfree_skb+0x11a/0x3d0 net/core/skbuff.c:663
enqueue_to_backlog+0x272/0xe00 net/core/dev.c:4263
netif_rx_internal+0xfd/0x670 net/core/dev.c:4491
loopback_xmit+0x2c7/0x710 drivers/net/loopback.c:95
__netdev_start_xmit include/linux/netdevice.h:4333 [inline]
netdev_start_xmit include/linux/netdevice.h:4347 [inline]
xmit_one net/core/dev.c:3256 [inline]
dev_hard_start_xmit+0x1a8/0x920 net/core/dev.c:3272
__dev_queue_xmit+0x269d/0x2e00 net/core/dev.c:3838
neigh_hh_output include/net/neighbour.h:491 [inline]
neigh_output include/net/neighbour.h:499 [inline]
ip_finish_output2+0xb6d/0x1540 net/ipv4/ip_output.c:229
ip_do_fragment+0xe2f/0x2270 net/ipv4/ip_output.c:814
ip_fragment.constprop.0+0x174/0x240 net/ipv4/ip_output.c:550
ip_finish_output+0x799/0xcd0 net/ipv4/ip_output.c:315
NF_HOOK_COND include/linux/netfilter.h:278 [inline]
ip_output+0x203/0x5f0 net/ipv4/ip_output.c:405
dst_output include/net/dst.h:455 [inline]
ip_local_out+0xaf/0x170 net/ipv4/ip_output.c:124
iptunnel_xmit+0x63b/0x9d0 net/ipv4/ip_tunnel_core.c:91
geneve_xmit_skb drivers/net/geneve.c:857 [inline]
geneve_xmit+0xdcf/0x28b0 drivers/net/geneve.c:929
__netdev_start_xmit include/linux/netdevice.h:4333 [inline]
netdev_start_xmit include/linux/netdevice.h:4347 [inline]
xmit_one net/core/dev.c:3256 [inline]
dev_hard_start_xmit+0x1a8/0x920 net/core/dev.c:3272
__dev_queue_xmit+0x269d/0x2e00 net/core/dev.c:3838
neigh_hh_output include/net/neighbour.h:491 [inline]
neigh_output include/net/neighbour.h:499 [inline]
ip6_finish_output2+0xde7/0x2290 net/ipv6/ip6_output.c:120
ip6_finish_output+0x7eb/0xc10 net/ipv6/ip6_output.c:154
NF_HOOK_COND include/linux/netfilter.h:278 [inline]
ip6_output+0x205/0x770 net/ipv6/ip6_output.c:171
dst_output include/net/dst.h:455 [inline]
NF_HOOK include/linux/netfilter.h:289 [inline]
mld_sendpack+0x674/0x1060 net/ipv6/mcast.c:1684
mld_send_initial_cr.part.0+0x106/0x150 net/ipv6/mcast.c:2101
mld_send_initial_cr net/ipv6/mcast.c:1196 [inline]
mld_dad_timer_expire+0x183/0x5e0 net/ipv6/mcast.c:2120
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:1703 [inline]
run_timer_softirq+0x21c/0x670 kernel/time/timer.c:1716
__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:544 [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:__orc_find+0xb1/0xf0 arch/x86/kernel/unwind_orc.c:56
Code: 39 c1 73 b0 4c 8d 63 fc 49 39 ec 73 b3 4d 29 ee 49 c1 fe 02 4b 8d 04 76 48 8d 04 46 48 83 c4 10 5b 5d 41 5c 41 5d 41 5e 41 5f <c3> 48 83 c4 10 31 c0 5b 5d 41 5c 41 5d 41 5e 41 5f c3 48 89 f0 eb
RSP: 0018:ffff8880471ce298 EFLAGS: 00000282 ORIG_RAX: ffffffffffffff13
RAX: ffffffff8a6627d2 RBX: 1ffff11008e39c5c RCX: ffffffff85be6baf
RDX: 0000000000000000 RSI: ffffffff8a6627cc RDI: ffffffff89f53be8
RBP: 0000000000000001 R08: ffffffff8a6627de R09: ffffffff8a6627cc
R10: 0000000000066061 R11: 00000000000f4be6 R12: ffff8880471ce3d0
R13: ffff8880471ce3bd R14: ffff8880471ce3c0 R15: ffff8880471ce388
orc_find arch/x86/kernel/unwind_orc.c:159 [inline]
unwind_next_frame+0x33b/0x1c60 arch/x86/kernel/unwind_orc.c:429
__save_stack_trace+0x9f/0x190 arch/x86/kernel/stacktrace.c:44
save_stack mm/kasan/kasan.c:448 [inline]
set_track mm/kasan/kasan.c:460 [inline]
kasan_kmalloc+0xeb/0x160 mm/kasan/kasan.c:553
kmem_cache_alloc_node_trace+0x151/0x3b0 mm/slab.c:3668
__do_kmalloc_node mm/slab.c:3688 [inline]
__kmalloc_node_track_caller+0x38/0x70 mm/slab.c:3703
__kmalloc_reserve net/core/skbuff.c:137 [inline]
__alloc_skb+0xae/0x560 net/core/skbuff.c:205
alloc_skb include/linux/skbuff.h:995 [inline]
nlmsg_new include/net/netlink.h:511 [inline]
rtmsg_fib+0x1fb/0x4e0 net/ipv4/fib_semantics.c:415
fib_table_delete+0x77c/0xfb0 net/ipv4/fib_trie.c:1599
fib_magic+0x361/0x540 net/ipv4/fib_frontend.c:892
fib_del_ifaddr+0xd36/0xfd0 net/ipv4/fib_frontend.c:1092
fib_inetaddr_event+0xb4/0x29b net/ipv4/fib_frontend.c:1232
notifier_call_chain+0xc0/0x230 kernel/notifier.c:93
__blocking_notifier_call_chain kernel/notifier.c:317 [inline]
__blocking_notifier_call_chain kernel/notifier.c:304 [inline]
blocking_notifier_call_chain kernel/notifier.c:328 [inline]
blocking_notifier_call_chain+0x85/0xa0 kernel/notifier.c:325
__inet_del_ifa+0x534/0xba0 net/ipv4/devinet.c:416
inet_del_ifa net/ipv4/devinet.c:446 [inline]
inetdev_destroy net/ipv4/devinet.c:311 [inline]
inetdev_event+0x5cb/0x1230 net/ipv4/devinet.c:1545
notifier_call_chain+0xc0/0x230 kernel/notifier.c:93
call_netdevice_notifiers_mtu net/core/dev.c:1785 [inline]
dev_set_mtu_ext+0x384/0x580 net/core/dev.c:7810
do_setlink+0x484/0x3540 net/core/rtnetlink.c:2412
rtnl_group_changelink net/core/rtnetlink.c:2925 [inline]
rtnl_newlink+0xbc0/0x15b0 net/core/rtnetlink.c:3083
rtnetlink_rcv_msg+0x453/0xb80 net/core/rtnetlink.c:4778
netlink_rcv_skb+0x160/0x440 net/netlink/af_netlink.c:2455
netlink_unicast_kernel net/netlink/af_netlink.c:1318 [inline]
netlink_unicast+0x4d5/0x690 net/netlink/af_netlink.c:1344
netlink_sendmsg+0x6bb/0xc40 net/netlink/af_netlink.c:1909
sock_sendmsg_nosec net/socket.c:622 [inline]
sock_sendmsg+0xc3/0x120 net/socket.c:632
___sys_sendmsg+0x7bb/0x8e0 net/socket.c:2115
__sys_sendmsg net/socket.c:2153 [inline]
__do_sys_sendmsg net/socket.c:2162 [inline]
__se_sys_sendmsg net/socket.c:2160 [inline]
__x64_sys_sendmsg+0x132/0x220 net/socket.c:2160
do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293
entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x45d5b9
Code: 5d 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 2b b4 fb ff c3 66 2e 0f 1f 84 00 00 00 00
RSP: 002b:00007f2d91c88c78 EFLAGS: 00000246 ORIG_RAX: 000000000000002e
RAX: ffffffffffffffda RBX: 000000000002ce80 RCX: 000000000045d5b9
RDX: 0000000000000000 RSI: 0000000020000140 RDI: 0000000000000004
RBP: 000000000118cf80 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 000000000118cf4c
R13: 00007ffe5e3913ff R14: 00007f2d91c899c0 R15: 000000000118cf4c
rcu: INFO: rcu_preempt detected expedited stalls on CPUs/tasks: { 0-... } 10675 jiffies s: 333 root: 0x1/.
rcu: blocking rcu_node structures:
Task dump for CPU 0:
syz-executor.2 R running task 22312 7904 6494 0x8000000e
Call Trace:


---
This report 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 issue. See:
https://goo.gl/tpsmEJ#status for how to communicate with syzbot.

syzbot

unread,
Dec 28, 2020, 7:26:12 PM12/28/20
to syzkaller...@googlegroups.com
Auto-closing this bug as obsolete.
Crashes did not happen for a while, no reproducer and no activity.
Reply all
Reply to author
Forward
0 new messages