Messages in this thread | | | Date | Mon, 22 Aug 2022 16:44:04 -0400 | From | Steven Rostedt <> | Subject | [BUG v6.0-rc2] lockdep splat on ct_kernel_enter() |
| |
My tests are failing because of this splat:
[ 16.073659] ------------[ cut here ]------------ [ 16.074407] bus: 'platform': add driver acpi-ged [ 16.074424] DEBUG_LOCKS_WARN_ON(lockdep_hardirqs_enabled()) [ 16.074424] WARNING: CPU: 0 PID: 0 at kernel/locking/lockdep.c:5506 check_flags+0x114/0x1d0 [ 16.083020] bus: 'acpi': add driver ac [ 16.074424] Modules linked in: [ 16.074424] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 6.0.0-rc2-test+ #18 [ 16.096856] bus: 'acpi': add driver button [ 16.074424] Hardware name: MSI MS-7823/CSM-H87M-G43 (MS-7823), BIOS V1.6 02/22/2014 [ 16.074424] RIP: 0010:check_flags+0x114/0x1d0 [ 16.103642] bus: 'acpi': __driver_probe_device: matched device PNP0C0C:00 with driver button [ 16.074424] Code: ff ff e8 ef 0a aa ff 85 c0 74 21 44 8b 0d bc 56 c6 00 45 85 c9 75 15 48 c7 c6 c7 e8 37 b9 48 c7 c7 a0 96 36 b9 e8 54 c9 f9 ff <0f> 0b 48 c7 c7 b0 fc 37 b9 e8 2e 20 fa ff eb 99 85 c0 0f 85 38 ff [ 16.074424] RSP: 0000:ffffffffb9603d28 EFLAGS: 00010082 [ 16.114488] bus: 'acpi': really_probe: probing driver button with device PNP0C0C:00 [ 16.074424] [ 16.074424] RAX: 0000000000000000 RBX: ffffffffb96d6c20 RCX: 0000000000000000 [ 16.074424] RDX: 0000000000000000 RSI: ffffffffb81171da RDI: 0000000000000001 [ 16.126499] device: 'input0': device_add [ 16.074424] RBP: ffffffffb9603d28 R08: 0000000000000000 R09: 0000000000000001 [ 16.074424] R10: 0000000000000000 R11: 0000000000000030 R12: ffffffffb961aa80 [ 16.074424] R13: ffffffffb961b3f0 R14: 0000000000000000 R15: ffffffffb9758878 [ 16.153763] PM: Adding info for No Bus:input0 [ 16.074424] FS: 0000000000000000(0000) GS:ffff961b55c00000(0000) knlGS:0000000000000000 [ 16.074424] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 16.166543] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 [ 16.074424] CR2: ffff961b5edff000 CR3: 00000000b1612001 CR4: 00000000001706f0 [ 16.074424] Call Trace: [ 16.074424] <TASK> [ 16.175153] device: 'wakeup15': device_add [ 16.074424] lock_is_held_type+0x6f/0x130 [ 16.186284] rcu_read_lock_sched_held+0x4a/0x90 [ 16.186284] trace_rcu_dyntick+0x3a/0xe0 [ 16.186284] ct_kernel_enter.constprop.0+0x66/0xa0 [ 16.186284] ct_idle_exit+0xd/0x30 [ 16.186284] cpuidle_enter_state+0x28a/0x310 [ 16.186284] cpuidle_enter+0x2e/0x50 [ 16.186284] do_idle+0x1ec/0x280 [ 16.186284] cpu_startup_entry+0x20/0x30 [ 16.186284] rest_init+0xf3/0x170 [ 16.186284] arch_call_rest_init+0xe/0x1d [ 16.186284] start_kernel+0x69f/0x6c9 [ 16.186284] x86_64_start_reservations+0x24/0x2a [ 16.186284] x86_64_start_kernel+0x8d/0x97 [ 16.186284] secondary_startup_64_no_verify+0xe0/0xeb [ 16.186284] </TASK> [ 16.186284] irq event stamp: 129196 [ 16.186284] hardirqs last enabled at (129196): [<ffffffffb8ba6bf2>] poll_idle+0x32/0xbc [ 16.186284] hardirqs last disabled at (129195): [<ffffffffb80ec080>] do_idle+0xb0/0x280 [ 16.186284] softirqs last enabled at (129097): [<ffffffffb8e00273>] __do_softirq+0x273/0x441 [ 16.186284] softirqs last disabled at (129086): [<ffffffffb809c4be>] __irq_exit_rcu+0x9e/0xd0 [ 16.186284] ---[ end trace 0000000000000000 ]---
Looks like lockdep and the trace_rcu_dyntick() code is getting out of sync with respect to whether or not interrupts are enabled.
Config attached.
-- Steve [unhandled content-type:application/octet-stream] | |