* [lkp] [kernel/fs] d57d611505: +54.7% turbostat.%Busy
@ 2016-02-23 8:26 kernel test robot
2016-02-23 8:55 ` Stephane Gasparini
0 siblings, 1 reply; 2+ messages in thread
From: kernel test robot @ 2016-02-23 8:26 UTC (permalink / raw)
To: Stephane Gasparini; +Cc: lkp, LKML, Philippe Longepe, Jens Axboe
[-- Attachment #1: Type: text/plain, Size: 20705 bytes --]
FYI, we noticed the below changes on
https://git.kernel.org/pub/scm/linux/kernel/git/torvalds/linux.git master
commit d57d611505d911c6f9f81cd9bd6dbd293d66dd9f ("kernel/fs: fix I/O wait not accounted for RW O_DSYNC")
=========================================================================================
compiler/cpufreq_governor/disk/filesize/fs/iterations/kconfig/nr_directories/nr_files_per_directory/nr_threads/rootfs/sync_method/tbox_group/test_size/testcase:
gcc-4.9/performance/1HDD/9B/f2fs/1x/x86_64-rhel/16d/256fpd/32t/debian-x86_64-2015-02-07.cgz/fsyncBeforeClose/lkp-ne04/400M/fsmark
commit:
09954bad448791ef01202351d437abdd9497a804
d57d611505d911c6f9f81cd9bd6dbd293d66dd9f
09954bad448791ef d57d611505d911c6f9f81cd9bd
---------------- --------------------------
%stddev %change %stddev
\ | \
14760 ± 1% +6.3% 15695 ± 1% fsmark.time.involuntary_context_switches
46.00 ± 0% -8.2% 42.25 ± 1% fsmark.time.percent_of_cpu_this_job_got
26151 ±116% -71.3% 7498 ± 23% latency_stats.sum.call_rwsem_down_read_failed.f2fs_mkdir.[f2fs].vfs_mkdir.SyS_mkdir.entry_SYSCALL_64_fastpath
7418 ± 23% -27.7% 5361 ± 3% numa-vmstat.node0.nr_slab_unreclaimable
1.47 ± 1% -9.9% 1.33 ± 0% time.user_time
1447 ± 4% -29.0% 1028 ± 7% uptime.idle
7.75 ± 19% +206.5% 23.75 ± 1% vmstat.procs.b
29675 ± 23% -27.7% 21447 ± 3% numa-meminfo.node0.SUnreclaim
83099 ± 8% -11.5% 73568 ± 1% numa-meminfo.node0.Slab
11.91 ± 1% +54.7% 18.43 ± 1% turbostat.%Busy
358.00 ± 1% +60.0% 572.75 ± 1% turbostat.Avg_MHz
21.54 ± 0% -17.4% 17.79 ± 1% turbostat.CPU%c1
24.78 ± 3% +41.1% 34.98 ± 1% turbostat.CPU%c3
41.76 ± 1% -31.0% 28.81 ± 1% turbostat.CPU%c6
8.53 ± 5% -25.6% 6.34 ± 10% turbostat.Pkg%pc3
66312232 ± 0% -68.5% 20910669 ± 4% cpuidle.C1-NHM.time
46386272 ± 2% -20.5% 36884085 ± 5% cpuidle.C1E-NHM.time
2.79e+08 ± 2% +51.5% 4.226e+08 ± 0% cpuidle.C3-NHM.time
254315 ± 2% +25.1% 318250 ± 2% cpuidle.C3-NHM.usage
7.585e+08 ± 1% -22.2% 5.901e+08 ± 1% cpuidle.C6-NHM.time
415414 ± 1% -38.1% 257115 ± 1% cpuidle.C6-NHM.usage
1.135e+08 ± 1% +77.8% 2.017e+08 ± 2% cpuidle.POLL.time
102777 ± 1% +36.0% 139811 ± 1% cpuidle.POLL.usage
2011 ± 25% -27.1% 1467 ± 2% sched_debug.cfs_rq:/.exec_clock.2
1820 ± 3% -12.2% 1597 ± 7% sched_debug.cfs_rq:/.exec_clock.4
4297 ± 6% +78.1% 7653 ± 54% sched_debug.cfs_rq:/.min_vruntime.12
4803 ± 18% -16.1% 4028 ± 21% sched_debug.cfs_rq:/.min_vruntime.8
3763 ± 4% -17.0% 3124 ± 7% sched_debug.cfs_rq:/.min_vruntime.9
3408 ± 4% -14.9% 2900 ± 2% sched_debug.cfs_rq:/.min_vruntime.min
4.75 ± 54% -73.7% 1.25 ±173% sched_debug.cfs_rq:/.nr_spread_over.2
1.99 ± 16% +25.5% 2.50 ± 9% sched_debug.cfs_rq:/.nr_spread_over.stddev
-4362 ±-25% -92.7% -318.24 ±-1304% sched_debug.cfs_rq:/.spread0.12
200.25 ± 47% -48.8% 102.50 ± 22% sched_debug.cfs_rq:/.util_avg.7
187.75 ± 64% -77.2% 42.75 ± 56% sched_debug.cfs_rq:/.util_avg.8
1.41 ± 31% +37.0% 1.93 ± 12% sched_debug.cpu.clock.stddev
1.41 ± 31% +37.0% 1.93 ± 12% sched_debug.cpu.clock_task.stddev
1.63 ± 67% -53.9% 0.75 ± 38% sched_debug.cpu.cpu_load[4].stddev
33822 ± 16% -17.2% 28018 ± 4% sched_debug.cpu.nr_switches.13
36824 ± 3% +12.9% 41569 ± 4% sched_debug.cpu.nr_switches.14
33117 ± 7% -11.1% 29438 ± 5% sched_debug.cpu.nr_switches.15
57634 ± 3% +8.8% 62716 ± 3% sched_debug.cpu.nr_switches.4
1723 ± 7% -11.3% 1527 ± 5% sched_debug.cpu.nr_uninterruptible.10
1378 ± 6% -8.7% 1258 ± 5% sched_debug.cpu.nr_uninterruptible.15
1232 ± 10% +25.3% 1543 ± 3% sched_debug.cpu.nr_uninterruptible.8
34660 ± 13% -19.1% 28034 ± 4% sched_debug.cpu.sched_count.13
37545 ± 2% +18.9% 44629 ± 7% sched_debug.cpu.sched_count.14
34003 ± 9% -13.4% 29456 ± 5% sched_debug.cpu.sched_count.15
62715 ± 6% +9.5% 68642 ± 7% sched_debug.cpu.sched_count.2
14091 ± 19% -20.4% 11212 ± 5% sched_debug.cpu.sched_goidle.13
14175 ± 3% +15.4% 16354 ± 6% sched_debug.cpu.sched_goidle.14
13465 ± 9% -12.5% 11782 ± 6% sched_debug.cpu.sched_goidle.15
24646 ± 3% +9.4% 26968 ± 4% sched_debug.cpu.sched_goidle.4
15258 ± 6% -22.8% 11773 ± 4% sched_debug.cpu.ttwu_count.11
15765 ± 5% +48.1% 23355 ± 15% sched_debug.cpu.ttwu_count.12
16869 ± 3% -26.1% 12461 ± 4% sched_debug.cpu.ttwu_count.13
3142 ± 5% +13.0% 3551 ± 8% sched_debug.cpu.ttwu_local.13
lkp-ne04: Nehalem-EP
Memory: 12G
uptime.idle
1600 ++-------------------------------------------------------------------+
| .*. *. |
1500 *+**.** * **.*.**.* *.**.**.*.**.* *.**.*.**.**.*.**.**.*.* **.*
1400 ++ : : : : :+ |
| :: :: * |
1300 ++ * * |
| |
1200 ++ |
| |
1100 O+OO OO O O OO O OO OO O O OO O |
1000 ++ |
| |
900 ++ O O |
| |
800 ++-------------------------------------------------------------------+
cpuidle.POLL.time
2.2e+08 ++---------------O--O----O----------------------------------------+
O O O O O |
2e+08 ++O O O O O O O O |
| O OO O O |
| |
1.8e+08 ++ |
| |
1.6e+08 ++ |
| |
1.4e+08 ++ |
| |
| |
1.2e+08 ++ .* .* *. .*.**. .**. *.**. *.* *. *.**.**.**.|
*.**.** * *. : **. * ** **.* *.* *.* * *
1e+08 ++------------*-----*---------------------------------------------+
cpuidle.C1-NHM.time
8e+07 ++------------------------------------------------------------------+
| |
7e+07 ++ .* *. .* .* *. *. .* *.* |
| *. *.**.*. .**.*. * *.* * *. *.* *.* * *. * *. .* *.**.*
6e+07 *+* * ** * * * * |
| |
5e+07 ++ |
| |
4e+07 ++ |
| |
3e+07 ++ |
| O O |
2e+07 O+OO OO OO O OO O OO OO OO O O |
| |
1e+07 ++------------------------------------------------------------------+
cpuidle.C3-NHM.time
4.4e+08 ++------------O---------------------------------------------------+
| OO O O O O O O |
4.2e+08 O+ O O O O O O |
4e+08 ++ O O O O O |
| |
3.8e+08 ++ |
3.6e+08 ++ |
| |
3.4e+08 ++ |
3.2e+08 ++ |
| * |
3e+08 ++ +: ** *.* .* |
2.8e+08 *+ *. *. *. * :.* + + .* .**. .* :.* .*.* * *.**.* .* .*
| * * * * * * * * ** * * *.* * *.** |
2.6e+08 ++----------------------------------------------------------------+
cpuidle.C6-NHM.time
8e+08 ++----------*-----------------------------------------------------+
| * .* .* + .* |
|.* + * * ** *. *.*. *. *.**.**.**. *. .**.**.**. *.**. *.* |
7.5e+08 *+ * * * * * * * * *.*
| |
| |
7e+08 ++ |
| |
6.5e+08 ++ |
| |
O |
6e+08 ++ O OO O O O O O O |
| O OO O O O O O O |
| O O |
5.5e+08 ++----------------------------------------------------------------+
cpuidle.C6-NHM.usage
440000 ++-----------------------------------------------------------------+
420000 ++ *. *. *. .*. * .* .* .*.* .* |
|.* .**.**. : *.* * **.** * + *.**.*.** * :.** : .** *.*
400000 *+ * * * * *.** |
380000 ++ |
| |
360000 ++ |
340000 ++ |
320000 ++ |
| |
300000 ++ |
280000 ++ |
| O O O O O |
260000 O+ O OO OO O O OO O O OO O O |
240000 ++-----------------------------------------------------------------+
turbostat.Avg_MHz
650 ++--------------------------------------------------------------------+
| |
600 O+ OO O O O O |
| O O OO O O OO OO O |
550 ++ O O O |
| |
500 ++ |
| |
450 ++ |
| |
400 ++ |
| *.*.* .**. .**.*. .**. .* .**. *.|
350 *+**.*.**.**.*. *.*.* .* *.* **.* ** *.**.* * *.* *
| * * |
300 ++--------------------------------------------------------------------+
turbostat._Busy
20 ++---------------------------------------------------------------------+
19 O+ O O O O |
| O O OO O O O O O OO |
18 ++OO O O O |
17 ++ |
| |
16 ++ |
15 ++ |
14 ++ |
| |
13 ++ |
12 ++ .* .**.*.* .*.**. *.*.**. .**.* .*.**.*.**.*.**.|
*.**.*.**.* *. .**.* .* * *.* * * *
11 ++ * * |
10 ++---------------------------------------------------------------------+
turbostat.CPU_c1
23 ++---------------------------------------------------------------------+
| * * *. |
22 ++ * +: : *. .* *. : *. * * *. |
| *. *. .* : * : : * :+ * .*.: * + + *. *.*.* .*.* *.**.*
21 *+* *.* * : : *.* * * * * * * |
| *.* |
20 ++ |
| |
19 ++ |
| |
18 ++ O OO O O O O O |
| OO O O O O O O O |
17 O+ O O O |
| |
16 ++---------------------------------------------------------------------+
turbostat.CPU_c3
38 ++---------------------------------------------------------------------+
| O |
36 ++OO O O O O |
34 ++ O O O O O OO O |
O O O |
32 ++ O O O |
| |
30 ++ |
| |
28 ++ * |
26 ++ : : *.* *.* * .*
*. *. .* .*. : : *. : : *. .**. + : *. *.*. :+ .* .*. *. * |
24 ++* * * ** * * : : * *.** :+ * **.* * * * *.* |
| * * |
22 ++---------------------------------------------------------------------+
turbostat.CPU_c6
44 ++---*-------*---------------------------------------------------------+
|.* + + *.*.* + .**. *. *. .** * .*. *.* *. .*.* |
42 *+ * * * **.*.* + * * + .**. + * * :.*.* *.** *.|
40 ++ * * * * *
| |
38 ++ |
36 ++ |
| |
34 ++ |
32 ++ |
O O O |
30 ++ O O O OO O O O |
28 ++OO O O O O O O |
| O O |
26 ++---------------------------------------------------------------------+
vmstat.procs.b
30 ++---------------------------------------------------------------------+
| |
| O |
25 O+O O O O OO O O O O O |
| O O O O O O O O |
| |
20 ++ |
| |
15 ++ |
| |
| |
10 ++* *.* .* .* *.*. *. .* .**.*. * |
|+ :.*. .* .* *.* * + *. .* * * :.*. * **. .**. + :.*
* * **.* :.* * * * * * * * |
5 ++-----------*---------------------------------------------------------+
[*] 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
[-- Attachment #2: job.yaml --]
[-- Type: text/plain, Size: 3900 bytes --]
---
LKP_SERVER: inn
LKP_CGI_PORT: 80
LKP_CIFS_PORT: 139
testcase: fsmark
default-monitors:
wait: activate-monitor
kmsg:
uptime:
iostat:
heartbeat:
vmstat:
numa-numastat:
numa-vmstat:
numa-meminfo:
proc-vmstat:
proc-stat:
interval: 10
meminfo:
slabinfo:
interrupts:
lock_stat:
latency_stats:
softirqs:
bdi_dev_mapping:
diskstats:
nfsstat:
cpuidle:
cpufreq-stats:
turbostat:
pmeter:
sched_debug:
interval: 60
cpufreq_governor: performance
default-watchdogs:
oom-killer:
watchdog:
commit: d57d611505d911c6f9f81cd9bd6dbd293d66dd9f
model: Nehalem-EP
memory: 12G
hdd_partitions: "/dev/disk/by-id/ata-ST3500514NS_9WJ03EBA-part3"
swap_partitions: "/dev/disk/by-id/ata-ST3120026AS_5MS07HA2-part2"
rootfs_partition: "/dev/disk/by-id/ata-ST3500514NS_9WJ03EBA-part1"
category: benchmark
iterations: 1x
nr_threads: 32t
disk: 1HDD
fs: f2fs
fs2:
fsmark:
filesize: 9B
test_size: 400M
sync_method: fsyncBeforeClose
nr_directories: 16d
nr_files_per_directory: 256fpd
queue: bisect
testbox: lkp-ne04
tbox_group: lkp-ne04
kconfig: x86_64-rhel
enqueue_time: 2016-02-22 10:58:09.364797751 +08:00
compiler: gcc-4.9
rootfs: debian-x86_64-2015-02-07.cgz
id: 6d2662afc93143f862f189ea98b1c462b2ff6215
user: lkp
head_commit: cb0ddba856afd26f4aa32ca286e798fae835c5d4
base_commit: 81f70ba233d5f660e1ea5fe23260ee323af5d53a
branch: linux-devel/devel-hourly-2016022201
result_root: "/result/fsmark/performance-1x-32t-1HDD-f2fs-9B-400M-fsyncBeforeClose-16d-256fpd/lkp-ne04/debian-x86_64-2015-02-07.cgz/x86_64-rhel/gcc-4.9/d57d611505d911c6f9f81cd9bd6dbd293d66dd9f/0"
job_file: "/lkp/scheduled/lkp-ne04/bisect_fsmark-performance-1x-32t-1HDD-f2fs-9B-400M-fsyncBeforeClose-16d-256fpd-debian-x86_64-2015-02-07.cgz-x86_64-rhel-d57d611505d911c6f9f81cd9bd6dbd293d66dd9f-20160222-22073-1mh810r-0.yaml"
nr_cpu: "$(nproc)"
max_uptime: 839.1400000000001
initrd: "/osimage/debian/debian-x86_64-2015-02-07.cgz"
bootloader_append:
- root=/dev/ram0
- user=lkp
- job=/lkp/scheduled/lkp-ne04/bisect_fsmark-performance-1x-32t-1HDD-f2fs-9B-400M-fsyncBeforeClose-16d-256fpd-debian-x86_64-2015-02-07.cgz-x86_64-rhel-d57d611505d911c6f9f81cd9bd6dbd293d66dd9f-20160222-22073-1mh810r-0.yaml
- ARCH=x86_64
- kconfig=x86_64-rhel
- branch=linux-devel/devel-hourly-2016022201
- commit=d57d611505d911c6f9f81cd9bd6dbd293d66dd9f
- BOOT_IMAGE=/pkg/linux/x86_64-rhel/gcc-4.9/d57d611505d911c6f9f81cd9bd6dbd293d66dd9f/vmlinuz-4.5.0-rc1-00192-gd57d611
- max_uptime=839
- RESULT_ROOT=/result/fsmark/performance-1x-32t-1HDD-f2fs-9B-400M-fsyncBeforeClose-16d-256fpd/lkp-ne04/debian-x86_64-2015-02-07.cgz/x86_64-rhel/gcc-4.9/d57d611505d911c6f9f81cd9bd6dbd293d66dd9f/0
- LKP_SERVER=inn
- |2-
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
lkp_initrd: "/lkp/lkp/lkp-x86_64.cgz"
modules_initrd: "/pkg/linux/x86_64-rhel/gcc-4.9/d57d611505d911c6f9f81cd9bd6dbd293d66dd9f/modules.cgz"
bm_initrd: "/osimage/deps/debian-x86_64-2015-02-07.cgz/lkp.cgz,/osimage/deps/debian-x86_64-2015-02-07.cgz/run-ipconfig.cgz,/osimage/deps/debian-x86_64-2015-02-07.cgz/turbostat.cgz,/lkp/benchmarks/turbostat.cgz,/osimage/deps/debian-x86_64-2015-02-07.cgz/fs.cgz,/osimage/deps/debian-x86_64-2015-02-07.cgz/fs2.cgz,/lkp/benchmarks/fsmark.cgz"
linux_headers_initrd: "/pkg/linux/x86_64-rhel/gcc-4.9/d57d611505d911c6f9f81cd9bd6dbd293d66dd9f/linux-headers.cgz"
repeat_to: 2
kernel: "/pkg/linux/x86_64-rhel/gcc-4.9/d57d611505d911c6f9f81cd9bd6dbd293d66dd9f/vmlinuz-4.5.0-rc1-00192-gd57d611"
dequeue_time: 2016-02-22 11:07:01.622256068 +08:00
job_state: finished
loadavg: 23.23 7.48 2.63 2/257 3180
start_time: '1456110470'
end_time: '1456110550'
version: "/lkp/lkp/.src-20160222-105838"
[-- Attachment #3: reproduce.sh --]
[-- Type: application/x-sh, Size: 2127 bytes --]
^ permalink raw reply [flat|nested] 2+ messages in thread
* Re: [lkp] [kernel/fs] d57d611505: +54.7% turbostat.%Busy
2016-02-23 8:26 [lkp] [kernel/fs] d57d611505: +54.7% turbostat.%Busy kernel test robot
@ 2016-02-23 8:55 ` Stephane Gasparini
0 siblings, 0 replies; 2+ messages in thread
From: Stephane Gasparini @ 2016-02-23 8:55 UTC (permalink / raw)
To: kernel test robot; +Cc: lkp, LKML, Philippe Longepe, Jens Axboe
The increase of this metric is expected as the I/O wait (I/O busy) were not accounted on some write operation before this patch and are accounted now.
—
Steph
> On Feb 23, 2016, at 9:26 AM, kernel test robot <ying.huang@linux.intel.com> wrote:
>
> FYI, we noticed the below changes on
>
> https://git.kernel.org/pub/scm/linux/kernel/git/torvalds/linux.git master
> commit d57d611505d911c6f9f81cd9bd6dbd293d66dd9f ("kernel/fs: fix I/O wait not accounted for RW O_DSYNC")
>
>
> =========================================================================================
> compiler/cpufreq_governor/disk/filesize/fs/iterations/kconfig/nr_directories/nr_files_per_directory/nr_threads/rootfs/sync_method/tbox_group/test_size/testcase:
> gcc-4.9/performance/1HDD/9B/f2fs/1x/x86_64-rhel/16d/256fpd/32t/debian-x86_64-2015-02-07.cgz/fsyncBeforeClose/lkp-ne04/400M/fsmark
>
> commit:
> 09954bad448791ef01202351d437abdd9497a804
> d57d611505d911c6f9f81cd9bd6dbd293d66dd9f
>
> 09954bad448791ef d57d611505d911c6f9f81cd9bd
> ---------------- --------------------------
> %stddev %change %stddev
> \ | \
> 14760 ± 1% +6.3% 15695 ± 1% fsmark.time.involuntary_context_switches
> 46.00 ± 0% -8.2% 42.25 ± 1% fsmark.time.percent_of_cpu_this_job_got
> 26151 ±116% -71.3% 7498 ± 23% latency_stats.sum.call_rwsem_down_read_failed.f2fs_mkdir.[f2fs].vfs_mkdir.SyS_mkdir.entry_SYSCALL_64_fastpath
> 7418 ± 23% -27.7% 5361 ± 3% numa-vmstat.node0.nr_slab_unreclaimable
> 1.47 ± 1% -9.9% 1.33 ± 0% time.user_time
> 1447 ± 4% -29.0% 1028 ± 7% uptime.idle
> 7.75 ± 19% +206.5% 23.75 ± 1% vmstat.procs.b
> 29675 ± 23% -27.7% 21447 ± 3% numa-meminfo.node0.SUnreclaim
> 83099 ± 8% -11.5% 73568 ± 1% numa-meminfo.node0.Slab
> 11.91 ± 1% +54.7% 18.43 ± 1% turbostat.%Busy
> 358.00 ± 1% +60.0% 572.75 ± 1% turbostat.Avg_MHz
> 21.54 ± 0% -17.4% 17.79 ± 1% turbostat.CPU%c1
> 24.78 ± 3% +41.1% 34.98 ± 1% turbostat.CPU%c3
> 41.76 ± 1% -31.0% 28.81 ± 1% turbostat.CPU%c6
> 8.53 ± 5% -25.6% 6.34 ± 10% turbostat.Pkg%pc3
> 66312232 ± 0% -68.5% 20910669 ± 4% cpuidle.C1-NHM.time
> 46386272 ± 2% -20.5% 36884085 ± 5% cpuidle.C1E-NHM.time
> 2.79e+08 ± 2% +51.5% 4.226e+08 ± 0% cpuidle.C3-NHM.time
> 254315 ± 2% +25.1% 318250 ± 2% cpuidle.C3-NHM.usage
> 7.585e+08 ± 1% -22.2% 5.901e+08 ± 1% cpuidle.C6-NHM.time
> 415414 ± 1% -38.1% 257115 ± 1% cpuidle.C6-NHM.usage
> 1.135e+08 ± 1% +77.8% 2.017e+08 ± 2% cpuidle.POLL.time
> 102777 ± 1% +36.0% 139811 ± 1% cpuidle.POLL.usage
> 2011 ± 25% -27.1% 1467 ± 2% sched_debug.cfs_rq:/.exec_clock.2
> 1820 ± 3% -12.2% 1597 ± 7% sched_debug.cfs_rq:/.exec_clock.4
> 4297 ± 6% +78.1% 7653 ± 54% sched_debug.cfs_rq:/.min_vruntime.12
> 4803 ± 18% -16.1% 4028 ± 21% sched_debug.cfs_rq:/.min_vruntime.8
> 3763 ± 4% -17.0% 3124 ± 7% sched_debug.cfs_rq:/.min_vruntime.9
> 3408 ± 4% -14.9% 2900 ± 2% sched_debug.cfs_rq:/.min_vruntime.min
> 4.75 ± 54% -73.7% 1.25 ±173% sched_debug.cfs_rq:/.nr_spread_over.2
> 1.99 ± 16% +25.5% 2.50 ± 9% sched_debug.cfs_rq:/.nr_spread_over.stddev
> -4362 ±-25% -92.7% -318.24 ±-1304% sched_debug.cfs_rq:/.spread0.12
> 200.25 ± 47% -48.8% 102.50 ± 22% sched_debug.cfs_rq:/.util_avg.7
> 187.75 ± 64% -77.2% 42.75 ± 56% sched_debug.cfs_rq:/.util_avg.8
> 1.41 ± 31% +37.0% 1.93 ± 12% sched_debug.cpu.clock.stddev
> 1.41 ± 31% +37.0% 1.93 ± 12% sched_debug.cpu.clock_task.stddev
> 1.63 ± 67% -53.9% 0.75 ± 38% sched_debug.cpu.cpu_load[4].stddev
> 33822 ± 16% -17.2% 28018 ± 4% sched_debug.cpu.nr_switches.13
> 36824 ± 3% +12.9% 41569 ± 4% sched_debug.cpu.nr_switches.14
> 33117 ± 7% -11.1% 29438 ± 5% sched_debug.cpu.nr_switches.15
> 57634 ± 3% +8.8% 62716 ± 3% sched_debug.cpu.nr_switches.4
> 1723 ± 7% -11.3% 1527 ± 5% sched_debug.cpu.nr_uninterruptible.10
> 1378 ± 6% -8.7% 1258 ± 5% sched_debug.cpu.nr_uninterruptible.15
> 1232 ± 10% +25.3% 1543 ± 3% sched_debug.cpu.nr_uninterruptible.8
> 34660 ± 13% -19.1% 28034 ± 4% sched_debug.cpu.sched_count.13
> 37545 ± 2% +18.9% 44629 ± 7% sched_debug.cpu.sched_count.14
> 34003 ± 9% -13.4% 29456 ± 5% sched_debug.cpu.sched_count.15
> 62715 ± 6% +9.5% 68642 ± 7% sched_debug.cpu.sched_count.2
> 14091 ± 19% -20.4% 11212 ± 5% sched_debug.cpu.sched_goidle.13
> 14175 ± 3% +15.4% 16354 ± 6% sched_debug.cpu.sched_goidle.14
> 13465 ± 9% -12.5% 11782 ± 6% sched_debug.cpu.sched_goidle.15
> 24646 ± 3% +9.4% 26968 ± 4% sched_debug.cpu.sched_goidle.4
> 15258 ± 6% -22.8% 11773 ± 4% sched_debug.cpu.ttwu_count.11
> 15765 ± 5% +48.1% 23355 ± 15% sched_debug.cpu.ttwu_count.12
> 16869 ± 3% -26.1% 12461 ± 4% sched_debug.cpu.ttwu_count.13
> 3142 ± 5% +13.0% 3551 ± 8% sched_debug.cpu.ttwu_local.13
>
> lkp-ne04: Nehalem-EP
> Memory: 12G
>
> uptime.idle
>
> 1600 ++-------------------------------------------------------------------+
> | .*. *. |
> 1500 *+**.** * **.*.**.* *.**.**.*.**.* *.**.*.**.**.*.**.**.*.* **.*
> 1400 ++ : : : : :+ |
> | :: :: * |
> 1300 ++ * * |
> | |
> 1200 ++ |
> | |
> 1100 O+OO OO O O OO O OO OO O O OO O |
> 1000 ++ |
> | |
> 900 ++ O O |
> | |
> 800 ++-------------------------------------------------------------------+
>
>
> cpuidle.POLL.time
>
> 2.2e+08 ++---------------O--O----O----------------------------------------+
> O O O O O |
> 2e+08 ++O O O O O O O O |
> | O OO O O |
> | |
> 1.8e+08 ++ |
> | |
> 1.6e+08 ++ |
> | |
> 1.4e+08 ++ |
> | |
> | |
> 1.2e+08 ++ .* .* *. .*.**. .**. *.**. *.* *. *.**.**.**.|
> *.**.** * *. : **. * ** **.* *.* *.* * *
> 1e+08 ++------------*-----*---------------------------------------------+
>
>
> cpuidle.C1-NHM.time
>
> 8e+07 ++------------------------------------------------------------------+
> | |
> 7e+07 ++ .* *. .* .* *. *. .* *.* |
> | *. *.**.*. .**.*. * *.* * *. *.* *.* * *. * *. .* *.**.*
> 6e+07 *+* * ** * * * * |
> | |
> 5e+07 ++ |
> | |
> 4e+07 ++ |
> | |
> 3e+07 ++ |
> | O O |
> 2e+07 O+OO OO OO O OO O OO OO OO O O |
> | |
> 1e+07 ++------------------------------------------------------------------+
>
>
> cpuidle.C3-NHM.time
>
> 4.4e+08 ++------------O---------------------------------------------------+
> | OO O O O O O O |
> 4.2e+08 O+ O O O O O O |
> 4e+08 ++ O O O O O |
> | |
> 3.8e+08 ++ |
> 3.6e+08 ++ |
> | |
> 3.4e+08 ++ |
> 3.2e+08 ++ |
> | * |
> 3e+08 ++ +: ** *.* .* |
> 2.8e+08 *+ *. *. *. * :.* + + .* .**. .* :.* .*.* * *.**.* .* .*
> | * * * * * * * * ** * * *.* * *.** |
> 2.6e+08 ++----------------------------------------------------------------+
>
>
> cpuidle.C6-NHM.time
>
> 8e+08 ++----------*-----------------------------------------------------+
> | * .* .* + .* |
> |.* + * * ** *. *.*. *. *.**.**.**. *. .**.**.**. *.**. *.* |
> 7.5e+08 *+ * * * * * * * * *.*
> | |
> | |
> 7e+08 ++ |
> | |
> 6.5e+08 ++ |
> | |
> O |
> 6e+08 ++ O OO O O O O O O |
> | O OO O O O O O O |
> | O O |
> 5.5e+08 ++----------------------------------------------------------------+
>
>
> cpuidle.C6-NHM.usage
>
> 440000 ++-----------------------------------------------------------------+
> 420000 ++ *. *. *. .*. * .* .* .*.* .* |
> |.* .**.**. : *.* * **.** * + *.**.*.** * :.** : .** *.*
> 400000 *+ * * * * *.** |
> 380000 ++ |
> | |
> 360000 ++ |
> 340000 ++ |
> 320000 ++ |
> | |
> 300000 ++ |
> 280000 ++ |
> | O O O O O |
> 260000 O+ O OO OO O O OO O O OO O O |
> 240000 ++-----------------------------------------------------------------+
>
>
> turbostat.Avg_MHz
>
> 650 ++--------------------------------------------------------------------+
> | |
> 600 O+ OO O O O O |
> | O O OO O O OO OO O |
> 550 ++ O O O |
> | |
> 500 ++ |
> | |
> 450 ++ |
> | |
> 400 ++ |
> | *.*.* .**. .**.*. .**. .* .**. *.|
> 350 *+**.*.**.**.*. *.*.* .* *.* **.* ** *.**.* * *.* *
> | * * |
> 300 ++--------------------------------------------------------------------+
>
>
> turbostat._Busy
>
> 20 ++---------------------------------------------------------------------+
> 19 O+ O O O O |
> | O O OO O O O O O OO |
> 18 ++OO O O O |
> 17 ++ |
> | |
> 16 ++ |
> 15 ++ |
> 14 ++ |
> | |
> 13 ++ |
> 12 ++ .* .**.*.* .*.**. *.*.**. .**.* .*.**.*.**.*.**.|
> *.**.*.**.* *. .**.* .* * *.* * * *
> 11 ++ * * |
> 10 ++---------------------------------------------------------------------+
>
>
> turbostat.CPU_c1
>
> 23 ++---------------------------------------------------------------------+
> | * * *. |
> 22 ++ * +: : *. .* *. : *. * * *. |
> | *. *. .* : * : : * :+ * .*.: * + + *. *.*.* .*.* *.**.*
> 21 *+* *.* * : : *.* * * * * * * |
> | *.* |
> 20 ++ |
> | |
> 19 ++ |
> | |
> 18 ++ O OO O O O O O |
> | OO O O O O O O O |
> 17 O+ O O O |
> | |
> 16 ++---------------------------------------------------------------------+
>
>
> turbostat.CPU_c3
>
> 38 ++---------------------------------------------------------------------+
> | O |
> 36 ++OO O O O O |
> 34 ++ O O O O O OO O |
> O O O |
> 32 ++ O O O |
> | |
> 30 ++ |
> | |
> 28 ++ * |
> 26 ++ : : *.* *.* * .*
> *. *. .* .*. : : *. : : *. .**. + : *. *.*. :+ .* .*. *. * |
> 24 ++* * * ** * * : : * *.** :+ * **.* * * * *.* |
> | * * |
> 22 ++---------------------------------------------------------------------+
>
>
> turbostat.CPU_c6
>
> 44 ++---*-------*---------------------------------------------------------+
> |.* + + *.*.* + .**. *. *. .** * .*. *.* *. .*.* |
> 42 *+ * * * **.*.* + * * + .**. + * * :.*.* *.** *.|
> 40 ++ * * * * *
> | |
> 38 ++ |
> 36 ++ |
> | |
> 34 ++ |
> 32 ++ |
> O O O |
> 30 ++ O O O OO O O O |
> 28 ++OO O O O O O O |
> | O O |
> 26 ++---------------------------------------------------------------------+
>
>
> vmstat.procs.b
>
> 30 ++---------------------------------------------------------------------+
> | |
> | O |
> 25 O+O O O O OO O O O O O |
> | O O O O O O O O |
> | |
> 20 ++ |
> | |
> 15 ++ |
> | |
> | |
> 10 ++* *.* .* .* *.*. *. .* .**.*. * |
> |+ :.*. .* .* *.* * + *. .* * * :.*. * **. .**. + :.*
> * * **.* :.* * * * * * * * |
> 5 ++-----------*---------------------------------------------------------+
>
> [*] 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
> <job.yaml><reproduce.sh>
^ permalink raw reply [flat|nested] 2+ messages in thread
end of thread, other threads:[~2016-02-23 8:55 UTC | newest]
Thread overview: 2+ messages (download: mbox.gz follow: Atom feed
-- links below jump to the message on this page --
2016-02-23 8:26 [lkp] [kernel/fs] d57d611505: +54.7% turbostat.%Busy kernel test robot
2016-02-23 8:55 ` Stephane Gasparini
This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox