early console in setup code early console in extract_kernel input_data: 0x0000000006995295 input_len: 0x0000000001885d8b output: 0x0000000001000000 output_len: 0x00000000053754c8 kernel_total_size: 0x000000000723e000 trampoline_32bit: 0x000000000009d000 Decompressing Linux... Parsing ELF... done. Booting the kernel. [ 0.000000] Linux version 4.17.0-rc1 (kbuild@lkp-wsm-ep1) (gcc version 7.3.0 (Debian 7.3.0-1)) #1 Tue Apr 17 12:03:01 CST 2018 [ 0.000000] Command line: ip=::::vm-lkp-hsw01-openwrt-ia32-7::dhcp root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-lkp-hsw01-openwrt-ia32-7/boot-1-openwrt-i386-2016-03-16.cgz-60cc43fc888428bb2f18f08997432d426a243338-20180417-30956-psgkzl-wait_kernel-0.yaml ARCH=x86_64 kconfig=x86_64-randconfig-ws0-03101549 branch=linus/master commit=60cc43fc888428bb2f18f08997432d426a243338 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-ws0-03101549/gcc-7/60cc43fc888428bb2f18f08997432d426a243338/vmlinuz-4.17.0-rc1 max_uptime=600 RESULT_ROOT=/result/boot/1/vm-lkp-hsw01-openwrt-ia32/openwrt-i386-2016-03-16.cgz/x86_64-randconfig-ws0-03101549/gcc-7/60cc43fc888428bb2f18f08997432d426a243338/0 LKP_SERVER=inn 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=no [ 0.000000] KERNEL supported cpus: [ 0.000000] Intel GenuineIntel [ 0.000000] AMD AuthenticAMD [ 0.000000] Centaur CentaurHauls [ 0.000000] x86/fpu: x87 FPU will use FXSAVE [ 0.000000] e820: 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-0x000000001a3dffff] usable [ 0.000000] BIOS-e820: [mem 0x000000001a3e0000-0x000000001a3fffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] debug: ignoring loglevel setting. [ 0.000000] bootconsole [earlyser0] enabled [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] Hypervisor detected: KVM [ 0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved [ 0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable [ 0.000000] e820: last_pfn = 0x1a3e0 max_arch_pfn = 0x400000000 [ 0.000000] MTRR default type: write-back [ 0.000000] MTRR fixed ranges enabled: [ 0.000000] 00000-9FFFF write-back [ 0.000000] A0000-BFFFF uncachable [ 0.000000] C0000-FFFFF write-protect [ 0.000000] MTRR variable ranges enabled: [ 0.000000] 0 base 0080000000 mask FF80000000 uncachable [ 0.000000] 1 disabled [ 0.000000] 2 disabled [ 0.000000] 3 disabled [ 0.000000] 4 disabled [ 0.000000] 5 disabled [ 0.000000] 6 disabled [ 0.000000] 7 disabled [ 0.000000] x86/PAT: Configuration [0-7]: WB WT UC- UC WB WT UC- UC [ 0.000000] Base memory trampoline at [ (ptrval)] 99000 size 24576 [ 0.000000] BRK [0x08228000, 0x08228fff] PGTABLE [ 0.000000] BRK [0x08229000, 0x08229fff] PGTABLE [ 0.000000] BRK [0x0822a000, 0x0822afff] PGTABLE [ 0.000000] BRK [0x0822b000, 0x0822bfff] PGTABLE [ 0.000000] BRK [0x0822c000, 0x0822cfff] PGTABLE [ 0.000000] BRK [0x0822d000, 0x0822dfff] PGTABLE [ 0.000000] RAMDISK: [mem 0x1a0bf000-0x1a3dffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F68D0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x000000001A3E15CE 000030 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x000000001A3E142A 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x000000001A3E0040 0013EA (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x000000001A3E0000 000040 [ 0.000000] ACPI: APIC 0x000000001A3E151E 000078 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x000000001A3E1596 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001) [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] mapped APIC to ffffffffff5fd000 ( fee00000) [ 0.000000] kvm-clock: cpu 0, msr 0:1a0bd001, primary cpu clock [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: using sched offset of 270754956 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x000000001a3dffff] [ 0.000000] Normal empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x000000001a3dffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x000000001a3dffff] [ 0.000000] On node 0 totalpages: 107390 [ 0.000000] DMA zone: 64 pages used for memmap [ 0.000000] DMA zone: 21 pages reserved [ 0.000000] DMA zone: 3998 pages, LIFO batch:0 [ 0.000000] DMA32 zone: 1616 pages used for memmap [ 0.000000] DMA32 zone: 103392 pages, LIFO batch:31 [ 0.000000] Reserved but unavailable: 98 pages [ 0.000000] kasan: KernelAddressSanitizer initialized [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 00, APIC ID 0, APIC INT 02 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 05, APIC ID 0, APIC INT 05 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 09, APIC ID 0, APIC INT 09 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 0a, APIC ID 0, APIC INT 0a [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Int: type 0, pol 1, trig 3, bus 00, IRQ 0b, APIC ID 0, APIC INT 0b [ 0.000000] ACPI: IRQ0 used by override. [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 01, APIC ID 0, APIC INT 01 [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 03, APIC ID 0, APIC INT 03 [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 04, APIC ID 0, APIC INT 04 [ 0.000000] ACPI: IRQ5 used by override. [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 06, APIC ID 0, APIC INT 06 [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 07, APIC ID 0, APIC INT 07 [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 08, APIC ID 0, APIC INT 08 [ 0.000000] ACPI: IRQ9 used by override. [ 0.000000] ACPI: IRQ10 used by override. [ 0.000000] ACPI: IRQ11 used by override. [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0c, APIC ID 0, APIC INT 0c [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0d, APIC ID 0, APIC INT 0d [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0e, APIC ID 0, APIC INT 0e [ 0.000000] Int: type 0, pol 0, trig 0, bus 00, IRQ 0f, APIC ID 0, APIC INT 0f [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] mapped IOAPIC to ffffffffff5fc000 (fec00000) [ 0.000000] KVM setup async PF for cpu 0 [ 0.000000] kvm-stealtime: cpu 0, msr 434f600 [ 0.000000] e820: [mem 0x1a400000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns [ 0.000000] random: fast init done [ 0.000000] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768 [ 0.000000] pcpu-alloc: [0] 0 [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 105689 [ 0.000000] Kernel command line: ip=::::vm-lkp-hsw01-openwrt-ia32-7::dhcp root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-lkp-hsw01-openwrt-ia32-7/boot-1-openwrt-i386-2016-03-16.cgz-60cc43fc888428bb2f18f08997432d426a243338-20180417-30956-psgkzl-wait_kernel-0.yaml ARCH=x86_64 kconfig=x86_64-randconfig-ws0-03101549 branch=linus/master commit=60cc43fc888428bb2f18f08997432d426a243338 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-ws0-03101549/gcc-7/60cc43fc888428bb2f18f08997432d426a243338/vmlinuz-4.17.0-rc1 max_uptime=600 RESULT_ROOT=/result/boot/1/vm-lkp-hsw01-openwrt-ia32/openwrt-i386-2016-03-16.cgz/x86_64-randconfig-ws0-03101549/gcc-7/60cc43fc888428bb2f18f08997432d426a243338/0 LKP_SERVER=inn 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 [ 0.000000] sysrq: sysrq always enabled. [ 0.000000] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes) [ 0.000000] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes) [ 0.000000] Memory: 231040K/429560K available (30732K kernel code, 30174K rwdata, 17200K rodata, 1908K init, 33484K bss, 198520K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 [ 0.000000] Kernel/User page tables isolation: enabled [ 0.010000] Running RCU self tests [ 0.010000] NR_IRQS: 4352, nr_irqs: 48, preallocated irqs: 16 [ 0.010000] console [ttyS0] enabled [ 0.010000] bootconsole [earlyser0] disabled [ 0.010000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.010000] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.010000] ... MAX_LOCK_DEPTH: 48 [ 0.010000] ... MAX_LOCKDEP_KEYS: 8191 [ 0.010000] ... CLASSHASH_SIZE: 4096 [ 0.010000] ... MAX_LOCKDEP_ENTRIES: 32768 [ 0.010000] ... MAX_LOCKDEP_CHAINS: 65536 [ 0.010000] ... CHAINHASH_SIZE: 32768 [ 0.010000] memory used by lock dependency info: 7903 kB [ 0.010000] per task-struct memory footprint: 2688 bytes [ 0.010000] ACPI: Core revision 20180313 [ 0.010000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.010000] hpet clockevent registered [ 0.010043] APIC: Switch to symmetric I/O mode setup [ 0.010553] x2apic enabled [ 0.010956] Switched APIC routing to physical x2apic. [ 0.011331] enabled ExtINT on CPU#0 [ 0.012159] ENABLING IO-APIC IRQs [ 0.012458] init IO_APIC IRQs [ 0.012687] apic 0 pin 0 not connected [ 0.013099] IOAPIC[0]: Set routing entry (0-1 -> 0xef -> IRQ 1 Mode:0 Active:0 Dest:0) [ 0.013779] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:0) [ 0.014391] IOAPIC[0]: Set routing entry (0-3 -> 0xef -> IRQ 3 Mode:0 Active:0 Dest:0) [ 0.015131] IOAPIC[0]: Set routing entry (0-4 -> 0xef -> IRQ 4 Mode:0 Active:0 Dest:0) [ 0.016126] IOAPIC[0]: Set routing entry (0-5 -> 0xef -> IRQ 5 Mode:1 Active:0 Dest:0) [ 0.017129] IOAPIC[0]: Set routing entry (0-6 -> 0xef -> IRQ 6 Mode:0 Active:0 Dest:0) [ 0.018137] IOAPIC[0]: Set routing entry (0-7 -> 0xef -> IRQ 7 Mode:0 Active:0 Dest:0) [ 0.019142] IOAPIC[0]: Set routing entry (0-8 -> 0xef -> IRQ 8 Mode:0 Active:0 Dest:0) [ 0.020000] IOAPIC[0]: Set routing entry (0-9 -> 0xef -> IRQ 9 Mode:1 Active:0 Dest:0) [ 0.020000] IOAPIC[0]: Set routing entry (0-10 -> 0xef -> IRQ 10 Mode:1 Active:0 Dest:0) [ 0.020000] IOAPIC[0]: Set routing entry (0-11 -> 0xef -> IRQ 11 Mode:1 Active:0 Dest:0) [ 0.020000] IOAPIC[0]: Set routing entry (0-12 -> 0xef -> IRQ 12 Mode:0 Active:0 Dest:0) [ 0.020000] IOAPIC[0]: Set routing entry (0-13 -> 0xef -> IRQ 13 Mode:0 Active:0 Dest:0) [ 0.020000] IOAPIC[0]: Set routing entry (0-14 -> 0xef -> IRQ 14 Mode:0 Active:0 Dest:0) [ 0.020000] IOAPIC[0]: Set routing entry (0-15 -> 0xef -> IRQ 15 Mode:0 Active:0 Dest:0) [ 0.020000] apic 0 pin 16 not connected [ 0.020000] apic 0 pin 17 not connected [ 0.020000] apic 0 pin 18 not connected [ 0.020000] apic 0 pin 19 not connected [ 0.020000] apic 0 pin 20 not connected [ 0.020000] apic 0 pin 21 not connected [ 0.020000] apic 0 pin 22 not connected [ 0.020000] apic 0 pin 23 not connected [ 0.020000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.020000] tsc: Detected 2593.992 MHz processor [ 0.020000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x25641074d3b, max_idle_ns: 440795244898 ns [ 0.020000] Calibrating delay loop (skipped) preset value.. 5187.98 BogoMIPS (lpj=25939920) [ 0.020000] pid_max: default: 32768 minimum: 301 [ 0.020000] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes) [ 0.020000] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes) [ 0.021561] mce: CPU supports 10 MCE banks [ 0.022172] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.022782] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.023454] CPU: Intel QEMU Virtual CPU version 2.5+ (family: 0x6, model: 0x6, stepping: 0x3) [ 0.024481] Spectre V2 : Spectre mitigation: kernel not compiled with retpoline; no mitigation available! [ 0.030073] Performance Events: PMU not available due to virtualization, using software events only. [ 0.041231] Using local APIC timer interrupts. [ 0.041231] calibrating APIC timer ... [ 0.050000] ... lapic delta = 6249955 [ 0.050000] ... PM-Timer delta = 357958 [ 0.050000] ... PM-Timer result ok [ 0.050000] ..... delta 6249955 [ 0.050000] ..... mult: 268433523 [ 0.050000] ..... calibration result: 9999928 [ 0.050000] ..... CPU clock speed is 2594.0194 MHz. [ 0.050000] ..... host bus clock speed is 999.9928 MHz. [ 0.050000] devtmpfs: initialized [ 0.050000] x86/mm: Memory block size: 128MB [ 0.050000] gcov: version magic: 0x4137332a [ 0.066466] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns [ 0.067220] futex hash table entries: 256 (order: 2, 24576 bytes) [ 0.068008] prandom: seed boundary self test passed [ 0.070041] prandom: 100 self tests passed [ 0.073606] NET: Registered protocol family 16 [ 0.079023] cpuidle: using governor menu [ 0.081433] ACPI: bus type PCI registered [ 0.082060] PCI: Using configuration type 1 for base access [ 0.173954] cryptd: max_cpu_qlen set to 1000 [ 0.175725] ACPI: Added _OSI(Module Device) [ 0.176157] ACPI: Added _OSI(Processor Device) [ 0.176598] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.177070] ACPI: Added _OSI(Processor Aggregator Device) [ 0.177628] ACPI: Added _OSI(Linux-Dell-Video) [ 0.223684] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.233804] workqueue: round-robin CPU selection forced, expect performance impact [ 0.241272] ACPI: Interpreter enabled [ 0.241766] ACPI: (supports S0 S3 S5) [ 0.242066] ACPI: Using IOAPIC for interrupt routing [ 0.242629] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.246303] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.336574] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.337129] acpi PNP0A03:00: _OSC: OS supports [Segments] [ 0.337728] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM [ 0.339232] PCI host bridge to bus 0000:00 [ 0.339560] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.340029] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.340531] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.341078] pci_bus 0000:00: root bus resource [mem 0x1a400000-0xfebfffff window] [ 0.341643] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.342184] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.346240] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.350136] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 0.352896] pci 0000:00:01.1: reg 0x20: [io 0xc040-0xc04f] [ 0.354404] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.354928] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.355403] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.355924] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.359295] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 0.360202] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.360740] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.364664] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 [ 0.367362] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref] [ 0.370028] pci 0000:00:02.0: reg 0x18: [mem 0xfebf0000-0xfebf0fff] [ 0.376297] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref] [ 0.380775] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000 [ 0.382928] pci 0000:00:03.0: reg 0x10: [mem 0xfebc0000-0xfebdffff] [ 0.384147] pci 0000:00:03.0: reg 0x14: [io 0xc000-0xc03f] [ 0.388955] pci 0000:00:03.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 0.392921] pci 0000:00:04.0: [8086:25ab] type 00 class 0x088000 [ 0.393818] pci 0000:00:04.0: reg 0x10: [mem 0xfebf1000-0xfebf100f] [ 0.399967] pci_bus 0000:00: on NUMA node 0 [ 0.408842] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) [ 0.411785] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) [ 0.414287] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) [ 0.416773] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) [ 0.418135] ACPI: PCI Interrupt Link [LNKS] (IRQs *9) [ 0.425196] pci 0000:00:02.0: vgaarb: setting as boot VGA device [ 0.425675] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none [ 0.426312] pci 0000:00:02.0: vgaarb: bridge control possible [ 0.426750] vgaarb: loaded [ 0.429438] ACPI: bus type USB registered [ 0.430072] usbcore: registered new interface driver usbfs [ 0.430637] usbcore: registered new interface driver hub [ 0.431211] usbcore: registered new device driver usb [ 0.432726] Linux video capture interface: v2.00 [ 0.433365] pps_core: LinuxPPS API ver. 1 registered [ 0.433755] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 0.434543] EDAC MC: Ver: 3.0.0 [ 0.436844] FPGA manager framework [ 0.437834] Advanced Linux Sound Architecture Driver Initialized. [ 0.439003] PCI: Using ACPI for IRQ routing [ 0.439527] PCI: pci_cache_line_size set to 64 bytes [ 0.440238] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] [ 0.441017] e820: reserve RAM buffer [mem 0x1a3e0000-0x1bffffff] [ 0.445834] nfc: nfc_init: NFC Core ver 0.1 [ 0.446784] NET: Registered protocol family 39 [ 0.451278] clocksource: Switched to clocksource kvm-clock [ 0.453067] VFS: Disk quotas dquot_6.6.0 [ 0.453711] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.455777] pnp: PnP ACPI init [ 0.457750] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active) [ 0.459737] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active) [ 0.460642] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active) [ 0.461787] pnp 00:03: [dma 2] [ 0.462721] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active) [ 0.465262] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active) [ 0.467668] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active) [ 0.470149] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active) [ 0.479749] pnp: PnP ACPI: found 7 devices [ 0.507998] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.518408] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 0.518923] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 0.519374] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 0.519875] pci_bus 0000:00: resource 7 [mem 0x1a400000-0xfebfffff window] [ 0.523611] NET: Registered protocol family 2 [ 0.526183] tcp_listen_portaddr_hash hash table entries: 256 (order: 2, 22528 bytes) [ 0.526845] TCP established hash table entries: 4096 (order: 3, 32768 bytes) [ 0.527519] TCP bind hash table entries: 4096 (order: 6, 327680 bytes) [ 0.528742] TCP: Hash tables configured (established 4096 bind 4096) [ 0.529433] UDP hash table entries: 256 (order: 3, 49152 bytes) [ 0.530005] UDP-Lite hash table entries: 256 (order: 3, 49152 bytes) [ 0.531162] NET: Registered protocol family 1 [ 0.532748] RPC: Registered named UNIX socket transport module. [ 0.533219] RPC: Registered udp transport module. [ 0.533569] RPC: Registered tcp transport module. [ 0.533914] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 0.538273] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.538832] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.539311] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.539905] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] [ 0.540639] PCI: CLS 0 bytes, default 64 [ 0.542049] Unpacking initramfs... [ 1.030364] kwatchdog (22) used greatest stack depth: 26312 bytes left [ 2.189507] debug: unmapping init [mem 0xffff88001a0bf000-0xffff88001a3dffff] [ 2.208343] PCLMULQDQ-NI instructions are not detected. [ 2.209601] AVX or AES-NI instructions are not detected. [ 2.210052] CPU feature 'AVX registers' is not supported. [ 2.210459] CPU feature 'AVX registers' is not supported. [ 2.210854] AVX2 or AES-NI instructions are not detected. [ 2.211250] AVX2 instructions are not detected. [ 3.200239] tsc: Refined TSC clocksource calibration: 2593.993 MHz [ 3.200785] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x256411d258c, max_idle_ns: 440795337342 ns [ 8.827981] rcu-torture:--- Start of test: nreaders=1 nfakewriters=4 stat_interval=60 verbose=1 test_no_idle_hz=1 shuffle_interval=3 stutter=5 irqreader=1 fqs_duration=0 fqs_holdoff=0 fqs_stutter=3 test_boost=1/0 test_boost_interval=7 test_boost_duration=4 shutdown_secs=0 stall_cpu=0 stall_cpu_holdoff=10 stall_cpu_irqsoff=0 n_barrier_cbs=0 onoff_interval=0 onoff_holdoff=0 [ 8.833059] rcu-torture: Creating rcu_torture_writer task [ 8.834076] rcu-torture: Creating rcu_torture_fakewriter task [ 8.834818] rcu-torture: rcu_torture_writer task started [ 8.835395] rcu-torture: GP expediting controlled from boot/sysfs for rcu. [ 8.836083] rcu_torture_writer: Testing conditional GPs. [ 8.836604] rcu_torture_writer: Testing expedited GPs. [ 8.837127] rcu_torture_writer: Testing asynchronous GPs. [ 8.837658] rcu_torture_writer: Testing normal GPs. [ 8.838236] rcu-torture: Creating rcu_torture_fakewriter task [ 8.839000] rcu-torture: rcu_torture_fakewriter task started [ 8.839664] rcu-torture: Creating rcu_torture_fakewriter task [ 8.840451] rcu-torture: rcu_torture_fakewriter task started [ 8.841111] rcu-torture: Creating rcu_torture_fakewriter task [ 8.841823] rcu-torture: rcu_torture_fakewriter task started [ 8.842493] rcu-torture: Creating rcu_torture_reader task [ 8.843207] rcu-torture: rcu_torture_fakewriter task started [ 8.843875] rcu-torture: Creating rcu_torture_stats task [ 8.844598] rcu-torture: rcu_torture_reader task started [ 8.845241] rcu-torture: Creating torture_shuffle task [ 8.845897] rcu-torture: rcu_torture_stats task started [ 8.846527] rcu-torture: Creating torture_stutter task [ 8.847205] rcu-torture: torture_shuffle task started [ 8.847828] rcu-torture: Creating rcu_torture_cbflood task [ 8.848545] rcu-torture: torture_stutter task started [ 8.862492] rcu-torture: rcu_torture_cbflood task started [ 13.100860] Initialise system trusted keyrings [ 13.102787] workingset: timestamp_bits=46 max_order=16 bucket_order=0 [ 13.179321] zbud: loaded [ 13.197351] NFS: Registering the id_resolver key type [ 13.198044] Key type id_resolver registered [ 13.198568] Key type id_legacy registered [ 13.212521] romfs: ROMFS MTD (C) 2007 Red Hat, Inc. [ 13.213697] 9p: Installing v9fs 9p2000 file system support [ 13.219036] ceph: loaded (mds proto 32) [ 13.219512] pstore: using deflate compression [ 13.231367] cryptomgr_test (85) used greatest stack depth: 25216 bytes left [ 13.247875] NET: Registered protocol family 38 [ 13.248534] Key type asymmetric registered [ 13.249043] Asymmetric key parser 'x509' registered [ 13.249634] Key type pkcs7_test registered [ 14.057793] String selftests succeeded [ 14.059173] xz_dec_test: module loaded [ 14.059468] xz_dec_test: Create a device node with 'mknod xz_dec_test c 245 0' and write .xz files to it. [ 14.063014] ipmi message handler version 39.2 [ 14.063363] ipmi device interface [ 14.063815] IPMI System Interface driver. [ 14.064739] ipmi_si: Unable to find any System Interface(s) [ 14.065164] IPMI Watchdog: driver initialized [ 14.065492] Copyright (C) 2004 MontaVista Software - IPMI Powerdown via sys_reboot. [ 14.067173] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 14.068019] ACPI: Power Button [PWRF] [ 14.262277] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled [ 14.285763] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 14.313955] 00:06: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 14.323145] lp: driver loaded but no devices found [ 14.323832] Non-volatile memory driver v1.3 [ 14.325146] telclk_interrupt = 0xf non-mcpbl0010 hw. [ 14.325933] Hangcheck: starting hangcheck timer 0.9.1 (tick is 180 seconds, margin is 60 seconds). [ 14.328232] parport_pc 00:04: reported by Plug and Play ACPI [ 14.329298] parport0: PC-style at 0x378, irq 7 [PCSPP,TRISTATE] [ 14.411809] lp0: using parport0 (interrupt-driven). [ 14.417270] dummy-irq: no IRQ given. Use irq=N [ 14.418062] Silicon Labs C2 port support v. 0.51.0 - (C) 2007 Rodolfo Giometti [ 14.419112] c2port c2port0: C2 port uc added [ 14.419442] c2port c2port0: uc flash has 30 blocks x 512 bytes (15360 bytes total) [ 14.422591] usbcore: registered new interface driver viperboard [ 14.423429] usbcore: registered new interface driver pn533_usb [ 14.424970] nfcsim 0.2 initialized [ 14.425355] usbcore: registered new interface driver port100 [ 14.426575] L440GX flash mapping: failed to find PIIX4 ISA bridge, cannot continue [ 14.427312] platform physmap-flash.0: failed to claim resource 0: [mem 0x08000000-0x07ffffff] [ 14.428045] SBC-GXx flash: IO:0x258-0x259 MEM:0xdc000-0xdffff [ 14.428811] slram: not enough parameters. [ 14.429244] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0 [ 14.429927] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0 [ 14.430628] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0 [ 14.431297] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0 [ 14.431966] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0 [ 14.432649] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0 [ 14.433324] nand: device found, Manufacturer ID: 0x98, Chip ID: 0x39 [ 14.433787] nand: Toshiba NAND 128MiB 1,8V 8-bit [ 14.434134] nand: 128 MiB, SLC, erase size: 16 KiB, page size: 512, OOB size: 16 [ 14.434734] flash size: 128 MiB [ 14.434976] page size: 512 bytes [ 14.435219] OOB area size: 16 bytes [ 14.435485] sector size: 16 KiB [ 14.435721] pages number: 262144 [ 14.435963] pages per sector: 32 [ 14.436206] bus width: 8 [ 14.436406] bits in sector size: 14 [ 14.436678] bits in page size: 9 [ 14.436921] bits in OOB size: 4 [ 14.437157] flash size with OOB: 135168 KiB [ 14.437469] page address bytes: 4 [ 14.437716] sector address bytes: 3 [ 14.437976] options: 0x42 [ 14.443133] Scanning device for bad blocks [ 14.523624] Creating 1 MTD partitions on "NAND 128MiB 1,8V 8-bit": [ 14.524118] 0x000000000000-0x000008000000 : "NAND simulator partition 0" [ 14.736585] parport0: AVR Butterfly [ 14.737327] parport0: cannot grant exclusive access for device spi-lm70llp [ 14.737871] spi_lm70llp: spi_lm70llp probe fail, status -12 [ 14.739050] HSI/SSI char device loaded [ 14.739452] eql: Equalizer2002: Simon Janes (simon@ncm.com) and David S. Miller (davem@redhat.com) [ 14.745389] libphy: Fixed MDIO Bus: probed [ 14.753478] tun: Universal TUN/TAP device driver, 1.6 [ 14.754476] arcnet: arcnet loaded [ 14.754742] arcnet:rfc1201: RFC1201 "standard" (`a') encapsulation support loaded [ 14.755279] arcnet:rfc1051: RFC1051 "simple standard" (`s') encapsulation support loaded [ 14.755891] arcnet:com90xx: COM90xx chipset support [ 15.065885] S3: No ARCnet cards found. [ 15.066263] arcnet:arc_rimi: RIM I (entirely mem-mapped) support [ 15.066706] arcnet:arc_rimi: E-mail me if you actually test the RIM I driver, please! [ 15.067265] arcnet:arc_rimi: Given: node 00h, shmem 0h, irq 0 [ 15.067700] arcnet:arc_rimi: No autoprobe for RIM I; you must specify the shmem and irq! [ 15.068601] e1000: Intel(R) PRO/1000 Network Driver - version 7.3.21-k8-NAPI [ 15.069115] e1000: Copyright (c) 1999-2006 Intel Corporation. [ 18.721197] PCI Interrupt Link [LNKC] enabled at IRQ 11 [ 19.623640] e1000 0000:00:03.0 eth0: (PCI:33MHz:32-bit) 52:54:00:12:34:56 [ 19.624225] e1000 0000:00:03.0 eth0: Intel(R) PRO/1000 Network Connection [ 19.624977] e1000e: Intel(R) PRO/1000 Network Driver - 3.2.6-k [ 19.625424] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. [ 19.626020] igb: Intel(R) Gigabit Ethernet Network Driver - version 5.4.0-k [ 19.626532] igb: Copyright (c) 2007-2014 Intel Corporation. [ 19.627073] ixgbe: Intel(R) 10 Gigabit PCI Express Network Driver - version 5.1.0-k [ 19.627630] ixgbe: Copyright (c) 1999-2016 Intel Corporation. [ 19.628525] YAM driver version 0.8 by F1OAT/F6FBB [ 19.635685] NET3 PLIP version 2.4-parport gniibe@mri.co.jp [ 19.636113] plip0: Parallel port at 0x378, using IRQ 7. [ 19.636627] usbcore: registered new interface driver catc [ 19.637143] usbcore: registered new interface driver kaweth [ 19.637697] usbcore: registered new interface driver rtl8150 [ 19.638230] usbcore: registered new interface driver r8152 [ 19.638750] usbcore: registered new interface driver lan78xx [ 19.639273] usbcore: registered new interface driver ipheth [ 19.640680] panel: could not claim access to parport0. Aborting. [ 19.641591] panel: panel driver not yet registered [ 19.642524] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 19.643018] ohci-pci: OHCI PCI platform driver [ 19.643495] ohci-platform: OHCI generic platform driver [ 19.644748] usbcore: registered new interface driver usblp [ 19.645269] usbcore: registered new interface driver usbtmc [ 19.645881] usbcore: registered new interface driver mdc800 [ 19.646294] mdc800: v0.7.5 (30/10/2000):USB Driver for Mustek MDC800 Digital Camera [ 19.646969] usbcore: registered new interface driver adutux [ 19.647494] usbcore: registered new interface driver appledisplay [ 19.648045] usbcore: registered new interface driver cypress_cy7c63 [ 19.648620] usbcore: registered new interface driver cytherm [ 19.649156] usbcore: registered new interface driver emi26 - firmware loader [ 19.649784] usbcore: registered new interface driver emi62 - firmware loader [ 19.650454] usbcore: registered new interface driver idmouse [ 19.650984] usbcore: registered new interface driver usblcd [ 19.651512] usbcore: registered new interface driver legousbtower [ 19.652068] usbcore: registered new interface driver rio500 [ 19.652594] usbcore: registered new interface driver usb_ehset_test [ 19.653164] usbcore: registered new interface driver usbsevseg [ 19.653755] usbcore: registered new interface driver yurex [ 19.656757] vhci_hcd: vhci_hcd_probe:1286: name vhci_hcd id 0 [ 19.657323] vhci_hcd vhci_hcd.0: USB/IP Virtual Host Controller [ 19.657831] vhci_hcd vhci_hcd.0: new USB bus registered, assigned bus number 1 [ 19.658421] vhci_hcd: vhci_start:1118: enter vhci_start [ 19.658905] vhci_hcd: vhci_start:1160: created sysfs vhci_hcd.0 [ 19.662980] hub 1-0:1.0: USB hub found [ 19.663689] vhci_hcd: vhci_hub_control:335: typeReq a006 wValue 2900 wIndex 0 [ 19.664485] vhci_hcd: vhci_hub_control:388: GetHubDescriptor [ 19.664959] vhci_hcd: vhci_hub_control:596: port -1 [ 19.665319] vhci_hcd: vhci_hub_control:604: bye [ 19.665746] hub 1-0:1.0: 8 ports detected [ 19.666398] vhci_hcd: vhci_hub_control:335: typeReq a000 wValue 0 wIndex 0 [ 19.666979] vhci_hcd: vhci_hub_control:411: GetHubStatus [ 19.667404] vhci_hcd: vhci_hub_control:596: port -1 [ 19.667763] vhci_hcd: vhci_hub_control:604: bye [ 19.671595] vhci_hcd: vhci_hub_control:335: typeReq 2303 wValue 8 wIndex 1 [ 19.672103] vhci_hcd: vhci_hub_control:518: SetPortFeature: USB_PORT_FEAT_POWER [ 19.672640] vhci_hcd: vhci_hub_control:596: port 0 [ 19.672994] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000100 [ 19.673586] vhci_hcd: dump_port_status_diff:142: +POWER [ 19.673974] vhci_hcd: dump_port_status_diff:150: [ 19.674320] vhci_hcd: vhci_hub_control:604: bye [ 19.674777] vhci_hcd: vhci_hub_control:335: typeReq 2303 wValue 8 wIndex 2 [ 19.675280] vhci_hcd: vhci_hub_control:518: SetPortFeature: USB_PORT_FEAT_POWER [ 19.675814] vhci_hcd: vhci_hub_control:596: port 1 [ 19.676164] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000100 [ 19.676755] vhci_hcd: dump_port_status_diff:142: +POWER [ 19.677140] vhci_hcd: dump_port_status_diff:150: [ 19.677513] vhci_hcd: vhci_hub_control:604: bye [ 19.677961] vhci_hcd: vhci_hub_control:335: typeReq 2303 wValue 8 wIndex 3 [ 19.678471] vhci_hcd: vhci_hub_control:518: SetPortFeature: USB_PORT_FEAT_POWER [ 19.679004] vhci_hcd: vhci_hub_control:596: port 2 [ 19.679356] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000100 [ 19.679945] vhci_hcd: dump_port_status_diff:142: +POWER [ 19.680021] vhci_hcd: dump_port_status_diff:150: [ 19.680021] vhci_hcd: vhci_hub_control:604: bye [ 19.681172] vhci_hcd: vhci_hub_control:335: typeReq 2303 wValue 8 wIndex 4 [ 19.681690] vhci_hcd: vhci_hub_control:518: SetPortFeature: USB_PORT_FEAT_POWER [ 19.682222] vhci_hcd: vhci_hub_control:596: port 3 [ 19.682589] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000100 [ 19.683173] vhci_hcd: dump_port_status_diff:142: +POWER [ 19.683564] vhci_hcd: dump_port_status_diff:150: [ 19.683909] vhci_hcd: vhci_hub_control:604: bye [ 19.684357] vhci_hcd: vhci_hub_control:335: typeReq 2303 wValue 8 wIndex 5 [ 19.684865] vhci_hcd: vhci_hub_control:518: SetPortFeature: USB_PORT_FEAT_POWER [ 19.685405] vhci_hcd: vhci_hub_control:596: port 4 [ 19.685780] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000100 [ 19.686369] vhci_hcd: dump_port_status_diff:142: +POWER [ 19.686762] vhci_hcd: dump_port_status_diff:150: [ 19.687108] vhci_hcd: vhci_hub_control:604: bye [ 19.687567] vhci_hcd: vhci_hub_control:335: typeReq 2303 wValue 8 wIndex 6 [ 19.688069] vhci_hcd: vhci_hub_control:518: SetPortFeature: USB_PORT_FEAT_POWER [ 19.688612] vhci_hcd: vhci_hub_control:596: port 5 [ 19.688971] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000100 [ 19.689562] vhci_hcd: dump_port_status_diff:142: +POWER [ 19.689952] vhci_hcd: dump_port_status_diff:150: [ 19.690296] vhci_hcd: vhci_hub_control:604: bye [ 19.690879] vhci_hcd: vhci_hub_control:335: typeReq 2303 wValue 8 wIndex 7 [ 19.691384] vhci_hcd: vhci_hub_control:518: SetPortFeature: USB_PORT_FEAT_POWER [ 19.691920] vhci_hcd: vhci_hub_control:596: port 6 [ 19.692274] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000100 [ 19.692866] vhci_hcd: dump_port_status_diff:142: +POWER [ 19.693252] vhci_hcd: dump_port_status_diff:150: [ 19.693624] vhci_hcd: vhci_hub_control:604: bye [ 19.694072] vhci_hcd: vhci_hub_control:335: typeReq 2303 wValue 8 wIndex 8 [ 19.694582] vhci_hcd: vhci_hub_control:518: SetPortFeature: USB_PORT_FEAT_POWER [ 19.695115] vhci_hcd: vhci_hub_control:596: port 7 [ 19.695472] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000100 [ 19.696060] vhci_hcd: dump_port_status_diff:142: +POWER [ 19.696455] vhci_hcd: dump_port_status_diff:150: [ 19.696802] vhci_hcd: vhci_hub_control:604: bye [ 19.698235] vhci_hcd vhci_hcd.0: USB/IP Virtual Host Controller [ 19.698690] vhci_hcd vhci_hcd.0: new USB bus registered, assigned bus number 2 [ 19.699247] vhci_hcd: vhci_start:1118: enter vhci_start [ 19.699845] vhci_hcd: vhci_hub_control:335: typeReq 8006 wValue f00 wIndex 0 [ 19.700442] vhci_hcd: vhci_hub_control:596: port -1 [ 19.700837] vhci_hcd: vhci_hub_control:604: bye [ 19.701301] vhci_hcd: vhci_hub_control:335: typeReq 8006 wValue f00 wIndex 0 [ 19.701997] vhci_hcd: vhci_hub_control:596: port -1 [ 19.702358] vhci_hcd: vhci_hub_control:604: bye [ 19.702756] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM. [ 19.705795] hub 2-0:1.0: USB hub found [ 19.706219] vhci_hcd: vhci_hub_control:335: typeReq a006 wValue 2a00 wIndex 0 [ 19.706746] vhci_hcd: vhci_hub_control:388: GetHubDescriptor [ 19.707169] vhci_hcd: vhci_hub_control:596: port -1 [ 19.707538] vhci_hcd: vhci_hub_control:604: bye [ 19.707943] hub 2-0:1.0: 8 ports detected [ 19.708462] vhci_hcd: vhci_hub_control:335: typeReq a000 wValue 0 wIndex 0 [ 19.708977] vhci_hcd: vhci_hub_control:411: GetHubStatus [ 19.709377] vhci_hcd: vhci_hub_control:596: port -1 [ 19.709770] vhci_hcd: vhci_hub_control:604: bye [ 19.713794] vhci_hcd: vhci_hub_control:335: typeReq 2303 wValue 8 wIndex 1 [ 19.714305] vhci_hcd: vhci_hub_control:518: SetPortFeature: USB_PORT_FEAT_POWER [ 19.714842] vhci_hcd: vhci_hub_control:596: port 0 [ 19.715197] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000200 [ 19.715793] vhci_hcd: dump_port_status_diff:142: +POWER [ 19.716183] vhci_hcd: dump_port_status_diff:150: [ 19.716534] vhci_hcd: vhci_hub_control:604: bye [ 19.716986] vhci_hcd: vhci_hub_control:335: typeReq 2303 wValue 8 wIndex 2 [ 19.717515] vhci_hcd: vhci_hub_control:518: SetPortFeature: USB_PORT_FEAT_POWER [ 19.718046] vhci_hcd: vhci_hub_control:596: port 1 [ 19.718404] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000200 [ 19.718992] vhci_hcd: dump_port_status_diff:142: +POWER [ 19.719380] vhci_hcd: dump_port_status_diff:150: [ 19.719730] vhci_hcd: vhci_hub_control:604: bye [ 19.720232] vhci_hcd: vhci_hub_control:335: typeReq 2303 wValue 8 wIndex 3 [ 19.720743] vhci_hcd: vhci_hub_control:518: SetPortFeature: USB_PORT_FEAT_POWER [ 19.721278] vhci_hcd: vhci_hub_control:596: port 2 [ 19.721645] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000200 [ 19.722234] vhci_hcd: dump_port_status_diff:142: +POWER [ 19.722628] vhci_hcd: dump_port_status_diff:150: [ 19.722975] vhci_hcd: vhci_hub_control:604: bye [ 19.723428] vhci_hcd: vhci_hub_control:335: typeReq 2303 wValue 8 wIndex 4 [ 19.723945] vhci_hcd: vhci_hub_control:518: SetPortFeature: USB_PORT_FEAT_POWER [ 19.724489] vhci_hcd: vhci_hub_control:596: port 3 [ 19.724842] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000200 [ 19.725463] vhci_hcd: dump_port_status_diff:142: +POWER [ 19.725857] vhci_hcd: dump_port_status_diff:150: [ 19.726204] vhci_hcd: vhci_hub_control:604: bye [ 19.726660] vhci_hcd: vhci_hub_control:335: typeReq 2303 wValue 8 wIndex 5 [ 19.727164] vhci_hcd: vhci_hub_control:518: SetPortFeature: USB_PORT_FEAT_POWER [ 19.727702] vhci_hcd: vhci_hub_control:596: port 4 [ 19.728056] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000200 [ 19.728651] vhci_hcd: dump_port_status_diff:142: +POWER [ 19.729040] vhci_hcd: dump_port_status_diff:150: [ 19.729386] vhci_hcd: vhci_hub_control:604: bye [ 19.729849] vhci_hcd: vhci_hub_control:335: typeReq 2303 wValue 8 wIndex 6 [ 19.730439] vhci_hcd: vhci_hub_control:518: SetPortFeature: USB_PORT_FEAT_POWER [ 19.730982] vhci_hcd: vhci_hub_control:596: port 5 [ 19.731334] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000200 [ 19.731923] vhci_hcd: dump_port_status_diff:142: +POWER [ 19.732310] vhci_hcd: dump_port_status_diff:150: [ 19.732660] vhci_hcd: vhci_hub_control:604: bye [ 19.733154] vhci_hcd: vhci_hub_control:335: typeReq 2303 wValue 8 wIndex 7 [ 19.733682] vhci_hcd: vhci_hub_control:518: SetPortFeature: USB_PORT_FEAT_POWER [ 19.734216] vhci_hcd: vhci_hub_control:596: port 6 [ 19.734575] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000200 [ 19.735397] vhci_hcd: dump_port_status_diff:142: +POWER [ 19.735795] vhci_hcd: dump_port_status_diff:150: [ 19.736142] vhci_hcd: vhci_hub_control:604: bye [ 19.736603] vhci_hcd: vhci_hub_control:335: typeReq 2303 wValue 8 wIndex 8 [ 19.737108] vhci_hcd: vhci_hub_control:518: SetPortFeature: USB_PORT_FEAT_POWER [ 19.737671] vhci_hcd: vhci_hub_control:596: port 7 [ 19.738026] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000200 [ 19.738618] vhci_hcd: dump_port_status_diff:142: +POWER [ 19.739005] vhci_hcd: dump_port_status_diff:150: [ 19.739350] vhci_hcd: vhci_hub_control:604: bye [ 19.740643] vhci_hcd: vhci_hcd_probe:1323: bye [ 19.741870] usbcore: registered new device driver usbip-host [ 19.744467] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 19.746362] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 19.746850] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 19.748584] parport0: cannot grant exclusive access for device parkbd [ 19.750567] mousedev: PS/2 mouse device common for all mice [ 19.751571] evbug: Connected device: input0 (Power Button at LNXPWRBN/button/input0) [ 19.753993] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 19.758123] usbcore: registered new interface driver bcm5974 [ 19.758755] evbug: Connected device: input1 (AT Translated Set 2 keyboard at isa0060/serio0/input0) [ 19.760587] usbcore: registered new interface driver synaptics_usb [ 19.763612] usbcore: registered new interface driver xpad [ 19.764294] usbcore: registered new interface driver usb_acecad [ 19.764864] usbcore: registered new interface driver aiptek [ 19.765389] usbcore: registered new interface driver gtco [ 19.765913] usbcore: registered new interface driver hanwang [ 19.766455] usbcore: registered new interface driver kbtab [ 19.768652] usbcore: registered new interface driver pegasus_notetaker [ 19.770807] rtc_cmos 00:00: RTC can wake from S4 [ 19.772319] rtc_cmos 00:00: registered as rtc0 [ 19.772674] rtc_cmos 00:00: nvmem registration failed [ 19.773046] rtc_cmos 00:00: alarms up to one day, y3k, 114 bytes nvram, hpet irqs [ 19.778198] i2c /dev entries driver [ 19.779104] usbcore: registered new interface driver RobotFuzz Open Source InterFace, OSIF [ 19.779838] usbcore: registered new interface driver i2c-tiny-usb [ 19.785534] usbcore: registered new interface driver ati_remote [ 19.786092] usbcore: registered new interface driver imon [ 19.786624] usbcore: registered new interface driver redrat3 [ 19.787156] usbcore: registered new interface driver streamzap [ 19.787739] Registered IR keymap rc-empty [ 19.788393] rc rc0: rc-core loopback device as /devices/virtual/rc/rc0 [ 19.789306] input: rc-core loopback device as /devices/virtual/rc/rc0/input3 [ 19.790385] evbug: Connected device: input3 (rc-core loopback device at rc-core/virtual) [ 19.791362] rc rc0: lirc_dev: driver rc-loopback registered at minor = 0 [ 19.792190] usbcore: registered new interface driver igorplugusb [ 19.792762] usbcore: registered new interface driver ttusbir [ 19.793923] serial_ir serial_ir.0: port 03f8 already in use [ 19.794341] serial_ir serial_ir.0: use 'setserial /dev/ttySX uart none' [ 19.794824] serial_ir serial_ir.0: or compile the serial port driver as module and [ 19.795371] serial_ir serial_ir.0: make sure this module is loaded first [ 19.795960] serial_ir: probe of serial_ir.0 failed with error -16 [ 19.796422] pps_parport: parallel port PPS client [ 19.796991] parport0: cannot grant exclusive access for device pps_parport [ 19.797499] pps_parport: couldn't register with parport0 [ 19.797900] Driver for 1-wire Dallas network protocol. [ 19.798690] usbcore: registered new interface driver DS9490R [ 19.799232] DS1WM w1 busmaster driver - (c) 2004 Szabolcs Gyurko [ 19.799895] w1_f0d_init() [ 19.800392] vhci_hcd: vhci_hub_control:335: typeReq a300 wValue 0 wIndex 1 [ 19.800945] vhci_hcd: vhci_hub_control:415: GetPortStatus port 1 [ 19.801421] vhci_hcd: vhci_hub_control:470: GetPortStatus bye 100 0 [ 19.801879] vhci_hcd: vhci_hub_control:596: port 0 [ 19.802230] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 19.802854] vhci_hcd: dump_port_status_diff:142: POWER [ 19.803244] vhci_hcd: dump_port_status_diff:150: [ 19.803596] vhci_hcd: vhci_hub_control:604: bye [ 19.804078] vhci_hcd: vhci_hub_control:335: typeReq a300 wValue 0 wIndex 2 [ 19.804588] vhci_hcd: vhci_hub_control:415: GetPortStatus port 2 [ 19.805033] vhci_hcd: vhci_hub_control:470: GetPortStatus bye 100 0 [ 19.805496] vhci_hcd: vhci_hub_control:596: port 1 [ 19.805848] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 19.806436] vhci_hcd: dump_port_status_diff:142: POWER [ 19.806822] vhci_hcd: dump_port_status_diff:150: [ 19.807167] vhci_hcd: vhci_hub_control:604: bye [ 19.807582] vhci_hcd: vhci_hub_control:335: typeReq a300 wValue 0 wIndex 3 [ 19.808085] vhci_hcd: vhci_hub_control:415: GetPortStatus port 3 [ 19.808530] vhci_hcd: vhci_hub_control:470: GetPortStatus bye 100 0 [ 19.808992] vhci_hcd: vhci_hub_control:596: port 2 [ 19.809345] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 19.809932] vhci_hcd: dump_port_status_diff:142: POWER [ 19.810120] vhci_hcd: dump_port_status_diff:150: [ 19.810120] vhci_hcd: vhci_hub_control:604: bye [ 19.815646] f71882fg: Not a Fintek device [ 19.815990] f71882fg: Not a Fintek device [ 19.822137] vhci_hcd: vhci_hub_control:335: typeReq a300 wValue 0 wIndex 4 [ 19.822655] vhci_hcd: vhci_hub_control:415: GetPortStatus port 4 [ 19.823095] vhci_hcd: vhci_hub_control:470: GetPortStatus bye 100 0 [ 19.823556] vhci_hcd: vhci_hub_control:596: port 3 [ 19.823907] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 19.824494] vhci_hcd: dump_port_status_diff:142: POWER [ 19.824881] vhci_hcd: dump_port_status_diff:150: [ 19.825225] vhci_hcd: vhci_hub_control:604: bye [ 19.825645] vhci_hcd: vhci_hub_control:335: typeReq a300 wValue 0 wIndex 5 [ 19.826146] vhci_hcd: vhci_hub_control:415: GetPortStatus port 5 [ 19.826590] vhci_hcd: vhci_hub_control:470: GetPortStatus bye 100 0 [ 19.827059] vhci_hcd: vhci_hub_control:596: port 4 [ 19.827415] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 19.827996] vhci_hcd: dump_port_status_diff:142: POWER [ 19.828382] vhci_hcd: dump_port_status_diff:150: [ 19.828729] vhci_hcd: vhci_hub_control:604: bye [ 19.829639] pc87360: PC8736x not detected, module not inserted [ 19.830316] sch56xx_common: Unsupported device id: 0xff [ 19.830735] sch56xx_common: Unsupported device id: 0xff [ 19.833962] intel_powerclamp: CPU does not support MWAIT [ 19.834616] usbcore: registered new interface driver pcwd_usb [ 19.835150] advantechwdt: WDT driver for Advantech single board computer initialising [ 19.836732] vhci_hcd: vhci_hub_control:335: typeReq a300 wValue 0 wIndex 6 [ 19.837240] vhci_hcd: vhci_hub_control:415: GetPortStatus port 6 [ 19.837687] vhci_hcd: vhci_hub_control:470: GetPortStatus bye 100 0 [ 19.838148] vhci_hcd: vhci_hub_control:596: port 5 [ 19.838506] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 19.839088] vhci_hcd: dump_port_status_diff:142: POWER [ 19.839481] vhci_hcd: dump_port_status_diff:150: [ 19.839827] vhci_hcd: vhci_hub_control:604: bye [ 19.840317] vhci_hcd: vhci_hub_control:335: typeReq a300 wValue 0 wIndex 7 [ 19.840828] vhci_hcd: vhci_hub_control:415: GetPortStatus port 7 [ 19.841268] vhci_hcd: vhci_hub_control:470: GetPortStatus bye 100 0 [ 19.841728] vhci_hcd: vhci_hub_control:596: port 6 [ 19.842078] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 19.842663] vhci_hcd: dump_port_status_diff:142: POWER [ 19.843048] vhci_hcd: dump_port_status_diff:150: [ 19.843391] vhci_hcd: vhci_hub_control:604: bye [ 19.843837] advantechwdt: initialized. timeout=60 sec (nowayout=0) [ 19.844493] ib700wdt: WDT driver for IB700 single board computer initialising [ 19.845591] ib700wdt: START method I/O 443 is not available [ 19.846081] ib700wdt: probe of ib700wdt failed with error -5 [ 19.846789] wafer5823wdt: WDT driver for Wafer 5823 single board computer initialising [ 19.847386] wafer5823wdt: I/O address 0x0443 already in use [ 19.847884] it87_wdt: no device [ 19.848238] pc87413_wdt: Version 1.1 at io 0x2E [ 19.848598] pc87413_wdt: cannot register miscdev on minor=130 (err=-16) [ 19.849100] sbc60xxwdt: I/O address 0x0443 already in use [ 19.849519] cpu5wdt: misc_register failed [ 19.849860] smsc37b787_wdt: SMsC 37B787 watchdog component driver 1.1 initialising... [ 19.850583] vhci_hcd: vhci_hub_control:335: typeReq a300 wValue 0 wIndex 8 [ 19.851090] vhci_hcd: vhci_hub_control:415: GetPortStatus port 8 [ 19.851536] vhci_hcd: vhci_hub_control:470: GetPortStatus bye 100 0 [ 19.851996] vhci_hcd: vhci_hub_control:596: port 7 [ 19.852349] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 19.852937] vhci_hcd: dump_port_status_diff:142: POWER [ 19.853327] vhci_hcd: dump_port_status_diff:150: [ 19.853677] vhci_hcd: vhci_hub_control:604: bye [ 19.854128] vhci_hcd: vhci_hub_control:335: typeReq a300 wValue 0 wIndex 1 [ 19.854638] vhci_hcd: vhci_hub_control:415: GetPortStatus port 1 [ 19.855079] vhci_hcd: vhci_hub_control:470: GetPortStatus bye 200 0 [ 19.855540] vhci_hcd: vhci_hub_control:596: port 0 [ 19.855894] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 19.856485] vhci_hcd: dump_port_status_diff:142: POWER [ 19.856874] vhci_hcd: dump_port_status_diff:150: [ 19.857221] vhci_hcd: vhci_hub_control:604: bye [ 19.858741] smsc37b787_wdt: Unable to register miscdev on minor 130 [ 19.859303] w83877f_wdt: I/O address 0x0443 already in use [ 19.859730] sbc_epx_c3: cannot register miscdev on minor=130 (err=-16) [ 19.860315] vhci_hcd: vhci_hub_control:335: typeReq a300 wValue 0 wIndex 2 [ 19.860825] vhci_hcd: vhci_hub_control:415: GetPortStatus port 2 [ 19.861269] vhci_hcd: vhci_hub_control:470: GetPortStatus bye 200 0 [ 19.861741] vhci_hcd: vhci_hub_control:596: port 1 [ 19.862095] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 19.862685] vhci_hcd: dump_port_status_diff:142: POWER [ 19.863074] vhci_hcd: dump_port_status_diff:150: [ 19.863423] vhci_hcd: vhci_hub_control:604: bye [ 19.864625] sdhci: Secure Digital Host Controller Interface driver [ 19.865086] sdhci: Copyright(c) Pierre Ossman [ 19.865741] VUB300 Driver rom wait states = 1C irqpoll timeout = 0400 [ 19.866031] vhci_hcd: vhci_hub_control:335: typeReq a300 wValue 0 wIndex 3 [ 19.867000] vhci_hcd: vhci_hub_control:415: GetPortStatus port 3 [ 19.867451] vhci_hcd: vhci_hub_control:470: GetPortStatus bye 200 0 [ 19.867911] vhci_hcd: vhci_hub_control:596: port 2 [ 19.868264] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 19.868851] vhci_hcd: dump_port_status_diff:142: POWER [ 19.869239] vhci_hcd: dump_port_status_diff:150: [ 19.869588] vhci_hcd: vhci_hub_control:604: bye [ 19.870736] usbcore: registered new interface driver vub300 [ 19.871395] vhci_hcd: vhci_hub_control:335: typeReq a300 wValue 0 wIndex 4 [ 19.871907] vhci_hcd: vhci_hub_control:415: GetPortStatus port 4 [ 19.872347] vhci_hcd: vhci_hub_control:470: GetPortStatus bye 200 0 [ 19.872809] vhci_hcd: vhci_hub_control:596: port 3 [ 19.873161] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 19.873767] vhci_hcd: dump_port_status_diff:142: POWER [ 19.874156] vhci_hcd: dump_port_status_diff:150: [ 19.874508] vhci_hcd: vhci_hub_control:604: bye [ 19.886159] NET: Registered protocol family 4 [ 19.887396] comedi: version 0.7.76 - http://www.comedi.org [ 19.888864] vhci_hcd: vhci_hub_control:335: typeReq a300 wValue 0 wIndex 5 [ 19.889375] vhci_hcd: vhci_hub_control:415: GetPortStatus port 5 [ 19.889824] vhci_hcd: vhci_hub_control:470: GetPortStatus bye 200 0 [ 19.890023] vhci_hcd: vhci_hub_control:596: port 4 [ 19.890023] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 19.890023] vhci_hcd: dump_port_status_diff:142: POWER [ 19.890023] vhci_hcd: dump_port_status_diff:150: [ 19.890023] vhci_hcd: vhci_hub_control:604: bye [ 19.892491] vhci_hcd: vhci_hub_control:335: typeReq a300 wValue 0 wIndex 6 [ 19.892996] vhci_hcd: vhci_hub_control:415: GetPortStatus port 6 [ 19.893441] vhci_hcd: vhci_hub_control:470: GetPortStatus bye 200 0 [ 19.893899] vhci_hcd: vhci_hub_control:596: port 5 [ 19.894250] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 19.894835] vhci_hcd: dump_port_status_diff:142: POWER [ 19.895221] vhci_hcd: dump_port_status_diff:150: [ 19.895569] vhci_hcd: vhci_hub_control:604: bye [ 19.895976] vhci_hcd: vhci_hub_control:335: typeReq a300 wValue 0 wIndex 7 [ 19.896481] vhci_hcd: vhci_hub_control:415: GetPortStatus port 7 [ 19.896921] vhci_hcd: vhci_hub_control:470: GetPortStatus bye 200 0 [ 19.897379] vhci_hcd: vhci_hub_control:596: port 6 [ 19.897733] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 19.898320] vhci_hcd: dump_port_status_diff:142: POWER [ 19.898710] vhci_hcd: dump_port_status_diff:150: [ 19.899056] vhci_hcd: vhci_hub_control:604: bye [ 19.899630] comedi comedi0: comedi_test: 1000000 microvolt, 100000 microsecond waveform attached [ 19.900434] vhci_hcd: vhci_hub_control:335: typeReq a300 wValue 0 wIndex 8 [ 19.900940] vhci_hcd: vhci_hub_control:415: GetPortStatus port 8 [ 19.901381] vhci_hcd: vhci_hub_control:470: GetPortStatus bye 200 0 [ 19.901842] vhci_hcd: vhci_hub_control:596: port 7 [ 19.902193] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 19.902777] vhci_hcd: dump_port_status_diff:142: POWER [ 19.903162] vhci_hcd: dump_port_status_diff:150: [ 19.903509] vhci_hcd: vhci_hub_control:604: bye [ 19.909346] usb usb1: vhci_bus_suspend [ 19.909817] vhci_hcd: vhci_hub_control:335: typeReq 2303 wValue 1b wIndex 1 [ 19.910416] vhci_hcd: vhci_hub_control:556: SetPortFeature: default 27 [ 19.910934] vhci_hcd: vhci_hub_control:596: port 0 [ 19.911287] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 08000200 [ 19.911874] vhci_hcd: dump_port_status_diff:142: POWER [ 19.912261] vhci_hcd: dump_port_status_diff:142: +R27 [ 19.912638] vhci_hcd: dump_port_status_diff:150: [ 19.912983] vhci_hcd: vhci_hub_control:604: bye [ 19.913498] comedi comedi0: driver 'comedi_test' has successfully auto-configured 'comedi_test'. [ 19.916249] LNetError: 1:0:(module.c:546:libcfs_init()) misc_register: error -16 [ 19.917200] vhci_hcd: vhci_hub_control:335: typeReq 2303 wValue 1b wIndex 2 [ 19.917717] vhci_hcd: vhci_hub_control:556: SetPortFeature: default 27 [ 19.918196] vhci_hcd: vhci_hub_control:596: port 1 [ 19.918551] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 08000200 [ 19.919134] vhci_hcd: dump_port_status_diff:142: POWER [ 19.919523] vhci_hcd: dump_port_status_diff:142: +R27 [ 19.919897] vhci_hcd: dump_port_status_diff:150: [ 19.920240] vhci_hcd: vhci_hub_control:604: bye [ 19.920815] vhci_hcd: vhci_hub_control:335: typeReq 2303 wValue 1b wIndex 3 [ 19.921326] vhci_hcd: vhci_hub_control:556: SetPortFeature: default 27 [ 19.921806] vhci_hcd: vhci_hub_control:596: port 2 [ 19.922157] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 08000200 [ 19.922743] vhci_hcd: dump_port_status_diff:142: POWER [ 19.923131] vhci_hcd: dump_port_status_diff:142: +R27 [ 19.923510] vhci_hcd: dump_port_status_diff:150: [ 19.923857] vhci_hcd: vhci_hub_control:604: bye [ 19.924272] vhci_hcd: vhci_hub_control:335: typeReq 2303 wValue 1b wIndex 4 [ 19.924782] vhci_hcd: vhci_hub_control:556: SetPortFeature: default 27 [ 19.925261] vhci_hcd: vhci_hub_control:596: port 3 [ 19.925617] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 08000200 [ 19.926204] vhci_hcd: dump_port_status_diff:142: POWER [ 19.926595] vhci_hcd: dump_port_status_diff:142: +R27 [ 19.926972] vhci_hcd: dump_port_status_diff:150: [ 19.927319] vhci_hcd: vhci_hub_control:604: bye [ 19.927733] vhci_hcd: vhci_hub_control:335: typeReq 2303 wValue 1b wIndex 5 [ 19.928244] vhci_hcd: vhci_hub_control:556: SetPortFeature: default 27 [ 19.928732] vhci_hcd: vhci_hub_control:596: port 4 [ 19.929083] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 08000200 [ 19.929667] vhci_hcd: dump_port_status_diff:142: POWER [ 19.930055] vhci_hcd: dump_port_status_diff:142: +R27 [ 19.930428] vhci_hcd: dump_port_status_diff:150: [ 19.930597] vhci_hcd: vhci_hub_control:604: bye [ 19.931289] vhci_hcd: vhci_hub_control:335: typeReq 2303 wValue 1b wIndex 6 [ 19.931803] vhci_hcd: vhci_hub_control:556: SetPortFeature: default 27 [ 19.932280] vhci_hcd: vhci_hub_control:596: port 5 [ 19.932633] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 08000200 [ 19.933216] vhci_hcd: dump_port_status_diff:142: POWER [ 19.933606] vhci_hcd: dump_port_status_diff:142: +R27 [ 19.933980] vhci_hcd: dump_port_status_diff:150: [ 19.934323] vhci_hcd: vhci_hub_control:604: bye [ 19.934738] vhci_hcd: vhci_hub_control:335: typeReq 2303 wValue 1b wIndex 7 [ 19.935244] vhci_hcd: vhci_hub_control:556: SetPortFeature: default 27 [ 19.935723] vhci_hcd: vhci_hub_control:596: port 6 [ 19.936073] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 08000200 [ 19.936659] vhci_hcd: dump_port_status_diff:142: POWER [ 19.937046] vhci_hcd: dump_port_status_diff:142: +R27 [ 19.937423] vhci_hcd: dump_port_status_diff:150: [ 19.937768] vhci_hcd: vhci_hub_control:604: bye [ 19.938179] vhci_hcd: vhci_hub_control:335: typeReq 2303 wValue 1b wIndex 8 [ 19.938697] vhci_hcd: vhci_hub_control:556: SetPortFeature: default 27 [ 19.939177] vhci_hcd: vhci_hub_control:596: port 7 [ 19.939540] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 08000200 [ 19.940123] vhci_hcd: dump_port_status_diff:142: POWER [ 19.940511] vhci_hcd: dump_port_status_diff:142: +R27 [ 19.940884] vhci_hcd: dump_port_status_diff:150: [ 19.941126] vhci_hcd: vhci_hub_control:604: bye [ 19.941703] usb usb2: vhci_bus_suspend [ 20.967090] ================================================================== [ 20.968082] BUG: KASAN: null-ptr-deref in cfs_trace_lock_tcd+0x25/0xeb [ 20.968856] Read of size 2 at addr 00000000000000a4 by task swapper/1 [ 20.969604] [ 20.969817] CPU: 0 PID: 1 Comm: swapper Tainted: G T 4.17.0-rc1 #1 [ 20.970046] Call Trace: [ 20.970046] dump_stack+0x2e/0x3e [ 20.970046] kasan_report+0x2f3/0x360 [ 20.970046] __asan_load2+0x31/0xe4 [ 20.970046] cfs_trace_lock_tcd+0x25/0xeb [ 20.970046] libcfs_debug_vmsg2+0x18d/0xd26 [ 20.970046] ? cfs_trace_get_tage+0x957/0x957 [ 20.970046] ? mark_lock+0xe9/0xa16 [ 20.970046] ? fput+0x111/0x11f [ 20.970046] ? lnet_ipif_enumerate+0x541/0x588 [ 20.970046] ? kasan_slab_free+0x15/0x1e [ 20.970046] ? kfree+0x215/0x2cb [ 20.970046] libcfs_debug_msg+0x9b/0xc5 [ 20.970046] ? libcfs_debug_vmsg2+0xd26/0xd26 [ 20.970046] ksocknal_startup+0x341/0x1228 [ 20.970046] ? __asan_loadN+0x1d/0x26 [ 20.970046] ? pvclock_clocksource_read+0x162/0x296 [ 20.970046] ? ksocknal_base_startup+0xbae/0xbae [ 20.970046] ? pvclock_read_flags+0x5d/0x5d [ 20.970046] ? kasan_check_read+0x1f/0x28 [ 20.970046] ? kvm_clock_read+0x24/0x3a [ 20.970046] ? kasan_check_write+0x22/0x2b [ 20.970046] ? sched_clock_local+0xc8/0xfa [ 20.970046] ? reacquire_held_locks+0x1cd/0x1cd [ 20.970046] ? cfs_percpt_lock+0xdf/0x1ad [ 20.970046] ? do_raw_spin_unlock+0x100/0x10d [ 20.970046] ? _raw_spin_unlock+0x37/0x4e [ 20.970046] ? cfs_percpt_unlock+0x66/0x13a [ 20.970046] lnet_startup_lndni+0x62a/0xf84 [ 20.970046] ? lnet_shutdown_lndni+0xcc/0xcc [ 20.970046] ? __schedule+0xbff/0xc7f [ 20.970046] ? firmware_map_remove+0x265/0x265 [ 20.970046] ? kasan_check_read+0x1f/0x28 [ 20.970046] LNetNIInit+0x5d4/0xbf8 [ 20.970046] ? lnet_lib_exit+0x147/0x147 [ 20.970046] ? del_timer+0x6d/0xf8 [ 20.970046] ? add_timer_on+0x32b/0x32b [ 20.970046] ? _raw_spin_unlock_irqrestore+0x74/0x9e [ 20.970046] ? trace_hardirqs_on_caller+0x2c8/0x33d [ 20.970046] ? schedule_timeout+0x82b/0x8a7 [ 20.970046] ? kasan_kmalloc+0x1c5/0x1e1 [ 20.970046] ? console_conditional_schedule+0x44/0x44 [ 20.970046] ? do_one_initcall+0x158/0x3ac [ 20.970046] ? kernel_init_freeable+0x2b8/0x434 [ 20.970046] ? kernel_init+0x13/0x1ae [ 20.970046] ? ret_from_fork+0x24/0x30 [ 20.970046] ? __check_object_size+0x8d7/0xa08 [ 20.970046] ? usercopy_abort+0xb7/0xb7 [ 20.970046] ? __lock_is_held+0x39/0xbb [ 20.970046] ? mark_held_locks+0x2c/0xb2 [ 20.970046] ? debug_check_no_locks_freed+0x237/0x25f [ 20.970046] ? collect_expired_timers+0x23b/0x23b [ 20.970046] ? lockdep_init_map+0x10/0x19 [ 20.970046] srpc_startup+0x136/0x352 [ 20.970046] ? srpc_shutdown+0x1f0/0x1f0 [ 20.970046] ? kvmalloc_node+0x6b/0xb6 [ 20.970046] lnet_selftest_init+0x33a/0x4f5 [ 20.970046] ? lnet_selftest_exit+0x13e/0x13e [ 20.970046] ? lustre_insert_debugfs+0x150/0x150 [ 20.970046] ? lnet_init+0x1df/0x1df [ 20.970046] ? lnet_selftest_exit+0x13e/0x13e [ 20.970046] do_one_initcall+0x158/0x3ac [ 20.970046] ? start_kernel+0xbf5/0xbf5 [ 20.970046] kernel_init_freeable+0x2b8/0x434 [ 20.970046] ? rest_init+0x1d2/0x1d2 [ 20.970046] kernel_init+0x13/0x1ae [ 20.970046] ? rest_init+0x1d2/0x1d2 [ 20.970046] ret_from_fork+0x24/0x30 [ 20.970046] ================================================================== [ 20.970046] Disabling lock debugging due to kernel taint [ 21.007543] BUG: unable to handle kernel NULL pointer dereference at 00000000000000a4 [ 21.009103] PGD 0 P4D 0 [ 21.009432] Oops: 0000 [#1] DEBUG_PAGEALLOC KASAN PTI [ 21.010063] CPU: 0 PID: 1 Comm: swapper Tainted: G B T 4.17.0-rc1 #1 [ 21.011023] RIP: 0010:cfs_trace_lock_tcd+0x25/0xeb [ 21.011650] RSP: 0000:ffff880014c87380 EFLAGS: 00010202 [ 21.012299] RAX: 0000000000000202 RBX: 0000000000000000 RCX: ffffffff8119215d [ 21.013197] RDX: dffffc0000000000 RSI: 0000000000000003 RDI: 0000000000000202 [ 21.014074] RBP: ffff880014c87398 R08: 0000000000000001 R09: 0000000000000001 [ 21.014940] R10: ffffed0002990e5a R11: 0000000000000001 R12: 00000000000000a4 [ 21.015818] R13: 0000000000000000 R14: ffff88001402d680 R15: ffff880014c87970 [ 21.016634] FS: 0000000000000000(0000) GS:ffffffff842e9000(0000) knlGS:0000000000000000 [ 21.016892] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 21.016892] CR2: 00000000000000a4 CR3: 0000000004226000 CR4: 00000000000006f0 [ 21.016892] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [ 21.016892] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [ 21.016892] Call Trace: [ 21.016892] libcfs_debug_vmsg2+0x18d/0xd26 [ 21.016892] ? cfs_trace_get_tage+0x957/0x957 [ 21.016892] ? mark_lock+0xe9/0xa16 [ 21.016892] ? fput+0x111/0x11f [ 21.016892] ? lnet_ipif_enumerate+0x541/0x588 [ 21.016892] ? kasan_slab_free+0x15/0x1e [ 21.016892] ? kfree+0x215/0x2cb [ 21.016892] libcfs_debug_msg+0x9b/0xc5 [ 21.016892] ? libcfs_debug_vmsg2+0xd26/0xd26 [ 21.016892] ksocknal_startup+0x341/0x1228 [ 21.016892] ? __asan_loadN+0x1d/0x26 [ 21.016892] ? pvclock_clocksource_read+0x162/0x296 [ 21.016892] ? ksocknal_base_startup+0xbae/0xbae [ 21.016892] ? pvclock_read_flags+0x5d/0x5d [ 21.016892] ? kasan_check_read+0x1f/0x28 [ 21.016892] ? kvm_clock_read+0x24/0x3a [ 21.016892] ? kasan_check_write+0x22/0x2b [ 21.016892] ? sched_clock_local+0xc8/0xfa [ 21.016892] ? reacquire_held_locks+0x1cd/0x1cd [ 21.016892] ? cfs_percpt_lock+0xdf/0x1ad [ 21.016892] ? do_raw_spin_unlock+0x100/0x10d [ 21.016892] ? _raw_spin_unlock+0x37/0x4e [ 21.016892] ? cfs_percpt_unlock+0x66/0x13a [ 21.016892] lnet_startup_lndni+0x62a/0xf84 [ 21.016892] ? lnet_shutdown_lndni+0xcc/0xcc [ 21.016892] ? __schedule+0xbff/0xc7f [ 21.016892] ? firmware_map_remove+0x265/0x265 [ 21.016892] ? kasan_check_read+0x1f/0x28 [ 21.016892] LNetNIInit+0x5d4/0xbf8 [ 21.016892] ? lnet_lib_exit+0x147/0x147 [ 21.016892] ? del_timer+0x6d/0xf8 [ 21.016892] ? add_timer_on+0x32b/0x32b [ 21.016892] ? _raw_spin_unlock_irqrestore+0x74/0x9e [ 21.016892] ? trace_hardirqs_on_caller+0x2c8/0x33d [ 21.016892] ? schedule_timeout+0x82b/0x8a7 [ 21.016892] ? kasan_kmalloc+0x1c5/0x1e1 [ 21.016892] ? console_conditional_schedule+0x44/0x44 [ 21.016892] ? do_one_initcall+0x158/0x3ac [ 21.016892] ? kernel_init_freeable+0x2b8/0x434 [ 21.016892] ? kernel_init+0x13/0x1ae [ 21.016892] ? ret_from_fork+0x24/0x30 [ 21.016892] ? __check_object_size+0x8d7/0xa08 [ 21.016892] ? usercopy_abort+0xb7/0xb7 [ 21.016892] ? __lock_is_held+0x39/0xbb [ 21.016892] ? mark_held_locks+0x2c/0xb2 [ 21.016892] ? debug_check_no_locks_freed+0x237/0x25f [ 21.016892] ? collect_expired_timers+0x23b/0x23b [ 21.016892] ? lockdep_init_map+0x10/0x19 [ 21.016892] srpc_startup+0x136/0x352 [ 21.016892] ? srpc_shutdown+0x1f0/0x1f0 [ 21.016892] ? kvmalloc_node+0x6b/0xb6 [ 21.016892] lnet_selftest_init+0x33a/0x4f5 [ 21.016892] ? lnet_selftest_exit+0x13e/0x13e [ 21.016892] ? lustre_insert_debugfs+0x150/0x150 [ 21.016892] ? lnet_init+0x1df/0x1df [ 21.016892] ? lnet_selftest_exit+0x13e/0x13e [ 21.016892] do_one_initcall+0x158/0x3ac [ 21.016892] ? start_kernel+0xbf5/0xbf5 [ 21.016892] kernel_init_freeable+0x2b8/0x434 [ 21.016892] ? rest_init+0x1d2/0x1d2 [ 21.016892] kernel_init+0x13/0x1ae [ 21.016892] ? rest_init+0x1d2/0x1d2 [ 21.016892] ret_from_fork+0x24/0x30 [ 21.016892] Code: d4 05 31 c0 5d c3 55 48 ff 05 2b bf d4 05 48 89 e5 41 55 41 54 4c 8d a7 a4 00 00 00 53 48 89 fb 41 89 f5 4c 89 e7 e8 16 a9 18 ff <66> 83 bb a4 00 00 00 02 76 24 48 c7 c6 20 37 75 85 48 c7 c7 40 [ 21.016892] RIP: cfs_trace_lock_tcd+0x25/0xeb RSP: ffff880014c87380 [ 21.016892] CR2: 00000000000000a4 [ 21.016892] ---[ end trace be7ae81fe247d9ae ]--- [ 21.016892] Kernel panic - not syncing: Fatal exception [ 21.016892] Kernel Offset: disabled Elapsed time: 30 #!/bin/bash # To reproduce, # 1) save job-script and this script (both are attached in 0day report email) # 2) run this script with your compiled kernel and optional env $INSTALL_MOD_PATH kernel=$1 initrds=( /osimage/openwrt/openwrt-i386-2016-03-16.cgz /lkp/lkp/lkp-i386.cgz ) HTTP_PREFIX=https://github.com/0day-ci/lkp-qemu/raw/master wget --timestamping "${initrds[@]/#/$HTTP_PREFIX}" { cat "${initrds[@]//*\//}" [[ $INSTALL_MOD_PATH ]] && ( cd "$INSTALL_MOD_PATH" find lib | cpio -o -H newc --quiet | gzip ) echo job-script | cpio -o -H newc --quiet | gzip } > initrd.img kvm=( qemu-system-x86_64 -enable-kvm -kernel $kernel -initrd initrd.img -m 420 -smp 1 -device e1000,netdev=net0 -netdev user,id=net0 -boot order=nc -no-reboot -watchdog i6300esb -watchdog-action debug -rtc base=localtime -serial stdio -display none -monitor null ) append=( ip=::::vm-lkp-hsw01-openwrt-ia32-7::dhcp root=/dev/ram0 user=lkp job=/job-script ARCH=x86_64 kconfig=x86_64-randconfig-ws0-03101549 branch=linus/master commit=60cc43fc888428bb2f18f08997432d426a243338 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-ws0-03101549/gcc-7/60cc43fc888428bb2f18f08997432d426a243338/vmlinuz-4.17.0-rc1 max_uptime=600 RESULT_ROOT=/result/boot/1/vm-lkp-hsw01-openwrt-ia32/openwrt-i386-2016-03-16.cgz/x86_64-randconfig-ws0-03101549/gcc-7/60cc43fc888428bb2f18f08997432d426a243338/0 result_service=tmpfs 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 drbd.minor_count=8 rcuperf.shutdown=0 ) "${kvm[@]}" -append "${append[*]}"