Greeting,
FYI, we noticed the following commit (built with gcc-9):
commit: d64696905554e919321e31afc210606653b8f6a4 ("Reimplement RLIMIT_SIGPENDING on top of ucounts")
https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git master
in testcase: trinity
version: trinity-i386
with following parameters:
number: 99999
group: group-02
test-description: Trinity is a linux system call fuzz tester.
test-url: http://codemonkey.org.uk/projects/trinity/
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]>
[ 558.756672][ T2642] WARNING: CPU: 0 PID: 2642 at kernel/ucount.c:268 dec_rlimit_ucounts (kernel/ucount.c:268 (discriminator 1))
[ 558.758020][ T2642] Modules linked in: uvesafb cfbfillrect cfbimgblt cfbcopyarea fb fbdev ppdev crc32_pclmul input_leds led_class intel_agp intel_gtt parport_pc parport qemu_fw_cfg
[ 558.766247][ T2642] CPU: 0 PID: 2642 Comm: trinity-main Not tainted 5.12.0-gd64696905554 #1
[ 558.767543][ T2642] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 558.772150][ T2642] EIP: dec_rlimit_ucounts (kernel/ucount.c:268 (discriminator 1))
[ 558.772945][ T2642] Code: 68 73 6c c3 01 83 15 6c 73 6c c3 00 85 c0 0f 94 c0 83 c4 04 5b 5e 5f 5d c3 8d 76 00 83 05 50 73 6c c3 01 83 15 54 73 6c c3 00 <0f> 0b 83 05 58 73 6c c3 01 83 15 5c 73 6c c3 00 eb 9d 8d b4 26 00
All code
========
0: 68 73 6c c3 01 pushq $0x1c36c73
5: 83 15 6c 73 6c c3 00 adcl $0x0,-0x3c938c94(%rip) # 0xffffffffc36c7378
c: 85 c0 test %eax,%eax
e: 0f 94 c0 sete %al
11: 83 c4 04 add $0x4,%esp
14: 5b pop %rbx
15: 5e pop %rsi
16: 5f pop %rdi
17: 5d pop %rbp
18: c3 retq
19: 8d 76 00 lea 0x0(%rsi),%esi
1c: 83 05 50 73 6c c3 01 addl $0x1,-0x3c938cb0(%rip) # 0xffffffffc36c7373
23: 83 15 54 73 6c c3 00 adcl $0x0,-0x3c938cac(%rip) # 0xffffffffc36c737e
2a:* 0f 0b ud2 <-- trapping instruction
2c: 83 05 58 73 6c c3 01 addl $0x1,-0x3c938ca8(%rip) # 0xffffffffc36c738b
33: 83 15 5c 73 6c c3 00 adcl $0x0,-0x3c938ca4(%rip) # 0xffffffffc36c7396
3a: eb 9d jmp 0xffffffffffffffd9
3c: 8d .byte 0x8d
3d: b4 26 mov $0x26,%ah
...
Code starting with the faulting instruction
===========================================
0: 0f 0b ud2
2: 83 05 58 73 6c c3 01 addl $0x1,-0x3c938ca8(%rip) # 0xffffffffc36c7361
9: 83 15 5c 73 6c c3 00 adcl $0x0,-0x3c938ca4(%rip) # 0xffffffffc36c736c
10: eb 9d jmp 0xffffffffffffffaf
12: 8d .byte 0x8d
13: b4 26 mov $0x26,%ah
...
[ 558.779398][ T2642] EAX: f63271e0 EBX: f63271e0 ECX: 00000001 EDX: ffffffff
[ 558.781206][ T2642] ESI: 0000003c EDI: ffffffff EBP: f62e3eac ESP: f62e3e9c
[ 558.782613][ T2642] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 0068 EFLAGS: 00010246
[ 558.783747][ T2642] CR0: 80050033 CR2: 08082ff0 CR3: 362b0000 CR4: 00040690
[ 558.792353][ T2642] Call Trace:
[ 558.793036][ T2642] ? release_task (include/linux/rcupdate.h:654 kernel/exit.c:191)
[ 558.793936][ T2642] release_task (kernel/exit.c:191)
[ 558.794818][ T2642] wait_task_zombie (kernel/exit.c:1107)
[ 558.800667][ T2642] wait_consider_task (kernel/exit.c:1334)
[ 558.801693][ T2642] ? _raw_read_lock (include/linux/rwlock_api_smp.h:149 kernel/locking/spinlock.c:223)
[ 558.802645][ T2642] do_wait (kernel/exit.c:1399 kernel/exit.c:1468)
[ 558.803462][ T2642] kernel_wait4 (kernel/exit.c:1630)
[ 558.806901][ T2642] ? kill_orphaned_pgrp (kernel/exit.c:1422)
[ 558.808347][ T2642] __ia32_sys_waitpid (kernel/exit.c:1675 kernel/exit.c:1673 kernel/exit.c:1673)
[ 558.809338][ T2642] do_int80_syscall_32 (arch/x86/entry/common.c:77 arch/x86/entry/common.c:94)
[ 558.810319][ T2642] entry_INT80_32 (arch/x86/entry/entry_32.S:1064)
[ 558.811254][ T2642] EIP: 0x809b132
[ 558.815723][ T2642] Code: 89 c8 c3 90 8d 74 26 00 85 c0 c7 01 01 00 00 00 75 d8 a1 6c 94 a8 08 eb d1 66 90 66 90 66 90 66 90 66 90 66 90 66 90 90 cd 80 <c3> 8d b6 00 00 00 00 8d bc 27 00 00 00 00 8b 10 a3 94 94 a8 08 85
All code
========
0: 89 c8 mov %ecx,%eax
2: c3 retq
3: 90 nop
4: 8d 74 26 00 lea 0x0(%rsi,%riz,1),%esi
8: 85 c0 test %eax,%eax
a: c7 01 01 00 00 00 movl $0x1,(%rcx)
10: 75 d8 jne 0xffffffffffffffea
12: a1 6c 94 a8 08 eb d1 movabs 0x9066d1eb08a8946c,%eax
19: 66 90
1b: 66 90 xchg %ax,%ax
1d: 66 90 xchg %ax,%ax
1f: 66 90 xchg %ax,%ax
21: 66 90 xchg %ax,%ax
23: 66 90 xchg %ax,%ax
25: 66 90 xchg %ax,%ax
27: 90 nop
28: cd 80 int $0x80
2a:* c3 retq <-- trapping instruction
2b: 8d b6 00 00 00 00 lea 0x0(%rsi),%esi
31: 8d bc 27 00 00 00 00 lea 0x0(%rdi,%riz,1),%edi
38: 8b 10 mov (%rax),%edx
3a: a3 .byte 0xa3
3b: 94 xchg %eax,%esp
3c: 94 xchg %eax,%esp
3d: a8 08 test $0x8,%al
3f: 85 .byte 0x85
Code starting with the faulting instruction
===========================================
0: c3 retq
1: 8d b6 00 00 00 00 lea 0x0(%rsi),%esi
7: 8d bc 27 00 00 00 00 lea 0x0(%rdi,%riz,1),%edi
e: 8b 10 mov (%rax),%edx
10: a3 .byte 0xa3
11: 94 xchg %eax,%esp
12: 94 xchg %eax,%esp
13: a8 08 test $0x8,%al
15: 85 .byte 0x85
[ 558.820109][ T2642] EAX: ffffffda EBX: 00000f0f ECX: bfb23394 EDX: 0000000b
[ 558.821480][ T2642] ESI: 00000002 EDI: 08a890fc EBP: 08a89034 ESP: bfb23364
[ 558.822693][ T2642] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 007b EFLAGS: 00000246
[ 558.828056][ T2642] irq event stamp: 1348273
[ 558.828922][ T2642] hardirqs last enabled at (1348281): console_unlock (kernel/printk/printk.c:2605 (discriminator 1))
[ 558.830629][ T2642] hardirqs last disabled at (1348288): console_unlock (kernel/printk/printk.c:2520 (discriminator 1))
[ 558.833190][ T2642] softirqs last enabled at (1348240): __do_softirq (kernel/softirq.c:372)
[ 558.834715][ T2642] softirqs last disabled at (1348231): do_softirq_own_stack (arch/x86/kernel/irq_32.c:60 arch/x86/kernel/irq_32.c:149)
[ 558.840026][ T2642] ---[ end trace 6bbb25560ce8d9b6 ]---
To reproduce:
# build kernel
cd linux
cp config-5.12.0-gd64696905554 .config
make HOSTCC=gcc-9 CC=gcc-9 ARCH=i386 olddefconfig prepare modules_prepare bzImage
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email
---
0DAY/LKP+ Test Infrastructure Open Source Technology Center
https://lists.01.org/hyperkitty/list/[email protected] Intel Corporation
Thanks,
Oliver Sang
On Mon, Sep 13, 2021 at 10:16:54PM +0800, kernel test robot wrote:
>
>
> Greeting,
>
> FYI, we noticed the following commit (built with gcc-9):
>
> commit: d64696905554e919321e31afc210606653b8f6a4 ("Reimplement RLIMIT_SIGPENDING on top of ucounts")
> https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git master
>
>
> in testcase: trinity
> version: trinity-i386
> with following parameters:
>
> number: 99999
> group: group-02
>
> test-description: Trinity is a linux system call fuzz tester.
> test-url: http://codemonkey.org.uk/projects/trinity/
>
>
> 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]>
>
>
> [ 558.756672][ T2642] WARNING: CPU: 0 PID: 2642 at kernel/ucount.c:268 dec_rlimit_ucounts (kernel/ucount.c:268 (discriminator 1))
> [ 558.758020][ T2642] Modules linked in: uvesafb cfbfillrect cfbimgblt cfbcopyarea fb fbdev ppdev crc32_pclmul input_leds led_class intel_agp intel_gtt parport_pc parport qemu_fw_cfg
> [ 558.766247][ T2642] CPU: 0 PID: 2642 Comm: trinity-main Not tainted 5.12.0-gd64696905554 #1
> [ 558.767543][ T2642] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
> [ 558.772150][ T2642] EIP: dec_rlimit_ucounts (kernel/ucount.c:268 (discriminator 1))
> [ 558.772945][ T2642] Code: 68 73 6c c3 01 83 15 6c 73 6c c3 00 85 c0 0f 94 c0 83 c4 04 5b 5e 5f 5d c3 8d 76 00 83 05 50 73 6c c3 01 83 15 54 73 6c c3 00 <0f> 0b 83 05 58 73 6c c3 01 83 15 5c 73 6c c3 00 eb 9d 8d b4 26 00
> All code
> ========
> 0: 68 73 6c c3 01 pushq $0x1c36c73
> 5: 83 15 6c 73 6c c3 00 adcl $0x0,-0x3c938c94(%rip) # 0xffffffffc36c7378
> c: 85 c0 test %eax,%eax
> e: 0f 94 c0 sete %al
> 11: 83 c4 04 add $0x4,%esp
> 14: 5b pop %rbx
> 15: 5e pop %rsi
> 16: 5f pop %rdi
> 17: 5d pop %rbp
> 18: c3 retq
> 19: 8d 76 00 lea 0x0(%rsi),%esi
> 1c: 83 05 50 73 6c c3 01 addl $0x1,-0x3c938cb0(%rip) # 0xffffffffc36c7373
> 23: 83 15 54 73 6c c3 00 adcl $0x0,-0x3c938cac(%rip) # 0xffffffffc36c737e
> 2a:* 0f 0b ud2 <-- trapping instruction
> 2c: 83 05 58 73 6c c3 01 addl $0x1,-0x3c938ca8(%rip) # 0xffffffffc36c738b
> 33: 83 15 5c 73 6c c3 00 adcl $0x0,-0x3c938ca4(%rip) # 0xffffffffc36c7396
> 3a: eb 9d jmp 0xffffffffffffffd9
> 3c: 8d .byte 0x8d
> 3d: b4 26 mov $0x26,%ah
> ...
>
> Code starting with the faulting instruction
> ===========================================
> 0: 0f 0b ud2
> 2: 83 05 58 73 6c c3 01 addl $0x1,-0x3c938ca8(%rip) # 0xffffffffc36c7361
> 9: 83 15 5c 73 6c c3 00 adcl $0x0,-0x3c938ca4(%rip) # 0xffffffffc36c736c
> 10: eb 9d jmp 0xffffffffffffffaf
> 12: 8d .byte 0x8d
> 13: b4 26 mov $0x26,%ah
> ...
> [ 558.779398][ T2642] EAX: f63271e0 EBX: f63271e0 ECX: 00000001 EDX: ffffffff
> [ 558.781206][ T2642] ESI: 0000003c EDI: ffffffff EBP: f62e3eac ESP: f62e3e9c
> [ 558.782613][ T2642] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 0068 EFLAGS: 00010246
> [ 558.783747][ T2642] CR0: 80050033 CR2: 08082ff0 CR3: 362b0000 CR4: 00040690
> [ 558.792353][ T2642] Call Trace:
> [ 558.793036][ T2642] ? release_task (include/linux/rcupdate.h:654 kernel/exit.c:191)
> [ 558.793936][ T2642] release_task (kernel/exit.c:191)
> [ 558.794818][ T2642] wait_task_zombie (kernel/exit.c:1107)
> [ 558.800667][ T2642] wait_consider_task (kernel/exit.c:1334)
> [ 558.801693][ T2642] ? _raw_read_lock (include/linux/rwlock_api_smp.h:149 kernel/locking/spinlock.c:223)
> [ 558.802645][ T2642] do_wait (kernel/exit.c:1399 kernel/exit.c:1468)
> [ 558.803462][ T2642] kernel_wait4 (kernel/exit.c:1630)
> [ 558.806901][ T2642] ? kill_orphaned_pgrp (kernel/exit.c:1422)
> [ 558.808347][ T2642] __ia32_sys_waitpid (kernel/exit.c:1675 kernel/exit.c:1673 kernel/exit.c:1673)
> [ 558.809338][ T2642] do_int80_syscall_32 (arch/x86/entry/common.c:77 arch/x86/entry/common.c:94)
> [ 558.810319][ T2642] entry_INT80_32 (arch/x86/entry/entry_32.S:1064)
> [ 558.811254][ T2642] EIP: 0x809b132
> [ 558.815723][ T2642] Code: 89 c8 c3 90 8d 74 26 00 85 c0 c7 01 01 00 00 00 75 d8 a1 6c 94 a8 08 eb d1 66 90 66 90 66 90 66 90 66 90 66 90 66 90 90 cd 80 <c3> 8d b6 00 00 00 00 8d bc 27 00 00 00 00 8b 10 a3 94 94 a8 08 85
> All code
> ========
> 0: 89 c8 mov %ecx,%eax
> 2: c3 retq
> 3: 90 nop
> 4: 8d 74 26 00 lea 0x0(%rsi,%riz,1),%esi
> 8: 85 c0 test %eax,%eax
> a: c7 01 01 00 00 00 movl $0x1,(%rcx)
> 10: 75 d8 jne 0xffffffffffffffea
> 12: a1 6c 94 a8 08 eb d1 movabs 0x9066d1eb08a8946c,%eax
> 19: 66 90
> 1b: 66 90 xchg %ax,%ax
> 1d: 66 90 xchg %ax,%ax
> 1f: 66 90 xchg %ax,%ax
> 21: 66 90 xchg %ax,%ax
> 23: 66 90 xchg %ax,%ax
> 25: 66 90 xchg %ax,%ax
> 27: 90 nop
> 28: cd 80 int $0x80
> 2a:* c3 retq <-- trapping instruction
> 2b: 8d b6 00 00 00 00 lea 0x0(%rsi),%esi
> 31: 8d bc 27 00 00 00 00 lea 0x0(%rdi,%riz,1),%edi
> 38: 8b 10 mov (%rax),%edx
> 3a: a3 .byte 0xa3
> 3b: 94 xchg %eax,%esp
> 3c: 94 xchg %eax,%esp
> 3d: a8 08 test $0x8,%al
> 3f: 85 .byte 0x85
>
> Code starting with the faulting instruction
> ===========================================
> 0: c3 retq
> 1: 8d b6 00 00 00 00 lea 0x0(%rsi),%esi
> 7: 8d bc 27 00 00 00 00 lea 0x0(%rdi,%riz,1),%edi
> e: 8b 10 mov (%rax),%edx
> 10: a3 .byte 0xa3
> 11: 94 xchg %eax,%esp
> 12: 94 xchg %eax,%esp
> 13: a8 08 test $0x8,%al
> 15: 85 .byte 0x85
> [ 558.820109][ T2642] EAX: ffffffda EBX: 00000f0f ECX: bfb23394 EDX: 0000000b
> [ 558.821480][ T2642] ESI: 00000002 EDI: 08a890fc EBP: 08a89034 ESP: bfb23364
> [ 558.822693][ T2642] DS: 007b ES: 007b FS: 0000 GS: 0033 SS: 007b EFLAGS: 00000246
> [ 558.828056][ T2642] irq event stamp: 1348273
> [ 558.828922][ T2642] hardirqs last enabled at (1348281): console_unlock (kernel/printk/printk.c:2605 (discriminator 1))
> [ 558.830629][ T2642] hardirqs last disabled at (1348288): console_unlock (kernel/printk/printk.c:2520 (discriminator 1))
> [ 558.833190][ T2642] softirqs last enabled at (1348240): __do_softirq (kernel/softirq.c:372)
> [ 558.834715][ T2642] softirqs last disabled at (1348231): do_softirq_own_stack (arch/x86/kernel/irq_32.c:60 arch/x86/kernel/irq_32.c:149)
> [ 558.840026][ T2642] ---[ end trace 6bbb25560ce8d9b6 ]---
>
>
> To reproduce:
>
> # build kernel
> cd linux
> cp config-5.12.0-gd64696905554 .config
> make HOSTCC=gcc-9 CC=gcc-9 ARCH=i386 olddefconfig prepare modules_prepare bzImage
>
> git clone https://github.com/intel/lkp-tests.git
> cd lkp-tests
> bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email
I am unable to run the test following this instruction.
I see a log like this:
[ 11.641013][ T144] udevd[144]: starting version 3.2.7
[ 11.641708][ T144] random: udevd: uninitialized urandom read (16 bytes read)
[ 11.642545][ T144] random: udevd: uninitialized urandom read (16 bytes read)
[ 11.643211][ T144] random: udevd: uninitialized urandom read (16 bytes read)
[ 11.645112][ T144] udevd[144]: specified group 'kvm' unknown
[ 11.648240][ T145] udevd[145]: starting eudev-3.2.7
[ 11.676942][ T145] udevd[145]: specified group 'kvm' unknown
[ 12.871897][ T163] _warn_unseeded_randomness: 197 callbacks suppressed
[ 12.871904][ T163] random: get_random_u32 called from arch_rnd+0x32/0x80 with crng_init=1
[ 12.871912][ T163] random: get_random_u32 called from randomize_stack_top+0x53/0x70 with crng_init=1
[ 12.871917][ T163] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
depmod: ERROR: could not open directory /lib/modules/5.14.0-09687-g27151f177827: No such file or directory
depmod: WARNING: -e needs -E or -F
depmod: ERROR: could not open directory /lib/modules/5.14.0-09687-g27151f177827: No such file or directory
depmod: FATAL: could not search modules: No such file or directory
hwclock: can't open '/dev/misc/rtc': No such file or directory
[ 13.047209][ T291] urandom_read: 3 callbacks suppressed
[ 13.047212][ T291] random: dd: uninitialized urandom read (512 bytes read)
INIT: Entering runlevel: 5
Configuring network interfaces... ip: RTNETLINK answers: File exists
hwclock: can't open '/dev/misc/rtc': No such file or directory
Starting syslogd/klogd: done
/etc/rc5.d/S77lkp-bootstrap: /lkp/jobs/scheduled/vm-snb-43/trinity-group-02-99999-yocto-i386-minimal-20190520.cgz-d64696905554e919321e31afc210606653b8f6a4-20210911-24127-1x1tp2w-8.sh: line 123: start: not found
/etc/rc5.d/S77lkp-bootstrap: line 75: /lkp/root/src/bin/lkp-setup-rootfs: not found
[ 13.103013][ T183] bootlogd (183) used greatest stack depth: 6132 bytes left
INIT: Id "S1" respawning too fast: disabled for 5 minutes
--
Rgrds, legion
Hi, legion
> -----Original Message-----
> From: Alexey Gladkov <[email protected]>
> Sent: Tuesday, September 14, 2021 3:40 AM
> To: Sang, Oliver <[email protected]>
> Cc: Eric W. Biederman <[email protected]>; LKML <linux-
> [email protected]>; [email protected]; lkp <[email protected]>
> Subject: Re: d646969055: WARNING:at_kernel/ucount.c:#dec_rlimit_ucounts
>
> On Mon, Sep 13, 2021 at 10:16:54PM +0800, kernel test robot wrote:
> >
> >
> > Greeting,
> >
> > FYI, we noticed the following commit (built with gcc-9):
> >
> > commit: d64696905554e919321e31afc210606653b8f6a4 ("Reimplement
> > RLIMIT_SIGPENDING on top of ucounts")
> > https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git master
> >
> >
> > in testcase: trinity
> > version: trinity-i386
> > with following parameters:
> >
> > number: 99999
> > group: group-02
> >
> > test-description: Trinity is a linux system call fuzz tester.
> > test-url: http://codemonkey.org.uk/projects/trinity/
> >
> >
> > 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]>
> >
> >
> > [ 558.756672][ T2642] WARNING: CPU: 0 PID: 2642 at kernel/ucount.c:268
> > dec_rlimit_ucounts (kernel/ucount.c:268 (discriminator 1)) [
> > 558.758020][ T2642] Modules linked in: uvesafb cfbfillrect cfbimgblt
> > cfbcopyarea fb fbdev ppdev crc32_pclmul input_leds led_class intel_agp
> > intel_gtt parport_pc parport qemu_fw_cfg [ 558.766247][ T2642] CPU: 0
> > PID: 2642 Comm: trinity-main Not tainted 5.12.0-gd64696905554 #1 [
> > 558.767543][ T2642] Hardware name: QEMU Standard PC (i440FX + PIIX,
> > 1996), BIOS 1.12.0-1 04/01/2014 [ 558.772150][ T2642] EIP:
> dec_rlimit_ucounts (kernel/ucount.c:268 (discriminator 1)) [ 558.772945][ T2642]
> Code: 68 73 6c c3 01 83 15 6c 73 6c c3 00 85 c0 0f 94 c0 83 c4 04 5b 5e 5f 5d c3
> 8d 76 00 83 05 50 73 6c c3 01 83 15 54 73 6c c3 00 <0f> 0b 83 05 58 73 6c c3 01
> 83 15 5c 73 6c c3 00 eb 9d 8d b4 26 00 All code ========
> > 0: 68 73 6c c3 01 pushq $0x1c36c73
> > 5: 83 15 6c 73 6c c3 00 adcl $0x0,-0x3c938c94(%rip) #
> 0xffffffffc36c7378
> > c: 85 c0 test %eax,%eax
> > e: 0f 94 c0 sete %al
> > 11: 83 c4 04 add $0x4,%esp
> > 14: 5b pop %rbx
> > 15: 5e pop %rsi
> > 16: 5f pop %rdi
> > 17: 5d pop %rbp
> > 18: c3 retq
> > 19: 8d 76 00 lea 0x0(%rsi),%esi
> > 1c: 83 05 50 73 6c c3 01 addl $0x1,-0x3c938cb0(%rip) #
> 0xffffffffc36c7373
> > 23: 83 15 54 73 6c c3 00 adcl $0x0,-0x3c938cac(%rip) #
> 0xffffffffc36c737e
> > 2a:* 0f 0b ud2 <-- trapping instruction
> > 2c: 83 05 58 73 6c c3 01 addl $0x1,-0x3c938ca8(%rip) #
> 0xffffffffc36c738b
> > 33: 83 15 5c 73 6c c3 00 adcl $0x0,-0x3c938ca4(%rip) #
> 0xffffffffc36c7396
> > 3a: eb 9d jmp 0xffffffffffffffd9
> > 3c: 8d .byte 0x8d
> > 3d: b4 26 mov $0x26,%ah
> > ...
> >
> > Code starting with the faulting instruction
> > ===========================================
> > 0: 0f 0b ud2
> > 2: 83 05 58 73 6c c3 01 addl $0x1,-0x3c938ca8(%rip) #
> 0xffffffffc36c7361
> > 9: 83 15 5c 73 6c c3 00 adcl $0x0,-0x3c938ca4(%rip) #
> 0xffffffffc36c736c
> > 10: eb 9d jmp 0xffffffffffffffaf
> > 12: 8d .byte 0x8d
> > 13: b4 26 mov $0x26,%ah
> > ...
> > [ 558.779398][ T2642] EAX: f63271e0 EBX: f63271e0 ECX: 00000001 EDX:
> > ffffffff [ 558.781206][ T2642] ESI: 0000003c EDI: ffffffff EBP:
> > f62e3eac ESP: f62e3e9c [ 558.782613][ T2642] DS: 007b ES: 007b FS:
> > 0000 GS: 0033 SS: 0068 EFLAGS: 00010246 [ 558.783747][ T2642] CR0:
> > 80050033 CR2: 08082ff0 CR3: 362b0000 CR4: 00040690 [ 558.792353][ T2642]
> Call Trace:
> > [ 558.793036][ T2642] ? release_task (include/linux/rcupdate.h:654
> > kernel/exit.c:191) [ 558.793936][ T2642] release_task
> > (kernel/exit.c:191) [ 558.794818][ T2642] wait_task_zombie
> > (kernel/exit.c:1107) [ 558.800667][ T2642] wait_consider_task
> > (kernel/exit.c:1334) [ 558.801693][ T2642] ? _raw_read_lock
> > (include/linux/rwlock_api_smp.h:149 kernel/locking/spinlock.c:223) [
> > 558.802645][ T2642] do_wait (kernel/exit.c:1399 kernel/exit.c:1468) [
> > 558.803462][ T2642] kernel_wait4 (kernel/exit.c:1630) [ 558.806901][
> > T2642] ? kill_orphaned_pgrp (kernel/exit.c:1422) [ 558.808347][ T2642]
> > __ia32_sys_waitpid (kernel/exit.c:1675 kernel/exit.c:1673
> > kernel/exit.c:1673) [ 558.809338][ T2642] do_int80_syscall_32
> > (arch/x86/entry/common.c:77 arch/x86/entry/common.c:94) [ 558.810319][
> > T2642] entry_INT80_32 (arch/x86/entry/entry_32.S:1064) [ 558.811254][
> > T2642] EIP: 0x809b132 [ 558.815723][ T2642] Code: 89 c8 c3 90 8d 74 26
> > 00 85 c0 c7 01 01 00 00 00 75 d8 a1 6c 94 a8 08 eb d1 66 90 66 90 66 90 66 90
> 66 90 66 90 66 90 90 cd 80 <c3> 8d b6 00 00 00 00 8d bc 27 00 00 00 00 8b 10 a3
> 94 94 a8 08 85 All code ========
> > 0: 89 c8 mov %ecx,%eax
> > 2: c3 retq
> > 3: 90 nop
> > 4: 8d 74 26 00 lea 0x0(%rsi,%riz,1),%esi
> > 8: 85 c0 test %eax,%eax
> > a: c7 01 01 00 00 00 movl $0x1,(%rcx)
> > 10: 75 d8 jne 0xffffffffffffffea
> > 12: a1 6c 94 a8 08 eb d1 movabs 0x9066d1eb08a8946c,%eax
> > 19: 66 90
> > 1b: 66 90 xchg %ax,%ax
> > 1d: 66 90 xchg %ax,%ax
> > 1f: 66 90 xchg %ax,%ax
> > 21: 66 90 xchg %ax,%ax
> > 23: 66 90 xchg %ax,%ax
> > 25: 66 90 xchg %ax,%ax
> > 27: 90 nop
> > 28: cd 80 int $0x80
> > 2a:* c3 retq <-- trapping instruction
> > 2b: 8d b6 00 00 00 00 lea 0x0(%rsi),%esi
> > 31: 8d bc 27 00 00 00 00 lea 0x0(%rdi,%riz,1),%edi
> > 38: 8b 10 mov (%rax),%edx
> > 3a: a3 .byte 0xa3
> > 3b: 94 xchg %eax,%esp
> > 3c: 94 xchg %eax,%esp
> > 3d: a8 08 test $0x8,%al
> > 3f: 85 .byte 0x85
> >
> > Code starting with the faulting instruction
> > ===========================================
> > 0: c3 retq
> > 1: 8d b6 00 00 00 00 lea 0x0(%rsi),%esi
> > 7: 8d bc 27 00 00 00 00 lea 0x0(%rdi,%riz,1),%edi
> > e: 8b 10 mov (%rax),%edx
> > 10: a3 .byte 0xa3
> > 11: 94 xchg %eax,%esp
> > 12: 94 xchg %eax,%esp
> > 13: a8 08 test $0x8,%al
> > 15: 85 .byte 0x85
> > [ 558.820109][ T2642] EAX: ffffffda EBX: 00000f0f ECX: bfb23394 EDX:
> > 0000000b [ 558.821480][ T2642] ESI: 00000002 EDI: 08a890fc EBP:
> > 08a89034 ESP: bfb23364 [ 558.822693][ T2642] DS: 007b ES: 007b FS:
> > 0000 GS: 0033 SS: 007b EFLAGS: 00000246 [ 558.828056][ T2642] irq
> > event stamp: 1348273 [ 558.828922][ T2642] hardirqs last enabled at
> > (1348281): console_unlock (kernel/printk/printk.c:2605 (discriminator
> > 1)) [ 558.830629][ T2642] hardirqs last disabled at (1348288):
> > console_unlock (kernel/printk/printk.c:2520 (discriminator 1)) [
> > 558.833190][ T2642] softirqs last enabled at (1348240): __do_softirq
> > (kernel/softirq.c:372) [ 558.834715][ T2642] softirqs last disabled at
> > (1348231): do_softirq_own_stack (arch/x86/kernel/irq_32.c:60
> > arch/x86/kernel/irq_32.c:149) [ 558.840026][ T2642] ---[ end trace
> > 6bbb25560ce8d9b6 ]---
> >
> >
> > To reproduce:
> >
> > # build kernel
> > cd linux
> > cp config-5.12.0-gd64696905554 .config
> > make HOSTCC=gcc-9 CC=gcc-9 ARCH=i386 olddefconfig prepare
> > modules_prepare bzImage
> >
> > git clone https://github.com/intel/lkp-tests.git
> > cd lkp-tests
> > bin/lkp qemu -k <bzImage> job-script # job-script is attached
> > in this email
>
> I am unable to run the test following this instruction.
After double check, we can reproduce this issue, could you kindly offer your full log and the reproducing steps?
As the log you mentioned, below [1] shows our corresponding log, they are very similar, only we don't have depmod error, I found some solutions and add their links here, could you check if they can solve your issue? Thanks.
depmod: ERROR: could not open directory /lib/modules/5.14.0-09687-g27151f177827: No such file or directory
depmod: FATAL: could not search modules: No such file or directory
https://stackoverflow.com/questions/28644386/kernel-install-gives-missing-module-error
https://serverfault.com/questions/780980/error-could-not-open-directory-lib-modules-4-2-0-25-generic-no-such-file-or-d
[1]
[ 12.451508][ T142] udevd[142]: starting version 3.2.7
[ 12.452573][ T142] random: udevd: uninitialized urandom read (16 bytes read)
[ 12.453575][ T142] random: udevd: uninitialized urandom read (16 bytes read)
[ 12.454383][ T142] random: udevd: uninitialized urandom read (16 bytes read)
[ 12.457336][ T142] udevd[142]: specified group 'kvm' unknown
[ 12.461646][ T143] udevd[143]: starting eudev-3.2.7
[ 12.505124][ T143] udevd[143]: specified group 'kvm' unknown
[ 12.551437][ T155] parport_pc 00:04: reported by Plug and Play ACPI
[ 12.552300][ T155] parport0: PC-style at 0x378, irq 7 [PCSPP,TRISTATE]
[ 12.631105][ T145] udevadm (145) used greatest stack depth: 6188 bytes left
[ 12.677804][ T155] parport_pc parport_pc.956: Unable to set coherent dma mask: disabling DMA
[ 12.679095][ T155] parport_pc parport_pc.888: Unable to set coherent dma mask: disabling DMA
[ 12.680302][ T155] parport_pc parport_pc.632: Unable to set coherent dma mask: disabling DMA
[ 12.816138][ T148] ppdev: user-space parallel port driver
[ 13.828199][ T161] _warn_unseeded_randomness: 196 callbacks suppressed
[ 13.828206][ T161] random: get_random_u32 called from arch_rnd+0x32/0x80 with crng_init=1
[ 13.828215][ T161] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 13.828223][ T161] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 13.850739][ T168] uvesafb: failed to execute /sbin/v86d
[ 13.851380][ T168] uvesafb: make sure that the v86d helper is installed and executable
[ 13.852224][ T168] uvesafb: Getting VBE info block failed (eax=0x4f00, err=-2)
[ 13.853009][ T168] uvesafb: vbe_init() failed with -22
[ 13.853713][ T168] uvesafb: probe of uvesafb.0 failed with error -22
hwclock: can't open '/dev/misc/rtc': No such file or directory
[ 14.052516][ T289] urandom_read: 3 callbacks suppressed
[ 14.052519][ T289] random: dd: uninitialized urandom read (512 bytes read)
INIT: Entering runlevel: 5
Configuring network interfaces... ip: RTNETLINK answers: File exists
hwclock: can't open '/dev/misc/rtc': No such file or directory
Starting syslogd/klogd: done
/etc/rc5.d/S77lkp-bootstrap: /lkp/jobs/scheduled/vm-snb-43/trinity-group-02-99999-yocto-i386-minimal-20190520.cgz-d64696905554e919321e31afc210606653b8f6a4-20210911-24127-1x1tp2
w-8.sh: line 123: start: not found
PATH=/sbin:/usr/sbin:/bin:/usr/bin:/lkp/root/src/bin
[ 14.141304][ T181] bootlogd (181) used greatest stack depth: 6124 bytes left
export VM_VIRTFS=1 due to result service 9p/virtfs_mount
LKP: HOSTNAME vm-snb-43, MAC 52:54:00:12:34:56, kernel 5.12.0-gd64696905554 1, serial co
nsole /dev/ttyS0
Poky (Yocto Project Reference Distro) 2.7+snapshot vm-snb-43 /dev/ttyS0
INIT: Id "S1" respawning too fast: disabled for 5 minutes
>
> I see a log like this:
>
> [ 11.641013][ T144] udevd[144]: starting version 3.2.7
> [ 11.641708][ T144] random: udevd: uninitialized urandom read (16 bytes read)
> [ 11.642545][ T144] random: udevd: uninitialized urandom read (16 bytes read)
> [ 11.643211][ T144] random: udevd: uninitialized urandom read (16 bytes read)
> [ 11.645112][ T144] udevd[144]: specified group 'kvm' unknown
> [ 11.648240][ T145] udevd[145]: starting eudev-3.2.7
> [ 11.676942][ T145] udevd[145]: specified group 'kvm' unknown
> [ 12.871897][ T163] _warn_unseeded_randomness: 197 callbacks suppressed
> [ 12.871904][ T163] random: get_random_u32 called from
> arch_rnd+0x32/0x80 with crng_init=1
> [ 12.871912][ T163] random: get_random_u32 called from
> randomize_stack_top+0x53/0x70 with crng_init=1
> [ 12.871917][ T163] random: get_random_u32 called from
> arch_align_stack+0x5b/0x80 with crng_init=1
> depmod: ERROR: could not open directory /lib/modules/5.14.0-09687-
> g27151f177827: No such file or directory
> depmod: WARNING: -e needs -E or -F
> depmod: ERROR: could not open directory /lib/modules/5.14.0-09687-
> g27151f177827: No such file or directory
> depmod: FATAL: could not search modules: No such file or directory
> hwclock: can't open '/dev/misc/rtc': No such file or directory
> [ 13.047209][ T291] urandom_read: 3 callbacks suppressed
> [ 13.047212][ T291] random: dd: uninitialized urandom read (512 bytes read)
> INIT: Entering runlevel: 5
> Configuring network interfaces... ip: RTNETLINK answers: File exists
> hwclock: can't open '/dev/misc/rtc': No such file or directory Starting
> syslogd/klogd: done
> /etc/rc5.d/S77lkp-bootstrap: /lkp/jobs/scheduled/vm-snb-43/trinity-group-02-
> 99999-yocto-i386-minimal-20190520.cgz-
> d64696905554e919321e31afc210606653b8f6a4-20210911-24127-1x1tp2w-8.sh:
> line 123: start: not found
> /etc/rc5.d/S77lkp-bootstrap: line 75: /lkp/root/src/bin/lkp-setup-rootfs: not
> found
> [ 13.103013][ T183] bootlogd (183) used greatest stack depth: 6132 bytes left
> INIT: Id "S1" respawning too fast: disabled for 5 minutes
>
> --
> Rgrds, legion
On Wed, Sep 15, 2021 at 01:54:09AM +0000, Si, Beibei wrote:
> Hi, legion
>
> > -----Original Message-----
> > From: Alexey Gladkov <[email protected]>
> > Sent: Tuesday, September 14, 2021 3:40 AM
> > To: Sang, Oliver <[email protected]>
> > Cc: Eric W. Biederman <[email protected]>; LKML <linux-
> > [email protected]>; [email protected]; lkp <[email protected]>
> > Subject: Re: d646969055: WARNING:at_kernel/ucount.c:#dec_rlimit_ucounts
> >
> > On Mon, Sep 13, 2021 at 10:16:54PM +0800, kernel test robot wrote:
> > >
> > >
> > > Greeting,
> > >
> > > FYI, we noticed the following commit (built with gcc-9):
> > >
> > > commit: d64696905554e919321e31afc210606653b8f6a4 ("Reimplement
> > > RLIMIT_SIGPENDING on top of ucounts")
> > > https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git master
> > >
> > >
> > > in testcase: trinity
> > > version: trinity-i386
> > > with following parameters:
> > >
> > > number: 99999
> > > group: group-02
> > >
> > > test-description: Trinity is a linux system call fuzz tester.
> > > test-url: http://codemonkey.org.uk/projects/trinity/
> > >
> > >
> > > 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]>
> > >
> > >
> > > [ 558.756672][ T2642] WARNING: CPU: 0 PID: 2642 at kernel/ucount.c:268
> > > dec_rlimit_ucounts (kernel/ucount.c:268 (discriminator 1)) [
> > > 558.758020][ T2642] Modules linked in: uvesafb cfbfillrect cfbimgblt
> > > cfbcopyarea fb fbdev ppdev crc32_pclmul input_leds led_class intel_agp
> > > intel_gtt parport_pc parport qemu_fw_cfg [ 558.766247][ T2642] CPU: 0
> > > PID: 2642 Comm: trinity-main Not tainted 5.12.0-gd64696905554 #1 [
> > > 558.767543][ T2642] Hardware name: QEMU Standard PC (i440FX + PIIX,
> > > 1996), BIOS 1.12.0-1 04/01/2014 [ 558.772150][ T2642] EIP:
> > dec_rlimit_ucounts (kernel/ucount.c:268 (discriminator 1)) [ 558.772945][ T2642]
> > Code: 68 73 6c c3 01 83 15 6c 73 6c c3 00 85 c0 0f 94 c0 83 c4 04 5b 5e 5f 5d c3
> > 8d 76 00 83 05 50 73 6c c3 01 83 15 54 73 6c c3 00 <0f> 0b 83 05 58 73 6c c3 01
> > 83 15 5c 73 6c c3 00 eb 9d 8d b4 26 00 All code ========
> > > 0: 68 73 6c c3 01 pushq $0x1c36c73
> > > 5: 83 15 6c 73 6c c3 00 adcl $0x0,-0x3c938c94(%rip) #
> > 0xffffffffc36c7378
> > > c: 85 c0 test %eax,%eax
> > > e: 0f 94 c0 sete %al
> > > 11: 83 c4 04 add $0x4,%esp
> > > 14: 5b pop %rbx
> > > 15: 5e pop %rsi
> > > 16: 5f pop %rdi
> > > 17: 5d pop %rbp
> > > 18: c3 retq
> > > 19: 8d 76 00 lea 0x0(%rsi),%esi
> > > 1c: 83 05 50 73 6c c3 01 addl $0x1,-0x3c938cb0(%rip) #
> > 0xffffffffc36c7373
> > > 23: 83 15 54 73 6c c3 00 adcl $0x0,-0x3c938cac(%rip) #
> > 0xffffffffc36c737e
> > > 2a:* 0f 0b ud2 <-- trapping instruction
> > > 2c: 83 05 58 73 6c c3 01 addl $0x1,-0x3c938ca8(%rip) #
> > 0xffffffffc36c738b
> > > 33: 83 15 5c 73 6c c3 00 adcl $0x0,-0x3c938ca4(%rip) #
> > 0xffffffffc36c7396
> > > 3a: eb 9d jmp 0xffffffffffffffd9
> > > 3c: 8d .byte 0x8d
> > > 3d: b4 26 mov $0x26,%ah
> > > ...
> > >
> > > Code starting with the faulting instruction
> > > ===========================================
> > > 0: 0f 0b ud2
> > > 2: 83 05 58 73 6c c3 01 addl $0x1,-0x3c938ca8(%rip) #
> > 0xffffffffc36c7361
> > > 9: 83 15 5c 73 6c c3 00 adcl $0x0,-0x3c938ca4(%rip) #
> > 0xffffffffc36c736c
> > > 10: eb 9d jmp 0xffffffffffffffaf
> > > 12: 8d .byte 0x8d
> > > 13: b4 26 mov $0x26,%ah
> > > ...
> > > [ 558.779398][ T2642] EAX: f63271e0 EBX: f63271e0 ECX: 00000001 EDX:
> > > ffffffff [ 558.781206][ T2642] ESI: 0000003c EDI: ffffffff EBP:
> > > f62e3eac ESP: f62e3e9c [ 558.782613][ T2642] DS: 007b ES: 007b FS:
> > > 0000 GS: 0033 SS: 0068 EFLAGS: 00010246 [ 558.783747][ T2642] CR0:
> > > 80050033 CR2: 08082ff0 CR3: 362b0000 CR4: 00040690 [ 558.792353][ T2642]
> > Call Trace:
> > > [ 558.793036][ T2642] ? release_task (include/linux/rcupdate.h:654
> > > kernel/exit.c:191) [ 558.793936][ T2642] release_task
> > > (kernel/exit.c:191) [ 558.794818][ T2642] wait_task_zombie
> > > (kernel/exit.c:1107) [ 558.800667][ T2642] wait_consider_task
> > > (kernel/exit.c:1334) [ 558.801693][ T2642] ? _raw_read_lock
> > > (include/linux/rwlock_api_smp.h:149 kernel/locking/spinlock.c:223) [
> > > 558.802645][ T2642] do_wait (kernel/exit.c:1399 kernel/exit.c:1468) [
> > > 558.803462][ T2642] kernel_wait4 (kernel/exit.c:1630) [ 558.806901][
> > > T2642] ? kill_orphaned_pgrp (kernel/exit.c:1422) [ 558.808347][ T2642]
> > > __ia32_sys_waitpid (kernel/exit.c:1675 kernel/exit.c:1673
> > > kernel/exit.c:1673) [ 558.809338][ T2642] do_int80_syscall_32
> > > (arch/x86/entry/common.c:77 arch/x86/entry/common.c:94) [ 558.810319][
> > > T2642] entry_INT80_32 (arch/x86/entry/entry_32.S:1064) [ 558.811254][
> > > T2642] EIP: 0x809b132 [ 558.815723][ T2642] Code: 89 c8 c3 90 8d 74 26
> > > 00 85 c0 c7 01 01 00 00 00 75 d8 a1 6c 94 a8 08 eb d1 66 90 66 90 66 90 66 90
> > 66 90 66 90 66 90 90 cd 80 <c3> 8d b6 00 00 00 00 8d bc 27 00 00 00 00 8b 10 a3
> > 94 94 a8 08 85 All code ========
> > > 0: 89 c8 mov %ecx,%eax
> > > 2: c3 retq
> > > 3: 90 nop
> > > 4: 8d 74 26 00 lea 0x0(%rsi,%riz,1),%esi
> > > 8: 85 c0 test %eax,%eax
> > > a: c7 01 01 00 00 00 movl $0x1,(%rcx)
> > > 10: 75 d8 jne 0xffffffffffffffea
> > > 12: a1 6c 94 a8 08 eb d1 movabs 0x9066d1eb08a8946c,%eax
> > > 19: 66 90
> > > 1b: 66 90 xchg %ax,%ax
> > > 1d: 66 90 xchg %ax,%ax
> > > 1f: 66 90 xchg %ax,%ax
> > > 21: 66 90 xchg %ax,%ax
> > > 23: 66 90 xchg %ax,%ax
> > > 25: 66 90 xchg %ax,%ax
> > > 27: 90 nop
> > > 28: cd 80 int $0x80
> > > 2a:* c3 retq <-- trapping instruction
> > > 2b: 8d b6 00 00 00 00 lea 0x0(%rsi),%esi
> > > 31: 8d bc 27 00 00 00 00 lea 0x0(%rdi,%riz,1),%edi
> > > 38: 8b 10 mov (%rax),%edx
> > > 3a: a3 .byte 0xa3
> > > 3b: 94 xchg %eax,%esp
> > > 3c: 94 xchg %eax,%esp
> > > 3d: a8 08 test $0x8,%al
> > > 3f: 85 .byte 0x85
> > >
> > > Code starting with the faulting instruction
> > > ===========================================
> > > 0: c3 retq
> > > 1: 8d b6 00 00 00 00 lea 0x0(%rsi),%esi
> > > 7: 8d bc 27 00 00 00 00 lea 0x0(%rdi,%riz,1),%edi
> > > e: 8b 10 mov (%rax),%edx
> > > 10: a3 .byte 0xa3
> > > 11: 94 xchg %eax,%esp
> > > 12: 94 xchg %eax,%esp
> > > 13: a8 08 test $0x8,%al
> > > 15: 85 .byte 0x85
> > > [ 558.820109][ T2642] EAX: ffffffda EBX: 00000f0f ECX: bfb23394 EDX:
> > > 0000000b [ 558.821480][ T2642] ESI: 00000002 EDI: 08a890fc EBP:
> > > 08a89034 ESP: bfb23364 [ 558.822693][ T2642] DS: 007b ES: 007b FS:
> > > 0000 GS: 0033 SS: 007b EFLAGS: 00000246 [ 558.828056][ T2642] irq
> > > event stamp: 1348273 [ 558.828922][ T2642] hardirqs last enabled at
> > > (1348281): console_unlock (kernel/printk/printk.c:2605 (discriminator
> > > 1)) [ 558.830629][ T2642] hardirqs last disabled at (1348288):
> > > console_unlock (kernel/printk/printk.c:2520 (discriminator 1)) [
> > > 558.833190][ T2642] softirqs last enabled at (1348240): __do_softirq
> > > (kernel/softirq.c:372) [ 558.834715][ T2642] softirqs last disabled at
> > > (1348231): do_softirq_own_stack (arch/x86/kernel/irq_32.c:60
> > > arch/x86/kernel/irq_32.c:149) [ 558.840026][ T2642] ---[ end trace
> > > 6bbb25560ce8d9b6 ]---
> > >
> > >
> > > To reproduce:
> > >
> > > # build kernel
> > > cd linux
> > > cp config-5.12.0-gd64696905554 .config
> > > make HOSTCC=gcc-9 CC=gcc-9 ARCH=i386 olddefconfig prepare
> > > modules_prepare bzImage
> > >
> > > git clone https://github.com/intel/lkp-tests.git
> > > cd lkp-tests
> > > bin/lkp qemu -k <bzImage> job-script # job-script is attached
> > > in this email
> >
> > I am unable to run the test following this instruction.
>
> After double check, we can reproduce this issue, could you kindly offer your full log and the reproducing steps?
Sure. Here is what i did:
$ grep PRETTY_NAME /etc/os-release
PRETTY_NAME="Fedora 34 (Workstation Edition)"
$ git clone git://git.kernel.org/pub/scm/linux/kernel/git/torvalds/linux.git
$ cd linux
$ git describe
v5.15-rc1-19-g3ca706c189db
$ cp /tmp/config-5.12.0-gd64696905554 .config
$ make -j8 ARCH=i386 olddefconfig prepare modules_prepare bzImage
...
Kernel: arch/x86/boot/bzImage is ready (#2)
$ git clone https://github.com/intel/lkp-tests.git
$ cd lkp-tests
$ git describe --always
64ef6f2b
$ bin/lkp qemu -k ../arch/x86/boot/bzImage ../job-script
The approx. disk space requirements are
10M simple boot test in rootfs openwrt
50M simple boot test in rootfs debian
1G plan to run a number of different tests
100G or more IO tests
Please enter a dir with enough disk space, or simply press Enter to accept the default.
You may still symlink /home/legion/.lkp to a more suitable place in future.
/home/legion/.lkp =>
~/scm/kernel/linux/lkp-tests/pkg/lkp-src ~/scm/kernel/linux/lkp-tests
x86_64
==> Making package: lkp-src 0-1 (Ср 15 сен 2021 13:11:17 CEST)
==> Checking runtime dependencies...
==> Checking buildtime dependencies...
==> WARNING: Using existing $srcdir/ tree
==> Removing existing $pkgdir/ directory...
==> Starting build()...
make: Entering directory '/home/legion/scm/kernel/linux/lkp-tests/bin/event'
gcc -m32 -Wl,-O1,--sort-common,--as-needed,-z,relro -static -o wakeup wakeup.o
rm -f wakeup.o
strip wakeup
strip: wakeup[.gnu.build.attributes__libc_freeres_fn]: Warning: version note missing - assuming version 3
make: Leaving directory '/home/legion/scm/kernel/linux/lkp-tests/bin/event'
==> Entering fakeroot environment...
x86_64
==> Starting package()...
==> Creating package "lkp-src"...
8808 blocks
renamed '/home/legion/.lkp/cache/lkp-i386.cgz.tmp' -> '/home/legion/.lkp/cache/lkp-i386.cgz'
==> Leaving fakeroot environment.
==> Finished making: lkp-src 0-1 (Ср 15 сен 2021 13:16:19 CEST)
~/scm/kernel/linux/lkp-tests
11 blocks
result_root: /home/legion/.lkp//result/trinity/group-02-99999/vm-snb/yocto-i386-minimal-20190520.cgz/i386-randconfig-r015-20210910/gcc-9/d64696905554e919321e31afc210606653b8f6a4/0
downloading initrds ...
/usr/bin/wget -q --timeout=1800 --tries=1 --local-encoding=UTF-8 https://download.01.org/0day-ci/lkp-qemu/osimage/yocto/yocto-i386-minimal-20190520.cgz -N -P /home/legion/.lkp/cache/osimage/yocto
17916 blocks
/usr/bin/wget -q --timeout=1800 --tries=1 --local-encoding=UTF-8 https://download.01.org/0day-ci/lkp-qemu/osimage/pkg/yocto-i386-minimal-20190520.cgz/trinity-i386.cgz -N -P /home/legion/.lkp/cache/osimage/pkg/yocto-i386-minimal-20190520.cgz
46817 blocks
exec command: qemu-system-x86_64 -enable-kvm -fsdev local,id=test_dev,path=/home/legion/.lkp//result/trinity/group-02-99999/vm-snb/yocto-i386-minimal-20190520.cgz/i386-randconfig-r015-20210910/gcc-9/d64696905554e919321e31afc210606653b8f6a4/0,security_model=none -device virtio-9p-pci,fsdev=test_dev,mount_tag=9p/virtfs_mount -kernel ../arch/x86/boot/bzImage -append root=/dev/ram0 user=$(whoami) job=/lkp/jobs/scheduled/vm-snb-43/trinity-group-02-99999-yocto-i386-minimal-20190520.cgz-d64696905554e919321e31afc210606653b8f6a4-20210911-24127-1x1tp2w-8.yaml ARCH=i386 kconfig=i386-randconfig-r015-20210910 branch=trace/ftrace/core commit=d64696905554e919321e31afc210606653b8f6a4 BOOT_IMAGE=/pkg/linux/i386-randconfig-r015-20210910/gcc-9/d64696905554e919321e31afc210606653b8f6a4/vmlinuz-5.12.0-gd64696905554 vmalloc=128M initramfs_async=0 page_owner=on max_uptime=2100 RESULT_ROOT=/result/trinity/group-02-99999/vm-snb/yocto-i386-minimal-20190520.cgz/i386-randconfig-r015-20210910/gcc-9/d64696905554e919321e31afc210606653b8f6a4/8 LKP_LOCAL_RUN=1 selinux=0 debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 net.ifnames=0 printk.devkmsg=on panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 drbd.minor_count=8 systemd.log_level=err ignore_loglevel console=tty0 earlyprintk=ttyS0,115200 console=ttyS0,115200 vga=normal rw ip=dhcp result_service=9p/virtfs_mount -initrd /home/legion/.lkp/cache/final_initrd -smp 2 -m 5390M -no-reboot -watchdog i6300esb -rtc base=localtime -device e1000,netdev=net0 -netdev user,id=net0 -display none -monitor null -serial stdio
early console in setup code
Probing EDD (edd=off to disable)... ok
[ 0.000000] Linux version 5.15.0-rc1+ ([email protected]) (gcc (GCC) 11.1.1 20210531 (Red Hat 11.1.1-3), GNU ld version 2.35.1-41.fc34) #2 SMP Wed Sep 15 13:03:08 CEST 2021
[ 0.000000] x86/fpu: x87 FPU will use FXSAVE
[ 0.000000] signal: max sigframe size: 1440
[ 0.000000] BIOS-provided physical RAM map:
[ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
[ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
[ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
[ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bffdffff] usable
[ 0.000000] BIOS-e820: [mem 0x00000000bffe0000-0x00000000bfffffff] reserved
[ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
[ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
[ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x0000000190dfffff] usable
[ 0.000000] printk: debug: ignoring loglevel setting.
[ 0.000000] printk: bootconsole [earlyser0] enabled
[ 0.000000] Notice: NX (Execute Disable) protection cannot be enabled: non-PAE kernel!
[ 0.000000] SMBIOS 2.8 present.
[ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.14.0-4.fc34 04/01/2014
[ 0.000000] Hypervisor detected: KVM
[ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
[ 0.000000] kvm-clock: cpu 0, msr 10818001, primary cpu clock
[ 0.000002] kvm-clock: using sched offset of 247343709 cycles
[ 0.000856] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
[ 0.003174] tsc: Detected 2593.994 MHz processor
[ 0.004586] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[ 0.005496] e820: remove [mem 0x000a0000-0x000fffff] usable
[ 0.006318] last_pfn = 0xbffe0 max_arch_pfn = 0x100000
[ 0.007096] x86/PAT: PAT not supported by the CPU.
[ 0.007789] x86/PAT: Configuration [0-7]: WB WT UC- UC WB WT UC- UC
[ 0.008817] Scan for SMP in [mem 0x00000000-0x000003ff]
[ 0.009606] Scan for SMP in [mem 0x0009fc00-0x0009ffff]
[ 0.010348] Scan for SMP in [mem 0x000f0000-0x000fffff]
[ 0.014307] found SMP MP-table at [mem 0x000f5c80-0x000f5c8f]
[ 0.015120] mpc: f5c90-f5d7c
[ 0.015524] initial memory mapped: [mem 0x00000000-0x10bfffff]
[ 0.016384] RAMDISK: [mem 0x7f97e000-0x7fffffff]
[ 0.017080] Allocated new RAMDISK: [mem 0x3617c000-0x367fdbe9]
[ 0.021514] Move RAMDISK from [mem 0x7f97e000-0x7ffffbe9] to [mem 0x3617c000-0x367fdbe9]
[ 0.022741] ACPI: Early table checksum verification disabled
[ 0.023589] ACPI: RSDP 0x00000000000F5A60 000014 (v00 BOCHS )
[ 0.024427] ACPI: RSDT 0x00000000BFFE15AB 000034 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001)
[ 0.025704] ACPI: FACP 0x00000000BFFE1457 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001)
[ 0.026839] ACPI: DSDT 0x00000000BFFE0040 001417 (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001)
[ 0.028102] ACPI: FACS 0x00000000BFFE0000 000040
[ 0.028758] ACPI: APIC 0x00000000BFFE14CB 000080 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001)
[ 0.029967] ACPI: HPET 0x00000000BFFE154B 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001)
[ 0.031216] ACPI: WAET 0x00000000BFFE1583 000028 (v01 BOCHS BXPCWAET 00000001 BXPC 00000001)
[ 0.032382] ACPI: Reserving FACP table memory at [mem 0xbffe1457-0xbffe14ca]
[ 0.033398] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe1456]
[ 0.034362] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f]
[ 0.035370] ACPI: Reserving APIC table memory at [mem 0xbffe14cb-0xbffe154a]
[ 0.036258] ACPI: Reserving HPET table memory at [mem 0xbffe154b-0xbffe1582]
[ 0.037266] ACPI: Reserving WAET table memory at [mem 0xbffe1583-0xbffe15aa]
[ 0.038257] mapped APIC to ffffb000 ( fee00000)
[ 0.039083] 2199MB HIGHMEM available.
[ 0.039560] 871MB LOWMEM available.
[ 0.040074] mapped low ram: 0 - 367fe000
[ 0.040631] low ram: 0 - 367fe000
[ 0.045476] Zone ranges:
[ 0.045863] DMA [mem 0x0000000000001000-0x0000000000ffffff]
[ 0.046766] Normal [mem 0x0000000001000000-0x00000000367fdfff]
[ 0.047642] HighMem [mem 0x00000000367fe000-0x00000000bffdffff]
[ 0.048551] Movable zone start for each node
[ 0.049125] Early memory node ranges
[ 0.049574] node 0: [mem 0x0000000000001000-0x000000000009efff]
[ 0.050454] node 0: [mem 0x0000000000100000-0x00000000bffdffff]
[ 0.051376] Initmem setup node 0 [mem 0x0000000000001000-0x00000000bffdffff]
[ 0.052390] On node 0, zone DMA: 1 pages in unavailable ranges
[ 0.052449] On node 0, zone DMA: 97 pages in unavailable ranges
[ 0.064385] On node 0, zone HighMem: 32 pages in unavailable ranges
[ 0.065265] Using APIC driver default
[ 0.067043] ACPI: PM-Timer IO Port: 0x608
[ 0.067641] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
[ 0.068456] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
[ 0.069426] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[ 0.070328] Int: type 0, pol 0, trig 0, bus 00, IRQ 00, APIC ID 0, APIC INT 02
[ 0.071352] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
[ 0.072303] Int: type 0, pol 1, trig 3, bus 00, IRQ 05, APIC ID 0, APIC INT 05
[ 0.073328] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[ 0.074194] Int: type 0, pol 1, trig 3, bus 00, IRQ 09, APIC ID 0, APIC INT 09
[ 0.075147] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
[ 0.076073] Int: type 0, pol 1, trig 3, bus 00, IRQ 0a, APIC ID 0, APIC INT 0a
[ 0.077122] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
[ 0.078099] Int: type 0, pol 1, trig 3, bus 00, IRQ 0b, APIC ID 0, APIC INT 0b
[ 0.079079] Int: type 0, pol 0, trig 0, bus 00, IRQ 01, APIC ID 0, APIC INT 01
[ 0.080105] Int: type 0, pol 0, trig 0, bus 00, IRQ 03, APIC ID 0, APIC INT 03
[ 0.081120] Int: type 0, pol 0, trig 0, bus 00, IRQ 04, APIC ID 0, APIC INT 04
[ 0.082136] Int: type 0, pol 0, trig 0, bus 00, IRQ 06, APIC ID 0, APIC INT 06
[ 0.083165] Int: type 0, pol 0, trig 0, bus 00, IRQ 07, APIC ID 0, APIC INT 07
[ 0.084167] Int: type 0, pol 0, trig 0, bus 00, IRQ 08, APIC ID 0, APIC INT 08
[ 0.085124] Int: type 0, pol 0, trig 0, bus 00, IRQ 0c, APIC ID 0, APIC INT 0c
[ 0.086156] Int: type 0, pol 0, trig 0, bus 00, IRQ 0d, APIC ID 0, APIC INT 0d
[ 0.087124] Int: type 0, pol 0, trig 0, bus 00, IRQ 0e, APIC ID 0, APIC INT 0e
[ 0.088193] Int: type 0, pol 0, trig 0, bus 00, IRQ 0f, APIC ID 0, APIC INT 0f
[ 0.089185] ACPI: Using ACPI (MADT) for SMP configuration information
[ 0.090090] ACPI: HPET id: 0x8086a201 base: 0xfed00000
[ 0.090862] smpboot: Allowing 2 CPUs, 0 hotplug CPUs
[ 0.091529] mapped IOAPIC to ffffa000 (fec00000)
[ 0.092172] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]
[ 0.093235] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x0009ffff]
[ 0.094346] PM: hibernation: Registered nosave memory: [mem 0x000a0000-0x000effff]
[ 0.095428] PM: hibernation: Registered nosave memory: [mem 0x000f0000-0x000fffff]
[ 0.096474] [mem 0xc0000000-0xfeffbfff] available for PCI devices
[ 0.097274] Booting paravirtualized kernel on KVM
[ 0.097927] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
[ 0.099382] setup_percpu: NR_CPUS:8 nr_cpumask_bits:8 nr_cpu_ids:2 nr_node_ids:1
[ 0.100454] percpu: Embedded 32 pages/cpu s99276 r0 d31796 u131072
[ 0.101331] pcpu-alloc: s99276 r0 d31796 u131072 alloc=32*4096
[ 0.102151] pcpu-alloc: [0] 0 [0] 1
[ 0.102653] kvm-guest: stealtime: cpu 0, msr 36147a40
[ 0.103411] kvm-guest: PV spinlocks disabled, no host support
[ 0.104247] Built 1 zonelists, mobility grouping on. Total pages: 784122
[ 0.105201] Kernel command line: root=/dev/ram0 user=$(whoami) job=/lkp/jobs/scheduled/vm-snb-43/trinity-group-02-99999-yocto-i386-minimal-20190520.cgz-d64696905554e919321e31afc210606653b8f6a4-20210911-24127-1x1tp2w-8.yaml ARCH=i386 kconfig=i386-randconfig-r015-20210910 branch=trace/ftrace/core commit=d64696905554e919321e31afc210606653b8f6a4 BOOT_IMAGE=/pkg/linux/i386-randconfig-r015-20210910/gcc-9/d64696905554e919321e31afc210606653b8f6a4/vmlinuz-5.12.0-gd64696905554 vmalloc=128M initramfs_async=0 page_owner=on max_uptime=2100 RESULT_ROOT=/result/trinity/group-02-99999/vm-snb/yocto-i386-minimal-20190520.cgz/i386-randconfig-r015-20210910/gcc-9/d64696905554e919321e31afc210606653b8f6a4/8 LKP_LOCAL_RUN=1 selinux=0 debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 net.ifnames=0 printk.devkmsg=on panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 drbd.minor_count=8 systemd.log_level=err ignore_loglevel console=tty0 earlyprintk=ttyS
[ 0.105625] sysrq: sysrq always enabled.
[ 0.119255] ignoring the deprecated load_ramdisk= option
[ 0.120230] Unknown command line parameters: user=$(whoami) job=/lkp/jobs/scheduled/vm-snb-43/trinity-group-02-99999-yocto-i386-minimal-20190520.cgz-d64696905554e919321e31afc210606653b8f6a4-20210911-24127-1x1tp2w-8.yaml ARCH=i386 kconfig=i386-randconfig-r015-20210910 branch=trace/ftrace/core commit=d64696905554e919321e31afc210606653b8f6a4 BOOT_IMAGE=/pkg/linux/i386-randconfig-r015-20210910/gcc-9/d64696905554e919321e31afc210606653b8f6a4/vmlinuz-5.12.0-gd64696905554 max_uptime=2100 RESULT_ROOT=/result/trinity/group-02-99999/vm-snb/yocto-i386-minimal-20190520.cgz/i386-randconfig-r015-20210910/gcc-9/d64696905554e919321e31afc210606653b8f6a4/8 LKP_LOCAL_RUN=1 softlockup_panic=1 prompt_ramdisk=0 vga=normal ip=dhcp result_service=9p/virtfs_mount
[ 0.129916] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear)
[ 0.131086] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear)
[ 0.132185] mem auto-init: stack:off, heap alloc:off, heap free:off
[ 0.134089] Initializing HighMem for node 0 (000367fe:000bffe0)
[ 0.216658] Initializing Movable for node 0 (00000000:00000000)
[ 0.219183] Checking if this processor honours the WP bit even in supervisor mode...Ok.
[ 0.220375] Memory: 3076340K/3145208K available (12370K kernel code, 1901K rwdata, 9072K rodata, 1076K init, 840K bss, 68868K reserved, 0K cma-reserved, 2252680K highmem)
[ 0.222620] random: get_random_u32 called from __kmem_cache_create+0x23/0x540 with crng_init=0
[ 0.222950] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
[ 0.225214] ftrace: allocating 43733 entries in 86 pages
[ 0.240068] ftrace: allocated 86 pages with 4 groups
[ 0.240825] trace event string verifier disabled
[ 0.241732] rcu: Hierarchical RCU implementation.
[ 0.242375] rcu: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=2.
[ 0.243319] RCU CPU stall warnings timeout set to 100 (rcu_cpu_stall_timeout).
[ 0.244382] Trampoline variant of Tasks RCU enabled.
[ 0.245116] Rude variant of Tasks RCU enabled.
[ 0.245786] Tracing variant of Tasks RCU enabled.
[ 0.246507] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
[ 0.247651] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
[ 0.254529] NR_IRQS: 2304, nr_irqs: 440, preallocated irqs: 16
[ 0.273395] Console: colour VGA+ 80x25
[ 0.325543] printk: console [tty0] enabled
[ 0.326385] printk: console [ttyS0] enabled
[ 0.326385] printk: console [ttyS0] enabled
[ 0.327855] printk: bootconsole [earlyser0] disabled
[ 0.327855] printk: bootconsole [earlyser0] disabled
[ 0.329521] ACPI: Core revision 20210730
[ 0.330469] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
[ 0.332345] APIC: Switch to symmetric I/O mode setup
[ 0.333394] Enabling APIC mode: Flat. Using 1 I/O APICs
[ 0.334576] masked ExtINT on CPU#0
[ 0.336162] ENABLING IO-APIC IRQs
[ 0.336899] init IO_APIC IRQs
[ 0.337572] apic 0 pin 0 not connected
[ 0.338387] IOAPIC[0]: Preconfigured routing entry (0-1 -> IRQ 1 Level:0 ActiveLow:0)
[ 0.339909] IOAPIC[0]: Preconfigured routing entry (0-2 -> IRQ 0 Level:0 ActiveLow:0)
[ 0.341474] IOAPIC[0]: Preconfigured routing entry (0-3 -> IRQ 3 Level:0 ActiveLow:0)
[ 0.343019] IOAPIC[0]: Preconfigured routing entry (0-4 -> IRQ 4 Level:0 ActiveLow:0)
[ 0.344544] IOAPIC[0]: Preconfigured routing entry (0-5 -> IRQ 5 Level:1 ActiveLow:0)
[ 0.346058] IOAPIC[0]: Preconfigured routing entry (0-6 -> IRQ 6 Level:0 ActiveLow:0)
[ 0.347634] IOAPIC[0]: Preconfigured routing entry (0-7 -> IRQ 7 Level:0 ActiveLow:0)
[ 0.349221] IOAPIC[0]: Preconfigured routing entry (0-8 -> IRQ 8 Level:0 ActiveLow:0)
[ 0.350788] IOAPIC[0]: Preconfigured routing entry (0-9 -> IRQ 9 Level:1 ActiveLow:0)
[ 0.352295] IOAPIC[0]: Preconfigured routing entry (0-10 -> IRQ 10 Level:1 ActiveLow:0)
[ 0.353912] IOAPIC[0]: Preconfigured routing entry (0-11 -> IRQ 11 Level:1 ActiveLow:0)
[ 0.355484] IOAPIC[0]: Preconfigured routing entry (0-12 -> IRQ 12 Level:0 ActiveLow:0)
[ 0.357066] IOAPIC[0]: Preconfigured routing entry (0-13 -> IRQ 13 Level:0 ActiveLow:0)
[ 0.358652] IOAPIC[0]: Preconfigured routing entry (0-14 -> IRQ 14 Level:0 ActiveLow:0)
[ 0.360247] IOAPIC[0]: Preconfigured routing entry (0-15 -> IRQ 15 Level:0 ActiveLow:0)
[ 0.361853] apic 0 pin 16 not connected
[ 0.362661] apic 0 pin 17 not connected
[ 0.363464] apic 0 pin 18 not connected
[ 0.364250] apic 0 pin 19 not connected
[ 0.365094] apic 0 pin 20 not connected
[ 0.365915] apic 0 pin 21 not connected
[ 0.366715] apic 0 pin 22 not connected
[ 0.367519] apic 0 pin 23 not connected
[ 0.368427] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[ 0.369673] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x256412811b4, max_idle_ns: 440795306987 ns
[ 0.371716] Calibrating delay loop (skipped) preset value.. 5187.98 BogoMIPS (lpj=2593994)
[ 0.372714] pid_max: default: 32768 minimum: 301
[ 0.373612] LSM: Security Framework initializing
[ 0.373723] Yama: becoming mindful.
[ 0.374724] LSM support for eBPF active
[ 0.375716] landlock: Up and running.
[ 0.376725] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
[ 0.377715] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
Poking KASLR using RDTSC...
[ 0.379760] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[ 0.380714] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
[ 0.381717] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
[ 0.382717] Spectre V2 : Mitigation: Full generic retpoline
[ 0.383714] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
[ 0.384714] Speculative Store Bypass: Vulnerable
[ 0.385714] L1TF: Kernel not compiled for PAE. No mitigation for L1TF
[ 0.386716] MDS: Vulnerable: Clear CPU buffers attempted, no microcode
[ 0.389800] Freeing SMP alternatives memory: 40K
[ 0.390781] Using local APIC timer interrupts.
[ 0.390781] calibrating APIC timer ...
[ 0.494491] ... lapic delta = 6250028
[ 0.494712] ... PM-Timer delta = 357953
[ 0.494712] ... PM-Timer result ok
[ 0.494712] ..... delta 6250028
[ 0.494712] ..... mult: 268435456
[ 0.494712] ..... calibration result: 1000004
[ 0.494712] ..... CPU clock speed is 2593.0965 MHz.
[ 0.494712] ..... host bus clock speed is 1000.0004 MHz.
[ 0.494760] smpboot: CPU0: Intel QEMU Virtual CPU version 2.5+ (family: 0x6, model: 0x6, stepping: 0x3)
[ 0.495822] Performance Events: PMU not available due to virtualization, using software events only.
[ 0.496745] rcu: Hierarchical SRCU implementation.
[ 0.497945] NMI watchdog: Perf NMI watchdog permanently disabled
[ 0.498759] smp: Bringing up secondary CPUs ...
[ 0.499790] x86: Booting SMP configuration:
[ 0.500715] .... node #0, CPUs: #1
[ 0.113149] kvm-clock: cpu 1, msr 10818021, secondary cpu clock
[ 0.113149] masked ExtINT on CPU#1
[ 0.113149] smpboot: CPU 1 Converting physical 0 to logical die 1
[ 0.504730] kvm-guest: stealtime: cpu 1, msr 36167a40
[ 0.506757] smp: Brought up 1 node, 2 CPUs
[ 0.507715] smpboot: Max logical packages: 2
[ 0.508714] smpboot: Total of 2 processors activated (10375.97 BogoMIPS)
[ 0.518115] allocated 31457280 bytes of page_ext
[ 0.518781] Node 0, zone DMA: page owner found early allocated 0 pages
[ 0.521199] Node 0, zone Normal: page owner found early allocated 8326 pages
[ 0.522727] Node 0, zone HighMem: page owner found early allocated 63 pages
[ 0.523792] devtmpfs: initialized
[ 0.525970] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
[ 0.526718] futex hash table entries: 512 (order: 2, 16384 bytes, linear)
[ 0.527763] pinctrl core: initialized pinctrl subsystem
[ 0.528844] PM: RTC time: 13:16:34, date: 2021-09-15
[ 0.529859] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[ 0.532088] audit: initializing netlink subsys (disabled)
[ 0.532748] audit: type=2000 audit(1631704594.860:1): state=initialized audit_enabled=0 res=1
[ 0.532882] thermal_sys: Registered thermal governor 'fair_share'
[ 0.533716] thermal_sys: Registered thermal governor 'bang_bang'
[ 0.534715] thermal_sys: Registered thermal governor 'step_wise'
[ 0.535715] thermal_sys: Registered thermal governor 'user_space'
[ 0.536727] cpuidle: using governor menu
[ 0.539187] ACPI: bus type PCI registered
[ 0.539715] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
[ 0.540876] PCI: PCI BIOS revision 2.10 entry at 0xfd1b8, last bus=0
[ 0.541716] PCI: Using configuration type 1 for base access
[ 0.544343] Kprobes globally optimized
[ 0.544778] HugeTLB registered 4.00 MiB page size, pre-allocated 0 pages
[ 1.232030] cryptd: max_cpu_qlen set to 1000
[ 1.236954] alg: No test for 842 (842-generic)
[ 1.237743] alg: No test for 842 (842-scomp)
[ 1.252185] DRBG: Continuing without Jitter RNG
[ 1.282782] raid6: skip pq benchmark and using algorithm sse2x2
[ 1.283719] raid6: using intx1 recovery algorithm
[ 1.284764] ACPI: Added _OSI(Module Device)
[ 1.285716] ACPI: Added _OSI(Processor Device)
[ 1.286718] ACPI: Added _OSI(3.0 _SCP Extensions)
[ 1.287715] ACPI: Added _OSI(Processor Aggregator Device)
[ 1.288717] ACPI: Added _OSI(Linux-Dell-Video)
[ 1.289715] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
[ 1.290715] ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics)
[ 1.292174] ACPI: 1 ACPI AML tables successfully acquired and loaded
[ 1.294348] ACPI: Interpreter enabled
[ 1.294728] ACPI: PM: (supports S0 S3 S4 S5)
[ 1.295715] ACPI: Using IOAPIC for interrupt routing
[ 1.296727] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[ 1.297810] ACPI: Enabled 2 GPEs in block 00 to 0F
[ 1.300466] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[ 1.300718] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI EDR HPX-Type3]
[ 1.301719] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
[ 1.302721] acpi resource window ([0x1c0000000-0x23fffffff] ignored, not CPU addressable)
[ 1.303916] acpiphp: Slot [3] registered
[ 1.304731] acpiphp: Slot [4] registered
[ 1.305730] acpiphp: Slot [5] registered
[ 1.306489] acpiphp: Slot [6] registered
[ 1.306733] acpiphp: Slot [7] registered
[ 1.307733] acpiphp: Slot [8] registered
[ 1.308730] acpiphp: Slot [9] registered
[ 1.309730] acpiphp: Slot [10] registered
[ 1.310568] acpiphp: Slot [11] registered
[ 1.310730] acpiphp: Slot [12] registered
[ 1.311730] acpiphp: Slot [13] registered
[ 1.312730] acpiphp: Slot [14] registered
[ 1.313730] acpiphp: Slot [15] registered
[ 1.314723] acpiphp: Slot [16] registered
[ 1.315577] acpiphp: Slot [17] registered
[ 1.315732] acpiphp: Slot [18] registered
[ 1.316730] acpiphp: Slot [19] registered
[ 1.317730] acpiphp: Slot [20] registered
[ 1.318729] acpiphp: Slot [21] registered
[ 1.319526] acpiphp: Slot [22] registered
[ 1.319730] acpiphp: Slot [23] registered
[ 1.320737] acpiphp: Slot [24] registered
[ 1.321732] acpiphp: Slot [25] registered
[ 1.322732] acpiphp: Slot [26] registered
[ 1.323733] acpiphp: Slot [27] registered
[ 1.324750] acpiphp: Slot [28] registered
[ 1.325733] acpiphp: Slot [29] registered
[ 1.327716] acpiphp: Slot [30] registered
[ 1.328732] acpiphp: Slot [31] registered
[ 1.329725] PCI host bridge to bus 0000:00
[ 1.330715] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
[ 1.331715] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
[ 1.332715] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[ 1.333715] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]
[ 1.334715] pci_bus 0000:00: root bus resource [bus 00-ff]
[ 1.335805] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
[ 1.337132] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
[ 1.338223] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
[ 1.340912] pci 0000:00:01.1: reg 0x20: [io 0xc080-0xc08f]
[ 1.343171] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
[ 1.343715] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6]
[ 1.344717] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
[ 1.345715] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376]
[ 1.346958] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
[ 1.348085] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI
[ 1.348723] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB
[ 1.349953] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000
[ 1.351733] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref]
[ 1.354732] pci 0000:00:02.0: reg 0x18: [mem 0xfebf0000-0xfebf0fff]
[ 1.360734] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref]
[ 1.362913] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200
[ 1.364715] pci 0000:00:03.0: reg 0x10: [io 0xc000-0xc03f]
[ 1.366715] pci 0000:00:03.0: reg 0x14: [mem 0xfebf1000-0xfebf1fff]
[ 1.370716] pci 0000:00:03.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref]
[ 1.373770] pci 0000:00:04.0: [8086:100e] type 00 class 0x020000
[ 1.375715] pci 0000:00:04.0: reg 0x10: [mem 0xfebc0000-0xfebdffff]
[ 1.377982] pci 0000:00:04.0: reg 0x14: [io 0xc040-0xc07f]
[ 1.383054] pci 0000:00:04.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref]
[ 1.383965] pci 0000:00:05.0: [8086:25ab] type 00 class 0x088000
[ 1.385991] pci 0000:00:05.0: reg 0x10: [mem 0xfebf2000-0xfebf200f]
[ 1.389365] pci_bus 0000:00: on NUMA node 0
[ 1.390854] ACPI: PCI: Interrupt link LNKA configured for IRQ 10
[ 1.392813] ACPI: PCI: Interrupt link LNKB configured for IRQ 10
[ 1.393809] ACPI: PCI: Interrupt link LNKC configured for IRQ 11
[ 1.394806] ACPI: PCI: Interrupt link LNKD configured for IRQ 11
[ 1.396713] ACPI: PCI: Interrupt link LNKS configured for IRQ 9
[ 1.398072] iommu: Default domain type: Translated
[ 1.398715] iommu: DMA domain TLB invalidation policy: lazy mode
[ 1.399790] pci 0000:00:02.0: vgaarb: setting as boot VGA device
[ 1.400712] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
[ 1.400716] pci 0000:00:02.0: vgaarb: bridge control possible
[ 1.401715] vgaarb: loaded
[ 1.402643] SCSI subsystem initialized
[ 1.403744] libata version 3.00 loaded.
[ 1.404758] ACPI: bus type USB registered
[ 1.405742] usbcore: registered new interface driver usbfs
[ 1.406731] usbcore: registered new interface driver hub
[ 1.408717] usbcore: registered new device driver usb
[ 1.409750] pps_core: LinuxPPS API ver. 1 registered
[ 1.410714] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <[email protected]>
[ 1.411718] PTP clock support registered
[ 1.412766] EDAC MC: Ver: 3.0.0
[ 1.414938] NetLabel: Initializing
[ 1.415715] NetLabel: domain hash size = 128
[ 1.416714] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO
[ 1.417734] NetLabel: unlabeled traffic allowed by default
[ 1.418722] PCI: Using ACPI for IRQ routing
[ 1.419715] PCI: pci_cache_line_size set to 64 bytes
[ 1.420823] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
[ 1.421719] e820: reserve RAM buffer [mem 0xbffe0000-0xbfffffff]
[ 1.423811] hpet: 3 channels of 0 reserved for per-cpu timers
[ 1.424731] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
[ 1.425714] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
[ 1.432769] clocksource: Switched to clocksource kvm-clock
[ 1.450889] VFS: Disk quotas dquot_6.6.0
[ 1.451842] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[ 1.453453] pnp: PnP ACPI init
[ 1.454285] pnp 00:02: [dma 2]
[ 1.455285] pnp: PnP ACPI: found 6 devices
[ 1.491745] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[ 1.493617] NET: Registered PF_INET protocol family
[ 1.494694] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
[ 1.496491] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144 bytes, linear)
[ 1.498309] TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear)
[ 1.499923] TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear)
[ 1.501431] TCP: Hash tables configured (established 8192 bind 8192)
[ 1.502821] MPTCP token hash table entries: 1024 (order: 2, 16384 bytes, linear)
[ 1.504415] UDP hash table entries: 512 (order: 2, 16384 bytes, linear)
[ 1.505808] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear)
[ 1.507313] NET: Registered PF_UNIX/PF_LOCAL protocol family
[ 1.508519] NET: Registered PF_XDP protocol family
[ 1.509557] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]
[ 1.510849] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]
[ 1.512086] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
[ 1.513538] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window]
[ 1.514980] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[ 1.516212] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[ 1.517460] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[ 1.518761] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
[ 1.520525] PCI: CLS 0 bytes, default 64
[ 1.521457] Trying to unpack rootfs image as initramfs...
[ 1.713192] Freeing initrd memory: 6664K
[ 1.714909] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x256412811b4, max_idle_ns: 440795306987 ns
[ 1.717760] Initialise system trusted keyrings
[ 1.718783] Key type blacklist registered
[ 1.719752] workingset: timestamp_bits=14 max_order=20 bucket_order=6
[ 1.722543] zbud: loaded
[ 1.723639] integrity: Platform Keyring initialized
[ 1.737954] NET: Registered PF_ALG protocol family
[ 1.738980] xor: measuring software checksum speed
[ 1.740561] pIII_sse : 20542 MB/sec
[ 1.741925] prefetch64-sse : 23982 MB/sec
[ 1.742909] xor: using function: prefetch64-sse (23982 MB/sec)
[ 1.744139] Key type asymmetric registered
[ 1.745039] Asymmetric key parser 'x509' registered
[ 1.746169] bounce: pool size: 64 pages
[ 1.747094] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 245)
[ 1.748707] io scheduler mq-deadline registered
[ 1.750002] io scheduler kyber registered
[ 1.751161] io scheduler bfq registered
[ 1.752394] atomic64_test: passed for i586+ platform with CX8 and with SSE
[ 1.754383] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
[ 1.756225] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
[ 1.758287] ACPI: button: Power Button [PWRF]
[ 1.775040] ACPI: \_SB_.LNKC: Enabled at IRQ 11
[ 1.777056] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled
[ 1.778502] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[ 1.781332] Non-volatile memory driver v1.3
[ 1.782297] Linux agpgart interface v0.103
[ 1.783540] ata_piix 0000:00:01.1: version 2.13
[ 1.785339] scsi host0: ata_piix
[ 1.786304] scsi host1: ata_piix
[ 1.787111] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc080 irq 14
[ 1.788567] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc088 irq 15
[ 1.790069] libphy: Fixed MDIO Bus: probed
[ 1.791249] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 1.792615] ehci-pci: EHCI PCI platform driver
[ 1.793564] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[ 1.794910] ohci-pci: OHCI PCI platform driver
[ 1.795868] uhci_hcd: USB Universal Host Controller Interface driver
[ 1.797245] usbcore: registered new interface driver usbserial_generic
[ 1.798634] usbserial: USB Serial support registered for generic
[ 1.799947] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
[ 1.802437] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 1.803499] serio: i8042 AUX port at 0x60,0x64 irq 12
[ 1.804623] mousedev: PS/2 mouse device common for all mice
[ 1.806140] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1
[ 1.808292] rtc_cmos 00:05: RTC can wake from S4
[ 1.809901] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4
[ 1.812102] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3
[ 1.813914] rtc_cmos 00:05: registered as rtc0
[ 1.814970] rtc_cmos 00:05: setting system clock to 2021-09-15T13:16:36 UTC (1631711796)
[ 1.816672] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs
[ 1.818294] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
[ 1.820756] device-mapper: uevent: version 1.0.3
[ 1.821788] device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: [email protected]
[ 1.823764] intel_pstate: CPU model not supported
[ 1.824907] hid: raw HID events driver (C) Jiri Kosina
[ 1.826142] usbcore: registered new interface driver usbhid
[ 1.827312] usbhid: USB HID core driver
[ 1.828212] drop_monitor: Initializing network drop monitor service
[ 1.838572] Initializing XFRM netlink socket
[ 1.839585] NET: Registered PF_INET6 protocol family
[ 1.841801] Segment Routing with IPv6
[ 1.842683] RPL Segment Routing with IPv6
[ 1.843585] In-situ OAM (IOAM) with IPv6
[ 1.844440] mip6: Mobile IPv6
[ 1.845176] NET: Registered PF_PACKET protocol family
[ 1.847003] IPI shorthand broadcast: enabled
[ 1.848037] ... APIC ID: 00000000 (0)
[ 1.849028] ... APIC VERSION: 00050014
[ 1.849028] 0000000000000000000000000000000000000000000000000000000000000000
[ 1.849028] 0000000000000000000000000000000000000000000000000000000000000000
[ 1.849028] 0000000000000000000000000000000000000000000000000000000000001000
[ 1.849028]
[ 1.854384] number of MP IRQ sources: 15.
[ 1.855515] number of IO-APIC #0 registers: 24.
[ 1.856719] testing the IO APIC.......................
[ 1.858135] IO APIC #0......
[ 1.859016] .... register #00: 00000000
[ 1.860108] ....... : physical APIC id: 00
[ 1.861249] ....... : Delivery Type: 0
[ 1.862379] ....... : LTS : 0
[ 1.863551] .... register #01: 00170011
[ 1.864654] ....... : max redirection entries: 17
[ 1.865673] ....... : PRQ implemented: 0
[ 1.866614] ....... : IO APIC version: 11
[ 1.867563] .... register #02: 00000000
[ 1.868390] ....... : arbitration: 00
[ 1.869295] .... IRQ redirection table:
[ 1.870177] IOAPIC 0:
[ 1.870810] pin00, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[ 1.872434] pin01, enabled , edge , high, V(23), IRR(0), S(0), logical , D(0002), M(0)
[ 1.874154] pin02, enabled , edge , high, V(30), IRR(0), S(0), logical , D(0001), M(0)
[ 1.875823] pin03, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[ 1.877581] pin04, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[ 1.879254] pin05, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[ 1.880966] pin06, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[ 1.882650] pin07, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[ 1.884268] pin08, enabled , edge , high, V(23), IRR(0), S(0), logical , D(0001), M(0)
[ 1.885952] pin09, enabled , level, high, V(21), IRR(0), S(0), logical , D(0002), M(0)
[ 1.887693] pin0a, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[ 1.889363] pin0b, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[ 1.891044] pin0c, enabled , edge , high, V(22), IRR(0), S(0), logical , D(0001), M(0)
[ 1.892798] pin0d, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[ 1.894462] pin0e, enabled , edge , high, V(21), IRR(0), S(0), logical , D(0001), M(0)
[ 1.896144] pin0f, enabled , edge , high, V(22), IRR(0), S(0), logical , D(0002), M(0)
[ 1.897779] pin10, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[ 1.899354] pin11, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[ 1.901063] pin12, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[ 1.902768] pin13, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[ 1.904403] pin14, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[ 1.906092] pin15, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[ 1.907805] pin16, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[ 1.909507] pin17, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[ 1.911204] IRQ to pin mappings:
[ 1.911965] IRQ0 -> 0:2
[ 1.912559] IRQ1 -> 0:1
[ 1.913151] IRQ3 -> 0:3
[ 1.913728] IRQ4 -> 0:4
[ 1.914319] IRQ5 -> 0:5
[ 1.914934] IRQ6 -> 0:6
[ 1.915513] IRQ7 -> 0:7
[ 1.916134] IRQ8 -> 0:8
[ 1.916709] IRQ9 -> 0:9
[ 1.917346] IRQ10 -> 0:10
[ 1.917939] IRQ11 -> 0:11
[ 1.918584] IRQ12 -> 0:12
[ 1.919226] IRQ13 -> 0:13
[ 1.919843] IRQ14 -> 0:14
[ 1.920425] IRQ15 -> 0:15
[ 1.921074] .................................... done.
[ 1.922166] sched_clock: Marking stable (1809994723, 112149602)->(1997769292, -75624967)
[ 1.923944] registered taskstats version 1
[ 1.924877] Loading compiled-in X.509 certificates
[ 1.928813] Loaded X.509 cert 'Build time autogenerated kernel key: 5f848f3a256c3033a276d466d757b9174d58558c'
[ 1.931028] zswap: loaded using pool lzo/zbud
[ 1.932212] Key type ._fscrypt registered
[ 1.933141] Key type .fscrypt registered
[ 1.933989] Key type fscrypt-provisioning registered
[ 1.935399] Btrfs loaded, crc32c=crc32c-generic, zoned=yes, fsverity=yes
[ 1.937362] Key type encrypted registered
[ 1.938451] ima: No TPM chip found, activating TPM-bypass!
[ 1.939809] Loading compiled-in module X.509 certificates
[ 1.943733] Loaded X.509 cert 'Build time autogenerated kernel key: 5f848f3a256c3033a276d466d757b9174d58558c'
[ 1.944780] ata2.01: NODEV after polling detection
[ 1.946329] ima: Allocated hash algorithm: sha256
[ 1.947837] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100
[ 1.948670] ima: No architecture policies found
[ 1.951261] evm: Initialising EVM extended attributes:
[ 1.952552] evm: security.selinux
[ 1.953446] evm: security.SMACK64 (disabled)
[ 1.954550] evm: security.SMACK64EXEC (disabled)
[ 1.955734] evm: security.SMACK64TRANSMUTE (disabled)
[ 1.956970] evm: security.SMACK64MMAP (disabled)
[ 1.958269] evm: security.apparmor (disabled)
[ 1.958297] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5
[ 1.959343] evm: security.ima
[ 1.959344] evm: security.capability
[ 1.959345] evm: HMAC attrs: 0x1
[ 1.963315] PM: Magic number: 5:244:281
[ 1.964463] tty tty18: hash matches
[ 1.983501] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
[ 1.985182] cdrom: Uniform CD-ROM driver Revision: 3.20
[ 2.003515] sr 1:0:0:0: Attached scsi CD-ROM sr0
[ 2.004946] sr 1:0:0:0: Attached scsi generic sg0 type 5
[ 2.007640] Freeing unused kernel image (initmem) memory: 1076K
[ 2.013798] Write protecting kernel text and read-only data: 21444k
[ 2.015796] rodata_test: all tests were successful
[ 2.022763] Run /init as init process
[ 2.023922] with arguments:
[ 2.024801] /init
[ 2.025447] with environment:
[ 2.026337] HOME=/
[ 2.027006] TERM=linux
[ 2.027784] user=$(whoami)
[ 2.028659] job=/lkp/jobs/scheduled/vm-snb-43/trinity-group-02-99999-yocto-i386-minimal-20190520.cgz-d64696905554e919321e31afc210606653b8f6a4-20210911-24127-1x1tp2w-8.yaml
[ 2.032415] ARCH=i386
[ 2.033140] kconfig=i386-randconfig-r015-20210910
[ 2.034457] branch=trace/ftrace/core
[ 2.035503] commit=d64696905554e919321e31afc210606653b8f6a4
[ 2.036995] BOOT_IMAGE=/pkg/linux/i386-randconfig-r015-20210910/gcc-9/d64696905554e919321e31afc210606653b8f6a4/vmlinuz-5.12.0-gd64696905554
[ 2.040147] max_uptime=2100
[ 2.041044] RESULT_ROOT=/result/trinity/group-02-99999/vm-snb/yocto-i386-minimal-20190520.cgz/i386-randconfig-r015-20210910/gcc-9/d64696905554e919321e31afc210606653b8f6a4/8
[ 2.044850] LKP_LOCAL_RUN=1
[ 2.045749] softlockup_panic=1
[ 2.046688] prompt_ramdisk=0
[ 2.047584] vga=normal
[ 2.048380] ip=dhcp
[ 2.049110] result_service=9p/virtfs_mount
INIT: version 2.88 booting
Starting udev
[ 2.073317] udevd[167]: starting version 3.2.7
[ 2.074652] random: udevd: uninitialized urandom read (16 bytes read)
[ 2.076331] random: udevd: uninitialized urandom read (16 bytes read)
[ 2.077986] random: udevd: uninitialized urandom read (16 bytes read)
[ 2.080262] udevd[167]: specified group 'kvm' unknown
[ 2.082655] udevd[168]: starting eudev-3.2.7
depmod: ERROR: could not open directory /lib/modules/5.15.0-rc1+: No such file or directory
depmod: WARNING: -e needs -E or -F
depmod: ERROR: could not open directory /lib/modules/5.15.0-rc1+: No such file or directory
depmod: FATAL: could not search modules: No such file or directory
INIT: Entering runlevel: 5
Configuring network interfaces... done.
Starting syslogd/klogd: done
/etc/rc5.d/S77lkp-bootstrap: /lkp/jobs/scheduled/vm-snb-43/trinity-group-02-99999-yocto-i386-minimal-20190520.cgz-d64696905554e919321e31afc210606653b8f6a4-20210911-24127-1x1tp2w-8.sh: line 123: start: not found
/etc/rc5.d/S77lkp-bootstrap: line 75: /lkp/root/src/bin/lkp-setup-rootfs: not found
INIT: Id "S1" respawning too fast: disabled for 5 minutes
Poky (Yocto Project Reference Distro) 2.7+snapshot qemux86 /dev/ttyS0
qemux86 login:
> As the log you mentioned, below [1] shows our corresponding log, they are very similar, only we don't have depmod error, I found some solutions and add their links here, could you check if they can solve your issue? Thanks.
>
> depmod: ERROR: could not open directory /lib/modules/5.14.0-09687-g27151f177827: No such file or directory
> depmod: FATAL: could not search modules: No such file or directory
>
> https://stackoverflow.com/questions/28644386/kernel-install-gives-missing-module-error
> https://serverfault.com/questions/780980/error-could-not-open-directory-lib-modules-4-2-0-25-generic-no-such-file-or-d
The error occurs inside qemu. It seems that the directory with modules and
lkp-tests itself (/lkp/root/src) was not mounted from the host system.
--
Rgrds, legion
Hi, legion
> -----Original Message-----
> From: Alexey Gladkov <[email protected]>
> Sent: Wednesday, September 15, 2021 7:40 PM
> To: Si, Beibei <[email protected]>
> Cc: Eric W. Biederman <[email protected]>; LKML <linux-
> [email protected]>; [email protected]; lkp <[email protected]>
> Subject: [LKP] Re: d646969055:
> WARNING:at_kernel/ucount.c:#dec_rlimit_ucounts
>
> On Wed, Sep 15, 2021 at 01:54:09AM +0000, Si, Beibei wrote:
> > Hi, legion
> >
> > > -----Original Message-----
> > > From: Alexey Gladkov <[email protected]>
> > > Sent: Tuesday, September 14, 2021 3:40 AM
> > > To: Sang, Oliver <[email protected]>
> > > Cc: Eric W. Biederman <[email protected]>; LKML <linux-
> > > [email protected]>; [email protected]; lkp <[email protected]>
> > > Subject: Re: d646969055:
> WARNING:at_kernel/ucount.c:#dec_rlimit_ucounts
> > >
> > > On Mon, Sep 13, 2021 at 10:16:54PM +0800, kernel test robot wrote:
> > > >
> > > >
> > > > Greeting,
> > > >
> > > > FYI, we noticed the following commit (built with gcc-9):
> > > >
> > > > commit: d64696905554e919321e31afc210606653b8f6a4 ("Reimplement
> > > > RLIMIT_SIGPENDING on top of ucounts")
> > > > https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git master
> > > >
> > > >
> > > > in testcase: trinity
> > > > version: trinity-i386
> > > > with following parameters:
> > > >
> > > > number: 99999
> > > > group: group-02
> > > >
> > > > test-description: Trinity is a linux system call fuzz tester.
> > > > test-url: http://codemonkey.org.uk/projects/trinity/
> > > >
> > > >
> > > > 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]>
> > > >
> > > >
> > > > [ 558.756672][ T2642] WARNING: CPU: 0 PID: 2642 at kernel/ucount.c:268
> > > > dec_rlimit_ucounts (kernel/ucount.c:268 (discriminator 1)) [
> > > > 558.758020][ T2642] Modules linked in: uvesafb cfbfillrect cfbimgblt
> > > > cfbcopyarea fb fbdev ppdev crc32_pclmul input_leds led_class intel_agp
> > > > intel_gtt parport_pc parport qemu_fw_cfg [ 558.766247][ T2642] CPU: 0
> > > > PID: 2642 Comm: trinity-main Not tainted 5.12.0-gd64696905554 #1 [
> > > > 558.767543][ T2642] Hardware name: QEMU Standard PC (i440FX + PIIX,
> > > > 1996), BIOS 1.12.0-1 04/01/2014 [ 558.772150][ T2642] EIP:
> > > dec_rlimit_ucounts (kernel/ucount.c:268 (discriminator 1))
> [ 558.772945][ T2642]
> > > Code: 68 73 6c c3 01 83 15 6c 73 6c c3 00 85 c0 0f 94 c0 83 c4 04 5b 5e 5f 5d
> c3
> > > 8d 76 00 83 05 50 73 6c c3 01 83 15 54 73 6c c3 00 <0f> 0b 83 05 58 73 6c c3
> 01
> > > 83 15 5c 73 6c c3 00 eb 9d 8d b4 26 00 All code ========
> > > > 0: 68 73 6c c3 01 pushq $0x1c36c73
> > > > 5: 83 15 6c 73 6c c3 00 adcl $0x0,-0x3c938c94(%rip) #
> > > 0xffffffffc36c7378
> > > > c: 85 c0 test %eax,%eax
> > > > e: 0f 94 c0 sete %al
> > > > 11: 83 c4 04 add $0x4,%esp
> > > > 14: 5b pop %rbx
> > > > 15: 5e pop %rsi
> > > > 16: 5f pop %rdi
> > > > 17: 5d pop %rbp
> > > > 18: c3 retq
> > > > 19: 8d 76 00 lea 0x0(%rsi),%esi
> > > > 1c: 83 05 50 73 6c c3 01 addl $0x1,-0x3c938cb0(%rip) #
> > > 0xffffffffc36c7373
> > > > 23: 83 15 54 73 6c c3 00 adcl $0x0,-0x3c938cac(%rip) #
> > > 0xffffffffc36c737e
> > > > 2a:* 0f 0b ud2 <-- trapping instruction
> > > > 2c: 83 05 58 73 6c c3 01 addl $0x1,-0x3c938ca8(%rip) #
> > > 0xffffffffc36c738b
> > > > 33: 83 15 5c 73 6c c3 00 adcl $0x0,-0x3c938ca4(%rip) #
> > > 0xffffffffc36c7396
> > > > 3a: eb 9d jmp 0xffffffffffffffd9
> > > > 3c: 8d .byte 0x8d
> > > > 3d: b4 26 mov $0x26,%ah
> > > > ...
> > > >
> > > > Code starting with the faulting instruction
> > > > ===========================================
> > > > 0: 0f 0b ud2
> > > > 2: 83 05 58 73 6c c3 01 addl $0x1,-0x3c938ca8(%rip) #
> > > 0xffffffffc36c7361
> > > > 9: 83 15 5c 73 6c c3 00 adcl $0x0,-0x3c938ca4(%rip) #
> > > 0xffffffffc36c736c
> > > > 10: eb 9d jmp 0xffffffffffffffaf
> > > > 12: 8d .byte 0x8d
> > > > 13: b4 26 mov $0x26,%ah
> > > > ...
> > > > [ 558.779398][ T2642] EAX: f63271e0 EBX: f63271e0 ECX: 00000001 EDX:
> > > > ffffffff [ 558.781206][ T2642] ESI: 0000003c EDI: ffffffff EBP:
> > > > f62e3eac ESP: f62e3e9c [ 558.782613][ T2642] DS: 007b ES: 007b FS:
> > > > 0000 GS: 0033 SS: 0068 EFLAGS: 00010246 [ 558.783747][ T2642] CR0:
> > > > 80050033 CR2: 08082ff0 CR3: 362b0000 CR4: 00040690
> [ 558.792353][ T2642]
> > > Call Trace:
> > > > [ 558.793036][ T2642] ? release_task (include/linux/rcupdate.h:654
> > > > kernel/exit.c:191) [ 558.793936][ T2642] release_task
> > > > (kernel/exit.c:191) [ 558.794818][ T2642] wait_task_zombie
> > > > (kernel/exit.c:1107) [ 558.800667][ T2642] wait_consider_task
> > > > (kernel/exit.c:1334) [ 558.801693][ T2642] ? _raw_read_lock
> > > > (include/linux/rwlock_api_smp.h:149 kernel/locking/spinlock.c:223) [
> > > > 558.802645][ T2642] do_wait (kernel/exit.c:1399 kernel/exit.c:1468) [
> > > > 558.803462][ T2642] kernel_wait4 (kernel/exit.c:1630) [ 558.806901][
> > > > T2642] ? kill_orphaned_pgrp (kernel/exit.c:1422) [ 558.808347][ T2642]
> > > > __ia32_sys_waitpid (kernel/exit.c:1675 kernel/exit.c:1673
> > > > kernel/exit.c:1673) [ 558.809338][ T2642] do_int80_syscall_32
> > > > (arch/x86/entry/common.c:77 arch/x86/entry/common.c:94)
> [ 558.810319][
> > > > T2642] entry_INT80_32 (arch/x86/entry/entry_32.S:1064) [ 558.811254][
> > > > T2642] EIP: 0x809b132 [ 558.815723][ T2642] Code: 89 c8 c3 90 8d 74 26
> > > > 00 85 c0 c7 01 01 00 00 00 75 d8 a1 6c 94 a8 08 eb d1 66 90 66 90 66 90 66
> 90
> > > 66 90 66 90 66 90 90 cd 80 <c3> 8d b6 00 00 00 00 8d bc 27 00 00 00 00 8b 10
> a3
> > > 94 94 a8 08 85 All code ========
> > > > 0: 89 c8 mov %ecx,%eax
> > > > 2: c3 retq
> > > > 3: 90 nop
> > > > 4: 8d 74 26 00 lea 0x0(%rsi,%riz,1),%esi
> > > > 8: 85 c0 test %eax,%eax
> > > > a: c7 01 01 00 00 00 movl $0x1,(%rcx)
> > > > 10: 75 d8 jne 0xffffffffffffffea
> > > > 12: a1 6c 94 a8 08 eb d1 movabs 0x9066d1eb08a8946c,%eax
> > > > 19: 66 90
> > > > 1b: 66 90 xchg %ax,%ax
> > > > 1d: 66 90 xchg %ax,%ax
> > > > 1f: 66 90 xchg %ax,%ax
> > > > 21: 66 90 xchg %ax,%ax
> > > > 23: 66 90 xchg %ax,%ax
> > > > 25: 66 90 xchg %ax,%ax
> > > > 27: 90 nop
> > > > 28: cd 80 int $0x80
> > > > 2a:* c3 retq <-- trapping instruction
> > > > 2b: 8d b6 00 00 00 00 lea 0x0(%rsi),%esi
> > > > 31: 8d bc 27 00 00 00 00 lea 0x0(%rdi,%riz,1),%edi
> > > > 38: 8b 10 mov (%rax),%edx
> > > > 3a: a3 .byte 0xa3
> > > > 3b: 94 xchg %eax,%esp
> > > > 3c: 94 xchg %eax,%esp
> > > > 3d: a8 08 test $0x8,%al
> > > > 3f: 85 .byte 0x85
> > > >
> > > > Code starting with the faulting instruction
> > > > ===========================================
> > > > 0: c3 retq
> > > > 1: 8d b6 00 00 00 00 lea 0x0(%rsi),%esi
> > > > 7: 8d bc 27 00 00 00 00 lea 0x0(%rdi,%riz,1),%edi
> > > > e: 8b 10 mov (%rax),%edx
> > > > 10: a3 .byte 0xa3
> > > > 11: 94 xchg %eax,%esp
> > > > 12: 94 xchg %eax,%esp
> > > > 13: a8 08 test $0x8,%al
> > > > 15: 85 .byte 0x85
> > > > [ 558.820109][ T2642] EAX: ffffffda EBX: 00000f0f ECX: bfb23394 EDX:
> > > > 0000000b [ 558.821480][ T2642] ESI: 00000002 EDI: 08a890fc EBP:
> > > > 08a89034 ESP: bfb23364 [ 558.822693][ T2642] DS: 007b ES: 007b FS:
> > > > 0000 GS: 0033 SS: 007b EFLAGS: 00000246 [ 558.828056][ T2642] irq
> > > > event stamp: 1348273 [ 558.828922][ T2642] hardirqs last enabled at
> > > > (1348281): console_unlock (kernel/printk/printk.c:2605 (discriminator
> > > > 1)) [ 558.830629][ T2642] hardirqs last disabled at (1348288):
> > > > console_unlock (kernel/printk/printk.c:2520 (discriminator 1)) [
> > > > 558.833190][ T2642] softirqs last enabled at (1348240): __do_softirq
> > > > (kernel/softirq.c:372) [ 558.834715][ T2642] softirqs last disabled at
> > > > (1348231): do_softirq_own_stack (arch/x86/kernel/irq_32.c:60
> > > > arch/x86/kernel/irq_32.c:149) [ 558.840026][ T2642] ---[ end trace
> > > > 6bbb25560ce8d9b6 ]---
> > > >
> > > >
> > > > To reproduce:
> > > >
> > > > # build kernel
> > > > cd linux
> > > > cp config-5.12.0-gd64696905554 .config
> > > > make HOSTCC=gcc-9 CC=gcc-9 ARCH=i386 olddefconfig prepare
> > > > modules_prepare bzImage
> > > >
> > > > git clone https://github.com/intel/lkp-tests.git
> > > > cd lkp-tests
> > > > bin/lkp qemu -k <bzImage> job-script # job-script is attached
> > > > in this email
> > >
> > > I am unable to run the test following this instruction.
> >
> > After double check, we can reproduce this issue, could you kindly offer your
> full log and the reproducing steps?
>
> Sure. Here is what i did:
Thanks, I tried your steps on my machine, but still can reproduce the kernel panic, I add my steps and log here, hope they can help. Also, a soft reminder, no need to download lkp-tests under linux/.
$ grep PRETTY_NAME /etc/os-release
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
$ git clone https://git.kernel.org/pub/scm/linux/kernel/git/torvalds/linux.git
$ cd linux
/linux$ git describe
v5.15-rc1-221-g4357f03d6611
/linux$ cp ../config-5.12.0-gd64696905554 .config
/linux$ make -j8 ARCH=i386 olddefconfig prepare modules_prepare bzImage
...
BUILD arch/x86/boot/bzImage
Kernel: arch/x86/boot/bzImage is ready (#1)
/lkp-tests$ sudo bin/lkp qemu -k ../linux/arch/x86/boot/bzImage ../tmp/job-script
result_root: /home/carel/.lkp//result/trinity/group-02-99999/vm-snb/yocto-i386-minimal-20190520.cgz/i386-randconfig-r015-20210910/gcc-9/d64696905554e919321e31afc210606653b8f6a4/8
downloading initrds ...
/usr/bin/wget -q --timeout=1800 --tries=1 --local-encoding=UTF-8 http://0day.sh.intel.com:80/~lkp/osimage/yocto/yocto-i386-minimal-20190520.cgz -N -P /home/carel/.lkp/cache/osimage/yocto
/usr/bin/wget -q --timeout=1800 --tries=1 --local-encoding=UTF-8 http://0day.sh.intel.com:80/~lkp/osimage/pkg/yocto-i386-minimal-20190520.cgz/trinity-i386.cgz -N -P /home/carel/.lkp/cache/osimage/pkg/yocto-i386-minimal-20190520.cgz
exec command: qemu-system-x86_64 -enable-kvm -fsdev local,id=test_dev,path=/home/carel/.lkp//result/trinity/group-02-99999/vm-snb/yocto-i386-minimal-20190520.cgz/i386-randconfig-r015-20210910/gcc-9/d64696905554e919321e31afc210606653b8f6a4/8,security_model=none -device virtio-9p-pci,fsdev=test_dev,mount_tag=9p/virtfs_mount -kernel ../linux/arch/x86/boot/bzImage -append root=/dev/ram0 user=$(whoami) job=/lkp/jobs/scheduled/vm-snb-43/trinity-group-02-99999-yocto-i386-minimal-20190520.cgz-d64696905554e919321e31afc210606653b8f6a4-20210911-24127-1x1tp2w-8.yaml ARCH=i386 kconfig=i386-randconfig-r015-20210910 branch=trace/ftrace/core commit=d64696905554e919321e31afc210606653b8f6a4 BOOT_IMAGE=/pkg/linux/i386-randconfig-r015-20210910/gcc-9/d64696905554e919321e31afc210606653b8f6a4/vmlinuz-5.12.0-gd64696905554 vmalloc=128M initramfs_async=0 page_owner=on max_uptime=2100 RESULT_ROOT=/result/trinity/group-02-99999/vm-snb/yocto-i386-minimal-20190520.cgz/i386-randconfig-r015-20210910/gcc-9/d64696905554e919321e31afc210606653b8f6a4/8 LKP_LOCAL_RUN=1 selinux=0 debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 net.ifnames=0 printk.devkmsg=on panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 drbd.minor_count=8 systemd.log_level=err ignore_loglevel console=tty0 earlyprintk=ttyS0,115200 console=ttyS0,115200 vga=normal rw ip=dhcp result_service=9p/virtfs_mount -initrd /home/carel/.lkp/cache/final_initrd -smp 2 -m 3700M -no-reboot -watchdog i6300esb -rtc base=localtime -device e1000,netdev=net0 -netdev user,id=net0 -display none -monitor null -serial stdio
early console in setup code
Probing EDD (edd=off to disable)... ok
Wrong EFI loader signature.
early console in extract_kernel
input_data: 0x031af079
input_len: 0x013d184d
output: 0x01000000
output_len: 0x026da05c
kernel_total_size: 0x03597000
needed_size: 0x03597000
Decompressing Linux... Parsing ELF... done.
Booting the kernel.
[ 0.000000][ T0] Linux version 5.15.0-rc1-00221-g4357f03d6611 (carel@carel) (gcc (Debian 8.3.0-6) 8.3.0, GNU ld (GNU Binutils for Debian) 2.31.1) #1 PREEMPT Sat Sep 18 09:42:44 CST 2021
[ 0.000000][ T0] KERNEL supported cpus:
[ 0.000000][ T0] AMD AuthenticAMD
[ 0.000000][ T0] NSC Geode by NSC
[ 0.000000][ T0] Cyrix CyrixInstead
[ 0.000000][ T0] Centaur CentaurHauls
[ 0.000000][ T0] zhaoxin Shanghai
[ 0.000000][ T0] CPU: vendor_id 'GenuineIntel' unknown, using generic init.
[ 0.000000][ T0] CPU: Your system may be unstable.
[ 0.000000][ T0] x86/fpu: x87 FPU will use FXSAVE
[ 0.000000][ T0] signal: max sigframe size: 1440
[ 0.000000][ T0] BIOS-provided physical RAM map:
[ 0.000000][ T0] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
[ 0.000000][ T0] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
[ 0.000000][ T0] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
[ 0.000000][ T0] BIOS-e820: [mem 0x0000000000100000-0x00000000bffdffff] usable
[ 0.000000][ T0] BIOS-e820: [mem 0x00000000bffe0000-0x00000000bfffffff] reserved
[ 0.000000][ T0] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
[ 0.000000][ T0] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
[ 0.000000][ T0] BIOS-e820: [mem 0x0000000100000000-0x00000001273fffff] usable
[ 0.000000][ T0] printk: debug: ignoring loglevel setting.
[ 0.000000][ T0] printk: bootconsole [earlyser0] enabled
[ 0.000000][ T0] Notice: NX (Execute Disable) protection cannot be enabled: non-PAE kernel!
[ 0.000000][ T0] SMBIOS 2.8 present.
[ 0.000000][ T0] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 0.000000][ T0] Hypervisor detected: KVM
[ 0.000000][ T0] kvm-clock: Using msrs 4b564d01 and 4b564d00
[ 0.000000][ T0] kvm-clock: cpu 0, msr 370e001, primary cpu clock
[ 0.000008][ T0] kvm-clock: using sched offset of 1062708934 cycles
[ 0.000544][ T0] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
[ 0.002029][ T0] tsc: Detected 3591.686 MHz processor
[ 0.003356][ T0] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[ 0.003979][ T0] e820: remove [mem 0x000a0000-0x000fffff] usable
[ 0.004504][ T0] last_pfn = 0xbffe0 max_arch_pfn = 0x100000
[ 0.005027][ T0] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT
[ 0.005670][ T0] initial memory mapped: [mem 0x00000000-0x047fffff]
[ 0.006272][ T0] RAMDISK: [mem 0x7f972000-0x7fffffff]
[ 0.006716][ T0] Allocated new RAMDISK: [mem 0x36570000-0x36bfd653]
[ 0.008979][ T0] Move RAMDISK from [mem 0x7f972000-0x7ffff653] to [mem 0x36570000-0x36bfd653]
[ 0.009782][ T0] ACPI: Early table checksum verification disabled
[ 0.010351][ T0] ACPI: RSDP 0x00000000000F5850 000014 (v00 BOCHS )
[ 0.010893][ T0] ACPI: RSDT 0x00000000BFFE15C9 000030 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001)
[ 0.011667][ T0] ACPI: FACP 0x00000000BFFE149D 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001)
[ 0.012441][ T0] ACPI: DSDT 0x00000000BFFE0040 00145D (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001)
[ 0.013214][ T0] ACPI: FACS 0x00000000BFFE0000 000040
[ 0.013662][ T0] ACPI: APIC 0x00000000BFFE1511 000080 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001)
[ 0.014437][ T0] ACPI: HPET 0x00000000BFFE1591 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001)
[ 0.015206][ T0] ACPI: Reserving FACP table memory at [mem 0xbffe149d-0xbffe1510]
[ 0.015851][ T0] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe149c]
[ 0.016492][ T0] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f]
[ 0.017134][ T0] ACPI: Reserving APIC table memory at [mem 0xbffe1511-0xbffe1590]
[ 0.017773][ T0] ACPI: Reserving HPET table memory at [mem 0xbffe1591-0xbffe15c8]
[ 0.018424][ T0] 2195MB HIGHMEM available.
[ 0.018789][ T0] 875MB LOWMEM available.
[ 0.019136][ T0] mapped low ram: 0 - 36bfe000
[ 0.019530][ T0] low ram: 0 - 36bfe000
[ 0.021850][ T0] Zone ranges:
[ 0.022170][ T0] Normal [mem 0x0000000000001000-0x0000000036bfdfff]
[ 0.022742][ T0] HighMem [mem 0x0000000036bfe000-0x00000000bffdffff]
[ 0.023312][ T0] Movable zone start for each node
[ 0.023723][ T0] Early memory node ranges
[ 0.024077][ T0] node 0: [mem 0x0000000000001000-0x000000000009efff]
[ 0.024655][ T0] node 0: [mem 0x0000000000100000-0x00000000bffdffff]
[ 0.025232][ T0] Initmem setup node 0 [mem 0x0000000000001000-0x00000000bffdffff]
[ 0.025889][ T0] On node 0, zone Normal: 1 pages in unavailable ranges
[ 0.030249][ T0] On node 0, zone Normal: 97 pages in unavailable ranges
[ 0.041791][ T0] On node 0, zone HighMem: 32 pages in unavailable ranges
[ 0.042588][ T0] ACPI: PM-Timer IO Port: 0x608
[ 0.043569][ T0] ACPI: HPET id: 0x8086a201 base: 0xfed00000
[ 0.044084][ T0] kvm-guest: stealtime: cpu 0, msr 2f13ac0
[ 0.044581][ T0] [mem 0xc0000000-0xfeffbfff] available for PCI devices
[ 0.045157][ T0] Booting paravirtualized kernel on KVM
[ 0.045623][ T0] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns
[ 0.046605][ T0] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
[ 0.047131][ T0] pcpu-alloc: [0] 0
[ 0.047464][ T0] Built 1 zonelists, mobility grouping on. Total pages: 784550
[ 0.048095][ T0] Kernel command line: root=/dev/ram0 user=$(whoami) job=/lkp/jobs/scheduled/vm-snb-43/trinity-group-02-99999-yocto-i386-minimal-20190520.cgz-d64696905554e919321e31afc210606653b8f6a4-20210911-24127-1x1tp2w-8.yaml ARCH=i386 kconfig=i386-randconfig-r015-20210910 branch=trace/ftrace/core commit=d64696905554e919321e31afc210606653b8f6a4 BOOT_IMAGE=/pkg/linux/i386-randconfig-r015-20210910/gcc-9/d64696905554e919321e31afc210606653b8f6a4/vmlinuz-5.12.0-gd64696905554 vmalloc=128M initramfs_async=0 page_owner=on max_uptime=2100 RESULT_ROOT=/result/trinity/group-02-99999/vm-snb/yocto-i386-minimal-20190520.cgz/i386-randconfig-r015-20210910/gcc-9/d64696905554e919321e31afc210606653b8f6a4/8 LKP_LOCAL_RUN=1 selinux=0 debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 net.ifnames=0 printk.devkmsg=on panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 drbd.minor_count=8 systemd.log_level=err ignore_loglevel console=tty0
[ 0.048491][ T0] sysrq: sysrq always enabled.
[ 0.056301][ T0] ignoring the deprecated load_ramdisk= option
[ 0.057014][ T0] Unknown command line parameters: user=$(whoami) job=/lkp/jobs/scheduled/vm-snb-43/trinity-group-02-99999-yocto-i386-minimal-20190520.cgz-d64696905554e919321e31afc210606653b8f6a4-20210911-24127-1x1tp2w-8.yaml ARCH=i386 kconfig=i386-randconfig-r015-20210910 branch=trace/ftrace/core commit=d64696905554e919321e31afc210606653b8f6a4 BOOT_IMAGE=/pkg/linux/i386-randconfig-r015-20210910/gcc-9/d64696905554e919321e31afc210606653b8f6a4/vmlinuz-5.12.0-gd64696905554 max_uptime=2100 RESULT_ROOT=/result/trinity/group-02-99999/vm-snb/yocto-i386-minimal-20190520.cgz/i386-randconfig-r015-20210910/gcc-9/d64696905554e919321e31afc210606653b8f6a4/8 LKP_LOCAL_RUN=1 selinux=0 apic=debug softlockup_panic=1 prompt_ramdisk=0 vga=normal result_service=9p/virtfs_mount
[ 0.062708][ T0] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes, linear)
[ 0.063433][ T0] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes, linear)
[ 0.064320][ T0] mem auto-init: stack:off, heap alloc:on, heap free:on
[ 0.064898][ T0] mem auto-init: clearing system memory may take some time...
[ 0.067713][ T0] Initializing HighMem for node 0 (00036bfe:000bffe0)
[ 1.664514][ T0] Initializing Movable for node 0 (00000000:00000000)
[ 2.271551][ T0] Checking if this processor honours the WP bit even in supervisor mode...Ok.
[ 2.272366][ T0] Memory: 3052536K/3145208K available (23745K kernel code, 7165K rwdata, 7728K rodata, 1028K init, 13920K bss, 92672K reserved, 0K cma-reserved, 2248584K highmem)
[ 2.273752][ T0] random: get_random_u32 called from __kmem_cache_create+0x48/0x7c0 with crng_init=0
[ 2.273842][ T0] random: get_random_u32 called from cache_random_seq_create+0xb7/0x250 with crng_init=0
[ 2.273901][ T0] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[ 2.276153][ T0] random: get_random_u32 called from __kmem_cache_create+0x48/0x7c0 with crng_init=0
[ 2.276204][ T0] trace event string verifier disabled
[ 2.277560][ T0] Running RCU self tests
[ 2.277935][ T0] rcu: Preemptible hierarchical RCU implementation.
[ 2.278486][ T0] rcu: RCU lockdep checking is enabled.
[ 2.278955][ T0] rcu: RCU debug extended QS entry/exit.
[ 2.279432][ T0] RCU CPU stall warnings timeout set to 100 (rcu_cpu_stall_timeout).
[ 2.280116][ T0] Trampoline variant of Tasks RCU enabled.
[ 2.280606][ T0] Rude variant of Tasks RCU enabled.
[ 2.281052][ T0] Tracing variant of Tasks RCU enabled.
[ 2.281524][ T0] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
[ 2.283419][ T0] NR_IRQS: 16, nr_irqs: 16, preallocated irqs: 16
[ 2.284284][ T0] kfence: initialized - using 2097152 bytes for 255 objects at 0x(ptrval)-0x(ptrval)
[ 2.285222][ T0] printk: console [ttyS0] enabled
[ 2.285222][ T0] printk: console [ttyS0] enabled
[ 2.286089][ T0] printk: bootconsole [earlyser0] disabled
[ 2.286089][ T0] printk: bootconsole [earlyser0] disabled
[ 2.287063][ T0] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[ 2.287797][ T0] ... MAX_LOCKDEP_SUBCLASSES: 8
[ 2.288218][ T0] ... MAX_LOCK_DEPTH: 48
[ 2.288647][ T0] ... MAX_LOCKDEP_KEYS: 8192
[ 2.289090][ T0] ... CLASSHASH_SIZE: 4096
[ 2.289533][ T0] ... MAX_LOCKDEP_ENTRIES: 32768
[ 2.289987][ T0] ... MAX_LOCKDEP_CHAINS: 65536
[ 2.290439][ T0] ... CHAINHASH_SIZE: 32768
[ 2.290889][ T0] memory used by lock dependency info: 3805 kB
[ 2.291423][ T0] memory used for stack traces: 2112 kB
[ 2.291903][ T0] per task-struct memory footprint: 1344 bytes
[ 2.292443][ T0] ACPI: Core revision 20210730
[ 2.292998][ T0] ACPI: setting ELCR to 0200 (from 0c00)
[ 2.293574][ T0] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
[ 2.294563][ T0] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x33c5a5f08b9, max_idle_ns: 440795345409 ns
[ 2.295561][ T0] Calibrating delay loop (skipped) preset value.. 7183.37 BogoMIPS (lpj=14366744)
[ 2.296352][ T0] pid_max: default: 32768 minimum: 301
[ 2.296866][ T0] LSM: Security Framework initializing
[ 2.297360][ T0] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
[ 2.298067][ T0] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
[ 2.300096][ T0] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[ 2.300634][ T0] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
[ 2.301217][ T0] CPU: GenuineIntel QEMU Virtual CPU version 2.5+ (family: 0x6, model: 0x6, stepping: 0x3)
[ 2.302076][ T0] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
[ 2.302889][ T0] Spectre V2 : Spectre mitigation: kernel not compiled with retpoline; no mitigation available!
[ 2.302891][ T0] Speculative Store Bypass: Vulnerable
[ 2.304023][ T0] L1TF: Kernel not compiled for PAE. No mitigation for L1TF
[ 2.304650][ T0] MDS: Vulnerable: Clear CPU buffers attempted, no microcode
[ 2.306112][ T1] Running RCU-tasks wait API self tests
[ 2.407774][ T1] Performance Events: no PMU driver, software events only.
[ 2.409029][ T1] rcu: Hierarchical SRCU implementation.
[ 2.410091][ T1] dyndbg: Ignore empty _ddebug table in a CONFIG_DYNAMIC_DEBUG_CORE build
[ 2.411359][ T1] NMI watchdog: Perf NMI watchdog permanently disabled
[ 2.415631][ T12] Callback from call_rcu_tasks_trace() invoked.
[ 2.419040][ T1] allocated 31457280 bytes of page_ext
[ 2.420779][ T1] Node 0, zone Normal: page owner found early allocated 8181 pages
[ 2.422009][ T1] Node 0, zone HighMem: page owner found early allocated 0 pages
[ 2.423650][ T1] devtmpfs: initialized
[ 2.424381][ T1] version magic: 0x4138332a
[ 2.427072][ T1] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[ 2.427568][ T1] futex hash table entries: 256 (order: 1, 12288 bytes, linear)
[ 2.428377][ T1] prandom: seed boundary self test passed
[ 2.429388][ T1] prandom: 100 self tests passed
[ 2.433248][ T1] prandom32: self test passed (less than 6 bits correlated)
[ 2.433877][ T1] pinctrl core: initialized pinctrl subsystem
[ 2.434402][ T1] pinctrl core: failed to create debugfs directory
[ 2.435209][ T1] regulator-dummy: no parameters, enabled
[ 2.435665][ T1]
[ 2.435871][ T1] *************************************************************
[ 2.436525][ T1] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE **
[ 2.437177][ T1] ** **
[ 2.437838][ T1] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL **
[ 2.438486][ T1] ** **
[ 2.439139][ T1] ** This means that this kernel is built to expose internal **
[ 2.439556][ T1] ** IOMMU data structures, which may compromise security on **
[ 2.440210][ T1] ** your system. **
[ 2.440861][ T1] ** **
[ 2.441508][ T1] ** If you see this message and you are not debugging the **
[ 2.442159][ T1] ** kernel, report this immediately to your vendor! **
[ 2.442813][ T1] ** **
[ 2.443556][ T1] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE **
[ 2.444210][ T1] *************************************************************
[ 2.445099][ T1] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[ 2.446474][ T1] audit: initializing netlink subsys (disabled)
[ 2.447713][ T1] cpuidle: using governor ladder
[ 2.448685][ T1] ACPI: bus type PCI registered
[ 2.449251][ T1] PCI: Using configuration type 1 for base access
[ 2.451593][ T18] audit: type=2000 audit(1631929790.328:1): state=initialized audit_enabled=0 res=1
[ 2.459421][ T1] HugeTLB registered 4.00 MiB page size, pre-allocated 0 pages
[ 2.460512][ T25] cryptomgr_test (25) used greatest stack depth: 7324 bytes left
[ 2.462143][ T1] cryptd: max_cpu_qlen set to 1000
[ 2.464553][ T1] gpio-f7188x: Not a Fintek device at 0x0000002e
[ 2.465127][ T1] gpio-f7188x: Not a Fintek device at 0x0000004e
[ 2.465728][ T1] ACPI: Added _OSI(Module Device)
[ 2.466164][ T1] ACPI: Added _OSI(Processor Device)
[ 2.466619][ T1] ACPI: Added _OSI(3.0 _SCP Extensions)
[ 2.467101][ T1] ACPI: Added _OSI(Processor Aggregator Device)
[ 2.467665][ T1] ACPI: Added _OSI(Linux-Dell-Video)
[ 2.468124][ T1] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
[ 2.468654][ T1] ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics)
[ 2.471762][ T1] ACPI: 1 ACPI AML tables successfully acquired and loaded
[ 2.474525][ T1] ACPI: Interpreter enabled
[ 2.474959][ T1] ACPI: PM: (supports S0 S3 S5)
[ 2.475379][ T1] ACPI: Using PIC for interrupt routing
[ 2.475598][ T1] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[ 2.476792][ T1] ACPI: Enabled 2 GPEs in block 00 to 0F
[ 2.487114][ T1] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[ 2.487567][ T1] acpi PNP0A03:00: _OSC: OS supports [Segments HPX-Type3]
[ 2.488207][ T1] acpi resource window ([0x140000000-0x1bfffffff] ignored, not CPU addressable)
[ 2.489975][ T1] PCI host bridge to bus 0000:00
[ 2.490402][ T1] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
[ 2.491059][ T1] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
[ 2.491557][ T1] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[ 2.492268][ T1] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]
[ 2.492974][ T1] pci_bus 0000:00: root bus resource [bus 00-ff]
[ 2.493968][ T1] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
[ 2.495802][ T1] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
[ 2.497037][ T1] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
[ 2.499268][ T1] pci 0000:00:01.1: reg 0x20: [io 0xc080-0xc08f]
[ 2.500250][ T1] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
[ 2.500932][ T1] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6]
[ 2.501555][ T1] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
[ 2.502230][ T1] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376]
[ 2.504048][ T1] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
[ 2.504876][ T1] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI
[ 2.505571][ T1] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB
[ 2.506929][ T1] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000
[ 2.511755][ T11] Callback from call_rcu_tasks_rude() invoked.
[ 2.515963][ T1] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref]
[ 2.518124][ T1] pci 0000:00:02.0: reg 0x18: [mem 0xfebf0000-0xfebf0fff]
[ 2.521663][ T1] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref]
[ 2.524209][ T1] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200
[ 2.525976][ T1] pci 0000:00:03.0: reg 0x10: [io 0xc000-0xc03f]
[ 2.527331][ T1] pci 0000:00:03.0: reg 0x14: [mem 0xfebf1000-0xfebf1fff]
[ 2.529511][ T1] pci 0000:00:03.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref]
[ 2.532428][ T1] pci 0000:00:04.0: [8086:100e] type 00 class 0x020000
[ 2.533708][ T1] pci 0000:00:04.0: reg 0x10: [mem 0xfebc0000-0xfebdffff]
[ 2.534960][ T1] pci 0000:00:04.0: reg 0x14: [io 0xc040-0xc07f]
[ 2.538549][ T1] pci 0000:00:04.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref]
[ 2.539960][ T1] pci 0000:00:05.0: [8086:25ab] type 00 class 0x088000
[ 2.540813][ T1] pci 0000:00:05.0: reg 0x10: [mem 0xfebf2000-0xfebf200f]
[ 2.543208][ T1] pci_bus 0000:00: on NUMA node 0
[ 2.544762][ T1] ACPI: PCI: Interrupt link LNKA configured for IRQ 10
[ 2.545566][ T1] ACPI: PCI: Interrupt link LNKB configured for IRQ 10
[ 2.546357][ T1] ACPI: PCI: Interrupt link LNKC configured for IRQ 11
[ 2.547701][ T1] ACPI: PCI: Interrupt link LNKD configured for IRQ 11
[ 2.548470][ T1] ACPI: PCI: Interrupt link LNKS configured for IRQ 9
[ 2.549739][ T1] iommu: Default domain type: Translated
[ 2.550234][ T1] iommu: DMA domain TLB invalidation policy: lazy mode
[ 2.551069][ T1] pci 0000:00:02.0: vgaarb: setting as boot VGA device
[ 2.551552][ T1] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
[ 2.551558][ T1] pci 0000:00:02.0: vgaarb: bridge control possible
[ 2.552118][ T1] vgaarb: loaded
[ 2.552890][ T1] SCSI subsystem initialized
[ 2.553322][ T1] libata version 3.00 loaded.
[ 2.553821][ T1] ACPI: bus type USB registered
[ 2.554311][ T1] usbcore: registered new interface driver usbfs
[ 2.555594][ T1] usbcore: registered new interface driver hub
[ 2.556144][ T1] usbcore: registered new device driver usb
[ 2.556803][ T1] mc: Linux media interface: v0.10
[ 2.557362][ T1] videodev: Linux video capture interface: v2.00
[ 2.557922][ T1] cec: Failed to create debugfs cec dir
[ 2.558417][ T1] pps_core: LinuxPPS API ver. 1 registered
[ 2.558920][ T1] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <[email protected]>
[ 2.559571][ T1] PTP clock support registered
[ 2.560592][ T1] PCI: Using ACPI for IRQ routing
[ 2.561032][ T1] PCI: pci_cache_line_size set to 64 bytes
[ 2.561603][ T1] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
[ 2.562195][ T1] e820: reserve RAM buffer [mem 0xbffe0000-0xbfffffff]
[ 2.563869][ T1] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
[ 2.564371][ T1] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
[ 2.568656][ T1] clocksource: Switched to clocksource kvm-clock
[ 2.603886][ T1] VFS: Disk quotas dquot_6.6.0
[ 2.604326][ T1] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[ 2.605145][ T1] pnp: PnP ACPI init
[ 2.605820][ T1] pnp 00:03: [dma 2]
[ 2.607006][ T1] pnp: PnP ACPI: found 6 devices
[ 2.607444][ T1] PnPBIOS: Disabled
[ 2.654549][ T1] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[ 2.655450][ T1] intel_rapl_common: driver does not support CPU family 6 model 6
[ 2.656239][ T1] NET: Registered PF_INET protocol family
[ 2.656804][ T1] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
[ 2.657924][ T1] CE: hpet increased min_delta_ns to 5000 nsec
[ 2.657982][ T1] CE: hpet increased min_delta_ns to 7500 nsec
[ 2.658067][ T1] CE: hpet increased min_delta_ns to 11250 nsec
[ 2.658238][ T1] tcp_listen_portaddr_hash hash table entries: 512 (order: 2, 22528 bytes, linear)
[ 2.660688][ T1] TCP established hash table entries: 8192 (order: 3, 32768 bytes, linear)
[ 2.661524][ T1] TCP bind hash table entries: 8192 (order: 6, 327680 bytes, linear)
[ 2.662406][ T1] TCP: Hash tables configured (established 8192 bind 8192)
[ 2.663095][ T1] UDP hash table entries: 512 (order: 3, 49152 bytes, linear)
[ 2.663884][ T1] UDP-Lite hash table entries: 512 (order: 3, 49152 bytes, linear)
[ 2.664683][ T1] NET: Registered PF_UNIX/PF_LOCAL protocol family
[ 2.665548][ T1] RPC: Registered named UNIX socket transport module.
[ 2.666144][ T1] RPC: Registered udp transport module.
[ 2.666622][ T1] RPC: Registered tcp transport module.
[ 2.667098][ T1] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 2.667787][ T1] NET: Registered PF_XDP protocol family
[ 2.668288][ T1] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]
[ 2.668894][ T1] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]
[ 2.669503][ T1] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
[ 2.670166][ T1] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window]
[ 2.670846][ T1] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[ 2.671417][ T1] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[ 2.672047][ T1] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[ 2.672676][ T1] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
[ 2.673494][ T1] PCI: CLS 0 bytes, default 64
[ 2.674101][ T7] Unpacking initramfs...
[ 2.723674][ T10] Callback from call_rcu_tasks() invoked.
[ 2.999818][ T7] Freeing initrd memory: 6712K
[ 3.000768][ T1] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x33c5a5f08b9, max_idle_ns: 440795345409 ns
[ 3.001880][ T1] NatSemi SCx200 Driver
[ 3.303836][ C0] random: fast init done
[ 3.511878][ T9] _warn_unseeded_randomness: 232 callbacks suppressed
[ 3.511882][ T9] random: get_random_u32 called from get_random_order+0xd0/0x130 with crng_init=1
[ 7.526547][ T7] random: get_random_u32 called from allocate_slab+0x221/0xbd0 with crng_init=1
[ 7.529115][ T9] random: get_random_u32 called from stress_one_work+0x21/0xe0 with crng_init=1
[ 7.529177][ T68] random: get_random_u32 called from get_random_order+0xd0/0x130 with crng_init=1
[ 9.531307][ T1] _warn_unseeded_randomness: 1 callbacks suppressed
[ 9.531311][ T1] random: get_random_u32 called from __kmem_cache_create+0x48/0x7c0 with crng_init=1
[ 9.531319][ T1] random: get_random_u32 called from cache_random_seq_create+0xb7/0x250 with crng_init=1
[ 9.531365][ T1] random: get_random_u32 called from allocate_slab+0x221/0xbd0 with crng_init=1
[ 9.716152][ T1] Initialise system trusted keyrings
[ 9.716716][ T1] workingset: timestamp_bits=30 max_order=20 bucket_order=0
[ 9.723158][ T1] zbud: loaded
[ 9.723992][ T1] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[ 9.725282][ T1] efs: 1.0a - http://aeschi.ch.eu.org/efs/
[ 9.725902][ T1] romfs: ROMFS MTD (C) 2007 Red Hat, Inc.
[ 9.726505][ T1] QNX4 filesystem 0.2.3 registered.
[ 9.727134][ T1] JFS: nTxBlock = 8192, nTxLock = 65536
[ 9.731931][ T1] gfs2: GFS2 installed
[ 9.742088][ T1] NET: Registered PF_ALG protocol family
[ 9.742603][ T1] Key type asymmetric registered
[ 9.743047][ T1] Asymmetric key parser 'x509' registered
[ 9.743771][ T1] bounce: pool size: 64 pages
[ 9.744282][ T1] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
[ 9.745014][ T1] io scheduler kyber registered
[ 9.759031][ T1] crc32: CRC_LE_BITS = 1, CRC_BE BITS = 1
[ 9.759527][ T1] crc32: self tests passed, processed 225944 bytes in 6670415 nsec
[ 9.767046][ T1] crc32c: CRC_LE_BITS = 1
[ 9.767423][ T1] crc32c: self tests passed, processed 225944 bytes in 3365492 nsec
[ 10.062697][ T1] crc32_combine: 8373 self tests passed
[ 10.343705][ T1] crc32c_combine: 8373 self tests passed
[ 10.344523][ T1] start plist test
[ 10.347001][ T1] end plist test
[ 10.348086][ T1] switchtec: loaded.
[ 10.348683][ T1] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
[ 10.355768][ T1] ACPI: button: Power Button [PWRF]
[ 10.356297][ T1] EINJ: EINJ table not found.
[ 10.356819][ T1] isapnp: Scanning for PnP cards...
[ 10.713449][ T1] isapnp: No Plug & Play device found
[ 10.861044][ T1] ACPI: \_SB_.LNKC: Enabled at IRQ 11
[ 10.861528][ T1] PCI: setting IRQ 11 as level-triggered
[ 10.886858][ T1] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[ 10.887553][ T1] serial 00:05: GPIO lookup for consumer rs485-term
[ 10.888165][ T1] serial 00:05: using ACPI for GPIO lookup
[ 10.888669][ T1] acpi PNP0501:00: GPIO: looking up rs485-term-gpios
[ 10.889240][ T1] acpi PNP0501:00: GPIO: looking up rs485-term-gpio
[ 10.889811][ T1] serial 00:05: using lookup tables for GPIO lookup
[ 10.890383][ T1] serial 00:05: No GPIO consumer rs485-term found
[ 10.891033][ T1] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[ 10.892621][ T1] Applicom driver: $Id: ac.c,v 1.30 2000/03/22 16:03:57 dwmw2 Exp $
[ 10.893325][ T1] ac.o: No PCI boards found.
[ 10.893720][ T1] ac.o: For an ISA board you must supply memory and irq parameters.
[ 10.894788][ T1] platform pc8736x_gpio.0: NatSemi pc8736x GPIO Driver Initializing
[ 10.895488][ T1] platform pc8736x_gpio.0: no device found
[ 10.896106][ T1] nsc_gpio initializing
[ 10.896477][ T1] telclk_interrupt = 0xf non-mcpbl0010 hw.
[ 10.896985][ T1] Linux agpgart interface v0.103
[ 10.897524][ T1] dummy-irq: no IRQ given. Use irq=N
[ 10.898490][ T1] usbcore: registered new interface driver dln2
[ 10.899155][ T1] _warn_unseeded_randomness: 175 callbacks suppressed
[ 10.899156][ T1] random: get_random_u32 called from __kmem_cache_create+0x48/0x7c0 with crng_init=1
[ 10.899162][ T1] random: get_random_u32 called from cache_random_seq_create+0xb7/0x250 with crng_init=1
[ 10.899183][ T1] random: get_random_u32 called from allocate_slab+0x221/0xbd0 with crng_init=1
[ 10.903868][ T1] Rounding down aligned max_sectors from 4294967295 to 4294967288
[ 10.904625][ T1] db_root: cannot open: /etc/target
[ 10.905182][ T1] mtdoops: mtd device (mtddev=name/number) must be supplied
[ 10.905862][ T1] slram: not enough parameters.
[ 10.907922][ T1] mtd mtd0: GPIO lookup for consumer wp
[ 10.908415][ T1] mtd mtd0: using lookup tables for GPIO lookup
[ 10.908952][ T1] mtd mtd0: No GPIO consumer wp found
[ 10.910396][ T96] kworker/u2:3 (96) used greatest stack depth: 6764 bytes left
[ 10.911319][ T1] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[ 10.912284][ T1] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[ 10.913250][ T1] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[ 10.914137][ T1] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[ 10.915010][ T1] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[ 10.915964][ T1] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[ 10.916861][ T1] nand: device found, Manufacturer ID: 0x98, Chip ID: 0x39
[ 10.917489][ T1] nand: Toshiba NAND 128MiB 1,8V 8-bit
[ 10.917967][ T1] nand: 128 MiB, SLC, erase size: 16 KiB, page size: 512, OOB size: 16
[ 10.918686][ T1] flash size: 128 MiB
[ 10.919030][ T1] page size: 512 bytes
[ 10.919380][ T1] OOB area size: 16 bytes
[ 10.919838][ T1] sector size: 16 KiB
[ 10.920188][ T1] pages number: 262144
[ 10.920537][ T1] pages per sector: 32
[ 10.920888][ T1] bus width: 8
[ 10.921177][ T1] bits in sector size: 14
[ 10.921557][ T1] bits in page size: 9
[ 10.921905][ T1] bits in OOB size: 4
[ 10.922247][ T1] flash size with OOB: 135168 KiB
[ 10.922677][ T1] page address bytes: 4
[ 10.923035][ T1] sector address bytes: 3
[ 10.923414][ T1] options: 0x42
[ 10.924729][ T1] Scanning device for bad blocks
[ 10.940846][ T1] mtd mtd1: GPIO lookup for consumer wp
[ 10.941339][ T1] mtd mtd1: using lookup tables for GPIO lookup
[ 10.941872][ T1] mtd mtd1: No GPIO consumer wp found
[ 10.942429][ T1] mtdblock: MTD device 'NAND 128MiB 1,8V 8-bit' is NAND, please consider using UBI block devices instead.
[ 10.944013][ T1] Creating 1 MTD partitions on "NAND 128MiB 1,8V 8-bit":
[ 10.944630][ T1] 0x000000000000-0x000008000000 : "NAND simulator partition 0"
[ 10.950174][ T1] mtd mtd2: GPIO lookup for consumer wp
[ 10.950660][ T1] mtd mtd2: using lookup tables for GPIO lookup
[ 10.951195][ T1] mtd mtd2: No GPIO consumer wp found
[ 10.951875][ T1] mtdblock: MTD device 'NAND simulator partition 0' is NAND, please consider using UBI block devices instead.
[ 10.953344][ T1] MACsec IEEE 802.1AE
[ 10.954388][ T1] mdio_bus fixed-0: GPIO lookup for consumer reset
[ 10.954959][ T1] mdio_bus fixed-0: using lookup tables for GPIO lookup
[ 10.955561][ T1] mdio_bus fixed-0: No GPIO consumer reset found
[ 10.956214][ T1] libphy: Fixed MDIO Bus: probed
[ 10.957361][ T1] e1000: Intel(R) PRO/1000 Network Driver
[ 10.957859][ T1] e1000: Copyright (c) 1999-2006 Intel Corporation.
[ 11.105215][ T1] ACPI: \_SB_.LNKD: Enabled at IRQ 11
[ 11.445953][ T1] e1000 0000:00:04.0 eth0: (PCI:33MHz:32-bit) 52:54:00:12:34:56
[ 11.446657][ T1] e1000 0000:00:04.0 eth0: Intel(R) PRO/1000 Network Connection
[ 11.447397][ T1] PPP generic driver version 2.4.2
[ 11.448058][ T1] usbcore: registered new interface driver lan78xx
[ 11.448932][ T1] VFIO - User Level meta-driver version: 0.3
[ 11.449748][ T1] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[ 11.450418][ T1] driver u132_hcd
[ 11.450850][ T1] usbcore: registered new interface driver microtekX6
[ 11.451448][ T1] usbcore: registered new interface driver emi26 - firmware loader
[ 11.452174][ T1] ftdi_elan: driver ftdi-elan
[ 11.452599][ T1] usbcore: registered new interface driver ftdi-elan
[ 11.453192][ T1] usbcore: registered new interface driver iowarrior
[ 11.453787][ T1] usbcore: registered new interface driver ldusb
[ 11.454346][ T1] usbcore: registered new interface driver legousbtower
[ 11.454973][ T1] usbcore: registered new interface driver usbtest
[ 11.455548][ T1] usbcore: registered new interface driver trancevibrator
[ 11.456225][ T1] usbcore: registered new interface driver yurex
[ 11.456869][ T1] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
[ 11.458241][ T1] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 11.458904][ T1] serio: i8042 AUX port at 0x60,0x64 irq 12
[ 11.460037][ T5] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1
[ 11.462860][ T1] rtc-test rtc-test.0: registered as rtc0
[ 11.463371][ T1] rtc-test rtc-test.0: setting system clock to 2021-09-18T01:49:59 UTC (1631929799)
[ 11.464617][ T1] rtc-test rtc-test.1: registered as rtc1
[ 11.465293][ T1] rtc-test rtc-test.2: registered as rtc2
[ 11.465866][ T1] i2c_dev: i2c /dev entries driver
[ 11.466473][ T1] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0
[ 11.468866][ T1] eeprom 0-0050: eeprom driver is deprecated, please use at24 instead
[ 11.471018][ T1] eeprom 0-0051: eeprom driver is deprecated, please use at24 instead
[ 11.473212][ T1] eeprom 0-0052: eeprom driver is deprecated, please use at24 instead
[ 11.475335][ T1] eeprom 0-0053: eeprom driver is deprecated, please use at24 instead
[ 11.477489][ T1] eeprom 0-0054: eeprom driver is deprecated, please use at24 instead
[ 11.479704][ T1] eeprom 0-0055: eeprom driver is deprecated, please use at24 instead
[ 11.481982][ T1] eeprom 0-0056: eeprom driver is deprecated, please use at24 instead
[ 11.489331][ T1] eeprom 0-0057: eeprom driver is deprecated, please use at24 instead
[ 11.490817][ T1] isa i2c-pca-isa.0: Please specify I/O base
[ 11.493416][ T1] dvbdev: DVB: registering new adapter (dvb_vidtv_bridge)
[ 11.495303][ T1] i2c i2c-1: DVB: registering adapter 0 frontend 0 (Dummy demod for DVB-T/T2/C/S/S2)...
[ 11.496901][ T1] dvbdev: dvb_create_media_entity: media entity 'Dummy demod for DVB-T/T2/C/S/S2' registered.
[ 11.500240][ T1] dvbdev: dvb_create_media_entity: media entity 'dvb-demux' registered.
[ 11.501575][ T1] vidtv vidtv.0: Successfully initialized vidtv!
[ 11.502354][ T1] Driver for 1-wire Dallas network protocol.
[ 11.502937][ T1] usbcore: registered new interface driver DS9490R
[ 11.628376][ T1] sdhci: Secure Digital Host Controller Interface driver
[ 11.629403][ T1] sdhci: Copyright(c) Pierre Ossman
[ 11.630190][ T1] wbsd: Winbond W83L51xD SD/MMC card interface driver
[ 11.631161][ T1] wbsd: Copyright(c) Pierre Ossman
[ 11.632071][ T1] ledtrig-cpu: registered to indicate activity on CPUs
[ 11.634071][ T1] usbcore: registered new interface driver usbhid
[ 11.635007][ T1] usbhid: USB HID core driver
[ 11.636268][ T1] IDT PCI-E Non-Transparent Bridge Driver 2.0
[ 11.637343][ T1] Software Queue-Pair Transport over NTB, version 4
[ 11.638432][ T1] usbcore: registered new interface driver hdm_usb
[ 11.640331][ T1] NET: Registered PF_INET6 protocol family
[ 11.642263][ T1] Segment Routing with IPv6
[ 11.642945][ T1] In-situ OAM (IOAM) with IPv6
[ 11.643788][ T1] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
[ 11.644755][ T1] NET: Registered PF_PACKET protocol family
[ 11.645308][ T1] can: controller area network core
[ 11.645842][ T1] NET: Registered PF_CAN protocol family
[ 11.646329][ T1] can: raw protocol
[ 11.646667][ T1] can: broadcast manager protocol
[ 11.647104][ T1] can: netlink gateway - max_hops=1
[ 11.647800][ T1] 9pnet: Installing 9P2000 support
[ 11.649059][ T1] batman_adv: B.A.T.M.A.N. advanced 2021.3 (compatibility version 15) loaded
[ 11.650343][ T1] sched_clock: Marking stable (11640208064, 7381146)->(11676156873, -28567663)
[ 11.651206][ T1] registered taskstats version 1
[ 11.651704][ T1] Loading compiled-in X.509 certificates
[ 11.652192][ T1] debug_vm_pgtable: [debug_vm_pgtable ]: Validating architecture page table helpers
[ 11.654322][ T1] Key type ._fscrypt registered
[ 11.654758][ T1] Key type .fscrypt registered
[ 11.655169][ T1] Key type fscrypt-provisioning registered
[ 11.655819][ T1] fs-verity: Initialized fs-verity
[ 11.657513][ T1] Key type encrypted registered
[ 11.658191][ T1] UBI error: cannot create "ubi" debugfs directory, error -2
[ 11.659248][ T1] UBI error: cannot initialize UBI, error -2
[ 12.073468][ T5] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3
[ 12.079546][ T1] _warn_unseeded_randomness: 111 callbacks suppressed
[ 12.079550][ T1] random: get_random_bytes called from ip_auto_config+0x52b/0x10d3 with crng_init=1
[ 12.084443][ T5] e1000: eth0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX
[ 12.087817][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[ 12.089422][ T5] random: get_random_bytes called from addrconf_dad_kick+0x9b/0x140 with crng_init=1
[ 12.107865][ T1] Sending DHCP requests .
[ 12.107874][ T1] random: get_random_bytes called from ic_dynamic+0x1bd/0x838 with crng_init=1
[ 12.108143][ T1] , OK
[ 12.110590][ T1] IP-Config: Got DHCP answer from 10.0.2.2, my address is 10.0.2.15
[ 12.111875][ T1] IP-Config: Complete:
[ 12.112467][ T1] device=eth0, hwaddr=52:54:00:12:34:56, ipaddr=10.0.2.15, mask=255.255.255.0, gw=10.0.2.2
[ 12.113964][ T1] host=10.0.2.15, domain=, nis-domain=(none)
[ 12.114874][ T1] bootserver=10.0.2.2, rootserver=10.0.2.2, rootpath=
[ 12.114878][ T1] nameserver0=10.0.2.3
[ 12.120151][ T1] Freeing unused kernel image (initmem) memory: 1028K
[ 12.128086][ T1] Write protecting kernel text and read-only data: 31476k
[ 12.128808][ T1] rodata_test: all tests were successful
[ 12.139988][ T1] Run /init as init process
[ 12.140448][ T1] with arguments:
[ 12.140810][ T1] /init
[ 12.141106][ T1] with environment:
[ 12.141569][ T1] HOME=/
[ 12.142027][ T1] TERM=linux
[ 12.142532][ T1] user=$(whoami)
[ 12.143088][ T1] job=/lkp/jobs/scheduled/vm-snb-43/trinity-group-02-99999-yocto-i386-minimal-20190520.cgz-d64696905554e919321e31afc210606653b8f6a4-20210911-24127-1x1tp2w-8.yaml
[ 12.145528][ T1] ARCH=i386
[ 12.146038][ T1] kconfig=i386-randconfig-r015-20210910
[ 12.146885][ T1] branch=trace/ftrace/core
[ 12.147573][ T1] commit=d64696905554e919321e31afc210606653b8f6a4
[ 12.148618][ T1] BOOT_IMAGE=/pkg/linux/i386-randconfig-r015-20210910/gcc-9/d64696905554e919321e31afc210606653b8f6a4/vmlinuz-5.12.0-gd64696905554
[ 12.150596][ T1] max_uptime=2100
[ 12.151168][ T1] RESULT_ROOT=/result/trinity/group-02-99999/vm-snb/yocto-i386-minimal-20190520.cgz/i386-randconfig-r015-20210910/gcc-9/d64696905554e919321e31afc210606653b8f6a4/8
[ 12.152932][ T1] LKP_LOCAL_RUN=1
[ 12.153314][ T1] selinux=0
[ 12.153611][ T1] apic=debug
[ 12.153915][ T1] softlockup_panic=1
[ 12.154278][ T1] prompt_ramdisk=0
[ 12.154627][ T1] vga=normal
[ 12.154931][ T1] result_service=9p/virtfs_mount
INIT: version 2.88 booting
[ 12.163098][ T120] mount (120) used greatest stack depth: 6684 bytes left
[ 12.167439][ T122] rc (122) used greatest stack depth: 6520 bytes left
Starting udev
[ 12.197692][ T143] pidof (143) used greatest stack depth: 6436 bytes left
[ 12.200700][ T144] udevd[144]: starting version 3.2.7
[ 12.201464][ T144] random: udevd: uninitialized urandom read (16 bytes read)
[ 12.202180][ T144] random: udevd: uninitialized urandom read (16 bytes read)
[ 12.202833][ T144] random: udevd: uninitialized urandom read (16 bytes read)
[ 12.205343][ T144] udevd[144]: specified group 'kvm' unknown
[ 12.209366][ T145] udevd[145]: starting eudev-3.2.7
[ 12.248942][ T145] udevd[145]: specified group 'kvm' unknown
[ 12.359690][ T147] udevadm (147) used greatest stack depth: 6188 bytes left
[ 13.515054][ T163] _warn_unseeded_randomness: 196 callbacks suppressed
[ 13.515062][ T163] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 13.515073][ T163] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 13.515082][ T163] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
depmod: ERROR: could not open directory /lib/modules/5.15.0-rc1-00221-g4357f03d6611: No such file or directory
depmod: WARNING: -e needs -E or -F
depmod: ERROR: could not open directory /lib/modules/5.15.0-rc1-00221-g4357f03d6611: No such file or directory
depmod: FATAL: could not search modules: No such file or directory
hwclock: can't open '/dev/misc/rtc': No such file or directory
[ 13.710909][ T291] urandom_read: 3 callbacks suppressed
[ 13.710912][ T291] random: dd: uninitialized urandom read (512 bytes read)
INIT: Entering runlevel: 5
Configuring network interfaces... ip: RTNETLINK answers: File exists
hwclock: can't open '/dev/misc/rtc': No such file or directory
Starting syslogd/klogd: done
/etc/rc5.d/S77lkp-bootstrap: /lkp/jobs/scheduled/vm-snb-43/trinity-group-02-99999-yocto-i386-minimal-20190520.cgz-d64696905554e919321e31afc210606653b8f6a4-20210911-24127-1x1tp2w-8.sh: line 123: start: not found
PATH=/sbin:/usr/sbin:/bin:/usr/bin:/lkp/root/src/bin
[ 13.791208][ T183] bootlogd (183) used greatest stack depth: 6136 bytes left
export VM_VIRTFS=1 due to result service 9p/virtfs_mount
LKP: HOSTNAME vm-snb-43, MAC 52:54:00:12:34:56, kernel 5.15.0-rc1-00221-g4357f03d6611 1, serial console /dev/ttyS0
Poky (Yocto Project Reference Distro) 2.7+snapshot vm-snb-43 /dev/ttyS0
INIT: Id "S1" respawning too fast: disabled for 5 minutes
[ 14.815728][ T347] mkdir: can't create directory '/sys/kernel/debug': Operation not permitted
[ 14.815728][ T347] mount: mounting debug on /sys/kernel/debug failed: No such file or directory
[ 14.815728][ T347] mount: mounting 9p/virtfs_mount on //result/trinity/group-02-99999/vm-snb/yocto-i386-minimal-20190520.cgz/i386-randconfig-r015-20210910/gcc-9/d64696905554e919321e31afc210606653b8f6a4/8 failed: No such device
[ 15.071963][ T609] _warn_unseeded_randomness: 2110 callbacks suppressed
[ 15.071970][ T609] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 15.071980][ T609] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 15.071988][ T609] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 15.135814][ T622] random: trinity: uninitialized urandom read (4 bytes read)
[ 15.505088][ T149] udevd (149) used greatest stack depth: 6132 bytes left
[ 16.077349][ T1506] _warn_unseeded_randomness: 2734 callbacks suppressed
[ 16.077352][ T1506] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 16.077357][ T1506] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 16.077362][ T1506] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 17.079904][ T2445] _warn_unseeded_randomness: 2821 callbacks suppressed
[ 17.079907][ T2445] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 17.079911][ T2445] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 17.079914][ T2445] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 18.160090][ T2754] _warn_unseeded_randomness: 946 callbacks suppressed
[ 18.160097][ T2754] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 18.160107][ T2754] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 18.160114][ T2754] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 19.174054][ T2757] _warn_unseeded_randomness: 13 callbacks suppressed
[ 19.174061][ T2757] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 19.174071][ T2757] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 19.174079][ T2757] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 20.188003][ T2760] _warn_unseeded_randomness: 13 callbacks suppressed
[ 20.188011][ T2760] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 20.188021][ T2760] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 20.188029][ T2760] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 21.202771][ T2763] _warn_unseeded_randomness: 13 callbacks suppressed
[ 21.202778][ T2763] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 21.202788][ T2763] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 21.202798][ T2763] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 22.217261][ T2766] _warn_unseeded_randomness: 13 callbacks suppressed
[ 22.217270][ T2766] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 22.217286][ T2766] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 22.217325][ T2766] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 23.231477][ T2769] _warn_unseeded_randomness: 13 callbacks suppressed
[ 23.231485][ T2769] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 23.231496][ T2769] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 23.231505][ T2769] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 24.247489][ T2773] _warn_unseeded_randomness: 19 callbacks suppressed
[ 24.247497][ T2773] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 24.247508][ T2773] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 24.247517][ T2773] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 25.264692][ T2779] _warn_unseeded_randomness: 29 callbacks suppressed
[ 25.264700][ T2779] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 25.264710][ T2779] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 25.264720][ T2779] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 26.278903][ T2782] _warn_unseeded_randomness: 13 callbacks suppressed
[ 26.278912][ T2782] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 26.278925][ T2782] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 26.278935][ T2782] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 27.294938][ T2785] _warn_unseeded_randomness: 13 callbacks suppressed
[ 27.294947][ T2785] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 27.294960][ T2785] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 27.294971][ T2785] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 28.260754][ T2753] trinity-main uses obsolete (PF_INET,SOCK_PACKET)
[ 28.310586][ T2912] _warn_unseeded_randomness: 18 callbacks suppressed
[ 28.310592][ T2912] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 28.310601][ T2912] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 28.310608][ T2912] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 29.322570][ T2915] _warn_unseeded_randomness: 15 callbacks suppressed
[ 29.322575][ T2915] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 29.322581][ T2915] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 29.322586][ T2915] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 30.303697][ T2911] CE: hpet increased min_delta_ns to 16875 nsec
[ 30.303897][ T2911] CE: hpet increased min_delta_ns to 25312 nsec
[ 30.304082][ T2911] CE: hpet increased min_delta_ns to 37968 nsec
[ 30.336566][ T2918] _warn_unseeded_randomness: 14 callbacks suppressed
[ 30.336571][ T2918] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 30.336578][ T2918] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 30.336583][ T2918] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 31.317804][ T2909] CE: hpet increased min_delta_ns to 56952 nsec
[ 31.348020][ T2921] _warn_unseeded_randomness: 14 callbacks suppressed
[ 31.348026][ T2921] random: get_random_u32 called from allocate_slab+0x221/0xbd0 with crng_init=1
[ 31.348233][ T2921] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 31.348241][ T2921] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 32.361691][ T2924] _warn_unseeded_randomness: 15 callbacks suppressed
[ 32.361698][ T2924] random: get_random_u32 called from allocate_slab+0x221/0xbd0 with crng_init=1
[ 32.361922][ T2924] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 32.361931][ T2924] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 33.375338][ T2927] _warn_unseeded_randomness: 15 callbacks suppressed
[ 33.375343][ T2927] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 33.375350][ T2927] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 33.375355][ T2927] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 34.386633][ T2931] _warn_unseeded_randomness: 23 callbacks suppressed
[ 34.386639][ T2931] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 34.386648][ T2931] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 34.386654][ T2931] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 35.402110][ T2934] _warn_unseeded_randomness: 14 callbacks suppressed
[ 35.402116][ T2934] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 35.402126][ T2934] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 35.402134][ T2934] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 36.416956][ T2940] _warn_unseeded_randomness: 32 callbacks suppressed
[ 36.416963][ T2940] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 36.416972][ T2940] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 36.416980][ T2940] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 37.430119][ T2943] _warn_unseeded_randomness: 15 callbacks suppressed
[ 37.430127][ T2943] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 37.430137][ T2943] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 37.430146][ T2943] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 38.447454][ T2947] _warn_unseeded_randomness: 15 callbacks suppressed
[ 38.447464][ T2947] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 38.447479][ T2947] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 38.447491][ T2947] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 39.464985][ T2950] _warn_unseeded_randomness: 13 callbacks suppressed
[ 39.464996][ T2950] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 39.465012][ T2950] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 39.465026][ T2950] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 40.484751][ T2953] _warn_unseeded_randomness: 15 callbacks suppressed
[ 40.484763][ T2953] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 40.484780][ T2953] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 40.484795][ T2953] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 41.501952][ T2956] _warn_unseeded_randomness: 13 callbacks suppressed
[ 41.501964][ T2956] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 41.501981][ T2956] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 41.501996][ T2956] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 42.518088][ T2959] _warn_unseeded_randomness: 17 callbacks suppressed
[ 42.518098][ T2959] random: get_random_u32 called from arch_rnd+0x34/0x80 with crng_init=1
[ 42.518115][ T2959] random: get_random_u32 called from randomize_stack_top+0x4b/0x80 with crng_init=1
[ 42.518128][ T2959] random: get_random_u32 called from arch_align_stack+0x5b/0x80 with crng_init=1
[ 43.414471][ C0] random: crng init done
[ 43.416074][ C0] random: 14 get_random_xx warning(s) missed due to ratelimiting
[ 72.318904][ T2909] trinity-c1 (2909) used greatest stack depth: 6012 bytes left
[ 75.338835][ T3061] CE: hpet increased min_delta_ns to 85428 nsec
INIT: Id "1" respawning too fast: disabled for 5 minutes
INIT: Id "S1" respawning too fast: disabled for 5 minutes
[ 470.838084][ T3484] ------------[ cut here ]------------
[ 470.838606][ T3484] WARNING: CPU: 0 PID: 3484 at kernel/ucount.c:253 dec_ucount+0x9e/0xf0
[ 470.839356][ T3484] Modules linked in:
[ 470.839950][ T3484] CPU: 0 PID: 3484 Comm: trinity-c1 Not tainted 5.15.0-rc1-00221-g4357f03d6611 #1
[ 470.840778][ T3484] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 470.841609][ T3484] EIP: dec_ucount+0x9e/0xf0
[ 470.842013][ T3484] Code: c3 00 0f b1 0a 74 b5 83 05 98 46 73 c3 01 89 c1 83 15 9c 46 73 c3 00 83 e9 01 79 d8 83 05 a8 46 73 c3 01 83 15 ac 46 73 c3 00 <0f> 0b 8b 43 08 83 05 b0 46 73 c3 01 83 15 b4 46 73 c3 00 8b 98 9c
[ 470.843840][ C0] BUG: kernel NULL pointer dereference, address: 0000019c
[ 470.843843][ C0] #PF: supervisor read access in kernel mode
[ 470.843844][ C0] #PF: error_code(0x0000) - not-present page
[ 470.843845][ C0] *pde = 00000000
[ 470.843848][ C0] Oops: 0000 [#1] PREEMPT
[ 470.843849][ C0] CPU: 0 PID: 3484 Comm: trinity-c1 Not tainted 5.15.0-rc1-00221-g4357f03d6611 #1
[ 470.843851][ C0] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 470.843852][ C0] EIP: dec_ucount+0xb1/0xf0
[ 470.843854][ C0] Code: 46 73 c3 00 83 e9 01 79 d8 83 05 a8 46 73 c3 01 83 15 ac 46 73 c3 00 0f 0b 8b 43 08 83 05 b0 46 73 c3 01 83 15 b4 46 73 c3 00 <8b> 98 9c 01 00 00 85 db 75 90 83 05 b8 46 73 c3 01 89 f0 83 15 bc
[ 470.843855][ C0] EAX: 00000000 EBX: c56eb240 ECX: ffffffff EDX: c56eb258
[ 470.843857][ C0] ESI: c56eb1e0 EDI: 00000018 EBP: c0181f4c ESP: c0181f40
[ 470.843858][ C0] DS: 007b ES: 007b FS: 0000 GS: 0000 SS: 0068 EFLAGS: 00010246
[ 470.843861][ C0] CR0: 80050033 CR2: 0000019c CR3: 057fc000 CR4: 00000690
[ 470.843863][ C0] Call Trace:
[ 470.843863][ C0] <SOFTIRQ>
[ 470.843865][ C0] delayed_free_pidns+0x25/0x180
[ 470.843868][ C0] rcu_do_batch.constprop.74+0x1ba/0x930
[ 470.843872][ C0] ? rcu_do_batch.constprop.74+0x174/0x930
[ 470.843875][ C0] rcu_core+0x44d/0xad0
[ 470.843878][ C0] rcu_core_si+0x16/0x30
[ 470.843881][ C0] __do_softirq+0x13f/0x8cf
[ 470.843884][ C0] ? _paravirt_nop+0x1/0x1
[ 470.843886][ C0] do_softirq_own_stack+0x2a/0x40
[ 470.843890][ C0] </SOFTIRQ>
[ 470.843891][ C0] irq_exit_rcu+0x114/0x1b0
[ 470.843894][ C0] common_interrupt+0x27/0x40
[ 470.843896][ C0] asm_common_interrupt+0x119/0x120
[ 470.843898][ C0] EIP: console_unlock+0x3f6/0x9a0
[ 470.843900][ C0] Code: c3 01 83 15 5c ca d1 c3 00 f6 c4 02 0f 85 2a 05 00 00 8b 75 88 85 f6 74 0f 83 05 70 ca d1 c3 01 83 15 74 ca d1 c3 00 fb 85 db <0f> 85 64 05 00 00 8b 8d 7c ff ff ff 83 05 78 ca d1 c3 01 83 15 7c
[ 470.843901][ C0] EAX: 00000046 EBX: 00000000 ECX: 00000006 EDX: 00000000
[ 470.843902][ C0] ESI: 00000200 EDI: 00000200 EBP: cc0a3c70 ESP: cc0a3bec
[ 470.843904][ C0] DS: 007b ES: 007b FS: 0000 GS: 0000 SS: 0068 EFLAGS: 00000246
[ 470.843906][ C0] ? trace_event_raw_event_lock_acquire+0x9b/0x200
[ 470.843908][ C0] ? trace_find_next_entry_inc+0xf0/0x120
[ 470.843911][ C0] ? trace_find_next_entry_inc+0xf0/0x120
[ 470.843913][ C0] ? console_unlock+0x3f6/0x9a0
[ 470.843917][ C0] vprintk_emit+0x2d1/0x580
[ 470.843919][ C0] ? dec_ucount+0x74/0xf0
[ 470.843921][ C0] vprintk_default+0x1e/0x30
[ 470.843923][ C0] vprintk+0x99/0xd0
[ 470.843924][ C0] ? dec_ucount+0x74/0xf0
[ 470.843925][ C0] _printk+0x1d/0x2d
[ 470.843929][ C0] show_opcodes.cold.6+0x23/0x39
[ 470.843933][ C0] ? sed_ioctl+0x5c3/0x1150
[ 470.843937][ C0] show_ip+0x3c/0x54
[ 470.843939][ C0] ? dec_ucount+0x9e/0xf0
[ 470.843941][ C0] __show_regs+0x3d/0x1c0
[ 470.843943][ C0] ? dec_ucount+0x9e/0xf0
[ 470.843945][ C0] show_regs+0x5d/0x90
[ 470.843947][ C0] __warn.cold.6+0x9b/0x19e
[ 470.843949][ C0] ? dec_ucount+0x9e/0xf0
[ 470.843950][ C0] report_bug+0x121/0x1d0
[ 470.843954][ C0] ? exc_overflow+0x40/0x40
[ 470.843955][ C0] handle_bug+0x2d/0x60
[ 470.843957][ C0] exc_invalid_op+0x1b/0x60
[ 470.843958][ C0] handle_exception+0x115/0x115
[ 470.843960][ C0] EIP: dec_ucount+0x9e/0xf0
[ 470.843961][ C0] Code: c3 00 0f b1 0a 74 b5 83 05 98 46 73 c3 01 89 c1 83 15 9c 46 73 c3 00 83 e9 01 79 d8 83 05 a8 46 73 c3 01 83 15 ac 46 73 c3 00 <0f> 0b 8b 43 08 83 05 b0 46 73 c3 01 83 15 b4 46 73 c3 00 8b 98 9c
[ 470.843962][ C0] EAX: 00000000 EBX: c56eb240 ECX: ffffffff EDX: c56eb274
[ 470.843964][ C0] ESI: c56eb240 EDI: 00000034 EBP: cc0a3e34 ESP: cc0a3e28
[ 470.843965][ C0] DS: 007b ES: 007b FS: 0000 GS: 0000 SS: 0068 EFLAGS: 00010246
[ 470.843967][ C0] ? exc_overflow+0x40/0x40
[ 470.843969][ C0] ? exc_overflow+0x40/0x40
[ 470.843970][ C0] ? dec_ucount+0x9e/0xf0
[ 470.843972][ C0] inotify_free_group_priv+0x60/0x90
[ 470.843974][ C0] fsnotify_put_group+0xb3/0x160
[ 470.843977][ C0] fsnotify_destroy_group+0xef/0x1c0
[ 470.843979][ C0] ? locks_remove_file+0x2b7/0x5f0
[ 470.843982][ C0] inotify_release+0x1c/0x30
[ 470.843984][ C0] __fput+0xe5/0x5a0
[ 470.843987][ C0] ____fput+0x16/0x30
[ 470.843989][ C0] task_work_run+0xaf/0x150
[ 470.843992][ C0] do_exit+0x621/0x1040
[ 470.843995][ C0] ? _raw_spin_unlock_irq+0x63/0xf0
[ 470.843996][ C0] do_group_exit+0x3b/0x140
[ 470.843999][ C0] get_signal+0x2a8/0x15d0
[ 470.844002][ C0] arch_do_signal_or_restart+0xb6/0x490
[ 470.844005][ C0] ? find_held_lock+0x34/0x130
[ 470.844007][ C0] ? syscall_exit_to_user_mode+0x1a/0x50
[ 470.844009][ C0] ? exit_to_user_mode_prepare+0x298/0x5f0
[ 470.844012][ C0] ? syscall_exit_to_user_mode+0x1a/0x50
[ 470.844013][ C0] ? trace_hardirqs_on+0x67/0x2a0
[ 470.844016][ C0] exit_to_user_mode_prepare+0x4b7/0x5f0
[ 470.844018][ C0] syscall_exit_to_user_mode+0x1a/0x50
[ 470.844020][ C0] do_int80_syscall_32+0x38/0x80
[ 470.844022][ C0] entry_INT80_32+0x107/0x107
[ 470.844023][ C0] EIP: 0x809b132
[ 470.844025][ C0] Code: Unable to access opcode bytes at RIP 0x809b108.
[ 470.844026][ C0] EAX: fffffe00 EBX: 0000013c ECX: 0925f718 EDX: 00000001
[ 470.844027][ C0] ESI: 3024f060 EDI: 0002010a EBP: 04000000 ESP: bfbaeed8
[ 470.844028][ C0] DS: 007b ES: 007b FS: 0000 GS: 0000 SS: 007b EFLAGS: 00000296
[ 470.844031][ C0] Modules linked in:
[ 470.844036][ C0] CR2: 000000000000019c
[ 470.844038][ C0] ---[ end trace 2e62bdafeb2ef073 ]---
[ 470.844039][ C0] EIP: dec_ucount+0xb1/0xf0
[ 470.844040][ C0] Code: 46 73 c3 00 83 e9 01 79 d8 83 05 a8 46 73 c3 01 83 15 ac 46 73 c3 00 0f 0b 8b 43 08 83 05 b0 46 73 c3 01 83 15 b4 46 73 c3 00 <8b> 98 9c 01 00 00 85 db 75 90 83 05 b8 46 73 c3 01 89 f0 83 15 bc
[ 470.844042][ C0] EAX: 00000000 EBX: c56eb240 ECX: ffffffff EDX: c56eb258
[ 470.844043][ C0] ESI: c56eb1e0 EDI: 00000018 EBP: c0181f4c ESP: c0181f40
[ 470.844044][ C0] DS: 007b ES: 007b FS: 0000 GS: 0000 SS: 0068 EFLAGS: 00010246
[ 470.844046][ C0] CR0: 80050033 CR2: 0000019c CR3: 057fc000 CR4: 00000690
[ 470.844047][ C0] Kernel panic - not syncing: Fatal exception in interrupt
[ 470.844049][ C0] Kernel Offset: disabled
>
> $ grep PRETTY_NAME /etc/os-release
> PRETTY_NAME="Fedora 34 (Workstation Edition)"
>
> $ git clone git://git.kernel.org/pub/scm/linux/kernel/git/torvalds/linux.git
> $ cd linux
>
> $ git describe
> v5.15-rc1-19-g3ca706c189db
>
> $ cp /tmp/config-5.12.0-gd64696905554 .config
>
> $ make -j8 ARCH=i386 olddefconfig prepare modules_prepare bzImage
> ...
> Kernel: arch/x86/boot/bzImage is ready (#2)
>
> $ git clone https://github.com/intel/lkp-tests.git
> $ cd lkp-tests
>
> $ git describe --always
> 64ef6f2b
>
> $ bin/lkp qemu -k ../arch/x86/boot/bzImage ../job-script
> The approx. disk space requirements are
>
> 10M simple boot test in rootfs openwrt
> 50M simple boot test in rootfs debian
> 1G plan to run a number of different tests
> 100G or more IO tests
>
> Please enter a dir with enough disk space, or simply press Enter to accept the
> default.
> You may still symlink /home/legion/.lkp to a more suitable place in future.
> /home/legion/.lkp =>
> ~/scm/kernel/linux/lkp-tests/pkg/lkp-src ~/scm/kernel/linux/lkp-tests
> x86_64
> ==> Making package: lkp-src 0-1 (Ср 15 сен 2021 13:11:17 CEST)
> ==> Checking runtime dependencies...
> ==> Checking buildtime dependencies...
> ==> WARNING: Using existing $srcdir/ tree
> ==> Removing existing $pkgdir/ directory...
> ==> Starting build()...
> make: Entering directory '/home/legion/scm/kernel/linux/lkp-tests/bin/event'
> gcc -m32 -Wl,-O1,--sort-common,--as-needed,-z,relro -static -o wakeup
> wakeup.o
> rm -f wakeup.o
> strip wakeup
> strip: wakeup[.gnu.build.attributes__libc_freeres_fn]: Warning: version note
> missing - assuming version 3
> make: Leaving directory '/home/legion/scm/kernel/linux/lkp-tests/bin/event'
> ==> Entering fakeroot environment...
> x86_64
> ==> Starting package()...
> ==> Creating package "lkp-src"...
> 8808 blocks
> renamed '/home/legion/.lkp/cache/lkp-i386.cgz.tmp' ->
> '/home/legion/.lkp/cache/lkp-i386.cgz'
> ==> Leaving fakeroot environment.
> ==> Finished making: lkp-src 0-1 (Ср 15 сен 2021 13:16:19 CEST)
> ~/scm/kernel/linux/lkp-tests
> 11 blocks
> result_root: /home/legion/.lkp//result/trinity/group-02-99999/vm-snb/yocto-
> i386-minimal-20190520.cgz/i386-randconfig-r015-20210910/gcc-
> 9/d64696905554e919321e31afc210606653b8f6a4/0
> downloading initrds ...
> /usr/bin/wget -q --timeout=1800 --tries=1 --local-encoding=UTF-8
> https://download.01.org/0day-ci/lkp-qemu/osimage/yocto/yocto-i386-
> minimal-20190520.cgz -N -P /home/legion/.lkp/cache/osimage/yocto
> 17916 blocks
> /usr/bin/wget -q --timeout=1800 --tries=1 --local-encoding=UTF-8
> https://download.01.org/0day-ci/lkp-qemu/osimage/pkg/yocto-i386-minimal-
> 20190520.cgz/trinity-i386.cgz -N -P
> /home/legion/.lkp/cache/osimage/pkg/yocto-i386-minimal-20190520.cgz
> 46817 blocks
> exec command: qemu-system-x86_64 -enable-kvm -fsdev
> local,id=test_dev,path=/home/legion/.lkp//result/trinity/group-02-99999/vm-
> snb/yocto-i386-minimal-20190520.cgz/i386-randconfig-r015-20210910/gcc-
> 9/d64696905554e919321e31afc210606653b8f6a4/0,security_model=none -
> device virtio-9p-pci,fsdev=test_dev,mount_tag=9p/virtfs_mount -
> kernel ../arch/x86/boot/bzImage -append root=/dev/ram0 user=$(whoami)
> job=/lkp/jobs/scheduled/vm-snb-43/trinity-group-02-99999-yocto-i386-
> minimal-20190520.cgz-d64696905554e919321e31afc210606653b8f6a4-
> 20210911-24127-1x1tp2w-8.yaml ARCH=i386 kconfig=i386-randconfig-r015-
> 20210910 branch=trace/ftrace/core
> commit=d64696905554e919321e31afc210606653b8f6a4
> BOOT_IMAGE=/pkg/linux/i386-randconfig-r015-20210910/gcc-
> 9/d64696905554e919321e31afc210606653b8f6a4/vmlinuz-5.12.0-
> gd64696905554 vmalloc=128M initramfs_async=0 page_owner=on
> max_uptime=2100 RESULT_ROOT=/result/trinity/group-02-99999/vm-
> snb/yocto-i386-minimal-20190520.cgz/i386-randconfig-r015-20210910/gcc-
> 9/d64696905554e919321e31afc210606653b8f6a4/8 LKP_LOCAL_RUN=1
> selinux=0 debug apic=debug sysrq_always_enabled
> rcupdate.rcu_cpu_stall_timeout=100 net.ifnames=0 printk.devkmsg=on panic=-
> 1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2
> prompt_ramdisk=0 drbd.minor_count=8 systemd.log_level=err ignore_loglevel
> console=tty0 earlyprintk=ttyS0,115200 console=ttyS0,115200 vga=normal rw
> ip=dhcp result_service=9p/virtfs_mount -initrd
> /home/legion/.lkp/cache/final_initrd -smp 2 -m 5390M -no-reboot -watchdog
> i6300esb -rtc base=localtime -device e1000,netdev=net0 -netdev user,id=net0 -
> display none -monitor null -serial stdio
> early console in setup code
> Probing EDD (edd=off to disable)... ok
> [ 0.000000] Linux version 5.15.0-rc1+ ([email protected]) (gcc (GCC) 11.1.1
> 20210531 (Red Hat 11.1.1-3), GNU ld version 2.35.1-41.fc34) #2 SMP Wed Sep
> 15 13:03:08 CEST 2021
> [ 0.000000] x86/fpu: x87 FPU will use FXSAVE
> [ 0.000000] signal: max sigframe size: 1440
> [ 0.000000] BIOS-provided physical RAM map:
> [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff]
> usable
> [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff]
> reserved
> [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff]
> reserved
> [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bffdffff]
> usable
> [ 0.000000] BIOS-e820: [mem 0x00000000bffe0000-0x00000000bfffffff]
> reserved
> [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff]
> reserved
> [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff]
> reserved
> [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x0000000190dfffff]
> usable
> [ 0.000000] printk: debug: ignoring loglevel setting.
> [ 0.000000] printk: bootconsole [earlyser0] enabled
> [ 0.000000] Notice: NX (Execute Disable) protection cannot be enabled: non-
> PAE kernel!
> [ 0.000000] SMBIOS 2.8 present.
> [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.14.0-4.fc34
> 04/01/2014
> [ 0.000000] Hypervisor detected: KVM
> [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
> [ 0.000000] kvm-clock: cpu 0, msr 10818001, primary cpu clock
> [ 0.000002] kvm-clock: using sched offset of 247343709 cycles
> [ 0.000856] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles:
> 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
> [ 0.003174] tsc: Detected 2593.994 MHz processor
> [ 0.004586] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
> [ 0.005496] e820: remove [mem 0x000a0000-0x000fffff] usable
> [ 0.006318] last_pfn = 0xbffe0 max_arch_pfn = 0x100000
> [ 0.007096] x86/PAT: PAT not supported by the CPU.
> [ 0.007789] x86/PAT: Configuration [0-7]: WB WT UC- UC WB WT UC- UC
> [ 0.008817] Scan for SMP in [mem 0x00000000-0x000003ff]
> [ 0.009606] Scan for SMP in [mem 0x0009fc00-0x0009ffff]
> [ 0.010348] Scan for SMP in [mem 0x000f0000-0x000fffff]
> [ 0.014307] found SMP MP-table at [mem 0x000f5c80-0x000f5c8f]
> [ 0.015120] mpc: f5c90-f5d7c
> [ 0.015524] initial memory mapped: [mem 0x00000000-0x10bfffff]
> [ 0.016384] RAMDISK: [mem 0x7f97e000-0x7fffffff]
> [ 0.017080] Allocated new RAMDISK: [mem 0x3617c000-0x367fdbe9]
> [ 0.021514] Move RAMDISK from [mem 0x7f97e000-0x7ffffbe9] to [mem
> 0x3617c000-0x367fdbe9]
> [ 0.022741] ACPI: Early table checksum verification disabled
> [ 0.023589] ACPI: RSDP 0x00000000000F5A60 000014 (v00 BOCHS )
> [ 0.024427] ACPI: RSDT 0x00000000BFFE15AB 000034 (v01 BOCHS BXPCRSDT
> 00000001 BXPC 00000001)
> [ 0.025704] ACPI: FACP 0x00000000BFFE1457 000074 (v01 BOCHS BXPCFACP
> 00000001 BXPC 00000001)
> [ 0.026839] ACPI: DSDT 0x00000000BFFE0040 001417 (v01 BOCHS BXPCDSDT
> 00000001 BXPC 00000001)
> [ 0.028102] ACPI: FACS 0x00000000BFFE0000 000040
> [ 0.028758] ACPI: APIC 0x00000000BFFE14CB 000080 (v01 BOCHS BXPCAPIC
> 00000001 BXPC 00000001)
> [ 0.029967] ACPI: HPET 0x00000000BFFE154B 000038 (v01 BOCHS BXPCHPET
> 00000001 BXPC 00000001)
> [ 0.031216] ACPI: WAET 0x00000000BFFE1583 000028 (v01 BOCHS
> BXPCWAET 00000001 BXPC 00000001)
> [ 0.032382] ACPI: Reserving FACP table memory at [mem 0xbffe1457-
> 0xbffe14ca]
> [ 0.033398] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-
> 0xbffe1456]
> [ 0.034362] ACPI: Reserving FACS table memory at [mem 0xbffe0000-
> 0xbffe003f]
> [ 0.035370] ACPI: Reserving APIC table memory at [mem 0xbffe14cb-
> 0xbffe154a]
> [ 0.036258] ACPI: Reserving HPET table memory at [mem 0xbffe154b-
> 0xbffe1582]
> [ 0.037266] ACPI: Reserving WAET table memory at [mem 0xbffe1583-
> 0xbffe15aa]
> [ 0.038257] mapped APIC to ffffb000 ( fee00000)
> [ 0.039083] 2199MB HIGHMEM available.
> [ 0.039560] 871MB LOWMEM available.
> [ 0.040074] mapped low ram: 0 - 367fe000
> [ 0.040631] low ram: 0 - 367fe000
> [ 0.045476] Zone ranges:
> [ 0.045863] DMA [mem 0x0000000000001000-0x0000000000ffffff]
> [ 0.046766] Normal [mem 0x0000000001000000-0x00000000367fdfff]
> [ 0.047642] HighMem [mem 0x00000000367fe000-0x00000000bffdffff]
> [ 0.048551] Movable zone start for each node
> [ 0.049125] Early memory node ranges
> [ 0.049574] node 0: [mem 0x0000000000001000-0x000000000009efff]
> [ 0.050454] node 0: [mem 0x0000000000100000-0x00000000bffdffff]
> [ 0.051376] Initmem setup node 0 [mem 0x0000000000001000-
> 0x00000000bffdffff]
> [ 0.052390] On node 0, zone DMA: 1 pages in unavailable ranges
> [ 0.052449] On node 0, zone DMA: 97 pages in unavailable ranges
> [ 0.064385] On node 0, zone HighMem: 32 pages in unavailable ranges
> [ 0.065265] Using APIC driver default
> [ 0.067043] ACPI: PM-Timer IO Port: 0x608
> [ 0.067641] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
> [ 0.068456] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
> [ 0.069426] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
> [ 0.070328] Int: type 0, pol 0, trig 0, bus 00, IRQ 00, APIC ID 0, APIC INT 02
> [ 0.071352] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
> [ 0.072303] Int: type 0, pol 1, trig 3, bus 00, IRQ 05, APIC ID 0, APIC INT 05
> [ 0.073328] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
> [ 0.074194] Int: type 0, pol 1, trig 3, bus 00, IRQ 09, APIC ID 0, APIC INT 09
> [ 0.075147] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
> [ 0.076073] Int: type 0, pol 1, trig 3, bus 00, IRQ 0a, APIC ID 0, APIC INT 0a
> [ 0.077122] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
> [ 0.078099] Int: type 0, pol 1, trig 3, bus 00, IRQ 0b, APIC ID 0, APIC INT 0b
> [ 0.079079] Int: type 0, pol 0, trig 0, bus 00, IRQ 01, APIC ID 0, APIC INT 01
> [ 0.080105] Int: type 0, pol 0, trig 0, bus 00, IRQ 03, APIC ID 0, APIC INT 03
> [ 0.081120] Int: type 0, pol 0, trig 0, bus 00, IRQ 04, APIC ID 0, APIC INT 04
> [ 0.082136] Int: type 0, pol 0, trig 0, bus 00, IRQ 06, APIC ID 0, APIC INT 06
> [ 0.083165] Int: type 0, pol 0, trig 0, bus 00, IRQ 07, APIC ID 0, APIC INT 07
> [ 0.084167] Int: type 0, pol 0, trig 0, bus 00, IRQ 08, APIC ID 0, APIC INT 08
> [ 0.085124] Int: type 0, pol 0, trig 0, bus 00, IRQ 0c, APIC ID 0, APIC INT 0c
> [ 0.086156] Int: type 0, pol 0, trig 0, bus 00, IRQ 0d, APIC ID 0, APIC INT 0d
> [ 0.087124] Int: type 0, pol 0, trig 0, bus 00, IRQ 0e, APIC ID 0, APIC INT 0e
> [ 0.088193] Int: type 0, pol 0, trig 0, bus 00, IRQ 0f, APIC ID 0, APIC INT 0f
> [ 0.089185] ACPI: Using ACPI (MADT) for SMP configuration information
> [ 0.090090] ACPI: HPET id: 0x8086a201 base: 0xfed00000
> [ 0.090862] smpboot: Allowing 2 CPUs, 0 hotplug CPUs
> [ 0.091529] mapped IOAPIC to ffffa000 (fec00000)
> [ 0.092172] PM: hibernation: Registered nosave memory: [mem 0x00000000-
> 0x00000fff]
> [ 0.093235] PM: hibernation: Registered nosave memory: [mem 0x0009f000-
> 0x0009ffff]
> [ 0.094346] PM: hibernation: Registered nosave memory: [mem 0x000a0000-
> 0x000effff]
> [ 0.095428] PM: hibernation: Registered nosave memory: [mem 0x000f0000-
> 0x000fffff]
> [ 0.096474] [mem 0xc0000000-0xfeffbfff] available for PCI devices
> [ 0.097274] Booting paravirtualized kernel on KVM
> [ 0.097927] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff,
> max_idle_ns: 1910969940391419 ns
> [ 0.099382] setup_percpu: NR_CPUS:8 nr_cpumask_bits:8 nr_cpu_ids:2
> nr_node_ids:1
> [ 0.100454] percpu: Embedded 32 pages/cpu s99276 r0 d31796 u131072
> [ 0.101331] pcpu-alloc: s99276 r0 d31796 u131072 alloc=32*4096
> [ 0.102151] pcpu-alloc: [0] 0 [0] 1
> [ 0.102653] kvm-guest: stealtime: cpu 0, msr 36147a40
> [ 0.103411] kvm-guest: PV spinlocks disabled, no host support
> [ 0.104247] Built 1 zonelists, mobility grouping on. Total pages: 784122
> [ 0.105201] Kernel command line: root=/dev/ram0 user=$(whoami)
> job=/lkp/jobs/scheduled/vm-snb-43/trinity-group-02-99999-yocto-i386-
> minimal-20190520.cgz-d64696905554e919321e31afc210606653b8f6a4-
> 20210911-24127-1x1tp2w-8.yaml ARCH=i386 kconfig=i386-randconfig-r015-
> 20210910 branch=trace/ftrace/core
> commit=d64696905554e919321e31afc210606653b8f6a4
> BOOT_IMAGE=/pkg/linux/i386-randconfig-r015-20210910/gcc-
> 9/d64696905554e919321e31afc210606653b8f6a4/vmlinuz-5.12.0-
> gd64696905554 vmalloc=128M initramfs_async=0 page_owner=on
> max_uptime=2100 RESULT_ROOT=/result/trinity/group-02-99999/vm-
> snb/yocto-i386-minimal-20190520.cgz/i386-randconfig-r015-20210910/gcc-
> 9/d64696905554e919321e31afc210606653b8f6a4/8 LKP_LOCAL_RUN=1
> selinux=0 debug apic=debug sysrq_always_enabled
> rcupdate.rcu_cpu_stall_timeout=100 net.ifnames=0 printk.devkmsg=on panic=-
> 1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2
> prompt_ramdisk=0 drbd.minor_count=8 systemd.log_level=err ignore_loglevel
> console=tty0 earlyprintk=ttyS
> [ 0.105625] sysrq: sysrq always enabled.
> [ 0.119255] ignoring the deprecated load_ramdisk= option
> [ 0.120230] Unknown command line parameters: user=$(whoami)
> job=/lkp/jobs/scheduled/vm-snb-43/trinity-group-02-99999-yocto-i386-
> minimal-20190520.cgz-d64696905554e919321e31afc210606653b8f6a4-
> 20210911-24127-1x1tp2w-8.yaml ARCH=i386 kconfig=i386-randconfig-r015-
> 20210910 branch=trace/ftrace/core
> commit=d64696905554e919321e31afc210606653b8f6a4
> BOOT_IMAGE=/pkg/linux/i386-randconfig-r015-20210910/gcc-
> 9/d64696905554e919321e31afc210606653b8f6a4/vmlinuz-5.12.0-
> gd64696905554 max_uptime=2100 RESULT_ROOT=/result/trinity/group-02-
> 99999/vm-snb/yocto-i386-minimal-20190520.cgz/i386-randconfig-r015-
> 20210910/gcc-9/d64696905554e919321e31afc210606653b8f6a4/8
> LKP_LOCAL_RUN=1 softlockup_panic=1 prompt_ramdisk=0 vga=normal ip=dhcp
> result_service=9p/virtfs_mount
> [ 0.129916] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes,
> linear)
> [ 0.131086] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes,
> linear)
> [ 0.132185] mem auto-init: stack:off, heap alloc:off, heap free:off
> [ 0.134089] Initializing HighMem for node 0 (000367fe:000bffe0)
> [ 0.216658] Initializing Movable for node 0 (00000000:00000000)
> [ 0.219183] Checking if this processor honours the WP bit even in supervisor
> mode...Ok.
> [ 0.220375] Memory: 3076340K/3145208K available (12370K kernel code,
> 1901K rwdata, 9072K rodata, 1076K init, 840K bss, 68868K reserved, 0K cma-
> reserved, 2252680K highmem)
> [ 0.222620] random: get_random_u32 called from
> __kmem_cache_create+0x23/0x540 with crng_init=0
> [ 0.222950] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
> [ 0.225214] ftrace: allocating 43733 entries in 86 pages
> [ 0.240068] ftrace: allocated 86 pages with 4 groups
> [ 0.240825] trace event string verifier disabled
> [ 0.241732] rcu: Hierarchical RCU implementation.
> [ 0.242375] rcu: RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=2.
> [ 0.243319] RCU CPU stall warnings timeout set to 100
> (rcu_cpu_stall_timeout).
> [ 0.244382] Trampoline variant of Tasks RCU enabled.
> [ 0.245116] Rude variant of Tasks RCU enabled.
> [ 0.245786] Tracing variant of Tasks RCU enabled.
> [ 0.246507] rcu: RCU calculated value of scheduler-enlistment delay is 100
> jiffies.
> [ 0.247651] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
> [ 0.254529] NR_IRQS: 2304, nr_irqs: 440, preallocated irqs: 16
> [ 0.273395] Console: colour VGA+ 80x25
> [ 0.325543] printk: console [tty0] enabled
> [ 0.326385] printk: console [ttyS0] enabled
> [ 0.326385] printk: console [ttyS0] enabled
> [ 0.327855] printk: bootconsole [earlyser0] disabled
> [ 0.327855] printk: bootconsole [earlyser0] disabled
> [ 0.329521] ACPI: Core revision 20210730
> [ 0.330469] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff,
> max_idle_ns: 19112604467 ns
> [ 0.332345] APIC: Switch to symmetric I/O mode setup
> [ 0.333394] Enabling APIC mode: Flat. Using 1 I/O APICs
> [ 0.334576] masked ExtINT on CPU#0
> [ 0.336162] ENABLING IO-APIC IRQs
> [ 0.336899] init IO_APIC IRQs
> [ 0.337572] apic 0 pin 0 not connected
> [ 0.338387] IOAPIC[0]: Preconfigured routing entry (0-1 -> IRQ 1 Level:0
> ActiveLow:0)
> [ 0.339909] IOAPIC[0]: Preconfigured routing entry (0-2 -> IRQ 0 Level:0
> ActiveLow:0)
> [ 0.341474] IOAPIC[0]: Preconfigured routing entry (0-3 -> IRQ 3 Level:0
> ActiveLow:0)
> [ 0.343019] IOAPIC[0]: Preconfigured routing entry (0-4 -> IRQ 4 Level:0
> ActiveLow:0)
> [ 0.344544] IOAPIC[0]: Preconfigured routing entry (0-5 -> IRQ 5 Level:1
> ActiveLow:0)
> [ 0.346058] IOAPIC[0]: Preconfigured routing entry (0-6 -> IRQ 6 Level:0
> ActiveLow:0)
> [ 0.347634] IOAPIC[0]: Preconfigured routing entry (0-7 -> IRQ 7 Level:0
> ActiveLow:0)
> [ 0.349221] IOAPIC[0]: Preconfigured routing entry (0-8 -> IRQ 8 Level:0
> ActiveLow:0)
> [ 0.350788] IOAPIC[0]: Preconfigured routing entry (0-9 -> IRQ 9 Level:1
> ActiveLow:0)
> [ 0.352295] IOAPIC[0]: Preconfigured routing entry (0-10 -> IRQ 10 Level:1
> ActiveLow:0)
> [ 0.353912] IOAPIC[0]: Preconfigured routing entry (0-11 -> IRQ 11 Level:1
> ActiveLow:0)
> [ 0.355484] IOAPIC[0]: Preconfigured routing entry (0-12 -> IRQ 12 Level:0
> ActiveLow:0)
> [ 0.357066] IOAPIC[0]: Preconfigured routing entry (0-13 -> IRQ 13 Level:0
> ActiveLow:0)
> [ 0.358652] IOAPIC[0]: Preconfigured routing entry (0-14 -> IRQ 14 Level:0
> ActiveLow:0)
> [ 0.360247] IOAPIC[0]: Preconfigured routing entry (0-15 -> IRQ 15 Level:0
> ActiveLow:0)
> [ 0.361853] apic 0 pin 16 not connected
> [ 0.362661] apic 0 pin 17 not connected
> [ 0.363464] apic 0 pin 18 not connected
> [ 0.364250] apic 0 pin 19 not connected
> [ 0.365094] apic 0 pin 20 not connected
> [ 0.365915] apic 0 pin 21 not connected
> [ 0.366715] apic 0 pin 22 not connected
> [ 0.367519] apic 0 pin 23 not connected
> [ 0.368427] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
> [ 0.369673] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles:
> 0x256412811b4, max_idle_ns: 440795306987 ns
> [ 0.371716] Calibrating delay loop (skipped) preset value.. 5187.98 BogoMIPS
> (lpj=2593994)
> [ 0.372714] pid_max: default: 32768 minimum: 301
> [ 0.373612] LSM: Security Framework initializing
> [ 0.373723] Yama: becoming mindful.
> [ 0.374724] LSM support for eBPF active
> [ 0.375716] landlock: Up and running.
> [ 0.376725] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes, linear)
> [ 0.377715] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes,
> linear)
> Poking KASLR using RDTSC...
> [ 0.379760] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
> [ 0.380714] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
> [ 0.381717] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user
> pointer sanitization
> [ 0.382717] Spectre V2 : Mitigation: Full generic retpoline
> [ 0.383714] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on
> context switch
> [ 0.384714] Speculative Store Bypass: Vulnerable
> [ 0.385714] L1TF: Kernel not compiled for PAE. No mitigation for L1TF
> [ 0.386716] MDS: Vulnerable: Clear CPU buffers attempted, no microcode
> [ 0.389800] Freeing SMP alternatives memory: 40K
> [ 0.390781] Using local APIC timer interrupts.
> [ 0.390781] calibrating APIC timer ...
> [ 0.494491] ... lapic delta = 6250028
> [ 0.494712] ... PM-Timer delta = 357953
> [ 0.494712] ... PM-Timer result ok
> [ 0.494712] ..... delta 6250028
> [ 0.494712] ..... mult: 268435456
> [ 0.494712] ..... calibration result: 1000004
> [ 0.494712] ..... CPU clock speed is 2593.0965 MHz.
> [ 0.494712] ..... host bus clock speed is 1000.0004 MHz.
> [ 0.494760] smpboot: CPU0: Intel QEMU Virtual CPU version 2.5+ (family: 0x6,
> model: 0x6, stepping: 0x3)
> [ 0.495822] Performance Events: PMU not available due to virtualization, using
> software events only.
> [ 0.496745] rcu: Hierarchical SRCU implementation.
> [ 0.497945] NMI watchdog: Perf NMI watchdog permanently disabled
> [ 0.498759] smp: Bringing up secondary CPUs ...
> [ 0.499790] x86: Booting SMP configuration:
> [ 0.500715] .... node #0, CPUs: #1
> [ 0.113149] kvm-clock: cpu 1, msr 10818021, secondary cpu clock
> [ 0.113149] masked ExtINT on CPU#1
> [ 0.113149] smpboot: CPU 1 Converting physical 0 to logical die 1
> [ 0.504730] kvm-guest: stealtime: cpu 1, msr 36167a40
> [ 0.506757] smp: Brought up 1 node, 2 CPUs
> [ 0.507715] smpboot: Max logical packages: 2
> [ 0.508714] smpboot: Total of 2 processors activated (10375.97 BogoMIPS)
> [ 0.518115] allocated 31457280 bytes of page_ext
> [ 0.518781] Node 0, zone DMA: page owner found early allocated 0 pages
> [ 0.521199] Node 0, zone Normal: page owner found early allocated 8326
> pages
> [ 0.522727] Node 0, zone HighMem: page owner found early allocated 63
> pages
> [ 0.523792] devtmpfs: initialized
> [ 0.525970] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff,
> max_idle_ns: 1911260446275000 ns
> [ 0.526718] futex hash table entries: 512 (order: 2, 16384 bytes, linear)
> [ 0.527763] pinctrl core: initialized pinctrl subsystem
> [ 0.528844] PM: RTC time: 13:16:34, date: 2021-09-15
> [ 0.529859] NET: Registered PF_NETLINK/PF_ROUTE protocol family
> [ 0.532088] audit: initializing netlink subsys (disabled)
> [ 0.532748] audit: type=2000 audit(1631704594.860:1): state=initialized
> audit_enabled=0 res=1
> [ 0.532882] thermal_sys: Registered thermal governor 'fair_share'
> [ 0.533716] thermal_sys: Registered thermal governor 'bang_bang'
> [ 0.534715] thermal_sys: Registered thermal governor 'step_wise'
> [ 0.535715] thermal_sys: Registered thermal governor 'user_space'
> [ 0.536727] cpuidle: using governor menu
> [ 0.539187] ACPI: bus type PCI registered
> [ 0.539715] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
> [ 0.540876] PCI: PCI BIOS revision 2.10 entry at 0xfd1b8, last bus=0
> [ 0.541716] PCI: Using configuration type 1 for base access
> [ 0.544343] Kprobes globally optimized
> [ 0.544778] HugeTLB registered 4.00 MiB page size, pre-allocated 0 pages
> [ 1.232030] cryptd: max_cpu_qlen set to 1000
> [ 1.236954] alg: No test for 842 (842-generic)
> [ 1.237743] alg: No test for 842 (842-scomp)
> [ 1.252185] DRBG: Continuing without Jitter RNG
> [ 1.282782] raid6: skip pq benchmark and using algorithm sse2x2
> [ 1.283719] raid6: using intx1 recovery algorithm
> [ 1.284764] ACPI: Added _OSI(Module Device)
> [ 1.285716] ACPI: Added _OSI(Processor Device)
> [ 1.286718] ACPI: Added _OSI(3.0 _SCP Extensions)
> [ 1.287715] ACPI: Added _OSI(Processor Aggregator Device)
> [ 1.288717] ACPI: Added _OSI(Linux-Dell-Video)
> [ 1.289715] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
> [ 1.290715] ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics)
> [ 1.292174] ACPI: 1 ACPI AML tables successfully acquired and loaded
> [ 1.294348] ACPI: Interpreter enabled
> [ 1.294728] ACPI: PM: (supports S0 S3 S4 S5)
> [ 1.295715] ACPI: Using IOAPIC for interrupt routing
> [ 1.296727] PCI: Using host bridge windows from ACPI; if necessary, use
> "pci=nocrs" and report a bug
> [ 1.297810] ACPI: Enabled 2 GPEs in block 00 to 0F
> [ 1.300466] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
> [ 1.300718] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments
> MSI EDR HPX-Type3]
> [ 1.301719] acpi PNP0A03:00: fail to add MMCONFIG information, can't access
> extended PCI configuration space under this bridge.
> [ 1.302721] acpi resource window ([0x1c0000000-0x23fffffff] ignored, not
> CPU addressable)
> [ 1.303916] acpiphp: Slot [3] registered
> [ 1.304731] acpiphp: Slot [4] registered
> [ 1.305730] acpiphp: Slot [5] registered
> [ 1.306489] acpiphp: Slot [6] registered
> [ 1.306733] acpiphp: Slot [7] registered
> [ 1.307733] acpiphp: Slot [8] registered
> [ 1.308730] acpiphp: Slot [9] registered
> [ 1.309730] acpiphp: Slot [10] registered
> [ 1.310568] acpiphp: Slot [11] registered
> [ 1.310730] acpiphp: Slot [12] registered
> [ 1.311730] acpiphp: Slot [13] registered
> [ 1.312730] acpiphp: Slot [14] registered
> [ 1.313730] acpiphp: Slot [15] registered
> [ 1.314723] acpiphp: Slot [16] registered
> [ 1.315577] acpiphp: Slot [17] registered
> [ 1.315732] acpiphp: Slot [18] registered
> [ 1.316730] acpiphp: Slot [19] registered
> [ 1.317730] acpiphp: Slot [20] registered
> [ 1.318729] acpiphp: Slot [21] registered
> [ 1.319526] acpiphp: Slot [22] registered
> [ 1.319730] acpiphp: Slot [23] registered
> [ 1.320737] acpiphp: Slot [24] registered
> [ 1.321732] acpiphp: Slot [25] registered
> [ 1.322732] acpiphp: Slot [26] registered
> [ 1.323733] acpiphp: Slot [27] registered
> [ 1.324750] acpiphp: Slot [28] registered
> [ 1.325733] acpiphp: Slot [29] registered
> [ 1.327716] acpiphp: Slot [30] registered
> [ 1.328732] acpiphp: Slot [31] registered
> [ 1.329725] PCI host bridge to bus 0000:00
> [ 1.330715] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
> [ 1.331715] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
> [ 1.332715] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff
> window]
> [ 1.333715] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff
> window]
> [ 1.334715] pci_bus 0000:00: root bus resource [bus 00-ff]
> [ 1.335805] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
> [ 1.337132] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
> [ 1.338223] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
> [ 1.340912] pci 0000:00:01.1: reg 0x20: [io 0xc080-0xc08f]
> [ 1.343171] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
> [ 1.343715] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6]
> [ 1.344717] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
> [ 1.345715] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376]
> [ 1.346958] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
> [ 1.348085] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI
> [ 1.348723] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB
> [ 1.349953] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000
> [ 1.351733] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref]
> [ 1.354732] pci 0000:00:02.0: reg 0x18: [mem 0xfebf0000-0xfebf0fff]
> [ 1.360734] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref]
> [ 1.362913] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200
> [ 1.364715] pci 0000:00:03.0: reg 0x10: [io 0xc000-0xc03f]
> [ 1.366715] pci 0000:00:03.0: reg 0x14: [mem 0xfebf1000-0xfebf1fff]
> [ 1.370716] pci 0000:00:03.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit
> pref]
> [ 1.373770] pci 0000:00:04.0: [8086:100e] type 00 class 0x020000
> [ 1.375715] pci 0000:00:04.0: reg 0x10: [mem 0xfebc0000-0xfebdffff]
> [ 1.377982] pci 0000:00:04.0: reg 0x14: [io 0xc040-0xc07f]
> [ 1.383054] pci 0000:00:04.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref]
> [ 1.383965] pci 0000:00:05.0: [8086:25ab] type 00 class 0x088000
> [ 1.385991] pci 0000:00:05.0: reg 0x10: [mem 0xfebf2000-0xfebf200f]
> [ 1.389365] pci_bus 0000:00: on NUMA node 0
> [ 1.390854] ACPI: PCI: Interrupt link LNKA configured for IRQ 10
> [ 1.392813] ACPI: PCI: Interrupt link LNKB configured for IRQ 10
> [ 1.393809] ACPI: PCI: Interrupt link LNKC configured for IRQ 11
> [ 1.394806] ACPI: PCI: Interrupt link LNKD configured for IRQ 11
> [ 1.396713] ACPI: PCI: Interrupt link LNKS configured for IRQ 9
> [ 1.398072] iommu: Default domain type: Translated
> [ 1.398715] iommu: DMA domain TLB invalidation policy: lazy mode
> [ 1.399790] pci 0000:00:02.0: vgaarb: setting as boot VGA device
> [ 1.400712] pci 0000:00:02.0: vgaarb: VGA device added:
> decodes=io+mem,owns=io+mem,locks=none
> [ 1.400716] pci 0000:00:02.0: vgaarb: bridge control possible
> [ 1.401715] vgaarb: loaded
> [ 1.402643] SCSI subsystem initialized
> [ 1.403744] libata version 3.00 loaded.
> [ 1.404758] ACPI: bus type USB registered
> [ 1.405742] usbcore: registered new interface driver usbfs
> [ 1.406731] usbcore: registered new interface driver hub
> [ 1.408717] usbcore: registered new device driver usb
> [ 1.409750] pps_core: LinuxPPS API ver. 1 registered
> [ 1.410714] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo
> Giometti <[email protected]>
> [ 1.411718] PTP clock support registered
> [ 1.412766] EDAC MC: Ver: 3.0.0
> [ 1.414938] NetLabel: Initializing
> [ 1.415715] NetLabel: domain hash size = 128
> [ 1.416714] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO
> [ 1.417734] NetLabel: unlabeled traffic allowed by default
> [ 1.418722] PCI: Using ACPI for IRQ routing
> [ 1.419715] PCI: pci_cache_line_size set to 64 bytes
> [ 1.420823] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
> [ 1.421719] e820: reserve RAM buffer [mem 0xbffe0000-0xbfffffff]
> [ 1.423811] hpet: 3 channels of 0 reserved for per-cpu timers
> [ 1.424731] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
> [ 1.425714] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
> [ 1.432769] clocksource: Switched to clocksource kvm-clock
> [ 1.450889] VFS: Disk quotas dquot_6.6.0
> [ 1.451842] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
> [ 1.453453] pnp: PnP ACPI init
> [ 1.454285] pnp 00:02: [dma 2]
> [ 1.455285] pnp: PnP ACPI: found 6 devices
> [ 1.491745] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff,
> max_idle_ns: 2085701024 ns
> [ 1.493617] NET: Registered PF_INET protocol family
> [ 1.494694] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
> [ 1.496491] tcp_listen_portaddr_hash hash table entries: 512 (order: 0, 6144
> bytes, linear)
> [ 1.498309] TCP established hash table entries: 8192 (order: 3, 32768 bytes,
> linear)
> [ 1.499923] TCP bind hash table entries: 8192 (order: 4, 65536 bytes, linear)
> [ 1.501431] TCP: Hash tables configured (established 8192 bind 8192)
> [ 1.502821] MPTCP token hash table entries: 1024 (order: 2, 16384 bytes,
> linear)
> [ 1.504415] UDP hash table entries: 512 (order: 2, 16384 bytes, linear)
> [ 1.505808] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear)
> [ 1.507313] NET: Registered PF_UNIX/PF_LOCAL protocol family
> [ 1.508519] NET: Registered PF_XDP protocol family
> [ 1.509557] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]
> [ 1.510849] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]
> [ 1.512086] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff
> window]
> [ 1.513538] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window]
> [ 1.514980] pci 0000:00:01.0: PIIX3: Enabling Passive Release
> [ 1.516212] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
> [ 1.517460] pci 0000:00:01.0: Activating ISA DMA hang workarounds
> [ 1.518761] pci 0000:00:02.0: Video device with shadowed ROM at [mem
> 0x000c0000-0x000dffff]
> [ 1.520525] PCI: CLS 0 bytes, default 64
> [ 1.521457] Trying to unpack rootfs image as initramfs...
> [ 1.713192] Freeing initrd memory: 6664K
> [ 1.714909] clocksource: tsc: mask: 0xffffffffffffffff max_cycles:
> 0x256412811b4, max_idle_ns: 440795306987 ns
> [ 1.717760] Initialise system trusted keyrings
> [ 1.718783] Key type blacklist registered
> [ 1.719752] workingset: timestamp_bits=14 max_order=20 bucket_order=6
> [ 1.722543] zbud: loaded
> [ 1.723639] integrity: Platform Keyring initialized
> [ 1.737954] NET: Registered PF_ALG protocol family
> [ 1.738980] xor: measuring software checksum speed
> [ 1.740561] pIII_sse : 20542 MB/sec
> [ 1.741925] prefetch64-sse : 23982 MB/sec
> [ 1.742909] xor: using function: prefetch64-sse (23982 MB/sec)
> [ 1.744139] Key type asymmetric registered
> [ 1.745039] Asymmetric key parser 'x509' registered
> [ 1.746169] bounce: pool size: 64 pages
> [ 1.747094] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 245)
> [ 1.748707] io scheduler mq-deadline registered
> [ 1.750002] io scheduler kyber registered
> [ 1.751161] io scheduler bfq registered
> [ 1.752394] atomic64_test: passed for i586+ platform with CX8 and with SSE
> [ 1.754383] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
> [ 1.756225] input: Power Button as
> /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
> [ 1.758287] ACPI: button: Power Button [PWRF]
> [ 1.775040] ACPI: \_SB_.LNKC: Enabled at IRQ 11
> [ 1.777056] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled
> [ 1.778502] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
> [ 1.781332] Non-volatile memory driver v1.3
> [ 1.782297] Linux agpgart interface v0.103
> [ 1.783540] ata_piix 0000:00:01.1: version 2.13
> [ 1.785339] scsi host0: ata_piix
> [ 1.786304] scsi host1: ata_piix
> [ 1.787111] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc080 irq
> 14
> [ 1.788567] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc088 irq
> 15
> [ 1.790069] libphy: Fixed MDIO Bus: probed
> [ 1.791249] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
> [ 1.792615] ehci-pci: EHCI PCI platform driver
> [ 1.793564] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
> [ 1.794910] ohci-pci: OHCI PCI platform driver
> [ 1.795868] uhci_hcd: USB Universal Host Controller Interface driver
> [ 1.797245] usbcore: registered new interface driver usbserial_generic
> [ 1.798634] usbserial: USB Serial support registered for generic
> [ 1.799947] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at
> 0x60,0x64 irq 1,12
> [ 1.802437] serio: i8042 KBD port at 0x60,0x64 irq 1
> [ 1.803499] serio: i8042 AUX port at 0x60,0x64 irq 12
> [ 1.804623] mousedev: PS/2 mouse device common for all mice
> [ 1.806140] input: AT Translated Set 2 keyboard as
> /devices/platform/i8042/serio0/input/input1
> [ 1.808292] rtc_cmos 00:05: RTC can wake from S4
> [ 1.809901] input: VirtualPS/2 VMware VMMouse as
> /devices/platform/i8042/serio1/input/input4
> [ 1.812102] input: VirtualPS/2 VMware VMMouse as
> /devices/platform/i8042/serio1/input/input3
> [ 1.813914] rtc_cmos 00:05: registered as rtc0
> [ 1.814970] rtc_cmos 00:05: setting system clock to 2021-09-15T13:16:36 UTC
> (1631711796)
> [ 1.816672] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet
> irqs
> [ 1.818294] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled.
> Duplicate IMA measurements will not be recorded in the IMA log.
> [ 1.820756] device-mapper: uevent: version 1.0.3
> [ 1.821788] device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-
> [email protected]
> [ 1.823764] intel_pstate: CPU model not supported
> [ 1.824907] hid: raw HID events driver (C) Jiri Kosina
> [ 1.826142] usbcore: registered new interface driver usbhid
> [ 1.827312] usbhid: USB HID core driver
> [ 1.828212] drop_monitor: Initializing network drop monitor service
> [ 1.838572] Initializing XFRM netlink socket
> [ 1.839585] NET: Registered PF_INET6 protocol family
> [ 1.841801] Segment Routing with IPv6
> [ 1.842683] RPL Segment Routing with IPv6
> [ 1.843585] In-situ OAM (IOAM) with IPv6
> [ 1.844440] mip6: Mobile IPv6
> [ 1.845176] NET: Registered PF_PACKET protocol family
> [ 1.847003] IPI shorthand broadcast: enabled
> [ 1.848037] ... APIC ID: 00000000 (0)
> [ 1.849028] ... APIC VERSION: 00050014
> [ 1.849028]
> 0000000000000000000000000000000000000000000000000000000000000000
> [ 1.849028]
> 0000000000000000000000000000000000000000000000000000000000000000
> [ 1.849028]
> 0000000000000000000000000000000000000000000000000000000000001000
> [ 1.849028]
> [ 1.854384] number of MP IRQ sources: 15.
> [ 1.855515] number of IO-APIC #0 registers: 24.
> [ 1.856719] testing the IO APIC.......................
> [ 1.858135] IO APIC #0......
> [ 1.859016] .... register #00: 00000000
> [ 1.860108] ....... : physical APIC id: 00
> [ 1.861249] ....... : Delivery Type: 0
> [ 1.862379] ....... : LTS : 0
> [ 1.863551] .... register #01: 00170011
> [ 1.864654] ....... : max redirection entries: 17
> [ 1.865673] ....... : PRQ implemented: 0
> [ 1.866614] ....... : IO APIC version: 11
> [ 1.867563] .... register #02: 00000000
> [ 1.868390] ....... : arbitration: 00
> [ 1.869295] .... IRQ redirection table:
> [ 1.870177] IOAPIC 0:
> [ 1.870810] pin00, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000),
> M(0)
> [ 1.872434] pin01, enabled , edge , high, V(23), IRR(0), S(0), logical , D(0002),
> M(0)
> [ 1.874154] pin02, enabled , edge , high, V(30), IRR(0), S(0), logical , D(0001),
> M(0)
> [ 1.875823] pin03, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000),
> M(0)
> [ 1.877581] pin04, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000),
> M(0)
> [ 1.879254] pin05, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000),
> M(0)
> [ 1.880966] pin06, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000),
> M(0)
> [ 1.882650] pin07, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000),
> M(0)
> [ 1.884268] pin08, enabled , edge , high, V(23), IRR(0), S(0), logical , D(0001),
> M(0)
> [ 1.885952] pin09, enabled , level, high, V(21), IRR(0), S(0), logical , D(0002),
> M(0)
> [ 1.887693] pin0a, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000),
> M(0)
> [ 1.889363] pin0b, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000),
> M(0)
> [ 1.891044] pin0c, enabled , edge , high, V(22), IRR(0), S(0), logical , D(0001),
> M(0)
> [ 1.892798] pin0d, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000),
> M(0)
> [ 1.894462] pin0e, enabled , edge , high, V(21), IRR(0), S(0), logical , D(0001),
> M(0)
> [ 1.896144] pin0f, enabled , edge , high, V(22), IRR(0), S(0), logical , D(0002),
> M(0)
> [ 1.897779] pin10, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000),
> M(0)
> [ 1.899354] pin11, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000),
> M(0)
> [ 1.901063] pin12, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000),
> M(0)
> [ 1.902768] pin13, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000),
> M(0)
> [ 1.904403] pin14, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000),
> M(0)
> [ 1.906092] pin15, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000),
> M(0)
> [ 1.907805] pin16, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000),
> M(0)
> [ 1.909507] pin17, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000),
> M(0)
> [ 1.911204] IRQ to pin mappings:
> [ 1.911965] IRQ0 -> 0:2
> [ 1.912559] IRQ1 -> 0:1
> [ 1.913151] IRQ3 -> 0:3
> [ 1.913728] IRQ4 -> 0:4
> [ 1.914319] IRQ5 -> 0:5
> [ 1.914934] IRQ6 -> 0:6
> [ 1.915513] IRQ7 -> 0:7
> [ 1.916134] IRQ8 -> 0:8
> [ 1.916709] IRQ9 -> 0:9
> [ 1.917346] IRQ10 -> 0:10
> [ 1.917939] IRQ11 -> 0:11
> [ 1.918584] IRQ12 -> 0:12
> [ 1.919226] IRQ13 -> 0:13
> [ 1.919843] IRQ14 -> 0:14
> [ 1.920425] IRQ15 -> 0:15
> [ 1.921074] .................................... done.
> [ 1.922166] sched_clock: Marking stable (1809994723, 112149602)-
> >(1997769292, -75624967)
> [ 1.923944] registered taskstats version 1
> [ 1.924877] Loading compiled-in X.509 certificates
> [ 1.928813] Loaded X.509 cert 'Build time autogenerated kernel key:
> 5f848f3a256c3033a276d466d757b9174d58558c'
> [ 1.931028] zswap: loaded using pool lzo/zbud
> [ 1.932212] Key type ._fscrypt registered
> [ 1.933141] Key type .fscrypt registered
> [ 1.933989] Key type fscrypt-provisioning registered
> [ 1.935399] Btrfs loaded, crc32c=crc32c-generic, zoned=yes, fsverity=yes
> [ 1.937362] Key type encrypted registered
> [ 1.938451] ima: No TPM chip found, activating TPM-bypass!
> [ 1.939809] Loading compiled-in module X.509 certificates
> [ 1.943733] Loaded X.509 cert 'Build time autogenerated kernel key:
> 5f848f3a256c3033a276d466d757b9174d58558c'
> [ 1.944780] ata2.01: NODEV after polling detection
> [ 1.946329] ima: Allocated hash algorithm: sha256
> [ 1.947837] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100
> [ 1.948670] ima: No architecture policies found
> [ 1.951261] evm: Initialising EVM extended attributes:
> [ 1.952552] evm: security.selinux
> [ 1.953446] evm: security.SMACK64 (disabled)
> [ 1.954550] evm: security.SMACK64EXEC (disabled)
> [ 1.955734] evm: security.SMACK64TRANSMUTE (disabled)
> [ 1.956970] evm: security.SMACK64MMAP (disabled)
> [ 1.958269] evm: security.apparmor (disabled)
> [ 1.958297] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ:
> 0 ANSI: 5
> [ 1.959343] evm: security.ima
> [ 1.959344] evm: security.capability
> [ 1.959345] evm: HMAC attrs: 0x1
> [ 1.963315] PM: Magic number: 5:244:281
> [ 1.964463] tty tty18: hash matches
> [ 1.983501] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
> [ 1.985182] cdrom: Uniform CD-ROM driver Revision: 3.20
> [ 2.003515] sr 1:0:0:0: Attached scsi CD-ROM sr0
> [ 2.004946] sr 1:0:0:0: Attached scsi generic sg0 type 5
> [ 2.007640] Freeing unused kernel image (initmem) memory: 1076K
> [ 2.013798] Write protecting kernel text and read-only data: 21444k
> [ 2.015796] rodata_test: all tests were successful
> [ 2.022763] Run /init as init process
> [ 2.023922] with arguments:
> [ 2.024801] /init
> [ 2.025447] with environment:
> [ 2.026337] HOME=/
> [ 2.027006] TERM=linux
> [ 2.027784] user=$(whoami)
> [ 2.028659] job=/lkp/jobs/scheduled/vm-snb-43/trinity-group-02-99999-
> yocto-i386-minimal-20190520.cgz-
> d64696905554e919321e31afc210606653b8f6a4-20210911-24127-1x1tp2w-
> 8.yaml
> [ 2.032415] ARCH=i386
> [ 2.033140] kconfig=i386-randconfig-r015-20210910
> [ 2.034457] branch=trace/ftrace/core
> [ 2.035503] commit=d64696905554e919321e31afc210606653b8f6a4
> [ 2.036995] BOOT_IMAGE=/pkg/linux/i386-randconfig-r015-20210910/gcc-
> 9/d64696905554e919321e31afc210606653b8f6a4/vmlinuz-5.12.0-
> gd64696905554
> [ 2.040147] max_uptime=2100
> [ 2.041044] RESULT_ROOT=/result/trinity/group-02-99999/vm-snb/yocto-
> i386-minimal-20190520.cgz/i386-randconfig-r015-20210910/gcc-
> 9/d64696905554e919321e31afc210606653b8f6a4/8
> [ 2.044850] LKP_LOCAL_RUN=1
> [ 2.045749] softlockup_panic=1
> [ 2.046688] prompt_ramdisk=0
> [ 2.047584] vga=normal
> [ 2.048380] ip=dhcp
> [ 2.049110] result_service=9p/virtfs_mount
> INIT: version 2.88 booting
> Starting udev
> [ 2.073317] udevd[167]: starting version 3.2.7
> [ 2.074652] random: udevd: uninitialized urandom read (16 bytes read)
> [ 2.076331] random: udevd: uninitialized urandom read (16 bytes read)
> [ 2.077986] random: udevd: uninitialized urandom read (16 bytes read)
> [ 2.080262] udevd[167]: specified group 'kvm' unknown
> [ 2.082655] udevd[168]: starting eudev-3.2.7
> depmod: ERROR: could not open directory /lib/modules/5.15.0-rc1+: No such
> file or directory
> depmod: WARNING: -e needs -E or -F
> depmod: ERROR: could not open directory /lib/modules/5.15.0-rc1+: No such
> file or directory
> depmod: FATAL: could not search modules: No such file or directory
> INIT: Entering runlevel: 5
> Configuring network interfaces... done.
> Starting syslogd/klogd: done
> /etc/rc5.d/S77lkp-bootstrap: /lkp/jobs/scheduled/vm-snb-43/trinity-group-02-
> 99999-yocto-i386-minimal-20190520.cgz-
> d64696905554e919321e31afc210606653b8f6a4-20210911-24127-1x1tp2w-8.sh:
> line 123: start: not found
> /etc/rc5.d/S77lkp-bootstrap: line 75: /lkp/root/src/bin/lkp-setup-rootfs: not
> found
> INIT: Id "S1" respawning too fast: disabled for 5 minutes
>
> Poky (Yocto Project Reference Distro) 2.7+snapshot qemux86 /dev/ttyS0
>
> qemux86 login:
>
>
> > As the log you mentioned, below [1] shows our corresponding log, they are
> very similar, only we don't have depmod error, I found some solutions and add
> their links here, could you check if they can solve your issue? Thanks.
> >
> > depmod: ERROR: could not open directory /lib/modules/5.14.0-09687-
> g27151f177827: No such file or directory
> > depmod: FATAL: could not search modules: No such file or directory
> >
> > https://stackoverflow.com/questions/28644386/kernel-install-gives-missing-
> module-error
> > https://serverfault.com/questions/780980/error-could-not-open-directory-lib-
> modules-4-2-0-25-generic-no-such-file-or-d
>
> The error occurs inside qemu. It seems that the directory with modules and
> lkp-tests itself (/lkp/root/src) was not mounted from the host system.
>
> --
> Rgrds, legion
> _______________________________________________
> LKP mailing list -- [email protected]
> To unsubscribe send an email to [email protected]