2022-05-23 08:03:09

by kernel test robot

[permalink] [raw]
Subject: [cpuidle] 838eb0275b: WARNING:at_drivers/cpuidle/cpuidle.c:#cpuidle_enter_state



Greeting,

FYI, we noticed the following commit (built with gcc-11):

commit: 838eb0275bd0de47d42070585861f210596949d7 ("cpuidle: Move IRQ state validation")
https://git.kernel.org/cgit/linux/kernel/git/peterz/queue.git sched/idle

in testcase: xfstests
version: xfstests-x86_64-64f2596-1_20220520
with following parameters:

nr_pmem: 4
fs: xfs
test: generic-dax
ucode: 0x700001c

test-description: xfstests is a regression test suite for xfs and other files ystems.
test-url: git://git.kernel.org/pub/scm/fs/xfs/xfstests-dev.git


on test machine: 16 threads 1 sockets Intel(R) Xeon(R) CPU D-1541 @ 2.10GHz with 48G memory

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



If you fix the issue, kindly add following tag
Reported-by: kernel test robot <[email protected]>


[ 9.816269][ T0] WARNING: CPU: 0 PID: 0 at drivers/cpuidle/cpuidle.c:239 cpuidle_enter_state (drivers/cpuidle/cpuidle.c:239 (discriminator 1))
[ 9.817232][ T1] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0
[ 9.826033][ T0] Modules linked in:
[ 9.835413][ T1] ACPI: button: Power Button [PWRB]
[ 9.838845][ T0] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 5.18.0-rc7-00334-g838eb0275bd0 #1
[ 9.844142][ T1] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input1
[ 9.852620][ T0] Hardware name: Supermicro SYS-5018D-FN4T/X10SDV-8C-TLN4F, BIOS 1.1 03/02/2016
[ 9.860977][ T1] ACPI: button: Power Button [PWRF]
[ 9.869591][ T0] RIP: 0010:cpuidle_enter_state (drivers/cpuidle/cpuidle.c:239 (discriminator 1))
[ 9.880379][ T0] Code: 24 08 48 8d 44 6d 00 48 8d 44 85 00 4c 8d 3c c5 18 00 00 00 48 83 fd 0a 0f 87 11 04 00 00 c6 04 24 00 4d 01 e7 e9 f3 f7 ff ff <0f> 0b fa e9 a4 f8 ff ff 83 c0 01 48 83 c1 40 44 39 c0 0f 8d c3 fa
All code
========
0: 24 08 and $0x8,%al
2: 48 8d 44 6d 00 lea 0x0(%rbp,%rbp,2),%rax
7: 48 8d 44 85 00 lea 0x0(%rbp,%rax,4),%rax
c: 4c 8d 3c c5 18 00 00 lea 0x18(,%rax,8),%r15
13: 00
14: 48 83 fd 0a cmp $0xa,%rbp
18: 0f 87 11 04 00 00 ja 0x42f
1e: c6 04 24 00 movb $0x0,(%rsp)
22: 4d 01 e7 add %r12,%r15
25: e9 f3 f7 ff ff jmpq 0xfffffffffffff81d
2a:* 0f 0b ud2 <-- trapping instruction
2c: fa cli
2d: e9 a4 f8 ff ff jmpq 0xfffffffffffff8d6
32: 83 c0 01 add $0x1,%eax
35: 48 83 c1 40 add $0x40,%rcx
39: 44 39 c0 cmp %r8d,%eax
3c: 0f .byte 0xf
3d: 8d (bad)
3e: c3 retq
3f: fa cli

Code starting with the faulting instruction
===========================================
0: 0f 0b ud2
2: fa cli
3: e9 a4 f8 ff ff jmpq 0xfffffffffffff8ac
8: 83 c0 01 add $0x1,%eax
b: 48 83 c1 40 add $0x40,%rcx
f: 44 39 c0 cmp %r8d,%eax
12: 0f .byte 0xf
13: 8d (bad)
14: c3 retq
15: fa cli
[ 9.899818][ T0] RSP: 0000:ffffffff84407db8 EFLAGS: 00010202
[ 9.905739][ T0] RAX: 0000000000000292 RBX: ffffe8ffff600000 RCX: ffffffff835d9307
[ 9.913565][ T0] RDX: 1ffffffff0883858 RSI: 0000000000000008 RDI: ffffffff8441c2c0
[ 9.921394][ T0] RBP: 0000000000000000 R08: 0000000000000000 R09: ffffffff8441c2c7
[ 9.929221][ T0] R10: fffffbfff0883858 R11: 0000000000000001 R12: ffffffff84d19400
[ 9.937046][ T0] R13: 0000000000000000 R14: ffffffff84d19458 R15: ffffffff84d19418
[ 9.944875][ T0] FS: 0000000000000000(0000) GS:ffff888b20000000(0000) knlGS:0000000000000000
[ 9.953654][ T0] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 9.960094][ T0] CR2: ffff888c7fc01000 CR3: 0000000c7e00e001 CR4: 00000000003706f0
[ 9.967920][ T0] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[ 9.975748][ T0] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
[ 9.983574][ T0] Call Trace:
[ 9.986722][ T0] <TASK>
[ 9.989521][ T0] ? menu_reflect (drivers/cpuidle/governors/menu.c:441)
[ 9.993975][ T0] ? __schedule (kernel/sched/core.c:6270)
[ 9.998421][ T0] cpuidle_enter (drivers/cpuidle/cpuidle.c:353)
[ 10.002695][ T0] cpuidle_idle_call (kernel/sched/idle.c:155 kernel/sched/idle.c:236)
[ 10.007487][ T0] ? arch_cpu_idle_exit+0xc0/0xc0
[ 10.012366][ T0] ? sched_clock_cpu (kernel/sched/clock.c:380)
[ 10.017161][ T0] ? tsc_verify_tsc_adjust (arch/x86/kernel/tsc_sync.c:58)
[ 10.022395][ T0] do_idle (kernel/sched/idle.c:303)
[ 10.026234][ T0] cpu_startup_entry (kernel/sched/idle.c:399 (discriminator 1))
[ 10.030855][ T0] rest_init (init/main.c:699)
[ 10.034953][ T0] arch_call_rest_init+0xf/0x15
[ 10.039660][ T0] start_kernel (init/main.c:1142)
[ 10.044020][ T0] secondary_startup_64_no_verify (arch/x86/kernel/head_64.S:358)
[ 10.049769][ T0] </TASK>
[ 10.052654][ T0] ---[ end trace 0000000000000000 ]---
[ 10.082035][ T1] ERST: Error Record Serialization Table (ERST) support is initialized.
[ 10.090228][ T1] pstore: Registered erst as persistent store backend
[ 10.097247][ T1] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[ 10.104354][ T1] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[ 10.112783][ T1] 00:04: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A
[ 10.123272][ T1] Non-volatile memory driver v1.3
[ 10.134644][ T1] ACPI Warning: SystemIO range 0x0000000000000428-0x000000000000042F conflicts with OpRegion 0x0000000000000428-0x000000000000042F (GPE0) (20211217/utaddress-204)
[ 10.150815][ T1] ACPI: OSL: Resource conflict; ACPI support missing from driver?
[ 10.158474][ T1] ACPI Warning: SystemIO range 0x0000000000000500-0x000000000000052F conflicts with OpRegion 0x000000000000052C-0x000000000000052D (GPIV) (20211217/utaddress-204)
[ 10.174636][ T1] ACPI: OSL: Resource conflict; ACPI support missing from driver?
[ 10.182442][ T1] lpc_ich: Resource conflict(s) found affecting gpio_ich
[ 10.189781][ T1] rdac: device handler registered
[ 10.194881][ T1] hp_sw: device handler registered
[ 10.199846][ T1] emc: device handler registered
[ 10.204794][ T1] alua: device handler registered
[ 10.211059][ T1] e1000: Intel(R) PRO/1000 Network Driver
[ 10.216633][ T1] e1000: Copyright (c) 1999-2006 Intel Corporation.
[ 10.223160][ T1] e1000e: Intel(R) PRO/1000 Network Driver
[ 10.228819][ T1] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.
[ 10.235536][ T1] igb: Intel(R) Gigabit Ethernet Network Driver
[ 10.241629][ T1] igb: Copyright (c) 2007-2014 Intel Corporation.
[ 10.309124][ T1] igb 0000:05:00.0: added PHC on eth0
[ 10.314365][ T1] igb 0000:05:00.0: Intel(R) Gigabit Ethernet Network Connection
[ 10.321934][ T1] igb 0000:05:00.0: eth0: (PCIe:5.0Gb/s:Width x4) 0c:c4:7a:c4:ab:7a
[ 10.329841][ T1] igb 0000:05:00.0: eth0: PBA No: 010A00-000
[ 10.335671][ T1] igb 0000:05:00.0: Using MSI-X interrupts. 8 rx queue(s), 8 tx queue(s)
[ 10.344631][ T1] IOAPIC[8]: Set IRTE entry (P:1 FPD:0 Dst_Mode:0 Redir_hint:1 Trig_Mode:0 Dlvry_Mode:0 Avail:0 Vector:EF Dest:00000000 SID:F0FF SQ:0 SVT:1)
[ 10.358804][ T1] IOAPIC[0]: Preconfigured routing entry (8-17 -> IRQ 17 Level:1 ActiveLow:1)
[ 10.427383][ T1] igb 0000:05:00.1: added PHC on eth1
[ 10.432624][ T1] igb 0000:05:00.1: Intel(R) Gigabit Ethernet Network Connection
[ 10.440194][ T1] igb 0000:05:00.1: eth1: (PCIe:5.0Gb/s:Width x4) 0c:c4:7a:c4:ab:7b
[ 10.448097][ T1] igb 0000:05:00.1: eth1: PBA No: 010A00-000
[ 10.453929][ T1] igb 0000:05:00.1: Using MSI-X interrupts. 8 rx queue(s), 8 tx queue(s)
[ 10.462271][ T1] Intel(R) 2.5G Ethernet Linux Driver
[ 10.467496][ T1] Copyright(c) 2018 Intel Corporation.
[ 10.472883][ T1] ixgbe: Intel(R) 10 Gigabit PCI Express Network Driver
[ 10.479674][ T1] ixgbe: Copyright (c) 1999-2016 Intel Corporation.
[ 10.486717][ T1] ACPI Warning: _SB.PCI0.BR2C._PRT: Return Package has no elements (empty) (20211217/nsprepkg-94)
[ 10.499114][ T1] pmd_set_huge: Cannot satisfy [mem 0xfbc00000-0xfbe00000] with a huge-page mapping due to MTRR override.
[ 10.579121][ T122] tsc: Refined TSC clocksource calibration: 2099.998 MHz
[ 10.586023][ T122] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x1e452ea631d, max_idle_ns: 440795244572 ns
[ 10.596813][ T122] clocksource: Switched to clocksource tsc
[ 11.893003][ T1] ixgbe 0000:03:00.0: Multiqueue Enabled: Rx Queue count = 16, Tx Queue count = 16 XDP Queue count = 0
[ 12.031135][ T1] ixgbe 0000:03:00.0: MAC: 5, PHY: 7, PBA No: 020C00-000
[ 12.038024][ T1] ixgbe 0000:03:00.0: 0c:c4:7a:c4:ad:e6
[ 12.106654][ T1] ixgbe 0000:03:00.0: Intel(R) 10 Gigabit Network Connection
[ 12.115142][ T1] ACPI Warning: _SB.PCI0.BR2C._PRT: Return Package has no elements (empty) (20211217/nsprepkg-94)
[ 12.127487][ T1] IOAPIC[9]: Set IRTE entry (P:1 FPD:0 Dst_Mode:0 Redir_hint:1 Trig_Mode:0 Dlvry_Mode:0 Avail:0 Vector:EF Dest:00000000 SID:002C SQ:0 SVT:1)
[ 12.141652][ T1] IOAPIC[1]: Preconfigured routing entry (9-12 -> IRQ 67 Level:1 ActiveLow:1)
[ 13.892952][ T1] ixgbe 0000:03:00.1: Multiqueue Enabled: Rx Queue count = 16, Tx Queue count = 16 XDP Queue count = 0
[ 14.031151][ T1] ixgbe 0000:03:00.1: MAC: 5, PHY: 7, PBA No: 020C00-000
[ 14.038043][ T1] ixgbe 0000:03:00.1: 0c:c4:7a:c4:ad:e7
[ 14.106642][ T1] ixgbe 0000:03:00.1: Intel(R) 10 Gigabit Network Connection
[ 14.114815][ T1] i40e: Intel(R) Ethernet Connection XL710 Network Driver
[ 14.121774][ T1] i40e: Copyright (c) 2013 - 2019 Intel Corporation.
[ 14.128711][ T1] usbcore: registered new interface driver r8152
[ 14.134951][ T1] usbcore: registered new interface driver asix
[ 14.141072][ T1] usbcore: registered new interface driver ax88179_178a
[ 14.148111][ T1] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 14.155339][ T1] ehci-pci: EHCI PCI platform driver
[ 14.162354][ T1] IOAPIC[8]: Set IRTE entry (P:1 FPD:0 Dst_Mode:0 Redir_hint:1 Trig_Mode:0 Dlvry_Mode:0 Avail:0 Vector:EF Dest:00000000 SID:F0FF SQ:0 SVT:1)
[ 14.176529][ T1] IOAPIC[0]: Preconfigured routing entry (8-18 -> IRQ 18 Level:1 ActiveLow:1)
[ 14.185346][ T1] ehci-pci 0000:00:1a.0: EHCI Host Controller
[ 14.191539][ T1] ehci-pci 0000:00:1a.0: new USB bus registered, assigned bus number 1
[ 14.199644][ T1] ehci-pci 0000:00:1a.0: debug port 2
[ 14.208883][ T1] ehci-pci 0000:00:1a.0: irq 18, io mem 0xfb414000
[ 14.222124][ T1] ehci-pci 0000:00:1a.0: USB 2.0 started, EHCI 1.00
[ 14.229019][ T1] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 5.18
[ 14.237977][ T1] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 14.245886][ T1] usb usb1: Product: EHCI Host Controller
[ 14.251458][ T1] usb usb1: Manufacturer: Linux 5.18.0-rc7-00334-g838eb0275bd0 ehci_hcd
[ 14.259632][ T1] usb usb1: SerialNumber: 0000:00:1a.0
[ 14.265743][ T1] hub 1-0:1.0: USB hub found
[ 14.270265][ T1] hub 1-0:1.0: 2 ports detected
[ 14.277856][ T1] ehci-pci 0000:00:1d.0: EHCI Host Controller
[ 14.284031][ T1] ehci-pci 0000:00:1d.0: new USB bus registered, assigned bus number 2
[ 14.292159][ T1] ehci-pci 0000:00:1d.0: debug port 2
[ 14.301412][ T1] ehci-pci 0000:00:1d.0: irq 18, io mem 0xfb413000
[ 14.314125][ T1] ehci-pci 0000:00:1d.0: USB 2.0 started, EHCI 1.00


To reproduce:

git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
sudo bin/lkp install job.yaml # job file is attached in this email
bin/lkp split-job --compatible job.yaml # generate the yaml file for lkp run
sudo bin/lkp run generated-yaml-file

# 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



Attachments:
(No filename) (12.23 kB)
config-5.18.0-rc7-00334-g838eb0275bd0 (168.67 kB)
job-script (5.99 kB)
dmesg.xz (32.20 kB)
xfstests (2.30 kB)
job.yaml (4.94 kB)
reproduce (1.00 kB)
Download all attachments