From mboxrd@z Thu Jan 1 00:00:00 1970 Return-Path: Received: (majordomo@vger.kernel.org) by vger.kernel.org via listexpand id S932146AbcCQFkG (ORCPT ); Thu, 17 Mar 2016 01:40:06 -0400 Received: from mga01.intel.com ([192.55.52.88]:60499 "EHLO mga01.intel.com" rhost-flags-OK-OK-OK-OK) by vger.kernel.org with ESMTP id S1751564AbcCQFkE (ORCPT ); Thu, 17 Mar 2016 01:40:04 -0400 X-ExtLoop1: 1 X-IronPort-AV: E=Sophos;i="5.24,348,1455004800"; d="yaml'?scan'208";a="935732986" Date: Thu, 17 Mar 2016 13:39:34 +0800 From: kernel test robot To: Jaegeuk Kim Cc: LKML , lkp@01.org Subject: [lkp] [f2fs] 25c1355151: +6.0% fsmark.app_overhead Message-ID: <20160317053934.GC1670@yexl-desktop> Reply-To: kernel test robot MIME-Version: 1.0 Content-Type: multipart/mixed; boundary="ikeVEW9yuYc//A+q" Content-Disposition: inline Content-Transfer-Encoding: 8bit User-Agent: Heirloom mailx 12.5 6/20/10 Sender: linux-kernel-owner@vger.kernel.org List-ID: X-Mailing-List: linux-kernel@vger.kernel.org --ikeVEW9yuYc//A+q Content-Type: text/plain; charset=iso-8859-1 Content-Disposition: inline Content-Transfer-Encoding: 8bit FYI, we noticed that fsmark.app_overhead +6.0% increasement on https://git.kernel.org/pub/scm/linux/kernel/git/jaegeuk/f2fs dev-test commit 25c13551519c66453737e038d104058f94b2e70a ("f2fs: use writepages->lock for WB_SYNC_ALL") ========================================================================================= 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/16MB/f2fs/1x/x86_64-rhel/16d/256fpd/32t/debian-x86_64-2015-02-07.cgz/fsyncBeforeClose/lkp-sb02/60G/fsmark commit: b483fadf7e913be838e11e065175205aa17e429a 25c13551519c66453737e038d104058f94b2e70a b483fadf7e913be8 25c13551519c66453737e038d1 ---------------- -------------------------- %stddev %change %stddev \ | \ 552212 ± 1% +6.0% 585551 ± 5% fsmark.app_overhead 21783 ± 1% +38.4% 30142 ± 4% fsmark.time.involuntary_context_switches 671513 ± 8% +78.6% 1199030 ± 4% fsmark.time.voluntary_context_switches 103046 ± 3% +36.4% 140590 ± 4% vmstat.memory.free 1340 ± 5% +71.5% 2299 ± 3% vmstat.system.cs 27693777 ± 11% +23.8% 34297734 ± 8% cpuidle.C1-SNB.time 1.574e+08 ± 30% +141.0% 3.794e+08 ± 16% cpuidle.POLL.time 214433 ± 9% +166.5% 571452 ± 4% cpuidle.POLL.usage 1010 ± 2% +47.4% 1489 ± 1% time.file_system_inputs 21783 ± 1% +38.4% 30142 ± 4% time.involuntary_context_switches 671513 ± 8% +78.6% 1199030 ± 4% time.voluntary_context_switches 191323 ± 6% -14.7% 163263 ± 3% meminfo.Dirty 102976 ± 3% +36.6% 140637 ± 4% meminfo.MemFree 30591 ± 0% +59.9% 48906 ± 2% meminfo.SUnreclaim 107972 ± 0% +23.8% 133628 ± 1% meminfo.Slab 4.88 ± 17% +98.1% 9.66 ± 12% turbostat.%Busy 143.78 ± 17% +100.7% 288.50 ± 12% turbostat.Avg_MHz 9.26 ± 3% +11.3% 10.31 ± 4% turbostat.CPU%c1 3.93 ± 9% +53.5% 6.03 ± 8% turbostat.CorWatt 24.40 ± 5% -20.8% 19.32 ± 5% turbostat.Pkg%pc2 7.06 ± 6% -18.4% 5.76 ± 6% turbostat.Pkg%pc3 28.14 ± 4% -22.4% 21.85 ± 5% turbostat.Pkg%pc6 7.31 ± 4% +29.2% 9.44 ± 5% turbostat.PkgWatt 344.44 ± 15% +38478.6% 132881 ± 8% slabinfo.f2fs_extent_node.active_objs 3.78 ± 20% +48240.6% 1826 ± 8% slabinfo.f2fs_extent_node.active_slabs 344.44 ± 15% +38610.4% 133335 ± 8% slabinfo.f2fs_extent_node.num_objs 3.78 ± 20% +48240.6% 1826 ± 8% slabinfo.f2fs_extent_node.num_slabs 1544 ± 0% +277.3% 5827 ± 6% slabinfo.kmalloc-256.active_objs 117.78 ± 3% +263.5% 428.10 ± 5% slabinfo.kmalloc-256.active_slabs 1892 ± 3% +262.3% 6856 ± 5% slabinfo.kmalloc-256.num_objs 117.78 ± 3% +263.5% 428.10 ± 5% slabinfo.kmalloc-256.num_slabs 295.11 ± 1% +1434.4% 4528 ± 7% slabinfo.kmalloc-4096.active_objs 39.00 ± 1% +2253.3% 917.80 ± 8% slabinfo.kmalloc-4096.active_slabs 315.00 ± 1% +1352.2% 4574 ± 7% slabinfo.kmalloc-4096.num_objs 39.00 ± 1% +2253.3% 917.80 ± 8% slabinfo.kmalloc-4096.num_slabs 93.67 ±164% +4783.1% 4573 ± 18% proc-vmstat.allocstall 110.22 ± 9% +6662.5% 7453 ± 36% proc-vmstat.kswapd_high_wmark_hit_quickly 5848 ± 1% +144.9% 14326 ± 15% proc-vmstat.kswapd_low_wmark_hit_quickly 47830 ± 6% -14.7% 40810 ± 3% proc-vmstat.nr_dirty 25744 ± 3% +36.6% 35157 ± 4% proc-vmstat.nr_free_pages 25.33 ± 26% +1126.4% 310.70 ± 15% proc-vmstat.nr_pages_scanned 7647 ± 0% +59.9% 12224 ± 2% proc-vmstat.nr_slab_unreclaimable 76857 ± 43% -60.7% 30217 ± 53% proc-vmstat.nr_vmscan_immediate_reclaim 6361 ± 0% +253.8% 22511 ± 22% proc-vmstat.pageoutrun 13101725 ± 0% +12.5% 14745650 ± 0% proc-vmstat.pgalloc_dma32 3956682 ± 0% +21.0% 4789042 ± 1% proc-vmstat.pgalloc_normal 16228928 ± 0% +15.3% 18704882 ± 0% proc-vmstat.pgfree 31211 ±107% +2261.2% 736978 ± 16% proc-vmstat.pgscan_direct_dma32 9873 ±107% +2223.3% 229380 ± 16% proc-vmstat.pgscan_direct_normal 13354 ±169% +5000.3% 681106 ± 18% proc-vmstat.pgsteal_direct_dma32 4264 ±168% +4865.8% 211768 ± 18% proc-vmstat.pgsteal_direct_normal 219420 ± 0% +2108.9% 4846809 ± 8% proc-vmstat.slabs_scanned 364381 ±132% -96.1% 14178 ±121% latency_stats.avg.alloc_nid.[f2fs].f2fs_new_inode.[f2fs].f2fs_create.[f2fs].vfs_create.path_openat.do_filp_open.do_sys_open.SyS_open.entry_SYSCALL_64_fastpath 0.00 ± -1% +Inf% 6157 ± 30% latency_stats.avg.allocate_data_block.[f2fs].do_write_page.[f2fs].write_data_page.[f2fs].do_write_data_page.[f2fs].f2fs_write_data_page.[f2fs].__f2fs_writepage.[f2fs].f2fs_write_cache_pages.[f2fs].f2fs_write_data_pages.[f2fs].do_writepages.__filemap_fdatawrite_range.filemap_write_and_wait_range.f2fs_sync_file.[f2fs] 0.00 ± -1% +Inf% 68118 ± 59% latency_stats.avg.call_rwsem_down_read_failed.f2fs_write_begin.[f2fs].generic_perform_write.__generic_file_write_iter.generic_file_write_iter.f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write.SyS_write.entry_SYSCALL_64_fastpath 19231 ± 0% +533.2% 121779 ± 65% latency_stats.avg.call_rwsem_down_write_failed.block_operations.[f2fs].write_checkpoint.[f2fs].f2fs_sync_fs.[f2fs].f2fs_sync_file.[f2fs].vfs_fsync_range.do_fsync.SyS_fsync.entry_SYSCALL_64_fastpath 0.00 ± -1% +Inf% 94391 ±101% latency_stats.avg.call_rwsem_down_write_failed.f2fs_submit_merged_bio.[f2fs].f2fs_write_data_pages.[f2fs].do_writepages.__filemap_fdatawrite_range.filemap_write_and_wait_range.f2fs_sync_file.[f2fs].vfs_fsync_range.do_fsync.SyS_fsync.entry_SYSCALL_64_fastpath 11119 ± 86% +1161.5% 140262 ± 10% latency_stats.avg.call_rwsem_down_write_failed.f2fs_submit_page_mbio.[f2fs].do_write_page.[f2fs].write_data_page.[f2fs].do_write_data_page.[f2fs].f2fs_write_data_page.[f2fs].__f2fs_writepage.[f2fs].f2fs_write_cache_pages.[f2fs].f2fs_write_data_pages.[f2fs].do_writepages.__filemap_fdatawrite_range.filemap_write_and_wait_range 23095 ± 15% -89.6% 2408 ±134% latency_stats.avg.call_rwsem_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 0.00 ± -1% +Inf% 2220210 ± 60% latency_stats.avg.f2fs_sync_fs.[f2fs].f2fs_sync_file.[f2fs].vfs_fsync_range.do_fsync.SyS_fsync.entry_SYSCALL_64_fastpath 0.00 ± -1% +Inf% 77575 ± 50% latency_stats.avg.wait_iff_congested.shrink_inactive_list.shrink_zone_memcg.shrink_zone.do_try_to_free_pages.try_to_free_pages.__alloc_pages_slowpath.__alloc_pages_nodemask.alloc_pages_current.__page_cache_alloc.pagecache_get_page.grab_cache_page_write_begin 0.00 ± -1% +Inf% 53520 ± 89% latency_stats.avg.wait_iff_congested.shrink_inactive_list.shrink_zone_memcg.shrink_zone.do_try_to_free_pages.try_to_free_pages.__alloc_pages_slowpath.__alloc_pages_nodemask.alloc_pages_current.new_slab.___slab_alloc.__slab_alloc 57788 ± 1% +221.3% 185675 ± 9% latency_stats.hits.wait_on_page_bit.__filemap_fdatawait_range.filemap_fdatawait_range.filemap_write_and_wait_range.f2fs_sync_file.[f2fs].vfs_fsync_range.do_fsync.SyS_fsync.entry_SYSCALL_64_fastpath 723355 ± 82% -73.3% 193177 ± 91% latency_stats.max.alloc_nid.[f2fs].f2fs_new_inode.[f2fs].f2fs_create.[f2fs].vfs_create.path_openat.do_filp_open.do_sys_open.SyS_open.entry_SYSCALL_64_fastpath 0.00 ± -1% +Inf% 19907 ±139% latency_stats.max.allocate_data_block.[f2fs].do_write_page.[f2fs].write_data_page.[f2fs].do_write_data_page.[f2fs].f2fs_write_data_page.[f2fs].__f2fs_writepage.[f2fs].f2fs_write_cache_pages.[f2fs].f2fs_write_data_pages.[f2fs].do_writepages.__filemap_fdatawrite_range.filemap_write_and_wait_range.f2fs_sync_file.[f2fs] 0.00 ± -1% +Inf% 150516 ± 59% latency_stats.max.call_rwsem_down_read_failed.f2fs_write_begin.[f2fs].generic_perform_write.__generic_file_write_iter.generic_file_write_iter.f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write.SyS_write.entry_SYSCALL_64_fastpath 794065 ± 51% -94.4% 44235 ±159% latency_stats.max.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.generic_file_write_iter 1014725 ± 22% -95.6% 44296 ±159% latency_stats.max.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.generic_file_write_iter.f2fs_file_write_iter.[f2fs].__vfs_write 425754 ± 97% -90.1% 42226 ±169% latency_stats.max.call_rwsem_down_read_failed.get_node_info.[f2fs].write_data_page.[f2fs].do_write_data_page.[f2fs].f2fs_write_data_page.[f2fs].__f2fs_writepage.[f2fs].f2fs_write_cache_pages.[f2fs].f2fs_write_data_pages.[f2fs].do_writepages.__filemap_fdatawrite_range.filemap_write_and_wait_range.f2fs_sync_file.[f2fs] 19231 ± 0% +4035.5% 795298 ± 80% latency_stats.max.call_rwsem_down_write_failed.block_operations.[f2fs].write_checkpoint.[f2fs].f2fs_sync_fs.[f2fs].f2fs_sync_file.[f2fs].vfs_fsync_range.do_fsync.SyS_fsync.entry_SYSCALL_64_fastpath 0.00 ± -1% +Inf% 123677 ±103% latency_stats.max.call_rwsem_down_write_failed.f2fs_submit_merged_bio.[f2fs].f2fs_write_data_pages.[f2fs].do_writepages.__filemap_fdatawrite_range.filemap_write_and_wait_range.f2fs_sync_file.[f2fs].vfs_fsync_range.do_fsync.SyS_fsync.entry_SYSCALL_64_fastpath 13652 ± 57% +9571.3% 1320329 ± 20% latency_stats.max.call_rwsem_down_write_failed.f2fs_submit_page_mbio.[f2fs].do_write_page.[f2fs].write_data_page.[f2fs].do_write_data_page.[f2fs].f2fs_write_data_page.[f2fs].__f2fs_writepage.[f2fs].f2fs_write_cache_pages.[f2fs].f2fs_write_data_pages.[f2fs].do_writepages.__filemap_fdatawrite_range.filemap_write_and_wait_range 0.00 ± -1% +Inf% 2342313 ± 61% latency_stats.max.f2fs_sync_fs.[f2fs].f2fs_sync_file.[f2fs].vfs_fsync_range.do_fsync.SyS_fsync.entry_SYSCALL_64_fastpath 192297 ± 57% +239.8% 653426 ± 32% latency_stats.max.get_request.blk_queue_bio.generic_make_request.submit_bio.__submit_merged_bio.[f2fs].f2fs_submit_merged_bio.[f2fs].f2fs_write_data_pages.[f2fs].do_writepages.__filemap_fdatawrite_range.filemap_write_and_wait_range.f2fs_sync_file.[f2fs].vfs_fsync_range 0.00 ± -1% +Inf% 78018 ± 50% latency_stats.max.wait_iff_congested.shrink_inactive_list.shrink_zone_memcg.shrink_zone.do_try_to_free_pages.try_to_free_pages.__alloc_pages_slowpath.__alloc_pages_nodemask.alloc_pages_current.__page_cache_alloc.pagecache_get_page.grab_cache_page_write_begin 0.00 ± -1% +Inf% 54060 ± 89% latency_stats.max.wait_iff_congested.shrink_inactive_list.shrink_zone_memcg.shrink_zone.do_try_to_free_pages.try_to_free_pages.__alloc_pages_slowpath.__alloc_pages_nodemask.alloc_pages_current.new_slab.___slab_alloc.__slab_alloc 4632456 ± 93% -77.6% 1037402 ±121% latency_stats.sum.alloc_nid.[f2fs].f2fs_new_inode.[f2fs].f2fs_create.[f2fs].vfs_create.path_openat.do_filp_open.do_sys_open.SyS_open.entry_SYSCALL_64_fastpath 0.00 ± -1% +Inf% 86433 ± 44% latency_stats.sum.allocate_data_block.[f2fs].do_write_page.[f2fs].write_data_page.[f2fs].do_write_data_page.[f2fs].f2fs_write_data_page.[f2fs].__f2fs_writepage.[f2fs].f2fs_write_cache_pages.[f2fs].f2fs_write_data_pages.[f2fs].do_writepages.__filemap_fdatawrite_range.filemap_write_and_wait_range.f2fs_sync_file.[f2fs] 0.00 ± -1% +Inf% 2383249 ± 92% latency_stats.sum.call_rwsem_down_read_failed.f2fs_write_begin.[f2fs].generic_perform_write.__generic_file_write_iter.generic_file_write_iter.f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write.SyS_write.entry_SYSCALL_64_fastpath 1199350 ±181% -74.2% 309546 ± 10% 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].get_read_data_page.[f2fs].find_data_page.[f2fs].f2fs_find_entry.[f2fs].f2fs_lookup.[f2fs].lookup_real.path_openat 19231 ± 0% +4037.1% 795607 ± 80% latency_stats.sum.call_rwsem_down_write_failed.block_operations.[f2fs].write_checkpoint.[f2fs].f2fs_sync_fs.[f2fs].f2fs_sync_file.[f2fs].vfs_fsync_range.do_fsync.SyS_fsync.entry_SYSCALL_64_fastpath 0.00 ± -1% +Inf% 150063 ±109% latency_stats.sum.call_rwsem_down_write_failed.f2fs_submit_merged_bio.[f2fs].f2fs_write_data_pages.[f2fs].do_writepages.__filemap_fdatawrite_range.filemap_write_and_wait_range.f2fs_sync_file.[f2fs].vfs_fsync_range.do_fsync.SyS_fsync.entry_SYSCALL_64_fastpath 13652 ± 57% +2.8e+05% 38009621 ± 12% latency_stats.sum.call_rwsem_down_write_failed.f2fs_submit_page_mbio.[f2fs].do_write_page.[f2fs].write_data_page.[f2fs].do_write_data_page.[f2fs].f2fs_write_data_page.[f2fs].__f2fs_writepage.[f2fs].f2fs_write_cache_pages.[f2fs].f2fs_write_data_pages.[f2fs].do_writepages.__filemap_fdatawrite_range.filemap_write_and_wait_range 1168485 ± 81% -58.4% 485914 ± 44% latency_stats.sum.call_rwsem_down_write_failed.get_node_info.[f2fs].new_node_page.[f2fs].new_inode_page.[f2fs].init_inode_metadata.[f2fs].__f2fs_add_link.[f2fs].f2fs_create.[f2fs].vfs_create.path_openat.do_filp_open.do_sys_open.SyS_open 3847 ± 76% +5520.0% 216250 ± 9% latency_stats.sum.call_rwsem_down_write_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].get_new_data_page.[f2fs].__f2fs_add_link.[f2fs].f2fs_create.[f2fs].vfs_create.path_openat 5857 ± 81% +5984.5% 356421 ± 57% latency_stats.sum.call_rwsem_down_write_failed.get_node_info.[f2fs].read_node_page.[f2fs].__get_node_page.[f2fs].get_node_page.[f2fs].get_dnode_of_data.[f2fs].get_read_data_page.[f2fs].find_data_page.[f2fs].f2fs_find_entry.[f2fs].f2fs_lookup.[f2fs].lookup_real.path_openat 10101346 ± 20% -90.6% 947017 ±141% latency_stats.sum.call_rwsem_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 674069 ± 79% -70.0% 202360 ± 6% latency_stats.sum.call_rwsem_down_write_failed.set_node_addr.[f2fs].new_node_page.[f2fs].new_inode_page.[f2fs].init_inode_metadata.[f2fs].__f2fs_add_link.[f2fs].f2fs_create.[f2fs].vfs_create.path_openat.do_filp_open.do_sys_open.SyS_open 0.00 ± -1% +Inf% 7065858 ± 87% latency_stats.sum.f2fs_sync_fs.[f2fs].f2fs_sync_file.[f2fs].vfs_fsync_range.do_fsync.SyS_fsync.entry_SYSCALL_64_fastpath 624892 ± 77% +875.0% 6092743 ± 31% latency_stats.sum.get_request.blk_queue_bio.generic_make_request.submit_bio.__submit_merged_bio.[f2fs].f2fs_submit_merged_bio.[f2fs].f2fs_write_data_pages.[f2fs].do_writepages.__filemap_fdatawrite_range.filemap_write_and_wait_range.f2fs_sync_file.[f2fs].vfs_fsync_range 0.00 ± -1% +Inf% 2781158 ±128% latency_stats.sum.wait_iff_congested.shrink_inactive_list.shrink_zone_memcg.shrink_zone.do_try_to_free_pages.try_to_free_pages.__alloc_pages_slowpath.__alloc_pages_nodemask.alloc_pages_current.__page_cache_alloc.pagecache_get_page.grab_cache_page_write_begin 0.00 ± -1% +Inf% 158254 ±150% latency_stats.sum.wait_iff_congested.shrink_inactive_list.shrink_zone_memcg.shrink_zone.do_try_to_free_pages.try_to_free_pages.__alloc_pages_slowpath.__alloc_pages_nodemask.alloc_pages_current.new_slab.___slab_alloc.__slab_alloc lkp-sb02: Sandy Bridge-EP Memory: 4G 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. --ikeVEW9yuYc//A+q Content-Type: text/plain; charset=us-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: 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: 25c13551519c66453737e038d104058f94b2e70a model: Sandy Bridge-EP memory: 4G hdd_partitions: "/dev/disk/by-id/ata-HDT722516DLA380_VDSD1DTCEKYAEJ-part2" swap_partitions: rootfs_partition: "/dev/disk/by-id/ata-HDT722516DLA380_VDSD1DTCEKYAEJ-part1" category: benchmark iterations: 1x nr_threads: 32t disk: 1HDD fs: f2fs fs2: fsmark: filesize: 16MB test_size: 60G sync_method: fsyncBeforeClose nr_directories: 16d nr_files_per_directory: 256fpd queue: bisect testbox: lkp-sb02 tbox_group: lkp-sb02 kconfig: x86_64-rhel enqueue_time: 2016-03-15 17:39:00.789753215 +08:00 compiler: gcc-4.9 rootfs: debian-x86_64-2015-02-07.cgz id: be4cffd59ced2eebd6f820e8a5c441cbf86589a2 user: lkp head_commit: 2ad5306156a6f5da7061b88e2c619b3830d328bd base_commit: f6cede5b49e822ebc41a099fe41ab4989f64e2cb branch: linux-devel/devel-hourly-2016031215 result_root: "/result/fsmark/performance-1x-32t-1HDD-f2fs-16MB-60G-fsyncBeforeClose-16d-256fpd/lkp-sb02/debian-x86_64-2015-02-07.cgz/x86_64-rhel/gcc-4.9/25c13551519c66453737e038d104058f94b2e70a/0" job_file: "/lkp/scheduled/lkp-sb02/bisect_fsmark-performance-1x-32t-1HDD-f2fs-16MB-60G-fsyncBeforeClose-16d-256fpd-debian-x86_64-2015-02-07.cgz-x86_64-rhel-25c13551519c66453737e038d104058f94b2e70a-20160315-22197-99wrmp-0.yaml" nr_cpu: "$(nproc)" max_uptime: 3468.8600000000006 initrd: "/osimage/debian/debian-x86_64-2015-02-07.cgz" bootloader_append: - root=/dev/ram0 - user=lkp - job=/lkp/scheduled/lkp-sb02/bisect_fsmark-performance-1x-32t-1HDD-f2fs-16MB-60G-fsyncBeforeClose-16d-256fpd-debian-x86_64-2015-02-07.cgz-x86_64-rhel-25c13551519c66453737e038d104058f94b2e70a-20160315-22197-99wrmp-0.yaml - ARCH=x86_64 - kconfig=x86_64-rhel - branch=linux-devel/devel-hourly-2016031215 - commit=25c13551519c66453737e038d104058f94b2e70a - BOOT_IMAGE=/pkg/linux/x86_64-rhel/gcc-4.9/25c13551519c66453737e038d104058f94b2e70a/vmlinuz-4.5.0-rc5-00178-g25c1355 - max_uptime=3468 - RESULT_ROOT=/result/fsmark/performance-1x-32t-1HDD-f2fs-16MB-60G-fsyncBeforeClose-16d-256fpd/lkp-sb02/debian-x86_64-2015-02-07.cgz/x86_64-rhel/gcc-4.9/25c13551519c66453737e038d104058f94b2e70a/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/25c13551519c66453737e038d104058f94b2e70a/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/25c13551519c66453737e038d104058f94b2e70a/linux-headers.cgz" repeat_to: 5 kernel: "/pkg/linux/x86_64-rhel/gcc-4.9/25c13551519c66453737e038d104058f94b2e70a/vmlinuz-4.5.0-rc5-00178-g25c1355" dequeue_time: 2016-03-15 18:02:40.532450188 +08:00 job_state: finished loadavg: 28.14 31.17 23.94 1/118 16890 start_time: '1458036196' end_time: '1458037454' version: "/lkp/lkp/.src-20160315-155314" --ikeVEW9yuYc//A+q Content-Type: text/plain; charset=us-ascii Content-Disposition: attachment; filename=reproduce 2016-03-15 18:03:12 echo performance > /sys/devices/system/cpu/cpu0/cpufreq/scaling_governor 2016-03-15 18:03:12 echo performance > /sys/devices/system/cpu/cpu1/cpufreq/scaling_governor 2016-03-15 18:03:12 echo performance > /sys/devices/system/cpu/cpu2/cpufreq/scaling_governor 2016-03-15 18:03:12 echo performance > /sys/devices/system/cpu/cpu3/cpufreq/scaling_governor 2016-03-15 18:03:12 mkfs -t f2fs /dev/sda2 2016-03-15 18:03:15 mount -t f2fs /dev/sda2 /fs/sda2 2016-03-15 18:03:16 ./fs_mark -d /fs/sda2/1 -d /fs/sda2/2 -d /fs/sda2/3 -d /fs/sda2/4 -d /fs/sda2/5 -d /fs/sda2/6 -d /fs/sda2/7 -d /fs/sda2/8 -d /fs/sda2/9 -d /fs/sda2/10 -d /fs/sda2/11 -d /fs/sda2/12 -d /fs/sda2/13 -d /fs/sda2/14 -d /fs/sda2/15 -d /fs/sda2/16 -d /fs/sda2/17 -d /fs/sda2/18 -d /fs/sda2/19 -d /fs/sda2/20 -d /fs/sda2/21 -d /fs/sda2/22 -d /fs/sda2/23 -d /fs/sda2/24 -d /fs/sda2/25 -d /fs/sda2/26 -d /fs/sda2/27 -d /fs/sda2/28 -d /fs/sda2/29 -d /fs/sda2/30 -d /fs/sda2/31 -d /fs/sda2/32 -D 16 -N 256 -n 120 -L 1 -S 1 -s 16777216 --ikeVEW9yuYc//A+q--