[<prev] [next>] [day] [month] [year] [list]
Message-ID: <20180403054636.ezkn7hkzanlnhbvn@shao2-debian>
Date: Tue, 3 Apr 2018 13:46:36 +0800
From: kernel test robot <fengguang.wu@...el.com>
To: Chris Wilson <chris@...is-wilson.co.uk>
Cc: Ingo Molnar <mingo@...nel.org>,
"Peter Zijlstra (Intel)" <peterz@...radead.org>,
linux-kernel@...r.kernel.org, LKP <lkp@...org>
Subject: [lkp-robot] [bisect done] 2b232e0c3b [ 8.623356] kworker/u2:0/5
is trying to contend lock (ww_class_mutex) at:
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 2b232e0c3b3a09f3e33750aa20e314f1b80e5361
Author: Chris Wilson <chris@...is-wilson.co.uk>
AuthorDate: Tue Feb 28 09:40:11 2017 +0000
Commit: Ingo Molnar <mingo@...nel.org>
CommitDate: Thu Mar 2 09:00:38 2017 +0100
locking/ww_mutex: Replace cpu_relax() with cond_resched() for tests
When busy-spinning on a ww_mutex_trylock(), we depend upon the other
thread advancing and releasing the lock. This can not happen on a single
CPU unless we relinquish it:
[ ] NMI watchdog: BUG: soft lockup - CPU#0 stuck for 22s! [kworker/0:1:18]
...
[ ] Call Trace:
[ ] mutex_trylock()
[ ] test_mutex_work+0x31/0x56
[ ] process_one_work+0x1b4/0x2f9
[ ] worker_thread+0x1b0/0x27c
[ ] kthread+0xd1/0xd3
[ ] ret_from_fork+0x19/0x30
Reported-by: Fengguang Wu <fengguang.wu@...el.com>
Signed-off-by: Chris Wilson <chris@...is-wilson.co.uk>
Signed-off-by: Peter Zijlstra (Intel) <peterz@...radead.org>
Cc: Andrew Morton <akpm@...ux-foundation.org>
Cc: Linus Torvalds <torvalds@...ux-foundation.org>
Cc: Paul E. McKenney <paulmck@...ux.vnet.ibm.com>
Cc: Peter Zijlstra <peterz@...radead.org>
Cc: Thomas Gleixner <tglx@...utronix.de>
Fixes: f2a5fec17395 ("locking/ww_mutex: Begin kselftests for ww_mutex")
Link: http://lkml.kernel.org/r/20170228094011.2595-1-chris@chris-wilson.co.uk
Signed-off-by: Ingo Molnar <mingo@...nel.org>
e2679aecf1 Merge branch 'linus' into locking/urgent, to pick up fixes
2b232e0c3b locking/ww_mutex: Replace cpu_relax() with cond_resched() for tests
bc16d4052f Merge branch 'efi-core-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
d1f1142ea4 Add linux-next specific files for 20180329
+-------------------------------------------------------+------------+------------+------------+---------------+
| | e2679aecf1 | 2b232e0c3b | bc16d4052f | next-20180329 |
+-------------------------------------------------------+------------+------------+------------+---------------+
| boot_successes | 47 | 0 | 11 | 48 |
| boot_failures | 8 | 33 | 0 | 2 |
| is_trying_to_contend_lock(ww_class_mutex)at | 8 | 33 | | |
| calltrace:__ww_mutex_lock | 8 | 33 | | |
| WARNING:at_arch/x86/mm/dump_pagetables.c:#note_page | 8 | 33 | | |
| WARNING:at_net/bridge/br_fdb.c:#br_fdb_find | 0 | 1 | | |
| Mem-Info | 0 | 7 | 0 | 2 |
| WARNING:at_lib/debugobjects.c:#debug_print_object | 0 | 18 | | |
| WARNING:at_drivers/pci/pci-sysfs.c:#pci_mmap_resource | 0 | 2 | | |
| EIP:__put_user_4 | 0 | 1 | | |
+-------------------------------------------------------+------------+------------+------------+---------------+
[ 8.622950]
[ 8.623213] =================================
[ 8.623356] [ BUG: bad contention detected! ]
[ 8.623356] 4.10.0-11076-g2b232e0 #256 Not tainted
[ 8.623356] ---------------------------------
[ 8.623356] kworker/u2:0/5 is trying to contend lock (ww_class_mutex) at:
[ 8.623356] [<81997dfc>] __ww_mutex_lock+0x12f/0xaf8
[ 8.623356] but there are no locks held!
[ 8.623356]
[ 8.623356] other info that might help us debug this:
[ 8.623356] 4 locks held by kworker/u2:0/5:
[ 8.623356] #0: ("test-ww_mutex"){......}, at: [<8105ea96>] process_one_work+0x1d3/0x44e
[ 8.623356] #1: ((&stress->work)){......}, at: [<8105eabb>] process_one_work+0x1f8/0x44e
[ 8.623356] #2: (ww_class_acquire){......}, at: [<8108d819>] stress_reorder_work+0x7a/0x18c
[ 8.623356] #3: (ww_class_mutex){......}, at: [<8108d82c>] stress_reorder_work+0x8d/0x18c
[ 8.623356]
[ 8.623356] stack backtrace:
[ 8.623356] CPU: 0 PID: 5 Comm: kworker/u2:0 Not tainted 4.10.0-11076-g2b232e0 #256
[ 8.623356] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 8.623356] Workqueue: test-ww_mutex stress_reorder_work
[ 8.623356] Call Trace:
[ 8.623356] dump_stack+0x79/0xab
[ 8.623356] ? __ww_mutex_lock+0x12f/0xaf8
[ 8.623356] print_lock_contention_bug+0xb4/0xc1
[ 8.623356] ? __ww_mutex_lock+0x12f/0xaf8
[ 8.623356] lock_acquired+0xd0/0x22d
[ 8.623356] ? stress_reorder_work+0x8d/0x18c
[ 8.623356] __ww_mutex_lock+0x12f/0xaf8
[ 8.623356] ww_mutex_lock+0x3e/0x45
[ 8.623356] ? stress_reorder_work+0x8d/0x18c
[ 8.623356] stress_reorder_work+0x8d/0x18c
[ 8.623356] ? process_one_work+0x22a/0x44e
[ 8.623356] process_one_work+0x290/0x44e
[ 8.623356] worker_thread+0x32a/0x40b
[ 8.623356] ? process_scheduled_works+0x27/0x27
[ 8.623356] kthread+0xdc/0xde
[ 8.623356] ? process_scheduled_works+0x27/0x27
[ 8.623356] ? __kthread_bind_mask+0x86/0x86
[ 8.623356] ret_from_fork+0x21/0x30
[ 45.079970] torture_init_begin: Refusing rcu init: spin_lock running.
[ 45.083167] torture_init_begin: One torture test at a time!
[ 45.084371] audit: initializing netlink subsys (disabled)
[ 45.086254] workingset: timestamp_bits=30 max_order=16 bucket_order=0
[ 45.087816] audit: type=2000 audit(1522699530.094:1): state=initialized audit_enabled=0 res=1
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start v4.11 v4.10 --
git bisect bad ce70df089143c49385b4f32f39d41fb50fbf6a7c # 21:47 B 0 6 22 3 mm, gup: fix typo in gup_p4d_range()
git bisect bad bd0f9b356d00aa241ced36fb075a07041c28d3b8 # 21:57 B 0 11 42 18 sched/headers: fix up header file dependency on <linux/sched/signal.h>
git bisect good d5500a074741b78b7f778b4ab3415d5ecdcda0a7 # 22:38 G 11 0 0 2 Merge tag 'usercopy-v4.11-rc1.fix' of git://git.kernel.org/pub/scm/linux/kernel/git/kees/linux
git bisect good 6053dc981449718d90a429933e99b441e1adaea6 # 23:37 G 11 0 0 4 Merge tag 'arm64-fixes' of git://git.kernel.org/pub/scm/linux/kernel/git/arm64/linux
git bisect good 606ed721afdbba2f560db87f33cbdb72463a5d7b # 00:32 G 10 0 0 4 Merge tag 'xtensa-20170303' of git://github.com/jcmvbkbc/linux-xtensa
git bisect good f26db9649af36b8eb76850108113d4056f494537 # 01:18 G 10 0 0 11 Merge tag 'trace-v4.11-rc1' of git://git.kernel.org/pub/scm/linux/kernel/git/rostedt/linux-trace
git bisect good 21f85778bd037f6d7652a79a60657599edf39ef6 # 02:25 G 10 0 0 11 Merge branch 'efi-urgent-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
git bisect bad c3abcabe813b4a0976b58f7e6c1e63b2070c8dda # 02:31 B 0 1 26 12 Merge branch 'perf-urgent-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
git bisect good 26db8f992444a87465fc01b264b0317a3943e2b6 # 03:37 G 10 0 0 7 Merge branch 'irq-urgent-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
git bisect bad 500e1af25209a048daa1f1f86083d4849d5c555b # 03:56 B 0 2 37 22 Merge branch 'locking-urgent-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
git bisect bad 2b232e0c3b3a09f3e33750aa20e314f1b80e5361 # 04:26 B 0 1 36 22 locking/ww_mutex: Replace cpu_relax() with cond_resched() for tests
git bisect good e2679aecf1060063b97bf187ba1c61430aab0701 # 06:42 G 10 0 0 8 Merge branch 'linus' into locking/urgent, to pick up fixes
# first bad commit: [2b232e0c3b3a09f3e33750aa20e314f1b80e5361] locking/ww_mutex: Replace cpu_relax() with cond_resched() for tests
git bisect good e2679aecf1060063b97bf187ba1c61430aab0701 # 09:40 G 30 0 0 8 Merge branch 'linus' into locking/urgent, to pick up fixes
# extra tests on HEAD of linux-devel/devel-catchup-201804021333
git bisect bad 055d8c1139e38f0550de9ca5e9943dc5ae9e1c56 # 09:40 B 0 14 32 0 0day head guard for 'devel-catchup-201804021333'
# extra tests on tree/branch linus/master
git bisect bad bc16d4052f1ae99996f3475b5a73d29c86e7ba81 # 09:40 B 1 2 0 0 Merge branch 'efi-core-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
# extra tests with first bad commit reverted
git bisect good abda4e2ba9aa789e51c233db44fb00189161ed92 # 13:37 G 15 0 0 0 Revert "locking/ww_mutex: Replace cpu_relax() with cond_resched() for tests"
# extra tests on tree/branch linux-next/master
git bisect bad d1f1142ea4f41cf0b6c71a39e90525faf1983aa6 # 13:40 B 1 14 0 0 Add linux-next specific files for 20180329
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
Download attachment "dmesg-yocto-intel12-23:20180403040553:i386-randconfig-n0-201813:4.10.0-11076-g2b232e0:256.gz" of type "application/gzip" (27869 bytes)
Download attachment "dmesg-quantal-ivb41-100:20180403043612:i386-randconfig-n0-201813:4.10.0-11075-ge2679ae:258.gz" of type "application/gzip" (23381 bytes)
View attachment "reproduce-yocto-intel12-23:20180403040553:i386-randconfig-n0-201813:4.10.0-11076-g2b232e0:256" of type "text/plain" (920 bytes)
View attachment "config-4.10.0-11076-g2b232e0" of type "text/plain" (112917 bytes)
Powered by blists - more mailing lists