[lkp] [x86/topology] 6a1447190e: BUG: unable to handle kernel paging request at ffffffffffffffff
by kernel test robot
FYI, we noticed the below changes on
https://git.kernel.org/pub/scm/linux/kernel/git/peterz/queue.git perf/core
commit 6a1447190e7f7540be17414db801ac6a12d77566 ("x86/topology: Create logical package id")
+------------------------------------------+------------+------------+
| | 0a5d007806 | 6a1447190e |
+------------------------------------------+------------+------------+
| boot_successes | 0 | 4 |
| boot_failures | 1 | 4 |
| invoked_oom-killer:gfp_mask=0x | 1 | |
| Mem-Info | 1 | |
| Out_of_memory:Kill_process | 1 | |
| BUG:unable_to_handle_kernel | 0 | 4 |
| Oops | 0 | 4 |
| RIP:__kmalloc_track_caller | 0 | 4 |
| Kernel_panic-not_syncing:Fatal_exception | 0 | 4 |
| backtrace:register_sched_domain_sysctl | 0 | 4 |
| backtrace:sched_init_smp | 0 | 4 |
| backtrace:kernel_init_freeable | 0 | 4 |
+------------------------------------------+------------+------------+
[ 4.680128] KVM setup async PF for cpu 159
[ 4.680132] kvm-stealtime: cpu 159, msr 371eca40
[ 4.686741] smpboot: Total of 160 processors activated (936319.36 BogoMIPS)
[ 5.326197] BUG: unable to handle kernel paging request at ffffffffffffffff
[ 5.328153] IP: [<ffffffff81211303>] __kmalloc_track_caller+0x106/0x1cb
[ 5.329868] PGD 220b067 PUD 220d067 PMD 0
[ 5.331359] Oops: 0000 [#1] SMP
[ 5.332563] Modules linked in:
[ 5.333646] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 4.5.0-rc4-00211-g6a14471 #1
[ 5.335903] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Debian-1.8.2-1 04/01/2014
[ 5.338445] task: ffff880035ac0000 ti: ffff880035a9c000 task.ti: ffff880035a9c000
[ 5.340884] RIP: 0010:[<ffffffff81211303>] [<ffffffff81211303>] __kmalloc_track_caller+0x106/0x1cb
[ 5.344055] RSP: 0000:ffff880035a9fda8 EFLAGS: 00010282
[ 5.345774] RAX: 0000000000000000 RBX: 00000000024000c0 RCX: 000000000000001d
[ 5.347876] RDX: 000000000000001c RSI: 0000000000000509 RDI: 0000000000018860
[ 5.349896] RBP: ffff880035a9fdd8 R08: ffff880035e18860 R09: ffffffffffffffff
[ 5.351857] R10: ffff880035807e00 R11: 0000000000000000 R12: ffff880035807e00
[ 5.353752] R13: 00000000024000c0 R14: 0000000000000005 R15: ffffffff811205ab
[ 5.355215] FS: 0000000000000000(0000) GS:ffff880035e00000(0000) knlGS:0000000000000000
[ 5.357180] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b
[ 5.358607] CR2: ffffffffffffffff CR3: 000000000220a000 CR4: 00000000000006f0
[ 5.360042] Stack:
[ 5.360779] 0000000000000005 ffff880035a9fe18 0000000000000005 0000000000000000
[ 5.362991] 0000000000015680 0000000000000001 ffff880035a9fdf8 ffffffff811d7d77
[ 5.365119] 0000000000000000 ffff880033468000 ffff880035a9fe80 ffffffff811205ab
[ 5.367410] Call Trace:
[ 5.368170] [<ffffffff811d7d77>] kstrdup+0x2e/0x4b
[ 5.369435] [<ffffffff811205ab>] register_sched_domain_sysctl+0xda/0x4fc
[ 5.371041] [<ffffffff823f4105>] sched_init_smp+0x51e/0x5f4
[ 5.372269] [<ffffffff8106ff4c>] ? mtrr_aps_init+0x3b/0x44
[ 5.373853] [<ffffffff823e781c>] ? native_smp_cpus_done+0x105/0x10a
[ 5.375485] [<ffffffff823d3046>] kernel_init_freeable+0x110/0x217
[ 5.377214] [<ffffffff81a64e05>] ? rest_init+0x8c/0x8c
[ 5.378598] [<ffffffff81a64e13>] kernel_init+0xe/0xe4
[ 5.380171] [<ffffffff81a6fbdf>] ret_from_fork+0x3f/0x70
[ 5.381818] [<ffffffff81a64e05>] ? rest_init+0x8c/0x8c
[ 5.383479] Code: 75 1e 4c 89 d7 4c 89 f9 83 ca ff 44 89 ee 4c 89 55 d0 e8 a4 cb ff ff 4c 8b 55 d0 49 89 c1 eb 26 49 63 42 20 48 8d 4a 01 49 8b 3a <49> 8b 1c 01 4c 89 c8 65 48 0f c7 0f 0f 94 c0 84 c0 74 a5 49 63
[ 5.394694] RIP [<ffffffff81211303>] __kmalloc_track_caller+0x106/0x1cb
[ 5.397400] RSP <ffff880035a9fda8>
[ 5.398839] CR2: ffffffffffffffff
[ 5.400237] ---[ end trace 15bbead4b677a907 ]---
[ 5.401972] Kernel panic - not syncing: Fatal exception
To reproduce:
git clone git://git.kernel.org/pub/scm/linux/kernel/git/wfg/lkp-tests.git
cd lkp-tests
bin/lkp install job.yaml # job file is attached in this email
bin/lkp run job.yaml
Thanks,
Kernel Test Robot
3 years, 9 months
Re: [LKP] [vfs] 0e00f1a079: INFO: trying to register non-static key.
by Fengguang Wu
Got it, thanks!
On Fri, Feb 26, 2016 at 09:02:15AM +0800, Long, Wai Man wrote:
> Hi,
>
> The new v4 patch should eliminate the INFO and backtrace that you saw in the boot test.
>
> Thanks,
> Longman
>
> -----Original Message-----
> From: kernel test robot [mailto:fengguang.wu@intel.com]
> Sent: Tuesday, February 23, 2016 9:05 PM
> To: Long, Wai Man
> Cc: LKP; 0day robot; wfg(a)linux.intel.com
> Subject: [vfs] 0e00f1a079: INFO: trying to register non-static key.
>
> Greetings,
>
> 0day kernel testing robot got the below dmesg and the first bad commit is
>
> https://github.com/0day-ci/linux Waiman-Long/vfs-Use-per-cpu-list-for-SB-s-s_inodes-list/20160224-030850
>
> commit 0e00f1a079552d9c4e397d9d5cef9e7f16110493
> Author: Waiman Long <Waiman.Long(a)hpe.com>
> AuthorDate: Tue Feb 23 14:04:32 2016 -0500
> Commit: 0day robot <fengguang.wu(a)intel.com>
> CommitDate: Wed Feb 24 03:08:57 2016 +0800
>
> vfs: Use per-cpu list for superblock's inode list
>
> When many threads are trying to add or delete inode to or from
> a superblock's s_inodes list, spinlock contention on the list can
> become a performance bottleneck.
>
> This patch changes the s_inodes field to become a per-cpu list with
> per-cpu spinlocks. As a result, the following superblock inode list
> (sb->s_inodes) iteration functions in vfs are also being modified:
>
> 1. iterate_bdevs()
> 2. drop_pagecache_sb()
> 3. wait_sb_inodes()
> 4. evict_inodes()
> 5. invalidate_inodes()
> 6. fsnotify_unmount_inodes()
> 7. add_dquot_ref()
> 8. remove_dquot_ref()
>
> With an exit microbenchmark that creates a large number of threads,
> attachs many inodes to them and then exits. The runtimes of that
> microbenchmark with 1000 threads before and after the patch on a
> 4-socket Intel E7-4820 v3 system (40 cores, 80 threads) were as
> follows:
>
> Kernel Elapsed Time System Time
> ------ ------------ -----------
> Vanilla 4.5-rc4 65.29s 82m14s
> Patched 4.5-rc4 22.81s 23m03s
>
> Before the patch, spinlock contention at the inode_sb_list_add()
> function at the startup phase and the inode_sb_list_del() function at
> the exit phase were about 79% and 93% of total CPU time respectively
> (as measured by perf). After the patch, the percpu_list_add()
> function consumed only about 0.04% of CPU time at startup phase. The
> percpu_list_del() function consumed about 0.4% of CPU time at exit
> phase. There were still some spinlock contention, but they happened
> elsewhere.
>
> Signed-off-by: Waiman Long <Waiman.Long(a)hpe.com>
>
> +----------------------------------------+------------+------------+------------+
> | | a85f89ba33 | 0e00f1a079 | 2220d6e058 |
> +----------------------------------------+------------+------------+------------+
> | boot_successes | 63 | 0 | 0 |
> | boot_failures | 0 | 26 | 13 |
> | INFO:trying_to_register_non-static_key | 0 | 26 | 13 |
> | backtrace:vfs_kern_mount | 0 | 26 | 13 |
> | backtrace:mnt_init | 0 | 26 | 13 |
> | backtrace:vfs_caches_init | 0 | 26 | 13 |
> +----------------------------------------+------------+------------+------------+
>
> [ 0.726094] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
> [ 0.728053] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
> [ 0.728053] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
> [ 0.730572] INFO: trying to register non-static key.
> [ 0.730572] INFO: trying to register non-static key.
> [ 0.732040] the code is fine but needs lockdep annotation.
> [ 0.732040] the code is fine but needs lockdep annotation.
> [ 0.733653] turning off the locking correctness validator.
>
> git bisect start 2220d6e058736159c7d557d4491c25b71c510709 81f70ba233d5f660e1ea5fe23260ee323af5d53a --
> git bisect bad 2ca1641b3b1ae6ae0303dab3ce3ca0b9f261a4b7 # 08:09 0- 24 Merge 'linux-review/PC-Liao/ASoC-mediatek-remove-soft-reset-and-add-second-I2S-clock/20160223-162321' into devel-spot-201602240728
> git bisect good d37dbb47aaaa323808a0fccd99a2c77708176db1 # 08:20 22+ 0 Merge 'kees/kspp/lkdtm-atomics' into devel-spot-201602240728
> git bisect bad b5566f3331202e10f593e2789f9ae218ff9a88b1 # 08:35 0- 17 Merge 'linux-review/Mauro-Carvalho-Chehab/ivtv-mailbox-avoid-confusing-smatch/20160223-181216' into devel-spot-201602240728
> git bisect bad 0d0183e5ed25c883f21c23a77ad170eb2dadf33d # 08:47 0- 24 Merge 'linux-review/Hans-Verkuil/soc_camera-omap1-move-to-staging-in-preparation-for-removal/20160223-201714' into devel-spot-201602240728
> git bisect bad 1238373f95745817f3585ceba8a7803404e78076 # 09:02 0- 22 Merge 'linux-review/Waiman-Long/vfs-Use-per-cpu-list-for-SB-s-s_inodes-list/20160224-030850' into devel-spot-201602240728
> git bisect good 31156742329f456bd2f8561d1559ae12529463e9 # 09:07 20+ 0 Merge 'kees/dm/do_mounts' into devel-spot-201602240728
> git bisect good 583c2e5225d522b65d389e6bed00dc79d923731d # 09:13 20+ 0 Merge 'kvmarm/master' into devel-spot-201602240728
> git bisect good 540792edaf897fb34550cfce660da1e7e3a2eb76 # 09:20 22+ 0 Merge 'linux-review/Sergei-Ianovich/mtd-support-BB-SRAM-on-ICP-DAS-LP-8x4x/20160224-030049' into devel-spot-201602240728
> git bisect good a85f89ba3365a313432caf59f43e8de6aa78fb45 # 09:26 22+ 0 fsnotify: Simplify inode iteration on umount
> git bisect bad 0e00f1a079552d9c4e397d9d5cef9e7f16110493 # 09:31 0- 22 vfs: Use per-cpu list for superblock's inode list
> # first bad commit: [0e00f1a079552d9c4e397d9d5cef9e7f16110493] vfs: Use per-cpu list for superblock's inode list
> git bisect good a85f89ba3365a313432caf59f43e8de6aa78fb45 # 09:35 63+ 0 fsnotify: Simplify inode iteration on umount
> # extra tests with DEBUG_INFO
> git bisect bad 0e00f1a079552d9c4e397d9d5cef9e7f16110493 # 09:41 0- 12 vfs: Use per-cpu list for superblock's inode list
> # extra tests on HEAD of linux-devel/devel-spot-201602240728
> git bisect bad 2220d6e058736159c7d557d4491c25b71c510709 # 09:41 0- 13 0day head guard for 'devel-spot-201602240728'
> # extra tests on tree/branch linux-review/Waiman-Long/vfs-Use-per-cpu-list-for-SB-s-s_inodes-list/20160224-030850
> git bisect bad 0e00f1a079552d9c4e397d9d5cef9e7f16110493 # 09:46 0- 26 vfs: Use per-cpu list for superblock's inode list
> # extra tests with first bad commit reverted
> git bisect good fad09e3ade895c6867555817cb19c7d3bb0bcd53 # 09:57 66+ 0 Revert "vfs: Use per-cpu list for superblock's inode list"
> # extra tests on tree/branch linus/master
> git bisect good 4de8ebeff8ddefaceeb7fc6a9b1a514fc9624509 # 10:01 65+ 0 Merge tag 'trace-fixes-v4.5-rc5' of git://git.kernel.org/pub/scm/linux/kernel/git/rostedt/linux-trace
> # extra tests on tree/branch linux-next/master
> git bisect good 538fe56e2a6658270b2094c3f9f2439cf1887425 # 10:04 65+ 0 Add linux-next specific files for 20160223
>
>
> 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 256
> -smp 1
> -device e1000,netdev=net0
> -netdev user,id=net0
> -boot order=nc
> -no-reboot
> -watchdog i6300esb
> -rtc base=localtime
> -serial stdio
> -display none
> -monitor null
> )
>
> append=(
> hung_task_panic=1
> earlyprintk=ttyS0,115200
> systemd.log_level=err
> 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[*]}"
> ----------------------------------------------------------------------------
>
> ---
> 0-DAY kernel test infrastructure Open Source Technology Center
> https://lists.01.org/pipermail/lkp Intel Corporation
3 years, 9 months
[lkp] [kernfs] abb29ac83c: WARNING: CPU: 3 PID: 406 at fs/sysfs/file.c:117 sysfs_kf_read+0x75/0x90()
by kernel test robot
FYI, we noticed the below changes on
https://github.com/0day-ci/linux Chris-Wilson/kernfs-Move-faulting-copy_user-operations-outside-of-the-mutex/20160223-194306
commit abb29ac83c6117ea1311b0b0d7bcb24316f907e7 ("kernfs: Move faulting copy_user operations outside of the mutex")
+---------------------------------------------+------------+------------+
| | 112d125a89 | abb29ac83c |
+---------------------------------------------+------------+------------+
| boot_successes | 23 | 18 |
| boot_failures | 0 | 5 |
| WARNING:at_fs/sysfs/file.c:#sysfs_kf_read() | 0 | 4 |
| backtrace:vfs_read | 0 | 4 |
| backtrace:SyS_read | 0 | 4 |
| backtrace:__vfs_read | 0 | 1 |
| BUG:kernel_test_crashed | 0 | 1 |
+---------------------------------------------+------------+------------+
[ 7.695817] ------------[ cut here ]------------
[ 7.696041] md: bind<sda7>
[ 7.696149] ------------[ cut here ]------------
[ 7.696153] WARNING: CPU: 3 PID: 406 at fs/sysfs/file.c:117 sysfs_kf_read+0x75/0x90()
[ 7.696166] Modules linked in: sg sr_mod cdrom sd_mod snd_hda_codec_realtek coretemp snd_hda_codec_generic snd_hda_codec_hdmi kvm_intel dcdbas ata_generic pata_acpi ata_piix snd_hda_intel kvm irqbypass snd_hda_codec i7core_edac snd_hda_core crc32c_intel snd_hwdep pcspkr serio_raw edac_core firewire_ohci libata snd_pcm usb_storage firewire_core crc_itu_t snd_timer snd soundcore shpchp acpi_cpufreq broadcom bcm_phy_lib
[ 7.696167] CPU: 3 PID: 406 Comm: mdadm Not tainted 4.5.0-rc4-00017-gabb29ac #1
[ 7.696168] Hardware name: Dell Inc. Studio XPS 8000/0X231R, BIOS A01 08/11/2009
[ 7.696170] 0000000000000000 ffff8800a9bbbda8 ffffffff8141e56a 0000000000000000
[ 7.696170] ffffffff81be47f8 ffff8800a9bbbde0 ffffffff81078ec6 0000000000000400
[ 7.696171] ffff8800aa3a6800 ffff8800a9bbbf20 ffff8800aaddc680 00007ffcebaa7c80
[ 7.696172] Call Trace:
[ 7.696177] [<ffffffff8141e56a>] dump_stack+0x63/0x89
[ 7.696180] [<ffffffff81078ec6>] warn_slowpath_common+0x86/0xc0
[ 7.696181] [<ffffffff81078fba>] warn_slowpath_null+0x1a/0x20
[ 7.696182] [<ffffffff81270b25>] sysfs_kf_read+0x75/0x90
[ 7.696183] [<ffffffff8126fe4b>] kernfs_fop_read+0xab/0x160
[ 7.696185] [<ffffffff811f0dc8>] __vfs_read+0x28/0xd0
[ 7.696187] [<ffffffff813accc3>] ? security_file_permission+0xa3/0xc0
[ 7.696188] [<ffffffff811f1ac7>] ? rw_verify_area+0x57/0xd0
[ 7.696188] [<ffffffff811f1bc6>] vfs_read+0x86/0x130
[ 7.696190] [<ffffffff811f2af6>] SyS_read+0x46/0xa0
[ 7.696192] [<ffffffff818daf2e>] entry_SYSCALL_64_fastpath+0x12/0x6d
[ 7.696193] ---[ end trace 2d6d55c322d0a900 ]---
[ 7.698291] md: bind<sda6>
To reproduce:
git clone git://git.kernel.org/pub/scm/linux/kernel/git/wfg/lkp-tests.git
cd lkp-tests
bin/lkp install job.yaml # job file is attached in this email
bin/lkp run job.yaml
Thanks,
Kernel Test Robot
3 years, 9 months
[lkp] [of] 681c3cb0e4: INFO: possible circular locking dependency detected ]
by kernel test robot
FYI, we noticed the below changes on
https://github.com/0day-ci/linux Alan-Tull/of-add-pre-operation-notifications/20160225-063254
commit 681c3cb0e4d77a0eed48269e2db81bffb97e6604 ("of: add pre-operation notifications")
[ 15.344947]
[ 15.345268] ======================================================
[ 15.345268] ======================================================
[ 15.346491] [ INFO: possible circular locking dependency detected ]
[ 15.346491] [ INFO: possible circular locking dependency detected ]
[ 15.347758] 4.5.0-rc3-00013-g681c3cb #2 Not tainted
[ 15.347758] 4.5.0-rc3-00013-g681c3cb #2 Not tainted
[ 15.348734] -------------------------------------------------------
[ 15.348734] -------------------------------------------------------
[ 15.349977] swapper/0/1 is trying to acquire lock:
[ 15.349977] swapper/0/1 is trying to acquire lock:
[ 15.350953] (
[ 15.350953] (of_mutexof_mutex){+.+.+.}){+.+.+.}, at: , at: [<816768c2>] of_device_uevent+0x102/0x1a0
[<816768c2>] of_device_uevent+0x102/0x1a0
[ 15.352460]
[ 15.352460] but task is already holding lock:
[ 15.352460]
[ 15.352460] but task is already holding lock:
[ 15.353648] (
[ 15.353648] ((of_reconfig_chain).rwsem(of_reconfig_chain).rwsem){.+.+.+}){.+.+.+}, at: , at: [<8106db1b>] __blocking_notifier_call_chain+0x1b/0x60
[<8106db1b>] __blocking_notifier_call_chain+0x1b/0x60
[ 15.355651]
[ 15.355651] which lock already depends on the new lock.
[ 15.355651]
[ 15.355651]
[ 15.355651] which lock already depends on the new lock.
[ 15.355651]
[ 15.357273]
[ 15.357273] the existing dependency chain (in reverse order) is:
Thanks,
Kernel Test Robot
3 years, 9 months
[lkp] [cpufreq] 8fb47ff100: -3.2% unixbench.score
by kernel test robot
FYI, we noticed the below changes on
https://git.kernel.org/pub/scm/linux/kernel/git/next/linux-next.git master
commit 8fb47ff100af48034eb11449a81f42af24213987 ("cpufreq: governor: Replace timers with utilization update callbacks")
=========================================================================================
compiler/kconfig/nr_task/rootfs/tbox_group/test/testcase:
gcc-4.9/x86_64-rhel/1/debian-x86_64-2015-02-07.cgz/nhm-white/shell1/unixbench
commit:
402c43ed2d7433d7a0a4cf2767bedc239f680155
8fb47ff100af48034eb11449a81f42af24213987
402c43ed2d7433d7 8fb47ff100af48034eb11449a8
---------------- --------------------------
%stddev %change %stddev
\ | \
1555 ± 0% -3.2% 1506 ± 0% unixbench.score
286697 ± 0% -7.0% 266678 ± 0% unixbench.time.involuntary_context_switches
17730295 ± 0% -3.1% 17172749 ± 0% unixbench.time.minor_page_faults
616646 ± 0% -3.1% 597250 ± 0% unixbench.time.voluntary_context_switches
288.75 ± 0% -3.0% 280.00 ± 0% turbostat.Avg_MHz
1956505 ± 12% -39.9% 1176054 ± 8% cpuidle.C1E-NHM.time
7033 ± 4% -18.0% 5765 ± 1% cpuidle.C1E-NHM.usage
14204 ± 0% -2.8% 13801 ± 0% vmstat.system.cs
1628 ± 0% +43.3% 2332 ± 0% vmstat.system.in
2855 ± 1% -11.1% 2538 ± 1% sched_debug.cfs_rq:/.exec_clock.stddev
43.25 ± 19% -39.3% 26.25 ± 18% sched_debug.cfs_rq:/.load_avg.2
20.00 ± 5% +135.0% 47.00 ± 68% sched_debug.cfs_rq:/.load_avg.7
15987 ± 3% -14.5% 13672 ± 1% sched_debug.cfs_rq:/.min_vruntime.stddev
0.33 ± 14% +38.1% 0.45 ± 5% sched_debug.cfs_rq:/.nr_running.avg
2.00 ± 79% +450.0% 11.00 ± 19% sched_debug.cfs_rq:/.runnable_load_avg.2
5.55 ± 19% +34.1% 7.44 ± 10% sched_debug.cfs_rq:/.runnable_load_avg.avg
-33720 ± -1% -17.3% -27894 ± -4% sched_debug.cfs_rq:/.spread0.4
-33413 ± -3% -13.7% -28847 ± -3% sched_debug.cfs_rq:/.spread0.5
-33146 ± -3% -18.0% -27185 ± -1% sched_debug.cfs_rq:/.spread0.6
-33527 ± -1% -12.8% -29230 ± -2% sched_debug.cfs_rq:/.spread0.7
-17639 ± -2% -16.2% -14779 ± -4% sched_debug.cfs_rq:/.spread0.avg
-34541 ± -1% -14.2% -29641 ± -2% sched_debug.cfs_rq:/.spread0.min
15990 ± 3% -14.5% 13674 ± 1% sched_debug.cfs_rq:/.spread0.stddev
708107 ± 10% +22.0% 863894 ± 5% sched_debug.cpu.avg_idle.0
13049 ± 44% -37.5% 8162 ± 38% sched_debug.cpu.curr->pid.6
22214 ± 0% -13.1% 19305 ± 0% sched_debug.cpu.curr->pid.max
9922 ± 4% -7.6% 9164 ± 1% sched_debug.cpu.curr->pid.stddev
29.00 ± 12% +162.1% 76.00 ± 36% sched_debug.cpu.load.2
124.75 ± 61% -63.1% 46.00 ± 42% sched_debug.cpu.load.3
15.50 ± 92% +343.5% 68.75 ± 59% sched_debug.cpu.load.4
54.67 ± 33% +43.6% 78.50 ± 3% sched_debug.cpu.load.7
0.35 ± 11% +28.9% 0.45 ± 11% sched_debug.cpu.nr_running.avg
8.52 ± 15% +29.7% 11.06 ± 10% sched_debug.cpu.nr_uninterruptible.stddev
25833 ± 0% +9.4% 28264 ± 2% sched_debug.cpu.ttwu_local.3
18030 ± 2% +10.7% 19951 ± 1% sched_debug.cpu.ttwu_local.5
17450 ± 1% +9.8% 19158 ± 1% sched_debug.cpu.ttwu_local.6
nhm-white: Nehalem
Memory: 6G
unixbench.score
1560 ++-------------------------------------------------------------------+
| .*. .*. .*. .*.*.*.. .*. .*. .*.*.*. .*.*.*.*.* |
1550 *+*.*.*.* * *.*.*.* * * *.* * * |
1540 ++ |
| |
1530 ++ |
| |
1520 ++ |
| |
1510 ++ O O O O O O O |
1500 ++ O O O
O O O O O O O O O O O O O O O |
1490 ++ O O O O O O O O O |
| O |
1480 ++-------------------------------------------------------------------+
unixbench.time.minor_page_faults
1.78e+07 ++---------------------------------------------------------------+
| .**.*.* |
1.77e+07 *+*.*.*.*.**.*.*.*.*.*.*.*.*.*.*.**.*.*.*.*.*.*.*.*.* |
1.76e+07 ++ |
| |
1.75e+07 ++ |
1.74e+07 ++ |
| |
1.73e+07 ++ |
1.72e+07 ++ |
| O O O OO O O O O O
1.71e+07 O+O O O O O O |
1.7e+07 ++ O O OO O O O O O O |
| O O O O O OO O |
1.69e+07 ++---------------------------------------------------------------+
unixbench.time.voluntary_context_switches
620000 ++-----------------------------------------------------------------+
| .*. |
615000 *+*.*.*.*.*.*.*. .*.*.*.*.*.*.**. .*.*.*.*.*.*.*.*.* *.* |
| *.*.* * |
| |
610000 ++ |
| |
605000 ++ |
| |
600000 ++ |
| O O O |
| O O O O O O O
595000 ++ O O O O O O |
O O O O O O O O O O O |
590000 ++----------------O-------O-O-O-O-OO-O-----------------------------+
unixbench.time.involuntary_context_switches
290000 ++-----------------------------------------------------------------+
*.*.*.*. .*.*.*.*.*. .*. .*. .*.*.*.* |
285000 ++ * *.*.*.*.*.* **.*.*.*.*.*.* *.* |
| |
280000 ++ |
| |
275000 ++ |
| |
270000 ++ |
| O O O O O O O O O
265000 ++ O |
O O O O |
260000 ++ O O O |
| O O O O O O O O O O OO O O O O O O |
255000 ++-----------------------------------------------------------------+
vmstat.system.in
2400 ++-------------------------------------------------------------------+
| O O O O O O O O O O O O O O O
2200 O+O O O O O O O O O O O O O O O O O O O |
| |
2000 ++ |
| |
1800 ++ |
| |
1600 *+*.*.*.*.*.*.*.*.*.*.*.* *.* *.*.* *.* *.*.*.* |
| : : + : : : + : |
1400 ++ : : *..* : : : *.* : |
| * : : * : : |
1200 ++ :: :: |
| * * |
1000 ++-------------------------------------------------------------------+
[*] bisect-good sample
[O] bisect-bad sample
To reproduce:
git clone git://git.kernel.org/pub/scm/linux/kernel/git/wfg/lkp-tests.git
cd lkp-tests
bin/lkp install job.yaml # job file is attached in this email
bin/lkp run job.yaml
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,
Ying Huang
3 years, 9 months
[i2c-mux] 3489746df0: WARNING: CPU: 0 PID: 1 at drivers/base/devres.c:888 devm_kfree()
by kernel test robot
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
https://github.com/0day-ci/linux Peter-Rosin/i2c-mux-cleanup-and-locking-update/20160106-000205
commit 3489746df00f2f18b1a6dc2ba4de263e980cfbb0
Author: Peter Rosin <peda(a)axentia.se>
AuthorDate: Tue Jan 5 16:57:13 2016 +0100
Commit: 0day robot <fengguang.wu(a)intel.com>
CommitDate: Wed Jan 6 00:02:09 2016 +0800
i2c-mux: move the slave side adapter management to i2c_mux_core
All muxes have slave side adapters, many have some arbitrary number of
them. Handle this in the mux core, so that drivers are simplified.
Add i2c_mux_reserve_adapter that can be used when it is known in advance
how many child adapters that is to be added. This avoids reallocating
memory.
Drop i2c_del_mux_adapter and replace it with i2c_del_mux_adapters, since
no mux driver is dynamically deleting individual child adapters anyway.
Signed-off-by: Peter Rosin <peda(a)axentia.se>
+------------------------------------------------------------------+------------+------------+------------+
| | f3ce0531d6 | 3489746df0 | 328de02ee7 |
+------------------------------------------------------------------+------------+------------+------------+
| boot_successes | 16 | 0 | 0 |
| boot_failures | 76 | 22 | 43 |
| Out_of_memory:Kill_process | 46 | | |
| Kernel_panic-not_syncing:Out_of_memory_and_no_killable_processes | 2 | | |
| Kernel_panic-not_syncing:Attempted_to_kill_init!exitcode= | 30 | 21 | 13 |
| WARNING:at_drivers/base/devres.c:#devm_kfree() | 0 | 22 | 43 |
| backtrace:of_unittest | 0 | 22 | 43 |
| backtrace:kernel_init_freeable | 0 | 22 | 43 |
+------------------------------------------------------------------+------------+------------+------------+
[ 17.872856] overlay_removal_is_ok: overlay #5 is not topmost
[ 17.876661] of_overlay_destroy: removal check failed for overlay #5
[ 17.881163] ------------[ cut here ]------------
[ 17.882437] WARNING: CPU: 0 PID: 1 at drivers/base/devres.c:888 devm_kfree+0x61/0x76()
[ 17.884828] CPU: 0 PID: 1 Comm: swapper Not tainted 4.4.0-rc3-00086-g3489746 #1
[ 17.886694] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Debian-1.8.2-1 04/01/2014
[ 17.889121] 0000000000000000 ffff88000fa3bb60 ffffffff8177aefa ffff88000fa3bb98
[ 17.891562] ffffffff81119965 ffffffff81d0a80c 0000000000000001 00000000fffffffe
[ 17.893975] ffff88000c7e1698 ffff88000c757820 ffff88000fa3bba8 ffffffff81119a50
[ 17.899218] Call Trace:
[ 17.900013] [<ffffffff8177aefa>] dump_stack+0x19/0x1b
[ 17.901286] [<ffffffff81119965>] warn_slowpath_common+0xb6/0xcf
[ 17.902684] [<ffffffff81d0a80c>] ? devm_kfree+0x61/0x76
[ 17.903953] [<ffffffff81119a50>] warn_slowpath_null+0x1a/0x1c
[ 17.905343] [<ffffffff81d0a80c>] devm_kfree+0x61/0x76
[ 17.906657] [<ffffffff8252ad4c>] i2c_mux_reserve_adapters+0xae/0xbf
[ 17.908324] [<ffffffff82842105>] unittest_i2c_mux_probe+0x1af/0x234
[ 17.911148] [<ffffffff82841f56>] ? unittest_i2c_mux_remove+0x90/0x90
[ 17.912678] [<ffffffff82526726>] i2c_device_probe+0x370/0x3b9
[ 17.914076] [<ffffffff81d05602>] driver_probe_device+0x2c5/0x6db
[ 17.915554] [<ffffffff81d05ab7>] __driver_attach+0x9f/0xd5
[ 17.917142] [<ffffffff81d05a18>] ? driver_probe_device+0x6db/0x6db
[ 17.918704] [<ffffffff81d02f3a>] bus_for_each_dev+0x91/0xa9
[ 17.920106] [<ffffffff81d05dc4>] driver_attach+0x1e/0x20
[ 17.921441] [<ffffffff81d03bd7>] bus_add_driver+0x1f7/0x36d
[ 17.922866] [<ffffffff81d06a93>] driver_register+0x10d/0x17f
[ 17.924278] [<ffffffff82528714>] i2c_register_driver+0xb1/0x147
[ 17.925762] [<ffffffff84f32561>] of_unittest_overlay+0xf05/0x1304
[ 17.950459] [<ffffffff84f339e8>] of_unittest+0x1088/0x10b6
[ 17.951884] [<ffffffff817b1043>] ? debug_check_no_obj_freed+0x26/0x28
[ 17.953463] [<ffffffff8125a594>] ? kfree+0x2c7/0x307
[ 17.954749] [<ffffffff84e87520>] ? do_one_initcall+0xf8/0x26c
[ 17.956209] [<ffffffff84f32960>] ? of_unittest_overlay+0x1304/0x1304
[ 17.958778] [<ffffffff84e875a1>] do_one_initcall+0x179/0x26c
[ 17.960190] [<ffffffff84e877f7>] kernel_init_freeable+0x163/0x22b
[ 17.961705] [<ffffffff82e3cc03>] ? rest_init+0x7a/0x7a
[ 17.963019] [<ffffffff82e3cc11>] kernel_init+0xe/0x13f
[ 17.964374] [<ffffffff82e4bfcf>] ret_from_fork+0x3f/0x70
[ 17.965704] [<ffffffff82e3cc03>] ? rest_init+0x7a/0x7a
[ 17.967146] ---[ end trace 3b2b863e959dd3c5 ]---
[ 17.968973] i2c i2c-0: Added multiplexed i2c bus 1
git bisect start 328de02ee7475df3b3e9849542e8d15adaaaa894 168309855a7d1e16db751e9c647119fe2d2dc878 --
git bisect bad 6115822e890d81471eda3c35bf203bf0e1cf2726 # 01:23 0- 18 Merge 'linux-review/Janusz-Dziedzic/mac80211-check-requested-flags-in-ieee80211_tx_prepare_skb/20160105-183905' into devel-spot-201601060011
git bisect bad 579e9f8621453bc381b04a6ad787e9c113b1eeaa # 01:34 0- 2 Merge 'peterz-queue/x86/mm' into devel-spot-201601060011
git bisect bad c13a4bf22a1ca649904deec37080e617fabc661f # 01:47 0- 17 Merge 'linux-review/Adam-Thomson/ASoC-da7219-Correct-BCLK-inversion-for-DSP-DAI-format-mode/20160105-230859' into devel-spot-201601060011
git bisect bad 8cac6f8fb02d6f55c25415e705410fc070a588ec # 01:55 0- 6 Merge 'cgroup/for-4.5' into devel-spot-201601060011
git bisect bad 4dd116948235f2da4e8d88f7df549b8311b16358 # 02:10 0- 4 Merge 'linux-review/Craig-Gallek/soreuseport-change-consume_skb-to-kfree_skb-in-error-case/20160105-235855' into devel-spot-201601060011
git bisect good bdca81bda03d112d0a2f7e972a6da677ef8bedf3 # 02:19 22+ 24 0day base guard for 'devel-spot-201601060011'
git bisect bad b5f2c558c3f81a5ddb89b1b34089d3a4357d05a1 # 02:26 0- 7 Merge 'linux-review/Peter-Rosin/i2c-mux-cleanup-and-locking-update/20160106-000205' into devel-spot-201601060011
git bisect good 5398b7ef6cdbc88581457b26b924081fc53d1de8 # 02:34 22+ 22 i2c: xlr: add interrupt support for Sigma Designs chips
git bisect good fcd0f469776ea6a2bef9c8ee535053a644c3d01a # 02:50 21+ 18 Merge branch 'i2c/for-4.5' into i2c/for-next
git bisect good bdcadbaaf804f56ee4060aada6c0162c91a540ec # 02:59 22+ 15 Merge branch 'i2c/for-4.5' into i2c/for-next
git bisect good 4222e8c152a36c482959d975d714cfbd0ccbd1e6 # 03:04 22+ 22 i2c-mux: add common core data for every mux instance
git bisect bad 3489746df00f2f18b1a6dc2ba4de263e980cfbb0 # 03:14 0- 3 i2c-mux: move the slave side adapter management to i2c_mux_core
git bisect good f3ce0531d6bf0bed5682a36cdf2e8bf044f3b67f # 03:46 22+ 11 i2c-mux: move select and deselect ops to i2c_mux_core
# first bad commit: [3489746df00f2f18b1a6dc2ba4de263e980cfbb0] i2c-mux: move the slave side adapter management to i2c_mux_core
git bisect good f3ce0531d6bf0bed5682a36cdf2e8bf044f3b67f # 03:49 66+ 76 i2c-mux: move select and deselect ops to i2c_mux_core
# extra tests with DEBUG_INFO
git bisect bad 3489746df00f2f18b1a6dc2ba4de263e980cfbb0 # 04:00 0- 17 i2c-mux: move the slave side adapter management to i2c_mux_core
# extra tests on HEAD of linux-devel/devel-spot-201601060011
git bisect bad 328de02ee7475df3b3e9849542e8d15adaaaa894 # 04:00 0- 43 0day head guard for 'devel-spot-201601060011'
# extra tests on tree/branch linux-review/Peter-Rosin/i2c-mux-cleanup-and-locking-update/20160106-000205
git bisect bad b1d2a9bab92639356ad5a2fda8ea046d1216c11c # 04:15 0- 14 i2c-mux: relax locking of the top i2c adapter during i2c controlled muxing
# extra tests on tree/branch linus/master
git bisect good 168309855a7d1e16db751e9c647119fe2d2dc878 # 04:19 66+ 165 Linux 4.4-rc8
# extra tests on tree/branch linux-next/master
git bisect good 8ef79cd05e6894c01ab9b41aa918a402fa8022a7 # 04:34 66+ 58 Add linux-next specific files for 20160105
This script may reproduce the error.
----------------------------------------------------------------------------
#!/bin/bash
kernel=$1
initrd=yocto-minimal-x86_64.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 256
-smp 1
-device e1000,netdev=net0
-netdev user,id=net0
-boot order=nc
-no-reboot
-watchdog i6300esb
-rtc base=localtime
-serial stdio
-display none
-monitor null
)
append=(
hung_task_panic=1
earlyprintk=ttyS0,115200
systemd.log_level=err
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[*]}"
----------------------------------------------------------------------------
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
3 years, 9 months
d06c9270fb: BUG: unable to handle kernel NULL pointer dereference at 0000000000000008
by kernel test robot
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
https://github.com/0day-ci/linux zhangaihua1-huawei-com/fix-waring-calltrace-when-usb-was-ejected/20160224-122520
commit d06c9270fb0d57edd5e5f0e120390e38496c146b
Author: zhangaihua <zhangaihua1(a)huawei.com>
AuthorDate: Wed Feb 24 12:25:21 2016 +0800
Commit: 0day robot <fengguang.wu(a)intel.com>
CommitDate: Wed Feb 24 12:25:23 2016 +0800
fix waring calltrace when usb was ejected.
When the usb was ejected, the bdi will be unregistered without telling
anyone else. Once this happens, will cause a kernel warning calltrace.
We can fix it by adding check before __mark_inode_dirty like ext4 in
ext4_commit_super().
The calltrace :
[ 191.767446] ------------[ cut here ]------------
[ 191.767449] WARNING: at fs/fs-writeback.c:2065
[ 191.767452] Modules linked in:
[ 191.767455]
[ 191.767459] CPU: 9 PID: 1451 Comm: ls Not tainted 4.4.0+ #6
[ 191.767463] Hardware name: Hisilicon PhosphorHi1382 EVB (DT)
[ 191.767466] task: ffffffc00e130c00 ti: ffffffc0d2a88000 task.ti:
ffffffc0d2a88000
[ 191.767478] PC is at __mark_inode_dirty+0x2b0/0x3d0
[ 191.767482] LR is at __mark_inode_dirty+0x2b0/0x3d0
[ 191.767484] pc : [<ffffffc000278490>] lr : [<ffffffc000278490>]
pstate: 80000145
[ 191.767487] sp : ffffffc0d2a8bd80
[ 191.767489] x29: ffffffc0d2a8bd80 x28: ffffffc0d2a88000
[ 191.767493] x27: ffffffc000ccd000 x26: 000000000000003d
[ 191.767498] x25: 000000000000011d x24: ffffffc00d570140
[ 191.767502] x23: 0000000000000000 x22: 0000000000000000
[ 191.767505] x21: ffffffc00d5700b8 x20: ffffffc0d3f201e0
[ 191.767509] x19: 0000000000000001 x18: 0000000000000000
[ 191.767513] x17: 00000000004b59f0 x16: ffffffc00025a640
[ 191.767517] x15: 0000007ff9236214 x14: 0ffffffffffffffe
[ 191.767521] x13: 0000000000000028 x12: 0101010101010101
[ 191.767524] x11: ffffffc0d2a8bac0 x10: ffffffc0d2a8bac0
[ 191.767528] x9 : ffffffd000000000 x8 : 6769737465726564
[ 191.767532] x7 : 0000000000000263 x6 : ffffffc0014d7377
[ 191.767536] x5 : 0000000000000005 x4 : 0000000000000002
[ 191.767539] x3 : ffffffc0014d6dda x2 : 0000000000000018
[ 191.767543] x1 : 0000000000000001 x0 : 0000000000000018
[ 191.767546]
[ 191.767549] ---[ end trace 67962b8750ae0a5b ]---
[ 191.767551] Call trace:
[ 191.767556] [<ffffffc000278490>] __mark_inode_dirty+0x2b0/0x3d0
[ 191.767561] [<ffffffc000262570>] generic_update_time+0x90/0xd0
[ 191.767565] [<ffffffc000264220>] touch_atime+0xa0/0xc0
[ 191.767571] [<ffffffc00025a1b0>] iterate_dir+0x100/0x140
[ 191.767575] [<ffffffc00025a6cc>] SyS_getdents64+0x8c/0x120
[ 191.767582] [<ffffffc000084cb0>] el0_svc_naked+0x24/0x28
[ 191.767644] EXT2-fs (sda1): previous I/O error to superblock detected
[ 191.767644]
[ 191.767654] EXT2-fs (sda1): error: ext2_get_inode: unable to read
inode block - inode=11, block=234
[ 191.767684] EXT2-fs (sda1): previous I/O error to superblock detected
[ 191.767684]
[ 191.767691] EXT2-fs (sda1): error: ext2_get_inode: unable to read
inode block - inode=12, block=234
[ 539.516201] EXT2-fs (sda1): previous I/O error to superblock detected
[ 539.516201]
[ 539.516210] EXT2-fs (sda1): error: ext2_get_inode: unable to read
inode block - inode=11, block=234
[ 539.516240] EXT2-fs (sda1): previous I/O error to superblock detected
[ 539.516240]
[ 539.516247] EXT2-fs (sda1): error: ext2_get_inode: unable to read
inode block - inode=12, block=234
Signed-off-by: Aihua Zhang <zhangaihua1(a)huawei.com>
+------------------------------------------+------------+------------+------------+
| | d89b5f6318 | d06c9270fb | f79afdab55 |
+------------------------------------------+------------+------------+------------+
| boot_successes | 63 | 0 | 0 |
| boot_failures | 0 | 22 | 21 |
| BUG:unable_to_handle_kernel | 0 | 22 | 21 |
| Oops | 0 | 22 | 21 |
| RIP:block_device_ejected | 0 | 22 | 21 |
| Kernel_panic-not_syncing:Fatal_exception | 0 | 22 | 21 |
| backtrace:chown_common | 0 | 22 | 21 |
| backtrace:SyS_chown | 0 | 22 | 21 |
| backtrace:populate_rootfs | 0 | 22 | 21 |
| backtrace:kernel_init_freeable | 0 | 22 | 21 |
+------------------------------------------+------------+------------+------------+
[ 7.199178] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[ 7.201138] pci 0000:00:02.0: Video device with shadowed ROM
[ 7.215319] PCI: CLS 0 bytes, default 64
[ 7.216902] BUG: unable to handle kernel NULL pointer dereference at 0000000000000008
[ 7.230371] IP: [<ffffffff813005db>] block_device_ejected+0x1b/0x90
[ 7.240998] PGD 0
[ 7.242264] Oops: 0000 [#1] SMP
[ 7.255928] Modules linked in:
[ 7.257245] CPU: 1 PID: 1 Comm: swapper/0 Not tainted 4.5.0-rc2-00031-gd06c927 #1
[ 7.270097] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Debian-1.8.2-1 04/01/2014
[ 7.281622] task: ffff880010082b00 ti: ffff880010084000 task.ti: ffff880010084000
[ 7.292652] RIP: 0010:[<ffffffff813005db>] [<ffffffff813005db>] block_device_ejected+0x1b/0x90
[ 7.308195] RSP: 0000:ffff880010087be0 EFLAGS: 00010202
[ 7.310287] RAX: 0000000000000000 RBX: ffff88000fc140c8 RCX: 0000000000000265
[ 7.320007] RDX: 000000001edd83fc RSI: 0000000000000007 RDI: ffff880010042000
[ 7.322661] RBP: ffff880010087be0 R08: 0000000000000000 R09: 0000000000000000
[ 7.333074] R10: 0000000000000000 R11: 0000000000000001 R12: 0000000000000007
[ 7.343713] R13: ffff880010042000 R14: 00000000000041ed R15: ffff88000fc140c8
[ 7.346534] FS: 0000000000000000(0000) GS:ffff880011300000(0000) knlGS:0000000000000000
[ 7.362991] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b
[ 7.364967] CR2: 0000000000000008 CR3: 0000000002009000 CR4: 00000000000006a0
[ 7.375585] Stack:
[ 7.376623] ffff880010087c10 ffffffff8126eae5 ffff88000fc140c8 ffff880010087c98
[ 7.389071] ffff88000fc11258 00000000000041ed ffff880010087c30 ffffffff8126b999
[ 7.397719] 0000000000000046 ffff880010087c98 ffff880010087c70 ffffffff8125bc98
[ 7.409107] Call Trace:
[ 7.410252] [<ffffffff8126eae5>] __mark_inode_dirty+0x25/0x3f0
[ 7.423378] [<ffffffff8126b999>] simple_setattr+0x59/0x90
[ 7.425287] [<ffffffff8125bc98>] notify_change+0x4d8/0x570
[ 7.438328] [<ffffffff8122c077>] chown_common+0x227/0x2a0
[ 7.444561] [<ffffffff810e80d4>] ? __might_sleep+0x64/0xc0
[ 7.446704] [<ffffffff8122dc8b>] SyS_chown+0xcb/0x110
[ 7.463836] [<ffffffff8242622b>] ? initrd_load+0x62/0x62
[ 7.465873] [<ffffffff82426fd5>] do_name+0x1e8/0x369
[ 7.478801] [<ffffffff82426409>] write_buffer+0x2a/0x4b
[ 7.484849] [<ffffffff82426467>] flush_buffer+0x3d/0xc4
[ 7.497933] [<ffffffff824575c5>] __gunzip+0x3c4/0x4ca
[ 7.503993] [<ffffffff824571f0>] ? bunzip2+0x5c2/0x5c2
[ 7.506043] [<ffffffff8242642a>] ? write_buffer+0x4b/0x4b
[ 7.523061] [<ffffffff8242745c>] ? do_collect+0x80/0x80
[ 7.524882] [<ffffffff824576e3>] gunzip+0x18/0x21
[ 7.526659] [<ffffffff8242622b>] ? initrd_load+0x62/0x62
[ 7.539808] [<ffffffff8242685d>] unpack_to_rootfs+0x1a1/0x340
[ 7.542030] [<ffffffff8242622b>] ? initrd_load+0x62/0x62
[ 7.552029] [<ffffffff8242747b>] populate_rootfs+0x1f/0x196
[ 7.553893] [<ffffffff81000435>] do_one_initcall+0xd5/0x2b0
[ 7.567943] [<ffffffff824257d4>] kernel_init_freeable+0x1c4/0x2d0
[ 7.570168] [<ffffffff81b2f890>] ? rest_init+0xe0/0xe0
[ 7.579134] [<ffffffff81b2f8a1>] kernel_init+0x11/0x190
[ 7.580980] [<ffffffff81b3b23f>] ret_from_fork+0x3f/0x70
[ 7.591019] [<ffffffff81b2f890>] ? rest_init+0xe0/0xe0
[ 7.592975] Code: 0b 48 83 05 ef 08 3b 01 01 0f 1f 80 00 00 00 00 55 48 8b 87 c8 00 00 00 48 83 05 b0 d0 3a 01 01 48 83 05 a8 c9 3a 01 01 48 89 e5 <48> 8b 78 08 48 c7 c0 20 30 0d 82 48 85 ff 74 1c 48 8b 47 28 48
[ 7.641649] RIP [<ffffffff813005db>] block_device_ejected+0x1b/0x90
[ 7.654320] RSP <ffff880010087be0>
[ 7.657976] CR2: 0000000000000008
[ 7.662519] ---[ end trace e340baf92a6d9dd8 ]---
[ 7.666240] Kernel panic - not syncing: Fatal exception
git bisect start f79afdab55d304133165274b6cbb298435105720 81f70ba233d5f660e1ea5fe23260ee323af5d53a --
git bisect bad cc76e29ddd63cfce6568dc6476d5c8578818b39d # 13:30 0- 16 Merge 'rcu/torture.2016.02.23a' into devel-catchup-201602241234
git bisect bad 7b118169710db0c5e32bd6c13cf6b17e88cf1251 # 13:43 0- 8 Merge 'asoc/for-next' into devel-catchup-201602241234
git bisect good b9382ee3612e3523233ebb095f3ec602f95188e2 # 14:02 21+ 0 Merge 'jkirsher-next-queue/1GbE' into devel-catchup-201602241234
git bisect bad 23385f751c1edc6e727164f6fdefec670736154e # 14:07 0- 22 Merge 'linux-review/zhangaihua1-huawei-com/fix-waring-calltrace-when-usb-was-ejected/20160224-122520' into devel-catchup-201602241234
git bisect good 2335d05f3a83f5290ec28c1ed30c1c742a37edc9 # 14:13 22+ 0 ext4: kill ext4_mballoc_ready
git bisect good 1f2d779fed21806ffed84aa65617c6125f480e85 # 14:18 22+ 0 ext4: optimize group search for inode allocation
git bisect good fb079071618e3f5b84a3fb4ac9f8ced5fc3b9403 # 14:30 22+ 0 jbd2: unify revoke and tag block checksum handling
git bisect bad d06c9270fb0d57edd5e5f0e120390e38496c146b # 14:36 0- 19 fix waring calltrace when usb was ejected.
git bisect good d89b5f6318c2e4500ee89b7cc84a2ab72da4792e # 14:44 22+ 0 jbd2: save some atomic ops in __JI_COMMIT_RUNNING handling
# first bad commit: [d06c9270fb0d57edd5e5f0e120390e38496c146b] fix waring calltrace when usb was ejected.
git bisect good d89b5f6318c2e4500ee89b7cc84a2ab72da4792e # 14:48 61+ 0 jbd2: save some atomic ops in __JI_COMMIT_RUNNING handling
# extra tests with DEBUG_INFO
git bisect bad d06c9270fb0d57edd5e5f0e120390e38496c146b # 15:01 0- 34 fix waring calltrace when usb was ejected.
# extra tests on HEAD of linux-devel/devel-catchup-201602241234
git bisect bad f79afdab55d304133165274b6cbb298435105720 # 15:01 0- 21 0day head guard for 'devel-catchup-201602241234'
# extra tests on tree/branch linux-review/zhangaihua1-huawei-com/fix-waring-calltrace-when-usb-was-ejected/20160224-122520
git bisect bad d06c9270fb0d57edd5e5f0e120390e38496c146b # 15:07 0- 22 fix waring calltrace when usb was ejected.
# extra tests with first bad commit reverted
git bisect good cc7f59d1899fdb0c9d87cc326e0e4be710e72c6a # 16:30 66+ 0 Revert "fix waring calltrace when usb was ejected."
# extra tests on tree/branch linus/master
git bisect good 84e54c46b2f440a365a5224f1e5f173a462b7cca # 16:47 65+ 2 Merge tag 'dm-4.5-fix' of git://git.kernel.org/pub/scm/linux/kernel/git/device-mapper/linux-dm
# extra tests on tree/branch linux-next/master
git bisect good 538fe56e2a6658270b2094c3f9f2439cf1887425 # 17:04 66+ 4 Add linux-next specific files for 20160223
This script may reproduce the error.
----------------------------------------------------------------------------
#!/bin/bash
kernel=$1
kvm=(
qemu-system-x86_64
-enable-kvm
-cpu kvm64
-kernel $kernel
-m 300
-smp 2
-device e1000,netdev=net0
-netdev user,id=net0
-boot order=nc
-no-reboot
-watchdog i6300esb
-rtc base=localtime
-serial stdio
-display none
-monitor null
)
append=(
hung_task_panic=1
earlyprintk=ttyS0,115200
systemd.log_level=err
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[*]}"
----------------------------------------------------------------------------
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
3 years, 9 months
[lkp] [drm/i915] 0d04b1ac58: piglit.igt/gem_partial_pwrite_pread/writes-after-reads-snoop.crash
by kernel test robot
FYI, we noticed the below changes on
https://github.com/0day-ci/linux Gabriel-Feceoru/drm-i915-Avoid-selecting-unavailable-BSD2-ring/20160222-200144
commit 0d04b1ac5845843ce79c1c2dc77991b4089e31af ("drm/i915: Avoid selecting unavailable BSD2 ring")
2016-02-23 10:17:26 piglit run igt -t igt/gem_partial_pwrite_pread/writes-after-reads-snoop /tmp/lkp/piglit-results-0
Test Environment check: Succeeded.
[0/1] Running Test(s): 0
[1/1] crash: 1
Thank you for running Piglit!
Results have been written to /tmp/lkp/piglit-results-0/results.json
igt/gem_partial_pwrite_pread/writes-after-reads-snoop.seconds: 2.589842649
2016-02-23 10:17:29 piglit summary console /tmp/lkp/piglit-results-0
igt/gem_partial_pwrite_pread/writes-after-reads-snoop: crash
summary:
pass: 0
fail: 0
crash: 1
skip: 0
timeout: 0
warn: 0
dmesg-warn: 0
dmesg-fail: 0
total: 1
/inn/result/piglit/igt-011/snb-black/debian-x86_64-2015-02-07.cgz/x86_64-rhel/gcc-4.9/0d04b1ac5845843ce79c1c2dc77991b4089e31af/0/results
all tests finished
To reproduce:
git clone git://git.kernel.org/pub/scm/linux/kernel/git/wfg/lkp-tests.git
cd lkp-tests
bin/lkp install job.yaml # job file is attached in this email
bin/lkp run job.yaml
Thanks,
Ying Huang
3 years, 9 months
[vfs] 0e00f1a079: INFO: trying to register non-static key.
by kernel test robot
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
https://github.com/0day-ci/linux Waiman-Long/vfs-Use-per-cpu-list-for-SB-s-s_inodes-list/20160224-030850
commit 0e00f1a079552d9c4e397d9d5cef9e7f16110493
Author: Waiman Long <Waiman.Long(a)hpe.com>
AuthorDate: Tue Feb 23 14:04:32 2016 -0500
Commit: 0day robot <fengguang.wu(a)intel.com>
CommitDate: Wed Feb 24 03:08:57 2016 +0800
vfs: Use per-cpu list for superblock's inode list
When many threads are trying to add or delete inode to or from
a superblock's s_inodes list, spinlock contention on the list can
become a performance bottleneck.
This patch changes the s_inodes field to become a per-cpu list with
per-cpu spinlocks. As a result, the following superblock inode list
(sb->s_inodes) iteration functions in vfs are also being modified:
1. iterate_bdevs()
2. drop_pagecache_sb()
3. wait_sb_inodes()
4. evict_inodes()
5. invalidate_inodes()
6. fsnotify_unmount_inodes()
7. add_dquot_ref()
8. remove_dquot_ref()
With an exit microbenchmark that creates a large number of threads,
attachs many inodes to them and then exits. The runtimes of that
microbenchmark with 1000 threads before and after the patch on a
4-socket Intel E7-4820 v3 system (40 cores, 80 threads) were as
follows:
Kernel Elapsed Time System Time
------ ------------ -----------
Vanilla 4.5-rc4 65.29s 82m14s
Patched 4.5-rc4 22.81s 23m03s
Before the patch, spinlock contention at the inode_sb_list_add()
function at the startup phase and the inode_sb_list_del() function at
the exit phase were about 79% and 93% of total CPU time respectively
(as measured by perf). After the patch, the percpu_list_add()
function consumed only about 0.04% of CPU time at startup phase. The
percpu_list_del() function consumed about 0.4% of CPU time at exit
phase. There were still some spinlock contention, but they happened
elsewhere.
Signed-off-by: Waiman Long <Waiman.Long(a)hpe.com>
+----------------------------------------+------------+------------+------------+
| | a85f89ba33 | 0e00f1a079 | 2220d6e058 |
+----------------------------------------+------------+------------+------------+
| boot_successes | 63 | 0 | 0 |
| boot_failures | 0 | 26 | 13 |
| INFO:trying_to_register_non-static_key | 0 | 26 | 13 |
| backtrace:vfs_kern_mount | 0 | 26 | 13 |
| backtrace:mnt_init | 0 | 26 | 13 |
| backtrace:vfs_caches_init | 0 | 26 | 13 |
+----------------------------------------+------------+------------+------------+
[ 0.726094] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.728053] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.728053] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.730572] INFO: trying to register non-static key.
[ 0.730572] INFO: trying to register non-static key.
[ 0.732040] the code is fine but needs lockdep annotation.
[ 0.732040] the code is fine but needs lockdep annotation.
[ 0.733653] turning off the locking correctness validator.
git bisect start 2220d6e058736159c7d557d4491c25b71c510709 81f70ba233d5f660e1ea5fe23260ee323af5d53a --
git bisect bad 2ca1641b3b1ae6ae0303dab3ce3ca0b9f261a4b7 # 08:09 0- 24 Merge 'linux-review/PC-Liao/ASoC-mediatek-remove-soft-reset-and-add-second-I2S-clock/20160223-162321' into devel-spot-201602240728
git bisect good d37dbb47aaaa323808a0fccd99a2c77708176db1 # 08:20 22+ 0 Merge 'kees/kspp/lkdtm-atomics' into devel-spot-201602240728
git bisect bad b5566f3331202e10f593e2789f9ae218ff9a88b1 # 08:35 0- 17 Merge 'linux-review/Mauro-Carvalho-Chehab/ivtv-mailbox-avoid-confusing-smatch/20160223-181216' into devel-spot-201602240728
git bisect bad 0d0183e5ed25c883f21c23a77ad170eb2dadf33d # 08:47 0- 24 Merge 'linux-review/Hans-Verkuil/soc_camera-omap1-move-to-staging-in-preparation-for-removal/20160223-201714' into devel-spot-201602240728
git bisect bad 1238373f95745817f3585ceba8a7803404e78076 # 09:02 0- 22 Merge 'linux-review/Waiman-Long/vfs-Use-per-cpu-list-for-SB-s-s_inodes-list/20160224-030850' into devel-spot-201602240728
git bisect good 31156742329f456bd2f8561d1559ae12529463e9 # 09:07 20+ 0 Merge 'kees/dm/do_mounts' into devel-spot-201602240728
git bisect good 583c2e5225d522b65d389e6bed00dc79d923731d # 09:13 20+ 0 Merge 'kvmarm/master' into devel-spot-201602240728
git bisect good 540792edaf897fb34550cfce660da1e7e3a2eb76 # 09:20 22+ 0 Merge 'linux-review/Sergei-Ianovich/mtd-support-BB-SRAM-on-ICP-DAS-LP-8x4x/20160224-030049' into devel-spot-201602240728
git bisect good a85f89ba3365a313432caf59f43e8de6aa78fb45 # 09:26 22+ 0 fsnotify: Simplify inode iteration on umount
git bisect bad 0e00f1a079552d9c4e397d9d5cef9e7f16110493 # 09:31 0- 22 vfs: Use per-cpu list for superblock's inode list
# first bad commit: [0e00f1a079552d9c4e397d9d5cef9e7f16110493] vfs: Use per-cpu list for superblock's inode list
git bisect good a85f89ba3365a313432caf59f43e8de6aa78fb45 # 09:35 63+ 0 fsnotify: Simplify inode iteration on umount
# extra tests with DEBUG_INFO
git bisect bad 0e00f1a079552d9c4e397d9d5cef9e7f16110493 # 09:41 0- 12 vfs: Use per-cpu list for superblock's inode list
# extra tests on HEAD of linux-devel/devel-spot-201602240728
git bisect bad 2220d6e058736159c7d557d4491c25b71c510709 # 09:41 0- 13 0day head guard for 'devel-spot-201602240728'
# extra tests on tree/branch linux-review/Waiman-Long/vfs-Use-per-cpu-list-for-SB-s-s_inodes-list/20160224-030850
git bisect bad 0e00f1a079552d9c4e397d9d5cef9e7f16110493 # 09:46 0- 26 vfs: Use per-cpu list for superblock's inode list
# extra tests with first bad commit reverted
git bisect good fad09e3ade895c6867555817cb19c7d3bb0bcd53 # 09:57 66+ 0 Revert "vfs: Use per-cpu list for superblock's inode list"
# extra tests on tree/branch linus/master
git bisect good 4de8ebeff8ddefaceeb7fc6a9b1a514fc9624509 # 10:01 65+ 0 Merge tag 'trace-fixes-v4.5-rc5' of git://git.kernel.org/pub/scm/linux/kernel/git/rostedt/linux-trace
# extra tests on tree/branch linux-next/master
git bisect good 538fe56e2a6658270b2094c3f9f2439cf1887425 # 10:04 65+ 0 Add linux-next specific files for 20160223
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 256
-smp 1
-device e1000,netdev=net0
-netdev user,id=net0
-boot order=nc
-no-reboot
-watchdog i6300esb
-rtc base=localtime
-serial stdio
-display none
-monitor null
)
append=(
hung_task_panic=1
earlyprintk=ttyS0,115200
systemd.log_level=err
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[*]}"
----------------------------------------------------------------------------
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
3 years, 9 months