[lkp-robot] [sched, rcu] 7a235ea661: [No primary change] +37% will-it-scale.time.involuntary_context_switches
by kernel test robot
Greeting,
There is no primary kpi change in this test, below is the data collected through multiple monitors running background just for your information.
commit: 7a235ea6614c8f75431b741d1576f6c808461efd ("sched,rcu: Make cond_resched() provide RCU quiescent state")
https://git.kernel.org/cgit/linux/kernel/git/next/linux-next.git master
in testcase: will-it-scale
on test machine: 32 threads Intel(R) Xeon(R) CPU E5-2680 0 @ 2.70GHz with 64G memory
with following parameters:
test: unlink2
cpufreq_governor: performance
test-description: Will It Scale takes a testcase and runs it from 1 through to n parallel copies to see if the testcase will scale. It builds both a process and threads based test in order to see any differences between the two.
test-url: https://github.com/antonblanchard/will-it-scale
Details are as below:
-------------------------------------------------------------------------------------------------->
To reproduce:
git clone https://github.com/01org/lkp-tests.git
cd lkp-tests
bin/lkp install job.yaml # job file is attached in this email
bin/lkp run job.yaml
testcase/path_params/tbox_group/run: will-it-scale/unlink2-performance/lkp-sb03
bb4d296cb9a315bf 7a235ea6614c8f75431b741d15
---------------- --------------------------
%stddev change %stddev
\ | \
17897 37% 24442 ± 3% will-it-scale.time.involuntary_context_switches
2845 ± 3% 13% 3207 vmstat.system.cs
882403 ± 3% 12% 989820 perf-stat.context-switches
0.41 -4% 0.40 perf-stat.branch-miss-rate%
8.954e+08 ± 10% 48% 1.325e+09 ± 8% perf-stat.dTLB-store-misses
0.09 ± 8% 44% 0.13 ± 7% perf-stat.dTLB-store-miss-rate%
26.40 9% 28.75 ± 3% perf-stat.node-store-miss-rate%
16326 22% 19910 perf-stat.cpu-migrations
7.277e+09 -6% 6.826e+09 perf-stat.node-stores
will-it-scale.time.involuntary_context_switches
30000 ++------------------------------------------------------------------+
| |
25000 O+ O O O O O |
| O O O O OO OO OO OO O |
| |
20000 ++* *. .* * * *. *. .* .*
* : * : * * * * * * : ** :*.* *: *.* : ** *.* ** * |
15000 ++: : : : : : : : : : :: : : :: : : : : : |
| : :: : : : :: :: :: : : : : : : : : : : : : : |
10000 ++: :: : : :: : : :: :: : : : : : : : : : : : : : |
| : ::: :: :: : :: :: : :: : : :: : : :: : : |
| : : :: :: :: :: :: :: :: : : :: :: :: :: |
5000 ++ : : : :: :: : : : :: : :: : : : |
| : : : : : : : : : : : : : : |
0 ++-O-*O-*O--O--O---O--*--*---*----*-----*----*---*------*-----------+
[*] 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
5 years, 1 month
[fsnotify] 55a6cc54da [ 1.790337] BUG: unable to handle kernel NULL pointer dereference at (null)
by Fengguang Wu
Hi Jan,
FYI, this bug may only hurt bisects.
https://git.kernel.org/pub/scm/linux/kernel/git/jack/linux-fs.git for_testing
commit 55a6cc54da595bb3b2a34e188818ef39026c8c4e
Author: Jan Kara <jack(a)suse.cz>
AuthorDate: Wed Feb 1 08:19:43 2017 +0100
Commit: Jan Kara <jack(a)suse.cz>
CommitDate: Sun Mar 19 19:07:11 2017 +0100
fsnotify: Lock object list with connector lock
So far list of marks attached to an object (inode / vfsmount) was
protected by i_lock or mnt_root->d_lock. This dictates that the list
must be empty before the object can be destroyed although the list is
now anchored in the fsnotify_mark_connector structure. Protect the list
by a spinlock in the fsnotify_mark_connector structure to decouple
lifetime of a list of marks from a lifetime of the object. This also
simplifies the code quite a bit since we don't have to differentiate
between inode and vfsmount lists in quite a few places anymore.
Reviewed-by: Amir Goldstein <amir73il(a)gmail.com>
Signed-off-by: Jan Kara <jack(a)suse.cz>
c87a70a13f fsnotify: Remove useless list deletion and comment
55a6cc54da fsnotify: Lock object list with connector lock
a88ad2c7d0 fsnotify: Move ->free_mark callback to fsnotify_ops
+------------------------------------------+------------+------------+------------+
| | c87a70a13f | 55a6cc54da | a88ad2c7d0 |
+------------------------------------------+------------+------------+------------+
| boot_successes | 33 | 1 | 13 |
| boot_failures | 0 | 14 | |
| BUG:unable_to_handle_kernel | 0 | 14 | |
| Oops:#[##] | 0 | 14 | |
| EIP:_raw_spin_lock | 0 | 14 | |
| Kernel_panic-not_syncing:Fatal_exception | 0 | 14 | |
+------------------------------------------+------------+------------+------------+
[ 1.785029] Freeing unused kernel memory: 572K
[ 1.785822] Write protecting the kernel text: 6928k
[ 1.786643] Write protecting the kernel read-only data: 2108k
[ 1.787503] NX-protecting the kernel data: 3312k
[ 1.788359] rodata_test: all tests were successful
[ 1.790337] BUG: unable to handle kernel NULL pointer dereference at (null)
[ 1.791410] IP: _raw_spin_lock+0x10/0x30
[ 1.792063] *pdpt = 000000001f248001 *pde = 0000000000000000
[ 1.792065]
[ 1.793348] Oops: 0002 [#1] SMP
[ 1.793904] Modules linked in:
[ 1.794448] CPU: 1 PID: 1 Comm: init Not tainted 4.11.0-rc2-00016-g55a6cc5 #1
[ 1.795438] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 1.796944] task: ddc77540 task.stack: ddc78000
[ 1.797661] EIP: _raw_spin_lock+0x10/0x30
[ 1.798328] EFLAGS: 00010246 CPU: 1
[ 1.798925] EAX: 00000000 EBX: dd870638 ECX: 00000001 EDX: 00000000
[ 1.799805] ESI: df2443a8 EDI: df1e8758 EBP: ddc79f44 ESP: ddc79f28
[ 1.804745] DS: 007b ES: 007b FS: 00d8 GS: 0033 SS: 0068
[ 1.805550] CR0: 80050033 CR2: 00000000 CR3: 1f247120 CR4: 000006b0
[ 1.806440] DR0: 00000000 DR1: 00000000 DR2: 00000000 DR3: 00000000
[ 1.807335] DR6: fffe0ff0 DR7: 00000400
[ 1.807972] Call Trace:
[ 1.808977] ? fsnotify_add_mark_locked+0xad/0x340
[ 1.809968] SyS_inotify_add_watch+0x2ab/0x2e0
[ 1.810671] do_fast_syscall_32+0x77/0x140
[ 1.811325] entry_SYSENTER_32+0x47/0x71
[ 1.811968] EIP: 0xb7737cc5
[ 1.812522] EFLAGS: 00000286 CPU: 1
[ 1.813113] EAX: ffffffda EBX: 00000005 ECX: 80097850 EDX: 00000bc8
[ 1.814035] ESI: 80097a78 EDI: 800978a0 EBP: 80097850 ESP: bf84e738
[ 1.814831] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 007b
[ 1.815606] Code: 74 26 00 89 c2 89 c8 e8 bf ea 9c ff 5d c3 8d b6 00 00 00 00 8d bc 27 00 00 00 00 89 c2 64 ff 05 1c 99 9b c1 31 c0 b9 01 00 00 00 <f0> 0f b1 0a 85 c0 75 08 c3 8d b4 26 00 00 00 00 55 89 d1 89 c2
[ 1.818304] EIP: _raw_spin_lock+0x10/0x30 SS:ESP: 0068:ddc79f28
[ 1.819167] CR2: 0000000000000000
[ 1.819744] ---[ end trace cb32cb10735da16c ]---
[ 1.820456] Kernel panic - not syncing: Fatal exception
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start 876285681d4a0b3f46f684a534a49ccd905a816e c02ed2e75ef4c74e41e421acb4ef1494671585e8 --
git bisect bad 3a4b96e796207ea833f1a0e18b11a414c5e279ef # 09:48 B 0 11 22 0 Merge 'kdave-btrfs-devel/dev/reada-cleanups' into devel-spot-201703280836
git bisect good f04653ff2a12ea82c5f25c175f99872323230aea # 09:58 G 11 0 0 0 Merge 'linux-review/Matthias-Kaehlcke/cfg80211-Fix-array-bounds-warning-in-fragment-copy/20170328-052243' into devel-spot-201703280836
git bisect good 1828caddd93c29a53a9c33e7f41bf0f38de7d4ac # 10:07 G 11 0 0 0 Merge 'robclark/msm-next' into devel-spot-201703280836
git bisect bad cf8bcb66d531ee5b2e9befa4e11ef313e5420bd3 # 10:16 B 0 11 22 0 Merge 'bluetooth-next/master' into devel-spot-201703280836
git bisect bad e2a187229b28adc49dbe6bf9096d07865a719d97 # 10:23 B 0 11 23 0 Merge 'ext3/for_testing' into devel-spot-201703280836
git bisect good 78fb984ae7bc02aeef69a6a3d73b38f2859b8caa # 10:37 G 11 0 0 0 Merge 'martinbrandenburg/readdir' into devel-spot-201703280836
git bisect good a57fed6a393d5453806f6a89f18f9586233b3e58 # 10:53 G 11 0 0 0 Merge 'asoc/for-linus' into devel-spot-201703280836
git bisect good 74673a73c59f846341d336f8aa3ebd2ed6eecabb # 11:03 G 11 0 0 0 fsnotify: Make fsnotify_mark_connector hold inode reference
git bisect good c208a020c9a850dc1e2d14e8dce3e5385fc581ed # 11:12 G 11 0 0 0 fsnotify: Move locking into fsnotify_find_mark()
git bisect good df18fc29eb14828046c1ed23dbabdcf6e6dacf6a # 11:29 G 10 0 0 0 fsnotify: Remove indirection from fsnotify_detach_mark()
git bisect bad 55a6cc54da595bb3b2a34e188818ef39026c8c4e # 11:40 B 0 1 12 0 fsnotify: Lock object list with connector lock
git bisect good c87a70a13f85d35484c2c1716bd6bde1c43621e2 # 11:56 G 11 0 0 0 fsnotify: Remove useless list deletion and comment
# first bad commit: [55a6cc54da595bb3b2a34e188818ef39026c8c4e] fsnotify: Lock object list with connector lock
git bisect good c87a70a13f85d35484c2c1716bd6bde1c43621e2 # 12:00 G 31 0 0 0 fsnotify: Remove useless list deletion and comment
# extra tests with CONFIG_DEBUG_INFO_REDUCED
git bisect bad 55a6cc54da595bb3b2a34e188818ef39026c8c4e # 12:10 B 0 11 22 0 fsnotify: Lock object list with connector lock
# extra tests on HEAD of linux-devel/devel-spot-201703280836
git bisect bad 876285681d4a0b3f46f684a534a49ccd905a816e # 12:10 B 0 22 39 2 0day head guard for 'devel-spot-201703280836'
# extra tests on tree/branch ext3/for_testing
git bisect good a88ad2c7d0b6509dbac9979b6a0069968c3fb2bd # 12:21 G 11 0 0 0 fsnotify: Move ->free_mark callback to fsnotify_ops
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
5 years, 1 month
[sd] 9006e745e7 [ 201.110436] WARNING: CPU: 0 PID: 5 at fs/kernfs/dir.c:1416 kernfs_remove_by_name_ns
by Fengguang Wu
Hi Hannes,
Just FYI, this warning in our internal merge test commit indicates
your patch may conflict with some others' work.
git://internal_merge_and_test_tree devel-hourly-2017032618
commit 9006e745e77b03f27d0e0d224b0e9c5e149c630b
Merge: 8eb75c5 17df1c0
Author: 0day robot <fengguang.wu(a)intel.com>
AuthorDate: Sun Mar 26 19:29:24 2017 +0800
Commit: 0day robot <fengguang.wu(a)intel.com>
CommitDate: Sun Mar 26 19:29:24 2017 +0800
Merge 'linux-review/Hannes-Reinecke/sd-use-async_probe-cookie-to-avoid-deadlocks/20170322-130853' into devel-hourly-2017032618
8eb75c5e55 Merge 'linux-review/Shawn-Guo/Add-ZTE-VGA-driver-support/20170322-100652' into devel-hourly-2017032618
17df1c0702 sd: use async_probe cookie to avoid deadlocks
9006e745e7 Merge 'linux-review/Hannes-Reinecke/sd-use-async_probe-cookie-to-avoid-deadlocks/20170322-130853' into devel-hourly-2017032618
d268ba88d2 0day head guard for 'devel-hourly-2017032618'
+--------------------------------------------------------------------------------+------------+------------+------------+------------------+
| | 8eb75c5e55 | 17df1c0702 | 9006e745e7 | v4.11-rc3_032618 |
+--------------------------------------------------------------------------------+------------+------------+------------+------------------+
| boot_successes | 1009 | 1006 | 1 | 0 |
| boot_failures | 0 | 0 | 913 | 21 |
| WARNING:at_fs/kernfs/dir.c:#kernfs_remove_by_name_ns | 0 | 0 | 913 | 21 |
| WARNING:at_lib/refcount.c:#refcount_sub_and_test | 0 | 0 | 362 | 6 |
| BUG:unable_to_handle_kernel | 0 | 0 | 374 | 9 |
| Oops:#[##] | 0 | 0 | 374 | 9 |
| Kernel_panic-not_syncing:Fatal_exception | 0 | 0 | 913 | 21 |
| WARNING:at_block/genhd.c:#disk_release | 0 | 0 | 539 | 12 |
| kernel_BUG_at_lib/list_debug.c | 0 | 0 | 539 | 12 |
| invalid_opcode:#[##] | 0 | 0 | 539 | 12 |
| WARNING:at_lib/kobject.c:#kobject_get | 0 | 0 | 19 | 2 |
| WARNING:at_lib/refcount.c:#refcount_inc | 0 | 0 | 19 | 2 |
| kobject''(#):tried_to_add_an_uninitialized_object,something_is_seriously_wrong | 0 | 0 | 19 | 2 |
| WARNING:at_lib/kobject.c:#kobject_put | 0 | 0 | 19 | 2 |
| WARNING:at_block/blk-sysfs.c:#blk_register_queue | 0 | 0 | 19 | 2 |
| WARNING:at_block/genhd.c:#del_gendisk | 0 | 0 | 9 | 1 |
+--------------------------------------------------------------------------------+------------+------------+------------+------------------+
[ 201.101881] osd: LOADED open-osd 0.2.1
[ 201.104562] scsi host0: scsi_debug: version 1.86 [20160430]
[ 201.104562] dev_size_mb=8, opts=0x0, submit_queues=1, statistics=0
[ 201.107698] scsi 0:0:0:0: Direct-Access Linux scsi_debug 0186 PQ: 0 ANSI: 7
[ 201.109698] ------------[ cut here ]------------
[ 201.110436] WARNING: CPU: 0 PID: 5 at fs/kernfs/dir.c:1416 kernfs_remove_by_name_ns+0x3f/0xa0
[ 201.111890] kernfs: can not remove 'bdi', no directory
[ 201.112679] CPU: 0 PID: 5 Comm: kworker/u2:0 Not tainted 4.11.0-rc3-04632-g9006e74 #1
[ 201.113956] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 201.115440] Workqueue: events_unbound async_run_entry_fn
[ 201.116218] Call Trace:
[ 201.116752] dump_stack+0x19/0x25
[ 201.117511] __warn+0xd7/0x100
[ 201.118419] warn_slowpath_fmt+0x44/0x50
[ 201.119126] sd 0:0:0:0: [sda] 16384 512-byte logical blocks: (8.39 MB/8.00 MiB)
[ 201.120349] ? iput+0x1a6/0x1c0
[ 201.120944] kernfs_remove_by_name_ns+0x3f/0xa0
[ 201.121658] sysfs_remove_link+0x1d/0x20
[ 201.122330] del_gendisk+0x117/0x1e0
[ 201.122963] ? device_del+0x2cd/0x2e0
[ 201.123620] sd_remove+0x73/0xe0
[ 201.124224] driver_probe_device+0x17c/0x330
[ 201.124902] __device_attach_driver+0x92/0xa0
[ 201.125624] sd 0:0:0:0: [sda] Write Protect is off
[ 201.125626] sd 0:0:0:0: [sda] Mode Sense: 73 00 10 08
[ 201.127113] ? __driver_attach+0xb0/0xb0
[ 201.127765] bus_for_each_drv+0x57/0x90
[ 201.128414] __device_attach+0xa7/0x120
[ 201.129103] device_initial_probe+0xe/0x10
[ 201.130058] bus_probe_device+0x39/0xc0
[ 201.130707] device_add+0x3bf/0x550
[ 201.131332] scsi_sysfs_add_sdev+0xf7/0x230
[ 201.132019] do_scan_async+0xc2/0x1a0
[ 201.132651] async_run_entry_fn+0x45/0x120
[ 201.133332] process_one_work+0x2b2/0x480
[ 201.133997] ? process_one_work+0x241/0x480
[ 201.134668] worker_thread+0x466/0x610
[ 201.135325] ? _raw_spin_unlock_irq+0x2b/0x40
[ 201.136021] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, supports DPO and FUA
[ 201.137349] ? finish_task_switch+0x16c/0x1e0
[ 201.138041] ? __schedule+0x55b/0x5a0
[ 201.138687] ? _raw_spin_unlock_irqrestore+0x4c/0x70
[ 201.139430] ? workqueue_prepare_cpu+0x60/0x60
[ 201.140127] ? schedule+0x89/0xa0
[ 201.140729] ? workqueue_prepare_cpu+0x60/0x60
[ 201.141497] kthread+0x137/0x140
[ 201.142134] ? __kthread_init_worker+0x80/0x80
[ 201.142832] ? __kthread_init_worker+0x80/0x80
[ 201.143553] ret_from_fork+0x31/0x40
[ 201.144193] ---[ end trace e1991e97466b6990 ]---
[ 201.144949] ------------[ cut here ]------------
[ 201.144949] ------------[ cut here ]------------
[ 201.146014] WARNING: CPU: 0 PID: 5 at lib/refcount.c:184 refcount_sub_and_test+0x4d/0x70
[ 201.147438] refcount_t: underflow; use-after-free.
[ 201.148164] CPU: 0 PID: 5 Comm: kworker/u2:0 Tainted: G W 4.11.0-rc3-04632-g9006e74 #1
[ 201.149644] ------------[ cut here ]------------
[ 201.149648] WARNING: CPU: 0 PID: 118 at lib/kobject.c:597 kobject_get+0x37/0x50
[ 201.149651] CPU: 0 PID: 118 Comm: kworker/u2:1 Tainted: G W 4.11.0-rc3-04632-g9006e74 #1
[ 201.149652] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 201.149656] Workqueue: events_unbound async_run_entry_fn
[ 201.149658] Call Trace:
[ 201.149660] dump_stack+0x19/0x25
[ 201.149662] __warn+0xd7/0x100
[ 201.149664] warn_slowpath_fmt+0x44/0x50
[ 201.149666] kobject_get+0x37/0x50
[ 201.149668] get_device+0x14/0x20
[ 201.149671] bdi_register_owner+0x71/0x90
[ 201.149674] device_add_disk+0x200/0x470
[ 201.149677] ? _raw_spin_unlock_irq+0x2b/0x40
[ 201.149680] ? __pm_runtime_use_autosuspend+0x62/0x70
[ 201.149684] sd_probe_async+0x121/0x1d0
[ 201.149685] async_run_entry_fn+0x45/0x120
[ 201.149687] process_one_work+0x2b2/0x480
[ 201.149689] ? process_one_work+0x241/0x480
[ 201.149690] worker_thread+0x466/0x610
[ 201.149692] ? _raw_spin_unlock_irq+0x2b/0x40
[ 201.149694] ? finish_task_switch+0x16c/0x1e0
[ 201.149695] ? __schedule+0x55b/0x5a0
[ 201.149697] ? _raw_spin_unlock_irqrestore+0x4c/0x70
[ 201.149699] ? workqueue_prepare_cpu+0x60/0x60
[ 201.149700] ? schedule+0x89/0xa0
[ 201.149702] ? workqueue_prepare_cpu+0x60/0x60
[ 201.149704] kthread+0x137/0x140
[ 201.149706] ? __kthread_init_worker+0x80/0x80
[ 201.149707] ? __kthread_init_worker+0x80/0x80
[ 201.149709] ret_from_fork+0x31/0x40
[ 201.149710] ---[ end trace e1991e97466b6991 ]---
[ 201.149711] ------------[ cut here ]------------
[ 201.149711] ------------[ cut here ]------------
[ 201.149713] WARNING: CPU: 0 PID: 118 at lib/refcount.c:150 refcount_inc+0x37/0x40
[ 201.149714] refcount_t: increment on 0; use-after-free.
[ 201.149716] CPU: 0 PID: 118 Comm: kworker/u2:1 Tainted: G W 4.11.0-rc3-04632-g9006e74 #1
[ 201.149717] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 201.149718] Workqueue: events_unbound async_run_entry_fn
[ 201.149720] Call Trace:
[ 201.149722] dump_stack+0x19/0x25
[ 201.149723] __warn+0xd7/0x100
[ 201.149725] warn_slowpath_fmt+0x44/0x50
[ 201.149727] refcount_inc+0x37/0x40
[ 201.149728] kobject_get+0x40/0x50
[ 201.149730] get_device+0x14/0x20
[ 201.149731] bdi_register_owner+0x71/0x90
[ 201.149733] device_add_disk+0x200/0x470
[ 201.149735] ? _raw_spin_unlock_irq+0x2b/0x40
[ 201.149736] ? __pm_runtime_use_autosuspend+0x62/0x70
[ 201.149738] sd_probe_async+0x121/0x1d0
[ 201.149740] async_run_entry_fn+0x45/0x120
[ 201.149742] process_one_work+0x2b2/0x480
[ 201.149743] ? process_one_work+0x241/0x480
[ 201.149745] worker_thread+0x466/0x610
[ 201.149746] ? _raw_spin_unlock_irq+0x2b/0x40
[ 201.149748] ? finish_task_switch+0x16c/0x1e0
[ 201.149749] ? __schedule+0x55b/0x5a0
[ 201.149751] ? _raw_spin_unlock_irqrestore+0x4c/0x70
[ 201.149752] ? workqueue_prepare_cpu+0x60/0x60
[ 201.149753] ? schedule+0x89/0xa0
[ 201.149755] ? workqueue_prepare_cpu+0x60/0x60
[ 201.149757] kthread+0x137/0x140
[ 201.149758] ? __kthread_init_worker+0x80/0x80
[ 201.149760] ? __kthread_init_worker+0x80/0x80
[ 201.149762] ret_from_fork+0x31/0x40
[ 201.149763] ---[ end trace e1991e97466b6992 ]---
[ 201.149776] ------------[ cut here ]------------
[ 201.149776] ------------[ cut here ]------------
[ 201.149778] WARNING: CPU: 0 PID: 118 at lib/kobject.c:597 kobject_get+0x37/0x50
[ 201.149779] kobject: '' (ffff88001cd370b0): is not initialized, yet kobject_get() is being called.
[ 201.149781] CPU: 0 PID: 118 Comm: kworker/u2:1 Tainted: G W 4.11.0-rc3-04632-g9006e74 #1
[ 201.149782] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 201.149784] Workqueue: events_unbound async_run_entry_fn
[ 201.149785] Call Trace:
[ 201.149787] dump_stack+0x19/0x25
[ 201.149788] __warn+0xd7/0x100
[ 201.149790] warn_slowpath_fmt+0x44/0x50
[ 201.149792] kobject_get+0x37/0x50
[ 201.149793] get_device+0x14/0x20
[ 201.149795] device_add+0x27/0x550
[ 201.149798] device_add_disk+0x253/0x470
[ 201.149799] ? _raw_spin_unlock_irq+0x2b/0x40
[ 201.149801] ? __pm_runtime_use_autosuspend+0x62/0x70
[ 201.149803] sd_probe_async+0x121/0x1d0
[ 201.149805] async_run_entry_fn+0x45/0x120
[ 201.149806] process_one_work+0x2b2/0x480
[ 201.149808] ? process_one_work+0x241/0x480
[ 201.149809] worker_thread+0x466/0x610
[ 201.149811] ? _raw_spin_unlock_irq+0x2b/0x40
[ 201.149812] ? finish_task_switch+0x16c/0x1e0
[ 201.149814] ? __schedule+0x55b/0x5a0
[ 201.149815] ? _raw_spin_unlock_irqrestore+0x4c/0x70
[ 201.149817] ? workqueue_prepare_cpu+0x60/0x60
[ 201.149818] ? schedule+0x89/0xa0
[ 201.149819] ? workqueue_prepare_cpu+0x60/0x60
[ 201.149821] kthread+0x137/0x140
[ 201.149823] ? __kthread_init_worker+0x80/0x80
[ 201.149825] ? __kthread_init_worker+0x80/0x80
[ 201.149826] ret_from_fork+0x31/0x40
[ 201.149827] ---[ end trace e1991e97466b6993 ]---
[ 201.149829] kobject '' (ffff88001cd370b0): tried to add an uninitialized object, something is seriously wrong.
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start d268ba88d28b67c93512b5ab66e2851be715e9f1 97da3854c526d3a6ee05c849c96e48d21527606c --
git bisect bad 1336e7b8c44938191cad7a3aeabc966bd258b42d # 14:39 B 0 2 54 42 Merge 'linux-review/simran-singhal/staging-adis16060_core-Replace-mlock-with-buf_lock-and-refactor-code/20170323-031726' into devel-hourly-2017032618
git bisect good 556149cac1d58479d29392cf4da6e9f66217f849 # 15:26 G 900 0 0 0 Merge 'linux-review/John-Keeping/pinctrl-rockchip-PREEMPT_RT_FULL-fixes/20170326-064546' into devel-hourly-2017032618
git bisect good 6ac77139d7b839511babe0f54b7ef57576f16908 # 16:14 G 901 0 0 0 Merge 'linux-review/Baolin-Wang/usb-phy-Introduce-one-extcon-device-into-usb-phy/20170325-110114' into devel-hourly-2017032618
git bisect bad d0b64b29f53f470fb5d951bef5278d522f8c0fd5 # 16:14 B 1 11 0 1016 Merge 'linux-review/gfree-wind-foxmail-com/Fix-invoking-expectfn-unloaded/20170324-162446' into devel-hourly-2017032618
git bisect bad 54b6c1352cd6d90f3f6cc7f282c66c2373a3ff0e # 16:28 B 45 1 45 45 Merge 'linux-review/Pushkar-Jambhlekar/drivers-video-fbdev-Fixing-coding-guidelines-in-acornfb-c/20170326-013023' into devel-hourly-2017032618
git bisect good 7b7c3e5dcd130acfc83a04b949bb3d44c3e056af # 17:51 G 910 0 0 0 Merge 'linux-review/David-Hildenbrand/KVM-x86-fix-user-triggerable-warning-in-kvm_apic_accept_events/20170326-091633' into devel-hourly-2017032618
git bisect good b07548ecc4f297291547c0cc0dc7d48cc22a6cab # 18:52 G 910 0 0 0 Merge 'mvebu/mvebu/soc' into devel-hourly-2017032618
git bisect bad 9006e745e77b03f27d0e0d224b0e9c5e149c630b # 19:06 B 98 2 98 98 Merge 'linux-review/Hannes-Reinecke/sd-use-async_probe-cookie-to-avoid-deadlocks/20170322-130853' into devel-hourly-2017032618
git bisect good d7bf7732300a9ef4b8ffec647d03b8f4d4a763f4 # 20:23 G 903 0 0 0 Merge 'linux-review/Kees-Cook/Kbuild-make-designated_init-attribute-fatal/20170323-063300' into devel-hourly-2017032618
git bisect good 8eb75c5e55f9f11460993501f5babbb31d91bc2c # 21:17 G 910 0 0 0 Merge 'linux-review/Shawn-Guo/Add-ZTE-VGA-driver-support/20170322-100652' into devel-hourly-2017032618
git bisect good 17df1c070217eba97b274c692d701849dd163de7 # 06:52 G 901 0 0 0 sd: use async_probe cookie to avoid deadlocks
# first bad commit: [9006e745e77b03f27d0e0d224b0e9c5e149c630b] Merge 'linux-review/Hannes-Reinecke/sd-use-async_probe-cookie-to-avoid-deadlocks/20170322-130853' into devel-hourly-2017032618
git bisect good 8eb75c5e55f9f11460993501f5babbb31d91bc2c # 07:01 G 1009 0 0 0 Merge 'linux-review/Shawn-Guo/Add-ZTE-VGA-driver-support/20170322-100652' into devel-hourly-2017032618
git bisect good 17df1c070217eba97b274c692d701849dd163de7 # 07:42 G 1000 0 0 0 sd: use async_probe cookie to avoid deadlocks
# extra tests with CONFIG_DEBUG_INFO_REDUCED
git bisect bad 9006e745e77b03f27d0e0d224b0e9c5e149c630b # 07:58 B 74 1 74 76 Merge 'linux-review/Hannes-Reinecke/sd-use-async_probe-cookie-to-avoid-deadlocks/20170322-130853' into devel-hourly-2017032618
# extra tests on HEAD of linux-devel/devel-hourly-2017032618
git bisect bad d268ba88d28b67c93512b5ab66e2851be715e9f1 # 07:58 B 0 2 38 19 0day head guard for 'devel-hourly-2017032618'
# extra tests on tree/branch linux-devel/devel-hourly-2017032618
git bisect bad d268ba88d28b67c93512b5ab66e2851be715e9f1 # 08:00 B 0 2 38 19 0day head guard for 'devel-hourly-2017032618'
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
5 years, 1 month
[KASAN, ACPI] 80a9201a59 [ 56.736479] NMI watchdog: BUG: soft lockup - CPU#0 stuck for 22s! [swapper/0:1]
by Fengguang Wu
Hi Alexander,
FYI, here is an old soft-lockup BUG that's is still in linux-next.
https://git.kernel.org/pub/scm/linux/kernel/git/torvalds/linux.git master
commit 80a9201a5965f4715d5c09790862e0df84ce0614
Author: Alexander Potapenko <glider(a)google.com>
AuthorDate: Thu Jul 28 15:49:07 2016 -0700
Commit: Linus Torvalds <torvalds(a)linux-foundation.org>
CommitDate: Thu Jul 28 16:07:41 2016 -0700
mm, kasan: switch SLUB to stackdepot, enable memory quarantine for SLUB
For KASAN builds:
- switch SLUB allocator to using stackdepot instead of storing the
allocation/deallocation stacks in the objects;
- change the freelist hook so that parts of the freelist can be put
into the quarantine.
[aryabinin(a)virtuozzo.com: fixes]
Link: http://lkml.kernel.org/r/1468601423-28676-1-git-send-email-aryabinin@virt...
Link: http://lkml.kernel.org/r/1468347165-41906-3-git-send-email-glider@google.com
Signed-off-by: Alexander Potapenko <glider(a)google.com>
Cc: Andrey Konovalov <adech.fo(a)gmail.com>
Cc: Christoph Lameter <cl(a)linux.com>
Cc: Dmitry Vyukov <dvyukov(a)google.com>
Cc: Steven Rostedt (Red Hat) <rostedt(a)goodmis.org>
Cc: Joonsoo Kim <iamjoonsoo.kim(a)lge.com>
Cc: Kostya Serebryany <kcc(a)google.com>
Cc: Andrey Ryabinin <aryabinin(a)virtuozzo.com>
Cc: Kuthonuzo Luruo <kuthonuzo.luruo(a)hpe.com>
Signed-off-by: Andrew Morton <akpm(a)linux-foundation.org>
Signed-off-by: Linus Torvalds <torvalds(a)linux-foundation.org>
c146a2b98e mm, kasan: account for object redzone in SLUB's nearest_obj()
80a9201a59 mm, kasan: switch SLUB to stackdepot, enable memory quarantine for SLUB
c02ed2e75e Linux 4.11-rc4
7f0c4a163a Add linux-next specific files for 20170327
+------------------------------------------------+------------+------------+-----------+---------------+
| | c146a2b98e | 80a9201a59 | v4.11-rc4 | next-20170327 |
+------------------------------------------------+------------+------------+-----------+---------------+
| boot_successes | 1003 | 0 | 0 | 0 |
| boot_failures | 0 | 731 | 90 | 4 |
| BUG:soft_lockup-CPU##stuck_for#s | 0 | 731 | 90 | 4 |
| RIP:note_page | 0 | 181 | | |
| calltrace:mark_rodata_ro | 0 | 725 | | |
| Kernel_panic-not_syncing:softlockup:hung_tasks | 0 | 731 | 90 | 4 |
| RIP:__asan_load4 | 0 | 66 | | |
| RIP:__sanitizer_cov_trace_pc | 0 | 145 | | |
| RIP:__asan_load8 | 0 | 292 | | |
| RIP:ptdump_walk_pgd_level_core | 0 | 42 | | |
| RIP:is_module_text_address | 0 | 3 | | |
| calltrace:virtio_pci_driver_init | 0 | 6 | | |
| RIP:_raw_spin_unlock_irqrestore | 0 | 1 | | |
| RIP:__kernel_text_address | 0 | 1 | | |
+------------------------------------------------+------------+------------+-----------+---------------+
[ 7.785664] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11
[ 7.786689] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x26d349e8249, max_idle_ns: 440795288087 ns
[ 12.201354] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 10
[ 21.262748] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 10
[ 32.256180] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 11
[ 56.736479] NMI watchdog: BUG: soft lockup - CPU#0 stuck for 22s! [swapper/0:1]
[ 56.738452] Modules linked in:
[ 56.739070] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 4.7.0-05999-g80a9201 #1
[ 56.740351] task: ffff88001a078000 task.stack: ffff88001a080000
[ 56.741431] RIP: 0010:[<ffffffff810f6d56>] [<ffffffff810f6d56>] __kernel_text_address+0x36/0x70
[ 56.743092] RSP: 0018:ffff88001a086d50 EFLAGS: 00000246
[ 56.744086] RAX: 0000000000000000 RBX: ffff8800000152a0 RCX: ffffffff810f6d4c
[ 56.745394] RDX: dffffc0000000000 RSI: ffffffff815e3e7f RDI: ffffffff8266d404
[ 56.746690] RBP: ffff88001a086d58 R08: 000000000000000f R09: 0000000000000000
[ 56.748008] R10: 0000000000000001 R11: 0000000000000000 R12: ffff88001a078000
[ 56.749321] R13: ffff88001a087588 R14: ffff88001a087568 R15: ffff8800000152a0
[ 56.750605] FS: 0000000000000000(0000) GS:ffff88001aa00000(0000) knlGS:0000000000000000
[ 56.752055] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 56.753089] CR2: 00007ffd61906fc8 CR3: 0000000019f27000 CR4: 00000000000406b0
[ 56.754361] Stack:
[ 56.754741] 0000000000000000 ffff88001a086db0 ffffffff810476f6 ffff88001a087588
[ 56.756171] ffffffffffff8000 ffff88001a086e58 ffffffff81c1d2a0 ffff88001a086e58
[ 56.757597] ffffffff81c1d2a0 ffff88001a078000 ffff88001a078000 ffff88001a086df8
[ 56.759051] Call Trace:
[ 56.759529] [<ffffffff810476f6>] print_context_stack+0x76/0xe0
[ 56.760606] [<ffffffff81046d93>] dump_trace+0x113/0x300
[ 56.761569] [<ffffffff81058d46>] save_stack_trace+0x26/0x50
[ 56.762594] [<ffffffff812751ed>] kasan_kmalloc+0x11d/0x1b0
[ 56.763621] [<ffffffff81058d46>] ? save_stack_trace+0x26/0x50
[ 56.764702] [<ffffffff812751ed>] ? kasan_kmalloc+0x11d/0x1b0
[ 56.765786] [<ffffffff81275772>] ? kasan_slab_alloc+0x12/0x20
[ 56.766882] [<ffffffff81272911>] ? kmem_cache_alloc+0xc1/0x160
[ 56.767993] [<ffffffff815e7a6d>] ? acpi_ut_allocate_object_desc_dbg+0x9b/0x189
[ 56.769346] [<ffffffff815e7c75>] ? acpi_ut_create_internal_object_dbg+0x54/0x179
[ 56.770731] [<ffffffff815982fd>] ? acpi_ds_build_internal_object+0x3ec/0x4eb
[ 56.785121] [<ffffffff815986da>] ? acpi_ds_build_internal_package_obj+0x2de/0x4e3
[ 56.786533] [<ffffffff81599962>] ? acpi_ds_eval_data_object_operands+0x1ad/0x298
[ 56.787928] [<ffffffff8159c3d2>] ? acpi_ds_exec_end_op+0x764/0xba4
[ 56.789094] [<ffffffff815d292a>] ? acpi_ps_parse_loop+0xfaa/0x1086
[ 56.790063] [<ffffffff815d4902>] ? acpi_ps_parse_aml+0x2bd/0x7e3
[ 56.790981] [<ffffffff815d5fd5>] ? acpi_ps_execute_method+0x387/0x4ac
[ 56.792100] [<ffffffff815c69cb>] ? acpi_ns_evaluate+0x576/0x7a7
[ 56.793190] [<ffffffff815e3e7f>] ? acpi_ut_evaluate_object+0x125/0x397
[ 56.794185] [<ffffffff81436af7>] ? depot_save_stack+0x1b7/0x5b0
[ 56.795058] [<ffffffff81275259>] ? kasan_kmalloc+0x189/0x1b0
[ 56.795921] [<ffffffff81058d46>] ? save_stack_trace+0x26/0x50
[ 56.796772] [<ffffffff812751ed>] ? kasan_kmalloc+0x11d/0x1b0
[ 56.797599] [<ffffffff81272788>] ? __kmalloc+0xf8/0x1c0
[ 56.811609] [<ffffffff81598581>] ? acpi_ds_build_internal_package_obj+0x185/0x4e3
[ 56.813004] [<ffffffff81599962>] ? acpi_ds_eval_data_object_operands+0x1ad/0x298
[ 56.814381] [<ffffffff8159c3d2>] ? acpi_ds_exec_end_op+0x764/0xba4
[ 56.815539] [<ffffffff815d292a>] ? acpi_ps_parse_loop+0xfaa/0x1086
[ 56.816709] [<ffffffff815d4902>] ? acpi_ps_parse_aml+0x2bd/0x7e3
[ 56.817847] [<ffffffff815d5fd5>] ? acpi_ps_execute_method+0x387/0x4ac
[ 56.819001] [<ffffffff815c69cb>] ? acpi_ns_evaluate+0x576/0x7a7
[ 56.820112] [<ffffffff815e3e7f>] ? acpi_ut_evaluate_object+0x125/0x397
[ 56.821331] [<ffffffff815d98b7>] ? acpi_rs_get_prt_method_data+0x8e/0x120
[ 56.822592] [<ffffffff815da464>] ? acpi_get_irq_routing_table+0xbf/0x10e
[ 56.836853] [<ffffffff81588f4b>] ? acpi_pci_irq_find_prt_entry+0x169/0x518
[ 56.837948] [<ffffffff8158938a>] ? acpi_pci_irq_lookup+0x90/0x588
[ 56.838846] [<ffffffff81589a2c>] ? acpi_pci_irq_enable+0x1aa/0x3f5
[ 56.839748] [<ffffffff8192af3b>] ? pcibios_enable_device+0x3b/0x50
[ 56.840660] [<ffffffff81474195>] ? do_pci_enable_device+0xe5/0x1f0
[ 56.841571] [<ffffffff81476812>] ? pci_enable_device_flags+0x1e2/0x280
[ 56.842525] [<ffffffff815e1cb4>] ? acpi_ut_track_stack_ptr+0xb4/0xd6
[ 56.843506] [<ffffffff81101a69>] ? ___might_sleep+0x1a9/0x1d0
[ 56.844355] [<ffffffff81275772>] kasan_slab_alloc+0x12/0x20
[ 56.845182] [<ffffffff81272911>] kmem_cache_alloc+0xc1/0x160
[ 56.846025] [<ffffffff815e7a6d>] acpi_ut_allocate_object_desc_dbg+0x9b/0x189
[ 56.847060] [<ffffffff815e7c75>] acpi_ut_create_internal_object_dbg+0x54/0x179
[ 56.848113] [<ffffffff815982fd>] acpi_ds_build_internal_object+0x3ec/0x4eb
[ 56.849123] [<ffffffff81597f11>] ? acpi_ds_init_object_from_op+0x52f/0x52f
[ 56.850210] [<ffffffff81272788>] ? __kmalloc+0xf8/0x1c0
[ 56.851159] [<ffffffff815986da>] acpi_ds_build_internal_package_obj+0x2de/0x4e3
[ 56.852452] [<ffffffff81599962>] acpi_ds_eval_data_object_operands+0x1ad/0x298
[ 56.853739] [<ffffffff8159c3d2>] acpi_ds_exec_end_op+0x764/0xba4
[ 56.854861] [<ffffffff8159bc6e>] ? acpi_ds_exec_begin_op+0x42b/0x42b
[ 56.869039] [<ffffffff815d292a>] acpi_ps_parse_loop+0xfaa/0x1086
[ 56.870103] [<ffffffff81aebf5f>] ? ret_from_fork+0x1f/0x40
[ 56.871053] [<ffffffff8113ff72>] ? do_raw_spin_unlock+0x92/0x120
[ 56.871919] [<ffffffff815d1980>] ? acpi_ps_get_next_arg+0x835/0x835
[ 56.872809] [<ffffffff81275772>] ? kasan_slab_alloc+0x12/0x20
[ 56.873624] [<ffffffff81272911>] ? kmem_cache_alloc+0xc1/0x160
[ 56.874455] [<ffffffff815e18c9>] ? acpi_ut_exit+0x9e/0xab
[ 56.875229] [<ffffffff815d4902>] acpi_ps_parse_aml+0x2bd/0x7e3
[ 56.876058] [<ffffffff815d5fd5>] acpi_ps_execute_method+0x387/0x4ac
[ 56.876942] [<ffffffff815c69cb>] acpi_ns_evaluate+0x576/0x7a7
[ 56.877769] [<ffffffff815e3e7f>] acpi_ut_evaluate_object+0x125/0x397
[ 56.878668] [<ffffffff815d98b7>] acpi_rs_get_prt_method_data+0x8e/0x120
[ 56.879603] [<ffffffff815d9829>] ? acpi_rs_set_resource_source+0x90/0x90
[ 56.880546] [<ffffffff815da39a>] ? acpi_rs_validate_parameters+0x158/0x163
[ 56.881516] [<ffffffff815da464>] acpi_get_irq_routing_table+0xbf/0x10e
[ 56.894307] [<ffffffff815da3a5>] ? acpi_rs_validate_parameters+0x163/0x163
[ 56.895679] [<ffffffff8113819c>] ? check_chain_key+0x14c/0x210
[ 56.899077] [<ffffffff81588f4b>] acpi_pci_irq_find_prt_entry+0x169/0x518
[ 56.900505] [<ffffffff81588de2>] ? acpi_isa_irq_available+0x4c/0x4c
[ 56.901746] [<ffffffff8113fde9>] ? do_raw_spin_lock+0x109/0x1a0
[ 56.902834] [<ffffffff8113ff72>] ? do_raw_spin_unlock+0x92/0x120
[ 56.903949] [<ffffffff8158938a>] acpi_pci_irq_lookup+0x90/0x588
[ 56.905049] [<ffffffff815892fa>] ? acpi_pci_irq_find_prt_entry+0x518/0x518
[ 56.906298] [<ffffffff81462907>] ? pci_bus_read_config_word+0x127/0x130
[ 56.907502] [<ffffffff8113ff72>] ? do_raw_spin_unlock+0x92/0x120
[ 56.908602] [<ffffffff81589a2c>] acpi_pci_irq_enable+0x1aa/0x3f5
[ 56.909702] [<ffffffff81589882>] ? acpi_pci_irq_lookup+0x588/0x588
[ 56.910957] [<ffffffff81436af7>] ? depot_save_stack+0x1b7/0x5b0
[ 56.912281] [<ffffffff81480a89>] ? pci_enable_resources+0x209/0x2c0
[ 56.913460] [<ffffffff81480880>] ? pci_reassign_resource+0x180/0x180
[ 56.914688] [<ffffffff81058d46>] ? save_stack_trace+0x26/0x50
[ 56.915788] [<ffffffff81270107>] ? slab_attr_store+0x47/0xd0
[ 56.916886] [<ffffffff8161f6b9>] ? virtio_pci_probe+0x49/0x1a0
[ 56.918016] [<ffffffff81479614>] ? local_pci_probe+0x74/0xe0
[ 56.919848] [<ffffffff8147b104>] ? pci_device_probe+0x204/0x260
[ 56.921022] [<ffffffff81495ed3>] ? acpi_pci_power_manageable+0x73/0x80
[ 56.922404] [<ffffffff8192af3b>] pcibios_enable_device+0x3b/0x50
[ 56.923620] [<ffffffff81474195>] do_pci_enable_device+0xe5/0x1f0
[ 56.925081] [<ffffffff814740b0>] ? pci_find_saved_ext_cap+0xb0/0xb0
[ 56.926317] [<ffffffff8113819c>] ? check_chain_key+0x14c/0x210
[ 56.927463] [<ffffffff8113819c>] ? check_chain_key+0x14c/0x210
[ 56.928573] [<ffffffff81476812>] pci_enable_device_flags+0x1e2/0x280
[ 56.929792] [<ffffffff81476630>] ? pci_enable_bridge+0x130/0x130
[ 56.930962] [<ffffffff81101a69>] ? ___might_sleep+0x1a9/0x1d0
[ 56.932098] [<ffffffff811396f5>] ? lockdep_init_map+0xa5/0x320
[ 56.933448] [<ffffffff8147690a>] pci_enable_device+0x1a/0x20
[ 56.934536] [<ffffffff8161f766>] virtio_pci_probe+0xf6/0x1a0
[ 56.935645] [<ffffffff8161f670>] ? virtio_pci_remove+0x80/0x80
[ 56.936750] [<ffffffff81479614>] local_pci_probe+0x74/0xe0
[ 56.937801] [<ffffffff8147b104>] pci_device_probe+0x204/0x260
[ 56.938905] [<ffffffff8147af00>] ? pci_device_remove+0x160/0x160
[ 56.940068] [<ffffffff816ac1a6>] ? devices_kset_move_last+0x66/0x80
[ 56.941495] [<ffffffff81aeb3e2>] ? _raw_spin_unlock+0x22/0x30
[ 56.942603] [<ffffffff8147af00>] ? pci_device_remove+0x160/0x160
[ 56.943799] [<ffffffff816b278d>] driver_probe_device+0x18d/0x4d0
[ 56.944954] [<ffffffff816b2ad0>] ? driver_probe_device+0x4d0/0x4d0
[ 56.946164] [<ffffffff816b2bf6>] __driver_attach+0x126/0x130
[ 56.947279] [<ffffffff816aec26>] bus_for_each_dev+0x116/0x190
[ 56.948591] [<ffffffff816aeb10>] ? subsys_dev_iter_exit+0x20/0x20
[ 56.949748] [<ffffffff81adeb4d>] ? klist_add_tail+0x4d/0x60
[ 56.950822] [<ffffffff8113ff72>] ? do_raw_spin_unlock+0x92/0x120
[ 56.951990] [<ffffffff816b1bbb>] driver_attach+0x2b/0x30
[ 56.952995] [<ffffffff816b1409>] bus_add_driver+0x239/0x3a0
[ 56.954061] [<ffffffff816b394b>] driver_register+0xfb/0x1e0
[ 56.955195] [<ffffffff814787e4>] __pci_register_driver+0xb4/0xc0
[ 56.956573] [<ffffffff82707f3f>] ? virtio_mmio_init+0x19/0x19
[ 56.957685] [<ffffffff82707f5d>] virtio_pci_driver_init+0x1e/0x20
[ 56.958862] [<ffffffff8100225f>] do_one_initcall+0x9f/0x250
[ 56.959958] [<ffffffff810021c0>] ? initcall_blacklisted+0x130/0x130
[ 56.961187] [<ffffffff810f9100>] ? parse_args+0x5e0/0x720
[ 56.962225] [<ffffffff826aea75>] ? set_debug_rodata+0x1f/0x1f
[ 56.963348] [<ffffffff826af662>] kernel_init_freeable+0x1ff/0x2ae
[ 56.964703] [<ffffffff81adf223>] kernel_init+0x13/0x180
[ 56.965709] [<ffffffff81aebf5f>] ret_from_fork+0x1f/0x40
[ 56.966735] [<ffffffff81adf210>] ? rest_init+0xe0/0xe0
[ 56.967746] Code: ff df fc ae 81 73 06 b8 01 00 00 00 c3 55 48 89 e5 53 48 89 fb 48 c7 c7 04 d4 66 82 e8 64 dd 17 00 8b 05 b2 66 57 01 85 c0 75 14 <48> 89 df e8 f2 fe ff ff 85 c0 74 08 b8 01 00 00 00 5b 5d c3 48
[ 56.973481] Kernel panic - not syncing: softlockup: hung tasks
[ 56.974591] CPU: 0 PID: 1 Comm: swapper/0 Tainted: G L 4.7.0-05999-g80a9201 #1
[ 56.976204] 00000000ffffffff ffff88001aa07d68 ffffffff813e06d9 ffffffff81c81fa0
[ 56.977585] ffff88001aa07e40 000000000000001e 0000000000000000 ffff88001aa07e30
[ 56.978779] ffffffff811edec1 0000000041b58ab3 ffffffff8201a618 ffffffff811edd41
[ 56.980057] Call Trace:
[ 56.980714] <IRQ> [<ffffffff813e06d9>] dump_stack+0xec/0x143
[ 56.981859] [<ffffffff811edec1>] panic+0x180/0x36e
[ 56.982798] [<ffffffff811edd41>] ? devm_memremap+0xc1/0xc1
[ 56.983903] [<ffffffff811b1201>] watchdog_timer_fn+0x271/0x280
[ 56.985022] [<ffffffff811b0f90>] ? watchdog+0x50/0x50
[ 56.986002] [<ffffffff8116bac1>] hrtimer_run_queues+0x171/0x310
[ 56.987227] [<ffffffff8116a620>] run_local_timers+0x20/0xa0
[ 56.988521] [<ffffffff8116a6c8>] update_process_times+0x28/0x60
[ 56.989658] [<ffffffff81184ea0>] tick_nohz_handler+0xc0/0x1a0
[ 56.990765] [<ffffffff81aeda62>] smp_trace_apic_timer_interrupt+0x92/0xd0
[ 56.992075] [<ffffffff81aedaa9>] smp_apic_timer_interrupt+0x9/0xb
[ 56.993273] [<ffffffff81aec8af>] apic_timer_interrupt+0x7f/0x90
[ 56.994395] <EOI> [<ffffffff810f6d4c>] ? __kernel_text_address+0x2c/0x70
[ 56.995740] [<ffffffff815e3e7f>] ? acpi_ut_evaluate_object+0x125/0x397
[ 56.997223] [<ffffffff810f6d56>] ? __kernel_text_address+0x36/0x70
[ 56.998401] [<ffffffff810476f6>] print_context_stack+0x76/0xe0
[ 56.999541] [<ffffffff81046d93>] dump_trace+0x113/0x300
[ 57.000552] [<ffffffff81058d46>] save_stack_trace+0x26/0x50
[ 57.001792] [<ffffffff812751ed>] kasan_kmalloc+0x11d/0x1b0
[ 57.002871] [<ffffffff81058d46>] ? save_stack_trace+0x26/0x50
[ 57.004000] [<ffffffff812751ed>] ? kasan_kmalloc+0x11d/0x1b0
[ 57.005308] [<ffffffff81275772>] ? kasan_slab_alloc+0x12/0x20
[ 57.006416] [<ffffffff81272911>] ? kmem_cache_alloc+0xc1/0x160
[ 57.007562] [<ffffffff815e7a6d>] ? acpi_ut_allocate_object_desc_dbg+0x9b/0x189
[ 57.008915] [<ffffffff815e7c75>] ? acpi_ut_create_internal_object_dbg+0x54/0x179
[ 57.010337] [<ffffffff815982fd>] ? acpi_ds_build_internal_object+0x3ec/0x4eb
[ 57.011679] [<ffffffff815986da>] ? acpi_ds_build_internal_package_obj+0x2de/0x4e3
[ 57.013316] [<ffffffff81599962>] ? acpi_ds_eval_data_object_operands+0x1ad/0x298
[ 57.014712] [<ffffffff8159c3d2>] ? acpi_ds_exec_end_op+0x764/0xba4
[ 57.015939] [<ffffffff815d292a>] ? acpi_ps_parse_loop+0xfaa/0x1086
[ 57.017072] [<ffffffff815d4902>] ? acpi_ps_parse_aml+0x2bd/0x7e3
[ 57.018261] [<ffffffff815d5fd5>] ? acpi_ps_execute_method+0x387/0x4ac
[ 57.019504] [<ffffffff815c69cb>] ? acpi_ns_evaluate+0x576/0x7a7
[ 57.020854] [<ffffffff815e3e7f>] ? acpi_ut_evaluate_object+0x125/0x397
[ 57.022081] [<ffffffff81436af7>] ? depot_save_stack+0x1b7/0x5b0
[ 57.023286] [<ffffffff81275259>] ? kasan_kmalloc+0x189/0x1b0
[ 57.024366] [<ffffffff81058d46>] ? save_stack_trace+0x26/0x50
[ 57.025460] [<ffffffff812751ed>] ? kasan_kmalloc+0x11d/0x1b0
[ 57.026541] [<ffffffff81272788>] ? __kmalloc+0xf8/0x1c0
[ 57.027578] [<ffffffff81598581>] ? acpi_ds_build_internal_package_obj+0x185/0x4e3
[ 57.029236] [<ffffffff81599962>] ? acpi_ds_eval_data_object_operands+0x1ad/0x298
[ 57.030641] [<ffffffff8159c3d2>] ? acpi_ds_exec_end_op+0x764/0xba4
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start v4.8 v4.7 --
git bisect bad e6e7214fbbdab1f90254af68e0927bdb24708d22 # 09:37 B 26 2 26 129 Merge branch 'sched-urgent-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
git bisect bad ba929b6646c5b87c7bb15cd8d3e51617725c983b # 11:05 B 544 1 544 544 Merge branch 'for-linus-4.8' of git://git.kernel.org/pub/scm/linux/kernel/git/mason/linux-btrfs
git bisect good 468fc7ed5537615efe671d94248446ac24679773 # 00:16 G 901 0 0 0 Merge git://git.kernel.org/pub/scm/linux/kernel/git/davem/net-next
git bisect bad e55884d2c6ac3ae50e49a1f6fe38601a91181719 # 00:40 B 97 1 97 97 Merge tag 'vfio-v4.8-rc1' of git://github.com/awilliam/linux-vfio
git bisect good 554828ee0db41618d101d9549db8808af9fd9d65 # 15:13 G 902 0 0 0 Merge branch 'salted-string-hash'
git bisect good ce8c891c3496d3ea4a72ec40beac9a7b7f6649bf # 03:09 G 909 0 0 0 Merge tag 'rproc-v4.8' of git://github.com/andersson/remoteproc
git bisect bad 1c88e19b0f6a8471ee50d5062721ba30b8fd4ba9 # 03:29 B 38 1 38 38 Merge branch 'akpm' (patches from Andrew)
git bisect good c9b011a87dd49bac1632311811c974bb7cd33c25 # 16:13 G 907 0 0 0 Merge tag 'hwlock-v4.8' of git://github.com/andersson/remoteproc
git bisect good 6039b80eb50a893476fea7d56e86ed2d19290054 # 04:09 G 904 0 0 0 Merge tag 'dmaengine-4.8-rc1' of git://git.infradead.org/users/vkoul/slave-dma
git bisect good bca6759258dbef378bcf5b872177bcd2259ceb68 # 17:12 G 907 0 0 0 mm, vmstat: remove zone and node double accounting by approximating retries
git bisect good efdc94907977d2db84b4b00cb9bd98ca011f6819 # 09:12 G 901 0 0 0 mm: fix memcg stack accounting for sub-page stacks
git bisect good fb399b4854d2159a4d23fbfbd7daaed914fd54fa # 22:12 G 902 0 0 0 mm/memblock.c: fix index adjustment error in __next_mem_range_rev()
git bisect bad 31a6c1909f51dbe9bf08eb40dc64e3db90cf6f79 # 23:27 B 824 2 824 824 mm, page_alloc: set alloc_flags only once in slowpath
git bisect good c146a2b98eb5898eb0fab15a332257a4102ecae9 # 12:14 G 903 0 0 0 mm, kasan: account for object redzone in SLUB's nearest_obj()
git bisect bad 87cc271d5e4320d705cfdf59f68d4d037b3511b2 # 12:33 B 173 1 173 173 lib/stackdepot.c: use __GFP_NOWARN for stack allocations
git bisect bad 80a9201a5965f4715d5c09790862e0df84ce0614 # 12:56 B 81 1 81 81 mm, kasan: switch SLUB to stackdepot, enable memory quarantine for SLUB
# first bad commit: [80a9201a5965f4715d5c09790862e0df84ce0614] mm, kasan: switch SLUB to stackdepot, enable memory quarantine for SLUB
git bisect good c146a2b98eb5898eb0fab15a332257a4102ecae9 # 13:17 G 1003 0 0 0 mm, kasan: account for object redzone in SLUB's nearest_obj()
# extra tests with CONFIG_DEBUG_INFO_REDUCED
git bisect bad 80a9201a5965f4715d5c09790862e0df84ce0614 # 14:26 B 223 1 223 224 mm, kasan: switch SLUB to stackdepot, enable memory quarantine for SLUB
# extra tests on HEAD of linux-devel/devel-spot-201703201203
git bisect bad dd9d0f58f5a99e4a3e77bce4981b39988fcb191b # 14:26 B 0 7 27 6 0day head guard for 'devel-spot-201703201203'
# extra tests on tree/branch linus/master
git bisect bad c02ed2e75ef4c74e41e421acb4ef1494671585e8 # 14:38 B 6 1 6 6 Linux 4.11-rc4
# extra tests on tree/branch linux-next/master
git bisect bad 7f0c4a163aa51c7b924bbafbe2013838d7ddaed0 # 14:53 B 0 1 12 0 Add linux-next specific files for 20170327
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
5 years, 1 month
[sched] dfb2369d22: BUG: unable to handle kernel NULL pointer dereference at 00000048
by kernel test robot
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
git://internal_merge_and_test_tree devel-catchup-201703280023
commit dfb2369d2230a1f61ec575528a52925015a3d8c2
Author: Vincent Guittot <vincent.guittot(a)linaro.org>
AuthorDate: Mon Feb 13 10:35:47 2017 +0100
Commit: Vincent Guittot <vincent.guittot(a)linaro.org>
CommitDate: Mon Mar 27 16:45:33 2017 +0200
sched: force update of blocked load of idle cpus
When idle, the blocked load of CPUs will be updated only when an idle
load balance is triggered which may never happen. Because of this
uncertainty on the execution of idle load balance, the utilization, the load
and the shares of idle cfs_rq can stay artificially high and steal shares and
running time to busy cfs_rqs of the task group.
Add a new light idle load balance state which ensures that blocked loads
are perioddiccally updated and decayed but does not perform any task migration
Signed-off-by: Vincent Guittot <vincent.guittot(a)linaro.org>
05b40e0577 sched/fair: Prefer sibiling only if local group is under-utilized
dfb2369d22 sched: force update of blocked load of idle cpus
864b7c207e 0day head guard for 'devel-catchup-201703280023'
+-------------------------------------------------------+------------+------------+------------+
| | 05b40e0577 | dfb2369d22 | 864b7c207e |
+-------------------------------------------------------+------------+------------+------------+
| boot_successes | 37 | 2 | 7 |
| boot_failures | 0 | 13 | 15 |
| BUG:unable_to_handle_kernel | 0 | 13 | 15 |
| Oops:#[##] | 0 | 13 | 15 |
| EIP:run_rebalance_domains | 0 | 13 | 15 |
| EIP:native_safe_halt | 0 | 13 | 15 |
| Kernel_panic-not_syncing:Fatal_exception_in_interrupt | 0 | 13 | 15 |
+-------------------------------------------------------+------------+------------+------------+
[ 1.511583] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active)
[ 1.513603] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active)
[ 1.513603] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active)
[ 1.516209] pnp: PnP ACPI: found 7 devices
[ 1.516209] pnp: PnP ACPI: found 7 devices
[ 1.517497] BUG: unable to handle kernel NULL pointer dereference at 00000048
[ 1.517497] BUG: unable to handle kernel NULL pointer dereference at 00000048
[ 1.519570] IP: run_rebalance_domains+0xa0/0x348
[ 1.519570] IP: run_rebalance_domains+0xa0/0x348
[ 1.520897] *pde = 00000000
[ 1.520897] *pde = 00000000
[ 1.520899]
[ 1.520899]
[ 1.522179] Oops: 0000 [#1] SMP DEBUG_PAGEALLOC
[ 1.522179] Oops: 0000 [#1] SMP DEBUG_PAGEALLOC
[ 1.523490] Modules linked in:
[ 1.523490] Modules linked in:
[ 1.524385] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 4.11.0-rc2-00228-gdfb2369 #1
[ 1.524385] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 4.11.0-rc2-00228-gdfb2369 #1
[ 1.526563] task: b01327c0 task.stack: b013a000
[ 1.526563] task: b01327c0 task.stack: b013a000
[ 1.527890] EIP: run_rebalance_domains+0xa0/0x348
[ 1.527890] EIP: run_rebalance_domains+0xa0/0x348
[ 1.529223] EFLAGS: 00210286 CPU: 1
[ 1.529223] EFLAGS: 00210286 CPU: 1
[ 1.543167] EAX: c5876fe8 EBX: ffff8b63 ECX: 00000001 EDX: 00000000
[ 1.543167] EAX: c5876fe8 EBX: ffff8b63 ECX: 00000001 EDX: 00000000
[ 1.544935] ESI: c5880ec0 EDI: 00000000 EBP: b0167fc0 ESP: b0167f7c
[ 1.544935] ESI: c5880ec0 EDI: 00000000 EBP: b0167fc0 ESP: b0167f7c
[ 1.546746] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068
[ 1.546746] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068
[ 1.548290] CR0: 80050033 CR2: 00000048 CR3: 020f9000 CR4: 000006d0
[ 1.548290] CR0: 80050033 CR2: 00000048 CR3: 020f9000 CR4: 000006d0
[ 1.550078] Call Trace:
[ 1.550078] Call Trace:
[ 1.550797] <SOFTIRQ>
[ 1.550797] <SOFTIRQ>
[ 1.551490] ? run_rebalance_domains+0x72/0x348
[ 1.551490] ? run_rebalance_domains+0x72/0x348
[ 1.552792] ? do_softirq_own_stack+0x28/0x2e
[ 1.552792] ? do_softirq_own_stack+0x28/0x2e
[ 1.554071] __do_softirq+0x19e/0x486
[ 1.554071] __do_softirq+0x19e/0x486
[ 1.555149] ? __tasklet_hrtimer_trampoline+0x52/0x52
[ 1.555149] ? __tasklet_hrtimer_trampoline+0x52/0x52
[ 1.564903] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[ 1.564903] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[ 1.564926] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]
[ 1.564926] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]
[ 1.564929] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start 099a22e47f71bf3b048385267d9eacea5150fcb7 c02ed2e75ef4c74e41e421acb4ef1494671585e8 --
git bisect bad 2b56837e66af1919eda94cd6fad8350bea902a89 # 04:16 B 0 2 14 0 Merge 'linux-review/Deepa-Dinamani/Change-k_clock-interfaces-to-use-timespec64/20170327-150649' into devel-spot-201703280154
git bisect bad 133f05d0259358bbdccf64598a955805f5590f03 # 04:31 B 0 11 26 3 Merge 'linux-review/Fam-Zheng/sd-Consider-max_xfer_blocks-if-opt_xfer_blocks-is-unusable/20170327-230445' into devel-spot-201703280154
git bisect bad 8978b51c7298f9da75998c524a78275d387e5104 # 04:43 B 0 11 33 11 Merge 'saeed/testing/net-next' into devel-spot-201703280154
git bisect good 50eb6d90a240ee032f2d6e1a5bf2cd58d26c00db # 05:09 G 10 0 0 0 Merge 'rrnayak/cpu-clks-8996-v2' into devel-spot-201703280154
git bisect good 5d3c20bb53a0e713417990c85a2f94b852367710 # 05:36 G 11 0 0 0 Merge 'kdave-btrfs-devel/misc-next' into devel-spot-201703280154
git bisect bad b4797f0b3c69a22db3ae77f32af560c9df90b8c8 # 05:57 B 0 6 19 2 Merge 'vincent.guittot/sched/pelt' into devel-spot-201703280154
git bisect good d7921a5ddab8d30e06e321f37eec629f23797486 # 06:13 G 11 0 0 0 sched/core: Fix rq lock pinning warning after call balance callbacks
git bisect good e141328851974014646fa956ab0f9318a116cda2 # 06:30 G 11 0 0 0 arm64: Wire frequency-invariant load-tracking support up to the scheduler
git bisect good 6159c5741efc93419f0d05d0dd5ce9b4fade85b8 # 06:49 G 11 0 0 0 sched: optim decay_load
git bisect bad dfb2369d2230a1f61ec575528a52925015a3d8c2 # 07:19 B 0 11 22 0 sched: force update of blocked load of idle cpus
# first bad commit: [dfb2369d2230a1f61ec575528a52925015a3d8c2] sched: force update of blocked load of idle cpus
git bisect good 05b40e057734811ce452344fb3690d09965a7b6a # 07:44 G 33 0 0 0 sched/fair: Prefer sibiling only if local group is under-utilized
# extra tests with CONFIG_DEBUG_INFO_REDUCED
git bisect bad dfb2369d2230a1f61ec575528a52925015a3d8c2 # 07:56 B 0 11 22 0 sched: force update of blocked load of idle cpus
# extra tests on HEAD of linux-devel/devel-spot-201703280154
git bisect bad 099a22e47f71bf3b048385267d9eacea5150fcb7 # 07:56 B 0 25 40 0 0day head guard for 'devel-spot-201703280154'
# extra tests on tree/branch linux-devel/devel-catchup-201703280023
git bisect bad 864b7c207e743bc787673af0bdb7e872158070ea # 09:38 B 0 3 15 0 0day head guard for 'devel-catchup-201703280023'
# extra tests with first bad commit reverted
git bisect good 5e7235cefc500c09a6ea96b3620ad9aec5579536 # 10:00 G 11 0 0 0 Revert "sched: force update of blocked load of idle cpus"
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
5 years, 1 month
[lkp-robot] [sched] bf994f7dea: unixbench.score 1.1% improvement
by kernel test robot
Greeting,
FYI, we noticed a 1.1% improvement of unixbench.score due to commit:
commit: bf994f7dea591fa8e201114e6d1ecb897df4f449 ("sched: Prefer sibiling only if local group is under-utilized")
url: https://github.com/0day-ci/linux/commits/Srikar-Dronamraju/sched-Prefer-s...
in testcase: unixbench
on test machine: 8 threads Ivy Bridge with 16G memory
with following parameters:
runtime: 300s
nr_task: 100%
test: shell1
cpufreq_governor: performance
test-description: UnixBench is the original BYTE UNIX benchmark suite aims to test performance of Unix-like system.
test-url: https://github.com/kdlucas/byte-unixbench
Details are as below:
-------------------------------------------------------------------------------------------------->
To reproduce:
git clone https://github.com/01org/lkp-tests.git
cd lkp-tests
bin/lkp install job.yaml # job file is attached in this email
bin/lkp run job.yaml
testcase/path_params/tbox_group/run: unixbench/300s-100%-shell1-performance/lkp-ivb-d01
bc4278987e3874da bf994f7dea591fa8e201114e6d
---------------- --------------------------
%stddev %change %stddev
\ | \
12926 ± 0% +1.1% 13071 ± 0% unixbench.score
9509999 ± 0% +2.0% 9698916 ± 0% unixbench.time.involuntary_context_switches
551.50 ± 1% +2.4% 564.67 ± 0% unixbench.time.percent_of_cpu_this_job_got
1011 ± 0% +1.9% 1031 ± 0% unixbench.time.system_time
2490 ± 0% +1.7% 2532 ± 0% unixbench.time.user_time
2.259e+08 ± 0% -9.1% 2.053e+08 ± 0% cpuidle.C3.time
600760 ± 0% -11.2% 533604 ± 0% interrupts.CAL:Function_call_interrupts
4250476 ±172% -97.0% 128507 ±134% latency_stats.avg.max
8492233 ±172% -97.9% 174595 ±136% latency_stats.max.max
71.02 ± 1% +2.3% 72.66 ± 0% turbostat.%Busy
2621 ± 1% +2.3% 2681 ± 0% turbostat.Avg_MHz
1.01 ± 2% -10.3% 0.90 ± 0% turbostat.CPU%c3
2.202e+12 ± 0% +1.2% 2.227e+12 ± 0% perf-stat.branch-instructions
5.559e+10 ± 0% +0.9% 5.609e+10 ± 0% perf-stat.branch-misses
1.584e+11 ± 0% +1.2% 1.603e+11 ± 0% perf-stat.cache-references
1.324e+13 ± 0% +1.8% 1.349e+13 ± 0% perf-stat.cpu-cycles
9155600 ± 0% +4.6% 9574114 ± 0% perf-stat.cpu-migrations
4.453e+09 ± 0% +2.1% 4.544e+09 ± 0% perf-stat.iTLB-load-misses
1.12e+13 ± 0% +1.1% 1.133e+13 ± 0% perf-stat.instructions
572921 ± 3% +12.8% 646227 ± 6% sched_debug.cpu.avg_idle.max
168383 ± 5% +20.5% 202870 ± 9% sched_debug.cpu.avg_idle.stddev
183.57 ± 6% +26.1% 231.42 ± 7% sched_debug.cpu.cpu_load[1].max
32.72 ± 8% +43.1% 46.83 ± 8% sched_debug.cpu.cpu_load[1].stddev
178.18 ± 3% +16.7% 207.88 ± 4% sched_debug.cpu.cpu_load[2].max
26.07 ± 4% +37.0% 35.70 ± 6% sched_debug.cpu.cpu_load[2].stddev
perf-stat.cpu-cycles
1.4e+13 ++-------O-----O-O--O------------O------O-------------------------+
O.O.*.O*.*.*.O.*.*O.*.O.O.O.OO.* O.O.** *.*.*.**.*.*.*.*.**.*.*
1.2e+13 ++ : : : : |
| : : : : |
1e+13 ++ : : : : |
| : : : : |
8e+12 ++ : : : : |
| : : : : |
6e+12 ++ : : : : |
| : : : : |
4e+12 ++ : : : : |
| : : |
2e+12 ++ : : |
| : : |
0 ++--O--O---O-------------------O-*-----O--*-----------------------+
perf-stat.cpu-migrations
1e+07 ++------------------------------------------------------------------+
9e+06 O+O.*.O.*O.*.O.O.O.O.O.O.OO.O.O.* O O.O.*.O *.*.*.*.*.*.*.**.*.*.*.*
| : : : : |
8e+06 ++ : : : : |
7e+06 ++ : : : : |
| : : : : |
6e+06 ++ : : : : |
5e+06 ++ : : : : |
4e+06 ++ : : :: |
| : : :: |
3e+06 ++ : : :: |
2e+06 ++ : : |
| : : |
1e+06 ++ : : |
0 ++--O---O--O--------------------O-*-----O--*------------------------+
turbostat.Avg_MHz
3000 ++-------------------------------------------------------------------+
O O O O O O O O O O O O O O O O |
2500 *+*.*.*.*.*.**.*.*.*.*.*.*.*.O.*.* O.*.*.* *.*.*.*.*.*.**.*.*.*.*.*
| : : : : |
| : : : : |
2000 ++ : : : : |
| : : : : |
1500 ++ : : : : |
| : : : : |
1000 ++ :: : : |
| :: : : |
| : :: |
500 ++ : : |
| : : |
0 ++--O---O---O--------------------O-*----O---*------------------------+
turbostat._Busy
80 ++---------------------------------------------------------------------+
O.O.*.O.*.O.*.O.O.O.O.O.O.O.O.O.O.* OO.O.*.O *.*.*.*.*.*.*.*. .*.*.|
70 ++ : : : : *.* *
60 ++ : : : : |
| : : : : |
50 ++ : : : : |
| : : : : |
40 ++ : : : : |
| :: : : |
30 ++ :: : : |
20 ++ :: : : |
| : : |
10 ++ : : |
| : : |
0 ++--O---O---O---------------------O-*----O---*-------------------------+
interrupts.CAL:Function_call_interrupts
700000 ++-----------------------------------------------------------------+
| |
600000 *+*.*.**.*.*.*.*.*.**.*.*.*.*.*.* *.*.*.* *.**.*.*.*.*.*.**.*.*.*
| O O O O OO O O O O O : OO O O : |
500000 O+O O : : : : |
| : : : : |
400000 ++ : : : : |
| : : : : |
300000 ++ : : : : |
| :: : : |
200000 ++ :: : : |
| : :: |
100000 ++ : : |
| : : |
0 ++--O--O---O--------------------O-*----O---*-----------------------+
unixbench.time.user_time
3000 ++-------------------------------------------------------------------+
| |
2500 O+O.*.O.*.O.*O.O.O.O.O.O.O.O.O.O.* OO.O.*.O *.*.*.*.*.*.**.*.*.*.*.*
| : : : : |
| : : : : |
2000 ++ : : : : |
| : : : : |
1500 ++ : : : : |
| : : : : |
1000 ++ :: : : |
| :: : : |
| : :: |
500 ++ : : |
| : : |
0 ++--O---O---O--------------------O-*----O---*------------------------+
unixbench.time.system_time
1200 ++-------------------------------------------------------------------+
| |
1000 O+O.*.O.*.O.*O.O.O.O.O.O.O.O.O.O.* OO.O.*.O *.*.*.*.*.*.**.*.*.*.*.*
| : : : : |
| : : : : |
800 ++ : : : : |
| : : : : |
600 ++ : : : : |
| : : : : |
400 ++ :: : : |
| :: : : |
| : :: |
200 ++ : : |
| : : |
0 ++--O---O---O--------------------O-*----O---*------------------------+
unixbench.time.percent_of_cpu_this_job_got
600 ++--------------------------------------------------------------------+
O.O.*.O.*.O.*.O.O.OO.O.O.O.O.O.O.* O O.O.*.O *.*.*.**.*.*.*.*.*.*.*.*
500 ++ : : : : |
| : : : : |
| : : : : |
400 ++ : : : : |
| : : : : |
300 ++ : : : : |
| : : : : |
200 ++ : : : : |
| : : : : |
| : : |
100 ++ : : |
| : : |
0 ++--O---O---O--------------------O-*-----O---*------------------------+
unixbench.time.involuntary_context_switches
1e+07 O+O---O--O---O-O-O-O-O-O-OO-O-O---O-O-O---O-------------------------+
9e+06 *+*.*.*.**.*.*.*.*.*.*.*.**.*.*.* *.*.*.* *.*.*.*.*.*.*.**.*.*.*.*
| : : : : |
8e+06 ++ : : : : |
7e+06 ++ : : : : |
| : : : : |
6e+06 ++ : : : : |
5e+06 ++ : : : : |
4e+06 ++ : : :: |
| : : :: |
3e+06 ++ : : :: |
2e+06 ++ : : |
| : : |
1e+06 ++ : : |
0 ++--O---O--O--------------------O-*-----O--*------------------------+
[*] 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
5 years, 1 month
[lkp-robot] [x86/tsc] 07e7eaa3bc: BUG:kernel_reboot-without-warning_in_early-boot_stage
by kernel test robot
FYI, we noticed the following commit:
commit: 07e7eaa3bc3a152ecd015f644ba2867fdb49ca4c ("x86/tsc: use tsc early")
url: https://github.com/0day-ci/linux/commits/Pavel-Tatashin/Early-boot-time-s...
in testcase: boot
on test machine: qemu-system-x86_64 -enable-kvm -m 420M
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
+-----------------------------------------------------------------------------------------------+------------+------------+
| | ca0f45435f | 07e7eaa3bc |
+-----------------------------------------------------------------------------------------------+------------+------------+
| boot_successes | 12 | 0 |
| boot_failures | 0 | 12 |
| BUG:kernel_reboot-without-warning_in_early-boot_stage,last_printk:early_console_in_setup_code | 0 | 12 |
+-----------------------------------------------------------------------------------------------+------------+------------+
early console in setup code
Elapsed time: 10
BUG: kernel reboot-without-warning in early-boot stage, last printk: early console in setup code
Linux version 4.11.0-rc2-00235-g07e7eaa #1
Command line: ip=::::vm-lkp-nhm-dp1-openwrt-ia32-2::dhcp root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-lkp-nhm-dp1-openwrt-ia32-2/boot-1-openwrt-i386-2016-03-16.cgz-07e7eaa3bc3a152ecd015f644ba2867fdb49ca4c-20170327-61570-cbwvy5-0.yaml ARCH=x86_64 kconfig=x86_64-randconfig-v0-03270418 branch=linux-devel/devel-spot-201703270150 commit=07e7eaa3bc3a152ecd015f644ba2867fdb49ca4c BOOT_IMAGE=/pkg/linux/x86_64-randconfig-v0-03270418/gcc-6/07e7eaa3bc3a152ecd015f644ba2867fdb49ca4c/vmlinuz-4.11.0-rc2-00235-g07e7eaa max_uptime=600 RESULT_ROOT=/result/boot/1/vm-lkp-nhm-dp1-openwrt-ia32/openwrt-i386-2016-03-16.cgz/x86_64-randconfig-v0-03270418/gcc-6/07e7eaa3bc3a152ecd015f644ba2867fdb49ca4c/0 LKP_SERVER=inn debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 net.ifnames=0 printk.devkmsg=on panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 drbd.minor_count=8 systemd.log_level=err ignore_loglevel earlyprintk=ttyS0,115200 console=ttyS0,115200 console=tty0 vga=normal rw drbd.minor_count=8
initrds=(
/osimage/openwrt/openwrt-i386-2016-03-16.cgz
To reproduce:
git clone https://github.com/01org/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email
Thanks,
Xiaolong
5 years, 1 month
9006e745e7: WARNING: CPU: 0 PID: 5 at fs/kernfs/dir.c:1416 kernfs_remove_by_name_ns
by kernel test robot
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
git://internal_merge_and_test_tree devel-hourly-2017032618
commit 9006e745e77b03f27d0e0d224b0e9c5e149c630b
Merge: 8eb75c5 17df1c0
Author: 0day robot <fengguang.wu(a)intel.com>
AuthorDate: Sun Mar 26 19:29:24 2017 +0800
Commit: 0day robot <fengguang.wu(a)intel.com>
CommitDate: Sun Mar 26 19:29:24 2017 +0800
Merge 'linux-review/Hannes-Reinecke/sd-use-async_probe-cookie-to-avoid-deadlocks/20170322-130853' into devel-hourly-2017032618
8eb75c5e55 Merge 'linux-review/Shawn-Guo/Add-ZTE-VGA-driver-support/20170322-100652' into devel-hourly-2017032618
17df1c0702 sd: use async_probe cookie to avoid deadlocks
9006e745e7 Merge 'linux-review/Hannes-Reinecke/sd-use-async_probe-cookie-to-avoid-deadlocks/20170322-130853' into devel-hourly-2017032618
d268ba88d2 0day head guard for 'devel-hourly-2017032618'
+--------------------------------------------------------------------------------+------------+------------+------------+------------------+
| | 8eb75c5e55 | 17df1c0702 | 9006e745e7 | v4.11-rc3_032618 |
+--------------------------------------------------------------------------------+------------+------------+------------+------------------+
| boot_successes | 1009 | 1006 | 1 | 0 |
| boot_failures | 0 | 0 | 913 | 21 |
| WARNING:at_fs/kernfs/dir.c:#kernfs_remove_by_name_ns | 0 | 0 | 913 | 21 |
| WARNING:at_lib/refcount.c:#refcount_sub_and_test | 0 | 0 | 362 | 6 |
| BUG:unable_to_handle_kernel | 0 | 0 | 374 | 9 |
| Oops:#[##] | 0 | 0 | 374 | 9 |
| Kernel_panic-not_syncing:Fatal_exception | 0 | 0 | 913 | 21 |
| WARNING:at_block/genhd.c:#disk_release | 0 | 0 | 539 | 12 |
| kernel_BUG_at_lib/list_debug.c | 0 | 0 | 539 | 12 |
| invalid_opcode:#[##] | 0 | 0 | 539 | 12 |
| WARNING:at_lib/kobject.c:#kobject_get | 0 | 0 | 19 | 2 |
| WARNING:at_lib/refcount.c:#refcount_inc | 0 | 0 | 19 | 2 |
| kobject''(#):tried_to_add_an_uninitialized_object,something_is_seriously_wrong | 0 | 0 | 19 | 2 |
| WARNING:at_lib/kobject.c:#kobject_put | 0 | 0 | 19 | 2 |
| WARNING:at_block/blk-sysfs.c:#blk_register_queue | 0 | 0 | 19 | 2 |
| WARNING:at_block/genhd.c:#del_gendisk | 0 | 0 | 9 | 1 |
+--------------------------------------------------------------------------------+------------+------------+------------+------------------+
[ 201.101881] osd: LOADED open-osd 0.2.1
[ 201.104562] scsi host0: scsi_debug: version 1.86 [20160430]
[ 201.104562] dev_size_mb=8, opts=0x0, submit_queues=1, statistics=0
[ 201.107698] scsi 0:0:0:0: Direct-Access Linux scsi_debug 0186 PQ: 0 ANSI: 7
[ 201.109698] ------------[ cut here ]------------
[ 201.110436] WARNING: CPU: 0 PID: 5 at fs/kernfs/dir.c:1416 kernfs_remove_by_name_ns+0x3f/0xa0
[ 201.111890] kernfs: can not remove 'bdi', no directory
[ 201.112679] CPU: 0 PID: 5 Comm: kworker/u2:0 Not tainted 4.11.0-rc3-04632-g9006e74 #1
[ 201.113956] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 201.115440] Workqueue: events_unbound async_run_entry_fn
[ 201.116218] Call Trace:
[ 201.116752] dump_stack+0x19/0x25
[ 201.117511] __warn+0xd7/0x100
[ 201.118419] warn_slowpath_fmt+0x44/0x50
[ 201.119126] sd 0:0:0:0: [sda] 16384 512-byte logical blocks: (8.39 MB/8.00 MiB)
[ 201.120349] ? iput+0x1a6/0x1c0
[ 201.120944] kernfs_remove_by_name_ns+0x3f/0xa0
[ 201.121658] sysfs_remove_link+0x1d/0x20
[ 201.122330] del_gendisk+0x117/0x1e0
[ 201.122963] ? device_del+0x2cd/0x2e0
[ 201.123620] sd_remove+0x73/0xe0
[ 201.124224] driver_probe_device+0x17c/0x330
[ 201.124902] __device_attach_driver+0x92/0xa0
[ 201.125624] sd 0:0:0:0: [sda] Write Protect is off
[ 201.125626] sd 0:0:0:0: [sda] Mode Sense: 73 00 10 08
[ 201.127113] ? __driver_attach+0xb0/0xb0
[ 201.127765] bus_for_each_drv+0x57/0x90
[ 201.128414] __device_attach+0xa7/0x120
[ 201.129103] device_initial_probe+0xe/0x10
[ 201.130058] bus_probe_device+0x39/0xc0
[ 201.130707] device_add+0x3bf/0x550
[ 201.131332] scsi_sysfs_add_sdev+0xf7/0x230
[ 201.132019] do_scan_async+0xc2/0x1a0
[ 201.132651] async_run_entry_fn+0x45/0x120
[ 201.133332] process_one_work+0x2b2/0x480
[ 201.133997] ? process_one_work+0x241/0x480
[ 201.134668] worker_thread+0x466/0x610
[ 201.135325] ? _raw_spin_unlock_irq+0x2b/0x40
[ 201.136021] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, supports DPO and FUA
[ 201.137349] ? finish_task_switch+0x16c/0x1e0
[ 201.138041] ? __schedule+0x55b/0x5a0
[ 201.138687] ? _raw_spin_unlock_irqrestore+0x4c/0x70
[ 201.139430] ? workqueue_prepare_cpu+0x60/0x60
[ 201.140127] ? schedule+0x89/0xa0
[ 201.140729] ? workqueue_prepare_cpu+0x60/0x60
[ 201.141497] kthread+0x137/0x140
[ 201.142134] ? __kthread_init_worker+0x80/0x80
[ 201.142832] ? __kthread_init_worker+0x80/0x80
[ 201.143553] ret_from_fork+0x31/0x40
[ 201.144193] ---[ end trace e1991e97466b6990 ]---
[ 201.144949] ------------[ cut here ]------------
[ 201.144949] ------------[ cut here ]------------
[ 201.146014] WARNING: CPU: 0 PID: 5 at lib/refcount.c:184 refcount_sub_and_test+0x4d/0x70
[ 201.147438] refcount_t: underflow; use-after-free.
[ 201.148164] CPU: 0 PID: 5 Comm: kworker/u2:0 Tainted: G W 4.11.0-rc3-04632-g9006e74 #1
[ 201.149644] ------------[ cut here ]------------
[ 201.149648] WARNING: CPU: 0 PID: 118 at lib/kobject.c:597 kobject_get+0x37/0x50
[ 201.149651] CPU: 0 PID: 118 Comm: kworker/u2:1 Tainted: G W 4.11.0-rc3-04632-g9006e74 #1
[ 201.149652] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 201.149656] Workqueue: events_unbound async_run_entry_fn
[ 201.149658] Call Trace:
[ 201.149660] dump_stack+0x19/0x25
[ 201.149662] __warn+0xd7/0x100
[ 201.149664] warn_slowpath_fmt+0x44/0x50
[ 201.149666] kobject_get+0x37/0x50
[ 201.149668] get_device+0x14/0x20
[ 201.149671] bdi_register_owner+0x71/0x90
[ 201.149674] device_add_disk+0x200/0x470
[ 201.149677] ? _raw_spin_unlock_irq+0x2b/0x40
[ 201.149680] ? __pm_runtime_use_autosuspend+0x62/0x70
[ 201.149684] sd_probe_async+0x121/0x1d0
[ 201.149685] async_run_entry_fn+0x45/0x120
[ 201.149687] process_one_work+0x2b2/0x480
[ 201.149689] ? process_one_work+0x241/0x480
[ 201.149690] worker_thread+0x466/0x610
[ 201.149692] ? _raw_spin_unlock_irq+0x2b/0x40
[ 201.149694] ? finish_task_switch+0x16c/0x1e0
[ 201.149695] ? __schedule+0x55b/0x5a0
[ 201.149697] ? _raw_spin_unlock_irqrestore+0x4c/0x70
[ 201.149699] ? workqueue_prepare_cpu+0x60/0x60
[ 201.149700] ? schedule+0x89/0xa0
[ 201.149702] ? workqueue_prepare_cpu+0x60/0x60
[ 201.149704] kthread+0x137/0x140
[ 201.149706] ? __kthread_init_worker+0x80/0x80
[ 201.149707] ? __kthread_init_worker+0x80/0x80
[ 201.149709] ret_from_fork+0x31/0x40
[ 201.149710] ---[ end trace e1991e97466b6991 ]---
[ 201.149711] ------------[ cut here ]------------
[ 201.149711] ------------[ cut here ]------------
[ 201.149713] WARNING: CPU: 0 PID: 118 at lib/refcount.c:150 refcount_inc+0x37/0x40
[ 201.149714] refcount_t: increment on 0; use-after-free.
[ 201.149716] CPU: 0 PID: 118 Comm: kworker/u2:1 Tainted: G W 4.11.0-rc3-04632-g9006e74 #1
[ 201.149717] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 201.149718] Workqueue: events_unbound async_run_entry_fn
[ 201.149720] Call Trace:
[ 201.149722] dump_stack+0x19/0x25
[ 201.149723] __warn+0xd7/0x100
[ 201.149725] warn_slowpath_fmt+0x44/0x50
[ 201.149727] refcount_inc+0x37/0x40
[ 201.149728] kobject_get+0x40/0x50
[ 201.149730] get_device+0x14/0x20
[ 201.149731] bdi_register_owner+0x71/0x90
[ 201.149733] device_add_disk+0x200/0x470
[ 201.149735] ? _raw_spin_unlock_irq+0x2b/0x40
[ 201.149736] ? __pm_runtime_use_autosuspend+0x62/0x70
[ 201.149738] sd_probe_async+0x121/0x1d0
[ 201.149740] async_run_entry_fn+0x45/0x120
[ 201.149742] process_one_work+0x2b2/0x480
[ 201.149743] ? process_one_work+0x241/0x480
[ 201.149745] worker_thread+0x466/0x610
[ 201.149746] ? _raw_spin_unlock_irq+0x2b/0x40
[ 201.149748] ? finish_task_switch+0x16c/0x1e0
[ 201.149749] ? __schedule+0x55b/0x5a0
[ 201.149751] ? _raw_spin_unlock_irqrestore+0x4c/0x70
[ 201.149752] ? workqueue_prepare_cpu+0x60/0x60
[ 201.149753] ? schedule+0x89/0xa0
[ 201.149755] ? workqueue_prepare_cpu+0x60/0x60
[ 201.149757] kthread+0x137/0x140
[ 201.149758] ? __kthread_init_worker+0x80/0x80
[ 201.149760] ? __kthread_init_worker+0x80/0x80
[ 201.149762] ret_from_fork+0x31/0x40
[ 201.149763] ---[ end trace e1991e97466b6992 ]---
[ 201.149776] ------------[ cut here ]------------
[ 201.149776] ------------[ cut here ]------------
[ 201.149778] WARNING: CPU: 0 PID: 118 at lib/kobject.c:597 kobject_get+0x37/0x50
[ 201.149779] kobject: '' (ffff88001cd370b0): is not initialized, yet kobject_get() is being called.
[ 201.149781] CPU: 0 PID: 118 Comm: kworker/u2:1 Tainted: G W 4.11.0-rc3-04632-g9006e74 #1
[ 201.149782] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 201.149784] Workqueue: events_unbound async_run_entry_fn
[ 201.149785] Call Trace:
[ 201.149787] dump_stack+0x19/0x25
[ 201.149788] __warn+0xd7/0x100
[ 201.149790] warn_slowpath_fmt+0x44/0x50
[ 201.149792] kobject_get+0x37/0x50
[ 201.149793] get_device+0x14/0x20
[ 201.149795] device_add+0x27/0x550
[ 201.149798] device_add_disk+0x253/0x470
[ 201.149799] ? _raw_spin_unlock_irq+0x2b/0x40
[ 201.149801] ? __pm_runtime_use_autosuspend+0x62/0x70
[ 201.149803] sd_probe_async+0x121/0x1d0
[ 201.149805] async_run_entry_fn+0x45/0x120
[ 201.149806] process_one_work+0x2b2/0x480
[ 201.149808] ? process_one_work+0x241/0x480
[ 201.149809] worker_thread+0x466/0x610
[ 201.149811] ? _raw_spin_unlock_irq+0x2b/0x40
[ 201.149812] ? finish_task_switch+0x16c/0x1e0
[ 201.149814] ? __schedule+0x55b/0x5a0
[ 201.149815] ? _raw_spin_unlock_irqrestore+0x4c/0x70
[ 201.149817] ? workqueue_prepare_cpu+0x60/0x60
[ 201.149818] ? schedule+0x89/0xa0
[ 201.149819] ? workqueue_prepare_cpu+0x60/0x60
[ 201.149821] kthread+0x137/0x140
[ 201.149823] ? __kthread_init_worker+0x80/0x80
[ 201.149825] ? __kthread_init_worker+0x80/0x80
[ 201.149826] ret_from_fork+0x31/0x40
[ 201.149827] ---[ end trace e1991e97466b6993 ]---
[ 201.149829] kobject '' (ffff88001cd370b0): tried to add an uninitialized object, something is seriously wrong.
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start d268ba88d28b67c93512b5ab66e2851be715e9f1 97da3854c526d3a6ee05c849c96e48d21527606c --
git bisect bad 1336e7b8c44938191cad7a3aeabc966bd258b42d # 14:39 B 0 2 54 42 Merge 'linux-review/simran-singhal/staging-adis16060_core-Replace-mlock-with-buf_lock-and-refactor-code/20170323-031726' into devel-hourly-2017032618
git bisect good 556149cac1d58479d29392cf4da6e9f66217f849 # 15:26 G 900 0 0 0 Merge 'linux-review/John-Keeping/pinctrl-rockchip-PREEMPT_RT_FULL-fixes/20170326-064546' into devel-hourly-2017032618
git bisect good 6ac77139d7b839511babe0f54b7ef57576f16908 # 16:14 G 901 0 0 0 Merge 'linux-review/Baolin-Wang/usb-phy-Introduce-one-extcon-device-into-usb-phy/20170325-110114' into devel-hourly-2017032618
git bisect bad d0b64b29f53f470fb5d951bef5278d522f8c0fd5 # 16:14 B 1 11 0 1016 Merge 'linux-review/gfree-wind-foxmail-com/Fix-invoking-expectfn-unloaded/20170324-162446' into devel-hourly-2017032618
git bisect bad 54b6c1352cd6d90f3f6cc7f282c66c2373a3ff0e # 16:28 B 45 1 45 45 Merge 'linux-review/Pushkar-Jambhlekar/drivers-video-fbdev-Fixing-coding-guidelines-in-acornfb-c/20170326-013023' into devel-hourly-2017032618
git bisect good 7b7c3e5dcd130acfc83a04b949bb3d44c3e056af # 17:51 G 910 0 0 0 Merge 'linux-review/David-Hildenbrand/KVM-x86-fix-user-triggerable-warning-in-kvm_apic_accept_events/20170326-091633' into devel-hourly-2017032618
git bisect good b07548ecc4f297291547c0cc0dc7d48cc22a6cab # 18:52 G 910 0 0 0 Merge 'mvebu/mvebu/soc' into devel-hourly-2017032618
git bisect bad 9006e745e77b03f27d0e0d224b0e9c5e149c630b # 19:06 B 98 2 98 98 Merge 'linux-review/Hannes-Reinecke/sd-use-async_probe-cookie-to-avoid-deadlocks/20170322-130853' into devel-hourly-2017032618
git bisect good d7bf7732300a9ef4b8ffec647d03b8f4d4a763f4 # 20:23 G 903 0 0 0 Merge 'linux-review/Kees-Cook/Kbuild-make-designated_init-attribute-fatal/20170323-063300' into devel-hourly-2017032618
git bisect good 8eb75c5e55f9f11460993501f5babbb31d91bc2c # 21:17 G 910 0 0 0 Merge 'linux-review/Shawn-Guo/Add-ZTE-VGA-driver-support/20170322-100652' into devel-hourly-2017032618
git bisect good 17df1c070217eba97b274c692d701849dd163de7 # 06:52 G 901 0 0 0 sd: use async_probe cookie to avoid deadlocks
# first bad commit: [9006e745e77b03f27d0e0d224b0e9c5e149c630b] Merge 'linux-review/Hannes-Reinecke/sd-use-async_probe-cookie-to-avoid-deadlocks/20170322-130853' into devel-hourly-2017032618
git bisect good 8eb75c5e55f9f11460993501f5babbb31d91bc2c # 07:01 G 1009 0 0 0 Merge 'linux-review/Shawn-Guo/Add-ZTE-VGA-driver-support/20170322-100652' into devel-hourly-2017032618
git bisect good 17df1c070217eba97b274c692d701849dd163de7 # 07:42 G 1000 0 0 0 sd: use async_probe cookie to avoid deadlocks
# extra tests with CONFIG_DEBUG_INFO_REDUCED
git bisect bad 9006e745e77b03f27d0e0d224b0e9c5e149c630b # 07:58 B 74 1 74 76 Merge 'linux-review/Hannes-Reinecke/sd-use-async_probe-cookie-to-avoid-deadlocks/20170322-130853' into devel-hourly-2017032618
# extra tests on HEAD of linux-devel/devel-hourly-2017032618
git bisect bad d268ba88d28b67c93512b5ab66e2851be715e9f1 # 07:58 B 0 2 38 19 0day head guard for 'devel-hourly-2017032618'
# extra tests on tree/branch linux-devel/devel-hourly-2017032618
git bisect bad d268ba88d28b67c93512b5ab66e2851be715e9f1 # 08:00 B 0 2 38 19 0day head guard for 'devel-hourly-2017032618'
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
5 years, 1 month
[x86/mm/gup] 2947ba054a [ 71.329069] kernel BUG at include/linux/pagemap.h:151!
by Fengguang Wu
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
https://git.kernel.org/pub/scm/linux/kernel/git/tip/tip.git x86/mm
commit 2947ba054a4dabbd82848728d765346886050029
Author: Kirill A. Shutemov <kirill.shutemov(a)linux.intel.com>
AuthorDate: Fri Mar 17 00:39:06 2017 +0300
Commit: Ingo Molnar <mingo(a)kernel.org>
CommitDate: Sat Mar 18 09:48:03 2017 +0100
x86/mm/gup: Switch GUP to the generic get_user_page_fast() implementation
This patch provides all required callbacks required by the generic
get_user_pages_fast() code and switches x86 over - and removes
the platform specific implementation.
Signed-off-by: Kirill A. Shutemov <kirill.shutemov(a)linux.intel.com>
Cc: Andrew Morton <akpm(a)linux-foundation.org>
Cc: Aneesh Kumar K . V <aneesh.kumar(a)linux.vnet.ibm.com>
Cc: Borislav Petkov <bp(a)alien8.de>
Cc: Catalin Marinas <catalin.marinas(a)arm.com>
Cc: Dann Frazier <dann.frazier(a)canonical.com>
Cc: Dave Hansen <dave.hansen(a)intel.com>
Cc: H. Peter Anvin <hpa(a)zytor.com>
Cc: Linus Torvalds <torvalds(a)linux-foundation.org>
Cc: Peter Zijlstra <peterz(a)infradead.org>
Cc: Rik van Riel <riel(a)redhat.com>
Cc: Steve Capper <steve.capper(a)linaro.org>
Cc: Thomas Gleixner <tglx(a)linutronix.de>
Cc: linux-arch(a)vger.kernel.org
Cc: linux-mm(a)kvack.org
Link: http://lkml.kernel.org/r/20170316213906.89528-1-kirill.shutemov@linux.int...
[ Minor readability edits. ]
Signed-off-by: Ingo Molnar <mingo(a)kernel.org>
73e10a6181 mm/gup: Provide callback to check if __GUP_fast() is allowed for the range
2947ba054a x86/mm/gup: Switch GUP to the generic get_user_page_fast() implementation
5b781c7e31 x86/tls: Forcibly set the accessed bit in TLS segments
d730a1a1d7 Merge branch 'linus'
+------------------------------------------+------------+------------+------------+------------+
| | 73e10a6181 | 2947ba054a | 5b781c7e31 | d730a1a1d7 |
+------------------------------------------+------------+------------+------------+------------+
| boot_successes | 198 | 64 | 74 | 13 |
| boot_failures | 3 | 6 | 2 | 4 |
| BUG:unable_to_handle_kernel | 3 | 2 | 0 | 3 |
| Oops:#[##] | 3 | 2 | 0 | 3 |
| Kernel_panic-not_syncing:Fatal_exception | 3 | 6 | 2 | 4 |
| kernel_BUG_at_include/linux/pagemap.h | 0 | 4 | 2 | 1 |
| invalid_opcode:#[##] | 0 | 4 | 2 | 1 |
+------------------------------------------+------------+------------+------------+------------+
[ 62.968921] init: networking main process (452) terminated with status 1
[ 62.968921] init: networking main process (452) terminated with status 1
[ 64.749439] Writes: Total: 2 Max/Min: 0/0 Fail: 0
[ 70.486518] sock: process `trinity-main' is using obsolete setsockopt SO_BSDCOMPAT
[ 71.326909] ------------[ cut here ]------------
[ 71.329069] kernel BUG at include/linux/pagemap.h:151!
[ 71.329069] kernel BUG at include/linux/pagemap.h:151!
[ 71.332456] invalid opcode: 0000 [#1]
[ 71.332456] invalid opcode: 0000 [#1]
[ 71.334359] CPU: 0 PID: 458 Comm: trinity-c0 Not tainted 4.11.0-rc2-00251-g2947ba0 #1
[ 71.334359] CPU: 0 PID: 458 Comm: trinity-c0 Not tainted 4.11.0-rc2-00251-g2947ba0 #1
[ 71.338444] task: ffff88001f19ab00 task.stack: ffff88001f084000
[ 71.338444] task: ffff88001f19ab00 task.stack: ffff88001f084000
[ 71.340586] RIP: 0010:gup_pud_range+0x56f/0x63d
[ 71.340586] RIP: 0010:gup_pud_range+0x56f/0x63d
[ 71.342886] RSP: 0018:ffff88001f087ba8 EFLAGS: 00010046
[ 71.342886] RSP: 0018:ffff88001f087ba8 EFLAGS: 00010046
[ 71.345607] RAX: 0000000080000000 RBX: 000000000164e000 RCX: ffff88001e0badc0
[ 71.345607] RAX: 0000000080000000 RBX: 000000000164e000 RCX: ffff88001e0badc0
[ 71.347923] RDX: dead000000000100 RSI: 0000000000000001 RDI: ffff88001e0badc0
[ 71.347923] RDX: dead000000000100 RSI: 0000000000000001 RDI: ffff88001e0badc0
[ 71.350249] RBP: ffff88001f087c38 R08: ffff88001f087cf8 R09: ffff88001f087c6c
[ 71.350249] RBP: ffff88001f087c38 R08: ffff88001f087cf8 R09: ffff88001f087c6c
[ 71.352741] R10: 0000000000000000 R11: ffff88001f19b0f0 R12: ffff88001f087c6c
[ 71.352741] R10: 0000000000000000 R11: ffff88001f19b0f0 R12: ffff88001f087c6c
[ 71.356086] R13: ffff88001e0badc0 R14: 800000001e7b7867 R15: 0000000000000000
[ 71.356086] R13: ffff88001e0badc0 R14: 800000001e7b7867 R15: 0000000000000000
[ 71.359328] FS: 00007f7ea7b60700(0000) GS:ffffffffae02f000(0000) knlGS:0000000000000000
[ 71.359328] FS: 00007f7ea7b60700(0000) GS:ffffffffae02f000(0000) knlGS:0000000000000000
[ 71.361945] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 71.361945] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 71.363806] CR2: 00000000013eb130 CR3: 0000000017ddb000 CR4: 00000000000006f0
[ 71.363806] CR2: 00000000013eb130 CR3: 0000000017ddb000 CR4: 00000000000006f0
[ 71.366122] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[ 71.366122] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[ 71.368424] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 00000000000d0602
[ 71.368424] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 00000000000d0602
[ 71.370729] Call Trace:
[ 71.370729] Call Trace:
[ 71.371537] __get_user_pages_fast+0x107/0x136
[ 71.371537] __get_user_pages_fast+0x107/0x136
[ 71.373435] get_user_pages_fast+0x78/0x89
[ 71.373435] get_user_pages_fast+0x78/0x89
[ 71.375447] get_futex_key+0xfd/0x350
[ 71.375447] get_futex_key+0xfd/0x350
[ 71.376999] ? simple_write_end+0x83/0xbe
[ 71.376999] ? simple_write_end+0x83/0xbe
[ 71.378614] futex_requeue+0x1a3/0x585
[ 71.378614] futex_requeue+0x1a3/0x585
[ 71.380244] do_futex+0x834/0x86f
[ 71.380244] do_futex+0x834/0x86f
[ 71.381893] ? kvm_clock_read+0x16/0x1e
[ 71.381893] ? kvm_clock_read+0x16/0x1e
[ 71.383794] ? paravirt_sched_clock+0x9/0xd
[ 71.383794] ? paravirt_sched_clock+0x9/0xd
[ 71.385857] ? lock_release+0x11e/0x328
[ 71.385857] ? lock_release+0x11e/0x328
[ 71.387760] SyS_futex+0x125/0x135
[ 71.387760] SyS_futex+0x125/0x135
[ 71.389446] ? write_seqcount_end+0x1a/0x1f
[ 71.389446] ? write_seqcount_end+0x1a/0x1f
[ 71.391499] ? vtime_account_user+0x4b/0x50
[ 71.391499] ? vtime_account_user+0x4b/0x50
[ 71.393404] do_syscall_64+0x61/0x74
[ 71.393404] do_syscall_64+0x61/0x74
[ 71.394806] entry_SYSCALL64_slow_path+0x25/0x25
[ 71.394806] entry_SYSCALL64_slow_path+0x25/0x25
[ 71.396853] RIP: 0033:0x7f7ea76756d9
[ 71.396853] RIP: 0033:0x7f7ea76756d9
[ 71.398617] RSP: 002b:00007ffcc92aa7b8 EFLAGS: 00000246 ORIG_RAX: 00000000000000ca
[ 71.398617] RSP: 002b:00007ffcc92aa7b8 EFLAGS: 00000246 ORIG_RAX: 00000000000000ca
[ 71.402322] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f7ea76756d9
[ 71.402322] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f7ea76756d9
[ 71.405421] RDX: 000000000000be98 RSI: 0000000000000004 RDI: 000000000164e690
[ 71.405421] RDX: 000000000000be98 RSI: 0000000000000004 RDI: 000000000164e690
[ 71.408674] RBP: 00000000000000ca R08: 00000000013e3110 R09: 950000000000002d
[ 71.408674] RBP: 00000000000000ca R08: 00000000013e3110 R09: 950000000000002d
[ 71.411757] R10: 0000000000f4e000 R11: 0000000000000246 R12: 0000000000000000
[ 71.411757] R10: 0000000000f4e000 R11: 0000000000000246 R12: 0000000000000000
[ 71.414998] R13: 00000000000000ca R14: 00000000000000ca R15: 950000000000002d
[ 71.414998] R13: 00000000000000ca R14: 00000000000000ca R15: 950000000000002d
[ 71.418178] Code: c1 e1 06 49 83 e5 fc 49 01 cd 4c 89 ef e8 20 f7 ff ff 48 89 c1 8b 05 18 83 10 01 a9 00 ff 1f 00 74 02 0f 0b a9 ff ff ff 7f 75 02 <0f> 0b 48 89 cf e8 fd f6 ff ff 8b 40 1c 85 c0 75 11 48 c7 c6 e5
[ 71.418178] Code: c1 e1 06 49 83 e5 fc 49 01 cd 4c 89 ef e8 20 f7 ff ff 48 89 c1 8b 05 18 83 10 01 a9 00 ff 1f 00 74 02 0f 0b a9 ff ff ff 7f 75 02 <0f> 0b 48 89 cf e8 fd f6 ff ff 8b 40 1c 85 c0 75 11 48 c7 c6 e5
[ 71.426515] RIP: gup_pud_range+0x56f/0x63d RSP: ffff88001f087ba8
[ 71.426515] RIP: gup_pud_range+0x56f/0x63d RSP: ffff88001f087ba8
[ 71.428870] ---[ end trace 86b31f300c9b87a7 ]---
[ 71.428870] ---[ end trace 86b31f300c9b87a7 ]---
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start 9872ac2f754f4f5e572dc16bdc879dca0c7cd1bc 4495c08e84729385774601b5146d51d9e5849f81 --
git bisect bad 092f53447eb7673382c281411fc3d1fb7e10b10d # 01:26 B 9 1 0 0 Merge 'linux-review/Moritz-Fischer/fpga-altera_freeze_bridge-Constify-ops/20170319-164702' into devel-spot-201703192350
git bisect bad 78dd5ec52f02b1a3a0755b265afccf0230590bd8 # 01:43 B 6 1 0 0 Merge 'linux-review/David-Rivshin/gpio-omap-return-error-if-requested-debounce-time-is-not-possible/20170319-201713' into devel-spot-201703192350
git bisect good 235b66a6e627c0d011570699e85445456a7c51c9 # 02:04 G 68 0 0 0 Merge 'saeed/net-rc' into devel-spot-201703192350
git bisect bad 1cb74cc1571bbb6ade2de556ca868e8471065f18 # 02:14 B 3 1 0 0 Merge 'iio/fixes-togreg' into devel-spot-201703192350
git bisect bad 764d81941ec35d3cb0eac136358f43bfb86c6cd6 # 02:25 B 0 1 11 0 Merge 'tip/x86/mm' into devel-spot-201703192350
git bisect good d11507e197242aaab172d7f1d0fe4771fbffa530 # 02:44 G 68 0 0 0 Merge tag 'xfs-4.11-fixes-2' of git://git.kernel.org/pub/scm/fs/xfs/xfs-linux
git bisect good f06bdd4001c257792c54dce9427399f2896470af # 03:00 G 68 0 0 0 x86/mm: Adapt MODULES_END based on fixmap section size
git bisect good e7884f8ead4a301b04687a3238527b06feef8ea0 # 03:17 G 63 0 0 2 mm/gup: Move permission checks into helpers
git bisect good b59f65fa076a8eac2ff3a8ab7f8e1705b9fa86cb # 03:43 G 66 0 0 3 mm/gup: Implement the dev_pagemap() logic in the generic get_user_pages_fast() function
git bisect bad 2947ba054a4dabbd82848728d765346886050029 # 03:58 B 13 1 0 2 x86/mm/gup: Switch GUP to the generic get_user_page_fast() implementation
git bisect good 73e10a61817dfc97fe7418bfad1f608e562d7348 # 04:27 G 64 0 1 3 mm/gup: Provide callback to check if __GUP_fast() is allowed for the range
# first bad commit: [2947ba054a4dabbd82848728d765346886050029] x86/mm/gup: Switch GUP to the generic get_user_page_fast() implementation
git bisect good 73e10a61817dfc97fe7418bfad1f608e562d7348 # 04:48 G 191 0 0 3 mm/gup: Provide callback to check if __GUP_fast() is allowed for the range
# extra tests with CONFIG_DEBUG_INFO_REDUCED
git bisect bad 2947ba054a4dabbd82848728d765346886050029 # 05:04 B 2 1 0 2 x86/mm/gup: Switch GUP to the generic get_user_page_fast() implementation
# extra tests on HEAD of linux-devel/devel-spot-201703192350
git bisect bad 9872ac2f754f4f5e572dc16bdc879dca0c7cd1bc # 05:04 B 21 4 0 0 0day head guard for 'devel-spot-201703192350'
# extra tests on tree/branch tip/x86/mm
git bisect bad 5b781c7e317fcf9f74475dc82bfce2e359dfca13 # 05:28 B 43 1 0 0 x86/tls: Forcibly set the accessed bit in TLS segments
# extra tests with first bad commit reverted
git bisect good ebfa79a64457cb162e3ab9fd6d26cfdefd03e604 # 05:59 G 173 0 0 0 Revert "x86/mm/gup: Switch GUP to the generic get_user_page_fast() implementation"
# extra tests on tree/branch tip/master
git bisect bad d730a1a1d7cbf6d447312f1a1a1c79d252fd7aea # 06:17 B 12 1 0 2 Merge branch 'linus'
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
5 years, 1 month
[lkp-robot] [fsnotify] 0ee0efcf7c: kernel_BUG_at_fs/notify/inotify/inotify_user.c
by kernel test robot
FYI, we noticed the following commit:
commit: 0ee0efcf7c7968fb045454f621b5681e94b2c288 ("fsnotify: Move queueing of mark for destruction into fsnotify_put_mark()")
https://git.kernel.org/cgit/linux/kernel/git/jack/linux-fs.git for_testing
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 -smp 2 -m 512M
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
+------------------------------------------------+------------+------------+
| | 58c5cae6d5 | 0ee0efcf7c |
+------------------------------------------------+------------+------------+
| boot_successes | 602 | 594 |
| boot_failures | 0 | 12 |
| kernel_BUG_at_fs/notify/inotify/inotify_user.c | 0 | 12 |
| invalid_opcode:#[##] | 0 | 12 |
| EIP:inotify_remove_from_idr | 0 | 12 |
| Kernel_panic-not_syncing:Fatal_exception | 0 | 12 |
+------------------------------------------------+------------+------------+
[ 330.941460] kernel BUG at fs/notify/inotify/inotify_user.c:454!
[ 330.942422] invalid opcode: 0000 [#1] SMP
[ 330.942884] Modules linked in:
[ 330.943531] CPU: 1 PID: 2301 Comm: ps Not tainted 4.11.0-rc2-00019-g0ee0efc #1
[ 330.944465] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 330.945803] task: de378100 task.stack: db7ec000
[ 330.946417] EIP: inotify_remove_from_idr+0xff/0x13a
[ 330.947114] EFLAGS: 00010202 CPU: 1
[ 330.947668] EAX: 0000004c EBX: dabfd4b0 ECX: df0f1d18 EDX: df0ecee4
[ 330.948521] ESI: dabfd4b0 EDI: dccbbb00 EBP: db7ede60 ESP: db7ede38
[ 330.949278] DS: 007b ES: 007b FS: 00d8 GS: 0033 SS: 0068
[ 330.949950] CR0: 80050033 CR2: b7713540 CR3: 1cc4f000 CR4: 000006d0
[ 330.950772] DR0: b6945000 DR1: 00000000 DR2: 00000000 DR3: 00000000
[ 330.951652] DR6: ffff0ff0 DR7: 00000600
[ 330.952182] Call Trace:
[ 330.952474] inotify_ignored_and_remove_idr+0x2c/0x46
[ 330.953143] inotify_freeing_mark+0x8/0xa
[ 330.953740] fsnotify_free_mark+0x42/0x47
[ 330.954234] fsnotify_destroy_mark+0x2b/0x2f
[ 330.954789] inotify_handle_event+0xc4/0xcd
[ 330.955295] fsnotify+0x24d/0x2d8
[ 330.955780] do_sys_open+0xa9/0xc7
[ 330.956341] SyS_open+0x18/0x1a
[ 330.956788] do_int80_syscall_32+0x45/0x57
[ 330.957390] entry_INT80_32+0x2a/0x2a
[ 330.957809] EIP: 0xb76d0305
[ 330.958162] EFLAGS: 00000282 CPU: 1
[ 330.958615] EAX: ffffffda EBX: bf83d127 ECX: 00008000 EDX: 00000000
[ 330.959579] ESI: 00000000 EDI: 00000000 EBP: bf83d104 ESP: bf83d0d8
[ 330.960424] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 007b
[ 330.961246] Code: 87 c1 01 e8 75 10 f3 ff 83 c4 28 eb 37 8b 43 04 83 f8 02 7f 18 ff 73 08 ff 73 4c 53 68 60 27 4f c1 68 a8 75 78 c1 e8 38 3f fa ff <0f> 0b 8b 55 f0 8d 87 e0 00 00 00 31 c9 e8 38 8a 06 00 89 d8 e8
[ 330.963728] EIP: inotify_remove_from_idr+0xff/0x13a SS:ESP: 0068:db7ede38
[ 330.964755] ---[ end trace 1a8558f20d1546cf ]---
To reproduce:
git clone https://github.com/01org/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email
Thanks,
Xiaolong
5 years, 1 month