d1ddd86a5a ("x86/paravirt: move native patch code strings to .."): BUG: kernel hang in boot stage
by kernel test robot
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
https://git.kernel.org/pub/scm/linux/kernel/git/jpoimboe/linux.git paravirt-alternatives
commit d1ddd86a5a61da04c1ec36576b77f98302223b12
Author: Josh Poimboeuf <jpoimboe(a)redhat.com>
AuthorDate: Wed Sep 27 11:56:51 2017 -0500
Commit: Josh Poimboeuf <jpoimboe(a)redhat.com>
CommitDate: Fri Sep 29 11:29:57 2017 -0500
x86/paravirt: move native patch code strings to macros
Signed-off-by: Josh Poimboeuf <jpoimboe(a)redhat.com>
0431d92bf6 x86/paravirt: remove wbinvd() paravirt interface
d1ddd86a5a x86/paravirt: move native patch code strings to macros
+-------------------------------------------------+------------+------------+
| | 0431d92bf6 | d1ddd86a5a |
+-------------------------------------------------+------------+------------+
| boot_successes | 181 | 0 |
| boot_failures | 14 | 70 |
| WARNING:at_kernel/jump_label.c:#jump_label_test | 14 | |
| BUG:kernel_hang_in_boot_stage | 0 | 70 |
+-------------------------------------------------+------------+------------+
[ 0.044223] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[ 0.045270] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
[ 0.046813] Freeing SMP alternatives memory: 16K
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start 78ec826f893c850bb106c8c29813c6fbc0e733f0 2bd6bf03f4c1c59381d62c61d03f6cc3fe71f66e --
git bisect good 6c5c4f69b66b56a184bb75147f9df41724c110a8 # 05:05 G 22 0 2 2 Merge 'linux-review/greearb-candelatech-com/ath10k-Retry-pci-probe-on-failure/20170930-020608' into devel-catchup-201709300310
git bisect good 7996a0c32e4ef2eb976427dbb14c2a410592a160 # 05:29 G 22 0 1 1 Merge 'nf/master' into devel-catchup-201709300310
git bisect good 51752c891f988c7f6b45cd9b159719df0c39ab2b # 05:57 G 22 0 10 11 Merge 'vfs/for-linus' into devel-catchup-201709300310
git bisect bad 9e7e87221e749778da52285a5aa3c099e13dab03 # 06:17 B 10 1 10 14 Merge 'jpoimboe/paravirt-alternatives' into devel-catchup-201709300310
git bisect good db0c4bd640b3b34601351a8968f08ca288936ecf # 06:43 G 64 0 26 26 Merge branch 'x86/urgent'
git bisect good e20668793b964f154a51ffba5c0b24636ef49c0c # 07:07 G 66 0 19 19 x86/fpu: Eliminate the 'xfeatures' local variable in copy_user_to_xstate()
git bisect good 51d4052b01ca555e0d1d5fe297b309beb6c64aa0 # 07:31 G 64 0 33 33 watchdog/sysctl: Get rid of the #ifdeffery
git bisect good 4cebb7cb6ff7563f1aa860165b74922864f0e407 # 08:08 G 60 0 16 16 Merge branch 'WIP.core/urgent'
git bisect bad d1ddd86a5a61da04c1ec36576b77f98302223b12 # 08:27 B 0 7 20 0 x86/paravirt: move native patch code strings to macros
git bisect good 0431d92bf6bfebf75c8ea3d90b463d65980949ba # 09:11 G 62 0 1 1 x86/paravirt: remove wbinvd() paravirt interface
# first bad commit: [d1ddd86a5a61da04c1ec36576b77f98302223b12] x86/paravirt: move native patch code strings to macros
git bisect good 0431d92bf6bfebf75c8ea3d90b463d65980949ba # 09:22 G 184 0 12 13 x86/paravirt: remove wbinvd() paravirt interface
# extra tests with CONFIG_DEBUG_INFO_REDUCED
git bisect bad d1ddd86a5a61da04c1ec36576b77f98302223b12 # 09:46 B 0 15 28 0 x86/paravirt: move native patch code strings to macros
# extra tests on HEAD of linux-devel/devel-catchup-201709300310
git bisect bad 78ec826f893c850bb106c8c29813c6fbc0e733f0 # 09:47 B 0 4 29 9 0day head guard for 'devel-catchup-201709300310'
# extra tests on tree/branch jpoimboe/paravirt-alternatives
# extra tests with first bad commit reverted
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
3 years, 6 months
[lkp-robot] [x86/asm] f5caf621ee: PANIC:double_fault
by kernel test robot
FYI, we noticed the following commit:
commit: f5caf621ee357279e759c0911daf6d55c7d36f03 ("x86/asm: Fix inline asm call constraints for Clang")
https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git master
in testcase: trinity
with following parameters:
runtime: 300s
test-description: Trinity is a linux system call fuzz tester.
test-url: http://codemonkey.org.uk/projects/trinity/
on test machine: qemu-system-x86_64 -enable-kvm -m 420M
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
+-----------------------------------------+------------+------------+
| | 0d0970eef3 | f5caf621ee |
+-----------------------------------------+------------+------------+
| boot_successes | 9 | 4 |
| boot_failures | 0 | 4 |
| PANIC:double_fault | 0 | 4 |
| Kernel_panic-not_syncing:Machine_halted | 0 | 4 |
+-----------------------------------------+------------+------------+
[ 7.757440] udevtrigger (130) used greatest stack depth: 12344 bytes left
[ 8.262143] procd: - ubus -
[ 9.279484] procd: - init -
Please press Enter to activate this console.
[ 9.349553] find (656) used greatest stack depth: 12296 bytes left
[ 10.584905] PANIC: double fault, error_code: 0x0
[ 10.585372] CPU: 0 PID: 917 Comm: netifd Not tainted 4.14.0-rc1-00015-gf5caf62 #2
[ 10.586062] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 10.586978] task: ffff8800141a8000 task.stack: ffffc90000274000
[ 10.587519] RIP: 0010:compat_sock_ioctl+0xfea/0x103e
[ 10.587974] RSP: 0000:0000000000277d78 EFLAGS: 00010283
[ 10.588448] RAX: 0000000000277d78 RBX: 0000000000008933 RCX: ffff8800141a8000
[ 10.589103] RDX: 0000000000000020 RSI: 00000000fffbea00 RDI: 00000000fffbea50
[ 10.589757] RBP: ffffc90000277e18 R08: fffbea50fffbea34 R09: ffffffff814a68c9
[ 10.590407] R10: ffffff9c00000002 R11: 00000000fffbea50 R12: 0000000000000000
[ 10.591056] R13: ffff880012c8c880 R14: 00000000fffbea50 R15: 00000000fffbea00
[ 10.591708] FS: 0000000000000000(0000) GS:ffff880019a00000(0063) knlGS:00000000f7fab9a0
[ 10.592446] CS: 0010 DS: 002b ES: 002b CR0: 0000000080050033
[ 10.592973] CR2: 0000000000277d68 CR3: 000000001807f000 CR4: 00000000000006b0
[ 10.593623] Call Trace:
[ 10.593858] Code: 02 0f ff 65 48 8b 04 25 80 d1 00 00 48 8b 80 28 25 00 00 48 83 e8 20 49 39 c7 77 34 89 e0 4c 89 f7 4c 89 fe ba 20 00 00 00 89 c4 <e8> b3 52 05 00 85 c0 74 22 eb 1a 4c 89 fa 89 de 4c 89 ef e8 c6
[ 10.595705] Kernel panic - not syncing: Machine halted.
[ 10.596181] CPU: 0 PID: 917 Comm: netifd Not tainted 4.14.0-rc1-00015-gf5caf62 #2
[ 10.596868] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 10.597786] Call Trace:
[ 10.598017] <#DF>
[ 10.598216] dump_stack+0x8f/0xc4
[ 10.598527] panic+0xda/0x22f
[ 10.598811] df_debug+0x30/0x30
[ 10.599104] do_double_fault+0x9b/0xaf
[ 10.599456] double_fault+0x22/0x30
[ 10.599791] RIP: 0010:compat_sock_ioctl+0xfea/0x103e
[ 10.600247] RSP: 0000:0000000000277d78 EFLAGS: 00010283
[ 10.600733] RAX: 0000000000277d78 RBX: 0000000000008933 RCX: ffff8800141a8000
[ 10.601381] RDX: 0000000000000020 RSI: 00000000fffbea00 RDI: 00000000fffbea50
[ 10.602036] RBP: ffffc90000277e18 R08: fffbea50fffbea34 R09: ffffffff814a68c9
[ 10.602700] R10: ffffff9c00000002 R11: 00000000fffbea50 R12: 0000000000000000
[ 10.603349] R13: ffff880012c8c880 R14: 00000000fffbea50 R15: 00000000fffbea00
[ 10.604002] ? dev_ioctl+0x2d7/0x5e3
[ 10.604336] WARNING: kernel stack regs at ffff880019a05f58 in netifd:917 has bad 'bp' value ffffc90000277e18
[ 10.604337] unwind stack type:0 next_sp:0000000000277d78 mask:0x10 graph_idx:0
[ 10.604339] ffff880019a05d48: ffff880019a05e28 (0xffff880019a05e28)
[ 10.604340] ffff880019a05d50: ffffffff8100ce27 (show_trace_log_lvl+0x203/0x2a7)
[ 10.604342] ffff880019a05d58: ffffffff81473d28 (compat_sock_ioctl+0xfea/0x103e)
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email
Thanks,
Xiaolong
3 years, 6 months
[XArray] 557f620bea: BUG:kernel_reboot-without-warning_in_early-boot_stage, last_printk:early_console_in_setup_code
by kernel test robot
FYI, we noticed the following commit (built with gcc-6):
commit: 557f620beafde320d9dff80728ef4689936839a3 ("XArray: Convert IDR and add test suite")
git://git.infradead.org/users/willy/linux-dax.git xarray-2017-09-27
in testcase: boot
on test machine: qemu-system-x86_64 -enable-kvm -cpu kvm64,+ssse3 -m 1G
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
+-----------------------------------------------------------------------------------------------+------------+------------+
| | 725b11291e | 557f620bea |
+-----------------------------------------------------------------------------------------------+------------+------------+
| boot_successes | 8 | 0 |
| boot_failures | 0 | 8 |
| BUG:kernel_reboot-without-warning_in_early-boot_stage,last_printk:early_console_in_setup_code | 0 | 8 |
+-----------------------------------------------------------------------------------------------+------------+------------+
early console in setup code
Elapsed time: 20
BUG: kernel reboot-without-warning in early-boot stage, last printk: early console in setup code
Linux version 4.14.0-rc2-00056-g557f620 #75
Command line: ip=::::vm-lkp-wsx03-1G-27::dhcp root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-lkp-wsx03-1G-27/boot-1-debian-x86_64-2016-08-31.cgz-557f620beafde320d9dff80728ef4689936839a3-20170929-68794-1o69dkz-0.yaml ARCH=x86_64 kconfig=x86_64-acpi-redef branch=linux-devel/devel-hourly-2017092822 commit=557f620beafde320d9dff80728ef4689936839a3 BOOT_IMAGE=/pkg/linux/x86_64-acpi-redef/gcc-6/557f620beafde320d9dff80728ef4689936839a3/vmlinuz-4.14.0-rc2-00056-g557f620 max_uptime=600 RESULT_ROOT=/result/boot/1/vm-lkp-wsx03-1G/debian-x86_64-2016-08-31.cgz/x86_64-acpi-redef/gcc-6/557f620beafde320d9dff80728ef4689936839a3/0 LKP_SERVER=inn debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 net.ifnames=0 printk.devkmsg=on panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 drbd.minor_count=8 systemd.log_level=err ignore_loglevel console=tty0 earlyprintk=ttyS0,115200 console=ttyS0,115200 vga=normal rw
initrds=(
/osimage/debian/debian-x86_64-2016-08-31.cgz
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email
Thanks,
lkp
3 years, 6 months
[drm/gem] 05eadb82a7: BUG:sleeping_function_called_from_invalid_context_at_kernel/locking/mutex.c
by kernel test robot
FYI, we noticed the following commit:
commit: 05eadb82a771dd64588809b382fc437aac5c981f ("drm/gem: use new idr deletion interface to cleanup drm_gem_handle_delete()")
url: https://github.com/0day-ci/linux/commits/Aishwarya-Pant/drm-gem-use-new-i...
base: git://people.freedesktop.org/~airlied/linux.git drm-next
in testcase: phoronix-test-suite
with following parameters:
need_x: true
test: unvanquished-1.5.0
cpufreq_governor: performance
test-description: The Phoronix Test Suite is the most comprehensive testing and benchmarking platform available that provides an extensible framework for which new tests can be easily added.
test-url: http://www.phoronix-test-suite.com/
on test machine: 4 threads Intel(R) Core(TM) i5-2500K CPU @ 3.30GHz with 6G memory
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
+-------------------------------+------------+------------+
| | 47e0cd6b1d | 05eadb82a7 |
+-------------------------------+------------+------------+
| boot_successes | 11 | 153 |
| boot_failures | 0 | 2 |
| BUG:kernel_hang_in_test_stage | 0 | 2 |
+-------------------------------+------------+------------+
kern :err : [ 144.487222] BUG: sleeping function called from invalid context at kernel/locking/mutex.c:238
kern :err : [ 144.497601] in_atomic(): 1, irqs_disabled(): 0, pid: 1125, name: Xorg
kern :warn : [ 144.504124] CPU: 1 PID: 1125 Comm: Xorg Not tainted 4.13.0-rc5-01130-g05eadb8 #1
kern :warn : [ 144.511622] Hardware name: System manufacturer System Product Name/P8H67-M PRO, BIOS 1002 04/01/2011
kern :warn : [ 144.520763] Call Trace:
kern :warn : [ 144.523244] dump_stack+0x63/0x86
kern :warn : [ 144.526586] ___might_sleep+0xf1/0x110
kern :warn : [ 144.530366] __might_sleep+0x4a/0x80
kern :warn : [ 144.534005] mutex_lock+0x20/0x50
kern :warn : [ 144.537413] drm_gem_object_release_handle+0x6d/0x90 [drm]
kern :warn : [ 144.542936] drm_gem_handle_delete+0x42/0x70 [drm]
kern :warn : [ 144.547773] ? drm_gem_handle_create+0x40/0x40 [drm]
kern :warn : [ 144.552789] drm_gem_close_ioctl+0x20/0x30 [drm]
kern :warn : [ 144.557461] drm_ioctl_kernel+0x69/0xb0 [drm]
kern :warn : [ 144.561877] ? __might_fault+0x2f/0x40
kern :warn : [ 144.565678] drm_ioctl+0x2f9/0x3d0 [drm]
kern :warn : [ 144.569629] ? drm_gem_handle_create+0x40/0x40 [drm]
kern :warn : [ 144.574652] ? __might_sleep+0x4a/0x80
kern :warn : [ 144.578491] ? selinux_file_ioctl+0x109/0x1b0
kern :warn : [ 144.582928] do_vfs_ioctl+0x95/0x670
kern :warn : [ 144.586586] ? security_file_ioctl+0x43/0x60
kern :warn : [ 144.590936] SyS_ioctl+0x79/0x90
kern :warn : [ 144.594195] entry_SYSCALL_64_fastpath+0x1a/0xa5
kern :warn : [ 144.598900] RIP: 0033:0x7f849fe14ca7
kern :warn : [ 144.602496] RSP: 002b:00007ffd3ae8bd38 EFLAGS: 00003246 ORIG_RAX: 0000000000000010
kern :warn : [ 144.610151] RAX: ffffffffffffffda RBX: 00007f849b2e9148 RCX: 00007f849fe14ca7
kern :warn : [ 144.617412] RDX: 00007ffd3ae8bd70 RSI: 0000000040086409 RDI: 000000000000000d
kern :warn : [ 144.624649] RBP: 00007f849adbf500 R08: 000000d16e268188 R09: 00000000000000a0
kern :warn : [ 144.631851] R10: 00007ffd3ae8bd80 R11: 0000000000003246 R12: 00007ffd3ae8bdc0
kern :warn : [ 144.639064] R13: 000000d16e2676f0 R14: 000000d16e267688 R15: 0000000000000001
user :notice: [ 158.502568] PTS_SILENT_MODE=1
user :notice: [ 159.138131] 2017-09-29 07:05:50 phoronix-test-suite default-run unvanquished-1.5.0
kern :err : [ 159.534525] BUG: sleeping function called from invalid context at kernel/locking/mutex.c:238
kern :err : [ 159.544927] in_atomic(): 1, irqs_disabled(): 0, pid: 1357, name: glxinfo
kern :warn : [ 159.551758] CPU: 2 PID: 1357 Comm: glxinfo Tainted: G W 4.13.0-rc5-01130-g05eadb8 #1
kern :warn : [ 159.560702] Hardware name: System manufacturer System Product Name/P8H67-M PRO, BIOS 1002 04/01/2011
kern :warn : [ 159.569930] Call Trace:
kern :warn : [ 159.572377] dump_stack+0x63/0x86
kern :warn : [ 159.575755] ___might_sleep+0xf1/0x110
kern :warn : [ 159.579526] __might_sleep+0x4a/0x80
kern :warn : [ 159.583175] mutex_lock+0x20/0x50
kern :warn : [ 159.586505] drm_gem_object_release_handle+0x6d/0x90 [drm]
kern :warn : [ 159.592061] drm_gem_handle_delete+0x42/0x70 [drm]
kern :warn : [ 159.596898] ? drm_gem_handle_create+0x40/0x40 [drm]
kern :warn : [ 159.601915] drm_gem_close_ioctl+0x20/0x30 [drm]
kern :warn : [ 159.606612] drm_ioctl_kernel+0x69/0xb0 [drm]
kern :warn : [ 159.610977] ? __might_fault+0x2f/0x40
kern :warn : [ 159.614785] drm_ioctl+0x2f9/0x3d0 [drm]
kern :warn : [ 159.618783] ? drm_gem_handle_create+0x40/0x40 [drm]
kern :warn : [ 159.623785] ? __might_sleep+0x4a/0x80
kern :warn : [ 159.627634] ? selinux_file_ioctl+0x109/0x1b0
kern :warn : [ 159.632054] do_vfs_ioctl+0x95/0x670
kern :warn : [ 159.635687] ? security_file_ioctl+0x43/0x60
kern :warn : [ 159.639992] SyS_ioctl+0x79/0x90
kern :warn : [ 159.643261] entry_SYSCALL_64_fastpath+0x1a/0xa5
kern :warn : [ 159.647888] RIP: 0033:0x7f1a77a10ca7
kern :warn : [ 159.651501] RSP: 002b:00007ffc99e109f8 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
kern :warn : [ 159.659259] RAX: ffffffffffffffda RBX: 00000000017cb890 RCX: 00007f1a77a10ca7
kern :warn : [ 159.666469] RDX: 00007ffc99e10a30 RSI: 0000000040086409 RDI: 0000000000000005
kern :warn : [ 159.673635] RBP: 0000000000000005 R08: 00000000017cb898 R09: 00000000000000a0
kern :warn : [ 159.680846] R10: 00007ffc99e10a40 R11: 0000000000000246 R12: 00000000017cad98
kern :warn : [ 159.688075] R13: 0000000000000000 R14: 00000000017cad98 R15: 0000000000000001
user :notice: [ 199.785643] No Internet Connectivity After Wait
user :notice: [ 203.792063] IPMI BMC is not supported on this machine, skip bmc-watchdog setup!
kern :info : [ 245.457087] perf: interrupt took too long (2535 > 2500), lowering kernel.perf_event_max_sample_rate to 78000
kern :info : [ 246.470090] perf: interrupt took too long (3182 > 3168), lowering kernel.perf_event_max_sample_rate to 62000
kern :info : [ 248.263087] perf: interrupt took too long (3980 > 3977), lowering kernel.perf_event_max_sample_rate to 50000
user :notice: [ 249.796984] No Internet Connectivity After Wait
user :notice: [ 250.900465] Phoronix Test Suite v5.8.1
user :notice: [ 250.906065] System Information
user :notice: [ 250.915926] Hardware:
user :notice: [ 250.925333] Processor: Intel Core i5-2500K @ 3.70GHz (4 Cores), Motherboard: ASUS P8H67-M PRO, Chipset: Intel 2nd Generation Core Family DRAM, Memory: 2048 MB + 1024 MB + 2048 MB + 1024 MB DDR3-1067MHz, Disk: 2000GB Western Digital WD20EZRX-00D, Graphics: Intel HD 3000 (1100MHz), Audio: Realtek ALC892, Network: Realtek RTL8111/8168/8411
user :notice: [ 251.129764] Software:
user :notice: [ 251.137772] OS: Debian GNU/Linux 9, Kernel: 4.13.0-rc5-01130-g05eadb8 (x86_64) 20170928, Display Server: X Server 1.16.4, Display Driver: intel 2.21.15, OpenGL: 3.3 Mesa 17.1.4, Compiler: GCC 6.4.0 20170704, File-System: UNKNOWN (0x794c7630), Screen Resolution: 1024x768
user :notice: [ 251.165486] Would you like to save these test results (Y/n):
user :notice: [ 251.174880] Unvanquished 0.26.0:
user :notice: [ 251.180651] pts/unvanquished-1.5.0 [Resolution: 800 x 600 - Effects Quality: Ultra]
user :notice: [ 251.190390] Test 1 of 2
user :notice: [ 251.195185] Estimated Trial Run Count: 3
user :notice: [ 251.201771] Estimated Test Run-Time: 6 Minutes
user :notice: [ 251.209174] Estimated Time To Completion: 12 Minutes
user :notice: [ 251.713270] Started Run 1 @ 18:07:22
user :notice: [ 253.713900] The test run did not produce a result.
user :notice: [ 253.722412] Started Run 2 @ 18:07:25
user :notice: [ 255.722956] The test run did not produce a result.
user :notice: [ 255.731454] Started Run 3 @ 18:07:27
user :notice: [ 255.737830] The test run did not produce a result.
user :notice: [ 255.746612] Test Results:
user :notice: [ 255.753047] Average: 0 Frames Per Second
user :notice: [ 255.759340] This test failed to run properly.
user :notice: [ 261.736310] Unvanquished 0.26.0:
user :notice: [ 261.742172] pts/unvanquished-1.5.0 [Resolution: 1024 x 768 - Effects Quality: Ultra]
user :notice: [ 261.751953] Test 2 of 2
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp install job.yaml # job file is attached in this email
bin/lkp run job.yaml
Thanks,
lkp
3 years, 6 months
[lkp-robot] [mm] d33dff8a27: autotest.linus_stress.fail
by kernel test robot
FYI, we noticed the following commit:
commit: d33dff8a279d3f468abac7de306e9077b027b872 ("mm: introduce validity check on vm dirtiness settings")
url: https://github.com/0day-ci/linux/commits/Yafang-Shao/mm-introduce-validit...
in testcase: autotest
with following parameters:
test: linus_stress
test-description: Autotest is a framework for fully automated testing. It is designed primarily to test the Linux kernel, though it is useful for many other functions such as qualifying new hardware.
test-url: https://github.com/autotest/autotest
on test machine: 32 threads Intel(R) Xeon(R) CPU E5-2680 0 @ 2.70GHz with 64G memory
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
2017-09-28 22:06:43 client/autotest-local run linus_stress
22:06:43 INFO | Writing results to /lkp/benchmarks/autotest/client/results/default
22:06:43 ERROR| Could not determine initlevel, assuming 2
22:06:44 INFO | START ---- ---- timestamp=1506636404 localtime=Sep 28 22:06:44
22:06:44 INFO | START linus_stress linus_stress timestamp=1506636404 localtime=Sep 28 22:06:44
22:06:44 WARNI| Could not find GDB installed. Crash handling will operate with limited functionality
22:06:44 ERROR| [stderr] linus_stress.c: In function 'main':
22:06:44 ERROR| [stderr] linus_stress.c:81:2: warning: implicit declaration of function 'srandom' [-Wimplicit-function-declaration]
22:06:44 ERROR| [stderr] srandom(time(NULL));
22:06:44 ERROR| [stderr] ^~~~~~~
22:06:44 ERROR| [stderr] linus_stress.c:83:30: warning: implicit declaration of function 'random' [-Wimplicit-function-declaration]
22:06:44 ERROR| [stderr] int index = (unsigned int) random() % NRCHUNKS;
22:06:44 ERROR| [stderr] ^~~~~~
22:06:44 ERROR| Exception escaping from test:
Traceback (most recent call last):
File "/lkp/benchmarks/autotest/client/shared/test.py", line 411, in _exec
_call_test_function(self.execute, *p_args, **p_dargs)
File "/lkp/benchmarks/autotest/client/shared/test.py", line 830, in _call_test_function
raise error.UnhandledTestFail(e)
UnhandledTestFail: Unhandled IOError: [Errno 22] Invalid argument
Traceback (most recent call last):
File "/lkp/benchmarks/autotest/client/shared/test.py", line 823, in _call_test_function
return func(*args, **dargs)
File "/lkp/benchmarks/autotest/client/tests/linus_stress/linus_stress.py", line 41, in execute
self.run_the_test(iterations)
File "/lkp/benchmarks/autotest/client/tests/linus_stress/linus_stress.py", line 20, in run_the_test
utils.write_one_line('/proc/sys/vm/dirty_ratio', '4')
File "/lkp/benchmarks/autotest/client/shared/utils.py", line 407, in write_one_line
open_write_close(filename, line.rstrip('\n') + '\n')
File "/lkp/benchmarks/autotest/client/shared/utils.py", line 415, in open_write_close
f.close()
IOError: [Errno 22] Invalid argument
22:06:44 INFO | System log file not found (looked for ['/var/log/messages', '/var/log/syslog'])
22:06:44 ERROR| child process failed
22:06:44 INFO | FAIL linus_stress linus_stress timestamp=1506636404 localtime=Sep 28 22:06:44 Unhandled IOError: [Errno 22] Invalid argument
Traceback (most recent call last):
File "/lkp/benchmarks/autotest/client/shared/test.py", line 823, in _call_test_function
return func(*args, **dargs)
File "/lkp/benchmarks/autotest/client/tests/linus_stress/linus_stress.py", line 41, in execute
self.run_the_test(iterations)
File "/lkp/benchmarks/autotest/client/tests/linus_stress/linus_stress.py", line 20, in run_the_test
utils.write_one_line('/proc/sys/vm/dirty_ratio', '4')
File "/lkp/benchmarks/autotest/client/shared/utils.py", line 407, in write_one_line
open_write_close(filename, line.rstrip('\n') + '\n')
File "/lkp/benchmarks/autotest/client/shared/utils.py", line 415, in open_write_close
f.close()
IOError: [Errno 22] Invalid argument
22:06:44 INFO | END FAIL linus_stress linus_stress timestamp=1506636404 localtime=Sep 28 22:06:44
22:06:44 INFO | END GOOD ---- ---- timestamp=1506636404 localtime=Sep 28 22:06:44
22:06:44 INFO | Report successfully generated at /lkp/benchmarks/autotest/client/results/default/job_report.html
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp install job.yaml # job file is attached in this email
bin/lkp run job.yaml
Thanks,
Xiaolong
3 years, 6 months
[lkp-robot] [selftests] 26e500fe62: kernel_selftests.mqueue.mq_open_tests.fail
by kernel test robot
FYI, we noticed the following commit:
commit: 26e500fe628e28f2e93d397014beeb9c213d91e9 ("selftests: mqueue: Use full path to run tests from Makefile")
https://git.kernel.org/cgit/linux/kernel/git/shuah/linux-kselftest.git fixes
in testcase: kernel_selftests
with following parameters:
test-description: The kernel contains a set of "self tests" under the tools/testing/selftests/ directory. These are intended to be small unit tests to exercise individual code paths in the kernel.
test-url: https://www.kernel.org/doc/Documentation/kselftest.txt
on test machine: 88 threads Intel(R) Xeon(R) CPU E5-2699 v4 @ 2.20GHz with 64G memory
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
2017-09-27 18:35:28 make run_tests -C mqueue
make: Entering directory '/usr/src/linux-selftests-x86_64-rhel-7.2-26e500fe628e28f2e93d397014beeb9c213d91e9/tools/testing/selftests/mqueue'
gcc -O2 mq_open_tests.c -lrt -lpthread -lpopt -o /usr/src/linux-selftests-x86_64-rhel-7.2-26e500fe628e28f2e93d397014beeb9c213d91e9/tools/testing/selftests/mqueue/mq_open_tests
gcc -O2 mq_perf_tests.c -lrt -lpthread -lpopt -o /usr/src/linux-selftests-x86_64-rhel-7.2-26e500fe628e28f2e93d397014beeb9c213d91e9/tools/testing/selftests/mqueue/mq_perf_tests
/usr/src/linux-selftests-x86_64-rhel-7.2-26e500fe628e28f2e93d397014beeb9c213d91e9/tools/testing/selftests/mqueue/mq_open_tests /test1 || echo "selftests: mq_open_tests [FAIL]"
/usr/src/linux-selftests-x86_64-rhel-7.2-26e500fe628e28f2e93d397014beeb9c213d91e9/tools/testing/selftests/mqueue//mq_perf_tests || echo "selftests: mq_perf_tests [FAIL]"
Initial system state:
Using queue path: /test1
RLIMIT_MSGQUEUE(soft): 819200
RLIMIT_MSGQUEUE(hard): 819200
Maximum Message Size: 8192
Maximum Queue Size: 10
Default Message Size: 8192
Default Queue Size: 10
Adjusted system state for testing:
RLIMIT_MSGQUEUE(soft): 819200
RLIMIT_MSGQUEUE(hard): 819200
Maximum Message Size: 8192
Maximum Queue Size: 10
Default Message Size: 8192
Default Queue Size: 10
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp install job.yaml # job file is attached in this email
bin/lkp run job.yaml
Thanks,
Xiaolong
3 years, 6 months
[lkp-robot] [xfs] 486aff5e04: fio.read_bw_MBps +443.9% improvement
by kernel test robot
Greeting,
FYI, we noticed a +443.9% improvement of fio.read_bw_MBps due to commit:
commit: 486aff5e04823bb1e60c4045226eb244024b8420 ("xfs: perform dax_device lookup at mount")
https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git master
in testcase: fio-basic
on test machine: 56 threads Intel(R) Xeon(R) CPU E5-2695 v3 @ 2.30GHz with 256G memory
with following parameters:
disk: 2pmem
fs: xfs
mount_option: dax
runtime: 200s
nr_task: 50%
time_based: tb
rw: randread
bs: 4k
ioengine: libaio
test_size: 200G
cpufreq_governor: performance
test-description: Fio is a tool that will spawn a number of threads or processes doing a particular type of I/O action as specified by the user.
test-url: https://github.com/axboe/fio
Details are as below:
-------------------------------------------------------------------------------------------------->
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp install job.yaml # job file is attached in this email
bin/lkp run job.yaml
testcase/path_params/tbox_group/run: fio-basic/2pmem-xfs-dax-200s-50%-tb-randread-4k-libaio-200G-performance/lkp-hsw-ep6
78f35473508118df 486aff5e04823bb1e60c404522
---------------- --------------------------
%stddev %change %stddev
\ | \
8709 +443.9% 47368 ± 7% fio.read_bw_MBps
0.07 ± 13% -0.1 0.01 fio.latency_1000us%
0.01 +94.7 94.66 ± 5% fio.latency_100us%
0.01 +5.3 5.33 ±105% fio.latency_250us%
0.02 -0.0 0.01 fio.latency_2ms%
99.49 -99.5 0.01 fio.latency_500us%
0.42 ± 24% -0.4 0.01 fio.latency_750us%
402.00 -78.3% 87.33 ± 12% fio.read_clat_90%_us
406.00 -76.8% 94.00 ± 9% fio.read_clat_95%_us
433.00 -75.1% 108.00 ± 7% fio.read_clat_99%_us
389.57 -81.5% 72.23 ± 7% fio.read_clat_mean_us
2229562 +443.9% 12126296 ± 7% fio.read_iops
11.92 -86.4% 1.62 ± 10% fio.read_slat_mean_us
5345 -24.0% 4061 ± 2% fio.time.system_time
260.77 +492.9% 1546 ± 6% fio.time.user_time
127635 ± 2% +4.6% 133453 interrupts.CAL:Function_call_interrupts
86075 ± 22% -39.5% 52061 ± 12% numa-meminfo.node0.Active
2840048 ± 8% -20.8% 2249248 ± 2% cpuidle.C1E.time
22191 ± 6% -18.3% 18137 ± 4% cpuidle.C1E.usage
2138 ± 11% -25.6% 1591 ± 12% proc-vmstat.numa_hint_faults_local
10568 ± 23% -24.6% 7972 ± 23% proc-vmstat.pgactivate
5345 -24.0% 4061 ± 2% time.system_time
260.77 +492.9% 1546 ± 6% time.user_time
fio.read_bw_MBps
60000 +-+-----------------------------------------------------------------+
| |
50000 +-+ O O O O O |
O O O O O O O O O O |
| O O O O O
40000 +-+ O |
| |
30000 +-+ |
| |
20000 +-+ |
| |
| |
10000 +-+ +..+..+..+...+..+..+..+..+..+..+..+..+.. +...+..+..+..+ |
| .. .. |
0 +-+-------------------O------------------------------------------O--+
fio.read_iops
1.4e+07 +-+---------------------------------------------------------------+
| O O O O O O |
1.2e+07 O-+ O O O O O O O O |
| O O O O O
1e+07 +-+ |
| O |
8e+06 +-+ |
| |
6e+06 +-+ |
| |
4e+06 +-+ |
| |
2e+06 +-+ +..+..+..+..+..+..+..+..+..+..+..+..+.. +..+..+..+..+ |
| .. .. |
0 +-+------------------O-----------------------------------------O--+
[*] bisect-good sample
[O] bisect-bad sample
Disclaimer:
Results have been estimated based on internal Intel analysis and are provided
for informational purposes only. Any difference in system hardware or software
design or configuration may affect actual performance.
Thanks,
Xiaolong
3 years, 6 months
[lkp-robot] [mac80211] 31e9170bde: hwsim.sta_dynamic_down_up.fail
by kernel test robot
FYI, we noticed the following commit:
commit: 31e9170bdeb6ebe66426337b4e2b9924683a412b ("mac80211: aead api to reduce redundancy")
url: https://github.com/0day-ci/linux/commits/Xiang-Gao/mac80211-aead-api-to-r...
base: https://git.kernel.org/cgit/linux/kernel/git/jberg/mac80211-next.git master
in testcase: hwsim
with following parameters:
group: hwsim-10
on test machine: qemu-system-x86_64 -enable-kvm -cpu host -smp 2 -m 2G
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
2017-09-27 16:04:27 ./run-tests.py sta_dynamic_down_up
DEV: wlan0: 02:00:00:00:00:00
DEV: wlan1: 02:00:00:00:01:00
DEV: wlan2: 02:00:00:00:02:00
APDEV: wlan3
APDEV: wlan4
START sta_dynamic_down_up 1/1
Test: Dynamically added wpa_supplicant interface down/up
Starting AP wlan3
Create a dynamic wpa_supplicant interface and connect
Connect STA wlan5 to AP
dev1->dev2 unicast data delivery failed
Traceback (most recent call last):
File "./run-tests.py", line 453, in main
t(dev, apdev)
File "/lkp/benchmarks/hwsim/tests/hwsim/test_sta_dynamic.py", line 122, in test_sta_dynamic_down_up
hwsim_utils.test_connectivity(wpas, hapd)
File "/lkp/benchmarks/hwsim/tests/hwsim/hwsim_utils.py", line 165, in test_connectivity
raise Exception(last_err)
Exception: dev1->dev2 unicast data delivery failed
FAIL sta_dynamic_down_up 5.397413 2017-09-27 16:04:32.540689
passed 0 test case(s)
skipped 0 test case(s)
failed tests: sta_dynamic_down_up
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email
Thanks,
Xiaolong
3 years, 6 months
[lkp-robot] [x86/mm] 6ebcb06071: BUG:kernel_reboot-without-warning_in_early-boot_stage, last_printk:early_console_in_setup_code
by kernel test robot
FYI, we noticed the following commit:
commit: 6ebcb060713f614c92216482eed501b31cee74ec ("x86/mm: Add support to encrypt the kernel in-place")
https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git master
in testcase: boot
on test machine: qemu-system-x86_64 -enable-kvm -cpu IvyBridge -smp 2 -m 1G
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
+-----------------------------------------------------------------------------------------------+------------+------------+
| | db516997a9 | 6ebcb06071 |
+-----------------------------------------------------------------------------------------------+------------+------------+
| boot_successes | 16 | 4 |
| boot_failures | 96 | 108 |
| BUG:kernel_hang_in_test_stage | 96 | 22 |
| BUG:kernel_reboot-without-warning_in_early-boot_stage,last_printk:early_console_in_setup_code | 0 | 41 |
| BUG:kernel_hang_in_early-boot_stage,last_printk:early_console_in_setup_code | 0 | 16 |
| BUG:kernel_in_stage | 0 | 28 |
| BUG:kernel_reboot-without-warning_in_boot_stage | 0 | 1 |
+-----------------------------------------------------------------------------------------------+------------+------------+
early console in setup code
Elapsed time: 10
BUG: kernel reboot-without-warning in early-boot stage, last printk: early console in setup code
Linux version 4.13.0-rc1-00070-g6ebcb06 #2
Command line: ip=::::vm-ivb41-1G-7::dhcp root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-ivb41-1G-7/boot-1-debian-x86_64-2016-08-31.cgz-6ebcb060713f614c92216482eed501b31cee74ec-20170925-22207-y8ykq5-0.yaml ARCH=x86_64 kconfig=x86_64-randconfig-n0-09222335 branch=linux-devel/devel-spot-201709221528 commit=6ebcb060713f614c92216482eed501b31cee74ec BOOT_IMAGE=/pkg/linux/x86_64-randconfig-n0-09222335/gcc-4.8/6ebcb060713f614c92216482eed501b31cee74ec/vmlinuz-4.13.0-rc1-00070-g6ebcb06 max_uptime=600 RESULT_ROOT=/result/boot/1/vm-ivb41-1G/debian-x86_64-2016-08-31.cgz/x86_64-randconfig-n0-09222335/gcc-4.8/6ebcb060713f614c92216482eed501b31cee74ec/0 LKP_SERVER=inn debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 net.ifnames=0 printk.devkmsg=on panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 drbd.minor_count=8 systemd.log_level=err ignore_loglevel console=tty0 earlyprintk=ttyS0,115200 console=ttyS0,115200 vga=normal rw
initrds=(
/osimage/debian/debian-x86_64-2016-08-31.cgz
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email
Thanks,
Xiaolong
3 years, 6 months
[lkp-robot] [EXP] a74063662f: INFO:task_blocked_for_more_than#seconds
by kernel test robot
FYI, we noticed the following commit:
commit: a74063662f3a456a402bd40fa23e104196c78993 ("EXP: Fine-grained timer diagnostics")
https://git.kernel.org/cgit/linux/kernel/git/paulmck/linux-rcu.git dev.2017.09.21b
in testcase: trinity
with following parameters:
runtime: 300s
test-description: Trinity is a linux system call fuzz tester.
test-url: http://codemonkey.org.uk/projects/trinity/
on test machine: qemu-system-x86_64 -enable-kvm -cpu IvyBridge -m 420M
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
+--------------------------------------------------+------------+------------+
| | ad6a4baa92 | a74063662f |
+--------------------------------------------------+------------+------------+
| boot_successes | 24 | 1 |
| boot_failures | 0 | 21 |
| BUG:kernel_hang_in_boot_stage | 0 | 12 |
| INFO:task_blocked_for_more_than#seconds | 0 | 9 |
| Kernel_panic-not_syncing:hung_task:blocked_tasks | 0 | 9 |
+--------------------------------------------------+------------+------------+
[ 245.387603] INFO: task swapper:1 blocked for more than 120 seconds.
[ 245.391458] Not tainted 4.14.0-rc1-00036-ga740636 #1
[ 245.394939] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 245.399647] swapper D 0 1 0 0x80000000
[ 245.402789] Call Trace:
[ 245.404509] ? __schedule+0x221/0x5c0
[ 245.406281] ? schedule+0x1b/0x30
[ 245.408629] ? schedule_timeout+0x1a5/0x380
[ 245.411794] ? trace_hardirqs_on_caller+0x10c/0x190
[ 245.414410] ? wait_for_completion+0xf3/0x140
[ 245.416345] ? do_task_dead+0x40/0x40
[ 245.419067] ? kthread_stop+0x2f/0x60
[ 245.421645] ? test_rht_init+0x834/0x883
[ 245.424521] ? config_sync_direct_show+0x40/0x40
[ 245.426762] ? config_sync_direct_show+0x40/0x40
[ 245.429468] ? list_sort_test+0x1c6/0x1c6
[ 245.432146] ? do_one_initcall+0x79/0x119
[ 245.434786] ? parse_args+0xc0/0x300
[ 245.436898] ? kernel_init_freeable+0xc9/0x15b
[ 245.439583] ? kernel_init_freeable+0xe6/0x15b
[ 245.442276] ? rest_init+0x90/0x90
[ 245.444435] ? kernel_init+0x5/0xf0
[ 245.446290] ? ret_from_fork+0x19/0x30
[ 245.448983]
[ 245.448983] Showing all locks held in the system:
[ 245.453032] 2 locks held by khungtaskd/9:
[ 245.455878] #0: (rcu_read_lock){....}, at: [<b10ac7eb>] watchdog+0x9b/0x390
[ 245.460547] #1: (tasklist_lock){.+.+}, at: [<b1075d00>] debug_show_all_locks+0x30/0x1a0
[ 245.466089]
[ 245.468114] =============================================
[ 245.468114]
[ 245.472781] Kernel panic - not syncing: hung_task: blocked tasks
[ 245.475726] CPU: 0 PID: 9 Comm: khungtaskd Not tainted 4.14.0-rc1-00036-ga740636 #1
[ 245.475728] Call Trace:
[ 245.475728] ? panic+0x8a/0x1ac
[ 245.475728] ? watchdog+0x390/0x390
[ 245.475728] ? kthread+0x10b/0x140
[ 245.475728] ? hung_task_panic+0x10/0x10
[ 245.475728] ? __kthread_create_on_node+0x160/0x160
[ 245.475728] ? ret_from_fork+0x19/0x30
[ 245.475728] Kernel Offset: disabled
Elapsed time: 250
initrds=(
/osimage/yocto/yocto-tiny-i386-2016-04-22.cgz
/lkp/scheduled/vm-ivb41-yocto-ia32-21/trinity-300s-yocto-tiny-i386-2016-04-22.cgz-a74063662f3a456a402bd40fa23e104196c78993-20170926-10223-190qn8m-0.cgz
/lkp/lkp/lkp-i386.cgz
/osimage/deps/debian-x86_64-2016-08-31.cgz/run-ipconfig.i386_2016-09-03.cgz
/osimage/pkg/static/trinity-i386.cgz
)
cat "${initrds[@]}" > /fs/sda5/initrd-vm-ivb41-yocto-ia32-21
kvm=(
qemu-system-x86_64
-enable-kvm
-cpu IvyBridge
-kernel /pkg/linux/i386-randconfig-b0-09251522/gcc-5/a74063662f3a456a402bd40fa23e104196c78993/vmlinuz-4.14.0-rc1-00036-ga740636
-initrd /fs/sda5/initrd-vm-ivb41-yocto-ia32-21
-m 420
-smp 1
-device e1000,netdev=net0
-netdev user,id=net0
-boot order=nc
-no-reboot
-watchdog i6300esb
-watchdog-action debug
-rtc base=localtime
-drive file=/fs/sda5/disk0-vm-ivb41-yocto-ia32-21,media=disk,if=virtio
-pidfile /dev/shm/kboot/pid-vm-ivb41-yocto-ia32-21
-serial file:/dev/shm/kboot/vm-ivb41-yocto-ia32-21/serial
-serial file:/dev/shm/kboot/vm-ivb41-yocto-ia32-21/kmsg
-daemonize
-display none
-monitor null
)
append=(
ip=::::vm-ivb41-yocto-ia32-21::dhcp
root=/dev/ram0
user=lkp
job=/lkp/scheduled/vm-ivb41-yocto-ia32-21/trinity-300s-yocto-tiny-i386-2016-04-22.cgz-a74063662f3a456a402bd40fa23e104196c78993-20170926-10223-190qn8m-0.yaml
ARCH=i386
kconfig=i386-randconfig-b0-09251522
branch=linux-devel/devel-hourly-2017092501
commit=a74063662f3a456a402bd40fa23e104196c78993
BOOT_IMAGE=/pkg/linux/i386-randconfig-b0-09251522/gcc-5/a74063662f3a456a402bd40fa23e104196c78993/vmlinuz-4.14.0-rc1-00036-ga740636
max_uptime=1500
RESULT_ROOT=/result/trinity/300s/vm-ivb41-yocto-ia32/yocto-tiny-i386-2016-04-22.cgz/i386-randconfig-b0-09251522/gcc-5/a74063662f3a456a402bd40fa23e104196c78993/0
LKP_SERVER=inn
debug
apic=debug
sysrq_always_enabled
rcupdate.rcu_cpu_stall_timeout=100
net.ifnames=0
printk.devkmsg=on
panic=-1
softlockup_panic=1
nmi_watchdog=panic
oops=panic
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email
Thanks,
Xiaolong
3 years, 6 months