From mboxrd@z Thu Jan 1 00:00:00 1970 Return-Path: Received: (majordomo@vger.kernel.org) by vger.kernel.org via listexpand id S933419AbcBABk2 (ORCPT ); Sun, 31 Jan 2016 20:40:28 -0500 Received: from mga02.intel.com ([134.134.136.20]:63767 "EHLO mga02.intel.com" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S933260AbcBABk0 (ORCPT ); Sun, 31 Jan 2016 20:40:26 -0500 X-ExtLoop1: 1 X-IronPort-AV: E=Sophos;i="5.22,378,1449561600"; d="yaml'?sh'?scan'208";a="39907329" From: kernel test robot Subject: [lkp] [f2fs] ea32c36edc: -41.5% fsmark.time.file_system_outputs CC: lkp@01.org CC: LKML CC: 0day robot TO: Jaegeuk Kim Date: Mon, 01 Feb 2016 09:40:21 +0800 Message-ID: <874mdti4xm.fsf@yhuang-dev.intel.com> User-Agent: Gnus/5.13 (Gnus v5.13) Emacs/24.5 (gnu/linux) MIME-Version: 1.0 Content-Type: multipart/mixed; boundary="=-=-=" Sender: linux-kernel-owner@vger.kernel.org List-ID: X-Mailing-List: linux-kernel@vger.kernel.org --=-=-= Content-Type: text/plain; charset=iso-8859-1 Content-Disposition: inline Content-Transfer-Encoding: quoted-printable FYI, we noticed the below changes on https://github.com/0day-ci/linux Jaegeuk-Kim/f2fs-avoid-multiple-node-page-= writes-due-to-inline_data/20160124-041711 commit ea32c36edcf58f8c27653f3e5bc41f8c0b41e235 ("f2fs: avoid multiple node= page writes due to inline_data") =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D= =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D= =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D= =3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D compiler/cpufreq_governor/disk/filesize/fs/iterations/kconfig/nr_directorie= s/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:=20 7fdec82af6a9e190e53d07a1463d2a9ac49a8750 ea32c36edcf58f8c27653f3e5bc41f8c0b41e235 7fdec82af6a9e190 ea32c36edcf58f8c27653f3e5b=20 ---------------- --------------------------=20 %stddev %change %stddev \ | \=20=20 1278 =B1 0% -3.2% 1236 =B1 0% fsmark.files_per_sec 1874824 =B1 0% -41.5% 1097506 =B1 0% fsmark.time.file_system_o= utputs 14748 =B1 2% +9.2% 16099 =B1 1% fsmark.time.involuntary_c= ontext_switches 44.50 =B1 4% +19.1% 53.00 =B1 0% fsmark.time.percent_of_cp= u_this_job_got 36.30 =B1 1% +18.6% 43.03 =B1 0% fsmark.time.system_time 870163 =B1 0% +19.6% 1041002 =B1 0% fsmark.time.voluntary_con= text_switches 22186 =B1 1% +10.4% 24490 =B1 1% vmstat.system.cs 326553 =B1 4% -10.6% 292026 =B1 0% meminfo.Active 292915 =B1 4% -11.9% 258035 =B1 0% meminfo.Active(file) 30038 =B1 10% +17.1% 35170 =B1 13% softirqs.RCU 31822 =B1 9% +16.4% 37037 =B1 13% softirqs.SCHED 143471 =B1 4% -15.6% 121104 =B1 2% numa-meminfo.node1.Active 17081 =B1 18% -21.7% 13370 =B1 13% numa-meminfo.node1.Active= (anon) 126389 =B1 2% -14.8% 107733 =B1 2% numa-meminfo.node1.Active= (file) 16928 =B1 18% -21.9% 13222 =B1 13% numa-meminfo.node1.AnonPa= ges 75337 =B1 20% -42.1% 43626 =B1 1% numa-vmstat.node0.nr_dirt= ied 4266 =B1 18% -21.8% 3338 =B1 13% numa-vmstat.node1.nr_acti= ve_anon 31597 =B1 2% -14.8% 26931 =B1 2% numa-vmstat.node1.nr_acti= ve_file 4226 =B1 18% -22.0% 3297 =B1 13% numa-vmstat.node1.nr_anon= _pages 73228 =B1 4% -11.9% 64502 =B1 0% proc-vmstat.nr_active_file 233617 =B1 0% -41.5% 136640 =B1 0% proc-vmstat.nr_dirtied 6178 =B1 0% -11.1% 5489 =B1 0% proc-vmstat.numa_pte_upda= tes 50891 =B1 0% -39.8% 30627 =B1 0% proc-vmstat.pgactivate 1874824 =B1 0% -41.5% 1097506 =B1 0% time.file_system_outputs 44.50 =B1 4% +19.1% 53.00 =B1 0% time.percent_of_cpu_this_= job_got 36.30 =B1 1% +18.6% 43.03 =B1 0% time.system_time 870163 =B1 0% +19.6% 1041002 =B1 0% time.voluntary_context_sw= itches 63126565 =B1 2% +16.8% 73717213 =B1 1% cpuidle.C1-NHM.time 49681942 =B1 1% +34.6% 66867204 =B1 3% cpuidle.C1E-NHM.time 56832 =B1 1% +20.6% 68527 =B1 5% cpuidle.C1E-NHM.usage 3.428e+08 =B1 1% +14.9% 3.938e+08 =B1 3% cpuidle.C3-NHM.time 314858 =B1 3% +32.6% 417584 =B1 11% cpuidle.C3-NHM.usage 10.96 =B1 6% +6.8% 11.70 =B1 1% turbostat.%Busy 20.82 =B1 5% +15.7% 24.10 =B1 1% turbostat.CPU%c1 28.15 =B1 4% +13.0% 31.82 =B1 3% turbostat.CPU%c3 40.07 =B1 7% -19.2% 32.38 =B1 4% turbostat.CPU%c6 9.22 =B1 6% -23.4% 7.06 =B1 3% turbostat.Pkg%pc3 36043 =B1 6% -100.0% 0.00 =B1 -1% latency_stats.avg.call_rw= sem_down_read_failed.f2fs_write_data_page.[f2fs].__f2fs_writepage.[f2fs].f2= fs_write_cache_pages.[f2fs].f2fs_write_data_pages.[f2fs].do_writepages.__fi= lemap_fdatawrite_range.filemap_write_and_wait_range.f2fs_sync_file.[f2fs].v= fs_fsync_range.do_fsync.SyS_fsync 7336 =B1 0% +698.9% 58613 =B1 1% latency_stats.hits.call_r= wsem_down_read_failed.get_node_info.[f2fs].f2fs_write_node_page.[f2fs].sync= _node_pages.[f2fs].f2fs_sync_file.[f2fs].vfs_fsync_range.do_fsync.SyS_fsync= .entry_SYSCALL_64_fastpath 22886 =B1 0% -100.0% 0.00 =B1 -1% latency_stats.hits.call_r= wsem_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_write_inlin= e_data.[f2fs].f2fs_write_data_page.[f2fs].__f2fs_writepage.[f2fs].f2fs_writ= e_cache_pages.[f2fs].f2fs_write_data_pages.[f2fs].do_writepages 0.00 =B1 -1% +Inf% 79634 =B1 0% latency_stats.hits.call_r= wsem_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_write_inlin= e_data.[f2fs].f2fs_write_end.[f2fs].generic_perform_write.__generic_file_wr= ite_iter.generic_file_write_iter.f2fs_file_write_iter.[f2fs] 75051 =B1 0% -100.0% 0.00 =B1 -1% latency_stats.hits.call_r= wsem_down_read_failed.get_node_info.[f2fs].read_node_page.[f2fs].__get_node= _page.[f2fs].get_node_page.[f2fs].get_node_page.[f2fs].update_inode_page.[f= 2fs].f2fs_write_end.[f2fs].generic_perform_write.__generic_file_write_iter.= generic_file_write_iter.f2fs_file_write_iter.[f2fs] 17214 =B1 0% +321.2% 72498 =B1 0% latency_stats.hits.call_r= wsem_down_read_failed.is_checkpointed_node.[f2fs].f2fs_sync_file.[f2fs].vfs= _fsync_range.do_fsync.SyS_fsync.entry_SYSCALL_64_fastpath 11958 =B1 0% +454.6% 66321 =B1 0% latency_stats.hits.call_r= wsem_down_read_failed.need_dentry_mark.[f2fs].sync_node_pages.[f2fs].f2fs_s= ync_file.[f2fs].vfs_fsync_range.do_fsync.SyS_fsync.entry_SYSCALL_64_fastpath 74681 =B1 0% -100.0% 8.25 =B1 61% latency_stats.hits.f2fs_w= rite_data_pages.[f2fs].do_writepages.__filemap_fdatawrite_range.filemap_wri= te_and_wait_range.f2fs_sync_file.[f2fs].vfs_fsync_range.do_fsync.SyS_fsync.= entry_SYSCALL_64_fastpath 130560 =B1 11% -100.0% 0.00 =B1 -1% latency_stats.max.call_rw= sem_down_read_failed.f2fs_write_data_page.[f2fs].__f2fs_writepage.[f2fs].f2= fs_write_cache_pages.[f2fs].f2fs_write_data_pages.[f2fs].do_writepages.__fi= lemap_fdatawrite_range.filemap_write_and_wait_range.f2fs_sync_file.[f2fs].v= fs_fsync_range.do_fsync.SyS_fsync 270069 =B1 14% -100.0% 125.25 =B1 81% latency_stats.max.f2fs_wr= ite_data_pages.[f2fs].do_writepages.__filemap_fdatawrite_range.filemap_writ= e_and_wait_range.f2fs_sync_file.[f2fs].vfs_fsync_range.do_fsync.SyS_fsync.e= ntry_SYSCALL_64_fastpath 12155740 =B1 1% -100.0% 0.00 =B1 -1% latency_stats.sum.call_rw= sem_down_read_failed.f2fs_write_data_page.[f2fs].__f2fs_writepage.[f2fs].f2= fs_write_cache_pages.[f2fs].f2fs_write_data_pages.[f2fs].do_writepages.__fi= lemap_fdatawrite_range.filemap_write_and_wait_range.f2fs_sync_file.[f2fs].v= fs_fsync_range.do_fsync.SyS_fsync 1498927 =B1 1% +858.3% 14364772 =B1 0% latency_stats.sum.call_rw= sem_down_read_failed.get_node_info.[f2fs].f2fs_write_node_page.[f2fs].sync_= node_pages.[f2fs].f2fs_sync_file.[f2fs].vfs_fsync_range.do_fsync.SyS_fsync.= entry_SYSCALL_64_fastpath 22102 =B1 9% +187.5% 63548 =B1 19% latency_stats.sum.call_rw= sem_down_read_failed.get_node_info.[f2fs].read_node_page.[f2fs].__get_node_= page.[f2fs].get_node_page.[f2fs].get_dnode_of_data.[f2fs].do_write_data_pag= e.[f2fs].f2fs_write_data_page.[f2fs].__f2fs_writepage.[f2fs].f2fs_write_cac= he_pages.[f2fs].f2fs_write_data_pages.[f2fs].do_writepages 5128495 =B1 1% -100.0% 0.00 =B1 -1% latency_stats.sum.call_rw= sem_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_write_inline= _data.[f2fs].f2fs_write_data_page.[f2fs].__f2fs_writepage.[f2fs].f2fs_write= _cache_pages.[f2fs].f2fs_write_data_pages.[f2fs].do_writepages 0.00 =B1 -1% +Inf% 29676287 =B1 0% latency_stats.sum.call_rw= sem_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_write_inline= _data.[f2fs].f2fs_write_end.[f2fs].generic_perform_write.__generic_file_wri= te_iter.generic_file_write_iter.f2fs_file_write_iter.[f2fs] 24113264 =B1 1% -100.0% 0.00 =B1 -1% latency_stats.sum.call_rw= sem_down_read_failed.get_node_info.[f2fs].read_node_page.[f2fs].__get_node_= page.[f2fs].get_node_page.[f2fs].get_node_page.[f2fs].update_inode_page.[f2= fs].f2fs_write_end.[f2fs].generic_perform_write.__generic_file_write_iter.g= eneric_file_write_iter.f2fs_file_write_iter.[f2fs] 11707 =B1 6% +229.8% 38617 =B1 24% latency_stats.sum.call_rw= sem_down_read_failed.get_node_info.[f2fs].write_data_page.[f2fs].do_write_d= ata_page.[f2fs].f2fs_write_data_page.[f2fs].__f2fs_writepage.[f2fs].f2fs_wr= ite_cache_pages.[f2fs].f2fs_write_data_pages.[f2fs].do_writepages.__filemap= _fdatawrite_range.filemap_fdatawrite.sync_dirty_inodes.[f2fs] 3670765 =B1 0% +549.9% 23857878 =B1 0% latency_stats.sum.call_rw= sem_down_read_failed.is_checkpointed_node.[f2fs].f2fs_sync_file.[f2fs].vfs_= fsync_range.do_fsync.SyS_fsync.entry_SYSCALL_64_fastpath 2546436 =B1 0% +680.8% 19883041 =B1 0% latency_stats.sum.call_rw= sem_down_read_failed.need_dentry_mark.[f2fs].sync_node_pages.[f2fs].f2fs_sy= nc_file.[f2fs].vfs_fsync_range.do_fsync.SyS_fsync.entry_SYSCALL_64_fastpath 5243465 =B1 2% +258.7% 18809634 =B1 1% latency_stats.sum.call_rw= sem_down_read_failed.need_inode_block_update.[f2fs].f2fs_sync_file.[f2fs].v= fs_fsync_range.do_fsync.SyS_fsync.entry_SYSCALL_64_fastpath 13216 =B1 86% -58.0% 5547 =B1 26% latency_stats.sum.call_rw= sem_down_write_failed.f2fs_init_extent_tree.[f2fs].f2fs_new_inode.[f2fs].f2= fs_create.[f2fs].vfs_create.path_openat.do_filp_open.do_sys_open.SyS_open.e= ntry_SYSCALL_64_fastpath 3020759 =B1 2% +333.5% 13096379 =B1 0% latency_stats.sum.call_rw= sem_down_write_failed.set_node_addr.[f2fs].f2fs_write_node_page.[f2fs].sync= _node_pages.[f2fs].f2fs_sync_file.[f2fs].vfs_fsync_range.do_fsync.SyS_fsync= .entry_SYSCALL_64_fastpath 1.722e+08 =B1 2% -100.0% 630.50 =B1 92% latency_stats.sum.f2fs_wr= ite_data_pages.[f2fs].do_writepages.__filemap_fdatawrite_range.filemap_writ= e_and_wait_range.f2fs_sync_file.[f2fs].vfs_fsync_range.do_fsync.SyS_fsync.e= ntry_SYSCALL_64_fastpath 896.92 =B1 10% +23.0% 1103 =B1 6% sched_debug.cfs_rq:/.exec= _clock.12 1663 =B1 9% +40.9% 2343 =B1 24% sched_debug.cfs_rq:/.exec= _clock.2 767.96 =B1 8% +16.5% 894.94 =B1 3% sched_debug.cfs_rq:/.exec= _clock.min 3.12 =B1 17% -88.0% 0.38 =B1110% sched_debug.cfs_rq:/.load= _avg.min 3666 =B1 13% +35.9% 4980 =B1 6% sched_debug.cfs_rq:/.min_= vruntime.12 4101 =B1 10% +60.7% 6589 =B1 26% sched_debug.cfs_rq:/.min_= vruntime.14 4702 =B1 7% +50.3% 7067 =B1 12% sched_debug.cfs_rq:/.min_= vruntime.15 7043 =B1 14% +25.9% 8870 =B1 11% sched_debug.cfs_rq:/.min_= vruntime.2 4100 =B1 4% +48.3% 6081 =B1 15% sched_debug.cfs_rq:/.min_= vruntime.9 6575 =B1 3% +17.8% 7744 =B1 3% sched_debug.cfs_rq:/.min_= vruntime.avg 3239 =B1 3% +31.0% 4242 =B1 9% sched_debug.cfs_rq:/.min_= vruntime.min 0.33 =B1141% +1175.0% 4.25 =B1 69% sched_debug.cfs_rq:/.nr_s= pread_over.2 -4695 =B1-17% -40.2% -2807 =B1-39% sched_debug.cfs_rq:/.spre= ad0.15 136.75 =B1 26% -25.8% 101.50 =B1 15% sched_debug.cfs_rq:/.util= _avg.3 48.62 =B1 21% -80.7% 9.38 =B1 59% sched_debug.cfs_rq:/.util= _avg.min 43.46 =B1 16% +60.2% 69.63 =B1 21% sched_debug.cfs_rq:/.util= _avg.stddev 9236 =B1 4% +9.8% 10143 =B1 6% sched_debug.cpu.nr_load_u= pdates.10 9179 =B1 4% +11.8% 10258 =B1 5% sched_debug.cpu.nr_load_u= pdates.14 9296 =B1 4% +9.8% 10211 =B1 4% sched_debug.cpu.nr_load_u= pdates.8 64213 =B1 7% +12.9% 72481 =B1 7% sched_debug.cpu.nr_switch= es.0 49843 =B1 2% +19.5% 59574 =B1 8% sched_debug.cpu.nr_switch= es.1 35136 =B1 10% +23.1% 43259 =B1 5% sched_debug.cpu.nr_switch= es.10 27937 =B1 6% +23.4% 34467 =B1 6% sched_debug.cpu.nr_switch= es.11 38343 =B1 10% +21.4% 46565 =B1 10% sched_debug.cpu.nr_switch= es.12 35454 =B1 10% +21.8% 43192 =B1 3% sched_debug.cpu.nr_switch= es.14 29114 =B1 7% +29.6% 37725 =B1 20% sched_debug.cpu.nr_switch= es.15 58979 =B1 5% +17.3% 69170 =B1 7% sched_debug.cpu.nr_switch= es.2 56391 =B1 5% +23.7% 69761 =B1 8% sched_debug.cpu.nr_switch= es.6 35766 =B1 9% +25.9% 45013 =B1 2% sched_debug.cpu.nr_switch= es.8 43509 =B1 5% +16.8% 50818 =B1 3% sched_debug.cpu.nr_switch= es.avg 65222 =B1 7% +12.5% 73372 =B1 7% sched_debug.cpu.nr_switch= es.max 27549 =B1 6% +18.2% 32567 =B1 3% sched_debug.cpu.nr_switch= es.min -6534 =B1 -5% +70.0% -11111 =B1 -2% sched_debug.cpu.nr_uninte= rruptible.0 -958.25 =B1-13% +42.1% -1361 =B1-10% sched_debug.cpu.nr_uninte= rruptible.1 1716 =B1 20% +46.1% 2507 =B1 6% sched_debug.cpu.nr_uninte= rruptible.10 1373 =B1 8% +56.0% 2143 =B1 10% sched_debug.cpu.nr_uninte= rruptible.11 1599 =B1 7% +71.7% 2744 =B1 6% sched_debug.cpu.nr_uninte= rruptible.12 1351 =B1 20% +52.4% 2060 =B1 3% sched_debug.cpu.nr_uninte= rruptible.13 1824 =B1 8% +40.8% 2568 =B1 4% sched_debug.cpu.nr_uninte= rruptible.14 1334 =B1 10% +68.0% 2241 =B1 4% sched_debug.cpu.nr_uninte= rruptible.15 -1140 =B1-14% +44.6% -1649 =B1 -4% sched_debug.cpu.nr_uninte= rruptible.5 -1139 =B1-15% +41.1% -1607 =B1-17% sched_debug.cpu.nr_uninte= rruptible.7 1167 =B1 13% +70.0% 1983 =B1 4% sched_debug.cpu.nr_uninte= rruptible.8 1319 =B1 7% +46.4% 1930 =B1 6% sched_debug.cpu.nr_uninte= rruptible.9 1956 =B1 8% +41.9% 2775 =B1 5% sched_debug.cpu.nr_uninte= rruptible.max -6537 =B1 -5% +70.0% -11114 =B1 -2% sched_debug.cpu.nr_uninte= rruptible.min 2035 =B1 1% +62.9% 3315 =B1 1% sched_debug.cpu.nr_uninte= rruptible.stddev 51578 =B1 2% +17.3% 60512 =B1 7% sched_debug.cpu.sched_cou= nt.1 35156 =B1 10% +24.2% 43650 =B1 4% sched_debug.cpu.sched_cou= nt.10 27959 =B1 6% +25.4% 35049 =B1 4% sched_debug.cpu.sched_cou= nt.11 38363 =B1 10% +25.0% 47965 =B1 7% sched_debug.cpu.sched_cou= nt.12 35618 =B1 9% +21.8% 43369 =B1 2% sched_debug.cpu.sched_cou= nt.14 29134 =B1 7% +34.3% 39119 =B1 18% sched_debug.cpu.sched_cou= nt.15 50741 =B1 8% +30.2% 66049 =B1 23% sched_debug.cpu.sched_cou= nt.3 62138 =B1 8% +14.3% 71037 =B1 6% sched_debug.cpu.sched_cou= nt.6 36028 =B1 9% +25.0% 45039 =B1 2% sched_debug.cpu.sched_cou= nt.8 27623 =B1 6% +18.4% 32700 =B1 3% sched_debug.cpu.sched_cou= nt.min 28067 =B1 8% +10.2% 30921 =B1 8% sched_debug.cpu.sched_goi= dle.0 21211 =B1 3% +20.1% 25465 =B1 8% sched_debug.cpu.sched_goi= dle.1 13529 =B1 10% +20.1% 16248 =B1 6% sched_debug.cpu.sched_goi= dle.10 11159 =B1 5% +21.5% 13554 =B1 6% sched_debug.cpu.sched_goi= dle.11 13666 =B1 11% +18.9% 16252 =B1 3% sched_debug.cpu.sched_goi= dle.14 11607 =B1 8% +29.2% 15001 =B1 25% sched_debug.cpu.sched_goi= dle.15 25465 =B1 6% +15.8% 29484 =B1 8% sched_debug.cpu.sched_goi= dle.2 24349 =B1 5% +22.5% 29827 =B1 10% sched_debug.cpu.sched_goi= dle.6 13756 =B1 9% +23.4% 16972 =B1 3% sched_debug.cpu.sched_goi= dle.8 18266 =B1 4% +14.8% 20973 =B1 4% sched_debug.cpu.sched_goi= dle.avg 28513 =B1 7% +11.4% 31770 =B1 7% sched_debug.cpu.sched_goi= dle.max 11005 =B1 5% +15.1% 12672 =B1 3% sched_debug.cpu.sched_goi= dle.min 15905 =B1 9% +22.8% 19533 =B1 8% sched_debug.cpu.ttwu_coun= t.12 13379 =B1 10% +22.5% 16391 =B1 9% sched_debug.cpu.ttwu_coun= t.13 15038 =B1 11% +29.0% 19395 =B1 8% sched_debug.cpu.ttwu_coun= t.14 26020 =B1 4% +22.2% 31789 =B1 3% sched_debug.cpu.ttwu_coun= t.2 25547 =B1 7% +16.5% 29762 =B1 5% sched_debug.cpu.ttwu_coun= t.3 26667 =B1 5% +31.7% 35117 =B1 9% sched_debug.cpu.ttwu_coun= t.4 26022 =B1 9% +15.1% 29953 =B1 3% sched_debug.cpu.ttwu_coun= t.5 27546 =B1 6% +31.4% 36193 =B1 8% sched_debug.cpu.ttwu_coun= t.6 25556 =B1 5% +24.9% 31908 =B1 13% sched_debug.cpu.ttwu_coun= t.7 24624 =B1 5% +18.5% 29191 =B1 3% sched_debug.cpu.ttwu_coun= t.avg 11891 =B1 7% +23.4% 14671 =B1 5% sched_debug.cpu.ttwu_coun= t.min 21466 =B1 2% +33.3% 28616 =B1 2% sched_debug.cpu.ttwu_loca= l.0 6323 =B1 9% +29.1% 8161 =B1 3% sched_debug.cpu.ttwu_loca= l.1 4485 =B1 9% +31.7% 5907 =B1 6% sched_debug.cpu.ttwu_loca= l.10 3238 =B1 3% +25.5% 4063 =B1 6% sched_debug.cpu.ttwu_loca= l.11 5061 =B1 10% +22.7% 6211 =B1 9% sched_debug.cpu.ttwu_loca= l.12 3264 =B1 10% +28.0% 4178 =B1 5% sched_debug.cpu.ttwu_loca= l.13 4339 =B1 9% +35.0% 5859 =B1 4% sched_debug.cpu.ttwu_loca= l.14 3638 =B1 10% +21.4% 4415 =B1 5% sched_debug.cpu.ttwu_loca= l.15 6344 =B1 6% +37.4% 8716 =B1 2% sched_debug.cpu.ttwu_loca= l.2 5839 =B1 9% +28.8% 7523 =B1 6% sched_debug.cpu.ttwu_loca= l.3 6459 =B1 6% +48.7% 9602 =B1 13% sched_debug.cpu.ttwu_loca= l.4 5643 =B1 9% +29.8% 7322 =B1 5% sched_debug.cpu.ttwu_loca= l.5 6341 =B1 4% +58.9% 10079 =B1 14% sched_debug.cpu.ttwu_loca= l.6 5599 =B1 4% +34.9% 7552 =B1 5% sched_debug.cpu.ttwu_loca= l.7 4901 =B1 6% +28.0% 6275 =B1 5% sched_debug.cpu.ttwu_loca= l.8 6031 =B1 3% +33.5% 8053 =B1 3% sched_debug.cpu.ttwu_loca= l.avg 21563 =B1 2% +34.9% 29080 =B1 3% sched_debug.cpu.ttwu_loca= l.max 3061 =B1 6% +29.6% 3966 =B1 4% sched_debug.cpu.ttwu_loca= l.min 4253 =B1 3% +36.5% 5807 =B1 4% sched_debug.cpu.ttwu_loca= l.stddev lkp-ne04: Nehalem-EP Memory: 12G fsmark.time.file_system_outputs 1.9e+06 **-**-*-**--***-****-***-****-***-***-****-***-****-***-***-****-= ** | * * = | 1.8e+06 ++ = | 1.7e+06 ++ = | | = | 1.6e+06 ++ = | 1.5e+06 ++ = | | = | 1.4e+06 ++ = | 1.3e+06 ++ = | | = | 1.2e+06 ++ = | 1.1e+06 ++ O OO OO = | OO OOOO OOO OOO OOOO OOO O OO O O = | 1e+06 ++---------------------------------------------------------------= -+ proc-vmstat.nr_dirtied 240000 ++----------------*--*--------------------------------------------= -+ **.***.***.****.** * *.***.***.****.***.***.***.***.****.***.***.= ** 220000 ++ = | | = | | = | 200000 ++ = | | = | 180000 ++ = | | = | 160000 ++ = | | = | | = | 140000 OO OOO OOO OOOO OOO OOO OOO OOO OOOO O = | | = | 120000 ++----------------------------------------------------------------= -+ proc-vmstat.pgactivate 55000 ++-----------------------------------------------------------------= -+ | = | **.***.***.* *.* .** .= ** 50000 ++ * : * * = | | : : = | | **.***.***.***.***.***.***.***.***.* *.***.** = | 45000 ++ * = | | = | 40000 ++ = | OO OOO OOO OOO OOO OOO = | | = | 35000 ++ = | | = | | = | 30000 ++---------------------OOO-OOO-OOO-OOO-----------------------------= -+ [*] bisect-good sample [O] bisect-bad sample To reproduce: git clone git://git.kernel.org/pub/scm/linux/kernel/git/wfg/lkp-tes= ts.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 provid= ed for informational purposes only. Any difference in system hardware or softw= are design or configuration may affect actual performance. Thanks, Ying Huang --=-=-= Content-Type: text/plain; charset=ascii Content-Disposition: attachment; filename=job.yaml --- LKP_SERVER: inn LKP_CGI_PORT: 80 LKP_CIFS_PORT: 139 testcase: fsmark default-monitors: wait: activate-monitor kmsg: uptime: iostat: 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: ea32c36edcf58f8c27653f3e5bc41f8c0b41e235 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-01-29 15:11:06.121815543 +08:00 id: 03a2baf75031b61e95f6ab2b0a9f4990556eb7c3 user: lkp compiler: gcc-4.9 head_commit: 27c52311cb3c7dd66ca9bb6b0c0b63ac2bc72051 base_commit: 92e963f50fc74041b5e9e744c330dca48e04f08d branch: linux-devel/devel-hourly-2016012903 rootfs: debian-x86_64-2015-02-07.cgz 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/ea32c36edcf58f8c27653f3e5bc41f8c0b41e235/1" 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-ea32c36edcf58f8c27653f3e5bc41f8c0b41e235-20160129-123190-1swp517-1.yaml" nr_cpu: "$(nproc)" max_uptime: 873.02 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-ea32c36edcf58f8c27653f3e5bc41f8c0b41e235-20160129-123190-1swp517-1.yaml - ARCH=x86_64 - kconfig=x86_64-rhel - branch=linux-devel/devel-hourly-2016012903 - commit=ea32c36edcf58f8c27653f3e5bc41f8c0b41e235 - BOOT_IMAGE=/pkg/linux/x86_64-rhel/gcc-4.9/ea32c36edcf58f8c27653f3e5bc41f8c0b41e235/vmlinuz-4.4.0-05594-gea32c36 - max_uptime=873 - 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/ea32c36edcf58f8c27653f3e5bc41f8c0b41e235/1 - 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/ea32c36edcf58f8c27653f3e5bc41f8c0b41e235/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/ea32c36edcf58f8c27653f3e5bc41f8c0b41e235/linux-headers.cgz" repeat_to: 2 kernel: "/pkg/linux/x86_64-rhel/gcc-4.9/ea32c36edcf58f8c27653f3e5bc41f8c0b41e235/vmlinuz-4.4.0-05594-gea32c36" dequeue_time: 2016-01-29 15:33:21.154043484 +08:00 job_state: finished loadavg: 22.81 8.07 2.89 2/252 3232 start_time: '1454052843' end_time: '1454052926' version: "/lkp/lkp/.src-20160127-223853" --=-=-= Content-Type: application/x-sh Content-Disposition: attachment; filename=reproduce.sh Content-Transfer-Encoding: base64 MjAxNi0wMS0yOSAxNTozMTo0NCBlY2hvIHBlcmZvcm1hbmNlID4gL3N5cy9kZXZpY2VzL3N5c3Rl bS9jcHUvY3B1MC9jcHVmcmVxL3NjYWxpbmdfZ292ZXJub3IKMjAxNi0wMS0yOSAxNTozMTo0NCBl Y2hvIHBlcmZvcm1hbmNlID4gL3N5cy9kZXZpY2VzL3N5c3RlbS9jcHUvY3B1MS9jcHVmcmVxL3Nj YWxpbmdfZ292ZXJub3IKMjAxNi0wMS0yOSAxNTozMTo0NCBlY2hvIHBlcmZvcm1hbmNlID4gL3N5 cy9kZXZpY2VzL3N5c3RlbS9jcHUvY3B1MTAvY3B1ZnJlcS9zY2FsaW5nX2dvdmVybm9yCjIwMTYt MDEtMjkgMTU6MzE6NDQgZWNobyBwZXJmb3JtYW5jZSA+IC9zeXMvZGV2aWNlcy9zeXN0ZW0vY3B1 L2NwdTExL2NwdWZyZXEvc2NhbGluZ19nb3Zlcm5vcgoyMDE2LTAxLTI5IDE1OjMxOjQ0IGVjaG8g cGVyZm9ybWFuY2UgPiAvc3lzL2RldmljZXMvc3lzdGVtL2NwdS9jcHUxMi9jcHVmcmVxL3NjYWxp bmdfZ292ZXJub3IKMjAxNi0wMS0yOSAxNTozMTo0NCBlY2hvIHBlcmZvcm1hbmNlID4gL3N5cy9k ZXZpY2VzL3N5c3RlbS9jcHUvY3B1MTMvY3B1ZnJlcS9zY2FsaW5nX2dvdmVybm9yCjIwMTYtMDEt MjkgMTU6MzE6NDQgZWNobyBwZXJmb3JtYW5jZSA+IC9zeXMvZGV2aWNlcy9zeXN0ZW0vY3B1L2Nw dTE0L2NwdWZyZXEvc2NhbGluZ19nb3Zlcm5vcgoyMDE2LTAxLTI5IDE1OjMxOjQ0IGVjaG8gcGVy Zm9ybWFuY2UgPiAvc3lzL2RldmljZXMvc3lzdGVtL2NwdS9jcHUxNS9jcHVmcmVxL3NjYWxpbmdf Z292ZXJub3IKMjAxNi0wMS0yOSAxNTozMTo0NCBlY2hvIHBlcmZvcm1hbmNlID4gL3N5cy9kZXZp Y2VzL3N5c3RlbS9jcHUvY3B1Mi9jcHVmcmVxL3NjYWxpbmdfZ292ZXJub3IKMjAxNi0wMS0yOSAx NTozMTo0NCBlY2hvIHBlcmZvcm1hbmNlID4gL3N5cy9kZXZpY2VzL3N5c3RlbS9jcHUvY3B1My9j cHVmcmVxL3NjYWxpbmdfZ292ZXJub3IKMjAxNi0wMS0yOSAxNTozMTo0NCBlY2hvIHBlcmZvcm1h bmNlID4gL3N5cy9kZXZpY2VzL3N5c3RlbS9jcHUvY3B1NC9jcHVmcmVxL3NjYWxpbmdfZ292ZXJu b3IKMjAxNi0wMS0yOSAxNTozMTo0NCBlY2hvIHBlcmZvcm1hbmNlID4gL3N5cy9kZXZpY2VzL3N5 c3RlbS9jcHUvY3B1NS9jcHVmcmVxL3NjYWxpbmdfZ292ZXJub3IKMjAxNi0wMS0yOSAxNTozMTo0 NCBlY2hvIHBlcmZvcm1hbmNlID4gL3N5cy9kZXZpY2VzL3N5c3RlbS9jcHUvY3B1Ni9jcHVmcmVx L3NjYWxpbmdfZ292ZXJub3IKMjAxNi0wMS0yOSAxNTozMTo0NCBlY2hvIHBlcmZvcm1hbmNlID4g L3N5cy9kZXZpY2VzL3N5c3RlbS9jcHUvY3B1Ny9jcHVmcmVxL3NjYWxpbmdfZ292ZXJub3IKMjAx Ni0wMS0yOSAxNTozMTo0NCBlY2hvIHBlcmZvcm1hbmNlID4gL3N5cy9kZXZpY2VzL3N5c3RlbS9j cHUvY3B1OC9jcHVmcmVxL3NjYWxpbmdfZ292ZXJub3IKMjAxNi0wMS0yOSAxNTozMTo0NCBlY2hv IHBlcmZvcm1hbmNlID4gL3N5cy9kZXZpY2VzL3N5c3RlbS9jcHUvY3B1OS9jcHVmcmVxL3NjYWxp bmdfZ292ZXJub3IKMjAxNi0wMS0yOSAxNTozMTo0NCBta2ZzIC10IGYyZnMgL2Rldi9zZGEzCjIw MTYtMDEtMjkgMTU6MzE6NDYgbW91bnQgLXQgZjJmcyAvZGV2L3NkYTMgL2ZzL3NkYTMKMjAxNi0w MS0yOSAxNTozMTo0NyAuL2ZzX21hcmsgLWQgL2ZzL3NkYTMvMSAtZCAvZnMvc2RhMy8yIC1kIC9m cy9zZGEzLzMgLWQgL2ZzL3NkYTMvNCAtZCAvZnMvc2RhMy81IC1kIC9mcy9zZGEzLzYgLWQgL2Zz L3NkYTMvNyAtZCAvZnMvc2RhMy84IC1kIC9mcy9zZGEzLzkgLWQgL2ZzL3NkYTMvMTAgLWQgL2Zz L3NkYTMvMTEgLWQgL2ZzL3NkYTMvMTIgLWQgL2ZzL3NkYTMvMTMgLWQgL2ZzL3NkYTMvMTQgLWQg L2ZzL3NkYTMvMTUgLWQgL2ZzL3NkYTMvMTYgLWQgL2ZzL3NkYTMvMTcgLWQgL2ZzL3NkYTMvMTgg LWQgL2ZzL3NkYTMvMTkgLWQgL2ZzL3NkYTMvMjAgLWQgL2ZzL3NkYTMvMjEgLWQgL2ZzL3NkYTMv MjIgLWQgL2ZzL3NkYTMvMjMgLWQgL2ZzL3NkYTMvMjQgLWQgL2ZzL3NkYTMvMjUgLWQgL2ZzL3Nk YTMvMjYgLWQgL2ZzL3NkYTMvMjcgLWQgL2ZzL3NkYTMvMjggLWQgL2ZzL3NkYTMvMjkgLWQgL2Zz L3NkYTMvMzAgLWQgL2ZzL3NkYTMvMzEgLWQgL2ZzL3NkYTMvMzIgLUQgMTYgLU4gMjU2IC1uIDMy MDAgLUwgMSAtUyAxIC1zIDkK --=-=-=--