syzbot


INFO: rcu detected stall in do_idle

Status: auto-closed as invalid on 2020/01/14 08:59
Reported-by: syzbot+6d831f7bbded28b257f8@syzkaller.appspotmail.com
First crash: 1031d, last: 1025d
similar bugs (5):
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
android-414 INFO: rcu detected stall in do_idle 1 1392d 1392d 0/1 auto-closed as invalid on 2019/03/13 10:31
linux-4.19 INFO: rcu detected stall in do_idle (2) 2 72d 72d 0/1 upstream: reported on 2022/04/26 06:47
linux-4.19 INFO: rcu detected stall in do_idle 1 930d 930d 0/1 auto-closed as invalid on 2020/04/18 00:25
upstream INFO: rcu detected stall in do_idle C done error 1587 4d17h 1363d 0/22 upstream: reported C repro on 2018/10/13 07:31
linux-4.14 INFO: rcu detected stall in do_idle (2) C 4 11d 76d 0/1 upstream: reported C repro on 2022/04/22 10:09

Sample crash report:
audit: type=1800 audit(1568624180.591:98): pid=15998 uid=0 auid=4294967295 ses=4294967295 subj=unconfined_u:system_r:insmod_t:s0-s0:c0.c1023 op="collect_data" cause="failed(directio)" comm="syz-executor.3" name="file0" dev="sda1" ino=16899 res=0
INFO: rcu_sched detected stalls on CPUs/tasks:
	0-...: (1 GPs behind) idle=2ae/1/0 softirq=36921/36926 fqs=1773 
	(detected by 1, t=10502 jiffies, g=7596, c=7595, q=31)
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 0 Comm: swapper/0 Not tainted 4.14.144 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
task: ffffffff87676240 task.stack: ffffffff87600000
RIP: 0010:__sanitizer_cov_trace_pc+0x28/0x60 kernel/kcov.c:68
RSP: 0018:ffff8880aee070a8 EFLAGS: 00000206
RAX: ffffffff87676240 RBX: ffff88808ca10f78 RCX: 0000000000000000
RDX: 0000000000000100 RSI: ffff88808ca11010 RDI: ffff88808ca11018
RBP: ffff8880aee07100 R08: 0000000000000000 R09: ffffffff87676bf8
R10: ffffffff87676bd8 R11: ffffffff87676240 R12: dffffc0000000000
R13: ffff88808ca10d80 R14: ffff88808ca11010 R15: ffff88808ca11000
FS:  0000000000000000(0000) GS:ffff8880aee00000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00000000007e5d08 CR3: 00000000826df000 CR4: 00000000001406f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <IRQ>
 dequeue_skb net/sched/sch_generic.c:148 [inline]
 qdisc_restart net/sched/sch_generic.c:241 [inline]
 __qdisc_run+0x2b8/0xe00 net/sched/sch_generic.c:257
 __dev_xmit_skb net/core/dev.c:3235 [inline]
 __dev_queue_xmit+0x1571/0x25e0 net/core/dev.c:3493
 dev_queue_xmit+0x18/0x20 net/core/dev.c:3558
 br_dev_queue_push_xmit+0x367/0x530 net/bridge/br_forward.c:55
 NF_HOOK include/linux/netfilter.h:250 [inline]
 NF_HOOK include/linux/netfilter.h:244 [inline]
 br_forward_finish+0xbc/0x320 net/bridge/br_forward.c:67
 NF_HOOK include/linux/netfilter.h:250 [inline]
 NF_HOOK include/linux/netfilter.h:244 [inline]
 __br_forward+0x560/0x9c0 net/bridge/br_forward.c:111
 deliver_clone+0x61/0xc0 net/bridge/br_forward.c:127
 maybe_deliver net/bridge/br_forward.c:168 [inline]
 maybe_deliver net/bridge/br_forward.c:156 [inline]
 br_flood+0x3c8/0x530 net/bridge/br_forward.c:210
 br_dev_xmit+0x9a4/0xd40 net/bridge/br_device.c:83
 __netdev_start_xmit include/linux/netdevice.h:4033 [inline]
 netdev_start_xmit include/linux/netdevice.h:4042 [inline]
 xmit_one net/core/dev.c:3009 [inline]
 dev_hard_start_xmit+0x18c/0x8b0 net/core/dev.c:3025
 __dev_queue_xmit+0x1d95/0x25e0 net/core/dev.c:3525
 dev_queue_xmit+0x18/0x20 net/core/dev.c:3558
 neigh_resolve_output net/core/neighbour.c:1364 [inline]
 neigh_resolve_output+0x4d8/0x870 net/core/neighbour.c:1344
 neigh_output include/net/neighbour.h:500 [inline]
 ip6_finish_output2+0x9ab/0x21b0 net/ipv6/ip6_output.c:120
 ip6_finish_output+0x4f4/0xb50 net/ipv6/ip6_output.c:154
 NF_HOOK_COND include/linux/netfilter.h:239 [inline]
 ip6_output+0x20f/0x6d0 net/ipv6/ip6_output.c:171
 dst_output include/net/dst.h:462 [inline]
 NF_HOOK include/linux/netfilter.h:250 [inline]
 ndisc_send_skb+0xb56/0x11e0 net/ipv6/ndisc.c:483
 ndisc_send_rs+0x129/0x680 net/ipv6/ndisc.c:677
 addrconf_rs_timer+0x289/0x5a0 net/ipv6/addrconf.c:3757
 call_timer_fn+0x161/0x670 kernel/time/timer.c:1279
 expire_timers kernel/time/timer.c:1318 [inline]
 __run_timers kernel/time/timer.c:1634 [inline]
 __run_timers kernel/time/timer.c:1602 [inline]
 run_timer_softirq+0x5b4/0x1570 kernel/time/timer.c:1647
 __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:native_safe_halt+0xe/0x10 arch/x86/include/asm/irqflags.h:61
RSP: 0018:ffffffff87607de8 EFLAGS: 00000286 ORIG_RAX: ffffffffffffff10
RAX: 1ffffffff0ee2a84 RBX: ffffffff87676240 RCX: 0000000000000000
RDX: dffffc0000000000 RSI: 0000000000000001 RDI: ffffffff87676abc
RBP: ffffffff87607e10 R08: 1ffffffff104a601 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000000 R12: ffffffff87715410
R13: 0000000000000000 R14: 0000000000000000 R15: ffffffff87676240
 arch_cpu_idle+0xa/0x10 arch/x86/kernel/process.c:557
 default_idle_call+0x36/0x90 kernel/sched/idle.c:98
 cpuidle_idle_call kernel/sched/idle.c:156 [inline]
 do_idle+0x262/0x3d0 kernel/sched/idle.c:246
 cpu_startup_entry+0x1b/0x20 kernel/sched/idle.c:351
 rest_init+0x1d9/0x1e2 init/main.c:435
 start_kernel+0x6df/0x6fd init/main.c:709
 x86_64_start_reservations+0x29/0x2b arch/x86/kernel/head64.c:381
 x86_64_start_kernel+0x77/0x7b arch/x86/kernel/head64.c:362
 secondary_startup_64+0xa5/0xb0 arch/x86/kernel/head_64.S:240
Code: ec ff ff 65 48 8b 04 25 40 ee 01 00 48 85 c0 74 1a 65 8b 15 cb 0a a5 7e 81 e2 00 01 1f 00 75 0b 8b 90 c8 12 00 00 83 fa 01 74 01 <c3> 55 48 89 e5 48 8b 75 08 48 8b 88 d0 12 00 00 8b 80 cc 12 00 
rcu_sched kthread starved for 6949 jiffies! g7596 c7595 f0x0 RCU_GP_WAIT_FQS(3) ->state=0x402 ->cpu=1
rcu_sched       I29776     9      2 0x80000000
Call Trace:
 context_switch kernel/sched/core.c:2807 [inline]
 __schedule+0x7b8/0x1cd0 kernel/sched/core.c:3383
 schedule+0x92/0x1c0 kernel/sched/core.c:3427
 schedule_timeout+0x43e/0xe10 kernel/time/timer.c:1744
 rcu_gp_kthread+0xbf4/0x1ec0 kernel/rcu/tree.c:2255
 kthread+0x319/0x430 kernel/kthread.c:232
 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404
INFO: rcu_preempt detected stalls on CPUs/tasks:
	0-...: (1 GPs behind) idle=2ae/1/0 softirq=36925/36926 fqs=1764 
	(detected by 1, t=10550 jiffies, g=9621, c=9620, q=1690)
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 0 Comm: swapper/0 Not tainted 4.14.144 #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
task: ffffffff87676240 task.stack: ffffffff87600000
RIP: 0010:hhf_dequeue+0x548/0xa60 net/sched/sch_hhf.c:437
RSP: 0018:ffff8880aee070b0 EFLAGS: 00000206
RAX: 0000000000000000 RBX: ffff88808ca10f78 RCX: 0000000000000000
RDX: 0000000000000100 RSI: ffff88808ca11010 RDI: ffff88808ca10f94
RBP: ffff8880aee07100 R08: 0000000000000000 R09: ffffffff87676bf8
R10: ffffffff87676bd8 R11: ffffffff87676240 R12: dffffc0000000000
R13: ffff88808ca10d80 R14: 0000000000000002 R15: ffff88808ca11000
FS:  0000000000000000(0000) GS:ffff8880aee00000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00000000007e5d08 CR3: 00000000826df000 CR4: 00000000001406f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <IRQ>
 dequeue_skb net/sched/sch_generic.c:148 [inline]
 qdisc_restart net/sched/sch_generic.c:241 [inline]
 __qdisc_run+0x2b8/0xe00 net/sched/sch_generic.c:257
 __dev_xmit_skb net/core/dev.c:3235 [inline]
 __dev_queue_xmit+0x1571/0x25e0 net/core/dev.c:3493
 dev_queue_xmit+0x18/0x20 net/core/dev.c:3558
 br_dev_queue_push_xmit+0x367/0x530 net/bridge/br_forward.c:55
 NF_HOOK include/linux/netfilter.h:250 [inline]
 NF_HOOK include/linux/netfilter.h:244 [inline]
 br_forward_finish+0xbc/0x320 net/bridge/br_forward.c:67
 NF_HOOK include/linux/netfilter.h:250 [inline]
 NF_HOOK include/linux/netfilter.h:244 [inline]
 __br_forward+0x560/0x9c0 net/bridge/br_forward.c:111
 deliver_clone+0x61/0xc0 net/bridge/br_forward.c:127
 maybe_deliver net/bridge/br_forward.c:168 [inline]
 maybe_deliver net/bridge/br_forward.c:156 [inline]
 br_flood+0x3c8/0x530 net/bridge/br_forward.c:210
 br_dev_xmit+0x9a4/0xd40 net/bridge/br_device.c:83
 __netdev_start_xmit include/linux/netdevice.h:4033 [inline]
 netdev_start_xmit include/linux/netdevice.h:4042 [inline]
 xmit_one net/core/dev.c:3009 [inline]
 dev_hard_start_xmit+0x18c/0x8b0 net/core/dev.c:3025
 __dev_queue_xmit+0x1d95/0x25e0 net/core/dev.c:3525
 dev_queue_xmit+0x18/0x20 net/core/dev.c:3558
 neigh_resolve_output net/core/neighbour.c:1364 [inline]
 neigh_resolve_output+0x4d8/0x870 net/core/neighbour.c:1344
 neigh_output include/net/neighbour.h:500 [inline]
 ip6_finish_output2+0x9ab/0x21b0 net/ipv6/ip6_output.c:120
 ip6_finish_output+0x4f4/0xb50 net/ipv6/ip6_output.c:154
 NF_HOOK_COND include/linux/netfilter.h:239 [inline]
 ip6_output+0x20f/0x6d0 net/ipv6/ip6_output.c:171
 dst_output include/net/dst.h:462 [inline]
 NF_HOOK include/linux/netfilter.h:250 [inline]
 ndisc_send_skb+0xb56/0x11e0 net/ipv6/ndisc.c:483
 ndisc_send_rs+0x129/0x680 net/ipv6/ndisc.c:677
 addrconf_rs_timer+0x289/0x5a0 net/ipv6/addrconf.c:3757
 call_timer_fn+0x161/0x670 kernel/time/timer.c:1279
 expire_timers kernel/time/timer.c:1318 [inline]
 __run_timers kernel/time/timer.c:1634 [inline]
 __run_timers kernel/time/timer.c:1602 [inline]
 run_timer_softirq+0x5b4/0x1570 kernel/time/timer.c:1647
 __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:native_safe_halt+0xe/0x10 arch/x86/include/asm/irqflags.h:61
RSP: 0018:ffffffff87607de8 EFLAGS: 00000286 ORIG_RAX: ffffffffffffff10
RAX: 1ffffffff0ee2a84 RBX: ffffffff87676240 RCX: 0000000000000000
RDX: dffffc0000000000 RSI: 0000000000000001 RDI: ffffffff87676abc
RBP: ffffffff87607e10 R08: 1ffffffff104a601 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000000 R12: ffffffff87715410
R13: 0000000000000000 R14: 0000000000000000 R15: ffffffff87676240
 arch_cpu_idle+0xa/0x10 arch/x86/kernel/process.c:557
 default_idle_call+0x36/0x90 kernel/sched/idle.c:98
 cpuidle_idle_call kernel/sched/idle.c:156 [inline]
 do_idle+0x262/0x3d0 kernel/sched/idle.c:246
 cpu_startup_entry+0x1b/0x20 kernel/sched/idle.c:351
 rest_init+0x1d9/0x1e2 init/main.c:435
 start_kernel+0x6df/0x6fd init/main.c:709
 x86_64_start_reservations+0x29/0x2b arch/x86/kernel/head64.c:381
 x86_64_start_kernel+0x77/0x7b arch/x86/kernel/head64.c:362
 secondary_startup_64+0xa5/0xb0 arch/x86/kernel/head_64.S:240
Code: 83 e2 07 83 c2 03 38 ca 7c 08 84 c9 0f 85 d1 03 00 00 45 8b b5 ac 02 00 00 89 45 b8 e8 12 4d 6d fc 49 8d bd 14 02 00 00 8b 45 b8 <48> 89 fa 48 c1 ea 03 42 0f b6 0c 22 48 89 fa 83 e2 07 83 c2 03 
rcu_preempt kthread starved for 7014 jiffies! g9621 c9620 f0x0 RCU_GP_WAIT_FQS(3) ->state=0x402 ->cpu=1
rcu_preempt     I29520     8      2 0x80000000
Call Trace:
 context_switch kernel/sched/core.c:2807 [inline]
 __schedule+0x7b8/0x1cd0 kernel/sched/core.c:3383
 schedule+0x92/0x1c0 kernel/sched/core.c:3427
 schedule_timeout+0x43e/0xe10 kernel/time/timer.c:1744
 rcu_gp_kthread+0xbf4/0x1ec0 kernel/rcu/tree.c:2255
 kthread+0x319/0x430 kernel/kthread.c:232
 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404

Crashes (4):
Manager Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Title
ci2-linux-4-14 2019/09/16 08:58 linux-4.14.y 968722f5371a 55c50e70 .config log report
ci2-linux-4-14 2019/09/13 02:13 linux-4.14.y e2cd24b62938 40fa42bc .config log report
ci2-linux-4-14 2019/09/12 08:49 linux-4.14.y e2cd24b62938 0b7672ee .config log report
ci2-linux-4-14 2019/09/10 08:26 linux-4.14.y 414510bc00a5 a60cb4cd .config log report