Greeting,
FYI, we noticed the following commit (built with gcc-9):
commit: d67e27e3d2e9c8412287d0ac8b8e4eaab404de6d ("sched/cpuacct: optimize away RCU read lock")
https://git.kernel.org/cgit/linux/kernel/git/peterz/queue.git sched/core
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):
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <[email protected]>
[ 2.042854][ C0] WARNING: suspicious RCU usage
[ 2.042857][ C0] 5.17.0-rc5-00050-gd67e27e3d2e9 #1 Not tainted
[ 2.042861][ C0] -----------------------------
[ 2.042863][ C0] include/linux/cgroup.h:494 suspicious rcu_dereference_check() usage!
[ 2.042867][ C0]
[ 2.042867][ C0] other info that might help us debug this:
[ 2.042867][ C0]
[ 2.042869][ C0]
[ 2.042869][ C0] rcu_scheduler_active = 1, debug_locks = 1
[ 2.042873][ C0] 2 locks held by swapper/0/1:
[ 2.042876][ C0] #0: ffffffffa4178740 (console_lock){+.+.}-{0:0}, at: vprintk_emit (kernel/printk/printk.c:1843 kernel/printk/printk.c:2244)
[ 2.043761][ C0] #1: ffff88839d439b58 (&rq->__lock){-...}-{2:2}, at: scheduler_tick (kernel/sched/sched.h:1539 kernel/sched/sched.h:1617 kernel/sched/core.c:5263)
[ 2.043779][ C0]
[ 2.043779][ C0] stack backtrace:
[ 2.043782][ C0] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 5.17.0-rc5-00050-gd67e27e3d2e9 #1
[ 2.043787][ C0] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 2.043791][ C0] Call Trace:
[ 2.043795][ C0] <IRQ>
[ 2.043800][ C0] dump_stack_lvl (lib/dump_stack.c:107)
[ 2.043809][ C0] cpuacct_charge (include/linux/cgroup.h:494 kernel/sched/cpuacct.c:40 kernel/sched/cpuacct.c:342)
[ 2.043820][ C0] update_curr (include/linux/cgroup.h:481 include/linux/cgroup.h:550 include/linux/cgroup.h:794 kernel/sched/fair.c:877)
[ 2.043820][ C0] task_tick_fair (kernel/sched/fair.c:4612 (discriminator 2) kernel/sched/fair.c:11180 (discriminator 2))
[ 2.043820][ C0] ? lock_is_held_type (kernel/locking/lockdep.c:5380 kernel/locking/lockdep.c:5682)
[ 2.043820][ C0] scheduler_tick (arch/x86/include/asm/jump_label.h:27 include/linux/jump_label.h:212 kernel/sched/features.h:99 kernel/sched/core.c:5269)
[ 2.043820][ C0] update_process_times (kernel/time/timer.c:1793)
[ 2.043820][ C0] tick_periodic (kernel/time/tick-common.c:101)
[ 2.043820][ C0] tick_handle_periodic (kernel/time/tick-common.c:120)
[ 2.043820][ C0] __sysvec_apic_timer_interrupt (arch/x86/include/asm/jump_label.h:27 include/linux/jump_label.h:212 arch/x86/include/asm/trace/irq_vectors.h:41 arch/x86/kernel/apic/apic.c:1104)
[ 2.043820][ C0] sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1097 (discriminator 14))
[ 2.043820][ C0] </IRQ>
[ 2.043820][ C0] <TASK>
[ 2.043820][ C0] asm_sysvec_apic_timer_interrupt (arch/x86/include/asm/idtentry.h:638)
[ 2.043820][ C0] RIP: 0010:console_unlock (kernel/printk/printk.c:2719)
[ 2.043820][ C0] Code: 08 e9 2d fc ff ff 48 c7 c6 83 c9 11 a0 48 c7 c7 a0 80 df a3 e8 ea f6 fd ff e8 65 2c 00 00 48 83 7c 24 18 00 0f 85 d4 00 00 00 <8b> 44 24 30 85 c0 0f 84 68 fa ff ff 31 d2 be a0 0a 00 00 48 c7 c7
All code
========
0: 08 e9 or %ch,%cl
2: 2d fc ff ff 48 sub $0x48fffffc,%eax
7: c7 c6 83 c9 11 a0 mov $0xa011c983,%esi
d: 48 c7 c7 a0 80 df a3 mov $0xffffffffa3df80a0,%rdi
14: e8 ea f6 fd ff callq 0xfffffffffffdf703
19: e8 65 2c 00 00 callq 0x2c83
1e: 48 83 7c 24 18 00 cmpq $0x0,0x18(%rsp)
24: 0f 85 d4 00 00 00 jne 0xfe
2a:* 8b 44 24 30 mov 0x30(%rsp),%eax <-- trapping instruction
2e: 85 c0 test %eax,%eax
30: 0f 84 68 fa ff ff je 0xfffffffffffffa9e
36: 31 d2 xor %edx,%edx
38: be a0 0a 00 00 mov $0xaa0,%esi
3d: 48 rex.W
3e: c7 .byte 0xc7
3f: c7 .byte 0xc7
Code starting with the faulting instruction
===========================================
0: 8b 44 24 30 mov 0x30(%rsp),%eax
4: 85 c0 test %eax,%eax
6: 0f 84 68 fa ff ff je 0xfffffffffffffa74
c: 31 d2 xor %edx,%edx
e: be a0 0a 00 00 mov $0xaa0,%esi
13: 48 rex.W
14: c7 .byte 0xc7
15: c7 .byte 0xc7
[ 2.043820][ C0] RSP: 0000:ffffc9000001fb70 EFLAGS: 00000206
[ 2.043820][ C0] RAX: 000000000000002b RBX: dffffc0000000000 RCX: 1ffffffff4bd2afe
[ 2.043820][ C0] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffffffa011ca80
[ 2.043820][ C0] RBP: ffffc9000001fbc8 R08: 0000000000000001 R09: fffffbfff4bd2a41
[ 2.043820][ C0] R10: ffffffffa5e95207 R11: fffffbfff4bd2a40 R12: 0000000000000000
[ 2.043820][ C0] R13: 0000000000000000 R14: ffffffffa47076e8 R15: 0000000000000000
[ 2.043820][ C0] ? console_unlock (arch/x86/include/asm/irqflags.h:45 arch/x86/include/asm/irqflags.h:80 arch/x86/include/asm/irqflags.h:138 kernel/printk/printk.c:2715)
[ 2.043820][ C0] ? do_syslog (kernel/printk/printk.c:2088)
[ 2.043820][ C0] ? rcu_read_unlock (include/linux/rcupdate.h:723 (discriminator 5))
[ 2.043820][ C0] ? vprintk_emit (kernel/printk/printk.c:1843 kernel/printk/printk.c:2244)
[ 2.043820][ C0] vprintk_emit (arch/x86/include/asm/preempt.h:85 kernel/printk/printk.c:2246)
[ 2.043820][ C0] _printk (kernel/printk/printk.c:2261)
[ 2.043820][ C0] ? record_print_text.cold (kernel/printk/printk.c:2261)
[ 2.043820][ C0] native_smp_prepare_cpus (arch/x86/kernel/smpboot.c:1432)
[ 2.043820][ C0] kernel_init_freeable (include/linux/compiler.h:241 include/linux/init.h:124 init/main.c:1417 init/main.c:1602)
[ 2.043820][ C0] ? lockdep_hardirqs_on_prepare (kernel/locking/lockdep.c:4232 kernel/locking/lockdep.c:4292 kernel/locking/lockdep.c:4244)
[ 2.043820][ C0] ? console_on_rootfs (init/main.c:1584)
[ 2.043820][ C0] ? rwlock_bug+0xc0/0xc0
[ 2.043820][ C0] ? rest_init (init/main.c:1494)
[ 2.043820][ C0] kernel_init (init/main.c:1504)
[ 2.043820][ C0] ret_from_fork (arch/x86/entry/entry_64.S:301)
[ 2.043820][ C0] </TASK>
[ 2.043820][ C0]
[ 2.043820][ C0] =============================
[ 2.043820][ C0] WARNING: suspicious RCU usage
[ 2.043820][ C0] 5.17.0-rc5-00050-gd67e27e3d2e9 #1 Not tainted
[ 2.043820][ C0] -----------------------------
[ 2.043820][ C0] include/linux/cgroup.h:481 suspicious rcu_dereference_check() usage!
[ 2.043820][ C0]
[ 2.043820][ C0] other info that might help us debug this:
[ 2.043820][ C0]
[ 2.043820][ C0] rcu_scheduler_active = 1, debug_locks = 1
[ 2.043820][ C0] 2 locks held by swapper/0/1:
[ 2.043820][ C0] #0: ffffffffa4178740 (console_lock){+.+.}-{0:0}, at: vprintk_emit (kernel/printk/printk.c:1843 kernel/printk/printk.c:2244)
[ 2.043820][ C0] #1: ffff88839d439b58 (&rq->__lock){-...}-{2:2}, at: scheduler_tick (kernel/sched/sched.h:1539 kernel/sched/sched.h:1617 kernel/sched/core.c:5263)
[ 2.043820][ C0]
[ 2.043820][ C0] stack backtrace:
[ 2.043820][ C0] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 5.17.0-rc5-00050-gd67e27e3d2e9 #1
[ 2.043820][ C0] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 2.043820][ C0] Call Trace:
[ 2.043820][ C0] <IRQ>
[ 2.043820][ C0] dump_stack_lvl (lib/dump_stack.c:107)
[ 2.043820][ C0] update_curr (include/linux/cgroup.h:481 include/linux/cgroup.h:550 include/linux/cgroup.h:794 kernel/sched/fair.c:877)
[ 2.043820][ C0] task_tick_fair (kernel/sched/fair.c:4612 (discriminator 2) kernel/sched/fair.c:11180 (discriminator 2))
[ 2.043820][ C0] ? lock_is_held_type (kernel/locking/lockdep.c:5380 kernel/locking/lockdep.c:5682)
[ 2.043820][ C0] scheduler_tick (arch/x86/include/asm/jump_label.h:27 include/linux/jump_label.h:212 kernel/sched/features.h:99 kernel/sched/core.c:5269)
[ 2.043820][ C0] update_process_times (kernel/time/timer.c:1793)
[ 2.043820][ C0] tick_periodic (kernel/time/tick-common.c:101)
[ 2.043820][ C0] tick_handle_periodic (kernel/time/tick-common.c:120)
[ 2.043820][ C0] __sysvec_apic_timer_interrupt (arch/x86/include/asm/jump_label.h:27 include/linux/jump_label.h:212 arch/x86/include/asm/trace/irq_vectors.h:41 arch/x86/kernel/apic/apic.c:1104)
[ 2.043820][ C0] sysvec_apic_timer_interrupt (arch/x86/kernel/apic/apic.c:1097 (discriminator 14))
[ 2.043820][ C0] </IRQ>
[ 2.043820][ C0] <TASK>
[ 2.043820][ C0] asm_sysvec_apic_timer_interrupt (arch/x86/include/asm/idtentry.h:638)
[ 2.043820][ C0] RIP: 0010:console_unlock (kernel/printk/printk.c:2719)
[ 2.043820][ C0] Code: 08 e9 2d fc ff ff 48 c7 c6 83 c9 11 a0 48 c7 c7 a0 80 df a3 e8 ea f6 fd ff e8 65 2c 00 00 48 83 7c 24 18 00 0f 85 d4 00 00 00 <8b> 44 24 30 85 c0 0f 84 68 fa ff ff 31 d2 be a0 0a 00 00 48 c7 c7
All code
========
0: 08 e9 or %ch,%cl
2: 2d fc ff ff 48 sub $0x48fffffc,%eax
7: c7 c6 83 c9 11 a0 mov $0xa011c983,%esi
d: 48 c7 c7 a0 80 df a3 mov $0xffffffffa3df80a0,%rdi
14: e8 ea f6 fd ff callq 0xfffffffffffdf703
19: e8 65 2c 00 00 callq 0x2c83
1e: 48 83 7c 24 18 00 cmpq $0x0,0x18(%rsp)
24: 0f 85 d4 00 00 00 jne 0xfe
2a:* 8b 44 24 30 mov 0x30(%rsp),%eax <-- trapping instruction
2e: 85 c0 test %eax,%eax
30: 0f 84 68 fa ff ff je 0xfffffffffffffa9e
36: 31 d2 xor %edx,%edx
38: be a0 0a 00 00 mov $0xaa0,%esi
3d: 48 rex.W
3e: c7 .byte 0xc7
3f: c7 .byte 0xc7
Code starting with the faulting instruction
===========================================
0: 8b 44 24 30 mov 0x30(%rsp),%eax
4: 85 c0 test %eax,%eax
6: 0f 84 68 fa ff ff je 0xfffffffffffffa74
c: 31 d2 xor %edx,%edx
e: be a0 0a 00 00 mov $0xaa0,%esi
13: 48 rex.W
14: c7 .byte 0xc7
15: c7 .byte 0xc7
[ 2.043820][ C0] RSP: 0000:ffffc9000001fb70 EFLAGS: 00000206
[ 2.043820][ C0] RAX: 000000000000002b RBX: dffffc0000000000 RCX: 1ffffffff4bd2afe
[ 2.043820][ C0] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffffffa011ca80
[ 2.043820][ C0] RBP: ffffc9000001fbc8 R08: 0000000000000001 R09: fffffbfff4bd2a41
[ 2.043820][ C0] R10: ffffffffa5e95207 R11: fffffbfff4bd2a40 R12: 0000000000000000
[ 2.043820][ C0] R13: 0000000000000000 R14: ffffffffa47076e8 R15: 0000000000000000
[ 2.043820][ C0] ? console_unlock (arch/x86/include/asm/irqflags.h:45 arch/x86/include/asm/irqflags.h:80 arch/x86/include/asm/irqflags.h:138 kernel/printk/printk.c:2715)
[ 2.043820][ C0] ? do_syslog (kernel/printk/printk.c:2088)
[ 2.043820][ C0] ? rcu_read_unlock (include/linux/rcupdate.h:723 (discriminator 5))
[ 2.043820][ C0] ? vprintk_emit (kernel/printk/printk.c:1843 kernel/printk/printk.c:2244)
[ 2.043820][ C0] vprintk_emit (arch/x86/include/asm/preempt.h:85 kernel/printk/printk.c:2246)
[ 2.043820][ C0] _printk (kernel/printk/printk.c:2261)
[ 2.043820][ C0] ? record_print_text.cold (kernel/printk/printk.c:2261)
[ 2.043820][ C0] native_smp_prepare_cpus (arch/x86/kernel/smpboot.c:1432)
[ 2.043820][ C0] kernel_init_freeable (include/linux/compiler.h:241 include/linux/init.h:124 init/main.c:1417 init/main.c:1602)
[ 2.043820][ C0] ? lockdep_hardirqs_on_prepare (kernel/locking/lockdep.c:4232 kernel/locking/lockdep.c:4292 kernel/locking/lockdep.c:4244)
[ 2.043820][ C0] ? console_on_rootfs (init/main.c:1584)
[ 2.043820][ C0] ? rwlock_bug+0xc0/0xc0
[ 2.043820][ C0] ? rest_init (init/main.c:1494)
[ 2.043820][ C0] kernel_init (init/main.c:1504)
[ 2.043820][ C0] ret_from_fork (arch/x86/entry/entry_64.S:301)
[ 2.043820][ C0] </TASK>
[ 2.107153][ T1] cblist_init_generic: Setting adjustable number of callback queues.
[ 2.107829][ T1] cblist_init_generic: Setting shift to 1 and lim to 1.
[ 2.109039][ T1] cblist_init_generic: Setting shift to 1 and lim to 1.
[ 2.110002][ T1] Running RCU-tasks wait API self tests
[ 2.111302][ T1] Performance Events: unsupported p6 CPU model 42 no PMU driver, software events only.
[ 2.113022][ T1] rcu: Hierarchical SRCU implementation.
[ 2.114307][ T14]
[ 2.114774][ T14] =============================
[ 2.114820][ T14] WARNING: suspicious RCU usage
[ 2.114820][ T14] 5.17.0-rc5-00050-gd67e27e3d2e9 #1 Not tainted
[ 2.114820][ T14] -----------------------------
[ 2.114820][ T14] include/linux/cgroup.h:481 suspicious rcu_dereference_check() usage!
[ 2.114820][ T14]
[ 2.114820][ T14] other info that might help us debug this:
[ 2.114820][ T14]
[ 2.114820][ T14] rcu_scheduler_active = 1, debug_locks = 1
[ 2.114820][ T14] 1 lock held by migration/0/14:
[ 2.114820][ T14] #0: ffff88839d439b58 (&rq->__lock){-...}-{2:2}, at: __schedule (kernel/sched/sched.h:1539 (discriminator 3) kernel/sched/sched.h:1617 (discriminator 3) kernel/sched/core.c:6220 (discriminator 3))
[ 2.114820][ T14]
[ 2.114820][ T14] stack backtrace:
[ 2.114820][ T14] CPU: 0 PID: 14 Comm: migration/0 Not tainted 5.17.0-rc5-00050-gd67e27e3d2e9 #1
[ 2.114820][ T14] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 2.114820][ T14] Stopper: 0x0 <- 0x0
[ 2.114820][ T14] Call Trace:
[ 2.114820][ T14] <TASK>
[ 2.114820][ T14] dump_stack_lvl (lib/dump_stack.c:107)
[ 2.114820][ T14] put_prev_task_stop (include/linux/cgroup.h:481 include/linux/cgroup.h:550 include/linux/cgroup.h:794 kernel/sched/stop_task.c:88)
[ 2.114820][ T14] __schedule (kernel/sched/core.c:5635 kernel/sched/core.c:6122 kernel/sched/core.c:6270)
[ 2.114820][ T14] ? io_schedule_timeout (kernel/sched/core.c:6185)
[ 2.114820][ T14] ? lockdep_hardirqs_on_prepare (kernel/locking/lockdep.c:4232 kernel/locking/lockdep.c:4292 kernel/locking/lockdep.c:4244)
[ 2.114820][ T14] ? smpboot_thread_fn (kernel/smpboot.c:112)
[ 2.114820][ T14] schedule (include/linux/instrumented.h:71 (discriminator 1) include/asm-generic/bitops/instrumented-non-atomic.h:134 (discriminator 1) include/linux/thread_info.h:118 (discriminator 1) include/linux/sched.h:2135 (discriminator 1) kernel/sched/core.c:6381 (discriminator 1))
[ 2.114820][ T14] smpboot_thread_fn (kernel/smpboot.c:160)
[ 2.114820][ T14] ? smpboot_register_percpu_thread (kernel/smpboot.c:107)
[ 2.114820][ T14] kthread (kernel/kthread.c:377)
[ 2.114820][ T14] ? kthread_complete_and_exit (kernel/kthread.c:332)
[ 2.114820][ T14] ret_from_fork (arch/x86/entry/entry_64.S:301)
[ 2.114820][ T14] </TASK>
[ 2.118750][ T1] NMI watchdog: Perf NMI watchdog permanently disabled
[ 2.118919][ T10] Callback from call_rcu_tasks_trace() invoked.
[ 2.120449][ T1] smp: Bringing up secondary CPUs ...
[ 2.122366][ T1] x86: Booting SMP configuration:
[ 2.122854][ T1] .... node #0, CPUs: #1
[ 0.120445][ T0] masked ExtINT on CPU#1
[ 0.120445][ T0] smpboot: CPU 1 Converting physical 0 to logical die 1
[ 2.125083][ T1] smp: Brought up 1 node, 2 CPUs
[ 2.125850][ T1] smpboot: Max logical packages: 2
[ 2.126665][ T1] smpboot: Total of 2 processors activated (10774.03 BogoMIPS)
[ 2.219942][ T9] Callback from call_rcu_tasks_rude() invoked.
[ 2.282486][ T21] node 0 deferred pages initialised in 154ms
[ 2.384701][ T1] allocated 201326592 bytes of page_ext
[ 2.385983][ T1] Node 0, zone DMA: page owner found early allocated 0 pages
[ 2.389880][ T1] Node 0, zone DMA32: page owner found early allocated 0 pages
[ 2.412052][ T1] Node 0, zone Normal: page owner found early allocated 50469 pages
[ 2.415224][ T1] devtmpfs: initialized
[ 2.416685][ T1] x86/mm: Memory block size: 128MB
[ 2.451512][ T1] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
[ 2.451870][ T1] futex hash table entries: 512 (order: 4, 65536 bytes, linear)
[ 2.453960][ T1] pinctrl core: initialized pinctrl subsystem
[ 2.459513][ T1] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[ 2.461798][ T1] audit: initializing netlink subsys (disabled)
[ 2.463438][ T27] audit: type=2000 audit(1645945121.029:1): state=initialized audit_enabled=0 res=1
[ 2.464201][ T1] thermal_sys: Registered thermal governor 'fair_share'
[ 2.464832][ T1] thermal_sys: Registered thermal governor 'bang_bang'
[ 2.465832][ T1] thermal_sys: Registered thermal governor 'step_wise'
[ 2.466832][ T1] thermal_sys: Registered thermal governor 'user_space'
[ 2.467955][ T1] cpuidle: using governor menu
[ 2.471077][ T1] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
[ 2.473505][ T1] PCI: Using configuration type 1 for base access
[ 2.518308][ T1] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.
[ 2.520331][ T1] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
[ 2.522793][ T1] cryptd: max_cpu_qlen set to 1000
[ 2.526542][ T1] ACPI: Added _OSI(Module Device)
[ 2.526833][ T1] ACPI: Added _OSI(Processor Device)
[ 2.527652][ T1] ACPI: Added _OSI(3.0 _SCP Extensions)
[ 2.527831][ T1] ACPI: Added _OSI(Processor Aggregator Device)
[ 2.528793][ T1] ACPI: Added _OSI(Linux-Dell-Video)
[ 2.528841][ T1] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
[ 2.529770][ T1] ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics)
[ 2.561600][ T1] ACPI: 1 ACPI AML tables successfully acquired and loaded
[ 2.571121][ T1] ACPI: Interpreter enabled
[ 2.572018][ T1] ACPI: PM: (supports S0 S3 S4 S5)
[ 2.572829][ T1] ACPI: Using IOAPIC for interrupt routing
[ 2.573901][ T1] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[ 2.577064][ T1] ACPI: Enabled 2 GPEs in block 00 to 0F
[ 2.647225][ T1] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[ 2.647879][ T1] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3]
[ 2.648833][ T1] acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI]
[ 2.650156][ T1] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
[ 2.658220][ T1] acpiphp: Slot [3] registered
[ 2.659111][ T1] acpiphp: Slot [4] registered
[ 2.660104][ T1] acpiphp: Slot [5] registered
[ 2.661093][ T1] acpiphp: Slot [6] registered
[ 2.662118][ T1] acpiphp: Slot [7] registered
[ 2.663081][ T1] acpiphp: Slot [8] registered
[ 2.664113][ T1] acpiphp: Slot [9] registered
[ 2.665095][ T1] acpiphp: Slot [10] registered
[ 2.666121][ T1] acpiphp: Slot [11] registered
[ 2.667081][ T1] acpiphp: Slot [12] registered
[ 2.668105][ T1] acpiphp: Slot [13] registered
[ 2.669093][ T1] acpiphp: Slot [14] registered
[ 2.670095][ T1] acpiphp: Slot [15] registered
[ 2.671081][ T1] acpiphp: Slot [16] registered
[ 2.672112][ T1] acpiphp: Slot [17] registered
[ 2.673081][ T1] acpiphp: Slot [18] registered
[ 2.674081][ T1] acpiphp: Slot [19] registered
[ 2.675092][ T1] acpiphp: Slot [20] registered
[ 2.676132][ T1] acpiphp: Slot [21] registered
[ 2.677090][ T1] acpiphp: Slot [22] registered
[ 2.678081][ T1] acpiphp: Slot [23] registered
[ 2.679092][ T1] acpiphp: Slot [24] registered
[ 2.680101][ T1] acpiphp: Slot [25] registered
[ 2.681081][ T1] acpiphp: Slot [26] registered
[ 2.682093][ T1] acpiphp: Slot [27] registered
[ 2.683081][ T1] acpiphp: Slot [28] registered
[ 2.684117][ T1] acpiphp: Slot [29] registered
[ 2.685081][ T1] acpiphp: Slot [30] registered
[ 2.686103][ T1] acpiphp: Slot [31] registered
[ 2.686951][ T1] PCI host bridge to bus 0000:00
[ 2.687751][ T1] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
[ 2.687838][ T1] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
[ 2.688838][ T1] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[ 2.689838][ T1] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]
[ 2.690838][ T1] pci_bus 0000:00: root bus resource [mem 0x440000000-0x4bfffffff window]
[ 2.691841][ T1] pci_bus 0000:00: root bus resource [bus 00-ff]
[ 2.693074][ T1] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
[ 2.696096][ T1] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
[ 2.698651][ T1] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
[ 2.701427][ T1] pci 0000:00:01.1: reg 0x20: [io 0xc040-0xc04f]
[ 2.702852][ T1] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
[ 2.703832][ T1] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6]
[ 2.704831][ T1] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
[ 2.705831][ T1] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376]
[ 2.707539][ T1] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
[ 2.708255][ T1] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI
[ 2.708842][ T1] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB
[ 2.712297][ T1] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000
[ 2.713848][ T1] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref]
[ 2.716762][ T1] pci 0000:00:02.0: reg 0x18: [mem 0xfebf0000-0xfebf0fff]
[ 2.720836][ T1] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref]
[ 2.721972][ T1] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
[ 2.724393][ T1] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000
[ 2.725664][ T1] pci 0000:00:03.0: reg 0x10: [mem 0xfebc0000-0xfebdffff]
[ 2.726602][ T1] pci 0000:00:03.0: reg 0x14: [io 0xc000-0xc03f]
[ 2.730172][ T1] pci 0000:00:03.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref]
[ 2.732372][ T1] pci 0000:00:04.0: [8086:25ab] type 00 class 0x088000
[ 2.733239][ T1] pci 0000:00:04.0: reg 0x10: [mem 0xfebf1000-0xfebf100f]
[ 2.745832][ T1] ACPI: PCI: Interrupt link LNKA configured for IRQ 10
[ 2.748692][ T1] ACPI: PCI: Interrupt link LNKB configured for IRQ 10
[ 2.750674][ T1] ACPI: PCI: Interrupt link LNKC configured for IRQ 11
[ 2.752663][ T1] ACPI: PCI: Interrupt link LNKD configured for IRQ 11
[ 2.753557][ T1] ACPI: PCI: Interrupt link LNKS configured for IRQ 9
[ 2.762061][ T1] iommu: Default domain type: Translated
[ 2.762834][ T1] iommu: DMA domain TLB invalidation policy: lazy mode
[ 2.764532][ T1] pci 0000:00:02.0: vgaarb: setting as boot VGA device
[ 2.764820][ T1] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
[ 2.764833][ T1] pci 0000:00:02.0: vgaarb: bridge control possible
[ 2.765817][ T1] vgaarb: loaded
[ 2.768023][ T1] SCSI subsystem initialized
To reproduce:
# build kernel
cd linux
cp config-5.17.0-rc5-00050-gd67e27e3d2e9 .config
make HOSTCC=gcc-9 CC=gcc-9 ARCH=x86_64 olddefconfig prepare modules_prepare bzImage modules
make HOSTCC=gcc-9 CC=gcc-9 ARCH=x86_64 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.
---
0DAY/LKP+ Test Infrastructure Open Source Technology Center
https://lists.01.org/hyperkitty/list/[email protected] Intel Corporation
Thanks,
Oliver Sang