[<prev] [next>] [thread-next>] [day] [month] [year] [list]
Message-ID: <5f8dc512.pzfR1ahTGDOChwCh%lkp@intel.com>
Date: Tue, 20 Oct 2020 00:55:46 +0800
From: kernel test robot <lkp@...el.com>
To: Peter Zijlstra <peterz@...radead.org>
Cc: lkp@...el.com, LKP <lkp@...ts.01.org>,
linux-kernel@...r.kernel.org, linux-kernel@...r.kernel.org,
Ingo Molnar <mingo@...nel.org>, philip.li@...el.com
Subject: 4d004099a6 ("lockdep: Fix lockdep recursion"): BUG: using
__this_cpu_read() in preemptible [00000000] code: trinity-c6/526
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 4d004099a668c41522242aa146a38cc4eb59cb1e
Author: Peter Zijlstra <peterz@...radead.org>
AuthorDate: Fri Oct 2 11:04:21 2020 +0200
Commit: Ingo Molnar <mingo@...nel.org>
CommitDate: Fri Oct 9 08:53:30 2020 +0200
lockdep: Fix lockdep recursion
Steve reported that lockdep_assert*irq*(), when nested inside lockdep
itself, will trigger a false-positive.
One example is the stack-trace code, as called from inside lockdep,
triggering tracing, which in turn calls RCU, which then uses
lockdep_assert_irqs_disabled().
Fixes: a21ee6055c30 ("lockdep: Change hardirq{s_enabled,_context} to per-cpu variables")
Reported-by: Steven Rostedt <rostedt@...dmis.org>
Signed-off-by: Peter Zijlstra (Intel) <peterz@...radead.org>
Signed-off-by: Ingo Molnar <mingo@...nel.org>
2bb8945bcc lockdep: Fix usage_traceoverflow
4d004099a6 lockdep: Fix lockdep recursion
7cf726a594 Merge tag 'linux-kselftest-kunit-5.10-rc1' of git://git.kernel.org/pub/scm/linux/kernel/git/shuah/linux-kselftest
+--------------------------------------------------------------------+------------+------------+------------+
| | 2bb8945bcc | 4d004099a6 | 7cf726a594 |
+--------------------------------------------------------------------+------------+------------+------------+
| boot_successes | 12 | 0 | 0 |
| boot_failures | 4 | 11 | 10 |
| Mem-Info | 4 | | |
| invoked_oom-killer:gfp_mask=0x | 3 | | |
| EIP:__copy_user_ll | 1 | | |
| EIP:__get_user_4 | 1 | | |
| EIP:__put_user_4 | 1 | | |
| EIP:clear_user | 1 | | |
| BUG:using__this_cpu_read()in_preemptible | 0 | 11 | 10 |
| WARNING:suspicious_RCU_usage | 0 | 6 | 8 |
| kernel/locking/lockdep.c:#RCU-list_traversed_in_non-reader_section | 0 | 6 | 8 |
+--------------------------------------------------------------------+------------+------------+------------+
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <lkp@...el.com>
[child6:526] fstat64 (197) returned ENOSYS, marking as inactive.
[child4:551] fstatfs (28) returned ENOSYS, marking as inactive.
[child0:520] faccessat (307) returned ENOSYS, marking as inactive.
[child0:520] fstatfs (100) returned ENOSYS, marking as inactive.
[ 91.880619] random: 2 urandom warning(s) missed due to ratelimiting
[ 92.898145] BUG: using __this_cpu_read() in preemptible [00000000] code: trinity-c6/526
[ 92.899792] caller is __this_cpu_preempt_check+0xf/0x11
[ 92.900613] CPU: 0 PID: 526 Comm: trinity-c6 Not tainted 5.9.0-rc8-00208-g4d004099a668c4 #1
[ 92.901913] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 92.903305] Call Trace:
[ 92.903780] dump_stack+0x6b/0x89
[ 92.904363] check_preemption_disabled+0x92/0xa4
[ 92.905182] __this_cpu_preempt_check+0xf/0x11
[ 92.905968] lockdep_hardirqs_on_prepare+0x2c/0x18f
[ 92.906853] trace_hardirqs_on+0x49/0x53
[ 92.907578] __bad_area_nosemaphore+0x3a/0x134
[ 92.908363] ? sysvec_kvm_asyncpf_interrupt+0x4b/0x4b
[ 92.909051] bad_area+0x37/0x3d
[ 92.909523] exc_page_fault+0x3ec/0x4bf
[ 92.910228] ? sysvec_kvm_asyncpf_interrupt+0x4b/0x4b
[ 92.911156] handle_exception+0x126/0x126
[ 92.911939] EIP: 0x8084bf8
[ 92.912445] Code: 90 90 53 8b 1d 20 8b ac 08 39 d9 0f 83 dc 00 00 00 5b 3b 0d 30 8b ac 08 0f 83 84 00 00 00 81 e9 80 00 00 00 81 e9 80 00 00 00 <66> 0f 7f 02 66 0f 7f 42 10 66 0f 7f 42 20 66 0f 7f 42 30 66 0f 7f
[ 92.915660] EAX: 00000000 EBX: 08134000 ECX: 00000f00 EDX: b749d000
[ 92.916771] ESI: b749d000 EDI: b749d000 EBP: b74a6030 ESP: bfd60e5c
[ 92.917884] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 007b EFLAGS: 00010206
[ 92.919184] BUG: using __this_cpu_read() in preemptible [00000000] code: trinity-c6/526
[ 92.920653] caller is __this_cpu_preempt_check+0xf/0x11
[ 92.921617] CPU: 0 PID: 526 Comm: trinity-c6 Not tainted 5.9.0-rc8-00208-g4d004099a668c4 #1
[ 92.923048] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 92.924473] Call Trace:
[ 92.924948] dump_stack+0x6b/0x89
[ 92.925556] check_preemption_disabled+0x92/0xa4
[ 92.926378] ? __bad_area_nosemaphore+0x3a/0x134
[ 92.927414] __this_cpu_preempt_check+0xf/0x11
[ 92.928225] lockdep_hardirqs_on+0x36/0x115
[ 92.928976] trace_hardirqs_on+0x51/0x53
[ 92.929681] __bad_area_nosemaphore+0x3a/0x134
[ 92.930651] ? sysvec_kvm_asyncpf_interrupt+0x4b/0x4b
[ 92.931576] bad_area+0x37/0x3d
[ 92.932116] exc_page_fault+0x3ec/0x4bf
[ 92.932814] ? sysvec_kvm_asyncpf_interrupt+0x4b/0x4b
[ 92.933694] handle_exception+0x126/0x126
[ 92.934408] EIP: 0x8084bf8
[ 92.934895] Code: 90 90 53 8b 1d 20 8b ac 08 39 d9 0f 83 dc 00 00 00 5b 3b 0d 30 8b ac 08 0f 83 84 00 00 00 81 e9 80 00 00 00 81 e9 80 00 00 00 <66> 0f 7f 02 66 0f 7f 42 10 66 0f 7f 42 20 66 0f 7f 42 30 66 0f 7f
[ 92.956477] EAX: 00000000 EBX: 08134000 ECX: 00000f00 EDX: b749d000
[ 92.957593] ESI: b749d000 EDI: b749d000 EBP: b74a6030 ESP: bfd60e5c
[ 92.958675] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 007b EFLAGS: 00010206
[ 94.314817] caller is __this_cpu_preempt_check+0xf/0x11
[ 94.315679] CPU: 1 PID: 712 Comm: trinity-c3 Not tainted 5.9.0-rc8-00208-g4d004099a668c4 #1
[ 94.316820] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 94.317956] Call Trace:
[ 94.318323] dump_stack+0x6b/0x89
[ 94.318788] check_preemption_disabled+0x92/0xa4
[ 94.319471] __this_cpu_preempt_check+0xf/0x11
[ 94.320089] lockdep_hardirqs_on_prepare+0x2c/0x18f
[ 94.320766] trace_hardirqs_on+0x49/0x53
[ 94.321305] __bad_area_nosemaphore+0x3a/0x134
[ 94.322042] ? sysvec_kvm_asyncpf_interrupt+0x4b/0x4b
[ 94.322750] bad_area+0x37/0x3d
[ 94.323226] exc_page_fault+0x3ec/0x4bf
[ 94.323786] ? sysvec_kvm_asyncpf_interrupt+0x4b/0x4b
[ 94.324490] handle_exception+0x126/0x126
[ 94.325043] EIP: 0x805bee0
[ 94.325432] Code: 48 6a 00 57 e8 f1 c3 fe ff 83 c4 10 e9 b9 fd ff ff 89 f6 8d bc 27 00 00 00 00 8b 54 24 44 85 d2 74 28 31 ed be 64 00 00 00 90 <c6> 04 2f 25 e8 47 02 00 00 a8 01 b8 73 00 00 00 0f 44 c6 88 44 2f
[ 94.327965] EAX: 0805bed8 EBX: 08134000 ECX: 00000008 EDX: 03ecb36e
[ 94.328835] ESI: 00000064 EDI: b749b000 EBP: 00000000 ESP: bfd60d20
[ 94.329671] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 007b EFLAGS: 00010246
[ 94.330634] BUG: using __this_cpu_read() in preemptible [00000000] code: trinity-c3/712
[ 94.331797] caller is __this_cpu_preempt_check+0xf/0x11
[ 94.332536] CPU: 1 PID: 712 Comm: trinity-c3 Not tainted 5.9.0-rc8-00208-g4d004099a668c4 #1
[ 94.333646] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 94.334783] Call Trace:
[ 94.335140] dump_stack+0x6b/0x89
[ 94.339655] check_preemption_disabled+0x92/0xa4
[ 94.340307] ? __bad_area_nosemaphore+0x3a/0x134
[ 94.341086] __this_cpu_preempt_check+0xf/0x11
[ 94.341708] lockdep_hardirqs_on+0x36/0x115
[ 94.342298] trace_hardirqs_on+0x51/0x53
[ 94.342858] __bad_area_nosemaphore+0x3a/0x134
[ 94.343668] ? sysvec_kvm_asyncpf_interrupt+0x4b/0x4b
[ 94.344367] bad_area+0x37/0x3d
[ 94.344815] exc_page_fault+0x3ec/0x4bf
[ 94.345352] ? sysvec_kvm_asyncpf_interrupt+0x4b/0x4b
[ 94.346049] handle_exception+0x126/0x126
[ 94.346604] EIP: 0x805bee0
[ 94.346997] Code: 48 6a 00 57 e8 f1 c3 fe ff 83 c4 10 e9 b9 fd ff ff 89 f6 8d bc 27 00 00 00 00 8b 54 24 44 85 d2 74 28 31 ed be 64 00 00 00 90 <c6> 04 2f 25 e8 47 02 00 00 a8 01 b8 73 00 00 00 0f 44 c6 88 44 2f
[ 94.349539] EAX: 0805bed8 EBX: 08134000 ECX: 00000008 EDX: 03ecb36e
[ 94.350401] ESI: 00000064 EDI: b749b000 EBP: 00000000 ESP: bfd60d20
[ 94.355448] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 007b EFLAGS: 00010246
[ 94.920644] init: tty5 main process (383) terminated with status 1
[ 94.921975] init: tty5 main process ended, respawning
[ 94.939382] init: tty4 main process (382) terminated with status 1
[ 94.941160] init: tty4 main process ended, respawning
[ 94.946647] init: tty2 main process (384) terminated with status 1
[ 94.948054] init: tty2 main process ended, respawning
[ 94.957691] init: tty3 main process (385) terminated with status 1
[ 94.959206] init: tty3 main process ended, respawning
[ 95.035891] init: tty6 main process (387) terminated with status 1
[ 95.042798] init: tty6 main process ended, respawning
[ 95.146323] BUG: using __this_cpu_read() in preemptible [00000000] code: trinity-c7/744
[ 95.147923] caller is __this_cpu_preempt_check+0xf/0x11
[ 95.148903] CPU: 0 PID: 744 Comm: trinity-c7 Not tainted 5.9.0-rc8-00208-g4d004099a668c4 #1
[ 95.150277] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 95.151702] Call Trace:
[ 95.152126] dump_stack+0x6b/0x89
[ 95.152620] check_preemption_disabled+0x92/0xa4
[ 95.153262] __this_cpu_preempt_check+0xf/0x11
[ 95.153893] lockdep_hardirqs_on_prepare+0x2c/0x18f
[ 95.154596] trace_hardirqs_on+0x49/0x53
[ 95.155285] __bad_area_nosemaphore+0x3a/0x134
[ 95.156227] ? sysvec_kvm_asyncpf_interrupt+0x4b/0x4b
[ 95.156991] bad_area+0x37/0x3d
[ 95.157539] exc_page_fault+0x3ec/0x4bf
[ 95.158234] ? sysvec_kvm_asyncpf_interrupt+0x4b/0x4b
[ 95.159010] handle_exception+0x126/0x126
[ 95.159742] EIP: 0x8084bf8
[ 95.160193] Code: 90 90 53 8b 1d 20 8b ac 08 39 d9 0f 83 dc 00 00 00 5b 3b 0d 30 8b ac 08 0f 83 84 00 00 00 81 e9 80 00 00 00 81 e9 80 00 00 00 <66> 0f 7f 02 66 0f 7f 42 10 66 0f 7f 42 20 66 0f 7f 42 30 66 0f 7f
[ 95.163390] EAX: 00000000 EBX: 08134000 ECX: 00000f00 EDX: b749b000
[ 95.164499] ESI: b749b000 EDI: b749b000 EBP: b749f030 ESP: bfd60d0c
[ 95.165575] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 007b EFLAGS: 00010206
[ 95.166889] BUG: using __this_cpu_read() in preemptible [00000000] code: trinity-c7/744
[ 95.168327] caller is __this_cpu_preempt_check+0xf/0x11
[ 95.169290] CPU: 0 PID: 744 Comm: trinity-c7 Not tainted 5.9.0-rc8-00208-g4d004099a668c4 #1
[ 95.170739] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 95.172231] Call Trace:
[ 95.172694] dump_stack+0x6b/0x89
[ 95.173301] check_preemption_disabled+0x92/0xa4
[ 95.174102] ? __bad_area_nosemaphore+0x3a/0x134
[ 95.175095] __this_cpu_preempt_check+0xf/0x11
[ 95.175898] lockdep_hardirqs_on+0x36/0x115
[ 95.176595] trace_hardirqs_on+0x51/0x53
[ 95.177306] __bad_area_nosemaphore+0x3a/0x134
[ 95.178270] ? sysvec_kvm_asyncpf_interrupt+0x4b/0x4b
[ 95.179157] bad_area+0x37/0x3d
[ 95.179753] exc_page_fault+0x3ec/0x4bf
[ 95.180457] ? sysvec_kvm_asyncpf_interrupt+0x4b/0x4b
[ 95.181355] handle_exception+0x126/0x126
[ 95.182068] EIP: 0x8084bf8
[ 95.182573] Code: 90 90 53 8b 1d 20 8b ac 08 39 d9 0f 83 dc 00 00 00 5b 3b 0d 30 8b ac 08 0f 83 84 00 00 00 81 e9 80 00 00 00 81 e9 80 00 00 00 <66> 0f 7f 02 66 0f 7f 42 10 66 0f 7f 42 20 66 0f 7f 42 30 66 0f 7f
[ 95.185846] EAX: 00000000 EBX: 08134000 ECX: 00000f00 EDX: b749b000
[ 95.186911] ESI: b749b000 EDI: b749b000 EBP: b749f030 ESP: bfd60d0c
[ 95.188041] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 007b EFLAGS: 00010206
[main] 10100 iterations. [F:6736 S:3353 HI:878]
[main] Using pid_max = 32768
[main] futex: 0 owner:0 global:1
[main] Reserved/initialized 10 futexes.
[main] sysv_shm: id:20 size:8192 flags:7b0 ptr:(nil) global:1
# HH:MM RESULT GOOD BAD GOOD_BUT_DIRTY DIRTY_NOT_BAD
git bisect start 84caa4e94a3e78425c9c9222c5838dc18569ed53 bbf5c979011a099af5dc76498918ed7df445635b --
git bisect bad dab538a37ee3643a27fa7dace841695022aa3b51 # 18:56 B 0 1 10 0 Merge 'tip/master' into devel-catchup-202010171728
git bisect good e47272658690b17657a850d466be4a0ece0fa845 # 19:15 G 10 0 8 8 0day base guard for 'devel-catchup-202010171728'
git bisect bad 694b55be5ab7554ff27e30039c01c0ce777a76b2 # 19:31 B 0 2 11 0 Merge 'mptcp/export' into devel-catchup-202010171728
git bisect bad 726eb70e0d34dc4bc4dada71f52bba8ed638431e # 19:50 B 0 1 10 0 Merge tag 'char-misc-5.10-rc1' of git://git.kernel.org/pub/scm/linux/kernel/git/gregkh/char-misc
git bisect bad 527f6750d92beb9c787d8aba48477b1e834d64e5 # 20:07 B 0 1 10 0 kasan: remove mentions of unsupported Clang versions
git bisect bad 647412daeb454b6dad12a6c6961ab90aac9e5d29 # 20:31 B 0 6 16 1 Merge tag 'mmc-v5.10' of git://git.kernel.org/pub/scm/linux/kernel/git/ulfh/mmc
git bisect bad 3bff6112c80cecb76af5fe485506f96e8adb6122 # 20:41 B 0 1 10 0 Merge tag 'perf-core-2020-10-12' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
git bisect good f5f59336a9ae8f683772d6b8cb2d6732b5e567ea # 21:11 G 10 0 8 8 Merge tag 'timers-core-2020-10-12' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
git bisect good edaa5ddf3833669a25654d42c0fb653dfdd906df # 21:24 G 10 0 9 9 Merge tag 'sched-core-2020-10-12' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
git bisect bad e6412f9833db23740ee848ab3d6e7af18dff82a6 # 21:36 B 0 4 13 0 Merge tag 'efi-core-2020-10-12' of git://git.kernel.org/pub/scm/linux/kernel/git/tip/tip
git bisect bad e705d397965811ac528d7213b42d74ffe43caf38 # 22:01 B 0 2 11 0 Merge branch 'locking/urgent' into locking/core, to pick up fixes
git bisect good ad56450db86413ff911eb527b5a49e04a4345e61 # 22:28 G 11 0 7 7 locking/selftest: Add test cases for queued_read_lock()
git bisect good 5cdd25572a29e46f932d3e6eedbd07429de66431 # 22:53 G 11 0 9 9 seqlock: Use unique prefix for seqcount_t property accessors
git bisect good 6d1823ccc480866e571ab1206665d693aeb600cf # 23:06 G 10 0 5 5 lockdep: Optimize the memory usage of circular queue
git bisect bad baffd723e44dc3d7f84f0b8f1fe1ece00ddd2710 # 23:17 B 0 4 13 0 lockdep: Revert "lockdep: Use raw_cpu_*() for per-cpu variables"
git bisect bad 4d004099a668c41522242aa146a38cc4eb59cb1e # 23:39 B 0 1 10 0 lockdep: Fix lockdep recursion
git bisect good 2bb8945bcc1a768f2bc402a16c9610bba8d5187d # 00:12 G 10 0 6 6 lockdep: Fix usage_traceoverflow
# first bad commit: [4d004099a668c41522242aa146a38cc4eb59cb1e] lockdep: Fix lockdep recursion
git bisect good 2bb8945bcc1a768f2bc402a16c9610bba8d5187d # 00:20 G 33 0 21 27 lockdep: Fix usage_traceoverflow
# extra tests with debug options
git bisect bad 4d004099a668c41522242aa146a38cc4eb59cb1e # 00:38 B 0 9 18 0 lockdep: Fix lockdep recursion
# extra tests on head commit of linus/master
git bisect bad 7cf726a59435301046250c42131554d9ccc566b8 # 00:49 B 0 4 13 0 Merge tag 'linux-kselftest-kunit-5.10-rc1' of git://git.kernel.org/pub/scm/linux/kernel/git/shuah/linux-kselftest
# bad: [7cf726a59435301046250c42131554d9ccc566b8] Merge tag 'linux-kselftest-kunit-5.10-rc1' of git://git.kernel.org/pub/scm/linux/kernel/git/shuah/linux-kselftest
# extra tests on linus/master
# duplicated: [7cf726a59435301046250c42131554d9ccc566b8] Merge tag 'linux-kselftest-kunit-5.10-rc1' of git://git.kernel.org/pub/scm/linux/kernel/git/shuah/linux-kselftest
# extra tests on linux-next/master
# 119: [b2926c108f9fd225d3fe9ea73fb5c35f48735d20] Add linux-next specific files for 20201016
---
0-DAY CI Kernel Test Service, Intel Corporation
https://lists.01.org/hyperkitty/list/lkp@lists.01.org
Download attachment "dmesg-quantal-vm-quantal-75:20201019234025:i386-randconfig-a005-20201017:5.9.0-rc8-00208-g4d004099a668c4:1.gz" of type "application/gzip" (30098 bytes)
Download attachment "dmesg-quantal-vm-quantal-102:20201020000235:i386-randconfig-a005-20201017:5.9.0-rc8-00207-g2bb8945bcc1a76:2.gz" of type "application/gzip" (144285 bytes)
View attachment "reproduce-quantal-vm-quantal-75:20201019234025:i386-randconfig-a005-20201017:5.9.0-rc8-00208-g4d004099a668c4:1" of type "text/plain" (1178 bytes)
Download attachment "84caa4e94a3e78425c9c9222c5838dc18569ed53:gcc-9:i386-randconfig-a005-20201017:BUG:using__this_cpu_read__in_preemptible.xz" of type "application/x-xz" (11016 bytes)
View attachment "config-5.9.0-rc8-00208-g4d004099a668c4" of type "text/plain" (151812 bytes)
View attachment "config-5.9.0-rc8-00208-g4d004099a668c4" of type "text/plain" (151813 bytes)
Powered by blists - more mailing lists