Date:	Sat, 7 Mar 2015 07:31:36 +0800
From:	Fengguang Wu <fengguang.wu@...el.com>
To:	Andy Lutomirski <luto@...capital.net>
Cc:	fengguang.wu@...el.com, Ingo Molnar <mingo@...nel.org>,
	LKP <lkp@...org>, linux-kernel@...r.kernel.org
Subject: [x86/asm/entry] WARNING: CPU: 0 PID: 1 at crypto/algapi.c:341
 crypto_wait_for_test()

Greetings,

0day kernel testing robot got the below dmesg and the first bad commit is

git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip.git x86/asm

commit 75182b1632a89f12540baa1806a7c5c180db620c
Author:     Andy Lutomirski <luto@...capital.net>
AuthorDate: Thu Mar 5 19:19:03 2015 -0800
Commit:     Ingo Molnar <mingo@...nel.org>
CommitDate: Fri Mar 6 08:32:57 2015 +0100

    x86/asm/entry: Switch all C consumers of kernel_stack to this_cpu_sp0()
    
    This will make modifying the semantics of kernel_stack easier.
    
    The change to ist_begin_non_atomic() is necessary because sp0 no
    longer points to the same THREAD_SIZE-aligned region as RSP;
    it's one byte too high for that.  At Denys' suggestion, rather
    than offsetting it, just check explicitly that we're in the
    correct range ending at sp0.  This has the added benefit that we
    no longer assume that the thread stack is aligned to
    THREAD_SIZE.
    
    Suggested-by: Denys Vlasenko <dvlasenk@...hat.com>
    Signed-off-by: Andy Lutomirski <luto@...capital.net>
    Cc: Borislav Petkov <bp@...en8.de>
    Cc: H. Peter Anvin <hpa@...or.com>
    Cc: Linus Torvalds <torvalds@...ux-foundation.org>
    Cc: Oleg Nesterov <oleg@...hat.com>
    Cc: Thomas Gleixner <tglx@...utronix.de>
    Link: http://lkml.kernel.org/r/ef8254ad414cbb8034c9a56396eeb24f5dd5b0de.1425611534.git.luto@amacapital.net
    Signed-off-by: Ingo Molnar <mingo@...nel.org>

+----------------------------------------------------+------------+------------+------------+
|                                                    | 8ef46a672a | 75182b1632 | fad99646bd |
+----------------------------------------------------+------------+------------+------------+
| boot_successes                                     | 99         | 0          | 0          |
| boot_failures                                      | 0          | 33         | 24         |
| WARNING:at_crypto/algapi.c:#crypto_wait_for_test() | 0          | 33         | 9          |
| Kernel_panic-not_syncing:No_working_init_found     | 0          | 33         | 9          |
| backtrace:crypto_register_shash                    | 0          | 33         | 9          |
| backtrace:rmd320_mod_init                          | 0          | 33         | 9          |
| backtrace:kernel_init_freeable                     | 0          | 33         | 9          |
| backtrace:sha1_generic_mod_init                    | 0          | 33         | 9          |
| backtrace:crypto_register_algs                     | 0          | 33         | 9          |
| backtrace:des_generic_mod_init                     | 0          | 33         | 9          |
| backtrace:serpent_mod_init                         | 0          | 33         | 9          |
| backtrace:crypto_register_alg                      | 0          | 33         | 9          |
| backtrace:aes_init                                 | 0          | 33         | 9          |
| backtrace:khazad_mod_init                          | 0          | 33         | 9          |
| backtrace:seed_init                                | 0          | 33         | 9          |
| backtrace:michael_mic_init                         | 0          | 33         | 9          |
| backtrace:krng_mod_init                            | 0          | 33         | 9          |
| backtrace:ghash_mod_init                           | 0          | 33         | 9          |
| backtrace:panic                                    | 0          | 33         | 9          |
| BUG:kernel_boot_hang                               | 0          | 0          | 15         |
+----------------------------------------------------+------------+------------+------------+

[    0.477684] VFS: Disk quotas dquot_6.5.2
[    0.478229] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[    0.479687] ------------[ cut here ]------------
[    0.480293] WARNING: CPU: 0 PID: 1 at crypto/algapi.c:341 crypto_wait_for_test+0x57/0x80()
[    0.481621] Modules linked in:
[    0.482031] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 4.0.0-rc2-00052-g75182b1 #7
[    0.483029] Hardware name: Bochs Bochs, BIOS Bochs 01/01/2011
[    0.493830]  00000000 00000000 8002fed4 813e13e1 00000000 8002fef0 8104258b 00000155
[    0.494955]  81184af7 801a7a30 815d8500 8166562f 8002ff00 8104262f 00000009 00000000
[    0.496188]  8002ff0c 81184af7 801a7a30 8002ff18 81184cf4 815f4640 8002ff24 81189ef7
[    0.497244] Call Trace:
[    0.497626]  [<813e13e1>] dump_stack+0x48/0x60
[    0.498249]  [<8104258b>] warn_slowpath_common+0x6b/0xa0
[    0.498897]  [<81184af7>] ? crypto_wait_for_test+0x57/0x80
[    0.499646]  [<8166562f>] ? crypto_xcbc_module_init+0xf/0xf
[    0.500387]  [<8104262f>] warn_slowpath_null+0xf/0x20
[    0.500975]  [<81184af7>] crypto_wait_for_test+0x57/0x80
[    0.501761]  [<81184cf4>] crypto_register_alg+0x44/0x50
[    0.502426]  [<81189ef7>] crypto_register_shash+0x17/0x20
[    0.513102]  [<8166563c>] rmd320_mod_init+0xd/0xf
[    0.513655]  [<8100041e>] do_one_initcall+0x7e/0x1a0
[    0.514379]  [<8164a4e1>] ? repair_env_string+0x12/0x54
[    0.515057]  [<8105ceda>] ? parse_args+0x20a/0x410
[    0.515616]  [<8164ac0d>] kernel_init_freeable+0xe8/0x160
[    0.516418]  [<813de058>] kernel_init+0x8/0xc0
[    0.516972]  [<813e8341>] ret_from_kernel_thread+0x21/0x30
[    0.523463]  [<813de050>] ? rest_init+0x120/0x120
[    0.524118] ---[ end trace 36b50b799302ec7b ]---
[    0.525052] ------------[ cut here ]------------

git bisect start fad99646bd5e9e5cf78637701931518b8a55890e 4f671fe2f9523a1ea206f63fe60a7c7b3a56d5c7 --
git bisect good 7dfd6d85242a6790260381cb45ea407bd9b65af3  # 18:40     33+      0  Merge branch 'linus'
git bisect good 0624492336dfd630334fb582eb3f20ee3e109293  # 18:45     33+      0  Merge branch 'x86/asm'
git bisect good 93cbe2969a57747f291894e2331d9864034ac0a1  # 18:52     33+      0  Merge branch 'timers/urgent'
git bisect good e0aa5c22486be95ff8b52926fcb4f0e6f01a79c6  # 18:57     33+      0  Merge branch 'perf/urgent'
git bisect  bad 74d398c3580c5cb5601028821833366dc8414a69  # 18:57      0-      2  Merge branch 'x86/asm'
git bisect  bad 9d0c914c60f4d3123debb653340dc1f7cf44939d  # 19:00      0-     33  x86/asm/entry/64/compat: Change the 32-bit sysenter code to use sp0
git bisect  bad 75182b1632a89f12540baa1806a7c5c180db620c  # 19:03      0-     33  x86/asm/entry: Switch all C consumers of kernel_stack to this_cpu_sp0()
git bisect good 8ef46a672a7d852709561d10672b6eaa8a4acd82  # 19:09     33+      0  x86/asm/entry: Add this_cpu_sp0() to read sp0 for the current cpu
# first bad commit: [75182b1632a89f12540baa1806a7c5c180db620c] x86/asm/entry: Switch all C consumers of kernel_stack to this_cpu_sp0()
git bisect good 8ef46a672a7d852709561d10672b6eaa8a4acd82  # 19:12     99+      0  x86/asm/entry: Add this_cpu_sp0() to read sp0 for the current cpu
# extra tests with DEBUG_INFO
git bisect good 75182b1632a89f12540baa1806a7c5c180db620c  # 19:17     99+     99  x86/asm/entry: Switch all C consumers of kernel_stack to this_cpu_sp0()
# extra tests on HEAD of tip/master
git bisect  bad fad99646bd5e9e5cf78637701931518b8a55890e  # 19:17      0-     24  Merge branch 'x86/urgent'
# extra tests on tree/branch tip/x86/asm
git bisect  bad 9b47668843d800ed57f6f6bfd6f5c4cffdf201c6  # 19:22      0-      7  x86/asm/entry: Rename 'INIT_TSS_IST' to 'CPU_TSS_IST'
# extra tests on tree/branch tip/master
git bisect  bad fad99646bd5e9e5cf78637701931518b8a55890e  # 19:22      0-     24  Merge branch 'x86/urgent'
# extra tests on tree/branch linus/master
git bisect good 99aedde0869ce194539166ac5a4d2e1a20995348  # 19:27     99+      0  Merge branch 'x86-urgent-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
# extra tests on tree/branch next/master


This script may reproduce the error.

----------------------------------------------------------------------------
#!/bin/bash

kernel=$1
initrd=yocto-minimal-i386.cgz

wget --no-clobber https://github.com/fengguang/reproduce-kernel-bug/raw/master/initrd/$initrd

kvm=(
	qemu-system-x86_64
	-enable-kvm
	-cpu Haswell,+smep,+smap
	-kernel $kernel
	-initrd $initrd
	-m 320
	-smp 1
	-net nic,vlan=1,model=e1000
	-net user,vlan=1
	-boot order=nc
	-no-reboot
	-watchdog i6300esb
	-rtc base=localtime
	-serial stdio
	-display none
	-monitor null 
)

append=(
	hung_task_panic=1
	earlyprintk=ttyS0,115200
	rd.udev.log-priority=err
	systemd.log_target=journal
	systemd.log_level=warning
	debug
	apic=debug
	sysrq_always_enabled
	rcupdate.rcu_cpu_stall_timeout=100
	panic=-1
	softlockup_panic=1
	nmi_watchdog=panic
	oops=panic
	load_ramdisk=2
	prompt_ramdisk=0
	console=ttyS0,115200
	console=tty0
	vga=normal
	root=/dev/ram0
	rw
	drbd.minor_count=8
)

"${kvm[@]}" --append "${append[*]}"
----------------------------------------------------------------------------

Thanks,
Fengguang

View attachment "dmesg-yocto-kbuild-24:20150306190131:i386-randconfig-nexs0-03061447:4.0.0-rc2-00052-g75182b1:7" of type "text/plain" (59326 bytes)

View attachment "config-4.0.0-rc2-00052-g75182b1" of type "text/plain" (74893 bytes)

Powered by blists - more mailing lists