[lkp] [f2fs] 60b99b486b: +1.9% fileio.requests_per_sec
FYI, we noticed the below changes on
https://git.kernel.org/pub/scm/linux/kernel/git/next/linux-next.git master
commit 60b99b486b568c13cbb7caa83cf8a12af7665f1e ("f2fs: introduce a periodic
checkpoint flow")
=
tbox_group/testcase/rootfs/kconfig/compiler/period/nr_threads/disk/fs/size/filenum/rwmode/iomode:
lkp-ws02/fileio/debian-x86_64-2015-02-07.cgz/x86_64-rhel/gcc-4.9/600s/100%/1HDD/f2fs/64G/1024f/seqrewr/sync
commit:
5c2674347466d5c2d5169214e95f4ad6dc09e9b6
60b99b486b568c13cbb7caa83cf8a12af7665f1e
5c2674347466d5c2 60b99b486b568c13cbb7caa83c
--
%stddev %change %stddev
\ |\
± 8%+279.7% 4219 ± 23% fileio.request_latency_max_ms
5656 ± 0% +1.9% 5764 ± 0% fileio.requests_per_sec
1.088e+08 ± 0% +1.9% 1.108e+08 ± 0% fileio.time.file_system_outputs
46225 ± 0% +4.9% 48473 ± 0%
fileio.time.involuntary_context_switches
3759 ± 0% +2.6% 3858 ± 1%
fileio.time.maximum_resident_set_size
47.00 ± 92%+163.8% 124.00 ± 8%
numa-vmstat.node0.workingset_refault
37306 ± 2% -10.6% 33365 ± 1% softirqs.BLOCK
328.00 ± 0% +55.5% 510.00 ± 1% time.file_system_inputs
79132 ± 17% +30.7% 103393 ± 2% numa-meminfo.node0.Active
122897 ± 10% -20.4% 97780 ± 2% numa-meminfo.node1.Active
1.45 ± 1% +3.3% 1.50 ± 1% turbostat.%Busy
0.40 ± 13% +76.1% 0.70 ± 19% turbostat.Pkg%pc3
0.12 ± 15%+638.8% 0.91 ± 16% turbostat.Pkg%pc6
83662 ± 0% +1.9% 85235 ± 0% vmstat.io.bo
626.00 ± 5% +23.0% 770.25 ± 8% vmstat.memory.buff
9980 ± 1% +2.6% 10241 ± 1% vmstat.system.cs
2.012e+08 ± 11% +25.0% 2.514e+08 ± 8% cpuidle.C1E-NHM.time
52329 ± 11% -23.6% 39994 ± 12% cpuidle.C3-NHM.usage
5227 ± 29%+413.0% 26816 ±114% cpuidle.POLL.time
336.25 ± 33% +82.5% 613.50 ± 6% cpuidle.POLL.usage
2648 ± 5% -13.8% 2283 ± 2%
proc-vmstat.kswapd_high_wmark_hit_quickly
3872 ± 1% +12.6% 4361 ± 3%
proc-vmstat.kswapd_low_wmark_hit_quickly
1072 ± 29% +30.1% 1395 ± 16% proc-vmstat.pgpgin
9856 ± 11%+350.3% 44384 ± 3% proc-vmstat.slabs_scanned
3364 ± 2% -20.9% 2660 ± 2%
slabinfo.f2fs_extent_tree.active_objs
3364 ± 2% -20.9% 2660 ± 2% slabinfo.f2fs_extent_tree.num_objs
19645 ± 0% +9.8% 21579 ± 4%
slabinfo.jbd2_revoke_record_s.num_objs
3165 ± 4% -8.7% 2891 ± 8% slabinfo.proc_inode_cache.num_objs
0.00 ± -1% +Inf%1774752 ± 7%
latency_stats.avg.call_rwsem_down_read_failed.f2fs_convert_inline_inode.[f2fs].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_pwrite64.entry_SYSCALL_64_fastpath
0.00 ± -1% +Inf%1804979 ± 68%
latency_stats.avg.get_request.blk_queue_bio.generic_make_request.submit_bio.f2fs_submit_page_bio.[f2fs].get_meta_page.[f2fs].get_node_info.[f2fs].read_node_page.[f2fs].get_node_page.[f2fs].get_dnode_of_data.[f2fs].f2fs_reserve_block.[f2fs].f2fs_get_block.[f2fs]
0.00 ± -1% +Inf%3191014 ± 6%
latency_stats.max.call_rwsem_down_read_failed.f2fs_convert_inline_inode.[f2fs].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_pwrite64.entry_SYSCALL_64_fastpath
1043277 ± 6%+294.7%4118293 ± 23%
latency_stats.max.generic_file_write_iter.f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write.SyS_pwrite64.entry_SYSCALL_64_fastpath
0.00 ± -1% +Inf%1804979 ± 68%
latency_stats.max.get_request.blk_queue_bio.generic_make_request.submit_bio.f2fs_submit_page_bio.[f2fs].get_meta_page.[f2fs].get_node_info.[f2fs].read_node_page.[f2fs].get_node_page.[f2fs].get_dnode_of_data.[f2fs].f2fs_reserve_block.[f2fs].f2fs_get_block.[f2fs]
16549 ± 50%+248.8% 57724 ±145%
latency_stats.max.rpc_wait_bit_killable.__rpc_wait_for_completion_task.nfs4_run_open_task.[nfsv4]._nfs4_open_and_get_state.[nfsv4].nfs4_do_open.[nfsv4].nfs4_atomic_open.[nfsv4].nfs4_file_open.[nfsv4].do_dentry_open.vfs_open.path_openat.do_filp_open.do_sys_open
0.00 ± -1% +Inf% 16400627 ± 7%
latency_stats.sum.call_rwsem_down_read_failed.f2fs_convert_inline_inode.[f2fs].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_pwrite64.entry_SYSCALL_64_fastpath
0.00 ± -1% +Inf%1804979 ± 68%
[lkp] [f2fs] 60b99b486b: +1.9% fileio.requests_per_sec
FYI, we noticed the below changes on
https://git.kernel.org/pub/scm/linux/kernel/git/next/linux-next.git master
commit 60b99b486b568c13cbb7caa83cf8a12af7665f1e ("f2fs: introduce a periodic
checkpoint flow")
=
tbox_group/testcase/rootfs/kconfig/compiler/period/nr_threads/disk/fs/size/filenum/rwmode/iomode:
lkp-ws02/fileio/debian-x86_64-2015-02-07.cgz/x86_64-rhel/gcc-4.9/600s/100%/1HDD/f2fs/64G/1024f/seqrewr/sync
commit:
5c2674347466d5c2d5169214e95f4ad6dc09e9b6
60b99b486b568c13cbb7caa83cf8a12af7665f1e
5c2674347466d5c2 60b99b486b568c13cbb7caa83c
--
%stddev %change %stddev
\ |\
± 8%+279.7% 4219 ± 23% fileio.request_latency_max_ms
5656 ± 0% +1.9% 5764 ± 0% fileio.requests_per_sec
1.088e+08 ± 0% +1.9% 1.108e+08 ± 0% fileio.time.file_system_outputs
46225 ± 0% +4.9% 48473 ± 0%
fileio.time.involuntary_context_switches
3759 ± 0% +2.6% 3858 ± 1%
fileio.time.maximum_resident_set_size
47.00 ± 92%+163.8% 124.00 ± 8%
numa-vmstat.node0.workingset_refault
37306 ± 2% -10.6% 33365 ± 1% softirqs.BLOCK
328.00 ± 0% +55.5% 510.00 ± 1% time.file_system_inputs
79132 ± 17% +30.7% 103393 ± 2% numa-meminfo.node0.Active
122897 ± 10% -20.4% 97780 ± 2% numa-meminfo.node1.Active
1.45 ± 1% +3.3% 1.50 ± 1% turbostat.%Busy
0.40 ± 13% +76.1% 0.70 ± 19% turbostat.Pkg%pc3
0.12 ± 15%+638.8% 0.91 ± 16% turbostat.Pkg%pc6
83662 ± 0% +1.9% 85235 ± 0% vmstat.io.bo
626.00 ± 5% +23.0% 770.25 ± 8% vmstat.memory.buff
9980 ± 1% +2.6% 10241 ± 1% vmstat.system.cs
2.012e+08 ± 11% +25.0% 2.514e+08 ± 8% cpuidle.C1E-NHM.time
52329 ± 11% -23.6% 39994 ± 12% cpuidle.C3-NHM.usage
5227 ± 29%+413.0% 26816 ±114% cpuidle.POLL.time
336.25 ± 33% +82.5% 613.50 ± 6% cpuidle.POLL.usage
2648 ± 5% -13.8% 2283 ± 2%
proc-vmstat.kswapd_high_wmark_hit_quickly
3872 ± 1% +12.6% 4361 ± 3%
proc-vmstat.kswapd_low_wmark_hit_quickly
1072 ± 29% +30.1% 1395 ± 16% proc-vmstat.pgpgin
9856 ± 11%+350.3% 44384 ± 3% proc-vmstat.slabs_scanned
3364 ± 2% -20.9% 2660 ± 2%
slabinfo.f2fs_extent_tree.active_objs
3364 ± 2% -20.9% 2660 ± 2% slabinfo.f2fs_extent_tree.num_objs
19645 ± 0% +9.8% 21579 ± 4%
slabinfo.jbd2_revoke_record_s.num_objs
3165 ± 4% -8.7% 2891 ± 8% slabinfo.proc_inode_cache.num_objs
0.00 ± -1% +Inf%1774752 ± 7%
latency_stats.avg.call_rwsem_down_read_failed.f2fs_convert_inline_inode.[f2fs].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_pwrite64.entry_SYSCALL_64_fastpath
0.00 ± -1% +Inf%1804979 ± 68%
latency_stats.avg.get_request.blk_queue_bio.generic_make_request.submit_bio.f2fs_submit_page_bio.[f2fs].get_meta_page.[f2fs].get_node_info.[f2fs].read_node_page.[f2fs].get_node_page.[f2fs].get_dnode_of_data.[f2fs].f2fs_reserve_block.[f2fs].f2fs_get_block.[f2fs]
0.00 ± -1% +Inf%3191014 ± 6%
latency_stats.max.call_rwsem_down_read_failed.f2fs_convert_inline_inode.[f2fs].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_pwrite64.entry_SYSCALL_64_fastpath
1043277 ± 6%+294.7%4118293 ± 23%
latency_stats.max.generic_file_write_iter.f2fs_file_write_iter.[f2fs].__vfs_write.vfs_write.SyS_pwrite64.entry_SYSCALL_64_fastpath
0.00 ± -1% +Inf%1804979 ± 68%
latency_stats.max.get_request.blk_queue_bio.generic_make_request.submit_bio.f2fs_submit_page_bio.[f2fs].get_meta_page.[f2fs].get_node_info.[f2fs].read_node_page.[f2fs].get_node_page.[f2fs].get_dnode_of_data.[f2fs].f2fs_reserve_block.[f2fs].f2fs_get_block.[f2fs]
16549 ± 50%+248.8% 57724 ±145%
latency_stats.max.rpc_wait_bit_killable.__rpc_wait_for_completion_task.nfs4_run_open_task.[nfsv4]._nfs4_open_and_get_state.[nfsv4].nfs4_do_open.[nfsv4].nfs4_atomic_open.[nfsv4].nfs4_file_open.[nfsv4].do_dentry_open.vfs_open.path_openat.do_filp_open.do_sys_open
0.00 ± -1% +Inf% 16400627 ± 7%
latency_stats.sum.call_rwsem_down_read_failed.f2fs_convert_inline_inode.[f2fs].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_pwrite64.entry_SYSCALL_64_fastpath
0.00 ± -1% +Inf%1804979 ± 68%
