06e196378c ("kfree_rcu() should use the new kfree_bulk() .."): BUG: using smp_processor_id() in preemptible [00000000] code: init/1
by kernel test robot
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
https://github.com/0day-ci/linux/commits/rao-shoaib-oracle-com/Move-kfree...
commit 06e196378c8692d9197c5fc23c677b037d53ef7e
Author: Rao Shoaib <rao.shoaib(a)oracle.com>
AuthorDate: Tue Jan 2 12:11:38 2018 -0800
Commit: 0day robot <fengguang.wu(a)intel.com>
CommitDate: Fri Jan 5 14:30:25 2018 +0800
kfree_rcu() should use the new kfree_bulk() interface for freeing rcu structures
Signed-off-by: Rao Shoaib <rao.shoaib(a)oracle.com>
bb48d720e2 Move kfree_call_rcu() to slab_common.c
06e196378c kfree_rcu() should use the new kfree_bulk() interface for freeing rcu structures
+--------------------------------------------+------------+------------+
| | bb48d720e2 | 06e196378c |
+--------------------------------------------+------------+------------+
| boot_successes | 45 | 5 |
| boot_failures | 0 | 16 |
| BUG:using_smp_processor_id()in_preemptible | 0 | 16 |
+--------------------------------------------+------------+------------+
[ 9.735070] ### dt-test ### end of unittest - 188 passed, 1 failed
[ 9.736167] debug: unmapping init [mem 0x41844000-0x41a18fff]
[ 9.738170] Write protecting the kernel text: 5300k
[ 9.738767] Write protecting the kernel read-only data: 2556k
[ 9.739365] rodata_test: all tests were successful
[ 9.753882] BUG: using smp_processor_id() in preemptible [00000000] code: init/1
[ 9.755095] caller is debug_smp_processor_id+0x12/0x20
[ 9.755881] CPU: 1 PID: 1 Comm: init Not tainted 4.15.0-rc1-00097-g06e1963 #67
[ 9.756645] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 9.757504] Call Trace:
[ 9.757837] ? dump_stack+0x58/0x79
[ 9.758340] ? check_preemption_disabled+0xcf/0xe0
[ 9.758818] ? debug_smp_processor_id+0x12/0x20
[ 9.759225] ? kfree_call_rcu+0x18/0x180
[ 9.759581] ? sock_destroy_inode+0x16/0x30
[ 9.759994] ? destroy_inode+0x2c/0x50
[ 9.760350] ? evict+0x107/0x160
[ 9.760720] ? iput+0x104/0x150
[ 9.761012] ? dentry_unlink_inode+0xd7/0x110
[ 9.761404] ? __dentry_kill+0xab/0x160
[ 9.761800] ? dput+0x260/0x270
[ 9.762147] ? __fput+0x139/0x1c0
[ 9.762451] ? ____fput+0x8/0x10
[ 9.762753] ? task_work_run+0x77/0xa0
[ 9.763113] ? exit_to_usermode_loop+0x78/0x90
[ 9.763532] ? do_int80_syscall_32+0xcf/0xf0
[ 9.763972] ? entry_INT80_32+0x2e/0x2e
[ 9.764390] BUG: using smp_processor_id() in preemptible [00000000] code: init/1
[ 9.765052] caller is debug_smp_processor_id+0x12/0x20
[ 9.765554] CPU: 1 PID: 1 Comm: init Not tainted 4.15.0-rc1-00097-g06e1963 #67
[ 9.766432] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 9.767342] Call Trace:
[ 9.767584] ? dump_stack+0x58/0x79
[ 9.767917] ? check_preemption_disabled+0xcf/0xe0
[ 9.768406] ? debug_smp_processor_id+0x12/0x20
[ 9.768823] ? kfree_call_rcu+0xe6/0x180
[ 9.769190] ? sock_destroy_inode+0x16/0x30
[ 9.769648] ? destroy_inode+0x2c/0x50
[ 9.770054] ? evict+0x107/0x160
[ 9.770358] ? iput+0x104/0x150
[ 9.770689] ? dentry_unlink_inode+0xd7/0x110
[ 9.771088] ? __dentry_kill+0xab/0x160
[ 9.771430] ? dput+0x260/0x270
[ 9.771719] ? __fput+0x139/0x1c0
[ 9.772068] ? ____fput+0x8/0x10
[ 9.772371] ? task_work_run+0x77/0xa0
[ 9.772721] ? exit_to_usermode_loop+0x78/0x90
[ 9.773155] ? do_int80_syscall_32+0xcf/0xf0
[ 9.773537] ? entry_INT80_32+0x2e/0x2e
[ 9.778260] BUG: using smp_processor_id() in preemptible [00000000] code: rc.local/115
[ 9.779179] caller is debug_smp_processor_id+0x12/0x20
[ 9.779692] CPU: 0 PID: 115 Comm: rc.local Not tainted 4.15.0-rc1-00097-g06e1963 #67
[ 9.780470] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 9.781345] Call Trace:
[ 9.781617] ? dump_stack+0x58/0x79
[ 9.782012] ? check_preemption_disabled+0xcf/0xe0
[ 9.782518] ? debug_smp_processor_id+0x12/0x20
[ 9.782993] ? kfree_call_rcu+0x18/0x180
[ 9.783397] ? sock_destroy_inode+0x16/0x30
[ 9.783819] ? destroy_inode+0x2c/0x50
[ 9.784234] ? evict+0x107/0x160
[ 9.784549] ? iput+0x104/0x150
[ 9.784905] ? dentry_unlink_inode+0xd7/0x110
[ 9.785331] ? __dentry_kill+0xab/0x160
[ 9.785745] ? dput+0x260/0x270
[ 9.786083] ? __fput+0x139/0x1c0
[ 9.786452] ? ____fput+0x8/0x10
[ 9.786806] ? task_work_run+0x77/0xa0
[ 9.787199] ? exit_to_usermode_loop+0x78/0x90
[ 9.787690] ? do_int80_syscall_32+0xcf/0xf0
[ 9.788114] ? entry_INT80_32+0x2e/0x2e
[ 9.790350] BUG: using smp_processor_id() in preemptible [00000000] code: rc.local/115
[ 9.791224] caller is debug_smp_processor_id+0x12/0x20
[ 9.791737] CPU: 0 PID: 115 Comm: rc.local Not tainted 4.15.0-rc1-00097-g06e1963 #67
[ 9.792505] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 9.793328] Call Trace:
[ 9.793590] ? dump_stack+0x58/0x79
[ 9.793993] ? check_preemption_disabled+0xcf/0xe0
[ 9.794497] ? debug_smp_processor_id+0x12/0x20
[ 9.794968] ? kfree_call_rcu+0x18/0x180
[ 9.795363] ? sock_destroy_inode+0x16/0x30
[ 9.795819] ? destroy_inode+0x2c/0x50
[ 9.796219] ? evict+0x107/0x160
[ 9.796544] ? iput+0x104/0x150
[ 9.796878] ? dentry_unlink_inode+0xd7/0x110
[ 9.797344] ? __dentry_kill+0xab/0x160
[ 9.797739] ? dput+0x260/0x270
[ 9.798069] ? __fput+0x139/0x1c0
[ 9.798404] ? ____fput+0x8/0x10
[ 9.798747] ? task_work_run+0x77/0xa0
[ 9.799152] ? exit_to_usermode_loop+0x78/0x90
[ 9.799606] ? do_int80_syscall_32+0xcf/0xf0
[ 9.800051] ? entry_INT80_32+0x2e/0x2e
[ 9.805590] BUG: using smp_processor_id() in preemptible [00000000] code: sh/117
[ 9.806825] caller is debug_smp_processor_id+0x12/0x20
[ 9.807665] CPU: 1 PID: 117 Comm: sh Not tainted 4.15.0-rc1-00097-g06e1963 #67
[ 9.808792] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 9.810042] Call Trace:
[ 9.810457] ? dump_stack+0x58/0x79
[ 9.811047] ? check_preemption_disabled+0xcf/0xe0
[ 9.811820] ? debug_smp_processor_id+0x12/0x20
[ 9.812573] ? kfree_call_rcu+0x18/0x180
[ 9.813234] ? sock_destroy_inode+0x16/0x30
[ 9.813928] ? destroy_inode+0x2c/0x50
[ 9.814549] ? evict+0x107/0x160
[ 9.815100] ? iput+0x104/0x150
[ 9.815612] ? dentry_unlink_inode+0xd7/0x110
[ 9.816337] ? __dentry_kill+0xab/0x160
[ 9.816983] ? dput+0x260/0x270
[ 9.817510] ? __fput+0x139/0x1c0
[ 9.817754] BUG: using smp_processor_id() in preemptible [00000000] code: sh/118
[ 9.817761] caller is debug_smp_processor_id+0x12/0x20
[ 9.820036] ? ____fput+0x8/0x10
[ 9.820585] ? task_work_run+0x77/0xa0
[ 9.821264] ? exit_to_usermode_loop+0x78/0x90
[ 9.822042] ? do_int80_syscall_32+0xcf/0xf0
[ 9.822773] ? entry_INT80_32+0x2e/0x2e
[ 9.823424] CPU: 0 PID: 118 Comm: sh Not tainted 4.15.0-rc1-00097-g06e1963 #67
[ 9.824243] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 9.825082] Call Trace:
[ 9.825341] ? dump_stack+0x58/0x79
[ 9.825714] ? check_preemption_disabled+0xcf/0xe0
[ 9.826210] ? debug_smp_processor_id+0x12/0x20
[ 9.826722] ? kfree_call_rcu+0x18/0x180
[ 9.827246] BUG: using smp_processor_id() in preemptible [00000000] code: sh/117
[ 9.827252] caller is debug_smp_processor_id+0x12/0x20
[ 9.829599] ? sock_destroy_inode+0x16/0x30
[ 9.830407] ? destroy_inode+0x2c/0x50
[ 9.830948] ? evict+0x107/0x160
[ 9.831316] ? iput+0x104/0x150
[ 9.831670] ? dentry_unlink_inode+0xd7/0x110
[ 9.832135] ? __dentry_kill+0xab/0x160
[ 9.832544] ? dput+0x260/0x270
[ 9.832891] ? __fput+0x139/0x1c0
[ 9.833226] ? ____fput+0x8/0x10
[ 9.833577] ? task_work_run+0x77/0xa0
[ 9.833999] ? exit_to_usermode_loop+0x78/0x90
[ 9.834528] ? do_int80_syscall_32+0xcf/0xf0
[ 9.835014] ? entry_INT80_32+0x2e/0x2e
[ 9.835458] CPU: 1 PID: 117 Comm: sh Not tainted 4.15.0-rc1-00097-g06e1963 #67
[ 9.835773] BUG: using smp_processor_id() in preemptible [00000000] code: sh/118
[ 9.835778] caller is debug_smp_processor_id+0x12/0x20
[ 9.838586] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 9.840088] Call Trace:
[ 9.840517] ? dump_stack+0x58/0x79
[ 9.841124] ? check_preemption_disabled+0xcf/0xe0
[ 9.841922] ? debug_smp_processor_id+0x12/0x20
[ 9.842700] ? kfree_call_rcu+0x18/0x180
[ 9.843365] ? sock_destroy_inode+0x16/0x30
[ 9.844089] ? destroy_inode+0x2c/0x50
[ 9.844751] ? evict+0x107/0x160
[ 9.845367] ? iput+0x104/0x150
[ 9.845947] ? dentry_unlink_inode+0xd7/0x110
[ 9.846716] ? __dentry_kill+0xab/0x160
[ 9.847322] ? dput+0x260/0x270
[ 9.847648] ? __fput+0x139/0x1c0
[ 9.847957] ? ____fput+0x8/0x10
[ 9.848249] ? task_work_run+0x77/0xa0
[ 9.848589] ? exit_to_usermode_loop+0x78/0x90
[ 9.848990] ? do_int80_syscall_32+0xcf/0xf0
[ 9.849373] ? entry_INT80_32+0x2e/0x2e
[ 9.849810] CPU: 0 PID: 118 Comm: sh Not tainted 4.15.0-rc1-00097-g06e1963 #67
[ 9.850718] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 9.851629] Call Trace:
[ 9.851927] ? dump_stack+0x58/0x79
[ 9.852305] ? check_preemption_disabled+0xcf/0xe0
[ 9.852872] ? debug_smp_processor_id+0x12/0x20
[ 9.853368] ? kfree_call_rcu+0x18/0x180
[ 9.853817] ? sock_destroy_inode+0x16/0x30
[ 9.854294] ? destroy_inode+0x2c/0x50
[ 9.854701] ? evict+0x107/0x160
[ 9.855050] ? iput+0x104/0x150
[ 9.855366] ? dentry_unlink_inode+0xd7/0x110
[ 9.855817] ? __dentry_kill+0xab/0x160
[ 9.856220] ? dput+0x260/0x270
[ 9.856535] ? __fput+0x139/0x1c0
[ 9.856884] ? ____fput+0x8/0x10
[ 9.857219] ? task_work_run+0x77/0xa0
[ 9.857624] ? exit_to_usermode_loop+0x78/0x90
[ 9.858074] ? do_int80_syscall_32+0xcf/0xf0
[ 9.858513] ? entry_INT80_32+0x2e/0x2e
[ 9.859103] BUG: using smp_processor_id() in preemptible [00000000] code: 99-trinity/120
[ 9.860447] caller is debug_smp_processor_id+0x12/0x20
[ 9.861248] CPU: 1 PID: 120 Comm: 99-trinity Not tainted 4.15.0-rc1-00097-g06e1963 #67
[ 9.862390] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 9.863618] Call Trace:
[ 9.864004] ? dump_stack+0x58/0x79
[ 9.864501] ? check_preemption_disabled+0xcf/0xe0
[ 9.865175] ? debug_smp_processor_id+0x12/0x20
[ 9.865803] ? kfree_call_rcu+0x18/0x180
[ 9.866453] ? sock_destroy_inode+0x16/0x30
[ 9.867175] ? destroy_inode+0x2c/0x50
[ 9.867802] ? evict+0x107/0x160
[ 9.868339] ? iput+0x104/0x150
[ 9.868875] ? dentry_unlink_inode+0xd7/0x110
[ 9.869588] ? __dentry_kill+0xab/0x160
[ 9.870232] ? dput+0x260/0x270
[ 9.870778] ? __fput+0x139/0x1c0
[ 9.871354] ? ____fput+0x8/0x10
[ 9.871897] ? task_work_run+0x77/0xa0
[ 9.872525] ? exit_to_usermode_loop+0x78/0x90
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start 06e196378c8692d9197c5fc23c677b037d53ef7e 2781e186b35ef340f543672d1557d9f265fa6811 --
git bisect good bb48d720e20ee1cf723d75fa62a0c32e96064917 # 16:05 G 11 0 0 0 Move kfree_call_rcu() to slab_common.c
# first bad commit: [06e196378c8692d9197c5fc23c677b037d53ef7e] kfree_rcu() should use the new kfree_bulk() interface for freeing rcu structures
git bisect good bb48d720e20ee1cf723d75fa62a0c32e96064917 # 16:09 G 31 0 0 1 Move kfree_call_rcu() to slab_common.c
# extra tests on HEAD of linux-review/rao-shoaib-oracle-com/Move-kfree_call_rcu-to-slab_common-c/20180105-143022
git bisect bad 06e196378c8692d9197c5fc23c677b037d53ef7e # 16:09 B 0 16 33 0 kfree_rcu() should use the new kfree_bulk() interface for freeing rcu structures
# extra tests on tree/branch linux-review/rao-shoaib-oracle-com/Move-kfree_call_rcu-to-slab_common-c/20180105-143022
git bisect bad 06e196378c8692d9197c5fc23c677b037d53ef7e # 16:09 B 0 16 33 0 kfree_rcu() should use the new kfree_bulk() interface for freeing rcu structures
# extra tests with first bad commit reverted
git bisect good 969a076c1bc372cfe03949dd03f99976c1192391 # 16:20 G 11 0 0 0 Revert "kfree_rcu() should use the new kfree_bulk() interface for freeing rcu structures"
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
4 years, 4 months
[page cache] 2442424275: BUG:Bad_page_state_in_process
by kernel test robot
FYI, we noticed the following commit (built with gcc-7):
commit: 2442424275f104e5c479d5d8ea92c79546dd48a0 ("page cache: Convert delete_batch to XArray")
git://git.infradead.org/users/willy/linux-dax.git xarray-2017-12-11
in testcase: boot
on test machine: qemu-system-x86_64 -enable-kvm -m 512M
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
+-------------------------------+------------+------------+
| | 453a73480b | 2442424275 |
+-------------------------------+------------+------------+
| boot_successes | 8 | 2 |
| boot_failures | 0 | 4 |
| BUG:Bad_page_state_in_process | 0 | 4 |
+-------------------------------+------------+------------+
[ 12.171742] BUG: Bad page state in process udevd pfn:1371f
[ 12.176137] page:ffffe3cb004dc7c0 count:0 mapcount:0 mapping:ffff94bbde00e9b8 index:0x45
[ 12.184510] flags: 0x10000000000000c(referenced|uptodate)
[ 12.189431] raw: 010000000000000c ffff94bbde00e9b8 0000000000000045 00000000ffffffff
[ 12.315553] raw: ffffe3cb004dc820 ffffbdc04032fc48 0000000000000000 0000000000000000
[ 12.318111] page dumped because: non-NULL mapping
[ 12.320602] Modules linked in: snd_pcsp
[ 12.321632] CPU: 0 PID: 2176 Comm: udevd Not tainted 4.15.0-rc6-00058-g24424242 #137
[ 12.323394] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 12.325232] Call Trace:
[ 12.325980] dump_stack+0x85/0xbc
[ 12.326828] bad_page+0xf2/0x10c
[ 12.333714] free_unref_page_prepare+0x19b/0x1f2
[ 12.334690] free_unref_page_list+0x4d/0x274
[ 12.335615] release_pages+0x2cb/0x2da
[ 12.336507] __pagevec_release+0x23/0x2c
[ 12.337419] truncate_inode_pages_range+0x1f1/0x582
[ 12.338470] __blkdev_put+0x62/0x194
[ 12.339315] blkdev_close+0x24/0x27
[ 12.340185] __fput+0xf3/0x1ac
[ 12.340992] task_work_run+0x79/0xa0
[ 12.341834] exit_to_usermode_loop+0x5e/0x8d
[ 12.342759] syscall_return_slowpath+0x102/0x115
[ 12.343731] entry_SYSCALL_64_fastpath+0x94/0x96
[ 12.344739] RIP: 0033:0x7f3e95c56f00
[ 12.345610] RSP: 002b:00007ffc154835f8 EFLAGS: 00000246 ORIG_RAX: 0000000000000003
[ 12.360325] RAX: 0000000000000000 RBX: 0000000000000007 RCX: 00007f3e95c56f00
[ 12.361604] RDX: 00007f3e95f17b78 RSI: 00007ffc15482df0 RDI: 0000000000000007
[ 12.362850] RBP: 00007f3e9658a6e0 R08: 00007f3e9658a780 R09: 000000000000000b
[ 12.364099] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000002
[ 12.365346] R13: 0000000000647010 R14: 0000000000000007 R15: 0000000000651900
[ 12.366777] Disabling lock debugging due to kernel taint
[ 12.547937] BUG: Bad page state in process udevd pfn:13720
[ 12.554706] page:ffffe3cb004dc800 count:0 mapcount:0 mapping:ffff94bbde00e9b8 index:0x44
[ 12.565093] flags: 0x10000000000000c(referenced|uptodate)
[ 12.576423] raw: 010000000000000c ffff94bbde00e9b8 0000000000000044 00000000ffffffff
[ 12.586107] raw: ffffe3cb004dc860 ffffbdc04032fc48 0000000000000000 0000000000000000
[ 12.596095] page dumped because: non-NULL mapping
[ 12.603179] Modules linked in: snd_pcsp
[ 12.609097] CPU: 0 PID: 2176 Comm: udevd Tainted: G B 4.15.0-rc6-00058-g24424242 #137
[ 12.611160] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 12.613152] Call Trace:
[ 12.613928] dump_stack+0x85/0xbc
[ 12.614893] bad_page+0xf2/0x10c
[ 12.615750] free_unref_page_prepare+0x19b/0x1f2
[ 12.616802] free_unref_page_list+0x4d/0x274
[ 12.617876] release_pages+0x2cb/0x2da
[ 12.618873] __pagevec_release+0x23/0x2c
[ 12.619791] truncate_inode_pages_range+0x1f1/0x582
[ 12.620970] __blkdev_put+0x62/0x194
[ 12.621865] blkdev_close+0x24/0x27
[ 12.622797] __fput+0xf3/0x1ac
[ 12.623700] task_work_run+0x79/0xa0
[ 12.624650] exit_to_usermode_loop+0x5e/0x8d
[ 12.625692] syscall_return_slowpath+0x102/0x115
[ 12.627685] entry_SYSCALL_64_fastpath+0x94/0x96
[ 12.628805] RIP: 0033:0x7f3e95c56f00
[ 12.629756] RSP: 002b:00007ffc154835f8 EFLAGS: 00000246 ORIG_RAX: 0000000000000003
[ 12.631633] RAX: 0000000000000000 RBX: 0000000000000007 RCX: 00007f3e95c56f00
[ 12.633005] RDX: 00007f3e95f17b78 RSI: 00007ffc15482df0 RDI: 0000000000000007
[ 12.634382] RBP: 00007f3e9658a6e0 R08: 00007f3e9658a780 R09: 000000000000000b
[ 12.635814] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000002
[ 12.637207] R13: 0000000000647010 R14: 0000000000000007 R15: 0000000000651900
[ 12.638768] BUG: Bad page state in process udevd pfn:13721
[ 12.767836] page:ffffe3cb004dc840 count:0 mapcount:0 mapping:ffff94bbde00e9b8 index:0x43
[ 12.773372] flags: 0x10000000000000c(referenced|uptodate)
[ 12.779649] raw: 010000000000000c ffff94bbde00e9b8 0000000000000043 00000000ffffffff
[ 12.807088] raw: ffffe3cb004dc8a0 ffffbdc04032fc48 0000000000000000 0000000000000000
[ 12.817119] page dumped because: non-NULL mapping
[ 12.823196] Modules linked in: snd_pcsp
[ 12.826750] CPU: 0 PID: 2176 Comm: udevd Tainted: G B 4.15.0-rc6-00058-g24424242 #137
[ 12.828972] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 12.831090] Call Trace:
[ 12.831952] dump_stack+0x85/0xbc
[ 12.832892] bad_page+0xf2/0x10c
[ 12.833827] free_unref_page_prepare+0x19b/0x1f2
[ 12.835008] free_unref_page_list+0x4d/0x274
[ 12.836118] release_pages+0x2cb/0x2da
[ 12.837142] __pagevec_release+0x23/0x2c
[ 12.838198] truncate_inode_pages_range+0x1f1/0x582
[ 12.839439] __blkdev_put+0x62/0x194
[ 12.840463] blkdev_close+0x24/0x27
[ 12.841423] __fput+0xf3/0x1ac
[ 12.842322] task_work_run+0x79/0xa0
[ 12.843322] exit_to_usermode_loop+0x5e/0x8d
[ 12.844333] syscall_return_slowpath+0x102/0x115
[ 12.845403] entry_SYSCALL_64_fastpath+0x94/0x96
[ 12.846555] RIP: 0033:0x7f3e95c56f00
[ 12.847519] RSP: 002b:00007ffc154835f8 EFLAGS: 00000246 ORIG_RAX: 0000000000000003
[ 12.849467] RAX: 0000000000000000 RBX: 0000000000000007 RCX: 00007f3e95c56f00
[ 12.851013] RDX: 00007f3e95f17b78 RSI: 00007ffc15482df0 RDI: 0000000000000007
[ 12.852485] RBP: 00007f3e9658a6e0 R08: 00007f3e9658a780 R09: 000000000000000b
[ 12.853974] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000002
[ 12.855450] R13: 0000000000647010 R14: 0000000000000007 R15: 0000000000651900
[ 12.856991] BUG: Bad page state in process udevd pfn:13722
[ 12.930193] page:ffffe3cb004dc880 count:0 mapcount:0 mapping:ffff94bbde00e9b8 index:0x42
[ 12.932457] flags: 0x10000000000000c(referenced|uptodate)
[ 12.933756] raw: 010000000000000c ffff94bbde00e9b8 0000000000000042 00000000ffffffff
[ 12.935775] raw: ffffe3cb004dc8e0 ffffbdc04032fc48 0000000000000000 0000000000000000
[ 12.937773] page dumped because: non-NULL mapping
[ 12.938912] Modules linked in: snd_pcsp
[ 12.939959] CPU: 0 PID: 2176 Comm: udevd Tainted: G B 4.15.0-rc6-00058-g24424242 #137
[ 12.942129] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 12.944181] Call Trace:
[ 12.944984] dump_stack+0x85/0xbc
[ 12.946078] bad_page+0xf2/0x10c
[ 12.947002] free_unref_page_prepare+0x19b/0x1f2
[ 12.949449] free_unref_page_list+0x4d/0x274
[ 12.950529] release_pages+0x2cb/0x2da
[ 12.951601] __pagevec_release+0x23/0x2c
[ 12.952639] truncate_inode_pages_range+0x1f1/0x582
[ 12.953799] __blkdev_put+0x62/0x194
[ 12.954753] blkdev_close+0x24/0x27
[ 12.955698] __fput+0xf3/0x1ac
[ 12.956610] task_work_run+0x79/0xa0
[ 12.957585] exit_to_usermode_loop+0x5e/0x8d
[ 12.958654] syscall_return_slowpath+0x102/0x115
[ 12.959739] entry_SYSCALL_64_fastpath+0x94/0x96
[ 12.960835] RIP: 0033:0x7f3e95c56f00
[ 12.961795] RSP: 002b:00007ffc154835f8 EFLAGS: 00000246 ORIG_RAX: 0000000000000003
[ 12.963671] RAX: 0000000000000000 RBX: 0000000000000007 RCX: 00007f3e95c56f00
[ 12.974070] RDX: 00007f3e95f17b78 RSI: 00007ffc15482df0 RDI: 0000000000000007
[ 12.975512] RBP: 00007f3e9658a6e0 R08: 00007f3e9658a780 R09: 000000000000000b
[ 12.976948] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000002
[ 12.978411] R13: 0000000000647010 R14: 0000000000000007 R15: 0000000000651900
[ 12.979894] BUG: Bad page state in process udevd pfn:13723
[ 12.981161] page:ffffe3cb004dc8c0 count:0 mapcount:0 mapping:ffff94bbde00e9b8 index:0x41
[ 12.983136] flags: 0x10000000000000c(referenced|uptodate)
[ 12.984352] raw: 010000000000000c ffff94bbde00e9b8 0000000000000041 00000000ffffffff
[ 12.986253] raw: ffffe3cb004dc920 ffffbdc04032fc48 0000000000000000 0000000000000000
[ 12.988174] page dumped because: non-NULL mapping
[ 12.989403] Modules linked in: snd_pcsp
[ 12.990458] CPU: 0 PID: 2176 Comm: udevd Tainted: G B 4.15.0-rc6-00058-g24424242 #137
[ 12.992516] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 12.994422] Call Trace:
[ 12.995264] dump_stack+0x85/0xbc
[ 12.999072] bad_page+0xf2/0x10c
[ 13.000009] free_unref_page_prepare+0x19b/0x1f2
[ 13.001129] free_unref_page_list+0x4d/0x274
[ 13.002164] release_pages+0x2cb/0x2da
[ 13.003167] __pagevec_release+0x23/0x2c
[ 13.004234] truncate_inode_pages_range+0x1f1/0x582
[ 13.005358] __blkdev_put+0x62/0x194
[ 13.006338] blkdev_close+0x24/0x27
[ 13.007274] __fput+0xf3/0x1ac
[ 13.008155] task_work_run+0x79/0xa0
[ 13.009104] exit_to_usermode_loop+0x5e/0x8d
[ 13.010131] syscall_return_slowpath+0x102/0x115
[ 13.011656] entry_SYSCALL_64_fastpath+0x94/0x96
[ 13.012813] RIP: 0033:0x7f3e95c56f00
[ 13.013771] RSP: 002b:00007ffc154835f8 EFLAGS: 00000246 ORIG_RAX: 0000000000000003
[ 13.015629] RAX: 0000000000000000 RBX: 0000000000000007 RCX: 00007f3e95c56f00
[ 13.017094] RDX: 00007f3e95f17b78 RSI: 00007ffc15482df0 RDI: 0000000000000007
[ 13.018518] RBP: 00007f3e9658a6e0 R08: 00007f3e9658a780 R09: 000000000000000b
[ 13.020016] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000002
[ 13.021444] R13: 0000000000647010 R14: 0000000000000007 R15: 0000000000651900
[ 13.022887] BUG: Bad page state in process udevd pfn:13724
[ 13.024928] page:ffffe3cb004dc900 count:0 mapcount:0 mapping:ffff94bbde00e9b8 index:0x40
[ 13.026884] flags: 0x10000000000000c(referenced|uptodate)
[ 13.028155] raw: 010000000000000c ffff94bbde00e9b8 0000000000000040 00000000ffffffff
[ 13.030139] raw: ffffe3cb005c9720 ffffbdc04032fc48 0000000000000000 0000000000000000
[ 13.032045] page dumped because: non-NULL mapping
[ 13.033156] Modules linked in: snd_pcsp
[ 13.034185] CPU: 0 PID: 2176 Comm: udevd Tainted: G B 4.15.0-rc6-00058-g24424242 #137
[ 13.036294] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 13.038237] Call Trace:
[ 13.039046] dump_stack+0x85/0xbc
[ 13.039915] bad_page+0xf2/0x10c
[ 13.040845] free_unref_page_prepare+0x19b/0x1f2
[ 13.041966] free_unref_page_list+0x4d/0x274
[ 13.042995] release_pages+0x2cb/0x2da
[ 13.043959] __pagevec_release+0x23/0x2c
[ 13.044970] truncate_inode_pages_range+0x1f1/0x582
[ 13.046180] __blkdev_put+0x62/0x194
[ 13.047172] blkdev_close+0x24/0x27
[ 13.048115] __fput+0xf3/0x1ac
[ 13.049057] task_work_run+0x79/0xa0
[ 13.050010] exit_to_usermode_loop+0x5e/0x8d
[ 13.051019] syscall_return_slowpath+0x102/0x115
[ 13.052086] entry_SYSCALL_64_fastpath+0x94/0x96
[ 13.053170] RIP: 0033:0x7f3e95c56f00
[ 13.054120] RSP: 002b:00007ffc154835f8 EFLAGS: 00000246 ORIG_RAX: 0000000000000003
[ 13.055975] RAX: 0000000000000000 RBX: 0000000000000007 RCX: 00007f3e95c56f00
[ 13.057556] RDX: 00007f3e95f17b78 RSI: 00007ffc15482df0 RDI: 0000000000000007
[ 13.059040] RBP: 00007f3e9658a6e0 R08: 00007f3e9658a780 R09: 000000000000000b
[ 13.060579] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000002
[ 13.062013] R13: 0000000000647010 R14: 0000000000000007 R15: 0000000000651900
[ 13.063593] BUG: Bad page state in process udevd pfn:1377e
[ 13.064918] page:ffffe3cb004ddf80 count:0 mapcount:0 mapping:ffff94bbde00e9b8 index:0x3ffff88
[ 13.067056] flags: 0x10000000000000c(referenced|uptodate)
[ 13.068329] raw: 010000000000000c ffff94bbde00e9b8 0000000003ffff88 00000000ffffffff
[ 13.070324] raw: ffffe3cb004ddf60 ffffbdc04032fc48 0000000000000000 0000000000000000
[ 13.072393] page dumped because: non-NULL mapping
[ 13.073562] Modules linked in: snd_pcsp
[ 13.074588] CPU: 0 PID: 2176 Comm: udevd Tainted: G B 4.15.0-rc6-00058-g24424242 #137
[ 13.076760] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 13.079093] Call Trace:
[ 13.079923] dump_stack+0x85/0xbc
[ 13.080875] bad_page+0xf2/0x10c
[ 13.081809] free_unref_page_prepare+0x19b/0x1f2
[ 13.082929] free_unref_page_list+0x4d/0x274
[ 13.084013] release_pages+0x2cb/0x2da
[ 13.085038] __pagevec_release+0x23/0x2c
[ 13.086058] truncate_inode_pages_range+0x1f1/0x582
[ 13.087176] __blkdev_put+0x62/0x194
[ 13.088154] blkdev_close+0x24/0x27
[ 13.089158] __fput+0xf3/0x1ac
[ 13.090134] task_work_run+0x79/0xa0
[ 13.091274] exit_to_usermode_loop+0x5e/0x8d
[ 13.092371] syscall_return_slowpath+0x102/0x115
[ 13.093535] entry_SYSCALL_64_fastpath+0x94/0x96
[ 13.094702] RIP: 0033:0x7f3e95c56f00
[ 13.095703] RSP: 002b:00007ffc154835f8 EFLAGS: 00000246 ORIG_RAX: 0000000000000003
[ 13.097649] RAX: 0000000000000000 RBX: 0000000000000007 RCX: 00007f3e95c56f00
[ 13.099130] RDX: 00007f3e95f17b78 RSI: 00007ffc15482df0 RDI: 0000000000000007
[ 13.100639] RBP: 00007f3e9658a6e0 R08: 00007f3e9658a780 R09: 000000000000000b
[ 13.102131] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000002
[ 13.106842] R13: 0000000000647010 R14: 0000000000000007 R15: 0000000000651900
[ 13.108363] BUG: Bad page state in process udevd pfn:1377d
[ 13.109503] page:ffffe3cb004ddf40 count:0 mapcount:0 mapping:ffff94bbde00e9b8 index:0x3ffff87
[ 13.111208] flags: 0x10000000000000c(referenced|uptodate)
[ 13.112227] raw: 010000000000000c ffff94bbde00e9b8 0000000003ffff87 00000000ffffffff
[ 13.113915] raw: ffffe3cb005b34a0 ffffbdc04032fc48 0000000000000000 0000000000000000
[ 13.115952] page dumped because: non-NULL mapping
[ 13.117160] Modules linked in: snd_pcsp
[ 13.118225] CPU: 0 PID: 2176 Comm: udevd Tainted: G B 4.15.0-rc6-00058-g24424242 #137
[ 13.120412] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 13.122555] Call Trace:
[ 13.123404] dump_stack+0x85/0xbc
[ 13.124373] bad_page+0xf2/0x10c
[ 13.125325] free_unref_page_prepare+0x19b/0x1f2
[ 13.126503] free_unref_page_list+0x4d/0x274
[ 13.127645] release_pages+0x2cb/0x2da
[ 13.128687] __pagevec_release+0x23/0x2c
[ 13.129736] truncate_inode_pages_range+0x1f1/0x582
[ 13.130924] __blkdev_put+0x62/0x194
[ 13.131923] blkdev_close+0x24/0x27
[ 13.132905] __fput+0xf3/0x1ac
[ 13.133849] task_work_run+0x79/0xa0
[ 13.134880] exit_to_usermode_loop+0x5e/0x8d
[ 13.136012] syscall_return_slowpath+0x102/0x115
[ 13.137156] entry_SYSCALL_64_fastpath+0x94/0x96
[ 13.138298] RIP: 0033:0x7f3e95c56f00
[ 13.139291] RSP: 002b:00007ffc154835f8 EFLAGS: 00000246 ORIG_RAX: 0000000000000003
[ 13.141249] RAX: 0000000000000000 RBX: 0000000000000007 RCX: 00007f3e95c56f00
[ 13.142759] RDX: 00007f3e95f17b78 RSI: 00007ffc15482df0 RDI: 0000000000000007
[ 13.144291] RBP: 00007f3e9658a6e0 R08: 00007f3e9658a780 R09: 000000000000000b
[ 13.145750] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000002
[ 13.147226] R13: 0000000000647010 R14: 0000000000000007 R15: 0000000000651900
[ 13.148771] BUG: Bad page state in process udevd pfn:16cd2
[ 13.150169] page:ffffe3cb005b3480 count:0 mapcount:0 mapping:ffff94bbde00e9b8 index:0x3ffff86
[ 13.152309] flags: 0x100000000000008(uptodate)
[ 13.153476] raw: 0100000000000008 ffff94bbde00e9b8 0000000003ffff86 00000000ffffffff
[ 13.155500] raw: ffffe3cb004ddf20 ffffbdc04032fc48 0000000000000000 0000000000000000
[ 13.157571] page dumped because: non-NULL mapping
[ 13.158918] Modules linked in: snd_pcsp
[ 13.160011] CPU: 0 PID: 2176 Comm: udevd Tainted: G B 4.15.0-rc6-00058-g24424242 #137
[ 13.162266] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 13.164210] Call Trace:
[ 13.165122] dump_stack+0x85/0xbc
[ 13.166128] bad_page+0xf2/0x10c
[ 13.167109] free_unref_page_prepare+0x19b/0x1f2
[ 13.168279] free_unref_page_list+0x4d/0x274
[ 13.169362] release_pages+0x2cb/0x2da
[ 13.170378] __pagevec_release+0x23/0x2c
[ 13.171422] truncate_inode_pages_range+0x1f1/0x582
[ 13.172638] __blkdev_put+0x62/0x194
[ 13.173664] blkdev_close+0x24/0x27
[ 13.174662] __fput+0xf3/0x1ac
[ 13.175587] task_work_run+0x79/0xa0
[ 13.176580] exit_to_usermode_loop+0x5e/0x8d
[ 13.177649] syscall_return_slowpath+0x102/0x115
[ 13.191576] entry_SYSCALL_64_fastpath+0x94/0x96
[ 13.192763] RIP: 0033:0x7f3e95c56f00
[ 13.193787] RSP: 002b:00007ffc154835f8 EFLAGS: 00000246 ORIG_RAX: 0000000000000003
[ 13.195758] RAX: 0000000000000000 RBX: 0000000000000007 RCX: 00007f3e95c56f00
[ 13.197233] RDX: 00007f3e95f17b78 RSI: 00007ffc15482df0 RDI: 0000000000000007
[ 13.198752] RBP: 00007f3e9658a6e0 R08: 00007f3e9658a780 R09: 000000000000000b
[ 13.200255] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000002
[ 13.201715] R13: 0000000000647010 R14: 0000000000000007 R15: 0000000000651900
[ 13.203229] BUG: Bad page state in process udevd pfn:1377c
[ 13.204558] page:ffffe3cb004ddf00 count:0 mapcount:0 mapping:ffff94bbde00e9b8 index:0x3ffff85
[ 13.206666] flags: 0x10000000000000c(referenced|uptodate)
[ 13.209212] raw: 010000000000000c ffff94bbde00e9b8 0000000003ffff85 00000000ffffffff
[ 13.211289] raw: ffffe3cb005b34e0 ffffbdc04032fc48 0000000000000000 0000000000000000
[ 13.213288] page dumped because: non-NULL mapping
[ 13.214456] Modules linked in: snd_pcsp
[ 13.215509] CPU: 0 PID: 2176 Comm: udevd Tainted: G B 4.15.0-rc6-00058-g24424242 #137
[ 13.217750] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 13.219866] Call Trace:
[ 13.220720] dump_stack+0x85/0xbc
[ 13.221683] bad_page+0xf2/0x10c
[ 13.222666] free_unref_page_prepare+0x19b/0x1f2
[ 13.223838] free_unref_page_list+0x4d/0x274
[ 13.224958] release_pages+0x2cb/0x2da
[ 13.225996] __pagevec_release+0x23/0x2c
[ 13.227034] truncate_inode_pages_range+0x1f1/0x582
[ 13.228265] __blkdev_put+0x62/0x194
[ 13.229402] blkdev_close+0x24/0x27
[ 13.230619] __fput+0xf3/0x1ac
[ 13.231590] task_work_run+0x79/0xa0
[ 13.232596] exit_to_usermode_loop+0x5e/0x8d
[ 13.233689] syscall_return_slowpath+0x102/0x115
[ 13.234840] entry_SYSCALL_64_fastpath+0x94/0x96
[ 13.235983] RIP: 0033:0x7f3e95c56f00
[ 13.236986] RSP: 002b:00007ffc154835f8 EFLAGS: 00000246 ORIG_RAX: 0000000000000003
[ 13.238982] RAX: 0000000000000000 RBX: 0000000000000007 RCX: 00007f3e95c56f00
[ 13.240494] RDX: 00007f3e95f17b78 RSI: 00007ffc15482df0 RDI: 0000000000000007
[ 13.241993] RBP: 00007f3e9658a6e0 R08: 00007f3e9658a780 R09: 000000000000000b
[ 13.246126] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000002
[ 13.247652] R13: 0000000000647010 R14: 0000000000000007 R15: 0000000000651900
[ 13.249167] BUG: Bad page state in process udevd pfn:16cd3
[ 13.250454] page:ffffe3cb005b34c0 count:0 mapcount:0 mapping:ffff94bbde00e9b8 index:0x3ffff84
[ 13.252620] flags: 0x100000000000008(uptodate)
[ 13.253785] raw: 0100000000000008 ffff94bbde00e9b8 0000000003ffff84 00000000ffffffff
[ 13.255888] raw: ffffe3cb004ddee0 ffffbdc04032fc48 0000000000000000 0000000000000000
[ 13.257932] page dumped because: non-NULL mapping
[ 13.259099] Modules linked in: snd_pcsp
[ 13.261487] CPU: 0 PID: 2176 Comm: udevd Tainted: G B 4.15.0-rc6-00058-g24424242 #137
[ 13.263720] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 13.265783] Call Trace:
[ 13.266637] dump_stack+0x85/0xbc
[ 13.267606] bad_page+0xf2/0x10c
[ 13.268559] free_unref_page_prepare+0x19b/0x1f2
[ 13.269699] free_unref_page_list+0x4d/0x274
[ 13.270819] release_pages+0x2cb/0x2da
[ 13.271873] __pagevec_release+0x23/0x2c
[ 13.272933] truncate_inode_pages_range+0x1f1/0x582
[ 13.274132] __blkdev_put+0x62/0x194
[ 13.275138] blkdev_close+0x24/0x27
[ 13.276141] __fput+0xf3/0x1ac
[ 13.277082] task_work_run+0x79/0xa0
[ 13.278086] exit_to_usermode_loop+0x5e/0x8d
[ 13.279266] syscall_return_slowpath+0x102/0x115
[ 13.280462] entry_SYSCALL_64_fastpath+0x94/0x96
[ 13.281653] RIP: 0033:0x7f3e95c56f00
[ 13.282657] RSP: 002b:00007ffc154835f8 EFLAGS: 00000246 ORIG_RAX: 0000000000000003
[ 13.284648] RAX: 0000000000000000 RBX: 0000000000000007 RCX: 00007f3e95c56f00
[ 13.286127] RDX: 00007f3e95f17b78 RSI: 00007ffc15482df0 RDI: 0000000000000007
[ 13.287672] RBP: 00007f3e9658a6e0 R08: 00007f3e9658a780 R09: 000000000000000b
[ 13.289185] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000002
[ 13.290645] R13: 0000000000647010 R14: 0000000000000007 R15: 0000000000651900
[ 13.292208] BUG: Bad page state in process udevd pfn:1377b
[ 13.293394] page:ffffe3cb004ddec0 count:0 mapcount:0 mapping:ffff94bbde00e9b8 index:0x3ffff83
[ 13.295497] flags: 0x10000000000000c(referenced|uptodate)
[ 13.296754] raw: 010000000000000c ffff94bbde00e9b8 0000000003ffff83 00000000ffffffff
[ 13.298729] raw: ffffe3cb004ddea0 ffffbdc04032fc48 0000000000000000 0000000000000000
[ 13.300744] page dumped because: non-NULL mapping
[ 13.301954] Modules linked in: snd_pcsp
[ 13.303035] CPU: 0 PID: 2176 Comm: udevd Tainted: G B 4.15.0-rc6-00058-g24424242 #137
[ 13.305216] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 13.307275] Call Trace:
[ 13.308128] dump_stack+0x85/0xbc
[ 13.309089] bad_page+0xf2/0x10c
[ 13.310218] free_unref_page_prepare+0x19b/0x1f2
[ 13.311393] free_unref_page_list+0x4d/0x274
[ 13.312482] release_pages+0x2cb/0x2da
[ 13.313510] __pagevec_release+0x23/0x2c
[ 13.314655] truncate_inode_pages_range+0x1f1/0x582
[ 13.315627] __blkdev_put+0x62/0x194
[ 13.316621] blkdev_close+0x24/0x27
[ 13.317534] __fput+0xf3/0x1ac
[ 13.318463] task_work_run+0x79/0xa0
[ 13.319463] exit_to_usermode_loop+0x5e/0x8d
[ 13.320522] syscall_return_slowpath+0x102/0x115
[ 13.321691] entry_SYSCALL_64_fastpath+0x94/0x96
[ 13.322841] RIP: 0033:0x7f3e95c56f00
[ 13.323846] RSP: 002b:00007ffc154835f8 EFLAGS: 00000246 ORIG_RAX: 0000000000000003
[ 13.325808] RAX: 0000000000000000 RBX: 0000000000000007 RCX: 00007f3e95c56f00
[ 13.327226] RDX: 00007f3e95f17b78 RSI: 00007ffc15482df0 RDI: 0000000000000007
[ 13.328691] RBP: 00007f3e9658a6e0 R08: 00007f3e9658a780 R09: 000000000000000b
[ 13.330187] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000002
[ 13.331721] R13: 0000000000647010 R14: 0000000000000007 R15: 0000000000651900
[ 13.333233] BUG: Bad page state in process udevd pfn:1377a
[ 13.334516] page:ffffe3cb004dde80 count:0 mapcount:0 mapping:ffff94bbde00e9b8 index:0x3ffff82
[ 13.336646] flags: 0x10000000000000c(referenced|uptodate)
[ 13.337928] raw: 010000000000000c ffff94bbde00e9b8 0000000003ffff82 00000000ffffffff
[ 13.339966] raw: ffffe3cb004dde60 ffffbdc04032fc48 0000000000000000 0000000000000000
[ 13.342020] page dumped because: non-NULL mapping
[ 13.343247] Modules linked in: snd_pcsp
[ 13.344329] CPU: 0 PID: 2176 Comm: udevd Tainted: G B 4.15.0-rc6-00058-g24424242 #137
[ 13.346535] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 13.348640] Call Trace:
[ 13.349496] dump_stack+0x85/0xbc
[ 13.350430] bad_page+0xf2/0x10c
[ 13.351263] free_unref_page_prepare+0x19b/0x1f2
[ 13.352387] free_unref_page_list+0x4d/0x274
[ 13.353513] release_pages+0x2cb/0x2da
[ 13.354530] __pagevec_release+0x23/0x2c
[ 13.355555] truncate_inode_pages_range+0x1f1/0x582
[ 13.356731] __blkdev_put+0x62/0x194
[ 13.357765] blkdev_close+0x24/0x27
[ 13.358794] __fput+0xf3/0x1ac
[ 13.359749] task_work_run+0x79/0xa0
[ 13.360790] exit_to_usermode_loop+0x5e/0x8d
[ 13.361865] syscall_return_slowpath+0x102/0x115
[ 13.362984] entry_SYSCALL_64_fastpath+0x94/0x96
[ 13.364110] RIP: 0033:0x7f3e95c56f00
[ 13.366067] RSP: 002b:00007ffc154835f8 EFLAGS: 00000246 ORIG_RAX: 0000000000000003
[ 13.368007] RAX: 0000000000000000 RBX: 0000000000000007 RCX: 00007f3e95c56f00
[ 13.369505] RDX: 00007f3e95f17b78 RSI: 00007ffc15482df0 RDI: 0000000000000007
[ 13.371038] RBP: 00007f3e9658a6e0 R08: 00007f3e9658a780 R09: 000000000000000b
[ 13.372540] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000002
[ 13.374027] R13: 0000000000647010 R14: 0000000000000007 R15: 0000000000651900
[ 13.375492] BUG: Bad page state in process udevd pfn:13779
[ 13.376715] page:ffffe3cb004dde40 count:0 mapcount:0 mapping:ffff94bbde00e9b8 index:0x3ffff81
[ 13.378764] flags: 0x10000000000000c(referenced|uptodate)
[ 13.379987] raw: 010000000000000c ffff94bbde00e9b8 0000000003ffff81 00000000ffffffff
[ 13.381891] raw: ffffe3cb004dde20 ffffbdc04032fc48 0000000000000000 0000000000000000
[ 13.383784] page dumped because: non-NULL mapping
[ 13.384908] Modules linked in: snd_pcsp
[ 13.385937] CPU: 0 PID: 2176 Comm: udevd Tainted: G B 4.15.0-rc6-00058-g24424242 #137
[ 13.387995] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 13.389914] Call Trace:
[ 13.390706] dump_stack+0x85/0xbc
[ 13.391619] bad_page+0xf2/0x10c
[ 13.392524] free_unref_page_prepare+0x19b/0x1f2
[ 13.393624] free_unref_page_list+0x4d/0x274
[ 13.394646] release_pages+0x2cb/0x2da
[ 13.395605] __pagevec_release+0x23/0x2c
[ 13.396585] truncate_inode_pages_range+0x1f1/0x582
[ 13.397663] __blkdev_put+0x62/0x194
[ 13.407770] blkdev_close+0x24/0x27
[ 13.408747] __fput+0xf3/0x1ac
[ 13.409630] task_work_run+0x79/0xa0
[ 13.410577] exit_to_usermode_loop+0x5e/0x8d
[ 13.411568] syscall_return_slowpath+0x102/0x115
[ 13.412618] entry_SYSCALL_64_fastpath+0x94/0x96
[ 13.413711] RIP: 0033:0x7f3e95c56f00
[ 13.414663] RSP: 002b:00007ffc154835f8 EFLAGS: 00000246 ORIG_RAX: 0000000000000003
[ 13.416522] RAX: 0000000000000000 RBX: 0000000000000007 RCX: 00007f3e95c56f00
[ 13.417961] RDX: 00007f3e95f17b78 RSI: 00007ffc15482df0 RDI: 0000000000000007
[ 13.419558] RBP: 00007f3e9658a6e0 R08: 00007f3e9658a780 R09: 000000000000000b
[ 13.420940] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000002
[ 13.422328] R13: 0000000000647010 R14: 0000000000000007 R15: 0000000000651900
[ 13.423767] BUG: Bad page state in process udevd pfn:13778
[ 13.425822] page:ffffe3cb004dde00 count:0 mapcount:0 mapping:ffff94bbde00e9b8 index:0x3ffff80
[ 13.427986] flags: 0x10000000000000c(referenced|uptodate)
[ 13.429219] raw: 010000000000000c ffff94bbde00e9b8 0000000003ffff80 00000000ffffffff
[ 13.431148] raw: ffffe3cb005b3560 ffffbdc04032fc48 0000000000000000 0000000000000000
[ 13.433070] page dumped because: non-NULL mapping
[ 13.434184] Modules linked in: snd_pcsp
[ 13.435222] CPU: 0 PID: 2176 Comm: udevd Tainted: G B 4.15.0-rc6-00058-g24424242 #137
[ 13.437326] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 13.439238] Call Trace:
[ 13.440074] dump_stack+0x85/0xbc
[ 13.441033] bad_page+0xf2/0x10c
[ 13.441994] free_unref_page_prepare+0x19b/0x1f2
[ 13.443095] free_unref_page_list+0x4d/0x274
[ 13.444180] release_pages+0x2cb/0x2da
[ 13.445183] __pagevec_release+0x23/0x2c
[ 13.446185] truncate_inode_pages_range+0x1f1/0x582
[ 13.447323] __blkdev_put+0x62/0x194
[ 13.448290] blkdev_close+0x24/0x27
[ 13.449239] __fput+0xf3/0x1ac
[ 13.450131] task_work_run+0x79/0xa0
[ 13.451088] exit_to_usermode_loop+0x5e/0x8d
[ 13.452164] syscall_return_slowpath+0x102/0x115
[ 13.453296] entry_SYSCALL_64_fastpath+0x94/0x96
[ 13.454401] RIP: 0033:0x7f3e95c56f00
[ 13.455356] RSP: 002b:00007ffc154835f8 EFLAGS: 00000246 ORIG_RAX: 0000000000000003
[ 13.457247] RAX: 0000000000000000 RBX: 0000000000000007 RCX: 00007f3e95c56f00
[ 13.458678] RDX: 00007f3e95f17b78 RSI: 00007ffc15482df0 RDI: 0000000000000007
[ 13.460138] RBP: 00007f3e9658a6e0 R08: 00007f3e9658a780 R09: 000000000000000b
[ 13.461581] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000002
[ 13.462964] R13: 0000000000647010 R14: 0000000000000007 R15: 0000000000651900
[ 13.464441] BUG: Bad page state in process udevd pfn:16cd5
[ 13.465740] page:ffffe3cb005b3540 count:0 mapcount:0 mapping:ffff94bbde00e9b8 index:0x3fffe7e
[ 13.467762] flags: 0x10000000000000c(referenced|uptodate)
[ 13.468974] raw: 010000000000000c ffff94bbde00e9b8 0000000003fffe7e 00000000ffffffff
[ 13.470903] raw: ffffe3cb004dcc20 ffffbdc04032fc48 0000000000000000 0000000000000000
[ 13.472882] page dumped because: non-NULL mapping
[ 13.474017] Modules linked in: snd_pcsp
[ 13.475028] CPU: 0 PID: 2176 Comm: udevd Tainted: G B 4.15.0-rc6-00058-g24424242 #137
[ 13.477189] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 13.479205] Call Trace:
[ 13.480028] dump_stack+0x85/0xbc
[ 13.480956] bad_page+0xf2/0x10c
[ 13.481887] free_unref_page_prepare+0x19b/0x1f2
[ 13.483017] free_unref_page_list+0x4d/0x274
[ 13.484070] release_pages+0x2cb/0x2da
[ 13.485052] __pagevec_release+0x23/0x2c
[ 13.486086] truncate_inode_pages_range+0x1f1/0x582
[ 13.487272] __blkdev_put+0x62/0x194
[ 13.488235] blkdev_close+0x24/0x27
[ 13.489183] __fput+0xf3/0x1ac
[ 13.490078] task_work_run+0x79/0xa0
[ 13.491040] exit_to_usermode_loop+0x5e/0x8d
[ 13.492118] syscall_return_slowpath+0x102/0x115
[ 13.493248] entry_SYSCALL_64_fastpath+0x94/0x96
[ 13.494363] RIP: 0033:0x7f3e95c56f00
[ 13.495322] RSP: 002b:00007ffc154835f8 EFLAGS: 00000246 ORIG_RAX: 0000000000000003
[ 13.497204] RAX: 0000000000000000 RBX: 0000000000000007 RCX: 00007f3e95c56f00
[ 13.498668] RDX: 00007f3e95f17b78 RSI: 00007ffc15482df0 RDI: 0000000000000007
[ 13.500126] RBP: 00007f3e9658a6e0 R08: 00007f3e9658a780 R09: 000000000000000b
[ 13.501537] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000002
[ 13.502989] R13: 0000000000647010 R14: 0000000000000007 R15: 0000000000651900
[ 13.504470] BUG: Bad page state in process udevd pfn:13730
[ 13.505707] page:ffffe3cb004dcc00 count:0 mapcount:0 mapping:ffff94bbde00e9b8 index:0x200
[ 13.507728] flags: 0x10000000000000c(referenced|uptodate)
[ 13.508974] raw: 010000000000000c ffff94bbde00e9b8 0000000000000200 00000000ffffffff
[ 13.510933] raw: ffffe3cb005b35a0 ffffbdc04032fc48 0000000000000000 0000000000000000
[ 13.512850] page dumped because: non-NULL mapping
[ 13.513988] Modules linked in: snd_pcsp
[ 13.515032] CPU: 0 PID: 2176 Comm: udevd Tainted: G B 4.15.0-rc6-00058-g24424242 #137
[ 13.517152] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 13.519173] Call Trace:
[ 13.520031] dump_stack+0x85/0xbc
[ 13.520976] bad_page+0xf2/0x10c
[ 13.521888] free_unref_page_prepare+0x19b/0x1f2
[ 13.522982] free_unref_page_list+0x4d/0x274
[ 13.524053] release_pages+0x2cb/0x2da
[ 13.525067] __pagevec_release+0x23/0x2c
[ 13.526083] truncate_inode_pages_range+0x1f1/0x582
[ 13.527221] __blkdev_put+0x62/0x194
[ 13.528210] blkdev_close+0x24/0x27
[ 13.529188] __fput+0xf3/0x1ac
[ 13.530116] task_work_run+0x79/0xa0
[ 13.531076] exit_to_usermode_loop+0x5e/0x8d
[ 13.532125] syscall_return_slowpath+0x102/0x115
[ 13.533219] entry_SYSCALL_64_fastpath+0x94/0x96
[ 13.534341] RIP: 0033:0x7f3e95c56f00
[ 13.535336] RSP: 002b:00007ffc154835f8 EFLAGS: 00000246 ORIG_RAX: 0000000000000003
[ 13.537215] RAX: 0000000000000000 RBX: 0000000000000007 RCX: 00007f3e95c56f00
[ 13.538630] RDX: 00007f3e95f17b78 RSI: 00007ffc15482df0 RDI: 0000000000000007
[ 13.540099] RBP: 00007f3e9658a6e0 R08: 00007f3e9658a780 R09: 000000000000000b
[ 13.541545] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000002
[ 13.542996] R13: 0000000000647010 R14: 0000000000000007 R15: 0000000000651900
Elapsed time: 20
#!/bin/bash
# To reproduce,
# 1) save job-script and this script (both are attached in 0day report email)
# 2) run this script with your compiled kernel and optional env $INSTALL_MOD_PATH
kernel=$1
initrds=(
/osimage/yocto/yocto-minimal-x86_64-2016-04-22.cgz
/lkp/lkp/lkp-x86_64.cgz
)
HTTP_PREFIX=https://github.com/0day-ci/lkp-qemu/raw/master
wget --timestamping "${initrds[@]/#/$HTTP_PREFIX}"
{
cat "${initrds[@]//*\//}"
[[ $INSTALL_MOD_PATH ]] && (
cd "$INSTALL_MOD_PATH"
find lib | cpio -o -H newc --quiet | gzip
)
echo job-script | cpio -o -H newc --quiet | gzip
} > initrd.img
qemu-img create -f qcow2 disk-vm-lkp-hsw01-yocto-x86_64-28-0 256G
kvm=(
qemu-system-x86_64
-enable-kvm
-kernel $kernel
-initrd initrd.img
-m 512
-smp 1
-device e1000,netdev=net0
-netdev user,id=net0
-boot order=nc
-no-reboot
-watchdog i6300esb
-watchdog-action debug
-rtc base=localtime
-drive file=disk-vm-lkp-hsw01-yocto-x86_64-28-0,media=disk,if=virtio
-serial stdio
-display none
-monitor null
)
append=(
ip=::::vm-lkp-hsw01-yocto-x86_64-28::dhcp
root=/dev/ram0
user=lkp
job=/job-script
ARCH=x86_64
kconfig=x86_64-nfsroot
branch=dax/xarray-2017-12-11
commit=2442424275f104e5c479d5d8ea92c79546dd48a0
BOOT_IMAGE=/pkg/linux/x86_64-nfsroot/gcc-7/2442424275f104e5c479d5d8ea92c79546dd48a0/vmlinuz-4.15.0-rc6-00058-g24424242
max_uptime=600
RESULT_ROOT=/result/boot/1/vm-lkp-hsw01-yocto-x86_64/yocto-minimal-x86_64-2016-04-22.cgz/x86_64-nfsroot/gcc-7/2442424275f104e5c479d5d8ea92c79546dd48a0/0
result_service=tmpfs
debug
apic=debug
sysrq_always_enabled
rcupdate.rcu_cpu_stall_timeout=100
net.ifnames=0
printk.devkmsg=on
panic=-1
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email
Thanks,
lkp
4 years, 4 months
192ffafb71 ("idr: Convert to XArray"): BUG: KASAN: use-after-free in xas_set_tag
by kernel test robot
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
git://git.infradead.org/users/willy/linux-dax.git xarray-2017-12-11
commit 192ffafb71abe8cd3ac76d24c1f4c00ce192108c
Author: Matthew Wilcox <mawilcox(a)microsoft.com>
AuthorDate: Fri Nov 17 08:21:15 2017 -0500
Commit: Matthew Wilcox <mawilcox(a)microsoft.com>
CommitDate: Mon Jan 1 16:31:57 2018 -0500
idr: Convert to XArray
The IDR distinguishes between unallocated entries (read as NULL) and
entries where the user has chosen to store NULL. The radix tree was
modified to consider NULL entries which had tag 0 _clear_ as being
allocated, but it added a lot of complexity.
Instead, the XArray has a 'zero entry', which the normal API will treat
as NULL, but is distinct from NULL when using the advanced API. The IDR
code converts between NULL and zero entries.
The idr_for_each_entry_ul() iterator becomes an alias for xa_for_each(),
so we drop the idr_get_next_ul() function as it has no users.
The exported IDR API was a weird mix of GPL-only and general symbols;
I converted them all to GPL as there was no way to use the IDR API
without being GPL.
Signed-off-by: Matthew Wilcox <mawilcox(a)microsoft.com>
7c9894b89d xarray: Add ability to store errno values
192ffafb71 idr: Convert to XArray
7c7f1f88ff convert test suite
+-------------------------------+------------+------------+------------+
| | 7c9894b89d | 192ffafb71 | 7c7f1f88ff |
+-------------------------------+------------+------------+------------+
| boot_successes | 43 | 9 | 1 |
| boot_failures | 0 | 9 | 2 |
| BUG:KASAN:use-after-free_in_x | 0 | 9 | 2 |
+-------------------------------+------------+------------+------------+
[ 62.436305] rcu-torture: Reader Batch: 0 2 0 0 0 0 0 0 0 0 0
[ 62.437432] rcu-torture: Free-Block Circulation: 0 0 0 0 0 0 0 0 0 0 0
[ 64.467707] Unable to find swap-space signature
[ 65.445573] Unable to find swap-space signature
[ 89.549673] ==================================================================
[ 89.550845] BUG: KASAN: use-after-free in xas_set_tag+0xc2/0x15a
[ 89.551765] Read of size 1 at addr ffff880013488cf9 by task trinity-c1/1030
[ 89.552857]
[ 89.553124] CPU: 0 PID: 1030 Comm: trinity-c1 Not tainted 4.15.0-rc6-00032-g192ffaf #1
[ 89.569358] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 89.570696] Call Trace:
[ 89.571130] dump_stack+0xae/0x12e
[ 89.571677] ? arch_local_irq_restore+0xd/0xd
[ 89.572374] ? show_regs_print_info+0xb/0xb
[ 89.573014] ? lock_acquire+0xe2/0x144
[ 89.573596] ? xas_set_tag+0xc2/0x15a
[ 89.574171] print_address_description+0x57/0x227
[ 89.574883] ? xas_set_tag+0xc2/0x15a
[ 89.575457] kasan_report+0x220/0x249
[ 89.576021] __asan_report_load1_noabort+0x14/0x16
[ 89.588849] xas_set_tag+0xc2/0x15a
[ 89.589468] xas_init_tags+0x72/0x8c
[ 89.590109] xas_store+0x15a/0xbd4
[ 89.590692] ? rcu_read_unlock+0x23/0x25
[ 89.591355] ? xas_init_tags+0x8c/0x8c
[ 89.591962] ? pvclock_read_flags+0xba/0xba
[ 89.592644] ? pvclock_read_flags+0xba/0xba
[ 89.593326] ? kvm_clock_read+0x25/0x2e
[ 89.593948] ? kvm_sched_clock_read+0x9/0x12
[ 89.594651] ? paravirt_sched_clock+0x9/0xd
[ 89.595342] ? sched_clock+0x9/0xb
[ 89.595918] ? find_held_lock+0x33/0x103
[ 89.596573] ? lock_acquired+0x50a/0x539
[ 89.597214] __xa_erase+0x1f3/0x22c
[ 89.597804] ? xa_load+0x268/0x268
[ 89.609403] idr_remove+0x23/0x3c
[ 89.609971] __bpf_map_put+0xc7/0x22c
[ 89.610589] ? bpf_dummy_read+0xd/0xd
[ 89.611193] ? in_sched_functions+0x30/0x30
[ 89.611901] ? fsnotify_unmount_inodes+0x263/0x263
[ 89.612734] ? rcu_note_context_switch+0x287/0x287
[ 89.613567] bpf_map_put+0xe/0x10
[ 89.614137] bpf_map_put_with_uref+0x55/0x58
[ 89.614844] bpf_map_release+0x94/0x9d
[ 89.615456] __fput+0x3a5/0x587
[ 89.615971] ? file_free+0x61/0x61
[ 89.616532] ? in_sched_functions+0x30/0x30
[ 89.617211] ____fput+0x9/0xb
[ 89.617699] task_work_run+0x193/0x1e4
[ 89.618318] ? task_work_cancel+0x1cf/0x1cf
[ 89.619017] ? free_nsproxy+0x6e/0x71
[ 89.619674] ? switch_task_namespaces+0x87/0x90
[ 89.620471] do_exit+0xccf/0x20e7
[ 89.621054] ? is_current_pgrp_orphaned+0x8c/0x8c
[ 89.621828] ? __set_page_dirty_no_writeback+0xf/0x53
[ 89.622639] ? put_page+0x62/0x11d
[ 89.623202] ? __list_add+0x150/0x150
[ 89.623798] ? fault_in_pages_readable+0xc0/0xc0
[ 89.624557] ? kvm_clock_read+0x25/0x2e
[ 89.625209] ? shmem_write_end+0x2dd/0x30f
[ 89.625926] ? zero_user_segments+0x61/0x61
[ 89.626653] ? pvclock_read_flags+0xba/0xba
[ 89.627363] ? iov_iter_copy_from_user_atomic+0x66e/0x66e
[ 89.628237] ? kvm_clock_read+0x25/0x2e
[ 89.628857] ? kvm_sched_clock_read+0x9/0x12
[ 89.629565] ? paravirt_sched_clock+0x9/0xd
[ 89.630276] ? sched_clock+0x9/0xb
[ 89.630835] ? check_chain_key+0x19e/0x25b
[ 89.631510] ? lock_release+0x639/0x668
[ 89.632163] ? lock_downgrade+0x56f/0x56f
[ 89.632862] ? pvclock_read_flags+0xba/0xba
[ 89.633597] ? pvclock_read_flags+0xba/0xba
[ 89.634304] ? pvclock_read_flags+0xba/0xba
[ 89.634993] ? sched_clock+0x9/0xb
[ 89.635553] ? kvm_clock_read+0x25/0x2e
[ 89.636180] ? kvm_sched_clock_read+0x9/0x12
[ 89.636864] ? paravirt_sched_clock+0x9/0xd
[ 89.637539] ? sched_clock+0x9/0xb
[ 89.638096] ? sched_clock_cpu+0x1f/0x147
[ 89.638761] ? lock_release+0x639/0x668
[ 89.639420] ? lock_downgrade+0x56f/0x56f
[ 89.640137] ? lock_acquire+0xe2/0x144
[ 89.640787] ? lock_acquire+0x135/0x144
[ 89.641457] do_group_exit+0x30a/0x30a
[ 89.642073] ? rcu_read_unlock+0x23/0x25
[ 89.642704] ? SyS_exit+0x20/0x20
[ 89.643249] ? pid_vnr+0x24/0x24
[ 89.643775] ? sys_gettid+0x1a/0x1a
[ 89.644346] ? lockdep_sys_exit_thunk+0x16/0x27
[ 89.645074] SyS_exit_group+0x18/0x18
[ 89.645681] entry_SYSCALL_64_fastpath+0x1e/0x86
[ 89.646458] RIP: 0033:0x452e48
[ 89.646957] RSP: 002b:00007ffee3e1dfa8 EFLAGS: 00000206 ORIG_RAX: 00000000000000e7
[ 89.648215] RAX: ffffffffffffffda RBX: 0000000001045cf8 RCX: 0000000000452e48
[ 89.649462] RDX: 0000000000000001 RSI: 000000000000003c RDI: 0000000000000001
[ 89.650638] RBP: 000000000000270f R08: 00000000000000e7 R09: ffffffffffffffb0
[ 89.651761] R10: ffffffffffffffff R11: 0000000000000206 R12: 0000000000000040
[ 89.652882] R13: 0000000001045cf8 R14: 0000000002d72f90 R15: 0000000001045ca0
[ 89.654005]
[ 89.654274] Allocated by task 669:
[ 89.654860] save_stack+0x43/0xc9
[ 89.655433] kasan_kmalloc+0x94/0xa3
[ 89.656021] kasan_slab_alloc+0x12/0x14
[ 89.656663] slab_post_alloc_hook+0x35/0x45
[ 89.657375] kmem_cache_alloc+0xdf/0xf1
[ 89.658057] xas_alloc+0xfe/0x329
[ 89.658644] xas_create+0x2b5/0x8bd
[ 89.659240] xas_store+0xc2/0xbd4
[ 89.659795] idr_alloc_ul+0x316/0x3cc
[ 89.660400] idr_alloc_cyclic+0x125/0x207
[ 89.661054] SyS_bpf+0x744/0x1b04
[ 89.661600] entry_SYSCALL_64_fastpath+0x1e/0x86
[ 89.662344]
[ 89.662604] Freed by task 1030:
[ 89.663124] save_stack+0x43/0xc9
[ 89.663673] kasan_slab_free+0x90/0xb3
[ 89.664310] slab_free_freelist_hook+0x8f/0x98
[ 89.665083] kmem_cache_free+0x4a/0xd5
[ 89.665735] radix_tree_node_rcu_free+0x105/0x12d
[ 89.666527] rcu_process_callbacks+0x73b/0xad9
[ 89.667248] __do_softirq+0x1cc/0x3fd
[ 89.667847]
[ 89.668114] The buggy address belongs to the object at ffff880013488cf8
[ 89.668114] which belongs to the cache radix_tree_node of size 192
[ 89.670113] The buggy address is located 1 bytes inside of
[ 89.670113] 192-byte region [ffff880013488cf8, ffff880013488db8)
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start 8701f126a98d743b77ad49964e0553f63d861108 30a7acd573899fd8b8ac39236eff6468b195ac7d --
git bisect bad 7c00133740b145493b65c516c614559fc87f000a # 11:33 B 2 2 0 0 Merge 'mzx/for-next' into devel-catchup-201801021046
git bisect bad c51383931ee7076c27eb1ad674bd31cbbf575b33 # 11:58 B 0 2 15 0 Merge 'dax/xarray-2017-12-11' into devel-catchup-201801021046
git bisect good eeef907284a9210217a0da8ed39a90bcf4d1a509 # 12:38 G 13 0 0 0 0day base guard for 'devel-catchup-201801021046'
git bisect bad b00df7ac263327b60bae584f3d9735ec2d629437 # 13:05 B 1 2 0 0 shmem: Convert find_swap_entry to XArray
git bisect good 8be4282fbbac7c11d2b5c40ce309dd44684501f5 # 13:53 G 14 0 0 0 xarray: Add xa_destroy
git bisect bad d314d57ea65a174b7222eba82bdd9d062e2e4cc6 # 14:16 B 0 1 14 0 page cache: Remove stray radix comment
git bisect bad e3b343f87afce611ff118458568da2651e9341bf # 14:31 B 0 1 14 0 ida: Convert to XArray
git bisect good c540e2a32cc9fbb91cd4ea83742cc3d669449d7c # 15:43 G 13 0 0 0 xarray: Add MAINTAINERS entry
git bisect bad 192ffafb71abe8cd3ac76d24c1f4c00ce192108c # 16:05 B 1 1 0 0 idr: Convert to XArray
git bisect good 7c9894b89d1e35db4f5d9e466f3b9e0626694b8b # 16:58 G 13 0 0 0 xarray: Add ability to store errno values
# first bad commit: [192ffafb71abe8cd3ac76d24c1f4c00ce192108c] idr: Convert to XArray
git bisect good 7c9894b89d1e35db4f5d9e466f3b9e0626694b8b # 17:52 G 39 0 0 0 xarray: Add ability to store errno values
# extra tests with debug options
git bisect bad 192ffafb71abe8cd3ac76d24c1f4c00ce192108c # 18:12 B 1 1 0 0 idr: Convert to XArray
# extra tests on HEAD of linux-devel/devel-catchup-201801021046
git bisect bad 8701f126a98d743b77ad49964e0553f63d861108 # 18:17 B 4 9 0 0 0day head guard for 'devel-catchup-201801021046'
# extra tests on tree/branch dax/xarray-2017-12-11
git bisect bad 7c7f1f88ffc55b930efc4cac2fe4b3b4e26ef54f # 18:38 B 1 1 0 0 convert test suite
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
4 years, 4 months
[lkp-robot] [mm, mlock, vmscan] 7f2ca91b49: reaim.jobs_per_min -7.4% regression
by kernel test robot
Greeting,
FYI, we noticed a -7.4% regression of reaim.jobs_per_min due to commit:
commit: 7f2ca91b498654e7e3405f1f76ac5a80c76d336e ("mm, mlock, vmscan: no more skipping pagevecs")
https://git.kernel.org/cgit/linux/kernel/git/next/linux-next.git master
in testcase: reaim
on test machine: 56 threads Intel(R) Xeon(R) CPU E5-2695 v3 @ 2.30GHz with 256G memory
with following parameters:
runtime: 300s
nr_task: 1000
test: mem_rtns_1
cpufreq_governor: performance
test-description: REAIM is an updated and improved version of AIM 7 benchmark.
test-url: https://sourceforge.net/projects/re-aim-7/
Details are as below:
-------------------------------------------------------------------------------------------------->
To reproduce:
git clone https://github.com/intel/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-7/performance/x86_64-rhel-7.2/1000/debian-x86_64-2016-08-31.cgz/300s/lkp-hsw-ep5/mem_rtns_1/reaim
commit:
df0ed1a935 ("mm: use sc->priority for slab shrink targets")
7f2ca91b49 ("mm, mlock, vmscan: no more skipping pagevecs")
df0ed1a935d2fa55 7f2ca91b498654e7e3405f1f76
---------------- --------------------------
%stddev %change %stddev
\ | \
181225 -7.4% 167863 reaim.jobs_per_min
181.22 -7.4% 167.86 reaim.jobs_per_min_child
85.06 -2.0% 83.31 reaim.jti
187067 -8.1% 171983 reaim.max_jobs_per_min
33.11 +8.0% 35.75 reaim.parent_time
14.36 +12.3% 16.12 ± 3% reaim.std_dev_percent
4.30 +20.0% 5.17 ± 2% reaim.std_dev_time
317.29 -4.5% 303.15 reaim.time.elapsed_time
317.29 -4.5% 303.15 reaim.time.elapsed_time.max
4244477 -3.1% 4112587 reaim.time.involuntary_context_switches
1.42e+09 -11.3% 1.26e+09 reaim.time.minor_page_faults
4512 -12.7% 3938 reaim.time.user_time
0.05 ± 22% +0.0 0.07 ± 23% mpstat.cpu.iowait%
1182842 ± 2% -10.6% 1057587 turbostat.C6
1.143e+09 ± 2% -10.7% 1.02e+09 cpuidle.C6.time
1183943 ± 2% -10.6% 1058650 cpuidle.C6.usage
20578 ± 2% +4.9% 21586 vmstat.system.cs
59905 -1.7% 58858 vmstat.system.in
7.263e+08 -11.4% 6.436e+08 numa-numastat.node0.local_node
7.263e+08 -11.4% 6.436e+08 numa-numastat.node0.numa_hit
6.96e+08 -11.0% 6.193e+08 numa-numastat.node1.local_node
6.96e+08 -11.0% 6.193e+08 numa-numastat.node1.numa_hit
360758 -15.3% 305643 meminfo.Active
43539 -100.0% 4.00 meminfo.Active(file)
1143319 -99.1% 10321 meminfo.Inactive
1132616 -100.0% 0.00 meminfo.Inactive(file)
35919 ± 14% -37.0% 22614 ± 3% meminfo.Shmem
184115 ± 4% -24.9% 138319 ± 21% numa-meminfo.node0.Active
21699 ± 4% -100.0% 2.00 ±100% numa-meminfo.node0.Active(file)
575096 ± 2% -99.4% 3258 ±109% numa-meminfo.node0.Inactive
569787 ± 2% -100.0% 0.00 numa-meminfo.node0.Inactive(file)
21838 ± 5% -100.0% 2.00 ±100% numa-meminfo.node1.Active(file)
568212 ± 2% -98.8% 7034 ± 51% numa-meminfo.node1.Inactive
562829 ± 2% -100.0% 0.00 numa-meminfo.node1.Inactive(file)
96.43 ± 3% -18.5% 78.61 ± 4% sched_debug.cfs_rq:/.exec_clock.stddev
77.67 ± 19% -33.9% 51.33 ± 61% sched_debug.cfs_rq:/.removed.util_avg.max
13.81 ± 2% -9.2% 12.54 sched_debug.cpu.nr_running.avg
23.25 ± 10% -15.6% 19.62 ± 2% sched_debug.cpu.nr_running.max
259.54 ± 18% +36.8% 355.08 ± 11% sched_debug.cpu.sched_goidle.min
11994 ± 6% +10.5% 13254 ± 6% sched_debug.cpu.ttwu_count.avg
1400 ± 5% +50.4% 2106 ± 20% sched_debug.cpu.ttwu_count.min
10884 -100.0% 1.00 proc-vmstat.nr_active_file
283153 -100.0% 0.00 proc-vmstat.nr_inactive_file
8982 ± 14% -37.1% 5645 ± 3% proc-vmstat.nr_shmem
10884 -100.0% 1.00 proc-vmstat.nr_zone_active_file
283153 -100.0% 0.00 proc-vmstat.nr_zone_inactive_file
1.422e+09 -11.2% 1.263e+09 proc-vmstat.numa_hit
1.422e+09 -11.2% 1.263e+09 proc-vmstat.numa_local
13178 ± 19% -57.6% 5583 ± 5% proc-vmstat.pgactivate
1.422e+09 -11.2% 1.263e+09 proc-vmstat.pgalloc_normal
1.42e+09 -11.2% 1.261e+09 proc-vmstat.pgfault
1.422e+09 -11.2% 1.263e+09 proc-vmstat.pgfree
5424 ± 4% -100.0% 0.50 ±100% numa-vmstat.node0.nr_active_file
142446 ± 2% -100.0% 0.00 numa-vmstat.node0.nr_inactive_file
5424 ± 4% -100.0% 0.50 ±100% numa-vmstat.node0.nr_zone_active_file
142446 ± 2% -100.0% 0.00 numa-vmstat.node0.nr_zone_inactive_file
3.635e+08 -11.7% 3.209e+08 numa-vmstat.node0.numa_hit
3.635e+08 -11.7% 3.209e+08 numa-vmstat.node0.numa_local
5459 ± 5% -100.0% 0.50 ±100% numa-vmstat.node1.nr_active_file
140707 ± 2% -100.0% 0.00 numa-vmstat.node1.nr_inactive_file
5459 ± 5% -100.0% 0.50 ±100% numa-vmstat.node1.nr_zone_active_file
140707 ± 2% -100.0% 0.00 numa-vmstat.node1.nr_zone_inactive_file
3.495e+08 -11.4% 3.096e+08 numa-vmstat.node1.numa_hit
3.493e+08 -11.4% 3.095e+08 numa-vmstat.node1.numa_local
5.422e+12 -7.6% 5.011e+12 perf-stat.branch-instructions
0.35 -0.0 0.34 perf-stat.branch-miss-rate%
1.876e+10 -10.4% 1.682e+10 perf-stat.branch-misses
3.13 +0.2 3.31 perf-stat.cache-miss-rate%
4.441e+09 -5.1% 4.214e+09 ± 2% perf-stat.cache-misses
1.419e+11 -10.3% 1.273e+11 perf-stat.cache-references
1.72 +4.8% 1.81 perf-stat.cpi
4.338e+13 -3.5% 4.185e+13 perf-stat.cpu-cycles
6.251e+12 -7.9% 5.754e+12 perf-stat.dTLB-loads
5.035e+09 -11.3% 4.465e+09 perf-stat.dTLB-store-misses
3.99e+12 -11.0% 3.549e+12 perf-stat.dTLB-stores
7.094e+09 -10.9% 6.321e+09 perf-stat.iTLB-loads
2.518e+13 -8.0% 2.317e+13 perf-stat.instructions
0.58 -4.6% 0.55 perf-stat.ipc
1.42e+09 -11.2% 1.261e+09 perf-stat.minor-faults
2.306e+09 ± 5% -9.0% 2.099e+09 ± 3% perf-stat.node-stores
1.42e+09 -11.2% 1.261e+09 perf-stat.page-faults
81.49 -66.7 14.75 ± 22% perf-profile.calltrace.cycles-pp.entry_SYSCALL_64_fastpath
81.36 -66.7 14.69 ± 22% perf-profile.calltrace.cycles-pp.sys_brk.entry_SYSCALL_64_fastpath
80.05 -65.5 14.50 ± 22% perf-profile.calltrace.cycles-pp.do_munmap.sys_brk.entry_SYSCALL_64_fastpath
74.39 -60.7 13.65 ± 22% perf-profile.calltrace.cycles-pp.unmap_region.do_munmap.sys_brk.entry_SYSCALL_64_fastpath
65.45 -3.8 61.61 perf-profile.calltrace.cycles-pp.tlb_finish_mmu.unmap_region.do_munmap.sys_brk.entry_SYSCALL_64_fastpath
65.30 -3.8 61.48 perf-profile.calltrace.cycles-pp.arch_tlb_finish_mmu.tlb_finish_mmu.unmap_region.do_munmap.sys_brk
63.63 -3.6 60.03 perf-profile.calltrace.cycles-pp.tlb_flush_mmu_free.arch_tlb_finish_mmu.tlb_finish_mmu.unmap_region.do_munmap
63.39 -3.6 59.81 perf-profile.calltrace.cycles-pp.release_pages.tlb_flush_mmu_free.arch_tlb_finish_mmu.tlb_finish_mmu.unmap_region
59.52 -3.1 56.46 perf-profile.calltrace.cycles-pp._raw_spin_lock_irqsave.release_pages.tlb_flush_mmu_free.arch_tlb_finish_mmu.tlb_finish_mmu
58.70 -2.9 55.79 perf-profile.calltrace.cycles-pp.native_queued_spin_lock_slowpath._raw_spin_lock_irqsave.release_pages.tlb_flush_mmu_free.arch_tlb_finish_mmu
11.82 +0.0 11.82 perf-profile.calltrace.cycles-pp.page_fault
11.71 +0.0 11.72 perf-profile.calltrace.cycles-pp.__do_page_fault.do_page_fault.page_fault
11.72 +0.0 11.73 perf-profile.calltrace.cycles-pp.do_page_fault.page_fault
9.99 +0.2 10.14 perf-profile.calltrace.cycles-pp.handle_mm_fault.__do_page_fault.do_page_fault.page_fault
9.68 +0.2 9.88 perf-profile.calltrace.cycles-pp.__handle_mm_fault.handle_mm_fault.__do_page_fault.do_page_fault.page_fault
5.26 +0.9 6.20 perf-profile.calltrace.cycles-pp.lru_add_drain.unmap_region.do_munmap.sys_brk.entry_SYSCALL_64_fastpath
4.62 +0.9 5.56 perf-profile.calltrace.cycles-pp._raw_spin_lock_irqsave.pagevec_lru_move_fn.lru_add_drain_cpu.lru_add_drain.unmap_region
5.22 +1.0 6.18 perf-profile.calltrace.cycles-pp.lru_add_drain_cpu.lru_add_drain.unmap_region.do_munmap.sys_brk
4.55 +1.0 5.51 perf-profile.calltrace.cycles-pp.native_queued_spin_lock_slowpath._raw_spin_lock_irqsave.pagevec_lru_move_fn.lru_add_drain_cpu.lru_add_drain
5.08 +1.0 6.05 perf-profile.calltrace.cycles-pp.pagevec_lru_move_fn.lru_add_drain_cpu.lru_add_drain.unmap_region.do_munmap
0.00 +57.3 57.28 ± 4% perf-profile.calltrace.cycles-pp.unmap_region.do_munmap.sys_brk.entry_SYSCALL_64_fastpath.brk
0.00 +61.3 61.34 ± 4% perf-profile.calltrace.cycles-pp.do_munmap.sys_brk.entry_SYSCALL_64_fastpath.brk
0.00 +62.3 62.30 ± 4% perf-profile.calltrace.cycles-pp.sys_brk.entry_SYSCALL_64_fastpath.brk
0.00 +62.4 62.36 ± 4% perf-profile.calltrace.cycles-pp.entry_SYSCALL_64_fastpath.brk
0.00 +65.0 64.95 ± 4% perf-profile.calltrace.cycles-pp.brk
81.45 -4.4 77.05 perf-profile.children.cycles-pp.sys_brk
81.53 -4.3 77.20 perf-profile.children.cycles-pp.entry_SYSCALL_64_fastpath
80.18 -4.2 75.98 perf-profile.children.cycles-pp.do_munmap
65.46 -3.8 61.63 perf-profile.children.cycles-pp.tlb_finish_mmu
65.34 -3.8 61.52 perf-profile.children.cycles-pp.arch_tlb_finish_mmu
63.69 -3.6 60.08 perf-profile.children.cycles-pp.tlb_flush_mmu_free
63.71 -3.6 60.10 perf-profile.children.cycles-pp.release_pages
74.47 -3.5 71.01 perf-profile.children.cycles-pp.unmap_region
67.37 -1.6 65.74 perf-profile.children.cycles-pp._raw_spin_lock_irqsave
66.42 -1.4 64.99 perf-profile.children.cycles-pp.native_queued_spin_lock_slowpath
11.84 +0.0 11.84 perf-profile.children.cycles-pp.page_fault
11.78 +0.0 11.79 perf-profile.children.cycles-pp.do_page_fault
11.80 +0.0 11.81 perf-profile.children.cycles-pp.__do_page_fault
10.04 +0.2 10.20 perf-profile.children.cycles-pp.handle_mm_fault
9.75 +0.2 9.94 perf-profile.children.cycles-pp.__handle_mm_fault
5.37 +0.9 6.30 perf-profile.children.cycles-pp.lru_add_drain
5.32 +1.0 6.27 perf-profile.children.cycles-pp.lru_add_drain_cpu
8.98 +1.6 10.62 perf-profile.children.cycles-pp.pagevec_lru_move_fn
0.00 +65.0 64.95 ± 4% perf-profile.children.cycles-pp.brk
66.42 -1.4 64.99 perf-profile.self.cycles-pp.native_queued_spin_lock_slowpath
reaim.parent_time
36.5 +-+------------------------------------------------------------------+
| O O |
36 O-O O O O O O O O O O O O |
35.5 +-+ O O O O O O |
| |
35 +-+ |
| |
34.5 +-+ |
| |
34 +-+ |
33.5 +-+ |
| .+.+..+. .+..+.+. .+.+.+..+.+. .+. .+. .|
33 +-+.. .+.+..+.+ + +..+ +. +.+. +.+.+..+ |
| + |
32.5 +-+------------------------------------------------------------------+
reaim.child_systime
1540 +-+------------------------------------------------------------------+
1520 +-+ O O |
O O O O O O O O O O O O O O O |
1500 +-+ O O O O |
1480 +-+ |
1460 +-+ |
1440 +-+ |
| |
1420 +-+ |
1400 +-+ |
1380 +-+ |
1360 +-+ .+..+. +. |
|.+.. .+. .+.+.+..+.+ +.+.. .+.+.+..+.+.+..+. .. +.+.+.. .|
1340 +-+ + +..+ + +.+ + |
1320 +-+------------------------------------------------------------------+
reaim.jobs_per_min
184000 +-+----------------------------------------------------------------+
182000 +-+.+.. |
| + +.+.+.+.. .+.+.+.. .+..+.+.+. .+.. .+.+.+..+. .+.+..+.+.|
180000 +-+ + +.+.+ + + + |
178000 +-+ |
| |
176000 +-+ |
174000 +-+ |
172000 +-+ |
| |
170000 +-+ |
168000 +-+ O O O O O O O |
O O O O O O O O O O O O |
166000 +-+ O O |
164000 +-+----------------------------------------------------------------+
reaim.jobs_per_min_child
184 +-+-------------------------------------------------------------------+
182 +-+ .+. |
| +. +.+..+.+. .+.+.+.. .+.+.+..+. .+.. .+.+..+.+. .+.+.+..+.|
180 +-+ +. +.+.+. + + +. |
178 +-+ |
| |
176 +-+ |
174 +-+ |
172 +-+ |
| |
170 +-+ |
168 +-+ O O O O O O O |
O O O O O O O O O O O O |
166 +-+ O O |
164 +-+-------------------------------------------------------------------+
reaim.std_dev_time
5.4 +-+-------------------------------------------------------------------+
| O O |
5.2 +-+ O O O O O O |
O O O O |
| O O O O O O O O O |
5 +-+ |
| |
4.8 +-+ |
| |
4.6 +-+ |
| .+ |
| .+. + |
4.4 +-+ .+. .+.+.. .+.+.. .+ +.+.. .+. .+. .+.+..+. |
|.+..+ +..+ + + + +. +.+..+ +.+..+.|
4.2 +-+-------------------------------------------------------------------+
reaim.max_jobs_per_min
190000 +-+----------------------------------------------------------------+
188000 +-+ .+. .+. .+. .+..+. |
| +.+..+ +. .+.. .+. +.+.+.+..+.+ +.. .+.+ +.|
186000 +-+ +..+.+.+ +.+.+ + |
184000 +-+ |
182000 +-+ |
180000 +-+ |
| |
178000 +-+ |
176000 +-+ |
174000 +-+ |
172000 +-O O O O O O O O |
O O O O O O O O O O O |
170000 +-+ O O |
168000 +-+----------------------------------------------------------------+
perf-stat.instructions
2.55e+13 +-+--------------------------------------------------------------+
| .+. .+. .+. .+. |
|.+.+..+.+.+.+ +..+.+.+ +.+..+.+.+.+.+.+..+ +.+ +..+.+.+.|
2.5e+13 +-+ |
| |
| |
2.45e+13 +-+ |
| |
2.4e+13 +-+ |
| |
| |
2.35e+13 +-+ |
| O O O |
O O O O O O O O O O O O O O O O O O |
2.3e+13 +-+--------------------------------------------------------------+
perf-stat.cache-references
1.5e+11 +-+--------------------------------------------------------------+
| .+.+ +..+.+ |
| .+.+ : |
1.45e+11 +-+.+.. .+.+. : |
| + +.+.+.+ +.+.+.+..+.+. .+.+.+..+. |
| + +.+.|
1.4e+11 +-+ |
| |
1.35e+11 +-+ |
| |
O O O O O O |
1.3e+11 +-+ O O O O O |
| O O O |
| O O O O O O O |
1.25e+11 +-+--------------------------------------------------------------+
perf-stat.branch-instructions
5.45e+12 +-+--------------------------------------------------------------+
5.4e+12 +-+ +..+.+.+.+ +.+.+ +.+..+.+.+.+.+.+..+ +.+ +..+.+.+ |
| |
5.35e+12 +-+ |
5.3e+12 +-+ |
| |
5.25e+12 +-+ |
5.2e+12 +-+ |
5.15e+12 +-+ |
| |
5.1e+12 +-+ |
5.05e+12 +-+ O O |
O O O O O O O O O O O O O O O |
5e+12 +-+ O O O O |
4.95e+12 +-+--------------------------------------------------------------+
perf-stat.branch-misses
1.95e+10 +-+--------------------------------------------------------------+
| .+. .+.+.. |
1.9e+10 +-+ .+ +.+ .+. |
| .+.+.+.+.+. +.+. .+ +.+.. .+.|
|.+.+..+ +. .+. .+.+ +.+ |
1.85e+10 +-+ + +. |
| |
1.8e+10 +-+ |
| |
1.75e+10 +-+ |
| |
| O O O O O O |
1.7e+10 O-O O O O O O O |
| O O O O O O O |
1.65e+10 +-+--------------------------------------------------------------+
perf-stat.dTLB-loads
6.4e+12 +-+---------------------------------------------------------------+
| |
6.3e+12 +-+ .+.+.+..+.+.+.+.+..+.+. .+. |
|.+.+..+.+ + +..+.+.+.+.+..+.+.+.+.+..+.+.|
6.2e+12 +-+ |
| |
6.1e+12 +-+ |
| |
6e+12 +-+ |
| |
5.9e+12 +-+ |
| |
5.8e+12 O-O O O O O O O O |
| O O O O O O O O O O O O |
5.7e+12 +-+---------------------------------------------------------------+
[*] 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
4 years, 4 months
[lkp-robot] [mm/memory_hotplug] 3072e413e3: page_allocation_failure:order:#, mode:#(GFP_KERNEL|__GFP_RETRY_MAYFAIL|__GFP_ZERO), nodemask=(null)
by kernel test robot
FYI, we noticed the following commit (built with gcc-7):
commit: 3072e413e305e353cd4654f8a57d953b66e85bf3 ("mm/memory_hotplug: introduce add_pages")
https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git master
in testcase: nvml
with following parameters:
group: obj
test: pmem
nr_pmem: 1
fs: ext4
mount_option: dax
on test machine: qemu-system-x86_64 -enable-kvm -cpu host -smp 2 -m 1G
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
Starting /etc/rc.local Compatibility...
Starting OpenBSD Secure Shell server...
Starting LKP bootstrap...
rc.local[2139]: PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/lkp/lkp/src/bin
LKP: HOSTNAME vm-lkp-hsw01-1G-10, MAC 52:54:00:12:34:56, kernel 4.13.0-09235-g3072e41 1, serial console /dev/ttyS0
[ 6.268581] systemd-udevd: page allocation failure: order:9, mode:0x14084c0(GFP_KERNEL|__GFP_RETRY_MAYFAIL|__GFP_ZERO), nodemask=(null)
[ 6.270880] systemd-udevd cpuset=/ mems_allowed=0
[ 6.271638] CPU: 0 PID: 1811 Comm: systemd-udevd Tainted: G O 4.13.0-09235-g3072e41 #1
[ 6.273289] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 6.274930] Call Trace:
[ 6.275644] dump_stack+0x8e/0xc8
[ 6.276289] warn_alloc+0xe4/0x165
[ 6.276922] ? find_next_bit+0xb/0xd
[ 6.277579] __alloc_pages_nodemask+0xe1a/0xef1
[ 6.278476] vmemmap_alloc_block+0x43/0x84
[ 6.279224] alloc_block_buf+0x15/0x3a
[ 6.280040] __vmemmap_alloc_block_buf+0x12b/0x13e
[ 6.280798] vmemmap_populate+0x115/0x2ed
[ 6.281487] sparse_mem_map_populate+0x27/0x38
[ 6.282230] sparse_add_one_section+0x76/0x15b
[ 6.282949] __add_pages+0x122/0x211
[ 6.283607] add_pages+0x1a/0x68
[ 6.284227] arch_add_memory+0x43/0x4b
[ 6.284888] devm_memremap_pages+0x27a/0x396
[ 6.285596] __wrap_devm_memremap_pages+0x50/0x59 [nfit_test_iomap]
[ 6.286467] pmem_attach_disk+0x305/0x4e4 [nd_pmem]
[ 6.287223] ? kfree_const+0x20/0x23
[ 6.287868] ? kobject_put+0x165/0x16d
[ 6.288531] ? put_device+0x17/0x1a
[ 6.289169] nd_pmem_probe+0x8f/0x94 [nd_pmem]
[ 6.289889] nvdimm_bus_probe+0x6c/0x10b [libnvdimm]
[ 6.290653] driver_probe_device+0x1d4/0x3cb
[ 6.291359] __driver_attach+0xbb/0xde
[ 6.292018] ? driver_probe_device+0x3cb/0x3cb
[ 6.292738] ? driver_probe_device+0x3cb/0x3cb
[ 6.293456] bus_for_each_dev+0x6d/0x85
[ 6.294121] driver_attach+0x1e/0x20
[ 6.294771] bus_add_driver+0x13b/0x222
[ 6.295440] driver_register+0x88/0xbf
[ 6.296098] ? 0xffffffffa0005000
[ 6.296724] __nd_driver_register+0x75/0x7c [libnvdimm]
[ 6.297506] ? 0xffffffffa0005000
[ 6.298129] pmem_init+0x1e/0x1000 [nd_pmem]
[ 6.298834] do_one_initcall+0x90/0x131
[ 6.299503] ? kmem_cache_alloc_trace+0xc9/0x179
[ 6.300290] ? do_init_module+0x27/0x1dd
[ 6.300964] do_init_module+0x5f/0x1dd
[ 6.301627] load_module+0x1ae2/0x20ea
[ 6.302291] ? kernel_read+0x43/0x55
[ 6.302936] SyS_finit_module+0xb8/0xc5
[ 6.303606] ? SyS_finit_module+0xb8/0xc5
[ 6.304291] do_syscall_64+0x69/0xee
[ 6.304936] entry_SYSCALL64_slow_path+0x25/0x25
[ 6.305670] RIP: 0033:0x7ff6c5c940f9
[ 6.306316] RSP: 002b:00007ffcd9b9da98 EFLAGS: 00000246 ORIG_RAX: 0000000000000139
[ 6.307594] RAX: ffffffffffffffda RBX: 0000562413ad7ed0 RCX: 00007ff6c5c940f9
[ 6.308535] RDX: 0000000000000000 RSI: 00007ff6c65ac265 RDI: 000000000000000f
[ 6.309477] RBP: 00007ff6c65ac265 R08: 0000000000000000 R09: 00007ffcd9b9e010
[ 6.310416] R10: 000000000000000f R11: 0000000000000246 R12: 0000000000000000
[ 6.311360] R13: 0000562413acfc70 R14: 0000000000020000 R15: 0000562412068924
[ 6.312319] Mem-Info:
[ 6.360020] active_anon:15233 inactive_anon:2237 isolated_anon:0
[ 6.360020] active_file:4 inactive_file:3 isolated_file:0
[ 6.360020] unevictable:106641 dirty:0 writeback:0 unstable:0
[ 6.360020] slab_reclaimable:6418 slab_unreclaimable:2577
[ 6.360020] mapped:3538 shmem:2265 pagetables:696 bounce:0
[ 6.360020] free:62722 free_pcp:128 free_cma:51196
[ 6.372019] Node 0 active_anon:61340kB inactive_anon:8948kB active_file:16kB inactive_file:12kB unevictable:426564kB isolated(anon):0kB isolated(file):0kB mapped:14152kB dirty:0kB writeback:0kB shmem:9060kB shmem_thp: 0kB shmem_pmdmapped: 0kB anon_thp: 0kB writeback_tmp:0kB unstable:0kB all_unreclaimable? no
[ 6.375805] Node 0 DMA free:3520kB min:788kB low:984kB high:1180kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB writepending:0kB present:15992kB managed:15908kB mlocked:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB
[ 6.388022] lowmem_reserve[]: 0 656 656 656 656
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email
Thanks,
Xiaolong
4 years, 4 months
[lkp-robot] [xfs] 8353a814f2: kmsg.XFS(dm-#):writeback_error_on_sector
by kernel test robot
FYI, we noticed the following commit (built with gcc-6):
commit: 8353a814f2518dcfa79a5bb77afd0e7dfa391bb1 ("xfs: open code end_buffer_async_write in xfs_finish_page_writeback")
https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git master
in testcase: xfstests
with following parameters:
disk: 4HDD
fs: xfs
test: generic-group3
test-description: xfstests is a regression test suite for xfs and other files ystems.
test-url: git://git.kernel.org/pub/scm/fs/xfs/xfstests-dev.git
on test machine: 4 threads Intel(R) Core(TM) i5-2500K CPU @ 3.30GHz with 6G memory
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
[ 725.992312] XFS (dm-3): writeback error on sector 1485824
[ 735.968267] XFS (dm-3): writeback error on sector 1487872
[ 735.972288] XFS (dm-3): writeback error on sector 1490944
[ 735.976156] XFS (dm-3): writeback error on sector 1494016
[ 735.980056] XFS (dm-3): writeback error on sector 1497088
[ 735.983875] XFS (dm-3): writeback error on sector 1500160
[ 735.987635] XFS (dm-3): writeback error on sector 1503232
[ 735.989493] XFS (dm-3): writeback error on sector 1506304
[ 735.991361] XFS (dm-3): writeback error on sector 1509376
[ 735.993200] XFS (dm-3): writeback error on sector 1512448
[ 735.995052] XFS (dm-3): writeback error on sector 1515520
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp install job.yaml # job file is attached in this email
bin/lkp run job.yaml
Thanks,
Xiaolong
4 years, 4 months
[lkp-robot] [workqueue] 5c0338c687: blogbench.write_score -21.2% regression
by kernel test robot
Greeting,
FYI, we noticed a -21.2% regression of blogbench.write_score due to commit:
commit: 5c0338c68706be53b3dc472e4308961c36e4ece1 ("workqueue: restore WQ_UNBOUND/max_active==1 to be ordered")
https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git master
in testcase: blogbench
on test machine: 16 threads Intel(R) Xeon(R) CPU D-1541 @ 2.10GHz with 8G memory
with following parameters:
disk: 1SSD
fs: btrfs
cpufreq_governor: performance
test-description: Blogbench is a portable filesystem benchmark that tries to reproduce the load of a real-world busy file server.
test-url: https://www.pureftpd.org/project/blogbench
Details are as below:
-------------------------------------------------------------------------------------------------->
To reproduce:
git clone https://github.com/intel/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/disk/fs/kconfig/rootfs/tbox_group/testcase:
gcc-6/performance/1SSD/btrfs/x86_64-rhel-7.2/debian-x86_64-2016-08-31.cgz/lkp-bdw-de1/blogbench
commit:
74cbd96bc2 ("Merge tag 'md/4.13-rc2' of git://git.kernel.org/pub/scm/linux/kernel/git/shli/md")
5c0338c687 ("workqueue: restore WQ_UNBOUND/max_active==1 to be ordered")
74cbd96bc2e00f5d 5c0338c68706be53b3dc472e43
---------------- --------------------------
%stddev %change %stddev
\ | \
3974 -21.2% 3131 ± 4% blogbench.write_score
1608428 ± 2% +9.7% 1764811 ± 6% blogbench.read_score
1.043e+08 -58.0% 43770754 ± 19% blogbench.time.file_system_inputs
33045282 -23.0% 25456502 ± 4% blogbench.time.file_system_outputs
1889747 -51.2% 922952 blogbench.time.involuntary_context_switches
1066 -9.1% 969.60 ± 4% blogbench.time.percent_of_cpu_this_job_got
3058 -9.6% 2764 ± 4% blogbench.time.system_time
20367518 ± 2% -58.2% 8523363 ± 17% blogbench.time.voluntary_context_switches
56387 ± 6% -9.4% 51101 ± 2% interrupts.CAL:Function_call_interrupts
599681 ± 2% -42.0% 347640 ± 14% softirqs.SCHED
21.79 ± 3% +6.4 28.17 ± 10% mpstat.cpu.iowait%
0.02 ± 22% +0.2 0.23 ± 15% mpstat.cpu.soft%
3.08 ± 5% +0.6 3.72 ± 6% mpstat.cpu.usr%
63227 ± 3% +13.0% 71434 ± 6% meminfo.CmaFree
1915913 ± 4% -25.3% 1431623 ± 4% meminfo.Inactive
1897786 ± 4% -25.5% 1413549 ± 4% meminfo.Inactive(file)
1269568 ± 4% +27.1% 1613730 ± 9% meminfo.MemFree
8434 ± 5% -55.9% 3719 ± 18% iostat.sda.r/s
168471 ± 5% -56.9% 72537 ± 19% iostat.sda.rkB/s
10.68 ± 8% -37.2% 6.70 ± 11% iostat.sda.rrqm/s
732.25 ± 5% -30.4% 509.76 ± 2% iostat.sda.w/s
1748 ± 4% -18.2% 1429 ± 5% iostat.sda.wrqm/s
8.165e+08 ± 2% -20.7% 6.477e+08 ± 14% cpuidle.C1.time
26339770 ± 2% -59.2% 10742045 ± 18% cpuidle.C1.usage
1.775e+08 ± 6% +236.0% 5.962e+08 ± 6% cpuidle.C1E.time
607354 ± 4% +51.8% 921820 ± 9% cpuidle.C1E.usage
134897 ± 25% -38.6% 82860 ± 15% cpuidle.C3.usage
518720 ± 2% -60.1% 207069 ± 19% cpuidle.POLL.usage
168530 ± 5% -56.9% 72617 ± 19% vmstat.io.bi
57048 ± 5% -22.2% 44397 ± 4% vmstat.io.bo
429.10 ± 5% +21.2% 520.20 ± 8% vmstat.memory.buff
1289089 ± 4% +26.6% 1631377 ± 8% vmstat.memory.free
40.40 ± 4% -17.6% 33.30 ± 11% vmstat.procs.b
207214 ± 5% -34.2% 136272 ± 9% vmstat.system.cs
27043 ± 2% -26.6% 19840 ± 3% vmstat.system.in
216066 ± 3% +12.8% 243680 ± 2% slabinfo.btrfs_delayed_node.active_objs
11273 ± 4% -27.3% 8194 ± 3% slabinfo.btrfs_extent_buffer.active_objs
11710 ± 4% -26.2% 8636 ± 3% slabinfo.btrfs_extent_buffer.num_objs
5056 ± 3% -12.2% 4441 ± 6% slabinfo.btrfs_ordered_extent.active_objs
5187 ± 3% -11.9% 4568 ± 6% slabinfo.btrfs_ordered_extent.num_objs
19452 ± 10% +66.7% 32428 ± 8% slabinfo.kmalloc-256.active_objs
624.40 ± 9% +65.7% 1034 ± 8% slabinfo.kmalloc-256.active_slabs
19996 ± 9% +65.7% 33129 ± 8% slabinfo.kmalloc-256.num_objs
624.40 ± 9% +65.7% 1034 ± 8% slabinfo.kmalloc-256.num_slabs
6.933e+11 -7.8% 6.395e+11 ± 2% perf-stat.branch-instructions
0.62 -0.1 0.47 ± 4% perf-stat.branch-miss-rate%
4.329e+09 -30.0% 3.032e+09 ± 2% perf-stat.branch-misses
64545297 ± 2% -35.9% 41378261 ± 9% perf-stat.context-switches
9.103e+12 -8.0% 8.376e+12 ± 3% perf-stat.cpu-cycles
6729558 ± 3% -72.4% 1858286 ± 17% perf-stat.cpu-migrations
26.24 ± 5% +23.6 49.83 ± 9% perf-stat.iTLB-load-miss-rate%
4.122e+08 ± 7% +26.5% 5.214e+08 ± 5% perf-stat.iTLB-load-misses
1.157e+09 ± 2% -54.2% 5.302e+08 ± 14% perf-stat.iTLB-loads
8459 ± 7% -24.3% 6399 ± 5% perf-stat.instructions-per-iTLB-miss
0.38 +4.4% 0.40 perf-stat.ipc
319949 ± 5% -3.9% 307528 perf-stat.minor-faults
319952 ± 5% -3.9% 307494 perf-stat.page-faults
84255382 ± 9% -95.6% 3708415 ± 83% proc-vmstat.compact_daemon_free_scanned
1829109 ± 18% -97.6% 44241 ± 93% proc-vmstat.compact_daemon_migrate_scanned
1059 ± 11% -92.8% 75.90 ±100% proc-vmstat.compact_daemon_wake
84255382 ± 9% -95.6% 3708415 ± 83% proc-vmstat.compact_free_scanned
781008 ± 21% -98.8% 9090 ± 89% proc-vmstat.compact_isolated
1829109 ± 18% -97.6% 44241 ± 93% proc-vmstat.compact_migrate_scanned
179.80 ± 9% -40.8% 106.50 ± 16% proc-vmstat.kswapd_high_wmark_hit_quickly
22499 ± 62% -100.0% 5.50 ±125% proc-vmstat.kswapd_inodesteal
4237 ± 8% -83.2% 710.60 ± 28% proc-vmstat.kswapd_low_wmark_hit_quickly
4539912 -24.2% 3441760 ± 4% proc-vmstat.nr_dirtied
316909 ± 4% +27.1% 402889 ± 9% proc-vmstat.nr_free_pages
474932 ± 4% -25.5% 353600 ± 4% proc-vmstat.nr_inactive_file
207449 ± 14% -54.1% 95277 ± 24% proc-vmstat.nr_vmscan_immediate_reclaim
4442638 -24.2% 3366510 ± 4% proc-vmstat.nr_written
474994 ± 4% -25.5% 353713 ± 4% proc-vmstat.nr_zone_inactive_file
20945924 -35.0% 13606065 ± 7% proc-vmstat.numa_hit
20945924 -35.0% 13606065 ± 7% proc-vmstat.numa_local
4632 ± 7% -75.8% 1119 ± 18% proc-vmstat.pageoutrun
26805123 ± 2% -35.6% 17261359 ± 6% proc-vmstat.pgactivate
6702031 -15.2% 5684286 ± 4% proc-vmstat.pgalloc_dma32
17277542 -27.9% 12464886 ± 4% proc-vmstat.pgalloc_normal
31715903 ± 2% -39.0% 19354510 ± 8% proc-vmstat.pgdeactivate
22331249 -26.4% 16425277 ± 5% proc-vmstat.pgfree
62247 ± 8% -94.5% 3437 ± 76% proc-vmstat.pgmigrate_success
52404647 -58.0% 22020215 ± 19% proc-vmstat.pgpgin
17745601 -24.2% 13447782 ± 4% proc-vmstat.pgpgout
31724465 ± 2% -39.0% 19363354 ± 8% proc-vmstat.pgrefill
229386 ± 12% -48.0% 119203 ± 28% proc-vmstat.pgrotated
16121910 -54.1% 7392371 ± 17% proc-vmstat.pgscan_kswapd
15714718 -54.8% 7109527 ± 17% proc-vmstat.pgsteal_kswapd
8744243 -55.3% 3910348 ± 18% proc-vmstat.slabs_scanned
1941347 ± 11% -75.0% 485169 ± 26% proc-vmstat.workingset_activate
3087977 ± 13% -76.7% 718263 ± 28% proc-vmstat.workingset_refault
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
4 years, 4 months
[lkp-robot] [x86/mm/kasan] 2533a63618: BUG:KASAN:use-after-scope_in__lock_acquire
by kernel test robot
FYI, we noticed the following commit (built with gcc-7):
commit: 2533a63618fcfd5fb0c7bb7549913e173a1908af ("x86/mm/kasan: Don't use vmemmap_populate() to initialize shadow")
https://git.kernel.org/cgit/linux/kernel/git/next/linux-next.git master
in testcase: trinity
with following parameters:
runtime: 300s
test-description: Trinity is a linux system call fuzz tester.
test-url: http://codemonkey.org.uk/projects/trinity/
on test machine: qemu-system-x86_64 -enable-kvm -cpu SandyBridge -m 512M
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
+--------------------------------------------+------------+------------+
| | fe9e139482 | 2533a63618 |
+--------------------------------------------+------------+------------+
| boot_successes | 56 | 0 |
| boot_failures | 0 | 65 |
| BUG:KASAN:use-after-scope_in__lock_acquire | 0 | 65 |
+--------------------------------------------+------------+------------+
[ 0.003333] BUG: KASAN: use-after-scope in __lock_acquire+0x19a0/0x20d6
[ 0.003333] BUG: KASAN: use-after-scope in __lock_acquire+0x19a0/0x20d6
[ 0.003333] Write of size 64 at addr ffffffff83007510 by task swapper/0
[ 0.003333] Write of size 64 at addr ffffffff83007510 by task swapper/0
[ 0.003333]
[ 0.003333]
[ 0.003333] CPU: 0 PID: 0 Comm: swapper Not tainted 4.14.0-00072-g2533a636 #1
[ 0.003333] CPU: 0 PID: 0 Comm: swapper Not tainted 4.14.0-00072-g2533a636 #1
[ 0.003333] Call Trace:
[ 0.003333] Call Trace:
[ 0.003333] dump_stack+0x106/0x1ca
[ 0.003333] dump_stack+0x106/0x1ca
[ 0.003333] ? arch_local_irq_restore+0xd/0xd
[ 0.003333] ? arch_local_irq_restore+0xd/0xd
[ 0.003333] ? printk+0x8f/0xab
[ 0.003333] ? printk+0x8f/0xab
[ 0.003333] ? cpumask_weight+0x49/0x49
[ 0.003333] ? cpumask_weight+0x49/0x49
[ 0.003333] ? __lock_acquire+0x19a0/0x20d6
[ 0.003333] ? __lock_acquire+0x19a0/0x20d6
[ 0.003333] print_address_description+0x86/0x226
[ 0.003333] print_address_description+0x86/0x226
[ 0.003333] ? __lock_acquire+0x19a0/0x20d6
[ 0.003333] ? __lock_acquire+0x19a0/0x20d6
[ 0.003333] kasan_report+0x21e/0x247
[ 0.003333] kasan_report+0x21e/0x247
[ 0.003333] __asan_report_store_n_noabort+0x12/0x14
[ 0.003333] __asan_report_store_n_noabort+0x12/0x14
[ 0.003333] __lock_acquire+0x19a0/0x20d6
[ 0.003333] __lock_acquire+0x19a0/0x20d6
[ 0.003333] ? debug_show_all_locks+0x37c/0x37c
[ 0.003333] ? debug_show_all_locks+0x37c/0x37c
[ 0.003333] ? debug_show_all_locks+0x37c/0x37c
[ 0.003333] ? debug_show_all_locks+0x37c/0x37c
[ 0.003333] ? put_dec+0x6c/0x73
[ 0.003333] ? put_dec+0x6c/0x73
[ 0.003333] ? do_raw_spin_trylock+0x15b/0x15b
[ 0.003333] ? do_raw_spin_trylock+0x15b/0x15b
[ 0.003333] ? down_trylock+0x49/0x60
[ 0.003333] ? down_trylock+0x49/0x60
[ 0.003333] lock_acquire+0xd6/0x12f
[ 0.003333] lock_acquire+0xd6/0x12f
[ 0.003333] ? lock_acquire+0xd6/0x12f
[ 0.003333] ? lock_acquire+0xd6/0x12f
[ 0.003333] ? console_unlock+0x232/0x608
[ 0.003333] ? console_unlock+0x232/0x608
[ 0.003333] _raw_spin_lock+0x2d/0x3c
[ 0.003333] _raw_spin_lock+0x2d/0x3c
[ 0.003333] ? console_unlock+0x232/0x608
[ 0.003333] ? console_unlock+0x232/0x608
[ 0.003333] console_unlock+0x232/0x608
[ 0.003333] console_unlock+0x232/0x608
[ 0.003333] ? vprintk_emit+0x2b5/0x2cf
[ 0.003333] ? vprintk_emit+0x2b5/0x2cf
[ 0.003333] vprintk_emit+0x2be/0x2cf
[ 0.003333] vprintk_emit+0x2be/0x2cf
[ 0.003333] vprintk_default+0x18/0x1a
[ 0.003333] vprintk_default+0x18/0x1a
[ 0.003333] vprintk_func+0xb5/0xbe
[ 0.003333] vprintk_func+0xb5/0xbe
[ 0.003333] printk+0x8f/0xab
[ 0.003333] printk+0x8f/0xab
[ 0.003333] ? cpumask_weight+0x49/0x49
[ 0.003333] ? cpumask_weight+0x49/0x49
[ 0.003333] ? arch_local_save_flags+0xb/0xd
[ 0.003333] ? arch_local_save_flags+0xb/0xd
[ 0.003333] ? trace_hardirqs_off_caller+0xd1/0x217
[ 0.003333] ? trace_hardirqs_off_caller+0xd1/0x217
[ 0.003333] mp_register_ioapic+0xad9/0xb7f
[ 0.003333] mp_register_ioapic+0xad9/0xb7f
[ 0.003333] ? mp_map_gsi_to_irq+0x68/0x68
[ 0.003333] ? mp_map_gsi_to_irq+0x68/0x68
[ 0.003333] ? acpi_os_map_memory+0x9/0xb
[ 0.003333] ? acpi_os_map_memory+0x9/0xb
[ 0.003333] ? acpi_tb_acquire_table+0xb6/0x1de
[ 0.003333] ? acpi_tb_acquire_table+0xb6/0x1de
[ 0.003333] acpi_parse_ioapic+0x2ee/0x31a
[ 0.003333] acpi_parse_ioapic+0x2ee/0x31a
[ 0.003333] ? acpi_tb_validate_table+0x4a/0x82
[ 0.003333] ? acpi_tb_validate_table+0x4a/0x82
[ 0.003333] ? acpi_parse_nmi_src+0x5f/0x5f
[ 0.003333] ? acpi_parse_nmi_src+0x5f/0x5f
[ 0.003333] ? acpi_ut_release_mutex+0xb5/0xbf
[ 0.003333] ? acpi_ut_release_mutex+0xb5/0xbf
[ 0.003333] ? acpi_get_table+0x164/0x17c
[ 0.003333] ? acpi_get_table+0x164/0x17c
[ 0.003333] acpi_table_parse_entries_array+0x383/0x499
[ 0.003333] acpi_table_parse_entries_array+0x383/0x499
[ 0.003333] ? acpi_parse_apic_instance+0x3c/0x3c
[ 0.003333] ? acpi_parse_apic_instance+0x3c/0x3c
[ 0.003333] ? acpi_ut_release_mutex+0xb5/0xbf
[ 0.003333] ? acpi_ut_release_mutex+0xb5/0xbf
[ 0.003333] ? acpi_put_table+0xcc/0xd8
[ 0.003333] ? acpi_put_table+0xcc/0xd8
[ 0.003333] ? acpi_parse_nmi_src+0x5f/0x5f
[ 0.003333] ? acpi_parse_nmi_src+0x5f/0x5f
[ 0.003333] acpi_table_parse_entries+0x14f/0x17b
[ 0.003333] acpi_table_parse_entries+0x14f/0x17b
[ 0.003333] ? acpi_table_parse_entries_array+0x499/0x499
[ 0.003333] ? acpi_table_parse_entries_array+0x499/0x499
[ 0.003333] ? acpi_parse_nmi_src+0x5f/0x5f
[ 0.003333] ? acpi_parse_nmi_src+0x5f/0x5f
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email
Thanks,
Xiaolong
4 years, 4 months
[lkp-robot] [x86/entry/64] 11a1251e3a: hackbench.throughput -12.1% regression
by kernel test robot
Greeting,
We noticed a -12.1% regression of hackbench.throughput due to commit:
commit: 11a1251e3a3cc9532f358c889deea63169bd2c65 ("x86/entry/64: Make cpu_entry_area.tss read-only")
https://git.kernel.org/cgit/linux/kernel/git/next/linux-next.git master
in testcase: hackbench
on test machine: 256 threads Phi with 96G memory
with following parameters:
nr_threads: 100%
mode: threads
ipc: pipe
cpufreq_governor: performance
test-description: Hackbench is both a benchmark and a stress test for the Linux kernel scheduler.
test-url: https://github.com/linux-test-project/ltp/blob/master/testcases/kernel/sc...
Details are as below:
-------------------------------------------------------------------------------------------------->
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp install job.yaml # job file is attached in this email
bin/lkp run job.yaml
=========================================================================================
compiler/kconfig/rootfs/sleep/tbox_group/testcase:
gcc-7/x86_64-kexec/debian-x86_64-2016-08-31.cgz/1/vm-lkp-wsx03-2G/boot
commit:
dff71e3c0e ("x86/entry: Clean up the SYSENTER_stack code")
11a1251e3a ("x86/entry/64: Make cpu_entry_area.tss read-only")
dff71e3c0e180fed 11a1251e3a3cc9532f358c889d
---------------- --------------------------
%stddev %change %stddev
\ | \
84922 -12.1% 74626 hackbench.throughput
710.29 +13.8% 807.99 hackbench.time.elapsed_time
710.29 +13.8% 807.99 hackbench.time.elapsed_time.max
1.375e+09 +4.6% 1.439e+09 hackbench.time.involuntary_context_switches
170288 +14.1% 194216 hackbench.time.system_time
3.659e+09 +6.7% 3.905e+09 hackbench.time.voluntary_context_switches
27.95 ± 2% -4.2% 26.77 ± 2% boot-time.kernel_boot
4.67 -0.5 4.15 ± 2% mpstat.cpu.usr%
1959105 +28.6% 2519832 softirqs.SCHED
171.26 -1.4% 168.86 turbostat.PkgWatt
6810850 -17.9% 5590300 ± 3% numa-numastat.node0.local_node
6810780 -17.9% 5590339 ± 3% numa-numastat.node0.numa_hit
4390448 ± 2% -15.0% 3732717 ± 3% numa-vmstat.node0.numa_hit
4390455 ± 2% -15.0% 3732722 ± 3% numa-vmstat.node0.numa_local
710.29 +13.8% 807.99 time.elapsed_time
710.29 +13.8% 807.99 time.elapsed_time.max
170288 +14.1% 194216 time.system_time
4113 -11.0% 3663 vmstat.procs.r
7205243 -7.3% 6681584 vmstat.system.cs
1136312 -7.3% 1053720 vmstat.system.in
6826262 -17.8% 5607814 ± 3% proc-vmstat.numa_hit
6826245 -17.8% 5607797 ± 3% proc-vmstat.numa_local
6893928 -17.6% 5682332 ± 2% proc-vmstat.pgalloc_normal
1001095 +18.9% 1190215 proc-vmstat.pgfault
6814642 -17.7% 5608336 ± 2% proc-vmstat.pgfree
6.678e+12 +7.1% 7.154e+12 perf-stat.branch-instructions
9.07 -0.3 8.74 perf-stat.branch-miss-rate%
6.057e+11 +3.2% 6.251e+11 perf-stat.branch-misses
8.52 +0.6 9.11 perf-stat.cache-miss-rate%
1.736e+11 +11.6% 1.938e+11 perf-stat.cache-misses
2.037e+12 +4.5% 2.127e+12 perf-stat.cache-references
5.067e+09 +6.5% 5.398e+09 perf-stat.context-switches
8.20 +7.9% 8.84 perf-stat.cpi
2.479e+14 +13.8% 2.82e+14 perf-stat.cpu-cycles
2.687e+08 +9.5% 2.942e+08 perf-stat.cpu-migrations
1.91 -0.1 1.84 perf-stat.iTLB-load-miss-rate%
5.896e+11 +0.9% 5.947e+11 perf-stat.iTLB-load-misses
3.03e+13 +4.9% 3.178e+13 perf-stat.iTLB-loads
3.024e+13 +5.5% 3.19e+13 perf-stat.instructions
51.29 +4.6% 53.64 perf-stat.instructions-per-iTLB-miss
0.12 -7.3% 0.11 perf-stat.ipc
969235 +18.8% 1151230 perf-stat.minor-faults
969196 +18.8% 1151862 perf-stat.page-faults
11893 ± 2% +35.4% 16103 ± 4% sched_debug.cfs_rq:/.MIN_vruntime.avg
hackbench.throughput
90000 +-+-----------------------------------------------------------------+
|..+..+ +..+..+..+..+..+..+..+.+..+..+..+..+..+..+..+..+..+..+..|
80000 O-+O : : O O O |
70000 +-+ O O O O O O O O |
| : : O |
60000 +-+ : : |
50000 +-+ : : |
| : : |
40000 +-+ : : |
30000 +-+ : : |
| : : |
20000 +-+ : : |
10000 +-+ : |
| : |
0 +-+-----------------------------------------------------------------+
[*] 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
4 years, 4 months