lists.openwall.net   lists  /  announce  owl-users  owl-dev  john-users  john-dev  passwdqc-users  yescrypt  popa3d-users  /  oss-security  kernel-hardening  musl  sabotage  tlsify  passwords  /  crypt-dev  xvendor  /  Bugtraq  Full-Disclosure  linux-kernel  linux-netdev  linux-ext4  linux-hardening  linux-cve-announce  PHC 
Open Source and information security mailing list archives
 
Hash Suite: Windows password security audit tool. GUI, reports in PDF.
[<prev] [next>] [day] [month] [year] [list]
Date:   Fri, 28 Jan 2022 16:09:51 +0800
From:   kernel test robot <oliver.sang@...el.com>
To:     Chuck Lever <chuck.lever@...cle.com>
Cc:     LKML <linux-kernel@...r.kernel.org>, lkp@...ts.01.org,
        lkp@...el.com, ying.huang@...el.com, feng.tang@...el.com,
        zhengjun.xing@...ux.intel.com, fengwei.yin@...el.com
Subject: [nfsd]  58f258f652:  fsmark.files_per_sec 19.1% improvement



Greeting,

FYI, we noticed a 19.1% improvement of fsmark.files_per_sec due to commit:


commit: 58f258f65267542959487dbe8b5641754411843d ("Revert "nfsd: skip some unnecessary stats in the v4 case"")
https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git master

in testcase: fsmark
on test machine: 128 threads 2 sockets Intel(R) Xeon(R) Gold 6338 CPU @ 2.00GHz with 256G memory
with following parameters:

	iterations: 1x
	nr_threads: 1t
	disk: 1BRD_32G
	fs: ext4
	fs2: nfsv4
	filesize: 4K
	test_size: 4G
	sync_method: fsyncBeforeClose
	nr_files_per_directory: 1fpd
	cpufreq_governor: performance
	ucode: 0xd000280

test-description: The fsmark is a file system benchmark to test synchronous write workloads, for example, mail servers workload.
test-url: https://sourceforge.net/projects/fsmark/





Details are as below:
-------------------------------------------------------------------------------------------------->


To reproduce:

        git clone https://github.com/intel/lkp-tests.git
        cd lkp-tests
        sudo bin/lkp install job.yaml           # job file is attached in this email
        bin/lkp split-job --compatible job.yaml # generate the yaml file for lkp run
        sudo bin/lkp run generated-yaml-file

        # if come across any failure that blocks the test,
        # please remove ~/.lkp and /lkp dir to run from a clean state.

=========================================================================================
compiler/cpufreq_governor/disk/filesize/fs2/fs/iterations/kconfig/nr_files_per_directory/nr_threads/rootfs/sync_method/tbox_group/test_size/testcase/ucode:
  gcc-9/performance/1BRD_32G/4K/nfsv4/ext4/1x/x86_64-rhel-8.3/1fpd/1t/debian-10.4-x86_64-20200603.cgz/fsyncBeforeClose/lkp-icl-2sp2/4G/fsmark/0xd000280

commit: 
  75acacb658 ("NFSD: Trace boot verifier resets")
  58f258f652 ("Revert "nfsd: skip some unnecessary stats in the v4 case"")

75acacb6583df0b9 58f258f65267542959487dbe8b5 
---------------- --------------------------- 
         %stddev     %change         %stddev
             \          |                \  
 1.209e+08           -23.5%   92419440        fsmark.app_overhead
      2281           +19.1%       2717 ±  2%  fsmark.files_per_sec
    442.46           -16.2%     370.73        fsmark.time.elapsed_time
    442.46           -16.2%     370.73        fsmark.time.elapsed_time.max
      7262 ±  8%     -34.0%       4790 ± 10%  fsmark.time.involuntary_context_switches
     17.00            -8.8%      15.50 ±  4%  fsmark.time.percent_of_cpu_this_job_got
     74.23           -26.9%      54.24 ±  2%  fsmark.time.system_time
   8830009           -27.2%    6429101        fsmark.time.voluntary_context_switches
      1.75            -4.9%       1.67        iostat.cpu.system
    164443           +18.1%     194248        meminfo.Dirty
    214794           +19.1%     255771        vmstat.io.bo
 5.651e+10           -16.0%  4.747e+10        cpuidle..time
 1.621e+08           -16.8%  1.349e+08        cpuidle..usage
 1.619e+08           -16.7%  1.348e+08        turbostat.C1
  1.65e+08           -16.7%  1.374e+08        turbostat.IRQ
    509.01           -14.1%     437.38        uptime.boot
     63539           -14.1%      54572        uptime.idle
      3225            -7.3%       2990        proc-vmstat.nr_active_anon
     41067           +18.2%      48530 ±  2%  proc-vmstat.nr_dirty
     11135            +3.0%      11465        proc-vmstat.nr_mapped
     11312            +3.2%      11669        proc-vmstat.nr_shmem
      3225            -7.3%       2990        proc-vmstat.nr_zone_active_anon
     41399           +18.1%      48891 ±  2%  proc-vmstat.nr_zone_write_pending
  17150642           -14.7%   14624975        proc-vmstat.numa_hit
  17034633           -14.8%   14509322        proc-vmstat.numa_local
    223090           +25.3%     279492        proc-vmstat.pgactivate
  17159178           -14.7%   14631511        proc-vmstat.pgalloc_normal
   1448230           -14.1%    1244580        proc-vmstat.pgfault
  12629097           -23.3%    9685211 ±  5%  proc-vmstat.pgfree
     90815 ±  2%     -15.7%      76531 ±  2%  proc-vmstat.pgreuse
     21.10            -6.9%      19.65 ±  2%  perf-stat.i.MPKI
  1.02e+09            -2.6%  9.934e+08        perf-stat.i.branch-instructions
   9952413 ±  4%     -28.1%    7159751 ± 14%  perf-stat.i.cache-misses
 1.031e+08            -8.4%   94438008        perf-stat.i.cache-references
      1.90            -3.2%       1.84        perf-stat.i.cpi
  8.97e+09 ±  2%      -3.9%  8.618e+09        perf-stat.i.cpu-cycles
      0.58           +33.5%       0.78 ± 12%  perf-stat.i.major-faults
      0.07 ±  2%      -4.0%       0.07        perf-stat.i.metric.GHz
    593.61           +10.8%     657.84 ±  2%  perf-stat.i.metric.K/sec
   1944012 ±  4%     -64.4%     692577 ± 11%  perf-stat.i.node-loads
     21.53            -7.6%      19.89 ±  2%  perf-stat.overall.MPKI
     25.04 ± 18%     +23.7       48.72 ± 14%  perf-stat.overall.node-load-miss-rate%
 1.018e+09            -2.7%  9.908e+08        perf-stat.ps.branch-instructions
   9960678 ±  4%     -28.3%    7144218 ± 14%  perf-stat.ps.cache-misses
  1.03e+08            -8.5%   94207132        perf-stat.ps.cache-references
 8.953e+09 ±  2%      -4.0%  8.596e+09        perf-stat.ps.cpu-cycles
      0.58           +33.6%       0.78 ± 12%  perf-stat.ps.major-faults
   1950659 ±  4%     -64.5%     692001 ± 12%  perf-stat.ps.node-loads
 2.135e+12           -17.0%  1.772e+12        perf-stat.total.instructions
     59492 ± 17%     -28.9%      42324 ± 17%  softirqs.CPU1.SCHED
     52823 ±  7%     -24.5%      39873 ± 18%  softirqs.CPU10.SCHED
     53022 ±  4%     -19.2%      42841 ±  6%  softirqs.CPU100.SCHED
     53078 ±  5%     -21.4%      41695 ± 14%  softirqs.CPU103.SCHED
     53662 ±  6%     -17.8%      44117 ±  6%  softirqs.CPU106.SCHED
     54529 ±  5%     -23.5%      41712 ± 14%  softirqs.CPU108.SCHED
     54078 ±  7%     -29.8%      37978 ± 34%  softirqs.CPU109.SCHED
     54715 ±  5%     -16.0%      45975 ± 10%  softirqs.CPU11.SCHED
     52936 ±  5%     -18.4%      43176 ±  8%  softirqs.CPU110.SCHED
     54142 ±  6%     -21.0%      42761 ± 12%  softirqs.CPU111.SCHED
     54043 ±  7%     -24.0%      41081 ± 26%  softirqs.CPU112.SCHED
     54822 ±  6%     -21.5%      43033 ± 10%  softirqs.CPU113.SCHED
     53644 ±  4%     -15.5%      45355 ±  5%  softirqs.CPU114.SCHED
    122412 ±  3%      -8.1%     112435 ±  2%  softirqs.CPU115.RCU
    126008 ±  4%     -12.6%     110126 ±  3%  softirqs.CPU117.RCU
     53947 ±  7%     -20.8%      42708 ± 18%  softirqs.CPU118.SCHED
     54875 ±  5%     -20.9%      43399 ± 15%  softirqs.CPU119.SCHED
    126988 ±  2%     -10.6%     113580 ±  5%  softirqs.CPU121.RCU
    131188 ±  3%     -11.8%     115717 ±  7%  softirqs.CPU122.RCU
     53662 ±  5%     -16.8%      44668 ±  5%  softirqs.CPU122.SCHED
     53382 ±  8%     -29.1%      37831 ± 35%  softirqs.CPU125.SCHED
     52686 ± 10%     -25.9%      39039 ± 19%  softirqs.CPU13.SCHED
     55394 ±  7%     -15.2%      46952 ±  5%  softirqs.CPU15.SCHED
     52522 ±  8%     -22.2%      40886 ±  7%  softirqs.CPU16.SCHED
     53382 ±  8%     -23.0%      41102 ± 18%  softirqs.CPU19.SCHED
     53646 ±  3%     -24.9%      40269 ± 16%  softirqs.CPU23.SCHED
     53774 ±  6%     -22.0%      41941 ± 16%  softirqs.CPU24.SCHED
     52294 ±  9%     -24.4%      39510 ± 19%  softirqs.CPU25.SCHED
     54750 ± 11%     -24.6%      41308 ± 13%  softirqs.CPU26.SCHED
     55598 ± 19%     -23.2%      42717 ±  8%  softirqs.CPU3.SCHED
     56395 ±  4%     -18.2%      46145 ±  7%  softirqs.CPU30.SCHED
     55716 ±  4%     -18.0%      45674 ±  6%  softirqs.CPU31.SCHED
    132238 ±  5%      -9.2%     120097 ±  4%  softirqs.CPU32.RCU
     57648 ± 19%     -27.8%      41633 ± 11%  softirqs.CPU34.SCHED
     55387 ±  6%     -22.5%      42931 ± 13%  softirqs.CPU36.SCHED
     53832 ±  8%     -20.0%      43063 ±  9%  softirqs.CPU37.SCHED
     53027 ±  5%     -30.7%      36746 ± 29%  softirqs.CPU4.SCHED
     54748 ±  5%     -20.4%      43578 ±  8%  softirqs.CPU43.SCHED
     55182 ±  6%     -24.3%      41761 ±  9%  softirqs.CPU50.SCHED
    128474 ±  6%     -12.2%     112791 ±  5%  softirqs.CPU51.RCU
     54439 ±  6%     -22.0%      42457 ±  9%  softirqs.CPU51.SCHED
     56458 ±  8%     -24.2%      42807 ±  8%  softirqs.CPU52.SCHED
     54685 ±  6%     -21.8%      42737 ±  9%  softirqs.CPU53.SCHED
     55644 ±  7%     -24.4%      42044 ± 10%  softirqs.CPU54.SCHED
     56221 ±  7%     -21.3%      44252 ±  8%  softirqs.CPU58.SCHED
     60220 ± 15%     -28.8%      42871 ± 10%  softirqs.CPU59.SCHED
     53409 ±  8%     -20.0%      42723 ± 12%  softirqs.CPU60.SCHED
     56008 ±  9%     -30.1%      39156 ± 17%  softirqs.CPU62.SCHED
     53846 ±  7%     -30.1%      37652 ± 24%  softirqs.CPU64.SCHED
     52929 ±  6%     -23.8%      40324 ± 28%  softirqs.CPU65.SCHED
     55383 ±  3%     -28.1%      39802 ± 20%  softirqs.CPU67.SCHED
     53543 ±  4%     -23.8%      40807 ± 17%  softirqs.CPU69.SCHED
     51770 ±  8%     -34.7%      33815 ± 38%  softirqs.CPU7.SCHED
     51708 ±  4%     -17.3%      42737 ± 13%  softirqs.CPU74.SCHED
     53440 ±  5%     -15.8%      45011 ±  5%  softirqs.CPU75.SCHED
     53881 ±  3%     -27.2%      39218 ± 16%  softirqs.CPU76.SCHED
     54875 ±  5%     -30.2%      38322 ± 16%  softirqs.CPU78.SCHED
     53638 ±  4%     -26.9%      39235 ± 28%  softirqs.CPU79.SCHED
     53326 ±  3%     -14.6%      45557 ±  6%  softirqs.CPU80.SCHED
     53754 ±  4%     -23.9%      40917 ± 20%  softirqs.CPU81.SCHED
     52572 ±  6%     -17.4%      43432 ±  4%  softirqs.CPU83.SCHED
     54370 ±  5%     -32.6%      36623 ± 31%  softirqs.CPU84.SCHED
     52428 ±  3%     -26.5%      38514 ± 19%  softirqs.CPU85.SCHED
     54807 ±  5%     -20.0%      43831 ±  4%  softirqs.CPU87.SCHED
     53644 ±  6%     -21.8%      41949 ± 19%  softirqs.CPU88.SCHED
     54565 ±  5%     -33.6%      36220 ± 26%  softirqs.CPU89.SCHED
     52459 ±  8%     -25.3%      39192 ± 20%  softirqs.CPU91.SCHED
     54086 ±  9%     -25.3%      40406 ± 28%  softirqs.CPU92.SCHED
     53091 ±  6%     -19.8%      42585 ± 13%  softirqs.CPU93.SCHED
     54504 ±  4%     -20.1%      43538 ±  4%  softirqs.CPU94.SCHED
     53818 ±  4%     -26.3%      39670 ± 29%  softirqs.CPU95.SCHED
     54631 ±  6%     -15.8%      46025 ±  5%  softirqs.CPU97.SCHED
     53314 ±  4%     -16.3%      44650 ±  3%  softirqs.CPU98.SCHED
   9403319           -22.4%    7299779        softirqs.NET_RX
   6823260 ±  4%     -19.8%    5471063 ±  5%  softirqs.SCHED
    316994 ±  2%     -11.7%     279761        softirqs.TIMER
      2.22 ±  4%      -1.4        0.82 ± 11%  perf-profile.calltrace.cycles-pp.nfs4_proc_access.nfs_do_access.nfs_permission.inode_permission.link_path_walk
      2.20 ±  4%      -1.4        0.82 ± 11%  perf-profile.calltrace.cycles-pp._nfs4_proc_access.nfs4_proc_access.nfs_do_access.nfs_permission.inode_permission
      2.10 ±  4%      -1.3        0.78 ± 12%  perf-profile.calltrace.cycles-pp.nfs4_do_call_sync._nfs4_proc_access.nfs4_proc_access.nfs_do_access.nfs_permission
      2.09 ±  4%      -1.3        0.78 ± 12%  perf-profile.calltrace.cycles-pp.nfs4_call_sync_custom.nfs4_do_call_sync._nfs4_proc_access.nfs4_proc_access.nfs_do_access
      2.08 ±  4%      -1.3        0.77 ± 12%  perf-profile.calltrace.cycles-pp.rpc_run_task.nfs4_call_sync_custom.nfs4_do_call_sync._nfs4_proc_access.nfs4_proc_access
      2.03 ±  4%      -1.3        0.76 ± 12%  perf-profile.calltrace.cycles-pp.rpc_execute.rpc_run_task.nfs4_call_sync_custom.nfs4_do_call_sync._nfs4_proc_access
      3.29 ±  4%      -1.0        2.33 ±  9%  perf-profile.calltrace.cycles-pp.__rpc_execute.rpc_execute.rpc_run_task.nfs4_call_sync_custom.nfs4_do_call_sync
      2.17 ±  6%      -0.6        1.56 ±  7%  perf-profile.calltrace.cycles-pp.link_path_walk.path_openat.do_filp_open.do_sys_openat2.do_sys_open
      1.40 ±  5%      -0.6        0.85 ± 11%  perf-profile.calltrace.cycles-pp.nfs_do_access.nfs_permission.inode_permission.link_path_walk.path_openat
      1.41 ±  5%      -0.6        0.86 ± 12%  perf-profile.calltrace.cycles-pp.nfs_permission.inode_permission.link_path_walk.path_openat.do_filp_open
      1.42 ±  5%      -0.5        0.87 ± 11%  perf-profile.calltrace.cycles-pp.inode_permission.link_path_walk.path_openat.do_filp_open.do_sys_openat2
      1.98 ±  4%      -0.5        1.44 ±  8%  perf-profile.calltrace.cycles-pp.mkdir
      1.93 ±  4%      -0.5        1.39 ±  9%  perf-profile.calltrace.cycles-pp.do_mkdirat.__x64_sys_mkdir.do_syscall_64.entry_SYSCALL_64_after_hwframe.mkdir
      1.95 ±  4%      -0.5        1.42 ±  9%  perf-profile.calltrace.cycles-pp.do_syscall_64.entry_SYSCALL_64_after_hwframe.mkdir
      1.94 ±  4%      -0.5        1.41 ±  8%  perf-profile.calltrace.cycles-pp.__x64_sys_mkdir.do_syscall_64.entry_SYSCALL_64_after_hwframe.mkdir
      1.95 ±  4%      -0.5        1.42 ±  9%  perf-profile.calltrace.cycles-pp.entry_SYSCALL_64_after_hwframe.mkdir
      2.74 ±  7%      -0.4        2.31 ±  4%  perf-profile.calltrace.cycles-pp.path_openat.do_filp_open.do_sys_openat2.do_sys_open.do_syscall_64
      2.78 ±  7%      -0.4        2.34 ±  4%  perf-profile.calltrace.cycles-pp.do_sys_openat2.do_sys_open.do_syscall_64.entry_SYSCALL_64_after_hwframe.open64
      2.74 ±  7%      -0.4        2.32 ±  5%  perf-profile.calltrace.cycles-pp.do_filp_open.do_sys_openat2.do_sys_open.do_syscall_64.entry_SYSCALL_64_after_hwframe
      2.78 ±  7%      -0.4        2.36 ±  4%  perf-profile.calltrace.cycles-pp.entry_SYSCALL_64_after_hwframe.open64
      2.78 ±  7%      -0.4        2.36 ±  4%  perf-profile.calltrace.cycles-pp.do_syscall_64.entry_SYSCALL_64_after_hwframe.open64
      2.83 ±  7%      -0.4        2.40 ±  4%  perf-profile.calltrace.cycles-pp.open64
      2.78 ±  7%      -0.4        2.35 ±  4%  perf-profile.calltrace.cycles-pp.do_sys_open.do_syscall_64.entry_SYSCALL_64_after_hwframe.open64
      1.55 ±  6%      -0.3        1.23 ±  8%  perf-profile.calltrace.cycles-pp.xs_stream_data_receive_workfn.process_one_work.worker_thread.kthread.ret_from_fork
      1.55 ±  6%      -0.3        1.23 ±  8%  perf-profile.calltrace.cycles-pp.xs_stream_data_receive.xs_stream_data_receive_workfn.process_one_work.worker_thread.kthread
      2.77 ±  8%      -0.3        2.50 ±  6%  perf-profile.calltrace.cycles-pp.inet6_csk_xmit.__tcp_transmit_skb.tcp_write_xmit.__tcp_push_pending_frames.tcp_sock_set_cork
      0.68 ±  6%      -0.1        0.61 ±  6%  perf-profile.calltrace.cycles-pp.fh_verify.nfsd4_proc_compound.nfsd_dispatch.svc_process_common.svc_process
      0.71 ±  8%      +0.1        0.80 ±  5%  perf-profile.calltrace.cycles-pp.ext4_create.vfs_create.do_nfsd_create.nfsd4_open.nfsd4_proc_compound
      0.73 ±  7%      +0.1        0.83 ±  5%  perf-profile.calltrace.cycles-pp.vfs_create.do_nfsd_create.nfsd4_open.nfsd4_proc_compound.nfsd_dispatch
      0.53 ±  3%      +0.1        0.64 ±  6%  perf-profile.calltrace.cycles-pp.journal_submit_commit_record.jbd2_journal_commit_transaction.kjournald2.kthread.ret_from_fork
      0.60 ±  5%      +0.2        0.77 ±  2%  perf-profile.calltrace.cycles-pp.ext4_getblk.ext4_bread.ext4_append.ext4_init_new_dir.ext4_mkdir
      0.60 ±  5%      +0.2        0.77 ±  3%  perf-profile.calltrace.cycles-pp.ext4_bread.ext4_append.ext4_init_new_dir.ext4_mkdir.vfs_mkdir
      0.64 ±  5%      +0.2        0.81 ±  3%  perf-profile.calltrace.cycles-pp.ext4_init_new_dir.ext4_mkdir.vfs_mkdir.nfsd_create_locked.nfsd4_create
      0.61 ±  5%      +0.2        0.78 ±  3%  perf-profile.calltrace.cycles-pp.ext4_append.ext4_init_new_dir.ext4_mkdir.vfs_mkdir.nfsd_create_locked
      0.98 ±  4%      +0.2        1.18 ± 16%  perf-profile.calltrace.cycles-pp.xs_tcp_send_request.xprt_transmit.call_transmit.__rpc_execute.rpc_async_schedule
      1.05 ±  4%      +0.2        1.25 ± 15%  perf-profile.calltrace.cycles-pp.call_transmit.__rpc_execute.rpc_async_schedule.process_one_work.worker_thread
      1.06 ±  8%      +0.2        1.26 ±  6%  perf-profile.calltrace.cycles-pp.do_nfsd_create.nfsd4_open.nfsd4_proc_compound.nfsd_dispatch.svc_process_common
      1.02 ±  4%      +0.2        1.23 ± 15%  perf-profile.calltrace.cycles-pp.xprt_transmit.call_transmit.__rpc_execute.rpc_async_schedule.process_one_work
      1.08 ± 12%      +0.2        1.30 ±  8%  perf-profile.calltrace.cycles-pp.__submit_bio.submit_bio_noacct.submit_bh_wbc.jbd2_journal_commit_transaction.kjournald2
      1.09 ± 12%      +0.2        1.32 ±  8%  perf-profile.calltrace.cycles-pp.submit_bio_noacct.submit_bh_wbc.jbd2_journal_commit_transaction.kjournald2.kthread
      0.35 ± 70%      +0.2        0.59 ±  4%  perf-profile.calltrace.cycles-pp.__ext4_new_inode.ext4_create.vfs_create.do_nfsd_create.nfsd4_open
      1.26 ± 10%      +0.3        1.52 ±  5%  perf-profile.calltrace.cycles-pp.submit_bh_wbc.jbd2_journal_commit_transaction.kjournald2.kthread.ret_from_fork
      1.48 ±  6%      +0.3        1.75 ±  3%  perf-profile.calltrace.cycles-pp.nfsd4_open.nfsd4_proc_compound.nfsd_dispatch.svc_process_common.svc_process
      0.27 ±100%      +0.3        0.57 ±  7%  perf-profile.calltrace.cycles-pp.__ext4_new_inode.ext4_mkdir.vfs_mkdir.nfsd_create_locked.nfsd4_create
      0.26 ±100%      +0.3        0.59 ±  7%  perf-profile.calltrace.cycles-pp.ext4_dx_add_entry.ext4_add_entry.ext4_mkdir.vfs_mkdir.nfsd_create_locked
      0.26 ±100%      +0.3        0.60 ±  7%  perf-profile.calltrace.cycles-pp.ext4_add_entry.ext4_mkdir.vfs_mkdir.nfsd_create_locked.nfsd4_create
      0.70 ±  4%      +0.3        1.05 ± 12%  perf-profile.calltrace.cycles-pp.rpc_execute.rpc_run_task.nfs4_call_sync_custom.nfs4_do_call_sync.nfs4_do_create
      0.75 ±  5%      +0.4        1.10 ± 11%  perf-profile.calltrace.cycles-pp.nfs4_do_create.nfs4_proc_mkdir.nfs_mkdir.vfs_mkdir.do_mkdirat
      0.87 ±  6%      +0.4        1.23 ± 11%  perf-profile.calltrace.cycles-pp.nfs4_proc_mkdir.nfs_mkdir.vfs_mkdir.do_mkdirat.__x64_sys_mkdir
      0.88 ±  6%      +0.4        1.24 ± 11%  perf-profile.calltrace.cycles-pp.vfs_mkdir.do_mkdirat.__x64_sys_mkdir.do_syscall_64.entry_SYSCALL_64_after_hwframe
      0.87 ±  5%      +0.4        1.23 ± 11%  perf-profile.calltrace.cycles-pp.nfs_mkdir.vfs_mkdir.do_mkdirat.__x64_sys_mkdir.do_syscall_64
      0.73 ±  5%      +0.4        1.09 ± 11%  perf-profile.calltrace.cycles-pp.nfs4_do_call_sync.nfs4_do_create.nfs4_proc_mkdir.nfs_mkdir.vfs_mkdir
      0.73 ±  5%      +0.4        1.09 ± 11%  perf-profile.calltrace.cycles-pp.nfs4_call_sync_custom.nfs4_do_call_sync.nfs4_do_create.nfs4_proc_mkdir.nfs_mkdir
      0.72 ±  5%      +0.4        1.08 ± 12%  perf-profile.calltrace.cycles-pp.rpc_run_task.nfs4_call_sync_custom.nfs4_do_call_sync.nfs4_do_create.nfs4_proc_mkdir
      1.71 ±  4%      +0.4        2.08 ±  4%  perf-profile.calltrace.cycles-pp.ext4_mkdir.vfs_mkdir.nfsd_create_locked.nfsd4_create.nfsd4_proc_compound
      1.90 ±  4%      +0.4        2.28 ± 16%  perf-profile.calltrace.cycles-pp.__rpc_execute.rpc_async_schedule.process_one_work.worker_thread.kthread
      1.72 ±  4%      +0.4        2.10 ±  5%  perf-profile.calltrace.cycles-pp.vfs_mkdir.nfsd_create_locked.nfsd4_create.nfsd4_proc_compound.nfsd_dispatch
      0.18 ±141%      +0.4        0.57 ±  6%  perf-profile.calltrace.cycles-pp.journal_end_buffer_io_sync.end_bio_bh_io_sync.__submit_bio.submit_bio_noacct.submit_bh_wbc
      1.94 ±  4%      +0.4        2.34 ±  5%  perf-profile.calltrace.cycles-pp.nfsd_create_locked.nfsd4_create.nfsd4_proc_compound.nfsd_dispatch.svc_process_common
      0.18 ±141%      +0.4        0.60 ±  9%  perf-profile.calltrace.cycles-pp.generic_perform_write.ext4_buffered_write_iter.do_iter_readv_writev.do_iter_write.nfsd_vfs_write
      2.38 ±  6%      +0.5        2.88 ±  4%  perf-profile.calltrace.cycles-pp.nfsd4_create.nfsd4_proc_compound.nfsd_dispatch.svc_process_common.svc_process
      0.00            +0.5        0.54 ±  4%  perf-profile.calltrace.cycles-pp.rpc_execute.rpc_run_task.nfs4_call_sync_custom.nfs4_do_call_sync._nfs4_proc_getattr
      0.00            +0.6        0.56 ±  4%  perf-profile.calltrace.cycles-pp.rpc_run_task.nfs4_call_sync_custom.nfs4_do_call_sync._nfs4_proc_getattr.nfs4_proc_getattr
      0.00            +0.6        0.56 ±  4%  perf-profile.calltrace.cycles-pp.nfs4_call_sync_custom.nfs4_do_call_sync._nfs4_proc_getattr.nfs4_proc_getattr.__nfs_revalidate_inode
      0.00            +0.6        0.56 ±  4%  perf-profile.calltrace.cycles-pp.nfs4_do_call_sync._nfs4_proc_getattr.nfs4_proc_getattr.__nfs_revalidate_inode.nfs_check_verifier
      0.00            +0.6        0.58 ±  4%  perf-profile.calltrace.cycles-pp._nfs4_proc_getattr.nfs4_proc_getattr.__nfs_revalidate_inode.nfs_check_verifier.nfs_do_lookup_revalidate
      0.00            +0.6        0.58 ±  4%  perf-profile.calltrace.cycles-pp.nfs4_proc_getattr.__nfs_revalidate_inode.nfs_check_verifier.nfs_do_lookup_revalidate.__nfs_lookup_revalidate
      0.00            +0.6        0.61 ±  5%  perf-profile.calltrace.cycles-pp.__nfs_revalidate_inode.nfs_check_verifier.nfs_do_lookup_revalidate.__nfs_lookup_revalidate.lookup_fast
      0.00            +0.6        0.62 ±  6%  perf-profile.calltrace.cycles-pp.nfs_check_verifier.nfs_do_lookup_revalidate.__nfs_lookup_revalidate.lookup_fast.walk_component
      7.41 ±  5%      +0.8        8.22 ±  4%  perf-profile.calltrace.cycles-pp.nfsd4_proc_compound.nfsd_dispatch.svc_process_common.svc_process.nfsd
      4.14 ±  4%      +1.0        5.11 ±  4%  perf-profile.calltrace.cycles-pp.jbd2_journal_commit_transaction.kjournald2.kthread.ret_from_fork
      4.40 ±  4%      +1.0        5.42 ±  4%  perf-profile.calltrace.cycles-pp.kjournald2.kthread.ret_from_fork
     23.91 ±  3%      +1.5       25.42 ±  2%  perf-profile.calltrace.cycles-pp.ret_from_fork
     23.91 ±  3%      +1.5       25.42 ±  2%  perf-profile.calltrace.cycles-pp.kthread.ret_from_fork
      3.14 ±  5%      -1.5        1.64 ±  6%  perf-profile.children.cycles-pp.link_path_walk
      2.41 ±  5%      -1.4        0.96 ±  9%  perf-profile.children.cycles-pp.inode_permission
      2.30 ±  5%      -1.4        0.86 ± 11%  perf-profile.children.cycles-pp.nfs_do_access
      2.32 ±  4%      -1.4        0.88 ± 10%  perf-profile.children.cycles-pp.nfs_permission
      2.22 ±  4%      -1.4        0.82 ± 11%  perf-profile.children.cycles-pp.nfs4_proc_access
      2.20 ±  4%      -1.4        0.82 ± 11%  perf-profile.children.cycles-pp._nfs4_proc_access
      3.44 ±  4%      -1.0        2.43 ±  9%  perf-profile.children.cycles-pp.nfs4_call_sync_custom
      3.45 ±  4%      -1.0        2.44 ±  9%  perf-profile.children.cycles-pp.nfs4_do_call_sync
      3.68 ±  4%      -0.9        2.74 ±  7%  perf-profile.children.cycles-pp.rpc_run_task
      3.54 ±  4%      -0.9        2.61 ±  7%  perf-profile.children.cycles-pp.rpc_execute
      1.03 ±  5%      -0.9        0.13 ± 15%  perf-profile.children.cycles-pp.filename_create
      0.98 ±  6%      -0.9        0.08 ± 17%  perf-profile.children.cycles-pp.filename_parentat
      0.96 ±  6%      -0.9        0.08 ± 20%  perf-profile.children.cycles-pp.path_parentat
      6.17 ±  4%      -0.8        5.36 ±  4%  perf-profile.children.cycles-pp.entry_SYSCALL_64_after_hwframe
      6.16 ±  4%      -0.8        5.35 ±  4%  perf-profile.children.cycles-pp.do_syscall_64
      1.93 ±  4%      -0.5        1.39 ±  9%  perf-profile.children.cycles-pp.do_mkdirat
      1.98 ±  4%      -0.5        1.44 ±  8%  perf-profile.children.cycles-pp.mkdir
      1.94 ±  4%      -0.5        1.41 ±  9%  perf-profile.children.cycles-pp.__x64_sys_mkdir
      4.41 ±  2%      -0.5        3.95 ±  6%  perf-profile.children.cycles-pp.tcp_sock_set_cork
      4.31 ±  2%      -0.4        3.88 ±  6%  perf-profile.children.cycles-pp.tcp_write_xmit
      2.82 ±  7%      -0.4        2.40 ±  4%  perf-profile.children.cycles-pp.do_sys_openat2
      2.83 ±  7%      -0.4        2.40 ±  4%  perf-profile.children.cycles-pp.open64
      2.78 ±  6%      -0.4        2.35 ±  5%  perf-profile.children.cycles-pp.path_openat
      2.82 ±  7%      -0.4        2.40 ±  4%  perf-profile.children.cycles-pp.do_sys_open
      2.79 ±  7%      -0.4        2.36 ±  4%  perf-profile.children.cycles-pp.do_filp_open
      4.35 ±  2%      -0.4        3.93 ±  6%  perf-profile.children.cycles-pp.__tcp_push_pending_frames
      4.01 ±  2%      -0.4        3.61 ±  6%  perf-profile.children.cycles-pp.__tcp_transmit_skb
      3.77            -0.4        3.40 ±  7%  perf-profile.children.cycles-pp.inet6_csk_xmit
      3.68            -0.4        3.33 ±  7%  perf-profile.children.cycles-pp.ip6_xmit
      3.58            -0.4        3.23 ±  7%  perf-profile.children.cycles-pp.ip6_output
      1.55 ±  6%      -0.3        1.23 ±  8%  perf-profile.children.cycles-pp.xs_stream_data_receive
      1.55 ±  6%      -0.3        1.24 ±  8%  perf-profile.children.cycles-pp.xs_stream_data_receive_workfn
      2.21 ±  3%      -0.2        2.05 ±  8%  perf-profile.children.cycles-pp.try_to_wake_up
      1.29 ±  3%      -0.2        1.13 ± 14%  perf-profile.children.cycles-pp.schedule_idle
      1.28 ±  5%      -0.1        1.14 ±  9%  perf-profile.children.cycles-pp.inet6_recvmsg
      0.72 ± 12%      -0.1        0.58 ±  8%  perf-profile.children.cycles-pp.xs_sock_recvmsg
      1.20 ±  5%      -0.1        1.06 ±  5%  perf-profile.children.cycles-pp.fh_verify
      0.59 ±  4%      -0.1        0.45 ±  5%  perf-profile.children.cycles-pp.rpc_wake_up_task_on_wq_queue_action_locked
      0.60 ±  4%      -0.1        0.47 ±  4%  perf-profile.children.cycles-pp.rpc_wake_up_queued_task
      0.35 ±  5%      -0.1        0.22 ± 12%  perf-profile.children.cycles-pp.__wake_up_bit
      0.96 ±  7%      -0.1        0.86 ±  3%  perf-profile.children.cycles-pp.svc_xprt_do_enqueue
      0.74 ±  6%      -0.1        0.64 ±  8%  perf-profile.children.cycles-pp.nfsd_setuser_and_check_port
      0.72 ±  5%      -0.1        0.63 ±  7%  perf-profile.children.cycles-pp.nfsd_setuser
      0.19 ± 12%      -0.1        0.10 ± 19%  perf-profile.children.cycles-pp.nfsd_access
      0.57 ±  6%      -0.1        0.50 ±  5%  perf-profile.children.cycles-pp.__might_resched
      0.44 ±  8%      -0.1        0.38 ±  6%  perf-profile.children.cycles-pp.out_of_line_wait_on_bit
      0.44 ±  8%      -0.1        0.38 ±  5%  perf-profile.children.cycles-pp.__wait_on_bit
      0.26 ± 12%      -0.1        0.20 ± 12%  perf-profile.children.cycles-pp.tcp_stream_alloc_skb
      0.24 ± 12%      -0.1        0.19 ±  9%  perf-profile.children.cycles-pp.__alloc_skb
      0.34 ±  6%      -0.1        0.29 ±  3%  perf-profile.children.cycles-pp.rpc_wait_bit_killable
      0.09 ± 25%      -0.0        0.04 ± 73%  perf-profile.children.cycles-pp.nfsd_permission
      0.44 ±  7%      -0.0        0.39 ±  6%  perf-profile.children.cycles-pp.nfsd_set_fh_dentry
      0.18 ± 13%      -0.0        0.14 ±  8%  perf-profile.children.cycles-pp.svc_generic_init_request
      0.14 ±  9%      +0.0        0.18 ± 12%  perf-profile.children.cycles-pp.__ext4_get_inode_loc
      0.14 ±  8%      +0.0        0.18 ± 13%  perf-profile.children.cycles-pp.ext4_get_inode_loc
      0.09 ± 14%      +0.0        0.13 ± 11%  perf-profile.children.cycles-pp._nfs4_opendata_to_nfs4_state
      0.11 ±  9%      +0.0        0.15 ± 10%  perf-profile.children.cycles-pp.brd_lookup_page
      0.14 ± 17%      +0.0        0.18 ± 10%  perf-profile.children.cycles-pp.__ext4_handle_dirty_metadata
      0.25 ±  4%      +0.0        0.29 ±  7%  perf-profile.children.cycles-pp.jbd2_journal_write_metadata_buffer
      0.10 ± 13%      +0.0        0.15 ± 11%  perf-profile.children.cycles-pp._raw_write_lock
      0.06 ± 13%      +0.0        0.10 ± 20%  perf-profile.children.cycles-pp.jbd2_journal_switch_revoke_table
      0.17 ±  8%      +0.0        0.21 ± 13%  perf-profile.children.cycles-pp.rpc_async_release
      0.16 ±  7%      +0.0        0.21 ± 13%  perf-profile.children.cycles-pp.nfs_write_completion
      0.23 ±  8%      +0.0        0.28 ±  8%  perf-profile.children.cycles-pp.nfs4_do_close
      0.28 ±  5%      +0.0        0.32 ±  7%  perf-profile.children.cycles-pp.nfs_file_release
      0.17 ±  8%      +0.1        0.22 ±  8%  perf-profile.children.cycles-pp.do_get_write_access
      0.27 ±  4%      +0.1        0.32 ±  7%  perf-profile.children.cycles-pp.__put_nfs_open_context
      0.35 ±  5%      +0.1        0.40 ±  6%  perf-profile.children.cycles-pp.__fput
      0.35 ±  7%      +0.1        0.40 ±  6%  perf-profile.children.cycles-pp.pagecache_get_page
      0.34 ±  7%      +0.1        0.40 ±  5%  perf-profile.children.cycles-pp.__filemap_get_folio
      0.34 ±  9%      +0.1        0.40 ±  7%  perf-profile.children.cycles-pp.__jbd2_log_wait_for_space
      0.31 ± 10%      +0.1        0.38 ±  6%  perf-profile.children.cycles-pp.ext4_find_dest_de
      0.21 ±  6%      +0.1        0.28 ± 12%  perf-profile.children.cycles-pp.rpc_free_task
      0.28 ± 14%      +0.1        0.36 ±  5%  perf-profile.children.cycles-pp.ext4_dirty_inode
      0.24 ±  9%      +0.1        0.32 ± 12%  perf-profile.children.cycles-pp.nfsd4_process_open2
      0.39 ±  4%      +0.1        0.47 ±  7%  perf-profile.children.cycles-pp.brd_do_bvec
      0.34 ± 11%      +0.1        0.42 ±  3%  perf-profile.children.cycles-pp.__mark_inode_dirty
      0.27 ±  4%      +0.1        0.35 ± 10%  perf-profile.children.cycles-pp.jbd2_journal_get_write_access
      0.00            +0.1        0.08 ± 26%  perf-profile.children.cycles-pp.do_open
      0.71 ±  8%      +0.1        0.80 ±  5%  perf-profile.children.cycles-pp.ext4_create
      0.40 ± 10%      +0.1        0.50 ±  8%  perf-profile.children.cycles-pp.nfs4_atomic_open
      0.40 ± 10%      +0.1        0.50 ±  8%  perf-profile.children.cycles-pp.nfs4_do_open
      0.42 ±  5%      +0.1        0.52 ±  5%  perf-profile.children.cycles-pp.brd_submit_bio
      0.34 ±  4%      +0.1        0.44 ±  8%  perf-profile.children.cycles-pp.__ext4_journal_get_write_access
      0.73 ±  7%      +0.1        0.83 ±  5%  perf-profile.children.cycles-pp.vfs_create
      0.48 ± 13%      +0.1        0.58 ±  7%  perf-profile.children.cycles-pp.journal_end_buffer_io_sync
      0.44 ±  3%      +0.1        0.54 ± 11%  perf-profile.children.cycles-pp.ext4_mb_new_blocks
      0.53 ±  8%      +0.1        0.63 ±  5%  perf-profile.children.cycles-pp.add_dirent_to_buf
      0.42 ±  9%      +0.1        0.53 ±  8%  perf-profile.children.cycles-pp.nfs_atomic_open
      0.53 ±  3%      +0.1        0.64 ±  6%  perf-profile.children.cycles-pp.journal_submit_commit_record
      0.48 ±  8%      +0.1        0.59 ±  7%  perf-profile.children.cycles-pp.ext4_dx_add_entry
      0.70 ±  9%      +0.1        0.82 ±  6%  perf-profile.children.cycles-pp.generic_perform_write
      0.48 ±  7%      +0.1        0.59 ±  6%  perf-profile.children.cycles-pp.jbd2__journal_start
      0.49 ±  7%      +0.1        0.61 ±  5%  perf-profile.children.cycles-pp.__ext4_journal_start_sb
      0.47 ±  5%      +0.1        0.59 ± 13%  perf-profile.children.cycles-pp.jbd2_journal_get_descriptor_buffer
      0.63 ±  7%      +0.1        0.76 ±  5%  perf-profile.children.cycles-pp.ext4_add_entry
      1.02 ±  6%      +0.1        1.16 ±  5%  perf-profile.children.cycles-pp.__ext4_new_inode
      0.71 ±  5%      +0.2        0.87 ±  7%  perf-profile.children.cycles-pp.ext4_ext_map_blocks
      0.70 ±  6%      +0.2        0.86 ±  5%  perf-profile.children.cycles-pp.crc32c_pcl_intel_update
      0.61 ±  4%      +0.2        0.78 ±  3%  perf-profile.children.cycles-pp.ext4_append
      0.64 ±  5%      +0.2        0.81 ±  3%  perf-profile.children.cycles-pp.ext4_init_new_dir
      0.71 ±  4%      +0.2        0.89 ±  3%  perf-profile.children.cycles-pp.ext4_bread
      0.73 ±  4%      +0.2        0.91 ±  2%  perf-profile.children.cycles-pp.ext4_getblk
      0.86 ±  5%      +0.2        1.05 ±  9%  perf-profile.children.cycles-pp.ext4_map_blocks
      1.06 ±  8%      +0.2        1.26 ±  6%  perf-profile.children.cycles-pp.do_nfsd_create
      1.48 ±  6%      +0.3        1.75 ±  3%  perf-profile.children.cycles-pp.nfsd4_open
      1.56 ± 10%      +0.3        1.85 ±  6%  perf-profile.children.cycles-pp.__submit_bio
      1.57 ± 10%      +0.3        1.87 ±  6%  perf-profile.children.cycles-pp.submit_bio_noacct
      1.70 ±  9%      +0.3        2.04 ±  4%  perf-profile.children.cycles-pp.submit_bh_wbc
      0.75 ±  5%      +0.4        1.10 ± 11%  perf-profile.children.cycles-pp.nfs4_do_create
      0.87 ±  5%      +0.4        1.23 ± 11%  perf-profile.children.cycles-pp.nfs4_proc_mkdir
      0.87 ±  6%      +0.4        1.23 ± 11%  perf-profile.children.cycles-pp.nfs_mkdir
      1.71 ±  4%      +0.4        2.08 ±  4%  perf-profile.children.cycles-pp.ext4_mkdir
      1.94 ±  4%      +0.4        2.34 ±  5%  perf-profile.children.cycles-pp.nfsd_create_locked
      2.38 ±  6%      +0.5        2.88 ±  4%  perf-profile.children.cycles-pp.nfsd4_create
      0.00            +0.6        0.58 ±  4%  perf-profile.children.cycles-pp._nfs4_proc_getattr
      0.00            +0.6        0.58 ±  4%  perf-profile.children.cycles-pp.nfs4_proc_getattr
      0.00            +0.6        0.61 ±  5%  perf-profile.children.cycles-pp.__nfs_revalidate_inode
      0.00            +0.6        0.62 ±  5%  perf-profile.children.cycles-pp.nfs_check_verifier
      2.61 ±  3%      +0.7        3.34 ±  4%  perf-profile.children.cycles-pp.vfs_mkdir
      7.42 ±  5%      +0.8        8.23 ±  4%  perf-profile.children.cycles-pp.nfsd4_proc_compound
      4.16 ±  4%      +1.0        5.14 ±  4%  perf-profile.children.cycles-pp.jbd2_journal_commit_transaction
      4.40 ±  4%      +1.0        5.42 ±  4%  perf-profile.children.cycles-pp.kjournald2
     23.91 ±  3%      +1.5       25.42 ±  2%  perf-profile.children.cycles-pp.kthread
     23.91 ±  3%      +1.5       25.43 ±  2%  perf-profile.children.cycles-pp.ret_from_fork
      0.34 ± 11%      -0.1        0.27 ± 12%  perf-profile.self.cycles-pp.__alloc_pages_bulk
      0.11 ±  6%      +0.0        0.14 ±  9%  perf-profile.self.cycles-pp.__radix_tree_lookup
      0.06 ± 13%      +0.0        0.10 ± 21%  perf-profile.self.cycles-pp.jbd2_journal_switch_revoke_table
      0.10 ± 11%      +0.0        0.14 ± 12%  perf-profile.self.cycles-pp._raw_write_lock
      0.43 ±  8%      +0.1        0.51 ±  6%  perf-profile.self.cycles-pp.unlock_buffer
      0.47 ± 13%      +0.1        0.56 ±  6%  perf-profile.self.cycles-pp.journal_end_buffer_io_sync
      0.28 ± 11%      +0.1        0.37 ±  9%  perf-profile.self.cycles-pp.jbd2_journal_commit_transaction




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.


---
0DAY/LKP+ Test Infrastructure                   Open Source Technology Center
https://lists.01.org/hyperkitty/list/lkp@lists.01.org       Intel Corporation

Thanks,
Oliver Sang


View attachment "config-5.16.0-rc5-00045-g58f258f65267" of type "text/plain" (173395 bytes)

View attachment "job-script" of type "text/plain" (8413 bytes)

View attachment "job.yaml" of type "text/plain" (5846 bytes)

View attachment "reproduce" of type "text/plain" (953 bytes)

Powered by blists - more mailing lists

Powered by Openwall GNU/*/Linux Powered by OpenVZ