Re: [PATCH printk v5 1/1] printk: extend console_lock for per-console locking

From: Marek Szyprowski
Date: Fri May 06 2022 - 09:04:18 EST


Hi John,

On 06.05.2022 14:41, John Ogness wrote:
> On 2022-05-06, Marek Szyprowski <m.szyprowski@xxxxxxxxxxx> wrote:
>> The Amlogic Meson related issue has been investigated and fixed:
>>
>> https://lore.kernel.org/all/b7c81f02-039e-e877-d7c3-6834728d2117@xxxxxxxxxxx/
>>
>> but I just found that there is one more issue.
>>
>> It appears on QCom-based DragonBoard 410c SBC
>> (arch/arm64/boot/dts/qcom/apq8016-sbc.dts). To see it on today's linux
>> next-20220506, one has to revert
>> 42cd402b8fd4672b692400fe5f9eecd55d2794ac, otherwise lockdep triggers
>> other warning and it is turned off too early:
>>
>> ================================
>> WARNING: inconsistent lock state
>> 5.18.0-rc5-next-20220506+ #11869 Not tainted
>> --------------------------------
>> inconsistent {HARDIRQ-ON-W} -> {IN-HARDIRQ-W} usage.
>> swapper/0/0 [HC1[1]:SC0[0]:HE0:SE1] takes:
>> ffff80000aaa8478 (&port_lock_key){?.+.}-{2:2}, at: msm_uart_irq+0x38/0x750
>> {HARDIRQ-ON-W} state was registered at:
>>   lock_acquire.part.0+0xe0/0x230
>>   lock_acquire+0x68/0x84
>>   _raw_spin_lock+0x5c/0x80
>>   __msm_console_write+0x1ac/0x220
>>   msm_console_write+0x48/0x60
>>   __console_emit_next_record+0x188/0x420
>>   printk_kthread_func+0x3a0/0x3bc
>>   kthread+0x118/0x11c
>>   ret_from_fork+0x10/0x20
>> irq event stamp: 12182
>> hardirqs last  enabled at (12181): [<ffff800008e3d2a8>]
>> cpuidle_enter_state+0xc4/0x30c
>>
>> stack backtrace:
>> CPU: 0 PID: 0 Comm: swapper/0 Not tainted 5.18.0-rc5-next-20220506+ #11869
>> Hardware name: Qualcomm Technologies, Inc. APQ 8016 SBC (DT)
>> Call trace:
>>  dump_backtrace.part.0+0xd0/0xe0
>>  show_stack+0x18/0x6c
>>  dump_stack_lvl+0x8c/0xb8
>>  dump_stack+0x18/0x34
>>  print_usage_bug.part.0+0x208/0x22c
>>  mark_lock+0x710/0x954
>>  __lock_acquire+0x9fc/0x20cc
>>  lock_acquire.part.0+0xe0/0x230
>>  lock_acquire+0x68/0x84
>>  _raw_spin_lock_irqsave+0x80/0xcc
>>  msm_uart_irq+0x38/0x750
>>  __handle_irq_event_percpu+0xac/0x3d0
>>  handle_irq_event+0x4c/0x120
>>  handle_fasteoi_irq+0xa4/0x1a0
>>  generic_handle_domain_irq+0x3c/0x60
>>  gic_handle_irq+0x44/0xc4
>>  call_on_irq_stack+0x2c/0x54
>>  do_interrupt_handler+0x80/0x84
>>  el1_interrupt+0x34/0x64
>>  el1h_64_irq_handler+0x18/0x24
>>  el1h_64_irq+0x64/0x68
>>  cpuidle_enter_state+0xcc/0x30c
>>  cpuidle_enter+0x38/0x50
>>  do_idle+0x22c/0x2bc
>>  cpu_startup_entry+0x28/0x30
>>  rest_init+0x110/0x190
>>  arch_post_acpi_subsys_init+0x0/0x18
>>  start_kernel+0x6c4/0x704
>>  __primary_switched+0xc0/0xc8
>>  INIT: version 2.88 booting
>> [info] Using makefile-style concurrent boot in runlevel S.
> The console write() callback for the msm driver (__msm_console_write)
> assumes interrupts are off and is doing a spin_lock(&port->lock) rather
> than spin_lock_irqsave(&port->lock, flags).
>
> The following change should address the issue:

Right, this help. spin_trylock() should be also converted imho, see below.

Tested-by: Marek Szyprowski <m.szyprowski@xxxxxxxxxxx>

> John
>
> diff --git a/drivers/tty/serial/msm_serial.c b/drivers/tty/serial/msm_serial.c
> index 23c94b927776..ab3f360bd354 100644
> --- a/drivers/tty/serial/msm_serial.c
> +++ b/drivers/tty/serial/msm_serial.c
> @@ -1599,6 +1599,7 @@ static inline struct uart_port *msm_get_port_from_line(unsigned int line)
> static void __msm_console_write(struct uart_port *port, const char *s,
> unsigned int count, bool is_uartdm)
> {
> + unsigned long flags;
> int i;
> int num_newlines = 0;
> bool replaced = false;
> @@ -1621,7 +1622,7 @@ static void __msm_console_write(struct uart_port *port, const char *s,
> else if (oops_in_progress)
> locked = spin_trylock(&port->lock);

locked = spin_trylock_irqsave(&port->lock, flags);

> else
> - spin_lock(&port->lock);
> + spin_lock_irqsave(&port->lock, flags);
>
> if (is_uartdm)
> msm_reset_dm_count(port, count);
> @@ -1660,7 +1661,7 @@ static void __msm_console_write(struct uart_port *port, const char *s,
> }
>
> if (locked)
> - spin_unlock(&port->lock);
> + spin_unlock_irqrestore(&port->lock, flags);
> }
>
> static void msm_console_write(struct console *co, const char *s,

Best regards
--
Marek Szyprowski, PhD
Samsung R&D Institute Poland