[lkp] [f2fs] 24b8491251: -7.1% fsmark.app_overhead

From: kernel test robot
Date: Thu Mar 10 2016 - 20:56:49 EST


FYI, we noticed the below changes on

https://git.kernel.org/pub/scm/linux/kernel/git/jaegeuk/f2fs dev-test
commit 24b8491251cde66879e74092167cc0f27a1f11ce ("f2fs: preallocate blocks for buffered aio writes")


=========================================================================================
compiler/cpufreq_governor/disk/filesize/fs/iterations/kconfig/nr_threads/rootfs/sync_method/tbox_group/test_size/testcase:
gcc-4.9/performance/1BRD_48G/4M/f2fs/1x/x86_64-rhel/64t/debian-x86_64-2015-02-07.cgz/NoSync/lkp-hsx04/40G/fsmark

commit:
b439b103a6c9eb3417f34b4a609d4e00b4c59aca
24b8491251cde66879e74092167cc0f27a1f11ce

b439b103a6c9eb34 24b8491251cde66879e7409216
---------------- --------------------------
%stddev %change %stddev
\ | \
612289 ± 1% -7.1% 568876 ± 1% fsmark.app_overhead
1495 ± 2% +25.1% 1871 ± 2% fsmark.files_per_sec
3422 ± 2% +41.0% 4827 ± 4% fsmark.time.percent_of_cpu_this_job_got
1188385 ± 1% -68.3% 377081 ± 9% fsmark.time.voluntary_context_switches
264601 ± 26% -38.8% 161926 ± 43% softirqs.SCHED
4802 ± 5% +84.1% 8841 ± 12% proc-vmstat.pgactivate
54154 ± 2% -11.3% 48039 ± 4% proc-vmstat.pgfault
43810 ± 2% -9.3% 39722 ± 2% proc-vmstat.pgfree
19.00 ± 20% +50.0% 28.50 ± 8% vmstat.procs.r
208274 ± 6% -66.3% 70257 ± 8% vmstat.system.cs
24846 ± 7% +18.3% 29381 ± 6% vmstat.system.in
4254 ± 1% +11.5% 4745 ± 4% numa-meminfo.node1.KernelStack
8893 ± 20% -33.7% 5896 ± 14% numa-meminfo.node3.Active(anon)
28208 ± 7% +21.6% 34295 ± 6% numa-meminfo.node3.Active(file)
8828 ± 20% -34.7% 5762 ± 13% numa-meminfo.node3.AnonPages
654.25 ± 9% -17.9% 537.00 ± 18% numa-vmstat.node0.nr_alloc_batch
2217 ± 20% -33.7% 1470 ± 14% numa-vmstat.node3.nr_active_anon
7050 ± 7% +21.6% 8573 ± 6% numa-vmstat.node3.nr_active_file
2208 ± 19% -34.7% 1441 ± 13% numa-vmstat.node3.nr_anon_pages
6.97 ± 2% -19.9% 5.59 ± 2% time.elapsed_time
6.97 ± 2% -19.9% 5.59 ± 2% time.elapsed_time.max
3422 ± 2% +41.0% 4827 ± 4% time.percent_of_cpu_this_job_got
0.46 ± 1% -12.6% 0.40 ± 4% time.user_time
1188385 ± 1% -68.3% 377081 ± 9% time.voluntary_context_switches
21.32 ± 3% +36.3% 29.05 ± 5% turbostat.%Busy
616.25 ± 3% +36.4% 840.75 ± 5% turbostat.Avg_MHz
26.38 ± 5% -23.9% 20.06 ± 10% turbostat.CPU%c1
2.77 ± 20% -59.9% 1.11 ± 12% turbostat.CPU%c3
309.69 ± 2% +4.5% 323.48 ± 0% turbostat.PkgWatt
15951637 ± 16% +127.1% 36232857 ± 28% cpuidle.C1-HSW.time
93867067 ± 12% -37.6% 58584188 ± 20% cpuidle.C1E-HSW.time
337610 ± 3% -70.0% 101408 ± 7% cpuidle.C1E-HSW.usage
37574978 ± 18% -71.3% 10766602 ± 7% cpuidle.C3-HSW.time
140480 ± 14% -75.2% 34776 ± 14% cpuidle.C3-HSW.usage
7.511e+08 ± 1% -24.4% 5.681e+08 ± 1% cpuidle.C6-HSW.time
790092 ± 3% -78.7% 168250 ± 15% cpuidle.C6-HSW.usage
0.00 ± -1% +Inf% 346080 ± 9% latency_stats.hits.call_rwsem_down_read_failed.get_node_info.[f2fs].read_node_page.[f2fs].__get_node_page.[f2fs].get_node_page.[f2fs].get_dnode_of_data.[f2fs].f2fs_map_blocks.[f2fs].f2fs_preallocate_blocks.[f2fs].f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write.SyS_write
36235 ± 4% -100.0% 0.00 ± -1% latency_stats.hits.call_rwsem_down_read_failed.get_node_info.[f2fs].read_node_page.[f2fs].__get_node_page.[f2fs].get_node_page.[f2fs].get_dnode_of_data.[f2fs].f2fs_reserve_block.[f2fs].f2fs_get_block.[f2fs].f2fs_write_begin.[f2fs].generic_perform_write.__generic_file_write_iter.f2fs_file_write_iter.[f2fs]
1110160 ± 2% -100.0% 0.00 ± -1% latency_stats.hits.call_rwsem_down_read_failed.get_node_info.[f2fs].read_node_page.[f2fs].__get_node_page.[f2fs].get_node_page.[f2fs].get_node_page.[f2fs].f2fs_write_begin.[f2fs].generic_perform_write.__generic_file_write_iter.f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write
10727 ± 2% -100.0% 0.00 ± -1% latency_stats.hits.call_rwsem_down_write_failed.get_node_info.[f2fs].new_node_page.[f2fs].get_dnode_of_data.[f2fs].f2fs_reserve_block.[f2fs].f2fs_get_block.[f2fs].f2fs_write_begin.[f2fs].generic_perform_write.__generic_file_write_iter.f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write
0.00 ± -1% +Inf% 104220 ± 12% latency_stats.sum.call_rwsem_down_read_failed.get_node_info.[f2fs].new_node_page.[f2fs].get_dnode_of_data.[f2fs].f2fs_map_blocks.[f2fs].f2fs_preallocate_blocks.[f2fs].f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write.SyS_write.entry_SYSCALL_64_fastpath
88684 ± 2% -100.0% 0.00 ± -1% latency_stats.sum.call_rwsem_down_read_failed.get_node_info.[f2fs].new_node_page.[f2fs].get_dnode_of_data.[f2fs].f2fs_reserve_block.[f2fs].f2fs_get_block.[f2fs].f2fs_write_begin.[f2fs].generic_perform_write.__generic_file_write_iter.f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write
0.00 ± -1% +Inf% 62708911 ± 13% latency_stats.sum.call_rwsem_down_read_failed.get_node_info.[f2fs].read_node_page.[f2fs].__get_node_page.[f2fs].get_node_page.[f2fs].get_dnode_of_data.[f2fs].f2fs_map_blocks.[f2fs].f2fs_preallocate_blocks.[f2fs].f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write.SyS_write
6532927 ± 7% -100.0% 0.00 ± -1% latency_stats.sum.call_rwsem_down_read_failed.get_node_info.[f2fs].read_node_page.[f2fs].__get_node_page.[f2fs].get_node_page.[f2fs].get_dnode_of_data.[f2fs].f2fs_reserve_block.[f2fs].f2fs_get_block.[f2fs].f2fs_write_begin.[f2fs].generic_perform_write.__generic_file_write_iter.f2fs_file_write_iter.[f2fs]
0.00 ± -1% +Inf% 860616 ± 16% latency_stats.sum.call_rwsem_down_read_failed.get_node_info.[f2fs].read_node_page.[f2fs].__get_node_page.[f2fs].get_node_page.[f2fs].get_node_page.[f2fs].f2fs_convert_inline_inode.[f2fs].f2fs_preallocate_blocks.[f2fs].f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write.SyS_write
1.663e+08 ± 0% -100.0% 0.00 ± -1% latency_stats.sum.call_rwsem_down_read_failed.get_node_info.[f2fs].read_node_page.[f2fs].__get_node_page.[f2fs].get_node_page.[f2fs].get_node_page.[f2fs].f2fs_write_begin.[f2fs].generic_perform_write.__generic_file_write_iter.f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write
0.00 ± -1% +Inf% 434819 ± 14% latency_stats.sum.call_rwsem_down_write_failed.get_node_info.[f2fs].new_node_page.[f2fs].get_dnode_of_data.[f2fs].f2fs_map_blocks.[f2fs].f2fs_preallocate_blocks.[f2fs].f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write.SyS_write.entry_SYSCALL_64_fastpath
436260 ± 2% -100.0% 0.00 ± -1% latency_stats.sum.call_rwsem_down_write_failed.get_node_info.[f2fs].new_node_page.[f2fs].get_dnode_of_data.[f2fs].f2fs_reserve_block.[f2fs].f2fs_get_block.[f2fs].f2fs_write_begin.[f2fs].generic_perform_write.__generic_file_write_iter.f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write
0.00 ± -1% +Inf% 375976 ± 14% latency_stats.sum.call_rwsem_down_write_failed.set_node_addr.[f2fs].new_node_page.[f2fs].get_dnode_of_data.[f2fs].f2fs_map_blocks.[f2fs].f2fs_preallocate_blocks.[f2fs].f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write.SyS_write.entry_SYSCALL_64_fastpath
827019 ± 5% -100.0% 0.00 ± -1% latency_stats.sum.call_rwsem_down_write_failed.set_node_addr.[f2fs].new_node_page.[f2fs].get_dnode_of_data.[f2fs].f2fs_reserve_block.[f2fs].f2fs_get_block.[f2fs].f2fs_write_begin.[f2fs].generic_perform_write.__generic_file_write_iter.f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write

=========================================================================================
compiler/cpufreq_governor/disk/filesize/fs/iterations/kconfig/nr_threads/rootfs/sync_method/tbox_group/test_size/testcase:
gcc-4.9/performance/1BRD_48G/4M/f2fs/1x/x86_64-rhel/64t/debian-x86_64-2015-02-07.cgz/NoSync/lkp-hsw-ep2/40G/fsmark

commit:
b439b103a6c9eb3417f34b4a609d4e00b4c59aca
24b8491251cde66879e74092167cc0f27a1f11ce

b439b103a6c9eb34 24b8491251cde66879e7409216
---------------- --------------------------
%stddev %change %stddev
\ | \
625.40 ± 1% +6.7% 667.52 ± 0% fsmark.files_per_sec
2702 ± 7% -36.6% 1714 ± 12% fsmark.time.involuntary_context_switches
770.50 ± 8% +52.2% 1172 ± 12% fsmark.time.percent_of_cpu_this_job_got
133.18 ± 7% +40.7% 187.40 ± 11% fsmark.time.system_time
686680 ± 3% -67.3% 224529 ± 18% fsmark.time.voluntary_context_switches
80197 ± 13% +19.3% 95683 ± 6% numa-meminfo.node1.Active
106550 ± 19% -38.6% 65433 ± 5% softirqs.SCHED
37713 ± 0% +17.5% 44314 ± 0% proc-vmstat.nr_active_file
5074 ± 4% +30.5% 6620 ± 20% proc-vmstat.pgactivate
178348 ± 1% +14.9% 204838 ± 0% meminfo.Active
150432 ± 0% +17.9% 177429 ± 0% meminfo.Active(file)
4898 ± 21% -12.5% 4284 ± 18% meminfo.AnonHugePages
15.63 ± 7% -42.0% 9.06 ± 6% turbostat.CPU%c1
3.34 ± 15% -22.2% 2.60 ± 6% turbostat.CPU%c3
10.18 ± 45% +89.7% 19.30 ± 14% turbostat.Pkg%pc2
1161365 ± 1% +2.6% 1192137 ± 0% vmstat.io.bo
3.25 ± 59% +138.5% 7.75 ± 10% vmstat.procs.r
65985 ± 5% -60.5% 26040 ± 12% vmstat.system.cs
8603 ± 3% +41.5% 12173 ± 11% vmstat.system.in
2702 ± 7% -36.6% 1714 ± 12% time.involuntary_context_switches
770.50 ± 8% +52.2% 1172 ± 12% time.percent_of_cpu_this_job_got
133.18 ± 7% +40.7% 187.40 ± 11% time.system_time
0.36 ± 6% -17.1% 0.30 ± 4% time.user_time
686680 ± 3% -67.3% 224529 ± 18% time.voluntary_context_switches
42510356 ± 16% -56.7% 18410803 ± 34% cpuidle.C1E-HSW.time
187168 ± 5% -63.9% 67587 ± 5% cpuidle.C1E-HSW.usage
34590282 ± 12% -42.9% 19767899 ± 11% cpuidle.C3-HSW.time
88675 ± 13% -73.0% 23973 ± 33% cpuidle.C3-HSW.usage
1.039e+09 ± 3% -8.8% 9.474e+08 ± 3% cpuidle.C6-HSW.time
380449 ± 12% -70.5% 112252 ± 17% cpuidle.C6-HSW.usage
42507793 ± 13% -66.1% 14427275 ± 19% cpuidle.POLL.time
7918 ± 50% -49.1% 4032 ± 31% cpuidle.POLL.usage
0.00 ± -1% +Inf% 194173 ± 20% latency_stats.hits.call_rwsem_down_read_failed.get_node_info.[f2fs].read_node_page.[f2fs].__get_node_page.[f2fs].get_node_page.[f2fs].get_dnode_of_data.[f2fs].f2fs_map_blocks.[f2fs].f2fs_preallocate_blocks.[f2fs].f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write.SyS_write
27391 ± 4% -100.0% 0.00 ± -1% latency_stats.hits.call_rwsem_down_read_failed.get_node_info.[f2fs].read_node_page.[f2fs].__get_node_page.[f2fs].get_node_page.[f2fs].get_dnode_of_data.[f2fs].f2fs_reserve_block.[f2fs].f2fs_get_block.[f2fs].f2fs_write_begin.[f2fs].generic_perform_write.__generic_file_write_iter.f2fs_file_write_iter.[f2fs]
621245 ± 4% -100.0% 0.00 ± -1% latency_stats.hits.call_rwsem_down_read_failed.get_node_info.[f2fs].read_node_page.[f2fs].__get_node_page.[f2fs].get_node_page.[f2fs].get_node_page.[f2fs].f2fs_write_begin.[f2fs].generic_perform_write.__generic_file_write_iter.f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write
0.00 ± -1% +Inf% 42514 ± 44% latency_stats.sum.call_rwsem_down_read_failed.get_node_info.[f2fs].new_node_page.[f2fs].get_dnode_of_data.[f2fs].f2fs_map_blocks.[f2fs].f2fs_preallocate_blocks.[f2fs].f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write.SyS_write.entry_SYSCALL_64_fastpath
71010 ± 9% -100.0% 0.00 ± -1% latency_stats.sum.call_rwsem_down_read_failed.get_node_info.[f2fs].new_node_page.[f2fs].get_dnode_of_data.[f2fs].f2fs_reserve_block.[f2fs].f2fs_get_block.[f2fs].f2fs_write_begin.[f2fs].generic_perform_write.__generic_file_write_iter.f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write
0.00 ± -1% +Inf% 29050748 ± 40% latency_stats.sum.call_rwsem_down_read_failed.get_node_info.[f2fs].read_node_page.[f2fs].__get_node_page.[f2fs].get_node_page.[f2fs].get_dnode_of_data.[f2fs].f2fs_map_blocks.[f2fs].f2fs_preallocate_blocks.[f2fs].f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write.SyS_write
5471586 ± 7% -100.0% 0.00 ± -1% latency_stats.sum.call_rwsem_down_read_failed.get_node_info.[f2fs].read_node_page.[f2fs].__get_node_page.[f2fs].get_node_page.[f2fs].get_dnode_of_data.[f2fs].f2fs_reserve_block.[f2fs].f2fs_get_block.[f2fs].f2fs_write_begin.[f2fs].generic_perform_write.__generic_file_write_iter.f2fs_file_write_iter.[f2fs]
0.00 ± -1% +Inf% 379285 ± 50% latency_stats.sum.call_rwsem_down_read_failed.get_node_info.[f2fs].read_node_page.[f2fs].__get_node_page.[f2fs].get_node_page.[f2fs].get_node_page.[f2fs].f2fs_convert_inline_inode.[f2fs].f2fs_preallocate_blocks.[f2fs].f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write.SyS_write
1.014e+08 ± 0% -100.0% 0.00 ± -1% latency_stats.sum.call_rwsem_down_read_failed.get_node_info.[f2fs].read_node_page.[f2fs].__get_node_page.[f2fs].get_node_page.[f2fs].get_node_page.[f2fs].f2fs_write_begin.[f2fs].generic_perform_write.__generic_file_write_iter.f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write
0.00 ± -1% +Inf% 160093 ± 47% latency_stats.sum.call_rwsem_down_write_failed.get_node_info.[f2fs].new_node_page.[f2fs].get_dnode_of_data.[f2fs].f2fs_map_blocks.[f2fs].f2fs_preallocate_blocks.[f2fs].f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write.SyS_write.entry_SYSCALL_64_fastpath
280946 ± 3% -100.0% 0.00 ± -1% latency_stats.sum.call_rwsem_down_write_failed.get_node_info.[f2fs].new_node_page.[f2fs].get_dnode_of_data.[f2fs].f2fs_reserve_block.[f2fs].f2fs_get_block.[f2fs].f2fs_write_begin.[f2fs].generic_perform_write.__generic_file_write_iter.f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write
0.00 ± -1% +Inf% 168921 ± 36% latency_stats.sum.call_rwsem_down_write_failed.set_node_addr.[f2fs].new_node_page.[f2fs].get_dnode_of_data.[f2fs].f2fs_map_blocks.[f2fs].f2fs_preallocate_blocks.[f2fs].f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write.SyS_write.entry_SYSCALL_64_fastpath
609595 ± 5% -100.0% 0.00 ± -1% latency_stats.sum.call_rwsem_down_write_failed.set_node_addr.[f2fs].new_node_page.[f2fs].get_dnode_of_data.[f2fs].f2fs_reserve_block.[f2fs].f2fs_get_block.[f2fs].f2fs_write_begin.[f2fs].generic_perform_write.__generic_file_write_iter.f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write

lkp-hsx04: Brickland Haswell-EX
Memory: 512G

lkp-hsw-ep2: Brickland Haswell-EP
Memory: 128G


fsmark.time.voluntary_context_switches

1.6e+06 ++----------------------------------------------------------------+
| |
1.4e+06 *+.*.*.. .*..*.*..*.*..*.*..*.*..*..* |
| * + .*. .*. .*
1.2e+06 ++ *..*.*. *..*.*..*.*. *. |
1e+06 ++ |
| |
800000 ++ |
| |
600000 ++ |
400000 ++ O O |
| O O O O O O O |
200000 O+ O O O O O O O O O O O O |
| O |
0 ++----------------------------------------------------------------+


time.voluntary_context_switches

1.6e+06 ++----------------------------------------------------------------+
| |
1.4e+06 *+.*.*.. .*..*.*..*.*..*.*..*.*..*..* |
| * + .*. .*. .*
1.2e+06 ++ *..*.*. *..*.*..*.*. *. |
1e+06 ++ |
| |
800000 ++ |
| |
600000 ++ |
400000 ++ O O |
| O O O O O O O |
200000 O+ O O O O O O O O O O O O |
| O |
0 ++----------------------------------------------------------------+



[*] 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,
Xiaolong Ye
---
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: 24b8491251cde66879e74092167cc0f27a1f11ce
model: Brickland Haswell-EX
nr_cpu: 120
memory: 512G
hdd_partitions:
swap_partitions:
pmeter_server: lkp-st01
pmeter_device: yokogawa-wt310
category: benchmark
iterations: 1x
nr_threads: 64t
disk: 1BRD_48G
need_memory: 50G
fs: f2fs
fs2:
fsmark:
filesize: 4M
test_size: 40G
sync_method: NoSync
queue: bisect
testbox: lkp-hsx04
tbox_group: lkp-hsx04
kconfig: x86_64-rhel
enqueue_time: 2016-03-11 04:30:12.640292103 +08:00
compiler: gcc-4.9
rootfs: debian-x86_64-2015-02-07.cgz
id: 93091349c60052c97f95e66db970b803f0281792
user: lkp
head_commit: 0c7106b0fa41b0df3bfe01f6761ebd70fea447e8
base_commit: f6cede5b49e822ebc41a099fe41ab4989f64e2cb
branch: linux-next/master
result_root: "/result/fsmark/performance-1x-64t-1BRD_48G-f2fs-4M-40G-NoSync/lkp-hsx04/debian-x86_64-2015-02-07.cgz/x86_64-rhel/gcc-4.9/24b8491251cde66879e74092167cc0f27a1f11ce/0"
job_file: "/lkp/scheduled/lkp-hsx04/bisect_fsmark-performance-1x-64t-1BRD_48G-f2fs-4M-40G-NoSync-debian-x86_64-2015-02-07.cgz-x86_64-rhel-24b8491251cde66879e74092167cc0f27a1f11ce-20160311-38408-n3fatz-0.yaml"
max_uptime: 751.4000000000001
initrd: "/osimage/debian/debian-x86_64-2015-02-07.cgz"
bootloader_append:
- root=/dev/ram0
- user=lkp
- job=/lkp/scheduled/lkp-hsx04/bisect_fsmark-performance-1x-64t-1BRD_48G-f2fs-4M-40G-NoSync-debian-x86_64-2015-02-07.cgz-x86_64-rhel-24b8491251cde66879e74092167cc0f27a1f11ce-20160311-38408-n3fatz-0.yaml
- ARCH=x86_64
- kconfig=x86_64-rhel
- branch=linux-next/master
- commit=24b8491251cde66879e74092167cc0f27a1f11ce
- BOOT_IMAGE=/pkg/linux/x86_64-rhel/gcc-4.9/24b8491251cde66879e74092167cc0f27a1f11ce/vmlinuz-4.5.0-rc5-00208-g24b8491
- max_uptime=751
- RESULT_ROOT=/result/fsmark/performance-1x-64t-1BRD_48G-f2fs-4M-40G-NoSync/lkp-hsx04/debian-x86_64-2015-02-07.cgz/x86_64-rhel/gcc-4.9/24b8491251cde66879e74092167cc0f27a1f11ce/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/24b8491251cde66879e74092167cc0f27a1f11ce/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/24b8491251cde66879e74092167cc0f27a1f11ce/linux-headers.cgz"
repeat_to: 2
kernel: "/pkg/linux/x86_64-rhel/gcc-4.9/24b8491251cde66879e74092167cc0f27a1f11ce/vmlinuz-4.5.0-rc5-00208-g24b8491"
dequeue_time: 2016-03-11 04:33:10.794035179 +08:00
job_state: finished
loadavg: 6.31 1.46 0.48 2/1304 2974
start_time: '1457642071'
end_time: '1457642076'
version: "/lkp/lkp/.src-20160310-210128"
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu0/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu1/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu10/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu100/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu101/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu102/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu103/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu104/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu105/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu106/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu107/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu108/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu109/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu11/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu110/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu111/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu112/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu113/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu114/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu115/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu116/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu117/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu118/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu119/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu12/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu120/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu121/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu122/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu123/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu124/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu125/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu126/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu127/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu128/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu129/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu13/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu130/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu131/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu132/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu133/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu134/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu135/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu136/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu137/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu138/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu139/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu14/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu140/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu141/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu142/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu143/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu15/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu16/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu17/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu18/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu19/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu2/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu20/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu21/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu22/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu23/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu24/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu25/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu26/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu27/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu28/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu29/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu3/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu30/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu31/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu32/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu33/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu34/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu35/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu36/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu37/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu38/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu39/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu4/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu40/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu41/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu42/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu43/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu44/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu45/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu46/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu47/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu48/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu49/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu5/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu50/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu51/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu52/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu53/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu54/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu55/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu56/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu57/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu58/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu59/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu6/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu60/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu61/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu62/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu63/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu64/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu65/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu66/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu67/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu68/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu69/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu7/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu70/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu71/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu72/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu73/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu74/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu75/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu76/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu77/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu78/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu79/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu8/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu80/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu81/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu82/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu83/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu84/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu85/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu86/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu87/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu88/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu89/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu9/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu90/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu91/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu92/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu93/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu94/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu95/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu96/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu97/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu98/cpufreq/scaling_governor
2016-03-11 04:34:28 echo performance > /sys/devices/system/cpu/cpu99/cpufreq/scaling_governor
2016-03-11 04:34:29 mkfs -t f2fs /dev/ram0
2016-03-11 04:34:30 mount -t f2fs /dev/ram0 /fs/ram0
2016-03-11 04:34:31 ./fs_mark -d /fs/ram0/1 -d /fs/ram0/2 -d /fs/ram0/3 -d /fs/ram0/4 -d /fs/ram0/5 -d /fs/ram0/6 -d /fs/ram0/7 -d /fs/ram0/8 -d /fs/ram0/9 -d /fs/ram0/10 -d /fs/ram0/11 -d /fs/ram0/12 -d /fs/ram0/13 -d /fs/ram0/14 -d /fs/ram0/15 -d /fs/ram0/16 -d /fs/ram0/17 -d /fs/ram0/18 -d /fs/ram0/19 -d /fs/ram0/20 -d /fs/ram0/21 -d /fs/ram0/22 -d /fs/ram0/23 -d /fs/ram0/24 -d /fs/ram0/25 -d /fs/ram0/26 -d /fs/ram0/27 -d /fs/ram0/28 -d /fs/ram0/29 -d /fs/ram0/30 -d /fs/ram0/31 -d /fs/ram0/32 -d /fs/ram0/33 -d /fs/ram0/34 -d /fs/ram0/35 -d /fs/ram0/36 -d /fs/ram0/37 -d /fs/ram0/38 -d /fs/ram0/39 -d /fs/ram0/40 -d /fs/ram0/41 -d /fs/ram0/42 -d /fs/ram0/43 -d /fs/ram0/44 -d /fs/ram0/45 -d /fs/ram0/46 -d /fs/ram0/47 -d /fs/ram0/48 -d /fs/ram0/49 -d /fs/ram0/50 -d /fs/ram0/51 -d /fs/ram0/52 -d /fs/ram0/53 -d /fs/ram0/54 -d /fs/ram0/55 -d /fs/ram0/56 -d /fs/ram0/57 -d /fs/ram0/58 -d /fs/ram0/59 -d /fs/ram0/60 -d /fs/ram0/61 -d /fs/ram0/62 -d /fs/ram0/63 -d /fs/ram0/64 -n 160 -L 1 -S 0 -s 4194304