syzbot


INFO: rcu detected stall in br_forward_delay_timer_expired

Status: upstream: reported on 2024/09/30 10:41
Reported-by: syzbot+f5fd20b1939709b78ec6@syzkaller.appspotmail.com
First crash: 54d, last: 54d
Similar bugs (2)
Kernel Title Repro Cause bisect Fix bisect Count Last Reported Patched Status
upstream INFO: rcu detected stall in br_forward_delay_timer_expired net 2 1821d 1821d 0/28 closed as invalid on 2019/11/29 14:24
linux-4.14 BUG: soft lockup in br_forward_delay_timer_expired 1 1014d 1014d 0/1 auto-closed as invalid on 2022/06/13 01:08

Sample crash report:
rcu: INFO: rcu_preempt detected expedited stalls on CPUs/tasks: { 0-.... } 3627 jiffies s: 1661 root: 0x1/.
rcu: blocking rcu_node structures (internal RCU debug):
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 3884 Comm: syz.2.58 Not tainted 6.1.111-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/13/2024
RIP: 0010:hrtimer_interrupt+0x546/0x980 kernel/time/hrtimer.c:1828
Code: 08 42 0f b6 04 30 84 c0 0f 85 c0 01 00 00 41 80 65 4c fd 4c 89 ef 48 8b 74 24 20 e8 44 69 37 09 4c 89 e7 31 f6 e8 ba b4 03 00 <89> c3 31 ff 89 c6 e8 ff dc 10 00 85 db 0f 84 0d 02 00 00 4d 89 fc
RSP: 0018:ffffc90000007688 EFLAGS: 00000006
RAX: 0000000000000000 RBX: ffff8880b8e2a520 RCX: ffff88801c6d5940
RDX: 0000000000010100 RSI: 0000000000000000 RDI: 0000000000000000
RBP: ffff8880b8e2a6a8 R08: ffffffff817cf420 R09: fffffbfff1d33cae
R10: 0000000000000000 R11: dffffc0000000001 R12: 000000188c7135fe
R13: ffff8880b8e2a4c0 R14: dffffc0000000000 R15: ffff8880b8e2a8a8
FS:  00007f2dce5de6c0(0000) GS:ffff8880b8e00000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000000100000000 CR3: 000000002d30b000 CR4: 00000000003506f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000600
Call Trace:
 <NMI>
 </NMI>
 <IRQ>
 local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1095 [inline]
 __sysvec_apic_timer_interrupt+0x156/0x580 arch/x86/kernel/apic/apic.c:1112
 sysvec_apic_timer_interrupt+0x3e/0xb0 arch/x86/kernel/apic/apic.c:1106
 asm_sysvec_apic_timer_interrupt+0x16/0x20 arch/x86/include/asm/idtentry.h:653
RIP: 0010:__raw_spin_unlock_irqrestore include/linux/spinlock_api_smp.h:152 [inline]
RIP: 0010:_raw_spin_unlock_irqrestore+0xd4/0x130 kernel/locking/spinlock.c:194
Code: 9c 8f 44 24 20 42 80 3c 23 00 74 08 4c 89 f7 e8 f2 f1 30 f7 f6 44 24 21 02 75 4e 41 f7 c7 00 02 00 00 74 01 fb bf 01 00 00 00 <e8> c7 37 ad f6 65 8b 05 98 2f 51 75 85 c0 74 3f 48 c7 04 24 0e 36
RSP: 0018:ffffc90000007880 EFLAGS: 00000206
RAX: 8db3e1155c739500 RBX: 1ffff92000000f14 RCX: ffffffff816af0fa
RDX: dffffc0000000000 RSI: ffffffff8b0c0340 RDI: 0000000000000001
RBP: ffffc90000007910 R08: dffffc0000000000 R09: fffffbfff223b85f
R10: 0000000000000000 R11: dffffc0000000001 R12: dffffc0000000000
R13: 1ffff92000000f10 R14: ffffc900000078a0 R15: 0000000000000246
 spin_unlock_irqrestore include/linux/spinlock.h:406 [inline]
 __wake_up_common_lock kernel/sched/wait.c:140 [inline]
 __wake_up+0x128/0x1c0 kernel/sched/wait.c:160
 netlink_unlock_table net/netlink/af_netlink.c:479 [inline]
 netlink_broadcast+0xfe7/0x10b0 net/netlink/af_netlink.c:1525
 nlmsg_multicast include/net/netlink.h:1071 [inline]
 nlmsg_notify+0xfb/0x1c0 net/netlink/af_netlink.c:2550
 br_forward_delay_timer_expired+0x2ce/0x420 net/bridge/br_stp_timer.c:98
 call_timer_fn+0x1ad/0x6b0 kernel/time/timer.c:1504
 expire_timers kernel/time/timer.c:1549 [inline]
 __run_timers+0x67c/0x890 kernel/time/timer.c:1820
 run_timer_softirq+0x63/0xf0 kernel/time/timer.c:1833
 handle_softirqs+0x2ee/0xa40 kernel/softirq.c:571
 __do_softirq kernel/softirq.c:605 [inline]
 invoke_softirq kernel/softirq.c:445 [inline]
 __irq_exit_rcu+0x157/0x240 kernel/softirq.c:654
 irq_exit_rcu+0x5/0x20 kernel/softirq.c:666
 sysvec_apic_timer_interrupt+0x91/0xb0 arch/x86/kernel/apic/apic.c:1106
 </IRQ>
 <TASK>
 asm_sysvec_apic_timer_interrupt+0x16/0x20 arch/x86/include/asm/idtentry.h:653
RIP: 0010:preempt_schedule_irq+0xf2/0x1c0 kernel/sched/core.c:6870
Code: 89 f5 49 c1 ed 03 eb 0d 48 f7 03 08 00 00 00 0f 84 97 00 00 00 bf 01 00 00 00 e8 e9 f2 ae f6 e8 14 ef e1 f6 fb bf 01 00 00 00 <e8> 79 b4 ff ff 43 80 7c 3d 00 00 74 08 4c 89 f7 e8 d9 ae 32 f7 48
RSP: 0018:ffffc90004ff7600 EFLAGS: 00000286
RAX: 8db3e1155c739500 RBX: 1ffff920009feec8 RCX: ffffffff97333103
RDX: dffffc0000000000 RSI: ffffffff8b0c0340 RDI: 0000000000000001
RBP: ffffc90004ff76c0 R08: ffffffff90141000 R09: ffffffff90141008
R10: ffffffff90141018 R11: ffffffff90141010 R12: 1ffff920009feec0
R13: 1ffff920009feec4 R14: ffffc90004ff7620 R15: dffffc0000000000
 irqentry_exit+0x53/0x80 kernel/entry/common.c:439
 asm_sysvec_apic_timer_interrupt+0x16/0x20 arch/x86/include/asm/idtentry.h:653
RIP: 0010:unwind_next_frame+0xa4/0x2220
Code: 00 84 c0 0f 85 05 1b 00 00 8b 03 85 c0 0f 84 c1 10 00 00 89 84 24 9c 00 00 00 48 89 8c 24 a0 00 00 00 4c 89 bc 24 80 00 00 00 <48> 89 6c 24 28 bf 01 00 00 00 e8 bd c0 21 00 48 89 1c 24 48 83 c3
RSP: 0018:ffffc90004ff7780 EFLAGS: 00000202
RAX: 0000000000000001 RBX: ffffc90004ff7860 RCX: ffffc90004ff7d38
RDX: dffffc0000000000 RSI: ffffffff88936186 RDI: ffffc90004ff7860
RBP: 1ffff920009fef0c R08: 0000000000000005 R09: ffffc90004ff7950
R10: 0000000000000000 R11: dffffc0000000001 R12: ffff88801c6d5940
R13: ffffffff81786c50 R14: dffffc0000000000 R15: ffffffff88936186
 arch_stack_walk+0x10d/0x140 arch/x86/kernel/stacktrace.c:25
 stack_trace_save+0x113/0x1c0 kernel/stacktrace.c:122
 kasan_save_stack mm/kasan/common.c:45 [inline]
 kasan_set_track+0x4b/0x70 mm/kasan/common.c:52
 __kasan_slab_alloc+0x65/0x70 mm/kasan/common.c:328
 kasan_slab_alloc include/linux/kasan.h:201 [inline]
 slab_post_alloc_hook+0x52/0x3a0 mm/slab.h:737
 slab_alloc_node mm/slub.c:3398 [inline]
 slab_alloc mm/slub.c:3406 [inline]
 __kmem_cache_alloc_lru mm/slub.c:3413 [inline]
 kmem_cache_alloc+0x10c/0x2d0 mm/slub.c:3422
 sk_prot_alloc+0x58/0x200 net/core/sock.c:2041
 sk_alloc+0x36/0x350 net/core/sock.c:2100
 pn_socket_create+0xfa/0x520 net/phonet/af_phonet.c:87
 __sock_create+0x488/0x910 net/socket.c:1550
 sock_create net/socket.c:1601 [inline]
 __sys_socket_create net/socket.c:1638 [inline]
 __sys_socket+0x136/0x3a0 net/socket.c:1666
 __do_sys_socket net/socket.c:1679 [inline]
 __se_sys_socket net/socket.c:1677 [inline]
 __x64_sys_socket+0x76/0x80 net/socket.c:1677
 do_syscall_x64 arch/x86/entry/common.c:51 [inline]
 do_syscall_64+0x3b/0xb0 arch/x86/entry/common.c:81
 entry_SYSCALL_64_after_hwframe+0x68/0xd2
RIP: 0033:0x7f2dce77dff9
Code: ff ff c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 40 00 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 73 01 c3 48 c7 c1 a8 ff ff ff f7 d8 64 89 01 48
RSP: 002b:00007f2dce5de038 EFLAGS: 00000246 ORIG_RAX: 0000000000000029
RAX: ffffffffffffffda RBX: 00007f2dce936058 RCX: 00007f2dce77dff9
RDX: 0000000000000000 RSI: 0000000000000002 RDI: 0000000000000023
RBP: 00007f2dce7f0296 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 0000000000000000 R14: 00007f2dce936058 R15: 00007fff058e7fc8
 </TASK>

Crashes (1):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2024/09/30 10:40 linux-6.1.y e526b12bf916 ba29ff75 .config console log report info [disk image] [vmlinux] [kernel image] ci2-linux-6-1-kasan-perf INFO: rcu detected stall in br_forward_delay_timer_expired
* Struck through repros no longer work on HEAD.