[<prev] [next>] [day] [month] [year] [list]
Message-ID: <87vb57yk6w.fsf@yhuang-dev.intel.com>
Date: Mon, 29 Feb 2016 16:50:15 +0800
From: kernel test robot <ying.huang@...ux.intel.com>
TO: Lokesh Jaliminche <lokesh.jaliminche@...il.com>
CC: Theodore Ts'o <tytso@....edu>
Subject: [lkp] [ext4] 1f2d779fed: +34.0% fsmark.files_per_sec
FYI, we noticed the below changes on
https://git.kernel.org/pub/scm/linux/kernel/git/next/linux-next.git master
commit 1f2d779fed21806ffed84aa65617c6125f480e85 ("ext4: optimize group search for inode allocation")
=========================================================================================
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/ext4/1x/x86_64-rhel/16d/256fpd/32t/debian-x86_64-2015-02-07.cgz/fsyncBeforeClose/lkp-ne04/400M/fsmark
commit:
29c6eaffc8868ef6fa71997d0ea507a02c52712c
1f2d779fed21806ffed84aa65617c6125f480e85
29c6eaffc8868ef6 1f2d779fed21806ffed84aa656
---------------- --------------------------
%stddev %change %stddev
\ | \
1479204 ± 11% +47.7% 2184108 ± 7% fsmark.app_overhead
148.78 ± 3% +34.0% 199.38 ± 2% fsmark.files_per_sec
693.79 ± 3% -26.1% 512.52 ± 2% fsmark.time.elapsed_time
693.79 ± 3% -26.1% 512.52 ± 2% fsmark.time.elapsed_time.max
264.00 ± 0% +11372.0% 30286 ± 15% fsmark.time.file_system_inputs
2.00 ± 0% +100.0% 4.00 ± 0% fsmark.time.percent_of_cpu_this_job_got
408852 ± 1% +19.0% 486551 ± 0% fsmark.time.voluntary_context_switches
42686 ± 4% -9.2% 38753 ± 1% softirqs.RCU
43495 ± 3% -6.4% 40722 ± 4% softirqs.SCHED
717.23 ± 3% -24.2% 543.65 ± 2% uptime.boot
9657 ± 4% -28.5% 6902 ± 3% uptime.idle
3817 ± 1% +26.2% 4819 ± 2% vmstat.system.cs
431.50 ± 1% +31.4% 567.00 ± 4% vmstat.system.in
620517 ± 4% -23.2% 476762 ± 1% numa-numastat.node0.local_node
620519 ± 4% -23.2% 476763 ± 1% numa-numastat.node0.numa_hit
783065 ± 5% -24.2% 593500 ± 3% numa-numastat.node1.local_node
783066 ± 5% -24.2% 593500 ± 3% numa-numastat.node1.numa_hit
36911353 ± 8% +61.1% 59481022 ± 5% cpuidle.C1E-NHM.time
9758 ± 5% +41.5% 13810 ± 2% cpuidle.C1E-NHM.usage
4.406e+08 ± 5% +34.7% 5.934e+08 ± 5% cpuidle.C3-NHM.time
112418 ± 3% +50.3% 168929 ± 1% cpuidle.C3-NHM.usage
1.049e+10 ± 3% -29.3% 7.418e+09 ± 3% cpuidle.C6-NHM.time
81277 ± 3% -20.9% 64279 ± 2% cpuidle.POLL.usage
1059 ± 5% -8.8% 965.75 ± 7% slabinfo.blkdev_requests.num_objs
638.25 ± 4% +34.7% 859.75 ± 8% slabinfo.dquot.active_objs
638.50 ± 4% +38.5% 884.25 ± 7% slabinfo.dquot.num_objs
2026 ± 13% -26.9% 1480 ± 9% slabinfo.jbd2_journal_head.active_objs
2061 ± 12% -25.8% 1529 ± 9% slabinfo.jbd2_journal_head.num_objs
2780 ± 2% +11.5% 3099 ± 3% slabinfo.kmalloc-256.active_objs
0.82 ± 2% +40.4% 1.16 ± 4% turbostat.%Busy
22.25 ± 3% +40.4% 31.25 ± 6% turbostat.Avg_MHz
2.69 ± 5% +49.3% 4.01 ± 6% turbostat.CPU%c1
6.79 ± 2% +73.8% 11.81 ± 8% turbostat.CPU%c3
28.16 ± 3% +21.5% 34.22 ± 3% turbostat.Pkg%pc3
33.39 ± 2% -41.9% 19.41 ± 12% turbostat.Pkg%pc6
693.79 ± 3% -26.1% 512.52 ± 2% time.elapsed_time
693.79 ± 3% -26.1% 512.52 ± 2% time.elapsed_time.max
264.00 ± 0% +11372.0% 30286 ± 15% time.file_system_inputs
2.00 ± 0% +100.0% 4.00 ± 0% time.percent_of_cpu_this_job_got
17.25 ± 1% +21.9% 21.03 ± 2% time.system_time
1.14 ± 2% +33.8% 1.53 ± 12% time.user_time
408852 ± 1% +19.0% 486551 ± 0% time.voluntary_context_switches
1400397 ± 3% -23.9% 1066153 ± 2% proc-vmstat.numa_hit
1400394 ± 3% -23.9% 1066151 ± 2% proc-vmstat.numa_local
247146 ± 4% -23.1% 190110 ± 1% proc-vmstat.pgalloc_dma32
1235243 ± 4% -23.6% 943649 ± 2% proc-vmstat.pgalloc_normal
1461923 ± 4% -25.7% 1086000 ± 2% proc-vmstat.pgfault
1314409 ± 4% -26.9% 961033 ± 2% proc-vmstat.pgfree
132.00 ± 0% +11365.9% 15135 ± 15% proc-vmstat.pgpgin
3926356 ± 18% -38.5% 2413806 ± 16% proc-vmstat.pgpgout
141.50 ± 16% +1078.3% 1667 ± 52% numa-vmstat.node0.nr_shmem
22694 ± 0% -17.7% 18679 ± 11% numa-vmstat.node0.nr_slab_reclaimable
6899 ± 1% -12.3% 6049 ± 1% numa-vmstat.node0.nr_slab_unreclaimable
447024 ± 4% -13.7% 385841 ± 4% numa-vmstat.node0.numa_hit
384765 ± 5% -15.8% 323917 ± 4% numa-vmstat.node0.numa_local
63402 ± 1% +19.2% 75581 ± 11% numa-vmstat.node1.nr_file_pages
2160 ± 0% -71.6% 613.25 ±143% numa-vmstat.node1.nr_inactive_anon
48098 ± 2% +28.5% 61803 ± 12% numa-vmstat.node1.nr_inactive_file
2373 ± 0% -31.3% 1630 ± 25% numa-vmstat.node1.nr_mapped
2207 ± 1% -70.1% 659.50 ±133% numa-vmstat.node1.nr_shmem
5466 ± 4% +78.8% 9772 ± 24% numa-vmstat.node1.nr_slab_reclaimable
4392 ± 1% +20.0% 5272 ± 1% numa-vmstat.node1.nr_slab_unreclaimable
523487 ± 1% -20.1% 418465 ± 6% numa-vmstat.node1.numa_hit
519756 ± 1% -20.2% 414604 ± 6% numa-vmstat.node1.numa_local
90778 ± 0% -17.7% 74720 ± 11% numa-meminfo.node0.SReclaimable
27598 ± 1% -12.3% 24198 ± 1% numa-meminfo.node0.SUnreclaim
567.50 ± 16% +1075.3% 6670 ± 52% numa-meminfo.node0.Shmem
118377 ± 0% -16.4% 98919 ± 9% numa-meminfo.node0.Slab
253611 ± 1% +19.2% 302328 ± 11% numa-meminfo.node1.FilePages
201041 ± 2% +24.2% 249668 ± 13% numa-meminfo.node1.Inactive
8645 ± 0% -71.6% 2454 ±143% numa-meminfo.node1.Inactive(anon)
192396 ± 2% +28.5% 247214 ± 12% numa-meminfo.node1.Inactive(file)
2197 ± 15% +25.2% 2752 ± 7% numa-meminfo.node1.KernelStack
9494 ± 0% -31.3% 6524 ± 25% numa-meminfo.node1.Mapped
345480 ± 1% +20.3% 415555 ± 10% numa-meminfo.node1.MemUsed
21865 ± 4% +78.8% 39089 ± 24% numa-meminfo.node1.SReclaimable
17570 ± 1% +20.0% 21091 ± 1% numa-meminfo.node1.SUnreclaim
8830 ± 1% -70.1% 2640 ±133% numa-meminfo.node1.Shmem
39436 ± 2% +52.6% 60181 ± 16% numa-meminfo.node1.Slab
25609 ±155% -99.0% 247.00 ±173% latency_stats.avg.do_get_write_access.jbd2_journal_get_write_access.__ext4_journal_get_write_access.ext4_reserve_inode_write.ext4_mark_inode_dirty.ext4_dirty_inode.__mark_inode_dirty.generic_update_time.file_update_time.__generic_file_write_iter.ext4_file_write_iter.__vfs_write
34613 ± 17% -93.2% 2366 ±100% latency_stats.avg.submit_bio_wait.blkdev_issue_flush.ext4_sync_file.vfs_fsync_range.do_fsync.SyS_fsync.entry_SYSCALL_64_fastpath
62402 ± 14% -100.0% 0.00 ± -1% latency_stats.avg.submit_bio_wait.blkdev_issue_flush.jbd2_cleanup_journal_tail.jbd2_log_do_checkpoint.__jbd2_log_wait_for_space.add_transaction_credits.start_this_handle.jbd2__journal_start.__ext4_journal_start_sb.__ext4_new_inode.ext4_create.vfs_create
85292 ± 16% -100.0% 0.00 ± -1% latency_stats.avg.submit_bio_wait.blkdev_issue_flush.jbd2_cleanup_journal_tail.jbd2_log_do_checkpoint.__jbd2_log_wait_for_space.add_transaction_credits.start_this_handle.jbd2__journal_start.__ext4_journal_start_sb.ext4_da_write_begin.generic_perform_write.__generic_file_write_iter
233836 ± 9% -100.0% 0.00 ± -1% latency_stats.avg.submit_bio_wait.blkdev_issue_flush.jbd2_cleanup_journal_tail.jbd2_log_do_checkpoint.__jbd2_log_wait_for_space.add_transaction_credits.start_this_handle.jbd2__journal_start.__ext4_journal_start_sb.ext4_dirty_inode.__mark_inode_dirty.generic_update_time
98586 ± 15% -100.0% 0.00 ± -1% latency_stats.avg.submit_bio_wait.blkdev_issue_flush.jbd2_cleanup_journal_tail.jbd2_log_do_checkpoint.__jbd2_log_wait_for_space.add_transaction_credits.start_this_handle.jbd2__journal_start.__ext4_journal_start_sb.ext4_writepages.do_writepages.__filemap_fdatawrite_range
138727 ± 20% -99.7% 356.50 ± 34% latency_stats.avg.wait_transaction_locked.add_transaction_credits.start_this_handle.jbd2__journal_start.__ext4_journal_start_sb.ext4_dirty_inode.__mark_inode_dirty.generic_update_time.file_update_time.__generic_file_write_iter.ext4_file_write_iter.__vfs_write
0.00 ± -1% +Inf% 7289 ± 37% latency_stats.hits.do_get_write_access.jbd2_journal_get_write_access.__ext4_journal_get_write_access.ext4_reserve_inode_write.ext4_mark_inode_dirty.add_dirent_to_buf.ext4_dx_add_entry.ext4_add_entry.ext4_add_nondir.ext4_create.vfs_create.path_openat
27954 ± 1% -86.6% 3734 ± 49% latency_stats.hits.ext4_mb_initialize_context.ext4_mb_new_blocks.ext4_ext_map_blocks.ext4_map_blocks.ext4_writepages.do_writepages.__filemap_fdatawrite_range.filemap_write_and_wait_range.ext4_sync_file.vfs_fsync_range.do_fsync.SyS_fsync
290546 ± 16% -85.7% 41420 ± 36% latency_stats.max.do_get_write_access.jbd2_journal_get_write_access.__ext4_journal_get_write_access.__ext4_new_inode.ext4_create.vfs_create.path_openat.do_filp_open.do_sys_open.SyS_open.entry_SYSCALL_64_fastpath
265287 ± 9% -85.9% 37329 ± 63% latency_stats.max.do_get_write_access.jbd2_journal_get_write_access.__ext4_journal_get_write_access.ext4_mb_mark_diskspace_used.ext4_mb_new_blocks.ext4_ext_map_blocks.ext4_map_blocks.ext4_writepages.do_writepages.__filemap_fdatawrite_range.filemap_write_and_wait_range.ext4_sync_file
0.00 ± -1% +Inf% 16683 ± 61% latency_stats.max.do_get_write_access.jbd2_journal_get_write_access.__ext4_journal_get_write_access.ext4_reserve_inode_write.ext4_mark_inode_dirty.add_dirent_to_buf.ext4_add_entry.ext4_add_nondir.ext4_create.vfs_create.path_openat.do_filp_open
0.00 ± -1% +Inf% 29279 ± 73% latency_stats.max.do_get_write_access.jbd2_journal_get_write_access.__ext4_journal_get_write_access.ext4_reserve_inode_write.ext4_mark_inode_dirty.add_dirent_to_buf.ext4_dx_add_entry.ext4_add_entry.ext4_add_nondir.ext4_create.vfs_create.path_openat
63561 ±165% -99.6% 267.75 ±173% latency_stats.max.do_get_write_access.jbd2_journal_get_write_access.__ext4_journal_get_write_access.ext4_reserve_inode_write.ext4_mark_inode_dirty.ext4_dirty_inode.__mark_inode_dirty.generic_update_time.file_update_time.__generic_file_write_iter.ext4_file_write_iter.__vfs_write
62202 ± 74% -95.4% 2841 ± 21% latency_stats.max.do_get_write_access.jbd2_journal_get_write_access.__ext4_journal_get_write_access.ext4_reserve_inode_write.ext4_mark_inode_dirty.ext4_dirty_inode.__mark_inode_dirty.generic_write_end.ext4_da_write_end.generic_perform_write.__generic_file_write_iter.ext4_file_write_iter
0.00 ± -1% +Inf% 37841 ± 39% latency_stats.max.do_get_write_access.jbd2_journal_get_write_access.__ext4_journal_get_write_access.ext4_reserve_inode_write.ext4_mark_inode_dirty.ext4_ext_tree_init.__ext4_new_inode.ext4_create.vfs_create.path_openat.do_filp_open.do_sys_open
279828 ± 21% -94.5% 15429 ± 97% latency_stats.max.ext4_mb_initialize_context.ext4_mb_new_blocks.ext4_ext_map_blocks.ext4_map_blocks.ext4_writepages.do_writepages.__filemap_fdatawrite_range.filemap_write_and_wait_range.ext4_sync_file.vfs_fsync_range.do_fsync.SyS_fsync
176558 ± 21% -95.8% 7488 ±102% latency_stats.max.submit_bio_wait.blkdev_issue_flush.ext4_sync_file.vfs_fsync_range.do_fsync.SyS_fsync.entry_SYSCALL_64_fastpath
381747 ± 21% -100.0% 0.00 ± -1% latency_stats.max.submit_bio_wait.blkdev_issue_flush.jbd2_cleanup_journal_tail.jbd2_log_do_checkpoint.__jbd2_log_wait_for_space.add_transaction_credits.start_this_handle.jbd2__journal_start.__ext4_journal_start_sb.__ext4_new_inode.ext4_create.vfs_create
165796 ± 24% -100.0% 0.00 ± -1% latency_stats.max.submit_bio_wait.blkdev_issue_flush.jbd2_cleanup_journal_tail.jbd2_log_do_checkpoint.__jbd2_log_wait_for_space.add_transaction_credits.start_this_handle.jbd2__journal_start.__ext4_journal_start_sb.ext4_da_write_begin.generic_perform_write.__generic_file_write_iter
406817 ± 14% -100.0% 0.00 ± -1% latency_stats.max.submit_bio_wait.blkdev_issue_flush.jbd2_cleanup_journal_tail.jbd2_log_do_checkpoint.__jbd2_log_wait_for_space.add_transaction_credits.start_this_handle.jbd2__journal_start.__ext4_journal_start_sb.ext4_dirty_inode.__mark_inode_dirty.generic_update_time
165247 ± 40% -100.0% 0.00 ± -1% latency_stats.max.submit_bio_wait.blkdev_issue_flush.jbd2_cleanup_journal_tail.jbd2_log_do_checkpoint.__jbd2_log_wait_for_space.add_transaction_credits.start_this_handle.jbd2__journal_start.__ext4_journal_start_sb.ext4_writepages.do_writepages.__filemap_fdatawrite_range
324551 ± 12% -91.2% 28575 ± 43% latency_stats.max.wait_transaction_locked.add_transaction_credits.start_this_handle.jbd2__journal_start.__ext4_journal_start_sb.__ext4_new_inode.ext4_create.vfs_create.path_openat.do_filp_open.do_sys_open.SyS_open
458237 ± 15% -99.5% 2140 ± 76% latency_stats.max.wait_transaction_locked.add_transaction_credits.start_this_handle.jbd2__journal_start.__ext4_journal_start_sb.ext4_dirty_inode.__mark_inode_dirty.generic_update_time.file_update_time.__generic_file_write_iter.ext4_file_write_iter.__vfs_write
234367 ± 47% -94.6% 12766 ± 80% latency_stats.max.wait_transaction_locked.add_transaction_credits.start_this_handle.jbd2__journal_start.__ext4_journal_start_sb.ext4_writepages.do_writepages.__filemap_fdatawrite_range.filemap_write_and_wait_range.ext4_sync_file.vfs_fsync_range.do_fsync
0.00 ± -1% +Inf% 23646 ±123% latency_stats.sum.do_get_write_access.jbd2_journal_get_write_access.__ext4_journal_get_write_access.ext4_mb_mark_diskspace_used.ext4_mb_new_blocks.ext4_ext_map_blocks.ext4_map_blocks.ext4_getblk.ext4_bread.ext4_append.do_split.ext4_dx_add_entry
0.00 ± -1% +Inf% 30398 ± 50% latency_stats.sum.do_get_write_access.jbd2_journal_get_write_access.__ext4_journal_get_write_access.ext4_mb_mark_diskspace_used.ext4_mb_new_blocks.ext4_ext_map_blocks.ext4_map_blocks.ext4_getblk.ext4_bread.ext4_append.ext4_mkdir.vfs_mkdir
0.00 ± -1% +Inf% 56525 ±105% latency_stats.sum.do_get_write_access.jbd2_journal_get_write_access.__ext4_journal_get_write_access.ext4_mb_mark_diskspace_used.ext4_mb_new_blocks.ext4_ext_map_blocks.ext4_map_blocks.ext4_getblk.ext4_bread.ext4_append.make_indexed_dir.ext4_add_entry
41228828 ± 7% -92.4% 3149423 ± 67% latency_stats.sum.do_get_write_access.jbd2_journal_get_write_access.__ext4_journal_get_write_access.ext4_mb_mark_diskspace_used.ext4_mb_new_blocks.ext4_ext_map_blocks.ext4_map_blocks.ext4_writepages.do_writepages.__filemap_fdatawrite_range.filemap_write_and_wait_range.ext4_sync_file
0.00 ± -1% +Inf% 1241212 ± 55% latency_stats.sum.do_get_write_access.jbd2_journal_get_write_access.__ext4_journal_get_write_access.ext4_reserve_inode_write.ext4_mark_inode_dirty.add_dirent_to_buf.ext4_add_entry.ext4_add_nondir.ext4_create.vfs_create.path_openat.do_filp_open
0.00 ± -1% +Inf% 2727180 ± 46% latency_stats.sum.do_get_write_access.jbd2_journal_get_write_access.__ext4_journal_get_write_access.ext4_reserve_inode_write.ext4_mark_inode_dirty.add_dirent_to_buf.ext4_dx_add_entry.ext4_add_entry.ext4_add_nondir.ext4_create.vfs_create.path_openat
0.00 ± -1% +Inf% 88155 ± 72% latency_stats.sum.do_get_write_access.jbd2_journal_get_write_access.__ext4_journal_get_write_access.ext4_reserve_inode_write.ext4_mark_inode_dirty.ext4_dirty_inode.__mark_inode_dirty.ext4_mb_new_blocks.ext4_ext_map_blocks.ext4_map_blocks.ext4_getblk.ext4_bread
200757 ±159% -99.5% 988.25 ±173% latency_stats.sum.do_get_write_access.jbd2_journal_get_write_access.__ext4_journal_get_write_access.ext4_reserve_inode_write.ext4_mark_inode_dirty.ext4_dirty_inode.__mark_inode_dirty.generic_update_time.file_update_time.__generic_file_write_iter.ext4_file_write_iter.__vfs_write
1755344 ± 9% -94.1% 103667 ± 53% latency_stats.sum.do_get_write_access.jbd2_journal_get_write_access.__ext4_journal_get_write_access.ext4_reserve_inode_write.ext4_mark_inode_dirty.ext4_dirty_inode.__mark_inode_dirty.generic_write_end.ext4_da_write_end.generic_perform_write.__generic_file_write_iter.ext4_file_write_iter
0.00 ± -1% +Inf% 4885655 ± 35% latency_stats.sum.do_get_write_access.jbd2_journal_get_write_access.__ext4_journal_get_write_access.ext4_reserve_inode_write.ext4_mark_inode_dirty.ext4_ext_tree_init.__ext4_new_inode.ext4_create.vfs_create.path_openat.do_filp_open.do_sys_open
0.00 ± -1% +Inf% 35213 ± 40% latency_stats.sum.do_get_write_access.jbd2_journal_get_write_access.__ext4_journal_get_write_access.ext4_reserve_inode_write.ext4_mark_inode_dirty.ext4_ext_tree_init.__ext4_new_inode.ext4_mkdir.vfs_mkdir.SyS_mkdir.entry_SYSCALL_64_fastpath
35021878 ± 12% -97.3% 959921 ± 59% latency_stats.sum.ext4_mb_initialize_context.ext4_mb_new_blocks.ext4_ext_map_blocks.ext4_map_blocks.ext4_writepages.do_writepages.__filemap_fdatawrite_range.filemap_write_and_wait_range.ext4_sync_file.vfs_fsync_range.do_fsync.SyS_fsync
2610110 ± 10% -99.6% 10320 ±115% latency_stats.sum.submit_bio_wait.blkdev_issue_flush.ext4_sync_file.vfs_fsync_range.do_fsync.SyS_fsync.entry_SYSCALL_64_fastpath
7233874 ± 35% -100.0% 0.00 ± -1% latency_stats.sum.submit_bio_wait.blkdev_issue_flush.jbd2_cleanup_journal_tail.jbd2_log_do_checkpoint.__jbd2_log_wait_for_space.add_transaction_credits.start_this_handle.jbd2__journal_start.__ext4_journal_start_sb.__ext4_new_inode.ext4_create.vfs_create
1159776 ± 50% -100.0% 0.00 ± -1% latency_stats.sum.submit_bio_wait.blkdev_issue_flush.jbd2_cleanup_journal_tail.jbd2_log_do_checkpoint.__jbd2_log_wait_for_space.add_transaction_credits.start_this_handle.jbd2__journal_start.__ext4_journal_start_sb.ext4_da_write_begin.generic_perform_write.__generic_file_write_iter
822013 ± 35% -100.0% 0.00 ± -1% latency_stats.sum.submit_bio_wait.blkdev_issue_flush.jbd2_cleanup_journal_tail.jbd2_log_do_checkpoint.__jbd2_log_wait_for_space.add_transaction_credits.start_this_handle.jbd2__journal_start.__ext4_journal_start_sb.ext4_dirty_inode.__mark_inode_dirty.generic_update_time
810979 ± 49% -100.0% 0.00 ± -1% latency_stats.sum.submit_bio_wait.blkdev_issue_flush.jbd2_cleanup_journal_tail.jbd2_log_do_checkpoint.__jbd2_log_wait_for_space.add_transaction_credits.start_this_handle.jbd2__journal_start.__ext4_journal_start_sb.ext4_writepages.do_writepages.__filemap_fdatawrite_range
3757907 ± 7% -99.8% 7957 ± 37% latency_stats.sum.wait_transaction_locked.add_transaction_credits.start_this_handle.jbd2__journal_start.__ext4_journal_start_sb.ext4_dirty_inode.__mark_inode_dirty.generic_update_time.file_update_time.__generic_file_write_iter.ext4_file_write_iter.__vfs_write
1020128 ± 78% -94.6% 54940 ± 73% latency_stats.sum.wait_transaction_locked.add_transaction_credits.start_this_handle.jbd2__journal_start.__ext4_journal_start_sb.ext4_writepages.do_writepages.__filemap_fdatawrite_range.filemap_write_and_wait_range.ext4_sync_file.vfs_fsync_range.do_fsync
5691 ± 8% -22.7% 4398 ± 14% sched_debug.cfs_rq:/.exec_clock.0
854.81 ± 10% +157.0% 2196 ± 27% sched_debug.cfs_rq:/.exec_clock.11
2946 ± 3% -16.0% 2475 ± 4% sched_debug.cfs_rq:/.exec_clock.4
2075 ± 6% -19.3% 1673 ± 10% sched_debug.cfs_rq:/.exec_clock.8
2.75 ± 30% +318.2% 11.50 ± 58% sched_debug.cfs_rq:/.load_avg.1
5.25 ± 75% +266.7% 19.25 ± 20% sched_debug.cfs_rq:/.load_avg.7
12.00 ± 31% -70.8% 3.50 ± 24% sched_debug.cfs_rq:/.load_avg.8
1.25 ± 34% +860.0% 12.00 ± 33% sched_debug.cfs_rq:/.load_avg.9
0.22 ± 37% +116.7% 0.47 ± 19% sched_debug.cfs_rq:/.load_avg.min
6649 ± 29% -31.8% 4537 ± 15% sched_debug.cfs_rq:/.min_vruntime.8
7953 ± 4% -12.7% 6940 ± 3% sched_debug.cfs_rq:/.min_vruntime.avg
19991 ± 6% -22.3% 15531 ± 5% sched_debug.cfs_rq:/.min_vruntime.max
4514 ± 8% -25.9% 3343 ± 9% sched_debug.cfs_rq:/.min_vruntime.stddev
0.75 ±110% +433.3% 4.00 ± 30% sched_debug.cfs_rq:/.nr_spread_over.13
4514 ± 8% -25.9% 3343 ± 9% sched_debug.cfs_rq:/.spread0.stddev
22.00 ± 19% +104.5% 45.00 ± 19% sched_debug.cfs_rq:/.util_avg.2
361962 ± 3% -24.9% 271884 ± 0% sched_debug.cpu.clock.0
361962 ± 3% -24.9% 271883 ± 0% sched_debug.cpu.clock.1
361968 ± 3% -24.9% 271888 ± 0% sched_debug.cpu.clock.10
361969 ± 3% -24.9% 271884 ± 0% sched_debug.cpu.clock.11
361969 ± 3% -24.9% 271889 ± 0% sched_debug.cpu.clock.12
361963 ± 3% -24.9% 271887 ± 0% sched_debug.cpu.clock.13
361971 ± 3% -24.9% 271890 ± 0% sched_debug.cpu.clock.14
361966 ± 3% -24.9% 271893 ± 0% sched_debug.cpu.clock.15
361965 ± 3% -24.9% 271886 ± 0% sched_debug.cpu.clock.2
361945 ± 3% -24.9% 271880 ± 0% sched_debug.cpu.clock.3
361968 ± 3% -24.9% 271885 ± 0% sched_debug.cpu.clock.4
361964 ± 3% -24.9% 271890 ± 0% sched_debug.cpu.clock.5
361971 ± 3% -24.9% 271886 ± 0% sched_debug.cpu.clock.6
361967 ± 3% -24.9% 271890 ± 0% sched_debug.cpu.clock.7
361963 ± 3% -24.9% 271886 ± 0% sched_debug.cpu.clock.8
361965 ± 3% -24.9% 271881 ± 0% sched_debug.cpu.clock.9
361965 ± 3% -24.9% 271886 ± 0% sched_debug.cpu.clock.avg
361973 ± 3% -24.9% 271893 ± 0% sched_debug.cpu.clock.max
361913 ± 3% -24.9% 271854 ± 0% sched_debug.cpu.clock.min
15.52 ± 18% -27.6% 11.24 ± 25% sched_debug.cpu.clock.stddev
361962 ± 3% -24.9% 271884 ± 0% sched_debug.cpu.clock_task.0
361962 ± 3% -24.9% 271883 ± 0% sched_debug.cpu.clock_task.1
361968 ± 3% -24.9% 271888 ± 0% sched_debug.cpu.clock_task.10
361969 ± 3% -24.9% 271884 ± 0% sched_debug.cpu.clock_task.11
361969 ± 3% -24.9% 271889 ± 0% sched_debug.cpu.clock_task.12
361963 ± 3% -24.9% 271887 ± 0% sched_debug.cpu.clock_task.13
361971 ± 3% -24.9% 271890 ± 0% sched_debug.cpu.clock_task.14
361966 ± 3% -24.9% 271893 ± 0% sched_debug.cpu.clock_task.15
361965 ± 3% -24.9% 271886 ± 0% sched_debug.cpu.clock_task.2
361945 ± 3% -24.9% 271880 ± 0% sched_debug.cpu.clock_task.3
361968 ± 3% -24.9% 271885 ± 0% sched_debug.cpu.clock_task.4
361964 ± 3% -24.9% 271890 ± 0% sched_debug.cpu.clock_task.5
361971 ± 3% -24.9% 271886 ± 0% sched_debug.cpu.clock_task.6
361967 ± 3% -24.9% 271890 ± 0% sched_debug.cpu.clock_task.7
361963 ± 3% -24.9% 271886 ± 0% sched_debug.cpu.clock_task.8
361965 ± 3% -24.9% 271881 ± 0% sched_debug.cpu.clock_task.9
361965 ± 3% -24.9% 271886 ± 0% sched_debug.cpu.clock_task.avg
361973 ± 3% -24.9% 271893 ± 0% sched_debug.cpu.clock_task.max
361913 ± 3% -24.9% 271854 ± 0% sched_debug.cpu.clock_task.min
15.52 ± 18% -27.6% 11.24 ± 25% sched_debug.cpu.clock_task.stddev
594.58 ± 12% -30.7% 412.29 ± 12% sched_debug.cpu.curr->pid.avg
8265 ± 6% -36.1% 5285 ± 12% sched_debug.cpu.curr->pid.max
2062 ± 7% -34.6% 1348 ± 11% sched_debug.cpu.curr->pid.stddev
25768 ± 4% -11.4% 22823 ± 7% sched_debug.cpu.nr_load_updates.6
7155 ± 5% -21.9% 5586 ± 14% sched_debug.cpu.nr_load_updates.stddev
7911 ± 9% +225.8% 25779 ± 60% sched_debug.cpu.nr_switches.11
61043 ± 5% -20.1% 48763 ± 23% sched_debug.cpu.nr_switches.14
11503 ± 41% +164.9% 30476 ± 57% sched_debug.cpu.nr_switches.15
7955 ± 3% +138.1% 18945 ± 39% sched_debug.cpu.nr_switches.9
7498 ± 6% +134.5% 17581 ± 40% sched_debug.cpu.nr_switches.min
61163 ± 7% -18.1% 50102 ± 9% sched_debug.cpu.nr_switches.stddev
-33543 ± -4% -41.2% -19708 ±-38% sched_debug.cpu.nr_uninterruptible.0
3853 ± 6% -52.0% 1849 ± 41% sched_debug.cpu.nr_uninterruptible.10
86.75 ± 59% +195.4% 256.25 ± 22% sched_debug.cpu.nr_uninterruptible.11
3849 ± 10% -48.7% 1974 ± 45% sched_debug.cpu.nr_uninterruptible.12
83.25 ± 66% +253.8% 294.50 ± 31% sched_debug.cpu.nr_uninterruptible.13
3930 ± 7% -48.4% 2029 ± 42% sched_debug.cpu.nr_uninterruptible.14
77.00 ± 35% +241.6% 263.00 ± 25% sched_debug.cpu.nr_uninterruptible.15
4437 ± 11% -55.8% 1959 ± 55% sched_debug.cpu.nr_uninterruptible.2
4509 ± 5% -51.1% 2206 ± 51% sched_debug.cpu.nr_uninterruptible.4
4507 ± 9% -50.6% 2226 ± 51% sched_debug.cpu.nr_uninterruptible.6
7142 ± 6% -29.1% 5065 ± 29% sched_debug.cpu.nr_uninterruptible.8
87.25 ± 42% +204.3% 265.50 ± 24% sched_debug.cpu.nr_uninterruptible.9
7146 ± 6% -29.1% 5065 ± 29% sched_debug.cpu.nr_uninterruptible.max
-33542 ± -4% -41.2% -19707 ±-38% sched_debug.cpu.nr_uninterruptible.min
8953 ± 4% -41.4% 5250 ± 38% sched_debug.cpu.nr_uninterruptible.stddev
7958 ± 9% +224.4% 25817 ± 60% sched_debug.cpu.sched_count.11
11549 ± 40% +169.2% 31095 ± 59% sched_debug.cpu.sched_count.15
8003 ± 3% +137.1% 18980 ± 39% sched_debug.cpu.sched_count.9
7638 ± 6% +130.6% 17616 ± 40% sched_debug.cpu.sched_count.min
3539 ± 9% +217.3% 11231 ± 61% sched_debug.cpu.sched_goidle.11
5137 ± 46% +159.0% 13303 ± 59% sched_debug.cpu.sched_goidle.15
3543 ± 4% +119.8% 7789 ± 37% sched_debug.cpu.sched_goidle.9
3327 ± 5% +112.9% 7083 ± 37% sched_debug.cpu.sched_goidle.min
28088 ± 7% -18.9% 22770 ± 7% sched_debug.cpu.sched_goidle.stddev
40517 ± 77% -70.7% 11888 ± 56% sched_debug.cpu.ttwu_count.15
119597 ± 3% -30.9% 82689 ± 19% sched_debug.cpu.ttwu_local.0
4054 ± 8% +44.6% 5862 ± 23% sched_debug.cpu.ttwu_local.1
5950 ± 3% -32.2% 4036 ± 21% sched_debug.cpu.ttwu_local.10
1259 ± 9% +154.6% 3206 ± 43% sched_debug.cpu.ttwu_local.13
1530 ± 8% +126.2% 3461 ± 40% sched_debug.cpu.ttwu_local.15
8444 ± 6% -25.1% 6328 ± 12% sched_debug.cpu.ttwu_local.2
3189 ± 15% +53.0% 4878 ± 31% sched_debug.cpu.ttwu_local.3
6155 ± 9% -20.3% 4905 ± 6% sched_debug.cpu.ttwu_local.4
6013 ± 12% -32.9% 4033 ± 8% sched_debug.cpu.ttwu_local.6
9433 ± 2% -19.1% 7632 ± 8% sched_debug.cpu.ttwu_local.8
1303 ± 12% +131.5% 3016 ± 38% sched_debug.cpu.ttwu_local.9
11588 ± 2% -18.7% 9421 ± 5% sched_debug.cpu.ttwu_local.avg
119620 ± 3% -30.9% 82707 ± 19% sched_debug.cpu.ttwu_local.max
1185 ± 12% +85.3% 2196 ± 26% sched_debug.cpu.ttwu_local.min
28011 ± 3% -32.1% 19019 ± 21% sched_debug.cpu.ttwu_local.stddev
361971 ± 3% -24.9% 271891 ± 0% sched_debug.cpu_clk
360052 ± 3% -24.9% 270234 ± 0% sched_debug.ktime
361971 ± 3% -24.9% 271891 ± 0% sched_debug.sched_clk
lkp-ne04: Nehalem-EP
Memory: 12G
turbostat._Busy
1.5 ++--------------------------------------------------------------------+
| O O |
1.4 ++ O |
1.3 ++ |
| O O O O |
1.2 ++ O O O O |
| O O O O O O
1.1 O+ O O O O O O |
| O O O |
1 ++ |
| |
0.9 ++ .*.. *. .*.. *.. |
0.8 *+.*.*.. .*..*. *.*.. .*. .. *. *.*.. .. *.*..*..*.*..*
| *..* *. *..* * |
0.7 ++--------------------------------------------------------------------+
uptime.idle
10500 ++------------------------------------------------------------------+
* *.. .*.. |
10000 ++ *.. .. * *.*.. *..*.. .*..*. .*..* *. |
9500 +++ + .* + .. + *.*..*.*. *. *..|
| * * *..* * *
9000 ++ |
8500 ++ |
| |
8000 ++ O O O O |
7500 O+ O O O O O O O O O |
| O O O O O O
7000 ++ O O O O |
6500 ++ O O |
| |
6000 ++-----------------------------------O------------------------------+
fsmark.time.voluntary_context_switches
500000 ++-----------------------------------------------------------------+
490000 ++ O O O O O O O |
O O O O O O O O O O |
480000 ++ O O O O O O O O O O
470000 ++ |
| |
460000 ++ |
450000 ++ |
440000 ++ |
| |
430000 ++ |
420000 ++ .*.. *.. *. |
*.. .*.. .*.*.. .*.*..*.*..*..* + .*..*.. .. *.. |
410000 ++ * *.*. *. * * *.* *.*..|
400000 ++-----------------------------------------------------------------*
fsmark.time.file_system_inputs
40000 ++------------------------------------------------------------------+
| O |
35000 ++ |
30000 ++ O O |
| O O O O O O O |
25000 O+ O O O O O O O O O O O O
| O O |
20000 ++ O O |
| |
15000 ++ |
10000 ++ |
| |
5000 ++ |
| |
0 *+-*-*--*-*--*--*-*--*--*-*--*-*--*--*-*--*-*--*--*-*--*--*-*--*-*--*
proc-vmstat.pgpgin
20000 ++------------------------------------------------------------------+
18000 ++ O |
| |
16000 ++ O O |
14000 ++ O O O O O O O |
O O O O O O O O O O O O O
12000 ++ O O |
10000 ++ O O |
8000 ++ |
| |
6000 ++ |
4000 ++ |
| |
2000 ++ |
0 *+-*-*--*-*--*--*-*--*--*-*--*-*--*--*-*--*-*--*--*-*--*--*-*--*-*--*
proc-vmstat.pgalloc_normal
1.35e+06 ++---------------------------------------------------------------+
1.3e+06 ++ * |
* *. *..* *. .. + |
1.25e+06 ++ *.. .. *.. + + .*..*. .. * *.. |
1.2e+06 +++ + .* *.*..*.*..* *..*.*..* * *.|
| * * *
1.15e+06 ++ |
1.1e+06 ++ |
1.05e+06 ++ O O O O |
O O O O O O O O O O O O O |
1e+06 ++ O O O
950000 ++ O O O O |
| O O |
900000 ++ O |
850000 ++---------------------------------------------------------------+
[*] 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
View attachment "job.yaml" of type "text/plain" (3894 bytes)
View attachment "reproduce" of type "text/plain" (2134 bytes)
Powered by blists - more mailing lists