[<prev] [next>] [day] [month] [year] [list]
Message-ID: <5dada16d.d6cNNLDBDQ3vbv0a%lkp@intel.com>
Date: Mon, 21 Oct 2019 20:15:41 +0800
From: kernel test robot <lkp@...el.com>
To: "Joel Fernandes (Google)" <joel@...lfernandes.org>
Cc: LKP <lkp@...ts.01.org>, linux-kernel@...r.kernel.org,
rcu@...r.kernel.org, "Paul E. McKenney" <paulmck@...ux.ibm.com>,
philip.li@...el.com
Subject: 28875945ba ("rcu: Add support for consolidated-RCU reader .."):
WARNING: suspicious RCU usage
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 28875945ba98d1b47a8a706812b6494d165bb0a0
Author: Joel Fernandes (Google) <joel@...lfernandes.org>
AuthorDate: Tue Jul 16 18:12:22 2019 -0400
Commit: Paul E. McKenney <paulmck@...ux.ibm.com>
CommitDate: Fri Aug 9 11:00:35 2019 -0700
rcu: Add support for consolidated-RCU reader checking
This commit adds RCU-reader checks to list_for_each_entry_rcu() and
hlist_for_each_entry_rcu(). These checks are optional, and are indicated
by a lockdep expression passed to a new optional argument to these two
macros. If this optional lockdep expression is omitted, these two macros
act as before, checking for an RCU read-side critical section.
Signed-off-by: Joel Fernandes (Google) <joel@...lfernandes.org>
[ paulmck: Update to eliminate return within macro and update comment. ]
Signed-off-by: Paul E. McKenney <paulmck@...ux.ibm.com>
9147089bee rcu: Remove redundant debug_locks check in rcu_read_lock_sched_held()
28875945ba rcu: Add support for consolidated-RCU reader checking
7d194c2100 Linux 5.4-rc4
c4b9850b36 Add linux-next specific files for 20191018
+--------------------------------------------------------------------------+------------+------------+----------+---------------+
| | 9147089bee | 28875945ba | v5.4-rc4 | next-20191018 |
+--------------------------------------------------------------------------+------------+------------+----------+---------------+
| boot_successes | 30 | 0 | 0 | 0 |
| boot_failures | 0 | 11 | 22 | 15 |
| WARNING:suspicious_RCU_usage | 0 | 11 | 22 | 15 |
| kernel/workqueue.c:#RCU-list_traversed_in_non-reader_section | 0 | 11 | 22 | 15 |
| kernel/events/core.c:#RCU-list_traversed_in_non-reader_section | 0 | 11 | 22 | 15 |
| drivers/base/power/runtime.c:#RCU-list_traversed_in_non-reader_section | 0 | 11 | | |
| drivers/acpi/osl.c:#RCU-list_traversed_in_non-reader_section | 0 | 11 | | |
| arch/x86/pci/mmconfig-shared.c:#RCU-list_traversed_in_non-reader_section | 0 | 11 | | |
| kernel/module.c:#RCU-list_traversed_in_non-reader_section | 0 | 10 | 22 | 15 |
| kernel/kprobes.c:#RCU-list_traversed_in_non-reader_section | 0 | 1 | 2 | 1 |
| net/ipv4/fib_trie.c:#RCU-list_traversed_in_non-reader_section | 0 | 2 | 5 | 5 |
+--------------------------------------------------------------------------+------------+------------+----------+---------------+
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <lkp@...el.com>
[ 4.186589] Spectre V2 : Spectre mitigation: kernel not compiled with retpoline; no mitigation available!
[ 4.186592] Speculative Store Bypass: Vulnerable
[ 4.188777] MDS: Vulnerable: Clear CPU buffers attempted, no microcode
[ 4.194116]
[ 4.194465] =============================
[ 4.195246] WARNING: suspicious RCU usage
[ 4.195903] 5.3.0-rc2-00003-g28875945ba98d #1 Tainted: G T
[ 4.197186] -----------------------------
[ 4.197956] kernel/workqueue.c:4285 RCU-list traversed in non-reader section!!
[ 4.199899]
[ 4.199899] other info that might help us debug this:
[ 4.199899]
[ 4.201401]
[ 4.201401] rcu_scheduler_active = 2, debug_locks = 1
[ 4.202629] 2 locks held by swapper/1:
[ 4.203366] #0: (____ptrval____) (wq_pool_mutex){+.+.}, at: alloc_workqueue+0x3be/0x7e0
[ 4.203899] #1: (____ptrval____) (&wq->mutex){+.+.}, at: alloc_workqueue+0x3c8/0x7e0
[ 4.205383]
[ 4.205383] stack backtrace:
[ 4.206235] CPU: 0 PID: 1 Comm: swapper Tainted: G T 5.3.0-rc2-00003-g28875945ba98d #1
[ 4.207900] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 4.209478] Call Trace:
[ 4.209975] dump_stack+0x19/0x25
[ 4.211908] lockdep_rcu_suspicious+0xd6/0xe0
[ 4.212761] alloc_workqueue+0x763/0x7e0
[ 4.213576] init_mm_internals+0x2c/0xd7
[ 4.214341] kernel_init_freeable+0xa7/0x387
[ 4.215188] ? rest_init+0x160/0x160
[ 4.215913] kernel_init+0x13/0x130
[ 4.216596] ? rest_init+0x160/0x160
[ 4.217289] ? rest_init+0x160/0x160
[ 4.217984] ret_from_fork+0x24/0x30
[ 4.218880] Performance Events: unsupported p6 CPU model 60 no PMU driver, software events only.
[ 4.220448]
[ 4.220778] =============================
[ 4.221546] WARNING: suspicious RCU usage
[ 4.222334] 5.3.0-rc2-00003-g28875945ba98d #1 Tainted: G T
[ 4.223894] -----------------------------
[ 4.224664] kernel/events/core.c:10151 RCU-list traversed in non-reader section!!
[ 4.226405]
[ 4.226405] other info that might help us debug this:
[ 4.226405]
[ 4.227894]
[ 4.227894] rcu_scheduler_active = 2, debug_locks = 1
[ 4.229120] 1 lock held by swapper/1:
[ 4.229821] #0: (____ptrval____) (&pmus_srcu){....}, at: perf_event_alloc+0x9e5/0x15e0
[ 4.231893]
[ 4.231893] stack backtrace:
[ 4.232728] CPU: 0 PID: 1 Comm: swapper Tainted: G T 5.3.0-rc2-00003-g28875945ba98d #1
[ 4.234452] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 4.235893] Call Trace:
[ 4.236386] dump_stack+0x19/0x25
[ 4.237031] lockdep_rcu_suspicious+0xd6/0xe0
[ 4.237877] perf_event_alloc+0x158d/0x15e0
[ 4.238723] perf_event_create_kernel_counter+0x21/0x1f0
[ 4.239916] hardlockup_detector_event_create+0x44/0x80
[ 4.240921] hardlockup_detector_perf_init+0x28/0x8e
[ 4.241866] watchdog_nmi_probe+0x1c/0x40
[ 4.242655] lockup_detector_init+0x40/0xad
[ 4.243894] kernel_init_freeable+0x102/0x387
[ 4.244470] ? rest_init+0x160/0x160
[ 4.244928] kernel_init+0x13/0x130
[ 4.245369] ? rest_init+0x160/0x160
[ 4.245818] ? rest_init+0x160/0x160
[ 4.246271] ret_from_fork+0x24/0x30
[ 4.246806] NMI watchdog: Perf NMI watchdog permanently disabled
[ 4.247677] TSC deadline timer enabled
[ 4.247876] devtmpfs: initialized
[ 4.248179] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[ 4.249411] futex hash table entries: 256 (order: 2, 24576 bytes, linear)
[ 4.250702] pinctrl core: initialized pinctrl subsystem
[ 4.252363]
[ 4.252583] =============================
[ 4.253082] WARNING: suspicious RCU usage
[ 4.253580] 5.3.0-rc2-00003-g28875945ba98d #1 Tainted: G T
[ 4.254437] -----------------------------
[ 4.254965] drivers/base/power/runtime.c:1665 RCU-list traversed in non-reader section!!
[ 4.255894]
[ 4.255894] other info that might help us debug this:
[ 4.255894]
[ 4.256878]
[ 4.256878] rcu_scheduler_active = 2, debug_locks = 1
[ 4.257717] 2 locks held by swapper/1:
[ 4.258225] #0: (____ptrval____) (&dev->mutex){....}, at: __device_driver_lock+0x59/0x60
[ 4.259300] #1: (____ptrval____) (device_links_srcu){....}, at: device_links_read_lock+0x5/0x80
[ 4.259892]
[ 4.259892] stack backtrace:
[ 4.260440] CPU: 0 PID: 1 Comm: swapper Tainted: G T 5.3.0-rc2-00003-g28875945ba98d #1
[ 4.261583] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 4.262731] Call Trace:
[ 4.263053] dump_stack+0x19/0x25
[ 4.263477] lockdep_rcu_suspicious+0xd6/0xe0
[ 4.263905] pm_runtime_get_suppliers+0xdd/0xf0
[ 4.264482] driver_probe_device+0x3c/0x170
[ 4.265015] device_driver_attach+0x7e/0x90
[ 4.265574] __driver_attach+0xa2/0x100
[ 4.266096] ? device_driver_attach+0x90/0x90
[ 4.266647] bus_for_each_dev+0x9b/0xf0
[ 4.267144] driver_attach+0x2b/0x30
[ 4.267615] bus_add_driver+0x23b/0x310
[ 4.267906] driver_register+0xd3/0x1c0
[ 4.268399] __platform_driver_register+0x6c/0x80
[ 4.268993] regulator_dummy_init+0xb2/0x106
[ 4.269566] regulator_init+0xbb/0xf0
[ 4.270043] ? regulator_late_cleanup+0x35c/0x35c
[ 4.270637] do_one_initcall+0x79/0x37a
[ 4.271128] ? rcu_read_lock_sched_held+0x6d/0x90
[ 4.271724] kernel_init_freeable+0x258/0x387
[ 4.271899] ? rest_init+0x160/0x160
[ 4.272361] kernel_init+0x13/0x130
[ 4.272827] ? rest_init+0x160/0x160
[ 4.273302] ? rest_init+0x160/0x160
[ 4.273755] ret_from_fork+0x24/0x30
[ 4.275194]
[ 4.275421] =============================
[ 4.275893] WARNING: suspicious RCU usage
[ 4.276399] 5.3.0-rc2-00003-g28875945ba98d #1 Tainted: G T
[ 4.277371] -----------------------------
[ 4.277874] drivers/base/power/runtime.c:1686 RCU-list traversed in non-reader section!!
[ 4.279109]
[ 4.279109] other info that might help us debug this:
[ 4.279109]
[ 4.279893]
[ 4.279893] rcu_scheduler_active = 2, debug_locks = 1
[ 4.280724] 2 locks held by swapper/1:
[ 4.281212] #0: (____ptrval____) (&dev->mutex){....}, at: __device_driver_lock+0x59/0x60
[ 4.282209] #1: (____ptrval____) (device_links_srcu){....}, at: device_links_read_lock+0x5/0x80
[ 4.283282]
[ 4.283282] stack backtrace:
[ 4.283826] CPU: 0 PID: 1 Comm: swapper Tainted: G T 5.3.0-rc2-00003-g28875945ba98d #1
[ 4.283892] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 4.284917] Call Trace:
[ 4.285238] dump_stack+0x19/0x25
[ 4.285697] lockdep_rcu_suspicious+0xd6/0xe0
[ 4.286325] pm_runtime_put_suppliers+0xe7/0xf0
[ 4.286894] driver_probe_device+0xb2/0x170
[ 4.287469] device_driver_attach+0x7e/0x90
[ 4.287900] __driver_attach+0xa2/0x100
[ 4.288384] ? device_driver_attach+0x90/0x90
[ 4.288898] bus_for_each_dev+0x9b/0xf0
[ 4.289391] driver_attach+0x2b/0x30
[ 4.289845] bus_add_driver+0x23b/0x310
[ 4.290335] driver_register+0xd3/0x1c0
[ 4.290821] __platform_driver_register+0x6c/0x80
[ 4.291440] regulator_dummy_init+0xb2/0x106
[ 4.291898] regulator_init+0xbb/0xf0
[ 4.292362] ? regulator_late_cleanup+0x35c/0x35c
[ 4.292947] do_one_initcall+0x79/0x37a
[ 4.293435] ? rcu_read_lock_sched_held+0x6d/0x90
[ 4.294029] kernel_init_freeable+0x258/0x387
[ 4.294574] ? rest_init+0x160/0x160
[ 4.295054] kernel_init+0x13/0x130
[ 4.295534] ? rest_init+0x160/0x160
[ 4.295894] ? rest_init+0x160/0x160
[ 4.296347] ret_from_fork+0x24/0x30
[ 4.297742] NET: Registered protocol family 16
[ 4.301875] cpuidle: using governor ladder
[ 4.302487] cpuidle: using governor menu
[ 4.303635] ACPI: bus type PCI registered
[ 4.304016] PCI: Using configuration type 1 for base access
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start 4f5cafb5cb8471e54afdc9054d973535614f7675 v5.3 --
git bisect bad 3c6a6910a81eae3566bb5fef6ea0f624382595e6 # 14:27 B 0 22 38 0 Merge branch 'linus' of git://git.kernel.org/pub/scm/linux/kernel/git/herbert/crypto-2.6
git bisect bad 1f7d290a7275edb270dbee13212c37cb59940221 # 14:28 B 0 22 38 0 Merge tag 'driver-core-5.4-rc1' of git://git.kernel.org/pub/scm/linux/kernel/git/gregkh/driver-core
git bisect bad e0d60a1e68a3fbf42cdf3546004e00230d9048ba # 14:28 B 0 22 38 0 Merge branch 'x86-entry-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
git bisect good d0a16fe934383ecdb605ab9312d700fb9099f75e # 14:28 G 21 0 0 1 Merge branch 'parisc-5.4-1' of git://git.kernel.org/pub/scm/linux/kernel/git/deller/parisc-linux
git bisect bad 98c82b4b8be60b05bc96aa4ab664ca0b0e39001f # 14:28 B 0 22 38 0 Merge branch 'core-stacktrace-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
git bisect good cef7298262e9af841fb70d8673af45caf55300a1 # 14:28 G 21 0 0 1 Merge tag 'armsoc-dt' of git://git.kernel.org/pub/scm/linux/kernel/git/soc/soc
git bisect good d75a43c645c26ab58118bd35405666a12971350d # 14:28 G 22 0 0 0 Merge branch 'core-objtool-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
git bisect bad 94d18ee9340e00ee3455bb45661484093e3b2674 # 14:28 B 0 22 38 0 Merge branch 'core-rcu-for-linus' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
git bisect bad ce5215c1342c6c89b3c3c45fea82cddf0b013787 # 14:28 B 0 22 38 0 rcu/nocb: Use separate flag to indicate offloaded ->cblist
git bisect good ba31ebfa7b749906e0befcc1e0c0db5e7463d55e # 14:28 G 22 0 0 0 MAINTAINERS: Update e-mail address for Andrea Parri
git bisect bad 31da067023dd0e35c5ec5556f0be7a31e5588277 # 14:28 B 0 22 38 0 Merge branches 'consolidate.2019.08.01b', 'fixes.2019.08.12a', 'lists.2019.08.13a' and 'torture.2019.08.01b' into HEAD
git bisect bad bee6f87166e9c6b8d81a7570995bd637e8da485a # 14:28 B 0 22 38 0 acpi: Use built-in RCU list checking for acpi_ioremaps list
git bisect bad fbab8d6735e2643365040bd9e1057addc0d9b4cf # 14:28 B 0 11 27 0 rcu/sync: Remove custom check for RCU readers
git bisect good 9147089bee3a6b504821dd8462e2be229e6dbfae # 14:29 G 22 0 0 0 rcu: Remove redundant debug_locks check in rcu_read_lock_sched_held()
git bisect bad 28875945ba98d1b47a8a706812b6494d165bb0a0 # 14:29 B 0 11 27 0 rcu: Add support for consolidated-RCU reader checking
# first bad commit: [28875945ba98d1b47a8a706812b6494d165bb0a0] rcu: Add support for consolidated-RCU reader checking
git bisect good 9147089bee3a6b504821dd8462e2be229e6dbfae # 14:32 G 30 0 0 0 rcu: Remove redundant debug_locks check in rcu_read_lock_sched_held()
# extra tests on HEAD of linux-devel/devel-hourly-2019101909
git bisect bad 2fcbef48534d2d6e9f20773312e7d6eec2f91617 # 14:33 B 0 34 54 1 0day head guard for 'devel-hourly-2019101909'
# extra tests on tree/branch linus/master
git bisect bad 7d194c2100ad2a6dded545887d02754948ca5241 # 17:17 B 0 1 28 11 Linux 5.4-rc4
# extra tests with first bad commit reverted
# extra tests on tree/branch linux-next/master
git bisect bad c4b9850b3676869ac0def5885d781d17f64b3a86 # 20:14 B 0 3 30 11 Add linux-next specific files for 20191018
---
0-DAY kernel test infrastructure Open Source Technology Center
https://lists.01.org/pipermail/lkp Intel Corporation
Download attachment "dmesg-yocto-vm-yocto-25dce13ca012:20191021132505:x86_64-randconfig-s2-201941:5.3.0-rc2-00003-g28875945ba98d:1.gz" of type "application/gzip" (19297 bytes)
View attachment "reproduce-yocto-vm-yocto-25dce13ca012:20191021132505:x86_64-randconfig-s2-201941:5.3.0-rc2-00003-g28875945ba98d:1" of type "text/plain" (914 bytes)
View attachment "config-5.3.0-rc2-00003-g28875945ba98d" of type "text/plain" (125227 bytes)
Powered by blists - more mailing lists