early console in setup code early console in extract_kernel input_data: 0x0000000005fce295 input_len: 0x00000000020fb0c8 output: 0x0000000001000000 output_len: 0x00000000060e0960 kernel_total_size: 0x00000000070ef000 trampoline_32bit: 0x000000000009d000 Decompressing Linux... Parsing ELF... done. Booting the kernel. [ 0.000000] Linux version 4.17.0-rc1 (kbuild@lkp-hsx03) (gcc version 7.3.0 (Debian 7.3.0-1)) #262 SMP Tue Apr 17 22:20:14 CST 2018 [ 0.000000] Command line: ip=::::vm-lkp-hsw01-1G-9::dhcp root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-lkp-hsw01-1G-9/trinity-300s-debian-x86_64-2016-08-31.cgz-60cc43fc888428bb2f18f08997432d426a243338-20180417-90038-7ko8tn-0.yaml ARCH=x86_64 kconfig=x86_64-randconfig-s5-04172210 branch=linus/master commit=60cc43fc888428bb2f18f08997432d426a243338 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-s5-04172210/gcc-7/60cc43fc888428bb2f18f08997432d426a243338/vmlinuz-4.17.0-rc1 max_uptime=1500 RESULT_ROOT=/result/trinity/300s/vm-lkp-hsw01-1G/debian-x86_64-2016-08-31.cgz/x86_64-randconfig-s5-04172210/gcc-7/60cc43fc888428bb2f18f08997432d426a243338/2 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=normal rw rcuperf.shutdown=0 [ 0.000000] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' [ 0.000000] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' [ 0.000000] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' [ 0.000000] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 [ 0.000000] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. [ 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-0x000000003ffdffff] usable [ 0.000000] BIOS-e820: [mem 0x000000003ffe0000-0x000000003fffffff] 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] random: fast init done [ 0.000000] SMBIOS 2.8 present. [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014 [ 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 = 0x3ffe0 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 WC UC- UC WB WP UC- WT [ 0.000000] Scan for SMP in [mem 0x00000000-0x000003ff] [ 0.000000] Scan for SMP in [mem 0x0009fc00-0x0009ffff] [ 0.000000] Scan for SMP in [mem 0x000f0000-0x000fffff] [ 0.000000] found SMP MP-table at [mem 0x000f6a80-0x000f6a8f] mapped at [ (ptrval)] [ 0.000000] mpc: f6a90-f6b74 [ 0.000000] Scanning 1 areas for low memory corruption [ 0.000000] Base memory trampoline at [ (ptrval)] 99000 size 24576 [ 0.000000] BRK [0x080ca000, 0x080cafff] PGTABLE [ 0.000000] BRK [0x080cb000, 0x080cbfff] PGTABLE [ 0.000000] BRK [0x080cc000, 0x080ccfff] PGTABLE [ 0.000000] BRK [0x080cd000, 0x080cdfff] PGTABLE [ 0.000000] BRK [0x080ce000, 0x080cefff] PGTABLE [ 0.000000] BRK [0x080cf000, 0x080cffff] PGTABLE [ 0.000000] RAMDISK: [mem 0x37246000-0x3ffdffff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F6870 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x000000003FFE1628 000030 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x000000003FFE147C 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x000000003FFE0040 00143C (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x000000003FFE0000 000040 [ 0.000000] ACPI: APIC 0x000000003FFE1570 000080 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x000000003FFE15F0 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:37244001, primary cpu clock [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: using sched offset of 310478239 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-0x000000003ffdffff] [ 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-0x000000003ffdffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffdffff] [ 0.000000] On node 0 totalpages: 262014 [ 0.000000] DMA zone: 56 pages used for memmap [ 0.000000] DMA zone: 21 pages reserved [ 0.000000] DMA zone: 3998 pages, LIFO batch:0 [ 0.000000] DMA32 zone: 3528 pages used for memmap [ 0.000000] DMA32 zone: 258016 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] smpboot: Allowing 2 CPUs, 0 hotplug CPUs [ 0.000000] mapped IOAPIC to ffffffffff5fc000 (fec00000) [ 0.000000] e820: [mem 0x40000000-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: 6370452778343963 ns [ 0.000000] setup_percpu: NR_CPUS:64 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 [ 0.000000] percpu: Embedded 500 pages/cpu @ (ptrval) s2019328 r0 d28672 u2097152 [ 0.000000] pcpu-alloc: s2019328 r0 d28672 u2097152 alloc=1*2097152 [ 0.000000] pcpu-alloc: [0] 0 [0] 1 [ 0.000000] KVM setup async PF for cpu 0 [ 0.000000] kvm-stealtime: cpu 0, msr 2cfec040 [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 258409 [ 0.000000] Kernel command line: ip=::::vm-lkp-hsw01-1G-9::dhcp root=/dev/ram0 user=lkp job=/lkp/scheduled/vm-lkp-hsw01-1G-9/trinity-300s-debian-x86_64-2016-08-31.cgz-60cc43fc888428bb2f18f08997432d426a243338-20180417-90038-7ko8tn-0.yaml ARCH=x86_64 kconfig=x86_64-randconfig-s5-04172210 branch=linus/master commit=60cc43fc888428bb2f18f08997432d426a243338 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-s5-04172210/gcc-7/60cc43fc888428bb2f18f08997432d426a243338/vmlinuz-4.17.0-rc1 max_uptime=1500 RESULT_ROOT=/result/trinity/300s/vm-lkp-hsw01-1G/debian-x86_64-2016-08-31.cgz/x86_64-randconfig-s5-04172210/gcc-7/60cc43fc888428bb2f18f08997432d426a243338/2 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=normal rw rcuperf.shutdow [ 0.000000] sysrq: sysrq always enabled. [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes) [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes) [ 0.000000] Memory: 618360K/1048056K available (57352K kernel code, 10754K rwdata, 11624K rodata, 3664K init, 20388K bss, 429696K reserved, 0K cma-reserved) [ 0.003333] Hierarchical RCU implementation. [ 0.003333] RCU dyntick-idle grace-period acceleration is enabled. [ 0.003333] RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=2. [ 0.003333] RCU CPU stall warnings timeout set to 100 (rcu_cpu_stall_timeout). [ 0.003333] Tasks RCU enabled. [ 0.003333] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 [ 0.003333] NR_IRQS: 4352, nr_irqs: 56, preallocated irqs: 16 [ 0.003333] Offload RCU callbacks from CPUs: (none). [ 0.003333] Console: colour VGA+ 80x25 [ 0.003333] console [tty0] enabled [ 0.003333] console [ttyS0] enabled [ 0.003333] bootconsole [earlyser0] disabled [ 0.003333] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.003333] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.003333] ... MAX_LOCK_DEPTH: 48 [ 0.003333] ... MAX_LOCKDEP_KEYS: 8191 [ 0.003333] ... CLASSHASH_SIZE: 4096 [ 0.003333] ... MAX_LOCKDEP_ENTRIES: 32768 [ 0.003333] ... MAX_LOCKDEP_CHAINS: 65536 [ 0.003333] ... CHAINHASH_SIZE: 32768 [ 0.003333] memory used by lock dependency info: 7871 kB [ 0.003333] per task-struct memory footprint: 2688 bytes [ 0.003333] ------------------------ [ 0.003333] | Locking API testsuite: [ 0.003333] ---------------------------------------------------------------------------- [ 0.003333] | spin |wlock |rlock |mutex | wsem | rsem | [ 0.003333] -------------------------------------------------------------------------- [ 0.003333] A-A deadlock:failed|failed| ok |failed|failed|failed|failed| [ 0.003333] A-B-B-A deadlock:failed|failed| ok |failed|failed|failed|failed| [ 0.003333] A-B-B-C-C-A deadlock:failed|failed| ok |failed|failed|failed|failed| [ 0.003333] A-B-C-A-B-C deadlock:failed|failed| ok |failed|failed|failed|failed| [ 0.003333] A-B-B-C-C-D-D-A deadlock:failed|failed| ok |failed|failed|failed|failed| [ 0.003333] A-B-C-D-B-D-D-A deadlock:failed|failed| ok |failed|failed|failed|failed| [ 0.003333] A-B-C-D-B-C-D-A deadlock:failed|failed| ok |failed|failed|failed|failed| [ 0.003333] double unlock: ok | ok | ok | ok | ok | ok | ok | [ 0.003333] initialize held: ok | ok | ok | ok | ok | ok | ok | [ 0.003333] -------------------------------------------------------------------------- [ 0.003333] recursive read-lock: | ok | |failed| [ 0.003333] recursive read-lock #2: | ok | |failed| [ 0.003333] mixed read-write-lock: |failed| |failed| [ 0.003333] mixed write-read-lock: |failed| |failed| [ 0.003333] mixed read-lock/lock-write ABBA: |failed| |failed| [ 0.003333] mixed read-lock/lock-read ABBA: | ok | |failed| [ 0.003333] mixed write-lock/lock-write ABBA: |failed| |failed| [ 0.003333] -------------------------------------------------------------------------- [ 0.003333] hard-irqs-on + irq-safe-A/12:failed|failed| ok | [ 0.003333] soft-irqs-on + irq-safe-A/12:failed|failed| ok | [ 0.003333] hard-irqs-on + irq-safe-A/21:failed|failed| ok | [ 0.003333] soft-irqs-on + irq-safe-A/21:failed|failed| ok | [ 0.003333] sirq-safe-A => hirqs-on/12:failed|failed| ok | [ 0.003333] sirq-safe-A => hirqs-on/21:failed|failed| ok | [ 0.003333] hard-safe-A + irqs-on/12:failed|failed| ok | [ 0.003333] soft-safe-A + irqs-on/12:failed|failed| ok | [ 0.003333] hard-safe-A + irqs-on/21:failed|failed| ok | [ 0.003333] soft-safe-A + irqs-on/21:failed|failed| ok | [ 0.003333] hard-safe-A + unsafe-B #1/123:failed|failed| ok | [ 0.003333] soft-safe-A + unsafe-B #1/123:failed|failed| ok | [ 0.003333] hard-safe-A + unsafe-B #1/132:failed|failed| ok | [ 0.003333] soft-safe-A + unsafe-B #1/132:failed|failed| ok | [ 0.003333] hard-safe-A + unsafe-B #1/213:failed|failed| ok | [ 0.003333] soft-safe-A + unsafe-B #1/213:failed|failed| ok | [ 0.003333] hard-safe-A + unsafe-B #1/231:failed|failed| ok | [ 0.003333] soft-safe-A + unsafe-B #1/231:failed|failed| ok | [ 0.003333] hard-safe-A + unsafe-B #1/312:failed|failed| ok | [ 0.003333] soft-safe-A + unsafe-B #1/312:failed|failed| ok | [ 0.003333] hard-safe-A + unsafe-B #1/321:failed|failed| ok | [ 0.003333] soft-safe-A + unsafe-B #1/321:failed|failed| ok | [ 0.003333] hard-safe-A + unsafe-B #2/123:failed|failed| ok | [ 0.003333] soft-safe-A + unsafe-B #2/123:failed|failed| ok | [ 0.003333] hard-safe-A + unsafe-B #2/132:failed|failed| ok | [ 0.003333] soft-safe-A + unsafe-B #2/132:failed|failed| ok | [ 0.003333] hard-safe-A + unsafe-B #2/213:failed|failed| ok | [ 0.003333] soft-safe-A + unsafe-B #2/213:failed|failed| ok | [ 0.003333] hard-safe-A + unsafe-B #2/231:failed|failed| ok | [ 0.003333] soft-safe-A + unsafe-B #2/231:failed|failed| ok | [ 0.003333] hard-safe-A + unsafe-B #2/312:failed|failed| ok | [ 0.003333] soft-safe-A + unsafe-B #2/312:failed|failed| ok | [ 0.003333] hard-safe-A + unsafe-B #2/321:failed|failed| ok | [ 0.003333] soft-safe-A + unsafe-B #2/321:failed|failed| ok | [ 0.003333] hard-irq lock-inversion/123:failed|failed| ok | [ 0.003333] soft-irq lock-inversion/123:failed|failed| ok | [ 0.003333] hard-irq lock-inversion/132:failed|failed| ok | [ 0.003333] soft-irq lock-inversion/132:failed|failed| ok | [ 0.003333] hard-irq lock-inversion/213:failed|failed| ok | [ 0.003333] soft-irq lock-inversion/213:failed|failed| ok | [ 0.003333] hard-irq lock-inversion/231:failed|failed| ok | [ 0.003333] soft-irq lock-inversion/231:failed|failed| ok | [ 0.003333] hard-irq lock-inversion/312:failed|failed| ok | [ 0.003333] soft-irq lock-inversion/312:failed|failed| ok | [ 0.003333] hard-irq lock-inversion/321:failed|failed| ok | [ 0.003333] soft-irq lock-inversion/321:failed|failed| ok | [ 0.003333] hard-irq read-recursion/123: ok | [ 0.003333] soft-irq read-recursion/123: ok | [ 0.003333] hard-irq read-recursion/132: ok | [ 0.003333] soft-irq read-recursion/132: ok | [ 0.003333] hard-irq read-recursion/213: ok | [ 0.003333] soft-irq read-recursion/213: ok | [ 0.003333] hard-irq read-recursion/231: ok | [ 0.003333] soft-irq read-recursion/231: ok | [ 0.003333] hard-irq read-recursion/312: ok | [ 0.003333] soft-irq read-recursion/312: ok | [ 0.003333] hard-irq read-recursion/321: ok | [ 0.003333] soft-irq read-recursion/321: ok | [ 0.003333] -------------------------------------------------------------------------- [ 0.003333] | Wound/wait tests | [ 0.003333] --------------------- [ 0.003333] ww api failures: ok | ok | ok | [ 0.003333] ww contexts mixing:failed| ok | [ 0.003333] finishing ww context: ok | ok | ok | ok | [ 0.003333] locking mismatches: ok | ok | ok | [ 0.003333] EDEADLK handling: ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | [ 0.003333] spinlock nest unlocked: ok | [ 0.003333] ----------------------------------------------------- [ 0.003333] |block | try |context| [ 0.003333] ----------------------------------------------------- [ 0.003333] context:failed| ok | ok | [ 0.003333] try:failed| ok |failed| [ 0.003333] block:failed| ok |failed| [ 0.003333] spinlock:failed| ok |failed| [ 0.003333] -------------------------------------------------------- [ 0.003333] 153 out of 262 testcases failed, as expected. | [ 0.003333] ---------------------------------------------------- [ 0.003333] ACPI: Core revision 20180313 [ 0.003333] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.003333] hpet clockevent registered [ 0.003367] APIC: Switch to symmetric I/O mode setup [ 0.004267] enabled ExtINT on CPU#0 [ 0.006684] ENABLING IO-APIC IRQs [ 0.007407] init IO_APIC IRQs [ 0.008037] apic 0 pin 0 not connected [ 0.008840] IOAPIC[0]: Set routing entry (0-1 -> 0xef -> IRQ 1 Mode:0 Active:0 Dest:1) [ 0.010076] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1) [ 0.011543] IOAPIC[0]: Set routing entry (0-3 -> 0xef -> IRQ 3 Mode:0 Active:0 Dest:1) [ 0.013043] IOAPIC[0]: Set routing entry (0-4 -> 0xef -> IRQ 4 Mode:0 Active:0 Dest:1) [ 0.013333] IOAPIC[0]: Set routing entry (0-5 -> 0xef -> IRQ 5 Mode:1 Active:0 Dest:1) [ 0.013333] IOAPIC[0]: Set routing entry (0-6 -> 0xef -> IRQ 6 Mode:0 Active:0 Dest:1) [ 0.013333] IOAPIC[0]: Set routing entry (0-7 -> 0xef -> IRQ 7 Mode:0 Active:0 Dest:1) [ 0.013333] IOAPIC[0]: Set routing entry (0-8 -> 0xef -> IRQ 8 Mode:0 Active:0 Dest:1) [ 0.013333] IOAPIC[0]: Set routing entry (0-9 -> 0xef -> IRQ 9 Mode:1 Active:0 Dest:1) [ 0.013333] IOAPIC[0]: Set routing entry (0-10 -> 0xef -> IRQ 10 Mode:1 Active:0 Dest:1) [ 0.013333] IOAPIC[0]: Set routing entry (0-11 -> 0xef -> IRQ 11 Mode:1 Active:0 Dest:1) [ 0.013333] IOAPIC[0]: Set routing entry (0-12 -> 0xef -> IRQ 12 Mode:0 Active:0 Dest:1) [ 0.013333] IOAPIC[0]: Set routing entry (0-13 -> 0xef -> IRQ 13 Mode:0 Active:0 Dest:1) [ 0.013333] IOAPIC[0]: Set routing entry (0-14 -> 0xef -> IRQ 14 Mode:0 Active:0 Dest:1) [ 0.013333] IOAPIC[0]: Set routing entry (0-15 -> 0xef -> IRQ 15 Mode:0 Active:0 Dest:1) [ 0.013333] apic 0 pin 16 not connected [ 0.013333] apic 0 pin 17 not connected [ 0.013333] apic 0 pin 18 not connected [ 0.013333] apic 0 pin 19 not connected [ 0.013333] apic 0 pin 20 not connected [ 0.013333] apic 0 pin 21 not connected [ 0.013333] apic 0 pin 22 not connected [ 0.013333] apic 0 pin 23 not connected [ 0.013333] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.013333] tsc: Detected 2593.992 MHz processor [ 0.013333] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x25641074d3b, max_idle_ns: 440795244898 ns [ 0.013359] Calibrating delay loop (skipped) preset value.. 5190.15 BogoMIPS (lpj=8646640) [ 0.016678] pid_max: default: 32768 minimum: 301 [ 0.018474] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes) [ 0.019859] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes) [ 0.024938] CPU: Physical Processor ID: 0 [ 0.030018] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.031174] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.032510] Spectre V2 : Spectre mitigation: kernel not compiled with retpoline; no mitigation available! [ 0.032689] debug: unmapping init [mem 0xffffffff86cd4000-0xffffffff86cdffff] [ 0.038337] TSC deadline timer enabled [ 0.039522] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2697 v3 @ 2.60GHz (family: 0x6, model: 0x3f, stepping: 0x2) [ 0.039999] Performance Events: Haswell events, Intel PMU driver. [ 0.041136] ... version: 2 [ 0.041941] ... bit width: 48 [ 0.042751] ... generic registers: 4 [ 0.043343] ... value mask: 0000ffffffffffff [ 0.044308] ... max period: 000000007fffffff [ 0.045271] ... fixed-purpose events: 3 [ 0.046067] ... event mask: 000000070000000f [ 0.046954] Hierarchical SRCU implementation. [ 0.052556] smp: Bringing up secondary CPUs ... [ 0.054680] x86: Booting SMP configuration: [ 0.055513] .... node #0, CPUs: #1 [ 0.003333] kvm-clock: cpu 1, msr 0:37244041, secondary cpu clock [ 0.003333] masked ExtINT on CPU#1 [ 0.060135] KVM setup async PF for cpu 1 [ 0.060855] kvm-stealtime: cpu 1, msr 2d1ec040 [ 0.061738] smp: Brought up 1 node, 2 CPUs [ 0.061738] smpboot: Max logical packages: 2 [ 0.061738] ---------------- [ 0.063356] | NMI testsuite: [ 0.064249] -------------------- [ 0.065220] remote IPI: ok | [ 0.066274] local IPI: ok | [ 0.066699] -------------------- [ 0.067658] Good, all 2 testcases passed! | [ 0.068774] --------------------------------- [ 0.069710] smpboot: Total of 2 processors activated (10380.30 BogoMIPS) [ 0.071112] devtmpfs: initialized [ 0.071393] x86/mm: Memory block size: 128MB [ 0.082630] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 6370867519511994 ns [ 0.083356] futex hash table entries: 512 (order: 4, 65536 bytes) [ 0.084515] xor: automatically using best checksumming function avx [ 0.085542] prandom: seed boundary self test passed [ 0.087459] prandom: 100 self tests passed [ 0.089680] regulator-dummy: no parameters [ 0.091812] NET: Registered protocol family 16 [ 0.096091] workqueue: round-robin CPU selection forced, expect performance impact [ 0.096821] cpuidle: using governor menu [ 0.098499] ACPI: bus type PCI registered [ 0.100356] PCI: Using configuration type 1 for base access [ 0.102404] core: PMU erratum BJ122, BV98, HSD29 workaround disabled, HT off [ 0.140522] HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages [ 0.141985] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 0.144255] cryptd: max_cpu_qlen set to 1000 [ 0.200015] raid6: sse2x1 gen() 5655 MB/s [ 0.256680] raid6: sse2x1 xor() 5595 MB/s [ 0.313351] raid6: sse2x2 gen() 7008 MB/s [ 0.370019] raid6: sse2x2 xor() 4144 MB/s [ 0.426683] raid6: sse2x4 gen() 7416 MB/s [ 0.483351] raid6: sse2x4 xor() 4965 MB/s [ 0.540023] raid6: avx2x1 gen() 10190 MB/s [ 0.596685] raid6: avx2x1 xor() 6367 MB/s [ 0.653352] raid6: avx2x2 gen() 12813 MB/s [ 0.710015] raid6: avx2x2 xor() 8274 MB/s [ 0.766684] raid6: avx2x4 gen() 16068 MB/s [ 0.823350] raid6: avx2x4 xor() 9102 MB/s [ 0.824633] raid6: using algorithm avx2x4 gen() 16068 MB/s [ 0.826036] raid6: .... xor() 9102 MB/s, rmw enabled [ 0.826682] raid6: using avx2x2 recovery algorithm [ 0.828853] gpio-f7188x: Not a Fintek device at 0x0000002e [ 0.830105] gpio-f7188x: Not a Fintek device at 0x0000004e [ 0.833211] ACPI: Added _OSI(Module Device) [ 0.833345] ACPI: Added _OSI(Processor Device) [ 0.834537] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.835716] ACPI: Added _OSI(Processor Aggregator Device) [ 0.836706] ACPI: Added _OSI(Linux-Dell-Video) [ 0.869431] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.882611] ACPI: Interpreter enabled [ 0.890239] ACPI: (supports S0 S3 S5) [ 0.891377] ACPI: Using IOAPIC for interrupt routing [ 0.892937] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 0.896651] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.974498] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.975933] acpi PNP0A03:00: _OSC: OS supports [Segments] [ 0.980198] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM [ 0.981652] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.983960] PCI host bridge to bus 0000:00 [ 0.984675] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.985610] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.986558] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.986696] pci_bus 0000:00: root bus resource [mem 0x40000000-0xfebfffff window] [ 0.988610] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.989967] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.993255] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.998840] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 1.003136] pci 0000:00:01.1: reg 0x20: [io 0xc040-0xc04f] [ 1.004924] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 1.006401] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 1.006677] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 1.007642] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 1.010722] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 1.012076] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 1.013361] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 1.018285] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 [ 1.021235] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref] [ 1.030036] pci 0000:00:02.0: reg 0x18: [mem 0xfebf0000-0xfebf0fff] [ 1.038296] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref] [ 1.043640] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000 [ 1.046263] pci 0000:00:03.0: reg 0x10: [mem 0xfebc0000-0xfebdffff] [ 1.047806] pci 0000:00:03.0: reg 0x14: [io 0xc000-0xc03f] [ 1.055107] pci 0000:00:03.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 1.060304] pci 0000:00:04.0: [8086:25ab] type 00 class 0x088000 [ 1.062823] pci 0000:00:04.0: reg 0x10: [mem 0xfebf1000-0xfebf100f] [ 1.069474] pci_bus 0000:00: on NUMA node 0 [ 1.078770] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) [ 1.083284] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) [ 1.083333] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) [ 1.083333] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) [ 1.083333] ACPI: PCI Interrupt Link [LNKS] (IRQs *9) [ 1.096683] pci 0000:00:02.0: vgaarb: setting as boot VGA device [ 1.096683] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none [ 1.100017] pci 0000:00:02.0: vgaarb: bridge control possible [ 1.101267] vgaarb: loaded [ 1.106315] SCSI subsystem initialized [ 1.107828] pps_core: LinuxPPS API ver. 1 registered [ 1.108997] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 1.114804] FPGA manager framework [ 1.116967] PCI: Using ACPI for IRQ routing [ 1.117644] PCI: pci_cache_line_size set to 64 bytes [ 1.118486] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] [ 1.120010] e820: reserve RAM buffer [mem 0x3ffe0000-0x3fffffff] [ 1.121104] Bluetooth: Core ver 2.22 [ 1.121804] NET: Registered protocol family 31 [ 1.122499] Bluetooth: HCI device and connection manager initialized [ 1.123368] Bluetooth: HCI socket layer initialized [ 1.124117] Bluetooth: L2CAP socket layer initialized [ 1.124945] NET: Registered protocol family 8 [ 1.125630] NET: Registered protocol family 20 [ 1.126886] nfc: nfc_init: NFC Core ver 0.1 [ 1.127690] NET: Registered protocol family 39 [ 1.128730] dcdbas dcdbas: Dell Systems Management Base Driver (version 5.6.0-3.2) [ 1.130515] clocksource: Switched to clocksource kvm-clock [ 1.131853] VFS: Disk quotas dquot_6.6.0 [ 1.132602] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 1.133684] pnp: PnP ACPI init [ 1.134796] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active) [ 1.136597] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active) [ 1.138800] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active) [ 1.140412] pnp 00:03: [dma 2] [ 1.149395] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active) [ 1.151582] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active) [ 1.153683] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active) [ 1.155778] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active) [ 1.161539] pnp: PnP ACPI: found 7 devices [ 1.192253] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 1.194877] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 1.196367] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 1.197857] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 1.199439] pci_bus 0000:00: resource 7 [mem 0x40000000-0xfebfffff window] [ 1.202314] NET: Registered protocol family 2 [ 1.205219] tcp_listen_portaddr_hash hash table entries: 512 (order: 3, 45056 bytes) [ 1.207967] TCP established hash table entries: 8192 (order: 4, 65536 bytes) [ 1.209788] TCP bind hash table entries: 8192 (order: 7, 655360 bytes) [ 1.212273] TCP: Hash tables configured (established 8192 bind 8192) [ 1.214152] UDP hash table entries: 512 (order: 4, 98304 bytes) [ 1.215735] UDP-Lite hash table entries: 512 (order: 4, 98304 bytes) [ 1.223324] NET: Registered protocol family 1 [ 1.224642] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 1.226072] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 1.227526] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 1.229089] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] [ 1.231395] PCI: CLS 0 bytes, default 64 [ 1.233325] Unpacking initramfs... [ 8.746828] debug: unmapping init [mem 0xffff880037246000-0xffff88003ffdffff] [ 8.762311] Scanning for low memory corruption every 60 seconds [ 8.771122] cryptomgr_test (35) used greatest stack depth: 30552 bytes left [ 8.777954] cryptomgr_test (53) used greatest stack depth: 30384 bytes left [ 8.796108] spin_lock-torture:--- Start of test [debug]: nwriters_stress=4 nreaders_stress=0 stat_interval=60 verbose=1 shuffle_interval=3 stutter=5 shutdown_secs=0 onoff_interval=0 onoff_holdoff=0 [ 8.799940] spin_lock-torture: Creating torture_shuffle task [ 8.801896] spin_lock-torture: torture_shuffle task started [ 8.802394] spin_lock-torture: Creating torture_stutter task [ 8.805296] spin_lock-torture: Creating lock_torture_writer task [ 8.806779] spin_lock-torture: torture_stutter task started [ 8.808708] spin_lock-torture: Creating lock_torture_writer task [ 8.810094] spin_lock-torture: lock_torture_writer task started [ 8.810189] spin_lock-torture: Creating lock_torture_writer task [ 8.811431] spin_lock-torture: lock_torture_writer task started [ 8.812804] spin_lock-torture: Creating lock_torture_writer task [ 8.813964] spin_lock-torture: lock_torture_writer task started [ 8.817693] spin_lock-torture: Creating lock_torture_stats task [ 8.817700] spin_lock-torture: lock_torture_writer task started [ 8.819913] torture_init_begin: Refusing rcu init: spin_lock running. [ 8.821831] torture_init_begin: One torture test at a time! [ 8.826935] Initialise system trusted keyrings [ 8.828211] Key type blacklist registered [ 8.842403] spin_lock-torture: lock_torture_stats task started [ 8.844873] workingset: timestamp_bits=62 max_order=18 bucket_order=0 [ 8.850202] zbud: loaded [ 8.858328] DLM installed [ 8.860156] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ 8.862891] ntfs: driver 2.1.32 [Flags: R/W]. [ 8.864305] efs: 1.0a - http://aeschi.ch.eu.org/efs/ [ 8.865590] romfs: ROMFS MTD (C) 2007 Red Hat, Inc. [ 8.866952] QNX4 filesystem 0.2.3 registered. [ 8.868194] qnx6: QNX6 filesystem 1.0.0 registered. [ 8.877244] JFS: nTxBlock = 4830, nTxLock = 38647 [ 8.894916] SGI XFS with security attributes, scrub, debug enabled [ 8.899071] NILFS version 2 loaded [ 8.900099] befs: version: 0.9.3 [ 8.914318] ocfs2: Registered cluster interface user [ 8.916268] OCFS2 User DLM kernel interface loaded [ 8.921879] gfs2: GFS2 installed [ 8.923765] pstore: using 842 compression [ 8.976330] NET: Registered protocol family 38 [ 8.977976] Key type asymmetric registered [ 8.979370] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248) [ 8.983774] io scheduler noop registered [ 8.984893] io scheduler deadline registered (default) [ 8.986337] io scheduler cfq registered [ 8.987423] io scheduler mq-deadline registered (default) [ 8.989026] io scheduler kyber registered [ 8.990290] io scheduler bfq registered [ 9.315024] String selftests succeeded [ 9.325229] crc32: CRC_LE_BITS = 1, CRC_BE BITS = 1 [ 9.326491] crc32: self tests passed, processed 225944 bytes in 3552547 nsec [ 9.332192] crc32c: CRC_LE_BITS = 1 [ 9.333208] crc32c: self tests passed, processed 225944 bytes in 1999230 nsec [ 9.520513] crc32_combine: 8373 self tests passed [ 9.714192] crc32c_combine: 8373 self tests passed [ 9.715811] xz_dec_test: module loaded [ 9.716479] xz_dec_test: Create a device node with 'mknod xz_dec_test c 247 0' and write .xz files to it. [ 9.719880] gpio_it87: no device [ 9.721797] gpio_winbond: chip ID at 2e is ffff [ 9.723009] gpio_winbond: not an our chip [ 9.724226] gpio_winbond: chip ID at 4e is ffff [ 9.725443] gpio_winbond: not an our chip [ 9.732743] hgafb: HGA card not detected. [ 9.734270] hgafb: probe of hgafb.0 failed with error -22 [ 9.737461] ipmi message handler version 39.2 [ 9.738627] IPMI System Interface driver. [ 9.740215] ipmi_si: Unable to find any System Interface(s) [ 9.741599] Copyright (C) 2004 MontaVista Software - IPMI Powerdown via sys_reboot. [ 9.744786] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 9.752430] ACPI: Power Button [PWRF] [ 9.754015] Warning: Processor Platform Limit event detected, but not handled. [ 9.756152] Consider compiling CPUfreq support into your kernel. [ 9.761826] tsc: Refined TSC clocksource calibration: 2593.993 MHz [ 9.763256] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x256411d258c, max_idle_ns: 440795337342 ns [ 10.056593] r3964: Philips r3964 Driver $Revision: 1.10 $ [ 10.057910] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled [ 10.085122] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 10.110302] 00:06: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 10.120034] lp: driver loaded but no devices found [ 10.122752] smapi::smapi_init, ERROR invalid usSmapiID [ 10.123709] mwave: tp3780i::tp3780I_InitializeBoardData: Error: SMAPI is not available on this machine [ 10.125091] mwave: mwavedd::mwave_init: Error: Failed to initialize board data [ 10.126324] mwave: mwavedd::mwave_init: Error: Failed to initialize [ 10.127219] Hangcheck: starting hangcheck timer 0.9.1 (tick is 180 seconds, margin is 60 seconds). [ 10.128642] drm_mm: Testing DRM range manger (struct drm_mm), with random_seed=0x11bab461 max_iterations=8192 max_prime=128 [ 10.130290] drm_mm: igt_sanitycheck - ok! [ 10.130977] igt_debug 0x0000000000000000-0x0000000000000200: 512: free [ 10.131867] igt_debug 0x0000000000000200-0x0000000000000600: 1024: used [ 10.132759] igt_debug 0x0000000000000600-0x0000000000000a00: 1024: free [ 10.133690] igt_debug 0x0000000000000a00-0x0000000000000e00: 1024: used [ 10.134603] igt_debug 0x0000000000000e00-0x0000000000001000: 512: free [ 10.135488] igt_debug total: 4096, used 2048 free 2048 [ 69.609239] Writes: Total: 9149708 Max/Min: 0/0 Fail: 0 [ 72.281726] [drm] Initialized vgem 1.0.0 20120112 for virtual device on minor 0 [ 72.284902] parport_pc 00:04: reported by Plug and Play ACPI [ 72.286011] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] [ 72.287450] lp0: using parport0 (interrupt-driven). [ 72.288194] lp0: console ready [ 72.292622] dummy-irq: no IRQ given. Use irq=N [ 72.297572] nfcsim 0.2 initialized [ 72.298861] Uniform Multi-Platform E-IDE driver [ 72.301032] ide_generic: please use "probe_mask=0x3f" module parameter for probing all legacy ISA IDE ports [ 72.303581] ide-gd driver 1.18 [ 72.305159] Loading iSCSI transport class v2.0-870. [ 72.308011] rdac: device handler registered [ 72.310066] hp_sw: device handler registered [ 72.313403] alua: device handler registered [ 72.314446] st: Version 20160209, fixed bufsize 32768, s/g segs 256 [ 72.316151] SCSI Media Changer driver v0.25 [ 72.317730] osd: LOADED open-osd 0.2.1 [ 72.326628] Rounding down aligned max_sectors from 4294967295 to 4294967288 [ 72.334571] SSFDC read-only Flash Translation layer [ 72.336026] mtdoops: mtd device (mtddev=name/number) must be supplied [ 72.337427] L440GX flash mapping: failed to find PIIX4 ISA bridge, cannot continue [ 72.338815] platform physmap-flash.0: failed to claim resource 0: [mem 0x08000000-0x07ffffff] [ 72.340649] slram: not enough parameters. [ 72.341570] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0 [ 72.342965] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0 [ 72.344406] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0 [ 72.345826] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0 [ 72.347218] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0 [ 72.348636] [nandsim] warning: read_byte: unexpected data output cycle, state is STATE_READY return 0x0 [ 72.350065] nand: device found, Manufacturer ID: 0x98, Chip ID: 0x39 [ 72.350965] nand: Toshiba NAND 128MiB 1,8V 8-bit [ 72.351678] nand: 128 MiB, SLC, erase size: 16 KiB, page size: 512, OOB size: 16 [ 72.352912] flash size: 128 MiB [ 72.353508] page size: 512 bytes [ 72.359073] OOB area size: 16 bytes [ 72.359727] sector size: 16 KiB [ 72.360320] pages number: 262144 [ 72.360910] pages per sector: 32 [ 72.361494] bus width: 8 [ 72.362007] bits in sector size: 14 [ 72.362614] bits in page size: 9 [ 72.363189] bits in OOB size: 4 [ 72.363812] flash size with OOB: 135168 KiB [ 72.364496] page address bytes: 4 [ 72.365081] sector address bytes: 3 [ 72.365686] options: 0x42 [ 72.367992] Scanning device for bad blocks [ 72.410631] Creating 1 MTD partitions on "NAND 128MiB 1,8V 8-bit": [ 72.411909] 0x000000000000-0x000008000000 : "NAND simulator partition 0" [ 72.426144] ftl_cs: FTL header not found. [ 72.428949] [nandsim] warning: CONFIG_MTD_PARTITIONED_MASTER must be enabled to expose debugfs stuff [ 72.552874] parport0: AVR Butterfly [ 72.553943] parport0: cannot grant exclusive access for device spi-lm70llp [ 72.554943] spi_lm70llp: spi_lm70llp probe fail, status -12 [ 72.556029] Ethernet Channel Bonding Driver: v3.7.1 (April 27, 2011) [ 72.575937] eql: Equalizer2002: Simon Janes (simon@ncm.com) and David S. Miller (davem@redhat.com) [ 72.579481] MACsec IEEE 802.1AE [ 72.584349] mdio_bus fixed-0: GPIO lookup for consumer reset [ 72.585186] mdio_bus fixed-0: using lookup tables for GPIO lookup [ 72.586048] mdio_bus fixed-0: No GPIO consumer reset found [ 72.586935] libphy: Fixed MDIO Bus: probed [ 72.590695] vcan: Virtual CAN interface driver [ 72.591440] CAN device driver interface [ 72.593056] e1000: Intel(R) PRO/1000 Network Driver - version 7.3.21-k8-NAPI [ 72.594038] e1000: Copyright (c) 1999-2006 Intel Corporation. [ 74.422442] PCI Interrupt Link [LNKC] enabled at IRQ 11 [ 74.797926] e1000 0000:00:03.0 eth0: (PCI:33MHz:32-bit) 52:54:00:12:34:56 [ 74.799369] e1000 0000:00:03.0 eth0: Intel(R) PRO/1000 Network Connection [ 74.800982] e1000e: Intel(R) PRO/1000 Network Driver - 3.2.6-k [ 74.802260] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. [ 74.803716] igb: Intel(R) Gigabit Ethernet Network Driver - version 5.4.0-k [ 74.805148] igb: Copyright (c) 2007-2014 Intel Corporation. [ 74.806528] ixgbe: Intel(R) 10 Gigabit PCI Express Network Driver - version 5.1.0-k [ 74.808458] ixgbe: Copyright (c) 1999-2016 Intel Corporation. [ 74.811341] atp.c:v1.09=ac 2002/10/01 Donald Becker [ 74.815257] NET3 PLIP version 2.4-parport gniibe@mri.co.jp [ 74.816506] plip0: Parallel port at 0x378, using IRQ 7. [ 74.817718] PPP generic driver version 2.4.2 [ 74.820313] PPP BSD Compression module registered [ 74.821518] PPP MPPE Compression module registered [ 74.822658] NET: Registered protocol family 24 [ 74.823799] SLIP: version 0.8.4-NET3.019-NEWTTY (dynamic channels, max=256). [ 74.825238] CSLIP: code copyright 1989 Regents of the University of California. [ 74.827128] SLIP linefill/keepalive option. [ 74.828193] hdlc: HDLC support module revision 1.22 [ 74.829356] LAPB Ethernet driver version 0.02 [ 74.831458] panel: could not claim access to parport0. Aborting. [ 74.833012] panel: panel driver not yet registered [ 74.834552] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 74.838140] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 74.839381] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 74.840895] parport0: cannot grant exclusive access for device parkbd [ 74.905063] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 [ 74.905330] i2c-parport: adapter type unspecified [ 74.911023] serial_ir serial_ir.0: port 03f8 already in use [ 74.912277] serial_ir serial_ir.0: use 'setserial /dev/ttySX uart none' [ 74.913703] serial_ir serial_ir.0: or compile the serial port driver as module and [ 74.915612] serial_ir serial_ir.0: make sure this module is loaded first [ 74.917119] serial_ir: probe of serial_ir.0 failed with error -16 [ 74.919222] sir_ir: port existence test failed, cannot continue [ 74.920675] pps_ldisc: PPS line discipline registered [ 74.921948] Driver for 1-wire Dallas network protocol. [ 74.923478] DS1WM w1 busmaster driver - (c) 2004 Szabolcs Gyurko [ 74.928272] applesmc: supported laptop not found! [ 74.929408] applesmc: driver init failed (ret=-19)! [ 74.935962] pc87360: PC8736x not detected, module not inserted [ 74.939416] Bluetooth: HCI UART driver ver 2.3 [ 74.940566] Bluetooth: HCI UART protocol H4 registered [ 74.941752] Bluetooth: HCI UART protocol BCSP registered [ 74.942954] Bluetooth: HCI UART protocol Three-wire (H5) registered [ 74.944295] Bluetooth: HCI UART protocol QCA registered [ 74.945492] Bluetooth: Generic Bluetooth SDIO driver ver 0.1 [ 74.968108] ISDN subsystem Rev: 1.1.2.3/ [ 74.968113] 1.1.2.2/ [ 74.969156] 1.1.2.3/ [ 74.969931] none/ [ 74.970731] 1.1.2.2 [ 74.971472] [ 74.972973] PPP BSD Compression module registered [ 74.974115] Modular ISDN core version 1.1.29 [ 74.978309] NET: Registered protocol family 34 [ 74.979462] dss1_divert module successfully installed [ 74.980676] gigaset: Driver for Gigaset 307x (debug build) [ 74.981909] gigaset: ISDN4Linux interface [ 74.983572] sdhci: Secure Digital Host Controller Interface driver [ 74.984915] sdhci: Copyright(c) Pierre Ossman [ 74.986263] sdhci-pltfm: SDHCI platform and OF driver helper [ 74.988388] No PC Engines board detected [ 74.992700] ledtrig-cpu: registered to indicate activity on CPUs [ 74.995142] OPA Virtual Network Driver - v1.0 [ 75.000950] hidraw: raw HID events driver (C) Jiri Kosina [ 75.008021] NET: Registered protocol family 4 [ 75.009449] comedi: version 0.7.76 - http://www.comedi.org [ 75.012618] FPGA DOWNLOAD ---> [ 75.013512] FPGA image file name: xlinx_fpga_firmware.bit [ 75.015163] GPIO INIT FAIL!! [ 75.037234] fake-fmc-carrier: mezzanine 0 [ 75.038329] Manufacturer: fake-vendor [ 75.039408] Product name: fake-design-for-testing [ 75.040995] fmc fake-design-for-testing-f001: Driver has no ID: matches all [ 75.042509] fmc_trivial: probe of fake-design-for-testing-f001 failed with error -95 [ 75.044323] fmc fake-design-for-testing-f001: Driver has no ID: matches all [ 75.045644] fmc_chardev fake-design-for-testing-f001: Created misc device "fake-design-for-testing-f001" [ 75.061570] swapper/0: page allocation failure: order:9, mode:0x14040c0(GFP_KERNEL|__GFP_COMP), nodemask=(null) [ 75.063053] CPU: 1 PID: 1 Comm: swapper/0 Not tainted 4.17.0-rc1 #262 [ 75.063338] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014 [ 75.063338] Call Trace: [ 75.063338] dump_stack+0x71/0xab [ 75.063338] warn_alloc+0x180/0x280 [ 75.063338] ? zone_watermark_ok_safe+0x260/0x260 [ 75.063338] ? __zone_watermark_ok+0x260/0x260 [ 75.063338] ? _cond_resched+0x14/0x30 [ 75.063338] __alloc_pages_nodemask+0x1068/0x19a0 [ 75.063338] ? gfp_pfmemalloc_allowed+0x150/0x150 [ 75.063338] ? sched_clock_cpu+0x14f/0x180 [ 75.063338] cache_alloc_refill+0x27e/0x770 [ 75.063338] ? lock_acquire+0xd0/0x190 [ 75.063338] __kmalloc+0x14b/0x180 [ 75.063338] stm_register_device+0xf3/0x5c0 [ 75.063338] ? stp_policy_node_put+0x10/0x10 [ 75.063338] dummy_stm_init+0x175/0x2b0 [ 75.063338] ? intel_th_pti_lpp_init+0x37/0x37 [ 75.063338] ? dummy_stm_exit+0x80/0x80 [ 75.063338] do_one_initcall+0xd8/0x1e0 [ 75.063338] ? start_kernel+0x9c2/0x9c2 [ 75.063338] ? __wake_up_common+0x580/0x580 [ 75.063338] ? lock_downgrade+0x5e0/0x5e0 [ 75.063338] kernel_init_freeable+0x2b6/0x348 [ 75.063338] ? rest_init+0x170/0x170 [ 75.063338] kernel_init+0xa/0x110 [ 75.063338] ? rest_init+0x170/0x170 [ 75.063338] ret_from_fork+0x1f/0x30 [ 75.089849] Mem-Info: [ 75.090370] active_anon:0 inactive_anon:0 isolated_anon:0 [ 75.090370] active_file:0 inactive_file:0 isolated_file:0 [ 75.090370] unevictable:123532 dirty:0 writeback:0 unstable:0 [ 75.090370] slab_reclaimable:6653 slab_unreclaimable:10019 [ 75.090370] mapped:0 shmem:0 pagetables:0 bounce:0 [ 75.090370] free:10580 free_pcp:0 free_cma:0 [ 75.094750] Node 0 active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:494128kB isolated(anon):0kB isolated(file):0kB mapped:0kB dirty:0kB writeback:0kB shmem:0kB writeback_tmp:0kB unstable:0kB all_unreclaimable? no [ 75.097690] DMA free:12232kB min:80kB low:100kB high:120kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:1180kB writepending:0kB present:15992kB managed:15904kB mlocked:0kB kernel_stack:0kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [ 75.101009] lowmem_reserve[]: 0 588 588 588 [ 75.101700] DMA32 free:30088kB min:3060kB low:3824kB high:4588kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:492948kB writepending:0kB present:1032064kB managed:602456kB mlocked:0kB kernel_stack:2432kB pagetables:0kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [ 75.105101] lowmem_reserve[]: 0 0 0 0 [ 75.105734] DMA: 2*4kB (ME) 106*8kB (UM) 111*16kB (UM) 96*32kB (UM) 32*64kB (UM) 3*128kB (UME) 2*256kB (UM) 3*512kB (UME) 2*1024kB (ME) 0*2048kB 0*4096kB = 12232kB [ 75.107933] DMA32: 24*4kB (U) 20*8kB (UME) 55*16kB (UME) 176*32kB (UME) 234*64kB (UE) 54*128kB (U) 4*256kB (UE) 0*512kB 1*1024kB (U) 0*2048kB 0*4096kB = 30704kB [ 75.110042] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=1048576kB [ 75.111347] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB [ 75.117500] 123546 total pagecache pages [ 75.118150] 0 pages in swap cache [ 75.118738] Swap cache stats: add 0, delete 0, find 0/0 [ 75.119496] Free swap = 0kB [ 75.120059] Total swap = 0kB [ 75.120629] 262014 pages RAM [ 75.121182] 0 pages HighMem/MovableOnly [ 75.121900] 107424 pages reserved [ 75.126964] pktgen: Packet Generator for packet performance testing. Version: 2.75 [ 75.130659] IPVS: Registered protocols (SCTP, AH) [ 75.131511] IPVS: Connection hash table configured (size=4096, memory=64Kbytes) [ 75.132736] IPVS: Each connection entry needs 400 bytes at least [ 75.134500] IPVS: ipvs loaded. [ 75.135458] IPVS: [rr] scheduler registered. [ 75.136364] IPVS: [lc] scheduler registered. [ 75.137285] IPVS: [wlc] scheduler registered. [ 75.138312] IPVS: [fo] scheduler registered. [ 75.139423] IPVS: [lblc] scheduler registered. [ 75.140558] IPVS: [dh] scheduler registered. [ 75.141585] IPVS: [sh] scheduler registered. [ 75.142568] IPVS: [nq] scheduler registered. [ 75.143321] ipip: IPv4 and MPLS over IPv4 tunneling driver [ 75.145151] IPv4 over IPsec tunneling driver [ 75.147417] NET: Registered protocol family 10 [ 75.150264] Segment Routing with IPv6 [ 75.151509] mip6: Mobile IPv6 [ 75.153303] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver [ 75.155396] NET: Registered protocol family 15 [ 75.156455] NET: Registered protocol family 9 [ 75.157226] X25: Linux Version 0.2 [ 75.157845] can: controller area network core (rev 20170425 abi 9) [ 75.158842] NET: Registered protocol family 29 [ 75.159562] can: raw protocol (rev 20170425) [ 75.160314] can: broadcast manager protocol (rev 20170425 t) [ 75.161150] can: netlink gateway (rev 20170425) max_hops=1 [ 75.162496] cryptomgr_probe (250) used greatest stack depth: 29288 bytes left [ 75.163738] NET: Registered protocol family 33 [ 75.164867] Key type rxrpc registered [ 75.165884] Key type rxrpc_s registered [ 75.173464] NET: Registered protocol family 41 [ 75.174550] l2tp_core: L2TP core driver, V2.0 [ 75.175516] l2tp_ip: L2TP IP encapsulation support (L2TPv3) [ 75.176734] l2tp_netlink: L2TP netlink interface [ 75.177972] l2tp_eth: L2TP ethernet pseudowire support (L2TPv3) [ 75.179293] l2tp_ip6: L2TP IP encapsulation support for IPv6 (L2TPv3) [ 75.180798] NET4: DECnet for Linux: V.2.5.68s (C) 1995-2003 Linux DECnet Project Team [ 75.182486] DECnet: Routing cache hash table of 512 buckets, 40Kbytes [ 75.183511] NET: Registered protocol family 12 [ 75.184317] NET: Registered protocol family 35 [ 75.185130] 8021q: 802.1Q VLAN Support v1.8 [ 75.186834] DCCP: Activated CCID 2 (TCP-like) [ 75.187897] sctp: Hash tables configured (bind 32/51) [ 75.188890] tipc: Activated (version 2.0.0) [ 75.189926] NET: Registered protocol family 30 [ 75.191736] tipc: Started in single node mode [ 75.193054] NET: Registered protocol family 43 [ 75.194507] 9pnet: Installing 9P2000 support [ 75.195372] NET: Registered protocol family 36 [ 75.196109] Key type dns_resolver registered [ 75.196864] Key type ceph registered [ 75.197802] libceph: loaded (mon/osd proto 15/24) [ 75.199277] batman_adv: B.A.T.M.A.N. advanced 2018.1 (compatibility version 15) loaded [ 75.200637] mpls_gso: MPLS GSO support [ 75.201648] start plist test [ 75.205365] end plist test [ 75.207035] ... APIC ID: 00000000 (0) [ 75.207852] ... APIC VERSION: 01050014 [ 75.208500] 0000000000000000000000000000000000000000000000000000000000000000 [ 75.209472] 0000000000000000000000000000000000000000000000000000000000000000 [ 75.210054] 0000000000000000000000000000000000000000000000000000000000001000 [ 75.211461] number of MP IRQ sources: 15. [ 75.212531] number of IO-APIC #0 registers: 24. [ 75.213682] testing the IO APIC....................... [ 75.214975] IO APIC #0...... [ 75.215915] .... register #00: 00000000 [ 75.216973] ....... : physical APIC id: 00 [ 75.218136] ....... : Delivery Type: 0 [ 75.219247] ....... : LTS : 0 [ 75.220385] .... register #01: 00170011 [ 75.221473] ....... : max redirection entries: 17 [ 75.222752] ....... : PRQ implemented: 0 [ 75.223925] ....... : IO APIC version: 11 [ 75.225097] .... register #02: 00000000 [ 75.226194] ....... : arbitration: 00 [ 75.227337] .... IRQ redirection table: [ 75.228423] IOAPIC 0: [ 75.229288] pin00, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 75.231411] pin01, enabled , edge , high, V(22), IRR(0), S(0), logical , D(01), M(0) [ 75.233514] pin02, enabled , edge , high, V(30), IRR(0), S(0), logical , D(01), M(0) [ 75.235569] pin03, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 75.237633] pin04, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 75.239655] pin05, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 75.241700] pin06, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 75.243276] pin07, enabled , edge , high, V(21), IRR(0), S(0), logical , D(01), M(0) [ 75.244522] pin08, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 75.245757] pin09, enabled , level, high, V(21), IRR(0), S(0), logical , D(02), M(0) [ 75.246998] pin0a, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 75.248229] pin0b, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 75.249451] pin0c, enabled , edge , high, V(22), IRR(0), S(0), logical , D(02), M(0) [ 75.250695] pin0d, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 75.251923] pin0e, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 75.253144] pin0f, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 75.254396] pin10, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 75.255623] pin11, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 75.256871] pin12, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 75.258119] pin13, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 75.259346] pin14, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 75.260579] pin15, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 75.261818] pin16, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 75.263080] pin17, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 75.264315] IRQ to pin mappings: [ 75.264901] IRQ0 -> 0:2 [ 75.265408] IRQ1 -> 0:1 [ 75.265918] IRQ3 -> 0:3 [ 75.266424] IRQ4 -> 0:4 [ 75.266973] IRQ5 -> 0:5 [ 75.267485] IRQ6 -> 0:6 [ 75.267995] IRQ7 -> 0:7 [ 75.268502] IRQ8 -> 0:8 [ 75.269012] IRQ9 -> 0:9 [ 75.269517] IRQ10 -> 0:10 [ 75.270057] IRQ11 -> 0:11 [ 75.270580] IRQ12 -> 0:12 [ 75.271130] IRQ13 -> 0:13 [ 75.271652] IRQ14 -> 0:14 [ 75.272181] IRQ15 -> 0:15 [ 75.272705] .................................... done. [ 75.273557] sched_clock: Marking stable (75273464413, 0)->(76368316643, -1094852230) [ 75.276032] Loading compiled-in X.509 certificates [ 75.278797] Btrfs loaded, crc32c=crc32c-intel, integrity-checker=on [ 75.287214] Key type big_key registered [ 75.288253] Key type encrypted registered [ 75.290087] console [netcon0] enabled [ 75.290718] netconsole: network logging started [ 75.291552] gtp: GTP module loaded (pdp ctx size 104 bytes) [ 75.293449] Duplicate name in testcase-data, renamed to "duplicate-name#1" [ 75.298700] ### dt-test ### start of unittest - you will see error messages [ 75.300020] OF: /testcase-data/phandle-tests/consumer-a: could not get #phandle-cells-missing for /testcase-data/phandle-tests/provider1 [ 75.302279] OF: /testcase-data/phandle-tests/consumer-a: could not get #phandle-cells-missing for /testcase-data/phandle-tests/provider1 [ 75.305030] OF: /testcase-data/phandle-tests/consumer-a: could not find phandle [ 75.306987] OF: /testcase-data/phandle-tests/consumer-a: could not find phandle [ 75.309004] OF: /testcase-data/phandle-tests/consumer-a: arguments longer than property [ 75.311136] OF: /testcase-data/phandle-tests/consumer-a: arguments longer than property [ 75.313707] OF: /testcase-data/phandle-tests/consumer-b: could not get #phandle-missing-cells for /testcase-data/phandle-tests/provider1 [ 75.327064] OF: /testcase-data/phandle-tests/consumer-b: could not find phandle [ 75.329052] OF: /testcase-data/phandle-tests/consumer-b: arguments longer than property [ 75.336987] ### dt-test ### end of unittest - 162 passed, 0 failed [ 75.341645] IPv6: ADDRCONF(NETDEV_UP): bond0: link is not ready [ 75.343132] 8021q: adding VLAN 0 to HW filter on device bond0 [ 75.347977] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready [ 75.350325] 8021q: adding VLAN 0 to HW filter on device eth0 [ 75.351733] IP-Config: Failed to open plip0 [ 75.353304] e1000: eth0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX [ 75.355210] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 75.366723] Sending DHCP requests ., OK [ 75.374418] IP-Config: Got DHCP answer from 10.0.2.2, my address is 10.0.2.15 [ 75.375866] IP-Config: Complete: [ 75.376796] device=eth0, hwaddr=52:54:00:12:34:56, ipaddr=10.0.2.15, mask=255.255.255.0, gw=10.0.2.2 [ 75.378946] host=vm-lkp-hsw01-1G-9, domain=, nis-domain=(none) [ 75.380290] bootserver=10.0.2.2, rootserver=10.0.2.2, rootpath= nameserver0=10.0.2.3 [ 75.387314] debug: unmapping init [mem 0xffffffff86940000-0xffffffff86cd3fff] [ 75.389040] Write protecting the kernel read-only data: 71680k [ 75.392446] debug: unmapping init [mem 0xffff880004804000-0xffff8800049fffff] [ 75.394123] debug: unmapping init [mem 0xffff88000555a000-0xffff8800055fffff] [ 75.411784] systemd[1]: RTC configured in localtime, applying delta of 480 minutes to system time. [ 75.467752] systemd-getty-g (264) used greatest stack depth: 28520 bytes left [ 75.492908] systemd-debug-g (266) used greatest stack depth: 27816 bytes left [ 75.495785] systemd-hiberna (270) used greatest stack depth: 27520 bytes left Mounting Huge Pages File System... Mounting Debug File System... Mounting POSIX Message Queue File System... Starting Remount Root and Kernel File Systems... Starting Load Kernel Modules... Mounting RPC Pipe File System... Starting Create Static Device Nodes in /dev... Starting Journal Service... See 'systemctl status run-rpc_pipefs.mount' for details. [ 75.622629] systemd-tmpfile (282) used greatest stack depth: 27024 bytes left Starting udev Kernel Device Manager... Mounting Configuration File System... Starting Apply Kernel Variables... Starting Load/Save Random Seed... Starting udev Coldplug all Devices... Starting Preprocess NFS configuration... Starting Flush Journal to Persistent Storage... Starting Create Volatile Files and Directories... Starting Network Time Synchronization... Starting RPC bind portmap service... Starting Update UTMP about System Boot/Shutdown... [ 75.938670] udevadm invoked oom-killer: gfp_mask=0x14040c0(GFP_KERNEL|__GFP_COMP), nodemask=(null), order=1, oom_score_adj=0 [ 75.941240] CPU: 1 PID: 294 Comm: udevadm Not tainted 4.17.0-rc1 #262 [ 75.942651] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014 [ 75.944711] Call Trace: [ 75.945595] dump_stack+0x71/0xab [ 75.946554] dump_header+0x14b/0x8d3 [ 75.947681] ? ___ratelimit+0x1cb/0x410 [ 75.948712] oom_kill_process+0x55f/0xc60 [ 75.949815] ? lock_downgrade+0x5e0/0x5e0 [ 75.950870] ? _raw_spin_unlock+0x1f/0x30 [ 75.951974] ? oom_badness+0x425/0x570 [ 75.952992] out_of_memory+0x214/0xf90 [ 75.954045] ? unregister_oom_notifier+0x10/0x10 [ 75.955202] ? zone_reclaimable_pages+0x240/0x6a0 [ 75.956367] ? mutex_trylock+0x15e/0x190 [ 75.957401] __alloc_pages_nodemask+0xfcd/0x19a0 [ 75.958580] ? gfp_pfmemalloc_allowed+0x150/0x150 [ 75.959743] ? kvm_sched_clock_read+0x21/0x30 [ 75.960893] ? sched_clock+0x5/0x10 [ 75.961886] ? sched_clock_cpu+0x18/0x180 [ 75.962976] cache_alloc_refill+0x27e/0x770 [ 75.964070] ? lock_acquire+0xd0/0x190 [ 75.965111] kmem_cache_alloc+0x10b/0x130 [ 75.966165] getname_flags+0x4a/0x400 [ 75.967172] ? cp_new_stat+0x3ae/0x530 [ 75.968205] user_path_at_empty+0x18/0x30 [ 75.969287] vfs_statx+0xb4/0x130 [ 75.970235] ? __se_sys_newfstat+0xd0/0xd0 [ 75.971352] ? sched_clock_cpu+0x18/0x180 [ 75.972405] __se_sys_newlstat+0x77/0xd0 [ 75.973483] ? __se_sys_newstat+0xd0/0xd0 [ 75.974545] ? up_read+0x17/0x110 [ 75.975531] ? __do_page_fault+0x45d/0x980 [ 75.976608] do_syscall_64+0xed/0x800 [ 75.977663] ? syscall_return_slowpath+0x190/0x190 [ 75.978899] ? mm_fault_error+0x2e0/0x2e0 [ 75.979972] entry_SYSCALL_64_after_hwframe+0x44/0xa9 [ 75.981196] RIP: 0033:0x7f9bcc709a85 [ 75.982208] RSP: 002b:00007fffc084da98 EFLAGS: 00000246 ORIG_RAX: 0000000000000006 [ 75.984191] RAX: ffffffffffffffda RBX: 0000557c73e5c960 RCX: 00007f9bcc709a85 [ 75.985685] RDX: 00007fffc084dae0 RSI: 00007fffc084dae0 RDI: 0000557c73e5b960 [ 75.987231] RBP: 00007fffc084dba0 R08: 0000000000000003 R09: 0000000000001011 [ 75.988767] R10: 0000000000000063 R11: 0000000000000246 R12: 0000557c73e5b960 [ 75.990244] R13: 0000557c73e5b968 R14: 00007fffc084dc25 R15: 00007fffc084dc28 [ 75.991237] Mem-Info: [ 75.991735] active_anon:1590 inactive_anon:974 isolated_anon:0 [ 75.991735] active_file:0 inactive_file:0 isolated_file:0 [ 75.991735] unevictable:123548 dirty:0 writeback:0 unstable:0 [ 75.991735] slab_reclaimable:7607 slab_unreclaimable:14104 [ 75.991735] mapped:2090 shmem:975 pagetables:152 bounce:0 [ 75.991735] free:1286 free_pcp:182 free_cma:0 [ 75.996096] Node 0 active_anon:6360kB inactive_anon:3896kB active_file:0kB inactive_file:0kB unevictable:494192kB isolated(anon):0kB isolated(file):0kB mapped:8360kB dirty:0kB writeback:0kB shmem:3900kB writeback_tmp:0kB unstable:0kB all_unreclaimable? yes [ 75.999118] DMA free:2428kB min:80kB low:100kB high:120kB active_anon:1120kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:1180kB writepending:0kB present:15992kB managed:15904kB mlocked:0kB kernel_stack:32kB pagetables:120kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [ 76.002438] lowmem_reserve[]: 0 588 588 588 [ 76.003117] DMA32 free:2716kB min:3060kB low:3824kB high:4588kB active_anon:5136kB inactive_anon:3896kB active_file:0kB inactive_file:0kB unevictable:493012kB writepending:0kB present:1032064kB managed:602456kB mlocked:0kB kernel_stack:2944kB pagetables:488kB bounce:0kB free_pcp:728kB local_pcp:240kB free_cma:0kB [ 76.006586] lowmem_reserve[]: 0 0 0 0 [ 76.007434] DMA: 1*4kB (U) 3*8kB (UME) 2*16kB (UE) 14*32kB (U) 14*64kB (UM) 4*128kB (UME) 2*256kB (UM) 0*512kB 0*1024kB 0*2048kB 0*4096kB = 2428kB [ 76.010314] DMA32: 191*4kB (UM) 0*8kB 0*16kB 27*32kB (UM) 17*64kB (UM) 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 2716kB [ 76.012791] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=1048576kB [ 76.014826] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB [ 76.016586] 124523 total pagecache pages [ 76.017482] 0 pages in swap cache [ 76.018290] Swap cache stats: add 0, delete 0, find 0/0 [ 76.019319] Free swap = 0kB [ 76.020083] Total swap = 0kB [ 76.020844] 262014 pages RAM [ 76.021594] 0 pages HighMem/MovableOnly [ 76.022455] 107424 pages reserved [ 76.023255] [ pid ] uid tgid total_vm rss pgtables_bytes swapents oom_score_adj name [ 76.025025] [ 284] 0 284 9987 1121 110592 0 0 systemd-journal [ 76.026852] [ 288] 0 288 10417 754 114688 0 -1000 systemd-udevd [ 76.028638] [ 294] 0 294 7367 1429 102400 0 0 udevadm [ 76.030378] [ 306] 104 306 31279 1017 143360 0 0 systemd-timesyn [ 76.032175] [ 307] 0 307 11933 879 131072 0 0 rpcbind [ 76.033899] Out of memory: Kill process 294 (udevadm) score 9 or sacrifice child [ 76.035528] Killed process 294 (udevadm) total-vm:29468kB, anon-rss:3320kB, file-rss:2396kB, shmem-rss:0kB [ 76.037983] oom_reaper: reaped process 294 (udevadm), now anon-rss:0kB, file-rss:0kB, shmem-rss:0kB See 'systemctl status systemd-udev-trigger.service' for details. Starting OpenBSD Secure Shell server... Starting Permit User Sessions... Starting /etc/rc.local Compatibility... Starting Login Service... Starting LKP bootstrap... [ 76.158205] lkp-bootstrap invoked oom-killer: gfp_mask=0x14040c0(GFP_KERNEL|__GFP_COMP), nodemask=(null), order=1, oom_score_adj=0 [ 76.158212] CPU: 1 PID: 328 Comm: lkp-bootstrap Not tainted 4.17.0-rc1 #262 [ 76.158215] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014 [ 76.158218] Call Trace: [ 76.158230] dump_stack+0x71/0xab [ 76.158239] dump_header+0x14b/0x8d3 [ 76.158244] ? ___ratelimit+0x1cb/0x410 [ 76.158249] oom_kill_process+0x55f/0xc60 [ 76.158256] ? lock_downgrade+0x5e0/0x5e0 [ 76.158263] ? _raw_spin_unlock+0x1f/0x30 [ 76.158267] ? oom_badness+0x425/0x570 [ 76.158271] out_of_memory+0x214/0xf90 [ 76.158276] ? unregister_oom_notifier+0x10/0x10 [ 76.158281] ? zone_reclaimable_pages+0x240/0x6a0 [ 76.158285] ? mutex_trylock+0x15e/0x190 [ 76.158290] __alloc_pages_nodemask+0xfcd/0x19a0 [ 76.158294] ? gfp_pfmemalloc_allowed+0x150/0x150 [ 76.158301] ? kvm_sched_clock_read+0x21/0x30 [ 76.158306] ? sched_clock+0x5/0x10 [ 76.158311] ? sched_clock_cpu+0x18/0x180 [ 76.158319] cache_alloc_refill+0x27e/0x770 [ 76.158323] ? lock_acquire+0xd0/0x190 [ 76.158327] kmem_cache_alloc+0x10b/0x130 [ 76.158333] getname_kernel+0x48/0x2a0 [ 76.158337] open_exec+0x7/0x40 [ 76.158343] load_elf_binary+0xf49/0x2a88 [ 76.158347] ? sched_clock_cpu+0x18/0x180 [ 76.158352] ? elf_core_dump+0x17d0/0x17d0 [ 76.158356] ? search_binary_handler+0xe5/0x220 [ 76.158360] search_binary_handler+0xd6/0x220 [ 76.158364] do_execveat_common+0x1239/0x1ae0 [ 76.158368] ? search_binary_handler+0x220/0x220 [ 76.158371] ? getname_flags+0x88/0x400 [ 76.158375] __x64_sys_execve+0x77/0xa0 [ 76.158381] do_syscall_64+0xed/0x800 [ 76.158386] ? syscall_return_slowpath+0x190/0x190 [ 76.158391] ? mm_fault_error+0x2e0/0x2e0 [ 76.158396] entry_SYSCALL_64_after_hwframe+0x44/0xa9 [ 76.158400] RIP: 0033:0x7fbe701981f7 [ 76.158403] RSP: 002b:00007ffc8fa3cd78 EFLAGS: 00000246 ORIG_RAX: 000000000000003b [ 76.158408] RAX: ffffffffffffffda RBX: 0000560f794acba0 RCX: 00007fbe701981f7 [ 76.158411] RDX: 0000560f796e9f58 RSI: 0000560f794acba0 RDI: 0000560f796ea0d8 [ 76.158414] RBP: 0000560f796ea0d8 R08: 0000000000000410 R09: 0000000000000211 [ 76.158417] R10: 00007fbe7069e9d0 R11: 0000000000000246 R12: 0000560f796e9f58 [ 76.158420] R13: 00007ffc8fa3cda8 R14: 0000560f796e9f58 R15: 0000560f794acb28 [ 76.158423] Mem-Info: [ 76.158432] active_anon:1488 inactive_anon:975 isolated_anon:0 [ 76.158432] active_file:0 inactive_file:0 isolated_file:0 [ 76.158432] unevictable:123548 dirty:0 writeback:0 unstable:0 [ 76.158432] slab_reclaimable:7406 slab_unreclaimable:13839 [ 76.158432] mapped:2912 shmem:977 pagetables:374 bounce:0 [ 76.158432] free:1360 free_pcp:206 free_cma:0 [ 76.158439] Node 0 active_anon:5952kB inactive_anon:3900kB active_file:0kB inactive_file:0kB unevictable:494192kB isolated(anon):0kB isolated(file):0kB mapped:11648kB dirty:0kB writeback:0kB shmem:3908kB writeback_tmp:0kB unstable:0kB all_unreclaimable? yes [ 76.158447] DMA free:2416kB min:80kB low:100kB high:120kB active_anon:1080kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:1180kB writepending:0kB present:15992kB managed:15904kB mlocked:0kB kernel_stack:288kB pagetables:384kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [ 76.158448] lowmem_reserve[]: 0 588 588 588 [ 76.158464] DMA32 free:3024kB min:3060kB low:3824kB high:4588kB active_anon:4920kB inactive_anon:3900kB active_file:0kB inactive_file:0kB unevictable:493012kB writepending:0kB present:1032064kB managed:602456kB mlocked:0kB kernel_stack:3200kB pagetables:1112kB bounce:0kB free_pcp:824kB local_pcp:276kB free_cma:0kB [ 76.158466] lowmem_reserve[]: 0 0 0 0 [ 76.158476] DMA: 2*4kB (UE) 1*8kB (M) 17*16kB (UME) 8*32kB (U) 15*64kB (UM) 3*128kB (UM) 2*256kB (UM) 0*512kB 0*1024kB 0*2048kB 0*4096kB = 2400kB [ 76.158509] DMA32: 46*4kB (U) 2*8kB (UE) 70*16kB (UE) 15*32kB (U) 17*64kB (UE) 1*128kB (M) 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 3016kB [ 76.158531] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=1048576kB [ 76.158533] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB [ 76.158534] 124525 total pagecache pages [ 76.158537] 0 pages in swap cache [ 76.158538] Swap cache stats: add 0, delete 0, find 0/0 [ 76.158539] Free swap = 0kB [ 76.158541] Total swap = 0kB [ 76.158543] 262014 pages RAM [ 76.158544] 0 pages HighMem/MovableOnly [ 76.158545] 107424 pages reserved [ 76.158547] [ pid ] uid tgid total_vm rss pgtables_bytes swapents oom_score_adj name [ 76.158554] [ 284] 0 284 9987 1121 110592 0 0 systemd-journal [ 76.158558] [ 288] 0 288 10417 767 114688 0 -1000 systemd-udevd [ 76.158561] [ 306] 104 306 31279 1017 143360 0 0 systemd-timesyn [ 76.158564] [ 307] 0 307 11933 879 131072 0 0 rpcbind [ 76.158568] [ 312] 0 312 16955 1412 167936 0 -1000 sshd [ 76.158571] [ 313] 101 313 10747 935 135168 0 -900 dbus-daemon [ 76.158575] [ 315] 0 315 1075 179 53248 0 0 rc.local [ 76.158578] [ 316] 0 316 8952 517 110592 0 0 systemd-logind [ 76.158581] [ 317] 0 317 7002 600 102400 0 0 cron [ 76.158584] [ 318] 0 318 1075 200 53248 0 0 lkp-bootstrap [ 76.158587] [ 319] 0 319 1075 190 49152 0 0 lkp-bootstrap [ 76.158590] [ 324] 0 324 3267 254 65536 0 0 mkdir [ 76.158593] [ 326] 0 326 10417 97 106496 0 0 systemd-udevd [ 76.158597] [ 327] 0 327 1075 33 53248 0 0 lkp-bootstrap [ 76.158600] [ 328] 0 328 1075 34 53248 0 0 lkp-bootstrap [ 76.158603] [ 329] 0 329 10417 97 106496 0 0 systemd-udevd [ 76.158606] [ 330] 0 330 1075 186 53248 0 0 lkp-setup-rootf [ 76.158609] [ 331] 0 331 10417 97 106496 0 0 systemd-udevd [ 76.158612] [ 332] 0 332 10417 97 102400 0 -1000 systemd-udevd [ 76.158615] [ 333] 0 333 1075 32 45056 0 0 lkp-setup-rootf [ 76.158618] Out of memory: Kill process 284 (systemd-journal) score 7 or sacrifice child [ 76.158629] Killed process 284 (systemd-journal) total-vm:39948kB, anon-rss:500kB, file-rss:3552kB, shmem-rss:432kB [ 76.170505] oom_reaper: reaped process 284 (systemd-journal), now anon-rss:0kB, file-rss:0kB, shmem-rss:432kB [ 76.250976] lkp-setup-rootf invoked oom-killer: gfp_mask=0x15080c0(GFP_KERNEL_ACCOUNT|__GFP_ZERO), nodemask=(null), order=0, oom_score_adj=0 [ 76.250982] CPU: 0 PID: 348 Comm: lkp-setup-rootf Not tainted 4.17.0-rc1 #262 [ 76.250984] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014 [ 76.250986] Call Trace: [ 76.250994] dump_stack+0x71/0xab [ 76.251000] dump_header+0x14b/0x8d3 [ 76.251004] ? ___ratelimit+0x1cb/0x410 [ 76.251007] oom_kill_process+0x55f/0xc60 [ 76.251011] ? lock_downgrade+0x5e0/0x5e0 [ 76.251016] ? _raw_spin_unlock+0x1f/0x30 [ 76.251018] ? oom_badness+0x425/0x570 [ 76.251021] out_of_memory+0x214/0xf90 [ 76.251024] ? unregister_oom_notifier+0x10/0x10 [ 76.251026] ? mutex_trylock+0x15e/0x190 [ 76.251028] __alloc_pages_nodemask+0xfcd/0x19a0 [ 76.251031] ? gfp_pfmemalloc_allowed+0x150/0x150 [ 76.251034] ? finish_mkwrite_fault+0x600/0x600 [ 76.251037] ? __handle_mm_fault+0x57a/0x22b0 [ 76.251039] ? __handle_mm_fault+0x105c/0x22b0 [ 76.251042] ? unlock_page+0x50/0x50 [ 76.251046] pte_alloc_one+0x12/0x80 [ 76.251049] __handle_mm_fault+0x1ab4/0x22b0 [ 76.251051] ? vm_iomap_memory+0x160/0x160 [ 76.251054] __do_page_fault+0x439/0x980 [ 76.251056] ? mm_fault_error+0x2e0/0x2e0 [ 76.251058] do_page_fault+0x2a/0x70 [ 76.251062] ? syscall_return_slowpath+0xc9/0x190 [ 76.251066] ? async_page_fault+0x8/0x30 [ 76.251068] async_page_fault+0x1e/0x30 [ 76.251071] RIP: 0033:0x7fe309af5e9a [ 76.251073] RSP: 002b:00007fff587bcaa0 EFLAGS: 00010246 [ 76.251076] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 00007fe309af5e9a [ 76.251078] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000001200011 [ 76.251079] RBP: 00007fff587bcad0 R08: 0000000000000000 R09: 00007fe309ffc700 [ 76.251081] R10: 00007fe309ffc9d0 R11: 0000000000000246 R12: 000000000000014a [ 76.251083] R13: 0000000000000000 R14: 0000000000000000 R15: 00005582443445a0 [ 76.251084] Mem-Info: [ 76.251090] active_anon:2695 inactive_anon:975 isolated_anon:0 [ 76.251090] active_file:0 inactive_file:0 isolated_file:0 [ 76.251090] unevictable:123548 dirty:0 writeback:0 unstable:0 [ 76.251090] slab_reclaimable:7406 slab_unreclaimable:12862 [ 76.251090] mapped:2980 shmem:977 pagetables:318 bounce:0 [ 76.251090] free:1351 free_pcp:121 free_cma:0 [ 76.251094] Node 0 active_anon:10780kB inactive_anon:3900kB active_file:0kB inactive_file:0kB unevictable:494192kB isolated(anon):0kB isolated(file):0kB mapped:11920kB dirty:0kB writeback:0kB shmem:3908kB writeback_tmp:0kB unstable:0kB all_unreclaimable? yes [ 76.251099] DMA free:2432kB min:80kB low:100kB high:120kB active_anon:2460kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:1180kB writepending:0kB present:15992kB managed:15904kB mlocked:0kB kernel_stack:128kB pagetables:160kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [ 76.251100] lowmem_reserve[]: 0 588 588 588 [ 76.251109] DMA32 free:2972kB min:3060kB low:3824kB high:4588kB active_anon:8252kB inactive_anon:3900kB active_file:0kB inactive_file:0kB unevictable:493012kB writepending:0kB present:1032064kB managed:602456kB mlocked:0kB kernel_stack:3264kB pagetables:1112kB bounce:0kB free_pcp:484kB local_pcp:176kB free_cma:0kB [ 76.251110] lowmem_reserve[]: 0 0 0 0 [ 76.251116] DMA: 34*4kB (UE) 24*8kB (U) 20*16kB (UME) 36*32kB (U) 10*64kB (UM) 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 2440kB [ 76.251137] DMA32: 1*4kB (M) 31*8kB (U) 128*16kB (U) 22*32kB (UE) 0*64kB 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 3004kB [ 76.251157] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=1048576kB [ 76.251159] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB [ 76.251160] 124525 total pagecache pages [ 76.251162] 0 pages in swap cache [ 76.251164] Swap cache stats: add 0, delete 0, find 0/0 [ 76.251165] Free swap = 0kB [ 76.251166] Total swap = 0kB [ 76.251169] 262014 pages RAM [ 76.251170] 0 pages HighMem/MovableOnly [ 76.251171] 107424 pages reserved [ 76.251173] [ pid ] uid tgid total_vm rss pgtables_bytes swapents oom_score_adj name [ 76.251180] [ 284] 0 284 9987 108 110592 0 0 systemd-journal [ 76.251184] [ 288] 0 288 10417 767 114688 0 -1000 systemd-udevd [ 76.251188] [ 306] 104 306 31279 1017 143360 0 0 systemd-timesyn [ 76.251192] [ 307] 0 307 11933 879 131072 0 0 rpcbind [ 76.251195] [ 312] 0 312 16955 1412 167936 0 -1000 sshd [ 76.251199] [ 313] 101 313 10747 935 135168 0 -900 dbus-daemon [ 76.251203] [ 316] 0 316 8952 517 110592 0 0 systemd-logind [ 76.251206] [ 317] 0 317 7002 600 102400 0 0 cron [ 76.251214] [ 319] 0 319 1075 190 49152 0 0 lkp-bootstrap [ 76.251218] [ 327] 0 327 1075 33 53248 0 0 lkp-bootstrap [ 76.251221] [ 330] 0 330 1075 405 53248 0 0 lkp-setup-rootf [ 76.251225] [ 334] 0 334 1053 165 53248 0 0 sleep [ 76.251228] [ 342] 0 342 1480 197 57344 0 0 tail [ 76.251231] [ 343] 0 343 5428 1700 90112 0 0 sed [ 76.251235] [ 344] 0 344 1480 182 53248 0 0 tail [ 76.251238] [ 345] 0 345 4354 651 69632 0 0 sed [ 76.251241] [ 348] 0 348 1075 53 45056 0 0 lkp-setup-rootf [ 76.251244] Out of memory: Kill process 343 (sed) score 11 or sacrifice child [ 76.251252] Killed process 343 (sed) total-vm:21712kB, anon-rss:4764kB, file-rss:2036kB, shmem-rss:0kB [ 76.268934] lkp-setup-rootf invoked oom-killer: gfp_mask=0x15080c0(GFP_KERNEL_ACCOUNT|__GFP_ZERO), nodemask=(null), order=0, oom_score_adj=0 [ 76.409937] CPU: 0 PID: 348 Comm: lkp-setup-rootf Not tainted 4.17.0-rc1 #262 [ 76.409941] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014 [ 76.409943] Call Trace: [ 76.409956] dump_stack+0x71/0xab [ 76.409965] dump_header+0x14b/0x8d3 [ 76.414307] ? ___ratelimit+0x1cb/0x410 [ 76.414313] oom_kill_process+0x55f/0xc60 [ 76.414319] ? lock_downgrade+0x5e0/0x5e0 [ 76.414327] ? _raw_spin_unlock+0x1f/0x30 [ 76.417986] ? oom_badness+0x425/0x570 [ 76.418815] out_of_memory+0x214/0xf90 [ 76.419641] ? unregister_oom_notifier+0x10/0x10 [ 76.420572] ? mutex_trylock+0x15e/0x190 [ 76.421418] __alloc_pages_nodemask+0xfcd/0x19a0 [ 76.422343] ? gfp_pfmemalloc_allowed+0x150/0x150 [ 76.423273] ? finish_mkwrite_fault+0x600/0x600 [ 76.424197] ? __handle_mm_fault+0x57a/0x22b0 [ 76.425093] ? __handle_mm_fault+0x105c/0x22b0 [ 76.425999] ? unlock_page+0x50/0x50 [ 76.426810] pte_alloc_one+0x12/0x80 [ 76.427615] __handle_mm_fault+0x1ab4/0x22b0 [ 76.428503] ? vm_iomap_memory+0x160/0x160 [ 76.429367] __do_page_fault+0x439/0x980 [ 76.430211] ? mm_fault_error+0x2e0/0x2e0 [ 76.431064] do_page_fault+0x2a/0x70 [ 76.431871] ? syscall_return_slowpath+0xc9/0x190 [ 76.432811] ? async_page_fault+0x8/0x30 [ 76.433664] async_page_fault+0x1e/0x30 [ 76.434506] RIP: 0033:0x7fe309af5e9a [ 76.435310] RSP: 002b:00007fff587bcaa0 EFLAGS: 00010246 [ 76.436299] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 00007fe309af5e9a [ 76.437519] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000001200011 [ 76.438729] RBP: 00007fff587bcad0 R08: 0000000000000000 R09: 00007fe309ffc700 [ 76.439941] R10: 00007fe309ffc9d0 R11: 0000000000000246 R12: 000000000000014a [ 76.441158] R13: 0000000000000000 R14: 0000000000000000 R15: 00005582443445a0 [ 76.442419] Mem-Info: [ 76.443087] active_anon:2545 inactive_anon:975 isolated_anon:0 [ 76.443087] active_file:0 inactive_file:0 isolated_file:0 [ 76.443087] unevictable:123548 dirty:0 writeback:0 unstable:0 [ 76.443087] slab_reclaimable:7413 slab_unreclaimable:12864 [ 76.443087] mapped:2825 shmem:978 pagetables:271 bounce:0 [ 76.443087] free:1364 free_pcp:295 free_cma:0 [ 76.443094] Node 0 active_anon:10180kB inactive_anon:3900kB active_file:0kB inactive_file:0kB unevictable:494192kB isolated(anon):0kB isolated(file):0kB mapped:11300kB dirty:0kB writeback:0kB shmem:3912kB writeback_tmp:0kB unstable:0kB all_unreclaimable? yes [ 76.443107] DMA free:2420kB min:80kB low:100kB high:120kB active_anon:2480kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:1180kB writepending:0kB present:15992kB managed:15904kB mlocked:0kB kernel_stack:128kB pagetables:144kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [ 76.459643] lowmem_reserve[]: 0 588 588 588 [ 76.460822] DMA32 free:3036kB min:3060kB low:3824kB high:4588kB active_anon:7708kB inactive_anon:3900kB active_file:0kB inactive_file:0kB unevictable:493012kB writepending:0kB present:1032064kB managed:602456kB mlocked:0kB kernel_stack:3200kB pagetables:940kB bounce:0kB free_pcp:1204kB local_pcp:760kB free_cma:0kB [ 76.465767] lowmem_reserve[]: 0 0 0 0 [ 76.466863] DMA: 33*4kB (UE) 24*8kB (U) 19*16kB (UE) 36*32kB (U) 10*64kB (UM) 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 2420kB [ 76.469574] DMA32: 1*4kB (M) 16*8kB (UM) 134*16kB (U) 23*32kB (UE) 1*64kB (U) 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 3076kB [ 76.472154] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=1048576kB [ 76.474388] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB [ 76.476342] 124526 total pagecache pages [ 76.477274] 0 pages in swap cache [ 76.478287] Swap cache stats: add 0, delete 0, find 0/0 [ 76.479576] Free swap = 0kB [ 76.480532] Total swap = 0kB [ 76.481478] 262014 pages RAM [ 76.482420] 0 pages HighMem/MovableOnly [ 76.483175] 107424 pages reserved [ 76.484116] [ pid ] uid tgid total_vm rss pgtables_bytes swapents oom_score_adj name [ 76.486319] [ 288] 0 288 10417 767 114688 0 -1000 systemd-udevd [ 76.488557] [ 306] 104 306 31279 1017 143360 0 0 systemd-timesyn [ 76.490369] [ 307] 0 307 11933 879 131072 0 0 rpcbind [ 76.492534] [ 312] 0 312 16955 1412 167936 0 -1000 sshd [ 76.494654] [ 313] 101 313 10747 935 135168 0 -900 dbus-daemon [ 76.496485] [ 316] 0 316 8952 517 110592 0 0 systemd-logind [ 76.498637] [ 317] 0 317 7002 600 102400 0 0 cron [ 76.500764] [ 319] 0 319 1075 190 49152 0 0 lkp-bootstrap [ 76.502886] [ 327] 0 327 1075 33 53248 0 0 lkp-bootstrap [ 76.504876] [ 330] 0 330 1075 405 53248 0 0 lkp-setup-rootf [ 76.507136] [ 334] 0 334 1053 165 53248 0 0 sleep [ 76.509255] [ 342] 0 342 1480 197 57344 0 0 tail [ 76.511050] [ 344] 0 344 1480 182 53248 0 0 tail [ 76.513159] [ 345] 0 345 5463 1773 77824 0 0 sed [ 76.515261] [ 348] 0 348 1075 53 45056 0 0 lkp-setup-rootf [ 76.517101] Out of memory: Kill process 345 (sed) score 11 or sacrifice child [ 76.518692] Killed process 345 (sed) total-vm:21852kB, anon-rss:5024kB, file-rss:2068kB, shmem-rss:0kB Stopping Flush Journal to Persistent Storage... Starting Journal Service... LKP: HOSTNAME vm-lkp-hsw01-1G-9, MAC 52:54:00:12:34:56, kernel 4.17.0-rc1 262, serial console /dev/ttyS0 [ 76.600742] lkp-setup-rootf invoked oom-killer: gfp_mask=0x15080c0(GFP_KERNEL_ACCOUNT|__GFP_ZERO), nodemask=(null), order=0, oom_score_adj=0 [ 76.602449] CPU: 0 PID: 365 Comm: lkp-setup-rootf Not tainted 4.17.0-rc1 #262 [ 76.603391] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014 [ 76.604654] Call Trace: [ 76.605163] dump_stack+0x71/0xab [ 76.605757] dump_header+0x14b/0x8d3 [ 76.606426] ? ___ratelimit+0x1cb/0x410 [ 76.607058] oom_kill_process+0x55f/0xc60 [ 76.607710] ? lock_downgrade+0x5e0/0x5e0 [ 76.608357] ? _raw_spin_unlock+0x1f/0x30 [ 76.609008] ? oom_badness+0x425/0x570 [ 76.609637] out_of_memory+0x214/0xf90 [ 76.610261] ? unregister_oom_notifier+0x10/0x10 [ 76.610971] ? zone_reclaimable_pages+0x240/0x6a0 [ 76.611683] ? mutex_trylock+0x15e/0x190 [ 76.612320] __alloc_pages_nodemask+0xfcd/0x19a0 [ 76.613025] ? gfp_pfmemalloc_allowed+0x150/0x150 [ 76.613739] ? finish_mkwrite_fault+0x600/0x600 [ 76.614437] ? __handle_mm_fault+0x57a/0x22b0 [ 76.615114] ? __handle_mm_fault+0x105c/0x22b0 [ 76.615804] ? unlock_page+0x50/0x50 [ 76.616587] pte_alloc_one+0x12/0x80 [ 76.617399] __handle_mm_fault+0x1ab4/0x22b0 [ 76.618076] ? vm_iomap_memory+0x160/0x160 [ 76.618737] __do_page_fault+0x439/0x980 [ 76.619375] ? mm_fault_error+0x2e0/0x2e0 [ 76.620026] do_page_fault+0x2a/0x70 [ 76.620646] ? syscall_return_slowpath+0xc9/0x190 [ 76.621357] ? async_page_fault+0x8/0x30 [ 76.622000] async_page_fault+0x1e/0x30 [ 76.622635] RIP: 0033:0x7fe309af5e9a [ 76.623241] RSP: 002b:00007fff587bc660 EFLAGS: 00010246 [ 76.624004] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 00007fe309af5e9a [ 76.624938] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000001200011 [ 76.625871] RBP: 00007fff587bc690 R08: 0000000000000000 R09: 00007fe309ffc700 [ 76.626805] R10: 00007fe309ffc9d0 R11: 0000000000000246 R12: 000000000000014a [ 76.627738] R13: 0000000000000002 R14: 0000000000000000 R15: 0000558244347760 [ 76.628723] Mem-Info: [ 76.629226] active_anon:1472 inactive_anon:1559 isolated_anon:0 [ 76.629226] active_file:0 inactive_file:0 isolated_file:0 [ 76.629226] unevictable:123547 dirty:0 writeback:0 unstable:0 [ 76.629226] slab_reclaimable:7262 slab_unreclaimable:13457 [ 76.629226] mapped:2812 shmem:1597 pagetables:297 bounce:0 [ 76.629226] free:1347 free_pcp:305 free_cma:0 [ 76.633641] Node 0 active_anon:5888kB inactive_anon:6236kB active_file:0kB inactive_file:0kB unevictable:494188kB isolated(anon):0kB isolated(file):0kB mapped:11248kB dirty:0kB writeback:0kB shmem:6388kB writeback_tmp:0kB unstable:0kB all_unreclaimable? yes [ 76.641572] DMA free:2420kB min:80kB low:100kB high:120kB active_anon:660kB inactive_anon:1632kB active_file:0kB inactive_file:0kB unevictable:1180kB writepending:0kB present:15992kB managed:15904kB mlocked:0kB kernel_stack:160kB pagetables:152kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [ 76.644935] lowmem_reserve[]: 0 588 588 588 [ 76.645621] DMA32 free:2968kB min:3060kB low:3824kB high:4588kB active_anon:5188kB inactive_anon:4592kB active_file:0kB inactive_file:0kB unevictable:493008kB writepending:0kB present:1032064kB managed:602456kB mlocked:0kB kernel_stack:3200kB pagetables:1036kB bounce:0kB free_pcp:1220kB local_pcp:612kB free_cma:0kB [ 76.649121] lowmem_reserve[]: 0 0 0 0 [ 76.649755] DMA: 9*4kB (UE) 1*8kB (E) 24*16kB (UM) 36*32kB (UM) 13*64kB (UM) 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 2412kB [ 76.651419] DMA32: 6*4kB (UE) 2*8kB (E) 89*16kB (U) 31*32kB (UME) 8*64kB (U) 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 2968kB [ 76.653082] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=1048576kB [ 76.654391] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB [ 76.655677] 125144 total pagecache pages [ 76.656316] 0 pages in swap cache [ 76.656919] Swap cache stats: add 0, delete 0, find 0/0 [ 76.657686] Free swap = 0kB [ 76.658231] Total swap = 0kB [ 76.658782] 262014 pages RAM [ 76.659326] 0 pages HighMem/MovableOnly [ 76.659966] 107424 pages reserved [ 76.660569] [ pid ] uid tgid total_vm rss pgtables_bytes swapents oom_score_adj name [ 76.661872] [ 288] 0 288 10417 767 114688 0 -1000 systemd-udevd [ 76.663201] [ 306] 104 306 31279 1017 143360 0 0 systemd-timesyn [ 76.664539] [ 307] 0 307 11933 879 131072 0 0 rpcbind [ 76.665807] [ 312] 0 312 16955 1412 167936 0 -1000 sshd [ 76.667055] [ 313] 101 313 10747 935 135168 0 -900 dbus-daemon [ 76.668349] [ 316] 0 316 8952 517 110592 0 0 systemd-logind [ 76.669672] [ 317] 0 317 7002 600 102400 0 0 cron [ 76.670913] [ 319] 0 319 1075 190 49152 0 0 lkp-bootstrap [ 76.672223] [ 327] 0 327 1075 33 53248 0 0 lkp-bootstrap [ 76.673540] [ 330] 0 330 1075 405 53248 0 0 lkp-setup-rootf [ 76.674866] [ 334] 0 334 1053 165 53248 0 0 sleep [ 76.676558] [ 344] 0 344 1480 182 53248 0 0 tail [ 76.678514] [ 357] 0 357 8931 942 106496 0 0 systemd-journal [ 76.680591] [ 358] 0 358 13615 288 139264 0 0 (agetty) [ 76.682571] [ 365] 0 365 1075 55 45056 0 0 lkp-setup-rootf [ 76.684639] Out of memory: Kill process 306 (systemd-timesyn) score 6 or sacrifice child [ 76.686583] Killed process 306 (systemd-timesyn) total-vm:125116kB, anon-rss:488kB, file-rss:3580kB, shmem-rss:0kB [ 76.693605] lkp-setup-rootf invoked oom-killer: gfp_mask=0x15080c0(GFP_KERNEL_ACCOUNT|__GFP_ZERO), nodemask=(null), order=0, oom_score_adj=0 [ 76.695285] CPU: 0 PID: 365 Comm: lkp-setup-rootf Not tainted 4.17.0-rc1 #262 [ 76.696226] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014 [ 76.697499] Call Trace: [ 76.698008] dump_stack+0x71/0xab [ 76.698605] dump_header+0x14b/0x8d3 [ 76.699269] ? ___ratelimit+0x1cb/0x410 [ 76.699905] oom_kill_process+0x55f/0xc60 [ 76.700560] ? lock_downgrade+0x5e0/0x5e0 [ 76.701207] ? _raw_spin_unlock+0x1f/0x30 [ 76.701861] ? oom_badness+0x425/0x570 [ 76.702488] out_of_memory+0x214/0xf90 [ 76.703113] ? unregister_oom_notifier+0x10/0x10 [ 76.703822] ? zone_reclaimable_pages+0x240/0x6a0 [ 76.704541] ? mutex_trylock+0x15e/0x190 [ 76.705179] __alloc_pages_nodemask+0xfcd/0x19a0 [ 76.705885] ? gfp_pfmemalloc_allowed+0x150/0x150 [ 76.706599] ? finish_mkwrite_fault+0x600/0x600 [ 76.707291] ? __handle_mm_fault+0x57a/0x22b0 [ 76.707972] ? __handle_mm_fault+0x105c/0x22b0 [ 76.708662] ? unlock_page+0x50/0x50 [ 76.709269] pte_alloc_one+0x12/0x80 [ 76.709880] __handle_mm_fault+0x1ab4/0x22b0 [ 76.710553] ? vm_iomap_memory+0x160/0x160 [ 76.711206] __do_page_fault+0x439/0x980 [ 76.711864] ? mm_fault_error+0x2e0/0x2e0 [ 76.712516] do_page_fault+0x2a/0x70 [ 76.713125] ? syscall_return_slowpath+0xc9/0x190 [ 76.713840] ? async_page_fault+0x8/0x30 [ 76.714482] async_page_fault+0x1e/0x30 [ 76.715113] RIP: 0033:0x7fe309af5e9a [ 76.715725] RSP: 002b:00007fff587bc660 EFLAGS: 00010246 [ 76.716489] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 00007fe309af5e9a [ 76.717417] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000001200011 [ 76.718350] RBP: 00007fff587bc690 R08: 0000000000000000 R09: 00007fe309ffc700 [ 76.719285] R10: 00007fe309ffc9d0 R11: 0000000000000246 R12: 000000000000014a [ 76.720220] R13: 0000000000000002 R14: 0000000000000000 R15: 0000558244347760 [ 76.721204] Mem-Info: [ 76.721713] active_anon:1339 inactive_anon:1763 isolated_anon:0 [ 76.721713] active_file:0 inactive_file:0 isolated_file:0 [ 76.721713] unevictable:123547 dirty:0 writeback:0 unstable:0 [ 76.721713] slab_reclaimable:7264 slab_unreclaimable:13471 [ 76.721713] mapped:2746 shmem:1791 pagetables:267 bounce:0 [ 76.721713] free:1363 free_pcp:285 free_cma:0 [ 76.726095] Node 0 active_anon:5356kB inactive_anon:7052kB active_file:0kB inactive_file:0kB unevictable:494188kB isolated(anon):0kB isolated(file):0kB mapped:10984kB dirty:0kB writeback:0kB shmem:7164kB writeback_tmp:0kB unstable:0kB all_unreclaimable? yes [ 76.729146] DMA free:2428kB min:80kB low:100kB high:120kB active_anon:428kB inactive_anon:1912kB active_file:0kB inactive_file:0kB unevictable:1180kB writepending:0kB present:15992kB managed:15904kB mlocked:0kB kernel_stack:160kB pagetables:136kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [ 76.732510] lowmem_reserve[]: 0 588 588 588 [ 76.733193] DMA32 free:3652kB min:3060kB low:3824kB high:4588kB active_anon:4956kB inactive_anon:5752kB active_file:0kB inactive_file:0kB unevictable:493008kB writepending:0kB present:1032064kB managed:602456kB mlocked:0kB kernel_stack:3136kB pagetables:932kB bounce:0kB free_pcp:1156kB local_pcp:612kB free_cma:0kB [ 76.736703] lowmem_reserve[]: 0 0 0 0 [ 76.737336] DMA: 15*4kB (UME) 3*8kB (UME) 24*16kB (UM) 35*32kB (U) 13*64kB (UM) 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 2420kB [ 76.739027] DMA32: 7*4kB (U) 136*8kB (U) 94*16kB (U) 27*32kB (UM) 2*64kB (UM) 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 3612kB [ 76.740722] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=1048576kB [ 76.740725] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB [ 76.740728] 125491 total pagecache pages [ 76.740731] 0 pages in swap cache [ 76.740733] Swap cache stats: add 0, delete 0, find 0/0 [ 76.740735] Free swap = 0kB [ 76.740737] Total swap = 0kB [ 76.740741] 262014 pages RAM [ 76.750493] 0 pages HighMem/MovableOnly [ 76.751569] 107424 pages reserved [ 76.752577] [ pid ] uid tgid total_vm rss pgtables_bytes swapents oom_score_adj name [ 76.752599] [ 288] 0 288 10417 767 114688 0 -1000 systemd-udevd [ 76.755884] [ 307] 0 307 11933 879 131072 0 0 rpcbind [ 76.757232] [ 312] 0 312 16955 1412 167936 0 -1000 sshd [ 76.758509] [ 313] 101 313 10747 935 135168 0 -900 dbus-daemon [ 76.759800] [ 316] 0 316 8952 517 110592 0 0 systemd-logind [ 76.761162] [ 317] 0 317 7002 600 102400 0 0 cron [ 76.762452] [ 319] 0 319 1075 190 49152 0 0 lkp-bootstrap [ 76.764167] [ 327] 0 327 1075 33 53248 0 0 lkp-bootstrap [ 76.765522] [ 330] 0 330 1075 405 53248 0 0 lkp-setup-rootf [ 76.766905] [ 334] 0 334 1053 165 53248 0 0 sleep [ 76.768193] [ 344] 0 344 1480 182 53248 0 0 tail [ 76.769424] [ 357] 0 357 9898 1010 114688 0 0 systemd-journal [ 76.771115] [ 358] 0 358 13615 288 139264 0 0 (agetty) [ 76.772457] [ 365] 0 365 1075 55 45056 0 0 lkp-setup-rootf [ 76.773826] [ 366] 0 366 13615 288 135168 0 0 systemd [ 76.775141] Out of memory: Kill process 357 (systemd-journal) score 6 or sacrifice child [ 76.776417] Killed process 357 (systemd-journal) total-vm:39592kB, anon-rss:448kB, file-rss:3356kB, shmem-rss:236kB Starting Flush Journal to Persistent Storage... [ 76.792395] systemd invoked oom-killer: gfp_mask=0x14040c0(GFP_KERNEL|__GFP_COMP), nodemask=(null), order=1, oom_score_adj=0 [ 76.795117] CPU: 1 PID: 1 Comm: systemd Not tainted 4.17.0-rc1 #262 [ 76.795985] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014 [ 76.803199] Call Trace: [ 76.804020] dump_stack+0x71/0xab [ 76.804769] dump_header+0x14b/0x8d3 [ 76.805430] ? ___ratelimit+0x1cb/0x410 [ 76.806060] oom_kill_process+0x55f/0xc60 [ 76.806737] ? lock_downgrade+0x5e0/0x5e0 [ 76.807822] ? _raw_spin_unlock+0x1f/0x30 [ 76.808471] ? oom_badness+0x425/0x570 [ 76.809094] out_of_memory+0x214/0xf90 [ 76.809717] ? unregister_oom_notifier+0x10/0x10 [ 76.810752] ? zone_reclaimable_pages+0x240/0x6a0 [ 76.811599] ? mutex_trylock+0x15e/0x190 [ 76.812234] __alloc_pages_nodemask+0xfcd/0x19a0 [ 76.812935] ? gfp_pfmemalloc_allowed+0x150/0x150 [ 76.813906] ? lock_contended+0xba0/0xba0 [ 76.814755] ? kvm_sched_clock_read+0x21/0x30 [ 76.815428] ? sched_clock+0x5/0x10 [ 76.816027] ? sched_clock_cpu+0x18/0x180 [ 76.816678] cache_alloc_refill+0x27e/0x770 [ 76.817804] ? lock_acquire+0xd0/0x190 [ 76.818428] __kmalloc+0x14b/0x180 [ 76.819021] seq_read+0x6f1/0x1110 [ 76.819614] ? kvm_sched_clock_read+0x21/0x30 [ 76.820550] ? sched_clock_cpu+0x18/0x180 [ 76.821407] ? __fdget_pos+0xac/0xe0 [ 76.822015] ? seq_open+0x1a0/0x1a0 [ 76.822616] ? lock_contended+0xba0/0xba0 [ 76.823259] ? lock_acquire+0xd0/0x190 [ 76.824288] ? __fdget_pos+0xac/0xe0 [ 76.824966] __vfs_read+0xd0/0x650 [ 76.825557] ? __fdget_pos+0xac/0xe0 [ 76.826159] ? do_sendfile+0xba0/0xba0 [ 76.826888] ? __ww_mutex_wakeup_for_backoff+0x230/0x230 [ 76.827991] ? cdev_init+0xa0/0xa0 [ 76.828587] ? lock_downgrade+0x5e0/0x5e0 [ 76.829229] ? lock_acquire+0xd0/0x190 [ 76.829851] ? __fget+0x42/0x220 [ 76.830760] ? __fget+0x1a9/0x220 [ 76.831479] vfs_read+0x100/0x270 [ 76.832066] ksys_read+0xb3/0x180 [ 76.832649] ? kernel_write+0x130/0x130 [ 76.833276] do_syscall_64+0xed/0x800 [ 76.834300] ? syscall_return_slowpath+0x190/0x190 [ 76.835080] ? mm_fault_error+0x2e0/0x2e0 [ 76.835727] ? search_binary_handler+0x220/0x220 [ 76.836422] entry_SYSCALL_64_after_hwframe+0x44/0xa9 [ 76.837546] RIP: 0033:0x7f7d3b15d07d [ 76.838242] RSP: 002b:00007ffd2c7704f0 EFLAGS: 00000293 ORIG_RAX: 0000000000000000 [ 76.839426] RAX: ffffffffffffffda RBX: 000055fc31244f00 RCX: 00007f7d3b15d07d [ 76.840664] RDX: 0000000000001000 RSI: 000055fc31241290 RDI: 0000000000000021 [ 76.841760] RBP: 00007ffd2c770c00 R08: 0000000000001110 R09: 0000000000001011 [ 76.842690] R10: 0000000000000000 R11: 0000000000000293 R12: 000055fc31244f00 [ 76.843861] R13: 0000000000000000 R14: 00007f7d3b41f420 R15: fffffffffffffe10 [ 76.845025] Mem-Info: [ 76.845523] active_anon:1388 inactive_anon:1926 isolated_anon:0 [ 76.845523] active_file:0 inactive_file:0 isolated_file:0 [ 76.845523] unevictable:123547 dirty:0 writeback:0 unstable:0 [ 76.845523] slab_reclaimable:7253 slab_unreclaimable:13211 [ 76.845523] mapped:2727 shmem:1945 pagetables:296 bounce:0 [ 76.845523] free:1367 free_pcp:247 free_cma:0 [ 76.850516] Node 0 active_anon:5552kB inactive_anon:7704kB active_file:0kB inactive_file:0kB unevictable:494188kB isolated(anon):0kB isolated(file):0kB mapped:10908kB dirty:0kB writeback:0kB shmem:7780kB writeback_tmp:0kB unstable:0kB all_unreclaimable? yes [ 76.854193] DMA free:2428kB min:80kB low:100kB high:120kB active_anon:408kB inactive_anon:1932kB active_file:0kB inactive_file:0kB unevictable:1180kB writepending:0kB present:15992kB managed:15904kB mlocked:0kB kernel_stack:160kB pagetables:136kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [ 76.858168] lowmem_reserve[]: 0 588 588 588 [ 76.858847] DMA32 free:3040kB min:3060kB low:3824kB high:4588kB active_anon:5152kB inactive_anon:5772kB active_file:0kB inactive_file:0kB unevictable:493008kB writepending:0kB present:1032064kB managed:602456kB mlocked:0kB kernel_stack:3232kB pagetables:1048kB bounce:0kB free_pcp:988kB local_pcp:592kB free_cma:0kB [ 76.862704] lowmem_reserve[]: 0 0 0 0 [ 76.863327] DMA: 21*4kB (UME) 3*8kB (UME) 22*16kB (UM) 35*32kB (U) 13*64kB (UM) 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 2412kB [ 76.865420] DMA32: 4*4kB (U) 96*8kB (U) 91*16kB (UE) 24*32kB (UE) 0*64kB 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 3008kB [ 76.867366] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=1048576kB [ 76.868832] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB [ 76.870199] 125492 total pagecache pages [ 76.871221] 0 pages in swap cache [ 76.871813] Swap cache stats: add 0, delete 0, find 0/0 [ 76.872570] Free swap = 0kB [ 76.873109] Total swap = 0kB [ 76.873935] 262014 pages RAM [ 76.874681] 0 pages HighMem/MovableOnly [ 76.875309] 107424 pages reserved [ 76.875893] [ pid ] uid tgid total_vm rss pgtables_bytes swapents oom_score_adj name [ 76.877642] [ 288] 0 288 10417 767 114688 0 -1000 systemd-udevd [ 76.879004] [ 307] 0 307 11933 879 131072 0 0 rpcbind [ 76.880486] [ 312] 0 312 16955 1412 167936 0 -1000 sshd [ 76.881951] [ 313] 101 313 10747 935 135168 0 -900 dbus-daemon [ 76.883731] [ 316] 0 316 8952 517 110592 0 0 systemd-logind [ 76.885960] [ 317] 0 317 7002 600 102400 0 0 cron [ 76.888096] [ 319] 0 319 1075 190 49152 0 0 lkp-bootstrap [ 76.890145] [ 327] 0 327 1075 33 53248 0 0 lkp-bootstrap [ 76.891445] [ 330] 0 330 1075 405 53248 0 0 lkp-setup-rootf [ 76.892758] [ 334] 0 334 1053 165 53248 0 0 sleep [ 76.894639] [ 344] 0 344 1480 182 53248 0 0 tail [ 76.896756] [ 358] 0 358 13615 288 139264 0 0 (agetty) [ 76.898906] [ 365] 0 365 1075 55 53248 0 0 lkp-setup-rootf [ 76.901150] [ 366] 0 366 13615 289 139264 0 0 (urnalctl) [ 76.903321] [ 368] 0 368 8902 510 110592 0 0 systemd-cgroups [ 76.905554] Out of memory: Kill process 307 (rpcbind) score 5 or sacrifice child [ 76.907606] Killed process 307 (rpcbind) total-vm:47732kB, anon-rss:432kB, file-rss:3084kB, shmem-rss:0kB Starting Journal Service... [ 76.937486] systemd invoked oom-killer: gfp_mask=0x14200ca(GFP_HIGHUSER_MOVABLE), nodemask=(null), order=0, oom_score_adj=0 [ 76.940216] CPU: 1 PID: 1 Comm: systemd Not tainted 4.17.0-rc1 #262 [ 76.941699] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014 [ 76.943803] Call Trace: [ 76.944661] dump_stack+0x71/0xab [ 76.945648] dump_header+0x14b/0x8d3 [ 76.946743] ? ___ratelimit+0x1cb/0x410 [ 76.947787] oom_kill_process+0x55f/0xc60 [ 76.948878] ? lock_downgrade+0x5e0/0x5e0 [ 76.949955] ? _raw_spin_unlock+0x1f/0x30 [ 76.951001] ? oom_badness+0x425/0x570 [ 76.952061] out_of_memory+0x214/0xf90 [ 76.953066] ? unregister_oom_notifier+0x10/0x10 [ 76.954253] ? zone_reclaimable_pages+0x240/0x6a0 [ 76.955400] ? mutex_trylock+0x15e/0x190 [ 76.956475] __alloc_pages_nodemask+0xfcd/0x19a0 [ 76.957635] ? gfp_pfmemalloc_allowed+0x150/0x150 [ 76.958809] ? kvm_sched_clock_read+0x21/0x30 [ 76.959941] ? sched_clock+0x5/0x10 [ 76.960929] ? sched_clock_cpu+0x18/0x180 [ 76.962017] ? kvm_sched_clock_read+0x21/0x30 [ 76.963142] ? sched_clock+0x5/0x10 [ 76.964128] ? sched_clock_cpu+0x18/0x180 [ 76.965186] ? kvm_sched_clock_read+0x21/0x30 [ 76.966313] ? sched_clock+0x5/0x10 [ 76.967309] wp_page_copy+0x130/0x1610 [ 76.968358] do_wp_page+0x3df/0x1870 [ 76.969363] ? finish_mkwrite_fault+0x600/0x600 [ 76.970515] ? __handle_mm_fault+0x57a/0x22b0 [ 76.971651] __handle_mm_fault+0x105c/0x22b0 [ 76.972741] ? vm_iomap_memory+0x160/0x160 [ 76.973871] __do_page_fault+0x439/0x980 [ 76.974928] ? mm_fault_error+0x2e0/0x2e0 [ 76.976004] ? search_binary_handler+0x220/0x220 [ 76.977155] do_page_fault+0x2a/0x70 [ 76.978187] ? async_page_fault+0x8/0x30 [ 76.979220] async_page_fault+0x1e/0x30 [ 76.980004] RIP: 0033:0x7f7d3b139fc8 [ 76.980608] RSP: 002b:00007ffd2c770bd0 EFLAGS: 00010246 [ 76.981357] RAX: 0000000000000001 RBX: 00007ffd2c770bd0 RCX: 00007f7d3b139e9a [ 76.982279] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000001200011 [ 76.983201] RBP: 00007ffd2c770c20 R08: 0000000000000001 R09: 00007f7d3cb81900 [ 76.984123] R10: 00007f7d3cb81bd0 R11: 0000000000000246 R12: 0000000000000001 [ 76.985067] R13: 0000000000000176 R14: 0000000000000001 R15: 000055fc312787e0 [ 76.986012] Mem-Info: [ 76.986503] active_anon:1380 inactive_anon:1924 isolated_anon:0 [ 76.986503] active_file:0 inactive_file:0 isolated_file:0 [ 76.986503] unevictable:123548 dirty:0 writeback:0 unstable:0 [ 76.986503] slab_reclaimable:7279 slab_unreclaimable:13273 [ 76.986503] mapped:2697 shmem:1945 pagetables:341 bounce:0 [ 76.986503] free:1367 free_pcp:145 free_cma:0 [ 76.995829] Node 0 active_anon:5520kB inactive_anon:7696kB active_file:0kB inactive_file:0kB unevictable:494192kB isolated(anon):0kB isolated(file):0kB mapped:10788kB dirty:0kB writeback:0kB shmem:7780kB writeback_tmp:0kB unstable:0kB all_unreclaimable? yes [ 76.998851] DMA free:2424kB min:80kB low:100kB high:120kB active_anon:768kB inactive_anon:1928kB active_file:0kB inactive_file:0kB unevictable:1180kB writepending:0kB present:15992kB managed:15904kB mlocked:0kB kernel_stack:128kB pagetables:188kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [ 77.002182] lowmem_reserve[]: 0 588 588 588 [ 77.002864] DMA32 free:3044kB min:3060kB low:3824kB high:4588kB active_anon:4736kB inactive_anon:5768kB active_file:0kB inactive_file:0kB unevictable:493012kB writepending:0kB present:1032064kB managed:602456kB mlocked:0kB kernel_stack:3232kB pagetables:1176kB bounce:0kB free_pcp:576kB local_pcp:336kB free_cma:0kB [ 77.006316] lowmem_reserve[]: 0 0 0 0 [ 77.006951] DMA: 10*4kB (UME) 16*8kB (U) 26*16kB (U) 33*32kB (UM) 12*64kB (UM) 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 2408kB [ 77.008622] DMA32: 69*4kB (UME) 56*8kB (UM) 95*16kB (UM) 25*32kB (UE) 0*64kB 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 3044kB [ 77.010273] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=1048576kB [ 77.011575] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB [ 77.012845] 125493 total pagecache pages [ 77.013488] 0 pages in swap cache [ 77.014076] Swap cache stats: add 0, delete 0, find 0/0 [ 77.014829] Free swap = 0kB [ 77.015370] Total swap = 0kB [ 77.015916] 262014 pages RAM [ 77.016455] 0 pages HighMem/MovableOnly [ 77.017096] 107424 pages reserved [ 77.017683] [ pid ] uid tgid total_vm rss pgtables_bytes swapents oom_score_adj name [ 77.018969] [ 288] 0 288 10417 767 114688 0 -1000 systemd-udevd [ 77.020272] [ 312] 0 312 16955 1412 167936 0 -1000 sshd [ 77.021499] [ 313] 101 313 10747 935 135168 0 -900 dbus-daemon [ 77.022778] [ 316] 0 316 8952 517 110592 0 0 systemd-logind [ 77.024086] [ 317] 0 317 7002 600 102400 0 0 cron [ 77.025310] [ 319] 0 319 1075 190 49152 0 0 lkp-bootstrap [ 77.026603] [ 327] 0 327 1075 33 53248 0 0 lkp-bootstrap [ 77.027899] [ 330] 0 330 1075 405 53248 0 0 lkp-setup-rootf [ 77.029210] [ 334] 0 334 1053 165 53248 0 0 sleep [ 77.030447] [ 344] 0 344 1480 182 53248 0 0 tail [ 77.031682] [ 358] 0 358 13615 288 139264 0 0 (agetty) [ 77.032932] [ 366] 0 366 8916 520 110592 0 0 journalctl [ 77.034210] [ 367] 0 367 8902 482 110592 0 0 systemd-cgroups [ 77.035551] [ 371] 0 371 3675 176 65536 0 0 systemd-cgroups [ 77.037049] [ 372] 0 372 34097 297 151552 0 0 (journald) [ 77.038360] [ 373] 0 373 1075 55 45056 0 0 lkp-setup-rootf [ 77.039674] [ 374] 0 374 34097 297 147456 0 0 systemd [ 77.041630] Out of memory: Kill process 317 (cron) score 4 or sacrifice child [ 77.042676] Killed process 317 (cron) total-vm:28008kB, anon-rss:240kB, file-rss:2160kB, shmem-rss:0kB [ 77.066748] systemd invoked oom-killer: gfp_mask=0x14200ca(GFP_HIGHUSER_MOVABLE), nodemask=(null), order=0, oom_score_adj=0 [ 77.068327] CPU: 1 PID: 1 Comm: systemd Not tainted 4.17.0-rc1 #262 [ 77.069191] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014 [ 77.070467] Call Trace: [ 77.070988] dump_stack+0x71/0xab [ 77.071577] dump_header+0x14b/0x8d3 [ 77.072254] ? ___ratelimit+0x1cb/0x410 [ 77.072894] oom_kill_process+0x55f/0xc60 [ 77.073546] ? lock_downgrade+0x5e0/0x5e0 [ 77.074200] ? _raw_spin_unlock+0x1f/0x30 [ 77.074848] ? oom_badness+0x425/0x570 [ 77.075469] out_of_memory+0x214/0xf90 [ 77.076095] ? unregister_oom_notifier+0x10/0x10 [ 77.076801] ? mutex_trylock+0x15e/0x190 [ 77.077439] __alloc_pages_nodemask+0xfcd/0x19a0 [ 77.078146] ? gfp_pfmemalloc_allowed+0x150/0x150 [ 77.078867] ? kvm_sched_clock_read+0x21/0x30 [ 77.079545] ? sched_clock+0x5/0x10 [ 77.080149] ? sched_clock_cpu+0x18/0x180 [ 77.080847] ? kvm_sched_clock_read+0x21/0x30 [ 77.081534] ? sched_clock+0x5/0x10 [ 77.082136] ? sched_clock_cpu+0x18/0x180 [ 77.082783] ? kvm_sched_clock_read+0x21/0x30 [ 77.083457] ? sched_clock+0x5/0x10 [ 77.084058] wp_page_copy+0x130/0x1610 [ 77.084682] do_wp_page+0x3df/0x1870 [ 77.085286] ? finish_mkwrite_fault+0x600/0x600 [ 77.085979] ? __handle_mm_fault+0x57a/0x22b0 [ 77.086657] __handle_mm_fault+0x105c/0x22b0 [ 77.087324] ? vm_iomap_memory+0x160/0x160 [ 77.087982] __do_page_fault+0x439/0x980 [ 77.088649] ? mm_fault_error+0x2e0/0x2e0 [ 77.089665] ? search_binary_handler+0x220/0x220 [ 77.090733] do_page_fault+0x2a/0x70 [ 77.091712] ? async_page_fault+0x8/0x30 [ 77.092578] async_page_fault+0x1e/0x30 [ 77.093254] RIP: 0033:0x7f7d3b139fc8 [ 77.094238] RSP: 002b:00007ffd2c770bd0 EFLAGS: 00010246 [ 77.095008] RAX: 0000000000000001 RBX: 00007ffd2c770bd0 RCX: 00007f7d3b139e9a [ 77.096326] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000001200011 [ 77.097584] RBP: 00007ffd2c770c20 R08: 0000000000000001 R09: 00007f7d3cb81900 [ 77.098866] R10: 00007f7d3cb81bd0 R11: 0000000000000246 R12: 0000000000000001 [ 77.100469] R13: 0000000000000176 R14: 0000000000000001 R15: 000055fc312787e0 [ 77.101441] Mem-Info: [ 77.101941] active_anon:1345 inactive_anon:1922 isolated_anon:0 [ 77.101941] active_file:0 inactive_file:0 isolated_file:0 [ 77.101941] unevictable:123548 dirty:0 writeback:0 unstable:0 [ 77.101941] slab_reclaimable:7284 slab_unreclaimable:13288 [ 77.101941] mapped:2685 shmem:1945 pagetables:318 bounce:0 [ 77.101941] free:1363 free_pcp:232 free_cma:0 [ 77.106294] Node 0 active_anon:5380kB inactive_anon:7688kB active_file:0kB inactive_file:0kB unevictable:494192kB isolated(anon):0kB isolated(file):0kB mapped:10740kB dirty:0kB writeback:0kB shmem:7780kB writeback_tmp:0kB unstable:0kB all_unreclaimable? yes [ 77.109309] DMA free:2408kB min:80kB low:100kB high:120kB active_anon:784kB inactive_anon:1924kB active_file:0kB inactive_file:0kB unevictable:1180kB writepending:0kB present:15992kB managed:15904kB mlocked:0kB kernel_stack:128kB pagetables:200kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [ 77.112636] lowmem_reserve[]: 0 588 588 588 [ 77.113319] DMA32 free:3044kB min:3060kB low:3824kB high:4588kB active_anon:4596kB inactive_anon:5764kB active_file:0kB inactive_file:0kB unevictable:493012kB writepending:0kB present:1032064kB managed:602456kB mlocked:0kB kernel_stack:3200kB pagetables:1072kB bounce:0kB free_pcp:928kB local_pcp:336kB free_cma:0kB [ 77.117312] lowmem_reserve[]: 0 0 0 0 [ 77.117991] DMA: 10*4kB (UME) 16*8kB (U) 26*16kB (U) 33*32kB (UM) 12*64kB (UM) 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 2408kB [ 77.120469] DMA32: 69*4kB (UME) 56*8kB (UM) 95*16kB (UM) 26*32kB (UE) 0*64kB 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 3076kB [ 77.122486] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=1048576kB [ 77.124247] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB [ 77.126064] 125493 total pagecache pages [ 77.126763] 0 pages in swap cache [ 77.127540] Swap cache stats: add 0, delete 0, find 0/0 [ 77.128306] Free swap = 0kB [ 77.129990] Total swap = 0kB [ 77.130550] 262014 pages RAM [ 77.131317] 0 pages HighMem/MovableOnly [ 77.132124] 107424 pages reserved [ 77.132714] [ pid ] uid tgid total_vm rss pgtables_bytes swapents oom_score_adj name [ 77.134037] [ 288] 0 288 10417 767 114688 0 -1000 systemd-udevd [ 77.135350] [ 312] 0 312 16955 1412 167936 0 -1000 sshd [ 77.136582] [ 313] 101 313 10747 935 135168 0 -900 dbus-daemon [ 77.138120] [ 316] 0 316 8952 517 110592 0 0 systemd-logind [ 77.140201] [ 319] 0 319 1075 190 49152 0 0 lkp-bootstrap [ 77.141762] [ 327] 0 327 1075 33 53248 0 0 lkp-bootstrap [ 77.143162] [ 330] 0 330 1075 405 53248 0 0 lkp-setup-rootf [ 77.144491] [ 334] 0 334 1053 165 53248 0 0 sleep [ 77.145745] [ 344] 0 344 1480 182 53248 0 0 tail [ 77.146985] [ 358] 0 358 13615 288 139264 0 0 (agetty) [ 77.148254] [ 366] 0 366 8916 520 110592 0 0 journalctl [ 77.149532] [ 367] 0 367 8902 482 110592 0 0 systemd-cgroups [ 77.150855] [ 371] 0 371 3675 176 65536 0 0 systemd-cgroups [ 77.152178] [ 372] 0 372 34097 297 151552 0 0 (journald) [ 77.158761] [ 373] 0 373 1075 55 45056 0 0 lkp-setup-rootf [ 77.160542] [ 374] 0 374 34097 297 147456 0 0 systemd [ 77.161980] Out of memory: Kill process 366 (journalctl) score 3 or sacrifice child [ 77.163232] Killed process 366 (journalctl) total-vm:35664kB, anon-rss:364kB, file-rss:1716kB, shmem-rss:0kB [ 77.185020] systemd invoked oom-killer: gfp_mask=0x14200ca(GFP_HIGHUSER_MOVABLE), nodemask=(null), order=0, oom_score_adj=0 [ 77.186601] CPU: 1 PID: 1 Comm: systemd Not tainted 4.17.0-rc1 #262 [ 77.187913] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014 [ 77.189752] Call Trace: [ 77.190361] dump_stack+0x71/0xab [ 77.191252] dump_header+0x14b/0x8d3 [ 77.191923] ? ___ratelimit+0x1cb/0x410 [ 77.192554] oom_kill_process+0x55f/0xc60 [ 77.193206] ? lock_downgrade+0x5e0/0x5e0 [ 77.193855] ? _raw_spin_unlock+0x1f/0x30 [ 77.194566] ? oom_badness+0x425/0x570 [ 77.195196] out_of_memory+0x214/0xf90 [ 77.195825] ? unregister_oom_notifier+0x10/0x10 [ 77.196525] ? mutex_trylock+0x15e/0x190 [ 77.197167] __alloc_pages_nodemask+0xfcd/0x19a0 [ 77.197873] ? gfp_pfmemalloc_allowed+0x150/0x150 [ 77.198585] ? kvm_sched_clock_read+0x21/0x30 [ 77.199269] ? sched_clock+0x5/0x10 [ 77.199871] ? sched_clock_cpu+0x18/0x180 [ 77.200517] ? kvm_sched_clock_read+0x21/0x30 [ 77.201320] ? sched_clock+0x5/0x10 [ 77.202147] ? sched_clock_cpu+0x18/0x180 [ 77.202799] ? kvm_sched_clock_read+0x21/0x30 [ 77.203472] ? sched_clock+0x5/0x10 [ 77.204074] wp_page_copy+0x130/0x1610 [ 77.204697] do_wp_page+0x3df/0x1870 [ 77.205299] ? finish_mkwrite_fault+0x600/0x600 [ 77.205992] ? __handle_mm_fault+0x57a/0x22b0 [ 77.206664] __handle_mm_fault+0x105c/0x22b0 [ 77.207336] ? vm_iomap_memory+0x160/0x160 [ 77.207990] __do_page_fault+0x439/0x980 [ 77.208623] ? mm_fault_error+0x2e0/0x2e0 [ 77.209271] ? search_binary_handler+0x220/0x220 [ 77.209973] do_page_fault+0x2a/0x70 [ 77.210600] ? async_page_fault+0x8/0x30 [ 77.211246] async_page_fault+0x1e/0x30 [ 77.211876] RIP: 0033:0x7f7d3b139fc8 [ 77.212479] RSP: 002b:00007ffd2c770bd0 EFLAGS: 00010246 [ 77.213235] RAX: 0000000000000001 RBX: 00007ffd2c770bd0 RCX: 00007f7d3b139e9a [ 77.214163] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000001200011 [ 77.215091] RBP: 00007ffd2c770c20 R08: 0000000000000001 R09: 00007f7d3cb81900 [ 77.216023] R10: 00007f7d3cb81bd0 R11: 0000000000000246 R12: 0000000000000001 [ 77.216952] R13: 0000000000000176 R14: 0000000000000001 R15: 000055fc312787e0 [ 77.217911] Mem-Info: [ 77.218408] active_anon:1260 inactive_anon:1922 isolated_anon:0 [ 77.218408] active_file:0 inactive_file:0 isolated_file:0 [ 77.218408] unevictable:123548 dirty:0 writeback:0 unstable:0 [ 77.218408] slab_reclaimable:7284 slab_unreclaimable:13288 [ 77.218408] mapped:2685 shmem:1945 pagetables:293 bounce:0 [ 77.218408] free:1367 free_pcp:325 free_cma:0 [ 77.222789] Node 0 active_anon:5040kB inactive_anon:7688kB active_file:0kB inactive_file:0kB unevictable:494192kB isolated(anon):0kB isolated(file):0kB mapped:10740kB dirty:0kB writeback:0kB shmem:7780kB writeback_tmp:0kB unstable:0kB all_unreclaimable? yes [ 77.225812] DMA free:2424kB min:80kB low:100kB high:120kB active_anon:684kB inactive_anon:1924kB active_file:0kB inactive_file:0kB unevictable:1180kB writepending:0kB present:15992kB managed:15904kB mlocked:0kB kernel_stack:160kB pagetables:200kB bounce:0kB free_pcp:0kB local_pcp:0kB free_cma:0kB [ 77.229146] lowmem_reserve[]: 0 588 588 588 [ 77.229827] DMA32 free:3044kB min:3060kB low:3824kB high:4588kB active_anon:4324kB inactive_anon:5764kB active_file:0kB inactive_file:0kB unevictable:493012kB writepending:0kB present:1032064kB managed:602456kB mlocked:0kB kernel_stack:3168kB pagetables:972kB bounce:0kB free_pcp:1300kB local_pcp:708kB free_cma:0kB [ 77.233895] lowmem_reserve[]: 0 0 0 0 [ 77.234522] DMA: 12*4kB (UME) 13*8kB (U) 26*16kB (U) 34*32kB (UM) 12*64kB (UM) 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 2424kB [ 77.236197] DMA32: 69*4kB (UME) 56*8kB (UM) 95*16kB (UM) 27*32kB (UE) 0*64kB 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 0*4096kB = 3108kB [ 77.237855] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=1048576kB [ 77.239151] Node 0 hugepages_total=0 hugepages_free=0 hugepages_surp=0 hugepages_size=2048kB [ 77.240431] 125493 total pagecache pages [ 77.241076] 0 pages in swap cache [ 77.241655] Swap cache stats: add 0, delete 0, find 0/0 [ 77.242410] Free swap = 0kB [ 77.242953] Total swap = 0kB [ 77.243503] 262014 pages RAM [ 77.244051] 0 pages HighMem/MovableOnly [ 77.244676] 107424 pages reserved [ 77.245262] [ pid ] uid tgid total_vm rss pgtables_bytes swapents oom_score_adj name [ 77.246547] [ 288] 0 288 10417 767 114688 0 -1000 systemd-udevd [ 77.247846] [ 312] 0 312 16955 1412 167936 0 -1000 sshd [ 77.249159] [ 313] 101 313 10747 935 135168 0 -900 dbus-daemon [ 77.250459] [ 316] 0 316 8952 517 110592 0 0 systemd-logind [ 77.251863] [ 319] 0 319 1075 190 49152 0 0 lkp-bootstrap [ 77.254044] [ 327] 0 327 1075 33 53248 0 0 lkp-bootstrap [ 77.256234] [ 330] 0 330 1075 405 53248 0 0 lkp-setup-rootf [ 77.258499] [ 334] 0 334 1053 165 53248 0 0 sleep [ 77.260645] [ 344] 0 344 1480 182 53248 0 0 tail [ 77.262739] [ 358] 0 358 13615 288 139264 0 0 (agetty) [ 77.264837] [ 367] 0 367 8902 482 110592 0 0 systemd-cgroups [ 77.267099] [ 371] 0 371 5008 203 73728 0 0 systemd-cgroups [ 77.269325] [ 372] 0 372 34097 297 151552 0 0 (journald) [ 77.271461] [ 373] 0 373 1075 55 45056 0 0 lkp-setup-rootf [ 77.273668] [ 374] 0 374 34097 297 147456 0 0 systemd [ 77.275789] Out of memory: Kill process 316 (systemd-logind) score 3 or sacrifice child [ 77.277852] Killed process 316 (systemd-logind) total-vm:35808kB, anon-rss:380kB, file-rss:1688kB, shmem-rss:0kB [ 77.285047] systemd-logind (316) used greatest stack depth: 26816 bytes left [ 77.311941] Out of memory: Kill process 372 (systemd-journal) score 6 or sacrifice child [ 77.313993] Killed process 372 (systemd-journal) total-vm:35724kB, anon-rss:424kB, file-rss:3324kB, shmem-rss:0kB Starting Network Time Synchronization... See 'systemctl status systemd-journal-flush.service' for details. See 'systemctl status systemd-journald.service' for details. [ 77.352364] Out of memory: Kill process 374 ((imesyncd)) score 5 or sacrifice child [ 77.353631] Killed process 374 ((imesyncd)) total-vm:136388kB, anon-rss:1160kB, file-rss:2236kB, shmem-rss:0kB Starting Login Service... [ 77.377233] Out of memory: Kill process 373 (dpkg) score 5 or sacrifice child [ 77.378215] Killed process 380 (dpkg-deb) total-vm:16780kB, anon-rss:128kB, file-rss:944kB, shmem-rss:0kB Starting Journal Service... [ 77.392978] Out of memory: Kill process 373 (dpkg) score 5 or sacrifice child [ 77.394769] Killed process 385 (rm) total-vm:5916kB, anon-rss:76kB, file-rss:652kB, shmem-rss:0kB [ 77.397620] oom_reaper: reaped process 385 (rm), now anon-rss:0kB, file-rss:0kB, shmem-rss:0kB [ 77.399768] Out of memory: Kill process 373 (dpkg) score 5 or sacrifice child [ 77.401321] Killed process 373 (dpkg) total-vm:26200kB, anon-rss:940kB, file-rss:2428kB, shmem-rss:0kB [ 77.423976] Out of memory: Kill process 387 (systemd-cgroups) score 3 or sacrifice child [ 77.425252] Killed process 387 (systemd-cgroups) total-vm:35608kB, anon-rss:364kB, file-rss:1468kB, shmem-rss:0kB [ 77.508337] Out of memory: Kill process 384 (systemd-logind) score 3 or sacrifice child [ 77.510349] Killed process 384 (systemd-logind) total-vm:35808kB, anon-rss:380kB, file-rss:1716kB, shmem-rss:0kB [ 77.522564] Out of memory: Kill process 386 (systemd-journal) score 6 or sacrifice child [ 77.524849] Killed process 386 (systemd-journal) total-vm:35724kB, anon-rss:420kB, file-rss:3348kB, shmem-rss:0kB Starting RPC bind portmap service... See 'systemctl status systemd-timesyncd.service' for details. See 'systemctl status systemd-logind.service' for details. [ 77.568626] Out of memory: Kill process 393 (rpcbind) score 5 or sacrifice child [ 77.570597] Killed process 393 (rpcbind) total-vm:47732kB, anon-rss:428kB, file-rss:3008kB, shmem-rss:0kB [ 77.591014] Out of memory: Kill process 392 (dpkg) score 5 or sacrifice child [ 77.592053] Killed process 396 (dpkg-split) total-vm:4kB, anon-rss:4kB, file-rss:0kB, shmem-rss:0kB See 'systemctl status systemd-journald.service' for details. See 'systemctl status rpcbind.service' for details. Starting Network Time Synchronization... Starting Journal Service... [ 77.635051] Out of memory: Kill process 402 ((journald)) score 6 or sacrifice child [ 77.637049] Killed process 402 ((journald)) total-vm:136388kB, anon-rss:1160kB, file-rss:2412kB, shmem-rss:0kB Starting Login Service... [ 77.645520] Out of memory: Kill process 401 ((imesyncd)) score 5 or sacrifice child [ 77.646772] Killed process 401 ((imesyncd)) total-vm:136388kB, anon-rss:1160kB, file-rss:2236kB, shmem-rss:0kB [ 77.660182] Out of memory: Kill process 330 (lkp-setup-rootf) score 2 or sacrifice child [ 77.662175] Killed process 400 (ldconfig) total-vm:2948kB, anon-rss:164kB, file-rss:1048kB, shmem-rss:0kB See 'systemctl status systemd-journald.service' for details. [ 77.677242] Out of memory: Kill process 330 (lkp-setup-rootf) score 2 or sacrifice child [ 77.684700] Killed process 406 (lkp-setup-rootf) total-vm:4412kB, anon-rss:236kB, file-rss:0kB, shmem-rss:0kB See 'systemctl status systemd-timesyncd.service' for details. See 'systemctl status systemd-journald.service' for details. [ 77.712113] Out of memory: Kill process 403 (systemd-logind) score 3 or sacrifice child [ 77.714319] Killed process 403 (systemd-logind) total-vm:35808kB, anon-rss:384kB, file-rss:1720kB, shmem-rss:0kB [ 77.727912] Out of memory: Kill process 330 (lkp-setup-rootf) score 2 or sacrifice child [ 77.730303] Killed process 330 (lkp-setup-rootf) total-vm:4412kB, anon-rss:236kB, file-rss:1472kB, shmem-rss:0kB Starting Network Time Synchronization... See 'systemctl status systemd-logind.service' for details. Starting Login Service... Starting RPC bind portmap service... [ 77.769649] Out of memory: Kill process 415 ((imesyncd)) score 5 or sacrifice child [ 77.771855] Killed process 415 ((imesyncd)) total-vm:136388kB, anon-rss:1160kB, file-rss:2236kB, shmem-rss:0kB [ 77.783843] Out of memory: Kill process 417 (rpcbind) score 2 or sacrifice child [ 77.785068] Killed process 417 (rpcbind) total-vm:45492kB, anon-rss:224kB, file-rss:1292kB, shmem-rss:0kB See 'systemctl status rpcbind.service' for details. See 'systemctl status systemd-timesyncd.service' for details. Starting Network Time Synchronization... [ 77.819257] Out of memory: Kill process 416 (systemd-logind) score 3 or sacrifice child [ 77.820557] Killed process 416 (systemd-logind) total-vm:35808kB, anon-rss:380kB, file-rss:1760kB, shmem-rss:0kB [ 77.827693] Out of memory: Kill process 422 ((imesyncd)) score 2 or sacrifice child [ 77.829486] Killed process 422 ((imesyncd)) total-vm:136388kB, anon-rss:1160kB, file-rss:28kB, shmem-rss:0kB Starting Login Service... See 'systemctl status systemd-timesyncd.service' for details. Starting RPC bind portmap service... [ 78.112950] Out of memory: Kill process 425 (systemd-logind) score 3 or sacrifice child [ 78.116987] Killed process 425 (systemd-logind) total-vm:35808kB, anon-rss:380kB, file-rss:1720kB, shmem-rss:0kB See 'systemctl status systemd-logind.service' for details. Elapsed time: 80 #!/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/debian/debian-x86_64-2016-08-31.cgz /lkp/lkp/lkp-x86_64.cgz /osimage/deps/debian-x86_64-2016-08-31.cgz/run-ipconfig_2016-11-15.cgz /osimage/deps/debian-x86_64-2016-08-31.cgz/lkp_2017-12-14.cgz /osimage/deps/debian-x86_64-2016-08-31.cgz/rsync-rootfs_2016-11-15.cgz /osimage/pkg/debian-x86_64-2016-08-31.cgz/trinity-x86_64-6ddabfd2_2017-11-10.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 -cpu host -kernel $kernel -initrd initrd.img -m 1024 -smp 2 -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-1G-9::dhcp root=/dev/ram0 user=lkp job=/job-script ARCH=x86_64 kconfig=x86_64-randconfig-s5-04172210 branch=linus/master commit=60cc43fc888428bb2f18f08997432d426a243338 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-s5-04172210/gcc-7/60cc43fc888428bb2f18f08997432d426a243338/vmlinuz-4.17.0-rc1 max_uptime=1500 RESULT_ROOT=/result/trinity/300s/vm-lkp-hsw01-1G/debian-x86_64-2016-08-31.cgz/x86_64-randconfig-s5-04172210/gcc-7/60cc43fc888428bb2f18f08997432d426a243338/2 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 rcuperf.shutdown=0 ) "${kvm[@]}" -append "${append[*]}"