linux-kernel - [serial] 0f3352c867: WARNING:at_kernel/locking/irqflag-debug.c:#warn_bogus_irq

lists.openwall.net		lists / announce owl-users owl-dev john-users john-dev passwdqc-users yescrypt popa3d-users / oss-security kernel-hardening musl sabotage tlsify passwords / crypt-dev xvendor / Bugtraq Full-Disclosure linux-kernel linux-netdev linux-ext4 linux-hardening linux-cve-announce PHC
Open Source and information security mailing list archives
Hash Suite: Windows password security audit tool. GUI, reports in PDF.
[<prev] [next>] [day] [month] [year] [list]
Date:   Tue, 23 Aug 2022 09:26:23 +0800
From:   kernel test robot <yujie.liu@...el.com>
To:     John Ogness <john.ogness@...utronix.de>
CC:     <lkp@...ts.01.org>, kernel test robot <lkp@...el.com>,
        "Sebastian Andrzej Siewior" <bigeasy@...utronix.de>,
        LKML <linux-kernel@...r.kernel.org>,
        <linux-serial@...r.kernel.org>, <linux-mips@...r.kernel.org>
Subject: [serial] 0f3352c867:
 WARNING:at_kernel/locking/irqflag-debug.c:#warn_bogus_irq_restore

Greeting,

FYI, we noticed the following commit (built with clang-14):

commit: 0f3352c867eec058542e57fb7a0cda5829a00d36 ("serial: 8250: implement write_atomic")
https://git.kernel.org/cgit/linux/kernel/git/rt/linux-rt-devel.git linux-6.0.y-rt

in testcase: boot

on test machine: qemu-system-x86_64 -enable-kvm -cpu SandyBridge -smp 2 -m 16G

caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):


[    2.505585][    T1] ------------[ cut here ]------------
[    2.505589][    T1] raw_local_irq_restore() called with IRQs enabled
[    2.505601][    T1] WARNING: CPU: 1 PID: 1 at kernel/locking/irqflag-debug.c:10 warn_bogus_irq_restore+0x22/0x30
[    2.505630][    T1] Modules linked in:
[    2.505638][    T1] CPU: 1 PID: 1 Comm: swapper/0 Tainted: G        W          6.0.0-rc1-00018-g0f3352c867ee #1
[    2.505645][    T1] EIP: warn_bogus_irq_restore+0x22/0x30
[    2.505652][    T1] Code: cc cc cc cc cc cc cc cc 55 89 e5 80 3d 9b 00 86 c2 00 74 02 5d c3 c6 05 9b 00 86 c2 01 68 0a c7 4b c2 e8 31 55 2f ff 83 c4 04 <0f> 0b 5d c3 cc cc cc cc cc cc cc cc cc cc 55 89 e5 57 56 50 64 8b
[    2.505657][    T1] EAX: 00000030 EBX: 00000100 ECX: 00000027 EDX: ec62fce8
[    2.505661][    T1] ESI: c372fde4 EDI: 00000004 EBP: c389fd28 ESP: c389fd28
[    2.505664][    T1] DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068 EFLAGS: 00010286
[    2.505669][    T1] CR0: 80050033 CR2: bfac9f1c CR3: 02f2c000 CR4: 000406d0
[    2.505676][    T1] DR0: 00000000 DR1: 00000000 DR2: 00000000 DR3: 00000000
[    2.505679][    T1] DR6: fffe0ff0 DR7: 00000400
[    2.505682][    T1] Call Trace:
[    2.505686][    T1]  serial8250_config_port+0x8cb/0x9a0
[    2.505696][    T1]  uart_add_one_port+0x1fe/0x5f0
[    2.505706][    T1]  serial8250_register_ports+0x7d/0xa3
[    2.505714][    T1]  serial8250_init+0xae/0xd4
[    2.505718][    T1]  __initstub__kmod_8250__224_1263_serial8250_init6+0x8/0xa
[    2.505723][    T1]  do_one_initcall+0x156/0x390
[    2.505732][    T1]  ? serial8250_isa_init_ports+0x18b/0x18b
[    2.505737][    T1]  do_initcall_level+0x6a/0x7c
[    2.505748][    T1]  ? rest_init+0x160/0x160
[    2.505753][    T1]  do_initcalls+0x3c/0x5d
[    2.505757][    T1]  do_basic_setup+0x12/0x14
[    2.505761][    T1]  kernel_init_freeable+0x7a/0xb2
[    2.505766][    T1]  kernel_init+0x12/0x170
[    2.505772][    T1]  ret_from_fork+0x19/0x30
[    2.505776][    T1] irq event stamp: 205287
[    2.505778][    T1] hardirqs last  enabled at (205293): [<c10d3df2>] console_trylock_spinning+0x172/0x1e0
[    2.505787][    T1] hardirqs last disabled at (205298): [<c10d3cee>] console_trylock_spinning+0x6e/0x1e0
[    2.505792][    T1] softirqs last  enabled at (204360): [<c102bfed>] do_softirq_own_stack+0x1d/0x30
[    2.505803][    T1] softirqs last disabled at (204355): [<c102bfed>] do_softirq_own_stack+0x1d/0x30
[    2.505808][    T1] ---[ end trace 0000000000000000 ]---


=========================================================================================
tbox_group/testcase/rootfs/kconfig/compiler/sleep:
   vm-snb/boot/openwrt-i386-generic-20190428.cgz/i386-randconfig-a002-20220822/clang-14/1

commit:
   e3c8f28432e291 ("printk: add infrastucture for atomic consoles")
   0f3352c867eec0 ("serial: 8250: implement write_atomic")

e3c8f28432e291b0 0f3352c867eec058542e57fb7a0
---------------- ---------------------------
        fail:runs  %reproduction    fail:runs
            |             |             |
            :20         100%          20:20    dmesg.EIP:warn_bogus_irq_restore
            :20         100%          20:20    dmesg.WARNING:at_kernel/locking/irqflag-debug.c:#warn_bogus_irq_restore


If you fix the issue, kindly add following tag
Reported-by: kernel test robot <yujie.liu@...el.com>


To reproduce:

         # build kernel
	cd linux
	cp config-6.0.0-rc1-00018-g0f3352c867ee .config
	make HOSTCC=clang-14 CC=clang-14 ARCH=i386 olddefconfig prepare modules_prepare bzImage modules
	make HOSTCC=clang-14 CC=clang-14 ARCH=i386 INSTALL_MOD_PATH=<mod-install-dir> modules_install
	cd <mod-install-dir>
	find lib/ | cpio -o -H newc --quiet | gzip > modules.cgz


         git clone https://github.com/intel/lkp-tests.git
         cd lkp-tests
         bin/lkp qemu -k <bzImage> -m modules.cgz job-script # job-script is attached in this email

         # if come across any failure that blocks the test,
         # please remove ~/.lkp and /lkp dir to run from a clean state.


-- 
0-DAY CI Kernel Test Service
https://01.org/lkp
View attachment "config-6.0.0-rc1-00018-g0f3352c867ee" of type "text/plain" (152553 bytes)

View attachment "job-script" of type "text/plain" (4987 bytes)

Download attachment "dmesg.xz" of type "application/x-xz" (15944 bytes)