[<prev] [next>] [day] [month] [year] [list]
Message-ID: <20171009155225.7to6zkdfesziro7u@wfg-t540p.sh.intel.com>
Date: Mon, 9 Oct 2017 23:52:25 +0800
From: Fengguang Wu <fengguang.wu@...el.com>
To: "Levin, Alexander (Sasha Levin)" <alexander.levin@...izon.com>
Cc: wfg@...ux.intel.com, Ingo Molnar <mingo@...nel.org>,
linux-kernel@...r.kernel.org, LKP <lkp@...org>
Subject: [rtmutex] cde50a6739 [ 3.661979] WARNING: bad unlock balance
detected!
Greetings,
0day kernel testing robot got the below dmesg and the first bad commit is
https://git.kernel.org/pub/scm/linux/kernel/git/torvalds/linux.git master
commit cde50a67397c0da7d11795d4b4418384022ab8e6
Author: Levin, Alexander (Sasha Levin) <alexander.levin@...izon.com>
AuthorDate: Sun Jun 18 14:06:01 2017 +0000
Commit: Ingo Molnar <mingo@...nel.org>
CommitDate: Tue Jun 20 11:53:09 2017 +0200
locking/rtmutex: Don't initialize lockdep when not required
pi_mutex isn't supposed to be tracked by lockdep, but just
passing NULLs for name and key will cause lockdep to spew a
warning and die, which is not what we want it to do.
Skip lockdep initialization if the caller passed NULLs for
name and key, suggesting such initialization isn't desired.
Signed-off-by: Sasha Levin <alexander.levin@...izon.com>
Cc: Linus Torvalds <torvalds@...ux-foundation.org>
Cc: Peter Zijlstra <peterz@...radead.org>
Cc: Thomas Gleixner <tglx@...utronix.de>
Fixes: f5694788ad8d ("rt_mutex: Add lockdep annotations")
Link: http://lkml.kernel.org/r/20170618140548.4763-1-alexander.levin@verizon.com
Signed-off-by: Ingo Molnar <mingo@...nel.org>
018956d641 locking/selftest: Add RT-mutex support
cde50a6739 locking/rtmutex: Don't initialize lockdep when not required
42b76d0e6b Merge tag 'armsoc-fixes' of git://git.kernel.org/pub/scm/linux/kernel/git/arm/arm-soc
1418b85217 Add linux-next specific files for 20170929
+------------------------------------------------------------------+------------+------------+------------+---------------+
| | 018956d641 | cde50a6739 | 42b76d0e6b | next-20170929 |
+------------------------------------------------------------------+------------+------------+------------+---------------+
| boot_successes | 745 | 259 | 126 | 0 |
| boot_failures | 138 | 26 | 167 | 300 |
| WARNING:at_kernel/locking/lockdep.c:#lockdep_init_map | 55 | | | |
| BUG:kernel_hang_in_test_stage | 32 | 3 | 10 | |
| BUG:kernel_reboot-without-warning_in_test_stage | 4 | 2 | 1 | |
| BUG:workqueue_lockup-pool | 47 | 11 | 25 | 32 |
| WARNING:suspicious_RCU_usage | 3 | 0 | 3 | 4 |
| kernel/rcu/rcutorture.c:#suspicious_rcu_dereference_check()usage | 3 | 0 | 3 | 4 |
| INFO:rcu_preempt_detected_stalls_on_CPUs/tasks | 1 | 0 | 0 | 4 |
| WARNING:bad_unlock_balance_detected | 0 | 10 | 139 | |
| is_trying_to_release_lock(rcu_preempt_state)at | 0 | 9 | 139 | |
| INFO:rcu_preempt_self-detected_stall_on_CPU | 0 | 0 | 1 | |
| kernel_BUG_at_arch/x86/mm/physaddr.c | 0 | 0 | 0 | 270 |
| invalid_opcode:#[##] | 0 | 0 | 0 | 270 |
| Kernel_panic-not_syncing:Fatal_exception | 0 | 0 | 0 | 270 |
+------------------------------------------------------------------+------------+------------+------------+---------------+
[ 3.637153] rcu-torture: Creating rcu_torture_cbflood task
[ 3.638063] rcu-torture: rcu_torture_boost started
[ 3.643372] rcu-torture: rcu_torture_cbflood task started
[ 3.660861]
[ 3.661161] =====================================
[ 3.661979] WARNING: bad unlock balance detected!
[ 3.662795] 4.12.0-rc4-00028-gcde50a6 #1 Not tainted
[ 3.667742] -------------------------------------
[ 3.668564] swapper/0/1 is trying to release lock (rcu_preempt_state) at:
[ 3.669754] [<ffffffffa4d3dabd>] rcu_read_unlock_special+0x54d/0x6f0
[ 3.670838] but there are no more locks to release!
[ 3.672117]
[ 3.672117] other info that might help us debug this:
[ 3.673055] 4 locks held by swapper/0/1:
[ 3.673616] #0: (gcov_lock){+.+.+.}, at: [<ffffffffa4d7b20c>] gcov_enable_events+0x1c/0x90
[ 3.674805] #1: (node_lock){+.+.+.}, at: [<ffffffffa4d7c0ac>] gcov_event+0x2c/0x620
[ 3.675927] #2: (&sb->s_type->i_mutex_key#3){+.+.+.}, at: [<ffffffffa4efa36e>] start_creating+0x6e/0x140
[ 3.677409] #3: (rcu_read_lock){......}, at: [<ffffffffa4e554c0>] __d_lookup+0x0/0x390
[ 3.678660]
[ 3.678660] stack backtrace:
[ 3.679331] CPU: 1 PID: 1 Comm: swapper/0 Not tainted 4.12.0-rc4-00028-gcde50a6 #1
[ 3.680514] Call Trace:
[ 3.680916] dump_stack+0x168/0x215
[ 3.681480] ? rcu_read_unlock_special+0x54d/0x6f0
[ 3.682222] print_unlock_imbalance_bug+0x175/0x190
[ 3.693175] lock_release+0x44a/0x5a0
[ 3.693768] rt_mutex_unlock+0x3e/0x110
[ 3.694370] ? trace_hardirqs_on+0x1b/0x30
[ 3.695021] rcu_read_unlock_special+0x54d/0x6f0
[ 3.695776] __rcu_read_unlock+0x9a/0xb0
[ 3.696472] __d_lookup+0x14c/0x390
[ 3.697088] ? __d_lookup_rcu+0x2a0/0x2a0
[ 3.697797] d_lookup+0x11b/0x1e0
[ 3.698379] ? lookup_dcache+0x28/0xb0
[ 3.699042] lookup_dcache+0x28/0xb0
[ 3.699662] __lookup_hash+0x29/0x100
[ 3.700236] lookup_one_len+0x15f/0x1a0
[ 3.700841] start_creating+0x8a/0x140
[ 3.701439] __debugfs_create_file+0x50/0x150
[ 3.702119] debugfs_create_file+0x22/0x40
[ 3.702766] new_node+0x140/0x570
[ 3.703289] ? __kmalloc_track_caller+0x8f/0xc0
[ 3.704058] gcov_event+0x54b/0x620
[ 3.704679] gcov_enable_events+0x40/0x90
[ 3.705384] ? gcov_persist_setup+0x71/0x71
[ 3.706795] gcov_fs_init+0xee/0x128
[ 3.707337] do_one_initcall+0xd5/0x21a
[ 3.707929] kernel_init_freeable+0x39f/0x489
[ 3.708707] ? do_early_param+0xd7/0xd7
[ 3.709391] ? rest_init+0x1e0/0x1e0
[ 3.710011] kernel_init+0x10/0x1b0
[ 3.710523] ret_from_fork+0x2a/0x40
[ 4.587976] tsc: Refined TSC clocksource calibration: 2693.508 MHz
[ 4.601228] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x26d349e8249, max_idle_ns: 440795288087 ns
[ 4.888892] workingset: timestamp_bits=46 max_order=17 bucket_order=0
[ 4.889890] zbud: loaded
[ 4.890654] fuse init (API version 7.26)
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start v4.13 v4.12 --
git bisect bad 63a86362130f4c17eaa57f3ef5171ec43111a54e # 17:11 B 29 6 3 3 Merge tag 'pm-4.13-rc2' of git://git.kernel.org/pub/scm/linux/kernel/git/rafael/linux-pm
git bisect bad 090a81d8766e21d33ab3e4d24e6c8e5eedf086dd # 17:29 B 17 1 0 0 Merge branch 'for-spi' of git://git.kernel.org/pub/scm/linux/kernel/git/viro/vfs
git bisect bad 3bad2f1c676581d01e7645eb03e9b27e28b0a92e # 17:51 B 21 4 0 0 Merge branch 'work.misc-set_fs' of git://git.kernel.org/pub/scm/linux/kernel/git/viro/vfs
git bisect bad 362f6729cbb1d6bbab59e069f19441b0622ff7ec # 18:10 B 12 12 2 2 Merge tag 'usb-4.13-rc1' of git://git.kernel.org/pub/scm/linux/kernel/git/gregkh/usb
git bisect bad 6553698be05983056f5561cef6aaee0cc6afe7a0 # 18:22 B 0 18 30 0 Merge branch 'x86-cleanups-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
git bisect bad 892ad5acca0b2ddb514fae63fa4686bf726d2471 # 18:49 B 53 1 6 6 Merge branch 'locking-core-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
git bisect good 26d3a77d2cb3cb31bbaa2de37b7a4e6375f204ee # 09:18 G 275 0 28 28 Merge tag 'edac_for_4.13' of git://git.kernel.org/pub/scm/linux/kernel/git/bp/bp
git bisect good 330e9e46253cbfab178450c976aa90ef0f3ae940 # 22:52 G 275 0 25 25 Merge branch 'core-rcu-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
git bisect good 162b246eb420d2ca2002a50917c897b10c9aba09 # 06:29 G 276 0 16 16 Merge branch 'efi-core-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
git bisect good 12d83f7361724e5aa4299bb28e4caadc62ae482b # 07:29 G 281 0 21 21 tools/include: Add (mostly) empty include/linux/sched/mm.h
git bisect good 3942b77121986519ee52ab4dd4ae8f4383dfe765 # 08:46 G 281 0 41 41 MAINTAINERS: Claim atomic*_t maintainership
git bisect bad cde50a67397c0da7d11795d4b4418384022ab8e6 # 09:09 B 36 2 2 2 locking/rtmutex: Don't initialize lockdep when not required
git bisect good cfb6133399a490419cda55fcdcf9dbbca65eacba # 11:59 G 285 0 59 59 locking/selftest: Remove the bad unlock ordering test
git bisect good 018956d6419be3e5ff5aacc60b2a3cff585adee1 # 13:04 G 282 0 45 45 locking/selftest: Add RT-mutex support
# first bad commit: [cde50a67397c0da7d11795d4b4418384022ab8e6] locking/rtmutex: Don't initialize lockdep when not required
git bisect good 018956d6419be3e5ff5aacc60b2a3cff585adee1 # 13:57 G 825 0 84 129 locking/selftest: Add RT-mutex support
# extra tests with CONFIG_DEBUG_INFO_REDUCED
git bisect bad cde50a67397c0da7d11795d4b4418384022ab8e6 # 14:23 B 62 1 1 1 locking/rtmutex: Don't initialize lockdep when not required
# extra tests on HEAD of linux-devel/devel-hourly-2017092912
git bisect bad 24b0ce22bf476fe0e1c1a867bf79de69cdfc0e17 # 14:29 B 0 2 28 11 0day head guard for 'devel-hourly-2017092912'
# extra tests on tree/branch linus/master
git bisect bad 42b76d0e6b1fe0fcb90e0ff6b4d053d50597b031 # 14:42 B 1 1 0 0 Merge tag 'armsoc-fixes' of git://git.kernel.org/pub/scm/linux/kernel/git/arm/arm-soc
# extra tests with first bad commit reverted
git bisect good aa92526f37dc05abd018ccd5dc59f463f87009a4 # 15:47 G 280 0 107 107 Revert "locking/rtmutex: Don't initialize lockdep when not required"
# extra tests on tree/branch linux-next/master
git bisect good 1418b852174ad50b3cb4738b8801626aefdc0bd9 # 16:42 G 280 0 280 280 Add linux-next specific files for 20170929
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
Download attachment "dmesg-quantal-vp-12:20171005090750:x86_64-randconfig-n0-09291732:4.12.0-rc4-00028-gcde50a6:1.gz" of type "application/gzip" (20579 bytes)
Download attachment "dmesg-quantal-vp-10:20171005131332:x86_64-randconfig-n0-09291732:4.12.0-rc4-00027-g018956d6419be:1.gz" of type "application/gzip" (21185 bytes)
View attachment "reproduce-quantal-vp-12:20171005090750:x86_64-randconfig-n0-09291732:4.12.0-rc4-00028-gcde50a6:1" of type "text/plain" (888 bytes)
View attachment "config-4.12.0-rc4-00028-gcde50a6" of type "text/plain" (88332 bytes)
Powered by blists - more mailing lists