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, 1 month
- 4
- 4
[lkp-robot] [sched/cfs] 625ed2bf04: unixbench.score -7.4% regression
by kernel test robot
Greeting,
FYI, we noticed a -7.4% regression of unixbench.score due to commit:
commit: 625ed2bf049d5a352c1bcca962d6e133454eaaff ("sched/cfs: Make util/load_avg more stable")
https://git.kernel.org/cgit/linux/kernel/git/next/linux-next.git master
in testcase: unixbench
on test machine: 88 threads Intel(R) Xeon(R) CPU E5-2699 v4 @ 2.20GHz with 64G memory
with following parameters:
runtime: 300s
nr_task: 100%
test: spawn
cpufreq_governor: performance
test-description: UnixBench is the original BYTE UNIX benchmark suite aims to test performance of Unix-like system.
test-url: https://github.com/kdlucas/byte-unixbench
Details are as below:
-------------------------------------------------------------------------------------------------->
To reproduce:
git clone https://github.com/01org/lkp-tests.git
cd lkp-tests
bin/lkp install job.yaml # job file is attached in this email
bin/lkp run job.yaml
testcase/path_params/tbox_group/run: unixbench/300s-100%-spawn-performance/lkp-bdw-ep3b
8663effb24f94303 625ed2bf049d5a352c1bcca962
---------------- --------------------------
%stddev change %stddev
\ | \
8888 -7% 8234 unixbench.score
11626 31% 15267 unixbench.time.system_time
5084 23% 6259 unixbench.time.percent_of_cpu_this_job_got
5203 5% 5455 unixbench.time.user_time
66039778 -7% 61588314 unixbench.time.voluntary_context_switches
7.932e+08 -7% 7.34e+08 unixbench.time.minor_page_faults
24502668 -52% 11794316 unixbench.time.involuntary_context_switches
628084 -17% 518637 interrupts.CAL:Function_call_interrupts
6000 ± 57% 1e+04 19033 ± 58% latency_stats.sum.call_rwsem_down_read_failed.__percpu_down_read.exit_signals.do_exit.do_group_exit.SyS_exit_group.entry_SYSCALL_64_fastpath
715117 ± 58% -4e+05 300172 ± 12% latency_stats.sum.io_schedule.__lock_page_or_retry.filemap_fault.__do_fault.__handle_mm_fault.handle_mm_fault.__do_page_fault.do_page_fault.page_fault
94622 96223 vmstat.system.in
500325 -16% 420024 vmstat.system.cs
1692 21% 2045 turbostat.Avg_MHz
60.71 21% 73.38 turbostat.%Busy
208 212 turbostat.PkgWatt
54.56 -8% 50.47 turbostat.RAMWatt
4.911e+13 21% 5.944e+13 perf-stat.cpu-cycles
6010 19% 7153 perf-stat.instructions-per-iTLB-miss
3.508e+12 14% 3.988e+12 perf-stat.branch-instructions
1.627e+13 10% 1.797e+13 perf-stat.instructions
4.504e+12 8% 4.886e+12 perf-stat.dTLB-loads
58.34 59.21 perf-stat.node-store-miss-rate%
42.85 42.00 perf-stat.iTLB-load-miss-rate%
3.609e+09 -4% 3.469e+09 perf-stat.iTLB-loads
2.125e+10 -5% 2.016e+10 perf-stat.branch-misses
2.707e+09 -7% 2.512e+09 perf-stat.iTLB-load-misses
7.939e+08 -7% 7.348e+08 perf-stat.page-faults
7.939e+08 -7% 7.348e+08 perf-stat.minor-faults
0.33 -9% 0.30 perf-stat.ipc
9.788e+09 -9% 8.927e+09 ± 3% perf-stat.dTLB-load-misses
14.74 -9% 13.43 perf-stat.cache-miss-rate%
3.426e+11 -9% 3.117e+11 perf-stat.cache-references
1.26e+09 -9% 1.141e+09 perf-stat.dTLB-store-misses
1.579e+12 -10% 1.421e+12 perf-stat.dTLB-stores
1.773e+10 -14% 1.523e+10 perf-stat.node-load-misses
5.685e+09 -15% 4.805e+09 perf-stat.node-store-misses
0.22 -16% 0.18 ± 3% perf-stat.dTLB-load-miss-rate%
1.666e+08 -16% 1.4e+08 perf-stat.context-switches
0.61 -17% 0.51 perf-stat.branch-miss-rate%
5.051e+10 -17% 4.187e+10 perf-stat.cache-misses
32471209 -18% 26608318 perf-stat.cpu-migrations
4.059e+09 -18% 3.311e+09 perf-stat.node-stores
8.13e+08 -24% 6.207e+08 perf-stat.node-loads
unixbench.time.involuntary_context_switches
2.6e+07 ++----------------------------------------------------------------+
*.*.*.. .*.*.*. .*.*.*. .*..*.*.*. .*..*.*.*.* |
2.4e+07 ++ * *..*.*. .*.*. * * |
2.2e+07 ++ * |
| |
2e+07 ++ |
O O O O |
1.8e+07 ++O |
| |
1.6e+07 ++ |
1.4e+07 ++ |
| |
1.2e+07 ++ O O O O O O O O O O O O |
| O O O O O O O O O O O O O O
1e+07 ++----------------------------------------------------------------+
perf-stat.cpu-cycles
6e+13 ++----------------------------------------------------------------+
| O O O O O O O O O O O O O O O O O O O O O O O O O O
5.8e+13 ++ |
| |
| |
5.6e+13 O+O O O |
| O |
5.4e+13 ++ |
| |
5.2e+13 ++ |
| |
| |
5e+13 ++ .*. .*.*.*..*.*.*.*. .*. .*. .*. |
*.*.*. * *..*.*.* *..*.*.* *..*.* * |
4.8e+13 ++----------------------------------------------------------------+
perf-stat.node-load-misses
1.8e+10 ++---------------------------------------------------------------+
*.*.*..*.*.*.* .*.*..*.*.*.*.*.*..*.*.*.*.*.* |
1.75e+10 ++ : * |
1.7e+10 ++ : .*. + |
| *.*. *.* |
1.65e+10 ++ |
| |
1.6e+10 ++ |
| |
1.55e+10 O+ O O O O O O O
1.5e+10 ++ O O O O O O O O |
| |
1.45e+10 ++O O O O O O O O O O O O O |
| O |
1.4e+10 ++---------------O-----------------------------------------------+
perf-stat.context-switches
1.7e+08 ++---------------------------------------------------------------+
*.*.*.. .*.*.* .*.*..*. .*.*.*.*.. .*.*.*.*.* |
1.65e+08 ++ * + * * * |
1.6e+08 ++ *. .*. + |
| *. *.* |
1.55e+08 ++ |
| |
1.5e+08 ++ |
| |
1.45e+08 O+O O O O |
1.4e+08 ++ O O O O O O O O |
| O O O O O O
1.35e+08 ++ O O O O O O O O O O |
| O O |
1.3e+08 ++---------------------------------------------------------------+
perf-stat.cpu-migrations
3.3e+07 ++-----------------------------------------------------*-*--------+
| .*..*. .*. * .*.*. .*.*. + |
3.2e+07 *+* * *. + + .*..*.* *..*.* *..*.* |
3.1e+07 ++ *..*.* * |
| |
3e+07 ++ |
| |
2.9e+07 ++ |
| |
2.8e+07 ++ |
2.7e+07 ++ |
O O O O O O O O O O O O O
2.6e+07 ++ O O O O O O |
| O O O O O O O O O O O O |
2.5e+07 ++----------------------------------------------------------------+
perf-stat.branch-miss-rate_
0.62 ++-------------------------------------------------------------------+
*. .*. .*..*.*. *..*.*. .*. .*.*.. .*. .*.*.*.. .* |
0.6 ++*. * *.*.. + *. * * *. * |
| *.* |
0.58 ++ |
| |
0.56 ++ |
| |
0.54 ++ |
| |
0.52 ++ O O |
O O O O O O |
0.5 ++ O O O O O O O O
| O O O O O O O O O O |
0.48 ++O--O---O------O------O---------------------------------------------+
perf-stat.ipc
0.335 ++------------------------------------------------------------------+
*.*..*.*.*.*..* .*..*.*.*..*.*.*.*..*.*.*.*..*.* |
0.33 ++ : *.. * |
0.325 ++ : + + |
| *.* *.* |
0.32 ++ |
| |
0.315 ++ |
| |
0.31 ++ |
0.305 ++ |
O O O O O O O O O O O O O O
0.3 ++ O O O O O |
| O O O O O O O O O O O O |
0.295 ++------------------------------------------------------------------+
perf-stat.instructions-per-iTLB-miss
7400 ++-------------------------------------------------------------------+
| O O O O O |
7200 ++O O O O O O O O O O O O O O O
7000 O+ O O O O O O O O O O |
| |
6800 ++ |
| |
6600 ++ |
| |
6400 ++ |
6200 ++ *. .*. |
*. + *..* *..*.*. .*.. |
6000 ++*..*. .*..*.* *..*. .* *.*. .*. .*..*.* |
| * * *. * |
5800 ++-------------------------------------------------------------------+
[*] bisect-good sample
[O] bisect-bad sample
Disclaimer:
Results have been estimated based on internal Intel analysis and are provided
for informational purposes only. Any difference in system hardware or software
design or configuration may affect actual performance.
Thanks,
Xiaolong
2 years, 10 months
- 4
- 3
[USB] f16443a034: EIP:arch_local_irq_restore
by kernel test robot
FYI, we noticed the following commit:
commit: f16443a034c7aa359ddf6f0f9bc40d01ca31faea ("USB: gadgetfs, dummy-hcd, net2280: fix locking for callbacks")
https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git master
in testcase: trinity
with following parameters:
runtime: 300s
test-description: Trinity is a linux system call fuzz tester.
test-url: http://codemonkey.org.uk/projects/trinity/
on test machine: qemu-system-x86_64 -enable-kvm -m 420M
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
+-----------------------------------------+------------+------------+
| | d2f48f05cd | f16443a034 |
+-----------------------------------------+------------+------------+
| boot_successes | 53 | 0 |
| boot_failures | 1 | 58 |
| INFO:task_blocked_for_more_than#seconds | 1 | |
| calltrace:rtnl_lock | 1 | |
| calltrace:debug_show_all_locks | 1 | |
| BUG:kernel_hang_in_test_stage | 1 | |
| EIP:arch_local_irq_restore | 0 | 34 |
| EIP:ftrace_likely_update | 0 | 5 |
| EIP:__rb_reserve_next | 0 | 3 |
| EIP:native_safe_halt | 0 | 5 |
| EIP:arch_local_irq_enable | 0 | 1 |
| EIP:ring_buffer_unlock_commit | 0 | 1 |
| EIP:ring_buffer_lock_reserve | 0 | 3 |
| EIP:rb_calculate_event_length | 0 | 2 |
| EIP:rb_commit | 0 | 2 |
| EIP:paravirt_sched_clock | 0 | 1 |
| EIP:ring_buffer_producer | 0 | 1 |
+-----------------------------------------+------------+------------+
[ 2.748828] kernel_init+0x8/0x150
[ 2.748828] kernel_init+0x8/0x150
[ 2.748830] ret_from_fork+0x19/0x24
[ 2.748830] ret_from_fork+0x19/0x24
[ 2.748830]
[ 2.748830] other info that might help us debug this:
[ 2.748830]
[ 2.748830]
[ 2.748830] other info that might help us debug this:
[ 2.748830]
[ 2.748837] Possible unsafe locking scenario:
[ 2.748837]
[ 2.748837] Possible unsafe locking scenario:
[ 2.748837]
[ 2.748839] CPU0 CPU1
[ 2.748839] CPU0 CPU1
[ 2.748840] ---- ----
[ 2.748840] ---- ----
[ 2.748840] lock(&(&cdev->lock)->rlock);
[ 2.748840] lock(&(&cdev->lock)->rlock);
[ 2.748843] lock(&(&dum_hcd->dum->lock)->rlock);
[ 2.748843] lock(&(&dum_hcd->dum->lock)->rlock);
[ 2.748845] lock(&(&cdev->lock)->rlock);
[ 2.748845] lock(&(&cdev->lock)->rlock);
[ 2.748848] lock(&(&dum_hcd->dum->lock)->rlock);
[ 2.748848] lock(&(&dum_hcd->dum->lock)->rlock);
[ 2.748850]
[ 2.748850] *** DEADLOCK ***
[ 2.748850]
[ 2.748850]
[ 2.748850] *** DEADLOCK ***
[ 2.748850]
[ 2.748852] 3 locks held by swapper/1:
[ 2.748852] 3 locks held by swapper/1:
[ 2.748853] #0: (console_lock){+.+...}, at: [<790d2ca8>] vprintk_emit+0x363/0x38e
[ 2.748853] #0: (console_lock){+.+...}, at: [<790d2ca8>] vprintk_emit+0x363/0x38e
[ 2.748859] #1: ((&dum_hcd->timer)){+.-...}, at: [<790ec25b>] call_timer_fn+0x0/0x38c
[ 2.748859] #1: ((&dum_hcd->timer)){+.-...}, at: [<790ec25b>] call_timer_fn+0x0/0x38c
[ 2.748865] #2: (&(&cdev->lock)->rlock){..-...}, at: [<799eab67>] composite_setup+0xaa9/0x1a55
[ 2.748865] #2: (&(&cdev->lock)->rlock){..-...}, at: [<799eab67>] composite_setup+0xaa9/0x1a55
[ 2.748871]
[ 2.748871] stack backtrace:
[ 2.748871]
[ 2.748871] stack backtrace:
[ 2.748874] CPU: 0 PID: 1 Comm: swapper Not tainted 4.12.0-rc5-00006-gf16443a #1
[ 2.748874] CPU: 0 PID: 1 Comm: swapper Not tainted 4.12.0-rc5-00006-gf16443a #1
[ 2.748876] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 2.748876] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 2.748878] Call Trace:
[ 2.748878] Call Trace:
[ 2.748879] <SOFTIRQ>
[ 2.748879] <SOFTIRQ>
[ 2.748882] ? show_stack+0x56/0x5e
[ 2.748882] ? show_stack+0x56/0x5e
[ 2.748886] dump_stack+0x16/0x18
[ 2.748886] dump_stack+0x16/0x18
[ 2.748889] print_circular_bug+0x18b/0x198
[ 2.748889] print_circular_bug+0x18b/0x198
[ 2.748892] validate_chain+0x668/0x829
[ 2.748892] validate_chain+0x668/0x829
[ 2.748895] ? ret_from_fork+0x19/0x24
[ 2.748895] ? ret_from_fork+0x19/0x24
[ 2.748897] ? mark_lock+0x1e/0x1cc
[ 2.748897] ? mark_lock+0x1e/0x1cc
[ 2.748900] __lock_acquire+0x543/0x5eb
[ 2.748900] __lock_acquire+0x543/0x5eb
[ 2.748902] lock_acquire+0xe1/0x157
[ 2.748902] lock_acquire+0xe1/0x157
[ 2.748905] ? dummy_queue+0xd6/0x1fb
[ 2.748905] ? dummy_queue+0xd6/0x1fb
[ 2.748907] _raw_spin_lock_irqsave+0x37/0x47
[ 2.748907] _raw_spin_lock_irqsave+0x37/0x47
[ 2.748910] ? dummy_queue+0xd6/0x1fb
[ 2.748910] ? dummy_queue+0xd6/0x1fb
[ 2.748911] dummy_queue+0xd6/0x1fb
[ 2.748911] dummy_queue+0xd6/0x1fb
[ 2.748913] usb_ep_queue+0x80/0x1b5
[ 2.748913] usb_ep_queue+0x80/0x1b5
[ 2.748915] ncm_do_notify+0x155/0x187
[ 2.748915] ncm_do_notify+0x155/0x187
[ 2.748917] ncm_set_alt+0x267/0x276
[ 2.748917] ncm_set_alt+0x267/0x276
[ 2.748919] composite_setup+0xc75/0x1a55
[ 2.748919] composite_setup+0xc75/0x1a55
[ 2.748920] ? check_chain_key+0x8c/0xe1
[ 2.748920] ? check_chain_key+0x8c/0xe1
[ 2.748923] ? do_raw_spin_unlock+0xea/0x126
[ 2.748923] ? do_raw_spin_unlock+0xea/0x126
[ 2.748925] dummy_timer+0x8ba/0x1083
[ 2.748925] dummy_timer+0x8ba/0x1083
[ 2.748926] ? dummy_timer+0x8ba/0x1083
[ 2.748926] ? dummy_timer+0x8ba/0x1083
[ 2.748928] ? __lock_is_held+0x35/0x65
[ 2.748928] ? __lock_is_held+0x35/0x65
[ 2.748930] ? dummy_udc_probe+0x1b5/0x1b5
[ 2.748930] ? dummy_udc_probe+0x1b5/0x1b5
[ 2.748932] call_timer_fn+0x179/0x38c
[ 2.748932] call_timer_fn+0x179/0x38c
[ 2.748933] ? dummy_udc_probe+0x1b5/0x1b5
[ 2.748933] ? dummy_udc_probe+0x1b5/0x1b5
[ 2.748935] ? dummy_udc_probe+0x1b5/0x1b5
[ 2.748935] ? dummy_udc_probe+0x1b5/0x1b5
[ 2.748936] run_timer_softirq+0x1a1/0x1c9
[ 2.748936] run_timer_softirq+0x1a1/0x1c9
[ 2.748939] ? rcu_read_unlock_sched_notrace+0x21/0x41
[ 2.748939] ? rcu_read_unlock_sched_notrace+0x21/0x41
[ 2.748941] __do_softirq+0x1f6/0x4c7
[ 2.748941] __do_softirq+0x1f6/0x4c7
[ 2.748946] ? univ8250_console_setup+0x7a/0x7a
[ 2.748946] ? univ8250_console_setup+0x7a/0x7a
[ 2.748948] ? _local_bh_enable+0x5f/0x5f
[ 2.748948] ? _local_bh_enable+0x5f/0x5f
[ 2.748950] do_softirq_own_stack+0x1e/0x24
[ 2.748950] do_softirq_own_stack+0x1e/0x24
[ 2.748951] </SOFTIRQ>
[ 2.748951] </SOFTIRQ>
[ 2.748953] irq_exit+0x92/0xab
[ 2.748953] irq_exit+0x92/0xab
[ 2.748954] smp_apic_timer_interrupt+0x23/0x2c
[ 2.748954] smp_apic_timer_interrupt+0x23/0x2c
[ 2.748956] apic_timer_interrupt+0x34/0x3c
[ 2.748956] apic_timer_interrupt+0x34/0x3c
[ 2.748958] EIP: arch_local_irq_restore+0x5/0xb
[ 2.748958] EIP: arch_local_irq_restore+0x5/0xb
[ 2.748959] EFLAGS: 00200202 CPU: 0
[ 2.748959] EFLAGS: 00200202 CPU: 0
[ 2.748960] EAX: 00200202 EBX: 00000000 ECX: 00000006 EDX: 00000007
[ 2.748960] EAX: 00200202 EBX: 00000000 ECX: 00000006 EDX: 00000007
[ 2.748961] ESI: 796eb13b EDI: 00000000 EBP: 919efe00 ESP: 919efe00
[ 2.748961] ESI: 796eb13b EDI: 00000000 EBP: 919efe00 ESP: 919efe00
[ 2.748962] DS: 007b ES: 007b FS: 0000 GS: 0000 SS: 0068
[ 2.748962] DS: 007b ES: 007b FS: 0000 GS: 0000 SS: 0068
[ 2.748964] ? univ8250_console_setup+0x7a/0x7a
[ 2.748964] ? univ8250_console_setup+0x7a/0x7a
[ 2.748966] ? trace_raw_output_console+0x2d/0x59
[ 2.748966] ? trace_raw_output_console+0x2d/0x59
[ 2.748968] console_unlock+0x514/0x667
[ 2.748968] console_unlock+0x514/0x667
[ 2.748970] vprintk_emit+0x384/0x38e
[ 2.748970] vprintk_emit+0x384/0x38e
[ 2.748971] vprintk_default+0x12/0x14
[ 2.748971] vprintk_default+0x12/0x14
[ 2.748973] vprintk_func+0x63/0x67
[ 2.748973] vprintk_func+0x63/0x67
[ 2.748975] printk+0xe/0x10
[ 2.748975] printk+0xe/0x10
[ 2.748977] test+0x2c7/0x314
[ 2.748977] test+0x2c7/0x314
[ 2.748979] ? disk_type+0x4e/0x4e
[ 2.748979] ? disk_type+0x4e/0x4e
[ 2.748981] raid6_test+0xb8/0x116
[ 2.748981] raid6_test+0xb8/0x116
[ 2.748983] ? test+0x314/0x314
[ 2.748983] ? test+0x314/0x314
[ 2.748984] do_one_initcall+0x8f/0x18f
[ 2.748984] do_one_initcall+0x8f/0x18f
[ 2.748986] ? parse_args+0x19f/0x24d
[ 2.748986] ? parse_args+0x19f/0x24d
[ 2.748988] ? kernel_init_freeable+0xdb/0x1bc
[ 2.748988] ? kernel_init_freeable+0xdb/0x1bc
[ 2.748989] kernel_init_freeable+0xfe/0x1bc
[ 2.748989] kernel_init_freeable+0xfe/0x1bc
[ 2.748991] ? rest_init+0x12a/0x12a
[ 2.748991] ? rest_init+0x12a/0x12a
[ 2.748992] kernel_init+0x8/0x150
[ 2.748992] kernel_init+0x8/0x150
[ 2.748994] ret_from_fork+0x19/0x24
[ 2.748994] ret_from_fork+0x19/0x24
[ 2.821984] cdc_ncm 1-1:1.0: MAC-Address: 4e:8c:d2:7b:df:4e
[ 2.821984] cdc_ncm 1-1:1.0: MAC-Address: 4e:8c:d2:7b:df:4e
[ 2.822334] cdc_ncm 1-1:1.0 usb1: register 'cdc_ncm' at usb-dummy_hcd.0-1, CDC NCM, 4e:8c:d2:7b:df:4e
[ 2.822334] cdc_ncm 1-1:1.0 usb1: register 'cdc_ncm' at usb-dummy_hcd.0-1, CDC NCM, 4e:8c:d2:7b:df:4e
[ 2.827981] raid6test: test_disks(12, 15): faila= 12(D) failb= 15(D) OK
To reproduce:
git clone https://github.com/01org/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email
Thanks,
Kernel Test Robot
2 years, 11 months
- 3
- 9
492b95e597 ("rcuperf: Set more user-friendly defaults"): WARNING: CPU: 0 PID: 10 at arch/x86/kernel/smp.c:128 native_smp_send_reschedule
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/paulmck/linux-rcu.git dev.2017.06.12a
commit 492b95e59735998312f678d77a2d5fe20af6b0b9
Author: Paul E. McKenney <paulmck(a)linux.vnet.ibm.com>
AuthorDate: Fri Apr 21 16:09:15 2017 -0700
Commit: Paul E. McKenney <paulmck(a)linux.vnet.ibm.com>
CommitDate: Thu Jun 8 08:25:31 2017 -0700
rcuperf: Set more user-friendly defaults
Common-case use of rcuperf must set rcuperf.nreaders=0 and if not built
as a module, rcuperf.shutdown. This commit therefore sets the default
for rcuperf.nreaders to zero and sets the default for rcuperf.shutdown
to zero if rcuperf is built as a module and to one otherwise.
Signed-off-by: Paul E. McKenney <paulmck(a)linux.vnet.ibm.com>
3ddf20c953 srcu: Shrink Tiny SRCU a bit more
492b95e597 rcuperf: Set more user-friendly defaults
62ff3cf157 swait: add idle variants which don't contribute to load average
+--------------------------------------------------------------+------------+------------+------------+
| | 3ddf20c953 | 492b95e597 | 62ff3cf157 |
+--------------------------------------------------------------+------------+------------+------------+
| boot_successes | 112 | 0 | 0 |
| boot_failures | 4 | 42 | 46 |
| BUG:kernel_reboot-without-warning_in_test_stage | 4 | 1 | |
| WARNING:at_arch/x86/kernel/smp.c:#native_smp_send_reschedule | 0 | 13 | 16 |
| BUG:kernel_hang_in_test_stage | 0 | 41 | 46 |
+--------------------------------------------------------------+------------+------------+------------+
[ 23.663581] acpi_power_off called
[ 24.117895] sched: Unexpected reschedule of offline CPU#1!
[ 24.117895] sched: Unexpected reschedule of offline CPU#1!
[ 24.118997] ------------[ cut here ]------------
[ 24.118997] ------------[ cut here ]------------
[ 24.119852] WARNING: CPU: 0 PID: 10 at arch/x86/kernel/smp.c:128 native_smp_send_reschedule+0x86/0xbe
[ 24.119852] WARNING: CPU: 0 PID: 10 at arch/x86/kernel/smp.c:128 native_smp_send_reschedule+0x86/0xbe
[ 24.121887] Modules linked in:
[ 24.121887] Modules linked in:
[ 24.122438] CPU: 0 PID: 10 Comm: migration/0 Not tainted 4.12.0-rc4-00028-g492b95e #1
[ 24.122438] CPU: 0 PID: 10 Comm: migration/0 Not tainted 4.12.0-rc4-00028-g492b95e #1
[ 24.123982] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 24.123982] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 24.125843] task: ffff88001d7b2140 task.stack: ffffc90000118000
[ 24.125843] task: ffff88001d7b2140 task.stack: ffffc90000118000
[ 24.126889] RIP: 0010:native_smp_send_reschedule+0x86/0xbe
[ 24.126889] RIP: 0010:native_smp_send_reschedule+0x86/0xbe
[ 24.128889] RSP: 0018:ffffc9000011bd48 EFLAGS: 00010096
[ 24.128889] RSP: 0018:ffffc9000011bd48 EFLAGS: 00010096
[ 24.129835] RAX: 000000000000002e RBX: 0000000000000003 RCX: ffff88001d7b2140
[ 24.129835] RAX: 000000000000002e RBX: 0000000000000003 RCX: ffff88001d7b2140
[ 24.131111] RDX: 0000002e1d7b2140 RSI: 0000000000000000 RDI: 0000000000000096
[ 24.131111] RDX: 0000002e1d7b2140 RSI: 0000000000000000 RDI: 0000000000000096
[ 24.132474] RBP: ffffc9000011bd60 R08: 0000000000000021 R09: 000000000000002e
[ 24.132474] RBP: ffffc9000011bd60 R08: 0000000000000021 R09: 000000000000002e
[ 24.133830] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000001
[ 24.133830] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000001
[ 24.135088] R13: 0000000000000001 R14: 0000000000000001 R15: 0000000000000001
[ 24.135088] R13: 0000000000000001 R14: 0000000000000001 R15: 0000000000000001
[ 24.136390] FS: 0000000000000000(0000) GS:ffff88001e600000(0000) knlGS:0000000000000000
[ 24.136390] FS: 0000000000000000(0000) GS:ffff88001e600000(0000) knlGS:0000000000000000
[ 24.137942] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 24.137942] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 24.138998] CR2: 00007f8ebf639b20 CR3: 000000001ee49000 CR4: 00000000000006b0
[ 24.138998] CR2: 00007f8ebf639b20 CR3: 000000001ee49000 CR4: 00000000000006b0
[ 24.140300] DR0: 00000000018b5000 DR1: 00000000018b5000 DR2: 0000000000000000
[ 24.140300] DR0: 00000000018b5000 DR1: 00000000018b5000 DR2: 0000000000000000
[ 24.141647] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000600
[ 24.141647] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000600
[ 24.142999] Call Trace:
[ 24.142999] Call Trace:
[ 24.143465] smp_send_reschedule+0xa/0xc
[ 24.143465] smp_send_reschedule+0xa/0xc
[ 24.144218] resched_curr+0x8a/0x96
[ 24.144218] resched_curr+0x8a/0x96
[ 24.144882] check_preempt_curr+0x7e/0xc0
[ 24.144882] check_preempt_curr+0x7e/0xc0
[ 24.145655] move_queued_task+0xbd/0xcb
[ 24.145655] move_queued_task+0xbd/0xcb
[ 24.146338] __migrate_task+0x9a/0xad
[ 24.146338] __migrate_task+0x9a/0xad
[ 24.147032] migration_cpu_stop+0xaf/0xe5
[ 24.147032] migration_cpu_stop+0xaf/0xe5
[ 24.147774] ? do_raw_spin_unlock+0x113/0x146
[ 24.147774] ? do_raw_spin_unlock+0x113/0x146
[ 24.148567] ? sched_ttwu_pending+0xa6/0xa6
[ 24.148567] ? sched_ttwu_pending+0xa6/0xa6
[ 24.149333] cpu_stopper_thread+0xf4/0x24a
[ 24.149333] cpu_stopper_thread+0xf4/0x24a
[ 24.150067] ? _raw_spin_unlock_irqrestore+0x4d/0x57
[ 24.150067] ? _raw_spin_unlock_irqrestore+0x4d/0x57
[ 24.150954] smpboot_thread_fn+0x343/0x364
[ 24.150954] smpboot_thread_fn+0x343/0x364
[ 24.151721] kthread+0x16c/0x17c
[ 24.151721] kthread+0x16c/0x17c
[ 24.152299] ? smpboot_park_thread+0x73/0x73
[ 24.152299] ? smpboot_park_thread+0x73/0x73
[ 24.153108] ? init_completion+0x2d/0x2d
[ 24.153108] ? init_completion+0x2d/0x2d
[ 24.153835] ret_from_fork+0x2a/0x40
[ 24.153835] ret_from_fork+0x2a/0x40
[ 24.154470] Code: 00 00 31 d2 be 01 00 00 00 48 c7 c7 c0 57 50 88 e8 9d 0e 15 00 44 89 e6 48 c7 c7 4d b8 21 88 48 ff 05 f9 93 d6 00 e8 1e 3e 1a 00 <0f> ff b9 01 00 00 00 31 d2 be 01 00 00 00 48 c7 c7 90 57 50 88
[ 24.154470] Code: 00 00 31 d2 be 01 00 00 00 48 c7 c7 c0 57 50 88 e8 9d 0e 15 00 44 89 e6 48 c7 c7 4d b8 21 88 48 ff 05 f9 93 d6 00 e8 1e 3e 1a 00 <0f> ff b9 01 00 00 00 31 d2 be 01 00 00 00 48 c7 c7 90 57 50 88
[ 24.158104] ---[ end trace 13e6f56914861e7d ]---
[ 24.158104] ---[ end trace 13e6f56914861e7d ]---
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start 158f470fb4e8221f43d21d1c13fadbef3ba9b508 32c1431eea4881a6b17bd7c639315010aeefa452 --
git bisect bad 361fe55113bb6ce1fc7dfa1ec940cdf0ccf21740 # 01:47 B 11 7 11 11 Merge 'nfc-next/master' into devel-catchup-201706192237
git bisect bad c78a6c534ccd19dce588d007875abb59b6807fea # 02:30 B 0 1 14 0 Merge 'tip/master' into devel-catchup-201706192237
git bisect good 2ddb18a80ed79b97483cb486c2c33a1085bb5d65 # 03:00 G 18 0 1 1 0day base guard for 'devel-catchup-201706192237'
git bisect good 73a618967f573a6312ced155ca0f4f788046b208 # 03:35 G 18 0 0 0 Merge 'linux-review/Xiaowei-Song/PCI-hisi-Add-DT-binding-for-PCIe-of-Kirin-SoC-series/20170619-222153' into devel-catchup-201706192237
git bisect bad 41ff71aa52c35cbfd04001f7fe52a01c31c052fd # 04:14 B 15 3 15 15 Merge branch 'timers/core'
git bisect bad f7f5712fcaba9543708804f01fa347fc3936c04a # 05:03 B 25 7 25 25 Merge branch 'ras/core'
git bisect bad 6d48152eafde1f0d0a4a9e0584fa7d9ff4fbfdac # 05:46 B 19 6 19 19 rcu: Remove RCU CPU stall warnings from Tiny RCU
git bisect bad d7d34d5e46140a13f86379c87a196dc8a0b9b585 # 06:34 B 16 12 16 16 sched: Rely on synchronize_rcu_mult() de-duplication
git bisect good 35bdc72a339717c60c16457091f227a122456bd9 # 06:52 G 36 0 1 1 docs: Fix typo in Documentation/memory-barriers.txt
git bisect bad f4687d2637a4016b2eedfdb777105c95e8d6fe52 # 07:48 B 19 6 19 19 rcu: Add preemptibility checks in rcu_sched_qs() and rcu_bh_qs()
git bisect bad 492b95e59735998312f678d77a2d5fe20af6b0b9 # 08:28 B 12 6 12 12 rcuperf: Set more user-friendly defaults
git bisect good 1f4f6da1c80905830337c3ff46a2d3260dabb864 # 08:49 G 38 0 0 0 srcu: Make Classic and Tree SRCU announce themselves at bootup
git bisect good 3ddf20c953520203c42dbed1f091ed52080e1cd2 # 09:05 G 38 0 1 1 srcu: Shrink Tiny SRCU a bit more
# first bad commit: [492b95e59735998312f678d77a2d5fe20af6b0b9] rcuperf: Set more user-friendly defaults
git bisect good 3ddf20c953520203c42dbed1f091ed52080e1cd2 # 09:10 G 110 0 3 4 srcu: Shrink Tiny SRCU a bit more
# extra tests with CONFIG_DEBUG_INFO_REDUCED
git bisect bad 492b95e59735998312f678d77a2d5fe20af6b0b9 # 09:54 B 12 3 12 12 rcuperf: Set more user-friendly defaults
# extra tests on HEAD of linux-devel/devel-catchup-201706192237
git bisect bad 158f470fb4e8221f43d21d1c13fadbef3ba9b508 # 09:55 B 0 6 49 28 0day head guard for 'devel-catchup-201706192237'
# extra tests on tree/branch rcu/dev.2017.06.12a
git bisect bad 62ff3cf157b070a384c025507f1657084a007ec1 # 11:02 B 1 1 1 2 swait: add idle variants which don't contribute to load average
# extra tests with first bad commit reverted
git bisect good 560f5e0f992d49e5d0cc8769063ffa32f7455c70 # 11:39 G 38 0 0 0 Revert "rcuperf: Set more user-friendly defaults"
# extra tests on tree/branch linux-next/master
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
3 years
- 3
- 3
7313b483cc ("sched: Replace spin_unlock_wait() with .."): inconsistent {IN-SOFTIRQ-W} -> {SOFTIRQ-ON-W} usage.
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/paulmck/linux-rcu.git spin_unlock_wait_no.2017.06.29c
commit 7313b483ccf580931046edc1e7c58a6f809b19d1
Author: Paul E. McKenney <paulmck(a)linux.vnet.ibm.com>
AuthorDate: Thu Jun 29 12:08:26 2017 -0700
Commit: Paul E. McKenney <paulmck(a)linux.vnet.ibm.com>
CommitDate: Thu Jun 29 12:08:26 2017 -0700
sched: Replace spin_unlock_wait() with lock/unlock pair
There is no agreed-upon definition of spin_unlock_wait()'s semantics,
and it appears that all callers could do just as well with a lock/unlock
pair. This commit therefore replaces the spin_unlock_wait() call in
do_task_dead() with spin_lock() followed immediately by spin_unlock().
This should be safe from a performance perspective because the lock is
this tasks ->pi_lock, and this is called only after the task exits.
Signed-off-by: Paul E. McKenney <paulmck(a)linux.vnet.ibm.com>
Cc: Ingo Molnar <mingo(a)redhat.com>
Cc: Peter Zijlstra <peterz(a)infradead.org>
Cc: Will Deacon <will.deacon(a)arm.com>
Cc: Peter Zijlstra <peterz(a)infradead.org>
Cc: Alan Stern <stern(a)rowland.harvard.edu>
Cc: Andrea Parri <parri.andrea(a)gmail.com>
Cc: Linus Torvalds <torvalds(a)linux-foundation.org>
46a4746d9a task_work: Replace spin_unlock_wait() with lock/unlock pair
7313b483cc sched: Replace spin_unlock_wait() with lock/unlock pair
e81efa4219 arch: Remove spin_unlock_wait() arch-specific definitions
+-------------------------------------------------+------------+------------+------------+
| | 46a4746d9a | 7313b483cc | e81efa4219 |
+-------------------------------------------------+------------+------------+------------+
| boot_successes | 35 | 0 | 0 |
| boot_failures | 0 | 15 | 19 |
| inconsistent{IN-SOFTIRQ-W}->{SOFTIRQ-ON-W}usage | 0 | 15 | 19 |
+-------------------------------------------------+------------+------------+------------+
[ 9.348645]
[ 9.348912] ================================
[ 9.352204] WARNING: inconsistent lock state
[ 9.358252] 4.12.0-rc4-00091-g7313b48 #1 Not tainted
[ 9.361203] --------------------------------
[ 9.361827] inconsistent {IN-SOFTIRQ-W} -> {SOFTIRQ-ON-W} usage.
[ 9.368726] cryptomgr_test/23 [HC0[0]:SC0[0]:HE1:SE1] takes:
[ 9.374531] (&p->pi_lock){+.?...}, at: [<ffffffff81083fde>] do_task_dead+0x1e/0x50
[ 9.382548] {IN-SOFTIRQ-W} state was registered at:
[ 9.387839] __lock_acquire+0x304/0x1220
[ 9.389695] lock_acquire+0x58/0x80
[ 9.390255] _raw_spin_lock_irqsave+0x41/0x60
[ 9.406126] try_to_wake_up+0x2e/0x1e0
[ 9.409355] wake_up_process+0x10/0x20
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start 491f731a1620f1e94615d26de9bdf75bf808aece 08332893e37af6ae779367e78e444f8f9571511d --
git bisect good a4ef0e70bb0e8515d44dc742f30141edc7924ac2 # 04:33 G 11 0 0 0 Merge 'miklos-vfs/overlayfs-linus' into devel-catchup-201707010218
git bisect good 979475e6b7e5126f28fce63083e50747a9ac59d8 # 04:50 G 11 0 0 0 Merge 'vfs/for-next' into devel-catchup-201707010218
git bisect bad 888454bcfe157babe9dd408f9943f0ae981c5d23 # 05:00 B 0 1 13 0 Merge 'rcu/spin_unlock_wait_no.2017.06.29c' into devel-catchup-201707010218
git bisect good 3caec62fbb313946b9be53720bbf2280bb19ec28 # 05:21 G 11 0 0 0 rcu: Move rcu_expedited and rcu_normal externs from rcupdate.h
git bisect good 90040c9e3015054db7efa0101afdd446d1167fe8 # 05:35 G 11 0 0 0 rcu: Remove *_SLOW_* Kconfig options
git bisect good 43a0a2a7d725f2ed2547cd656749eb66c093f2c2 # 05:49 G 11 0 0 0 rcu: Move RCU debug Kconfig options to kernel/rcu
git bisect bad 7daa52aa27c23f125bdafccfde67db6c5da26939 # 06:03 B 0 11 25 2 completion: Replace spin_unlock_wait() with lock/unlock pair
git bisect good ee4c0fbd46e7874f15d5f7217cd0e172aad7d078 # 06:14 G 11 0 0 0 netfilter: Replace spin_unlock_wait() with lock/unlock pair
git bisect bad 7313b483ccf580931046edc1e7c58a6f809b19d1 # 06:22 B 0 2 14 0 sched: Replace spin_unlock_wait() with lock/unlock pair
git bisect good 46a4746d9a364a9b0267c19be0f8419e9b72ad37 # 06:35 G 11 0 0 0 task_work: Replace spin_unlock_wait() with lock/unlock pair
# first bad commit: [7313b483ccf580931046edc1e7c58a6f809b19d1] sched: Replace spin_unlock_wait() with lock/unlock pair
git bisect good 46a4746d9a364a9b0267c19be0f8419e9b72ad37 # 06:37 G 31 0 0 0 task_work: Replace spin_unlock_wait() with lock/unlock pair
# extra tests with CONFIG_DEBUG_INFO_REDUCED
git bisect bad 7313b483ccf580931046edc1e7c58a6f809b19d1 # 06:46 B 0 11 24 0 sched: Replace spin_unlock_wait() with lock/unlock pair
# extra tests on HEAD of linux-devel/devel-catchup-201707010218
git bisect bad 491f731a1620f1e94615d26de9bdf75bf808aece # 06:46 B 0 33 48 0 0day head guard for 'devel-catchup-201707010218'
# extra tests on tree/branch rcu/spin_unlock_wait_no.2017.06.29c
git bisect bad e81efa4219e9b07e476448572aafe8f9c4ad28c8 # 07:05 B 0 1 13 0 arch: Remove spin_unlock_wait() arch-specific definitions
# extra tests with first bad commit reverted
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
3 years
- 1
- 0
560a5aede4 ("Merge 'kees/kspp/usercopy-whitelist/20170619' .."): kernel BUG at mm/usercopy.c:72!
by kernel test robot
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
git://internal_merge_and_test_tree devel-spot-201706301235
commit 560a5aede4068580f7caaba00f997cb040b8b2e6
Merge: 4c14c2f444891 157d3da018940
Author: 0day robot <fengguang.wu(a)intel.com>
AuthorDate: Fri Jun 30 12:38:41 2017 +0800
Commit: 0day robot <fengguang.wu(a)intel.com>
CommitDate: Fri Jun 30 12:38:41 2017 +0800
Merge 'kees/kspp/usercopy-whitelist/20170619' into devel-spot-201706301235
4c14c2f444 Merge 'regulator/for-next' into devel-spot-201706301235
157d3da018 xfs: define usercopy region in xfs_inode slab cache
560a5aede4 Merge 'kees/kspp/usercopy-whitelist/20170619' into devel-spot-201706301235
c98fcf387b 0day head guard for 'devel-spot-201706301235'
+------------------------------------------+------------+------------+------------+------------+
| | 4c14c2f444 | 157d3da018 | 560a5aede4 | c98fcf387b |
+------------------------------------------+------------+------------+------------+------------+
| boot_successes | 35 | 35 | 4 | 14 |
| boot_failures | 0 | 0 | 11 | 25 |
| kernel_BUG_at_mm/usercopy.c | 0 | 0 | 11 | 25 |
| invalid_opcode:#[##] | 0 | 0 | 11 | 25 |
| EIP:__check_object_size | 0 | 0 | 11 | 25 |
| Kernel_panic-not_syncing:Fatal_exception | 0 | 0 | 11 | 25 |
+------------------------------------------+------------+------------+------------+------------+
[ 6.913189] Loading compiled-in X.509 certificates
[ 6.914081] rtc_cmos 00:00: setting system clock to 2017-06-30 17:57:23 UTC (1498845443)
[ 6.915661] sir_ir sir_ir.0: Trapped in interrupt
[ 6.916062] genirq: Flags mismatch irq 4. 00000000 (ttyS0) vs. 00000000 (sir_ir)
[ 6.916592] CPU: 0 PID: 1 Comm: swapper Not tainted 4.12.0-rc7-02453-g560a5ae #2
[ 6.917129] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 6.917850] Call Trace:
[ 6.918030] dump_stack+0x16/0x1c
[ 6.918266] __setup_irq+0x42b/0x590
[ 6.918529] ? kmem_cache_alloc+0xfb/0x1c0
[ 6.918839] request_threaded_irq+0xec/0x150
[ 6.919142] univ8250_setup_irq+0x1cf/0x210
[ 6.919436] serial8250_do_startup+0x41a/0x600
[ 6.919774] serial8250_startup+0x15/0x20
[ 6.920058] uart_port_startup+0xab/0x170
[ 6.920343] uart_port_activate+0x78/0xa0
[ 6.920627] tty_port_open+0x6c/0xb0
[ 6.920903] uart_open+0x33/0x50
[ 6.921133] tty_open+0x2e6/0x3f0
[ 6.921370] chrdev_open+0x127/0x180
[ 6.921624] do_dentry_open+0x169/0x290
[ 6.921961] ? exact_lock+0x20/0x20
[ 6.922209] vfs_open+0x4e/0x60
[ 6.922435] path_openat+0xc8d/0x1000
[ 6.922696] ? ret_from_fork+0x19/0x24
[ 6.922989] ? find_held_lock+0x2d/0xa0
[ 6.923261] ? __lock_is_held+0x4a/0x90
[ 6.923533] do_filp_open+0x75/0xd0
[ 6.923803] ? _raw_spin_unlock+0x1d/0x30
[ 6.924087] ? __alloc_fd+0x192/0x1a0
[ 6.924347] ? regulator_late_cleanup+0x132/0x132
[ 6.924679] do_sys_open+0x149/0x1d0
[ 6.924951] SyS_open+0x1d/0x20
[ 6.925187] kernel_init_freeable+0x19a/0x1f9
[ 6.925495] ? rest_init+0x110/0x110
[ 6.925767] kernel_init+0xb/0x100
[ 6.926010] ? schedule_tail_wrapper+0x9/0xc
[ 6.926310] ret_from_fork+0x19/0x24
[ 6.926882] Freeing unused kernel memory: 468K
[ 6.927248] Write protecting the kernel text: 4240k
[ 6.927682] Write protecting the kernel read-only data: 1552k
[ 6.929442] sir_ir sir_ir.0: Trapped in interrupt
[ 6.929835] genirq: Flags mismatch irq 4. 00000000 (ttyS0) vs. 00000000 (sir_ir)
[ 6.930355] CPU: 0 PID: 1 Comm: init Not tainted 4.12.0-rc7-02453-g560a5ae #2
[ 6.930878] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 6.931576] Call Trace:
[ 6.931778] dump_stack+0x16/0x1c
[ 6.932015] __setup_irq+0x42b/0x590
[ 6.932271] ? kmem_cache_alloc+0xfb/0x1c0
[ 6.932559] request_threaded_irq+0xec/0x150
[ 6.932886] univ8250_setup_irq+0x1cf/0x210
[ 6.933182] serial8250_do_startup+0x41a/0x600
[ 6.933495] serial8250_startup+0x15/0x20
[ 6.933807] uart_port_startup+0xab/0x170
[ 6.934091] uart_port_activate+0x78/0xa0
[ 6.934372] tty_port_open+0x6c/0xb0
[ 6.934626] uart_open+0x33/0x50
[ 6.934872] tty_open+0x2e6/0x3f0
[ 6.935108] chrdev_open+0x127/0x180
[ 6.935363] do_dentry_open+0x169/0x290
[ 6.935674] ? exact_lock+0x20/0x20
[ 6.935948] vfs_open+0x4e/0x60
[ 6.936172] path_openat+0xc8d/0x1000
[ 6.936432] ? find_held_lock+0x2d/0xa0
[ 6.936703] ? __lock_is_held+0x4a/0x90
[ 6.937002] do_filp_open+0x75/0xd0
[ 6.937252] ? _raw_spin_unlock+0x1d/0x30
[ 6.937535] ? __alloc_fd+0x192/0x1a0
[ 6.937819] do_sys_open+0x149/0x1d0
[ 6.938074] SyS_open+0x1d/0x20
[ 6.938298] do_int80_syscall_32+0x6d/0x120
[ 6.938600] entry_INT80_32+0x2f/0x2f
[ 6.938884] EIP: 0x47f3655e
[ 6.939089] EFLAGS: 00000246 CPU: 0
[ 6.939337] EAX: ffffffda EBX: 0804df90 ECX: 00000800 EDX: 00000000
[ 6.939800] ESI: 00000000 EDI: 7f8a3dc1 EBP: 7f8a2188 ESP: 7f8a1c88
[ 6.940237] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 007b
[ 6.941686] sir_ir sir_ir.0: Trapped in interrupt
[ 6.942069] genirq: Flags mismatch irq 4. 00000000 (ttyS0) vs. 00000000 (sir_ir)
[ 6.942591] CPU: 0 PID: 1 Comm: init Not tainted 4.12.0-rc7-02453-g560a5ae #2
[ 6.943117] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 6.943844] Call Trace:
[ 6.944021] dump_stack+0x16/0x1c
[ 6.944258] __setup_irq+0x42b/0x590
[ 6.944512] ? kmem_cache_alloc+0xfb/0x1c0
[ 6.944827] request_threaded_irq+0xec/0x150
[ 6.945129] univ8250_setup_irq+0x1cf/0x210
[ 6.945424] serial8250_do_startup+0x41a/0x600
[ 6.945753] serial8250_startup+0x15/0x20
[ 6.946037] uart_port_startup+0xab/0x170
[ 6.946320] uart_port_activate+0x78/0xa0
[ 6.946603] tty_port_open+0x6c/0xb0
[ 6.946878] uart_open+0x33/0x50
[ 6.947107] tty_open+0x2e6/0x3f0
[ 6.947343] chrdev_open+0x127/0x180
[ 6.947597] do_dentry_open+0x169/0x290
[ 6.947932] ? exact_lock+0x20/0x20
[ 6.948180] vfs_open+0x4e/0x60
[ 6.948411] path_openat+0xc8d/0x1000
[ 6.948670] ? __lock_is_held+0x4a/0x90
[ 6.948964] do_filp_open+0x75/0xd0
[ 6.949214] ? _raw_spin_unlock+0x1d/0x30
[ 6.949496] ? __alloc_fd+0x192/0x1a0
[ 6.949779] do_sys_open+0x149/0x1d0
[ 6.950033] ? preempt_schedule_common+0x1a/0x30
[ 6.950358] SyS_open+0x1d/0x20
[ 6.950587] do_int80_syscall_32+0x6d/0x120
[ 6.950905] entry_INT80_32+0x2f/0x2f
[ 6.951165] EIP: 0x47f3655e
[ 6.951365] EFLAGS: 00000246 CPU: 0
[ 6.951611] EAX: ffffffda EBX: 0804df90 ECX: 00000902 EDX: 00000000
[ 6.952072] ESI: 7f8a1cdc EDI: 00000902 EBP: 00000102 ESP: 7f8a1c18
[ 6.952509] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 007b
[ 6.954034] sir_ir sir_ir.0: Trapped in interrupt
[ 6.954390] genirq: Flags mismatch irq 4. 00000000 (ttyS0) vs. 00000000 (sir_ir)
[ 6.954932] CPU: 0 PID: 1 Comm: init Not tainted 4.12.0-rc7-02453-g560a5ae #2
[ 6.955424] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 6.956148] Call Trace:
[ 6.956327] dump_stack+0x16/0x1c
[ 6.956564] __setup_irq+0x42b/0x590
[ 6.956840] ? kmem_cache_alloc+0xfb/0x1c0
[ 6.957130] request_threaded_irq+0xec/0x150
[ 6.957432] univ8250_setup_irq+0x1cf/0x210
[ 6.957751] serial8250_do_startup+0x41a/0x600
[ 6.958067] serial8250_startup+0x15/0x20
[ 6.958354] uart_port_startup+0xab/0x170
[ 6.958637] uart_port_activate+0x78/0xa0
[ 6.958946] tty_port_open+0x6c/0xb0
[ 6.959199] uart_open+0x33/0x50
[ 6.959429] tty_open+0x2e6/0x3f0
[ 6.959665] chrdev_open+0x127/0x180
[ 6.959942] do_dentry_open+0x169/0x290
[ 6.960253] ? exact_lock+0x20/0x20
[ 6.960501] vfs_open+0x4e/0x60
[ 6.960725] path_openat+0xc8d/0x1000
[ 6.961006] ? __lock_is_held+0x4a/0x90
[ 6.961277] do_filp_open+0x75/0xd0
[ 6.961526] ? _raw_spin_unlock+0x1d/0x30
[ 6.961834] ? __alloc_fd+0x192/0x1a0
[ 6.962093] do_sys_open+0x149/0x1d0
[ 6.962348] ? up_read+0x16/0x30
[ 6.962578] SyS_open+0x1d/0x20
[ 6.962822] do_int80_syscall_32+0x6d/0x120
[ 6.963118] entry_INT80_32+0x2f/0x2f
[ 6.963377] EIP: 0x47f3655e
[ 6.963577] EFLAGS: 00000246 CPU: 0
[ 6.963848] EAX: ffffffda EBX: 0804df90 ECX: 00000901 EDX: 47e77ff4
[ 6.964286] ESI: 0804dfb9 EDI: 00000901 EBP: 00000901 ESP: 7f8a1a28
[ 6.964737] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 007b
[ 6.966119] sir_ir sir_ir.0: Trapped in interrupt
[ 6.966475] genirq: Flags mismatch irq 4. 00000000 (ttyS0) vs. 00000000 (sir_ir)
[ 6.967017] CPU: 0 PID: 1 Comm: init Not tainted 4.12.0-rc7-02453-g560a5ae #2
[ 6.967510] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 6.968238] Call Trace:
[ 6.968423] dump_stack+0x16/0x1c
[ 6.968661] __setup_irq+0x42b/0x590
[ 6.968946] ? kmem_cache_alloc+0xfb/0x1c0
[ 6.969234] request_threaded_irq+0xec/0x150
[ 6.969537] univ8250_setup_irq+0x1cf/0x210
[ 6.969857] serial8250_do_startup+0x41a/0x600
[ 6.970168] serial8250_startup+0x15/0x20
[ 6.970453] uart_port_startup+0xab/0x170
[ 6.970760] uart_port_activate+0x78/0xa0
[ 6.971044] tty_port_open+0x6c/0xb0
[ 6.971299] uart_open+0x33/0x50
[ 6.971529] tty_open+0x2e6/0x3f0
[ 6.971804] chrdev_open+0x127/0x180
[ 6.972059] do_dentry_open+0x169/0x290
[ 6.972372] ? exact_lock+0x20/0x20
[ 6.972621] vfs_open+0x4e/0x60
[ 6.972868] path_openat+0xc8d/0x1000
[ 6.973129] ? __lock_is_held+0x4a/0x90
[ 6.973401] do_filp_open+0x75/0xd0
[ 6.973651] ? _raw_spin_unlock+0x1d/0x30
[ 6.973956] ? __alloc_fd+0x192/0x1a0
[ 6.974216] do_sys_open+0x149/0x1d0
[ 6.974472] ? preempt_schedule_common+0x1a/0x30
[ 6.974822] SyS_open+0x1d/0x20
[ 6.975047] do_int80_syscall_32+0x6d/0x120
[ 6.975343] entry_INT80_32+0x2f/0x2f
[ 6.975603] EIP: 0x47f3655e
[ 6.975833] EFLAGS: 00000246 CPU: 0
[ 6.976081] EAX: ffffffda EBX: 0804df90 ECX: 00000901 EDX: 47e77ff4
[ 6.976518] ESI: 7f8a1a90 EDI: 00000901 EBP: 00000901 ESP: 7f8a1a28
[ 6.976972] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 007b
[ 6.978322] sir_ir sir_ir.0: Trapped in interrupt
[ 6.978685] genirq: Flags mismatch irq 4. 00000000 (ttyS0) vs. 00000000 (sir_ir)
[ 6.979226] CPU: 0 PID: 1 Comm: init Not tainted 4.12.0-rc7-02453-g560a5ae #2
[ 6.979718] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 6.980446] Call Trace:
[ 6.980625] dump_stack+0x16/0x1c
[ 6.980884] __setup_irq+0x42b/0x590
[ 6.981138] ? kmem_cache_alloc+0xfb/0x1c0
[ 6.981426] request_threaded_irq+0xec/0x150
[ 6.981754] univ8250_setup_irq+0x1cf/0x210
[ 6.982050] serial8250_do_startup+0x41a/0x600
[ 6.982363] serial8250_startup+0x15/0x20
[ 6.982646] uart_port_startup+0xab/0x170
[ 6.982949] uart_port_activate+0x78/0xa0
[ 6.983231] tty_port_open+0x6c/0xb0
[ 6.983484] uart_open+0x33/0x50
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start c98fcf387b5593329c00d33c4206cac80a7539cb c0bc126f97fb929b3ae02c1c62322645d70eb408 --
git bisect good 70562391a9cb5e8f3bfaf9c00398c89dc3cc92ce # 16:40 G 11 0 0 0 Merge 'asoc/topic/rt5645' into devel-spot-201706301235
git bisect bad e36ae765c25006ae47ef58e0fe6da9356ee46d5d # 16:52 B 0 11 23 0 Merge 'pci/pci/irq-fixups' into devel-spot-201706301235
git bisect good 9999a332768f8e414a09ae91895addb5e9fc7e80 # 17:10 G 11 0 0 0 Merge 'linux-platform-drivers-x86/testing' into devel-spot-201706301235
git bisect bad 487dfde1281e12f1a1d2049fbd88967789f0684b # 17:20 B 0 11 24 0 Merge 'rockchip/v4.14-armsoc/dts32' into devel-spot-201706301235
git bisect good 4c14c2f444891de21a3605b97d1c06e86f6ab8c8 # 17:43 G 11 0 0 0 Merge 'regulator/for-next' into devel-spot-201706301235
git bisect bad 560a5aede4068580f7caaba00f997cb040b8b2e6 # 17:58 B 0 11 23 0 Merge 'kees/kspp/usercopy-whitelist/20170619' into devel-spot-201706301235
git bisect good 34630ac1e845ac7b5e8982300436029e2c347bf4 # 18:46 G 11 0 0 0 ext4: define usercopy region in ext4_inode_cache slab cache
git bisect good dca68148843ad90cd9f2f8ae4175d893af575324 # 19:31 G 11 0 0 0 fork: define usercopy region in thread_stack, task_struct, mm_struct slab caches
git bisect good 2fcb1017ce965e5475eaf3aa57e31f200e572c9d # 20:17 G 11 0 0 0 dcache: define usercopy region in dentry_cache slab cache
git bisect good 157d3da018940be250dbc3ad395235716ea27274 # 21:02 G 11 0 0 0 xfs: define usercopy region in xfs_inode slab cache
# first bad commit: [560a5aede4068580f7caaba00f997cb040b8b2e6] Merge 'kees/kspp/usercopy-whitelist/20170619' into devel-spot-201706301235
git bisect good 4c14c2f444891de21a3605b97d1c06e86f6ab8c8 # 21:04 G 31 0 0 0 Merge 'regulator/for-next' into devel-spot-201706301235
git bisect good 157d3da018940be250dbc3ad395235716ea27274 # 21:40 G 31 0 0 0 xfs: define usercopy region in xfs_inode slab cache
# extra tests with CONFIG_DEBUG_INFO_REDUCED
git bisect bad 560a5aede4068580f7caaba00f997cb040b8b2e6 # 21:50 B 0 11 23 0 Merge 'kees/kspp/usercopy-whitelist/20170619' into devel-spot-201706301235
# extra tests on HEAD of linux-devel/devel-spot-201706301235
git bisect bad c98fcf387b5593329c00d33c4206cac80a7539cb # 21:50 B 0 25 41 0 0day head guard for 'devel-spot-201706301235'
# extra tests on tree/branch linux-devel/devel-spot-201706301235
git bisect bad c98fcf387b5593329c00d33c4206cac80a7539cb # 21:51 B 0 25 41 0 0day head guard for 'devel-spot-201706301235'
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
3 years
- 1
- 0
[task_work] 46a4746d9a: inconsistent{IN-HARDIRQ-W}->{HARDIRQ-ON-W}usage
by kernel test robot
FYI, we noticed the following commit:
commit: 46a4746d9a364a9b0267c19be0f8419e9b72ad37 ("task_work: Replace spin_unlock_wait() with lock/unlock pair")
https://git.kernel.org/cgit/linux/kernel/git/paulmck/linux-rcu.git spin_unlock_wait_no.2017.06.29c
in testcase: boot
on test machine: qemu-system-x86_64 -enable-kvm -cpu host -smp 2 -m 1G
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
+-------------------------------------------------+------------+------------+
| | ee4c0fbd46 | 46a4746d9a |
+-------------------------------------------------+------------+------------+
| boot_successes | 6 | 0 |
| boot_failures | 0 | 10 |
| inconsistent{IN-HARDIRQ-W}->{HARDIRQ-ON-W}usage | 0 | 8 |
| inconsistent{IN-SOFTIRQ-W}->{SOFTIRQ-ON-W}usage | 0 | 2 |
+-------------------------------------------------+------------+------------+
[ 4.784726] WARNING: inconsistent lock state
[ 4.785206] 4.12.0-rc4-00090-g46a4746 #86 Not tainted
[ 4.785733] --------------------------------
[ 4.786203] inconsistent {IN-HARDIRQ-W} -> {HARDIRQ-ON-W} usage.
[ 4.786815] modprobe/143 [HC0[0]:SC0[0]:HE1:SE1] takes:
[ 4.787377] (&p->pi_lock){?.-.-.}, at: [<ffffffffb31016b7>] task_work_run+0x6e/0xa8
[ 4.788202] {IN-HARDIRQ-W} state was registered at:
[ 4.788711] __lock_acquire+0x3a9/0xed4
[ 4.789151] lock_acquire+0x125/0x1be
[ 4.789571] _raw_spin_lock_irqsave+0x49/0x84
[ 4.790048] try_to_wake_up+0x35/0x25b
[ 4.790478] wake_up_process+0x15/0x17
[ 4.790910] watchdog_timer_fn+0x51/0x1e3
[ 4.791368] __hrtimer_run_queues+0x164/0x30e
[ 4.791848] hrtimer_interrupt+0x75/0x143
[ 4.792296] local_apic_timer_interrupt+0x4b/0x4e
[ 4.792800] smp_apic_timer_interrupt+0x29/0x39
[ 4.800188] apic_timer_interrupt+0x93/0xa0
[ 4.800649] do_raw_spin_trylock+0x1c/0x3e
[ 4.801107] _raw_spin_lock+0x3c/0x6a
[ 4.801531] lockref_put_or_lock+0xd/0x2c
[ 4.801984] dput+0x4d/0x1e1
[ 4.802343] path_put+0x16/0x21
[ 4.802723] terminate_walk+0x26/0x88
[ 4.803160] path_lookupat+0x179/0x18b
[ 4.803589] filename_lookup+0x7d/0xfa
[ 4.804021] user_path_at_empty+0x37/0x3d
[ 4.804470] vfs_statx+0x72/0xb6
[ 4.804868] clean_path+0x38/0x72
[ 4.805260] do_name+0x7a/0x29e
[ 4.805640] write_buffer+0x28/0x39
[ 4.806053] flush_buffer+0x39/0x91
[ 4.806459] __gunzip+0x271/0x311
[ 4.806856] gunzip+0x11/0x13
[ 4.807234] unpack_to_rootfs+0x14c/0x274
[ 4.807688] populate_rootfs+0x61/0x106
[ 4.808128] do_one_initcall+0x90/0x138
[ 4.808563] kernel_init_freeable+0x1d5/0x25d
[ 4.809049] kernel_init+0xe/0xfa
[ 4.809441] ret_from_fork+0x2a/0x40
[ 4.809863] irq event stamp: 789
[ 4.810244] hardirqs last enabled at (789): [<ffffffffb3003800>] prepare_exit_to_usermode+0x69/0xd4
[ 4.811174] hardirqs last disabled at (788): [<ffffffffb30039c5>] syscall_return_slowpath+0x15a/0x1c6
[ 4.812113] softirqs last enabled at (0): [<ffffffffb30e4759>] copy_process+0x60f/0x19c0
[ 4.813012] softirqs last disabled at (0): [< (null)>] (null)
[ 4.813802]
[ 4.813802] other info that might help us debug this:
[ 4.814520] Possible unsafe locking scenario:
[ 4.814520]
[ 4.815204] CPU0
[ 4.815523] ----
[ 4.815847] lock(&p->pi_lock);
[ 4.816226] <Interrupt>
[ 4.816559] lock(&p->pi_lock);
[ 4.816956]
[ 4.816956] *** DEADLOCK ***
[ 4.816956]
[ 4.817706] no locks held by modprobe/143.
[ 4.818155]
[ 4.818155] stack backtrace:
[ 4.818710] CPU: 0 PID: 143 Comm: modprobe Not tainted 4.12.0-rc4-00090-g46a4746 #86
[ 4.819538] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 4.820542] Call Trace:
[ 4.820870] dump_stack+0x82/0xb8
[ 4.821258] print_usage_bug+0x1bc/0x1d1
[ 4.821692] ? check_usage_forwards+0xba/0xba
[ 4.822164] mark_lock+0x10b/0x1ec
[ 4.822559] __lock_acquire+0x411/0xed4
[ 4.822991] ? mark_lock+0x24/0x1ec
[ 4.823407] ? unmap_region+0xdb/0xff
[ 4.823834] ? __lock_is_held+0x47/0x7a
[ 4.824264] lock_acquire+0x125/0x1be
[ 4.824676] ? lock_acquire+0x125/0x1be
[ 4.825107] ? task_work_run+0x6e/0xa8
[ 4.825529] _raw_spin_lock+0x34/0x6a
[ 4.825946] ? task_work_run+0x6e/0xa8
[ 4.826366] task_work_run+0x6e/0xa8
[ 4.826774] prepare_exit_to_usermode+0xae/0xd4
[ 4.827270] syscall_return_slowpath+0x162/0x1c6
[ 4.827760] entry_SYSCALL_64_fastpath+0xbc/0xbe
[ 4.828252] RIP: 0033:0x7f424ae4b087
[ 4.828659] RSP: 002b:00007ffe825c1df8 EFLAGS: 00000206 ORIG_RAX: 000000000000000b
[ 4.829463] RAX: 0000000000000000 RBX: 00007f424b057168 RCX: 00007f424ae4b087
[ 4.830146] RDX: 0000000300000000 RSI: 00000000000028ec RDI: 00007f424b050000
[ 4.830827] RBP: 00007ffe825c1ee0 R08: 0000000000000000 R09: 00007f424b0544c0
[ 4.831523] R10: 00007f424b056030 R11: 0000000000000206 R12: 000000037d3220bf
[ 4.832207] R13: 00007f424b0569d8 R14: 00007f424b04e700 R15: 00000000ffffffff
[ 4.833444] modprobe (143) used greatest stack depth: 14056 bytes left
[ 4.834174] lp: driver loaded but no devices found
[ 4.834715] Applicom driver: $Id: ac.c,v 1.30 2000/03/22 16:03:57 dwmw2 Exp $
[ 4.835450] ac.o: No PCI boards found.
[ 4.835892] ac.o: For an ISA board you must supply memory and irq parameters.
[ 4.836908] Non-volatile memory driver v1.3
[ 4.838510] ppdev: user-space parallel port driver
[ 4.839062] telclk_interrupt = 0xf non-mcpbl0010 hw.
[ 4.839646] smapi::smapi_init, ERROR invalid usSmapiID
[ 4.840202] mwave: tp3780i::tp3780I_InitializeBoardData: Error: SMAPI is not available on this machine
[ 4.841165] mwave: mwavedd::mwave_init: Error: Failed to initialize board data
[ 4.841962] mwave: mwavedd::mwave_init: Error: Failed to initialize
[ 4.842592] Linux agpgart interface v0.103
[ 4.843319] SyncLink PC Card driver $Revision: 4.34 $, tty major#238
To reproduce:
git clone https://github.com/01org/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email
Thanks,
Kernel Test Robot
3 years
- 3
- 2
8db0604fcd ("lirc_dev: sanitize locking"): WARNING: CPU: 0 PID: 1 at fs/sysfs/dir.c:31 sysfs_warn_dup
by Fengguang Wu
Hi David,
FYI we find a temporal warning in the *middle* of your patchset.
https://github.com/0day-ci/linux/commits/David-H-rdeman/lirc_dev-modernis...
commit 8db0604fcd9a6b5efc91f9887e9f8a13c9e7a94c
Author: David Härdeman <david(a)hardeman.nu>
AuthorDate: Sun Jun 25 14:32:00 2017 +0200
Commit: 0day robot <fengguang.wu(a)intel.com>
CommitDate: Mon Jun 26 12:06:37 2017 +0800
lirc_dev: sanitize locking
Use the irctl mutex for all device operations and only use lirc_dev_lock to
protect the irctls array. Also, make sure that the device is alive early in
each fops function before doing anything else.
Since this patch touches nearly every line where the irctl mutex is
taken/released, it also renames the mutex at the same time (the name
irctl_lock will be misleading once struct irctl goes away in later
patches).
Signed-off-by: David Härdeman <david(a)hardeman.nu>
0a5e5446fd lirc_dev: change irctl->attached to be a boolean
8db0604fcd lirc_dev: sanitize locking
160b9262d9 lirc_dev: consistent device registration printk
+-------------------------------------------+------------+------------+------------+
| | 0a5e5446fd | 8db0604fcd | 160b9262d9 |
+-------------------------------------------+------------+------------+------------+
| boot_successes | 35 | 0 | 11 |
| boot_failures | 0 | 15 | |
| WARNING:at_fs/sysfs/dir.c:#sysfs_warn_dup | 0 | 15 | |
+-------------------------------------------+------------+------------+------------+
[ 13.985208] evbug: Connected device: input7 (SIR IrDA port at sir_ir/input0)
[ 13.986110] input: MCE IR Keyboard/Mouse (sir_ir) as /devices/virtual/input/input8
[ 13.987144] evbug: Connected device: input8 (MCE IR Keyboard/Mouse (sir_ir) at /input0)
[ 13.987962] sysfs: cannot create duplicate filename '/class/lirc/lirc0'
[ 13.988616] ------------[ cut here ]------------
[ 13.989060] WARNING: CPU: 0 PID: 1 at fs/sysfs/dir.c:31 sysfs_warn_dup+0x4c/0x60
[ 13.989931] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 4.12.0-rc3-00229-g8db0604 #1
[ 13.990653] task: ffff88001d120000 task.stack: ffffc900000d0000
[ 13.991209] RIP: 0010:sysfs_warn_dup+0x4c/0x60
[ 13.991636] RSP: 0000:ffffc900000d3a38 EFLAGS: 00010292
[ 13.992130] RAX: 000000000000003b RBX: ffff880017415000 RCX: 0000000000000006
[ 13.992806] RDX: 00000000000003f7 RSI: ffff88001d120c40 RDI: 0000000000000246
[ 13.993477] RBP: ffffc900000d3a50 R08: 00000000ffffffff R09: 0000000000000000
[ 13.994155] R10: 0000000000000000 R11: 0000000000000000 R12: ffff88001ee329c0
[ 13.994832] R13: ffff88001ed01bd0 R14: ffff88001ed01bd0 R15: ffffffffffffffef
[ 13.995501] FS: 0000000000000000(0000) GS:ffff88001d400000(0000) knlGS:0000000000000000
[ 13.996264] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 13.996831] CR2: 0000000000000000 CR3: 0000000002011000 CR4: 00000000000006b0
[ 13.997506] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[ 13.998184] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
[ 13.998865] Call Trace:
[ 13.999109] sysfs_do_create_link_sd+0x87/0xb0
[ 13.999598] sysfs_create_link+0x29/0x40
[ 13.999980] device_add+0x1e5/0x630
[ 14.000319] ? refcount_inc+0x9/0x30
[ 14.000674] ? kobject_get+0x30/0x40
[ 14.001021] cdev_device_add+0x23/0x70
[ 14.001383] ? cdev_init+0x50/0x60
[ 14.001721] lirc_register_driver+0x40e/0x460
[ 14.002135] ir_lirc_register+0x16a/0x1b0
[ 14.002519] ir_raw_event_register+0xbc/0xd0
[ 14.002931] rc_register_device+0x357/0x470
[ 14.003330] devm_rc_register_device+0x3c/0x70
[ 14.003759] sir_ir_probe+0x1a4/0x230
[ 14.004112] platform_drv_probe+0x3a/0x90
[ 14.004496] driver_probe_device+0x13a/0x330
[ 14.004911] __device_attach_driver+0x76/0x90
[ 14.005326] ? __driver_attach+0x90/0x90
[ 14.005706] bus_for_each_drv+0x4f/0x90
[ 14.006072] __device_attach+0xa7/0x120
[ 14.006437] device_initial_probe+0xe/0x10
[ 14.006876] bus_probe_device+0x35/0xb0
[ 14.007246] device_add+0x3ed/0x630
[ 14.007591] ? do_early_param+0x8f/0x8f
[ 14.007960] platform_device_add+0x15e/0x1d0
[ 14.008367] ? do_early_param+0x8f/0x8f
[ 14.008743] sir_ir_init+0x3b/0x65
[ 14.009073] ? loop_init+0x1a9/0x1a9
[ 14.009417] do_one_initcall+0x8b/0x13c
[ 14.009792] ? do_early_param+0x8f/0x8f
[ 14.010159] kernel_init_freeable+0x321/0x3b2
[ 14.010582] ? rest_init+0x140/0x140
[ 14.010926] kernel_init+0x9/0xf0
[ 14.011246] ret_from_fork+0x2a/0x40
[ 14.011597] Code: 85 c0 48 89 c3 74 12 b9 00 10 00 00 48 89 c2 31 f6 4c 89 ef e8 06 cd ff ff 4c 89 e2 48 89 de 48 c7 c7 a8 22 d8 81 e8 b8 29 f2 ff <0f> ff 48 89 df e8 8a 78 f7 ff 5b 41 5c 41 5d 5d c3 0f 1f 00 48
[ 14.013493] ---[ end trace a9df301187fd7f90 ]---
[ 14.014703] evbug: Disconnected device: input8
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start d5d341caa7a50b49e81633a44c09432352c8aad3 c0bc126f97fb929b3ae02c1c62322645d70eb408 --
git bisect bad 51e5cc319de921af4fe90fb662b0f64ee7bcd661 # 02:01 B 0 2 13 0 Merge 'kbuild/thin-ar' into devel-spot-201706262028
git bisect good 5865115dc6f7b26c1b27a8026f7279996a2a5a35 # 02:15 G 11 0 0 0 Merge 'linux-review/Yuval-Shaia/IB-Move-PCI-dependency-from-root-KConfig-to-HW-s-KConfigs/20170626-185305' into devel-spot-201706262028
git bisect bad 81c344439265b21d75a2aba66ff5a83dd217be86 # 02:26 B 0 11 22 0 Merge 'linux-review/David-H-rdeman/lirc_dev-modernisation/20170626-120627' into devel-spot-201706262028
git bisect good 33fc7d4cd19e464ee240e41ac22f21f73989026e # 02:34 G 11 0 0 0 Merge 'linux-review/Chris-Packham/dt-bindings-add-bindings-for-i2c-pca-platform/20170626-164851' into devel-spot-201706262028
git bisect good b62822e9d45774b5e10eb3e22ec8c95b9d992e2a # 02:44 G 11 0 0 0 Merge 'linux-review/Karim-Eshapa/soc-qman-Sleep-instead-of-stuck-hacking-jiffies/20170626-140438' into devel-spot-201706262028
git bisect good 3208a8c7859dd7f84118c84104008fcb5a62374e # 02:54 G 11 0 0 0 Merge 'linux-review/kys-exchange-microsoft-com/Drivers-hv-vmbus-Ringbuffer-cleanup-and-optimizations/20170626-145401' into devel-spot-201706262028
git bisect good 3bbbeeb06c797db2d5262ca0858bbbebb42a9f05 # 03:04 G 11 0 0 0 Merge 'linux-review/Tommy-Nguyen/android-Update-maintainer-s-e-mail-in-TODO/20170626-070306' into devel-spot-201706262028
git bisect good 69793afc5adcad6b9ef5030e9e601753444b2f65 # 03:19 G 11 0 0 0 Merge 'linux-review/Michel-Thierry/drm-i915-There-is-only-one-fault-register-from-Gen8-onwards/20170626-105102' into devel-spot-201706262028
git bisect good 1dc17ad92d91dd15a0cdd3dac4b506f373fa237c # 03:29 G 11 0 0 0 lirc_dev: remove kmalloc in lirc_dev_fop_read()
git bisect bad 112a49c460556a79e29aa1f68389ebbade3577e7 # 03:41 B 0 11 24 2 lirc_dev: use an IDA instead of an array to keep track of registered devices
git bisect bad 8db0604fcd9a6b5efc91f9887e9f8a13c9e7a94c # 03:51 B 0 3 16 2 lirc_dev: sanitize locking
git bisect good 0a5e5446fdde36165ce9313631547acc321c7408 # 04:06 G 11 0 0 0 lirc_dev: change irctl->attached to be a boolean
# first bad commit: [8db0604fcd9a6b5efc91f9887e9f8a13c9e7a94c] lirc_dev: sanitize locking
git bisect good 0a5e5446fdde36165ce9313631547acc321c7408 # 04:08 G 31 0 0 0 lirc_dev: change irctl->attached to be a boolean
# extra tests with CONFIG_DEBUG_INFO_REDUCED
git bisect bad 8db0604fcd9a6b5efc91f9887e9f8a13c9e7a94c # 04:16 B 0 5 16 0 lirc_dev: sanitize locking
# extra tests on HEAD of linux-devel/devel-spot-201706262028
git bisect bad d5d341caa7a50b49e81633a44c09432352c8aad3 # 04:22 B 0 91 105 0 0day head guard for 'devel-spot-201706262028'
# extra tests on tree/branch linux-review/David-H-rdeman/lirc_dev-modernisation/20170626-120627
git bisect good 160b9262d9ce204fa45b059ea8bfe21a6d63e689 # 04:34 G 11 0 0 0 lirc_dev: consistent device registration printk
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
3 years
- 2
- 1
1131482629 ("posix-timers: Use get_timepsec64() and .."): 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
git://internal_merge_and_test_tree devel-catchup-201706292032
commit 11314826298445e447cc52df284d55f1e1137519
Author: Deepa Dinamani <deepa.kernel(a)gmail.com>
AuthorDate: Sat Jun 24 11:45:05 2017 -0700
Commit: Al Viro <viro(a)zeniv.linux.org.uk>
CommitDate: Sun Jun 25 21:58:46 2017 -0400
posix-timers: Use get_timepsec64() and put_timespec64()
Usage of these apis and their compat versions makes
the syscalls: clock_gettime, clock_settime, clock_getres
and their compat implementations simpler.
This is a preparatory patch to isolate data conversions to
struct timespec64 at userspace boundaries. This helps contain
the changes needed to transition to new y2038 safe types.
Signed-off-by: Deepa Dinamani <deepa.kernel(a)gmail.com>
Signed-off-by: Al Viro <viro(a)zeniv.linux.org.uk>
63a766a178 posix-stubs: Conditionally include COMPAT_SYS_NI defines
1131482629 posix-timers: Use get_timepsec64() and put_timespec64()
+------------------------------------------+------------+------------+
| | 63a766a178 | 1131482629 |
+------------------------------------------+------------+------------+
| boot_successes | 917 | 296 |
| boot_failures | 0 | 18 |
| BUG:unable_to_handle_kernel | 0 | 17 |
| Oops:#[##] | 0 | 17 |
| Kernel_panic-not_syncing:Fatal_exception | 0 | 18 |
| general_protection_fault:#[##] | 0 | 1 |
+------------------------------------------+------------+------------+
[ 16.567012] caif:caif_disconnect_client(): nothing to disconnect
[ 16.584816] LoadPin: mnt_sb lacks block device, treating as: writable
[ 16.586719] LoadPin: load pinning can be disabled.
[ 16.592674] LoadPin: kernel-module pinned obj="/sys/kernel/slab/dlmfs_inode_cache/objs_per_slab" pid=1986 cmdline="/trinity -q -d -x get_robust_list -N 999999"
[ 16.600816] caif:caif_disconnect_client(): nothing to disconnect
[ 16.612073] BUG: unable to handle kernel NULL pointer dereference at 0000000000000008
[ 16.618373] IP: compat_SyS_clock_settime+0x34/0x80
[ 16.619961] PGD 1eed4067
[ 16.619962] P4D 1eed4067
[ 16.621174] PUD 1746c067
[ 16.625867] PMD 0
[ 16.627060]
[ 16.632623] Oops: 0000 [#1] SMP
[ 16.633909] Modules linked in:
[ 16.638678] CPU: 0 PID: 1986 Comm: trinity-c0 Not tainted 4.12.0-rc3-00235-g1131482 #2
[ 16.642567] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 16.649185] task: ffff88001ee61600 task.stack: ffff88001f2b0000
[ 16.653016] RIP: 0010:compat_SyS_clock_settime+0x34/0x80
[ 16.658187] RSP: 0000:ffff88001f2b3f10 EFLAGS: 00010246
[ 16.659860] RAX: 0000000000000000 RBX: 0000000000e766c4 RCX: 0000000000000000
[ 16.663002] RDX: fffffffffffffff2 RSI: ffff88001f2b3f10 RDI: 0000000000e766c4
[ 16.668473] RBP: ffff88001f2b3f30 R08: 0000000000000000 R09: 0000000000000000
[ 16.674921] R10: 0000000001ec9000 R11: 0000000000000006 R12: 0000000000000000
[ 16.676912] R13: 0000000000000108 R14: 0000000000000108 R15: 400000a74ef5bff7
[ 16.684700] FS: 00007f6c1d009700(0000) GS:ffff88001e600000(0000) knlGS:0000000000000000
[ 16.684701] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 16.684702] CR2: 0000000000000008 CR3: 000000001f0c1000 CR4: 00000000000006b0
[ 16.684706] DR0: 0000000001ec1000 DR1: 0000000000000000 DR2: 0000000000000000
[ 16.684706] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000600
[ 16.684708] Call Trace:
[ 16.684717] do_int80_syscall_32+0x52/0xc0
[ 16.684722] entry_INT80_compat+0x33/0x40
[ 16.684724] RIP: 0033:0x40a4f6
[ 16.684725] RSP: 002b:00007ffd5e2aa008 EFLAGS: 00000202 ORIG_RAX: 0000000000000108
[ 16.684726] RAX: ffffffffffffffda RBX: 8000000000e766c4 RCX: 0000000001ec9000
[ 16.684727] RDX: 9000000000203005 RSI: 9400000000640000 RDI: fffffffffffffbff
[ 16.684728] RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000
[ 16.684729] R10: 0000000000000000 R11: 0000000000000000 R12: 0000000000000000
[ 16.684729] R13: 0000000000000108 R14: 0000000000000108 R15: 400000a74ef5bff7
[ 16.684730] Code: fb 48 83 ec 10 85 ff 78 43 45 31 e4 83 ff 0b 76 2e 48 8d 7d e0 e8 6d 13 01 00 85 c0 48 c7 c2 f2 ff ff ff 75 0e 48 8d 75 e0 89 df <41> ff 54 24 08 48 63 d0 48 83 c4 10 48 89 d0 5b 41 5c 5d c3 48
[ 16.684755] RIP: compat_SyS_clock_settime+0x34/0x80 RSP: ffff88001f2b3f10
[ 16.684756] CR2: 0000000000000008
[ 16.684786] ---[ end trace d7fcc1a78cdad9e5 ]---
[ 16.684788] Kernel panic - not syncing: Fatal exception
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start 1ac7bf7b1518265edd7d3960edb0727333f99324 c0bc126f97fb929b3ae02c1c62322645d70eb408 --
git bisect bad 0651e73f84226d356a3e83e548b1c3100aa1ad10 # 05:18 B 28 1 2 2 Merge 'trace/ftrace/core' into devel-spot-201706300203
git bisect good 13d41b3858f88d0e05a54a6487b1192732809736 # 05:55 G 258 0 0 0 Merge 'cryptodev/master' into devel-spot-201706300203
git bisect good e89d90fee8917515f3f2b7ab534b889e99143a69 # 06:30 G 261 0 0 0 Merge 'scsi/for-next' into devel-spot-201706300203
git bisect good 61aff0a32e93dbcff0b804c5ec69d7db6b401113 # 07:25 G 265 0 0 0 Merge 'vfs/work.net-ioctl' into devel-spot-201706300203
git bisect bad 295d79c4a8381a7459c918a117644e6f837b05b3 # 07:59 B 165 1 4 4 Merge 'vfs/work.misc-set_fs' into devel-spot-201706300203
git bisect bad e7626e8b67f08e2f0dc65af79953e6a05aba3f4b # 08:43 B 153 1 7 7 Merge 'vfs/work.compat' into devel-spot-201706300203
git bisect good e5f699d443192001613df21f123c5c3483e55888 # 09:43 G 300 0 0 0 ipmi: get rid of field-by-field __get_user()
git bisect good 92ebce5ac55dba258c608248dddf59eca3f7f514 # 10:16 G 302 0 0 0 osf_wait4: switch to kernel_wait4()
git bisect bad 11314826298445e447cc52df284d55f1e1137519 # 10:47 B 183 1 8 8 posix-timers: Use get_timepsec64() and put_timespec64()
git bisect good d5b7ffbfbdacc29e4db035f90665951668fa9c58 # 11:25 G 310 0 0 0 time: introduce {get,put}_itimerspec64
git bisect good 63a766a1780f9581e8885bdb64270a594a84f81a # 12:25 G 307 0 0 0 posix-stubs: Conditionally include COMPAT_SYS_NI defines
# first bad commit: [11314826298445e447cc52df284d55f1e1137519] posix-timers: Use get_timepsec64() and put_timespec64()
git bisect good 63a766a1780f9581e8885bdb64270a594a84f81a # 12:58 G 903 0 0 0 posix-stubs: Conditionally include COMPAT_SYS_NI defines
# extra tests on HEAD of linux-devel/devel-spot-201706300203
git bisect bad 1ac7bf7b1518265edd7d3960edb0727333f99324 # 12:59 B 98 4 0 6 0day head guard for 'devel-spot-201706300203'
# extra tests on tree/branch linux-devel/devel-catchup-201706292032
# extra tests with first bad commit reverted
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
3 years
- 2
- 1
[lkp-robot] [udp] bc0d3d0639: apachebench.requests_per_second -21% regression
by kernel test robot
Greeting,
FYI, we noticed a -21% regression of apachebench.requests_per_second due to commit:
commit: bc0d3d0639a29546708657c1666a474c0af19316 ("udp: try to avoid 2 cache miss on dequeue")
url: https://github.com/0day-ci/linux/commits/Paolo-Abeni/udp-reduce-cache-pre...
in testcase: apachebench
on test machine: 16 threads Intel(R) Atom(R) CPU 3958 @ 2.00GHz with 64G memory
with following parameters:
runtime: 300s
concurrency: 1000
cluster: cs-localhost
cpufreq_governor: performance
test-description: apachebench is a tool for benchmarking your Apache Hypertext Transfer Protocol (HTTP) server.
test-url: https://httpd.apache.org/docs/2.4/programs/ab.html
Details are as below:
-------------------------------------------------------------------------------------------------->
To reproduce:
git clone https://github.com/01org/lkp-tests.git
cd lkp-tests
bin/lkp install job.yaml # job file is attached in this email
bin/lkp run job.yaml
testcase/path_params/tbox_group/run: apachebench/300s-1000-cs-localhost-performance/lkp-denverton2
85f4454bfd01c363 bc0d3d0639a29546708657c166
---------------- --------------------------
%stddev change %stddev
\ | \
62.90 26% 79.18 apachebench.time_per_request
15899 -21% 12628 apachebench.requests_per_second
170764 -21% 135638 apachebench.transfer_rate
60098 23% 74166 apachebench.connection_time.total.max
60098 23% 74166 apachebench.max_latency.100%
64.91 56% 101.13 apachebench.time.elapsed_time
64.91 56% 101.13 apachebench.time.elapsed_time.max
69 -37% 43 apachebench.time.percent_of_cpu_this_job_got
41225 20% 49376 interrupts.CAL:Function_call_interrupts
570 -33% 381 turbostat.Avg_MHz
28.59 -33% 19.07 turbostat.%Busy
75381 -43% 42629 vmstat.system.in
142204 -52% 67789 vmstat.system.cs
13095 ± 26% 9e+05 960405 ±171% latency_stats.avg.max
13095 ± 26% 1e+06 994807 ±171% latency_stats.max.max
13879 ± 67% -8e+03 6306 ± 19% latency_stats.sum.ep_poll.SyS_epoll_wait.do_syscall_64.return_from_SYSCALL_64
9834 ± 63% -1e+04 0 latency_stats.sum.vm_unmap_aliases.change_page_attr_set_clr.set_memory_ro.bpf_prog_select_runtime.bpf_prepare_filter.bpf_prog_create_from_user.do_seccomp.prctl_set_seccomp.SyS_prctl.entry_SYSCALL_64_fastpath
7.43 ± 4% 11% 8.23 ± 3% perf-stat.branch-miss-rate%
3.309e+09 3% 3.413e+09 perf-stat.branch-misses
1224211 3% 1261383 perf-stat.page-faults
1224211 3% 1261382 perf-stat.minor-faults
2.258e+11 ± 4% -7% 2.111e+11 perf-stat.instructions
4.463e+10 ± 5% -7% 4.148e+10 perf-stat.branch-instructions
0.36 -8% 0.33 perf-stat.ipc
9533387 -26% 7020637 perf-stat.context-switches
perf-stat.page-faults
1.28e+06 ++------------O--------------------------------------------------+
| |
1.27e+06 ++ O O O |
| OO O OO OO O O |
1.26e+06 O+ OO O O O O OO OO O |
| |
1.25e+06 ++ |
| |
1.24e+06 *+ .* |
| * * * * * * : |
1.23e+06 ++ : + : : :+ + :+ : : |
| *.* *.**.* .* *. .* : * * *.: * *. .**. .**.**. *.*
1.22e+06 ++ *.* * ** * *.* * * ** * |
| |
1.21e+06 ++---------------------------------------------------------------+
perf-stat.context-switches
1e+07 ++----------------------------------------------------------------+
| *. .**.*.**.**. *.* .* .*. |
9.5e+06 *+* ** **.*.**.* *.*.**.** * **.**.**.*.**.**.**.*
| |
9e+06 ++ |
| |
8.5e+06 ++ |
| |
8e+06 ++ |
| |
7.5e+06 ++ |
| O O |
7e+06 O+OO O OO OO OO OO O OO OO OO O OO O |
| |
6.5e+06 ++----------------------------------------------------------------+
perf-stat.minor-faults
1.28e+06 ++------------O--------------------------------------------------+
| |
1.27e+06 ++ O O O |
| OO O OO OO O O |
1.26e+06 O+ OO O O O O OO OO O |
| |
1.25e+06 ++ |
| |
1.24e+06 *+ .* |
| * * * * * * : |
1.23e+06 ++ : + : : :+ + :+ : : |
| *.* *.**.* .* *. .* : * * *.: * *. .**. .**.**. *.*
1.22e+06 ++ *.* * ** * *.* * * ** * |
| |
1.21e+06 ++---------------------------------------------------------------+
turbostat.Avg_MHz
600 ++--------------------------------------------------------------------+
| *. .*. **. *.* * .* .* .*. .*. |
| : *.**.*.** ** : *.** * : *.*.* : * *.* * ** **.*
550 ++ : : : : : : : :: : |
| : : : : : : : : : : |
| : : : : :: : : : : : |
500 ++: : : : : :: :: : : |
| : : : : : :: :: : : |
450 ++: : :: : : : : |
*.* O : : : : *: |
| * * * * * |
400 O+ O O OO O OO O |
| O O O O OO OO O OO O OO O |
| |
350 ++--------------------------------------------------------------------+
turbostat._Busy
30 ++---------------------------------------------------------------------+
| *. *. *.* **. * *. *. .*. .*. |
28 ++ : *.**.*.*.* *.* : *.*.* * : *.** : * *.* * ** **.*
| : : : : : : : : : |
| : : : : :: : : :: : |
26 ++ : : : : : : : : :: : |
| : :: :: : : : : : : |
24 ++: :: :: : : : : : : |
| : : :: : : : : |
22 ++: O : : : : : : |
*.* * * * * *.* |
| O O O |
20 O+OO O OO O O O O O O O |
| OO O O OO O O |
18 ++---------------------------------------------------------------------+
apachebench.time.percent_of_cpu_this_job_got
75 ++---------------------------------------------------------------------+
| *.*. .* *. |
70 ++ *.*. *. .*.* * * *.*.* * * *.** * **.*.**. .*.**.*.* .*
| : * * : : : : : : : : * * |
65 ++ : : : : : : : : : |
| : : : : : : : : :: : |
60 ++ : : : : : : : : : : : |
| : :: :: : : : : : : |
55 ++: :: :: : : : : : : |
| : O : : : : : : |
50 ++: : : : : *.: |
*.* * * * * * |
45 O+OO O OO O O O O OO O OO O O O O O O O |
| O O |
40 ++---------------------------------------------------------------------+
apachebench.time.elapsed_time
105 ++--------------------------------------------------------------------+
O OO O OO O OO OO O OO O OO O OO O OO O |
100 ++ |
95 ++ |
*.* * * * * ** |
90 ++: : : : : :: |
85 ++: O : : : :: :: |
| : : : : : :: :: : : |
80 ++ : : : : : :: :: : : |
75 ++ : : : : :: : : : : : |
| : : : : :: : : :: : |
70 ++ : : : : : : : : : |
65 ++ *.*. .*.* .*: :*. : : :.* : * : *. .*. *.*.**.*
| ** *.* * * *.** * * *.*.* *.* *.** * |
60 ++--------------------------------------------------------------------+
apachebench.time.elapsed_time.max
105 ++--------------------------------------------------------------------+
O OO O OO O OO OO O OO O OO O OO O OO O |
100 ++ |
95 ++ |
*.* * * * * ** |
90 ++: : : : : :: |
85 ++: O : : : :: :: |
| : : : : : :: :: : : |
80 ++ : : : : : :: :: : : |
75 ++ : : : : :: : : : : : |
| : : : : :: : : :: : |
70 ++ : : : : : : : : : |
65 ++ *.*. .*.* .*: :*. : : :.* : * : *. .*. *.*.**.*
| ** *.* * * *.** * * *.*.* *.* *.** * |
60 ++--------------------------------------------------------------------+
apachebench.connection_time.connect.max
16000 ++OO-O--O--O------OO------O-OO----O-O-------------------------------+
O O O O OO O OO OO O O |
14000 ++ |
12000 ++ |
| |
10000 ++ |
| |
8000 ++ |
| |
6000 ++ |
4000 ++ |
| *.* * * * * *.* * * ** * * * * |
2000 ++ : :+ + :+ +: + :+ : :: + :+ : :: + : :+ + : |
| : * * *.** :.* * :: :.* * : : : .** *.*.* *.** *.*
0 *+*----------------*---------*--*---------*--*-*--------------------+
vmstat.system.in
80000 ++------------------------------------------------------------------+
| *.* .*.**.*.**.* *.**.*.* * *.**.** .*. *.|
75000 ++ : * : : : : : : * **.**.*.** **.* *
70000 ++ : : : : :: : : : : |
| : : : ::: : : :: : |
65000 ++: :: :: :: : : : : |
| : :: : :: : : : |
60000 ++: : * : * *.: |
*.* * * * |
55000 ++ |
50000 ++ |
| O |
45000 ++ O |
O OO O O OO O O OO O OO O OO OO O OO O |
40000 ++------------------------------------------------------------------+
vmstat.system.cs
150000 ++------*----------------------------------------------------------+
| *.** **.**.*.* **.*.** * **.**.* * **.*.**.**.*. .**.*
140000 ++ : : : : : : : : : ** |
130000 ++ : : : : :: : : : : : |
| : : : : :: : :: : : |
120000 ++: :: :: : : :: : : |
110000 ++: :: : : : : : : |
| : : * : * *: |
100000 *+* * * * |
90000 ++ |
| |
80000 ++ O |
70000 ++ |
O OO OO O OO O O OO OO O OO OO O OO OO |
60000 ++-----------------------------------------------------------------+
[*] bisect-good sample
[O] bisect-bad sample
Disclaimer:
Results have been estimated based on internal Intel analysis and are provided
for informational purposes only. Any difference in system hardware or software
design or configuration may affect actual performance.
Thanks,
Xiaolong
3 years
- 3
- 3