2016-04-26 07:24:27

by Meelis Roos

[permalink] [raw]
Subject: Bisected: spontaneous reboot in early boot on x86-64 in 4.6-rc

Today I finished bisecting a boot problem on my IBM X346 (with 64-bit P4
Xeons). 4.5.0 worked fine but I saw the spontaneous reboots during early
boot in 4.6-rc4 and bisected it down to the commit below.

The server does not seem to have NX - dmesg has this:

Notice: NX (Execute Disable) protection missing in CPU!

Full dmesg from adjacent commit is below.

320d25b6a05f8b73c23fc21025d2906ecdd2d4fc is the first bad commit
commit 320d25b6a05f8b73c23fc21025d2906ecdd2d4fc
Author: Andy Lutomirski <[email protected]>
Date: Tue Jan 19 13:38:58 2016 -0800

x86/mm/32: Set NX in __supported_pte_mask before enabling paging

There's a short window in which very early mappings can end up
with NX clear because they are created before we've noticed that
we have NX.

It turns out that we detect NX very early, so there's no need to
defer __supported_pte_mask setup.

Signed-off-by: Andy Lutomirski <[email protected]>
Cc: Andy Lutomirski <[email protected]>
Cc: Arjan van de Ven <[email protected]>
Cc: Borislav Petkov <[email protected]>
Cc: Brian Gerst <[email protected]>
Cc: Denys Vlasenko <[email protected]>
Cc: H. Peter Anvin <[email protected]>
Cc: Linus Torvalds <[email protected]>
Cc: Mike Galbraith <[email protected]>
Cc: Pavel Machek <[email protected]>
Cc: Peter Zijlstra <[email protected]>
Cc: Stephen Smalley <[email protected]>
Cc: Thomas Gleixner <[email protected]>
Link: http://lkml.kernel.org/r/2b544627345f7110160545a3f47031eb45c3ad4f.1453239349.git.luto@kernel.org
Signed-off-by: Ingo Molnar <[email protected]>

:040000 040000 63ce898a6cc03c34bbd516e3edb959641127dab5 406184ad4debca62a328cd11b5c3864b415a8861 M arch


[ 0.000000] Linux version 4.4.0-05821-g43c75f9 (mroos@x346) (gcc version 5.3.1 20160409 (Debian 5.3.1-14) ) #31 SMP Tue Apr 26 10:24:56 EEST 2016
[ 0.000000] Command line: BOOT_IMAGE=/boot/vmlinuz-4.4.0-05821-g43c75f9 root=/dev/sda1 ro
[ 0.000000] x86/fpu: Legacy x87 FPU detected.
[ 0.000000] x86/fpu: Using 'lazy' FPU context switches.
[ 0.000000] e820: BIOS-provided physical RAM map:
[ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009bfff] usable
[ 0.000000] BIOS-e820: [mem 0x000000000009c000-0x000000000009ffff] reserved
[ 0.000000] BIOS-e820: [mem 0x00000000000e0000-0x00000000000fffff] reserved
[ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000d7fcc9ff] usable
[ 0.000000] BIOS-e820: [mem 0x00000000d7fcca00-0x00000000d7fcffff] ACPI data
[ 0.000000] BIOS-e820: [mem 0x00000000d7fd0000-0x00000000d7ffffff] reserved
[ 0.000000] BIOS-e820: [mem 0x00000000e0000000-0x00000000efffffff] reserved
[ 0.000000] BIOS-e820: [mem 0x00000000fec00000-0x00000000ffffffff] reserved
[ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x0000000167ffffff] usable
[ 0.000000] Notice: NX (Execute Disable) protection missing in CPU!
[ 0.000000] SMBIOS 2.3 present.
[ 0.000000] DMI: IBM eserver xSeries 346 -[8840ECY]-/, BIOS -[KPE144AUS-1.17]- 09/11/2007
[ 0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[ 0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
[ 0.000000] e820: last_pfn = 0x168000 max_arch_pfn = 0x400000000
[ 0.000000] MTRR default type: uncachable
[ 0.000000] MTRR fixed ranges enabled:
[ 0.000000] 00000-9FFFF write-back
[ 0.000000] A0000-BFFFF uncachable
[ 0.000000] C0000-CFFFF write-protect
[ 0.000000] D0000-DFFFF uncachable
[ 0.000000] E0000-FFFFF write-protect
[ 0.000000] MTRR variable ranges enabled:
[ 0.000000] 0 base 000000000 mask F00000000 write-back
[ 0.000000] 1 base 0D8000000 mask FF8000000 uncachable
[ 0.000000] 2 base 0E0000000 mask FE0000000 uncachable
[ 0.000000] 3 base 100000000 mask F00000000 write-back
[ 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 WC UC- UC
[ 0.000000] original variable MTRRs
[ 0.000000] reg 0, base: 0GB, range: 4GB, type WB
[ 0.000000] reg 1, base: 3456MB, range: 128MB, type UC
[ 0.000000] reg 2, base: 3584MB, range: 512MB, type UC
[ 0.000000] reg 3, base: 4GB, range: 4GB, type WB
[ 0.000000] total RAM covered: 7552M
[ 0.000000] Found optimal setting for mtrr clean up
[ 0.000000] gran_size: 64K chunk_size: 1G num_reg: 4 lose cover RAM: 0G
[ 0.000000] New variable MTRRs
[ 0.000000] reg 0, base: 0GB, range: 4GB, type WB
[ 0.000000] reg 1, base: 3456MB, range: 128MB, type UC
[ 0.000000] reg 2, base: 3584MB, range: 512MB, type UC
[ 0.000000] reg 3, base: 4GB, range: 4GB, type WB
[ 0.000000] e820: update [mem 0xd8000000-0xffffffff] usable ==> reserved
[ 0.000000] e820: last_pfn = 0xd7fcc max_arch_pfn = 0x400000000
[ 0.000000] found SMP MP-table at [mem 0x0009c140-0x0009c14f] mapped at [ffff88000009c140]
[ 0.000000] Base memory trampoline at [ffff880000096000] 96000 size 24576
[ 0.000000] BRK [0x017bd000, 0x017bdfff] PGTABLE
[ 0.000000] BRK [0x017be000, 0x017befff] PGTABLE
[ 0.000000] BRK [0x017bf000, 0x017bffff] PGTABLE
[ 0.000000] BRK [0x017c0000, 0x017c0fff] PGTABLE
[ 0.000000] BRK [0x017c1000, 0x017c1fff] PGTABLE
[ 0.000000] ACPI: Early table checksum verification disabled
[ 0.000000] ACPI: RSDP 0x00000000000FDFB0 000024 (v02 IBM )
[ 0.000000] ACPI: XSDT 0x00000000D7FCFF00 000044 (v01 IBM SERONYXP 00001001 IBM 45444F43)
[ 0.000000] ACPI: FACP 0x00000000D7FCFE40 000084 (v02 IBM SERONYXP 00001001 IBM 45444F43)
[ 0.000000] ACPI: DSDT 0x00000000D7FCCA00 002595 (v02 IBM SERTURQU 00001000 INTL 20041203)
[ 0.000000] ACPI: FACS 0x00000000D7FCFD00 000040
[ 0.000000] ACPI: APIC 0x00000000D7FCFD80 0000B4 (v01 IBM SERONYXP 00001001 IBM 45444F43)
[ 0.000000] ACPI: MCFG 0x00000000D7FCFD40 00003C (v01 IBM SERONYXP 00001001 IBM 45444F43)
[ 0.000000] ACPI: SSDT 0x00000000D7FCFA40 0002BD (v02 IBM YETA0 00001000 INTL 20041203)
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] Zone ranges:
[ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff]
[ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000ffffffff]
[ 0.000000] Normal [mem 0x0000000100000000-0x0000000167ffffff]
[ 0.000000] Movable zone start for each node
[ 0.000000] Early memory node ranges
[ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009bfff]
[ 0.000000] node 0: [mem 0x0000000000100000-0x00000000d7fcbfff]
[ 0.000000] node 0: [mem 0x0000000100000000-0x0000000167ffffff]
[ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x0000000167ffffff]
[ 0.000000] On node 0 totalpages: 1310567
[ 0.000000] DMA zone: 64 pages used for memmap
[ 0.000000] DMA zone: 21 pages reserved
[ 0.000000] DMA zone: 3995 pages, LIFO batch:0
[ 0.000000] DMA32 zone: 13760 pages used for memmap
[ 0.000000] DMA32 zone: 880588 pages, LIFO batch:31
[ 0.000000] Normal zone: 6656 pages used for memmap
[ 0.000000] Normal zone: 425984 pages, LIFO batch:31
[ 0.000000] ACPI: PM-Timer IO Port: 0x588
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x00] dfl dfl lint[0x1])
[ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1])
[ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x02] dfl dfl lint[0x1])
[ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x03] dfl dfl lint[0x1])
[ 0.000000] IOAPIC[0]: apic_id 14, version 32, address 0xfec00000, GSI 0-23
[ 0.000000] IOAPIC[1]: apic_id 13, version 32, address 0xfec84000, GSI 24-47
[ 0.000000] IOAPIC[2]: apic_id 12, version 32, address 0xfec84400, GSI 48-71
[ 0.000000] IOAPIC[3]: apic_id 11, version 32, address 0xfec80000, GSI 72-95
[ 0.000000] IOAPIC[4]: apic_id 10, version 32, address 0xfec80400, GSI 96-119
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[ 0.000000] ACPI: IRQ0 used by override.
[ 0.000000] ACPI: IRQ9 used by override.
[ 0.000000] Using ACPI (MADT) for SMP configuration information
[ 0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs
[ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
[ 0.000000] PM: Registered nosave memory: [mem 0x0009c000-0x0009ffff]
[ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000dffff]
[ 0.000000] PM: Registered nosave memory: [mem 0x000e0000-0x000fffff]
[ 0.000000] PM: Registered nosave memory: [mem 0xd7fcc000-0xd7fccfff]
[ 0.000000] PM: Registered nosave memory: [mem 0xd7fcd000-0xd7fcffff]
[ 0.000000] PM: Registered nosave memory: [mem 0xd7fd0000-0xd7ffffff]
[ 0.000000] PM: Registered nosave memory: [mem 0xd8000000-0xdfffffff]
[ 0.000000] PM: Registered nosave memory: [mem 0xe0000000-0xefffffff]
[ 0.000000] PM: Registered nosave memory: [mem 0xf0000000-0xfebfffff]
[ 0.000000] PM: Registered nosave memory: [mem 0xfec00000-0xffffffff]
[ 0.000000] e820: [mem 0xf0000000-0xfebfffff] available for PCI devices
[ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns
[ 0.000000] setup_percpu: NR_CPUS:4 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1
[ 0.000000] PERCPU: Embedded 31 pages/cpu @ffff880167c00000 s88088 r8192 d30696 u524288
[ 0.000000] pcpu-alloc: s88088 r8192 d30696 u524288 alloc=1*2097152
[ 0.000000] pcpu-alloc: [0] 0 1 2 3
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 1290066
[ 0.000000] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-4.4.0-05821-g43c75f9 root=/dev/sda1 ro
[ 0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes)
[ 0.000000] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes)
[ 0.000000] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes)
[ 0.000000] Memory: 5073360K/5242268K available (4039K kernel code, 429K rwdata, 1320K rodata, 780K init, 536K bss, 168908K reserved, 0K cma-reserved)
[ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[ 0.000000] Hierarchical RCU implementation.
[ 0.000000] Build-time adjustment of leaf fanout to 64.
[ 0.000000] NR_IRQS:4352 nr_irqs:1024 16
[ 0.000000] Offload RCU callbacks from all CPUs
[ 0.000000] Offload RCU callbacks from CPUs: 0-3.
[ 0.000000] Console: colour VGA+ 80x25
[ 0.000000] console [tty0] enabled
[ 0.000000] tsc: Fast TSC calibration using PIT
[ 0.000000] tsc: Detected 3200.075 MHz processor
[ 0.008016] Calibrating delay loop (skipped), value calculated using timer frequency.. 6400.15 BogoMIPS (lpj=12800300)
[ 0.008468] pid_max: default: 32768 minimum: 301
[ 0.008700] ACPI: Core revision 20151218
[ 0.012698] ACPI: 2 ACPI AML tables successfully acquired and loaded

[ 0.013242] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes)
[ 0.013469] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes)
[ 0.014399] CPU: Physical Processor ID: 0
[ 0.014629] CPU: Processor Core ID: 0
[ 0.014847] mce: CPU supports 4 MCE banks
[ 0.015086] CPU0: Thermal monitoring enabled (TM1)
[ 0.015310] process: using mwait in idle threads
[ 0.015542] Last level iTLB entries: 4KB 64, 2MB 64, 4MB 64
[ 0.015764] Last level dTLB entries: 4KB 64, 2MB 0, 4MB 64, 1GB 0
[ 0.016416] Freeing SMP alternatives memory: 20K (ffffffff81730000 - ffffffff81735000)
[ 0.018801] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[ 0.060000] smpboot: CPU0: Intel(R) Xeon(TM) CPU 3.20GHz (family: 0xf, model: 0x3, stepping: 0x4)
[ 0.060000] Performance Events: Netburst events, Netburst P4/Xeon PMU driver.
[ 0.060000] ... version: 0
[ 0.060000] ... bit width: 40
[ 0.060000] ... generic registers: 18
[ 0.060000] ... value mask: 000000ffffffffff
[ 0.060000] ... max period: 0000007fffffffff
[ 0.060000] ... fixed-purpose events: 0
[ 0.060000] ... event mask: 000000000003ffff
[ 0.060000] x86: Booting SMP configuration:
[ 0.060000] .... node #0, CPUs: #1
[ 0.070053] NMI watchdog: enabled on all CPUs, permanently consumes one hw-PMU counter.
[ 0.152206] #2 #3
[ 0.178750] x86: Booted up 1 node, 4 CPUs
[ 0.179169] smpboot: Total of 4 processors activated (25601.60 BogoMIPS)
[ 0.180115] devtmpfs: initialized
[ 0.180622] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[ 0.181049] NET: Registered protocol family 16
[ 0.184014] cpuidle: using governor ladder
[ 0.188011] cpuidle: using governor menu
[ 0.188247] ACPI: bus type PCI registered
[ 0.188525] PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xe0000000-0xefffffff] (base 0xe0000000)
[ 0.188897] PCI: Intel Corporation E7520 Memory Controller Hub with MMCONFIG support
[ 0.189270] PCI: MMCONFIG at [mem 0xe0000000-0xefffffff] reserved in E820
[ 0.189490] pmd_set_huge: Cannot satisfy [mem 0xe0000000-0xe0200000] with a huge-page mapping due to MTRR override.
[ 0.190297] PCI: Using configuration type 1 for base access
[ 0.192089] ACPI: Added _OSI(Module Device)
[ 0.192274] ACPI: Added _OSI(Processor Device)
[ 0.192479] ACPI: Added _OSI(3.0 _SCP Extensions)
[ 0.192685] ACPI: Added _OSI(Processor Aggregator Device)
[ 0.195042] ACPI: Interpreter enabled
[ 0.195270] ACPI: (supports S0 S4 S5)
[ 0.195476] ACPI: Using IOAPIC for interrupt routing
[ 0.196051] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[ 0.210722] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[ 0.210941] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI]
[ 0.211317] acpi PNP0A08:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
[ 0.221947] acpi PNP0A08:00: ignoring host bridge window [mem 0x000c8000-0x000dffff window] (conflicts with Video ROM [mem 0x000c0000-0x000cafff])
[ 0.222392] PCI host bridge to bus 0000:00
[ 0.222601] pci_bus 0000:00: root bus resource [mem 0xf24000000-0xfffffffff window]
[ 0.222969] pci_bus 0000:00: root bus resource [mem 0xea4000000-0xee3ffffff window]
[ 0.223338] pci_bus 0000:00: root bus resource [mem 0xe24000000-0xe63ffffff window]
[ 0.223705] pci_bus 0000:00: root bus resource [mem 0xda4000000-0xde3ffffff window]
[ 0.224005] pci_bus 0000:00: root bus resource [mem 0xd24000000-0xd63ffffff window]
[ 0.224374] pci_bus 0000:00: root bus resource [mem 0xca4000000-0xce3ffffff window]
[ 0.224741] pci_bus 0000:00: root bus resource [mem 0xc24000000-0xc63ffffff window]
[ 0.225109] pci_bus 0000:00: root bus resource [mem 0xba4000000-0xbe3ffffff window]
[ 0.225478] pci_bus 0000:00: root bus resource [mem 0xb24000000-0xb63ffffff window]
[ 0.225846] pci_bus 0000:00: root bus resource [mem 0xaa4000000-0xae3ffffff window]
[ 0.226213] pci_bus 0000:00: root bus resource [mem 0xa24000000-0xa63ffffff window]
[ 0.226581] pci_bus 0000:00: root bus resource [mem 0x9a4000000-0x9e3ffffff window]
[ 0.228004] pci_bus 0000:00: root bus resource [mem 0x924000000-0x963ffffff window]
[ 0.228371] pci_bus 0000:00: root bus resource [mem 0x8a4000000-0x8e3ffffff window]
[ 0.228739] pci_bus 0000:00: root bus resource [mem 0x824000000-0x863ffffff window]
[ 0.229107] pci_bus 0000:00: root bus resource [mem 0x7a4000000-0x7e3ffffff window]
[ 0.232003] pci_bus 0000:00: root bus resource [mem 0x724000000-0x763ffffff window]
[ 0.232371] pci_bus 0000:00: root bus resource [mem 0x6a4000000-0x6e3ffffff window]
[ 0.232738] pci_bus 0000:00: root bus resource [mem 0x624000000-0x663ffffff window]
[ 0.233106] pci_bus 0000:00: root bus resource [mem 0x5a4000000-0x5e3ffffff window]
[ 0.233475] pci_bus 0000:00: root bus resource [mem 0x524000000-0x563ffffff window]
[ 0.233843] pci_bus 0000:00: root bus resource [mem 0x4a4000000-0x4e3ffffff window]
[ 0.234210] pci_bus 0000:00: root bus resource [mem 0x424000000-0x463ffffff window]
[ 0.234577] pci_bus 0000:00: root bus resource [mem 0x3a4000000-0x3e3ffffff window]
[ 0.234944] pci_bus 0000:00: root bus resource [mem 0x324000000-0x363ffffff window]
[ 0.235312] pci_bus 0000:00: root bus resource [mem 0x2a4000000-0x2e3ffffff window]
[ 0.235679] pci_bus 0000:00: root bus resource [mem 0xd8000000-0xffffffff window]
[ 0.236004] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[ 0.236373] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
[ 0.236584] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
[ 0.236794] pci_bus 0000:00: root bus resource [bus 00-ff]
[ 0.237016] pci 0000:00:00.0: [8086:3590] type 00 class 0x060000
[ 0.237040] pci 0000:00:00.0: reg 0x14: [mem 0xff000000-0xff000fff]
[ 0.237175] pci 0000:00:00.1: [8086:3591] type 00 class 0xff0000
[ 0.237314] pci 0000:00:02.0: [8086:3595] type 01 class 0x060400
[ 0.237379] pci 0000:00:02.0: PME# supported from D0 D3hot D3cold
[ 0.237501] pci 0000:00:04.0: [8086:3597] type 01 class 0x060400
[ 0.237564] pci 0000:00:04.0: PME# supported from D0 D3hot D3cold
[ 0.237680] pci 0000:00:05.0: [8086:3598] type 01 class 0x060400
[ 0.237744] pci 0000:00:05.0: PME# supported from D0 D3hot D3cold
[ 0.237850] pci 0000:00:06.0: [8086:3599] type 01 class 0x060400
[ 0.237913] pci 0000:00:06.0: PME# supported from D0 D3hot D3cold
[ 0.238022] pci 0000:00:08.0: [8086:359b] type 00 class 0x088000
[ 0.238173] pci 0000:00:1d.0: [8086:24d2] type 00 class 0x0c0300
[ 0.238230] pci 0000:00:1d.0: reg 0x20: [io 0x2200-0x221f]
[ 0.238350] pci 0000:00:1d.1: [8086:24d4] type 00 class 0x0c0300
[ 0.238406] pci 0000:00:1d.1: reg 0x20: [io 0x2600-0x261f]
[ 0.238539] pci 0000:00:1d.7: [8086:24dd] type 00 class 0x0c0320
[ 0.238572] pci 0000:00:1d.7: reg 0x10: [mem 0xf9000000-0xf90003ff]
[ 0.238657] pci 0000:00:1d.7: PME# supported from D0 D3hot D3cold
[ 0.238765] pci 0000:00:1e.0: [8086:244e] type 01 class 0x060400
[ 0.238903] pci 0000:00:1f.0: [8086:24d0] type 00 class 0x060100
[ 0.238987] pci 0000:00:1f.0: Force enabled HPET at 0xfed00000
[ 0.238998] pci 0000:00:1f.0: quirk: [io 0x0580-0x05ff] claimed by ICH4 ACPI/GPIO/TCO
[ 0.239371] pci 0000:00:1f.0: quirk: [io 0x0400-0x043f] claimed by ICH4 GPIO
[ 0.239676] pci 0000:00:1f.1: [8086:24db] type 00 class 0x01018a
[ 0.239697] pci 0000:00:1f.1: reg 0x10: [io 0x01f0-0x01f7]
[ 0.239709] pci 0000:00:1f.1: reg 0x14: [io 0x03f4-0x03f7]
[ 0.239720] pci 0000:00:1f.1: reg 0x18: [io 0x0170-0x0177]
[ 0.239732] pci 0000:00:1f.1: reg 0x1c: [io 0x0374-0x0377]
[ 0.240010] pci 0000:00:1f.1: reg 0x20: [io 0x0480-0x048f]
[ 0.240023] pci 0000:00:1f.1: reg 0x24: [mem 0x00000000-0x000003ff]
[ 0.240039] pci 0000:00:1f.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
[ 0.240250] pci 0000:00:1f.1: legacy IDE quirk: reg 0x14: [io 0x03f6]
[ 0.240459] pci 0000:00:1f.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
[ 0.240670] pci 0000:00:1f.1: legacy IDE quirk: reg 0x1c: [io 0x0376]
[ 0.240973] pci 0000:00:1f.3: [8086:24d3] type 00 class 0x0c0500
[ 0.241029] pci 0000:00:1f.3: reg 0x20: [io 0x0440-0x045f]
[ 0.241202] pci 0000:02:00.0: [8086:0329] type 01 class 0x060400
[ 0.241218] pci 0000:02:00.0: PXH quirk detected; SHPC device MSI disabled
[ 0.241485] pci 0000:02:00.0: PME# supported from D0 D3hot D3cold
[ 0.241590] pci 0000:02:00.2: [8086:032a] type 01 class 0x060400
[ 0.241605] pci 0000:02:00.2: PXH quirk detected; SHPC device MSI disabled
[ 0.241870] pci 0000:02:00.2: PME# supported from D0 D3hot D3cold
[ 0.241964] pci 0000:02:00.0: disabling ASPM on pre-1.1 PCIe device. You can enable it with 'pcie_aspm=force'
[ 0.242344] pci 0000:00:02.0: PCI bridge to [bus 02-04]
[ 0.242642] pci 0000:02:00.0: PCI bridge to [bus 03]
[ 0.242940] pci 0000:02:00.2: PCI bridge to [bus 04]
[ 0.243231] pci 0000:05:00.0: [14e4:1659] type 00 class 0x020000
[ 0.243274] pci 0000:05:00.0: reg 0x10: [mem 0xdeff0000-0xdeffffff 64bit]
[ 0.243371] pci 0000:05:00.0: PME# supported from D3hot D3cold
[ 0.243451] pci 0000:05:00.0: disabling ASPM on pre-1.1 PCIe device. You can enable it with 'pcie_aspm=force'
[ 0.243832] pci 0000:00:04.0: PCI bridge to [bus 05]
[ 0.244008] pci 0000:00:04.0: bridge window [mem 0xdd000000-0xdeffffff]
[ 0.244080] pci 0000:06:00.0: [14e4:1659] type 00 class 0x020000
[ 0.244122] pci 0000:06:00.0: reg 0x10: [mem 0xdcff0000-0xdcffffff 64bit]
[ 0.244217] pci 0000:06:00.0: PME# supported from D3hot D3cold
[ 0.244296] pci 0000:06:00.0: disabling ASPM on pre-1.1 PCIe device. You can enable it with 'pcie_aspm=force'
[ 0.244677] pci 0000:00:05.0: PCI bridge to [bus 06]
[ 0.244889] pci 0000:00:05.0: bridge window [mem 0xdb000000-0xdcffffff]
[ 0.244956] pci 0000:07:00.0: [8086:0330] type 01 class 0x060400
[ 0.245025] pci 0000:07:00.0: PME# supported from D0 D3hot D3cold
[ 0.245127] pci 0000:07:00.2: [8086:0332] type 01 class 0x060400
[ 0.245197] pci 0000:07:00.2: PME# supported from D0 D3hot D3cold
[ 0.245292] pci 0000:07:00.0: disabling ASPM on pre-1.1 PCIe device. You can enable it with 'pcie_aspm=force'
[ 0.245673] pci 0000:00:06.0: PCI bridge to [bus 07-09]
[ 0.245884] pci 0000:00:06.0: bridge window [io 0x4000-0xffff]
[ 0.245889] pci 0000:00:06.0: bridge window [mem 0xd9000000-0xdaffffff]
[ 0.245974] pci 0000:08:0e.0: [9005:0250] type 00 class 0x010400
[ 0.246012] pci 0000:08:0e.0: reg 0x10: [mem 0xdafff000-0xdaffffff]
[ 0.246067] pci 0000:08:0e.0: reg 0x30: [mem 0x00000000-0x00007fff pref]
[ 0.246104] pci 0000:08:0e.0: supports D1
[ 0.246177] pci 0000:07:00.0: PCI bridge to [bus 08]
[ 0.246390] pci 0000:07:00.0: bridge window [mem 0xd9000000-0xdaffffff]
[ 0.246481] pci 0000:07:00.2: PCI bridge to [bus 09]
[ 0.246693] pci 0000:07:00.2: bridge window [io 0x4000-0xffff]
[ 0.246765] pci 0000:01:06.0: [1002:5159] type 00 class 0x030000
[ 0.246792] pci 0000:01:06.0: reg 0x10: [mem 0xf0000000-0xf7ffffff pref]
[ 0.246804] pci 0000:01:06.0: reg 0x14: [io 0x3000-0x30ff]
[ 0.246815] pci 0000:01:06.0: reg 0x18: [mem 0xf8000000-0xf800ffff]
[ 0.246853] pci 0000:01:06.0: reg 0x30: [mem 0x00000000-0x0001ffff pref]
[ 0.246883] pci 0000:01:06.0: supports D1 D2
[ 0.246969] pci 0000:00:1e.0: PCI bridge to [bus 01] (subtractive decode)
[ 0.247185] pci 0000:00:1e.0: bridge window [io 0x3000-0x3fff]
[ 0.247191] pci 0000:00:1e.0: bridge window [mem 0xf8000000-0xf8ffffff]
[ 0.247197] pci 0000:00:1e.0: bridge window [mem 0xf0000000-0xf7ffffff pref]
[ 0.247200] pci 0000:00:1e.0: bridge window [mem 0xf24000000-0xfffffffff window] (subtractive decode)
[ 0.247203] pci 0000:00:1e.0: bridge window [mem 0xea4000000-0xee3ffffff window] (subtractive decode)
[ 0.247206] pci 0000:00:1e.0: bridge window [mem 0xe24000000-0xe63ffffff window] (subtractive decode)
[ 0.247209] pci 0000:00:1e.0: bridge window [mem 0xda4000000-0xde3ffffff window] (subtractive decode)
[ 0.247212] pci 0000:00:1e.0: bridge window [mem 0xd24000000-0xd63ffffff window] (subtractive decode)
[ 0.247215] pci 0000:00:1e.0: bridge window [mem 0xca4000000-0xce3ffffff window] (subtractive decode)
[ 0.247218] pci 0000:00:1e.0: bridge window [mem 0xc24000000-0xc63ffffff window] (subtractive decode)
[ 0.247221] pci 0000:00:1e.0: bridge window [mem 0xba4000000-0xbe3ffffff window] (subtractive decode)
[ 0.247224] pci 0000:00:1e.0: bridge window [mem 0xb24000000-0xb63ffffff window] (subtractive decode)
[ 0.247227] pci 0000:00:1e.0: bridge window [mem 0xaa4000000-0xae3ffffff window] (subtractive decode)
[ 0.247230] pci 0000:00:1e.0: bridge window [mem 0xa24000000-0xa63ffffff window] (subtractive decode)
[ 0.247232] pci 0000:00:1e.0: bridge window [mem 0x9a4000000-0x9e3ffffff window] (subtractive decode)
[ 0.247235] pci 0000:00:1e.0: bridge window [mem 0x924000000-0x963ffffff window] (subtractive decode)
[ 0.247238] pci 0000:00:1e.0: bridge window [mem 0x8a4000000-0x8e3ffffff window] (subtractive decode)
[ 0.247241] pci 0000:00:1e.0: bridge window [mem 0x824000000-0x863ffffff window] (subtractive decode)
[ 0.247244] pci 0000:00:1e.0: bridge window [mem 0x7a4000000-0x7e3ffffff window] (subtractive decode)
[ 0.247247] pci 0000:00:1e.0: bridge window [mem 0x724000000-0x763ffffff window] (subtractive decode)
[ 0.247250] pci 0000:00:1e.0: bridge window [mem 0x6a4000000-0x6e3ffffff window] (subtractive decode)
[ 0.247253] pci 0000:00:1e.0: bridge window [mem 0x624000000-0x663ffffff window] (subtractive decode)
[ 0.247256] pci 0000:00:1e.0: bridge window [mem 0x5a4000000-0x5e3ffffff window] (subtractive decode)
[ 0.247259] pci 0000:00:1e.0: bridge window [mem 0x524000000-0x563ffffff window] (subtractive decode)
[ 0.247262] pci 0000:00:1e.0: bridge window [mem 0x4a4000000-0x4e3ffffff window] (subtractive decode)
[ 0.247265] pci 0000:00:1e.0: bridge window [mem 0x424000000-0x463ffffff window] (subtractive decode)
[ 0.247268] pci 0000:00:1e.0: bridge window [mem 0x3a4000000-0x3e3ffffff window] (subtractive decode)
[ 0.247271] pci 0000:00:1e.0: bridge window [mem 0x324000000-0x363ffffff window] (subtractive decode)
[ 0.247274] pci 0000:00:1e.0: bridge window [mem 0x2a4000000-0x2e3ffffff window] (subtractive decode)
[ 0.247277] pci 0000:00:1e.0: bridge window [mem 0xd8000000-0xffffffff window] (subtractive decode)
[ 0.247280] pci 0000:00:1e.0: bridge window [mem 0x000a0000-0x000bffff window] (subtractive decode)
[ 0.247283] pci 0000:00:1e.0: bridge window [io 0x0d00-0xffff window] (subtractive decode)
[ 0.247285] pci 0000:00:1e.0: bridge window [io 0x0000-0x0cf7 window] (subtractive decode)
[ 0.247313] pci_bus 0000:00: on NUMA node 0
[ 0.248103] ACPI: PCI Interrupt Link [LP00] (IRQs *3)
[ 0.248594] ACPI: PCI Interrupt Link [LP01] (IRQs *11)
[ 0.249083] ACPI: PCI Interrupt Link [LP02] (IRQs *10)
[ 0.249578] ACPI: PCI Interrupt Link [LP03] (IRQs *5)
[ 0.250065] ACPI: PCI Interrupt Link [LP04] (IRQs *11)
[ 0.250551] ACPI: PCI Interrupt Link [LP05] (IRQs) *0, disabled.
[ 0.251081] ACPI: PCI Interrupt Link [LP06] (IRQs) *0, disabled.
[ 0.251615] ACPI: PCI Interrupt Link [LP07] (IRQs *7)
[ 0.252142] vgaarb: setting as boot device: PCI:0000:01:06.0
[ 0.252237] vgaarb: device added: PCI:0000:01:06.0,decodes=io+mem,owns=io+mem,locks=none
[ 0.252606] vgaarb: loaded
[ 0.252811] vgaarb: bridge control possible 0000:01:06.0
[ 0.253133] SCSI subsystem initialized
[ 0.253411] PCI: Using ACPI for IRQ routing
[ 0.263243] PCI: pci_cache_line_size set to 64 bytes
[ 0.263324] e820: reserve RAM buffer [mem 0x0009c000-0x0009ffff]
[ 0.263329] e820: reserve RAM buffer [mem 0xd7fcca00-0xd7ffffff]
[ 0.263641] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 133484882848 ns
[ 0.264008] hpet clockevent registered
[ 0.264014] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
[ 0.264228] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
[ 0.264605] hpet0: 3 comparators, 64-bit 14.318180 MHz counter
[ 0.266835] clocksource: Switched to clocksource hpet
[ 0.266835] pnp: PnP ACPI init
[ 0.266835] system 00:00: [io 0x0520-0x053f] has been reserved
[ 0.266835] system 00:00: [io 0x0540-0x0547] has been reserved
[ 0.266835] system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active)
[ 0.266835] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active)
[ 0.266835] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active)
[ 0.266835] pnp 00:03: [dma 2]
[ 0.266835] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active)
[ 0.267204] pnp 00:04: Plug and Play ACPI device, IDs PNP0501 (active)
[ 0.267261] pnp 00:05: Plug and Play ACPI device, IDs PNP0b00 (active)
[ 0.267369] system 00:06: [io 0x0400-0x043f] has been reserved
[ 0.267582] system 00:06: [io 0x04d0-0x04d1] has been reserved
[ 0.267797] system 00:06: [io 0x0540-0x055f] could not be reserved
[ 0.268018] system 00:06: [io 0x0580-0x05ff] has been reserved
[ 0.268228] system 00:06: [io 0x0800-0x080f] has been reserved
[ 0.268437] system 00:06: [io 0x0ca8-0x0caf] has been reserved
[ 0.268648] system 00:06: [mem 0xe0000000-0xefffffff] has been reserved
[ 0.268858] system 00:06: [mem 0xfed20800-0xfed208ff] has been reserved
[ 0.269069] system 00:06: [mem 0xfed30800-0xfed308ff] has been reserved
[ 0.269280] system 00:06: [mem 0xff000000-0xff000fff] has been reserved
[ 0.269490] system 00:06: [mem 0xfff00000-0xffffffff] has been reserved
[ 0.269704] system 00:06: Plug and Play ACPI device, IDs PNP0c02 (active)
[ 0.269949] pnp: PnP ACPI: found 7 devices
[ 0.278064] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[ 0.278518] pci 0000:00:1f.1: BAR 5: assigned [mem 0xd8000000-0xd80003ff]
[ 0.278734] pci 0000:02:00.0: PCI bridge to [bus 03]
[ 0.278951] pci 0000:02:00.2: PCI bridge to [bus 04]
[ 0.279167] pci 0000:00:02.0: PCI bridge to [bus 02-04]
[ 0.279383] pci 0000:00:04.0: PCI bridge to [bus 05]
[ 0.279594] pci 0000:00:04.0: bridge window [mem 0xdd000000-0xdeffffff]
[ 0.279810] pci 0000:00:05.0: PCI bridge to [bus 06]
[ 0.280029] pci 0000:00:05.0: bridge window [mem 0xdb000000-0xdcffffff]
[ 0.280249] pci 0000:08:0e.0: BAR 6: assigned [mem 0xd9000000-0xd9007fff pref]
[ 0.280619] pci 0000:07:00.0: PCI bridge to [bus 08]
[ 0.280829] pci 0000:07:00.0: bridge window [mem 0xd9000000-0xdaffffff]
[ 0.281044] pci 0000:07:00.2: PCI bridge to [bus 09]
[ 0.281253] pci 0000:07:00.2: bridge window [io 0x4000-0xffff]
[ 0.281469] pci 0000:00:06.0: PCI bridge to [bus 07-09]
[ 0.281678] pci 0000:00:06.0: bridge window [io 0x4000-0xffff]
[ 0.281889] pci 0000:00:06.0: bridge window [mem 0xd9000000-0xdaffffff]
[ 0.282109] pci 0000:01:06.0: BAR 6: assigned [mem 0xf8020000-0xf803ffff pref]
[ 0.282477] pci 0000:00:1e.0: PCI bridge to [bus 01]
[ 0.282686] pci 0000:00:1e.0: bridge window [io 0x3000-0x3fff]
[ 0.282899] pci 0000:00:1e.0: bridge window [mem 0xf8000000-0xf8ffffff]
[ 0.283112] pci 0000:00:1e.0: bridge window [mem 0xf0000000-0xf7ffffff pref]
[ 0.283486] pci_bus 0000:00: resource 4 [mem 0xf24000000-0xfffffffff window]
[ 0.283489] pci_bus 0000:00: resource 5 [mem 0xea4000000-0xee3ffffff window]
[ 0.283492] pci_bus 0000:00: resource 6 [mem 0xe24000000-0xe63ffffff window]
[ 0.283494] pci_bus 0000:00: resource 7 [mem 0xda4000000-0xde3ffffff window]
[ 0.283497] pci_bus 0000:00: resource 8 [mem 0xd24000000-0xd63ffffff window]
[ 0.283499] pci_bus 0000:00: resource 9 [mem 0xca4000000-0xce3ffffff window]
[ 0.283502] pci_bus 0000:00: resource 10 [mem 0xc24000000-0xc63ffffff window]
[ 0.283505] pci_bus 0000:00: resource 11 [mem 0xba4000000-0xbe3ffffff window]
[ 0.283507] pci_bus 0000:00: resource 12 [mem 0xb24000000-0xb63ffffff window]
[ 0.283510] pci_bus 0000:00: resource 13 [mem 0xaa4000000-0xae3ffffff window]
[ 0.283512] pci_bus 0000:00: resource 14 [mem 0xa24000000-0xa63ffffff window]
[ 0.283515] pci_bus 0000:00: resource 15 [mem 0x9a4000000-0x9e3ffffff window]
[ 0.283517] pci_bus 0000:00: resource 16 [mem 0x924000000-0x963ffffff window]
[ 0.283520] pci_bus 0000:00: resource 17 [mem 0x8a4000000-0x8e3ffffff window]
[ 0.283522] pci_bus 0000:00: resource 18 [mem 0x824000000-0x863ffffff window]
[ 0.283525] pci_bus 0000:00: resource 19 [mem 0x7a4000000-0x7e3ffffff window]
[ 0.283527] pci_bus 0000:00: resource 20 [mem 0x724000000-0x763ffffff window]
[ 0.283530] pci_bus 0000:00: resource 21 [mem 0x6a4000000-0x6e3ffffff window]
[ 0.283532] pci_bus 0000:00: resource 22 [mem 0x624000000-0x663ffffff window]
[ 0.283535] pci_bus 0000:00: resource 23 [mem 0x5a4000000-0x5e3ffffff window]
[ 0.283537] pci_bus 0000:00: resource 24 [mem 0x524000000-0x563ffffff window]
[ 0.283540] pci_bus 0000:00: resource 25 [mem 0x4a4000000-0x4e3ffffff window]
[ 0.283542] pci_bus 0000:00: resource 26 [mem 0x424000000-0x463ffffff window]
[ 0.283545] pci_bus 0000:00: resource 27 [mem 0x3a4000000-0x3e3ffffff window]
[ 0.283547] pci_bus 0000:00: resource 28 [mem 0x324000000-0x363ffffff window]
[ 0.283550] pci_bus 0000:00: resource 29 [mem 0x2a4000000-0x2e3ffffff window]
[ 0.283552] pci_bus 0000:00: resource 30 [mem 0xd8000000-0xffffffff window]
[ 0.283555] pci_bus 0000:00: resource 31 [mem 0x000a0000-0x000bffff window]
[ 0.283558] pci_bus 0000:00: resource 32 [io 0x0d00-0xffff window]
[ 0.283561] pci_bus 0000:00: resource 33 [io 0x0000-0x0cf7 window]
[ 0.283564] pci_bus 0000:05: resource 1 [mem 0xdd000000-0xdeffffff]
[ 0.283567] pci_bus 0000:06: resource 1 [mem 0xdb000000-0xdcffffff]
[ 0.283570] pci_bus 0000:07: resource 0 [io 0x4000-0xffff]
[ 0.283572] pci_bus 0000:07: resource 1 [mem 0xd9000000-0xdaffffff]
[ 0.283575] pci_bus 0000:08: resource 1 [mem 0xd9000000-0xdaffffff]
[ 0.283578] pci_bus 0000:09: resource 0 [io 0x4000-0xffff]
[ 0.283581] pci_bus 0000:01: resource 0 [io 0x3000-0x3fff]
[ 0.283584] pci_bus 0000:01: resource 1 [mem 0xf8000000-0xf8ffffff]
[ 0.283586] pci_bus 0000:01: resource 2 [mem 0xf0000000-0xf7ffffff pref]
[ 0.283589] pci_bus 0000:01: resource 4 [mem 0xf24000000-0xfffffffff window]
[ 0.283592] pci_bus 0000:01: resource 5 [mem 0xea4000000-0xee3ffffff window]
[ 0.283594] pci_bus 0000:01: resource 6 [mem 0xe24000000-0xe63ffffff window]
[ 0.283597] pci_bus 0000:01: resource 7 [mem 0xda4000000-0xde3ffffff window]
[ 0.283599] pci_bus 0000:01: resource 8 [mem 0xd24000000-0xd63ffffff window]
[ 0.283602] pci_bus 0000:01: resource 9 [mem 0xca4000000-0xce3ffffff window]
[ 0.283605] pci_bus 0000:01: resource 10 [mem 0xc24000000-0xc63ffffff window]
[ 0.283607] pci_bus 0000:01: resource 11 [mem 0xba4000000-0xbe3ffffff window]
[ 0.283609] pci_bus 0000:01: resource 12 [mem 0xb24000000-0xb63ffffff window]
[ 0.283612] pci_bus 0000:01: resource 13 [mem 0xaa4000000-0xae3ffffff window]
[ 0.283614] pci_bus 0000:01: resource 14 [mem 0xa24000000-0xa63ffffff window]
[ 0.283617] pci_bus 0000:01: resource 15 [mem 0x9a4000000-0x9e3ffffff window]
[ 0.283619] pci_bus 0000:01: resource 16 [mem 0x924000000-0x963ffffff window]
[ 0.283622] pci_bus 0000:01: resource 17 [mem 0x8a4000000-0x8e3ffffff window]
[ 0.283624] pci_bus 0000:01: resource 18 [mem 0x824000000-0x863ffffff window]
[ 0.283627] pci_bus 0000:01: resource 19 [mem 0x7a4000000-0x7e3ffffff window]
[ 0.283629] pci_bus 0000:01: resource 20 [mem 0x724000000-0x763ffffff window]
[ 0.283632] pci_bus 0000:01: resource 21 [mem 0x6a4000000-0x6e3ffffff window]
[ 0.283634] pci_bus 0000:01: resource 22 [mem 0x624000000-0x663ffffff window]
[ 0.283637] pci_bus 0000:01: resource 23 [mem 0x5a4000000-0x5e3ffffff window]
[ 0.283639] pci_bus 0000:01: resource 24 [mem 0x524000000-0x563ffffff window]
[ 0.283642] pci_bus 0000:01: resource 25 [mem 0x4a4000000-0x4e3ffffff window]
[ 0.283644] pci_bus 0000:01: resource 26 [mem 0x424000000-0x463ffffff window]
[ 0.283647] pci_bus 0000:01: resource 27 [mem 0x3a4000000-0x3e3ffffff window]
[ 0.283649] pci_bus 0000:01: resource 28 [mem 0x324000000-0x363ffffff window]
[ 0.283652] pci_bus 0000:01: resource 29 [mem 0x2a4000000-0x2e3ffffff window]
[ 0.283654] pci_bus 0000:01: resource 30 [mem 0xd8000000-0xffffffff window]
[ 0.283657] pci_bus 0000:01: resource 31 [mem 0x000a0000-0x000bffff window]
[ 0.283659] pci_bus 0000:01: resource 32 [io 0x0d00-0xffff window]
[ 0.283662] pci_bus 0000:01: resource 33 [io 0x0000-0x0cf7 window]
[ 0.283708] NET: Registered protocol family 2
[ 0.284162] TCP established hash table entries: 65536 (order: 7, 524288 bytes)
[ 0.284754] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes)
[ 0.285469] TCP: Hash tables configured (established 65536 bind 65536)
[ 0.285802] UDP hash table entries: 4096 (order: 5, 131072 bytes)
[ 0.286096] UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes)
[ 0.286495] NET: Registered protocol family 1
[ 0.286736] pci_bus 0000:02: writes to ASPM control bits will be ignored
[ 0.286951] pci_bus 0000:05: writes to ASPM control bits will be ignored
[ 0.287166] pci_bus 0000:06: writes to ASPM control bits will be ignored
[ 0.287381] pci_bus 0000:07: writes to ASPM control bits will be ignored
[ 0.287701] pci 0000:02:00.0: rerouting interrupts for [8086:0329]
[ 0.287915] pci 0000:02:00.2: rerouting interrupts for [8086:032a]
[ 0.288166] pci 0000:07:00.0: rerouting interrupts for [8086:0330]
[ 0.288380] pci 0000:07:00.2: rerouting interrupts for [8086:0332]
[ 0.288600] pci 0000:01:06.0: Video device with shadowed ROM
[ 0.288605] PCI: CLS 64 bytes, default 64
[ 0.288654] PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
[ 0.288866] software IO TLB [mem 0xd3fcc000-0xd7fcc000] (64MB) mapped at [ffff8800d3fcc000-ffff8800d7fcbfff]
[ 0.289863] futex hash table entries: 1024 (order: 5, 131072 bytes)
[ 0.290528] HugeTLB registered 2 MB page size, pre-allocated 0 pages
[ 0.296275] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
[ 0.296652] io scheduler noop registered
[ 0.296916] io scheduler cfq registered (default)
[ 0.297999] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[ 0.318713] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[ 0.319684] Non-volatile memory driver v1.3
[ 0.320338] ips 0000:08:0e.0: PCI IRQ 38 -> rerouted to legacy IRQ 18
[ 1.288019] tsc: Refined TSC clocksource calibration: 3200.113 MHz
[ 1.288233] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x2e20b4b4bc2, max_idle_ns: 440795278723 ns
[ 2.823896] clocksource: Switched to clocksource tsc
[ 2.823954] scsi host0: IBM PCI ServeRAID 7.12.05 Build 761
[ 2.824275] i8042: PNP: PS/2 Controller [PNP0303:PS2K,PNP0f13:PS2M] at 0x64,0x60 irq 1,12
[ 2.824276] i8042: PNP: PS/2 controller has invalid data port 0x64; using default 0x60
[ 2.824277] i8042: PNP: PS/2 controller has invalid command port 0x60; using default 0x64
[ 2.825871] scsi 0:0:0:0: Direct-Access IBM SERVERAID 1.00 PQ: 0 ANSI: 2
[ 2.826268] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 2.826286] serio: i8042 AUX port at 0x60,0x64 irq 12
[ 2.826876] mousedev: PS/2 mouse device common for all mice
[ 2.827368] rtc_cmos 00:05: rtc core: registered rtc_cmos as rtc0
[ 2.827613] rtc_cmos 00:05: alarms up to one year, 242 bytes nvram, hpet irqs
[ 2.828289] NET: Registered protocol family 10
[ 2.828877] mip6: Mobile IPv6
[ 2.829091] NET: Registered protocol family 17
[ 2.829320] Key type dns_resolver registered
[ 2.830170] registered taskstats version 1
[ 2.831024] Key type encrypted registered
[ 2.831666] console [netcon0] enabled
[ 2.831883] netconsole: network logging started
[ 2.832152] rtc_cmos 00:05: setting system clock to 2016-04-26 07:28:51 UTC (1461655731)
[ 2.837473] scsi 0:0:15:0: Processor IBM SERVERAID 1.00 PQ: 0 ANSI: 2
[ 2.842581] scsi 0:2:8:0: Processor IBM 39M6750a S320 0 1 PQ: 0 ANSI: 2
[ 2.844147] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
[ 2.844556] sd 0:0:0:0: [sda] 71096320 512-byte logical blocks: (36.4 GB/33.9 GiB)
[ 2.844945] sd 0:0:0:0: [sda] Assuming Write Enabled
[ 2.845154] sd 0:0:0:0: [sda] Assuming drive cache: write through
[ 2.852274] sda: sda1 sda2 < sda5 >
[ 2.853015] sd 0:0:0:0: [sda] Attached SCSI disk
[ 2.862066] EXT4-fs (sda1): couldn't mount as ext3 due to feature incompatibilities
[ 2.862633] EXT4-fs (sda1): couldn't mount as ext2 due to feature incompatibilities
[ 2.879416] EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts: (null)
[ 2.879800] VFS: Mounted root (ext4 filesystem) readonly on device 8:1.
[ 2.900884] devtmpfs: mounted
[ 2.901575] Freeing unused kernel memory: 780K (ffffffff8166d000 - ffffffff81730000)
[ 2.901945] Write protecting the kernel read-only data: 6144k
[ 2.902359] Freeing unused kernel memory: 44K (ffff8800013f5000 - ffff880001400000)
[ 2.905522] Freeing unused kernel memory: 728K (ffff88000154a000 - ffff880001600000)
[ 4.056481] random: udevadm urandom read with 13 bits of entropy available
[ 4.483859] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2
[ 4.484259] ACPI: Power Button [PWRF]
[ 4.492545] EDAC MC: Ver: 3.0.0
[ 4.515367] EDAC e752x: tolm = d8000, remapbase = 140000, remaplimit = 164000
[ 4.516048] EDAC MC0: Giving out device to module e752x_edac controller E7520: DEV 0000:00:00.0 (POLLED)
[ 4.516453] EDAC PCI0: Giving out device to module e752x_edac controller EDAC PCI controller: DEV 0000:00:00.0 (POLLED)
[ 4.540425] Floppy drive(s): fd0 is 1.44M
[ 4.559391] FDC 0 is a National Semiconductor PC87306
[ 4.559962] sd 0:0:0:0: Attached scsi generic sg0 type 0
[ 4.560689] scsi 0:0:15:0: Attached scsi generic sg1 type 3
[ 4.561022] scsi 0:2:8:0: Attached scsi generic sg2 type 3
[ 4.573470] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt
[ 4.611841] libata version 3.00 loaded.
[ 4.632518] intel_rng: FWH not detected
[ 4.639186] pps_core: LinuxPPS API ver. 1 registered
[ 4.639409] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <[email protected]>
[ 4.664378] input: PC Speaker as /devices/platform/pcspkr/input/input3
[ 4.666589] ata_piix 0000:00:1f.1: can't derive routing for PCI INT A
[ 4.666827] ata_piix 0000:00:1f.1: version 2.13
[ 4.667642] scsi host1: ata_piix
[ 4.668120] scsi host2: ata_piix
[ 4.668453] ata1: PATA max UDMA/100 cmd 0x1f0 ctl 0x3f6 bmdma 0x480 irq 14
[ 4.668668] ata2: PATA max UDMA/100 cmd 0x170 ctl 0x376 bmdma 0x488 irq 15
[ 4.669083] ata2: port disabled--ignoring
[ 4.743915] PTP clock support registered
[ 4.745163] ACPI: bus type USB registered
[ 4.745450] usbcore: registered new interface driver usbfs
[ 4.745691] usbcore: registered new interface driver hub
[ 4.745951] usbcore: registered new device driver usb
[ 4.804468] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 4.815172] uhci_hcd: USB Universal Host Controller Interface driver
[ 4.815657] uhci_hcd 0000:00:1d.0: UHCI Host Controller
[ 4.815879] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 1
[ 4.816305] uhci_hcd 0000:00:1d.0: irq 16, io base 0x00002200
[ 4.816673] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001
[ 4.816887] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 4.817256] usb usb1: Product: UHCI Host Controller
[ 4.817463] usb usb1: Manufacturer: Linux 4.4.0-05821-g43c75f9 uhci_hcd
[ 4.817674] usb usb1: SerialNumber: 0000:00:1d.0
[ 4.818124] hub 1-0:1.0: USB hub found
[ 4.818372] hub 1-0:1.0: 2 ports detected
[ 4.818927] uhci_hcd 0000:00:1d.1: UHCI Host Controller
[ 4.819145] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 2
[ 4.819547] uhci_hcd 0000:00:1d.1: irq 19, io base 0x00002600
[ 4.819883] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001
[ 4.820110] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 4.820484] usb usb2: Product: UHCI Host Controller
[ 4.820691] usb usb2: Manufacturer: Linux 4.4.0-05821-g43c75f9 uhci_hcd
[ 4.820902] usb usb2: SerialNumber: 0000:00:1d.1
[ 4.821358] hub 2-0:1.0: USB hub found
[ 4.821595] hub 2-0:1.0: 2 ports detected
[ 4.826849] ata1.00: ATAPI: PHILIPS DVD+/-RW SDVD8820, AX04, max UDMA/33
[ 4.846414] ata1.00: configured for UDMA/33
[ 4.848577] scsi 1:0:0:0: CD-ROM PHILIPS DVD+-RW SDVD8820 AX04 PQ: 0 ANSI: 5
[ 4.858345] scsi 1:0:0:0: Attached scsi generic sg3 type 5
[ 4.860716] ehci-pci: EHCI PCI platform driver
[ 4.861796] ehci-pci 0000:00:1d.7: EHCI Host Controller
[ 4.862056] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 3
[ 4.862456] ehci-pci 0000:00:1d.7: debug port 1
[ 4.866575] ehci-pci 0000:00:1d.7: cache line size of 64 is not supported
[ 4.866600] ehci-pci 0000:00:1d.7: irq 23, io mem 0xf9000000
[ 4.876024] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00
[ 4.876356] usb usb3: New USB device found, idVendor=1d6b, idProduct=0002
[ 4.876569] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 4.876938] usb usb3: Product: EHCI Host Controller
[ 4.877145] usb usb3: Manufacturer: Linux 4.4.0-05821-g43c75f9 ehci_hcd
[ 4.877355] usb usb3: SerialNumber: 0000:00:1d.7
[ 4.877806] hub 3-0:1.0: USB hub found
[ 4.878037] hub 3-0:1.0: 4 ports detected
[ 4.900096] hub 1-0:1.0: USB hub found
[ 4.900332] hub 1-0:1.0: 2 ports detected
[ 4.919280] iTCO_vendor_support: vendor-support=0
[ 4.924160] hub 2-0:1.0: USB hub found
[ 4.924403] hub 2-0:1.0: 2 ports detected
[ 4.932561] iTCO_wdt: Intel TCO WatchDog Timer Driver v1.11
[ 4.932886] iTCO_wdt: Found a ICH5 or ICH5R TCO device (Version=1, TCOBASE=0x05e0)
[ 4.933178] tg3.c:v3.137 (May 11, 2014)
[ 4.933689] iTCO_wdt: initialized. heartbeat=30 sec (nowayout=0)
[ 4.962934] tg3 0000:05:00.0 eth0: Tigon3 [partno(BCM95721) rev 4101] (PCI Express) MAC address 00:14:5e:2a:35:14
[ 4.963317] tg3 0000:05:00.0 eth0: attached PHY is 5750 (10/100/1000Base-T Ethernet) (WireSpeed[1], EEE[0])
[ 4.963691] tg3 0000:05:00.0 eth0: RXcsums[1] LinkChgREG[0] MIirq[0] ASF[1] TSOcap[1]
[ 4.964071] tg3 0000:05:00.0 eth0: dma_rwctrl[76180000] dma_mask[64-bit]
[ 4.987837] sr 1:0:0:0: [sr0] scsi3-mmc drive: 24x/24x writer cd/rw xa/form2 cdda tray
[ 4.988223] cdrom: Uniform CD-ROM driver Revision: 3.20
[ 4.988752] sr 1:0:0:0: Attached scsi CD-ROM sr0
[ 4.998941] tg3 0000:06:00.0 eth1: Tigon3 [partno(BCM95721) rev 4101] (PCI Express) MAC address 00:14:5e:2a:35:15
[ 4.999325] tg3 0000:06:00.0 eth1: attached PHY is 5750 (10/100/1000Base-T Ethernet) (WireSpeed[1], EEE[0])
[ 4.999699] tg3 0000:06:00.0 eth1: RXcsums[1] LinkChgREG[0] MIirq[0] ASF[1] TSOcap[1]
[ 5.000083] tg3 0000:06:00.0 eth1: dma_rwctrl[76180000] dma_mask[64-bit]
[ 5.215990] input: ImPS/2 Logitech Wheel Mouse as /devices/platform/i8042/serio1/input/input4
[ 5.322864] Linux agpgart interface v0.103
[ 5.363490] [drm] Initialized drm 1.1.0 20060810
[ 5.756374] [drm] radeon kernel modesetting enabled.
[ 5.757383] [drm] initializing kernel modesetting (RV100 0x1002:0x5159 0x1014:0x02C8).
[ 5.757779] [drm] register mmio base: 0xF8000000
[ 5.757987] [drm] register mmio size: 65536
[ 5.758294] radeon 0000:01:06.0: VRAM: 128M 0x00000000F0000000 - 0x00000000F7FFFFFF (16M used)
[ 5.758666] radeon 0000:01:06.0: GTT: 512M 0x00000000D0000000 - 0x00000000EFFFFFFF
[ 5.759041] [drm] Detected VRAM RAM=128M, BAR=128M
[ 5.759248] [drm] RAM width 32bits DDR
[ 5.759561] [TTM] Zone kernel: Available graphics memory: 2537466 kiB
[ 5.759773] [TTM] Zone dma32: Available graphics memory: 2097152 kiB
[ 5.759983] [TTM] Initializing pool allocator
[ 5.760215] [TTM] Initializing DMA pool allocator
[ 5.760454] [drm] radeon: 16M of VRAM memory ready
[ 5.760662] [drm] radeon: 512M of GTT memory ready.
[ 5.760891] [drm] GART: num cpu pages 131072, num gpu pages 131072
[ 5.783454] [drm] PCI GART of 512M enabled (table at 0x00000000D1F80000).
[ 5.783726] radeon 0000:01:06.0: WB disabled
[ 5.783938] radeon 0000:01:06.0: fence driver on ring 0 use gpu addr 0x00000000d0000000 and cpu addr 0xffff8800d1f39000
[ 5.784319] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
[ 5.784529] [drm] Driver supports precise vblank timestamp query.
[ 5.784771] [drm] radeon: irq initialized.
[ 5.785004] [drm] Loading R100 Microcode
[ 5.899899] [drm] radeon: ring at 0x00000000D0001000
[ 5.900180] [drm] ring test succeeded in 1 usecs
[ 5.901280] [drm] ib test succeeded in 0 usecs
[ 5.902112] [drm] No TV DAC info found in BIOS
[ 5.902395] [drm] Radeon Display Connectors
[ 5.902603] [drm] Connector 0:
[ 5.902806] [drm] VGA-1
[ 5.903010] [drm] DDC: 0x60 0x60 0x60 0x60 0x60 0x60 0x60 0x60
[ 5.903220] [drm] Encoders:
[ 5.903424] [drm] CRT1: INTERNAL_DAC1
[ 5.903630] [drm] Connector 1:
[ 5.907564] [drm] DVI-I-1
[ 5.907769] [drm] HPD2
[ 5.907972] [drm] DDC: 0x6c 0x6c 0x6c 0x6c 0x6c 0x6c 0x6c 0x6c
[ 5.908188] [drm] Encoders:
[ 5.908392] [drm] CRT2: INTERNAL_DAC2
[ 5.908598] [drm] DFP2: INTERNAL_DVO1
[ 5.971706] [drm] fb mappable at 0xF0040000
[ 5.971929] [drm] vram apper at 0xF0000000
[ 5.972159] [drm] size 786432
[ 5.972382] [drm] fb depth is 8
[ 5.972587] [drm] pitch is 1024
[ 5.972948] fbcon: radeondrmfb (fb0) is primary device
[ 6.289566] Console: switching to colour frame buffer device 128x48
[ 6.300066] radeon 0000:01:06.0: fb0: radeondrmfb frame buffer device
[ 6.332073] [drm] Initialized radeon 2.43.0 20080528 for 0000:01:06.0 on minor 0
[ 6.756366] Adding 1489916k swap on /dev/sda5. Priority:-1 extents:1 across:1489916k
[ 6.796295] EXT4-fs (sda1): re-mounted. Opts: (null)
[ 6.891445] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro
[ 7.248167] loop: module loaded
[ 7.979621] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[ 9.565823] tg3 0000:05:00.0 eth0: Link is up at 100 Mbps, full duplex
[ 9.569044] tg3 0000:05:00.0 eth0: Flow control is off for TX and off for RX
[ 9.569044] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[ 432.558986] random: nonblocking pool is initialized

--
Meelis Roos ([email protected])


2016-04-26 15:12:23

by Andy Lutomirski

[permalink] [raw]
Subject: Re: Bisected: spontaneous reboot in early boot on x86-64 in 4.6-rc

On Tue, Apr 26, 2016 at 12:30 AM, Meelis Roos <[email protected]> wrote:
> Today I finished bisecting a boot problem on my IBM X346 (with 64-bit P4
> Xeons). 4.5.0 worked fine but I saw the spontaneous reboots during early
> boot in 4.6-rc4 and bisected it down to the commit below.
>
> The server does not seem to have NX - dmesg has this:
>
> Notice: NX (Execute Disable) protection missing in CPU!

I reproduced a failure under KVM, which might be your failure.
Digging around now.

--Andy

2016-04-26 15:52:51

by Andy Lutomirski

[permalink] [raw]
Subject: [PATCH urgent] Revert "x86/mm/32: Set NX in __supported_pte_mask before enabling paging"

This reverts commit 320d25b6a05f8b73c23fc21025d2906ecdd2d4fc.

This change was problematic for a couple of reasons:

1. It missed a some entry points (Xen things and 64-bit native).

2. The entry it changed can be executed more than once. This isn't
really a problem, but it conflated per-cpu state setup and global
state setup.

3. It broke 64-bit non-NX. 64-bit non-NX worked the other way around from
32-bit -- __supported_pte_mask had NX set initially and was *cleared*
in x86_configure_nx. With the patch applied, it never got cleared.

Reported-by: Meelis Roos <[email protected]>
Signed-off-by: Andy Lutomirski <[email protected]>
---
arch/x86/kernel/head_32.S | 6 ------
arch/x86/mm/setup_nx.c | 5 +++--
2 files changed, 3 insertions(+), 8 deletions(-)

diff --git a/arch/x86/kernel/head_32.S b/arch/x86/kernel/head_32.S
index 54cdbd2003fe..af1112980dd4 100644
--- a/arch/x86/kernel/head_32.S
+++ b/arch/x86/kernel/head_32.S
@@ -389,12 +389,6 @@ default_entry:
/* Make changes effective */
wrmsr

- /*
- * And make sure that all the mappings we set up have NX set from
- * the beginning.
- */
- orl $(1 << (_PAGE_BIT_NX - 32)), pa(__supported_pte_mask + 4)
-
enable_paging:

/*
diff --git a/arch/x86/mm/setup_nx.c b/arch/x86/mm/setup_nx.c
index 8bea84724a7d..f65a33f505b6 100644
--- a/arch/x86/mm/setup_nx.c
+++ b/arch/x86/mm/setup_nx.c
@@ -32,8 +32,9 @@ early_param("noexec", noexec_setup);

void x86_configure_nx(void)
{
- /* If disable_nx is set, clear NX on all new mappings going forward. */
- if (disable_nx)
+ if (boot_cpu_has(X86_FEATURE_NX) && !disable_nx)
+ __supported_pte_mask |= _PAGE_NX;
+ else
__supported_pte_mask &= ~_PAGE_NX;
}

--
2.5.5

Subject: [tip:x86/urgent] Revert "x86/mm/32: Set NX in __supported_pte_mask before enabling paging"

Commit-ID: e16d8a6cbb499c5c8bfe9330d3351b649bded4af
Gitweb: http://git.kernel.org/tip/e16d8a6cbb499c5c8bfe9330d3351b649bded4af
Author: Andy Lutomirski <[email protected]>
AuthorDate: Tue, 26 Apr 2016 08:52:44 -0700
Committer: Ingo Molnar <[email protected]>
CommitDate: Tue, 26 Apr 2016 19:52:57 +0200

Revert "x86/mm/32: Set NX in __supported_pte_mask before enabling paging"

This reverts commit 320d25b6a05f8b73c23fc21025d2906ecdd2d4fc.

This change was problematic for a couple of reasons:

1. It missed a some entry points (Xen things and 64-bit native).

2. The entry it changed can be executed more than once. This isn't
really a problem, but it conflated per-cpu state setup and global
state setup.

3. It broke 64-bit non-NX. 64-bit non-NX worked the other way around from
32-bit -- __supported_pte_mask had NX set initially and was *cleared*
in x86_configure_nx. With the patch applied, it never got cleared.

Reported-and-tested-by: Meelis Roos <[email protected]>
Signed-off-by: Andy Lutomirski <[email protected]>
Cc: Andy Lutomirski <[email protected]>
Cc: Borislav Petkov <[email protected]>
Cc: Brian Gerst <[email protected]>
Cc: Denys Vlasenko <[email protected]>
Cc: H. Peter Anvin <[email protected]>
Cc: Linus Torvalds <[email protected]>
Cc: Mike Galbraith <[email protected]>
Cc: Peter Zijlstra <[email protected]>
Cc: Thomas Gleixner <[email protected]>
Link: http://lkml.kernel.org/r/59bd15f7f4b56b633a611b7f70876c6d2ad01a98.1461685884.git.luto@kernel.org
Signed-off-by: Ingo Molnar <[email protected]>
---
arch/x86/kernel/head_32.S | 6 ------
arch/x86/mm/setup_nx.c | 5 +++--
2 files changed, 3 insertions(+), 8 deletions(-)

diff --git a/arch/x86/kernel/head_32.S b/arch/x86/kernel/head_32.S
index 54cdbd2..af11129 100644
--- a/arch/x86/kernel/head_32.S
+++ b/arch/x86/kernel/head_32.S
@@ -389,12 +389,6 @@ default_entry:
/* Make changes effective */
wrmsr

- /*
- * And make sure that all the mappings we set up have NX set from
- * the beginning.
- */
- orl $(1 << (_PAGE_BIT_NX - 32)), pa(__supported_pte_mask + 4)
-
enable_paging:

/*
diff --git a/arch/x86/mm/setup_nx.c b/arch/x86/mm/setup_nx.c
index 8bea847..f65a33f 100644
--- a/arch/x86/mm/setup_nx.c
+++ b/arch/x86/mm/setup_nx.c
@@ -32,8 +32,9 @@ early_param("noexec", noexec_setup);

void x86_configure_nx(void)
{
- /* If disable_nx is set, clear NX on all new mappings going forward. */
- if (disable_nx)
+ if (boot_cpu_has(X86_FEATURE_NX) && !disable_nx)
+ __supported_pte_mask |= _PAGE_NX;
+ else
__supported_pte_mask &= ~_PAGE_NX;
}