Re: [LKP] [rcu] kernel BUG at include/linux/pagemap.h:149!
by Frederic Weisbecker
On Fri, Sep 11, 2015 at 10:19:47AM +0800, Boqun Feng wrote:
> Subject: [PATCH 01/27] rcu: Don't disable preemption for Tiny and Tree RCU
> readers
>
> Because preempt_disable() maps to barrier() for non-debug builds,
> it forces the compiler to spill and reload registers. Because Tree
> RCU and Tiny RCU now only appear in CONFIG_PREEMPT=n builds, these
> barrier() instances generate needless extra code for each instance of
> rcu_read_lock() and rcu_read_unlock(). This extra code slows down Tree
> RCU and bloats Tiny RCU.
>
> This commit therefore removes the preempt_disable() and preempt_enable()
> from the non-preemptible implementations of __rcu_read_lock() and
> __rcu_read_unlock(), respectively.
>
> For debug purposes, preempt_disable() and preempt_enable() are still
> kept if CONFIG_PREEMPT_COUNT=y, which makes the detection of sleeping
> inside atomic sections still work in non-preemptible kernels.
>
> Signed-off-by: Boqun Feng <boqun.feng(a)gmail.com>
> Signed-off-by: Paul E. McKenney <paulmck(a)linux.vnet.ibm.com>
> ---
> include/linux/rcupdate.h | 6 ++++--
> include/linux/rcutiny.h | 1 +
> kernel/rcu/tree.c | 9 +++++++++
> 3 files changed, 14 insertions(+), 2 deletions(-)
>
> diff --git a/include/linux/rcupdate.h b/include/linux/rcupdate.h
> index d63bb77..6c3cece 100644
> --- a/include/linux/rcupdate.h
> +++ b/include/linux/rcupdate.h
> @@ -297,12 +297,14 @@ void synchronize_rcu(void);
>
> static inline void __rcu_read_lock(void)
> {
> - preempt_disable();
> + if (IS_ENABLED(CONFIG_PREEMPT_COUNT))
> + preempt_disable();
preempt_disable() is a no-op when !CONFIG_PREEMPT_COUNT, right?
Or rather it's a barrier(), which is anyway implied by rcu_read_lock().
So perhaps we can get rid of the IS_ENABLED() check?
1 year, 7 months
Extending the 0-day system with syzkaller?
by David Drysdale
Hi Fengguang / LKP-folk,
Quick question -- how easy is it to add extra builds/tests/checks to
your marvellous 0-day kbuild system?
The reason I ask is that I've recently been exploring syzkaller [1],
which is a system call fuzzer written by some of my colleagues here at
Google (cc'ed). Although it's fairly new, it has uncovered a bunch of
kernel bugs already [2] so I wondered if it might be a good candidate
for inclusion in the 0-day checks at some point.
(As an aside, I'm in the process of writing an article about syzkaller
for LWN, which might also expose it to more folk.)
What do you think?
Thanks,
David
[1] https://github.com/google/syzkaller
[2] https://github.com/google/syzkaller/wiki/Found-Bugs
4 years, 7 months
Adding Xen to the kbuild bot?
by Andy Lutomirski
Hi all-
Would it make sense to add some basic Xen PV testing to the kbuild bot?
qemu can boot Xen like this:
qemu-system-x86_64 -kernel path/to/xen-4.5.2 -initrd 'path/to/bzImage
kernelarg otherkernelarg=value" -append 'xenarg other_xen_arg'
This should work with any kernel image for x86 or x86_64 with CONFIG_XEN=y.
Linux has never been been able to do virtio under Xen, which will
screw up your scripts, but I'm cautiously optimistic that virtio will
work as expected on a Xen guest starting with Linux 4.6. If you want
to play around, it should work in this tree:
https://git.kernel.org/cgit/linux/kernel/git/luto/linux.git/log/?h=virtio...
I'm hoping to get that queued up for real in the next couple of days.
--Andy
4 years, 9 months
[lkp] [futex] 65d8fc777f: +25.6% will-it-scale.per_process_ops
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 65d8fc777f6dcfee12785c057a6b57f679641c90 ("futex: Remove requirement for lock_page() in get_futex_key()")
=========================================================================================
compiler/cpufreq_governor/kconfig/rootfs/tbox_group/test/testcase:
gcc-4.9/performance/x86_64-rhel/debian-x86_64-2015-02-07.cgz/lkp-sbx04/futex1/will-it-scale
commit:
8ad7b378d0d016309014cae0f640434bca7b5e11
65d8fc777f6dcfee12785c057a6b57f679641c90
8ad7b378d0d01630 65d8fc777f6dcfee12785c057a
---------------- --------------------------
%stddev %change %stddev
\ | \
5076304 ± 0% +25.6% 6374220 ± 0% will-it-scale.per_process_ops
1194117 ± 0% +14.4% 1366153 ± 1% will-it-scale.per_thread_ops
0.58 ± 0% -2.0% 0.57 ± 0% will-it-scale.scalability
6820 ± 0% -19.6% 5483 ± 15% meminfo.AnonHugePages
2652 ± 5% -10.4% 2375 ± 2% vmstat.system.cs
2848 ± 32% +141.2% 6870 ± 65% numa-meminfo.node1.Active(anon)
2832 ± 31% +57.6% 4465 ± 27% numa-meminfo.node1.AnonPages
15018 ± 12% -23.3% 11515 ± 15% numa-meminfo.node2.AnonPages
1214 ± 14% -22.8% 936.75 ± 20% numa-meminfo.node3.PageTables
712.25 ± 32% +141.2% 1718 ± 65% numa-vmstat.node1.nr_active_anon
708.25 ± 31% +57.7% 1116 ± 27% numa-vmstat.node1.nr_anon_pages
3754 ± 12% -23.3% 2879 ± 15% numa-vmstat.node2.nr_anon_pages
304.75 ± 14% -23.1% 234.50 ± 20% numa-vmstat.node3.nr_page_table_pages
3.53 ± 1% -100.0% 0.00 ± -1% perf-profile.cycles.___might_sleep.__might_sleep.get_futex_key.futex_wake.do_futex
4.34 ± 1% -100.0% 0.00 ± -1% perf-profile.cycles.__might_sleep.get_futex_key.futex_wake.do_futex.sys_futex
1.27 ± 3% -100.0% 0.00 ± -1% perf-profile.cycles.__wake_up_bit.unlock_page.get_futex_key.futex_wake.do_futex
4.36 ± 1% +29.6% 5.65 ± 1% perf-profile.cycles.drop_futex_key_refs.isra.12.futex_wake.do_futex.sys_futex.entry_SYSCALL_64_fastpath
6.69 ± 1% +28.1% 8.57 ± 0% perf-profile.cycles.entry_SYSCALL_64
6.73 ± 0% +30.6% 8.79 ± 0% perf-profile.cycles.entry_SYSCALL_64_after_swapgs
74.21 ± 0% -11.0% 66.06 ± 0% perf-profile.cycles.futex_wake.do_futex.sys_futex.entry_SYSCALL_64_fastpath
59.05 ± 0% -21.4% 46.40 ± 0% perf-profile.cycles.get_futex_key.futex_wake.do_futex.sys_futex.entry_SYSCALL_64_fastpath
4.12 ± 0% +78.5% 7.36 ± 1% perf-profile.cycles.get_futex_key_refs.isra.11.futex_wake.do_futex.sys_futex.entry_SYSCALL_64_fastpath
2.27 ± 3% +24.1% 2.82 ± 4% perf-profile.cycles.get_user_pages_fast.futex_wake.do_futex.sys_futex.entry_SYSCALL_64_fastpath
26.95 ± 0% +30.0% 35.04 ± 1% perf-profile.cycles.get_user_pages_fast.get_futex_key.futex_wake.do_futex.sys_futex
13.43 ± 0% +27.2% 17.09 ± 1% perf-profile.cycles.gup_pte_range.gup_pud_range.get_user_pages_fast.get_futex_key.futex_wake
19.66 ± 1% +28.4% 25.24 ± 0% perf-profile.cycles.gup_pud_range.get_user_pages_fast.get_futex_key.futex_wake.do_futex
4.33 ± 1% +37.0% 5.93 ± 4% perf-profile.cycles.hash_futex.do_futex.sys_futex.entry_SYSCALL_64_fastpath
13.59 ± 0% -100.0% 0.00 ± -1% perf-profile.cycles.unlock_page.get_futex_key.futex_wake.do_futex.sys_futex
15160 ± 19% -34.8% 9883 ± 0% sched_debug.cfs_rq:/.exec_clock.min
27.25 ± 15% -37.6% 17.00 ± 8% sched_debug.cfs_rq:/.load_avg.7
21.00 ± 38% -27.4% 15.25 ± 2% sched_debug.cpu.cpu_load[2].1
21.00 ± 38% -27.4% 15.25 ± 2% sched_debug.cpu.cpu_load[3].1
21.00 ± 38% -27.4% 15.25 ± 2% sched_debug.cpu.cpu_load[4].1
1790 ± 0% +42.4% 2549 ± 45% sched_debug.cpu.curr->pid.21
50033 ± 4% -6.8% 46622 ± 4% sched_debug.cpu.nr_load_updates.29
4398 ± 42% +103.5% 8949 ± 23% sched_debug.cpu.nr_switches.11
7452 ± 34% +111.3% 15744 ± 54% sched_debug.cpu.nr_switches.20
3739 ± 13% +213.5% 11723 ± 40% sched_debug.cpu.nr_switches.23
1648 ± 53% +96.5% 3239 ± 63% sched_debug.cpu.nr_switches.51
0.25 ±519% -1300.0% -3.00 ±-52% sched_debug.cpu.nr_uninterruptible.24
8632 ± 16% -32.5% 5823 ± 19% sched_debug.cpu.sched_count.1
5091 ± 36% +137.5% 12092 ± 31% sched_debug.cpu.sched_count.11
12453 ± 90% -74.6% 3159 ± 24% sched_debug.cpu.sched_count.2
7782 ± 32% +118.2% 16977 ± 46% sched_debug.cpu.sched_count.20
2665 ± 48% -49.8% 1337 ± 30% sched_debug.cpu.sched_count.32
1365 ± 11% -14.0% 1174 ± 3% sched_debug.cpu.sched_count.45
1693 ± 51% +147.7% 4193 ± 42% sched_debug.cpu.sched_count.51
5023 ± 57% -51.5% 2434 ± 43% sched_debug.cpu.sched_count.57
1705 ± 16% +129.6% 3915 ± 48% sched_debug.cpu.sched_goidle.23
536.25 ± 14% -18.7% 435.75 ± 2% sched_debug.cpu.sched_goidle.45
1228 ± 19% -27.3% 892.50 ± 17% sched_debug.cpu.sched_goidle.5
1919 ± 55% +88.5% 3617 ± 37% sched_debug.cpu.ttwu_count.11
7699 ± 35% -43.7% 4335 ± 43% sched_debug.cpu.ttwu_count.24
5380 ± 36% -45.6% 2926 ± 18% sched_debug.cpu.ttwu_count.30
563.25 ± 20% +140.3% 1353 ± 38% sched_debug.cpu.ttwu_local.11
4297 ± 46% -49.1% 2186 ± 39% sched_debug.cpu.ttwu_local.24
2828 ± 47% -47.8% 1475 ± 34% sched_debug.cpu.ttwu_local.27
3243 ± 36% -54.3% 1482 ± 32% sched_debug.cpu.ttwu_local.30
199.25 ± 6% +100.6% 399.75 ± 32% sched_debug.cpu.ttwu_local.44
1158 ± 64% -67.3% 379.00 ± 46% sched_debug.cpu.ttwu_local.54
242.25 ± 21% +51.0% 365.75 ± 19% sched_debug.cpu.ttwu_local.55
1009 ± 26% -50.8% 496.50 ± 44% sched_debug.cpu.ttwu_local.59
1736 ± 53% -67.8% 559.25 ± 22% sched_debug.cpu.ttwu_local.9
lkp-sbx04: Sandy Bridge-EX
Memory: 64G
perf-profile.cycles.futex_wake.do_futex.sys_futex.entry_SYSCALL_64_fastpath
76 ++---------------------------------------------------------------------+
| |
74 ++ .*.. .*..*..*.. .*.. .*.. .*.. .*.. .*..*..*..* |
*..*. *..*..*. *..*. *.*. *. *. *. |
| |
72 ++ |
| |
70 ++ |
| |
68 ++ |
| |
| O O O O O O O O O O O |
66 O+ O O O O O
| O O O O O O O |
64 ++-------------O-------------------------------------------------------+
will-it-scale.per_process_ops
6.6e+06 O+----O-O--O------------------------------------------------------+
| O O O O O |
6.4e+06 ++ O O O O O O O O O O O O O O O O
| |
6.2e+06 ++ |
6e+06 ++ |
| |
5.8e+06 ++ |
| |
5.6e+06 ++ |
5.4e+06 ++ |
| |
5.2e+06 ++ |
*..*..*.*..*..*..*.*..*..*..*.*..*..*..*.*..*..*..*.*..*..*..*.* |
5e+06 ++----------------------------------------------------------------+
[*] 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
4 years, 9 months
[ppdev] e7223f1860: kernel BUG at drivers/base/driver.c:153!
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/gregkh/char-misc.git char-misc-testing
commit e7223f18603374d235d8bb0398532323e5f318b9
Author: Sudip Mukherjee <sudipm.mukherjee(a)gmail.com>
AuthorDate: Fri Feb 12 18:33:45 2016 +0530
Commit: Greg Kroah-Hartman <gregkh(a)linuxfoundation.org>
CommitDate: Sun Feb 14 17:43:50 2016 -0800
ppdev: use new parport device model
Modify ppdev driver to use the new parallel port device model.
Signed-off-by: Sudip Mukherjee <sudip(a)vectorindia.org>
Signed-off-by: Greg Kroah-Hartman <gregkh(a)linuxfoundation.org>
+---------------------------------------------------------------------+------------+------------+------------+
| | 3c8db58432 | e7223f1860 | 8eb81b9e40 |
+---------------------------------------------------------------------+------------+------------+------------+
| boot_successes | 29 | 0 | 0 |
| boot_failures | 67 | 30 | 26 |
| Kernel_panic-not_syncing:Attempted_to_kill_init!exitcode= | 67 | | |
| kernel_BUG_at_drivers/base/driver.c | 0 | 30 | 26 |
| invalid_opcode:#[##] | 0 | 30 | 26 |
| invalid_opcode:#[##]PREEMPT_PREEMPT_DEBUG_PAGEALLOC_DEBUG_PAGEALLOC | 0 | 30 | 26 |
| RIP:driver_register | 0 | 30 | 26 |
| Kernel_panic-not_syncing:Fatal_exception | 0 | 30 | 26 |
| backtrace:ppdev_init | 0 | 30 | 26 |
| backtrace:kernel_init_freeable | 0 | 30 | 26 |
+---------------------------------------------------------------------+------------+------------+------------+
[ 1.808834] Non-volatile memory driver v1.3
[ 1.810078] ------------[ cut here ]------------
[ 1.810078] ------------[ cut here ]------------
[ 1.810982] kernel BUG at drivers/base/driver.c:153!
[ 1.810982] kernel BUG at drivers/base/driver.c:153!
[ 1.812297] invalid opcode: 0000 [#1]
[ 1.812297] invalid opcode: 0000 [#1] PREEMPT PREEMPT DEBUG_PAGEALLOC DEBUG_PAGEALLOC
[ 1.813465] CPU: 0 PID: 1 Comm: swapper Not tainted 4.5.0-rc4-00154-ge7223f1 #2
[ 1.813465] CPU: 0 PID: 1 Comm: swapper Not tainted 4.5.0-rc4-00154-ge7223f1 #2
[ 1.814852] task: ffff88000f468000 ti: ffff88000f46c000 task.ti: ffff88000f46c000
[ 1.814852] task: ffff88000f468000 ti: ffff88000f46c000 task.ti: ffff88000f46c000
[ 1.816276] RIP: 0010:[<ffffffff816e0e51>]
[ 1.816276] RIP: 0010:[<ffffffff816e0e51>] [<ffffffff816e0e51>] driver_register+0xa1/0xd0
[<ffffffff816e0e51>] driver_register+0xa1/0xd0
[ 1.817855] RSP: 0000:ffff88000f46fe70 EFLAGS: 00010246
[ 1.817855] RSP: 0000:ffff88000f46fe70 EFLAGS: 00010246
[ 1.818867] RAX: ffffffff82ef039c RBX: 000000000e136c08 RCX: 0000000000000000
[ 1.818867] RAX: ffffffff82ef039c RBX: 000000000e136c08 RCX: 0000000000000000
[ 1.820206] RDX: ffffffff82ef039c RSI: ffffffff83459b80 RDI: ffffffff83456428
[ 1.820206] RDX: ffffffff82ef039c RSI: ffffffff83459b80 RDI: ffffffff83456428
[ 1.821559] RBP: ffff88000f46fe88 R08: 0000000000000001 R09: 0000000000000000
[ 1.821559] RBP: ffff88000f46fe88 R08: 0000000000000001 R09: 0000000000000000
[ 1.822913] R10: 0000000000000000 R11: 0000000000000000 R12: ffffffff83456400
[ 1.822913] R10: 0000000000000000 R11: 0000000000000000 R12: ffffffff83456400
[ 1.824259] R13: 0000000000000000 R14: ffffffff836bd0b0 R15: 0000000000000000
[ 1.824259] R13: 0000000000000000 R14: ffffffff836bd0b0 R15: 0000000000000000
[ 1.825613] FS: 0000000000000000(0000) GS:ffffffff83221000(0000) knlGS:0000000000000000
[ 1.825613] FS: 0000000000000000(0000) GS:ffffffff83221000(0000) knlGS:0000000000000000
[ 1.827147] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 1.827147] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 1.828240] CR2: 0000000000000000 CR3: 0000000003210000 CR4: 00000000001406b0
[ 1.828240] CR2: 0000000000000000 CR3: 0000000003210000 CR4: 00000000001406b0
[ 1.829590] Stack:
[ 1.829590] Stack:
[ 1.829988] ffffffff816d7c89
[ 1.829988] ffffffff816d7c89 000000000e136c08 000000000e136c08 ffffffff8364e617 ffffffff8364e617 ffff88000f46fea0 ffff88000f46fea0
[ 1.831442] ffffffff8364e695
[ 1.831442] ffffffff8364e695 ffff88000e136af0 ffff88000e136af0 ffff88000f46ff10 ffff88000f46ff10 ffffffff8361e0b5 ffffffff8361e0b5
[ 1.832903] 0000000000000000
[ 1.832903] 0000000000000000 ffffffff8312c928 ffffffff8312c928 000005ca00060006 000005ca00060006 ffffffff82f32904 ffffffff82f32904
[ 1.834368] Call Trace:
[ 1.834368] Call Trace:
[ 1.834841] [<ffffffff816d7c89>] ? __parport_register_driver+0x39/0x100
[ 1.834841] [<ffffffff816d7c89>] ? __parport_register_driver+0x39/0x100
[ 1.836121] [<ffffffff8364e617>] ? rng_init+0x12/0x12
[ 1.836121] [<ffffffff8364e617>] ? rng_init+0x12/0x12
[ 1.837099] [<ffffffff8364e695>] ppdev_init+0x7e/0xcb
[ 1.837099] [<ffffffff8364e695>] ppdev_init+0x7e/0xcb
[ 1.838081] [<ffffffff8361e0b5>] do_one_initcall+0xf0/0x183
[ 1.838081] [<ffffffff8361e0b5>] do_one_initcall+0xf0/0x183
[ 1.839164] [<ffffffff8361e249>] kernel_init_freeable+0x101/0x187
[ 1.839164] [<ffffffff8361e249>] kernel_init_freeable+0x101/0x187
[ 1.840344] [<ffffffff82695b10>] ? rest_init+0x130/0x130
[ 1.840344] [<ffffffff82695b10>] ? rest_init+0x130/0x130
[ 1.841379] [<ffffffff82695b19>] kernel_init+0x9/0xe0
[ 1.841379] [<ffffffff82695b19>] kernel_init+0x9/0xe0
[ 1.842366] [<ffffffff8269fb1f>] ret_from_fork+0x3f/0x70
[ 1.842366] [<ffffffff8269fb1f>] ret_from_fork+0x3f/0x70
[ 1.843405] [<ffffffff82695b10>] ? rest_init+0x130/0x130
[ 1.843405] [<ffffffff82695b10>] ? rest_init+0x130/0x130
[ 1.844437] Code:
[ 1.844437] Code: ff ff 85 85 c0 c0 41 41 89 89 c4 c4 75 75 13 13 48 48 8b 8b 7b 7b 70 70 31 31 f6 f6 e8 e8 47 47 d3 d3 e8 e8 ff ff 44 44 89 89 e0 e0 5b 5b 41 41 5c 5c 5d 5d c3 c3 48 48 89 89 df df e8 e8 b7 b7 df df ff ff ff ff 44 44 89 89 e0 e0 5b 5b 41 41 5c 5c 5d 5d c3 c3 <0f> <0f> 0b 0b 48 48 8b 8b 33 33 48 48 c7 c7 c7 c7 58 58 f3 f3 f8 f8 82 82 e8 e8 ed ed 24 24 a5 a5 ff ff 48 48 8b 8b 73 73 08 08
[ 1.848930] RIP
[ 1.848930] RIP [<ffffffff816e0e51>] driver_register+0xa1/0xd0
[<ffffffff816e0e51>] driver_register+0xa1/0xd0
[ 1.850075] RSP <ffff88000f46fe70>
[ 1.850075] RSP <ffff88000f46fe70>
[ 1.850780] ---[ end trace 301e5f19aca79aa0 ]---
[ 1.850780] ---[ end trace 301e5f19aca79aa0 ]---
git bisect start 8eb81b9e40322ecdc7c326ca3d429af82dc71c45 18558cae0272f8fd9647e69d3fec1565a7949865 --
git bisect good 81177251dd233e878a3ab7fa4fb34a9d985c69ab # 11:25 22+ 1 Merge 'tty/tty-testing' into devel-catchup-201602151050
git bisect bad 408808ab2ab758c6fa1bdec8fe4d7f7120779186 # 11:33 0- 12 Merge 'linux-review/Simon-Horman/MAINTAINERS-Update-mailing-list-for-Renesas-ARM64-SoC-Development/20160215-095242' into devel-catchup-201602151050
git bisect good 0a6b1d10601e41de57eeadcf17164d7e668425b7 # 11:41 22+ 0 Merge 'jsakkine-tpmdd/master' into devel-catchup-201602151050
git bisect bad 84e1e09d3107ab136b1e932d9d8e6fe9097e21be # 11:47 0- 24 Merge 'char-misc/char-misc-testing' into devel-catchup-201602151050
git bisect good 52210c8745e418f82f3f0aeeee01d7bc4858812a # 12:03 22+ 7 coresight: implementing 'cpu_id()' API
git bisect good 202cdb6f889bf45e1cb4883e1727e9909152b777 # 12:10 22+ 0 drivers: char: raw: Removed unnecessary braces
git bisect good 990162f038400bd229685316beea1155be095125 # 12:17 22+ 14 char: nwbutton: avoid unused variable warning
git bisect good 6ddf2f0cb1e1931d16e08e30130ed04e5a441f2c # 12:26 22+ 18 misc: mic: use after free printing error message
git bisect good 83e80605cc3ce6a2ac966151cd515f691e4835e0 # 12:32 22+ 24 ppdev: remove braces
git bisect good 3c8db584323875a50696718c89d94cef0ed54f30 # 12:39 22+ 22 ppdev: remove space before tab
git bisect bad 396ec3dea3d82d0a32906efe9803a8ef2647df51 # 12:47 0- 23 ppdev: use dev_* macros
git bisect bad e7223f18603374d235d8bb0398532323e5f318b9 # 12:51 0- 24 ppdev: use new parport device model
# first bad commit: [e7223f18603374d235d8bb0398532323e5f318b9] ppdev: use new parport device model
git bisect good 3c8db584323875a50696718c89d94cef0ed54f30 # 12:54 66+ 67 ppdev: remove space before tab
# extra tests with DEBUG_INFO
git bisect bad e7223f18603374d235d8bb0398532323e5f318b9 # 13:00 0- 3 ppdev: use new parport device model
# extra tests on HEAD of linux-devel/devel-catchup-201602151050
git bisect bad 8eb81b9e40322ecdc7c326ca3d429af82dc71c45 # 13:00 0- 26 0day head guard for 'devel-catchup-201602151050'
# extra tests on tree/branch char-misc/char-misc-testing
git bisect bad 396ec3dea3d82d0a32906efe9803a8ef2647df51 # 13:08 0- 30 ppdev: use dev_* macros
# extra tests with first bad commit reverted
git bisect good 695d7d11b66df48501e9b9f6f4bf94e28817b2ca # 15:48 62+ 44 Revert "ppdev: use new parport device model"
# extra tests on tree/branch linus/master
git bisect good 1926e54f115725a9248d0c4c65c22acaf94de4c4 # 16:07 62+ 8 MAINTAINERS: Update mailing list for Renesas ARM64 SoC Development
# extra tests on tree/branch linux-next/master
git bisect good 2625f908fc0cbd7e40483217772888529ecbdfd1 # 16:20 64+ 64 Add linux-next specific files for 20160215
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
4 years, 10 months
[lkp] [gpu/i915] 7632469f92: BUG: kernel boot crashed
by kernel test robot
FYI, we noticed the below changes on
https://git.kernel.org/pub/scm/linux/kernel/git/rt/linux-rt-devel.git linux-4.4.y-rt
commit 7632469f927db4e8ebecfbc59bba16c14974a474 ("gpu/i915: don't open code these things")
+-------------------------+------------+------------+
| | 6e4ba49cad | 7632469f92 |
+-------------------------+------------+------------+
| boot_successes | 15 | 0 |
| boot_failures | 0 | 18 |
| BUG:kernel_boot_crashed | 0 | 16 |
| BUG:kernel_boot_hang | 0 | 2 |
+-------------------------+------------+------------+
[ 0.000000] bootconsole [earlyser0] disabled
Elapsed time: 300
BUG: kernel boot crashed
qemu-system-x86_64 -enable-kvm -cpu Haswell,+smep,+smap -kernel /pkg/linux/x86_64-allyesdebian/gcc-5/7632469f927db4e8ebecfbc59bba16c14974a474/vmlinuz-4.4.0-rc6-00247-g7632469 -append 'root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-kbuild-1G-6/bisect_boot-1-debian-x86_64-2015-02-07.cgz-x86_64-allyesdebian-7632469f927db4e8ebecfbc59bba16c14974a474-20160220-100734-xc9ybt-1.yaml ARCH=x86_64 kconfig=x86_64-allyesdebian branch=linux-rt-devel/linux-4.4.y-rt commit=7632469f927db4e8ebecfbc59bba16c14974a474 BOOT_IMAGE=/pkg/linux/x86_64-allyesdebian/gcc-5/7632469f927db4e8ebecfbc59bba16c14974a474/vmlinuz-4.4.0-rc6-00247-g7632469 max_uptime=600 RESULT_ROOT=/result/boot/1/vm-kbuild-1G/debian-x86_64-2015-02-07.cgz/x86_64-allyesdebian/gcc-5/7632469f927db4e8ebecfbc59bba16c14974a474/0 LKP_SERVER=inn 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 rw ip=::::vm-kbuild-1G-6::dhcp' -initrd /fs/sdg1/initrd-vm-kbuild-1G-6 -m 1536 -smp 2 -device e1000,netdev=net0 -netdev user,id=net0,hostfwd=tcp::23005-:22 -boot order=nc -no-reboot -watchdog i6300esb -rtc base=localtime -device virtio-scsi-pci,id=scsi0 -drive file=/fs/sdg1/disk0-vm-kbuild-1G-6,if=none,id=hd0,media=disk,aio=native,cache=none -device scsi-hd,bus=scsi0.0,drive=hd0,scsi-id=1,lun=0 -drive file=/fs/sdg1/disk1-vm-kbuild-1G-6,if=none,id=hd1,media=disk,aio=native,cache=none -device scsi-hd,bus=scsi0.0,drive=hd1,scsi-id=1,lun=1 -drive file=/fs/sdg1/disk2-vm-kbuild-1G-6,if=none,id=hd2,media=disk,aio=native,cache=none -device scsi-hd,bus=scsi0.0,drive=hd2,scsi-id=1,lun=2 -drive file=/fs/sdg1/disk3-vm-kbuild-1G-6,if=none,id=hd3,media=disk,aio=native,cache=none -device scsi-hd,bus=scsi0.0,drive=hd3,scsi-id=1,lun=3 -drive file=/fs/sdg1/disk4-vm-kbuild-1G-6,if=none,id=hd4,media=disk,aio=native,cache=none -device scsi-hd,bus=scsi0.0,drive=hd4,scsi-id=1,lun=4 -pidfile /dev/shm/kboot/pid-vm-kbuild-1G-6 -serial file:/dev/shm/kboot/serial-vm-kbuild-1G-6 -daemonize -display none -monitor null
Thanks,
Kernel Test Robot
4 years, 10 months
Re: [LKP] [lkp] [printk] 34578dc67f: EIP is at vprintk_emit+0x1ea/0x600
by Sergey Senozhatsky
On (02/23/16 22:15), Sergey Senozhatsky wrote:
> On (02/23/16 08:55), kernel test robot wrote:
> > [ 33.497678] ### dt-test ### of_unittest_destroy_tracked_overlays: overlay destroy failed for #6
> > [ 33.497693] NMI watchdog: BUG: soft lockup - CPU#0 stuck for 23s! [swapper:1]
> > [ 33.497693] NMI watchdog: BUG: soft lockup - CPU#0 stuck for 23s! [swapper:1]
> > [ 33.497695] Modules linked in:
> > [ 33.497695] Modules linked in:
> > [ 33.497696] irq event stamp: 69018756
> > [ 33.497696] irq event stamp: 69018756
>
> how may consoles do you have registered? is it possible that your
> call_console_drivers() loop push the same data to different consoles,
> but the messages end up in one place (serial port, etc... dunno)?
> does it happen to all of the messages?
oh... didn't notice there was a dmesg.xz attached.
ok, so everything is "doubled" in your dmesg, starting from "console [ttyS0] enabled" line
254 [ 0.000000] vmalloc : 0xc47e0000 - 0xff7fe000 ( 944 MB)
255 [ 0.000000] lowmem : 0xb0000000 - 0xc3fe0000 ( 319 MB)
256 [ 0.000000] .init : 0xc0dc4000 - 0xc0e3a000 ( 472 kB)
257 [ 0.000000] .data : 0xc0a0a040 - 0xc0dc2560 (3809 kB)
258 [ 0.000000] .text : 0xc0600000 - 0xc0a0a040 (4136 kB)
259 [ 0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok.
260 [ 0.000000] SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
261 [ 0.000000] Running RCU self tests
262 [ 0.000000] NR_IRQS:2304 nr_irqs:256 16
263 [ 0.000000] CPU 0 irqstacks, hard=b002a000 soft=b002c000
264 [ 0.000000] console [ttyS0] enabled
265 [ 0.000000] console [ttyS0] enabled
266 [ 0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
267 [ 0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
268 [ 0.000000] ... MAX_LOCKDEP_SUBCLASSES: 8
269 [ 0.000000] ... MAX_LOCKDEP_SUBCLASSES: 8
270 [ 0.000000] ... MAX_LOCK_DEPTH: 48
271 [ 0.000000] ... MAX_LOCK_DEPTH: 48
272 [ 0.000000] ... MAX_LOCKDEP_KEYS: 8191
273 [ 0.000000] ... MAX_LOCKDEP_KEYS: 8191
274 [ 0.000000] ... CLASSHASH_SIZE: 4096
275 [ 0.000000] ... CLASSHASH_SIZE: 4096
276 [ 0.000000] ... MAX_LOCKDEP_ENTRIES: 32768
277 [ 0.000000] ... MAX_LOCKDEP_ENTRIES: 32768
278 [ 0.000000] ... MAX_LOCKDEP_CHAINS: 65536
279 [ 0.000000] ... MAX_LOCKDEP_CHAINS: 65536
280 [ 0.000000] ... CHAINHASH_SIZE: 32768
281 [ 0.000000] ... CHAINHASH_SIZE: 32768
282 [ 0.000000] memory used by lock dependency info: 5167 kB
283 [ 0.000000] memory used by lock dependency info: 5167 kB
284 [ 0.000000] per task-struct memory footprint: 2112 bytes
285 [ 0.000000] per task-struct memory footprint: 2112 bytes
286 [ 0.000000] ------------------------
287 [ 0.000000] ------------------------
288 [ 0.000000] | Locking API testsuite:
289 [ 0.000000] | Locking API testsuite:
290 [ 0.000000] ----------------------------------------------------------------------------
291 [ 0.000000] ----------------------------------------------------------------------------
292 [ 0.000000] | spin |wlock |rlock |mutex | wsem | rsem |
293 [ 0.000000] | spin |wlock |rlock |mutex | wsem | rsem |
294 [ 0.000000] --------------------------------------------------------------------------
295 [ 0.000000] --------------------------------------------------------------------------
looking at your Kernel command line
[ 0.000000] Kernel command line: root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-kbuild-yocto-i386-53/bisect_boot-1-yocto-minimal-i386.cgz-i386-randconfig-h1-02192137-34578dc67f38c02ccbe696e4099967884caa8e15-20160220-72722-vao2m5-0.yaml ARCH=i386 kconfig=i386-randconfig-h1-02192137 branch=linux-next/master commi t=34578dc67f38c02ccbe696e4099967884caa8e15 BOOT_IMAGE=/pkg/linux/i386-randconfig-h1-02192137/gcc-5/34578dc67f38c02ccbe696e4099967884caa8e15/vmlinuz-4.5.0-rc4-00295-g34578dc max_uptime=600 RESULT_ROOT=/result/boot/1/vm-kbuild-yocto-i386/yocto-minimal-i386.cgz/i386-randconfig-h1-02192137/gcc-5/34578dc67f38c02ccbe69 6e4099967884caa8e15/9 LKP_SERVER=inn 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 rw ip=::::vm-kbuild-yo cto-i386-53::dhcp drbd.minor_count=8
- earlyprintk=ttyS0,115200
- console=ttyS0,115200
- console=tty0
so you have two consoles: ttyS0 and tty0?
and I see "bootconsole [earlyser0] enabled" but no "bootconsole [earlyser0] disabled" message, which
I'd expect to see...
So how may consoles do you have? 2 or 3? so call_console_drivers() has to ->write()
every log line N times; at least to ttyS0->write() and to tty0->write()?
-ss
4 years, 10 months
[slab] a1fd55538c: WARNING: CPU: 0 PID: 0 at kernel/locking/lockdep.c:2601 trace_hardirqs_on_caller()
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/next/linux-next.git master
commit a1fd55538cae9f411059c9b067a3d48c41aa876b
Author: Jesper Dangaard Brouer <brouer(a)redhat.com>
AuthorDate: Thu Jan 28 09:47:16 2016 +1100
Commit: Stephen Rothwell <sfr(a)canb.auug.org.au>
CommitDate: Thu Jan 28 09:47:16 2016 +1100
slab: use slab_pre_alloc_hook in SLAB allocator shared with SLUB
Deduplicate code in SLAB allocator functions slab_alloc() and
slab_alloc_node() by using the slab_pre_alloc_hook() call, which is now
shared between SLUB and SLAB.
Signed-off-by: Jesper Dangaard Brouer <brouer(a)redhat.com>
Cc: Christoph Lameter <cl(a)linux.com>
Cc: Pekka Enberg <penberg(a)kernel.org>
Cc: David Rientjes <rientjes(a)google.com>
Cc: Joonsoo Kim <iamjoonsoo.kim(a)lge.com>
Cc: Vladimir Davydov <vdavydov(a)virtuozzo.com>
Signed-off-by: Andrew Morton <akpm(a)linux-foundation.org>
+-----------------------------------------------------------------+------------+------------+---------------+
| | 074b6f53c3 | a1fd55538c | next-20160128 |
+-----------------------------------------------------------------+------------+------------+---------------+
| boot_successes | 40 | 0 | 0 |
| boot_failures | 52 | 26 | 19 |
| Kernel_panic-not_syncing:Attempted_to_kill_init!exitcode= | 52 | 26 | 14 |
| WARNING:at_kernel/locking/lockdep.c:#trace_hardirqs_on_caller() | 0 | 26 | 19 |
| backtrace:pcpu_mem_zalloc | 0 | 26 | 19 |
| backtrace:percpu_init_late | 0 | 26 | 19 |
| IP-Config:Auto-configuration_of_network_failed | 0 | 0 | 2 |
+-----------------------------------------------------------------+------------+------------+---------------+
[ 0.000000] Inode-cache hash table entries: 16384 (order: 5, 131072 bytes)
[ 0.000000] Memory: 194224K/261624K available (10816K kernel code, 5060K rwdata, 6628K rodata, 988K init, 33076K bss, 67400K reserved, 0K cma-reserved)
[ 0.000000] ------------[ cut here ]------------
[ 0.000000] WARNING: CPU: 0 PID: 0 at kernel/locking/lockdep.c:2601 trace_hardirqs_on_caller+0x341/0x380()
[ 0.000000] DEBUG_LOCKS_WARN_ON(unlikely(early_boot_irqs_disabled))
[ 0.000000] CPU: 0 PID: 0 Comm: swapper Not tainted 4.5.0-rc1-00069-ga1fd555 #1
[ 0.000000] ffffffff82403dd8 ffffffff82403d90 ffffffff813b937d ffffffff82403dc8
[ 0.000000] ffffffff810eb4d3 ffffffff812617cc 0000000000000001 ffff88000fcc50a8
[ 0.000000] ffff8800000984c0 00000000024000c0 ffffffff82403e28 ffffffff810eb5c7
[ 0.000000] Call Trace:
[ 0.000000] [<ffffffff813b937d>] dump_stack+0x27/0x3a
[ 0.000000] [<ffffffff810eb4d3>] warn_slowpath_common+0xa3/0x100
[ 0.000000] [<ffffffff812617cc>] ? cache_alloc_refill+0x7ac/0x910
[ 0.000000] [<ffffffff810eb5c7>] warn_slowpath_fmt+0x57/0x70
[ 0.000000] [<ffffffff81143e61>] trace_hardirqs_on_caller+0x341/0x380
[ 0.000000] [<ffffffff81143ebd>] trace_hardirqs_on+0x1d/0x30
[ 0.000000] [<ffffffff812617cc>] cache_alloc_refill+0x7ac/0x910
[ 0.000000] [<ffffffff8121df6a>] ? pcpu_mem_zalloc+0x5a/0xc0
[ 0.000000] [<ffffffff81261fce>] __kmalloc+0x24e/0x440
[ 0.000000] [<ffffffff8121df6a>] pcpu_mem_zalloc+0x5a/0xc0
[ 0.000000] [<ffffffff829213aa>] percpu_init_late+0x4d/0xbb
[ 0.000000] [<ffffffff828f41c9>] start_kernel+0x30b/0x6e1
[ 0.000000] [<ffffffff828f3120>] ? early_idt_handler_array+0x120/0x120
[ 0.000000] [<ffffffff828f332f>] x86_64_start_reservations+0x46/0x4f
[ 0.000000] [<ffffffff828f34d4>] x86_64_start_kernel+0x19c/0x1b2
[ 0.000000] ---[ end trace cb88537fdc8fa200 ]---
[ 0.000000] Running RCU self tests
git bisect start 888c8375131656144c1605071eab2eb6ac49abc3 92e963f50fc74041b5e9e744c330dca48e04f08d --
git bisect good f664e02a71d85691fc33f116bae3eb7f0debd194 # 17:19 17+ 13 Merge remote-tracking branch 'kbuild/for-next'
git bisect good c7173552fb5efc15dd092d3a90b5d6ad0f3d9421 # 17:35 17+ 2 Merge remote-tracking branch 'audit/next'
git bisect good bd605d2e3cc724606fa7c0fd3d5d90276f07e979 # 17:47 17+ 2 Merge remote-tracking branch 'extcon/extcon-next'
git bisect good 108776431802ced1ca8ba38a9765ef81c48513de # 18:06 17+ 5 Merge remote-tracking branch 'llvmlinux/for-next'
git bisect good 56f1389517d2470a8abdb661c97d6ef640ca8cf3 # 18:30 17+ 3 Merge remote-tracking branch 'coresight/next'
git bisect bad 3cb196d8ee7f94b78c3d609bb91f5b175b3841d8 # 19:17 0- 8 Merge branch 'akpm-current/current'
git bisect good 49d5623e2407b26b532ca24f49d778b5b6fedb22 # 19:48 22+ 0 Merge remote-tracking branch 'rtc/rtc-next'
git bisect bad 8ccfb34d7450299714a9a590a764934397a818c6 # 20:06 0- 22 mm: filemap: avoid unnecessary calls to lock_page when waiting for IO to complete during a read
git bisect good d9dc8f2de4f863bef9a303b2cbae0bbd1c9dfceb # 20:32 22+ 22 ocfs2: add feature document for online file check
git bisect bad ebea6ceb9754b02bcab987af96c64782c665aa91 # 20:56 0- 18 mm/slab: remove object status buffer for DEBUG_SLAB_LEAK
git bisect bad 24d88722c03b13ef63b3b631f81454a63ac26cc4 # 21:06 0- 22 mm: kmemcheck skip object if slab allocation failed
git bisect good 1fc2d06fe0cfca10e571e2e444a4a37693495502 # 21:26 22+ 22 ocfs2/dlm: move lock to the tail of grant queue while doing in-place convert
git bisect good 3355ee84b3d96c7c30923d0bba228b0b7aa380d2 # 21:33 21+ 8 slub: cleanup code for kmem cgroup support to kmem_cache_free_bulk
git bisect good 074b6f53c320a81e975c0b5dd79daa5e78a711ba # 21:39 22+ 24 mm: fault-inject take over bootstrap kmem_cache check
git bisect bad a1fd55538cae9f411059c9b067a3d48c41aa876b # 21:49 0- 26 slab: use slab_pre_alloc_hook in SLAB allocator shared with SLUB
# first bad commit: [a1fd55538cae9f411059c9b067a3d48c41aa876b] slab: use slab_pre_alloc_hook in SLAB allocator shared with SLUB
git bisect good 074b6f53c320a81e975c0b5dd79daa5e78a711ba # 21:53 66+ 52 mm: fault-inject take over bootstrap kmem_cache check
# extra tests with DEBUG_INFO
git bisect bad a1fd55538cae9f411059c9b067a3d48c41aa876b # 22:00 0- 36 slab: use slab_pre_alloc_hook in SLAB allocator shared with SLUB
# extra tests on HEAD of linux-next/master
git bisect bad 888c8375131656144c1605071eab2eb6ac49abc3 # 22:00 0- 19 Add linux-next specific files for 20160128
# extra tests on tree/branch linux-next/master
git bisect bad 888c8375131656144c1605071eab2eb6ac49abc3 # 22:00 0- 19 Add linux-next specific files for 20160128
# extra tests with first bad commit reverted
git bisect good fea4cd9180f321dd12ec9a7932a9bfb32bfaf4c4 # 22:32 66+ 30 Revert "slab: use slab_pre_alloc_hook in SLAB allocator shared with SLUB"
# extra tests on tree/branch linus/master
git bisect good 03c21cb775a313f1ff19be59c5d02df3e3526471 # 22:52 65+ 67 Merge tag 'for_linus' of git://git.kernel.org/pub/scm/linux/kernel/git/mst/vhost
# extra tests on tree/branch linux-next/master
git bisect bad 888c8375131656144c1605071eab2eb6ac49abc3 # 22:52 0- 19 Add linux-next specific files for 20160128
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
4 years, 10 months
[mm: readahead] 99b902528e: INFO: task trinity-main:404 blocked for more than 120 seconds.
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 Johannes-Weiner/mm-readahead-do-not-cap-readahead-and-MADV_WILLNEED/20160224-094046
commit 99b902528e4e49cc02fcbc26cc0a10d0eaa70a3e
Author: Johannes Weiner <hannes(a)cmpxchg.org>
AuthorDate: Tue Feb 23 17:38:47 2016 -0800
Commit: 0day robot <fengguang.wu(a)intel.com>
CommitDate: Wed Feb 24 09:40:49 2016 +0800
mm: readahead: do not cap readahead() and MADV_WILLNEED
All readahead is currently capped to a maximum of the device readahead
limit, which defaults to 128k. For heuristics-based readahead this
makes perfect sense, too, but unfortunately the limit is also applied
to the explicit readahead() or madvise(MADV_WILLNEED) syscalls, and
128k is an awfully low limit, particularly for bigger machines. It's
not unreasonable for a user on a 100G machine to say, read this 1G
file, and read it now, I'm going to access the whole thing shortly.
Since both readahead() and MADV_WILLNEED take an explicit length
parameter, it seems weird to truncate that request quietly. Just do
what the user asked for and leave the limiting to the heuristics.
Signed-off-by: Johannes Weiner <hannes(a)cmpxchg.org>
+--------------------------------------------------+------------+------------+------------+
| | 4de8ebeff8 | 99b902528e | 44ec563f74 |
+--------------------------------------------------+------------+------------+------------+
| boot_successes | 1919 | 902 | 230 |
| boot_failures | 4 | 12 | 8 |
| IP-Config:Auto-configuration_of_network_failed | 2 | 0 | 4 |
| BUG:kernel_test_crashed | 2 | | |
| INFO:rcu_sched_detected_stalls_on_CPUs/tasks | 0 | 3 | 1 |
| INFO:task_blocked_for_more_than#seconds | 0 | 12 | |
| Kernel_panic-not_syncing:hung_task:blocked_tasks | 0 | 12 | 4 |
| backtrace:watchdog | 0 | 12 | 4 |
| backtrace:vfs_kern_mount | 0 | 0 | 8 |
| backtrace:mnt_init | 0 | 0 | 8 |
| backtrace:vfs_caches_init | 0 | 0 | 8 |
+--------------------------------------------------+------------+------------+------------+
error: 'rc.local' exited outside the expected code flow.
(t=31501 jiffies g=353 c=352 q=12507)
[ 241.872344] INFO: task trinity-main:404 blocked for more than 120 seconds.
[ 241.872344] INFO: task trinity-main:404 blocked for more than 120 seconds.
[ 241.874262] Not tainted 4.5.0-rc5-00173-g99b9025 #1
[ 241.874262] Not tainted 4.5.0-rc5-00173-g99b9025 #1
[ 241.875827] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 241.875827] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 241.887914] Kernel panic - not syncing: hung_task: blocked tasks
[ 241.887914] Kernel panic - not syncing: hung_task: blocked tasks
[ 241.889617] CPU: 0 PID: 16 Comm: khungtaskd Not tainted 4.5.0-rc5-00173-g99b9025 #1
[ 241.889617] CPU: 0 PID: 16 Comm: khungtaskd Not tainted 4.5.0-rc5-00173-g99b9025 #1
[ 241.891753] 0000000000000000
[ 241.891753] 0000000000000000 ffff8800101c7d90 ffff8800101c7d90 ffffffff81817ca6 ffffffff81817ca6 ffffffff827c669a ffffffff827c669a
[ 241.893907] ffff8800101c7e20
[ 241.893907] ffff8800101c7e20 ffff8800101c7e10 ffff8800101c7e10 ffffffff81248e43 ffffffff81248e43 0000000000000008 0000000000000008
[ 241.910022] ffff8800101c7e20
[ 241.910022] ffff8800101c7e20 ffff8800101c7db8 ffff8800101c7db8 ffffffff8181e3b6 ffffffff8181e3b6 0000000000000002 0000000000000002
[ 241.912112] Call Trace:
[ 241.912112] Call Trace:
[ 241.912791] [<ffffffff81817ca6>] dump_stack+0xea/0x154
[ 241.912791] [<ffffffff81817ca6>] dump_stack+0xea/0x154
[ 241.914229] [<ffffffff81248e43>] panic+0x11e/0x325
[ 241.914229] [<ffffffff81248e43>] panic+0x11e/0x325
[ 241.915629] [<ffffffff8181e3b6>] ? nmi_trigger_all_cpu_backtrace+0x206/0x530
[ 241.915629] [<ffffffff8181e3b6>] ? nmi_trigger_all_cpu_backtrace+0x206/0x530
[ 241.938594] [<ffffffff812237bc>] watchdog+0x67c/0x760
[ 241.938594] [<ffffffff812237bc>] watchdog+0x67c/0x760
[ 241.940198] [<ffffffff81223220>] ? watchdog+0xe0/0x760
[ 241.940198] [<ffffffff81223220>] ? watchdog+0xe0/0x760
[ 241.941826] [<ffffffff81223140>] ? hung_task_panic+0x20/0x20
[ 241.941826] [<ffffffff81223140>] ? hung_task_panic+0x20/0x20
[ 241.964754] [<ffffffff81160aba>] kthread+0x12a/0x160
[ 241.964754] [<ffffffff81160aba>] kthread+0x12a/0x160
[ 241.966286] [<ffffffff81160990>] ? __kthread_unpark+0xa0/0xa0
[ 241.966286] [<ffffffff81160990>] ? __kthread_unpark+0xa0/0xa0
[ 241.967878] [<ffffffff820d486f>] ret_from_fork+0x3f/0x70
[ 241.967878] [<ffffffff820d486f>] ret_from_fork+0x3f/0x70
[ 241.969348] [<ffffffff81160990>] ? __kthread_unpark+0xa0/0xa0
[ 241.969348] [<ffffffff81160990>] ? __kthread_unpark+0xa0/0xa0
[ 241.982838] Kernel Offset: disabled
[ 241.982838] Kernel Offset: disabled
git bisect start 44ec563f74e478ccd262b899fc404761bc5c6870 81f70ba233d5f660e1ea5fe23260ee323af5d53a --
git bisect bad b9380b78ec52e5f8d842af61766e8e628bc7c845 # 08:00 0- 4 Merge 'pci/pci/vpd' into devel-spot-201602240957
git bisect bad f510875390c26be8247645f3f6b11fe2a3d5d695 # 08:00 0- 6 Merge 'kees/seccomp/tests' into devel-spot-201602240957
git bisect bad 165c8f1695d5783fb3abb35c2ba4006115a54da3 # 08:00 0- 3 Merge 'kbusch-nvme/master' into devel-spot-201602240957
git bisect bad b554db13ba65be39df5672622a4c7df1933712f0 # 08:14 393- 3 Merge 'linux-review/Han-Xu/support-gpmi-on-i-MX6UL-7D-and-HW-bitflip-on-i-MX6QP-7D/20160224-085042' into devel-spot-201602240957
git bisect bad 9c5e6420f6f9f861a1b39ddb5db862c5d54cf9bc # 08:29 134- 3 Merge 'linux-review/Johannes-Weiner/mm-readahead-do-not-cap-readahead-and-MADV_WILLNEED/20160224-094046' into devel-spot-201602240957
git bisect good be8328a7aa06e70d4dedbf434f75df613181ea65 # 09:18 910+ 2 Merge 'linux-review/Adam-Buchbinder/include-linux-Fix-misspellings-in-comments/20160224-094831' into devel-spot-201602240957
git bisect good e8a91d281358dd8c80fc5c779ef68813ac019ad2 # 10:12 904+ 2 Merge 'linux-review/Adam-Buchbinder/ext4-Fix-misspellings-in-comments/20160224-094938' into devel-spot-201602240957
git bisect good 148f472da5db4d78fcfe61807c18f020eb5bd7fc # 11:03 903+ 1 mlxsw: reg: Add the Switch Port Acceptable Frame Types register
git bisect good 3bd7594e69bd97c962faa6a5ae15dd8c6c082636 # 11:58 904+ 0 Bluetooth: hci_core: Avoid mixing up req_complete and req_complete_skb
git bisect good d856626d3b051a3ad7139ba59463b692c131f844 # 12:36 905+ 0 Merge tag 'linux-can-fixes-for-4.5-20160221' of git://git.kernel.org/pub/scm/linux/kernel/git/mkl/linux-can
git bisect good dea08e604408d0303e2332896c5fdd8c1f7d79a2 # 12:56 905+ 0 Merge git://git.kernel.org/pub/scm/linux/kernel/git/davem/net
git bisect good 2cfec6a2f989d5c921ba11a329ff8ea986702b9b # 13:19 910+ 0 xen/pcifront: Report the errors better.
git bisect good 6e22c8366416251a3d88ba6c92d13d595089f0ed # 13:35 907+ 0 tracing, kasan: Silence Kasan warning in check_stack of stack_tracer
git bisect good 692b8c663cbaf892d10106fbca543b4bbc3202ad # 13:53 910+ 2 Merge tag 'for-linus-4.5-rc5-tag' of git://git.kernel.org/pub/scm/linux/kernel/git/xen/tip
git bisect bad 99b902528e4e49cc02fcbc26cc0a10d0eaa70a3e # 14:08 326- 1 mm: readahead: do not cap readahead() and MADV_WILLNEED
git bisect good 4de8ebeff8ddefaceeb7fc6a9b1a514fc9624509 # 14:21 909+ 4 Merge tag 'trace-fixes-v4.5-rc5' of git://git.kernel.org/pub/scm/linux/kernel/git/rostedt/linux-trace
# first bad commit: [99b902528e4e49cc02fcbc26cc0a10d0eaa70a3e] mm: readahead: do not cap readahead() and MADV_WILLNEED
git bisect good 4de8ebeff8ddefaceeb7fc6a9b1a514fc9624509 # 14:38 1010+ 4 Merge tag 'trace-fixes-v4.5-rc5' of git://git.kernel.org/pub/scm/linux/kernel/git/rostedt/linux-trace
# extra tests with DEBUG_INFO
git bisect bad 99b902528e4e49cc02fcbc26cc0a10d0eaa70a3e # 14:56 314- 1 mm: readahead: do not cap readahead() and MADV_WILLNEED
# extra tests on HEAD of linux-devel/devel-spot-201602240957
git bisect bad 44ec563f74e478ccd262b899fc404761bc5c6870 # 14:56 0- 8 0day head guard for 'devel-spot-201602240957'
# extra tests on tree/branch linux-review/Johannes-Weiner/mm-readahead-do-not-cap-readahead-and-MADV_WILLNEED/20160224-094046
git bisect bad 99b902528e4e49cc02fcbc26cc0a10d0eaa70a3e # 14:56 0- 12 mm: readahead: do not cap readahead() and MADV_WILLNEED
# extra tests with first bad commit reverted
git bisect good 19cfcdf584ce1f947c98be262ece8575438982a9 # 15:21 1010+ 1 Revert "mm: readahead: do not cap readahead() and MADV_WILLNEED"
# extra tests on tree/branch linus/master
git bisect good 29a9faa641857425af76e44f2fab22db53032401 # 15:37 1010+ 5 Merge branch 'for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/sage/ceph-client
# extra tests on tree/branch linux-next/master
git bisect good 4639ea604f53d9804b19ec75d13648c8be3698da # 15:53 1006+ 7 Add linux-next specific files for 20160226
This script may reproduce the error.
----------------------------------------------------------------------------
#!/bin/bash
kernel=$1
initrd=quantal-core-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 kvm64
-kernel $kernel
-initrd $initrd
-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
4 years, 10 months
