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 for Android: free password hash cracker in your pocket
[<prev] [next>] [thread-next>] [day] [month] [year] [list]
Message-ID: <20171009155536.nunzqpzfb5jcbaqd@wfg-t540p.sh.intel.com>
Date:   Mon, 9 Oct 2017 23:55:36 +0800
From:   Fengguang Wu <fengguang.wu@...el.com>
To:     Linus Torvalds <torvalds@...ux-foundation.org>
Cc:     wfg@...ux.intel.com, LKML <linux-kernel@...r.kernel.org>,
        Ingo Molnar <mingo@...nel.org>, LKP <lkp@...org>
Subject: [locking] 892ad5acca [   12.849409] 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 892ad5acca0b2ddb514fae63fa4686bf726d2471
Merge: 162b246eb420d 5d6dec6fba38c
Author:     Linus Torvalds <torvalds@...ux-foundation.org>
AuthorDate: Mon Jul 3 12:14:18 2017 -0700
Commit:     Linus Torvalds <torvalds@...ux-foundation.org>
CommitDate: Mon Jul 3 12:14:18 2017 -0700

     Merge branch 'locking-core-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
     
     Pull locking updates from Ingo Molnar:
      "The main changes in this cycle were:
     
        - Add CONFIG_REFCOUNT_FULL=y to allow the disabling of the 'full'
          (robustness checked) refcount_t implementation with slightly lower
          runtime overhead. (Kees Cook)
     
          The lighter weight variant is the default. The two variants use the
          same API. Having this variant was a precondition by some
          maintainers to merge refcount_t cleanups.
     
        - Add lockdep support for rtmutexes (Peter Zijlstra)
     
        - liblockdep fixes and improvements (Sasha Levin, Ben Hutchings)
     
        - ... misc fixes and improvements"
     
     * 'locking-core-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip: (30 commits)
       locking/refcount: Remove the half-implemented refcount_sub() API
       locking/refcount: Create unchecked atomic_t implementation
       locking/rtmutex: Don't initialize lockdep when not required
       locking/selftest: Add RT-mutex support
       locking/selftest: Remove the bad unlock ordering test
       rt_mutex: Add lockdep annotations
       MAINTAINERS: Claim atomic*_t maintainership
       locking/x86: Remove the unused atomic_inc_short() methd
       tools/lib/lockdep: Remove private kernel headers
       tools/lib/lockdep: Hide liblockdep output from test results
       tools/lib/lockdep: Add dummy current_gfp_context()
       tools/include: Add IS_ERR_OR_NULL to err.h
       tools/lib/lockdep: Add empty __is_[module,kernel]_percpu_address
       tools/lib/lockdep: Include err.h
       tools/include: Add (mostly) empty include/linux/sched/mm.h
       tools/lib/lockdep: Use LDFLAGS
       tools/lib/lockdep: Remove double-quotes from soname
       tools/lib/lockdep: Fix object file paths used in an out-of-tree build
       tools/lib/lockdep: Fix compilation for 4.11
       tools/lib/lockdep: Don't mix fd-based and stream IO
       ...

162b246eb4  Merge branch 'efi-core-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
5d6dec6fba  locking/refcount: Remove the half-implemented refcount_sub() API
892ad5acca  Merge branch 'locking-core-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
7a92616c0b  Merge tag 'pm-4.14-rc4' of git://git.kernel.org/pub/scm/linux/kernel/git/rafael/linux-pm
1418b85217  Add linux-next specific files for 20170929
+------------------------------------------------+------------+------------+------------+------------+---------------+
|                                                | 162b246eb4 | 5d6dec6fba | 892ad5acca | 7a92616c0b | next-20170929 |
+------------------------------------------------+------------+------------+------------+------------+---------------+
| boot_successes                                 | 47         | 47         | 0          | 4          | 16            |
| boot_failures                                  | 0          | 0          | 16         | 19         |               |
| WARNING:bad_unlock_balance_detected            | 0          | 0          | 16         | 19         |               |
| is_trying_to_release_lock(rcu_preempt_state)at | 0          | 0          | 16         | 19         |               |
+------------------------------------------------+------------+------------+------------+------------+---------------+

This also occurs in 4.14-rc4.

[    2.007473]   Duration of test: 371853014 ns
[    2.007970] Average test time: 370129908
[    2.008369] Testing concurrent rhashtable access from 10 threads
[   12.847998] 
[   12.848626] =====================================
[   12.849409] WARNING: bad unlock balance detected!
[   12.850157] 4.12.0-00420-g892ad5a #1 Not tainted
[   12.850870] -------------------------------------
[   12.851574] rhashtable_thra/109 is trying to release lock (rcu_preempt_state) at:
[   12.852701] [<ffffffff811087c8>] rcu_read_unlock_special+0x3de/0x4a7
[   12.853707] but there are no more locks to release!
[   12.854505] 
[   12.854505] other info that might help us debug this:
[   12.855522] 1 lock held by rhashtable_thra/109:
[   12.856206]  #0:  (rcu_read_lock){......}, at: [<ffffffff812d263e>] thread_lookup_test+0x27/0x50b
[   12.857530] 
[   12.857530] stack backtrace:
[   12.858221] CPU: 0 PID: 109 Comm: rhashtable_thra Not tainted 4.12.0-00420-g892ad5a #1
[   12.859494] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[   12.860783] Call Trace:
[   12.861164]  dump_stack+0xf1/0x162
[   12.861684]  ? rcu_read_unlock_special+0x3de/0x4a7
[   12.862411]  print_unlock_imbalance_bug+0x15c/0x16c
[   12.863142]  lock_release+0x22c/0x304
[   12.863706]  rt_mutex_unlock+0x34/0xed
[   12.864288]  ? trace_hardirqs_on+0x1b/0x24
[   12.864927]  rcu_read_unlock_special+0x3de/0x4a7
[   12.865660]  __rcu_read_unlock+0x62/0x9f
[   12.866262]  thread_lookup_test+0x400/0x50b
[   12.866911]  threadfunc+0x84f/0x8e0
[   12.867474]  ? insert_retry+0x762/0x762
[   12.868406]  kthread+0x183/0x192
[   12.868934]  ? kthread_stop+0xb7/0xb7
[   12.869523]  ret_from_fork+0x2a/0x40
[   13.780976] rhashtable_thra (111) used greatest stack depth: 14152 bytes left
[   13.782110] Started 10 threads, 0 failed
[   13.840515] rcu-perf: rcu_perf_writer 0 has 100 measurements
[   13.851933] rcu-perf: Test complete
[   13.852512] rcu-perf:!!! All grace periods expedited, no normal ones to measure!

                                                           # HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start v4.13 v4.12 --
git bisect  bad 63a86362130f4c17eaa57f3ef5171ec43111a54e  # 03:23  B      0    11   24   0  Merge tag 'pm-4.13-rc2' of git://git.kernel.org/pub/scm/linux/kernel/git/rafael/linux-pm
git bisect  bad 090a81d8766e21d33ab3e4d24e6c8e5eedf086dd  # 03:33  B      3     3    0   0  Merge branch 'for-spi' of git://git.kernel.org/pub/scm/linux/kernel/git/viro/vfs
git bisect  bad 3bad2f1c676581d01e7645eb03e9b27e28b0a92e  # 03:57  B      0    13   26   0  Merge branch 'work.misc-set_fs' of git://git.kernel.org/pub/scm/linux/kernel/git/viro/vfs
git bisect  bad 362f6729cbb1d6bbab59e069f19441b0622ff7ec  # 05:02  B      8     8    0   0  Merge tag 'usb-4.13-rc1' of git://git.kernel.org/pub/scm/linux/kernel/git/gregkh/usb
git bisect  bad 6553698be05983056f5561cef6aaee0cc6afe7a0  # 05:25  B      3     5    0   0  Merge branch 'x86-cleanups-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
git bisect  bad 892ad5acca0b2ddb514fae63fa4686bf726d2471  # 05:37  B      0     5   18   0  Merge branch 'locking-core-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
git bisect good 26d3a77d2cb3cb31bbaa2de37b7a4e6375f204ee  # 05:54  G     16     0    0   0  Merge tag 'edac_for_4.13' of git://git.kernel.org/pub/scm/linux/kernel/git/bp/bp
git bisect good 330e9e46253cbfab178450c976aa90ef0f3ae940  # 06:17  G     16     0    0   0  Merge branch 'core-rcu-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
git bisect good 162b246eb420d2ca2002a50917c897b10c9aba09  # 06:36  G     15     0    0   0  Merge branch 'efi-core-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
git bisect good 12d83f7361724e5aa4299bb28e4caadc62ae482b  # 06:52  G     16     0    0   0  tools/include: Add (mostly) empty include/linux/sched/mm.h
git bisect good 3942b77121986519ee52ab4dd4ae8f4383dfe765  # 07:07  G     16     0    0   0  MAINTAINERS: Claim atomic*_t maintainership
git bisect good cde50a67397c0da7d11795d4b4418384022ab8e6  # 07:19  G     16     0    0   0  locking/rtmutex: Don't initialize lockdep when not required
git bisect good fd25d19f6b8da315332bb75936605fb45d3ea981  # 07:46  G     16     0    0   0  locking/refcount: Create unchecked atomic_t implementation
git bisect good 5d6dec6fba38c3e2d408df108bb92ef4ac201f18  # 08:09  G     15     0    0   0  locking/refcount: Remove the half-implemented refcount_sub() API
# first bad commit: [892ad5acca0b2ddb514fae63fa4686bf726d2471] Merge branch 'locking-core-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
git bisect good 162b246eb420d2ca2002a50917c897b10c9aba09  # 08:20  G     45     0    0   0  Merge branch 'efi-core-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
git bisect good 5d6dec6fba38c3e2d408df108bb92ef4ac201f18  # 08:28  G     47     0    0   0  locking/refcount: Remove the half-implemented refcount_sub() API
# extra tests with CONFIG_DEBUG_INFO_REDUCED
git bisect  bad 892ad5acca0b2ddb514fae63fa4686bf726d2471  # 08:47  B      4    12    0   0  Merge branch 'locking-core-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
# extra tests on HEAD of linux-devel/devel-hourly-2017100521
git bisect  bad 9b1f2a653b3fc84460a80e11559196321717bd91  # 08:47  B      0    49   65   0  0day head guard for 'devel-hourly-2017100521'
# extra tests on tree/branch linus/master
git bisect  bad 7a92616c0bac849e790283723b36c399668a1d9f  # 08:59  B      0     4   17   0  Merge tag 'pm-4.14-rc4' of git://git.kernel.org/pub/scm/linux/kernel/git/rafael/linux-pm
# extra tests on tree/branch linux-next/master
git bisect good 1418b852174ad50b3cb4738b8801626aefdc0bd9  # 09:15  G     16     0    0   0  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-yocto-lkp-nhm-dp1-10:20171006053710:x86_64-randconfig-h0-10060134:4.12.0-00420-g892ad5a:1.gz" of type "application/gzip" (10622 bytes)

View attachment "reproduce-yocto-lkp-nhm-dp1-10:20171006053710:x86_64-randconfig-h0-10060134:4.12.0-00420-g892ad5a:1" of type "text/plain" (877 bytes)

View attachment "config-4.12.0-00420-g892ad5a" of type "text/plain" (89555 bytes)

Powered by blists - more mailing lists

Powered by Openwall GNU/*/Linux Powered by OpenVZ