2015-11-10 02:28:09

by kernel test robot

[permalink] [raw]
Subject: [lkp] [cpuidle,menu] 0c30c691fe: -9.9% fsmark.app_overhead, +76.7% turbostat.%Busy

FYI, we noticed the below changes on

https://github.com/0day-ci/linux riel-redhat-com/cpuidle-small-improvements-fixes-for-menu-governor-resend/20151104-063831
commit 0c30c691fe875fc1f8d6ac97c36d914830ff36bd ("cpuidle,menu: use interactivity_req to disable polling")


=========================================================================================
tbox_group/testcase/rootfs/kconfig/compiler/cpufreq_governor/iterations/nr_threads/disk/fs/filesize/test_size/sync_method/nr_directories/nr_files_per_directory:
lkp-ne04/fsmark/debian-x86_64-2015-02-07.cgz/x86_64-rhel/gcc-4.9/performance/1x/32t/1HDD/f2fs/5K/400M/fsyncBeforeClose/16d/256fpd

commit:
1de5243ef31e0f138ca13fe28524819da648fab3
0c30c691fe875fc1f8d6ac97c36d914830ff36bd

1de5243ef31e0f13 0c30c691fe875fc1f8d6ac97c3
---------------- --------------------------
%stddev %change %stddev
\ | \
7509492 ? 6% -9.9% 6763959 ? 5% fsmark.app_overhead
1539 ? 0% -6.8% 1434 ? 0% vmstat.system.in
0.00 ? -1% +Inf% 6139416 ?106% latency_stats.avg.nfs_wait_on_request.nfs_updatepage.nfs_write_end.generic_perform_write.__generic_file_write_iter.generic_file_write_iter.nfs_file_write.__vfs_write.vfs_write.SyS_write.entry_SYSCALL_64_fastpath
0.00 ? -1% +Inf% 6139416 ?106% latency_stats.max.nfs_wait_on_request.nfs_updatepage.nfs_write_end.generic_perform_write.__generic_file_write_iter.generic_file_write_iter.nfs_file_write.__vfs_write.vfs_write.SyS_write.entry_SYSCALL_64_fastpath
0.00 ? -1% +Inf% 6139416 ?106% latency_stats.sum.nfs_wait_on_request.nfs_updatepage.nfs_write_end.generic_perform_write.__generic_file_write_iter.generic_file_write_iter.nfs_file_write.__vfs_write.vfs_write.SyS_write.entry_SYSCALL_64_fastpath
52047094 ? 5% -72.4% 14389925 ? 6% cpuidle.C1-NHM.time
240980 ? 4% -94.7% 12665 ? 4% cpuidle.C1-NHM.usage
49879 ? 38% +84818.1% 42356292 ? 9% cpuidle.POLL.time
1948 ? 19% +11824.2% 232344 ? 4% cpuidle.POLL.usage
1.95 ? 1% +76.7% 3.45 ? 3% turbostat.%Busy
38.50 ? 1% +127.3% 87.50 ? 5% turbostat.Avg_MHz
1969 ? 0% +29.1% 2541 ? 1% turbostat.Bzy_MHz
7.40 ? 1% -15.4% 6.26 ? 2% turbostat.CPU%c1
1750 ? 27% -23.4% 1340 ? 35% sched_debug.cfs_rq[11]:/.exec_clock
1.50 ? 33% +216.7% 4.75 ? 37% sched_debug.cfs_rq[12]:/.nr_spread_over
7.00 ? 14% -50.0% 3.50 ? 65% sched_debug.cfs_rq[13]:/.nr_spread_over
2722 ? 6% +30.4% 3550 ? 11% sched_debug.cfs_rq[14]:/.min_vruntime
1610 ? 17% +27.9% 2058 ? 8% sched_debug.cfs_rq[15]:/.exec_clock
3225 ? 15% +30.4% 4206 ? 9% sched_debug.cfs_rq[15]:/.min_vruntime
6755 ? 3% -44.8% 3726 ? 42% sched_debug.cfs_rq[3]:/.exec_clock
111.00 ? 85% -100.0% 0.00 ? -1% sched_debug.cfs_rq[3]:/.load
9237 ? 1% -40.1% 5534 ? 34% sched_debug.cfs_rq[3]:/.min_vruntime
41.50 ? 34% -100.0% 0.00 ? -1% sched_debug.cfs_rq[3]:/.runnable_load_avg
3879 ? 15% -110.0% -388.37 ?-712% sched_debug.cfs_rq[3]:/.spread0
322.50 ? 5% -100.0% 0.00 ? -1% sched_debug.cfs_rq[3]:/.utilization_load_avg
2596 ? 22% +70.5% 4428 ? 33% sched_debug.cfs_rq[4]:/.avg->runnable_avg_sum
55.50 ? 22% +73.9% 96.50 ? 33% sched_debug.cfs_rq[4]:/.tg_runnable_contrib
6225 ? 25% -34.9% 4051 ? 25% sched_debug.cfs_rq[5]:/.min_vruntime
8.00 ? 25% -50.0% 4.00 ? 30% sched_debug.cfs_rq[5]:/.nr_spread_over
867.69 ?130% -315.7% -1871 ?-70% sched_debug.cfs_rq[5]:/.spread0
2468 ? 5% +19.7% 2953 ? 7% sched_debug.cfs_rq[6]:/.avg->runnable_avg_sum
2007 ? 8% -52.0% 962.75 ? 50% sched_debug.cfs_rq[6]:/.blocked_load_avg
2060 ? 7% -53.2% 965.00 ? 49% sched_debug.cfs_rq[6]:/.tg_load_contrib
53.00 ? 5% +20.8% 64.00 ? 6% sched_debug.cfs_rq[6]:/.tg_runnable_contrib
1523 ? 3% +118.3% 3325 ? 32% sched_debug.cfs_rq[7]:/.exec_clock
4211 ? 1% +21.2% 5103 ? 18% sched_debug.cfs_rq[7]:/.min_vruntime
1101 ? 6% +41.7% 1560 ? 22% sched_debug.cfs_rq[8]:/.exec_clock
2031 ? 27% -51.7% 981.25 ? 59% sched_debug.cfs_rq[9]:/.blocked_load_avg
-1233 ?-74% +149.3% -3075 ?-28% sched_debug.cfs_rq[9]:/.spread0
963152 ? 2% -20.7% 763351 ? 9% sched_debug.cpu#0.avg_idle
-1808 ? -1% +7.7% -1947 ? -3% sched_debug.cpu#0.nr_uninterruptible
18.00 ? 0% -96.3% 0.67 ?141% sched_debug.cpu#1.cpu_load[1]
13.50 ? 11% -90.1% 1.33 ?141% sched_debug.cpu#1.cpu_load[2]
9.50 ? 15% -92.1% 0.75 ?173% sched_debug.cpu#1.cpu_load[3]
6.50 ? 7% -74.4% 1.67 ? 74% sched_debug.cpu#1.cpu_load[4]
38209 ? 3% +24.2% 47439 ? 15% sched_debug.cpu#10.nr_switches
38245 ? 3% +26.3% 48291 ? 14% sched_debug.cpu#10.sched_count
0.00 ? 0% +Inf% 4.50 ? 71% sched_debug.cpu#12.cpu_load[3]
73134 ? 5% -47.1% 38683 ? 3% sched_debug.cpu#12.nr_switches
73179 ? 5% -47.1% 38721 ? 3% sched_debug.cpu#12.sched_count
34479 ? 5% -50.3% 17139 ? 3% sched_debug.cpu#12.sched_goidle
1920 ? 2% -13.3% 1663 ? 6% sched_debug.cpu#13.ttwu_local
39693 ? 4% +12.9% 44825 ? 6% sched_debug.cpu#14.sched_count
764.00 ? 4% +23.7% 944.75 ? 10% sched_debug.cpu#14.ttwu_local
232.50 ? 9% -13.7% 200.75 ? 9% sched_debug.cpu#15.nr_uninterruptible
1000000 ? 0% -15.1% 849463 ? 8% sched_debug.cpu#2.avg_idle
-56.50 ?-36% +73.9% -98.25 ?-24% sched_debug.cpu#2.nr_uninterruptible
590.50 ? 43% -100.0% 0.00 ? -1% sched_debug.cpu#3.curr->pid
111.00 ? 85% -100.0% 0.00 ? -1% sched_debug.cpu#3.load
31005 ? 20% -23.0% 23886 ? 7% sched_debug.cpu#3.ttwu_count
900645 ? 0% -14.3% 771998 ? 7% sched_debug.cpu#4.avg_idle
33801 ? 21% -26.1% 24967 ? 12% sched_debug.cpu#4.ttwu_count
851849 ? 7% -15.0% 724256 ? 15% sched_debug.cpu#5.avg_idle
1905 ? 6% +30.3% 2483 ? 13% sched_debug.cpu#6.ttwu_local
12046 ? 1% -8.7% 10997 ? 7% sched_debug.cpu#9.nr_load_updates

=========================================================================================
tbox_group/testcase/rootfs/kconfig/compiler/cpufreq_governor/iterations/nr_threads/disk/fs/fs2/filesize/test_size/sync_method/nr_directories/nr_files_per_directory:
nhm4/fsmark/debian-x86_64-2015-02-07.cgz/x86_64-rhel/gcc-4.9/performance/1x/32t/1HDD/f2fs/nfsv4/16MB/60G/NoSync/16d/256fpd

commit:
1de5243ef31e0f138ca13fe28524819da648fab3
0c30c691fe875fc1f8d6ac97c36d914830ff36bd

1de5243ef31e0f13 0c30c691fe875fc1f8d6ac97c3
---------------- --------------------------
%stddev %change %stddev
\ | \
2.966e+08 ? 2% +5.8% 3.137e+08 ? 1% fsmark.app_overhead
2681995 ? 0% +5.1% 2817555 ? 0% fsmark.time.voluntary_context_switches
31908 ? 0% +1.9% 32517 ? 0% vmstat.system.cs
5.88 ? 1% +179.6% 16.44 ? 3% turbostat.%Busy
194.50 ? 1% +182.4% 549.25 ? 3% turbostat.Avg_MHz
25.23 ? 3% -28.8% 17.96 ? 3% turbostat.CPU%c1
5.785e+08 ? 4% -73.8% 1.517e+08 ? 4% cpuidle.C1-NHM.time
7183573 ? 0% -33.4% 4785240 ? 0% cpuidle.C1-NHM.usage
24298203 ? 11% +2162.0% 5.496e+08 ? 4% cpuidle.POLL.time
24755 ? 3% +10280.9% 2569797 ? 1% cpuidle.POLL.usage
1074 ? 38% +68.3% 1807 ? 40% sched_debug.cfs_rq[1]:/.blocked_load_avg
22.00 ? 96% +176.1% 60.75 ? 27% sched_debug.cfs_rq[1]:/.runnable_load_avg
1105 ? 39% +69.4% 1873 ? 38% sched_debug.cfs_rq[1]:/.tg_load_contrib
1811 ? 41% -54.7% 821.25 ? 34% sched_debug.cfs_rq[2]:/.blocked_load_avg
1849 ? 40% -53.9% 853.25 ? 35% sched_debug.cfs_rq[2]:/.tg_load_contrib
2245 ? 27% -36.3% 1431 ? 25% sched_debug.cfs_rq[4]:/.blocked_load_avg
2242 ?156% -95.8% 93.67 ? 72% sched_debug.cfs_rq[4]:/.load
2478 ? 24% -40.8% 1467 ? 24% sched_debug.cfs_rq[4]:/.tg_load_contrib
201.50 ? 22% -53.5% 93.67 ? 72% sched_debug.cpu#4.load
25.75 ?109% +150.5% 64.50 ? 33% sched_debug.cpu#5.cpu_load[1]
117.50 ? 12% +19.8% 140.75 ? 12% sched_debug.cpu#6.nr_uninterruptible
249339 ? 6% +266.3% 913374 ?119% sched_debug.cpu#7.ttwu_count
52587 ? 4% +1208.6% 688188 ?159% sched_debug.cpu#7.ttwu_local

=========================================================================================
tbox_group/testcase/rootfs/kconfig/compiler/test:
lkp-sb03/will-it-scale/debian-x86_64-2015-02-07.cgz/x86_64-rhel/gcc-4.9/brk1

commit:
1de5243ef31e0f138ca13fe28524819da648fab3
0c30c691fe875fc1f8d6ac97c36d914830ff36bd

1de5243ef31e0f13 0c30c691fe875fc1f8d6ac97c3
---------------- --------------------------
%stddev %change %stddev
\ | \
104.75 ? 2% +6.2% 111.25 ? 1% will-it-scale.time.percent_of_cpu_this_job_got
330.49 ? 2% +8.1% 357.41 ? 1% will-it-scale.time.system_time
35829732 ? 1% -2.4% 34975224 ? 1% will-it-scale.time.voluntary_context_switches
5081 ? 19% -20.0% 4067 ? 0% numa-meminfo.node1.AnonHugePages
10097 ? 5% +16.5% 11766 ? 7% slabinfo.kmalloc-256.active_objs
10979 ? 5% +14.4% 12565 ? 7% slabinfo.kmalloc-256.num_objs
226317 ? 1% -3.6% 218100 ? 1% vmstat.system.cs
19905 ? 4% -16.5% 16619 ? 4% vmstat.system.in
5449 ? 79% +114.3% 11678 ?173% latency_stats.avg.call_rwsem_down_read_failed.task_numa_work.task_work_run.do_notify_resume.retint_signal
5533 ? 78% +111.1% 11678 ?173% latency_stats.max.call_rwsem_down_read_failed.task_numa_work.task_work_run.do_notify_resume.retint_signal
6440 ? 5% +489.7% 37980 ? 88% latency_stats.max.call_rwsem_down_write_failed.SyS_mprotect.entry_SYSCALL_64_fastpath
7367 ? 70% +58.5% 11678 ?173% latency_stats.sum.call_rwsem_down_read_failed.task_numa_work.task_work_run.do_notify_resume.retint_signal
9213 ? 23% +327.4% 39378 ? 87% latency_stats.sum.call_rwsem_down_write_failed.SyS_mprotect.entry_SYSCALL_64_fastpath
28.29 ? 0% +68.1% 47.56 ? 0% turbostat.%Busy
875.25 ? 0% +67.6% 1466 ? 0% turbostat.Avg_MHz
42.84 ? 0% -43.4% 24.25 ? 0% turbostat.CPU%c1
0.04 ? 14% -57.1% 0.01 ? 33% turbostat.CPU%c3
95.41 ? 0% +22.0% 116.38 ? 0% turbostat.CorWatt
47.00 ? 1% +14.4% 53.75 ? 0% turbostat.CoreTmp
47.50 ? 1% +14.7% 54.50 ? 2% turbostat.PkgTmp
122.99 ? 0% +17.1% 143.99 ? 0% turbostat.PkgWatt
2.127e+09 ? 1% -89.7% 2.184e+08 ? 4% cpuidle.C1-SNB.time
26448928 ? 7% -88.4% 3068569 ? 35% cpuidle.C1-SNB.usage
6961573 ? 37% -49.3% 3531923 ? 13% cpuidle.C1E-SNB.time
3507 ? 22% -42.9% 2002 ? 8% cpuidle.C1E-SNB.usage
2388876 ? 39% -51.0% 1171617 ? 11% cpuidle.C3-SNB.time
2058 ? 21% -54.7% 931.25 ? 12% cpuidle.C3-SNB.usage
287398 ? 2% -11.2% 255069 ? 0% cpuidle.C7-SNB.usage
782931 ?171% +2.6e+05% 2.02e+09 ? 0% cpuidle.POLL.time
2079 ? 12% +1.2e+06% 25220612 ? 3% cpuidle.POLL.usage
2.75 ? 30% +81.8% 5.00 ? 14% sched_debug.cfs_rq[0]:/.nr_spread_over
905.00 ? 31% +136.6% 2141 ? 15% sched_debug.cfs_rq[11]:/.avg->runnable_avg_sum
102.50 ? 95% +599.8% 717.25 ?114% sched_debug.cfs_rq[11]:/.blocked_load_avg
1.75 ? 62% +257.1% 6.25 ? 47% sched_debug.cfs_rq[11]:/.nr_spread_over
103.50 ? 96% +607.0% 731.75 ?114% sched_debug.cfs_rq[11]:/.tg_load_contrib
19.25 ? 33% +139.0% 46.00 ? 15% sched_debug.cfs_rq[11]:/.tg_runnable_contrib
4000 ? 50% +86.5% 7460 ? 51% sched_debug.cfs_rq[1]:/.avg->runnable_avg_sum
87.25 ? 52% +85.7% 162.00 ? 51% sched_debug.cfs_rq[1]:/.tg_runnable_contrib
488.25 ? 61% -81.4% 91.00 ? 87% sched_debug.cfs_rq[20]:/.blocked_load_avg
464.00 ? 15% -43.9% 260.25 ? 54% sched_debug.cfs_rq[22]:/.blocked_load_avg
474.50 ? 15% -42.1% 274.75 ? 46% sched_debug.cfs_rq[22]:/.tg_load_contrib
11201 ? 16% -28.6% 8000 ? 10% sched_debug.cfs_rq[26]:/.tg_load_avg
11196 ? 16% -33.2% 7476 ? 20% sched_debug.cfs_rq[27]:/.tg_load_avg
10602 ? 18% -29.4% 7489 ? 20% sched_debug.cfs_rq[28]:/.tg_load_avg
10546 ? 19% -29.0% 7489 ? 20% sched_debug.cfs_rq[29]:/.tg_load_avg
10552 ? 19% -29.5% 7439 ? 20% sched_debug.cfs_rq[30]:/.tg_load_avg
10502 ? 20% -29.6% 7398 ? 20% sched_debug.cfs_rq[31]:/.tg_load_avg
899.75 ? 63% -75.9% 217.25 ? 75% sched_debug.cfs_rq[3]:/.tg_load_contrib
33.00 ? -3% +166.7% 88.00 ? 20% sched_debug.cfs_rq[9]:/.load
12.00 ? -8% +306.2% 48.75 ? 74% sched_debug.cfs_rq[9]:/.runnable_load_avg
55.00 ? -1% +431.8% 292.50 ? 26% sched_debug.cfs_rq[9]:/.utilization_load_avg
2.50 ?107% +410.0% 12.75 ? 36% sched_debug.cpu#1.cpu_load[2]
2.00 ? 79% +687.5% 15.75 ? 34% sched_debug.cpu#1.cpu_load[3]
2.50 ? 72% +570.0% 16.75 ? 51% sched_debug.cpu#1.cpu_load[4]
2252 ? 22% +44.8% 3260 ? 13% sched_debug.cpu#1.ttwu_local
5.00 ? 61% +100.0% 10.00 ? 27% sched_debug.cpu#13.cpu_load[4]
23.25 ? 54% -81.4% 4.33 ? 96% sched_debug.cpu#14.cpu_load[1]
19.50 ? 61% -76.1% 4.67 ? 82% sched_debug.cpu#14.cpu_load[2]
15.50 ? 86% -78.5% 3.33 ? 78% sched_debug.cpu#14.cpu_load[3]
13.00 ?107% -84.6% 2.00 ? 70% sched_debug.cpu#14.cpu_load[4]
9.50 ? 27% -39.5% 5.75 ? 37% sched_debug.cpu#16.cpu_load[2]
7.50 ? 22% -40.0% 4.50 ? 33% sched_debug.cpu#16.cpu_load[3]
676459 ? 8% +18.9% 804468 ? 13% sched_debug.cpu#2.avg_idle
-1.00 ?-70% -425.0% 3.25 ? 54% sched_debug.cpu#21.nr_uninterruptible
1971003 ? 9% -21.7% 1544151 ? 19% sched_debug.cpu#23.nr_switches
2043058 ? 9% -21.2% 1610570 ? 18% sched_debug.cpu#23.sched_count
985071 ? 9% -21.6% 771987 ? 19% sched_debug.cpu#23.sched_goidle
1244880 ? 32% -38.7% 763279 ? 27% sched_debug.cpu#23.ttwu_count
8.25 ? 78% -75.8% 2.00 ?108% sched_debug.cpu#28.cpu_load[3]
6.75 ? 54% -81.5% 1.25 ? 34% sched_debug.cpu#28.cpu_load[4]
376.00 ? 2% +18.2% 444.25 ? 11% sched_debug.cpu#28.ttwu_local
17.25 ? 54% -72.5% 4.75 ? 73% sched_debug.cpu#29.cpu_load[2]
14.25 ? 45% -73.7% 3.75 ? 68% sched_debug.cpu#29.cpu_load[3]
11.00 ? 49% -72.7% 3.00 ? 62% sched_debug.cpu#29.cpu_load[4]
165177 ? 37% +133.9% 386374 ? 29% sched_debug.cpu#29.nr_switches
177745 ? 38% +129.4% 407813 ? 28% sched_debug.cpu#29.sched_count
82161 ? 37% +134.9% 193016 ? 29% sched_debug.cpu#29.sched_goidle
689.75 ? 62% -41.4% 404.00 ? 7% sched_debug.cpu#29.ttwu_local
-3.75 ?-80% -180.0% 3.00 ?105% sched_debug.cpu#5.nr_uninterruptible
774864 ? 37% -50.6% 382807 ? 31% sched_debug.cpu#5.ttwu_count
897279 ? 7% -13.7% 774608 ? 5% sched_debug.cpu#8.avg_idle
778200 ? 8% +22.0% 949175 ? 2% sched_debug.cpu#9.avg_idle
1389 ? 0% +4.0% 1444 ? 66% sched_debug.cpu#9.curr->pid
33.00 ? -3% +166.7% 88.00 ? 20% sched_debug.cpu#9.load
-5.25 ?-88% -138.1% 2.00 ? 79% sched_debug.cpu#9.nr_uninterruptible
1914 ? 24% +81.7% 3479 ? 37% sched_debug.cpu#9.ttwu_local
1.82 ? 19% -47.9% 0.95 ? 26% perf-profile.cycles.__account_scheduler_latency.enqueue_entity.enqueue_task_fair.enqueue_task.activate_task
1.84 ? 6% -58.4% 0.77 ? 10% perf-profile.cycles.__remove_hrtimer.hrtimer_start_range_ns.tick_nohz_stop_sched_tick.__tick_nohz_idle_enter.tick_nohz_idle_enter
0.60 ? 45% -62.7% 0.23 ? 28% perf-profile.cycles.__remove_hrtimer.hrtimer_try_to_cancel.hrtimer_cancel.tick_nohz_restart.tick_nohz_idle_exit
15.17 ? 6% -66.2% 5.13 ? 11% perf-profile.cycles.__rwsem_do_wake.rwsem_wake.call_rwsem_wake.sys_brk.entry_SYSCALL_64_fastpath
6.64 ? 3% -64.2% 2.38 ? 5% perf-profile.cycles.__schedule.schedule.rwsem_down_write_failed.call_rwsem_down_write_failed.sys_brk
4.99 ? 3% -66.5% 1.67 ? 6% perf-profile.cycles.__schedule.schedule.schedule_preempt_disabled.cpu_startup_entry.start_secondary
4.76 ? 1% -69.2% 1.47 ? 11% perf-profile.cycles.__split_vma.isra.34.do_munmap.sys_brk.entry_SYSCALL_64_fastpath
4.80 ? 2% -59.7% 1.94 ? 10% perf-profile.cycles.__tick_nohz_idle_enter.tick_nohz_idle_enter.cpu_startup_entry.start_secondary
0.89 ? 17% -65.5% 0.31 ? 19% perf-profile.cycles._raw_spin_lock.try_to_wake_up.wake_up_process.__rwsem_do_wake.rwsem_wake
2.41 ? 21% -56.4% 1.05 ? 33% perf-profile.cycles._raw_spin_lock_irqsave.rwsem_wake.call_rwsem_wake.sys_brk.entry_SYSCALL_64_fastpath
6.50 ? 8% -63.1% 2.40 ? 11% perf-profile.cycles.activate_task.ttwu_do_activate.try_to_wake_up.wake_up_process.__rwsem_do_wake
1.81 ? 10% -69.4% 0.55 ? 19% perf-profile.cycles.anon_vma_clone.__split_vma.do_munmap.sys_brk.entry_SYSCALL_64_fastpath
5.59 ? 8% +1133.2% 68.97 ? 1% perf-profile.cycles.call_cpuidle.cpu_startup_entry.start_secondary
21.03 ? 6% -69.6% 6.38 ? 17% perf-profile.cycles.call_rwsem_down_write_failed.sys_brk.entry_SYSCALL_64_fastpath
19.17 ? 7% -64.8% 6.74 ? 13% perf-profile.cycles.call_rwsem_wake.sys_brk.entry_SYSCALL_64_fastpath
1.28 ? 4% -69.6% 0.39 ? 13% perf-profile.cycles.check_preempt_curr.ttwu_do_wakeup.ttwu_do_activate.try_to_wake_up.wake_up_process
1.55 ? 6% -60.6% 0.61 ? 14% perf-profile.cycles.clockevents_program_event.tick_program_event.__remove_hrtimer.hrtimer_start_range_ns.tick_nohz_stop_sched_tick
1.59 ? 4% -64.7% 0.56 ? 11% perf-profile.cycles.clockevents_program_event.tick_program_event.hrtimer_start_range_ns.tick_nohz_restart.tick_nohz_idle_exit
24.94 ? 3% +204.7% 76.00 ? 1% perf-profile.cycles.cpu_startup_entry.start_secondary
5.24 ? 10% +1212.7% 68.82 ? 1% perf-profile.cycles.cpuidle_enter.call_cpuidle.cpu_startup_entry.start_secondary
5.02 ? 11% +1269.6% 68.79 ? 1% perf-profile.cycles.cpuidle_enter_state.cpuidle_enter.call_cpuidle.cpu_startup_entry.start_secondary
1.77 ? 2% -66.4% 0.60 ? 3% perf-profile.cycles.cpuidle_select.cpu_startup_entry.start_secondary
3.48 ? 2% -63.2% 1.28 ? 5% perf-profile.cycles.deactivate_task.__schedule.schedule.rwsem_down_write_failed.call_rwsem_down_write_failed
2.58 ? 3% -63.3% 0.95 ? 5% perf-profile.cycles.dequeue_entity.dequeue_task_fair.dequeue_task.deactivate_task.__schedule
3.40 ? 2% -63.1% 1.26 ? 5% perf-profile.cycles.dequeue_task.deactivate_task.__schedule.schedule.rwsem_down_write_failed
3.12 ? 3% -63.1% 1.15 ? 4% perf-profile.cycles.dequeue_task_fair.dequeue_task.deactivate_task.__schedule.schedule
10.49 ? 1% -70.5% 3.09 ? 7% perf-profile.cycles.do_brk.sys_brk.entry_SYSCALL_64_fastpath
11.80 ? 2% -70.0% 3.54 ? 11% perf-profile.cycles.do_munmap.sys_brk.entry_SYSCALL_64_fastpath
1.85 ? 3% -68.0% 0.59 ? 5% perf-profile.cycles.down_write.sys_brk.entry_SYSCALL_64_fastpath
1.60 ? 18% -46.8% 0.85 ? 27% perf-profile.cycles.dump_trace.save_stack_trace_tsk.__account_scheduler_latency.enqueue_entity.enqueue_task_fair
5.17 ? 11% -61.1% 2.01 ? 14% perf-profile.cycles.enqueue_entity.enqueue_task_fair.enqueue_task.activate_task.ttwu_do_activate
6.49 ? 8% -63.1% 2.39 ? 12% perf-profile.cycles.enqueue_task.activate_task.ttwu_do_activate.try_to_wake_up.wake_up_process
5.72 ? 9% -61.9% 2.18 ? 13% perf-profile.cycles.enqueue_task_fair.enqueue_task.activate_task.ttwu_do_activate.try_to_wake_up
68.68 ? 0% -68.5% 21.63 ? 4% perf-profile.cycles.entry_SYSCALL_64_fastpath
1.60 ? 11% -73.2% 0.43 ? 28% perf-profile.cycles.find_vma.do_munmap.sys_brk.entry_SYSCALL_64_fastpath
1.39 ? 9% -69.1% 0.43 ? 30% perf-profile.cycles.find_vma.sys_brk.entry_SYSCALL_64_fastpath
1.07 ? 5% -67.4% 0.35 ? 7% perf-profile.cycles.free_pgtables.unmap_region.do_munmap.sys_brk.entry_SYSCALL_64_fastpath
1.06 ? 20% -60.8% 0.42 ? 12% perf-profile.cycles.hrtimer_cancel.tick_nohz_restart.tick_nohz_idle_exit.cpu_startup_entry.start_secondary
2.34 ? 7% -63.9% 0.85 ? 9% perf-profile.cycles.hrtimer_start_range_ns.tick_nohz_restart.tick_nohz_idle_exit.cpu_startup_entry.start_secondary
3.25 ? 9% -61.0% 1.27 ? 10% perf-profile.cycles.hrtimer_start_range_ns.tick_nohz_stop_sched_tick.__tick_nohz_idle_enter.tick_nohz_idle_enter.cpu_startup_entry
1.10 ? 27% -64.5% 0.39 ? 12% perf-profile.cycles.hrtimer_try_to_cancel.hrtimer_cancel.tick_nohz_restart.tick_nohz_idle_exit.cpu_startup_entry
4.74 ? 8% -98.1% 0.09 ? 20% perf-profile.cycles.intel_idle.cpuidle_enter_state.cpuidle_enter.call_cpuidle.cpu_startup_entry
1.19 ? 7% -61.5% 0.46 ? 13% perf-profile.cycles.lapic_next_deadline.clockevents_program_event.tick_program_event.__remove_hrtimer.hrtimer_start_range_ns
1.23 ? 5% -64.4% 0.44 ? 18% perf-profile.cycles.lapic_next_deadline.clockevents_program_event.tick_program_event.hrtimer_start_range_ns.tick_nohz_restart
1.52 ? 3% -64.9% 0.54 ? 2% perf-profile.cycles.menu_select.cpuidle_select.cpu_startup_entry.start_secondary
2.06 ? 21% -55.2% 0.92 ? 35% perf-profile.cycles.native_queued_spin_lock_slowpath._raw_spin_lock_irqsave.rwsem_wake.call_rwsem_wake.sys_brk
1.43 ? 16% -61.5% 0.55 ? 13% perf-profile.cycles.native_write_msr_safe.lapic_next_deadline.clockevents_program_event.tick_program_event.__remove_hrtimer
1.46 ? 9% -64.3% 0.52 ? 19% perf-profile.cycles.native_write_msr_safe.lapic_next_deadline.clockevents_program_event.tick_program_event.hrtimer_start_range_ns
3.45 ? 4% -68.6% 1.08 ? 5% perf-profile.cycles.perf_event_aux.perf_event_mmap.do_brk.sys_brk.entry_SYSCALL_64_fastpath
1.05 ? 7% -70.8% 0.31 ? 15% perf-profile.cycles.perf_event_aux_ctx.perf_event_aux.perf_event_mmap.do_brk.sys_brk
4.67 ? 5% -68.7% 1.46 ? 3% perf-profile.cycles.perf_event_mmap.do_brk.sys_brk.entry_SYSCALL_64_fastpath
3.15 ? 7% -67.0% 1.04 ? 4% perf-profile.cycles.pick_next_task_fair.__schedule.schedule.schedule_preempt_disabled.cpu_startup_entry
0.00 ? -1% +Inf% 68.91 ? 1% perf-profile.cycles.poll_idle.cpuidle_enter_state.cpuidle_enter.call_cpuidle.cpu_startup_entry
1.44 ? 18% -47.1% 0.77 ? 28% perf-profile.cycles.print_context_stack.dump_trace.save_stack_trace_tsk.__account_scheduler_latency.enqueue_entity
20.94 ? 6% -69.6% 6.36 ? 17% perf-profile.cycles.rwsem_down_write_failed.call_rwsem_down_write_failed.sys_brk.entry_SYSCALL_64_fastpath
10.71 ? 11% -72.8% 2.92 ? 34% perf-profile.cycles.rwsem_spin_on_owner.rwsem_down_write_failed.call_rwsem_down_write_failed.sys_brk.entry_SYSCALL_64_fastpath
19.07 ? 7% -64.9% 6.70 ? 13% perf-profile.cycles.rwsem_wake.call_rwsem_wake.sys_brk.entry_SYSCALL_64_fastpath
1.63 ? 20% -46.9% 0.87 ? 27% perf-profile.cycles.save_stack_trace_tsk.__account_scheduler_latency.enqueue_entity.enqueue_task_fair.enqueue_task
6.92 ? 3% -64.3% 2.47 ? 6% perf-profile.cycles.schedule.rwsem_down_write_failed.call_rwsem_down_write_failed.sys_brk.entry_SYSCALL_64_fastpath
5.04 ? 3% -66.2% 1.71 ? 7% perf-profile.cycles.schedule.schedule_preempt_disabled.cpu_startup_entry.start_secondary
5.22 ? 3% -66.3% 1.76 ? 6% perf-profile.cycles.schedule_preempt_disabled.cpu_startup_entry.start_secondary
1.88 ? 10% -67.6% 0.61 ? 5% perf-profile.cycles.set_next_entity.pick_next_task_fair.__schedule.schedule.schedule_preempt_disabled
25.17 ? 3% +202.2% 76.07 ? 1% perf-profile.cycles.start_secondary
68.28 ? 0% -68.5% 21.51 ? 4% perf-profile.cycles.sys_brk.entry_SYSCALL_64_fastpath
5.05 ? 2% -59.8% 2.03 ? 9% perf-profile.cycles.tick_nohz_idle_enter.cpu_startup_entry.start_secondary
4.66 ? 2% -63.3% 1.71 ? 8% perf-profile.cycles.tick_nohz_idle_exit.cpu_startup_entry.start_secondary
3.53 ? 3% -63.3% 1.30 ? 10% perf-profile.cycles.tick_nohz_restart.tick_nohz_idle_exit.cpu_startup_entry.start_secondary
4.19 ? 4% -59.8% 1.68 ? 9% perf-profile.cycles.tick_nohz_stop_sched_tick.__tick_nohz_idle_enter.tick_nohz_idle_enter.cpu_startup_entry.start_secondary
1.61 ? 7% -59.9% 0.65 ? 12% perf-profile.cycles.tick_program_event.__remove_hrtimer.hrtimer_start_range_ns.tick_nohz_stop_sched_tick.__tick_nohz_idle_enter
1.66 ? 3% -64.1% 0.59 ? 12% perf-profile.cycles.tick_program_event.hrtimer_start_range_ns.tick_nohz_restart.tick_nohz_idle_exit.cpu_startup_entry
13.88 ? 6% -66.6% 4.63 ? 11% perf-profile.cycles.try_to_wake_up.wake_up_process.__rwsem_do_wake.rwsem_wake.call_rwsem_wake
8.76 ? 6% -64.6% 3.10 ? 11% perf-profile.cycles.ttwu_do_activate.constprop.83.try_to_wake_up.wake_up_process.__rwsem_do_wake.rwsem_wake
2.18 ? 0% -69.2% 0.67 ? 10% perf-profile.cycles.ttwu_do_wakeup.ttwu_do_activate.try_to_wake_up.wake_up_process.__rwsem_do_wake
3.42 ? 4% -68.8% 1.07 ? 11% perf-profile.cycles.unmap_region.do_munmap.sys_brk.entry_SYSCALL_64_fastpath
1.12 ? 3% -66.7% 0.37 ? 8% perf-profile.cycles.unmap_single_vma.unmap_vmas.unmap_region.do_munmap.sys_brk
1.56 ? 6% -66.9% 0.52 ? 11% perf-profile.cycles.unmap_vmas.unmap_region.do_munmap.sys_brk.entry_SYSCALL_64_fastpath
1.47 ? 2% -71.0% 0.43 ? 4% perf-profile.cycles.up_write.sys_brk.entry_SYSCALL_64_fastpath
1.86 ? 17% -75.7% 0.45 ? 40% perf-profile.cycles.up_write.vma_adjust.vma_merge.do_brk.sys_brk
1.17 ? 1% -67.5% 0.38 ? 10% perf-profile.cycles.update_cfs_shares.dequeue_entity.dequeue_task_fair.dequeue_task.deactivate_task
1.16 ? 8% -72.5% 0.32 ? 17% perf-profile.cycles.update_cfs_shares.enqueue_entity.enqueue_task_fair.enqueue_task.activate_task
1.98 ? 5% -67.8% 0.64 ? 7% perf-profile.cycles.vma_adjust.__split_vma.do_munmap.sys_brk.entry_SYSCALL_64_fastpath
3.52 ? 11% -74.1% 0.91 ? 21% perf-profile.cycles.vma_adjust.vma_merge.do_brk.sys_brk.entry_SYSCALL_64_fastpath
4.04 ? 8% -74.7% 1.02 ? 21% perf-profile.cycles.vma_merge.do_brk.sys_brk.entry_SYSCALL_64_fastpath
14.71 ? 6% -66.3% 4.96 ? 11% perf-profile.cycles.wake_up_process.__rwsem_do_wake.rwsem_wake.call_rwsem_wake.sys_brk


lkp-ne04: Nehalem-EP
Memory: 12G

nhm4: Nehalem
Memory: 4G

lkp-sb03: Sandy Bridge-EP
Memory: 64G


cpuidle.POLL.time

2.5e+09 ++----------------------------------------------------------------+
O O O O |
| O O O O O O O O O O O O O O O O O O O |
2e+09 ++ O O O O |
| |
| |
1.5e+09 ++ |
| |
1e+09 ++ |
| |
| |
5e+08 ++ |
| |
| |
0 *+*-*--*-*-*-*-*--*-*-*-*-*--*-*-*-*-*--*-*-*-*-*--*-*-*-*-*--*-*-*


cpuidle.POLL.usage

3e+07 ++----------------------------------------------------------------+
| O O O O O O O O O O |
2.5e+07 ++O O O O O O O O O O |
O O O O O O |
| O |
2e+07 ++ |
| |
1.5e+07 ++ |
| |
1e+07 ++ |
| |
| |
5e+06 ++ |
| |
0 *+*-*--*-*-*-*-*--*-*-*-*-*--*-*-*-*-*--*-*-*-*-*--*-*-*-*-*--*-*-*


cpuidle.C1-SNB.time

2.5e+09 ++----------------------------------------------------------------+
| |
*.*.*..*.*.*.*.*..*.*.*.*.*..*.*.*.*.*..*.* *.*..*.*.*.*.*..*.*.*
2e+09 ++ : : |
| : : |
| : : |
1.5e+09 ++ : : |
| : : |
1e+09 ++ : : |
| : : |
| : : |
5e+08 ++ :: |
| : |
O O O O O O O O O O O O O O O O O O O O O O O O |
0 ++-----------O-O--O-------------------------*---------------------+


cpuidle.C1-SNB.usage

3.5e+07 ++----------------------------------------------------------------+
| |
3e+07 *+ .*..*.*.*.*.*..*.*. .*.*.. |
| * *.*.*..*.*.* *. .*.. .*.*.*. .*.* |
2.5e+07 ++ * * * *. +|
| : : *
2e+07 ++ : : |
| : : |
1.5e+07 ++ : : |
| : : |
1e+07 ++ : : |
| : : |
5e+06 ++ : O |
| O O O O O O O O O O O O O O O O O |
0 O+O-O--O-O-O-O-O--O-------------------------*---------------------+


turbostat.Avg_MHz

1600 ++-------------------------------------------------------------------+
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 |
1400 ++ |
1200 ++ |
| |
1000 ++ |
*.*..*.*.*..*.*.*.*..*.*.*..*.*.*..*.*.*.*..* *..*.*.*..*.*.*.*..*.*
800 ++ : : |
| : : |
600 ++ : : |
400 ++ : : |
| : : |
200 ++ :: |
| : |
0 ++--------------------------------------------*----------------------+


turbostat._Busy

50 O+---O-O-O--O-O--O-O-O--O-O-O--O-O--O-O------O-O-----------------------+
45 ++O O O O O O O O O |
| |
40 ++ |
35 ++ |
| |
30 *+*..*.*.*..*.*..*.*.*..*.*.*..*.*..*.*.*..*.* *.*.*..*.*..*.*.*..*.*
25 ++ : : |
20 ++ : : |
| : : |
15 ++ : : |
10 ++ : : |
| :: |
5 ++ : |
0 ++---------------------------------------------*-----------------------+


turbostat.CPU_c1

45 ++---------------------------------------------------------------------+
*.*..*.*.*..*.*..*.*.*..*.*.*..*.*..*.*.*..*.* *.*.*..*.*..*.*.*..*.*
40 ++ : : |
35 ++ : : |
| : : |
30 ++ : : |
25 ++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 |
20 ++ : : |
15 ++ : : |
| : : |
10 ++ :: |
5 ++ : |
| : |
0 ++---------------------------------------------*-----------------------+


turbostat.PkgWatt

160 ++--------------------------------------------------------------------+
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 |
140 ++ |
120 *+*..*.*.*..*.*.*..*.*.*..*.*.*..*.*.*..*.*.* *.*..*.*.*..*.*.*..*.*
| : : |
100 ++ : : |
| : : |
80 ++ : : |
| : : |
60 ++ : : |
40 ++ : : |
| : : |
20 ++ :: |
| : |
0 ++---------------------------------------------*----------------------+


turbostat.CorWatt

120 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--------+
| |
100 ++ |
*.*..*.*.*..*.*.*..*.*.*..*.*.*..*.*.*..*.*.* *.*..*.*.*..*.*.*..*.*
| : : |
80 ++ : : |
| : : |
60 ++ : : |
| : : |
40 ++ : : |
| : : |
| : : |
20 ++ :: |
| : |
0 ++---------------------------------------------*----------------------+




80 ++---------------------------------------------------------------------+
| |
70 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
60 ++ |
| |
50 ++ |
| |
40 ++ |
| |
30 ++ |
20 ++ |
| |
10 ++ |
| |
0 *+-*-*--*--*--*-*--*--*--*-*--*--*--*-*--*--*-*--*--*--*-*--*--*--*----+


perf-profile.cycles.start_secondary

80 ++-------O-----------O--------------------------------O----------------+
| O O O O O O O O O O O O O O O O O O O O O |
70 O+ O O |
60 ++ |
| |
50 ++ |
| |
40 ++ |
| |
30 ++ .*. .*.. .*. .*. .*. .*. *. .*.. .*.. .*.*.. |
20 *+*..*.*.*..*.*. * * *. *..* *. * : * * * *.*
| : : |
10 ++ : : |
| :: |
0 ++---------------------------------------------*-----------------------+


perf-profile.cycles.cpu_startup_entry.start_secondary

80 ++-------------------O--------------------------------O----------------+
| O O O O O O O O O O O O O O O O O O O O O O |
70 O+ O O |
60 ++ |
| |
50 ++ |
| |
40 ++ |
| |
30 ++ .*. .*. .*. .*. *. .*.. .*. |
20 *+*..*.*.*..*.*. *.*..*.*.*. *..* *. * : * *.*..* *..*.*
| : : |
10 ++ : : |
| :: |
0 ++---------------------------------------------*-----------------------+


perf-profile.cycles.call_cpuidle.cpu_startup_entry.start_secondary

80 ++---------------------------------------------------------------------+
| |
70 ++O O O O O O O O O O O O O O O O O O O O O |
60 O+ O O O O O |
| |
50 ++ |
| |
40 ++ |
| |
30 ++ |
20 ++ |
| |
10 ++ .*. |
*.*..*.*.*..*.*. *.*..*.*.*..*.*..*.*.*..*.*. .*.*.*..*.*..*.*.*..*.*
0 ++---------------------------------------------*-----------------------+




80 ++---------------------------------------------------------------------+
| |
70 ++O O O O O O O O O O O O O O O O O O O O O |
60 O+ O O O O O |
| |
50 ++ |
| |
40 ++ |
| |
30 ++ |
20 ++ |
| |
10 ++ .*. |
*.*..*.*.*..*.*. *.*..*.*.*..*.*..*.*.*..*.*. .*.*.*..*.*..*.*.*..*.*
0 ++---------------------------------------------*-----------------------+




80 ++---------------------------------------------------------------------+
| |
70 ++O O O O O O O O O O O O O O O O O O O O O |
60 O+ O O O O O |
| |
50 ++ |
| |
40 ++ |
| |
30 ++ |
20 ++ |
| |
10 ++ .*. |
*.*..*.*.*..*.*. *.*..*.*.*..*.*..*.*.*..*.*. .*.*.*..*.*..*.*.*..*.*
0 ++---------------------------------------------*-----------------------+


perf-profile.cycles.entry_SYSCALL_64_fastpath

80 ++---------------------------------------------------------------------+
| |
70 *+*..*.*.*..*.*..*.*.*..*.*.*..*.*..*.*.*..*.* *.*.*..*.*..*.*.*..*.*
60 ++ : : |
| : : |
50 ++ : : |
| : : |
40 ++ : : |
| : : |
30 ++ : : |
20 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 |
| :: |
10 ++ :: |
| : |
0 ++---------------------------------------------*-----------------------+


perf-profile.cycles.sys_brk.entry_SYSCALL_64_fastpath

80 ++---------------------------------------------------------------------+
| |
70 *+*..*.*.*..*.*..*.*.*..*.*.*..*.*..*.*.*..*.* *.*.*..*.*..*.*.*..*.*
60 ++ : : |
| : : |
50 ++ : : |
| : : |
40 ++ : : |
| : : |
30 ++ : : |
20 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 |
| :: |
10 ++ :: |
| : |
0 ++---------------------------------------------*-----------------------+


perf-profile.cycles.call_rwsem_wake.sys_brk.entry_SYSCALL_64_fastpath

25 ++*--------------------------------------------------------------------+
| :: * * |
|: : * * .* :: .. + *
20 ++ : .* * + : : + .* : :: .*.* *. +|
| : .*. + : + + : : + .*.*. : : :.*. *..* |
* *.* *.. : * *.*..* * : : * |
15 ++ * : : |
| : : |
10 ++ : : |
O : : |
| O O O O O O O O O O O O O:O: O O O |
5 ++O O O O O O :: O O O |
| : |
| : |
0 ++---------------------------------------------*-----------------------+

[*] 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


Attachments:
(No filename) (49.52 kB)
job.yaml (3.22 kB)
reproduce (39.00 B)
Download all attachments