4becb7ee5b ("net/x25: Fix x25_neigh refcnt leak when x25 .."): [ 89.261843] BUG: kernel NULL pointer dereference, address: 00000074
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 4becb7ee5b3d2829ed7b9261a245a77d5b7de902
Author: Xiyu Yang <xiyuyang19(a)fudan.edu.cn>
AuthorDate: Sat Apr 25 21:06:25 2020 +0800
Commit: David S. Miller <davem(a)davemloft.net>
CommitDate: Mon Apr 27 11:20:30 2020 -0700
net/x25: Fix x25_neigh refcnt leak when x25 disconnect
x25_connect() invokes x25_get_neigh(), which returns a reference of the
specified x25_neigh object to "x25->neighbour" with increased refcnt.
When x25 connect success and returns, the reference still be hold by
"x25->neighbour", so the refcount should be decreased in
x25_disconnect() to keep refcount balanced.
The reference counting issue happens in x25_disconnect(), which forgets
to decrease the refcnt increased by x25_get_neigh() in x25_connect(),
causing a refcnt leak.
Fix this issue by calling x25_neigh_put() before x25_disconnect()
returns.
Signed-off-by: Xiyu Yang <xiyuyang19(a)fudan.edu.cn>
Signed-off-by: Xin Tan <tanxin.ctf(a)gmail.com>
Signed-off-by: David S. Miller <davem(a)davemloft.net>
095f5614bf net/tls: Fix sk_psock refcnt leak in bpf_exec_tx_verdict()
4becb7ee5b net/x25: Fix x25_neigh refcnt leak when x25 disconnect
+-------------------------------------------------------+------------+------------+
| | 095f5614bf | 4becb7ee5b |
+-------------------------------------------------------+------------+------------+
| boot_successes | 29 | 1 |
| boot_failures | 4 | 10 |
| BUG:kernel_timeout_in_boot_stage | 1 | |
| BUG:kernel_hang_in_test_stage | 2 | |
| BUG:kernel_hang_in_boot_stage | 1 | 1 |
| BUG:kernel_NULL_pointer_dereference,address | 0 | 9 |
| Oops:#[##] | 0 | 9 |
| EIP:x25_disconnect | 0 | 9 |
| Kernel_panic-not_syncing:Fatal_exception_in_interrupt | 0 | 9 |
| WARNING:at_lib/refcount.c:#refcount_warn_saturate | 0 | 1 |
| EIP:refcount_warn_saturate | 0 | 1 |
+-------------------------------------------------------+------------+------------+
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <lkp(a)intel.com>
Stopping syslogd/klogd: stopped syslogd (pid 459)
stopped klogd (pid 462)
done
Deconfiguring network interfaces... done.
Sending all processes the TERM signal...
[ 89.261843] BUG: kernel NULL pointer dereference, address: 00000074
[ 89.263892] #PF: supervisor write access in kernel mode
[ 89.264352] #PF: error_code(0x0002) - not-present page
[ 89.264799] *pde = 00000000
[ 89.265057] Oops: 0002 [#1] SMP
[ 89.265338] CPU: 1 PID: 785 Comm: trinity-c2 Not tainted 5.7.0-rc2-00379-g4becb7ee5b3d2 #1
[ 89.303957] EIP: x25_disconnect+0x81/0xbc
[ 89.304969] Code: b3 7c 02 00 00 75 0d 89 d8 ff 93 08 03 00 00 0f ba 6b 50 00 b8 a0 b9 f8 81 e8 a6 70 03 00 8b 8b 50 03 00 00 83 ca ff 8d 41 74 <f0> 0f c1 51 74 83 fa 01 75 09 89 c8 e8 12 32 81 ff eb 0e 85 d2 7f
[ 89.309273] EAX: 00000074 EBX: f25fb800 ECX: 00000000 EDX: ffffffff
[ 89.310597] ESI: 00000000 EDI: 00000008 EBP: f2ff5ed0 ESP: f2ff5ec0
[ 89.312086] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068 EFLAGS: 00010286
[ 89.313295] CR0: 80050033 CR2: 00000074 CR3: 72eb6000 CR4: 00140690
[ 89.314409] Call Trace:
[ 89.314796] x25_release+0x98/0xec
[ 89.317726] __sock_release+0x26/0x78
[ 89.318307] sock_close+0xd/0x11
[ 89.332917] __fput+0xe5/0x1a2
[ 89.333443] ____fput+0x8/0xa
[ 89.334210] task_work_run+0x53/0x76
[ 89.334789] do_exit+0x404/0x8f8
[ 89.335286] do_group_exit+0x82/0x82
[ 89.335833] __ia32_sys_exit_group+0x10/0x10
[ 89.336506] do_fast_syscall_32+0x8c/0xc5
[ 89.337749] entry_SYSENTER_32+0xaa/0x102
[ 89.338246] EIP: 0x77fc1c3d
[ 89.338588] Code: Bad RIP value.
[ 89.339050] EAX: ffffffda EBX: 00000000 ECX: 00000000 EDX: 00000000
[ 89.339782] ESI: 00000080 EDI: 09d30ef8 EBP: 0000006e ESP: 7fc0c0fc
[ 89.340549] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 007b EFLAGS: 00000216
[ 89.341451] Modules linked in:
[ 89.341834] CR2: 0000000000000074
[ 89.342300] ---[ end trace 4adddd6044784e2e ]---
[ 89.342971] EIP: x25_disconnect+0x81/0xbc
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start b54e1dda887def1d16df3f47692ce7fbaccfb7d1 6a8b55ed4056ea5559ebe4f6a4b247f627870d4c --
git bisect bad 8ea28476ea8059845ba55223fc779048553f4914 # 06:25 B 0 3 19 0 Merge 'nsaenz-linux-rpi/for-next' into devel-hourly-2020042823
git bisect bad 00be51a8460ac2298cf6515ca5ff90ec0214f986 # 07:05 B 0 4 20 0 Merge 'linux-review/Mason-Yang/mtd-spi-nor-macronix-Add-support-for-mx25l512-mx25u512/20200426-125136' into devel-hourly-2020042823
git bisect bad 5b07957c29cdcb3f9fd2850460abe343b3cb6edd # 07:56 B 0 2 18 0 Merge 'linux-review/Like-Xu/KVM-x86-pmu-Support-full-width-counting/20200428-055206' into devel-hourly-2020042823
git bisect bad ea46db9609519c8a9cbe7bfec63194adefd51a2d # 10:26 B 0 6 22 0 Merge 'linux-review/Ranjani-Sridharan/Kconfig-updates-for-DMIC-and-SOF-HDMI-support/20200428-093102' into devel-hourly-2020042823
git bisect good 98e97b9813c233f075a74c9a89e62e3ca35b00d3 # 14:34 G 10 0 0 0 Merge 'linux-review/Anders-Roxell/memory-tegra-mark-PM-functions-as-__maybe_unused/20200428-094935' into devel-hourly-2020042823
git bisect good e16c3f98a1906ef3b1a2c8d61c937b7a4f6a7628 # 16:07 G 11 0 0 0 Merge 'linux-review/sathyanarayanan-kuppuswamy-linux-intel-com/PCI-AER-Use-_OSC-negotiation-to-determine-AER-ownership/20200428-040550' into devel-hourly-2020042823
git bisect bad 60da1f95aa465e3b6ea917b753cfc8e8e0796459 # 17:01 B 1 1 1 1 Merge 'linux-review/Toke-H-iland-J-rgensen/wireguard-Use-tunnel-helpers-for-decapsulating-ECN-markings/20200428-082513' into devel-hourly-2020042823
git bisect good 7358cb29b9fd5a2553da6210e824052406698177 # 17:44 G 10 0 1 1 Merge 'linux-review/Eric-Dumazet/fq_codel-fix-TCA_FQ_CODEL_DROP_BATCH_SIZE-sanity-checks/20200427-190619' into devel-hourly-2020042823
git bisect good ffe419ae8a3e08aa9bad4878b99f5543d4ee5d6b # 18:17 G 10 0 0 0 Merge 'linux-review/UPDATE-20200428-085738/Sakari-Ailus/IPU3-ImgU-driver-parameter-struct-fixes/20200416-195812' into devel-hourly-2020042823
git bisect bad bae361c54fb6ac6eba3b4762f49ce14beb73ef13 # 18:56 B 0 4 20 0 bnxt_en: Improve AER slot reset.
git bisect bad 4becb7ee5b3d2829ed7b9261a245a77d5b7de902 # 19:28 B 0 2 18 0 net/x25: Fix x25_neigh refcnt leak when x25 disconnect
git bisect good 18e6719c141e472fe3b9dce2d089eb89fdbce0b5 # 20:05 G 10 0 3 3 Merge branch 'vsock-virtio-fixes-about-packet-delivery-to-monitoring-devices'
git bisect good 095f5614bfe16e5b3e191b34ea41b10d6fdd4ced # 21:02 G 10 0 1 1 net/tls: Fix sk_psock refcnt leak in bpf_exec_tx_verdict()
# first bad commit: [4becb7ee5b3d2829ed7b9261a245a77d5b7de902] net/x25: Fix x25_neigh refcnt leak when x25 disconnect
git bisect good 095f5614bfe16e5b3e191b34ea41b10d6fdd4ced # 21:14 G 30 0 1 2 net/tls: Fix sk_psock refcnt leak in bpf_exec_tx_verdict()
# extra tests with debug options
git bisect bad 4becb7ee5b3d2829ed7b9261a245a77d5b7de902 # 21:31 B 0 2 18 0 net/x25: Fix x25_neigh refcnt leak when x25 disconnect
# extra tests on revert first bad commit
git bisect good c56c1e56fe4c60e83308391f3faf5100ff5d3874 # 22:30 G 10 0 1 1 Revert "net/x25: Fix x25_neigh refcnt leak when x25 disconnect"
# good: [c56c1e56fe4c60e83308391f3faf5100ff5d3874] Revert "net/x25: Fix x25_neigh refcnt leak when x25 disconnect"
---
0-DAY CI Kernel Test Service, Intel Corporation
https://lists.01.org/hyperkitty/list/lkp@lists.01.org
1 month
- 1
- 0
Re: [mm/debug] fa6726c1e7: kernel_BUG_at_include/linux/mm.h
by Catalin Marinas
On Tue, Apr 28, 2020 at 04:41:11AM -0400, Qian Cai wrote:
> On Apr 28, 2020, at 1:54 AM, Anshuman Khandual <Anshuman.Khandual(a)arm.com> wrote:
> > That is true. There is a slight change in the rules, making it explicit yes
> > only when both ARCH_HAS_DEBUG_VM_PGTABLE and DEBUG_VM are enabled.
> >
> > +config DEBUG_VM_PGTABLE
> > + bool "Debug arch page table for semantics compliance"
> > + depends on MMU
> > + depends on !IA64 && !ARM
> > + depends on ARCH_HAS_DEBUG_VM_PGTABLE || EXPERT
> > + default y if ARCH_HAS_DEBUG_VM_PGTABLE && DEBUG_VM
> > + help
> >
> > The default is really irrelevant as the config option can be set explicitly.
>
> That could also explain. Since not long time ago, it was only “default
> y if DEBUG_VM”, that caused the robot saved a .config with
> DEBUG_VM_PGTABLE=y by default.
>
> Even though you changed the rule recently, it has no effect as the
> robot could “make oldconfig” from the saved config for each linux-next
> tree execution and the breakage will go on.
I'm not entirely sure that's the case. This report still points at the
old commit fa6726c1e7 which has:
+ depends on ARCH_HAS_DEBUG_VM_PGTABLE || EXPERT
+ default n if !ARCH_HAS_DEBUG_VM_PGTABLE
+ default y if DEBUG_VM
In -next we now have commit 647d9a0de34c and subsequently modified by
commit 0a8646638865. So hopefully with the latest -next tree we won't
see this report.
We could as well remove the 'depends on ... || EXPERT' part but I'd
rather leave this around with a default n (as in current -next) in case
others want to have a go. If that's still causing problems, we can
remove the '|| EXPERT' part, so there won't be any further regressions.
--
Catalin
1 month
- 4
- 5
90f0081848 ("kernfs: fix possibility of NULL pointer .."): WARNING: lock held when returning to user space!
by kernel test robot
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
https://github.com/0day-ci/linux/commits/youngjun/kernfs-fix-possibility-...
commit 90f0081848b85a7943dab6b1036c40f68ee60264
Author: youngjun <her0gyugyu(a)gmail.com>
AuthorDate: Mon Apr 27 09:48:36 2020 -0700
Commit: 0day robot <lkp(a)intel.com>
CommitDate: Tue Apr 28 09:27:55 2020 +0800
kernfs: fix possibility of NULL pointer dereference.
When dentry is negative, "kernfs_dentry_node" returns NULL.
In this case, "kernfs_root" dereferences NULL pointer.
Signed-off-by: youngjun <her0gyugyu(a)gmail.com>
96fa72ffb2 Merge 5.7-rc3 into driver-core-next
90f0081848 kernfs: fix possibility of NULL pointer dereference.
+------------------------------------------------+------------+------------+
| | 96fa72ffb2 | 90f0081848 |
+------------------------------------------------+------------+------------+
| boot_successes | 41 | 6 |
| boot_failures | 0 | 8 |
| WARNING:lock_held_when_returning_to_user_space | 0 | 8 |
| is_leaving_the_kernel_with_locks_still_held | 0 | 8 |
+------------------------------------------------+------------+------------+
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <lkp(a)intel.com>
[child3:684] vm86old (113) returned ENOSYS, marking as inactive.
[child1:686] io_cancel (249) returned ENOSYS, marking as inactive.
[child1:686] mq_getsetattr (282) returned ENOSYS, marking as inactive.
[ 18.050958]
[ 18.051083] ================================================
[ 18.051565] WARNING: lock held when returning to user space!
[ 18.052193] 5.7.0-rc3-00008-g90f0081848b85a #1 Not tainted
[ 18.052819] ------------------------------------------------
[ 18.053465] trinity-c1/686 is leaving the kernel with locks still held!
[ 18.054215] 1 lock held by trinity-c1/686:
[ 18.054687] #0: f42f28f8 (kn->active#6){++++}-{0:0}, at: kernfs_iop_rename+0x2b/0xd0
[child2:683] mq_getsetattr (282) returned ENOSYS, marking as inactive.
[child2:683] pkey_alloc (381) returned ENOSYS, marking as inactive.
[ 18.077451] VFS: Warning: trinity-c1 using old stat() call. Recompile your binary.
[child1:686] io_setup (245) returned ENOSYS, marking as inactive.
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start 6af4b6f59d9d3cd72325056b7b25cf9016952263 6a8b55ed4056ea5559ebe4f6a4b247f627870d4c --
git bisect bad 705b896e3b86bfc9653f17c55c1c23b6e6369aad # 05:30 B 1 1 0 0 Merge 'linux-review/yuiko-oshino-microchip-com/net-phy-microchip_t1-add-lan87xx_phy_init-to-initialize-the-lan87xx-phy/20200422-105747' into devel-hourly-2020042821
git bisect bad d2f89f2e48319d5aa0916afb7409ba79a111bdca # 05:56 B 0 3 19 0 Merge 'linux-review/Shijie-Hu/hugetlbfs-Get-unmapped-area-below-TASK_UNMAPPED_BASE-for-hugetlbfs/20200428-071603' into devel-hourly-2020042821
git bisect good d6b6606d1fab7b5c0dcc6b71266136c8bf423eb1 # 06:41 G 13 0 0 0 Merge 'linux-review/David-Ahern/net-Add-support-for-XDP-in-egress-path/20200428-135444' into devel-hourly-2020042821
git bisect bad 6488dc0bee3801181a7e064817cff5cf0838ea47 # 07:04 B 1 4 0 0 Merge 'linux-review/Nishad-Kamdar/NFS-Use-the-correct-style-for-SPDX-License-Identifier/20200427-164819' into devel-hourly-2020042821
git bisect bad eadb2a0d40b96f5a93dd880e60b92656d8a358fe # 07:34 B 0 4 21 0 Merge 'linux-review/Wei-Yongjun/ath11k-use-GFP_ATOMIC-under-spin-lock/20200428-062853' into devel-hourly-2020042821
git bisect bad c2f6bab338be7aedaa3b4f5b14b2d9b1e98fa950 # 08:29 B 0 1 17 0 Merge 'linux-review/Wei-Yongjun/ath11k-remove-redundant-dev_err-call-in-ath11k_ahb_probe/20200428-070454' into devel-hourly-2020042821
git bisect bad 6d50d87806ace0b238c44be99e163f028e62b312 # 09:23 B 1 3 0 0 Merge 'linux-review/Anthony-Felice/net-tc35815-Fix-phydev-supported-advertising-mask/20200428-044618' into devel-hourly-2020042821
git bisect bad 3ae490f0ef7a579e0009e63e7a368f0bc2868fcf # 10:07 B 2 5 0 0 Merge 'linux-review/youngjun/kernfs-fix-possibility-of-NULL-pointer-dereference/20200428-092748' into devel-hourly-2020042821
git bisect good 1463aa7c6bee023a635540246f9b1e99e0c23f3f # 10:36 G 14 0 0 0 Merge 'linux-review/Gustavo-A-R-Silva/mtd-lpddr-Fix-bad-logic-bug-in-print_drs_error/20200428-120038' into devel-hourly-2020042821
git bisect good 69b07ee33eb12a505d55e3e716fc7452496b9041 # 13:32 G 14 0 1 1 debugfs: Use the correct style for SPDX License Identifier
git bisect good fbc35b45f9f6a971341b9462c6e94c257e779fb5 # 14:30 G 13 0 1 1 Add documentation on meaning of -EPROBE_DEFER
git bisect bad 90f0081848b85a7943dab6b1036c40f68ee60264 # 15:54 B 0 1 17 0 kernfs: fix possibility of NULL pointer dereference.
git bisect good 96fa72ffb2155dba9ba8c5d282a1ff19ed32f177 # 16:12 G 13 0 0 0 Merge 5.7-rc3 into driver-core-next
# first bad commit: [90f0081848b85a7943dab6b1036c40f68ee60264] kernfs: fix possibility of NULL pointer dereference.
git bisect good 96fa72ffb2155dba9ba8c5d282a1ff19ed32f177 # 16:20 G 39 0 1 1 Merge 5.7-rc3 into driver-core-next
# extra tests with debug options
git bisect bad 90f0081848b85a7943dab6b1036c40f68ee60264 # 17:00 B 1 1 0 0 kernfs: fix possibility of NULL pointer dereference.
# extra tests on head commit of linux-review/youngjun/kernfs-fix-possibility-of-NULL-pointer-dereference/20200428-092748
git bisect bad 90f0081848b85a7943dab6b1036c40f68ee60264 # 17:17 B 6 8 0 0 kernfs: fix possibility of NULL pointer dereference.
# bad: [90f0081848b85a7943dab6b1036c40f68ee60264] kernfs: fix possibility of NULL pointer dereference.
# extra tests on revert first bad commit
git bisect good cc2b347449ca6666b089dca93c3769e9e8813440 # 18:59 G 13 0 0 0 Revert "kernfs: fix possibility of NULL pointer dereference."
# good: [cc2b347449ca6666b089dca93c3769e9e8813440] Revert "kernfs: fix possibility of NULL pointer dereference."
---
0-DAY CI Kernel Test Service, Intel Corporation
https://lists.01.org/hyperkitty/list/lkp@lists.01.org
1 month
- 1
- 0
7322464a68 ("nsproxy: attach to namespaces via pidfds"): WARNING: CPU: 0 PID: 808 at lib/refcount.c:25 refcount_warn_saturate
by kernel test robot
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
https://github.com/0day-ci/linux/commits/Christian-Brauner/nsproxy-attach...
commit 7322464a68c444dccde385b3b696f48e6d1bb5cc
Author: Christian Brauner <christian.brauner(a)ubuntu.com>
AuthorDate: Mon Apr 27 16:36:46 2020 +0200
Commit: 0day robot <lkp(a)intel.com>
CommitDate: Tue Apr 28 08:20:37 2020 +0800
nsproxy: attach to namespaces via pidfds
For quite a while we have been thinking about using pidfds to attach to
namespaces. This patchset has existed for about a year already but we've
wanted to wait to see how the general api would be received and adopted.
Now that more and more programs in userspace have started using pidfds
for process management it's time to send this one out.
This patch makes it possible to use pidfds to attach to the namespaces
of another process, i.e. they can be passed as the first argument to the
setns() syscall. When only a single namespace type is specified the
semantics are equivalent to passing an nsfd. That means
setns(nsfd, CLONE_NEWNET) equals setns(pidfd, CLONE_NEWNET). However,
when a pidfd is passed, multiple namespace flags can be specified in the
second setns() argument and setns() will attach the caller to all the
specified namespaces all at once or to none of them. If 0 is specified
together with a pidfd then setns() will interpret it the same way 0 is
interpreted together with a nsfd argument, i.e. attach to any/all
namespaces.
The obvious example where this is useful is a standard container
manager interacting with a running container: pushing and pulling files
or directories, injecting mounts, attaching/execing any kind of process,
managing network devices all these operations require attaching to all
or at least multiple namespaces at the same time. Given that nowadays
most containers are spawned with all namespaces enabled we're currently
looking at at least 14 syscalls, 7 to open the /proc/<pid>/ns/<ns>
nsfds, another 7 to actually perform the namespace switch. With time
namespaces we're looking at about 16 syscalls.
(We could amortize the first 7 or 8 syscalls for opening the nsfds by
stashing them in each container's monitor process but that would mean
we need to send around those file descriptors through unix sockets
everytime we want to interact with the container or keep on-disk
state. Even in scenarios where a caller wants to join a particular
namespace in a particular order callers still profit from batching
other namespaces. That mostly applies to the user namespace but
all container runtimes I found join the user namespace first no matter
if it privileges or deprivileges the container.)
With pidfds this becomes a single syscall no matter how many namespaces
are supposed to be attached to.
A decently designed, large-scale container manager usually isn't the
parent of any of the containers it spawns so the containers don't die
when it crashes or needs to update or reinitialize. This means that
for the manger to interact with containers through pids is inherently
racy especially on systems where the maximum pid number is not
signficianly bumped. This is even more problematic since we often spawn
and manage thousands or ten-thousands of containers. Interacting with a
container through a pid thus can become risky quite quickly. Especially
since we allow for an administrator to enable advanced features such as
syscall interception where we're performing syscalls in lieu of the
container. In all of those cases we use pidfds if they are available and
we pass them around as stable references. Using them to setns() to the
target process namespaces is as reliable as using nsfds. Either the
target process is already dead and we get ESRCH or we manage to attach
to its namespaces but we can't accidently attach to another process'
namespaces. So pidfds lend themselves to be used with this api.
Apart from significiantly reducing the number of syscalls from double
digit to single digit which is a decent reason post-spectre/meltdown
this also allows to switch to a set of namespaces atomically, i.e.
either attaching to all the specified namespaces succeeds or we fail. If
we fail we haven't changed a single namespace. There are currently three
namespaces that can fail (other than for ENOMEM which really is not
very interesting since we then have other problems anyway) for
non-trivial reasons, user, mount, and pid namespaces. We can fail to
attach to a pid namespace if it is not our current active pid namespace
or a descendant of it. We can fail to attach to a user namespace because
we are multi-threaded, because our current mount namespace shares
filesystem state with other tasks, or because we're trying to setns()
to the same user namespace, i.e. the target task has the same user
namespace as we do. We can fail to attach to a mount namespace because
it shares filesystem state with other tasks or because we fail to lookup
the new root for the new mount namespace. In most non-pathological
scenarios these issues can be somewhat mitigated. But there's e.g.
still an inherent race between trying to setns() to the mount namespace
of a task and that task spawning a child with CLONE_FS. If that process
runs in a new user namespace we must have already setns()ed into the new
user namespace otherwise we fail to attach to the mount namespace. There
are other cases similar to that and we've had issues where we're
half-attached to some namespace and failing in the middle. I've talked
about some of these problem during the hallway track (something only the
pre-COVID-19 generation will remember) of Plumber in Los Angeles in
2018(?). Even if all these issues could be avoided with super careful
userspace coding it would be nicer to have this done in-kernel. There's
not a lot of cost associated with this extension for the kernel and
pidfds seem to lend themselves nicely for this.
Cc: Eric W. Biederman <ebiederm(a)xmission.com>
Cc: Serge Hallyn <serge(a)hallyn.com>
Cc: Aleksa Sarai <cyphar(a)cyphar.com>
Signed-off-by: Christian Brauner <christian.brauner(a)ubuntu.com>
51184ae37e Merge tag 'for-5.7-rc3-tag' of git://git.kernel.org/pub/scm/linux/kernel/git/kdave/linux
7322464a68 nsproxy: attach to namespaces via pidfds
+---------------------------------------------------+------------+------------+
| | 51184ae37e | 7322464a68 |
+---------------------------------------------------+------------+------------+
| boot_successes | 44 | 0 |
| boot_failures | 1 | 16 |
| Mem-Info | 1 | |
| BUG:kernel_NULL_pointer_dereference,address | 0 | 10 |
| Oops:#[##] | 0 | 16 |
| EIP:__ia32_sys_setns | 0 | 11 |
| Kernel_panic-not_syncing:Fatal_exception | 0 | 16 |
| WARNING:at_lib/refcount.c:#refcount_warn_saturate | 0 | 6 |
| EIP:refcount_warn_saturate | 0 | 6 |
| BUG:unable_to_handle_page_fault_for_address | 0 | 6 |
| EIP:get_pid_task | 0 | 5 |
+---------------------------------------------------+------------+------------+
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <lkp(a)intel.com>
[ 9.233966] VFS: Warning: trinity-c3 using old stat() call. Recompile your binary.
[child3:813] set_mempolicy (276) returned ENOSYS, marking as inactive.
[ 9.237518] warning: process `trinity-c2' used the deprecated sysctl system call with
[ 9.238724] ------------[ cut here ]------------
[ 9.239358] refcount_t: addition on 0; use-after-free.
[ 9.240095] WARNING: CPU: 0 PID: 808 at lib/refcount.c:25 refcount_warn_saturate+0xba/0x120
[ 9.241429] Modules linked in:
[ 9.241851] CPU: 0 PID: 808 Comm: trinity-c3 Tainted: G S 5.7.0-rc3-00013-g7322464a68c44 #1
[ 9.243138] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 9.244244] EIP: refcount_warn_saturate+0xba/0x120
[ 9.244884] Code: 58 e9 87 00 00 00 8d b4 26 00 00 00 00 8d 76 00 80 3d f4 84 f2 d1 00 75 74 68 24 07 bc d1 c6 05 f4 84 f2 d1 01 e8 36 56 c9 ff <0f> 0b 58 eb 5e 90 80 3d f3 84 f2 d1 00 75 54 68 50 07 bc d1 c6 05
[ 9.247345] EAX: 0000002a EBX: f66d0b44 ECX: 0000008b EDX: f7314300
[ 9.248175] ESI: 00000000 EDI: f7314300 EBP: f7317f64 ESP: f7317f60
[ 9.249001] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 0068 EFLAGS: 00010292
[ 9.249909] CR0: 80050033 CR2: b6d3c000 CR3: 2c9e6000 CR4: 000006d0
[ 9.250755] Call Trace:
[ 9.251099] get_pid_task+0x5e/0xa0
[ 9.251576] __ia32_sys_setns+0xcd/0x440
[ 9.252100] ? __task_pid_nr_ns+0xb7/0xd0
[ 9.252643] do_int80_syscall_32+0x45/0xd0
[ 9.253199] entry_INT80_32+0xf4/0xf4
[ 9.253691] EIP: 0x809b132
[ 9.254065] Code: 89 c8 c3 90 8d 74 26 00 85 c0 c7 01 01 00 00 00 75 d8 a1 6c 94 a8 08 eb d1 66 90 66 90 66 90 66 90 66 90 66 90 66 90 90 cd 80 <c3> 8d b6 00 00 00 00 8d bc 27 00 00 00 00 8b 10 a3 94 94 a8 08 85
[ 9.256568] EAX: ffffffda EBX: 0000011c ECX: 00000000 EDX: 4a03bed6
[ 9.257399] ESI: fffffffb EDI: 0d258544 EBP: 0000c000 ESP: bfea7cd8
[ 9.258231] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 007b EFLAGS: 00000296
[ 9.259145] ---[ end trace 6da55ee5a0c4840d ]---
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start 5d84712bd468a94c6dc944824cbe62278e9ba112 6a8b55ed4056ea5559ebe4f6a4b247f627870d4c --
git bisect bad 56a717a7c44e387d6d9ac05bdb00177ed94073c7 # 02:19 B 0 1 17 0 Merge 'linux-review/Chuck-Lever/NFS-RDMA-client-patches-for-v5-7-rc/20200421-201520' into devel-hourly-2020042818
git bisect bad 6b419cca3362544aa5b545cfd147f80268dbf995 # 02:48 B 0 4 20 0 Merge 'linux-review/Nishad-Kamdar/f2fs-Use-the-correct-style-for-SPDX-License-Identifier/20200427-163732' into devel-hourly-2020042818
git bisect good 31d4507e44281e3a526306083d7240ae9727ca59 # 03:18 G 13 0 0 0 Merge 'linux-review/Denis-Kirjanov/xen-networking-add-basic-XDP-support-for-xen-netfront/20200428-083754' into devel-hourly-2020042818
git bisect bad 39c0c195552fd7f3999a276a4d32a04f990541a4 # 03:53 B 1 3 1 1 Merge 'linux-review/Mateusz-Gorski/Add-support-for-different-DMIC-configurations/20200428-074312' into devel-hourly-2020042818
git bisect good 57e099d6b915c6fdf563859662b3c49766011ba9 # 04:29 G 13 0 6 6 Merge 'linux-review/Jin-Yao/perf-stat-Fix-uncore-event-mixed-metric-with-workload-error-issue/20200428-082344' into devel-hourly-2020042818
git bisect good 01c0ef45fd240689365da8765fe716700fac6ad6 # 05:00 G 13 0 4 4 Merge 'linux-review/Nishad-Kamdar/NFS-Use-the-correct-style-for-SPDX-License-Identifier/20200427-164819' into devel-hourly-2020042818
git bisect good 864d22c79992955a3bcb81ec9b65be07ffdfe3a4 # 08:35 G 14 0 7 7 Merge 'linux-review/Marek-Szyprowski/Minor-WM8994-MFD-codec-fixes/20200428-055602' into devel-hourly-2020042818
git bisect good 1ac57c71a6f74f5d705f4718bc0cad04b9de22b7 # 09:19 G 13 0 7 7 Merge 'linux-review/madhuparnabhowmik10-gmail-com/rapidio-Avoid-data-race-between-file-operation-callbacks-and-mport_cdev_add/20200428-031110' into devel-hourly-2020042818
git bisect good 98d171a4cb8c07fa091f8ad5cbe9187771ce15ef # 10:06 G 13 0 6 6 Merge 'linux-review/Masahiro-Yamada/kbuild-remove-target/20200427-162454' into devel-hourly-2020042818
git bisect bad 771b1c0092cd189d26703e37d6d5a62d064841d4 # 10:53 B 1 1 1 1 Merge 'linux-review/Christian-Brauner/nsproxy-attach-to-namespaces-via-pidfds/20200428-082028' into devel-hourly-2020042818
git bisect bad 7322464a68c444dccde385b3b696f48e6d1bb5cc # 15:15 B 1 3 1 1 nsproxy: attach to namespaces via pidfds
# first bad commit: [7322464a68c444dccde385b3b696f48e6d1bb5cc] nsproxy: attach to namespaces via pidfds
git bisect good 51184ae37e0518fd90cb437a2fbc953ae558cd0d # 16:08 G 47 0 5 5 Merge tag 'for-5.7-rc3-tag' of git://git.kernel.org/pub/scm/linux/kernel/git/kdave/linux
# extra tests with debug options
git bisect bad 7322464a68c444dccde385b3b696f48e6d1bb5cc # 16:41 B 3 1 3 3 nsproxy: attach to namespaces via pidfds
# extra tests on head commit of linux-review/Christian-Brauner/nsproxy-attach-to-namespaces-via-pidfds/20200428-082028
git bisect bad 7322464a68c444dccde385b3b696f48e6d1bb5cc # 16:48 B 0 11 32 5 nsproxy: attach to namespaces via pidfds
# bad: [7322464a68c444dccde385b3b696f48e6d1bb5cc] nsproxy: attach to namespaces via pidfds
# extra tests on revert first bad commit
git bisect good a845404448ebed36cbab42e09ce85fcebd48e701 # 17:19 G 15 0 1 1 Revert "nsproxy: attach to namespaces via pidfds"
# good: [a845404448ebed36cbab42e09ce85fcebd48e701] Revert "nsproxy: attach to namespaces via pidfds"
---
0-DAY CI Kernel Test Service, Intel Corporation
https://lists.01.org/hyperkitty/list/lkp@lists.01.org
1 month
- 1
- 0
[tracing] 06e0a548ba: WARNING:at_kernel/trace/ring_buffer.c:#ring_buffer_iter_peek
by kernel test robot
Greeting,
FYI, we noticed the following commit (built with gcc-7):
commit: 06e0a548bad0f43a21e036db018e4dadb501ce8b ("tracing: Do not disable tracing when reading the trace file")
https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git master
in testcase: kernel-selftests
with following parameters:
group: kselftests-01
ucode: 0x500002c
test-description: The kernel contains a set of "self tests" under the tools/testing/selftests/ directory. These are intended to be small unit tests to exercise individual code paths in the kernel.
test-url: https://www.kernel.org/doc/Documentation/kselftest.txt
on test machine: 192 threads Intel(R) Xeon(R) Platinum 9242 CPU @ 2.30GHz with 192G memory
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <lkp(a)intel.com>
kern :warn : [ 886.763510] WARNING: CPU: 70 PID: 22584 at kernel/trace/ring_buffer.c:4067 ring_buffer_iter_peek+0x13c/0x1d0
kern :warn : [ 886.776216] Modules linked in: test_firmware intel_rapl_msr intel_rapl_common skx_edac nfit libnvdimm btrfs x86_pkg_temp_thermal intel_powerclamp blake2b_generic xor zstd_decompress zstd_compress coretemp ast kvm_intel kvm raid6_pq drm_vram_helper drm_ttm_helper libcrc32c irqbypass ttm crct10dif_pclmul crc32_pclmul drm_kms_helper snd_pcm crc32c_intel ghash_clmulni_intel ahci snd_timer syscopyarea libahci aesni_intel ipmi_ssif sysfillrect snd crypto_simd sysimgblt cryptd nvme fb_sys_fops mei_me soundcore ipmi_si glue_helper pcspkr drm nvme_core ioatdma ipmi_devintf t10_pi libata mei i2c_i801 joydev lpc_ich dca ipmi_msghandler wmi acpi_pad acpi_power_meter ip_tables
kern :warn : [ 886.838112] CPU: 70 PID: 22584 Comm: cat Not tainted 5.6.0-rc4-00017-g06e0a548bad0f #1
kern :warn : [ 886.846573] RIP: 0010:ring_buffer_iter_peek+0x13c/0x1d0
kern :warn : [ 886.852355] Code: 41 5e 41 5f c3 83 38 1d 0f 85 98 00 00 00 48 89 df e8 78 cb ff ff e9 32 ff ff ff 80 3c 24 00 75 c8 49 8b 44 24 10 f0 ff 40 08 <0f> 0b 4c 89 f6 4c 89 ef e8 37 8c 8f 00 48 83 c4 08 31 c0 5b 5d 41
kern :warn : [ 886.872239] RSP: 0018:ffffc900213e7d78 EFLAGS: 00010002
kern :warn : [ 886.878030] RAX: ffff889883ea7740 RBX: ffff88a3fbd93720 RCX: ffff88a42101b700
kern :warn : [ 886.885731] RDX: ffff88a415c02e00 RSI: ffff88a42101b440 RDI: ffff88a3fbd93720
kern :warn : [ 886.893432] RBP: 0000000000000000 R08: 000000ce959ae6ab R09: ffff88a42101bb80
kern :warn : [ 886.901129] R10: ffff88a3e99e2300 R11: 0000000000000178 R12: ffff88a415c02e00
kern :warn : [ 886.908831] R13: ffff88a415c02e18 R14: 0000000000000296 R15: ffffc900213e7df8
kern :warn : [ 886.916521] FS: 00007f12d51d2640(0000) GS:ffff88a44f780000(0000) knlGS:0000000000000000
kern :warn : [ 886.925179] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
kern :warn : [ 886.931495] CR2: 00007f12d4e36000 CR3: 00000023e901e006 CR4: 00000000007606e0
kern :warn : [ 886.939194] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
kern :warn : [ 886.946896] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
kern :warn : [ 886.954588] PKRU: 55555554
kern :warn : [ 886.957858] Call Trace:
kern :warn : [ 886.960866] peek_next_entry+0x22/0x70
kern :warn : [ 886.965165] __find_next_entry+0xaf/0x180
kern :warn : [ 886.969714] trace_find_next_entry_inc+0x1e/0x80
kern :warn : [ 886.974863] s_next+0x49/0x70
kern :warn : [ 886.978355] seq_read+0x23f/0x400
kern :warn : [ 886.982193] vfs_read+0x9b/0x160
kern :warn : [ 886.985937] ksys_read+0xa1/0xe0
kern :warn : [ 886.989677] do_syscall_64+0x5b/0x1f0
kern :warn : [ 886.993853] entry_SYSCALL_64_after_hwframe+0x44/0xa9
kern :warn : [ 886.999408] RIP: 0033:0x7f12d50f559e
kern :warn : [ 887.003479] Code: c0 e9 c6 fe ff ff 50 48 8d 3d 36 fc 09 00 e8 e9 e7 01 00 66 0f 1f 84 00 00 00 00 00 64 8b 04 25 18 00 00 00 85 c0 75 14 0f 05 <48> 3d 00 f0 ff ff 77 5a c3 66 0f 1f 84 00 00 00 00 00 48 83 ec 28
kern :warn : [ 887.023260] RSP: 002b:00007ffdab31acd8 EFLAGS: 00000246 ORIG_RAX: 0000000000000000
kern :warn : [ 887.031350] RAX: ffffffffffffffda RBX: 0000000000020000 RCX: 00007f12d50f559e
kern :warn : [ 887.039006] RDX: 0000000000020000 RSI: 00007f12d4e36000 RDI: 0000000000000005
kern :warn : [ 887.046657] RBP: 00007f12d4e36000 R08: 00007f12d4e35010 R09: 0000000000000000
kern :warn : [ 887.054305] R10: fffffffffffffc4d R11: 0000000000000246 R12: 00007f12d4e36000
kern :warn : [ 887.061958] R13: 0000000000000005 R14: 0000000000020000 R15: 0000000000000f93
kern :warn : [ 887.069608] ---[ end trace 507492ef8332a5b4 ]---
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp install job.yaml # job file is attached in this email
bin/lkp run job.yaml
Thanks,
lkp
1 month
- 1
- 0
[fs] ce436509a8: ltp.openat203.fail
by kernel test robot
Greeting,
FYI, we noticed the following commit (built with gcc-7):
commit: ce436509a8e109330c56bb4d8ec87d258788f5f4 ("[PATCH v4 2/3] fs: openat2: Extend open_how to allow userspace-selected fds")
url: https://github.com/0day-ci/linux/commits/Josh-Triplett/Support-userspace-...
base: https://git.kernel.org/cgit/linux/kernel/git/shuah/linux-kselftest.git next
in testcase: ltp
with following parameters:
disk: 1HDD
fs: ext4
test: syscalls_part4
test-description: The LTP testsuite contains a collection of tools for testing the Linux kernel and related features.
test-url: http://linux-test-project.github.io/
on test machine: qemu-system-x86_64 -enable-kvm -cpu SandyBridge -smp 2 -m 8G
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <rong.a.chen(a)intel.com>
<<<test_start>>>
tag=openat203 stime=1587952903
cmdline="openat203"
contacts=""
analysis=exit
<<<test_output>>>
tst_buffers.c:55: INFO: Test is using guarded buffers
tst_test.c:1246: INFO: Timeout per run is 0h 05m 00s
openat203.c:67: PASS: invalid-dfd: openat2() failed as expected: EBADF (9)
openat203.c:67: PASS: invalid-pathname: openat2() failed as expected: EFAULT (14)
openat203.c:67: PASS: invalid-flags: openat2() failed as expected: EINVAL (22)
openat203.c:67: PASS: invalid-mode: openat2() failed as expected: EINVAL (22)
openat203.c:67: PASS: invalid-resolve: openat2() failed as expected: EINVAL (22)
openat203.c:67: PASS: invalid-size-zero: openat2() failed as expected: EINVAL (22)
openat203.c:67: PASS: invalid-size-small: openat2() failed as expected: EINVAL (22)
openat203.c:67: PASS: invalid-size-big: openat2() failed as expected: EFAULT (14)
openat203.c:63: FAIL: invalid-size-big-with-pad: openat2() should fail with E2BIG: EINVAL (22)
Summary:
passed 8
failed 1
skipped 0
warnings 0
<<<execution_status>>>
initiation_status="ok"
duration=0 termination_type=exited termination_id=1 corefile=no
cutime=0 cstime=0
<<<test_end>>>
To reproduce:
# build kernel
cd linux
cp config-5.7.0-rc1-00005-gce436509a8e10 .config
make HOSTCC=gcc-7 CC=gcc-7 ARCH=x86_64 olddefconfig prepare modules_prepare bzImage modules
make HOSTCC=gcc-7 CC=gcc-7 ARCH=x86_64 INSTALL_MOD_PATH=<mod-install-dir> modules_install
cd <mod-install-dir>
find lib/ | cpio -o -H newc --quiet | gzip > modules.cgz
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> -m modules.cgz job-script # job-script is attached in this email
Thanks,
Rong Chen
1 month, 1 week
- 3
- 4
[mm] b79980a586: WARNING:at_kernel/locking/lockdep.c:#__lock_acquire
by kernel test robot
Greeting,
FYI, we noticed the following commit (built with gcc-7):
commit: b79980a586f5a910ee92b360e55e2aabf33981ff ("mm: Move pt_mm within struct page")
git://git.infradead.org/users/willy/linux-dax.git pt_mm
in testcase: trinity
with following parameters:
runtime: 300s
test-description: Trinity is a linux system call fuzz tester.
test-url: http://codemonkey.org.uk/projects/trinity/
on test machine: qemu-system-x86_64 -enable-kvm -cpu SandyBridge -smp 2 -m 8G
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
+-----------------------------------------------------------+----------+------------+
| | v5.7-rc3 | b79980a586 |
+-----------------------------------------------------------+----------+------------+
| boot_successes | 29 | 0 |
| boot_failures | 17 | 4 |
| BUG:unable_to_handle_page_fault_for_address | 1 | |
| Oops:#[##] | 2 | 4 |
| Kernel_panic-not_syncing:Fatal_exception | 2 | 4 |
| BUG:kernel_NULL_pointer_dereference,address | 1 | 4 |
| RIP:__rb_erase_color | 1 | |
| BUG:kernel_hang_in_boot_stage | 5 | |
| Assertion_failed | 4 | |
| Kernel_panic-not_syncing:Attempted_to_kill_init!exitcode= | 9 | |
| BUG:workqueue_lockup-pool | 1 | |
| WARNING:at_kernel/locking/lockdep.c:#__lock_acquire | 0 | 4 |
| RIP:__lock_acquire | 0 | 4 |
+-----------------------------------------------------------+----------+------------+
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <lkp(a)intel.com>
[ 2.549572] WARNING: CPU: 0 PID: 0 at kernel/locking/lockdep.c:183 __lock_acquire+0x707/0x1910
[ 2.550743] Modules linked in:
[ 2.550743] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 5.7.0-rc3-00001-gb79980a586f5a #1
[ 2.550743] RIP: 0010:__lock_acquire+0x707/0x1910
[ 2.550743] Code: a1 15 24 a5 48 c7 c7 59 12 13 a5 e8 43 f4 f8 ff 0f 0b e9 29 fb ff ff 48 c7 c6 a1 15 24 a5 48 c7 c7 59 12 13 a5 e8 29 f4 f8 ff <0f> 0b 31 c0 e9 c7 fa ff ff 41 bf 01 00 00 00 48 89 0b 41 8b 85 68
[ 2.550743] RSP: 0000:ffffffffa5603ca8 EFLAGS: 00010082
[ 2.550743] RAX: 0000000000000000 RBX: ffffffffa567c558 RCX: 0000000097ea2c7c
[ 2.550743] RDX: 0000000000000016 RSI: ffffffffa27ad1a3 RDI: ffffffffa27ad1ea
[ 2.550743] RBP: ffffffffa5603d28 R08: 0000000000000001 R09: 0000000000000000
[ 2.550743] R10: 0000000000000000 R11: 2931284e4f5f4e52 R12: bd981937e545b767
[ 2.550743] R13: ffffffffa567b8c0 R14: 0000000000000001 R15: 0000000000000017
[ 2.550743] FS: 0000000000000000(0000) GS:ffff8979f7c00000(0000) knlGS:0000000000000000
[ 2.550743] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 2.550743] CR2: 00000000ffffffff CR3: 0000000035272000 CR4: 00000000000406b0
[ 2.550743] Call Trace:
[ 2.550743] ? cpu_bugs_smt_update+0x13/0x2d0
[ 2.550743] lock_acquire+0xa0/0x390
[ 2.550743] ? sync_global_pgds_l4+0x114/0x170
[ 2.550743] ? find_held_lock+0x35/0xa0
[ 2.550743] ? cpu_bugs_smt_update+0x112/0x2d0
[ 2.550743] _raw_spin_lock+0x2a/0x40
[ 2.550743] ? sync_global_pgds_l4+0x114/0x170
[ 2.550743] sync_global_pgds_l4+0x114/0x170
[ 2.550743] sync_global_pgds+0x9/0x10
[ 2.550743] vmalloc_sync_mappings+0x2a/0x30
[ 2.550743] register_die_notifier+0xd/0x20
[ 2.550743] alternative_instructions+0x2a/0x125
[ 2.550743] check_bugs+0x832/0x8a5
[ 2.550743] start_kernel+0x4e9/0x515
[ 2.550743] x86_64_start_reservations+0x24/0x26
[ 2.550743] x86_64_start_kernel+0x74/0x77
[ 2.550743] secondary_startup_64+0xa4/0xb0
[ 2.550743] irq event stamp: 3461
[ 2.550743] hardirqs last enabled at (3461): [<ffffffffa27abd40>] console_unlock+0x440/0x5a0
[ 2.550743] hardirqs last disabled at (3460): [<ffffffffa27ab97c>] console_unlock+0x7c/0x5a0
[ 2.550743] softirqs last enabled at (3450): [<ffffffffa440028c>] __do_softirq+0x28c/0x46d
[ 2.550743] softirqs last disabled at (3443): [<ffffffffa27375c3>] irq_exit+0xb3/0xc0
[ 2.550743] ---[ end trace 2556965f47d35212 ]---
To reproduce:
# build kernel
cd linux
cp config-5.7.0-rc3-00001-gb79980a586f5a .config
make HOSTCC=gcc-7 CC=gcc-7 ARCH=x86_64 olddefconfig prepare modules_prepare bzImage
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email
Thanks,
lkp
1 month, 1 week
- 2
- 1
[crypto] beeb460cd1: stress-ng.af-alg.ops_per_sec 17454.7% improvement
by kernel test robot
Greeting,
FYI, we noticed a 17454.7% improvement of stress-ng.af-alg.ops_per_sec due to commit:
commit: beeb460cd12ac9b91640b484b6a52dcba9d9fc8f ("crypto: algapi - Avoid spurious modprobe on LOADED")
https://git.kernel.org/cgit/linux/kernel/git/next/linux-next.git master
in testcase: stress-ng
on test machine: 88 threads Intel(R) Xeon(R) CPU E5-2699 v4 @ 2.20GHz with 128G memory
with following parameters:
nr_threads: 100%
disk: 1HDD
testtime: 1s
class: cpu
cpufreq_governor: performance
ucode: 0xb000038
Details are as below:
-------------------------------------------------------------------------------------------------->
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp install job.yaml # job file is attached in this email
bin/lkp run job.yaml
=========================================================================================
class/compiler/cpufreq_governor/disk/kconfig/nr_threads/rootfs/tbox_group/testcase/testtime/ucode:
cpu/gcc-7/performance/1HDD/x86_64-rhel-7.6/100%/debian-x86_64-20191114.cgz/lkp-bdw-ep6/stress-ng/1s/0xb000038
commit:
56b80bdee4 ("crypto: sun8i-ss - Delete an error message in sun8i_ss_probe()")
beeb460cd1 ("crypto: algapi - Avoid spurious modprobe on LOADED")
56b80bdee4a16cf3 beeb460cd12ac9b91640b484b6a
---------------- ---------------------------
%stddev %change %stddev
\ | \
1099 ± 90% +4914.5% 55147 stress-ng.af-alg.ops
190.88 ± 88% +17454.7% 33508 ± 2% stress-ng.af-alg.ops_per_sec
112458 +13.6% 127769 ± 6% stress-ng.atomic.ops
112544 +13.6% 127847 ± 6% stress-ng.atomic.ops_per_sec
47.26 -7.5% 43.73 stress-ng.time.elapsed_time
47.26 -7.5% 43.73 stress-ng.time.elapsed_time.max
7336 +7.8% 7908 stress-ng.time.percent_of_cpu_this_job_got
55189 ± 18% +77.3% 97878 ± 7% stress-ng.time.voluntary_context_switches
0.80 +6.2% 0.85 ± 5% boot-time.smp_boot
46139 +21.1% 55857 ± 2% meminfo.Shmem
16.95 -6.0 10.91 ± 4% mpstat.cpu.all.idle%
6.843e+08 ± 6% -56.8% 2.956e+08 ± 34% cpuidle.C6.time
763608 -39.6% 460844 ± 7% cpuidle.C6.usage
32623 ± 3% -9.9% 29394 ± 2% softirqs.CPU54.TIMER
31389 ± 5% -8.3% 28775 softirqs.CPU61.TIMER
33888 ± 6% -13.0% 29487 softirqs.CPU70.TIMER
19.50 ± 2% -26.9% 14.25 ± 5% vmstat.cpu.id
65.75 +6.8% 70.25 vmstat.cpu.us
5444 ± 12% +67.5% 9120 ± 6% vmstat.system.cs
1730383 ± 10% +16.3% 2012737 ± 2% numa-numastat.node0.local_node
1785683 ± 9% +15.7% 2065187 ± 2% numa-numastat.node0.numa_hit
1827655 ± 7% +14.8% 2097849 ± 8% numa-numastat.node1.local_node
1857503 ± 7% +14.8% 2132540 ± 7% numa-numastat.node1.numa_hit
1218409 ± 9% +28.4% 1564653 ± 3% numa-vmstat.node0.numa_hit
1044425 ± 11% +36.7% 1427589 ± 7% numa-vmstat.node0.numa_local
1257153 ± 4% +25.5% 1577543 ± 6% numa-vmstat.node1.numa_hit
1226664 ± 3% +22.8% 1506818 ± 10% numa-vmstat.node1.numa_local
20.13 -28.0% 14.49 ± 4% iostat.cpu.idle
13.70 ± 2% +7.7% 14.76 ± 2% iostat.cpu.system
66.17 +6.9% 70.75 iostat.cpu.user
6.19 ±100% -100.0% 0.00 iostat.sda.await.max
6.19 ±100% -100.0% 0.00 iostat.sda.r_await.max
3.09 ±100% -100.0% 0.00 iostat.sda.svctm.max
7012 ± 18% +61.7% 11338 ± 8% slabinfo.cred_jar.active_objs
166.50 ± 18% +62.0% 269.75 ± 8% slabinfo.cred_jar.active_slabs
7012 ± 18% +61.7% 11338 ± 8% slabinfo.cred_jar.num_objs
166.50 ± 18% +62.0% 269.75 ± 8% slabinfo.cred_jar.num_slabs
22516 ± 6% +16.7% 26265 ± 6% slabinfo.filp.active_objs
727.75 ± 5% +16.9% 851.00 ± 6% slabinfo.filp.active_slabs
23308 ± 5% +16.9% 27243 ± 6% slabinfo.filp.num_objs
727.75 ± 5% +16.9% 851.00 ± 6% slabinfo.filp.num_slabs
281401 +1.0% 284257 proc-vmstat.nr_file_pages
6038 +4.7% 6321 ± 2% proc-vmstat.nr_inactive_anon
9715 +6.0% 10297 ± 2% proc-vmstat.nr_mapped
11522 +20.9% 13935 ± 3% proc-vmstat.nr_shmem
38248 +2.6% 39226 proc-vmstat.nr_slab_unreclaimable
6038 +4.7% 6321 ± 2% proc-vmstat.nr_zone_inactive_anon
3673028 ± 8% +14.9% 4220629 ± 5% proc-vmstat.numa_hit
3587869 ± 8% +15.2% 4133471 ± 5% proc-vmstat.numa_local
7827 +41.5% 11074 ± 2% proc-vmstat.pgactivate
3506649 ± 9% +15.3% 4043091 ± 5% proc-vmstat.pgfault
102330 ± 2% +9.2% 111707 ± 4% proc-vmstat.pgmigrate_success
4898 ± 6% -21.5% 3846 ± 22% sched_debug.cfs_rq:/.load.avg
3505 ± 8% +29.7% 4547 ± 17% sched_debug.cfs_rq:/.runnable_avg.max
2842 ± 62% -91.4% 245.06 ±443% sched_debug.cfs_rq:/.spread0.avg
16461 ± 11% -29.2% 11649 ± 24% sched_debug.cfs_rq:/.spread0.max
-2942 +73.7% -5111 sched_debug.cfs_rq:/.spread0.min
40.84 ± 33% -49.8% 20.51 ± 28% sched_debug.cfs_rq:/.util_est_enqueued.avg
665.50 ± 29% -26.1% 492.00 ± 3% sched_debug.cfs_rq:/.util_est_enqueued.max
130.10 ± 21% -32.8% 87.38 ± 14% sched_debug.cfs_rq:/.util_est_enqueued.stddev
303.34 ± 8% -24.3% 229.64 ± 12% sched_debug.cpu.curr->pid.avg
674.10 ± 3% -12.5% 589.53 ± 5% sched_debug.cpu.curr->pid.stddev
0.17 ± 10% -23.0% 0.13 ± 12% sched_debug.cpu.nr_running.avg
62.75 ± 6% -25.9% 46.50 ± 20% sched_debug.cpu.nr_uninterruptible.max
3391 ± 28% +90.6% 6462 ± 4% interrupts.CPU0.NMI:Non-maskable_interrupts
3391 ± 28% +90.6% 6462 ± 4% interrupts.CPU0.PMI:Performance_monitoring_interrupts
3153 ± 24% +99.3% 6285 interrupts.CPU1.NMI:Non-maskable_interrupts
3153 ± 24% +99.3% 6285 interrupts.CPU1.PMI:Performance_monitoring_interrupts
3886 ± 10% +68.1% 6532 ± 6% interrupts.CPU10.NMI:Non-maskable_interrupts
3886 ± 10% +68.1% 6532 ± 6% interrupts.CPU10.PMI:Performance_monitoring_interrupts
3694 ± 4% +69.0% 6244 interrupts.CPU11.NMI:Non-maskable_interrupts
3694 ± 4% +69.0% 6244 interrupts.CPU11.PMI:Performance_monitoring_interrupts
3618 ± 2% +76.2% 6374 ± 3% interrupts.CPU12.NMI:Non-maskable_interrupts
3618 ± 2% +76.2% 6374 ± 3% interrupts.CPU12.PMI:Performance_monitoring_interrupts
3180 ± 25% +96.7% 6256 interrupts.CPU18.NMI:Non-maskable_interrupts
3180 ± 25% +96.7% 6256 interrupts.CPU18.PMI:Performance_monitoring_interrupts
2702 ± 32% +130.6% 6233 interrupts.CPU19.NMI:Non-maskable_interrupts
2702 ± 32% +130.6% 6233 interrupts.CPU19.PMI:Performance_monitoring_interrupts
154.50 ± 10% +29.4% 200.00 ± 6% interrupts.CPU19.RES:Rescheduling_interrupts
3384 ± 28% +85.5% 6276 interrupts.CPU2.NMI:Non-maskable_interrupts
3384 ± 28% +85.5% 6276 interrupts.CPU2.PMI:Performance_monitoring_interrupts
2797 ± 29% +123.4% 6247 interrupts.CPU20.NMI:Non-maskable_interrupts
2797 ± 29% +123.4% 6247 interrupts.CPU20.PMI:Performance_monitoring_interrupts
2879 ± 36% +121.5% 6378 ± 2% interrupts.CPU21.NMI:Non-maskable_interrupts
2879 ± 36% +121.5% 6378 ± 2% interrupts.CPU21.PMI:Performance_monitoring_interrupts
3039 ± 42% +110.9% 6408 ± 3% interrupts.CPU22.NMI:Non-maskable_interrupts
3039 ± 42% +110.9% 6408 ± 3% interrupts.CPU22.PMI:Performance_monitoring_interrupts
3145 ± 23% +99.3% 6269 interrupts.CPU23.NMI:Non-maskable_interrupts
3145 ± 23% +99.3% 6269 interrupts.CPU23.PMI:Performance_monitoring_interrupts
3156 ± 23% +99.5% 6298 interrupts.CPU24.NMI:Non-maskable_interrupts
3156 ± 23% +99.5% 6298 interrupts.CPU24.PMI:Performance_monitoring_interrupts
3274 ± 25% +92.0% 6287 interrupts.CPU25.NMI:Non-maskable_interrupts
3274 ± 25% +92.0% 6287 interrupts.CPU25.PMI:Performance_monitoring_interrupts
3135 ± 23% +107.3% 6500 ± 6% interrupts.CPU26.NMI:Non-maskable_interrupts
3135 ± 23% +107.3% 6500 ± 6% interrupts.CPU26.PMI:Performance_monitoring_interrupts
3140 ± 23% +107.3% 6508 ± 6% interrupts.CPU27.NMI:Non-maskable_interrupts
3140 ± 23% +107.3% 6508 ± 6% interrupts.CPU27.PMI:Performance_monitoring_interrupts
164.25 ± 7% +27.2% 209.00 ± 8% interrupts.CPU29.RES:Rescheduling_interrupts
3620 ± 2% +78.4% 6458 ± 2% interrupts.CPU3.NMI:Non-maskable_interrupts
3620 ± 2% +78.4% 6458 ± 2% interrupts.CPU3.PMI:Performance_monitoring_interrupts
3201 ± 23% +95.5% 6257 interrupts.CPU37.NMI:Non-maskable_interrupts
3201 ± 23% +95.5% 6257 interrupts.CPU37.PMI:Performance_monitoring_interrupts
3142 ± 23% +101.3% 6325 interrupts.CPU38.NMI:Non-maskable_interrupts
3142 ± 23% +101.3% 6325 interrupts.CPU38.PMI:Performance_monitoring_interrupts
3139 ± 23% +102.8% 6366 ± 2% interrupts.CPU39.NMI:Non-maskable_interrupts
3139 ± 23% +102.8% 6366 ± 2% interrupts.CPU39.PMI:Performance_monitoring_interrupts
3180 ± 25% +97.3% 6274 interrupts.CPU40.NMI:Non-maskable_interrupts
3180 ± 25% +97.3% 6274 interrupts.CPU40.PMI:Performance_monitoring_interrupts
3175 ± 26% +97.6% 6273 interrupts.CPU41.NMI:Non-maskable_interrupts
3175 ± 26% +97.6% 6273 interrupts.CPU41.PMI:Performance_monitoring_interrupts
3796 ± 40% +65.0% 6265 interrupts.CPU42.NMI:Non-maskable_interrupts
3796 ± 40% +65.0% 6265 interrupts.CPU42.PMI:Performance_monitoring_interrupts
3285 ± 27% +92.8% 6333 interrupts.CPU43.NMI:Non-maskable_interrupts
3285 ± 27% +92.8% 6333 interrupts.CPU43.PMI:Performance_monitoring_interrupts
3310 ± 27% +98.4% 6568 ± 7% interrupts.CPU44.NMI:Non-maskable_interrupts
3310 ± 27% +98.4% 6568 ± 7% interrupts.CPU44.PMI:Performance_monitoring_interrupts
3178 ± 26% +97.5% 6276 interrupts.CPU45.NMI:Non-maskable_interrupts
3178 ± 26% +97.5% 6276 interrupts.CPU45.PMI:Performance_monitoring_interrupts
3415 ± 29% +83.9% 6279 interrupts.CPU46.NMI:Non-maskable_interrupts
3415 ± 29% +83.9% 6279 interrupts.CPU46.PMI:Performance_monitoring_interrupts
3178 ± 26% +105.0% 6514 ± 5% interrupts.CPU47.NMI:Non-maskable_interrupts
3178 ± 26% +105.0% 6514 ± 5% interrupts.CPU47.PMI:Performance_monitoring_interrupts
3171 ± 26% +97.9% 6276 interrupts.CPU48.NMI:Non-maskable_interrupts
3171 ± 26% +97.9% 6276 interrupts.CPU48.PMI:Performance_monitoring_interrupts
3163 ± 25% +97.7% 6253 interrupts.CPU49.NMI:Non-maskable_interrupts
3163 ± 25% +97.7% 6253 interrupts.CPU49.PMI:Performance_monitoring_interrupts
3617 ± 2% +76.2% 6371 ± 2% interrupts.CPU50.NMI:Non-maskable_interrupts
3617 ± 2% +76.2% 6371 ± 2% interrupts.CPU50.PMI:Performance_monitoring_interrupts
155.00 ± 9% +32.1% 204.75 ± 7% interrupts.CPU50.RES:Rescheduling_interrupts
3618 ± 2% +73.2% 6267 interrupts.CPU59.NMI:Non-maskable_interrupts
3618 ± 2% +73.2% 6267 interrupts.CPU59.PMI:Performance_monitoring_interrupts
157.25 ± 10% +25.4% 197.25 ± 12% interrupts.CPU59.RES:Rescheduling_interrupts
3620 ± 2% +73.2% 6271 interrupts.CPU63.NMI:Non-maskable_interrupts
3620 ± 2% +73.2% 6271 interrupts.CPU63.PMI:Performance_monitoring_interrupts
152.25 ± 5% +15.9% 176.50 ± 4% interrupts.CPU64.RES:Rescheduling_interrupts
3159 ± 24% +98.6% 6275 interrupts.CPU67.NMI:Non-maskable_interrupts
3159 ± 24% +98.6% 6275 interrupts.CPU67.PMI:Performance_monitoring_interrupts
3610 ± 2% +73.5% 6264 interrupts.CPU7.NMI:Non-maskable_interrupts
3610 ± 2% +73.5% 6264 interrupts.CPU7.PMI:Performance_monitoring_interrupts
162.50 ± 4% +188.3% 468.50 ± 91% interrupts.CPU70.RES:Rescheduling_interrupts
3805 ± 8% +64.6% 6265 interrupts.CPU75.NMI:Non-maskable_interrupts
3805 ± 8% +64.6% 6265 interrupts.CPU75.PMI:Performance_monitoring_interrupts
171.00 ± 11% +51.3% 258.75 ± 35% interrupts.CPU77.RES:Rescheduling_interrupts
3612 ± 2% +73.8% 6277 interrupts.CPU8.NMI:Non-maskable_interrupts
3612 ± 2% +73.8% 6277 interrupts.CPU8.PMI:Performance_monitoring_interrupts
3171 ± 24% +97.7% 6269 interrupts.CPU85.NMI:Non-maskable_interrupts
3171 ± 24% +97.7% 6269 interrupts.CPU85.PMI:Performance_monitoring_interrupts
3469 ± 30% +80.4% 6257 interrupts.CPU86.NMI:Non-maskable_interrupts
3469 ± 30% +80.4% 6257 interrupts.CPU86.PMI:Performance_monitoring_interrupts
3332 ± 27% +88.9% 6294 interrupts.CPU87.NMI:Non-maskable_interrupts
3332 ± 27% +88.9% 6294 interrupts.CPU87.PMI:Performance_monitoring_interrupts
4234 ± 24% +47.6% 6251 interrupts.CPU9.NMI:Non-maskable_interrupts
4234 ± 24% +47.6% 6251 interrupts.CPU9.PMI:Performance_monitoring_interrupts
298153 +69.5% 505374 ± 4% interrupts.NMI:Non-maskable_interrupts
298153 +69.5% 505374 ± 4% interrupts.PMI:Performance_monitoring_interrupts
77.22 -28.8 48.43 perf-profile.calltrace.cycles-pp.swapcontext
37.82 -13.6 24.17 perf-profile.calltrace.cycles-pp.entry_SYSCALL_64_after_hwframe.swapcontext
37.15 -13.4 23.74 perf-profile.calltrace.cycles-pp.do_syscall_64.entry_SYSCALL_64_after_hwframe.swapcontext
16.94 ± 4% -11.1 5.83 ± 9% perf-profile.calltrace.cycles-pp.cpu_startup_entry.start_secondary.secondary_startup_64
16.94 ± 4% -11.1 5.83 ± 9% perf-profile.calltrace.cycles-pp.start_secondary.secondary_startup_64
17.12 ± 4% -11.1 6.01 ± 10% perf-profile.calltrace.cycles-pp.secondary_startup_64
16.93 ± 4% -11.1 5.83 ± 9% perf-profile.calltrace.cycles-pp.do_idle.cpu_startup_entry.start_secondary.secondary_startup_64
15.69 ± 3% -10.2 5.52 ± 9% perf-profile.calltrace.cycles-pp.cpuidle_enter.do_idle.cpu_startup_entry.start_secondary.secondary_startup_64
15.51 ± 3% -10.0 5.47 ± 9% perf-profile.calltrace.cycles-pp.cpuidle_enter_state.cpuidle_enter.do_idle.cpu_startup_entry.start_secondary
12.70 ± 3% -7.8 4.89 ± 11% perf-profile.calltrace.cycles-pp.intel_idle.cpuidle_enter_state.cpuidle_enter.do_idle.cpu_startup_entry
16.40 -6.7 9.68 perf-profile.calltrace.cycles-pp.entry_SYSCALL_64.swapcontext
6.46 -2.3 4.17 perf-profile.calltrace.cycles-pp.syscall_return_via_sysret.swapcontext
6.69 ± 3% -2.2 4.48 ± 4% perf-profile.calltrace.cycles-pp.__x64_sys_rt_sigprocmask.do_syscall_64.entry_SYSCALL_64_after_hwframe.swapcontext
2.65 ± 5% -2.0 0.63 ± 10% perf-profile.calltrace.cycles-pp.apic_timer_interrupt.cpuidle_enter_state.cpuidle_enter.do_idle.cpu_startup_entry
2.45 ± 5% -2.0 0.46 ± 57% perf-profile.calltrace.cycles-pp.smp_apic_timer_interrupt.apic_timer_interrupt.cpuidle_enter_state.cpuidle_enter.do_idle
2.70 ± 5% -0.9 1.82 ± 4% perf-profile.calltrace.cycles-pp._copy_from_user.__x64_sys_rt_sigprocmask.do_syscall_64.entry_SYSCALL_64_after_hwframe.swapcontext
1.10 ± 5% -0.6 0.47 ± 58% perf-profile.calltrace.cycles-pp.worker_thread.kthread.ret_from_fork
1.09 ± 6% -0.6 0.46 ± 57% perf-profile.calltrace.cycles-pp.process_one_work.worker_thread.kthread.ret_from_fork
1.06 ± 6% -0.6 0.45 ± 57% perf-profile.calltrace.cycles-pp.drm_fb_helper_dirty_work.process_one_work.worker_thread.kthread.ret_from_fork
1.61 -0.6 1.04 perf-profile.calltrace.cycles-pp._copy_to_user.__x64_sys_rt_sigprocmask.do_syscall_64.entry_SYSCALL_64_after_hwframe.swapcontext
1.00 ± 6% -0.6 0.43 ± 58% perf-profile.calltrace.cycles-pp.memcpy_erms.drm_fb_helper_dirty_work.process_one_work.worker_thread.kthread
1.15 ± 5% -0.5 0.62 ± 11% perf-profile.calltrace.cycles-pp.ret_from_fork
1.14 ± 5% -0.5 0.61 ± 11% perf-profile.calltrace.cycles-pp.kthread.ret_from_fork
1.11 ± 7% -0.4 0.75 ± 4% perf-profile.calltrace.cycles-pp.__might_fault._copy_from_user.__x64_sys_rt_sigprocmask.do_syscall_64.entry_SYSCALL_64_after_hwframe
0.00 +6.5 6.53 perf-profile.calltrace.cycles-pp.fetestexcept
0.00 +31.1 31.14 perf-profile.calltrace.cycles-pp.feclearexcept
77.29 -28.4 48.89 perf-profile.children.cycles-pp.swapcontext
39.34 -13.7 25.60 perf-profile.children.cycles-pp.entry_SYSCALL_64_after_hwframe
38.74 -13.5 25.23 perf-profile.children.cycles-pp.do_syscall_64
17.12 ± 4% -11.1 6.01 ± 10% perf-profile.children.cycles-pp.do_idle
16.94 ± 4% -11.1 5.83 ± 9% perf-profile.children.cycles-pp.start_secondary
17.12 ± 4% -11.1 6.01 ± 10% perf-profile.children.cycles-pp.secondary_startup_64
17.12 ± 4% -11.1 6.01 ± 10% perf-profile.children.cycles-pp.cpu_startup_entry
15.85 ± 3% -10.2 5.69 ± 10% perf-profile.children.cycles-pp.cpuidle_enter
15.84 ± 3% -10.1 5.69 ± 10% perf-profile.children.cycles-pp.cpuidle_enter_state
12.83 ± 3% -7.9 4.92 ± 10% perf-profile.children.cycles-pp.intel_idle
15.73 -6.0 9.70 perf-profile.children.cycles-pp.entry_SYSCALL_64
7.14 -2.5 4.62 perf-profile.children.cycles-pp.syscall_return_via_sysret
6.74 ± 3% -2.2 4.51 ± 4% perf-profile.children.cycles-pp.__x64_sys_rt_sigprocmask
4.50 ± 4% -2.0 2.48 ± 5% perf-profile.children.cycles-pp.apic_timer_interrupt
4.12 ± 3% -1.9 2.23 ± 4% perf-profile.children.cycles-pp.smp_apic_timer_interrupt
2.96 ± 3% -1.2 1.75 ± 4% perf-profile.children.cycles-pp.hrtimer_interrupt
2.75 ± 5% -0.9 1.85 ± 4% perf-profile.children.cycles-pp._copy_from_user
2.04 ± 5% -0.8 1.21 ± 3% perf-profile.children.cycles-pp.__hrtimer_run_queues
0.92 ± 17% -0.7 0.22 ± 15% perf-profile.children.cycles-pp.menu_select
1.66 -0.6 1.08 perf-profile.children.cycles-pp._copy_to_user
1.74 ± 3% -0.6 1.16 ± 4% perf-profile.children.cycles-pp.__might_fault
1.15 ± 4% -0.5 0.63 ± 10% perf-profile.children.cycles-pp.ret_from_fork
1.14 ± 5% -0.5 0.61 ± 11% perf-profile.children.cycles-pp.kthread
1.10 ± 5% -0.5 0.59 ± 11% perf-profile.children.cycles-pp.worker_thread
1.09 ± 6% -0.5 0.58 ± 11% perf-profile.children.cycles-pp.process_one_work
1.06 ± 6% -0.5 0.57 ± 12% perf-profile.children.cycles-pp.drm_fb_helper_dirty_work
1.07 ± 6% -0.5 0.57 ± 12% perf-profile.children.cycles-pp.memcpy_erms
1.27 ± 8% -0.4 0.84 perf-profile.children.cycles-pp.tick_sched_timer
1.33 ± 3% -0.4 0.91 perf-profile.children.cycles-pp.copy_user_generic_unrolled
0.72 ± 13% -0.4 0.32 ± 7% perf-profile.children.cycles-pp.vprintk_emit
0.70 ± 4% -0.4 0.31 ± 12% perf-profile.children.cycles-pp.irq_exit
0.72 ± 14% -0.4 0.33 ± 26% perf-profile.children.cycles-pp.console_unlock
0.48 ± 14% -0.4 0.11 ± 12% perf-profile.children.cycles-pp.tick_nohz_get_sleep_length
1.11 ± 6% -0.4 0.74 ± 2% perf-profile.children.cycles-pp.tick_sched_handle
0.64 ± 15% -0.4 0.28 ± 26% perf-profile.children.cycles-pp.serial8250_console_write
0.61 ± 15% -0.3 0.28 ± 26% perf-profile.children.cycles-pp.uart_console_write
1.06 ± 6% -0.3 0.73 ± 2% perf-profile.children.cycles-pp.update_process_times
0.54 ± 22% -0.3 0.22 ± 11% perf-profile.children.cycles-pp.io_serial_in
0.52 ± 14% -0.3 0.20 ± 10% perf-profile.children.cycles-pp._fini
0.52 ± 14% -0.3 0.20 ± 10% perf-profile.children.cycles-pp.devkmsg_write
0.52 ± 14% -0.3 0.20 ± 10% perf-profile.children.cycles-pp.devkmsg_emit
0.54 ± 13% -0.3 0.22 ± 11% perf-profile.children.cycles-pp.write
0.55 ± 21% -0.3 0.24 ± 28% perf-profile.children.cycles-pp.wait_for_xmitr
0.53 ± 20% -0.3 0.22 ± 15% perf-profile.children.cycles-pp.ktime_get
0.53 ± 14% -0.3 0.23 ± 9% perf-profile.children.cycles-pp.ksys_write
0.53 ± 14% -0.3 0.23 ± 9% perf-profile.children.cycles-pp.vfs_write
0.53 ± 14% -0.3 0.23 ± 9% perf-profile.children.cycles-pp.new_sync_write
0.54 ± 20% -0.3 0.24 ± 28% perf-profile.children.cycles-pp.serial8250_console_putchar
0.38 ± 11% -0.3 0.09 ± 12% perf-profile.children.cycles-pp.tick_nohz_next_event
0.55 ± 8% -0.3 0.26 ± 12% perf-profile.children.cycles-pp.__softirqentry_text_start
0.85 ± 2% -0.3 0.56 ± 6% perf-profile.children.cycles-pp.___might_sleep
0.75 ± 5% -0.3 0.48 ± 4% perf-profile.children.cycles-pp.copy_user_enhanced_fast_string
0.68 ± 2% -0.2 0.46 ± 3% perf-profile.children.cycles-pp.scheduler_tick
0.47 ± 8% -0.2 0.26 ± 17% perf-profile.children.cycles-pp.clockevents_program_event
0.27 ± 17% -0.2 0.06 ± 13% perf-profile.children.cycles-pp.get_next_timer_interrupt
0.28 ± 6% -0.2 0.08 ± 5% perf-profile.children.cycles-pp.irq_enter
0.22 ± 6% -0.2 0.03 ±100% perf-profile.children.cycles-pp.tick_irq_enter
0.19 ± 21% -0.2 0.03 ±100% perf-profile.children.cycles-pp.__next_timer_interrupt
0.35 ± 6% -0.2 0.18 ± 14% perf-profile.children.cycles-pp.perf_mux_hrtimer_handler
0.39 ± 11% -0.1 0.25 ± 15% perf-profile.children.cycles-pp.__x86_indirect_thunk_rax
0.32 ± 5% -0.1 0.19 ± 9% perf-profile.children.cycles-pp.sigprocmask
0.42 ± 4% -0.1 0.30 ± 6% perf-profile.children.cycles-pp.__might_sleep
0.18 ± 9% -0.1 0.09 ± 7% perf-profile.children.cycles-pp.read_tsc
0.11 ± 7% -0.1 0.03 ±100% perf-profile.children.cycles-pp.timerqueue_del
0.14 ± 5% -0.1 0.06 ± 13% perf-profile.children.cycles-pp.__remove_hrtimer
0.23 ± 17% -0.1 0.15 ± 10% perf-profile.children.cycles-pp.native_write_msr
0.14 ± 11% -0.1 0.07 ± 7% perf-profile.children.cycles-pp.run_timer_softirq
0.17 ± 6% -0.1 0.10 ± 17% perf-profile.children.cycles-pp._raw_spin_lock
0.17 ± 12% -0.1 0.11 ± 11% perf-profile.children.cycles-pp.ktime_get_update_offsets_now
0.13 ± 9% -0.1 0.08 ± 10% perf-profile.children.cycles-pp.__set_current_blocked
0.08 ± 26% -0.1 0.03 ±102% perf-profile.children.cycles-pp.fbcon_putcs
0.13 ± 6% -0.0 0.08 ± 10% perf-profile.children.cycles-pp.swapcontext@plt
0.10 ± 7% -0.0 0.06 ± 7% perf-profile.children.cycles-pp.arch_scale_freq_tick
0.09 ± 26% -0.0 0.04 ± 60% perf-profile.children.cycles-pp.vt_console_print
0.09 ± 26% -0.0 0.04 ± 60% perf-profile.children.cycles-pp.lf
0.09 ± 26% -0.0 0.04 ± 60% perf-profile.children.cycles-pp.con_scroll
0.09 ± 26% -0.0 0.04 ± 60% perf-profile.children.cycles-pp.fbcon_scroll
0.09 ± 26% -0.0 0.04 ± 60% perf-profile.children.cycles-pp.fbcon_redraw
0.08 ± 10% -0.0 0.04 ± 60% perf-profile.children.cycles-pp.ksys_read
0.11 ± 26% -0.0 0.08 ± 14% perf-profile.children.cycles-pp.crypto_alloc_tfm
0.11 ± 26% -0.0 0.08 ± 14% perf-profile.children.cycles-pp.crypto_alg_mod_lookup
0.11 ± 26% -0.0 0.08 ± 14% perf-profile.children.cycles-pp.__request_module
0.11 ± 26% -0.0 0.08 ± 10% perf-profile.children.cycles-pp.bind
0.11 ± 26% -0.0 0.08 ± 10% perf-profile.children.cycles-pp.__x64_sys_bind
0.11 ± 26% -0.0 0.08 ± 10% perf-profile.children.cycles-pp.__sys_bind
0.11 ± 26% -0.0 0.08 ± 10% perf-profile.children.cycles-pp.alg_bind
0.10 ± 10% -0.0 0.07 ± 17% perf-profile.children.cycles-pp._raw_spin_lock_irq
0.08 -0.0 0.05 ± 9% perf-profile.children.cycles-pp.__intel_pmu_enable_all
0.32 ± 3% -0.0 0.29 ± 3% perf-profile.children.cycles-pp.task_tick_fair
0.01 ±173% +0.0 0.06 ± 7% perf-profile.children.cycles-pp.cexp
0.00 +0.1 0.08 ± 5% perf-profile.children.cycles-pp.@plt
0.00 +0.1 0.11 ± 10% perf-profile.children.cycles-pp.memcpy@plt
0.00 +0.1 0.12 ± 5% perf-profile.children.cycles-pp.prepare_to_wait_event
0.00 +0.1 0.15 ± 7% perf-profile.children.cycles-pp.sqrt
0.00 +0.2 0.16 ± 7% perf-profile.children.cycles-pp.feclearexcept@plt
0.00 +0.2 0.17 ± 11% perf-profile.children.cycles-pp.fetestexcept@plt
0.00 +0.2 0.18 ± 4% perf-profile.children.cycles-pp.__errno_location@plt
0.03 ±100% +0.2 0.23 ± 36% perf-profile.children.cycles-pp.syscall
0.00 +0.2 0.20 ± 10% perf-profile.children.cycles-pp.finished_loading
0.00 +0.2 0.21 ± 2% perf-profile.children.cycles-pp.fegetround
0.00 +0.3 0.32 ± 15% perf-profile.children.cycles-pp.osq_lock
0.00 +0.3 0.33 ± 17% perf-profile.children.cycles-pp.__mutex_lock
0.00 +0.4 0.38 ± 4% perf-profile.children.cycles-pp.log2
0.00 +0.4 0.40 ± 6% perf-profile.children.cycles-pp.__errno_location
0.00 +0.4 0.40 ± 4% perf-profile.children.cycles-pp.log
0.03 ±100% +0.4 0.47 ± 20% perf-profile.children.cycles-pp.__do_sys_finit_module
0.03 ±100% +0.4 0.47 ± 20% perf-profile.children.cycles-pp.load_module
0.00 +0.5 0.51 perf-profile.children.cycles-pp.exp
0.00 +6.5 6.53 perf-profile.children.cycles-pp.fetestexcept
0.00 +31.2 31.16 perf-profile.children.cycles-pp.feclearexcept
30.34 -11.1 19.20 perf-profile.self.cycles-pp.do_syscall_64
12.80 ± 3% -7.9 4.92 ± 10% perf-profile.self.cycles-pp.intel_idle
16.64 ± 2% -6.2 10.41 ± 2% perf-profile.self.cycles-pp.swapcontext
15.04 -5.8 9.27 perf-profile.self.cycles-pp.entry_SYSCALL_64
7.13 -2.5 4.62 perf-profile.self.cycles-pp.syscall_return_via_sysret
1.96 ± 6% -0.6 1.36 ± 6% perf-profile.self.cycles-pp.__x64_sys_rt_sigprocmask
1.07 ± 6% -0.5 0.57 ± 12% perf-profile.self.cycles-pp.memcpy_erms
1.11 ± 3% -0.4 0.75 perf-profile.self.cycles-pp.copy_user_generic_unrolled
0.50 ± 15% -0.3 0.21 ± 9% perf-profile.self.cycles-pp.io_serial_in
0.82 ± 2% -0.3 0.55 ± 5% perf-profile.self.cycles-pp.___might_sleep
0.71 ± 3% -0.3 0.44 ± 6% perf-profile.self.cycles-pp.entry_SYSCALL_64_after_hwframe
0.73 ± 5% -0.3 0.47 ± 4% perf-profile.self.cycles-pp.copy_user_enhanced_fast_string
0.34 ± 28% -0.3 0.09 ± 14% perf-profile.self.cycles-pp.menu_select
0.38 ± 31% -0.2 0.16 ± 20% perf-profile.self.cycles-pp.ktime_get
0.57 ± 7% -0.2 0.37 ± 5% perf-profile.self.cycles-pp._copy_from_user
0.26 ± 11% -0.2 0.07 perf-profile.self.cycles-pp.cpuidle_enter_state
0.50 ± 7% -0.2 0.33 perf-profile.self.cycles-pp.__might_fault
0.36 ± 5% -0.1 0.26 ± 7% perf-profile.self.cycles-pp.__might_sleep
0.28 ± 2% -0.1 0.19 ± 6% perf-profile.self.cycles-pp._copy_to_user
0.17 ± 9% -0.1 0.08 ± 10% perf-profile.self.cycles-pp.read_tsc
0.23 ± 7% -0.1 0.14 ± 16% perf-profile.self.cycles-pp.__x86_indirect_thunk_rax
0.23 ± 17% -0.1 0.15 ± 10% perf-profile.self.cycles-pp.native_write_msr
0.20 ± 5% -0.1 0.12 ± 10% perf-profile.self.cycles-pp.sigprocmask
0.15 ± 4% -0.1 0.10 ± 14% perf-profile.self.cycles-pp._raw_spin_lock
0.11 ± 17% -0.1 0.06 ± 26% perf-profile.self.cycles-pp._raw_spin_lock_irqsave
0.11 ± 7% -0.0 0.07 ± 7% perf-profile.self.cycles-pp.__set_current_blocked
0.13 ± 6% -0.0 0.08 ± 10% perf-profile.self.cycles-pp.swapcontext@plt
0.10 ± 11% -0.0 0.07 ± 6% perf-profile.self.cycles-pp.hrtimer_interrupt
0.00 +0.1 0.06 ± 9% perf-profile.self.cycles-pp.cexp
0.00 +0.1 0.11 ± 10% perf-profile.self.cycles-pp.memcpy@plt
0.00 +0.1 0.12 ± 11% perf-profile.self.cycles-pp.sqrt
0.00 +0.2 0.16 ± 7% perf-profile.self.cycles-pp.feclearexcept@plt
0.00 +0.2 0.17 ± 8% perf-profile.self.cycles-pp.fetestexcept@plt
0.00 +0.2 0.18 ± 4% perf-profile.self.cycles-pp.__errno_location@plt
0.00 +0.2 0.18 ± 2% perf-profile.self.cycles-pp.fegetround
0.00 +0.2 0.22 ± 9% perf-profile.self.cycles-pp.__errno_location
0.00 +0.3 0.31 ± 14% perf-profile.self.cycles-pp.osq_lock
0.00 +0.3 0.34 ± 5% perf-profile.self.cycles-pp.log2
0.00 +0.4 0.36 ± 4% perf-profile.self.cycles-pp.log
0.00 +0.5 0.47 perf-profile.self.cycles-pp.exp
0.00 +6.3 6.32 ± 2% perf-profile.self.cycles-pp.fetestexcept
0.00 +30.8 30.80 perf-profile.self.cycles-pp.feclearexcept
stress-ng.time.percent_of_cpu_this_job_got
8000 +--------------------------------------------------------------------+
7800 |-+O O O O O O O O O O O O O O O |
| O O O O |
7600 |-+ |
7400 |.. .+. .+.. .+. |
| +.+..+. + +.+. +.+..+..+.+..+.+..+. +..+ |
7200 |-+ : : |
7000 |-+ : : |
6800 |-+ : : |
| : : |
6600 |-+ : : |
6400 |-+ : : |
| : : |
6200 |-+ : |
6000 +--------------------------------------------------------------------+
stress-ng.af-alg.ops
60000 +-------------------------------------------------------------------+
| O O O O O O O O O O O O O O O O O O O O O O O O O |
50000 |-+ |
| |
| |
40000 |-+ |
| |
30000 |-+ |
| |
20000 |-+ |
| + |
| :+ |
10000 |-+ : + .+.. .+ |
|.. .+. : + +. + .+.. |
0 +-------------------------------------------------------------------+
stress-ng.af-alg.ops_per_sec
40000 +-------------------------------------------------------------------+
| |
35000 |-+O O O O O O O O O O O O O O O O O O |
30000 |-+ O O O O O O O |
| |
25000 |-+ |
| |
20000 |-+ |
| |
15000 |-+ |
10000 |-+ |
| |
5000 |-+ |
| .+.. |
0 +-------------------------------------------------------------------+
[*] bisect-good sample
[O] bisect-bad sample
Disclaimer:
Results have been estimated based on internal Intel analysis and are provided
for informational purposes only. Any difference in system hardware or software
design or configuration may affect actual performance.
Thanks,
Rong Chen
1 month, 1 week
- 1
- 0
fe31d0fc13 ("x86/kvm: Handle async page faults directly .."): [ 0.098212] WARNING: CPU: 0 PID: 0 at arch/x86/kernel/kvm.c:315 kvm_guest_init
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/tglx/devel.git x86/entry
commit fe31d0fc13d1d2d13e7c688335861a55ed497440
Author: Andy Lutomirski <luto(a)kernel.org>
AuthorDate: Fri Feb 28 10:42:48 2020 -0800
Commit: Thomas Gleixner <tglx(a)linutronix.de>
CommitDate: Mon Apr 27 10:51:44 2020 +0200
x86/kvm: Handle async page faults directly through do_page_fault()
KVM overloads #PF to indicate two types of not-actually-page-fault
events. Right now, the KVM guest code intercepts them by modifying
the IDT and hooking the #PF vector. This makes the already fragile
fault code even harder to understand, and it also pollutes call
traces with async_page_fault and do_async_page_fault for normal page
faults.
Clean it up by moving the logic into do_page_fault() using a static
branch. This gets rid of the platform trap_init override mechanism
completely.
[ tglx: Fixed up 32bit, removed error code from the async functions and
massaged coding style ]
Signed-off-by: Andy Lutomirski <luto(a)kernel.org>
Signed-off-by: Thomas Gleixner <tglx(a)linutronix.de>
8f55789126 x86/entry: Remove the unused LOCKDEP_SYSEXIT cruft
fe31d0fc13 x86/kvm: Handle async page faults directly through do_page_fault()
541826c579 x86/entry: Remove the TRACE_IRQS cruft
+--------------------------------------------------+------------+------------+------------+
| | 8f55789126 | fe31d0fc13 | 541826c579 |
+--------------------------------------------------+------------+------------+------------+
| boot_successes | 0 | 0 | 0 |
| boot_failures | 44 | 11 | 3 |
| BUG:unable_to_handle_page_fault_for_address | 43 | 11 | 3 |
| Oops:#[##] | 43 | 11 | 3 |
| EIP:__lock_acquire | 43 | 11 | 3 |
| Kernel_panic-not_syncing:Fatal_exception | 43 | 11 | 3 |
| System_halted | 1 | | |
| WARNING:at_arch/x86/kernel/kvm.c:#kvm_guest_init | 0 | 11 | 3 |
| EIP:kvm_guest_init | 0 | 11 | 3 |
+--------------------------------------------------+------------+------------+------------+
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <lkp(a)intel.com>
[ 0.096462] Int: type 0, pol 0, trig 0, bus 00, IRQ 0f, APIC ID 0, APIC INT 0f
[ 0.096867] Using ACPI (MADT) for SMP configuration information
[ 0.097200] ACPI: HPET id: 0x8086a201 base: 0xfed00000
[ 0.097505] mapped IOAPIC to ffffb000 (fec00000)
[ 0.097949] ------------[ cut here ]------------
[ 0.098212] WARNING: CPU: 0 PID: 0 at arch/x86/kernel/kvm.c:315 kvm_guest_init+0xe0/0x1c9
[ 0.098864] Modules linked in:
[ 0.099055] CPU: 0 PID: 0 Comm: swapper Not tainted 5.7.0-rc2-00114-gfe31d0fc13d1d #1
[ 0.099505] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 0.099969] EIP: kvm_guest_init+0xe0/0x1c9
[ 0.100198] Code: 74 0a b8 70 1f 04 c1 e8 3a d0 ff ff b8 04 00 00 00 e8 20 37 e4 fe 84 c0 74 5c 83 3d 88 17 fc c1 00 74 53 e9 02 00 00 00 eb 04 <0f> 0b eb 00 b8 40 17 fc c1 e8 5e 98 e4 fe 89 c3 89 c6 b8 0a 00 00
[ 0.101246] EAX: 00000001 EBX: c22a16c0 ECX: 00000004 EDX: 00000000
[ 0.101595] ESI: c22a16c0 EDI: 00000000 EBP: c1f93f34 ESP: c1f93f58
[ 0.102036] DS: 007b ES: 007b FS: 0000 GS: 0000 SS: ec00 EFLAGS: 00210002
[ 0.102414] CR0: 80050033 CR2: 00000000 CR3: 02290000 CR4: 00000690
[ 0.102763] Call Trace:
[ 0.102904] start_kernel+0x4b/0x65f
[ 0.103132] ? set_intr_gate+0x37/0x40
[ 0.103347] ? early_idt_handler_common+0x44/0x44
[ 0.103619] i386_start_kernel+0x42/0x44
[ 0.103839] startup_32_smp+0x164/0x168
[ 0.104061] random: get_random_bytes called from init_oops_id+0x23/0x50 with crng_init=0
[ 0.104063] ---[ end trace 5348b3c6a4338041 ]---
[ 0.104777] KVM setup async PF for cpu 0
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start ad61002f87334b07fed9943e9f23733d17da7ceb 6a8b55ed4056ea5559ebe4f6a4b247f627870d4c --
git bisect bad e50a530a21d4363ac5cf5dd25121d46aa723a715 # 00:38 B 0 2 18 0 Merge 'linux-review/Bernard-Zhao/kmalloc_index-optimization-add-kmalloc-max-size-check/20200420-091423' into devel-hourly-2020042719
git bisect bad 12ab92a0bfcf61c1dbbffc0663e79f89a8c2514f # 00:56 B 0 2 18 0 Merge 'linux-review/Jon-Derrick/Honoring-Native-AER-DPC-Host-Bridges/20200422-214929' into devel-hourly-2020042719
git bisect bad ba6e013efe4ac75c060f5d1ab5d97c8bd7ed95a6 # 01:16 B 0 2 18 0 Merge 'mac80211/master' into devel-hourly-2020042719
git bisect good 9f2f2ccc4db4a213976613e995393b82b2840151 # 01:37 G 11 0 11 11 Merge 'linux-review/Sascha-Hauer/arm64-defconfig-Enable-Freescale-XGMAC-MDIO/20200426-170931' into devel-hourly-2020042719
git bisect bad ab77eb349e9995434452e1840127fe566593af97 # 01:49 B 0 2 18 0 Merge 'iio/fixes-togreg' into devel-hourly-2020042719
git bisect good fcf7f2c0a76f6dd452245a00491bb5c2d5481cc7 # 02:16 G 10 0 10 10 Merge 'linux-review/Mason-Yang/mtd-spi-nor-macronix-Add-support-for-mx25l512-mx25u512/20200426-125136' into devel-hourly-2020042719
git bisect bad 0e1a6da4f0e923020c50b1ecd1f39e95df1fb149 # 02:31 B 0 1 17 0 Merge 'tglx-devel/x86/entry' into devel-hourly-2020042719
git bisect good 7ffe70783b3fd2e97c6d900affa7393749ff8196 # 03:03 G 10 0 10 10 Merge 'linux-review/Russell-King/net-phy-bcm84881-clear-settings-on-link-down/20200426-121024' into devel-hourly-2020042719
git bisect good 46884bc7e3f7032d3e186529daceccd373295fc7 # 03:20 G 11 0 11 11 Merge 'linux-review/Chirantan-Ekbote/fuse-Mark-fscrypt-ioctls-as-unrestricted/20200426-115535' into devel-hourly-2020042719
git bisect bad 866387c561a776103e999265f060e1adef52e4f6 # 03:51 B 0 2 18 0 x86/entry/64: Reorder idtentries
git bisect good cae2d304e8694edd2d990e87088711993bbd78ee # 04:14 G 10 0 10 10 locking/atomics: Flip fallbacks and instrumentation
git bisect bad 7de77fa0a2b2c57a0ff36fcad947ba15778dca68 # 04:37 B 0 1 17 0 x86/entry: Mark enter_from_user_mode() noinstr
git bisect bad bc65908be288834e437e2854602d249abf59b4f5 # 05:05 B 0 1 17 0 kprobes: Support NOKPROBE_SYMBOL() in modules
git bisect bad ed9ef0285e23afd8e4ad73875eae59ac97622d11 # 05:28 B 0 1 17 0 x86/kvm: Sanitize kvm_async_pf_task_wait()
git bisect good 1f21ead1d43f09ba63a0de8b91d7a47f49774ce4 # 05:50 G 10 0 10 10 x86/entry/64: Avoid pointless code when CONTEXT_TRACKING=n
git bisect bad fe31d0fc13d1d2d13e7c688335861a55ed497440 # 06:09 B 0 6 22 0 x86/kvm: Handle async page faults directly through do_page_fault()
git bisect good 8f55789126fe72f44ac7e5e9bbbd90e75f241662 # 06:25 G 10 0 10 10 x86/entry: Remove the unused LOCKDEP_SYSEXIT cruft
# first bad commit: [fe31d0fc13d1d2d13e7c688335861a55ed497440] x86/kvm: Handle async page faults directly through do_page_fault()
git bisect good 8f55789126fe72f44ac7e5e9bbbd90e75f241662 # 06:30 G 31 0 31 41 x86/entry: Remove the unused LOCKDEP_SYSEXIT cruft
# extra tests with debug options
git bisect bad fe31d0fc13d1d2d13e7c688335861a55ed497440 # 06:43 B 0 8 24 0 x86/kvm: Handle async page faults directly through do_page_fault()
# extra tests on head commit of tglx-devel/x86/entry
git bisect bad 541826c5796f8c00230e400f1c4e0dc2849d17bc # 07:12 B 0 1 17 0 x86/entry: Remove the TRACE_IRQS cruft
# bad: [541826c5796f8c00230e400f1c4e0dc2849d17bc] x86/entry: Remove the TRACE_IRQS cruft
---
0-DAY CI Kernel Test Service, Intel Corporation
https://lists.01.org/hyperkitty/list/lkp@lists.01.org
1 month, 1 week
- 1
- 0
[drm/i915/gen9] 53b9bd37af: phoronix-test-suite.clpeak.KernelLatency.us 22.5% regression
by kernel test robot
Greeting,
FYI, we noticed a 22.5% regression of phoronix-test-suite.clpeak.KernelLatency.us due to commit:
commit: 53b9bd37af59d1def99b20707536105857eb9bd0 ("drm/i915/gen9: Clear residual context state on context switch")
https://git.kernel.org/cgit/linux/kernel/git/stable/linux-stable.git linux-5.4.y
in testcase: phoronix-test-suite
on test machine: 4 threads Intel(R) Core(TM) i7-7567U CPU @ 3.50GHz with 32G memory
with following parameters:
test: clpeak-1.0.1
cpufreq_governor: performance
ucode: 0xca
test-description: The Phoronix Test Suite is the most comprehensive testing and benchmarking platform available that provides an extensible framework for which new tests can be easily added.
test-url: http://www.phoronix-test-suite.com/
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <rong.a.chen(a)intel.com>
Details are as below:
-------------------------------------------------------------------------------------------------->
To reproduce:
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp install job.yaml # job file is attached in this email
bin/lkp run job.yaml
=========================================================================================
compiler/cpufreq_governor/kconfig/rootfs/tbox_group/test/testcase/ucode:
gcc-7/performance/x86_64-lck-7931/clear-x86_64-phoronix-30140/lkp-kbl-nuc1/clpeak-1.0.1/phoronix-test-suite/0xca
commit:
f58642c1bc ("netfilter: ipset: avoid null deref when IPSET_ATTR_LINENO is present")
53b9bd37af ("drm/i915/gen9: Clear residual context state on context switch")
f58642c1bc7946c3 53b9bd37af59d1def99b2070753
---------------- ---------------------------
%stddev %change %stddev
\ | \
24.49 ± 2% +22.5% 30.00 phoronix-test-suite.clpeak.KernelLatency.us
101.56 ± 38% -70.7% 29.74 phoronix-test-suite.time.elapsed_time
101.56 ± 38% -70.7% 29.74 phoronix-test-suite.time.elapsed_time.max
405511 ± 30% -54.3% 185150 phoronix-test-suite.time.minor_page_faults
53.33 ± 2% +4.4% 55.67 phoronix-test-suite.time.percent_of_cpu_this_job_got
47.70 ± 37% -70.2% 14.20 phoronix-test-suite.time.user_time
454369 ± 41% -75.5% 111123 phoronix-test-suite.time.voluntary_context_switches
11.39 ± 2% -6.7% 10.62 ± 6% boot-time.dhcp
591003 ± 3% -11.4% 523381 ± 2% meminfo.Active(file)
53200 ± 50% +159.9% 138245 meminfo.max_used_kB
61.00 ± 19% -38.3% 37.67 ± 2% vmstat.cpu.id
28.00 ± 32% +63.1% 45.67 vmstat.cpu.us
3583 ± 45% +106.2% 7390 ± 5% vmstat.io.bi
1.33 ± 35% +125.0% 3.00 vmstat.procs.r
60.90 ± 20% -24.2 36.70 ± 3% mpstat.cpu.all.idle%
0.89 ± 19% +0.6 1.46 ± 14% mpstat.cpu.all.iowait%
0.20 ± 23% +0.1 0.28 ± 2% mpstat.cpu.all.soft%
8.03 ± 35% +4.7 12.69 ± 2% mpstat.cpu.all.sys%
28.78 ± 32% +18.9 47.66 mpstat.cpu.all.usr%
13077984 ± 54% -54.8% 5908886 ± 43% cpuidle.C1.time
597419 ± 46% -74.3% 153496 ± 15% cpuidle.C1.usage
24140686 ± 20% -72.9% 6543020 ± 20% cpuidle.C1E.time
356666 ± 25% -71.4% 102084 ± 12% cpuidle.C1E.usage
1.55e+08 ± 53% -86.5% 20926680 ± 24% cpuidle.C6.time
262494 ± 49% -76.9% 60562 ± 25% cpuidle.C6.usage
3614603 ± 39% -73.6% 952459 ± 2% cpuidle.POLL.time
409623 ± 42% -74.9% 102932 cpuidle.POLL.usage
79.96 ± 16% +23.4% 98.63 turbostat.Any%C0
1499 ± 30% +57.6% 2363 turbostat.Avg_MHz
38.92 ± 31% +23.0 61.94 turbostat.Busy%
597382 ± 46% -74.3% 153485 ± 15% turbostat.C1
356611 ± 25% -71.4% 102035 ± 12% turbostat.C1E
262458 ± 49% -76.9% 60550 ± 25% turbostat.C6
34.42 ± 27% -17.6 16.77 ± 24% turbostat.C6%
18.75 ± 52% -84.2% 2.96 ± 52% turbostat.CPU%c6
14.41 ± 21% +37.9% 19.87 turbostat.CorWatt
1777243 ± 32% -66.4% 597719 turbostat.IRQ
21.36 ± 14% +27.9% 27.32 turbostat.PkgWatt
123.28 ± 25% +44.0% 177.47 turbostat.Totl%C0
38364 ± 4% -23.5% 29333 ± 7% softirqs.CPU0.RCU
16353 ± 31% -60.7% 6429 ± 6% softirqs.CPU0.SCHED
55438 ± 25% -55.7% 24533 ± 4% softirqs.CPU0.TIMER
38652 ± 7% -25.8% 28672 ± 3% softirqs.CPU1.RCU
17071 ± 29% -58.5% 7091 ± 6% softirqs.CPU1.SCHED
63131 ± 33% -58.6% 26110 ± 7% softirqs.CPU1.TIMER
233404 ± 40% -74.3% 60064 softirqs.CPU2.HI
36812 ± 5% -24.4% 27818 ± 3% softirqs.CPU2.RCU
17331 ± 30% -65.2% 6025 ± 7% softirqs.CPU2.SCHED
52817 ± 26% -51.1% 25847 softirqs.CPU2.TIMER
37680 ± 4% -27.2% 27418 ± 5% softirqs.CPU3.RCU
17232 ± 33% -57.0% 7413 ± 2% softirqs.CPU3.SCHED
54880 ± 31% -48.7% 28163 ± 7% softirqs.CPU3.TIMER
233405 ± 40% -74.3% 60065 softirqs.HI
151510 ± 5% -25.3% 113242 ± 2% softirqs.RCU
67989 ± 31% -60.3% 26959 softirqs.SCHED
226267 ± 28% -53.7% 104655 softirqs.TIMER
147753 ± 3% -11.4% 130854 ± 2% proc-vmstat.nr_active_file
386270 +4.2% 402302 proc-vmstat.nr_dirty_background_threshold
3804020 -2.4% 3713749 proc-vmstat.nr_dirty_threshold
803734 -3.1% 778927 proc-vmstat.nr_file_pages
452742 -1.6% 445477 proc-vmstat.nr_inactive_file
10099 +2.1% 10308 proc-vmstat.nr_kernel_stack
2628 +1.8% 2675 proc-vmstat.nr_page_table_pages
82010 -5.4% 77547 proc-vmstat.nr_slab_reclaimable
24816 -3.2% 24014 proc-vmstat.nr_slab_unreclaimable
780.67 -2.3% 763.00 proc-vmstat.nr_unevictable
147753 ± 3% -11.4% 130854 ± 2% proc-vmstat.nr_zone_active_file
452742 -1.6% 445477 proc-vmstat.nr_zone_inactive_file
780.67 -2.3% 763.00 proc-vmstat.nr_zone_unevictable
5659020 ± 6% -46.0% 3058187 proc-vmstat.numa_hit
5659020 ± 6% -46.0% 3058187 proc-vmstat.numa_local
47921 ± 3% -16.2% 40136 ± 2% proc-vmstat.pgactivate
5867768 ± 7% -44.8% 3238245 proc-vmstat.pgalloc_normal
8000575 ± 5% -44.9% 4409621 proc-vmstat.pgfault
5730760 ± 7% -45.9% 3102373 proc-vmstat.pgfree
285530 ± 4% -23.9% 217222 ± 4% proc-vmstat.pgpgin
49.48 ± 70% -49.5 0.00 perf-profile.calltrace.cycles-pp.secondary_startup_64
40.07 ± 70% -40.1 0.00 perf-profile.calltrace.cycles-pp.intel_idle.cpuidle_enter_state.cpuidle_enter.do_idle.cpu_startup_entry
36.60 ± 79% -36.6 0.00 perf-profile.calltrace.cycles-pp.start_secondary.secondary_startup_64
36.59 ± 79% -36.6 0.00 perf-profile.calltrace.cycles-pp.cpu_startup_entry.start_secondary.secondary_startup_64
36.51 ± 79% -36.5 0.00 perf-profile.calltrace.cycles-pp.do_idle.cpu_startup_entry.start_secondary.secondary_startup_64
35.12 ± 79% -35.1 0.00 perf-profile.calltrace.cycles-pp.cpuidle_enter.do_idle.cpu_startup_entry.start_secondary.secondary_startup_64
34.92 ± 79% -34.9 0.00 perf-profile.calltrace.cycles-pp.cpuidle_enter_state.cpuidle_enter.do_idle.cpu_startup_entry.start_secondary
6.65 ± 72% -6.6 0.00 perf-profile.calltrace.cycles-pp.entry_SYSCALL_64_after_hwframe
6.47 ± 72% -6.5 0.00 perf-profile.calltrace.cycles-pp.do_syscall_64.entry_SYSCALL_64_after_hwframe
4.00 ± 72% -4.0 0.00 perf-profile.calltrace.cycles-pp.poll_idle.cpuidle_enter_state.cpuidle_enter.do_idle.cpu_startup_entry
49.48 ± 70% -49.5 0.00 perf-profile.children.cycles-pp.secondary_startup_64
49.48 ± 70% -49.5 0.00 perf-profile.children.cycles-pp.cpu_startup_entry
49.37 ± 70% -49.4 0.00 perf-profile.children.cycles-pp.do_idle
47.50 ± 70% -47.5 0.00 perf-profile.children.cycles-pp.cpuidle_enter
47.38 ± 70% -47.4 0.00 perf-profile.children.cycles-pp.cpuidle_enter_state
40.10 ± 70% -40.1 0.00 perf-profile.children.cycles-pp.intel_idle
36.60 ± 79% -36.6 0.00 perf-profile.children.cycles-pp.start_secondary
7.29 ± 72% -7.3 0.00 perf-profile.children.cycles-pp.entry_SYSCALL_64_after_hwframe
7.12 ± 71% -7.1 0.00 perf-profile.children.cycles-pp.do_syscall_64
4.03 ± 72% -4.0 0.00 perf-profile.children.cycles-pp.poll_idle
40.10 ± 70% -40.1 0.00 perf-profile.self.cycles-pp.intel_idle
3.76 ± 71% -3.8 0.00 perf-profile.self.cycles-pp.poll_idle
695942 ± 40% -74.6% 176670 interrupts.125:IR-PCI-MSI.32768-edge.i915
34054 ± 4% -17.3% 28167 ± 9% interrupts.127:IR-PCI-MSI.376832-edge.ahci[0000:00:17.0]
1050 ± 28% -49.8% 527.33 ± 39% interrupts.128:IR-PCI-MSI.520192-edge.eth0
222197 ± 4% -41.3% 130456 interrupts.CAL:Function_call_interrupts
55148 -39.6% 33319 ± 2% interrupts.CPU0.CAL:Function_call_interrupts
194140 ± 36% -68.0% 62087 interrupts.CPU0.LOC:Local_timer_interrupts
1863 ± 88% -97.8% 41.33 ± 89% interrupts.CPU0.NMI:Non-maskable_interrupts
1863 ± 88% -97.8% 41.33 ± 89% interrupts.CPU0.PMI:Performance_monitoring_interrupts
6030 ± 17% -32.2% 4089 ± 7% interrupts.CPU0.RES:Rescheduling_interrupts
5253 ± 37% -73.9% 1369 ± 23% interrupts.CPU0.TLB:TLB_shootdowns
34054 ± 4% -17.3% 28167 ± 9% interrupts.CPU1.127:IR-PCI-MSI.376832-edge.ahci[0000:00:17.0]
56244 ± 8% -42.8% 32144 ± 2% interrupts.CPU1.CAL:Function_call_interrupts
194206 ± 36% -68.0% 62051 interrupts.CPU1.LOC:Local_timer_interrupts
1228 ± 67% -96.7% 41.00 ± 82% interrupts.CPU1.NMI:Non-maskable_interrupts
1228 ± 67% -96.7% 41.00 ± 82% interrupts.CPU1.PMI:Performance_monitoring_interrupts
4247 ± 13% -41.7% 2477 ± 5% interrupts.CPU1.RES:Rescheduling_interrupts
2396 ± 58% -76.5% 562.33 ± 30% interrupts.CPU1.TLB:TLB_shootdowns
695942 ± 40% -74.6% 176670 interrupts.CPU2.125:IR-PCI-MSI.32768-edge.i915
1050 ± 28% -49.8% 527.33 ± 39% interrupts.CPU2.128:IR-PCI-MSI.520192-edge.eth0
54618 -37.7% 34042 ± 4% interrupts.CPU2.CAL:Function_call_interrupts
194173 ± 36% -68.0% 62105 interrupts.CPU2.LOC:Local_timer_interrupts
1547 ± 73% -97.3% 41.00 ± 77% interrupts.CPU2.NMI:Non-maskable_interrupts
1547 ± 73% -97.3% 41.00 ± 77% interrupts.CPU2.PMI:Performance_monitoring_interrupts
9129 ± 17% -48.5% 4701 ± 6% interrupts.CPU2.RES:Rescheduling_interrupts
1957 ± 60% -91.0% 175.33 ± 37% interrupts.CPU2.TLB:TLB_shootdowns
56187 ± 5% -44.9% 30951 ± 6% interrupts.CPU3.CAL:Function_call_interrupts
194173 ± 36% -68.0% 62079 interrupts.CPU3.LOC:Local_timer_interrupts
947.00 ± 67% -95.8% 39.33 ± 85% interrupts.CPU3.NMI:Non-maskable_interrupts
947.00 ± 67% -95.8% 39.33 ± 85% interrupts.CPU3.PMI:Performance_monitoring_interrupts
5359 ± 32% -93.4% 353.67 ± 46% interrupts.CPU3.TLB:TLB_shootdowns
776694 ± 36% -68.0% 248323 interrupts.LOC:Local_timer_interrupts
5586 ± 72% -97.1% 162.67 ± 83% interrupts.NMI:Non-maskable_interrupts
5586 ± 72% -97.1% 162.67 ± 83% interrupts.PMI:Performance_monitoring_interrupts
24885 ± 7% -36.2% 15873 ± 7% interrupts.RES:Rescheduling_interrupts
14966 ± 11% -83.6% 2461 ± 9% interrupts.TLB:TLB_shootdowns
2014 ± 46% +58.2% 3187 ± 34% sched_debug.cfs_rq:/.load_avg.max
33405 ± 40% -58.6% 13826 ± 9% sched_debug.cfs_rq:/.min_vruntime.avg
37077 ± 38% -51.2% 18080 ± 26% sched_debug.cfs_rq:/.min_vruntime.max
29779 ± 42% -60.7% 11702 ± 6% sched_debug.cfs_rq:/.min_vruntime.min
1489 ± 10% +38.2% 2058 ± 14% sched_debug.cfs_rq:/.util_avg.max
94180 ± 5% -69.7% 28544 ± 69% sched_debug.cpu.avg_idle.min
62749 ± 44% -65.5% 21617 ± 5% sched_debug.cpu.clock.avg
62750 ± 44% -65.5% 21623 ± 5% sched_debug.cpu.clock.max
62748 ± 44% -65.6% 21612 ± 5% sched_debug.cpu.clock.min
0.72 ± 20% +490.0% 4.26 ± 45% sched_debug.cpu.clock.stddev
61991 ± 44% -65.5% 21373 ± 5% sched_debug.cpu.clock_task.avg
62297 ± 44% -65.4% 21536 ± 5% sched_debug.cpu.clock_task.max
61557 ± 44% -65.7% 21140 ± 5% sched_debug.cpu.clock_task.min
297.83 ± 30% -43.4% 168.59 sched_debug.cpu.clock_task.stddev
2455 ± 33% +43.8% 3529 ± 10% sched_debug.cpu.curr->pid.avg
0.00 ± 31% -51.7% 0.00 ± 38% sched_debug.cpu.next_balance.stddev
203929 ± 46% -67.6% 66070 ± 7% sched_debug.cpu.nr_switches.avg
258658 ± 46% -68.4% 81856 ± 4% sched_debug.cpu.nr_switches.max
155789 ± 46% -67.3% 51018 ± 8% sched_debug.cpu.nr_switches.min
0.17 ±108% +250.0% 0.58 ± 53% sched_debug.cpu.nr_uninterruptible.avg
60.22 ± 56% -70.7% 17.67 ± 49% sched_debug.cpu.nr_uninterruptible.max
-78.78 -83.5% -13.00 sched_debug.cpu.nr_uninterruptible.min
54.22 ± 53% -77.4% 12.27 ± 41% sched_debug.cpu.nr_uninterruptible.stddev
1225073 ± 70% -99.9% 749.58 ± 36% sched_debug.cpu.sched_count.avg
1935922 ± 72% -99.9% 1573 ± 36% sched_debug.cpu.sched_count.max
519540 ± 79% -99.9% 535.76 ± 41% sched_debug.cpu.sched_count.stddev
68013 ± 70% -99.4% 428.67 ± 39% sched_debug.cpu.ttwu_count.avg
117399 ± 70% -99.3% 848.33 ± 51% sched_debug.cpu.ttwu_count.max
30185 ± 70% -99.0% 305.10 ± 62% sched_debug.cpu.ttwu_count.stddev
18430 ± 69% -98.5% 277.08 ± 43% sched_debug.cpu.ttwu_local.avg
41983 ± 69% -98.7% 534.33 ± 48% sched_debug.cpu.ttwu_local.max
13660 ± 68% -98.6% 186.19 ± 63% sched_debug.cpu.ttwu_local.stddev
62747 ± 44% -65.6% 21609 ± 5% sched_debug.cpu_clk
62538 ± 44% -65.7% 21422 ± 5% sched_debug.ktime
0.02 ±141% +249.5% 0.06 ± 22% sched_debug.rt_rq:/.rt_time.avg
62766 ± 44% -65.6% 21619 ± 5% sched_debug.sched_clk
53.07 ± 25% -37.9% 32.94 perf-stat.i.MPKI
1.429e+09 ± 27% +52.1% 2.173e+09 perf-stat.i.branch-instructions
25378470 ± 48% +113.2% 54106012 perf-stat.i.branch-misses
41939756 ± 26% +38.8% 58213548 perf-stat.i.cache-misses
1.916e+08 ± 25% +47.4% 2.823e+08 ± 2% perf-stat.i.cache-references
13953 ± 10% +17.0% 16320 perf-stat.i.context-switches
1.39 ± 16% -22.4% 1.08 perf-stat.i.cpi
5.98e+09 ± 31% +57.8% 9.436e+09 perf-stat.i.cpu-cycles
253.07 ± 45% +98.8% 503.12 ± 6% perf-stat.i.cpu-migrations
0.22 ± 38% -0.1 0.10 perf-stat.i.dTLB-load-miss-rate%
1478975 ± 21% +34.7% 1991993 perf-stat.i.dTLB-load-misses
1.516e+09 ± 24% +42.7% 2.163e+09 perf-stat.i.dTLB-loads
0.14 ± 11% -0.0 0.11 perf-stat.i.dTLB-store-miss-rate%
565610 ± 24% +34.5% 760493 perf-stat.i.dTLB-store-misses
6.417e+08 ± 17% +31.0% 8.404e+08 perf-stat.i.dTLB-stores
611337 ± 19% +29.3% 790163 ± 2% perf-stat.i.iTLB-load-misses
5.981e+09 ± 26% +49.3% 8.931e+09 perf-stat.i.instructions
1.82 ± 51% +157.8% 4.70 perf-stat.i.major-faults
1.68 ± 19% +0.8 2.49 perf-stat.overall.branch-miss-rate%
21.83 -1.2 20.63 ± 2% perf-stat.overall.cache-miss-rate%
0.99 ± 4% +6.9% 1.06 perf-stat.overall.cpi
141.04 ± 4% +14.9% 162.09 perf-stat.overall.cycles-between-cache-misses
0.10 ± 3% -0.0 0.09 perf-stat.overall.dTLB-load-miss-rate%
14.55 ± 6% +1.2 15.77 ± 2% perf-stat.overall.iTLB-load-miss-rate%
9694 ± 9% +16.7% 11311 ± 2% perf-stat.overall.instructions-per-iTLB-miss
1.01 ± 4% -6.6% 0.95 perf-stat.overall.ipc
1.413e+09 ± 26% +50.9% 2.132e+09 perf-stat.ps.branch-instructions
25047514 ± 47% +112.0% 53091697 perf-stat.ps.branch-misses
41461384 ± 25% +37.8% 57118869 perf-stat.ps.cache-misses
1.894e+08 ± 24% +46.3% 2.77e+08 ± 2% perf-stat.ps.cache-references
13813 ± 9% +15.9% 16012 perf-stat.ps.context-switches
5.91e+09 ± 30% +56.7% 9.258e+09 perf-stat.ps.cpu-cycles
249.80 ± 45% +97.7% 493.74 ± 6% perf-stat.ps.cpu-migrations
1462753 ± 20% +33.6% 1954515 perf-stat.ps.dTLB-load-misses
1.499e+09 ± 23% +41.6% 2.122e+09 perf-stat.ps.dTLB-loads
6.349e+08 ± 16% +29.9% 8.246e+08 perf-stat.ps.dTLB-stores
3524622 ± 12% +17.5% 4140201 perf-stat.ps.iTLB-loads
5.913e+09 ± 25% +48.2% 8.763e+09 perf-stat.ps.instructions
1.80 ± 50% +156.4% 4.61 perf-stat.ps.major-faults
5.49e+11 ± 21% -50.6% 2.71e+11 perf-stat.total.instructions
phoronix-test-suite.clpeak.KernelLatency.us
35 +----------------------------------------------------------------------+
| |
30 |-+ O O O O |
| O O |
25 |-+ +...+ +...+ + + + + |
| : : : : : : : + : |
20 |:+ : : : : : : : : : : : : : :|
|: : : : : : : : : : : : : : : :|
15 |-: : : : : : : : : : : : : : : : |
| : : : : : : : : : : : : : : : : |
10 |-: : : : : : : : : : : : : : : : |
| : : : : : : : : : : : : : : : : |
5 |-+: : : : : : : : : : : : : : : : |
| : : : : : : : : |
0 +----------------------------------------------------------------------+
[*] bisect-good sample
[O] bisect-bad sample
Disclaimer:
Results have been estimated based on internal Intel analysis and are provided
for informational purposes only. Any difference in system hardware or software
design or configuration may affect actual performance.
Thanks,
Rong Chen
1 month, 1 week
- 3
- 3