[lkp] [mm, page_alloc] d0164adc89: -100.0% fsmark.app_overhead

[kernel test robot]

FYI, we noticed the below changes on

https://git.kernel.org/pub/scm/linux/kernel/git/torvalds/linux.git master
commit d0164adc89f6bb374d304ffcc375c6d2652fe67d ("mm, page_alloc: distinguish between being unable to sleep, unwilling to sleep and avoiding waking kswapd")

Note: the testing machine is a virtual machine with only 1G memory.

=========================================================================================
compiler/disk/filesize/fs/iterations/kconfig/nr_directories/nr_files_per_directory/nr_threads/rootfs/sync_method/tbox_group/test_size/testcase:
  gcc-4.9/1HDD/16MB/xfs/1x/x86_64-rhel/16d/256fpd/32t/debian-x86_64-2015-02-07.cgz/fsyncBeforeClose/vm-vp-1G/60G/fsmark

commit: 
  016c13daa5c9e4827eca703e2f0621c131f2cca3
  d0164adc89f6bb374d304ffcc375c6d2652fe67d

016c13daa5c9e482 d0164adc89f6bb374d304ffcc3 
---------------- -------------------------- 
       fail:runs  %reproduction    fail:runs
           |             |             |    
           :4          100%           4:4     last_state.fsmark.exit_code.143
           :4           50%           2:4     last_state.is_incomplete_run
           :4          100%           4:4     dmesg.Mem-Info
           :4          100%           4:4     dmesg.page_allocation_failure:order:#,mode
           :4          100%           4:4     dmesg.warn_alloc_failed+0x
      6327  23%     -93.5%     409.00  80%  proc-vmstat.allocstall
    173495  58%    -100.0%       0.00  -1%  proc-vmstat.compact_free_scanned
      4394  59%    -100.0%       0.00  -1%  proc-vmstat.compact_isolated
     10055  44%    -100.0%       0.00  -1%  proc-vmstat.compact_migrate_scanned
    443.25  13%     -99.7%       1.50 100%  proc-vmstat.kswapd_high_wmark_hit_quickly
     28950  12%     -91.4%       2502  81%  proc-vmstat.kswapd_low_wmark_hit_quickly
  15704144   0%     -91.1%    1402050  73%  proc-vmstat.nr_dirtied
     12851   0%     +26.3%      16235  18%  proc-vmstat.nr_dirty_background_threshold
     25704   0%     +26.3%      32471  18%  proc-vmstat.nr_dirty_threshold
      2882   0%   +1130.5%      35463  84%  proc-vmstat.nr_free_pages
  15693749   0%     -91.3%    1365065  75%  proc-vmstat.nr_written
  16289593   0%     -91.0%    1464689  72%  proc-vmstat.numa_hit
  16289593   0%     -91.0%    1464689  72%  proc-vmstat.numa_local
     30453  12%     -91.6%       2552  81%  proc-vmstat.pageoutrun
  16316641   0%     -91.0%    1468330  72%  proc-vmstat.pgalloc_dma32
    642889   5%     -90.5%      61326  56%  proc-vmstat.pgfault
  16218859   0%     -91.6%    1355797  78%  proc-vmstat.pgfree
     69.25  68%    -100.0%       0.00  -1%  proc-vmstat.pgmigrate_fail
      2066  58%    -100.0%       0.00  -1%  proc-vmstat.pgmigrate_success
  62849613   0%     -91.2%    5512004  74%  proc-vmstat.pgpgout
    417966  16%     -80.1%      82999  36%  proc-vmstat.pgscan_direct_dma32
  15259915   0%     -91.5%    1303209  76%  proc-vmstat.pgscan_kswapd_dma32
    360298  23%     -93.5%      23325  82%  proc-vmstat.pgsteal_direct_dma32
  15224912   0%     -91.7%    1270706  79%  proc-vmstat.pgsteal_kswapd_dma32
    236736   0%     -96.1%       9216 100%  proc-vmstat.slabs_scanned
    108153   0%     -98.0%       2154 100%  proc-vmstat.workingset_nodereclaim

vm-vp-1G: qemu-system-x86_64 -enable-kvm -cpu Nehalem
Memory: 1G

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
---
LKP_SERVER: inn
LKP_CGI_PORT: 80
LKP_CIFS_PORT: 139
testcase: fsmark
default-monitors:
  wait: activate-monitor
  kmsg: 
  uptime: 
  iostat: 
  vmstat: 
  numa-numastat: 
  numa-vmstat: 
  numa-meminfo: 
  proc-vmstat: 
  proc-stat:
    interval: 10
  meminfo: 
  slabinfo: 
  interrupts: 
  lock_stat: 
  latency_stats: 
  softirqs: 
  bdi_dev_mapping: 
  diskstats: 
  nfsstat: 
  cpuidle: 
  cpufreq-stats: 
  turbostat: 
  pmeter: 
  sched_debug:
    interval: 60
cpufreq_governor: 
default-watchdogs:
  oom-killer: 
  watchdog: 
model: qemu-system-x86_64 -enable-kvm -cpu Nehalem
nr_vm: 8
nr_cpu: 2
memory: 1G
rootfs: debian-x86_64-2015-02-07.cgz
hdd_partitions: "/dev/vda /dev/vdb /dev/vdc /dev/vdd /dev/vde"
swap_partitions: "/dev/vdf"
ssh_base_port: 23100
category: benchmark
iterations: 1x
nr_threads: 32t
disk: 1HDD
fs: xfs
fs2: 
fsmark:
  filesize: 16MB
  test_size: 60G
  sync_method: fsyncBeforeClose
  nr_directories: 16d
  nr_files_per_directory: 256fpd
enqueue_time: 2015-11-25 21:12:33.684805278 +08:00
branch: linus/master
commit: d0164adc89f6bb374d304ffcc375c6d2652fe67d
queue: bisect
compiler: gcc-4.9
testbox: vm-vp-1G-8
tbox_group: vm-vp-1G
kconfig: x86_64-rhel
id: ed261a47c6b05a513e665dc43b2e7756796f92b9
user: lkp
result_root: "/result/fsmark/1x-32t-1HDD-xfs-16MB-60G-fsyncBeforeClose-16d-256fpd/vm-vp-1G/debian-x86_64-2015-02-07.cgz/x86_64-rhel/gcc-4.9/d0164adc89f6bb374d304ffcc375c6d2652fe67d/0"
job_file: "/lkp/scheduled/vm-vp-1G-8/bisect_fsmark-1x-32t-1HDD-xfs-16MB-60G-fsyncBeforeClose-16d-256fpd-debian-x86_64-2015-02-07.cgz-x86_64-rhel-d0164adc89f6bb374d304ffcc375c6d2652fe67d-20151125-7326-77ivz1-0.yaml"
max_uptime: 674.07
initrd: "/osimage/debian/debian-x86_64-2015-02-07.cgz"
bootloader_append:
- root=/dev/ram0
- user=lkp
- job=/lkp/scheduled/vm-vp-1G-8/bisect_fsmark-1x-32t-1HDD-xfs-16MB-60G-fsyncBeforeClose-16d-256fpd-debian-x86_64-2015-02-07.cgz-x86_64-rhel-d0164adc89f6bb374d304ffcc375c6d2652fe67d-20151125-7326-77ivz1-0.yaml
- ARCH=x86_64
- kconfig=x86_64-rhel
- branch=linus/master
- commit=d0164adc89f6bb374d304ffcc375c6d2652fe67d
- BOOT_IMAGE=/pkg/linux/x86_64-rhel/gcc-4.9/d0164adc89f6bb374d304ffcc375c6d2652fe67d/vmlinuz-4.3.0-08056-gd0164ad
- max_uptime=674
- RESULT_ROOT=/result/fsmark/1x-32t-1HDD-xfs-16MB-60G-fsyncBeforeClose-16d-256fpd/vm-vp-1G/debian-x86_64-2015-02-07.cgz/x86_64-rhel/gcc-4.9/d0164adc89f6bb374d304ffcc375c6d2652fe67d/0
- LKP_SERVER=inn
- |2-


  earlyprintk=ttyS0,115200 systemd.log_level=err
  debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100
  panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0
  console=ttyS0,115200 console=tty0 vga=normal

  rw
lkp_initrd: "/lkp/lkp/lkp-x86_64.cgz"
modules_initrd: "/pkg/linux/x86_64-rhel/gcc-4.9/d0164adc89f6bb374d304ffcc375c6d2652fe67d/modules.cgz"
bm_initrd: "/osimage/deps/debian-x86_64-2015-02-07.cgz/lkp.cgz,/osimage/deps/debian-x86_64-2015-02-07.cgz/run-ipconfig.cgz,/osimage/deps/debian-x86_64-2015-02-07.cgz/turbostat.cgz,/lkp/benchmarks/turbostat.cgz,/osimage/deps/debian-x86_64-2015-02-07.cgz/fs.cgz,/osimage/deps/debian-x86_64-2015-02-07.cgz/fs2.cgz,/lkp/benchmarks/fsmark.cgz"
kernel: "/pkg/linux/x86_64-rhel/gcc-4.9/d0164adc89f6bb374d304ffcc375c6d2652fe67d/vmlinuz-4.3.0-08056-gd0164ad"
dequeue_time: 2015-11-25 21:23:05.193290200 +08:00
job_state: finished
loadavg: 6.27 1.40 0.46 2/145 915
start_time: '1448457855'
end_time: '1448457863'
version: "/lkp/lkp/.src-20151125-184334"

Attachment: reproduce.sh
Description: Bourne shell script