WARNING: kernel stack regs at (ptrval) in syzkaller has bad 'bp' value (ptrval)

Status: fixed on 2018/07/09 18:05
Subsystems: kernel
[Documentation on labels]
Reported-by: syzbot+e073e4740cfbb3ae200b@syzkaller.appspotmail.com
Fix commit: f044a84e040b crypto: don't optimize keccakf()
First crash: 3047d, last: 3046d
▶ ▼ Duplicate bugs (3)
Title Rank 🛈 Repro Cause bisect Fix bisect Count Last Reported Patched Status
WARNING: kernel stack regs has bad value -1 syz, C 1765 2983d 3045d 0/29 closed as dup on 2018/04/25 07:30
WARNING: kernel stack regs at (ptrval) in syz-executor has bad 'bp' value (ptrval) kernel -1 5 3046d 3047d 0/29 closed as dup on 2018/04/24 15:37
WARNING: kernel stack frame pointer at (ptrval) in syzkaller has bad value (ptrval) -1 syz, C 1 3047d 3047d 0/29 closed as dup on 2018/04/24 15:40
▶ ▼ Discussions (2)
Title Replies (including bot) Last reply
[PATCH 4.17 00/67] 4.17.7-stable review 74 (74) 2018/07/17 09:41
WARNING: kernel stack regs at (ptrval) in syzkaller has bad 'bp' value (ptrval) 1 (2) 2018/04/23 10:59

Sample crash report:
        (ptrval): 000000000043fe79 (0x43fe79)
        (ptrval): 0000000000000033 (0x33)
        (ptrval): 0000000000000213 (0x213)
        (ptrval): 00007ffe76e4b4c8 (0x7ffe76e4b4c8)
        (ptrval): 000000000000002b (0x2b)
WARNING: kernel stack regs at         (ptrval) in syzkaller272337:4548 has bad 'bp' value         (ptrval)
WARNING: kernel stack frame pointer at         (ptrval) in syzkaller272337:4548 has bad value         (ptrval)

================================
WARNING: inconsistent lock state
4.17.0-rc2+ #14 Not tainted
--------------------------------
inconsistent {HARDIRQ-ON-W} -> {IN-HARDIRQ-W} usage.
swapper/1/0 [HC1[1]:SC0[0]:HE0:SE1] takes:
        (ptrval) (fs_reclaim){?.+.}, at: fs_reclaim_acquire.part.82+0x0/0x30 mm/page_alloc.c:463
{HARDIRQ-ON-W} state was registered at:
  lock_acquire+0x1dc/0x520 kernel/locking/lockdep.c:3920
  fs_reclaim_acquire.part.82+0x24/0x30 mm/page_alloc.c:3739
  fs_reclaim_acquire+0x14/0x20 mm/page_alloc.c:3740
  slab_pre_alloc_hook mm/slab.h:418 [inline]
  slab_alloc_node mm/slab.c:3299 [inline]
  kmem_cache_alloc_node_trace+0x39/0x770 mm/slab.c:3661
  kmalloc_node include/linux/slab.h:550 [inline]
  kzalloc_node include/linux/slab.h:712 [inline]
  alloc_worker+0xbd/0x2e0 kernel/workqueue.c:1704
  init_rescuer.part.25+0x1f/0x190 kernel/workqueue.c:4000
  init_rescuer kernel/workqueue.c:3997 [inline]
  workqueue_init+0x51f/0x7d0 kernel/workqueue.c:5732
  kernel_init_freeable+0x2ad/0x58e init/main.c:1115
  kernel_init+0x11/0x1b3 init/main.c:1053
  ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:412
irq event stamp: 314258
hardirqs last  enabled at (314255): [<ffffffff876e9d1d>] default_idle+0x8d/0x440 arch/x86/kernel/process.c:354
hardirqs last disabled at (314256): [<ffffffff87800905>] interrupt_entry+0xb5/0xf0 arch/x86/entry/entry_64.S:625
softirqs last  enabled at (314258): [<ffffffff81471abc>] _local_bh_enable+0x1c/0x30 kernel/softirq.c:155
softirqs last disabled at (314257): [<ffffffff81474e40>] irq_enter+0xa0/0xd0 kernel/softirq.c:351

other info that might help us debug this:
 Possible unsafe locking scenario:

       CPU0
       ----
  lock(fs_reclaim);
  <Interrupt>
    lock(fs_reclaim);

 *** DEADLOCK ***

no locks held by swapper/1/0.

stack backtrace:
CPU: 1 PID: 0 Comm: swapper/1 Not tainted 4.17.0-rc2+ #14
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+0x1b9/0x294 lib/dump_stack.c:113
 print_usage_bug.cold.59+0x320/0x41a kernel/locking/lockdep.c:2542
 valid_state kernel/locking/lockdep.c:2555 [inline]
 mark_lock_irq kernel/locking/lockdep.c:2749 [inline]
 mark_lock+0x1034/0x19e0 kernel/locking/lockdep.c:3147
 mark_irqflags kernel/locking/lockdep.c:3022 [inline]
 __lock_acquire+0x1595/0x5140 kernel/locking/lockdep.c:3388
 lock_acquire+0x1dc/0x520 kernel/locking/lockdep.c:3920
 fs_reclaim_acquire.part.82+0x24/0x30 mm/page_alloc.c:3739
 fs_reclaim_acquire+0x14/0x20 mm/page_alloc.c:3740
 slab_pre_alloc_hook mm/slab.h:418 [inline]
 slab_alloc mm/slab.c:3378 [inline]
 __do_kmalloc mm/slab.c:3716 [inline]
 __kmalloc+0x45/0x760 mm/slab.c:3727
 kmalloc_array include/linux/slab.h:631 [inline]
 kcalloc include/linux/slab.h:642 [inline]
 numa_crng_init drivers/char/random.c:798 [inline]
 crng_reseed+0x427/0x920 drivers/char/random.c:923
 credit_entropy_bits+0x98d/0xa30 drivers/char/random.c:708
 add_interrupt_randomness+0x494/0x860 drivers/char/random.c:1254
 handle_irq_event_percpu+0xf9/0x1c0 kernel/irq/handle.c:191
 handle_irq_event+0xa7/0x135 kernel/irq/handle.c:206
 handle_edge_irq+0x20f/0x870 kernel/irq/chip.c:791
 generic_handle_irq_desc include/linux/irqdesc.h:159 [inline]
 handle_irq+0x18c/0x2e7 arch/x86/kernel/irq_64.c:77
 do_IRQ+0x78/0x190 arch/x86/kernel/irq.c:245
 common_interrupt+0xf/0xf arch/x86/entry/entry_64.S:642
 </IRQ>
RIP: 0010:native_safe_halt+0x6/0x10 arch/x86/include/asm/irqflags.h:54
RSP: 0018:ffff8801d9ae7c38 EFLAGS: 00000286 ORIG_RAX: ffffffffffffffd5
RAX: dffffc0000000000 RBX: 1ffff1003b35cf8a RCX: 0000000000000000
RDX: 1ffffffff11a3160 RSI: 0000000000000001 RDI: ffffffff88d18b00
RBP: ffff8801d9ae7c38 R08: ffffed003b5e46c3 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000001
R13: ffff8801d9ae7cf0 R14: ffffffff897beda0 R15: 0000000000000000
 arch_safe_halt arch/x86/include/asm/paravirt.h:94 [inline]
 default_idle+0xc2/0x440 arch/x86/kernel/process.c:354
 arch_cpu_idle+0x10/0x20 arch/x86/kernel/process.c:345
 default_idle_call+0x6d/0x90 kernel/sched/idle.c:93
 cpuidle_idle_call kernel/sched/idle.c:153 [inline]
 do_idle+0x395/0x560 kernel/sched/idle.c:262
 cpu_startup_entry+0x104/0x120 kernel/sched/idle.c:368
 start_secondary+0x426/0x5b0 arch/x86/kernel/smpboot.c:269
 secondary_startup_64+0xa5/0xb0 arch/x86/kernel/head_64.S:242
BUG: sleeping function called from invalid context at mm/slab.h:421
in_atomic(): 1, irqs_disabled(): 1, pid: 0, name: swapper/1
INFO: lockdep is turned off.
irq event stamp: 314258
hardirqs last  enabled at (314255): [<ffffffff876e9d1d>] default_idle+0x8d/0x440 arch/x86/kernel/process.c:354
hardirqs last disabled at (314256): [<ffffffff87800905>] interrupt_entry+0xb5/0xf0 arch/x86/entry/entry_64.S:625
softirqs last  enabled at (314258): [<ffffffff81471abc>] _local_bh_enable+0x1c/0x30 kernel/softirq.c:155
softirqs last disabled at (314257): [<ffffffff81474e40>] irq_enter+0xa0/0xd0 kernel/softirq.c:351
CPU: 1 PID: 0 Comm: swapper/1 Not tainted 4.17.0-rc2+ #14
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+0x1b9/0x294 lib/dump_stack.c:113
 ___might_sleep.cold.87+0x11f/0x13a kernel/sched/core.c:6188
 __might_sleep+0x95/0x190 kernel/sched/core.c:6141
 slab_pre_alloc_hook mm/slab.h:421 [inline]
 slab_alloc mm/slab.c:3378 [inline]
 __do_kmalloc mm/slab.c:3716 [inline]
 __kmalloc+0x2b9/0x760 mm/slab.c:3727
 kmalloc_array include/linux/slab.h:631 [inline]
 kcalloc include/linux/slab.h:642 [inline]
 numa_crng_init drivers/char/random.c:798 [inline]
 crng_reseed+0x427/0x920 drivers/char/random.c:923
 credit_entropy_bits+0x98d/0xa30 drivers/char/random.c:708
 add_interrupt_randomness+0x494/0x860 drivers/char/random.c:1254
 handle_irq_event_percpu+0xf9/0x1c0 kernel/irq/handle.c:191
 handle_irq_event+0xa7/0x135 kernel/irq/handle.c:206
 handle_edge_irq+0x20f/0x870 kernel/irq/chip.c:791
 generic_handle_irq_desc include/linux/irqdesc.h:159 [inline]
 handle_irq+0x18c/0x2e7 arch/x86/kernel/irq_64.c:77
 do_IRQ+0x78/0x190 arch/x86/kernel/irq.c:245
 common_interrupt+0xf/0xf arch/x86/entry/entry_64.S:642
 </IRQ>
RIP: 0010:native_safe_halt+0x6/0x10 arch/x86/include/asm/irqflags.h:54
RSP: 0018:ffff8801d9ae7c38 EFLAGS: 00000286 ORIG_RAX: ffffffffffffffd5
RAX: dffffc0000000000 RBX: 1ffff1003b35cf8a RCX: 0000000000000000
RDX: 1ffffffff11a3160 RSI: 0000000000000001 RDI: ffffffff88d18b00
RBP: ffff8801d9ae7c38 R08: ffffed003b5e46c3 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000001
R13: ffff8801d9ae7cf0 R14: ffffffff897beda0 R15: 0000000000000000
 arch_safe_halt arch/x86/include/asm/paravirt.h:94 [inline]
 default_idle+0xc2/0x440 arch/x86/kernel/process.c:354
 arch_cpu_idle+0x10/0x20 arch/x86/kernel/process.c:345
 default_idle_call+0x6d/0x90 kernel/sched/idle.c:93
 cpuidle_idle_call kernel/sched/idle.c:153 [inline]
 do_idle+0x395/0x560 kernel/sched/idle.c:262
 cpu_startup_entry+0x104/0x120 kernel/sched/idle.c:368
 start_secondary+0x426/0x5b0 arch/x86/kernel/smpboot.c:269
 secondary_startup_64+0xa5/0xb0 arch/x86/kernel/head_64.S:242
random: crng init done

Crashes (3):
Time Kernel Commit Syzkaller Config Log Report Syz repro C repro VM info Assets (help?) Manager Title
2018/04/24 00:20 upstream 6d08b06e67cd 0d8e591c .config console log report syz C ci-upstream-kasan-gce
2018/04/23 20:59 upstream 6d08b06e67cd 0d8e591c .config console log report syz C ci-upstream-kasan-gce-root
2018/04/23 06:27 upstream 5ec83b22a2dd d23fcf6c .config console log report syz C ci-upstream-kasan-gce-root
* Struck through repros no longer work on HEAD.