igt@i915_selftest@live@gt_lrc - incomplete - WARNING: inconsistent lock state
https://intel-gfx-ci.01.org/tree/drm-tip/IGTPW_11037/bat-adlp-6/igt@i915_selftest@live@gt_lrc.html https://intel-gfx-ci.01.org/tree/drm-tip/IGTPW_11037/bat-adlp-6/pstore0-1713419156_Panic_1.txt
<4>[ 514.761279] irq event stamp: 13928849
<4>[ 514.761279] hardirqs last enabled at (13928848): [<ffffffff81d4a9b3>] _raw_spin_unlock_irq+0x23/0x50
<4>[ 514.761284] hardirqs last disabled at (13928849): [<ffffffff81d4a746>] _raw_spin_lock_irqsave+0x56/0x60
<4>[ 514.761285] softirqs last enabled at (13928808): [<ffffffff81d4bc81>] __do_softirq+0x301/0x3e9
<4>[ 514.761286] softirqs last disabled at (13928845): [<ffffffff810dfcb9>] irq_exit_rcu+0x89/0xc0
<4>[ 514.761289] CPU: 3 PID: 0 Comm: swapper/3 Tainted: G U W 6.9.0-rc4-CI_DRM_14598-ga4f566444a64+ #1
<4>[ 514.761290] Hardware name: Intel Corporation Alder Lake Client Platform/AlderLake-P DDR4 RVP, BIOS RPLPFWI1.R00.4035.A00.2301200723 01/20/2023
<4>[ 514.761291] RIP: 0010:queued_spin_lock_slowpath+0x4f/0x330
<4>[ 514.761293] Code: 6d 00 08 0f 92 c0 0f b6 c0 c1 e0 08 89 c2 8b 45 00 30 e4 09 d0 a9 00 01 ff ff 75 2c 85 c0 74 12 0f b6 45 00 84 c0 74 0a f3 90 <0f> b6 45 00 84 c0 75 f6 b8 01 00 00 00 66 89 45 00 5b 5d 41 5c 41
<4>[ 514.761294] RSP: 0018:ffffc9000048ccf0 EFLAGS: 00000002
<4>[ 514.761295] RAX: 0000000000000001 RBX: ffff888100106fa8 RCX: 000000006a3df6dd
<4>[ 514.761296] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffff888100106fa8
<4>[ 514.761297] RBP: ffff888100106fa8 R08: 0000000030fa562e R09: 0000000000000001
<4>[ 514.761297] R10: 0000000000000001 R11: ffff888100f9aa00 R12: 0000000000000000
<4>[ 514.761298] R13: ffff888100209c00 R14: 0000000000000004 R15: ffff888100106fa8
<4>[ 514.761298] FS: 0000000000000000(0000) GS:ffff88888f180000(0000) knlGS:0000000000000000
<4>[ 514.761299] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
<4>[ 514.761299] CR2: 00007f4f1f5cf110 CR3: 000000000663a000 CR4: 0000000000f50ef0
<4>[ 514.761300] PKRU: 55555554
<4>[ 514.761301] Call Trace:
<4>[ 514.761301] <NMI>
<4>[ 514.761302] ? watchdog_hardlockup_check+0x189/0x240
<4>[ 514.761305] ? __perf_event_overflow+0xfa/0x1e0
<4>[ 514.761308] ? handle_pmi_common+0x141/0x360
<4>[ 514.761312] ? intel_pmu_handle_irq+0x113/0x5c0
<4>[ 514.761314] ? perf_event_nmi_handler+0x27/0x50
<4>[ 514.761316] ? nmi_handle+0xc7/0x280
<4>[ 514.761318] ? queued_spin_lock_slowpath+0x4f/0x330
<4>[ 514.761319] ? default_do_nmi+0x6b/0x180
<4>[ 514.761320] ? exc_nmi+0xf0/0x120
<4>[ 514.761321] ? end_repeat_nmi+0xf/0x53
<4>[ 514.761324] ? queued_spin_lock_slowpath+0x4f/0x330
<4>[ 514.761325] ? queued_spin_lock_slowpath+0x4f/0x330
<4>[ 514.761326] ? queued_spin_lock_slowpath+0x4f/0x330
<4>[ 514.761327] </NMI>
<4>[ 514.761327] <IRQ>
<4>[ 514.761328] do_raw_spin_lock+0xb2/0xc0
<4>[ 514.761330] qi_submit_sync+0x303/0x820
<4>[ 514.761334] ? __pfx_fq_flush_timeout+0x10/0x10
<4>[ 514.761336] qi_flush_iotlb+0x82/0xa0
<4>[ 514.761337] intel_flush_iotlb_all+0x7c/0x140
<4>[ 514.761339] ? __pfx_fq_flush_timeout+0x10/0x10
<4>[ 514.761340] fq_flush_iotlb+0x1d/0x30
<4>[ 514.761342] fq_flush_timeout+0x27/0xe0
<4>[ 514.761343] ? __pfx_fq_flush_timeout+0x10/0x10
<4>[ 514.761344] ? __pfx_fq_flush_timeout+0x10/0x10
<4>[ 514.761346] call_timer_fn+0xa0/0x250
<4>[ 514.761347] run_timer_base+0x235/0x330
<4>[ 514.761349] ? ktime_get+0x58/0x140
<4>[ 514.761350] ? ktime_get+0x8c/0x140
<4>[ 514.761350] run_timer_softirq+0x15/0x30
<4>[ 514.761351] __do_softirq+0xc1/0x3e9
<4>[ 514.761353] irq_exit_rcu+0x89/0xc0
<4>[ 514.761354] sysvec_apic_timer_interrupt+0xa6/0xd0
<4>[ 514.761355] </IRQ>
<4>[ 514.761355] <TASK>
<4>[ 514.761356] asm_sysvec_apic_timer_interrupt+0x1a/0x20
<4>[ 514.761357] RIP: 0010:cpuidle_enter_state+0xf3/0x540
<4>[ 514.761358] Code: 7e 89 c0 48 0f a3 05 1c b6 b5 00 0f 82 2a 03 00 00 31 ff e8 0f 67 40 ff 45 84 ff 0f 85 da 02 00 00 e8 b1 48 4e ff fb 45 85 f6 <0f> 88 fe 01 00 00 49 63 c6 4c 2b 2c 24 48 8d 14 40 48 8d 14 90 49
<4>[ 514.761359] RSP: 0018:ffffc900001e7e78 EFLAGS: 00000206
<4>[ 514.761360] RAX: 0000000000000003 RBX: 0000000000000003 RCX: 000000000000001f
<4>[ 514.761360] RDX: 0000000000000000 RSI: ffffffff82454205 RDI: ffffffff8242e841
<4>[ 514.761361] RBP: ffffe8ffff7b3500 R08: 0000000000000001 R09: 0000000000000001
<4>[ 514.761361] R10: 0000000000000001 R11: ffff888100f9aa00 R12: ffffffff827be1e0
<4>[ 514.761362] R13: 0000007367e1250f R14: 0000000000000003 R15: 0000000000000000
<4>[ 514.761364] ? cpuidle_enter_state+0xef/0x540
<4>[ 514.761365] cpuidle_enter+0x28/0x40
<4>[ 514.761367] do_idle+0x1e4/0x240
<4>[ 514.761369] cpu_startup_entry+0x24/0x30
<4>[ 514.761370] start_secondary+0x11a/0x140
<4>[ 514.761371] common_startup_64+0x13e/0x148
<4>[ 514.761375] </TASK>
<0>[ 514.761375] Kernel panic - not syncing: Hard LOCKUP
<4>[ 515.791232]
<4>[ 515.791233] ================================
<4>[ 515.791233] WARNING: inconsistent lock state
<4>[ 515.791233] 6.9.0-rc4-CI_DRM_14598-ga4f566444a64+ #1 Tainted: G U W
<4>[ 515.791234] --------------------------------
<4>[ 515.791235] inconsistent {INITIAL USE} -> {IN-NMI} usage.
<4>[ 515.791235] swapper/3/0 [HC1[1]:SC1[1]:HE0:SE0] takes:
<4>[ 515.791236] ffffffff82643058 (&nmi_desc[0].lock){....}-{2:2}, at: __register_nmi_handler+0x5c/0x150
<4>[ 515.791239] {INITIAL USE} state was registered at:
<4>[ 515.791240] lock_acquire+0xd7/0x2f0
<4>[ 515.791241] _raw_spin_lock_irqsave+0x3d/0x60
<4>[ 515.791242] __register_nmi_handler+0x5c/0x150
<4>[ 515.791243] init_hw_perf_events+0x153/0x700
<4>[ 515.791245] do_one_initcall+0x57/0x2b0
<4>[ 515.791246] kernel_init_freeable+0xa6/0x330
<4>[ 515.791248] kernel_init+0x15/0x120
<4>[ 515.791249] ret_from_fork+0x2c/0x50
<4>[ 515.791250] ret_from_fork_asm+0x1a/0x30
<4>[ 515.791251] irq event stamp: 13928849
<4>[ 515.791252] hardirqs last enabled at (13928848): [<ffffffff81d4a9b3>] _raw_spin_unlock_irq+0x23/0x50
<4>[ 515.791253] hardirqs last disabled at (13928849): [<ffffffff81d4a746>] _raw_spin_lock_irqsave+0x56/0x60
<4>[ 515.791254] softirqs last enabled at (13928808): [<ffffffff81d4bc81>] __do_softirq+0x301/0x3e9
<4>[ 515.791255] softirqs last disabled at (13928845): [<ffffffff810dfcb9>] irq_exit_rcu+0x89/0xc0
<4>[ 515.791256]
<4>[ 515.791256] other info that might help us debug this:
<4>[ 515.791256] Possible unsafe locking scenario:
<4>[ 515.791256]
<4>[ 515.791257] CPU0
<4>[ 515.791257] ----
<4>[ 515.791257] lock(&nmi_desc[0].lock);
<4>[ 515.791258] <Interrupt>
<4>[ 515.791258] lock(&nmi_desc[0].lock);
<4>[ 515.791258]
<4>[ 515.791258] *** DEADLOCK ***
<4>[ 515.791258]
<4>[ 515.791259] 2 locks held by swapper/3/0:
<4>[ 515.791259] #0: ffffc9000048cea0 ((&cookie->fq_timer)){+.-.}-{0:0}, at: call_timer_fn+0x72/0x250
<4>[ 515.791261] #1: ffff888100106fc0 (&qi->q_lock){-.-.}-{2:2}, at: qi_submit_sync+0x303/0x820
<4>[ 515.791264]
<4>[ 515.791264] stack backtrace:
<4>[ 515.791264] CPU: 3 PID: 0 Comm: swapper/3 Tainted: G U W 6.9.0-rc4-CI_DRM_14598-ga4f566444a64+ #1
<4>[ 515.791265] Hardware name: Intel Corporation Alder Lake Client Platform/AlderLake-P DDR4 RVP, BIOS RPLPFWI1.R00.4035.A00.2301200723 01/20/2023
<4>[ 515.791266] Call Trace:
<4>[ 515.791266] <NMI>
<4>[ 515.791267] lock_acquire+0x2b6/0x2f0
<4>[ 515.791268] ? __register_nmi_handler+0x5c/0x150
<4>[ 515.791270] _raw_spin_lock_irqsave+0x3d/0x60
<4>[ 515.791271] ? __register_nmi_handler+0x5c/0x150
<4>[ 515.791272] __register_nmi_handler+0x5c/0x150
<4>[ 515.791273] ? _printk+0x57/0x80
<4>[ 515.791275] native_stop_other_cpus+0x15b/0x1e0
<4>[ 515.791277] panic+0x109/0x310
<4>[ 515.791280] nmi_panic+0x26/0x40
<4>[ 515.791281] watchdog_hardlockup_check+0x1b1/0x240
<4>[ 515.791283] __perf_event_overflow+0xfa/0x1e0
<4>[ 515.791285] handle_pmi_common+0x141/0x360
<4>[ 515.791289] intel_pmu_handle_irq+0x113/0x5c0
<4>[ 515.791291] perf_event_nmi_handler+0x27/0x50
<4>[ 515.791292] nmi_handle+0xc7/0x280
<4>[ 515.791293] ? queued_spin_lock_slowpath+0x4f/0x330
<4>[ 515.791295] default_do_nmi+0x6b/0x180
<4>[ 515.791296] exc_nmi+0xf0/0x120
<4>[ 515.791297] end_repeat_nmi+0xf/0x53
<4>[ 515.791298] RIP: 0010:queued_spin_lock_slowpath+0x4f/0x330
<4>[ 515.791299] Code: 6d 00 08 0f 92 c0 0f b6 c0 c1 e0 08 89 c2 8b 45 00 30 e4 09 d0 a9 00 01 ff ff 75 2c 85 c0 74 12 0f b6 45 00 84 c0 74 0a f3 90 <0f> b6 45 00 84 c0 75 f6 b8 01 00 00 00 66 89 45 00 5b 5d 41 5c 41
<4>[ 515.791300] RSP: 0018:ffffc9000048ccf0 EFLAGS: 00000002
<4>[ 515.791301] RAX: 0000000000000001 RBX: ffff888100106fa8 RCX: 000000006a3df6dd
<4>[ 515.791301] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffff888100106fa8
<4>[ 515.791302] RBP: ffff888100106fa8 R08: 0000000030fa562e R09: 0000000000000001
<4>[ 515.791302] R10: 0000000000000001 R11: ffff888100f9aa00 R12: 0000000000000000
<4>[ 515.791303] R13: ffff888100209c00 R14: 0000000000000004 R15: ffff888100106fa8
<4>[ 515.791305] ? queued_spin_lock_slowpath+0x4f/0x330
<4>[ 515.791306] ? queued_spin_lock_slowpath+0x4f/0x330