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]
Message-ID: <20160621021552.GE25382@yexl-desktop>
Date:	Tue, 21 Jun 2016 10:15:52 +0800
From:	kernel test robot <xiaolong.ye@...el.com>
To:	Len Brown <len.brown@...el.com>
Cc:	LKML <linux-kernel@...r.kernel.org>,
	Len Brown <len.brown@...el.com>, linux-pm@...r.kernel.org,
	linux-acpi@...r.kernel.org, lkp@...org
Subject: [lkp] [x86 tsc_msr]  8c82d5a94b: unixbench.score -15.6% regression


FYI, we noticed a -15.6% regression of unixbench.score due to commit:

commit 8c82d5a94b754b6015f8cf8ea1fde15821fc6611 ("x86 tsc_msr: Extend to include Intel Core Architecture")
https://git.kernel.org/pub/scm/linux/kernel/git/lenb/linux.git release

in testcase: unixbench
on test machine: lkp-bdw-de1: 16 threads Broadwell-DE with 8G memory
with following parameters: cpufreq_governor=performance/nr_task=1/runtime=300s/test=whetstone-double



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


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

=========================================================================================
compiler/cpufreq_governor/kconfig/nr_task/rootfs/runtime/tbox_group/test/testcase:
  gcc-4.9/performance/x86_64-rhel/1/debian-x86_64-2015-02-07.cgz/300s/lkp-bdw-de1/whetstone-double/unixbench

commit: 
  abc6a0f4b18281410da1a3f26e2819d8e03e144f
  8c82d5a94b754b6015f8cf8ea1fde15821fc6611

abc6a0f4b1828141 8c82d5a94b754b6015f8cf8ea1 
---------------- -------------------------- 
       fail:runs  %reproduction    fail:runs
           |             |             |    
          1:4          -25%            :4     kmsg.Spurious_LAPIC_timer_interrupt_on_cpu
         %stddev     %change         %stddev
             \          |                \  
    816.90 ±  0%     -15.6%     689.82 ±  0%  unixbench.score
    462.07 ±  0%      +2.3%     472.47 ±  0%  unixbench.time.elapsed_time
    462.07 ±  0%      +2.3%     472.47 ±  0%  unixbench.time.elapsed_time.max
     80.00 ±  0%      +1.2%      81.00 ±  0%  unixbench.time.percent_of_cpu_this_job_got
    371.83 ±  0%      +3.0%     383.12 ±  0%  unixbench.time.user_time
    613.50 ±  4%     +23.0%     754.50 ±  2%  vmstat.system.cs
     16034 ±  0%     +76.0%      28213 ±  1%  vmstat.system.in
      5852 ±  0%     +14.3%       6692 ±  4%  proc-vmstat.nr_active_anon
      2404 ±  0%     +24.5%       2993 ±  1%  proc-vmstat.nr_shmem
      1389 ±  1%     +62.4%       2257 ±  9%  proc-vmstat.pgactivate
     39227 ±  0%      +9.3%      42862 ±  2%  meminfo.Active
     23426 ±  0%     +14.3%      26777 ±  4%  meminfo.Active(anon)
      4082 ±  0%     +24.9%       5098 ± 19%  meminfo.AnonHugePages
      9619 ±  0%     +24.5%      11974 ±  1%  meminfo.Shmem
    498549 ±  4%    +367.4%    2330223 ±  3%  cpuidle.C1-BDW.time
     57855 ±  3%     +62.4%      93954 ±  2%  cpuidle.C1-BDW.usage
   6366987 ± 26%     -24.3%    4821327 ±  2%  cpuidle.C3-BDW.time
 6.651e+09 ±  0%     -72.3%  1.841e+09 ±  9%  cpuidle.C6-BDW.time
   7056683 ±  0%     -72.6%    1935634 ±  9%  cpuidle.C6-BDW.usage
  13526734 ± 34%  +37932.5%  5.145e+09 ±  3%  cpuidle.POLL.time
      1302 ±  2%   +3739.8%      50004 ±  6%  cpuidle.POLL.usage
      8.09 ±  0%    +826.0%      74.94 ±  3%  turbostat.%Busy
    189.50 ±  1%    +890.8%       1877 ±  3%  turbostat.Avg_MHz
     31.16 ±  0%     -75.6%       7.59 ±  9%  turbostat.CPU%c1
      0.04 ± 45%     -77.8%       0.01 ±  0%  turbostat.CPU%c3
     60.71 ±  0%     -71.2%      17.46 ± 10%  turbostat.CPU%c6
     56.25 ±  0%     +13.8%      64.00 ±  1%  turbostat.CoreTmp
      1.52 ±  2%     -99.7%       0.01 ±173%  turbostat.Pkg%pc2
      0.01 ± 34%    -100.0%       0.00 ± -1%  turbostat.Pkg%pc3
      9.95 ±  1%     -99.6%       0.04 ±116%  turbostat.Pkg%pc6
     55.25 ±  0%     +15.8%      64.00 ±  1%  turbostat.PkgTmp
     19.25 ±  0%     +55.8%      29.98 ±  1%  turbostat.PkgWatt
 1.396e+09 ±  0%     -43.3%   7.92e+08 ±  1%  perf-stat.L1-dcache-load-misses
 2.502e+11 ±  0%    +264.8%  9.128e+11 ±  2%  perf-stat.L1-dcache-loads
 1.205e+11 ±  1%     -19.8%  9.659e+10 ±  1%  perf-stat.L1-dcache-stores
 1.978e+09 ±  0%     -62.8%  7.362e+08 ±  7%  perf-stat.L1-icache-load-misses
  8.09e+08 ±  0%     -58.1%  3.391e+08 ±  4%  perf-stat.LLC-loads
 6.025e+08 ±  0%     -56.2%  2.641e+08 ±  4%  perf-stat.LLC-stores
  1.55e+11 ±  3%    +435.3%    8.3e+11 ±  3%  perf-stat.branch-instructions
 1.546e+09 ±  0%     -34.0%   1.02e+09 ±  1%  perf-stat.branch-load-misses
 1.519e+11 ±  0%    +445.3%  8.284e+11 ±  2%  perf-stat.branch-loads
 1.515e+09 ±  0%     -34.9%  9.861e+08 ±  1%  perf-stat.branch-misses
 5.222e+10 ±  0%    +971.5%  5.596e+11 ±  3%  perf-stat.bus-cycles
 4.109e+09 ±  0%     -62.0%  1.561e+09 ±  5%  perf-stat.cache-misses
 4.087e+09 ±  0%     -62.2%  1.547e+09 ±  6%  perf-stat.cache-references
    282484 ±  4%     +25.9%     355784 ±  2%  perf-stat.context-switches
 1.261e+12 ±  0%   +1010.8%  1.401e+13 ±  3%  perf-stat.cpu-cycles
 2.378e+08 ±  0%     -66.2%   80299694 ±  7%  perf-stat.dTLB-load-misses
 2.495e+11 ±  0%    +266.4%   9.14e+11 ±  2%  perf-stat.dTLB-loads
  39543763 ±  0%     -69.1%   12232186 ±  8%  perf-stat.dTLB-store-misses
 1.191e+11 ±  1%     -18.4%  9.722e+10 ±  0%  perf-stat.dTLB-stores
  89967876 ± 39%     -72.8%   24439509 ±  9%  perf-stat.iTLB-load-misses
  48505118 ±  0%     -73.9%   12652529 ±  5%  perf-stat.iTLB-loads
 1.341e+12 ±  3%    +193.5%  3.934e+12 ±  2%  perf-stat.instructions
    543009 ±  0%      +3.2%     560464 ±  1%  perf-stat.minor-faults
    542964 ±  0%      +3.2%     560437 ±  1%  perf-stat.page-faults
 1.097e+12 ±  0%    +971.6%  1.176e+13 ±  3%  perf-stat.ref-cycles
      1.97 ± 80%   +1290.8%      27.39 ± 84%  sched_debug.cfs_rq:/.MIN_vruntime.avg
     31.52 ± 80%   +1290.8%     438.31 ± 84%  sched_debug.cfs_rq:/.MIN_vruntime.max
      7.63 ± 80%   +1290.8%     106.10 ± 84%  sched_debug.cfs_rq:/.MIN_vruntime.stddev
    253.54 ±  6%      -9.6%     229.17 ±  6%  sched_debug.cfs_rq:/.load_avg.stddev
      1.97 ± 80%   +1292.0%      27.42 ± 84%  sched_debug.cfs_rq:/.max_vruntime.avg
     31.52 ± 80%   +1292.0%     438.68 ± 84%  sched_debug.cfs_rq:/.max_vruntime.max
      7.63 ± 80%   +1292.0%     106.19 ± 84%  sched_debug.cfs_rq:/.max_vruntime.stddev
    213.91 ±  5%      -9.5%     193.53 ±  0%  sched_debug.cpu.cpu_load[0].stddev
    901.94 ±  1%     -12.3%     790.97 ±  1%  sched_debug.cpu.cpu_load[1].max
    217.75 ±  2%     -12.5%     190.58 ±  0%  sched_debug.cpu.cpu_load[1].stddev
    895.38 ±  3%     -12.4%     784.59 ±  1%  sched_debug.cpu.cpu_load[2].max
    216.46 ±  4%     -12.7%     188.90 ±  1%  sched_debug.cpu.cpu_load[2].stddev
    880.84 ±  4%     -11.7%     777.62 ±  1%  sched_debug.cpu.cpu_load[3].max
    213.30 ±  5%     -12.3%     187.05 ±  1%  sched_debug.cpu.cpu_load[3].stddev
    867.22 ±  5%     -11.3%     769.41 ±  0%  sched_debug.cpu.cpu_load[4].max
    210.20 ±  5%     -11.8%     185.34 ±  0%  sched_debug.cpu.cpu_load[4].stddev
     10216 ±  2%     +18.4%      12096 ±  2%  sched_debug.cpu.nr_switches.avg
     28571 ± 16%     +48.8%      42525 ±  6%  sched_debug.cpu.nr_switches.max
      7768 ±  5%     +45.7%      11316 ±  8%  sched_debug.cpu.nr_switches.stddev
      8265 ±  2%     +21.7%      10056 ±  2%  sched_debug.cpu.sched_count.avg
     25938 ± 22%     +49.1%      38684 ± 10%  sched_debug.cpu.sched_count.max
      7071 ±  9%     +46.0%      10324 ± 10%  sched_debug.cpu.sched_count.stddev
      3783 ±  3%     +24.4%       4704 ±  2%  sched_debug.cpu.sched_goidle.avg
     11805 ± 16%     +56.1%      18427 ±  5%  sched_debug.cpu.sched_goidle.max
      3254 ±  5%     +55.0%       5045 ±  7%  sched_debug.cpu.sched_goidle.stddev
      3681 ±  3%     +24.4%       4580 ±  2%  sched_debug.cpu.ttwu_count.avg
    314.38 ±  3%     -27.9%     226.78 ±  9%  sched_debug.cpu.ttwu_local.min
      2.55 ± 26%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.__hrtimer_run_queues.hrtimer_interrupt.local_apic_timer_interrupt.smp_apic_timer_interrupt.apic_timer_interrupt
      1.94 ± 23%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.__tick_nohz_idle_enter.tick_nohz_irq_exit.irq_exit.smp_apic_timer_interrupt.apic_timer_interrupt
      9.41 ± 10%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.apic_timer_interrupt.cpuidle_enter.call_cpuidle.cpu_startup_entry.start_secondary
      1.40 ± 12%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.call_console_drivers.constprop.23.console_unlock.vprintk_emit.vprintk_default.printk
      1.40 ± 12%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.console_unlock.vprintk_emit.vprintk_default.printk.perf_duration_warn
      2.31 ± 10%    +162.8%       6.08 ± 52%  perf-profile.cycles-pp.cpuidle_enter_state.cpuidle_enter.call_cpuidle.cpu_startup_entry.rest_init
     81.21 ±  1%     +15.0%      93.40 ±  3%  perf-profile.cycles-pp.cpuidle_enter_state.cpuidle_enter.call_cpuidle.cpu_startup_entry.start_secondary
      1.12 ± 17%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.cpuidle_select.cpu_startup_entry.start_secondary
      3.33 ± 21%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.hrtimer_interrupt.local_apic_timer_interrupt.smp_apic_timer_interrupt.apic_timer_interrupt.cpuidle_enter
     81.30 ±  1%     -98.7%       1.07 ± 16%  perf-profile.cycles-pp.intel_idle.cpuidle_enter_state.cpuidle_enter.call_cpuidle.cpu_startup_entry
      0.92 ± 16%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.io_serial_in.wait_for_xmitr.serial8250_console_putchar.uart_console_write.serial8250_console_write
      1.98 ±  8%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.irq_enter.smp_apic_timer_interrupt.apic_timer_interrupt.cpuidle_enter.call_cpuidle
      2.65 ± 11%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.irq_exit.smp_apic_timer_interrupt.apic_timer_interrupt.cpuidle_enter.call_cpuidle
      1.40 ± 12%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.irq_work_run.smp_irq_work_interrupt.irq_work_interrupt.cpuidle_enter.call_cpuidle
      1.40 ± 12%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.irq_work_run_list.irq_work_run.smp_irq_work_interrupt.irq_work_interrupt.cpuidle_enter
      3.52 ± 21%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.local_apic_timer_interrupt.smp_apic_timer_interrupt.apic_timer_interrupt.cpuidle_enter.call_cpuidle
      1.40 ± 12%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.perf_duration_warn.irq_work_run_list.irq_work_run.smp_irq_work_interrupt.irq_work_interrupt
      1.02 ± 12%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.perf_mux_hrtimer_handler.__hrtimer_run_queues.hrtimer_interrupt.local_apic_timer_interrupt.smp_apic_timer_interrupt
      0.54 ±173%  +18227.6%      98.05 ±  0%  perf-profile.cycles-pp.poll_idle.cpuidle_enter_state.cpuidle_enter.call_cpuidle.cpu_startup_entry
      1.40 ± 12%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.printk.perf_duration_warn.irq_work_run_list.irq_work_run.smp_irq_work_interrupt
      1.29 ± 12%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.serial8250_console_putchar.uart_console_write.serial8250_console_write.univ8250_console_write.call_console_drivers.constprop.23
      1.29 ± 12%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.serial8250_console_write.univ8250_console_write.call_console_drivers.constprop.23.console_unlock.vprintk_emit
      9.54 ± 12%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.smp_apic_timer_interrupt.apic_timer_interrupt.cpuidle_enter.call_cpuidle.cpu_startup_entry
      1.40 ± 12%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.smp_irq_work_interrupt.irq_work_interrupt.cpuidle_enter.call_cpuidle.cpu_startup_entry
      1.24 ± 26%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.tick_irq_enter.irq_enter.smp_apic_timer_interrupt.apic_timer_interrupt.cpuidle_enter
      2.03 ± 22%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.tick_nohz_irq_exit.irq_exit.smp_apic_timer_interrupt.apic_timer_interrupt.cpuidle_enter
      1.50 ± 25%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.tick_nohz_stop_sched_tick.__tick_nohz_idle_enter.tick_nohz_irq_exit.irq_exit.smp_apic_timer_interrupt
      1.29 ± 12%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.uart_console_write.serial8250_console_write.univ8250_console_write.call_console_drivers.constprop.23.console_unlock
      1.29 ± 12%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.univ8250_console_write.call_console_drivers.constprop.23.console_unlock.vprintk_emit.vprintk_default
      1.40 ± 12%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.vprintk_default.printk.perf_duration_warn.irq_work_run_list.irq_work_run
      1.40 ± 12%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.vprintk_emit.vprintk_default.printk.perf_duration_warn.irq_work_run_list
      1.26 ± 14%    -100.0%       0.00 ± -1%  perf-profile.cycles-pp.wait_for_xmitr.serial8250_console_putchar.uart_console_write.serial8250_console_write.univ8250_console_write





                                  unixbench.score

  820 *+*--*-*-*--*-*-*--*-*-*--*-*-*--*-*-*--*-*-*--*-*-*--*-*-*--*--------+
      |                                                                     |
  800 ++                                                                    |
      |                                                                     |
  780 ++                                                                    |
      |                                                                     |
  760 ++                                                                    |
      |                                                                     |
  740 ++                                                                    |
      |                                                                     |
  720 ++                                                                    |
      |                                                                     |
  700 ++                                                                    |
      O O  O O O  O O O  O O O  O O O  O O O  O O O  O O O  O O O  O O O  O O
  680 ++--------------------------------------------------------------------+


	[*] bisect-good sample
	[O] bisect-bad  sample



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

View attachment "config-4.7.0-rc3-00007-g8c82d5a" of type "text/plain" (150917 bytes)

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

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

Powered by blists - more mailing lists

Powered by Openwall GNU/*/Linux Powered by OpenVZ