early console in setup code
early console in extract_kernel
input_data: 0x024ec079
input_len: 0x00855249
output: 0x01000000
output_len: 0x017d8758
kernel_total_size: 0x02147000
needed_size: 0x02147000

Decompressing Linux... Parsing ELF... done.
Booting the kernel.
[    0.000000][    T0] Linux version 5.15.0-rc1-00002-gd3ff51cfa9a6 (kbuild@20566814452f) (clang version 14.0.0 (git://gitmirror/llvm_project b6a8c695542b2987eb9a203d5663a0740cb4725f), LLD 14.0.0) #1 SMP PREEMPT Thu Oct 14 00:45:30 CST 2021
[    0.000000][    T0] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
[    0.000000][    T0] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
[    0.000000][    T0] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
[    0.000000][    T0] x86/fpu: xstate_offset[2]:  576, xstate_sizes[2]:  256
[    0.000000][    T0] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format.
[    0.000000][    T0] signal: max sigframe size: 1760
[    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-0x000000013fffffff] 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] Hypervisor detected: KVM
[    0.000000][    T0] kvm-clock: Using msrs 4b564d01 and 4b564d00
[    0.000000][    T0] kvm-clock: cpu 0, msr 27eb001, primary cpu clock
[    0.000014][    T0] kvm-clock: using sched offset of 2400928388 cycles
[    0.000600][    T0] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
[    0.002276][    T0] tsc: Detected 2194.916 MHz processor
[    0.003968][    T0] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[    0.004713][    T0] e820: remove [mem 0x000a0000-0x000fffff] usable
[    0.005318][    T0] last_pfn = 0xbffe0 max_arch_pfn = 0x100000
[    0.005918][    T0] x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WP  UC- WT  
[    0.006664][    T0] Scan for SMP in [mem 0x00000000-0x000003ff]
[    0.007232][    T0] Scan for SMP in [mem 0x0009fc00-0x0009ffff]
[    0.007796][    T0] Scan for SMP in [mem 0x000f0000-0x000fffff]
[    0.012956][    T0] found SMP MP-table at [mem 0x000f5a80-0x000f5a8f]
[    0.013600][    T0]   mpc: f5a90-f5b74
[    0.014000][    T0] initial memory mapped: [mem 0x00000000-0x033fffff]
[    0.014699][    T0] RAMDISK: [mem 0x7f3dd000-0x7fffffff]
[    0.015216][    T0] Allocated new RAMDISK: [mem 0x457db000-0x463fdc18]
[    0.039591][    T0] Move RAMDISK from [mem 0x7f3dd000-0x7ffffc18] to [mem 0x457db000-0x463fdc18]
[    0.040253][    T0] ACPI: Early table checksum verification disabled
[    0.040669][    T0] ACPI: RSDP 0x00000000000F5850 000014 (v00 BOCHS )
[    0.041223][    T0] ACPI: RSDT 0x00000000BFFE15C9 000030 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
[    0.041884][    T0] ACPI: FACP 0x00000000BFFE149D 000074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
[    0.042447][    T0] ACPI: DSDT 0x00000000BFFE0040 00145D (v01 BOCHS  BXPCDSDT 00000001 BXPC 00000001)
[    0.043048][    T0] ACPI: FACS 0x00000000BFFE0000 000040
[    0.043411][    T0] ACPI: APIC 0x00000000BFFE1511 000080 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
[    0.044123][    T0] ACPI: HPET 0x00000000BFFE1591 000038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)
[    0.044721][    T0] ACPI: Reserving FACP table memory at [mem 0xbffe149d-0xbffe1510]
[    0.045198][    T0] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe149c]
[    0.045705][    T0] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f]
[    0.046163][    T0] ACPI: Reserving APIC table memory at [mem 0xbffe1511-0xbffe1590]
[    0.046653][    T0] ACPI: Reserving HPET table memory at [mem 0xbffe1591-0xbffe15c8]
[    0.047161][    T0] mapped APIC to         ffffc000 (        fee00000)
[    0.047565][    T0] 1947MB HIGHMEM available.
[    0.047913][    T0] 1123MB LOWMEM available.
[    0.048257][    T0]   mapped low ram: 0 - 463fe000
[    0.048677][    T0]   low ram: 0 - 463fe000
[    0.049087][    T0] Zone ranges:
[    0.049373][    T0]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
[    0.049978][    T0]   Normal   [mem 0x0000000001000000-0x00000000463fdfff]
[    0.050523][    T0]   HighMem  [mem 0x00000000463fe000-0x00000000bffdffff]
[    0.051053][    T0] Movable zone start for each node
[    0.051420][    T0] Early memory node ranges
[    0.051683][    T0]   node   0: [mem 0x0000000000001000-0x000000000009efff]
[    0.052122][    T0]   node   0: [mem 0x0000000000100000-0x00000000bffdffff]
[    0.052731][    T0] Initmem setup node 0 [mem 0x0000000000001000-0x00000000bffdffff]
[    0.054101][    T0] On node 0, zone DMA: 1 pages in unavailable ranges
[    0.054242][    T0] On node 0, zone DMA: 97 pages in unavailable ranges
[    0.079615][    T0] On node 0, zone HighMem: 32 pages in unavailable ranges
[    0.080056][    T0] Using APIC driver default
[    0.080963][    T0] ACPI: PM-Timer IO Port: 0x608
[    0.081243][    T0] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
[    0.081670][    T0] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
[    0.082151][    T0] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[    0.082554][    T0] Int: type 0, pol 0, trig 0, bus 00, IRQ 00, APIC ID 0, APIC INT 02
[    0.083016][    T0] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
[    0.083431][    T0] Int: type 0, pol 1, trig 3, bus 00, IRQ 05, APIC ID 0, APIC INT 05
[    0.083880][    T0] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[    0.084416][    T0] Int: type 0, pol 1, trig 3, bus 00, IRQ 09, APIC ID 0, APIC INT 09
[    0.084956][    T0] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
[    0.085489][    T0] Int: type 0, pol 1, trig 3, bus 00, IRQ 0a, APIC ID 0, APIC INT 0a
[    0.086153][    T0] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
[    0.086622][    T0] Int: type 0, pol 1, trig 3, bus 00, IRQ 0b, APIC ID 0, APIC INT 0b
[    0.087114][    T0] Int: type 0, pol 0, trig 0, bus 00, IRQ 01, APIC ID 0, APIC INT 01
[    0.087595][    T0] Int: type 0, pol 0, trig 0, bus 00, IRQ 03, APIC ID 0, APIC INT 03
[    0.088083][    T0] Int: type 0, pol 0, trig 0, bus 00, IRQ 04, APIC ID 0, APIC INT 04
[    0.088609][    T0] Int: type 0, pol 0, trig 0, bus 00, IRQ 06, APIC ID 0, APIC INT 06
[    0.089095][    T0] Int: type 0, pol 0, trig 0, bus 00, IRQ 07, APIC ID 0, APIC INT 07
[    0.089558][    T0] Int: type 0, pol 0, trig 0, bus 00, IRQ 08, APIC ID 0, APIC INT 08
[    0.090033][    T0] Int: type 0, pol 0, trig 0, bus 00, IRQ 0c, APIC ID 0, APIC INT 0c
[    0.090586][    T0] Int: type 0, pol 0, trig 0, bus 00, IRQ 0d, APIC ID 0, APIC INT 0d
[    0.091109][    T0] Int: type 0, pol 0, trig 0, bus 00, IRQ 0e, APIC ID 0, APIC INT 0e
[    0.091579][    T0] Int: type 0, pol 0, trig 0, bus 00, IRQ 0f, APIC ID 0, APIC INT 0f
[    0.092057][    T0] ACPI: Using ACPI (MADT) for SMP configuration information
[    0.092494][    T0] ACPI: HPET id: 0x8086a201 base: 0xfed00000
[    0.092894][    T0] TSC deadline timer available
[    0.093160][    T0] smpboot: Allowing 2 CPUs, 0 hotplug CPUs
[    0.093591][    T0] mapped IOAPIC to ffffb000 (fec00000)
[    0.094033][    T0] [mem 0xc0000000-0xfeffbfff] available for PCI devices
[    0.094597][    T0] Booting paravirtualized kernel on KVM
[    0.094940][    T0] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns
[    0.095738][    T0] setup_percpu: NR_CPUS:32 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1
[    0.097591][    T0] percpu: Embedded 351 pages/cpu s1408180 r0 d29516 u1437696
[    0.098013][    T0] pcpu-alloc: s1408180 r0 d29516 u1437696 alloc=351*4096
[    0.098431][    T0] pcpu-alloc: [0] 0 [0] 1 
[    0.098821][    T0] kvm-guest: stealtime: cpu 0, msr 43cd0a80
[    0.099196][    T0] Built 1 zonelists, mobility grouping on.  Total pages: 784054
[    0.099810][    T0] Kernel command line: ip=::::vm-snb-i386-27::dhcp root=/dev/ram0 user=lkp job=/lkp/jobs/scheduled/vm-snb-i386-27/boot-300-yocto-i386-minimal-20190520.cgz-d3ff51cfa9a64cdc18abe24c9821891b5122e617-20211014-86848-1be7mcg-4.yaml ARCH=i386 kconfig=i386-randconfig-a011-20211012 branch=linux-review/Sean-Nyekjaer/mtd-core-protect-access-to-mtd-devices-while-in-suspend/20211011-195606 commit=d3ff51cfa9a64cdc18abe24c9821891b5122e617 BOOT_IMAGE=/pkg/linux/i386-randconfig-a011-20211012/clang-14/d3ff51cfa9a64cdc18abe24c9821891b5122e617/vmlinuz-5.15.0-rc1-00002-gd3ff51cfa9a6 vmalloc=128M initramfs_async=0 page_owner=on max_uptime=600 RESULT_ROOT=/result/boot/300/vm-snb-i386/yocto-i386-minimal-20190520.cgz/i386-randconfig-a011-20211012/clang-14/d3ff51cfa9a64cdc18abe24c9821891b5122e617/3 LKP_SERVER=internal-lkp-server 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=pani
[    0.100358][    T0] sysrq: sysrq always enabled.
[    0.107037][    T0] ignoring the deprecated load_ramdisk= option
[    0.107817][    T0] Unknown command line parameters: user=lkp job=/lkp/jobs/scheduled/vm-snb-i386-27/boot-300-yocto-i386-minimal-20190520.cgz-d3ff51cfa9a64cdc18abe24c9821891b5122e617-20211014-86848-1be7mcg-4.yaml ARCH=i386 kconfig=i386-randconfig-a011-20211012 branch=linux-review/Sean-Nyekjaer/mtd-core-protect-access-to-mtd-devices-while-in-suspend/20211011-195606 commit=d3ff51cfa9a64cdc18abe24c9821891b5122e617 BOOT_IMAGE=/pkg/linux/i386-randconfig-a011-20211012/clang-14/d3ff51cfa9a64cdc18abe24c9821891b5122e617/vmlinuz-5.15.0-rc1-00002-gd3ff51cfa9a6 max_uptime=600 RESULT_ROOT=/result/boot/300/vm-snb-i386/yocto-i386-minimal-20190520.cgz/i386-randconfig-a011-20211012/clang-14/d3ff51cfa9a64cdc18abe24c9821891b5122e617/3 LKP_SERVER=internal-lkp-server selinux=0 softlockup_panic=1 prompt_ramdisk=0 vga=normal
[    0.113136][    T0] Dentry cache hash table entries: 262144 (order: 8, 1048576 bytes, linear)
[    0.113785][    T0] Inode-cache hash table entries: 131072 (order: 7, 524288 bytes, linear)
[    0.114461][    T0] mem auto-init: stack:off, heap alloc:off, heap free:on
[    0.115086][    T0] mem auto-init: clearing system memory may take some time...
[    0.117558][    T0] Initializing HighMem for node 0 (000463fe:000bffe0)
[    1.372261][    T0] Initializing Movable for node 0 (00000000:00000000)
[    1.821093][    T0] Checking if this processor honours the WP bit even in supervisor mode...Ok.
[    1.821768][    T0] Memory: 3066336K/3145208K available (11101K kernel code, 4848K rwdata, 6132K rodata, 2168K init, 8296K bss, 78872K reserved, 0K cma-reserved, 1994632K highmem)
[    1.823295][    T0] ODEBUG: selftest passed
[    1.823569][    T0] ftrace: allocating 41672 entries in 82 pages
[    1.838865][    T0] ftrace: allocated 82 pages with 3 groups
[    1.839279][    T0] 
[    1.839413][    T0] **********************************************************
[    1.839917][    T0] **   NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE   **
[    1.840607][    T0] **                                                      **
[    1.841287][    T0] ** trace_printk() being used. Allocating extra memory.  **
[    1.841965][    T0] **                                                      **
[    1.842655][    T0] ** This means that this is a DEBUG kernel and it is     **
[    1.843330][    T0] ** unsafe for production use.                           **
[    1.844011][    T0] **                                                      **
[    1.844717][    T0] ** If you see this message and you are not debugging    **
[    1.845441][    T0] ** the kernel, report this immediately to your vendor!  **
[    1.846150][    T0] **                                                      **
[    1.846876][    T0] **   NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE   **
[    1.847574][    T0] **********************************************************
[    1.849162][    T0] trace event string verifier disabled
[    1.850039][    T0] Running RCU self tests
[    1.850477][    T0] rcu: Preemptible hierarchical RCU implementation.
[    1.851114][    T0] rcu: 	RCU event tracing is enabled.
[    1.851617][    T0] rcu: 	RCU lockdep checking is enabled.
[    1.852132][    T0] rcu: 	RCU restricting CPUs from NR_CPUS=32 to nr_cpu_ids=2.
[    1.852821][    T0] rcu: 	RCU priority boosting: priority 1 delay 500 ms.
[    1.853469][    T0] rcu: 	RCU callback double-/use-after-free debug enabled.
[    1.854132][    T0] rcu: 	RCU debug extended QS entry/exit.
[    1.854661][    T0] 	RCU CPU stall warnings timeout set to 100 (rcu_cpu_stall_timeout).
[    1.855443][    T0] 	Trampoline variant of Tasks RCU enabled.
[    1.855986][    T0] 	Rude variant of Tasks RCU enabled.
[    1.856490][    T0] 	Tracing variant of Tasks RCU enabled.
[    1.857015][    T0] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
[    1.857796][    T0] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
[    1.872309][    T0] NR_IRQS: 2304, nr_irqs: 56, preallocated irqs: 16
[    1.873601][    T0] printk: console [ttyS0] enabled
[    1.874559][    T0] printk: bootconsole [earlyser0] disabled
[    1.875672][    T0] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[    1.876490][    T0] ... MAX_LOCKDEP_SUBCLASSES:  8
[    1.876966][    T0] ... MAX_LOCK_DEPTH:          48
[    1.877446][    T0] ... MAX_LOCKDEP_KEYS:        8192
[    1.877958][    T0] ... CLASSHASH_SIZE:          4096
[    1.878460][    T0] ... MAX_LOCKDEP_ENTRIES:     32768
[    1.878990][    T0] ... MAX_LOCKDEP_CHAINS:      65536
[    1.879500][    T0] ... CHAINHASH_SIZE:          32768
[    1.880013][    T0]  memory used by lock dependency info: 4061 kB
[    1.880609][    T0]  memory used for stack traces: 2112 kB
[    1.881153][    T0]  per task-struct memory footprint: 2112 bytes
[    1.881789][    T0] ACPI: Core revision 20210730
[    1.882646][    T0] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
[    1.883889][    T0] APIC: Switch to symmetric I/O mode setup
[    1.884468][    T0] Enabling APIC mode:  Flat.  Using 1 I/O APICs
[    1.885100][    T0] masked ExtINT on CPU#0
[    1.886460][    T0] ENABLING IO-APIC IRQs
[    1.886885][    T0] init IO_APIC IRQs
[    1.887429][    T0]  apic 0 pin 0 not connected
[    1.887967][    T0] IOAPIC[0]: Preconfigured routing entry (0-1 -> IRQ 1 Level:0 ActiveLow:0)
[    1.888819][    T0] IOAPIC[0]: Preconfigured routing entry (0-2 -> IRQ 0 Level:0 ActiveLow:0)
[    1.889664][    T0] IOAPIC[0]: Preconfigured routing entry (0-3 -> IRQ 3 Level:0 ActiveLow:0)
[    1.890503][    T0] IOAPIC[0]: Preconfigured routing entry (0-4 -> IRQ 4 Level:0 ActiveLow:0)
[    1.891348][    T0] IOAPIC[0]: Preconfigured routing entry (0-5 -> IRQ 5 Level:1 ActiveLow:0)
[    1.892225][    T0] IOAPIC[0]: Preconfigured routing entry (0-6 -> IRQ 6 Level:0 ActiveLow:0)
[    1.893098][    T0] IOAPIC[0]: Preconfigured routing entry (0-7 -> IRQ 7 Level:0 ActiveLow:0)
[    1.893948][    T0] IOAPIC[0]: Preconfigured routing entry (0-8 -> IRQ 8 Level:0 ActiveLow:0)
[    1.894798][    T0] IOAPIC[0]: Preconfigured routing entry (0-9 -> IRQ 9 Level:1 ActiveLow:0)
[    1.895655][    T0] IOAPIC[0]: Preconfigured routing entry (0-10 -> IRQ 10 Level:1 ActiveLow:0)
[    1.896574][    T0] IOAPIC[0]: Preconfigured routing entry (0-11 -> IRQ 11 Level:1 ActiveLow:0)
[    1.897444][    T0] IOAPIC[0]: Preconfigured routing entry (0-12 -> IRQ 12 Level:0 ActiveLow:0)
[    1.898331][    T0] IOAPIC[0]: Preconfigured routing entry (0-13 -> IRQ 13 Level:0 ActiveLow:0)
[    1.899221][    T0] IOAPIC[0]: Preconfigured routing entry (0-14 -> IRQ 14 Level:0 ActiveLow:0)
[    1.900136][    T0] IOAPIC[0]: Preconfigured routing entry (0-15 -> IRQ 15 Level:0 ActiveLow:0)
[    1.900992][    T0]  apic 0 pin 16 not connected
[    1.901446][    T0]  apic 0 pin 17 not connected
[    1.901901][    T0]  apic 0 pin 18 not connected
[    1.902354][    T0]  apic 0 pin 19 not connected
[    1.902807][    T0]  apic 0 pin 20 not connected
[    1.903276][    T0]  apic 0 pin 21 not connected
[    1.903730][    T0]  apic 0 pin 22 not connected
[    1.904242][    T0]  apic 0 pin 23 not connected
[    1.904868][    T0] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[    1.905577][    T0] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x1fa3704c1a9, max_idle_ns: 440795296692 ns
[    1.906703][    T0] Calibrating delay loop (skipped) preset value.. 4389.83 BogoMIPS (lpj=8779664)
[    1.907593][    T0] pid_max: default: 4096 minimum: 301
[    1.910736][    T0] LSM: Security Framework initializing
[    1.911301][    T0] Mount-cache hash table entries: 4096 (order: 2, 16384 bytes, linear)
[    1.912092][    T0] Mountpoint-cache hash table entries: 4096 (order: 2, 16384 bytes, linear)
[    1.913915][    T0] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[    1.914687][    T0] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
[    1.915377][    T0] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
[    1.916284][    T0] Spectre V2 : Mitigation: Full generic retpoline
[    1.916897][    T0] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
[    1.917786][    T0] Speculative Store Bypass: Vulnerable
[    1.918306][    T0] L1TF: Kernel not compiled for PAE. No mitigation for L1TF
[    1.918697][    T0] MDS: Vulnerable: Clear CPU buffers attempted, no microcode
[    1.919889][    T0] Freeing SMP alternatives memory: 32K
[    1.920888][    T1] smpboot: CPU0: Intel Xeon E312xx (Sandy Bridge) (family: 0x6, model: 0x2a, stepping: 0x1)
[    1.922681][    T1] Running RCU-tasks wait API self tests
[    2.023011][    T1] Performance Events: unsupported p6 CPU model 42 no PMU driver, software events only.
[    2.024176][    T1] rcu: Hierarchical SRCU implementation.
[    2.025283][    T1] NMI watchdog: Perf NMI watchdog permanently disabled
[    2.025906][    T1] smp: Bringing up secondary CPUs ...
[    2.029060][    T1] x86: Booting SMP configuration:
[    2.029584][    T1] .... node  #0, CPUs:      #1
[    0.033331][    T0] kvm-clock: cpu 1, msr 27eb041, secondary cpu clock
[    0.033331][    T0] masked ExtINT on CPU#1
[    0.033331][    T0] smpboot: CPU 1 Converting physical 0 to logical die 1
[    2.034811][   T19] kvm-guest: stealtime: cpu 1, msr 43e2fa80
[    2.035855][    T1] smp: Brought up 1 node, 2 CPUs
[    2.036331][    T1] smpboot: Max logical packages: 2
[    2.036867][    T1] smpboot: Total of 2 processors activated (8779.66 BogoMIPS)
[    2.047804][    T1] allocated 31457280 bytes of page_ext
[    2.048594][    T1] Node 0, zone      DMA: page owner found early allocated 0 pages
[    2.050024][    T1] Node 0, zone   Normal: page owner found early allocated 8978 pages
[    2.050595][    T1] Node 0, zone  HighMem: page owner found early allocated 63 pages
[    2.051401][    T1] devtmpfs: initialized
[    2.053615][    T1] random: get_random_u32 called from rhashtable_init+0x1e6/0x330 with crng_init=0
[    2.053881][    T1] random: get_random_bytes called from setup_net+0x3d/0x340 with crng_init=0
[    2.055419][    T1] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    2.056216][    T1] futex hash table entries: 16 (order: -2, 1024 bytes, linear)
[    2.056819][    T1] pinctrl core: initialized pinctrl subsystem
[    2.057343][    T1] pinctrl core: failed to create debugfs directory
[    2.058741][    T1] NET: Registered PF_NETLINK/PF_ROUTE protocol family
[    2.061593][    T1] thermal_sys: Registered thermal governor 'fair_share'
[    2.061598][    T1] thermal_sys: Registered thermal governor 'bang_bang'
[    2.062135][    T1] thermal_sys: Registered thermal governor 'step_wise'
[    2.062718][    T1] EISA bus registered
[    2.063586][    T1] cpuidle: using governor ladder
[    2.064893][    T1] ACPI: bus type PCI registered
[    2.065513][    T1] PCI: PCI BIOS revision 2.10 entry at 0xfd1bc, last bus=0
[    2.065958][    T1] PCI: Using configuration type 1 for base access
[    2.105872][   T32] cryptomgr_test (32) used greatest stack depth: 7036 bytes left
[    2.106919][   T33] cryptomgr_test (33) used greatest stack depth: 6972 bytes left
[    2.110021][   T47] cryptomgr_test (47) used greatest stack depth: 6932 bytes left
[    2.114536][    T1] cryptd: max_cpu_qlen set to 1000
[    2.123459][    T1] ACPI: Added _OSI(Module Device)
[    2.123986][    T1] ACPI: Added _OSI(Processor Device)
[    2.124500][    T1] ACPI: Added _OSI(3.0 _SCP Extensions)
[    2.125039][    T1] ACPI: Added _OSI(Processor Aggregator Device)
[    2.125673][    T1] ACPI: Added _OSI(Linux-Dell-Video)
[    2.126194][    T1] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
[    2.127063][   T11] Callback from call_rcu_tasks_trace() invoked.
[    2.127709][   T10] Callback from call_rcu_tasks_rude() invoked.
[    2.128364][    T1] ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics)
[    2.139099][    T1] ACPI: 1 ACPI AML tables successfully acquired and loaded
[    2.145114][    T1] ACPI: Interpreter enabled
[    2.145575][    T1] ACPI: PM: (supports S0 S5)
[    2.145998][    T1] ACPI: Using IOAPIC for interrupt routing
[    2.146598][    T1] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    2.147854][    T1] ACPI: Enabled 2 GPEs in block 00 to 0F
[    2.179838][    T1] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[    2.180543][    T1] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments HPX-Type3]
[    2.181350][    T1] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
[    2.182482][    T1] acpi resource window ([0x140000000-0x1bfffffff] ignored, not CPU addressable)
[    2.183033][    T1] PCI host bridge to bus 0000:00
[    2.183478][    T1] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
[    2.184227][    T1] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
[    2.184964][    T1] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[    2.185730][    T1] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]
[    2.186471][    T1] pci_bus 0000:00: root bus resource [bus 00-ff]
[    2.188057][    T1] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
[    2.190996][    T1] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
[    2.193055][    T1] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
[    2.200550][    T1] pci 0000:00:01.1: reg 0x20: [io  0xc040-0xc04f]
[    2.202430][    T1] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io  0x01f0-0x01f7]
[    2.202698][    T1] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io  0x03f6]
[    2.203396][    T1] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io  0x0170-0x0177]
[    2.204624][    T1] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io  0x0376]
[    2.207903][    T1] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
[    2.208707][    T1] pci 0000:00:01.3: quirk: [io  0x0600-0x063f] claimed by PIIX4 ACPI
[    2.209515][    T1] pci 0000:00:01.3: quirk: [io  0x0700-0x070f] claimed by PIIX4 SMB
[    2.212493][    T1] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000
[    2.214717][    T1] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref]
[    2.217256][    T1] pci 0000:00:02.0: reg 0x18: [mem 0xfebf0000-0xfebf0fff]
[    2.222272][    T1] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref]
[    2.224609][    T1] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000
[    2.226485][    T1] pci 0000:00:03.0: reg 0x10: [mem 0xfebc0000-0xfebdffff]
[    2.227807][    T1] pci 0000:00:03.0: reg 0x14: [io  0xc000-0xc03f]
[    2.234068][    T1] pci 0000:00:03.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref]
[    2.236945][    T1] pci 0000:00:04.0: [8086:25ab] type 00 class 0x088000
[    2.238257][    T1] pci 0000:00:04.0: reg 0x10: [mem 0xfebf1000-0xfebf100f]
[    2.242681][    T1] pci_bus 0000:00: on NUMA node 0
[    2.247278][    T1] ACPI: PCI: Interrupt link LNKA configured for IRQ 10
[    2.248836][    T1] ACPI: PCI: Interrupt link LNKB configured for IRQ 10
[    2.250328][    T1] ACPI: PCI: Interrupt link LNKC configured for IRQ 11
[    2.251554][    T1] ACPI: PCI: Interrupt link LNKD configured for IRQ 11
[    2.252595][    T1] ACPI: PCI: Interrupt link LNKS configured for IRQ 9
[    2.256758][    T1] iommu: Default domain type: Translated 
[    2.257347][    T1] iommu: DMA domain TLB invalidation policy: lazy mode 
[    2.258520][    T1] pci 0000:00:02.0: vgaarb: setting as boot VGA device
[    2.258681][    T1] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
[    2.262700][    T1] pci 0000:00:02.0: vgaarb: bridge control possible
[    2.263386][    T1] vgaarb: loaded
[    2.265801][    T1] mc: Linux media interface: v0.10
[    2.266455][    T1] videodev: Linux video capture interface: v2.00
[    2.266741][    T1] cec: Failed to create debugfs cec dir
[    2.267415][    T1] pps_core: LinuxPPS API ver. 1 registered
[    2.268012][    T1] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[    2.269080][    T1] PTP clock support registered
[    2.270886][    T1] Advanced Linux Sound Architecture Driver Initialized.
[    2.272899][    T1] PCI: Using ACPI for IRQ routing
[    2.273410][    T1] PCI: pci_cache_line_size set to 64 bytes
[    2.274090][    T1] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
[    2.274722][    T1] e820: reserve RAM buffer [mem 0xbffe0000-0xbfffffff]
[    2.276811][    T1] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
[    2.277400][    T1] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
[    2.281149][    T1] clocksource: Switched to clocksource kvm-clock
[    2.338916][    T9] Callback from call_rcu_tasks() invoked.
[    2.538327][    T1] pnp: PnP ACPI init
[    2.539821][    T1] pnp 00:03: [dma 2]
[    2.543517][    T1] pnp: PnP ACPI: found 7 devices
[    2.580371][    T1] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[    2.582112][    T1] NET: Registered PF_INET protocol family
[    2.582770][    T1] random: get_random_u32 called from neigh_hash_alloc+0x59/0xd0 with crng_init=0
[    2.582865][    T1] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)
[    2.585666][    T1] tcp_listen_portaddr_hash hash table entries: 1024 (order: 3, 53248 bytes, linear)
[    2.586651][    T1] TCP established hash table entries: 16384 (order: 4, 65536 bytes, linear)
[    2.587999][    T1] TCP bind hash table entries: 16384 (order: 7, 786432 bytes, linear)
[    2.589511][    T1] TCP: Hash tables configured (established 16384 bind 16384)
[    2.590434][    T1] UDP hash table entries: 1024 (order: 4, 114688 bytes, linear)
[    2.591361][    T1] UDP-Lite hash table entries: 1024 (order: 4, 114688 bytes, linear)
[    2.592464][    T1] NET: Registered PF_UNIX/PF_LOCAL protocol family
[    2.594419][    T1] RPC: Registered named UNIX socket transport module.
[    2.595146][    T1] RPC: Registered udp transport module.
[    2.595691][    T1] RPC: Registered tcp transport module.
[    2.596265][    T1] RPC: Registered tcp NFSv4.1 backchannel transport module.
[    2.596968][    T1] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
[    2.597658][    T1] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
[    2.598328][    T1] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
[    2.599101][    T1] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window]
[    2.600303][    T1] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[    2.600952][    T1] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[    2.601614][    T1] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[    2.602340][    T1] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
[    2.603368][    T1] PCI: CLS 0 bytes, default 64
[    2.604613][    T7] Unpacking initramfs...
[    3.860035][    T7] Freeing initrd memory: 12428K
[    3.861894][    T1] RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer
[    3.862814][    T1] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x1fa3704c1a9, max_idle_ns: 440795296692 ns
[    3.863942][    T1] mce: Machine check injector initialized
[    3.867141][  T120] cryptomgr_test (120) used greatest stack depth: 6864 bytes left
[    3.868229][    T1] The force parameter has not been set to 1. The Iris poweroff handler will not be installed.
[    3.869369][    T1] NatSemi SCx200 Driver
[    3.870041][    T1] rcu-scale:--- Start of test: nreaders=2 nwriters=2 verbose=1 shutdown=1
[    3.870893][    T1] rcu-torture: Creating rcu_scale_shutdown task
[    3.882786][    T1] rcu-torture: Creating rcu_scale_reader task
[    3.884278][    T1] rcu-torture: Creating rcu_scale_reader task
[    3.884286][  T126] rcu-scale: rcu_scale_reader task started
[    3.884974][  T127] rcu-scale: rcu_scale_reader task started
[    3.890929][    T1] rcu-torture: Creating rcu_scale_writer task
[    3.894782][    T1] rcu-torture: Creating rcu_scale_writer task
[    3.895504][  T128] rcu-scale: rcu_scale_writer task started
[    3.899940][  T129] rcu-scale: rcu_scale_writer task started
[    3.906781][    T1] workingset: timestamp_bits=30 max_order=20 bucket_order=0
[    3.911913][    T1] fuse: init (API version 7.34)
[    3.942860][    T1] Key type asymmetric registered
[    3.943394][    T1] Asymmetric key parser 'pkcs8' registered
[    4.129789][    T1] String selftests succeeded
[    4.130251][    T1] test_printf: loaded.
[    4.130762][    T1] test_printf: crng possibly not yet initialized. plain 'p' buffer contains "(ptrval)"
[    4.130790][    T1] test_printf: crng possibly not yet initialized. plain 'p' buffer contains "(ptrval)"
[    4.132022][    T1] test_printf: crng possibly not yet initialized. plain 'p' buffer contains "(ptrval)"
[    4.133148][    T1] test_printf: all 396 tests passed
[    4.134389][    T1] test_scanf: loaded.
[    4.137360][    T1] test_scanf: all 2383 tests passed
[    4.137857][    T1] test_bitmap: loaded.
[    4.138492][    T1] test_bitmap: parselist: 14: input is '0-2047:128/256' OK, Time: 1790
[    4.141992][    T1] test_bitmap: all 1945 tests passed
[    4.142477][    T1] test_strscpy: loaded.
[    4.142876][    T1] test_strscpy: all 32 tests passed
[    4.143481][    T1] start plist test
[    4.145102][    T1] end plist test
[    4.147151][    T1] gpio_winbond: chip ID at 2e is ffff
[    4.147682][    T1] gpio_winbond: not an our chip
[    4.148175][    T1] gpio_winbond: chip ID at 4e is ffff
[    4.148675][    T1] gpio_winbond: not an our chip
[    4.149541][    T1] IPMI message handler: version 39.2
[    4.150234][    T1] ipmi_si: IPMI System Interface driver
[    4.151044][    T1] ipmi_si: Unable to find any System Interface(s)
[    4.151655][    T1] IPMI Watchdog: driver initialized
[    4.152127][    T1] IPMI poweroff: Copyright (C) 2004 MontaVista Software - IPMI Powerdown via sys_reboot
[    4.155509][    T1] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
[    4.156252][    T1] ACPI: button: Power Button [PWRF]
[    4.157117][    T1] Warning: Processor Platform Limit event detected, but not handled.
[    4.157805][    T1] Consider compiling CPUfreq support into your kernel.
[    4.174467][    T1] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[    4.206979][    T1] serial8250: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[    4.238923][    T1] serial8250: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A
[    4.247198][  T138] kworker/u4:0 (138) used greatest stack depth: 6644 bytes left
[    4.247964][    T1] lp: driver loaded but no devices found
[    4.248917][    T1] toshiba: not a supported Toshiba laptop
[    4.249431][    T1] scx200_gpio: no SCx200 gpio present
[    4.249888][    T1] nsc_gpio initializing
[    4.250270][    T1] smapi::smapi_init, ERROR invalid usSmapiID
[    4.250887][    T1] mwave: tp3780i::tp3780I_InitializeBoardData: Error: SMAPI is not available on this machine
[    4.251896][    T1] mwave: mwavedd::mwave_init: Error: Failed to initialize board data
[    4.252600][    T1] mwave: mwavedd::mwave_init: Error: Failed to initialize
[    4.255166][    T1] dummy-irq: no IRQ given.  Use irq=N
[    4.258855][    T1] mtdoops: mtd device (mtddev=name/number) must be supplied
[    4.259817][    T1] slram: not enough parameters.
[    4.260389][    T1] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[    4.261303][    T1] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[    4.262202][    T1] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[    4.263147][    T1] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[    4.264068][    T1] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[    4.264928][    T1] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0
[    4.265805][    T1] nand: device found, Manufacturer ID: 0x98, Chip ID: 0x39
[    4.266407][    T1] nand: Toshiba NAND 128MiB 1,8V 8-bit
[    4.266876][    T1] nand: 128 MiB, SLC, erase size: 16 KiB, page size: 512, OOB size: 16
[    4.267637][    T1] flash size: 128 MiB
[    4.267996][    T1] page size: 512 bytes
[    4.268348][    T1] OOB area size: 16 bytes
[    4.268717][    T1] sector size: 16 KiB
[    4.269091][    T1] pages number: 262144
[    4.269452][    T1] pages per sector: 32
[    4.269817][    T1] bus width: 8
[    4.270116][    T1] bits in sector size: 14
[    4.270505][    T1] bits in page size: 9
[    4.274735][    T1] bits in OOB size: 4
[    4.275119][    T1] flash size with OOB: 135168 KiB
[    4.275550][    T1] page address bytes: 4
[    4.275948][    T1] sector address bytes: 3
[    4.276338][    T1] options: 0x42
[    4.277604][    T1] Scanning device for bad blocks
[    4.278038][    T1] INFO: trying to register non-static key.
[    4.278540][    T1] The code is fine but needs lockdep annotation, or maybe
[    4.278694][    T1] you didn't initialize this object before use?
[    4.278694][    T1] turning off the locking correctness validator.
[    4.278694][    T1] CPU: 1 PID: 1 Comm: swapper/0 Not tainted 5.15.0-rc1-00002-gd3ff51cfa9a6 #1
[    4.278694][    T1] Call Trace:
[    4.278694][    T1]  dump_stack_lvl+0x69/0x99
[    4.278694][    T1]  dump_stack+0xd/0x12
[    4.278694][    T1]  assign_lock_key+0xbc/0xc0
[    4.278694][    T1]  register_lock_class+0x9c/0x290
[    4.278694][    T1]  __lock_acquire+0x5c/0xbb0
[    4.278694][    T1]  ? debug_smp_processor_id+0x12/0x20
[    4.278694][    T1]  ? rcu_read_lock_sched_held+0x36/0x70
[    4.278694][    T1]  lock_acquire+0x99/0x170
[    4.278694][    T1]  ? mtd_start_access+0x32/0xc0
[    4.278694][    T1]  down_read+0x41/0x110
[    4.278694][    T1]  ? mtd_start_access+0x32/0xc0
[    4.278694][    T1]  mtd_start_access+0x32/0xc0
[    4.278694][    T1]  ? ledtrig_mtd_activity+0x37/0x40
[    4.278694][    T1]  mtd_read_oob+0x75/0x1e0
[    4.278694][    T1]  scan_block_fast+0x6a/0xc0
[    4.278694][    T1]  create_bbt+0x130/0x2a0
[    4.278694][    T1]  ? __kmalloc+0x146/0x1a0
[    4.278694][    T1]  ? trace_kmalloc_node+0x39/0x100
[    4.278694][    T1]  nand_create_bbt+0x1fe/0x9e0
[    4.278694][    T1]  ? ns_alloc_device+0xa4/0x18b
[    4.278694][    T1]  ? ns_init+0x3b6/0x688
[    4.278694][    T1]  ? __kmalloc+0x146/0x1a0
[    4.278694][    T1]  ns_init_module+0x5f9/0x809
[    4.278694][    T1]  ? __this_cpu_preempt_check+0xf/0x11
[    4.278694][    T1]  ? debug_smp_processor_id+0x12/0x20
[    4.278694][    T1]  ? generic_onenand_driver_init+0x16/0x16
[    4.278694][    T1]  ? rcu_read_lock_sched_held+0x36/0x70
[    4.278694][    T1]  ? generic_onenand_driver_init+0x16/0x16
[    4.278694][    T1]  do_one_initcall+0x93/0x160
[    4.278694][    T1]  ? irqentry_exit+0x56/0x80
[    4.278694][    T1]  ? __this_cpu_preempt_check+0xf/0x11
[    4.278694][    T1]  ? lockdep_hardirqs_on+0x82/0x110
[    4.278694][    T1]  ? irqentry_exit+0x56/0x80
[    4.278694][    T1]  ? sysvec_call_function_single+0x30/0x30
[    4.278694][    T1]  ? trace_hardirqs_on+0x45/0x50
[    4.278694][    T1]  ? irqentry_exit+0x56/0x80
[    4.278694][    T1]  ? sysvec_apic_timer_interrupt+0x29/0x30
[    4.278694][    T1]  ? handle_exception+0x101/0x101
[    4.278694][    T1]  ? p9_client_readlink+0x9b/0xa0
[    4.278694][    T1]  ? strlen+0xd/0x20
[    4.278694][    T1]  ? next_arg+0xfb/0x110
[    4.278694][    T1]  ? parse_args+0x15c/0x330
[    4.278694][    T1]  ? __this_cpu_preempt_check+0xf/0x11
[    4.278694][    T1]  ? debug_smp_processor_id+0x12/0x20
[    4.278694][    T1]  ? generic_onenand_driver_init+0x16/0x16
[    4.278694][    T1]  do_initcall_level+0x80/0x92
[    4.278694][    T1]  ? rest_init+0x1c0/0x1c0
[    4.278694][    T1]  do_initcalls+0x41/0x62
[    4.278694][    T1]  do_basic_setup+0x17/0x19
[    4.278694][    T1]  kernel_init_freeable+0x8c/0xd1
[    4.278694][    T1]  kernel_init+0x17/0x170
[    4.278694][    T1]  ret_from_fork+0x1c/0x28
[    4.304729][    T1] ------------[ cut here ]------------
[    4.305194][    T1] DEBUG_RWSEMS_WARN_ON(sem->magic != sem): count = 0x0, magic = 0x0, owner = 0x0, curr 0xb3690000, list not empty
[    4.306218][    T1] WARNING: CPU: 1 PID: 1 at kernel/locking/rwsem.c:1240 down_read+0xff/0x110
[    4.306989][    T1] Modules linked in:
[    4.307318][    T1] CPU: 1 PID: 1 Comm: swapper/0 Not tainted 5.15.0-rc1-00002-gd3ff51cfa9a6 #1
[    4.308071][    T1] EIP: down_read+0xff/0x110
[    4.308445][    T1] Code: 9f 03 b2 ba 0f 44 d1 52 0f 44 d1 52 ff 75 f0 ff ff 75 f0 ff 00 b2 68 79 00 b2 68 79 c7 d5 5a ff c7 d5 5a ff c4 1c 0f 0b c4 1c <0f> 0b 58 ff ff ff 58 ff ff ff ff 90 90 3e ff 90 90 3e 55 89 e5 53
[    4.310153][    T1] EAX: 00000000 EBX: b15a2702 ECX: 80000001 EDX: 00000001
[    4.310861][    T1] ESI: f5dc0404 EDI: 00000000 EBP: b3693c98 ESP: b3693c84
[    4.311546][    T1] DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068 EFLAGS: 00010296
[    4.312277][    T1] CR0: 80050033 CR2: 00000000 CR3: 027d9000 CR4: 000406d0
[    4.312919][    T1] DR0: 00000000 DR1: 00000000 DR2: 00000000 DR3: 00000000
[    4.313518][    T1] DR6: fffe0ff0 DR7: 00000400
[    4.313926][    T1] Call Trace:
[    4.314237][    T1]  mtd_start_access+0x32/0xc0
[    4.314707][    T1]  ? ledtrig_mtd_activity+0x37/0x40
[    4.315194][    T1]  mtd_read_oob+0x75/0x1e0
[    4.315572][    T1]  scan_block_fast+0x6a/0xc0
[    4.316003][    T1]  create_bbt+0x130/0x2a0
[    4.316399][    T1]  ? __kmalloc+0x146/0x1a0
[    4.316811][    T1]  ? trace_kmalloc_node+0x39/0x100
[    4.317267][    T1]  nand_create_bbt+0x1fe/0x9e0
[    4.317685][    T1]  ? ns_alloc_device+0xa4/0x18b
[    4.318107][    T1]  ? ns_init+0x3b6/0x688
[    4.318459][    T1]  ? __kmalloc+0x146/0x1a0
[    4.318858][    T1]  ns_init_module+0x5f9/0x809
[    4.319254][    T1]  ? __this_cpu_preempt_check+0xf/0x11
[    4.319719][    T1]  ? debug_smp_processor_id+0x12/0x20
[    4.320174][    T1]  ? generic_onenand_driver_init+0x16/0x16
[    4.320662][    T1]  ? rcu_read_lock_sched_held+0x36/0x70
[    4.321122][    T1]  ? generic_onenand_driver_init+0x16/0x16
[    4.321602][    T1]  do_one_initcall+0x93/0x160
[    4.321997][    T1]  ? irqentry_exit+0x56/0x80
[    4.322382][    T1]  ? __this_cpu_preempt_check+0xf/0x11
[    4.322854][    T1]  ? lockdep_hardirqs_on+0x82/0x110
[    4.323273][    T1]  ? irqentry_exit+0x56/0x80
[    4.323642][    T1]  ? sysvec_call_function_single+0x30/0x30
[    4.324124][    T1]  ? trace_hardirqs_on+0x45/0x50
[    4.324523][    T1]  ? irqentry_exit+0x56/0x80
[    4.324893][    T1]  ? sysvec_apic_timer_interrupt+0x29/0x30
[    4.325367][    T1]  ? handle_exception+0x101/0x101
[    4.325776][    T1]  ? p9_client_readlink+0x9b/0xa0
[    4.326186][    T1]  ? strlen+0xd/0x20
[    4.326508][    T1]  ? next_arg+0xfb/0x110
[    4.326877][    T1]  ? parse_args+0x15c/0x330
[    4.327244][    T1]  ? __this_cpu_preempt_check+0xf/0x11
[    4.327688][    T1]  ? debug_smp_processor_id+0x12/0x20
[    4.328155][    T1]  ? generic_onenand_driver_init+0x16/0x16
[    4.328664][    T1]  do_initcall_level+0x80/0x92
[    4.329088][    T1]  ? rest_init+0x1c0/0x1c0
[    4.329475][    T1]  do_initcalls+0x41/0x62
[    4.329838][    T1]  do_basic_setup+0x17/0x19
[    4.330214][    T1]  kernel_init_freeable+0x8c/0xd1
[    4.330657][    T1]  kernel_init+0x17/0x170
[    4.331087][    T1]  ret_from_fork+0x1c/0x28
[    4.331503][    T1] irq event stamp: 319917
[    4.331919][    T1] hardirqs last  enabled at (319917): [<b10e59cc>] __up_console_sem+0x5c/0x90
[    4.332719][    T1] hardirqs last disabled at (319916): [<b10e59b3>] __up_console_sem+0x43/0x90
[    4.333495][    T1] softirqs last  enabled at (318956): [<b121d2f1>] bdi_register_va+0x1d1/0x1f0
[    4.334243][    T1] softirqs last disabled at (318954): [<b121d202>] bdi_register_va+0xe2/0x1f0
[    4.334994][    T1] _warn_unseeded_randomness: 5 callbacks suppressed
[    4.334997][    T1] random: get_random_bytes called from __warn+0xc3/0x140 with crng_init=0
[    4.335006][    T1] ---[ end trace 8e9a8c821c89b3d1 ]---
[    4.336766][    T1] ------------[ cut here ]------------
[    4.337266][    T1] DEBUG_RWSEMS_WARN_ON(sem->magic != sem): count = 0x100, magic = 0x0, owner = 0xb3690001, curr 0xb3690000, list not empty
[    4.338454][    T1] WARNING: CPU: 1 PID: 1 at kernel/locking/rwsem.c:1292 __up_read+0x115/0x1c0
[    4.339257][    T1] Modules linked in:
[    4.339615][    T1] CPU: 1 PID: 1 Comm: swapper/0 Tainted: G        W         5.15.0-rc1-00002-gd3ff51cfa9a6 #1
[    4.340477][    T1] EIP: __up_read+0x115/0x1c0
[    4.340888][    T1] Code: 38 39 ca b9 ba 84 f9 01 ba 84 f9 01 52 50 ff 76 52 50 ff 76 68 fa 3f 00 68 fa 3f 00 fa b1 e8 be fa b1 e8 be c4 1c 0f 0b c4 1c <0f> 0b 0a ff ff ff 0a ff ff ff ff c6 05 4d ff c6 05 4d 8d 46 38 8b
[    4.342745][    T1] EAX: 00000078 EBX: 00000000 ECX: 80000001 EDX: 00000001
[    4.343422][    T1] ESI: f5dc0404 EDI: 00000000 EBP: b3693cb8 ESP: b3693cac
[    4.344029][    T1] DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068 EFLAGS: 00010286
[    4.344662][    T1] CR0: 80050033 CR2: 00000000 CR3: 027d9000 CR4: 000406d0
[    4.345280][    T1] DR0: 00000000 DR1: 00000000 DR2: 00000000 DR3: 00000000
[    4.345869][    T1] DR6: fffe0ff0 DR7: 00000400
[    4.346258][    T1] Call Trace:
[    4.346541][    T1]  up_read+0x1d/0x20
[    4.346914][    T1]  mtd_read_oob+0x1af/0x1e0
[    4.347327][    T1]  scan_block_fast+0x6a/0xc0
[    4.347716][    T1]  create_bbt+0x130/0x2a0
[    4.348092][    T1]  ? __kmalloc+0x146/0x1a0
[    4.348462][    T1]  ? trace_kmalloc_node+0x39/0x100
[    4.348882][    T1]  nand_create_bbt+0x1fe/0x9e0
[    4.349275][    T1]  ? ns_alloc_device+0xa4/0x18b
[    4.349681][    T1]  ? ns_init+0x3b6/0x688
[    4.350033][    T1]  ? __kmalloc+0x146/0x1a0
[    4.350399][    T1]  ns_init_module+0x5f9/0x809
[    4.350801][    T1]  ? __this_cpu_preempt_check+0xf/0x11
[    4.351318][    T1]  ? debug_smp_processor_id+0x12/0x20
[    4.351838][    T1]  ? generic_onenand_driver_init+0x16/0x16
[    4.352365][    T1]  ? rcu_read_lock_sched_held+0x36/0x70
[    4.352872][    T1]  ? generic_onenand_driver_init+0x16/0x16
[    4.353405][    T1]  do_one_initcall+0x93/0x160
[    4.353814][    T1]  ? irqentry_exit+0x56/0x80
[    4.354202][    T1]  ? __this_cpu_preempt_check+0xf/0x11
[    4.354665][    T1]  ? lockdep_hardirqs_on+0x82/0x110
[    4.355122][    T1]  ? irqentry_exit+0x56/0x80
[    4.355509][    T1]  ? sysvec_call_function_single+0x30/0x30
[    4.356010][    T1]  ? trace_hardirqs_on+0x45/0x50
[    4.356448][    T1]  ? irqentry_exit+0x56/0x80
[    4.356876][    T1]  ? sysvec_apic_timer_interrupt+0x29/0x30
[    4.357415][    T1]  ? handle_exception+0x101/0x101
[    4.357882][    T1]  ? p9_client_readlink+0x9b/0xa0
[    4.358358][    T1]  ? strlen+0xd/0x20
[    4.358729][    T1]  ? next_arg+0xfb/0x110
[    4.359105][    T1]  ? parse_args+0x15c/0x330
[    4.359520][    T1]  ? __this_cpu_preempt_check+0xf/0x11
[    4.360010][    T1]  ? debug_smp_processor_id+0x12/0x20
[    4.360456][    T1]  ? generic_onenand_driver_init+0x16/0x16
[    4.360941][    T1]  do_initcall_level+0x80/0x92
[    4.361340][    T1]  ? rest_init+0x1c0/0x1c0
[    4.361709][    T1]  do_initcalls+0x41/0x62
[    4.362064][    T1]  do_basic_setup+0x17/0x19
[    4.362438][    T1]  kernel_init_freeable+0x8c/0xd1
[    4.362867][    T1]  kernel_init+0x17/0x170
[    4.363227][    T1]  ret_from_fork+0x1c/0x28
[    4.363599][    T1] irq event stamp: 319917
[    4.363989][    T1] hardirqs last  enabled at (319917): [<b10e59cc>] __up_console_sem+0x5c/0x90
[    4.364768][    T1] hardirqs last disabled at (319916): [<b10e59b3>] __up_console_sem+0x43/0x90
[    4.365508][    T1] softirqs last  enabled at (318956): [<b121d2f1>] bdi_register_va+0x1d1/0x1f0
[    4.366252][    T1] softirqs last disabled at (318954): [<b121d202>] bdi_register_va+0xe2/0x1f0
[    4.370707][    T1] ---[ end trace 8e9a8c821c89b3d2 ]---
[    4.402862][    T1] Creating 1 MTD partitions on "NAND 128MiB 1,8V 8-bit":
[    4.403545][    T1] 0x000000000000-0x000008000000 : "NAND simulator partition 0"
[    4.423162][    T1] [nandsim] warning: CONFIG_MTD_PARTITIONED_MASTER must be enabled to expose debugfs stuff
[    4.424491][    T1] e1000: Intel(R) PRO/1000 Network Driver
[    4.424986][    T1] e1000: Copyright (c) 1999-2006 Intel Corporation.
[    4.578937][    T1] ACPI: \_SB_.LNKC: Enabled at IRQ 11
[    4.936440][    T1] e1000 0000:00:03.0 eth0: (PCI:33MHz:32-bit) 52:54:00:12:34:56
[    4.937193][    T1] e1000 0000:00:03.0 eth0: Intel(R) PRO/1000 Network Connection
[    4.938076][    T1] VFIO - User Level meta-driver version: 0.3
[    4.942898][    T1] panel: panel driver not yet registered
[    4.943852][    T1] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
[    4.946022][    T1] serio: i8042 KBD port at 0x60,0x64 irq 1
[    4.946521][    T1] serio: i8042 AUX port at 0x60,0x64 irq 12
[    4.949427][  T110] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1
[    4.950477][    T1] rtc-test rtc-test.0: registered as rtc0
[    4.951586][    T1] rtc-test rtc-test.0: setting system clock to 2021-10-13T17:40:07 UTC (1634146807)
[    4.953162][    T1] rtc-test rtc-test.1: registered as rtc1
[    4.954426][    T1] rtc-test rtc-test.2: registered as rtc2
[    4.955366][    T1] i2c_dev: i2c /dev entries driver
[    4.960924][    T1] pps pps0: new PPS source ktimer
[    4.961384][    T1] pps pps0: ktimer PPS source registered
[    4.967261][    T1] Driver for 1-wire Dallas network protocol.
[    4.967869][    T1] DS1WM w1 busmaster driver - (c) 2004 Szabolcs Gyurko
[    4.968806][    T1] __power_supply_register: Expected proper parent device for 'test_ac'
[    4.970120][    T1] __power_supply_register: Expected proper parent device for 'test_battery'
[    4.971169][    T1] __power_supply_register: Expected proper parent device for 'test_usb'
[    4.975680][    T1] intel_powerclamp: CPU does not support MWAIT
[    4.976360][    T1] ib700wdt: WDT driver for IB700 single board computer initialising
[    4.982858][    T1] it87_wdt: no device
[    4.983203][    T1] sc1200wdt: build 20020303
[    4.983598][    T1] sc1200wdt: io parameter must be specified
[    4.984131][    T1] pc87413_wdt: Version 1.1 at io 0x2E
[    4.984605][    T1] pc87413_wdt: cannot register miscdev on minor=130 (err=-16)
[    4.985240][    T1] sbc60xxwdt: I/O address 0x0443 already in use
[    4.985771][    T1] sbc7240_wdt: I/O address 0x0443 already in use
[    4.986315][    T1] cpu5wdt: misc_register failed
[    4.986852][    T1] smsc37b787_wdt: SMsC 37B787 watchdog component driver 1.1 initialising...
[    4.988614][    T1] smsc37b787_wdt: Unable to register miscdev on minor 130
[    4.989307][    T1] w83877f_wdt: I/O address 0x0443 already in use
[    4.989841][    T1] w83977f_wdt: driver v1.00
[    4.990223][    T1] w83977f_wdt: cannot register miscdev on minor=130 (err=-16)
[    4.990877][    T1] machzwd: MachZ ZF-Logic Watchdog driver initializing
[    4.991463][    T1] machzwd: no ZF-Logic found
[    4.996490][    T1] ledtrig-cpu: registered to indicate activity on CPUs
[    4.997351][    T1] Driver 'memconsole' was unable to register with bus_type 'coreboot' because the bus was not initialized.
[    4.998507][    T1] comedi: version 0.7.76 - http://www.comedi.org
[    5.008290][    T1] gnss: GNSS driver registered with major 235
[    5.010384][    T1] Motu MidiTimePiece on parallel port irq: 7 ioport: 0x378
[    5.022782][    T1] NET: Registered PF_INET6 protocol family
[    5.023501][    T1] random: get_random_u32 called from neigh_hash_alloc+0x59/0xd0 with crng_init=0
[    5.023511][    T1] random: get_random_u32 called from neigh_hash_alloc+0x64/0xd0 with crng_init=0
[    5.029443][    T1] Segment Routing with IPv6
[    5.029843][    T1] In-situ OAM (IOAM) with IPv6
[    5.030333][    T1] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver
[    5.031817][    T1] NET: Registered PF_PACKET protocol family
[    5.032343][    T1] 9pnet: Installing 9P2000 support
[    5.034548][    T1] IPI shorthand broadcast: enabled
[    5.035019][    C0] ... APIC ID:      00000000 (0)
[    5.035543][    C0] ... APIC VERSION: 00050014
[    5.036028][    C0] 0000000000000000000000000000000000000000000000000000000000000000
[    5.036860][    C0] 0000000000000000000000000000000000000000000000000000000000000000
[    5.037718][    C0] 0000000000000000000000000000000000000000000000000000000000000000
[    5.038565][    C0] 
[    5.038832][    T1] number of MP IRQ sources: 15.
[    5.039248][    T1] number of IO-APIC #0 registers: 24.
[    5.039698][    T1] testing the IO APIC.......................
[    5.040239][    T1] IO APIC #0......
[    5.040553][    T1] .... register #00: 00000000
[    5.040943][    T1] .......    : physical APIC id: 00
[    5.041393][    T1] .......    : Delivery Type: 0
[    5.041815][    T1] .......    : LTS          : 0
[    5.042231][    T1] .... register #01: 00170011
[    5.042633][    T1] .......     : max redirection entries: 17
[    5.043162][    T1] .......     : PRQ implemented: 0
[    5.043606][    T1] .......     : IO APIC version: 11
[    5.044054][    T1] .... register #02: 00000000
[    5.044453][    T1] .......     : arbitration: 00
[    5.044863][    T1] .... IRQ redirection table:
[    5.045261][    T1] IOAPIC 0:
[    5.045545][    T1]  pin00, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[    5.046296][    T1]  pin01, enabled , edge , high, V(22), IRR(0), S(0), logical , D(0002), M(0)
[    5.050744][    T1]  pin02, enabled , edge , high, V(30), IRR(0), S(0), logical , D(0001), M(0)
[    5.051561][    T1]  pin03, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[    5.052372][    T1]  pin04, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[    5.053120][    T1]  pin05, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[    5.053870][    T1]  pin06, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[    5.054660][    T1]  pin07, enabled , edge , high, V(22), IRR(0), S(0), logical , D(0001), M(0)
[    5.055460][    T1]  pin08, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[    5.056225][    T1]  pin09, enabled , level, high, V(21), IRR(0), S(0), logical , D(0002), M(0)
[    5.056984][    T1]  pin0a, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[    5.057763][    T1]  pin0b, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[    5.058542][    T1]  pin0c, enabled , edge , high, V(21), IRR(0), S(0), logical , D(0001), M(0)
[    5.059369][    T1]  pin0d, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[    5.060167][    T1]  pin0e, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[    5.060951][    T1]  pin0f, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[    5.061733][    T1]  pin10, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[    5.062511][    T1]  pin11, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[    5.063305][    T1]  pin12, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[    5.064090][    T1]  pin13, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[    5.064858][    T1]  pin14, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[    5.065600][    T1]  pin15, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[    5.066342][    T1]  pin16, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[    5.067110][    T1]  pin17, disabled, edge , high, V(00), IRR(0), S(0), physical, D(0000), M(0)
[    5.067863][    T1] IRQ to pin mappings:
[    5.068203][    T1] IRQ0 -> 0:2
[    5.068483][    T1] IRQ1 -> 0:1
[    5.068765][    T1] IRQ3 -> 0:3
[    5.069051][    T1] IRQ4 -> 0:4
[    5.069335][    T1] IRQ5 -> 0:5
[    5.069618][    T1] IRQ6 -> 0:6
[    5.069901][    T1] IRQ7 -> 0:7
[    5.070184][    T1] IRQ8 -> 0:8
[    5.070468][    T1] IRQ9 -> 0:9
[    5.070774][    T1] IRQ10 -> 0:10
[    5.071073][    T1] IRQ11 -> 0:11
[    5.071370][    T1] IRQ12 -> 0:12
[    5.071696][    T1] IRQ13 -> 0:13
[    5.072012][    T1] IRQ14 -> 0:14
[    5.072321][    T1] IRQ15 -> 0:15
[    5.072630][    T1] .................................... done.
[    5.073183][    T1] sched_clock: Marking stable (5041428175, 29331958)->(5097842393, -27082260)
[    5.074149][    T1] Key type ._fscrypt registered
[    5.074570][    T1] Key type .fscrypt registered
[    5.074993][    T1] Key type fscrypt-provisioning registered
[    5.087041][    T1] Key type encrypted registered
[    5.088362][    T1] UBI error: cannot create "ubi" debugfs directory, error -1
[    5.089073][    T1] UBI error: cannot initialize UBI, error -1
[    5.574292][  T110] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3
[    5.579116][    T1] _warn_unseeded_randomness: 4 callbacks suppressed
[    5.579123][    T1] random: get_random_bytes called from ic_open_devs+0x127/0x27a with crng_init=0
[    5.584649][  T110] e1000: eth0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX
[    5.590746][  T110] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[    5.592288][  T110] random: get_random_bytes called from addrconf_dad_work+0x43c/0x520 with crng_init=0
[    5.610753][    T1] Sending DHCP requests .
[    5.610764][    T1] random: get_random_bytes called from ic_dynamic+0xcf/0x260 with crng_init=0
[    5.611050][    T1] , OK
[    5.612745][    T1] IP-Config: Got DHCP answer from 10.0.2.2, my address is 10.0.2.15
[    5.613498][    T1] IP-Config: Complete:
[    5.613901][    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
[    5.614942][    T1]      host=vm-snb-i386-27, domain=, nis-domain=(none)
[    5.615585][    T1]      bootserver=10.0.2.2, rootserver=10.0.2.2, rootpath=
[    5.615588][    T1]      nameserver0=10.0.2.3
[    5.617371][    T1] ALSA device list:
[    5.617734][    T1]   #0: MTPAV on parallel port at 0x378
[    5.618250][    T1] TAP version 14
[    5.618581][    T1] 1..17
[    5.618840][    T1]     # Subtest: time_test_cases
[    5.618843][    T1]     1..1
[    7.471580][    C1] random: get_random_bytes called from flow_hash_from_keys+0xe9/0x110 with crng_init=0
[    7.471711][  T110] random: get_random_bytes called from addrconf_dad_work+0x43c/0x520 with crng_init=0
[   13.892131][    T1]     ok 1 - time64_to_tm_test_date_range
[   13.892141][    T1] ok 1 - time_test_cases
[   13.893950][    T1]     # Subtest: sysctl_test
[   13.893955][    T1]     1..10
[   13.897587][    T1]     ok 1 - sysctl_test_api_dointvec_null_tbl_data
[   13.897906][    T1]     ok 2 - sysctl_test_api_dointvec_table_maxlen_unset
[   13.898676][    T1]     ok 3 - sysctl_test_api_dointvec_table_len_is_zero
[   13.902748][    T1]     ok 4 - sysctl_test_api_dointvec_table_read_but_position_set
[   13.906751][    T1]     ok 5 - sysctl_test_dointvec_read_happy_single_positive
[   13.910762][    T1]     ok 6 - sysctl_test_dointvec_read_happy_single_negative
[   13.914744][    T1]     ok 7 - sysctl_test_dointvec_write_happy_single_positive
[   13.918767][    T1]     ok 8 - sysctl_test_dointvec_write_happy_single_negative
[   13.922743][    T1]     ok 9 - sysctl_test_api_dointvec_write_single_less_int_min
[   13.926733][    T1]     ok 10 - sysctl_test_api_dointvec_write_single_greater_int_max
[   13.927480][    T1] # sysctl_test: pass:10 fail:0 skip:0 total:10
[   13.928260][    T1] # Totals: pass:10 fail:0 skip:0 total:10
[   13.928849][    T1] ok 2 - sysctl_test
[   13.929808][    T1]     # Subtest: kunit_executor_test
[   13.929811][    T1]     1..3
[   13.934805][    T1]     ok 1 - filter_subsuite_test
[   13.938768][    T1]     ok 2 - filter_subsuite_to_empty_test
[   13.942739][    T1]     ok 3 - filter_suites_test
[   13.943321][    T1] # kunit_executor_test: pass:3 fail:0 skip:0 total:3
[   13.943811][    T1] # Totals: pass:3 fail:0 skip:0 total:3
[   13.944499][    T1] ok 3 - kunit_executor_test
[   13.945525][    T1]     # Subtest: kunit-try-catch-test
[   13.945529][    T1]     1..2
[   13.950746][    T1]     ok 1 - kunit_test_try_catch_successful_try_no_catch
[   13.959025][    T1]     ok 2 - kunit_test_try_catch_unsuccessful_try_does_catch
[   13.959790][    T1] # kunit-try-catch-test: pass:2 fail:0 skip:0 total:2
[   13.960500][    T1] # Totals: pass:2 fail:0 skip:0 total:2
[   13.961162][    T1] ok 4 - kunit-try-catch-test
[   13.962199][    T1]     # Subtest: kunit-resource-test
[   13.962201][    T1]     1..7
[   13.966741][    T1]     ok 1 - kunit_resource_test_init_resources
[   13.970754][    T1]     ok 2 - kunit_resource_test_alloc_resource
[   13.974735][    T1]     ok 3 - kunit_resource_test_destroy_resource
[   13.978751][    T1]     ok 4 - kunit_resource_test_cleanup_resources
[   13.982740][    T1]     ok 5 - kunit_resource_test_proper_free_ordering
[   13.986954][    T1]     ok 6 - kunit_resource_test_static
[   13.990749][    T1]     ok 7 - kunit_resource_test_named
[   13.991317][    T1] # kunit-resource-test: pass:7 fail:0 skip:0 total:7
[   13.991871][    T1] # Totals: pass:7 fail:0 skip:0 total:7
[   13.992521][    T1] ok 5 - kunit-resource-test
[   13.993546][    T1]     # Subtest: kunit-log-test
[   13.993549][    T1]     1..1
[   13.994755][  T182] put this in log.
[   13.994959][  T182] this too.
[   13.995175][  T182] add to suite log.
[   13.995355][  T182] along with this.
[   13.995595][    T1]     ok 1 - kunit_log_test
[   13.995979][    T1] ok 6 - kunit-log-test
[   13.996918][    T1]     # Subtest: kunit_status
[   13.996921][    T1]     1..2
[   13.998736][    T1]     ok 1 - kunit_status_set_failure_test
[   14.002765][    T1]     ok 2 - kunit_status_mark_skipped_test
[   14.003345][    T1] # kunit_status: pass:2 fail:0 skip:0 total:2
[   14.003929][    T1] # Totals: pass:2 fail:0 skip:0 total:2
[   14.004495][    T1] ok 7 - kunit_status
[   14.005478][    T1]     # Subtest: string-stream-test
[   14.005482][    T1]     1..3
[   14.006744][    T1]     ok 1 - string_stream_test_empty_on_creation
[   14.010752][    T1]     ok 2 - string_stream_test_not_empty_after_add
[   14.014744][    T1]     ok 3 - string_stream_test_get_string
[   14.015389][    T1] # string-stream-test: pass:3 fail:0 skip:0 total:3
[   14.015960][    T1] # Totals: pass:3 fail:0 skip:0 total:3
[   14.016597][    T1] ok 8 - string-stream-test
[   14.017642][    T1]     # Subtest: example
[   14.017646][    T1]     1..3
[   14.018745][  T188]     # example_simple_test: initializing
[   14.019299][    T1]     ok 1 - example_simple_test
[   14.022730][  T189]     # example_skip_test: initializing
[   14.023362][  T189]     # example_skip_test: You should not see a line below.
[   14.023375][    T1]     ok 2 - example_skip_test # SKIP this test should be skipped
[   14.026747][  T190]     # example_mark_skipped_test: initializing
[   14.027578][  T190]     # example_mark_skipped_test: You should see a line below.
[   14.027580][  T190]     # example_mark_skipped_test: You should see this line.
[   14.028079][    T1]     ok 3 - example_mark_skipped_test # SKIP this test should be skipped
[   14.028809][    T1] # example: pass:1 fail:0 skip:2 total:3
[   14.029632][    T1] # Totals: pass:1 fail:0 skip:2 total:3
[   14.030179][    T1] ok 9 - example
[   14.031220][    T1]     # Subtest: rational
[   14.031223][    T1]     1..1
[   14.034749][    T1]     # rational_test: ok 1 - Exceeds bounds, semi-convergent term > 1/2 last term
[   14.038733][    T1]     # rational_test: ok 2 - Exceeds bounds, semi-convergent term < 1/2 last term
[   14.042759][    T1]     # rational_test: ok 3 - Closest to zero
[   14.050711][    T1]     # rational_test: ok 4 - Closest to smallest non-zero
[   14.054739][    T1]     # rational_test: ok 5 - Use convergent
[   14.058749][    T1]     # rational_test: ok 6 - Exact answer
[   14.062756][    T1]     # rational_test: ok 7 - Semiconvergent, numerator limit
[   14.066784][    T1]     # rational_test: ok 8 - Semiconvergent, denominator limit
[   14.067546][    T1]     # rational_test: pass:8 fail:0 skip:0 total:8
[   14.068310][    T1]     ok 1 - rational_test
[   14.068958][    T1] # Totals: pass:8 fail:0 skip:0 total:8
[   14.069375][    T1] ok 10 - rational
[   14.070393][    T1]     # Subtest: bitfields
[   14.070397][    T1]     1..2
[   14.074750][    T1]     ok 1 - test_bitfields_constants
[   14.078736][    T1]     ok 2 - test_bitfields_variables
[   14.079279][    T1] # bitfields: pass:2 fail:0 skip:0 total:2
[   14.079797][    T1] # Totals: pass:2 fail:0 skip:0 total:2
[   14.080364][    T1] ok 11 - bitfields
[   14.082942][    T1]     # Subtest: list-kunit-test
[   14.082946][    T1]     1..36
[   14.086734][    T1]     ok 1 - list_test_list_init
[   14.090737][    T1]     ok 2 - list_test_list_add
[   14.094730][    T1]     ok 3 - list_test_list_add_tail
[   14.098747][    T1]     ok 4 - list_test_list_del
[   14.102744][    T1]     ok 5 - list_test_list_replace
[   14.106751][    T1]     ok 6 - list_test_list_replace_init
[   14.110733][    T1]     ok 7 - list_test_list_swap
[   14.114751][    T1]     ok 8 - list_test_list_del_init
[   14.118741][    T1]     ok 9 - list_test_list_move
[   14.122823][    T1]     ok 10 - list_test_list_move_tail
[   14.126729][    T1]     ok 11 - list_test_list_bulk_move_tail
[   14.134733][    T1]     ok 12 - list_test_list_is_first
[   14.138771][    T1]     ok 13 - list_test_list_is_last
[   14.142758][    T1]     ok 14 - list_test_list_empty
[   14.147014][    T1]     ok 15 - list_test_list_empty_careful
[   14.150737][    T1]     ok 16 - list_test_list_rotate_left
[   14.154739][    T1]     ok 17 - list_test_list_rotate_to_front
[   14.158740][    T1]     ok 18 - list_test_list_is_singular
[   14.162746][    T1]     ok 19 - list_test_list_cut_position
[   14.166729][    T1]     ok 20 - list_test_list_cut_before
[   14.170766][    T1]     ok 21 - list_test_list_splice
[   14.174728][    T1]     ok 22 - list_test_list_splice_tail
[   14.178742][    T1]     ok 23 - list_test_list_splice_init
[   14.182733][    T1]     ok 24 - list_test_list_splice_tail_init
[   14.186776][    T1]     ok 25 - list_test_list_entry
[   14.190978][    T1]     ok 26 - list_test_list_first_entry
[   14.194769][    T1]     ok 27 - list_test_list_last_entry
[   14.198739][    T1]     ok 28 - list_test_list_first_entry_or_null
[   14.202797][    T1]     ok 29 - list_test_list_next_entry
[   14.206752][    T1]     ok 30 - list_test_list_prev_entry
[   14.210812][    T1]     ok 31 - list_test_list_for_each
[   14.214733][    T1]     ok 32 - list_test_list_for_each_prev
[   14.218752][    T1]     ok 33 - list_test_list_for_each_safe
[   14.222734][    T1]     ok 34 - list_test_list_for_each_prev_safe
[   14.226780][    T1]     ok 35 - list_test_list_for_each_entry
[   14.231018][    T1]     ok 36 - list_test_list_for_each_entry_reverse
[   14.231619][    T1] # list-kunit-test: pass:36 fail:0 skip:0 total:36
[   14.232275][    T1] # Totals: pass:36 fail:0 skip:0 total:36
[   14.232930][    T1] ok 12 - list-kunit-test
[   14.234412][    T1]     # Subtest: linear-ranges-test
[   14.234415][    T1]     1..4
[   14.238760][    T1]     ok 1 - range_test_get_value_amount
[   14.242773][    T1]     ok 2 - range_test_get_selector_high
[   14.246759][    T1]     ok 3 - range_test_get_selector_low
[   14.250805][    T1]     ok 4 - range_test_get_value
[   14.251382][    T1] # linear-ranges-test: pass:4 fail:0 skip:0 total:4
[   14.251892][    T1] # Totals: pass:4 fail:0 skip:0 total:4
[   14.252511][    T1] ok 13 - linear-ranges-test
[   14.253944][    T1]     # Subtest: bits-test
[   14.253948][    T1]     1..3
[   14.254752][    T1]     ok 1 - genmask_test
[   14.258773][    T1]     ok 2 - genmask_ull_test
[   14.262761][    T1]     ok 3 - genmask_input_check_test
[   14.263230][    T1] # bits-test: pass:3 fail:0 skip:0 total:3
[   14.263749][    T1] # Totals: pass:3 fail:0 skip:0 total:3
[   14.264317][    T1] ok 14 - bits-test
[   14.265732][    T1]     # Subtest: qos-kunit-test
[   14.265736][    T1]     1..3
[   14.266776][    T1]     ok 1 - freq_qos_test_min
[   14.271005][    T1]     ok 2 - freq_qos_test_maxdef
[   14.278741][    T1]     ok 3 - freq_qos_test_readd
[   14.279291][    T1] # qos-kunit-test: pass:3 fail:0 skip:0 total:3
[   14.279806][    T1] # Totals: pass:3 fail:0 skip:0 total:3
[   14.280422][    T1] ok 15 - qos-kunit-test
[   14.282154][    T1]     # Subtest: property-entry
[   14.282158][    T1]     1..7
[   14.286855][    T1]     ok 1 - pe_test_uints
[   14.290806][    T1]     ok 2 - pe_test_uint_arrays
[   14.294800][    T1]     ok 3 - pe_test_strings
[   14.298766][    T1]     ok 4 - pe_test_bool
[   14.302763][    T1]     ok 5 - pe_test_move_inline_u8
[   14.307049][    T1]     ok 6 - pe_test_move_inline_str
[   14.310890][    T1]     ok 7 - pe_test_reference
[   14.311432][    T1] # property-entry: pass:7 fail:0 skip:0 total:7
[   14.311908][    T1] # Totals: pass:7 fail:0 skip:0 total:7
[   14.312500][    T1] ok 16 - property-entry
[   14.314042][    T1]     # Subtest: iio-format
[   14.314046][    T1]     1..5
[   14.318754][    T1]     ok 1 - iio_test_iio_format_value_integer
[   14.322797][    T1]     ok 2 - iio_test_iio_format_value_fixedpoint
[   14.326764][    T1]     ok 3 - iio_test_iio_format_value_fractional
[   14.331025][    T1]     ok 4 - iio_test_iio_format_value_fractional_log2
[   14.334776][    T1]     ok 5 - iio_test_iio_format_value_multiple
[   14.335453][    T1] # iio-format: pass:5 fail:0 skip:0 total:5
[   14.336086][    T1] # Totals: pass:5 fail:0 skip:0 total:5
[   14.336666][    T1] ok 17 - iio-format
[   14.349240][    T1] Freeing unused kernel image (initmem) memory: 2168K
[   14.362791][    T1] Write protecting kernel text and read-only data: 17236k
[   14.382799][    T1] Run /init as init process
[   14.383304][    T1]   with arguments:
[   14.383678][    T1]     /init
[   14.383988][    T1]   with environment:
[   14.384372][    T1]     HOME=/
[   14.384683][    T1]     TERM=linux
[   14.385033][    T1]     user=lkp
[   14.385361][    T1]     job=/lkp/jobs/scheduled/vm-snb-i386-27/boot-300-yocto-i386-minimal-20190520.cgz-d3ff51cfa9a64cdc18abe24c9821891b5122e617-20211014-86848-1be7mcg-4.yaml
[   14.386886][    T1]     ARCH=i386
[   14.387234][    T1]     kconfig=i386-randconfig-a011-20211012
[   14.387800][    T1]     branch=linux-review/Sean-Nyekjaer/mtd-core-protect-access-to-mtd-devices-while-in-suspend/20211011-195606
[   14.388942][    T1]     commit=d3ff51cfa9a64cdc18abe24c9821891b5122e617
[   14.389597][    T1]     BOOT_IMAGE=/pkg/linux/i386-randconfig-a011-20211012/clang-14/d3ff51cfa9a64cdc18abe24c9821891b5122e617/vmlinuz-5.15.0-rc1-00002-gd3ff51cfa9a6
[   14.391018][    T1]     max_uptime=600
[   14.391400][    T1]     RESULT_ROOT=/result/boot/300/vm-snb-i386/yocto-i386-minimal-20190520.cgz/i386-randconfig-a011-20211012/clang-14/d3ff51cfa9a64cdc18abe24c9821891b5122e617/3
[   14.392983][    T1]     LKP_SERVER=internal-lkp-server
[   14.393498][    T1]     selinux=0
[   14.393834][    T1]     softlockup_panic=1
[   14.394257][    T1]     prompt_ramdisk=0
[   14.394646][    T1]     vga=normal
[   14.398885][    T1] random: get_random_u32 called from arch_pick_mmap_layout+0x58/0x110 with crng_init=0
[   14.398899][    T1] random: get_random_u32 called from randomize_stack_top+0x1f/0x40 with crng_init=0
[   14.398908][    T1] random: get_random_u32 called from arch_align_stack+0x28/0x40 with crng_init=0
Starting udev
[   14.541573][  T285] udevd[285]: starting version 3.2.7
[   14.542673][  T285] random: udevd: uninitialized urandom read (16 bytes read)
[   14.543505][  T285] random: udevd: uninitialized urandom read (16 bytes read)
[   14.544244][  T285] random: udevd: uninitialized urandom read (16 bytes read)
[   14.547355][  T285] udevd[285]: specified group 'kvm' unknown
[   14.551146][  T286] udevd[286]: starting eudev-3.2.7
[   14.602902][  T286] udevd[286]: specified group 'kvm' unknown
[   15.715119][  T305] _warn_unseeded_randomness: 138 callbacks suppressed
[   15.715127][  T305] random: get_random_u32 called from arch_pick_mmap_layout+0x58/0x110 with crng_init=0
[   15.715142][  T305] random: get_random_u32 called from randomize_stack_top+0x1f/0x40 with crng_init=0
[   15.715149][  T305] random: get_random_u32 called from arch_align_stack+0x28/0x40 with crng_init=0
[   15.896405][  T128] rcu-scale: rcu_scale_writer 0 has 100 measurements
[   15.916887][  T129] rcu-scale: rcu_scale_writer 1 has 100 measurements
[   15.958711][  T129] Dumping ftrace buffer:
[   15.959034][  T129] ---------------------------------
[   15.959549][  T129] swapper/-1         1..... 3929705us : gen_synth_test: next_pid_field=777 next_comm_field=hula hoops ts_ns=1000000 ts_ms=1000 cpu=1 my_string_field=thneed my_int_field=598
[   15.961157][  T129] swapper/-1         1..... 3930290us : empty_synth_test: next_pid_field=777 next_comm_field=tiddlywinks ts_ns=1000000 ts_ms=1000 cpu=1 my_string_field=thneed_2.0 my_int_field=399
[   15.962808][  T129] swapper/-1         1..... 3931003us : create_synth_test: next_pid_field=777 next_comm_field=tiddlywinks ts_ns=1000000 dynstring_field_1=xrayspecs ts_ms=1000 cpu=1 my_string_field=thneed dynstring_field_2=kerplunk my_int_field=398
[   15.964468][  T129] swapper/-1         1..... 3931005us : gen_synth_test: next_pid_field=777 next_comm_field=slinky ts_ns=1000000 ts_ms=1000 cpu=1 my_string_field=thneed_2.01 my_int_field=395
[   15.965663][  T129] swapper/-1         1..... 3931006us : gen_synth_test: next_pid_field=777 next_comm_field=silly putty ts_ns=1000000 ts_ms=1000 cpu=1 my_string_field=thneed_9 my_int_field=3999
[   15.967293][  T129] swapper/-1         1..... 3931009us : create_synth_test: next_pid_field=444 next_comm_field=clackers ts_ns=1000000 dynstring_field_1=viewmaster ts_ms=1000 cpu=1 my_string_field=Thneed dynstring_field_2=yoyos my_int_field=999
[   15.969376][  T129] rb_produ-131       1..... 3932447us : ring_buffer_producer: Starting ring buffer hammer
[   15.970317][  T129] rb_produ-131       1..... 13938686us : ring_buffer_producer: End ring buffer hammer
[   15.971034][  T129] rb_produ-131       1..... 13941811us : ring_buffer_producer: Running Consumer at nice: 19
[   15.971919][  T129] rb_produ-131       1..... 13941815us : ring_buffer_producer: Running Producer at nice: 19
[   15.972519][  T129] rb_produ-131       1..... 13941816us : ring_buffer_producer: WARNING!!! This test is running at lowest priority.
[   15.973562][  T129] rb_produ-131       1..... 13941817us : ring_buffer_producer: Time:     10006235 (usecs)
[   15.974359][  T129] rb_produ-131       1..... 13941817us : ring_buffer_producer: Overruns: 0
[   15.975197][  T129] rb_produ-131       1..... 13941818us : ring_buffer_producer: Read:     4405000  (by events)
[   15.976164][  T129] rb_produ-131       1..... 13941819us : ring_buffer_producer: Entries:  50
[   15.976978][  T129] rb_produ-131       1..... 13941820us : ring_buffer_producer: Total:    4405050
[   15.977825][  T129] rb_produ-131       1..... 13941821us : ring_buffer_producer: Missed:   0
[   15.978624][  T129] rb_produ-131       1..... 13941821us : ring_buffer_producer: Hit:      4405050
[   15.979473][  T129] rb_produ-131       1..... 13941822us : ring_buffer_producer: Entries per millisec: 440
[   15.980407][  T129] rb_produ-131       1..... 13941823us : ring_buffer_producer: 2272 ns per entry
[   15.981251][  T129] rb_produ-131       1..... 13941823us : ring_buffer_producer_thread: Sleeping for 10 secs
[   15.982168][  T129] ---------------------------------
[   15.985255][  T129] rcu-scale: Test complete
[   15.985734][  T125] rcu-torture: Stopping rcu_scale_reader task
[   15.986363][  T126] rcu-torture: Stopping rcu_scale_reader
[   15.987214][  T125] rcu-torture: Stopping rcu_scale_reader task
[   15.988948][  T127] rcu-torture: Stopping rcu_scale_reader
[   15.989566][  T125] rcu-torture: Stopping rcu_scale_writer task
[   15.990182][  T128] rcu-torture: Stopping rcu_scale_writer
[   15.990843][  T125] rcu-scale: writer 0 gps: 103
[   15.991314][  T125] rcu-torture: Stopping rcu_scale_writer task
[   15.991924][  T129] rcu-torture: Stopping rcu_scale_writer
[   15.992300][  T125] rcu-scale: writer 1 gps: 101
[   15.992781][  T125] rcu-scale: start: 14337375851 end: 15885392932 duration: 1548017081 gps: 204 batches: 161
[   15.993727][  T125] rcu-scale:    0 writer-duration:     0 15998987
[   15.998717][  T125] rcu-scale:    0 writer-duration:     1 20002605
[   15.999368][  T125] rcu-scale:    0 writer-duration:     2 15997776
[   15.999978][  T125] rcu-scale:    0 writer-duration:     3 12056423
[   16.000570][  T125] rcu-scale:    0 writer-duration:     4 15974916
[   16.001182][  T125] rcu-scale:    0 writer-duration:     5 15978992
[   16.001789][  T125] rcu-scale:    0 writer-duration:     6 16034229
[   16.002388][  T125] rcu-scale:    0 writer-duration:     7 11967876
[   16.003055][  T125] rcu-scale:    0 writer-duration:     8 16005988
[   16.003675][  T125] rcu-scale:    0 writer-duration:     9 4038837
[   16.004274][  T125] rcu-scale:    0 writer-duration:    10 11984710
[   16.004861][  T125] rcu-scale:    0 writer-duration:    11 23975925
[   16.005459][  T125] rcu-scale:    0 writer-duration:    12 7976574
[   16.006043][  T125] rcu-scale:    0 writer-duration:    13 8007026
[   16.006641][  T125] rcu-scale:    0 writer-duration:    14 4044676
[   16.007270][  T125] rcu-scale:    0 writer-duration:    15 11946930
[   16.007913][  T125] rcu-scale:    0 writer-duration:    16 16006461
[   16.008506][  T125] rcu-scale:    0 writer-duration:    17 24005200
[   16.009104][  T125] rcu-scale:    0 writer-duration:    18 4084031
[   16.009701][  T125] rcu-scale:    0 writer-duration:    19 19914707
[   16.010300][  T125] rcu-scale:    0 writer-duration:    20 188180
[   16.011040][  T125] rcu-scale:    0 writer-duration:    21 15927908
[   16.011680][  T125] rcu-scale:    0 writer-duration:    22 11985347
[   16.012318][  T125] rcu-scale:    0 writer-duration:    23 16007950
[   16.012931][  T125] rcu-scale:    0 writer-duration:    24 300032
[   16.013541][  T125] rcu-scale:    0 writer-duration:    25 19580534
[   16.014162][  T125] rcu-scale:    0 writer-duration:    26 15997969
[   16.014800][  T125] rcu-scale:    0 writer-duration:    27 15998751
[   16.015462][  T125] rcu-scale:    0 writer-duration:    28 15998145
[   16.016079][  T125] rcu-scale:    0 writer-duration:    29 16000351
[   16.016673][  T125] rcu-scale:    0 writer-duration:    30 20001563
[   16.017281][  T125] rcu-scale:    0 writer-duration:    31 16001322
[   16.017900][  T125] rcu-scale:    0 writer-duration:    32 15995899
[   16.018487][  T125] rcu-scale:    0 writer-duration:    33 15998942
[   16.019109][  T125] rcu-scale:    0 writer-duration:    34 15997887
[   16.019712][  T125] rcu-scale:    0 writer-duration:    35 16009579
[   16.020331][  T125] rcu-scale:    0 writer-duration:    36 15991091
[   16.020940][  T125] rcu-scale:    0 writer-duration:    37 16002644
[   16.021520][  T125] rcu-scale:    0 writer-duration:    38 19995868
[   16.022132][  T125] rcu-scale:    0 writer-duration:    39 15995852
[   16.022776][  T125] rcu-scale:    0 writer-duration:    40 16006598
[   16.023388][  T125] rcu-scale:    0 writer-duration:    41 15995477
[   16.023997][  T125] rcu-scale:    0 writer-duration:    42 20001360
[   16.024597][  T125] rcu-scale:    0 writer-duration:    43 15996563
[   16.025197][  T125] rcu-scale:    0 writer-duration:    44 15999794
[   16.025795][  T125] rcu-scale:    0 writer-duration:    45 15996432
[   16.026391][  T125] rcu-scale:    0 writer-duration:    46 16004611
[   16.027013][  T125] rcu-scale:    0 writer-duration:    47 16001559
[   16.027609][  T125] rcu-scale:    0 writer-duration:    48 15996336
[   16.028217][  T125] rcu-scale:    0 writer-duration:    49 15997692
[   16.028821][  T125] rcu-scale:    0 writer-duration:    50 15999658
[   16.029418][  T125] rcu-scale:    0 writer-duration:    51 20003090
[   16.030018][  T125] rcu-scale:    0 writer-duration:    52 16000177
[   16.030617][  T125] rcu-scale:    0 writer-duration:    53 16000449
[   16.031252][  T125] rcu-scale:    0 writer-duration:    54 15991447
[   16.031850][  T430] urandom_read: 4 callbacks suppressed
[   16.031853][  T430] random: dd: uninitialized urandom read (512 bytes read)
[   16.031875][  T125] rcu-scale:    0 writer-duration:    55 16000136
[   16.033699][  T125] rcu-scale:    0 writer-duration:    56 15999326
[   16.034298][  T125] rcu-scale:    0 writer-duration:    57 15997817
[   16.034939][  T125] rcu-scale:    0 writer-duration:    58 16001175
[   16.035552][  T125] rcu-scale:    0 writer-duration:    59 15998659
[   16.036171][  T125] rcu-scale:    0 writer-duration:    60 15999097
[   16.036758][  T125] rcu-scale:    0 writer-duration:    61 16001247
[   16.037342][  T125] rcu-scale:    0 writer-duration:    62 15996904
[   16.037899][  T125] rcu-scale:    0 writer-duration:    63 15999960
[   16.038475][  T125] rcu-scale:    0 writer-duration:    64 16007621
[   16.039092][  T125] rcu-scale:    0 writer-duration:    65 15991718
[   16.039696][  T125] rcu-scale:    0 writer-duration:    66 16002045
[   16.040271][  T125] rcu-scale:    0 writer-duration:    67 15999823
[   16.041070][  T125] rcu-scale:    0 writer-duration:    68 15998992
[   16.041688][  T125] rcu-scale:    0 writer-duration:    69 15997749
[   16.042513][  T125] rcu-scale:    0 writer-duration:    70 16002878
[   16.043169][  T125] rcu-scale:    0 writer-duration:    71 15995952
[   16.043174][  T125] rcu-scale:    0 writer-duration:    72 15998794
[   16.043176][  T125] rcu-scale:    0 writer-duration:    73 16001263
[   16.043179][  T125] rcu-scale:    0 writer-duration:    74 15999790
[   16.043181][  T125] rcu-scale:    0 writer-duration:    75 15999255
[   16.043184][  T125] rcu-scale:    0 writer-duration:    76 15996694
[   16.046791][  T125] rcu-scale:    0 writer-duration:    77 16001004
[   16.047386][  T125] rcu-scale:    0 writer-duration:    78 16001807
[   16.047391][  T125] rcu-scale:    0 writer-duration:    79 16000799
[   16.047393][  T125] rcu-scale:    0 writer-duration:    80 15997429
[   16.047396][  T125] rcu-scale:    0 writer-duration:    81 15997747
[   16.050303][  T125] rcu-scale:    0 writer-duration:    83 16001934
[   16.051092][  T125] rcu-scale:    0 writer-duration:    84 15997736
[   16.051096][  T125] rcu-scale:    0 writer-duration:    85 15999075
[   16.051098][  T125] rcu-scale:    0 writer-duration:    86 16002333
[   16.051101][  T125] rcu-scale:    0 writer-duration:    87 15995976
[   16.053300][  T125] rcu-scale:    0 writer-duration:    88 16019637
[   16.053909][  T125] rcu-scale:    0 writer-duration:    89 8051956
[   16.054511][  T125] rcu-scale:    0 writer-duration:    90 19948495
Configuring network interfaces... [   16.055402][  T125] rcu-scale:    0 writer-duration:    91 20002070
[   16.056034][  T125] rcu-scale:    0 writer-duration:    92 16033001
[   16.056649][  T125] rcu-scale:    0 writer-duration:    93 11959154
[   16.057261][  T125] rcu-scale:    0 writer-duration:    94 12005211
[   16.057869][  T125] rcu-scale:    0 writer-duration:    95 8090130
[   16.058476][  T125] rcu-scale:    0 writer-duration:    96 19901193
[   16.059182][  T125] rcu-scale:    0 writer-duration:    97 229328
[   16.059795][  T125] rcu-scale:    0 writer-duration:    98 23773893
[   16.060400][  T125] rcu-scale:    0 writer-duration:    99 7980121
[   16.060998][  T125] rcu-scale:    0 writer-duration:   100 16102740
[   16.061934][  T444] ip (444) used greatest stack depth: 6016 bytes left
[   16.066735][  T125] rcu-scale:    0 writer-duration:   101 17762611
[   16.067390][  T125] rcu-scale:    0 writer-duration:   102 20124800
[   16.068061][  T125] rcu-scale:    1 writer-duration:     0 16004661
Starting syslogd/klogd: [   16.074747][  T125] rcu-scale:    1 writer-duration:     1 20094242
[   16.075382][  T125] rcu-scale:    1 writer-duration:     2 15916353
[   16.076014][  T125] rcu-scale:    1 writer-duration:     3 12060304
[   16.076633][  T125] rcu-scale:    1 writer-duration:     4 11968624
[   16.077254][  T125] rcu-scale:    1 writer-duration:     5 11956999
[   16.077871][  T125] rcu-scale:    1 writer-duration:     6 20055440
[   16.078484][  T125] rcu-scale:    1 writer-duration:     7 7994737
[   16.079177][  T125] rcu-scale:    1 writer-duration:     8 23975933
[   16.079805][  T125] rcu-scale:    1 writer-duration:     9 8020307
[   16.080406][  T125] rcu-scale:    1 writer-duration:    10 23952672
[   16.080999][  T125] rcu-scale:    1 writer-duration:    11 8211349
[   16.081588][  T125] rcu-scale:    1 writer-duration:    12 15796020
[   16.082195][  T125] rcu-scale:    1 writer-duration:    13 8093079
[   16.082808][  T125] rcu-scale:    1 writer-duration:    14 20017975
[   16.083419][  T125] rcu-scale:    1 writer-duration:    15 19906335
[   16.084046][  T125] rcu-scale:    1 writer-duration:    16 8171592
[   16.084643][  T125] rcu-scale:    1 writer-duration:    17 23809674
[   16.085256][  T125] rcu-scale:    1 writer-duration:    18 203237
[   16.085951][  T125] rcu-scale:    1 writer-duration:    19 15911863
[   16.086561][  T125] rcu-scale:    1 writer-duration:    20 11971616
[   16.087207][  T125] rcu-scale:    1 writer-duration:    21 15972774
[   16.087840][  T125] rcu-scale:    1 writer-duration:    22 233485
[   16.088441][  T125] rcu-scale:    1 writer-duration:    23 19689449
[   16.089052][  T125] rcu-scale:    1 writer-duration:    24 16004210
[   16.089677][  T125] rcu-scale:    1 writer-duration:    25 15998773
[   16.090313][  T125] rcu-scale:    1 writer-duration:    26 15998207
[   16.090958][  T125] rcu-scale:    1 writer-duration:    27 16000388
[   16.091590][  T125] rcu-scale:    1 writer-duration:    28 20001575
[   16.092207][  T125] rcu-scale:    1 writer-duration:    29 16001103
[   16.092805][  T125] rcu-scale:    1 writer-duration:    30 15996163
[   16.093399][  T125] rcu-scale:    1 writer-duration:    31 15998960
[   16.094004][  T125] rcu-scale:    1 writer-duration:    32 15997900
[   16.094602][  T125] rcu-scale:    1 writer-duration:    33 16009622
[   16.095248][  T125] rcu-scale:    1 writer-duration:    34 15991043
[   16.095884][  T125] rcu-scale:    1 writer-duration:    35 16002633
[   16.096494][  T125] rcu-scale:    1 writer-duration:    36 19995854
[   16.097108][  T125] rcu-scale:    1 writer-duration:    37 15995889
[   16.097732][  T125] rcu-scale:    1 writer-duration:    38 16006585
[   16.098337][  T125] rcu-scale:    1 writer-duration:    39 15995452
[   16.098966][  T125] rcu-scale:    1 writer-duration:    40 20001885
[   16.099587][  T125] rcu-scale:    1 writer-duration:    41 15996563
[   16.100206][  T125] rcu-scale:    1 writer-duration:    42 15999903
[   16.100789][  T125] rcu-scale:    1 writer-duration:    43 15996343
[   16.101396][  T125] rcu-scale:    1 writer-duration:    44 16004609
[   16.102001][  T125] rcu-scale:    1 writer-duration:    45 16001580
[   16.102613][  T125] rcu-scale:    1 writer-duration:    46 15996482
[   16.103241][  T125] rcu-scale:    1 writer-duration:    47 15997722
[   16.103860][  T125] rcu-scale:    1 writer-duration:    48 15999602
[   16.104461][  T125] rcu-scale:    1 writer-duration:    49 20002982
[   16.105069][  T125] rcu-scale:    1 writer-duration:    50 16000120
[   16.105678][  T125] rcu-scale:    1 writer-duration:    51 16000906
[   16.106291][  T125] rcu-scale:    1 writer-duration:    52 15989089
[   16.106939][  T125] rcu-scale:    1 writer-duration:    53 16002199
[   16.107551][  T125] rcu-scale:    1 writer-duration:    54 15994449
[   16.108171][  T125] rcu-scale:    1 writer-duration:    55 16000328
[   16.108790][  T125] rcu-scale:    1 writer-duration:    56 15996326
[   16.109396][  T125] rcu-scale:    1 writer-duration:    57 16004461
[   16.111326][  T125] rcu-scale:    1 writer-duration:    58 15998479
[   16.111940][  T125] rcu-scale:    1 writer-duration:    59 15998344
[   16.112551][  T125] rcu-scale:    1 writer-duration:    60 16003335
[   16.113160][  T125] rcu-scale:    1 writer-duration:    61 15996633
[   16.113768][  T125] rcu-scale:    1 writer-duration:    62 16000743
[   16.114377][  T125] rcu-scale:    1 writer-duration:    63 16002381
[   16.115006][  T125] rcu-scale:    1 writer-duration:    64 15996590
[   16.115637][  T125] rcu-scale:    1 writer-duration:    65 16005552
[   16.116294][  T125] rcu-scale:    1 writer-duration:    66 16000583
[   16.116897][  T125] rcu-scale:    1 writer-duration:    67 15993403
[   16.117513][  T125] rcu-scale:    1 writer-duration:    68 15997452
[   16.118117][  T125] rcu-scale:    1 writer-duration:    69 15999993
[   16.120656][  T125] rcu-scale:    1 writer-duration:    70 15998054
[   16.121300][  T125] rcu-scale:    1 writer-duration:    71 15999777
[   16.121924][  T125] rcu-scale:    1 writer-duration:    72 16007493
[   16.122554][  T125] rcu-scale:    1 writer-duration:    73 15999341
[   16.123198][  T125] rcu-scale:    1 writer-duration:    74 15996861
[   16.123838][  T125] rcu-scale:    1 writer-duration:    75 16001105
[   16.124456][  T125] rcu-scale:    1 writer-duration:    76 16001847
[   16.125089][  T125] rcu-scale:    1 writer-duration:    77 15996322
[   16.125713][  T125] rcu-scale:    1 writer-duration:    78 16002221
[   16.126333][  T125] rcu-scale:    1 writer-duration:    79 15997831
PATH=/sbin:/usr/sbin:/bin:/usr/bin:/lkp/lkp/src/bin[   16.127794][  T125] rcu-scale:    1 writer-duration:    80 16001072
[   16.128443][  T125] rcu-scale:    1 writer-duration:    81 16001976
[   16.129076][  T125] rcu-scale:    1 writer-duration:    82 15997740
[   16.129703][  T125] rcu-scale:    1 writer-duration:    83 15999109
[   16.130343][  T125] rcu-scale:    1 writer-duration:    84 15998273

[   16.131715][  T125] rcu-scale:    1 writer-duration:    86 16014095
[   16.132365][  T125] rcu-scale:    1 writer-duration:    87 8035212
[   16.132979][  T125] rcu-scale:    1 writer-duration:    88 19961614
[   16.133613][  T125] rcu-scale:    1 writer-duration:    89 12027700
[   16.134232][  T125] rcu-scale:    1 writer-duration:    90 15994287
[   16.136851][  T125] rcu-scale:    1 writer-duration:    91 8062864
[   16.137509][  T125] rcu-scale:    1 writer-duration:    92 7991464
[   16.138135][  T125] rcu-scale:    1 writer-duration:    93 15913384
[   16.138818][  T125] rcu-scale:    1 writer-duration:    94 8146345
[   16.139419][  T125] rcu-scale:    1 writer-duration:    95 19863336
[   16.140048][  T125] rcu-scale:    1 writer-duration:    96 4004554
[   16.140640][  T125] rcu-scale:    1 writer-duration:    97 19998466
[   16.141238][  T125] rcu-scale:    1 writer-duration:    98 7975403
[   16.141842][  T125] rcu-scale:    1 writer-duration:    99 16016357
[   16.142448][  T125] rcu-scale:    1 writer-duration:   100 20006063
LKP: HOSTNAME vm-snb-i386-27, MAC 52:54:00:12:34:56, kernel 5.15.0-rc1-00002-gd3ff51cfa9a6 1, serial console /dev/ttyS0
Poky (Yocto Project Reference Distro) 2.7+snapshot vm-snb-i386-27 /dev/ttyS0
[   16.417556][  T125] reboot: Power down

Kboot worker: lkp-worker24
Elapsed time: 60

kvm=(
	qemu-system-i386
	-enable-kvm
	-cpu SandyBridge
	-kernel $kernel
	-initrd initrd-vm-snb-i386-27.cgz
	-m 4096
	-smp 2
	-device e1000,netdev=net0
	-netdev user,id=net0,hostfwd=tcp::32032-:22
	-boot order=nc
	-no-reboot
	-watchdog i6300esb
	-watchdog-action debug
	-rtc base=localtime
	-serial stdio
	-display none
	-monitor null
)

append=(
	ip=::::vm-snb-i386-27::dhcp
	root=/dev/ram0
	user=lkp
	job=/job-script
	ARCH=i386
	kconfig=i386-randconfig-a011-20211012
	branch=linux-review/Sean-Nyekjaer/mtd-core-protect-access-to-mtd-devices-while-in-suspend/20211011-195606
	commit=d3ff51cfa9a64cdc18abe24c9821891b5122e617
	BOOT_IMAGE=/pkg/linux/i386-randconfig-a011-20211012/clang-14/d3ff51cfa9a64cdc18abe24c9821891b5122e617/vmlinuz-5.15.0-rc1-00002-gd3ff51cfa9a6
	vmalloc=128M
	initramfs_async=0
	page_owner=on
	max_uptime=600
	RESULT_ROOT=/result/boot/300/vm-snb-i386/yocto-i386-minimal-20190520.cgz/i386-randconfig-a011-20211012/clang-14/d3ff51cfa9a64cdc18abe24c9821891b5122e617/3
	result_service=tmpfs
	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
	rcuperf.shutdown=0
	watchdog_thresh=240
)

"${kvm[@]}" -append "${append[*]}"
