syzbot


BUG: soft lockup in rcu_read_lock_sched_held

Status: upstream: reported syz repro on 2019/12/29 15:17
Reported-by: syzbot+c810003c6fae676ba836@syzkaller.appspotmail.com
First crash: 1574d, last: 1574d
Fix bisection: failed (error log, bisect log)
  
Last patch testing requests (2)
Created Duration User Patch Repo Result
2022/12/04 19:30 14m retest repro linux-4.14.y report log
2022/08/26 15:27 15m retest repro linux-4.14.y report log

Sample crash report:
IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready
IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready
8021q: adding VLAN 0 to HW filter on device batadv0
watchdog: BUG: soft lockup - CPU#1 stuck for 123s! [syz-executor.3:7182]
Modules linked in:
irq event stamp: 26186815
hardirqs last  enabled at (26186814): [<ffffffff86800979>] restore_regs_and_return_to_kernel+0x0/0x27
hardirqs last disabled at (26186815): [<ffffffff86801b01>] apic_timer_interrupt+0x91/0xa0 arch/x86/entry/entry_64.S:792
softirqs last  enabled at (3632): [<ffffffff86a00645>] __do_softirq+0x645/0x9a0 kernel/softirq.c:314
softirqs last disabled at (5019): [<ffffffff81392c40>] invoke_softirq kernel/softirq.c:368 [inline]
softirqs last disabled at (5019): [<ffffffff81392c40>] irq_exit+0x160/0x1b0 kernel/softirq.c:409
CPU: 1 PID: 7182 Comm: syz-executor.3 Not tainted 4.14.160-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
task: ffff8880996c82c0 task.stack: ffff888095da0000
RIP: 0010:debug_lockdep_rcu_enabled kernel/rcu/update.c:299 [inline]
RIP: 0010:rcu_read_lock_sched_held+0x19/0x130 kernel/rcu/update.c:109
RSP: 0018:ffff8880aed07d38 EFLAGS: 00000206 ORIG_RAX: ffffffffffffff10
RAX: ffffffff88b2490c RBX: 0000000000000001 RCX: ffffffff88b2490c
RDX: dffffc0000000000 RSI: ffff8880996c8b40 RDI: ffff8880996c8b3c
RBP: ffff8880aed07d40 R08: ffff8880996c82c0 R09: ffff8880996c8b60
R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000100
R13: ffff8880aed07dd0 R14: ffff8880aed239c0 R15: 0000000000000001
FS:  000000000202e940(0000) GS:ffff8880aed00000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f0767dda170 CR3: 0000000096cf4000 CR4: 00000000001406e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <IRQ>
 trace_timer_expire_exit include/trace/events/timer.h:121 [inline]
 call_timer_fn+0x537/0x670 kernel/time/timer.c:1280
 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:do_futex+0x92a/0x19e0 kernel/futex.c:3905
RSP: 0018:ffff888095da7c20 EFLAGS: 00000297 ORIG_RAX: ffffffffffffff10
RAX: ffff8880996c82c0 RBX: 0000000000000001 RCX: 1ffff11012bb4f99
RDX: 0000000000000000 RSI: 0000000000000081 RDI: 000000000075bf2c
RBP: ffff888095da7e10 R08: 0000000000000009 R09: 0000000000000000
R10: 1ffff11012bb4ff9 R11: 0000000000000000 R12: 0000000000000000
R13: 0000000000000000 R14: 0000000000000009 R15: ffff888095da7de8
 SYSC_futex kernel/futex.c:3963 [inline]
 SyS_futex+0x215/0x310 kernel/futex.c:3931
 do_syscall_64+0x1e8/0x640 arch/x86/entry/common.c:292
 entry_SYSCALL_64_after_hwframe+0x42/0xb7
RIP: 0033:0x45a919
RSP: 002b:00007fff281f0a88 EFLAGS: 00000246 ORIG_RAX: 00000000000000ca
RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 000000000045a919
RDX: 00000000000f4240 RSI: 0000000000000081 RDI: 000000000075bf2c
RBP: 000000000075bf2c R08: 0000000000000009 R09: ffffffffffffffff
R10: ffffffffffffffff R11: 0000000000000246 R12: 000000000075bf20
R13: 0000000000000003 R14: 0000000000000000 R15: 000000000075bf2c
Code: 0b 48 c7 c7 40 69 f1 87 e8 65 58 3a 00 eb d2 0f 1f 00 48 c7 c0 0c 49 b2 88 55 48 ba 00 00 00 00 00 fc ff df 48 89 c1 48 89 e5 53 <83> e0 07 48 c1 e9 03 83 c0 03 0f b6 14 11 38 d0 7c 08 84 d2 0f 
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 7184 Comm: syz-executor.2 Not tainted 4.14.160-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
task: ffff888095a34340 task.stack: ffff888096a28000
RIP: 0010:memcmp+0x65/0xc0 lib/string.c:861
RSP: 0000:ffff8880aec077a8 EFLAGS: 00000202
RAX: 000000000000005b RBX: ffff8880aec07879 RCX: 0000000000000001
RDX: 0000000000000000 RSI: ffff8880840e5711 RDI: ffff8880aec07850
RBP: ffff8880aec077d0 R08: 000000001199cbff R09: 0000000000000004
R10: 0000000000000000 R11: ffff888095a34340 R12: dffffc0000000000
R13: ffff8880aec078b8 R14: 000000000000000d R15: ffff8880840e56d0
FS:  0000000001b4b940(0000) GS:ffff8880aec00000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 0000001b2df20074 CR3: 0000000093f4f000 CR4: 00000000001406f0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
 <IRQ>
 find_stack lib/stackdepot.c:176 [inline]
 depot_save_stack+0x11c/0x410 lib/stackdepot.c:225
 save_stack+0xa9/0xd0 mm/kasan/kasan.c:453
 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
 kmem_cache_alloc_node_trace+0x153/0x770 mm/slab.c:3661
 __do_kmalloc_node mm/slab.c:3681 [inline]
 __kmalloc_node_track_caller+0x3d/0x80 mm/slab.c:3696
 __kmalloc_reserve.isra.0+0x40/0xe0 net/core/skbuff.c:137
 __alloc_skb+0xcf/0x500 net/core/skbuff.c:205
 alloc_skb include/linux/skbuff.h:980 [inline]
 ndisc_alloc_skb+0x13c/0x340 net/ipv6/ndisc.c:402
 ndisc_send_rs+0x303/0x670 net/ipv6/ndisc.c:661
 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: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:arch_local_irq_restore arch/x86/include/asm/paravirt.h:779 [inline]
RIP: 0010:lock_acquire+0x1ea/0x430 kernel/locking/lockdep.c:3997
RSP: 0000:ffff888096a2f790 EFLAGS: 00000282 ORIG_RAX: ffffffffffffff10
RAX: 1ffffffff0fe2d29 RBX: ffff888095a34340 RCX: 0000000025d630b3
RDX: dffffc0000000000 RSI: ffff888095a34c10 RDI: 0000000000000282
RBP: ffff888096a2f7d8 R08: 000000000000080e R09: ffffffff89563ab0
R10: ffff888095a34c10 R11: ffff888095a34340 R12: ffff888082589740
R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
 __raw_spin_lock include/linux/spinlock_api_smp.h:142 [inline]
 _raw_spin_lock+0x2f/0x40 kernel/locking/spinlock.c:152
 spin_lock include/linux/spinlock.h:317 [inline]
 ext4_do_update_inode fs/ext4/inode.c:5085 [inline]
 ext4_mark_iloc_dirty+0x1ff/0x2900 fs/ext4/inode.c:5728
 ext4_mark_inode_dirty+0x1f0/0x860 fs/ext4/inode.c:5922
 ext4_dirty_inode+0x73/0xa0 fs/ext4/inode.c:5953
 __mark_inode_dirty+0x54c/0x1040 fs/fs-writeback.c:2144
 generic_update_time+0x1b0/0x270 fs/inode.c:1650
 update_time fs/inode.c:1666 [inline]
 file_update_time+0x243/0x360 fs/inode.c:1882
 ext4_page_mkwrite+0x1d0/0x1030 fs/ext4/inode.c:6104
 do_page_mkwrite+0xd9/0x2f0 mm/memory.c:2383
 wp_page_shared mm/memory.c:2675 [inline]
 do_wp_page+0x7d1/0x1250 mm/memory.c:2775
 handle_pte_fault mm/memory.c:4005 [inline]
 __handle_mm_fault+0x1cc3/0x33d0 mm/memory.c:4113
 handle_mm_fault+0x293/0x7c0 mm/memory.c:4150
 __do_page_fault+0x4c1/0xb80 arch/x86/mm/fault.c:1420
 do_page_fault+0x71/0x511 arch/x86/mm/fault.c:1495
 page_fault+0x45/0x50 arch/x86/entry/entry_64.S:1122
RIP: 0033:0x401c27
RSP: 002b:00007ffef66920b0 EFLAGS: 00010287
RAX: 0000001b2df20074 RBX: 0000000000000003 RCX: 0000001b2ef20000
RDX: 0000001b2df20078 RSI: 0000000000000001 RDI: 0000000000000004
RBP: 0000000000000009 R08: 0000000000000009 R09: ffffffffffffffff
R10: ffffffffffffffff R11: 0000000000000246 R12: 000000000075bf20
R13: 0000000000000003 R14: 000000000075bf20 R15: 000000000075bf2c
Code: 89 da 48 c1 e8 03 83 e2 07 42 0f b6 04 20 38 d0 7f 04 84 c0 75 57 48 89 f2 48 89 f1 0f b6 03 48 c1 ea 03 83 e1 07 42 0f b6 14 22 <38> ca 7f 04 84 d2 75 22 0f b6 16 29 d0 74 b5 48 83 c4 10 5b 41 

Crashes (1):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2019/12/29 15:16 linux-4.14.y e1f7d50ae3a3 af6b8ef8 .config console log report syz ci2-linux-4-14
* Struck through repros no longer work on HEAD.