[lkp-robot] [tcp] e70ac17165: WARNING:at_kernel/softirq.c:#__local_bh_enable_ip
by kernel test robot
FYI, we noticed the following commit:
commit: e70ac171658679ecf6bea4bbd9e9325cd6079d2b ("tcp: tcp_probe: use spin_lock_bh()")
https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git master
in testcase: boot
on test machine: qemu-system-x86_64 -enable-kvm -cpu host -smp 2 -m 2G
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
+-----------------------------------------------------+------------+------------+
| | a725eb15db | e70ac17165 |
+-----------------------------------------------------+------------+------------+
| boot_successes | 0 | 0 |
| boot_failures | 14 | 16 |
| WARNING:at_arch/x86/mm/dump_pagetables.c:#note_page | 14 | 16 |
| invoked_oom-killer:gfp_mask=0x | 0 | 3 |
| Mem-Info | 0 | 3 |
| Out_of_memory:Kill_process | 0 | 1 |
| WARNING:at_kernel/softirq.c:#__local_bh_enable_ip | 0 | 11 |
+-----------------------------------------------------+------------+------------+
[ 27.257372] WARNING: CPU: 1 PID: 483 at kernel/softirq.c:161 __local_bh_enable_ip+0x3b/0x80
[ 27.259647] Modules linked in: auth_rpcgss nfsv4 nfs lockd grace fscache af_packet ide_cd_mod ide_pci_generic crct10dif_pclmul crct10dif_common bochs_drm ttm crc32c_intel fbcon bitblit fbcon_rotate fbcon_ccw fbcon_ud fbcon_cw softcursor font tileblit drm_kms_helper input_leds serio_raw drm i6300esb virtio_pci piix e1000 ide_core i2c_piix4 tpm_tis tpm_tis_core floppy qemu_fw_cfg evbug evdev sunrpc ip_tables ipv6 autofs4
[ 27.266515] CPU: 1 PID: 483 Comm: mount.nfs Tainted: G W 4.10.0-rc7-00193-ge70ac17 #2
[ 27.267842] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 27.269268] Call Trace:
[ 27.270086] dump_stack+0x63/0x81
[ 27.271046] __warn+0xbb/0xe0
[ 27.271932] warn_slowpath_null+0x18/0x20
[ 27.272848] __local_bh_enable_ip+0x3b/0x80
[ 27.273806] _raw_spin_unlock_bh+0x30/0x40
[ 27.274736] jtcp_rcv_established+0x297/0x2c0
[ 27.275714] tcp_v4_do_rcv+0x96/0x150
[ 27.276586] __release_sock+0xce/0x150
[ 27.277451] release_sock+0x2b/0xb0
[ 27.278297] tcp_sendmsg+0x9ea/0xaf0
[ 27.279199] inet_sendmsg+0xd4/0x100
[ 27.280070] kernel_sendmsg+0x30/0x40
[ 27.280947] xs_send_kvec+0x6b/0x90 [sunrpc]
[ 27.281826] xs_sendpages+0x5e/0x1e0 [sunrpc]
[ 27.282763] xs_tcp_send_request+0x7d/0x160 [sunrpc]
[ 27.283680] xprt_transmit+0xbb/0x280 [sunrpc]
[ 27.284538] call_transmit+0x1cc/0x240 [sunrpc]
[ 27.285445] ? rpc_destroy_wait_queue+0x20/0x20 [sunrpc]
[ 27.286358] __rpc_execute+0x83/0x200 [sunrpc]
[ 27.287257] ? wake_up_bit+0x20/0x30
[ 27.288072] rpc_execute+0x38/0x40 [sunrpc]
[ 27.288934] rpc_run_task+0x14b/0x160 [sunrpc]
[ 27.289774] rpc_call_sync+0x7f/0xa0 [sunrpc]
[ 27.290629] rpc_ping+0x4d/0x70 [sunrpc]
[ 27.291479] rpc_create_xprt+0xde/0x170 [sunrpc]
[ 27.292339] rpc_create+0x198/0x1c0 [sunrpc]
[ 27.293166] ? rpcauth_lookup_credcache+0x204/0x2c0 [sunrpc]
[ 27.294103] nfs_create_rpc_client+0xcd/0xf0 [nfs]
[ 27.295010] nfs4_init_client+0x82/0x1c0 [nfsv4]
[ 27.295916] ? nfs_get_client+0x36b/0x3c0 [nfs]
[ 27.296759] ? kvm_sched_clock_read+0x25/0x40
[ 27.297572] ? sched_clock+0x9/0x10
[ 27.298319] ? sched_clock_cpu+0xa5/0xb0
[ 27.299109] ? nfs_get_client+0x36b/0x3c0 [nfs]
[ 27.299938] ? nfs_get_client+0xb4/0x3c0 [nfs]
[ 27.300778] ? __lock_acquire+0x87d/0x940
[ 27.301649] nfs_get_client+0x382/0x3c0 [nfs]
[ 27.302473] ? nfs_get_client+0xb4/0x3c0 [nfs]
[ 27.303395] ? is_module_address+0x10/0x20
[ 27.304179] nfs4_set_client+0x76/0xa0 [nfsv4]
[ 27.304949] nfs4_create_server+0x10b/0x270 [nfsv4]
[ 27.305796] nfs4_remote_mount+0x29/0x50 [nfsv4]
[ 27.306543] mount_fs+0xf/0x90
[ 27.307210] vfs_kern_mount+0x6b/0x170
[ 27.307859] nfs_do_root_mount+0x93/0xc0 [nfsv4]
[ 27.308668] nfs4_try_mount+0x32/0x50 [nfsv4]
[ 27.309402] nfs_fs_mount+0x8aa/0x950 [nfs]
[ 27.310045] ? nfs_remount+0x3c0/0x3c0 [nfs]
[ 27.310766] ? nfs_auth_info_match+0x40/0x40 [nfs]
[ 27.311521] mount_fs+0xf/0x90
[ 27.312090] vfs_kern_mount+0x6b/0x170
[ 27.312716] do_mount+0x9c4/0xd40
[ 27.313323] ? copy_mount_options+0x28/0x160
[ 27.313973] SyS_mount+0x8c/0xc0
[ 27.314552] do_syscall_64+0x7d/0x160
[ 27.315186] entry_SYSCALL64_slow_path+0x25/0x25
[ 27.315911] RIP: 0033:0x7f2c30cd598a
[ 27.316520] RSP: 002b:00007fff1bf85388 EFLAGS: 00000206 ORIG_RAX: 00000000000000a5
[ 27.317600] RAX: ffffffffffffffda RBX: 0000000000000000 RCX: 00007f2c30cd598a
[ 27.319087] RDX: 0000000001b9cf30 RSI: 0000000001b9cf10 RDI: 0000000001b9cef0
[ 27.320581] RBP: 00007fff1bf85490 R08: 0000000001b9d890 R09: 0000000001b9d890
[ 27.322077] R10: 0000000000000000 R11: 0000000000000206 R12: 00007fff1bf85490
[ 27.323571] R13: 0000000001b9d650 R14: 0000000000000010 R15: 0000000001b9b010
[ 27.325060] ---[ end trace 1b69e98171ee3b1d ]---
To reproduce:
git clone git://git.kernel.org/pub/scm/linux/kernel/git/wfg/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email
Thanks,
Xiaolong
4 years
- 3
- 2
[mm] c3263ba15e inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage.
by Fengguang Wu
Hi Peter,
FYI, here is another bisected warning to this commit.
Attached a reproduce script for your convenience.
https://github.com/0day-ci/linux peter-enderborg-sonymobile-com/android-Collect-statistics-from-lowmemorykiller/20170215-004327
commit c3263ba15e872666094c18a1d882597bfe1ce1c1
Author: Peter Enderborg <peter.enderborg(a)sonymobile.com>
AuthorDate: Tue Feb 14 17:09:32 2017 +0100
Commit: 0day robot <fengguang.wu(a)intel.com>
CommitDate: Wed Feb 15 00:43:32 2017 +0800
mm: Remove RCU and tasklocks from lmk
Fundamental changes:
1 Does NOT take any RCU lock in shrinker functions.
2 It returns same result for scan and counts, so we dont need to do
shinker will know when it is pointless to call scan.
3 It does not lock any other process than the one that is
going to be killed.
Background.
The low memory killer scans for process that can be killed to free
memory. This can be cpu consuming when there is a high demand for
memory. This can be seen by analysing the kswapd0 task work.
The stats function added in earler patch adds a counter for waste work.
How it works.
This patch create a structure within the lowmemory killer that caches
the user spaces processes that it might kill. It is done with a
sorted rbtree so we can very easy find the candidate to be killed,
and knows its properies as memory usage and sorted by oom_score_adj
to look up the task with highest oom_score_adj. To be able to achive
this it uses oom_score_notify events.
This patch also as a other effect, we are now free to do other
lowmemorykiller configurations. Without the patch there is a need
for a tradeoff between freed memory and task and rcu locks. This
is no longer a concern for tuning lmk. This patch is not intended
to do any calculation changes other than we do use the cache for
calculate the count values and that makes kswapd0 to shrink other
areas.
Signed-off-by: Peter Enderborg <peter.enderborg(a)sonymobile.com>
+-------------------------------------------------+------------+------------+------------------+
| | 0174c40bf1 | c3263ba15e | v4.10-rc8_021805 |
+-------------------------------------------------+------------+------------+------------------+
| boot_successes | 261 | 0 | 70 |
| boot_failures | 3 | 71 | 25 |
| BUG:kernel_hang_in_test_stage | 3 | 1 | 4 |
| inconsistent{IN-SOFTIRQ-W}->{SOFTIRQ-ON-W}usage | 0 | 6 | 10 |
| calltrace:lmk_oom_score_notifier | 0 | 70 | |
| calltrace:smpboot_thread_fn | 0 | 3 | |
| calltrace:__set_oom_adj | 0 | 2 | |
| inconsistent{SOFTIRQ-ON-W}->{IN-SOFTIRQ-W}usage | 0 | 64 | 10 |
| calltrace:SyS_write | 0 | 63 | |
| calltrace:rcu_process_callbacks | 0 | 64 | 10 |
| calltrace:SyS_munmap | 0 | 1 | |
| calltrace:irq_exit | 0 | 1 | 4 |
| calltrace:SyS_mmap_pgoff | 0 | 1 | |
| calltrace:copy_process | 0 | 2 | 3 |
| calltrace:n_tty_write | 0 | 1 | |
| BUG:kernel_in_stage | 0 | 0 | 1 |
| calltrace:vprintk_emit | 0 | 0 | 2 |
| calltrace:univ8250_release_irq | 0 | 0 | 1 |
+-------------------------------------------------+------------+------------+------------------+
[ 9.180183]
[ 9.180610] =================================
[ 9.181713] [ INFO: inconsistent lock state ]
[ 9.182811] 4.10.0-rc7-00639-gc3263ba #2 Not tainted
[ 9.184067] ---------------------------------
[ 9.185260] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage.
[ 9.186780] ksoftirqd/0/6 [HC0[0]:SC1[1]:HE1:SE0] takes:
[ 9.188173] (lmk_task_lock){+.?...}, at: [<ffffffff81441d54>] lmk_oom_score_notifier+0x64/0x150
[ 9.192310] {SOFTIRQ-ON-W} state was registered at:
[ 9.193508]
[ 9.193515] [<ffffffff81095509>] __lock_acquire+0x5d9/0x1760
[ 9.197638]
[ 9.197644] [<ffffffff81096acf>] lock_acquire+0x8f/0xe0
[ 9.200487]
[ 9.200494] [<ffffffff8151084c>] _raw_spin_lock+0x3c/0x80
[ 9.203921]
[ 9.203930] [<ffffffff81441bf0>] lmk_task_watch+0x40/0x140
[ 9.207799]
[ 9.207807] [<ffffffff81441d12>] lmk_oom_score_notifier+0x22/0x150
[ 9.211497]
[ 9.211504] [<ffffffff8107dec4>] notifier_call_chain+0x34/0xa0
[ 9.216504]
[ 9.216508] [<ffffffff8107df97>] atomic_notifier_call_chain+0x67/0x100
[ 9.218637]
[ 9.218644] [<ffffffff810e3014>] oom_score_notify_update+0x24/0x40
[ 9.224726]
[ 9.224734] [<ffffffff811a7c3d>] __set_oom_adj+0x15d/0x4a0
[ 9.226560]
[ 9.226563] [<ffffffff811a803d>] oom_score_adj_write+0xbd/0xd0
[ 9.228466]
[ 9.228471] [<ffffffff81149d33>] __vfs_write+0x23/0x120
[ 9.231499]
[ 9.231503] [<ffffffff8114b8a4>] vfs_write+0xc4/0x1c0
[ 9.237215]
[ 9.237221] [<ffffffff8114ba84>] SyS_write+0x44/0xa0
[ 9.238895]
[ 9.238900] [<ffffffff815116fd>] entry_SYSCALL_64_fastpath+0x1f/0xc1
[ 9.241805] irq event stamp: 41246
[ 9.244701] hardirqs last enabled at (41246): [<ffffffff81112a4b>] free_hot_cold_page+0x1cb/0x2e0
[ 9.247554] hardirqs last disabled at (41245): [<ffffffff811129ae>] free_hot_cold_page+0x12e/0x2e0
[ 9.251752] softirqs last enabled at (41088): [<ffffffff81060c6a>] __do_softirq+0x20a/0x270
[ 9.256594] softirqs last disabled at (41093): [<ffffffff81060cef>] run_ksoftirqd+0x1f/0x70
[ 9.258397]
[ 9.258397] other info that might help us debug this:
[ 9.261476] Possible unsafe locking scenario:
[ 9.261476]
[ 9.264234] CPU0
[ 9.267364] ----
[ 9.267992] lock(lmk_task_lock);
[ 9.268899] <Interrupt>
[ 9.269565] lock(lmk_task_lock);
[ 9.272459]
[ 9.272459] *** DEADLOCK ***
[ 9.272459]
[ 9.273949] 2 locks held by ksoftirqd/0/6:
[ 9.276583] #0: (rcu_callback){......}, at: [<ffffffff810abfe9>] rcu_process_callbacks+0x269/0x620
[ 9.280664] #1: (rcu_read_lock){......}, at: [<ffffffff8107df30>] atomic_notifier_call_chain+0x0/0x100
[ 9.283754]
[ 9.283754] stack backtrace:
[ 9.287175] CPU: 0 PID: 6 Comm: ksoftirqd/0 Not tainted 4.10.0-rc7-00639-gc3263ba #2
[ 9.289626] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 9.294629] Call Trace:
[ 9.296338] dump_stack+0x19/0x26
[ 9.297172] print_usage_bug+0x1df/0x1f0
[ 9.300938] mark_lock+0x5be/0x650
[ 9.301788] ? print_shortest_lock_dependencies+0x1a0/0x1a0
[ 9.303269] __lock_acquire+0x517/0x1760
[ 9.307267] ? kvm_clock_read+0x22/0x40
[ 9.308326] ? kvm_sched_clock_read+0x9/0x20
[ 9.309521] ? kvm_clock_read+0x22/0x40
[ 9.312740] ? kvm_sched_clock_read+0x9/0x20
[ 9.313959] lock_acquire+0x8f/0xe0
[ 9.315280] ? lmk_oom_score_notifier+0x64/0x150
[ 9.318345] _raw_spin_lock+0x3c/0x80
[ 9.319269] ? lmk_oom_score_notifier+0x64/0x150
[ 9.322357] lmk_oom_score_notifier+0x64/0x150
[ 9.323474] notifier_call_chain+0x34/0xa0
[ 9.327487] ? will_become_orphaned_pgrp+0x90/0x90
[ 9.328755] atomic_notifier_call_chain+0x67/0x100
[ 9.330050] ? notifier_call_chain+0xa0/0xa0
[ 9.333014] oom_score_notify_free+0x21/0x40
[ 9.334183] ? kmem_cache_free+0x18/0x40
[ 9.335978] __put_task_struct+0x57/0x170
[ 9.341088] delayed_put_task_struct+0x29/0x30
[ 9.342256] rcu_process_callbacks+0x2d0/0x620
[ 9.343371] ? rcu_process_callbacks+0x269/0x620
[ 9.344565] __do_softirq+0x12a/0x270
[ 9.346733] ? smpboot_thread_fn+0x23/0x250
[ 9.348353] run_ksoftirqd+0x1f/0x70
[ 9.351651] smpboot_thread_fn+0x16a/0x250
[ 9.352724] kthread+0x102/0x140
[ 9.353541] ? sort_range+0x20/0x20
[ 9.356468] ? kthread_create_on_node+0x40/0x40
[ 9.357650] ret_from_fork+0x31/0x40
[ 9.419370] random: trinity: uninitialized urandom read (4 bytes read)
mountall: Event failed
[ 9.462308] random: mountall: uninitialized urandom read (12 bytes read)
[ 9.519336] init: Failed to create pty - disabling logging for job
[ 9.529057] init: Temporary process spawn error: No such file or directory
git bisect start 804340e99508771d2c3709a1605ca0d7aa7ef761 7089db84e356562f8ba737c29e472cc42d530dbc --
git bisect bad 0d2799238644a776f5bfcdb060e361ed56a36cd6 # 23:06 0- 16 Merge 'renesas/devel' into devel-hourly-2017021805
git bisect good 157f37653a4382f7eeddb3ea6d460af714fb50a8 # 23:18 65+ 1 Merge 'linux-review/Geert-Uytterhoeven/ARM-PM-Drop-useless-checks-for-PM_SUSPEND_STANDBY/20170218-025420' into devel-hourly-2017021805
git bisect good 1d4f149c684d839094ccadab501860440200d98a # 23:46 63+ 0 Merge 'linux-review/Olav-Haugan/staging-speakup-coding-style-Simplify-comparisons-to-NULL/20170217-131253' into devel-hourly-2017021805
git bisect bad cf14a82cebeec14fb05b5fa844f10e22964d658a # 23:58 0- 2 Merge 'linux-review/thor-thayer-linux-intel-com/mfd-altr-a10sr-Add-Arria10-SR-sysfs-attributes/20170215-022501' into devel-hourly-2017021805
git bisect bad 644e51d644f6c446930b4a3f6dbc664dd27776c6 # 00:11 0- 6 Merge 'linux-review/Colin-King/usb-misc-usbtest-remove-redundant-check-on-retval-0/20170213-024141' into devel-hourly-2017021805
git bisect good 54a136f5b3b9a36eb5c717644d3e97fd69a030b8 # 00:25 64+ 1 Merge 'linux-review/Bjorn-Andersson/arm64-dts-qcom-pm8994-Add-rtc-node/20170218-020240' into devel-hourly-2017021805
git bisect good e79a5f53ec94ec08e7b7997150ef85d4b516c41b # 00:45 63+ 0 Merge 'linux-review/Paolo-Bonzini/KVM-change-gfn-hva-cache-to-use-per-VCPU-memslots/20170216-065425' into devel-hourly-2017021805
git bisect good 9382124d4146803e057e7dbe8d92a73eabb0cf14 # 01:09 63+ 0 Merge 'vfio/next' into devel-hourly-2017021805
git bisect bad 108f1e75acb82a913bec494f26eec68d497098a3 # 01:38 0- 5 Merge 'linux-review/Alban/MIPS-Allow-compressed-images-to-be-loaded-at-any-address/20170214-053759' into devel-hourly-2017021805
git bisect bad 11bc53d63ef26e59ce1c7c8ca88a4b7f959b878d # 01:54 0- 1 Merge 'linux-review/peter-enderborg-sonymobile-com/android-Collect-statistics-from-lowmemorykiller/20170215-004327' into devel-hourly-2017021805
git bisect good 0174c40bf153def3ac7b287f000a885b15048a38 # 02:16 61+ 0 oom: Add notification for oom_score_adj
git bisect bad c3263ba15e872666094c18a1d882597bfe1ce1c1 # 02:31 0- 15 mm: Remove RCU and tasklocks from lmk
# first bad commit: [c3263ba15e872666094c18a1d882597bfe1ce1c1] mm: Remove RCU and tasklocks from lmk
git bisect good 0174c40bf153def3ac7b287f000a885b15048a38 # 02:43 189+ 0 oom: Add notification for oom_score_adj
# extra tests with CONFIG_DEBUG_INFO_REDUCED
git bisect bad c3263ba15e872666094c18a1d882597bfe1ce1c1 # 03:16 0- 7 mm: Remove RCU and tasklocks from lmk
# extra tests on HEAD of linux-devel/devel-hourly-2017021805
git bisect bad 804340e99508771d2c3709a1605ca0d7aa7ef761 # 03:16 0- 23 0day head guard for 'devel-hourly-2017021805'
# extra tests on tree/branch linux-review/peter-enderborg-sonymobile-com/android-Collect-statistics-from-lowmemorykiller/20170215-004327
git bisect bad c3263ba15e872666094c18a1d882597bfe1ce1c1 # 03:23 0- 68 mm: Remove RCU and tasklocks from lmk
# extra tests with first bad commit reverted
git bisect good 1f3fd50274732605285e1de35c03b552107df194 # 16:21 187+ 1 Revert "mm: Remove RCU and tasklocks from lmk"
# extra tests on tree/branch linus/master
git bisect good 00ea1ceebe0d9f2dc1cc2b7bd575a00100c27869 # 05:14 183+ 4 ipv6: release dst on error in ip6_dst_lookup_tail
# extra tests on tree/branch linux-next/master
git bisect good 4ce4a759a3e221b5265ebd03c2f8888b69a7cf3e # 17:24 183+ 17 Add linux-next specific files for 20170217
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
4 years
- 1
- 0
[clear_page] 0ad07c8104 BUG: unable to handle kernel NULL pointer dereference at 0000000000000040
by Fengguang Wu
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
https://github.com/0day-ci/linux Borislav-Petkov/x86-Optimize-clear_page/20170210-053052
commit 0ad07c8104eb5c12dfcb86581c1cc657183496cc
Author: Borislav Petkov <bp(a)suse.de>
AuthorDate: Thu Feb 9 20:51:25 2017 +0100
Commit: 0day robot <fengguang.wu(a)intel.com>
CommitDate: Fri Feb 10 05:30:58 2017 +0800
x86: Optimize clear_page()
Currently, we CALL clear_page() which then JMPs to the proper function
chosen by the alternatives.
What we should do instead is CALL the proper function directly. (This
was something Ingo suggested a while ago). So let's do that.
Measuring our favourite kernel build workload shows that there are no
significant changes in performance.
...
Signed-off-by: Borislav Petkov <bp(a)suse.de>
+------------------------------------------+------------+------------+------------+
| | 10b9dd5686 | 0ad07c8104 | 648de4be23 |
+------------------------------------------+------------+------------+------------+
| boot_successes | 66 | 0 | 0 |
| boot_failures | 0 | 26 | 17 |
| BUG:unable_to_handle_kernel | 0 | 26 | 17 |
| Oops | 0 | 26 | 17 |
| RIP:prep_new_page | 0 | 26 | |
| calltrace:netlink_proto_init | 0 | 26 | |
| Kernel_panic-not_syncing:Fatal_exception | 0 | 26 | 17 |
+------------------------------------------+------------+------------+------------+
[ 0.665715] xor: using function: prefetch64-sse (14670.000 MB/sec)
[ 0.667274] prandom: seed boundary self test passed
[ 0.669099] prandom: 100 self tests passed
[ 0.673854] BUG: unable to handle kernel NULL pointer dereference at 0000000000000040
[ 0.675772] IP: [<ffffffff8115be9a>] prep_new_page+0x14a/0x270
[ 0.681170] PGD 0
[ 0.681639]
[ 0.682043] Oops: 0000 [#1] PREEMPT
[ 0.682875] CPU: 0 PID: 1 Comm: swapper Not tainted 4.9.0-rc6-00134-g0ad07c8 #1
[ 0.684716] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 0.690535] task: ffff8800000636c0 task.stack: ffffc90000008000
[ 0.691962] RIP: 0010:[<ffffffff8115be9a>] [<ffffffff8115be9a>] prep_new_page+0x14a/0x270
[ 0.697990] RSP: 0000:ffffc9000000b9b8 EFLAGS: 00010202
[ 0.699265] RAX: 0000000000000040 RBX: 0000000000000004 RCX: 0000000000000001
[ 0.701046] RDX: ffff8800000636c0 RSI: 0000000000000000 RDI: ffff880000161000
[ 0.706074] RBP: ffffc9000000ba58 R08: ffff8800000636c0 R09: ffff880000000000
[ 0.707771] R10: ffff88001ffd0000 R11: 0000000000000000 R12: ffff88001d921800
[ 0.713599] R13: 0000000000000002 R14: 000000000240c0c0 R15: 0000000000000001
[ 0.715285] FS: 0000000000000000(0000) GS:ffffffff82034000(0000) knlGS:0000000000000000
[ 0.717232] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 0.718611] CR2: 0000000000000040 CR3: 0000000002010000 CR4: 00000000000006b0
[ 0.720361] Stack:
[ 0.720908] ffffffff82138d80 0000000000000000 ffffc9000000ba38 0000000000000206
[ 0.722748] ffff88001d921800 ffffffff00000000 dead000000000100 0000000000000206
[ 0.724654] ffff880000000000 0000000000000046 0000000000000001 ffffffff82138d80
[ 0.726502] Call Trace:
[ 0.727118] [<ffffffff8115c3f5>] get_page_from_freelist+0x435/0x7f0
[ 0.728744] [<ffffffff81033e6c>] ? T.555+0x5c/0x70
[ 0.729944] [<ffffffff81033e6c>] ? T.555+0x5c/0x70
[ 0.731105] [<ffffffff81882085>] ? ret_from_fork+0x25/0x30
[ 0.732450] [<ffffffff81033eb6>] ? unwind_next_frame+0x36/0x50
[ 0.733880] [<ffffffff81024204>] ? __save_stack_trace+0x84/0x150
[ 0.735328] [<ffffffff8115ca35>] __alloc_pages_nodemask+0x1a5/0xd50
[ 0.736933] [<ffffffff81024375>] ? save_stack_trace+0x15/0x20
[ 0.738322] [<ffffffff810edb6d>] ? __lock_acquire+0x2fd/0x4b0
[ 0.739733] [<ffffffff8187d529>] ? mutex_unlock+0x9/0x10
[ 0.741075] [<ffffffff8187d3db>] ? __mutex_unlock_slowpath+0xdb/0x180
[ 0.742632] [<ffffffff811776ac>] kmalloc_order+0x1c/0x70
[ 0.743940] [<ffffffff82191c4a>] netlink_proto_init+0x39/0x18a
[ 0.745356] [<ffffffff811e9644>] ? kern_mount_data+0x14/0x30
[ 0.746754] [<ffffffff82191c11>] ? netlink_net_init+0x2e/0x2e
[ 0.748139] [<ffffffff821469af>] do_one_initcall+0x86/0x11f
[ 0.749542] [<ffffffff82146be2>] do_basic_setup+0xa8/0xcb
[ 0.753869] [<ffffffff82146d84>] ? kernel_init_freeable+0x17f/0x17f
[ 0.755410] [<ffffffff82146d04>] kernel_init_freeable+0xff/0x17f
[ 0.756899] [<ffffffff818762c9>] ? kernel_init+0x9/0x100
[ 0.758189] [<ffffffff818762c0>] ? rest_init+0xc0/0xc0
[ 0.759447] [<ffffffff818762c0>] ? rest_init+0xc0/0xc0
[ 0.760732] [<ffffffff818762c9>] kernel_init+0x9/0x100
[ 0.761949] [<ffffffff81882085>] ret_from_fork+0x25/0x30
[ 0.763272] Code: db 7e be 4c 8b 04 25 00 30 03 82 4c 89 e0 31 c9 49 b9 00 00 00 00 00 88 ff ff 4c 89 c2 ff 05 82 71 ed 00 41 83 80 e8 0e 00 00 01 <48> 8b 30 48 c1 ee 2d 48 89 f7 48 c1 ef 07 4c 8b 14 fd a0 d3 c1
[ 0.769249] RIP [<ffffffff8115be9a>] prep_new_page+0x14a/0x270
[ 0.770683] RSP <ffffc9000000b9b8>
[ 0.771527] CR2: 0000000000000040
[ 0.772317] ---[ end trace e69a76b01b566199 ]---
[ 0.773471] Kernel panic - not syncing: Fatal exception
git bisect start 648de4be2364cf3a02404e043d76926e43e561e8 d5adbfcd5f7bcc6fa58a41c5c5ada0e5c826ce2c --
git bisect good f08b53c27c5d6c8b83792ed94a8e9694ef9f3b67 # 01:13 21+ 0 Merge 'linux-review/Thomas-Garnier/syscalls-Restore-address-limit-after-a-syscall/20170210-065105' into devel-spot-201702101332
git bisect bad 09edec8d0905916acd6206dc0411d1da27f203d9 # 01:28 0- 4 Merge 'bp/for-next' into devel-spot-201702101332
git bisect bad 013fb7dbee2050def11e2180abcb6958d0a5867c # 01:35 0- 2 Merge 'robh/of-graph-helpers' into devel-spot-201702101332
git bisect good 9c7fb1ac8023b3c30daca6890b85605d924da1ad # 01:46 21+ 0 Merge 'linux-review/Colin-King/Smack-fix-a-dereference-before-null-check-on-sock-sk/20170210-055729' into devel-spot-201702101332
git bisect bad 6ef54f0002c76068d65d01a3b51ce07b6f347235 # 01:58 0- 3 Merge 'linux-review/Borislav-Petkov/x86-Optimize-clear_page/20170210-053052' into devel-spot-201702101332
git bisect good 11dfb62ce4afb2111de9cfa25b8566a093c40975 # 02:08 21+ 1 Merge 'linux-review/Ben-Gardner/eeprom-at24-use-device_property_-functions-instead-of-of_get_property/20170210-060909' into devel-spot-201702101332
git bisect good 79a6fed9048002031fa4f9050e2ceabc0f746ae6 # 02:40 22+ 0 Merge 'linux-review/Avraham-Shukron/staging-omap4iss-fix-multiline-comment-style/20170210-050947' into devel-spot-201702101332
git bisect bad 0ad07c8104eb5c12dfcb86581c1cc657183496cc # 03:00 0- 3 x86: Optimize clear_page()
# first bad commit: [0ad07c8104eb5c12dfcb86581c1cc657183496cc] x86: Optimize clear_page()
git bisect good 10b9dd56860e93f11cd352e8c75a33357b80b70b # 03:17 66+ 0 Merge tag 'nfs-for-4.9-4' of git://git.linux-nfs.org/projects/anna/linux-nfs
# extra tests with CONFIG_DEBUG_INFO_REDUCED
git bisect bad 0ad07c8104eb5c12dfcb86581c1cc657183496cc # 03:31 0- 14 x86: Optimize clear_page()
# extra tests on HEAD of linux-devel/devel-spot-201702101332
git bisect bad 648de4be2364cf3a02404e043d76926e43e561e8 # 03:31 0- 17 0day head guard for 'devel-spot-201702101332'
# extra tests on tree/branch linux-review/Borislav-Petkov/x86-Optimize-clear_page/20170210-053052
git bisect bad 0ad07c8104eb5c12dfcb86581c1cc657183496cc # 03:38 0- 26 x86: Optimize clear_page()
# extra tests with first bad commit reverted
git bisect good d9d04c9a587a9963e6df6b6b6622cd0eaa0a6d2a # 03:56 61+ 0 Revert "x86: Optimize clear_page()"
# extra tests on tree/branch linus/master
git bisect good 2fe1e8a7b2f4dcac3fcb07ff06b0ae7396201fd6 # 04:09 65+ 0 Merge tag 'powerpc-4.10-5' of git://git.kernel.org/pub/scm/linux/kernel/git/powerpc/linux
# extra tests on tree/branch linux-next/master
git bisect good 4ce4a759a3e221b5265ebd03c2f8888b69a7cf3e # 04:41 61+ 0 Add linux-next specific files for 20170217
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
4 years
- 2
- 8
[sched/core] cb42c9a3eb WARNING: CPU: 0 PID: 40 at kernel/sched/sched.h:804 rq_clock_task
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/next/linux-next.git master
commit cb42c9a3ebbbb23448c3f9a25417fae6309b1a92
Author: Matt Fleming <matt(a)codeblueprint.co.uk>
AuthorDate: Wed Sep 21 14:38:13 2016 +0100
Commit: Ingo Molnar <mingo(a)kernel.org>
CommitDate: Sat Jan 14 11:29:35 2017 +0100
sched/core: Add debugging code to catch missing update_rq_clock() calls
There's no diagnostic checks for figuring out when we've accidentally
missed update_rq_clock() calls. Let's add some by piggybacking on the
rq_*pin_lock() wrappers.
The idea behind the diagnostic checks is that upon pining rq lock the
rq clock should be updated, via update_rq_clock(), before anybody
reads the clock with rq_clock() or rq_clock_task().
The exception to this rule is when updates have explicitly been
disabled with the rq_clock_skip_update() optimisation.
There are some functions that only unpin the rq lock in order to grab
some other lock and avoid deadlock. In that case we don't need to
update the clock again and the previous diagnostic state can be
carried over in rq_repin_lock() by saving the state in the rq_flags
context.
Since this patch adds a new clock update flag and some already exist
in rq::clock_skip_update, that field has now been renamed. An attempt
has been made to keep the flag manipulation code small and fast since
it's used in the heart of the __schedule() fast path.
For the !CONFIG_SCHED_DEBUG case the only object code change (other
than addresses) is the following change to reset RQCF_ACT_SKIP inside
of __schedule(),
- c7 83 38 09 00 00 00 movl $0x0,0x938(%rbx)
- 00 00 00
+ 83 a3 38 09 00 00 fc andl $0xfffffffc,0x938(%rbx)
Suggested-by: Peter Zijlstra <peterz(a)infradead.org>
Signed-off-by: Matt Fleming <matt(a)codeblueprint.co.uk>
Signed-off-by: Peter Zijlstra (Intel) <peterz(a)infradead.org>
Cc: Byungchul Park <byungchul.park(a)lge.com>
Cc: Frederic Weisbecker <fweisbec(a)gmail.com>
Cc: Jan Kara <jack(a)suse.cz>
Cc: Linus Torvalds <torvalds(a)linux-foundation.org>
Cc: Luca Abeni <luca.abeni(a)unitn.it>
Cc: Mel Gorman <mgorman(a)techsingularity.net>
Cc: Mike Galbraith <efault(a)gmx.de>
Cc: Mike Galbraith <umgwanakikbuti(a)gmail.com>
Cc: Petr Mladek <pmladek(a)suse.com>
Cc: Rik van Riel <riel(a)redhat.com>
Cc: Sergey Senozhatsky <sergey.senozhatsky.work(a)gmail.com>
Cc: Thomas Gleixner <tglx(a)linutronix.de>
Cc: Wanpeng Li <wanpeng.li(a)hotmail.com>
Cc: Yuyang Du <yuyang.du(a)intel.com>
Link: http://lkml.kernel.org/r/20160921133813.31976-8-matt@codeblueprint.co.uk
Signed-off-by: Ingo Molnar <mingo(a)kernel.org>
+--------------------------------------------------------------+------------+------------+
| | 2fb8d36787 | cb42c9a3eb |
+--------------------------------------------------------------+------------+------------+
| boot_successes | 1219 | 170 |
| boot_failures | 5 | 144 |
| WARNING:at_arch/x86/include/asm/fpu/internal.h:#fpu__restore | 3 | |
| BUG:workqueue_lockup-pool | 2 | |
| WARNING:at_kernel/sched/sched.h:#rq_clock_task | 0 | 143 |
| INFO:possible_circular_locking_dependency_detected | 0 | 100 |
| calltrace:disk_events_workfn | 0 | 48 |
| calltrace:torture_shuffle | 0 | 100 |
| calltrace:_do_fork | 0 | 100 |
| calltrace:workqueue_init | 0 | 100 |
| calltrace:ret_from_fork | 0 | 78 |
| EIP:ide_output_data | 0 | 78 |
| calltrace:blk_delay_work | 0 | 30 |
| EIP:native_safe_halt | 0 | 19 |
| EIP:__do_softirq | 0 | 8 |
| calltrace:SyS_fstatat64 | 0 | 3 |
| EIP:_raw_spin_unlock_irq | 0 | 1 |
| EIP:check_poison_obj | 0 | 2 |
| EIP:strcmp | 0 | 1 |
| invoked_oom-killer:gfp_mask=0x | 0 | 2 |
| Mem-Info | 0 | 2 |
+--------------------------------------------------------------+------------+------------+
[ 83.578917] rcu-torture: rtc: c5a6c780 ver: 1 tfle: 0 rta: 1 rtaf: 0 rtf: 0 rtmbe: 0 rtbe: 0 rtbke: 0 rtbre: 0 rtbf: 0 rtb: 0 nt: 1 barrier: 0/0:0 cbflood: 1
[ 83.584146] rcu-torture: Reader Pipe: 2 0 0 0 0 0 0 0 0 0 0
[ 83.586253] rcu-torture: Reader Batch: 1 1 0 0 0 0 0 0 0 0 0
[ 83.587877] rcu-torture: Free-Block Circulation: 0 0 0 0 0 0 0 0 0 0 0
[ 83.791548] ------------[ cut here ]------------
[ 83.793245] WARNING: CPU: 0 PID: 40 at kernel/sched/sched.h:804 rq_clock_task+0x126/0x290
[ 83.796441] rq->clock_update_flags < RQCF_ACT_SKIP
[ 83.796454] CPU: 0 PID: 40 Comm: torture_shuffle Not tainted 4.10.0-rc3-00256-gcb42c9a #3
[ 83.800931] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 83.815146] Call Trace:
[ 83.816232] dump_stack+0x2c6/0x39a
[ 83.817461] __warn+0x23d/0x280
[ 83.818643] ? rq_clock_task+0x126/0x290
[ 83.819947] ? rq_clock_task+0x126/0x290
[ 83.821244] warn_slowpath_fmt+0x57/0x70
[ 83.831558] rq_clock_task+0x126/0x290
[ 83.832837] set_next_entity+0x90/0xc0
[ 83.834107] set_curr_task_fair+0x48/0x60
[ 83.835414] do_set_cpus_allowed+0x26f/0x470
[ 83.836768] __set_cpus_allowed_ptr+0x1e8/0x510
[ 83.838161] set_cpus_allowed_ptr+0x1d/0x30
[ 83.839498] torture_shuffle+0x21b/0x610
[ 83.858854] kthread+0x224/0x240
[ 83.860043] ? torture_shutdown+0x620/0x620
[ 83.861375] ? __kthread_bind_mask+0xf0/0xf0
[ 83.862748] ret_from_fork+0x19/0x30
[ 83.864065] ---[ end trace 6227f0c8323ad65a ]---
[ 86.016087] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11
git bisect start 7ba5052770189d990301ffc7d970616dca3e7ddd 7089db84e356562f8ba737c29e472cc42d530dbc --
git bisect bad 273df238275de49611ba1e8716f31907b87a78f7 # 23:47 2- 6 Merge 'wsa/renesas/topic/sdhi-dma-sync-v2' into devel-spot-201702181304
git bisect good b3ce255771424298b466f7b1a1c5988534205a8b # 00:58 306+ 2 Merge 'linux-review/Lepton-Wu/Make-mtdblock-can-handle-partition-bigger-than-4G/20170218-080401' into devel-spot-201702181304
git bisect bad 5bfd5a19aad7f0dbe19d7df4faa3c465de5c1322 # 01:27 6- 2 Merge 'linux-review/David-Daney/of_mdio-Add-broadcom-bcm5241-to-the-whitelist/20170218-050724' into devel-spot-201702181304
git bisect bad c1f80db5c3d68d6740ba755383ea35c5bf460a38 # 01:46 0- 1 Merge 'linux-review/Steven-Rostedt-VMware/sched-rt-Add-comments-describing-the-RT-IPI-pull-method/20170218-072124' into devel-spot-201702181304
git bisect good fc4e0527223c01107d9eed1e54fb9e79474531b8 # 03:31 307+ 3 Merge 'linux-review/Colin-King/ext4-fix-spelling-mistake-alligned-aligned/20170218-073533' into devel-spot-201702181304
git bisect good 2d386e93a226eb2e71ca775fefa4cd3a42bc3a08 # 04:37 300+ 1 Merge 'block/for-4.11/block' into devel-spot-201702181304
git bisect good e77acbd376baaeddcaa8bfd4a0acbd01c01eafb0 # 05:25 302+ 2 Merge 'pci/next' into devel-spot-201702181304
git bisect bad 07e5f5e353aaa61696c8353d87050994a0c4648a # 05:41 2- 3 time: Introduce jiffies64_to_nsecs()
git bisect bad 9881b024b7d7671f6a014091bc96506b89081802 # 06:01 1- 3 sched/clock: Delay switching sched_clock to stable
git bisect good c8d7dabf8f91fadd265e6eb87afb201d14ea299b # 08:36 301+ 3 sched/cputime: Rename vtime_account_user() to vtime_flush()
git bisect good 80f5c1b84baa8180c3c27b7e227429712cd967b6 # 09:52 304+ 3 sched/core: Add missing update_rq_clock() in detach_task_cfs_rq()
git bisect bad cb42c9a3ebbbb23448c3f9a25417fae6309b1a92 # 11:20 1- 2 sched/core: Add debugging code to catch missing update_rq_clock() calls
git bisect good 2fb8d36787affe26f3536c3d8ec094995a48037d # 12:59 302+ 1 sched/core: Add missing update_rq_clock() call in set_user_nice()
# first bad commit: [cb42c9a3ebbbb23448c3f9a25417fae6309b1a92] sched/core: Add debugging code to catch missing update_rq_clock() calls
git bisect good 2fb8d36787affe26f3536c3d8ec094995a48037d # 16:20 918+ 5 sched/core: Add missing update_rq_clock() call in set_user_nice()
# extra tests with CONFIG_DEBUG_INFO_REDUCED
git bisect bad cb42c9a3ebbbb23448c3f9a25417fae6309b1a92 # 16:41 24- 5 sched/core: Add debugging code to catch missing update_rq_clock() calls
# extra tests on HEAD of linux-devel/devel-spot-201702181304
git bisect bad 7ba5052770189d990301ffc7d970616dca3e7ddd # 16:41 0- 3 0day head guard for 'devel-spot-201702181304'
# extra tests on tree/branch linux-next/master
git bisect good 4ce4a759a3e221b5265ebd03c2f8888b69a7cf3e # 18:56 910+ 914 Add linux-next specific files for 20170217
# extra tests on tree/branch linus/master
git bisect good 00ea1ceebe0d9f2dc1cc2b7bd575a00100c27869 # 21:27 903+ 5 ipv6: release dst on error in ip6_dst_lookup_tail
# extra tests on tree/branch linux-next/master
git bisect good 4ce4a759a3e221b5265ebd03c2f8888b69a7cf3e # 21:57 910+ 1824 Add linux-next specific files for 20170217
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
4 years
- 2
- 1
[hrtimer] 336a9cde10: WARNING:at_kernel/time/hrtimer.c:#hrtimer_init
by kernel test robot
FYI, we noticed the following commit:
commit: 336a9cde10d641e70bac67d90ae91b3190c3edca ("hrtimer: Catch invalid clockids again")
https://git.kernel.org/cgit/linux/kernel/git/tip/tip.git timers/core
in testcase: boot
on test machine: qemu-system-x86_64 -enable-kvm -cpu host -smp 2 -m 4G
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
+------------------------------------------------+------------+------------+
| | dba9a0babd | 336a9cde10 |
+------------------------------------------------+------------+------------+
| boot_successes | 4 | 0 |
| boot_failures | 1 | 12 |
| invoked_oom-killer:gfp_mask=0x | 1 | |
| Mem-Info | 1 | |
| WARNING:at_kernel/time/hrtimer.c:#hrtimer_init | 0 | 12 |
+------------------------------------------------+------------+------------+
[ 19.886448] WARNING: CPU: 0 PID: 1 at kernel/time/hrtimer.c:1090 hrtimer_init+0x11f/0x199
[ 19.889938] Invalid clockid 4. Using MONOTONIC
[ 19.891512] Modules linked in:
[ 19.892913] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 4.10.0-rc3-00262-g336a9cd #19
[ 19.895739] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 19.899404] Call Trace:
[ 19.900516] dump_stack+0x82/0xb8
[ 19.901298] __warn+0xc2/0xdd
[ 19.902081] warn_slowpath_fmt+0x4b/0x53
[ 19.902948] ? lock_is_held_type+0x4b/0x54
[ 19.903844] hrtimer_init+0x11f/0x199
[ 19.904737] ? mac80211_hwsim_get_tsf+0x1d/0x1d
[ 19.905698] tasklet_hrtimer_init+0x1b/0x4f
[ 19.906675] mac80211_hwsim_new_radio+0x7fe/0x916
[ 19.907659] ? set_debug_rodata+0x12/0x12
[ 19.908607] init_mac80211_hwsim+0x138/0x29f
[ 19.909519] ? rndis_wlan_driver_init+0x1b/0x1b
[ 19.910557] do_one_initcall+0x90/0x142
[ 19.911416] ? do_one_initcall+0x136/0x142
[ 19.912380] ? set_debug_rodata+0x12/0x12
[ 19.913248] kernel_init_freeable+0x1cb/0x258
[ 19.914246] ? rest_init+0x13b/0x13b
[ 19.915066] kernel_init+0xe/0xf5
[ 19.916056] ret_from_fork+0x2a/0x40
[ 19.917378] ---[ end trace 55127f051d2c3115 ]---
To reproduce:
git clone git://git.kernel.org/pub/scm/linux/kernel/git/wfg/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email
Thanks,
Kernel Test Robot
4 years
- 2
- 1
[auxdisplay: ht16k33] cac513f1a9: BUG: KASAN: global-out-of-bounds in __of_match_node at addr ffffffff82ea8cf8
by kernel test robot
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
https://git.kernel.org/pub/scm/linux/kernel/git/next/linux-next.git master
commit cac513f1a9f7ace21d27665435f8fe7e39050396
Author: Dmitry Torokhov <dmitry.torokhov(a)gmail.com>
AuthorDate: Thu Feb 9 10:15:52 2017 -0800
Commit: Greg Kroah-Hartman <gregkh(a)linuxfoundation.org>
CommitDate: Fri Feb 10 15:57:28 2017 +0100
auxdisplay: ht16k33: rework input device initialization
This patch fixes following issues in input device (keypad) handling:
- requesting IRQ before allocating and initializing parts of the device
that can be referenced from IRQ handler is racy, even if we try to
disable interrupt after requesting it. Let's move allocations around
so that everything is ready by the time we request IRQ.
- using threaded interrupt handler to schedule a work item it sub-optimal.
Disabling and then re-enabling interrupts in work item and in open/close
methods is prone to races and exactly the reason theraded interrupts were
introduced. Let's use the infrastructure properly and keep scanning the
matrix array in IRQ thread, stopping when there are no keys, or when told
to do so.
Signed-off-by: Dmitry Torokhov <dmitry.torokhov(a)gmail.com>
Tested-by: Robin van der Gracht <robin(a)protonic.nl>
Signed-off-by: Greg Kroah-Hartman <gregkh(a)linuxfoundation.org>
cac513f1a9 auxdisplay: ht16k33: rework input device initialization
+--------------------------------------------------------------------+----+
| | |
+--------------------------------------------------------------------+----+
| boot_successes | 0 |
| boot_failures | 26 |
| BUG:KASAN:global-out-of-bounds_in__of_match_node_at_addr | 26 |
| BUG:KASAN:global-out-of-bounds_in__of_device_is_compatible_at_addr | 26 |
+--------------------------------------------------------------------+----+
[ 16.004589] OF: /testcase-data/phandle-tests/consumer-a: arguments longer than property
[ 16.008292] irq: no irq domain found for /testcase-data/interrupts/intc0 !
[ 16.008292] irq: no irq domain found for /testcase-data/interrupts/intc0 !
[ 16.011090] ==================================================================
[ 16.011090] ==================================================================
[ 16.014687] BUG: KASAN: global-out-of-bounds in __of_match_node+0xf9/0x100 at addr ffffffff82ea8cf8
[ 16.014687] BUG: KASAN: global-out-of-bounds in __of_match_node+0xf9/0x100 at addr ffffffff82ea8cf8
[ 16.018072] Read of size 1 by task swapper/1
[ 16.018072] Read of size 1 by task swapper/1
[ 16.019363] Address belongs to variable img_ascii_lcd_matches+0x258/0x8c0
[ 16.019363] Address belongs to variable img_ascii_lcd_matches+0x258/0x8c0
[ 16.021741] CPU: 0 PID: 1 Comm: swapper Not tainted 4.10.0-rc7-00153-gcac513f #2
[ 16.021741] CPU: 0 PID: 1 Comm: swapper Not tainted 4.10.0-rc7-00153-gcac513f #2
[ 16.024296] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 16.024296] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 16.027579] Call Trace:
[ 16.027579] Call Trace:
[ 16.028433] dump_stack+0x19/0x29
[ 16.028433] dump_stack+0x19/0x29
[ 16.029555] kasan_report_error+0x4a8/0x4d0
[ 16.029555] kasan_report_error+0x4a8/0x4d0
[ 16.030752] ? save_stack+0xb1/0xd0
[ 16.030752] ? save_stack+0xb1/0xd0
[ 16.032046] __asan_report_load1_noabort+0x3d/0x40
[ 16.032046] __asan_report_load1_noabort+0x3d/0x40
[ 16.033507] ? __of_match_node+0xf9/0x100
[ 16.033507] ? __of_match_node+0xf9/0x100
[ 16.034773] __of_match_node+0xf9/0x100
[ 16.034773] __of_match_node+0xf9/0x100
[ 16.036266] of_match_node+0x29/0x50
[ 16.036266] of_match_node+0x29/0x50
[ 16.037363] of_match_device+0x43/0x60
[ 16.037363] of_match_device+0x43/0x60
[ 16.038487] ? _raw_spin_unlock+0x22/0x30
[ 16.038487] ? _raw_spin_unlock+0x22/0x30
[ 16.039884] platform_match+0xa4/0x280
[ 16.039884] platform_match+0xa4/0x280
[ 16.041094] __device_attach_driver+0xb5/0x260
[ 16.041094] __device_attach_driver+0xb5/0x260
[ 16.042516] ? __driver_attach+0x1c0/0x1c0
[ 16.042516] ? __driver_attach+0x1c0/0x1c0
[ 16.043950] bus_for_each_drv+0x112/0x1b0
[ 16.043950] bus_for_each_drv+0x112/0x1b0
[ 16.045221] ? subsys_find_device_by_id+0x300/0x300
[ 16.045221] ? subsys_find_device_by_id+0x300/0x300
[ 16.046684] ? wait_for_completion_killable_timeout+0x460/0x460
[ 16.046684] ? wait_for_completion_killable_timeout+0x460/0x460
[ 16.048799] __device_attach+0x18b/0x200
[ 16.048799] __device_attach+0x18b/0x200
[ 16.049978] ? device_bind_driver+0xb0/0xb0
[ 16.049978] ? device_bind_driver+0xb0/0xb0
[ 16.051041] ? kobject_uevent_env+0x22e/0xad0
[ 16.051041] ? kobject_uevent_env+0x22e/0xad0
[ 16.052314] ? klist_add_tail+0xef/0x150
[ 16.052314] ? klist_add_tail+0xef/0x150
[ 16.054010] device_initial_probe+0xe/0x10
[ 16.054010] device_initial_probe+0xe/0x10
[ 16.055861] bus_probe_device+0x1aa/0x250
[ 16.055861] bus_probe_device+0x1aa/0x250
[ 16.057567] device_add+0x7c7/0x1280
[ 16.057567] device_add+0x7c7/0x1280
[ 16.059070] ? dev_warn+0xe0/0xe0
[ 16.059070] ? dev_warn+0xe0/0xe0
[ 16.060586] of_device_add+0xad/0x110
[ 16.060586] of_device_add+0xad/0x110
[ 16.062148] of_platform_device_create_pdata+0x103/0x160
[ 16.062148] of_platform_device_create_pdata+0x103/0x160
[ 16.064439] of_platform_bus_create+0x22f/0x410
[ 16.064439] of_platform_bus_create+0x22f/0x410
[ 16.066384] ? of_platform_device_create_pdata+0x160/0x160
[ 16.066384] ? of_platform_device_create_pdata+0x160/0x160
[ 16.068856] of_platform_populate+0x39/0x90
[ 16.068856] of_platform_populate+0x39/0x90
[ 16.070659] of_platform_default_populate+0x16/0x20
[ 16.070659] of_platform_default_populate+0x16/0x20
[ 16.072817] of_unittest_platform_populate+0xa7/0x40e
[ 16.072817] of_unittest_platform_populate+0xa7/0x40e
[ 16.074992] ? of_irq_find_parent+0xc0/0xc0
[ 16.074992] ? of_irq_find_parent+0xc0/0xc0
[ 16.076809] ? of_unittest_check_node_linkage+0xd5/0xd5
[ 16.076809] ? of_unittest_check_node_linkage+0xd5/0xd5
[ 16.078972] of_unittest+0x24f4/0x259d
[ 16.078972] of_unittest+0x24f4/0x259d
[ 16.080296] ? of_unittest_check_tree_linkage+0xb2/0xb2
[ 16.080296] ? of_unittest_check_tree_linkage+0xb2/0xb2
[ 16.082204] ? vprintk_default+0x1a/0x20
[ 16.082204] ? vprintk_default+0x1a/0x20
[ 16.083327] ? printk+0x93/0xaf
[ 16.083327] ? printk+0x93/0xaf
[ 16.084515] ? kzalloc+0x10/0x10
[ 16.084515] ? kzalloc+0x10/0x10
[ 16.085676] ? edd_init+0x153/0x6a9
[ 16.085676] ? edd_init+0x153/0x6a9
[ 16.086854] ? esb_driver_init+0x1b/0x1b
[ 16.086854] ? esb_driver_init+0x1b/0x1b
[ 16.088198] ? of_unittest_check_tree_linkage+0xb2/0xb2
[ 16.088198] ? of_unittest_check_tree_linkage+0xb2/0xb2
[ 16.089932] do_one_initcall+0x11f/0x207
[ 16.089932] do_one_initcall+0x11f/0x207
[ 16.091050] ? start_kernel+0x56c/0x56c
[ 16.091050] ? start_kernel+0x56c/0x56c
[ 16.092478] ? parse_args+0x412/0x820
[ 16.092478] ? parse_args+0x412/0x820
[ 16.093650] ? __usermodehelper_set_disable_depth+0x3d/0x40
[ 16.093650] ? __usermodehelper_set_disable_depth+0x3d/0x40
[ 16.095302] kernel_init_freeable+0x3b2/0x43e
[ 16.095302] kernel_init_freeable+0x3b2/0x43e
[ 16.096884] ? rest_init+0xe0/0xe0
[ 16.096884] ? rest_init+0xe0/0xe0
[ 16.097905] kernel_init+0xe/0x110
[ 16.097905] kernel_init+0xe/0x110
[ 16.098932] ? rest_init+0xe0/0xe0
[ 16.098932] ? rest_init+0xe0/0xe0
[ 16.100229] ret_from_fork+0x2c/0x40
[ 16.100229] ret_from_fork+0x2c/0x40
[ 16.101284] Memory state around the buggy address:
[ 16.101284] Memory state around the buggy address:
[ 16.102705] ffffffff82ea8b80: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
[ 16.102705] ffffffff82ea8b80: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
[ 16.105304] ffffffff82ea8c00: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
git bisect start 1820955fd468ff3c37aae0653e546bf2517c705e 7089db84e356562f8ba737c29e472cc42d530dbc --
git bisect bad c1152191ee09d8d5fd59bc9d2578f7abb211354c # 01:06 0- 1 Merge 'khilman-linux-amlogic/for-next' into devel-hourly-2017021909
git bisect good 1be341f4313e168e1348b9305f89fd15a8837038 # 01:23 20+ 22 Merge 'linux-review/Shiva-Kerdel/Staging-ks7010-ks_-Use-the-BIT-macro-for-bitwise-checks/20170217-075323' into devel-hourly-2017021909
git bisect good 60a1bb893867306b1ac1fb80ebb0b155bd9c7043 # 01:38 22+ 22 Merge 'linux-review/Gustavo-A-R-Silva/usb-storage-add-missing-pre-increment-to-variable/20170215-154353' into devel-hourly-2017021909
git bisect good 4cd1042777431e4de2b7a01a8e6a32f4851bafbf # 02:04 22+ 22 Merge 'linux-review/yegorslists-googlemail-com/ARM-dts-AM35x-Add-hecc-node/20170217-215527' into devel-hourly-2017021909
git bisect bad 5cfd8d419497c1bc4e2c9ca61b436cfb78dd4a15 # 02:15 0- 17 Merge 'linux-review/Rameshwar-Prasad-Sahu/ata-xgene-Enable-NCQ-support-for-APM-X-Gene-SATA-controller-hardware-v1-1/20170214-205241' into devel-hourly-2017021909
git bisect good 4e8fa9d36472d17695157a70cd12e6d082385f32 # 02:25 21+ 21 Merge 'andersson-remoteproc/rpmsg-next' into devel-hourly-2017021909
git bisect bad 8cb0fbc3441f3641359c5c37d9850a889d22b2ce # 02:37 0- 5 Merge 'rdma/k.o/for-4.11' into devel-hourly-2017021909
git bisect good f3255cef5f132c70602f9f9a1be3af23682b17ec # 02:47 22+ 22 Merge 'linux-review/Ivan-Khoronzhuk/net-ethernet-ti-cpsw-correct-ale-dev-to-cpsw/20170216-020406' into devel-hourly-2017021909
git bisect good ccef6766d910b2700e463a3f299d02b2988f5606 # 03:04 22+ 22 Merge 'linux-review/Joao-Pinto/add-support-for-multiple-queues-channels-in-stmmac/20170216-194017' into devel-hourly-2017021909
git bisect bad d0892d5ba431fac2fdec8782af7c267f2dbbb9f8 # 03:15 0- 22 Merge 'char-misc/char-misc-next' into devel-hourly-2017021909
git bisect good 5883319ff94dce8497ba71b03f439db35a48baf8 # 03:29 22+ 22 Merge 'linux-review/Imran-Khan/soc-qcom-Add-SoC-info-driver/20170216-191952' into devel-hourly-2017021909
git bisect good 846569641069da86e0d097650ea2fd6565ee8cd8 # 03:42 22+ 43 Merge 'linux-review/Jeremy-Kerr/irq-clarify-logic-calculating-bogus-irqreturn_t-values/20170216-123007' into devel-hourly-2017021909
git bisect good eb67bc3ffd1796e198fc923da2ba15beb7965529 # 03:59 21+ 21 tools: firmware: add fallback cancelation testing
git bisect good 84a1ed0407d209beff4d9cb41120d0f69a89d4b8 # 04:15 21+ 21 misc: panel: Fix LCD_FLAG_F/LCD_FLAG_N exchange
git bisect bad 8fa8bea728c261551baed01ef230e1138f2944ce # 04:32 0- 22 auxdisplay: ht16k33: remove private workqueue
git bisect good dee863b571b0a76e9c549ee99e8782bb4bc6502b # 04:42 20+ 20 hv: export current Hyper-V clocksource
git bisect good f6c4391553573d592212e6624cfba5e2752cd5c8 # 05:00 22+ 22 vmbus: remove no longer used signal_policy
git bisect good 372b1e91343e657a7cc5e2e2bcecd5140ac28119 # 05:10 22+ 22 drivers: hv: Turn off write permission on the hypercall page
git bisect bad cac513f1a9f7ace21d27665435f8fe7e39050396 # 05:22 0- 24 auxdisplay: ht16k33: rework input device initialization
git bisect good bbd39d1e4ada551d0d7e7a39f97382fa24b5e7c0 # 05:33 22+ 47 auxdisplay: ht16k33: do not try to free fbdev
# first bad commit: [cac513f1a9f7ace21d27665435f8fe7e39050396] auxdisplay: ht16k33: rework input device initialization
git bisect good bbd39d1e4ada551d0d7e7a39f97382fa24b5e7c0 # 05:35 66+ 113 auxdisplay: ht16k33: do not try to free fbdev
# extra tests with CONFIG_DEBUG_INFO_REDUCED
git bisect bad cac513f1a9f7ace21d27665435f8fe7e39050396 # 05:47 0- 3 auxdisplay: ht16k33: rework input device initialization
# extra tests on HEAD of linux-devel/devel-hourly-2017021909
git bisect bad 1820955fd468ff3c37aae0653e546bf2517c705e # 05:47 0- 17 0day head guard for 'devel-hourly-2017021909'
# extra tests on tree/branch linux-next/master
git bisect bad 4ce4a759a3e221b5265ebd03c2f8888b69a7cf3e # 05:57 0- 13 Add linux-next specific files for 20170217
# extra tests with first bad commit reverted
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
4 years
- 3
- 2
2acdde7750: [ INFO: suspicious RCU usage. ]
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-2017021823
commit 2acdde7750ea3a261f08f34e39ba0652ebc8c3d5
Merge: 6a6281c 947a7ea
Author: 0day robot <fengguang.wu(a)intel.com>
AuthorDate: Sun Feb 19 02:26:32 2017 +0800
Commit: 0day robot <fengguang.wu(a)intel.com>
CommitDate: Sun Feb 19 02:26:32 2017 +0800
Merge 'dax/wlist' into devel-hourly-2017021823
2acdde7750 Merge 'dax/wlist' into devel-hourly-2017021823
+--------------------------------------------------+----+
| | |
+--------------------------------------------------+----+
| boot_successes | 0 |
| boot_failures | 39 |
| INFO:suspicious_RCU_usage | 38 |
| INFO:task_blocked_for_more_than#seconds | 36 |
| INFO:lockdep_is_turned_off | 35 |
| Kernel_panic-not_syncing:hung_task:blocked_tasks | 36 |
+--------------------------------------------------+----+
[ 4.663240] Duration of test: 742146576 ns
[ 4.663959] Average test time: 743132709
[ 4.664398] Testing concurrent rhashtable access from 10 threads
[ 8.729714]
[ 8.732017] ===============================
[ 8.732486] [ INFO: suspicious RCU usage. ]
[ 8.733014] 4.10.0-rc8-07697-g2acdde7 #1 Not tainted
[ 8.733566] -------------------------------
[ 8.734052] lib/rhashtable.c:1126 suspicious rcu_dereference_protected() usage!
[ 8.735014]
[ 8.735014] other info that might help us debug this:
[ 8.735014]
[ 8.735865]
[ 8.735865] rcu_scheduler_active = 2, debug_locks = 0
[ 8.736579] 1 lock held by rhashtable_thra/176:
[ 8.737178] #0: (rcu_read_lock){......}, at: [<ffffffff9bfa7b5d>] thread_lookup_test+0xad/0x540
[ 8.738233]
[ 8.738233] stack backtrace:
[ 8.738725] CPU: 0 PID: 176 Comm: rhashtable_thra Not tainted 4.10.0-rc8-07697-g2acdde7 #1
[ 8.739620] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 8.740795] Call Trace:
[ 8.741080] dump_stack+0x19/0x20
[ 8.741443] lockdep_rcu_suspicious+0xfe/0x110
[ 8.741948] rht_bucket_nested+0xf0/0x230
[ 8.742403] thread_lookup_test+0x214/0x540
[ 8.742944] ? thread_lookup_test+0xad/0x540
[ 8.743492] ? jhash+0x220/0x220
[ 8.743872] ? rhashtable_insert_slow+0x29/0x110
[ 8.744390] ? insert_retry+0x251/0x5f0
[ 8.745032] threadfunc+0x141/0x6f0
[ 8.745414] ? trace_hardirqs_on+0xd/0x10
[ 8.745856] ? __kthread_parkme+0xdb/0x100
[ 8.746293] kthread+0x1cb/0x1e0
[ 8.746647] ? insert_retry+0x5f0/0x5f0
[ 8.747267] ? __kthread_create_on_node+0x2e0/0x2e0
[ 8.747819] ret_from_fork+0x31/0x40
[ 13.973510] Started 10 threads, 0 failed
[ 14.186234] test_bitmap: all 460506 tests passed
[ 14.186864] test_uuid: all 18 tests passed
[ 14.191804] crc32: CRC_LE_BITS = 8, CRC_BE BITS = 8
[ 14.192370] crc32: self tests passed, processed 225944 bytes in 2091318 nsec
git bisect start 171f40b4581864c00a8159f6ba19dd02d012bf26 7089db84e356562f8ba737c29e472cc42d530dbc --
git bisect good 6f4eabb22829ac3a4b91b8636f6e6742fc895f32 # 20:07 33+ 0 Merge 'linux-review/simran-singhal/staging-rtl8192u-fixing-white-space-issue/20170215-043641' into devel-hourly-2017021823
git bisect bad 3b5dc5d37acd8ad092d764b8a6e2fab3e73a0103 # 20:24 0- 8 Merge 'linux-review/Florian-Westphal/netfilter-nat-remove-incorrect-debug-assert/20170209-063353' into devel-hourly-2017021823
git bisect bad c907b1dfd74ac2da5d2096f7d3c222e6bd69471e # 20:52 1- 8 Merge 'pwm/for-4.11/acpi' into devel-hourly-2017021823
git bisect good 902585b2d89a02329b31335d8f2ccc177773854b # 21:13 35+ 36 Merge 'mellanox/queue-rc' into devel-hourly-2017021823
git bisect good 7fda1dcd5c5e28d035aeab337342b37c3eac256b # 21:27 35+ 36 Merge 'linux-review/Ming-Lei/block-loop-fix-race-between-I-O-and-set_status/20170211-114516' into devel-hourly-2017021823
git bisect good 1634f155d118930b9699c6c792f8029fca49769b # 21:43 34+ 36 Merge 'pci/pci/host-hv' into devel-hourly-2017021823
git bisect bad 46d151895c5c82dbf6f9bbe35e5f33063f019081 # 21:55 0- 3 Merge 'linux-review/Dmitry-Torokhov/gpio-return-NULL-from-gpiod_get_optional-when-GPIOLIB-is-disabled/20170213-091717' into devel-hourly-2017021823
git bisect good 6a6281c7fe53e49cbe42c3505295e9811b124f89 # 22:08 35+ 37 Merge 'linux-review/Joe-Perches/compiler-compiler-gcc-Add-__fallthrough/20170211-050556' into devel-hourly-2017021823
git bisect bad 2acdde7750ea3a261f08f34e39ba0652ebc8c3d5 # 22:35 0- 6 Merge 'dax/wlist' into devel-hourly-2017021823
git bisect good e73639b1a67abc581c3b7671556a439c41353bca # 22:58 35+ 37 fold list.h
git bisect good 947a7ea93f3d85ddc885b02550ce263f15921544 # 23:09 35+ 39 Convert semaphores to use waitlists
# first bad commit: [2acdde7750ea3a261f08f34e39ba0652ebc8c3d5] Merge 'dax/wlist' into devel-hourly-2017021823
git bisect good 6a6281c7fe53e49cbe42c3505295e9811b124f89 # 23:18 105+ 142 Merge 'linux-review/Joe-Perches/compiler-compiler-gcc-Add-__fallthrough/20170211-050556' into devel-hourly-2017021823
git bisect good 947a7ea93f3d85ddc885b02550ce263f15921544 # 23:27 105+ 143 Convert semaphores to use waitlists
# extra tests with CONFIG_DEBUG_INFO_REDUCED
git bisect bad 2acdde7750ea3a261f08f34e39ba0652ebc8c3d5 # 23:43 5- 14 Merge 'dax/wlist' into devel-hourly-2017021823
# extra tests on HEAD of linux-devel/devel-hourly-2017021823
git bisect bad 171f40b4581864c00a8159f6ba19dd02d012bf26 # 23:43 0- 23 0day head guard for 'devel-hourly-2017021823'
# extra tests on tree/branch linux-devel/devel-hourly-2017021823
git bisect bad 171f40b4581864c00a8159f6ba19dd02d012bf26 # 23:45 0- 23 0day head guard for 'devel-hourly-2017021823'
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
4 years
- 1
- 0
[genirq] f91f694540 BUG: unable to handle kernel NULL pointer dereference at 0000000000000078
by Fengguang Wu
Hi Thomas,
FYI, here is another bisect result.
https://git.kernel.org/pub/scm/linux/kernel/git/next/linux-next.git master
commit f91f694540f3f8ed25da57814fe0c673afd36e7e
Author: Thomas Gleixner <tglx(a)linutronix.de>
AuthorDate: Wed Feb 15 15:43:54 2017 +0100
Commit: Thomas Gleixner <tglx(a)linutronix.de>
CommitDate: Thu Feb 16 15:32:19 2017 +0100
genirq: Reenable shared irq debugging in request_*_irq()
Commit 6d83f94db95c ("genirq: Disable the SHIRQ_DEBUG call in
request_threaded_irq for now") disabled the SHIRQ_DEBUG facility for the
irq request side. Unfortunately the 'for now' part and the _FIXME add on to
the CONFIG_SHIRQ_DEBUG guard got forgotten.
It's unfortunately not possible to keep the original idea of just invoking
the newly installed handler due to the reasons described in the commit
which disabled it, but having this debug facility available makes a lot of
sense.
The only way to regain that testing is to invoke the real interrupt
handling mechanism, which will also invoke an already registered handler,
but that's not an issue because _all_ interrupt handlers need to be
prepared for handling spurious interrupts.
Signed-off-by: Thomas Gleixner <tglx(a)linutronix.de>
Cc: Peter Zijlstra <peterz(a)infradead.org>
Link: http://lkml.kernel.org/r/alpine.DEB.2.20.1702151542330.3562@nanos
Signed-off-by: Thomas Gleixner <tglx(a)linutronix.de>
+-----------------------------------------------------------+------------+------------+------------------+
| | 5d4bac9a5f | f91f694540 | v4.10-rc8_021716 |
+-----------------------------------------------------------+------------+------------+------------------+
| boot_successes | 27 | 0 | 0 |
| boot_failures | 59 | 21 | 41 |
| BUG:kernel_reboot-without-warning_in_test_stage | 2 | | |
| Kernel_panic-not_syncing:Attempted_to_kill_init!exitcode= | 57 | | |
| BUG:unable_to_handle_kernel | 0 | 21 | 41 |
| Oops | 0 | 21 | 41 |
| Kernel_panic-not_syncing:Fatal_exception | 0 | 21 | 41 |
+-----------------------------------------------------------+------------+------------+------------------+
[ 0.652008] ACPI: Added _OSI(3.0 _SCP Extensions)
[ 0.653360] ACPI: Added _OSI(Processor Aggregator Device)
[ 0.653360] ACPI: Added _OSI(Processor Aggregator Device)
[ 0.655401] BUG: unable to handle kernel NULL pointer dereference at 0000000000000078
[ 0.655401] BUG: unable to handle kernel NULL pointer dereference at 0000000000000078
[ 0.656000] IP: irq_complete_move+0xe/0x20
[ 0.656000] IP: irq_complete_move+0xe/0x20
[ 0.656000] PGD 0
[ 0.656000] PGD 0
[ 0.656000]
[ 0.656000]
[ 0.656000] Oops: 0000 [#1] SMP
[ 0.656000] Oops: 0000 [#1] SMP
[ 0.656000] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 4.10.0-rc6-00021-gf91f694 #1
[ 0.656000] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 4.10.0-rc6-00021-gf91f694 #1
[ 0.656000] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 0.656000] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 0.656000] task: ffff88001d4ac040 task.stack: ffff88001d4b0000
[ 0.656000] task: ffff88001d4ac040 task.stack: ffff88001d4b0000
[ 0.656000] RIP: 0010:irq_complete_move+0xe/0x20
[ 0.656000] RIP: 0010:irq_complete_move+0xe/0x20
[ 0.656000] RSP: 0000:ffff88001d4b3ce0 EFLAGS: 00010046
[ 0.656000] RSP: 0000:ffff88001d4b3ce0 EFLAGS: 00010046
[ 0.656000] RAX: 0000000000000000 RBX: 0000000000000000 RCX: ffffffff810368c0
[ 0.656000] RAX: 0000000000000000 RBX: 0000000000000000 RCX: ffffffff810368c0
[ 0.656000] RDX: 0000000000000003 RSI: ffffffff81170024 RDI: ffff8800000979a0
[ 0.656000] RDX: 0000000000000003 RSI: ffffffff81170024 RDI: ffff8800000979a0
[ 0.656000] RBP: ffff88001d4b3d20 R08: 0000000000000000 R09: 0000000000000001
[ 0.656000] RBP: ffff88001d4b3d20 R08: 0000000000000000 R09: 0000000000000001
[ 0.656000] R10: 0000000000f2f520 R11: ffff88001d44b588 R12: ffff88001d4496a0
[ 0.656000] R10: 0000000000f2f520 R11: ffff88001d44b588 R12: ffff88001d4496a0
[ 0.656000] R13: ffff88001d449620 R14: ffff8800000979a0 R15: ffff88001d7c3000
[ 0.656000] R13: ffff88001d449620 R14: ffff8800000979a0 R15: ffff88001d7c3000
[ 0.656000] FS: 0000000000000000(0000) GS:ffff88001e400000(0000) knlGS:0000000000000000
[ 0.656000] FS: 0000000000000000(0000) GS:ffff88001e400000(0000) knlGS:0000000000000000
[ 0.656000] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 0.656000] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 0.656000] CR2: 0000000000000078 CR3: 0000000003811000 CR4: 00000000000006b0
[ 0.656000] CR2: 0000000000000078 CR3: 0000000003811000 CR4: 00000000000006b0
[ 0.656000] Call Trace:
[ 0.656000] Call Trace:
[ 0.656000] ? ioapic_ack_level+0x2b/0x1e0
[ 0.656000] ? ioapic_ack_level+0x2b/0x1e0
[ 0.656000] handle_fasteoi_irq+0x23a/0x250
[ 0.656000] handle_fasteoi_irq+0x23a/0x250
[ 0.656000] request_threaded_irq+0x2fe/0x3a0
[ 0.656000] request_threaded_irq+0x2fe/0x3a0
[ 0.656000] ? acpi_map_lookup+0x4f/0x4f
[ 0.656000] ? acpi_map_lookup+0x4f/0x4f
[ 0.656000] ? acpi_ev_sci_dispatch+0x74/0x74
[ 0.656000] ? acpi_ev_sci_dispatch+0x74/0x74
[ 0.656000] acpi_os_install_interrupt_handler+0xd2/0x11c
[ 0.656000] acpi_os_install_interrupt_handler+0xd2/0x11c
[ 0.656000] ? do_early_param+0xbb/0xbb
[ 0.656000] ? do_early_param+0xbb/0xbb
[ 0.656000] acpi_ev_install_sci_handler+0x23/0x25
[ 0.656000] acpi_ev_install_sci_handler+0x23/0x25
[ 0.656000] acpi_ev_install_xrupt_handlers+0x2e/0x9f
[ 0.656000] acpi_ev_install_xrupt_handlers+0x2e/0x9f
[ 0.656000] acpi_enable_subsystem+0xf3/0x128
[ 0.656000] acpi_enable_subsystem+0xf3/0x128
[ 0.656000] acpi_init+0xf4/0x461
[ 0.656000] acpi_init+0xf4/0x461
[ 0.656000] ? do_early_param+0xbb/0xbb
[ 0.656000] ? do_early_param+0xbb/0xbb
[ 0.656000] ? video_setup+0x103/0x103
[ 0.656000] ? video_setup+0x103/0x103
[ 0.656000] ? acpi_sleep_proc_init+0x28/0x28
[ 0.656000] ? acpi_sleep_proc_init+0x28/0x28
[ 0.656000] do_one_initcall+0xaf/0x1d9
[ 0.656000] do_one_initcall+0xaf/0x1d9
[ 0.656000] ? do_early_param+0xbb/0xbb
[ 0.656000] ? do_early_param+0xbb/0xbb
[ 0.656000] kernel_init_freeable+0x1a9/0x270
[ 0.656000] kernel_init_freeable+0x1a9/0x270
[ 0.656000] ? rest_init+0xd0/0xd0
[ 0.656000] ? rest_init+0xd0/0xd0
[ 0.656000] kernel_init+0xe/0x180
[ 0.656000] kernel_init+0xe/0x180
[ 0.656000] ret_from_fork+0x2c/0x40
[ 0.656000] ret_from_fork+0x2c/0x40
[ 0.656000] Code: f9 fd 1b 00 48 83 05 e9 d1 bd 02 01 e9 60 ff ff ff 66 90 66 2e 0f 1f 84 00 00 00 00 00 e8 ab da 8a 01 55 65 48 8b 05 fa 5d fd 7e <48> 8b 70 78 48 89 e5 f7 d6 e8 d4 e9 ff ff 5d c3 66 90 e8 8b da
[ 0.656000] Code: f9 fd 1b 00 48 83 05 e9 d1 bd 02 01 e9 60 ff ff ff 66 90 66 2e 0f 1f 84 00 00 00 00 00 e8 ab da 8a 01 55 65 48 8b 05 fa 5d fd 7e <48> 8b 70 78 48 89 e5 f7 d6 e8 d4 e9 ff ff 5d c3 66 90 e8 8b da
[ 0.656000] RIP: irq_complete_move+0xe/0x20 RSP: ffff88001d4b3ce0
[ 0.656000] RIP: irq_complete_move+0xe/0x20 RSP: ffff88001d4b3ce0
[ 0.656000] CR2: 0000000000000078
[ 0.656000] CR2: 0000000000000078
[ 0.656000] ---[ end trace c9c412fc9253e9ee ]---
[ 0.656000] ---[ end trace c9c412fc9253e9ee ]---
git bisect start 4a46686569061cc1abc34beaa653e8cdf624e06c 7089db84e356562f8ba737c29e472cc42d530dbc --
git bisect good fb084b07b6bff4d415a6528eb7c32dc4306c9eae # 03:18 20+ 10 Merge 'abelloni/at91-dt' into devel-hourly-2017021716
git bisect good f1ad3ae3cd2dd394a392ddb24d7f56b4c51c3a08 # 03:30 19+ 19 Merge 'linux-review/Igor-Pylypiv/net-fix-description-of-skb_find_text-according-to-removed-functionality/20170208-105106' into devel-hourly-2017021716
git bisect bad 8ba70b201bb869c59cc0bac3fdb800882ff5f1ed # 03:41 0- 21 Merge 'linux-review/Pavel-Machek/Re-PATCHv2-dt-bindings-Add-support-for-CSI1-bus/20170206-180540' into devel-hourly-2017021716
git bisect bad 9d6faad77542ee6f877913083a579c6eb8dc1778 # 03:52 0- 21 Merge 'linux-review/Mark-Rutland/arm64-uaccess-consistently-check-object-sizes/20170207-204101' into devel-hourly-2017021716
git bisect bad f18ba3c78f70fe7267e3e00f82244890114611ef # 04:06 0- 8 Merge 'tip/irq/core' into devel-hourly-2017021716
git bisect good 158680bbd6f7623b9aeadbd2ded1e9780bbc2473 # 04:35 21+ 23 Merge 'linux-review/Philippe-Reynes/net-mellanox-switchx2-use-new-api-ethtool_-get-set-_link_ksettings/20170208-071136' into devel-hourly-2017021716
git bisect good b3e682d648280cab775874ddb08e866408db44ce # 04:53 22+ 22 Merge 'linux-review/Tiezhu-Yang/f2fs-fix-a-typo-in-f2fs-txt/20170208-055253' into devel-hourly-2017021716
git bisect good 92288a70fbdb2c1971fd6ca09051e92886233d9a # 05:37 22+ 22 Merge 'tip/locking/urgent' into devel-hourly-2017021716
git bisect good 330392c96471909a8c5efb4ad1a55fdab90632c5 # 05:57 22+ 22 Merge 'linux-review/Willem-de-Bruijn/Fixes-for-header-length-truncation/20170208-052303' into devel-hourly-2017021716
git bisect good 55d26d9ddc3d7a9893a8a3d62c3bd82896a2ad0b # 06:56 22+ 22 Merge 'linux-review/Cong-Wang/ping-fix-a-null-pointer-dereference/20170208-051921' into devel-hourly-2017021716
git bisect good 5d4bac9a5f4ef24b2482529bda6661a58e5b5b65 # 07:23 22+ 16 genirq: Clarify logic calculating bogus irqreturn_t values
git bisect bad f91f694540f3f8ed25da57814fe0c673afd36e7e # 07:45 0- 14 genirq: Reenable shared irq debugging in request_*_irq()
# first bad commit: [f91f694540f3f8ed25da57814fe0c673afd36e7e] genirq: Reenable shared irq debugging in request_*_irq()
git bisect good 5d4bac9a5f4ef24b2482529bda6661a58e5b5b65 # 07:48 61+ 59 genirq: Clarify logic calculating bogus irqreturn_t values
# extra tests with CONFIG_DEBUG_INFO_REDUCED
git bisect bad f91f694540f3f8ed25da57814fe0c673afd36e7e # 08:08 0- 66 genirq: Reenable shared irq debugging in request_*_irq()
# extra tests on HEAD of linux-devel/devel-hourly-2017021716
git bisect bad 4a46686569061cc1abc34beaa653e8cdf624e06c # 08:08 0- 41 0day head guard for 'devel-hourly-2017021716'
# extra tests on tree/branch linux-next/master
git bisect bad 4ce4a759a3e221b5265ebd03c2f8888b69a7cf3e # 08:21 0- 3 Add linux-next specific files for 20170217
# extra tests with first bad commit reverted
git bisect good 2cc13c810cd9b4f7981c8cfbc0586a470944989e # 09:04 62+ 40 Revert "genirq: Reenable shared irq debugging in request_*_irq()"
# extra tests on tree/branch linus/master
git bisect good 6dc39c50e4aeb769c8ae06edf2b1a732f3490913 # 09:41 61+ 39 Merge branch 'for-linus' of git://git.kernel.dk/linux-block
# extra tests on tree/branch linux-next/master
git bisect bad 4ce4a759a3e221b5265ebd03c2f8888b69a7cf3e # 09:41 0- 67 Add linux-next specific files for 20170217
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
4 years
- 2
- 2
[locking/mutex] e274795ea7 WARNING: CPU: 0 PID: 1 at arch/x86/include/asm/fpu/internal.h:348 __switch_to
by Fengguang Wu
Hi Peter,
0day kernel testing robot got the below dmesg and the first bad commit is
https://git.kernel.org/pub/scm/linux/kernel/git/next/linux-next.git master
commit e274795ea7b7caa0fd74ef651594382a69e2a951
Author: Peter Zijlstra <peterz(a)infradead.org>
AuthorDate: Wed Jan 11 14:17:48 2017 +0100
Commit: Ingo Molnar <mingo(a)kernel.org>
CommitDate: Sat Jan 14 11:14:38 2017 +0100
locking/mutex: Fix mutex handoff
While reviewing the ww_mutex patches, I noticed that it was still
possible to (incorrectly) succeed for (incorrect) code like:
mutex_lock(&a);
mutex_lock(&a);
This was possible if the second mutex_lock() would block (as expected)
but then receive a spurious wakeup. At that point it would find itself
at the front of the queue, request a handoff and instantly claim
ownership and continue, since owner would point to itself.
Avoid this scenario and simplify the code by introducing a third low
bit to signal handoff pickup. So once we request handoff, unlock
clears the handoff bit and sets the pickup bit along with the new
owner.
This also removes the need for the .handoff argument to
__mutex_trylock(), since that becomes superfluous with PICKUP.
In order to guarantee enough low bits, ensure task_struct alignment is
at least L1_CACHE_BYTES (which seems a good ideal regardless).
Signed-off-by: Peter Zijlstra (Intel) <peterz(a)infradead.org>
Cc: Andrew Morton <akpm(a)linux-foundation.org>
Cc: Linus Torvalds <torvalds(a)linux-foundation.org>
Cc: Paul E. McKenney <paulmck(a)linux.vnet.ibm.com>
Cc: Peter Zijlstra <peterz(a)infradead.org>
Cc: Thomas Gleixner <tglx(a)linutronix.de>
Fixes: 9d659ae14b54 ("locking/mutex: Add lock handoff to avoid starvation")
Signed-off-by: Ingo Molnar <mingo(a)kernel.org>
+------------------------------------------------------------------------+------------+------------+------------+
| | 52b94129f2 | e274795ea7 | 8e5373fe04 |
+------------------------------------------------------------------------+------------+------------+------------+
| boot_successes | 256 | 31 | 19 |
| boot_failures | 3 | 35 | 8 |
| invoked_oom-killer:gfp_mask=0x | 3 | | |
| Mem-Info | 3 | | |
| WARNING:at_arch/x86/include/asm/fpu/internal.h:#__switch_to | 0 | 35 | 8 |
| WARNING:at_arch/x86/include/asm/fpu/internal.h:#copy_fpregs_to_fpstate | 0 | 35 | 8 |
| WARNING:at_arch/x86/include/asm/fpu/internal.h:#copy_kernel_to_xregs | 0 | 35 | 8 |
+------------------------------------------------------------------------+------------+------------+------------+
[ 13.377261] Write protecting the kernel text: 15320k
[ 13.378910] Write protecting the kernel read-only data: 6316k
[ 13.380655] NX-protecting the kernel data: 9256k
[ 13.382475] x86/mm: Checked W+X mappings: passed, no W+X pages found.
[ 13.384781] ------------[ cut here ]------------
[ 13.386327] WARNING: CPU: 0 PID: 1 at arch/x86/include/asm/fpu/internal.h:348 __switch_to+0x1b6/0x260
[ 13.392043] CPU: 0 PID: 1 Comm: init Not tainted 4.10.0-rc3-00137-ge274795 #1
[ 13.393915] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 13.396969] Call Trace:
[ 13.398094] ---[ end trace bea5ac2809caed12 ]---
[ 13.400879] ------------[ cut here ]------------
[ 13.402417] WARNING: CPU: 0 PID: 1 at arch/x86/include/asm/fpu/internal.h:348 copy_fpregs_to_fpstate+0x62/0x7b
[ 13.408198] CPU: 0 PID: 1 Comm: init Tainted: G W 4.10.0-rc3-00137-ge274795 #1
[ 13.410959] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 13.414112] Call Trace:
[ 13.415350] dump_stack+0x16/0x18
[ 13.416698] __warn+0xa0/0xb7
[ 13.417964] ? copy_fpregs_to_fpstate+0x62/0x7b
[ 13.419464] warn_slowpath_null+0x11/0x16
[ 13.420866] copy_fpregs_to_fpstate+0x62/0x7b
[ 13.422342] fpu__copy+0x68/0x92
[ 13.423615] arch_dup_task_struct+0x21/0x25
[ 13.425070] copy_process+0xee/0x1198
[ 13.426539] ? strncpy_from_user+0x41/0xce
[ 13.427974] ? ___might_sleep+0x2b/0xf4
[ 13.429387] _do_fork+0x9d/0x1d3
[ 13.430673] SyS_clone+0x19/0x1b
[ 13.431999] do_int80_syscall_32+0x44/0x56
[ 13.433557] entry_INT80_32+0x2a/0x2a
[ 13.434910] EIP: 0x47f11df2
[ 13.436113] EFLAGS: 00000286 CPU: 0
[ 13.437427] EAX: ffffffda EBX: 01200011 ECX: 00000000 EDX: 00000000
[ 13.439207] ESI: 00000000 EDI: b7777728 EBP: bfa57788 ESP: bfa57744
[ 13.442636] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 007b
[ 13.444313] ---[ end trace bea5ac2809caed13 ]---
[ 13.446100] ------------[ cut here ]------------
[ 13.447653] WARNING: CPU: 0 PID: 1 at arch/x86/include/asm/fpu/internal.h:363 __switch_to+0x12c/0x260
[ 13.450896] CPU: 0 PID: 1 Comm: init Tainted: G W 4.10.0-rc3-00137-ge274795 #1
[ 13.454647] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 13.457800] Call Trace:
[ 13.459040] ---[ end trace bea5ac2809caed14 ]---
[ 13.463277] ------------[ cut here ]------------
[ 13.466253] WARNING: CPU: 0 PID: 213 at arch/x86/include/asm/fpu/internal.h:363 copy_kernel_to_xregs+0x33/0x36
[ 13.469910] CPU: 0 PID: 213 Comm: rcS Tainted: G W 4.10.0-rc3-00137-ge274795 #1
[ 13.472674] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 13.475830] Call Trace:
[ 13.476990] dump_stack+0x16/0x18
[ 13.478280] __warn+0xa0/0xb7
[ 13.479505] ? copy_kernel_to_xregs+0x33/0x36
[ 13.481158] warn_slowpath_null+0x11/0x16
[ 13.482556] copy_kernel_to_xregs+0x33/0x36
[ 13.484191] copy_kernel_to_fpregs+0x20/0x35
[ 13.485638] fpu__restore+0x1f/0x27
[ 13.486966] __fpu__restore_sig+0x269/0x398
[ 13.488396] fpu__restore_sig+0x2e/0x32
[ 13.489768] restore_sigcontext+0xd7/0xe0
[ 13.491300] sys_sigreturn+0xa2/0xc2
[ 13.492625] do_int80_syscall_32+0x44/0x56
[ 13.494064] entry_INT80_32+0x2a/0x2a
[ 13.495599] EIP: 0x47ea7ee7
[ 13.496815] EFLAGS: 00000246 CPU: 0
[ 13.498142] EAX: 00000000 EBX: 00000002 ECX: bfe5e3c0 EDX: 00000000
[ 13.499933] ESI: 00000008 EDI: 47fdcff4 EBP: bfe5e3c0 ESP: bfe5e290
[ 13.501720] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 007b
[ 13.503366] ---[ end trace bea5ac2809caed15 ]---
/etc/rcS.d/S00fbsetup: line 3: /sbin/modprobe: No such file or directory
git bisect start 8e5373fe04a362a9db115f875654d82f31bd3d5a 7089db84e356562f8ba737c29e472cc42d530dbc --
git bisect bad cc3d94c407e49e788c2ce358d73c0af6d519fd06 # 10:31 2- 3 Merge 'linux-review/Alexey-Khoroshilov/mtd-spi-nor-hisi-do-not-ignore-clk_prepare_enable-failure/20170218-071622' into devel-catchup-201702180748
git bisect good 7d0b0c72199ffe0f5e960488d27e3832fc0fbf3c # 10:52 26+ 0 Merge 'linux-review/Colin-King/ext4-fix-spelling-mistake-alligned-aligned/20170218-073533' into devel-catchup-201702180748
git bisect bad 0885cf212cc1584ef969243f4df16b28926995c6 # 11:10 1- 3 Merge 'linux-review/Waiman-Long/locking-pvqspinlock-Relax-cmpxchg-s-to-improve-performance-on-some-archs/20170218-070718' into devel-catchup-201702180748
git bisect good 6f5daa6f332fd9861290efcf150f91dbffe62197 # 11:22 28+ 0 Merge 'linux-review/Steven-Rostedt-VMware/sched-rt-Add-comments-describing-the-RT-IPI-pull-method/20170218-072124' into devel-catchup-201702180748
git bisect bad f2a5fec17395f259d54daa8833d81b00cceb15c3 # 11:34 5- 4 locking/ww_mutex: Begin kselftests for ww_mutex
git bisect bad 3822da3ed0676e01f83fe0518c333c8e9ba249bf # 11:47 2- 1 locking/ww_mutex: Extract stamp comparison to __ww_mutex_stamp_after()
git bisect good 5376f2e722026e91cb46384bda8d8b3e9f88217c # 12:17 63+ 0 drivers/tty: Compute 'current' directly
git bisect good 8f95c90ceb541a38ac16fec48c05142ef1450c25 # 12:38 65+ 0 sched/wait, RCU: Introduce rcuwait machinery
git bisect bad e274795ea7b7caa0fd74ef651594382a69e2a951 # 12:52 3- 12 locking/mutex: Fix mutex handoff
git bisect good 52b94129f274937e4c25dd17b76697664a3c43c9 # 13:13 60+ 1 locking/percpu-rwsem: Replace waitqueue with rcuwait
# first bad commit: [e274795ea7b7caa0fd74ef651594382a69e2a951] locking/mutex: Fix mutex handoff
git bisect good 52b94129f274937e4c25dd17b76697664a3c43c9 # 13:32 180+ 1 locking/percpu-rwsem: Replace waitqueue with rcuwait
# extra tests with CONFIG_DEBUG_INFO_REDUCED
git bisect bad e274795ea7b7caa0fd74ef651594382a69e2a951 # 13:48 14- 6 locking/mutex: Fix mutex handoff
# extra tests on HEAD of linux-devel/devel-catchup-201702180748
git bisect bad 8e5373fe04a362a9db115f875654d82f31bd3d5a # 13:48 0- 8 0day head guard for 'devel-catchup-201702180748'
# extra tests on tree/branch linux-next/master
git bisect bad 4ce4a759a3e221b5265ebd03c2f8888b69a7cf3e # 13:51 7- 1 Add linux-next specific files for 20170217
# extra tests on tree/branch linus/master
git bisect good 6dc39c50e4aeb769c8ae06edf2b1a732f3490913 # 14:33 184+ 0 Merge branch 'for-linus' of git://git.kernel.dk/linux-block
# extra tests on tree/branch linux-next/master
git bisect bad 4ce4a759a3e221b5265ebd03c2f8888b69a7cf3e # 14:33 0- 72 Add linux-next specific files for 20170217
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
4 years
- 2
- 4
[x86] 0ad07c8104: BUG: unable to handle kernel paging request at 000000001ea0d000
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 Borislav-Petkov/x86-Optimize-clear_page/20170210-053052
commit 0ad07c8104eb5c12dfcb86581c1cc657183496cc
Author: Borislav Petkov <bp(a)suse.de>
AuthorDate: Thu Feb 9 20:51:25 2017 +0100
Commit: 0day robot <fengguang.wu(a)intel.com>
CommitDate: Fri Feb 10 05:30:58 2017 +0800
x86: Optimize clear_page()
Currently, we CALL clear_page() which then JMPs to the proper function
chosen by the alternatives.
What we should do instead is CALL the proper function directly. (This
was something Ingo suggested a while ago). So let's do that.
Measuring our favourite kernel build workload shows that there are no
significant changes in performance.
AMD
===
--- /tmp/before 2017-02-09 18:01:46.451961188 +0100
+++ /tmp/after 2017-02-09 18:01:54.883961175 +0100
@@ -1,15 +1,15 @@
Performance counter stats for 'system wide' (5 runs):
- 1028960.373643 cpu-clock (msec) # 6.000 CPUs utilized ( +- 1.41% )
+ 1023086.018961 cpu-clock (msec) # 6.000 CPUs utilized ( +- 1.20% )
- 518,744 context-switches # 0.504 K/sec ( +- 1.04% )
+ 518,254 context-switches # 0.507 K/sec ( +- 1.01% )
- 38,112 cpu-migrations # 0.037 K/sec ( +- 1.95% )
+ 37,917 cpu-migrations # 0.037 K/sec ( +- 1.02% )
- 20,874,266 page-faults # 0.020 M/sec ( +- 0.07% )
+ 20,918,897 page-faults # 0.020 M/sec ( +- 0.18% )
- 2,043,646,230,667 cycles # 1.986 GHz ( +- 0.14% ) (66.67%)
+ 2,045,305,584,032 cycles # 1.999 GHz ( +- 0.16% ) (66.67%)
- 553,698,855,431 stalled-cycles-frontend # 27.09% frontend cycles idle ( +- 0.07% ) (66.67%)
+ 555,099,401,413 stalled-cycles-frontend # 27.14% frontend cycles idle ( +- 0.13% ) (66.67%)
- 621,544,286,390 stalled-cycles-backend # 30.41% backend cycles idle ( +- 0.39% ) (66.67%)
+ 621,371,430,254 stalled-cycles-backend # 30.38% backend cycles idle ( +- 0.32% ) (66.67%)
- 1,738,364,431,659 instructions # 0.85 insn per cycle
+ 1,739,895,771,901 instructions # 0.85 insn per cycle
- # 0.36 stalled cycles per insn ( +- 0.11% ) (66.67%)
+ # 0.36 stalled cycles per insn ( +- 0.13% ) (66.67%)
- 391,170,943,850 branches # 380.161 M/sec ( +- 0.13% ) (66.67%)
+ 391,398,551,757 branches # 382.567 M/sec ( +- 0.13% ) (66.67%)
- 22,567,810,411 branch-misses # 5.77% of all branches ( +- 0.11% ) (66.67%)
+ 22,574,726,683 branch-misses # 5.77% of all branches ( +- 0.13% ) (66.67%)
- 171.480741921 seconds time elapsed ( +- 1.41% )
+ 170.509229451 seconds time elapsed ( +- 1.20% )
Intel
=====
--- /tmp/before 2017-02-09 20:36:19.851947473 +0100
+++ /tmp/after 2017-02-09 20:36:30.151947458 +0100
@@ -1,15 +1,15 @@
Performance counter stats for 'system wide' (5 runs):
- 2207248.598126 cpu-clock (msec) # 8.000 CPUs utilized ( +- 0.69% )
+ 2213300.106631 cpu-clock (msec) # 8.000 CPUs utilized ( +- 0.73% )
- 899,342 context-switches # 0.407 K/sec ( +- 0.68% )
+ 898,381 context-switches # 0.406 K/sec ( +- 0.79% )
- 80,553 cpu-migrations # 0.036 K/sec ( +- 1.13% )
+ 80,979 cpu-migrations # 0.037 K/sec ( +- 1.11% )
- 36,171,148 page-faults # 0.016 M/sec ( +- 0.02% )
+ 36,179,791 page-faults # 0.016 M/sec ( +- 0.02% )
- 6,665,288,826,484 cycles # 3.020 GHz ( +- 0.07% ) (83.33%)
+ 6,671,638,410,799 cycles # 3.014 GHz ( +- 0.06% ) (83.33%)
- 5,065,975,115,197 stalled-cycles-frontend # 76.01% frontend cycles idle ( +- 0.11% ) (83.33%)
+ 5,076,835,183,223 stalled-cycles-frontend # 76.10% frontend cycles idle ( +- 0.11% ) (83.33%)
- 3,841,556,350,614 stalled-cycles-backend # 57.64% backend cycles idle ( +- 0.13% ) (66.67%)
+ 3,852,823,974,333 stalled-cycles-backend # 57.75% backend cycles idle ( +- 0.12% ) (66.67%)
- 4,148,398,171,079 instructions # 0.62 insn per cycle
+ 4,148,997,156,059 instructions # 0.62 insn per cycle
- # 1.22 stalled cycles per insn ( +- 0.10% ) (83.33%)
+ # 1.22 stalled cycles per insn ( +- 0.11% ) (83.33%)
- 887,187,118,591 branches # 401.943 M/sec ( +- 0.09% ) (83.33%)
+ 887,271,341,121 branches # 400.882 M/sec ( +- 0.11% ) (83.33%)
- 30,139,439,034 branch-misses # 3.40% of all branches ( +- 0.09% ) (83.33%)
+ 30,134,864,997 branch-misses # 3.40% of all branches ( +- 0.06% ) (83.33%)
- 275.904405540 seconds time elapsed ( +- 0.69% )
+ 276.660352016 seconds time elapsed ( +- 0.73% )
allmodconfig vmlinux size grows by a ~1Kb but that's fine - we optimize
our calling of the clear_page variants.
text data bss dec hex filename
9051979 23067670 27009024 59128673 3863b61 vmlinux
9053000 23067670 27009024 59129694 3863f5e vmlinux.clear_page
Signed-off-by: Borislav Petkov <bp(a)suse.de>
+-------------------------------------------------------------------+------------+------------+------------+
| | 10b9dd5686 | 0ad07c8104 | 00667aaf17 |
+-------------------------------------------------------------------+------------+------------+------------+
| boot_successes | 20 | 0 | 0 |
| boot_failures | 46 | 26 | 21 |
| Kernel_panic-not_syncing:Attempted_to_kill_init!exitcode= | 46 | | |
| BUG:unable_to_handle_kernel | 0 | 26 | 21 |
| Oops | 0 | 26 | 21 |
| RIP:clear_page_orig | 0 | 4 | |
| calltrace:netlink_proto_init | 0 | 26 | |
| Kernel_panic-not_syncing:Fatal_exception | 0 | 26 | 21 |
| RIP:clear_page_rep | 0 | 20 | |
| BUG:kernel_in_stage | 0 | 1 | 5 |
| RIP:clear_page_erms | 0 | 2 | |
| BUG:kernel_reboot-without-warning_in_early-boot_stage,last_printk | 0 | 1 | |
| BUG:kernel_hang_in_test_stage | 0 | 0 | 2 |
+-------------------------------------------------------------------+------------+------------+------------+
[ 0.324616] gcov: version magic: 0x3630322a
[ 0.329304] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
[ 0.331770] atomic64_test: passed for x86-64 platform with CX8 and with SSE
[ 0.334605] BUG: unable to handle kernel paging request at 000000001ea0d000
[ 0.336767] IP: [<ffffffff814050b7>] clear_page_rep+0x7/0x10
[ 0.338200] PGD 0
[ 0.338642]
[ 0.339102] Oops: 0002 [#1] PREEMPT SMP
[ 0.339935] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 4.9.0-rc6-00134-g0ad07c8 #1
[ 0.341521] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.9.3-20161025_171302-gandalf 04/01/2014
[ 0.343839] task: ffff88001e942040 task.stack: ffffc900000d0000
[ 0.345137] RIP: 0010:[<ffffffff814050b7>] [<ffffffff814050b7>] clear_page_rep+0x7/0x10
[ 0.346999] RSP: 0000:ffffc900000d3b30 EFLAGS: 00010246
[ 0.348235] RAX: 0000000000000000 RBX: ffff88001f3cc340 RCX: 0000000000000200
[ 0.349924] RDX: ffffffff83a37440 RSI: ffff88001ec24000 RDI: 000000001ea0d000
[ 0.351027] RBP: ffffc900000d3be0 R08: 00000000001d7e50 R09: ffff88001e942040
[ 0.352112] R10: 0000000000000001 R11: 000000006a64d04b R12: ffff88001e942040
[ 0.353272] R13: ffff88001e942040 R14: ffff88001f3cc400 R15: ffff88001fca4600
[ 0.354322] FS: 0000000000000000(0000) GS:ffff88001fa00000(0000) knlGS:0000000000000000
[ 0.355474] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 0.356398] CR2: 000000001ea0d000 CR3: 000000000240c000 CR4: 00000000000006f0
[ 0.357463] Stack:
[ 0.357775] ffffffff8120f231 0000000000000008 ffff88001e801500 ffff88001fca4a90
[ 0.359005] 0000000000000014 0000000000000002 ffffffff00000000 0000000000000000
[ 0.360091] ffffc900000d3bd8 0000000000000202 ffff88001fca4600 ffff88001fca4600
[ 0.361188] Call Trace:
[ 0.361520] [<ffffffff8120f231>] ? get_page_from_freelist+0x991/0xe30
[ 0.362432] [<ffffffff812100da>] __alloc_pages_nodemask+0x2aa/0x1520
[ 0.363269] [<ffffffff81052e55>] ? unwind_next_frame+0x35/0x60
[ 0.364063] [<ffffffff81033cc9>] ? __save_stack_trace+0xe9/0x150
[ 0.364870] [<ffffffff8102c941>] ? sched_clock+0x11/0x20
[ 0.365789] [<ffffffff81a0d336>] ? proto_register+0x26/0x2f0
[ 0.366547] [<ffffffff812692b9>] alloc_page_interleave+0x49/0xc0
[ 0.367413] [<ffffffff8126bcb4>] alloc_pages_current+0x1f4/0x2b0
[ 0.368302] [<ffffffff8123463b>] kmalloc_order+0x1b/0x90
[ 0.369254] [<ffffffff82d599c1>] netlink_proto_init+0x78/0x289
[ 0.370231] [<ffffffff82d59949>] ? netlink_net_init+0x90/0x90
[ 0.371251] [<ffffffff82ca03a4>] do_one_initcall+0x113/0x28a
[ 0.372374] [<ffffffff82ca09b4>] kernel_init_freeable+0x499/0x630
[ 0.374274] [<ffffffff81c19af0>] ? rest_init+0x120/0x120
[ 0.375786] [<ffffffff81c19b01>] kernel_init+0x11/0x1d0
[ 0.377166] [<ffffffff81c25b45>] ret_from_fork+0x25/0x30
[ 0.378583] Code: 8d 44 24 18 4c 89 4c 24 40 c7 04 24 10 00 00 00 48 89 44 24 10 e8 3a f1 ff ff c9 c3 90 90 90 90 90 90 90 90 b9 00 02 00 00 31 c0 <f3> 48 ab c3 0f 1f 44 00 00 31 c0 b9 40 00 00 00 66 0f 1f 84 00
[ 0.385298] RIP [<ffffffff814050b7>] clear_page_rep+0x7/0x10
[ 0.386686] RSP <ffffc900000d3b30>
[ 0.387493] CR2: 000000001ea0d000
[ 0.388277] ---[ end trace a7f1f3ffa0ea1d28 ]---
[ 0.389358] Kernel panic - not syncing: Fatal exception
git bisect start 00667aaf171632d226c7c7fca267a079f73b9931 d5adbfcd5f7bcc6fa58a41c5c5ada0e5c826ce2c --
git bisect good 0feccff1c5df3fd2a3479a336a4728829685386a # 20:27 21+ 21 Merge 'pci/pci/aer' into devel-spot-201702101513
git bisect bad 38ef0935885d068ebfe6fa006209f5f28b2730b0 # 20:40 0- 2 Merge 'linux-review/Or-Gerlitz/net-mlx5e-Add-preemption-enable-disable-around-TC-statistics-upcall/20170210-005814' into devel-spot-201702101513
git bisect bad eeb64cd65c7de9ca4ee56377703a0b80349cc2ea # 20:58 0- 12 Merge 'arm64/for-next/core' into devel-spot-201702101513
git bisect good 4d039269f20b4a151b4055f214c1ef83b069e981 # 03:14 22+ 19 Merge 'linux-review/Ben-Gardner/eeprom-at24-use-device_property_-functions-instead-of-of_get_property/20170210-060909' into devel-spot-201702101513
git bisect bad 93cfd48226219b636fa1b7ea0f5570c69a529e8a # 03:57 0- 4 Merge 'linux-review/Philippe-Reynes/net-micrel-ksz884x-use-new-api-ethtool_-get-set-_link_ksettings/20170210-052528' into devel-spot-201702101513
git bisect good a6859423fcceb31c4f420a0e7d992c0969d94991 # 04:15 21+ 22 Merge 'linux-review/Avraham-Shukron/staging-omap4iss-fix-multiline-comment-style/20170210-050947' into devel-spot-201702101513
git bisect bad 5a4dc79a5a99841901be08ff8ce58f3ab70426b6 # 04:27 0- 5 Merge 'linux-review/Borislav-Petkov/x86-Optimize-clear_page/20170210-053052' into devel-spot-201702101513
git bisect bad 0ad07c8104eb5c12dfcb86581c1cc657183496cc # 04:50 0- 1 x86: Optimize clear_page()
# first bad commit: [0ad07c8104eb5c12dfcb86581c1cc657183496cc] x86: Optimize clear_page()
git bisect good 10b9dd56860e93f11cd352e8c75a33357b80b70b # 05:29 66+ 46 Merge tag 'nfs-for-4.9-4' of git://git.linux-nfs.org/projects/anna/linux-nfs
# extra tests with CONFIG_DEBUG_INFO_REDUCED
git bisect bad 0ad07c8104eb5c12dfcb86581c1cc657183496cc # 05:42 0- 32 x86: Optimize clear_page()
# extra tests on HEAD of linux-devel/devel-spot-201702101513
git bisect bad 00667aaf171632d226c7c7fca267a079f73b9931 # 05:42 0- 21 0day head guard for 'devel-spot-201702101513'
# extra tests on tree/branch linux-review/Borislav-Petkov/x86-Optimize-clear_page/20170210-053052
git bisect bad 0ad07c8104eb5c12dfcb86581c1cc657183496cc # 05:44 0- 26 x86: Optimize clear_page()
# extra tests with first bad commit reverted
git bisect good d9d04c9a587a9963e6df6b6b6622cd0eaa0a6d2a # 06:25 66+ 35 Revert "x86: Optimize clear_page()"
# extra tests on tree/branch linus/master
git bisect good 3d88460dbd285e7f32437b530d5bb7cb916142fa # 06:55 64+ 46 Merge tag 'drm-fixes-for-v4.10-rc8' of git://people.freedesktop.org/~airlied/linux
# extra tests on tree/branch linux-next/master
git bisect good 632571b1bee00494aef749512d9f3290dfba0ead # 07:10 63+ 38 Add linux-next specific files for 20170210
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
4 years
- 3
- 2