linux-kernel - [lkp-robot] [x86] 1a39381d70: WARNING:at_kernel/locking/mutex.c:#__mutex_unlock

lists.openwall.net		lists / announce owl-users owl-dev john-users john-dev passwdqc-users yescrypt popa3d-users / oss-security kernel-hardening musl sabotage tlsify passwords / crypt-dev xvendor / Bugtraq Full-Disclosure linux-kernel linux-netdev linux-ext4 linux-hardening linux-cve-announce PHC
Open Source and information security mailing list archives
Hash Suite: Windows password security audit tool. GUI, reports in PDF.
[<prev] [next>] [<thread-prev] [day] [month] [year] [list]
Message-ID: <20180607030530.GR16472@yexl-desktop>
Date:   Thu, 7 Jun 2018 11:05:30 +0800
From:   kernel test robot <xiaolong.ye@...el.com>
To:     Nadav Amit <namit@...are.com>
Cc:     linux-kernel@...r.kernel.org, x86@...nel.org,
        Nadav Amit <namit@...are.com>,
        Thomas Gleixner <tglx@...utronix.de>,
        Ingo Molnar <mingo@...hat.com>,
        "H. Peter Anvin" <hpa@...or.com>,
        Josh Poimboeuf <jpoimboe@...hat.com>, lkp@...org
Subject: [lkp-robot] [x86]  1a39381d70:
 WARNING:at_kernel/locking/mutex.c:#__mutex_unlock_slowpath


FYI, we noticed the following commit (built with gcc-7):

commit: 1a39381d70000f0097ec6e2ceb75812d6c00b2f1 ("x86: alternatives: macrofy locks for better inlining")
url: https://github.com/0day-ci/linux/commits/Nadav-Amit/x86-macrofying-inline-asm-for-better-compilation/20180605-124313


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 Haswell,+smep,+smap -m 512M

caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):


+-----------------------------------------------------------------------------------------+------------+------------+
|                                                                                         | 2c1316126e | 1a39381d70 |
+-----------------------------------------------------------------------------------------+------------+------------+
| boot_successes                                                                          | 0          | 0          |
| boot_failures                                                                           | 18         | 17         |
| WARNING:at_lib/debugobjects.c:#__debug_object_init                                      | 18         |            |
| RIP:__debug_object_init                                                                 | 18         |            |
| WARNING:at_kernel/locking/mutex.c:#__mutex_unlock_slowpath                              | 0          | 17         |
| RIP:__mutex_unlock_slowpath                                                             | 0          | 17         |
| WARNING:at_arch/x86/kernel/idt.c:#update_intr_gate                                      | 0          | 17         |
| RIP:update_intr_gate                                                                    | 0          | 17         |
| page_allocation_failure:order:#,mode:#(),nodemask=(null)                                | 0          | 17         |
| Mem-Info                                                                                | 0          | 17         |
| Kernel_panic-not_syncing:kmem_cache_create:Failed_to_create_slab'radix_tree_node'.Error | 0          | 17         |
+-----------------------------------------------------------------------------------------+------------+------------+



[    0.000000] WARNING: CPU: 0 PID: 0 at kernel/locking/mutex.c:1032 __mutex_unlock_slowpath+0x1ff/0x2a0
[    0.000000] Modules linked in:
[    0.000000] CPU: 0 PID: 0 Comm: swapper Not tainted 4.17.0-00004-g1a39381 #2
[    0.000000] RIP: 0010:__mutex_unlock_slowpath+0x1ff/0x2a0
[    0.000000] RSP: 0000:ffffffffb4a03df0 EFLAGS: 00010082 ORIG_RAX: 0000000000000000
[    0.000000] RAX: 0000000000000033 RBX: 0000000000000000 RCX: ffffffffb4a797c0
[    0.000000] RDX: ffffffffb36b41de RSI: 0000000000000001 RDI: 0000000000000046
[    0.000000] RBP: ffffffffb4a03e30 R08: 0000000000000001 R09: 0000000000000000
[    0.000000] R10: 0000000000000000 R11: 0000000000000000 R12: ffffffffb4c789e0
[    0.000000] R13: ffffffffb4a03df8 R14: ffffffffb48dcfb0 R15: 0000000000000000
[    0.000000] FS:  0000000000000000(0000) GS:ffffffffb4a8e000(0000) knlGS:0000000000000000
[    0.000000] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[    0.000000] CR2: ffffa2951a312000 CR3: 0000000018a74000 CR4: 00000000000606b0
[    0.000000] Call Trace:
[    0.000000]  mutex_unlock+0x12/0x20
[    0.000000]  __clocksource_register_scale+0xda/0x120
[    0.000000]  kvmclock_init+0x22d/0x23f
[    0.000000]  setup_arch+0xa20/0xaf6
[    0.000000]  start_kernel+0x6a/0x4dc
[    0.000000]  ? copy_bootdata+0x1f/0xb8
[    0.000000]  x86_64_start_reservations+0x24/0x26
[    0.000000]  x86_64_start_kernel+0x73/0x76
[    0.000000]  secondary_startup_64+0xa5/0xb0
[    0.000000] Code: 0f 0b e9 ae fe ff ff e8 d0 15 a5 ff 85 c0 74 1d 44 8b 15 1d 0c 8f 01 45 85 d2 75 11 4c 89 f6 48 c7 c7 53 b4 8c b4 e8 81 3a 5c ff <0f> 0b 44 8b 0d c0 b2 7c 01 45 85 c9 0f 84 6f fe ff ff e9 73 fe 
[    0.000000] random: get_random_bytes called from print_oops_end_marker+0x3f/0x60 with crng_init=0
[    0.000000] ---[ end trace a9c261981ad74140 ]---


To reproduce:

        git clone https://github.com/intel/lkp-tests.git
        cd lkp-tests
        bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email



Thanks,
Xiaolong

View attachment "config-4.17.0-00004-g1a39381" of type "text/plain" (120533 bytes)

View attachment "job-script" of type "text/plain" (3862 bytes)

Download attachment "dmesg.xz" of type "application/x-xz" (5304 bytes)