lock-up with module: Optimize __module_address() using a latched RB-tree

From: Arthur Marsh
Date: Sun Jul 05 2015 - 14:34:08 EST


On this machine, a single core Athlon 64 with a 32 bit current Linus' git head kernel, I get a lock-up early in the boot process. (A dmesg output of a successful boot-up of kernel 4.1.0 up to and slightly passed the point where the git head kernel locks up is attached).

A photo of the lock-up appears at:

http://www.users.on.net/~arthur.marsh/20150706462.jpg


git-bisect reveals the bad commit as:


git bisect good
93c2e105f6bcee231c951ba0e56e84505c4b0483 is the first bad commit
commit 93c2e105f6bcee231c951ba0e56e84505c4b0483
Author: Peter Zijlstra <peterz@xxxxxxxxxxxxx>
Date: Wed May 27 11:09:37 2015 +0930

module: Optimize __module_address() using a latched RB-tree

Currently __module_address() is using a linear search through all
modules in order to find the module corresponding to the provided
address. With a lot of modules this can take a lot of time.

One of the users of this is kernel_text_address() which is employed
in many stack unwinders; which in turn are used by perf-callchain and
ftrace (possibly from NMI context).

So by optimizing __module_address() we optimize many stack unwinders
which are used by both perf and tracing in performance sensitive code.

Cc: Rusty Russell <rusty@xxxxxxxxxxxxxxx>
Cc: Steven Rostedt <rostedt@xxxxxxxxxxx>
Cc: Mathieu Desnoyers <mathieu.desnoyers@xxxxxxxxxxxx>
Cc: Oleg Nesterov <oleg@xxxxxxxxxx>
Cc: "Paul E. McKenney" <paulmck@xxxxxxxxxxxxxxxxxx>
Signed-off-by: Peter Zijlstra (Intel) <peterz@xxxxxxxxxxxxx>
Signed-off-by: Rusty Russell <rusty@xxxxxxxxxxxxxxx>

:040000 040000 1d6863a47d8521a4edbe44f9e7c3422ad1421d61 a209090da5e67f56f0997671f5a8b510338511ba M include
:040000 040000 da680638e9cebc8da54d43cc0e67b77b953430fa 31063f7ed575d22f0d27b24c76b9a0fb68c7cd40 M kernel


I am happy to supply further details and run further tests.

Arthur.
[ 0.000000] Initializing cgroup subsys cpuset
[ 0.000000] Initializing cgroup subsys cpu
[ 0.000000] Initializing cgroup subsys cpuacct
[ 0.000000] Linux version 4.1.0 (root@am64) (gcc version 5.1.1 20150616 (Debian 5.1.1-11) ) #1772 SMP PREEMPT Mon Jun 22 22:42:18 ACST 2015
[ 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 0x00000000000e0000-0x00000000000fffff] reserved
[ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffaffff] usable
[ 0.000000] BIOS-e820: [mem 0x000000003ffb0000-0x000000003ffbdfff] ACPI data
[ 0.000000] BIOS-e820: [mem 0x000000003ffbe000-0x000000003ffdffff] ACPI NVS
[ 0.000000] BIOS-e820: [mem 0x000000003ffe0000-0x000000003fffffff] reserved
[ 0.000000] BIOS-e820: [mem 0x00000000e0000000-0x00000000efffffff] reserved
[ 0.000000] BIOS-e820: [mem 0x00000000fec00000-0x00000000fec00fff] reserved
[ 0.000000] BIOS-e820: [mem 0x00000000ff780000-0x00000000ffffffff] reserved
[ 0.000000] Notice: NX (Execute Disable) protection cannot be enabled: non-PAE kernel!
[ 0.000000] SMBIOS 2.3 present.
[ 0.000000] DMI: System manufacturer System Product Name/A8V-MX, BIOS 0503 12/06/2005
[ 0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[ 0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
[ 0.000000] e820: last_pfn = 0x3ffb0 max_arch_pfn = 0x100000
[ 0.000000] MTRR default type: uncachable
[ 0.000000] MTRR fixed ranges enabled:
[ 0.000000] 00000-9FFFF write-back
[ 0.000000] A0000-EFFFF uncachable
[ 0.000000] F0000-FFFFF write-protect
[ 0.000000] MTRR variable ranges enabled:
[ 0.000000] 0 base 0000000000 mask FFC0000000 write-back
[ 0.000000] 1 base 00D0000000 mask FFF0000000 write-combining
[ 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] PAT configuration [0-7]: WB WC UC- UC WB WC UC- UC
[ 0.000000] found SMP MP-table at [mem 0x000ff780-0x000ff78f] mapped at [c00ff780]
[ 0.000000] initial memory mapped: [mem 0x00000000-0x023fffff]
[ 0.000000] Base memory trampoline at [c009b000] 9b000 size 16384
[ 0.000000] init_memory_mapping: [mem 0x00000000-0x000fffff]
[ 0.000000] [mem 0x00000000-0x000fffff] page 4k
[ 0.000000] init_memory_mapping: [mem 0x35c00000-0x35ffffff]
[ 0.000000] [mem 0x35c00000-0x35ffffff] page 4M
[ 0.000000] init_memory_mapping: [mem 0x00100000-0x35bfffff]
[ 0.000000] [mem 0x00100000-0x003fffff] page 4k
[ 0.000000] [mem 0x00400000-0x35bfffff] page 4M
[ 0.000000] init_memory_mapping: [mem 0x36000000-0x377fdfff]
[ 0.000000] [mem 0x36000000-0x373fffff] page 4M
[ 0.000000] [mem 0x37400000-0x377fdfff] page 4k
[ 0.000000] BRK [0x02059000, 0x02059fff] PGTABLE
[ 0.000000] RAMDISK: [mem 0x3614a000-0x3709cfff]
[ 0.000000] ACPI: Early table checksum verification disabled
[ 0.000000] ACPI: RSDP 0x00000000000FAC60 000024 (v02 ACPIAM)
[ 0.000000] ACPI: XSDT 0x000000003FFB0100 00003C (v01 A M I OEMXSDT 12000506 MSFT 00000097)
[ 0.000000] ACPI: FACP 0x000000003FFB0290 0000F4 (v03 A M I OEMFACP 12000506 MSFT 00000097)
[ 0.000000] ACPI: DSDT 0x000000003FFB03F0 0046F0 (v01 A0347 A0347001 00000001 INTL 02002026)
[ 0.000000] ACPI: FACS 0x000000003FFBE000 000040
[ 0.000000] ACPI: APIC 0x000000003FFB0390 00005C (v01 A M I OEMAPIC 12000506 MSFT 00000097)
[ 0.000000] ACPI: OEMB 0x000000003FFBE040 000046 (v01 A M I AMI_OEM 12000506 MSFT 00000097)
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] 135MB HIGHMEM available.
[ 0.000000] 887MB LOWMEM available.
[ 0.000000] mapped low ram: 0 - 377fe000
[ 0.000000] low ram: 0 - 377fe000
[ 0.000000] BRK [0x0205a000, 0x0205afff] PGTABLE
[ 0.000000] Zone ranges:
[ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff]
[ 0.000000] Normal [mem 0x0000000001000000-0x00000000377fdfff]
[ 0.000000] HighMem [mem 0x00000000377fe000-0x000000003ffaffff]
[ 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-0x000000003ffaffff]
[ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffaffff]
[ 0.000000] On node 0 totalpages: 261966
[ 0.000000] DMA zone: 36 pages used for memmap
[ 0.000000] DMA zone: 0 pages reserved
[ 0.000000] DMA zone: 3998 pages, LIFO batch:0
[ 0.000000] Normal zone: 1962 pages used for memmap
[ 0.000000] Normal zone: 223230 pages, LIFO batch:31
[ 0.000000] HighMem zone: 34738 pages, LIFO batch:7
[ 0.000000] Using APIC driver default
[ 0.000000] ACPI: PM-Timer IO Port: 0x808
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] IOAPIC[0]: apic_id 1, version 3, address 0xfec00000, GSI 0-23
[ 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 low 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 2 CPUs, 1 hotplug CPUs
[ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
[ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff]
[ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000dffff]
[ 0.000000] PM: Registered nosave memory: [mem 0x000e0000-0x000fffff]
[ 0.000000] e820: [mem 0x40000000-0xdfffffff] available for PCI devices
[ 0.000000] Booting paravirtualized kernel on bare hardware
[ 0.000000] clocksource refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns
[ 0.000000] setup_percpu: NR_CPUS:8 nr_cpumask_bits:8 nr_cpu_ids:2 nr_node_ids:1
[ 0.000000] PERCPU: Embedded 18 pages/cpu @f5efe000 s42792 r0 d30936 u73728
[ 0.000000] pcpu-alloc: s42792 r0 d30936 u73728 alloc=18*4096
[ 0.000000] pcpu-alloc: [0] 0 [0] 1
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 259968
[ 0.000000] Kernel command line: BOOT_IMAGE=/vmlinuz-4.1.0 root=UUID=96c96a61-8615-4715-86d0-09cb8c62638c ro
[ 0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)
[ 0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[ 0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[ 0.000000] Initializing CPU#0
[ 0.000000] Initializing HighMem for node 0 (000377fe:0003ffb0)
[ 0.000000] Initializing Movable for node 0 (00000000:00000000)
[ 0.000000] Memory: 1004700K/1047864K available (5432K kernel code, 520K rwdata, 2044K rodata, 528K init, 8140K bss, 43164K reserved, 0K cma-reserved, 138952K highmem)
[ 0.000000] virtual kernel memory layout:
fixmap : 0xfff16000 - 0xfffff000 ( 932 kB)
pkmap : 0xff800000 - 0xffc00000 (4096 kB)
vmalloc : 0xf7ffe000 - 0xff7fe000 ( 120 MB)
lowmem : 0xc0000000 - 0xf77fe000 ( 887 MB)
.init : 0xc17d3000 - 0xc1857000 ( 528 kB)
.data : 0xc154e5d4 - 0xc17d1140 (2570 kB)
.text : 0xc1000000 - 0xc154e5d4 (5433 kB)
[ 0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok.
[ 0.000000] Running RCU self tests
[ 0.000000] Preemptible hierarchical RCU implementation.
[ 0.000000] RCU dyntick-idle grace-period acceleration is enabled.
[ 0.000000] RCU lockdep checking is enabled.
[ 0.000000] RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=2.
[ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2
[ 0.000000] NR_IRQS:2304 nr_irqs:440 16
[ 0.000000] CPU 0 irqstacks, hard=f5816000 soft=f5818000
[ 0.000000] spurious 8259A interrupt: IRQ7.
[ 0.000000] Console: colour VGA+ 80x25
[ 0.000000] console [tty0] enabled
[ 0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[ 0.000000] ... MAX_LOCKDEP_SUBCLASSES: 8
[ 0.000000] ... MAX_LOCK_DEPTH: 48
[ 0.000000] ... MAX_LOCKDEP_KEYS: 8191
[ 0.000000] ... CLASSHASH_SIZE: 4096
[ 0.000000] ... MAX_LOCKDEP_ENTRIES: 32768
[ 0.000000] ... MAX_LOCKDEP_CHAINS: 65536
[ 0.000000] ... CHAINHASH_SIZE: 32768
[ 0.000000] memory used by lock dependency info: 4911 kB
[ 0.000000] per task-struct memory footprint: 1152 bytes
[ 0.000000] ------------------------
[ 0.000000] | Locking API testsuite:
[ 0.000000] ----------------------------------------------------------------------------
[ 0.000000] | spin |wlock |rlock |mutex | wsem | rsem |
[ 0.000000] --------------------------------------------------------------------------
[ 0.000000] A-A deadlock: ok | ok | ok | ok | ok | ok |
[ 0.000000] A-B-B-A deadlock: ok | ok | ok | ok | ok | ok |
[ 0.000000] A-B-B-C-C-A deadlock: ok | ok | ok | ok | ok | ok |
[ 0.000000] A-B-C-A-B-C deadlock: ok | ok | ok | ok | ok | ok |
[ 0.000000] A-B-B-C-C-D-D-A deadlock: ok | ok | ok | ok | ok | ok |
[ 0.000000] A-B-C-D-B-D-D-A deadlock: ok | ok | ok | ok | ok | ok |
[ 0.000000] A-B-C-D-B-C-D-A deadlock: ok | ok | ok | ok | ok | ok |
[ 0.000000] double unlock: ok | ok | ok | ok | ok | ok |
[ 0.000000] initialize held: ok | ok | ok | ok | ok | ok |
[ 0.000000] bad unlock order: ok | ok | ok | ok | ok | ok |
[ 0.000000] --------------------------------------------------------------------------
[ 0.000000] recursive read-lock: | ok | | ok |
[ 0.000000] recursive read-lock #2: | ok | | ok |
[ 0.000000] mixed read-write-lock: | ok | | ok |
[ 0.000000] mixed write-read-lock: | ok | | ok |
[ 0.000000] --------------------------------------------------------------------------
[ 0.000000] hard-irqs-on + irq-safe-A/12: ok | ok | ok |
[ 0.000000] soft-irqs-on + irq-safe-A/12: ok | ok | ok |
[ 0.000000] hard-irqs-on + irq-safe-A/21: ok | ok | ok |
[ 0.000000] soft-irqs-on + irq-safe-A/21: ok | ok | ok |
[ 0.000000] sirq-safe-A => hirqs-on/12: ok | ok | ok |
[ 0.000000] sirq-safe-A => hirqs-on/21: ok | ok | ok |
[ 0.000000] hard-safe-A + irqs-on/12: ok | ok | ok |
[ 0.000000] soft-safe-A + irqs-on/12: ok | ok | ok |
[ 0.000000] hard-safe-A + irqs-on/21: ok | ok | ok |
[ 0.000000] soft-safe-A + irqs-on/21: ok | ok | ok |
[ 0.000000] hard-safe-A + unsafe-B #1/123: ok | ok | ok |
[ 0.000000] soft-safe-A + unsafe-B #1/123: ok | ok | ok |
[ 0.000000] hard-safe-A + unsafe-B #1/132: ok | ok | ok |
[ 0.000000] soft-safe-A + unsafe-B #1/132: ok | ok | ok |
[ 0.000000] hard-safe-A + unsafe-B #1/213: ok | ok | ok |
[ 0.000000] soft-safe-A + unsafe-B #1/213: ok | ok | ok |
[ 0.000000] hard-safe-A + unsafe-B #1/231: ok | ok | ok |
[ 0.000000] soft-safe-A + unsafe-B #1/231: ok | ok | ok |
[ 0.000000] hard-safe-A + unsafe-B #1/312: ok | ok | ok |
[ 0.000000] soft-safe-A + unsafe-B #1/312: ok | ok | ok |
[ 0.000000] hard-safe-A + unsafe-B #1/321: ok | ok | ok |
[ 0.000000] soft-safe-A + unsafe-B #1/321: ok | ok | ok |
[ 0.000000] hard-safe-A + unsafe-B #2/123: ok | ok | ok |
[ 0.000000] soft-safe-A + unsafe-B #2/123: ok | ok | ok |
[ 0.000000] hard-safe-A + unsafe-B #2/132: ok | ok | ok |
[ 0.000000] soft-safe-A + unsafe-B #2/132: ok | ok | ok |
[ 0.000000] hard-safe-A + unsafe-B #2/213: ok | ok | ok |
[ 0.000000] soft-safe-A + unsafe-B #2/213: ok | ok | ok |
[ 0.000000] hard-safe-A + unsafe-B #2/231: ok | ok | ok |
[ 0.000000] soft-safe-A + unsafe-B #2/231: ok | ok | ok |
[ 0.000000] hard-safe-A + unsafe-B #2/312: ok | ok | ok |
[ 0.000000] soft-safe-A + unsafe-B #2/312: ok | ok | ok |
[ 0.000000] hard-safe-A + unsafe-B #2/321: ok | ok | ok |
[ 0.000000] soft-safe-A + unsafe-B #2/321: ok | ok | ok |
[ 0.000000] hard-irq lock-inversion/123: ok | ok | ok |
[ 0.000000] soft-irq lock-inversion/123: ok | ok | ok |
[ 0.000000] hard-irq lock-inversion/132: ok | ok | ok |
[ 0.000000] soft-irq lock-inversion/132: ok | ok | ok |
[ 0.000000] hard-irq lock-inversion/213: ok | ok | ok |
[ 0.000000] soft-irq lock-inversion/213: ok | ok | ok |
[ 0.000000] hard-irq lock-inversion/231: ok | ok | ok |
[ 0.000000] soft-irq lock-inversion/231: ok | ok | ok |
[ 0.000000] hard-irq lock-inversion/312: ok | ok | ok |
[ 0.000000] soft-irq lock-inversion/312: ok | ok | ok |
[ 0.000000] hard-irq lock-inversion/321: ok | ok | ok |
[ 0.000000] soft-irq lock-inversion/321: ok | ok | ok |
[ 0.000000] hard-irq read-recursion/123: ok |
[ 0.000000] soft-irq read-recursion/123: ok |
[ 0.000000] hard-irq read-recursion/132: ok |
[ 0.000000] soft-irq read-recursion/132: ok |
[ 0.000000] hard-irq read-recursion/213: ok |
[ 0.000000] soft-irq read-recursion/213: ok |
[ 0.000000] hard-irq read-recursion/231: ok |
[ 0.000000] soft-irq read-recursion/231: ok |
[ 0.000000] hard-irq read-recursion/312: ok |
[ 0.000000] soft-irq read-recursion/312: ok |
[ 0.000000] hard-irq read-recursion/321: ok |
[ 0.000000] soft-irq read-recursion/321: ok |
[ 0.000000] --------------------------------------------------------------------------
[ 0.000000] | Wound/wait tests |
[ 0.000000] ---------------------
[ 0.000000] ww api failures: ok | ok | ok |
[ 0.000000] ww contexts mixing: ok | ok |
[ 0.000000] finishing ww context: ok | ok | ok | ok |
[ 0.000000] locking mismatches: ok | ok | ok |
[ 0.000000] EDEADLK handling: ok | ok | ok | ok | ok | ok | ok | ok | ok | ok |
[ 0.000000] spinlock nest unlocked: ok |
[ 0.000000] -----------------------------------------------------
[ 0.000000] |block | try |context|
[ 0.000000] -----------------------------------------------------
[ 0.000000] context: ok | ok | ok |
[ 0.000000] try: ok | ok | ok |
[ 0.000000] block: ok | ok | ok |
[ 0.000000] spinlock: ok | ok | ok |
[ 0.000000] -------------------------------------------------------
[ 0.000000] Good, all 253 testcases passed! |
[ 0.000000] ---------------------------------
[ 0.000000] tsc: Fast TSC calibration using PIT
[ 0.000000] tsc: Detected 1999.957 MHz processor
[ 0.000000] tsc: Marking TSC unstable due to TSCs unsynchronized
[ 0.008137] Calibrating delay loop (skipped), value calculated using timer frequency.. 3999.91 BogoMIPS (lpj=7999828)
[ 0.008253] pid_max: default: 32768 minimum: 301
[ 0.008364] ACPI: Core revision 20150410
[ 0.018131] ACPI: All ACPI Tables successfully acquired
[ 0.018562] Security Framework initialized
[ 0.018630] AppArmor: AppArmor disabled by boot time parameter
[ 0.018689] Yama: becoming mindful.
[ 0.018819] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.018880] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.020277] Initializing cgroup subsys blkio
[ 0.020340] Initializing cgroup subsys memory
[ 0.020417] Initializing cgroup subsys devices
[ 0.020500] Initializing cgroup subsys freezer
[ 0.020615] Initializing cgroup subsys net_cls
[ 0.020677] Initializing cgroup subsys perf_event
[ 0.020740] Initializing cgroup subsys net_prio
[ 0.020837] mce: CPU supports 5 MCE banks
[ 0.020903] Last level iTLB entries: 4KB 512, 2MB 8, 4MB 4
[ 0.020962] Last level dTLB entries: 4KB 512, 2MB 8, 4MB 4, 1GB 0
[ 0.026987] Enabling APIC mode: Flat. Using 1 I/O APICs
[ 0.027596] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=0 pin2=0
[ 0.068000] smpboot: CPU0: AMD Athlon(tm) 64 Processor 3200+ (fam: 0f, model: 2f, stepping: 02)
[ 0.068000] Performance Events: AMD PMU driver.
[ 0.068000] ... version: 0
[ 0.068000] ... bit width: 48
[ 0.068000] ... generic registers: 4
[ 0.068000] ... value mask: 0000ffffffffffff
[ 0.068000] ... max period: 00007fffffffffff
[ 0.068000] ... fixed-purpose events: 0
[ 0.068000] ... event mask: 000000000000000f
[ 0.088070] x86: Booted up 1 node, 1 CPUs
[ 0.088130] smpboot: Total of 1 processors activated (3999.91 BogoMIPS)
[ 0.088954] NMI watchdog: enabled on all CPUs, permanently consumes one hw-PMU counter.
[ 0.090195] devtmpfs: initialized
[ 0.093239] PM: Registering ACPI NVS region [mem 0x3ffbe000-0x3ffdffff] (139264 bytes)
[ 0.093577] clocksource jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[ 0.093866] pinctrl core: initialized pinctrl subsystem
[ 0.094837] NET: Registered protocol family 16
[ 0.104046] cpuidle: using governor ladder
[ 0.116017] cpuidle: using governor menu
[ 0.116082] node 0 link 0: io port [1000, ffffff]
[ 0.116086] TOM: 0000000040000000 aka 1024M
[ 0.116146] node 0 link 0: mmio [a0000, bffff]
[ 0.116151] node 0 link 0: mmio [40000000, ffffffff]
[ 0.116155] bus: [bus 00-ff] on node 0 link 0
[ 0.116158] bus: 00 [io 0x0000-0xffff]
[ 0.116160] bus: 00 [mem 0x000a0000-0x000bffff]
[ 0.116163] bus: 00 [mem 0x40000000-0xffffffff]
[ 0.116263] ACPI: bus type PCI registered
[ 0.116321] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
[ 0.117350] PCI: PCI BIOS revision 3.00 entry at 0xf0031, last bus=5
[ 0.117409] PCI: Using configuration type 1 for base access
[ 0.133643] ACPI: Added _OSI(Module Device)
[ 0.133705] ACPI: Added _OSI(Processor Device)
[ 0.133763] ACPI: Added _OSI(3.0 _SCP Extensions)
[ 0.133821] ACPI: Added _OSI(Processor Aggregator Device)
[ 0.141453] ACPI: Executed 1 blocks of module-level executable AML code
[ 0.147402] ACPI: Interpreter enabled
[ 0.147479] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [\_S2_] (20150410/hwxface-580)
[ 0.147637] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [\_S3_] (20150410/hwxface-580)
[ 0.147848] ACPI: (supports S0 S1 S4 S5)
[ 0.147905] ACPI: Using IOAPIC for interrupt routing
[ 0.148058] PCI: Ignoring host bridge windows from ACPI; if necessary, use "pci=use_crs" and report a bug
[ 0.172634] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[ 0.172704] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI]
[ 0.172871] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
[ 0.173140] acpi PNP0A03:00: host bridge window [io 0x0000-0x0cf7 window] (ignored)
[ 0.173144] acpi PNP0A03:00: host bridge window [io 0x0d00-0xffff window] (ignored)
[ 0.173148] acpi PNP0A03:00: host bridge window [mem 0x000a0000-0x000bffff window] (ignored)
[ 0.173151] acpi PNP0A03:00: host bridge window [mem 0x000c0000-0x000dffff window] (ignored)
[ 0.173154] acpi PNP0A03:00: host bridge window [mem 0x40000000-0xffffffff window] (ignored)
[ 0.173158] PCI: root bus 00: hardware-probed resources
[ 0.173223] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
[ 0.174437] PCI host bridge to bus 0000:00
[ 0.174496] pci_bus 0000:00: root bus resource [bus 00-ff]
[ 0.174556] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]
[ 0.174616] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff]
[ 0.174677] pci_bus 0000:00: root bus resource [mem 0x40000000-0xffffffff]
[ 0.174789] pci 0000:00:00.0: [1106:0204] type 00 class 0x060000
[ 0.174803] pci 0000:00:00.0: reg 0x10: [mem 0xd0000000-0xdfffffff pref]
[ 0.175469] pci 0000:00:00.1: [1106:1204] type 00 class 0x060000
[ 0.175814] pci 0000:00:00.2: [1106:2204] type 00 class 0x060000
[ 0.176170] pci 0000:00:00.3: [1106:3204] type 00 class 0x060000
[ 0.176536] pci 0000:00:00.4: [1106:4204] type 00 class 0x060000
[ 0.176878] pci 0000:00:00.7: [1106:7204] type 00 class 0x060000
[ 0.177227] pci 0000:00:01.0: [1106:b188] type 01 class 0x060400
[ 0.177294] pci 0000:00:01.0: supports D1
[ 0.177599] pci 0000:00:0f.0: [1106:0571] type 00 class 0x01018a
[ 0.177660] pci 0000:00:0f.0: reg 0x20: [io 0xfc00-0xfc0f]
[ 0.177688] pci 0000:00:0f.0: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
[ 0.177750] pci 0000:00:0f.0: legacy IDE quirk: reg 0x14: [io 0x03f6]
[ 0.177810] pci 0000:00:0f.0: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
[ 0.177871] pci 0000:00:0f.0: legacy IDE quirk: reg 0x1c: [io 0x0376]
[ 0.178225] pci 0000:00:10.0: [1106:3038] type 00 class 0x0c0300
[ 0.178281] pci 0000:00:10.0: reg 0x20: [io 0xec00-0xec1f]
[ 0.178336] pci 0000:00:10.0: supports D1 D2
[ 0.178339] pci 0000:00:10.0: PME# supported from D0 D1 D2 D3hot D3cold
[ 0.178583] pci 0000:00:10.0: System wakeup disabled by ACPI
[ 0.178816] pci 0000:00:10.1: [1106:3038] type 00 class 0x0c0300
[ 0.178873] pci 0000:00:10.1: reg 0x20: [io 0xe880-0xe89f]
[ 0.178928] pci 0000:00:10.1: supports D1 D2
[ 0.178931] pci 0000:00:10.1: PME# supported from D0 D1 D2 D3hot D3cold
[ 0.179089] pci 0000:00:10.1: System wakeup disabled by ACPI
[ 0.179325] pci 0000:00:10.2: [1106:3038] type 00 class 0x0c0300
[ 0.179381] pci 0000:00:10.2: reg 0x20: [io 0xe800-0xe81f]
[ 0.179436] pci 0000:00:10.2: supports D1 D2
[ 0.179439] pci 0000:00:10.2: PME# supported from D0 D1 D2 D3hot D3cold
[ 0.179614] pci 0000:00:10.2: System wakeup disabled by ACPI
[ 0.179846] pci 0000:00:10.3: [1106:3038] type 00 class 0x0c0300
[ 0.179902] pci 0000:00:10.3: reg 0x20: [io 0xe480-0xe49f]
[ 0.179957] pci 0000:00:10.3: supports D1 D2
[ 0.179960] pci 0000:00:10.3: PME# supported from D0 D1 D2 D3hot D3cold
[ 0.180128] pci 0000:00:10.3: System wakeup disabled by ACPI
[ 0.180368] pci 0000:00:10.4: [1106:3104] type 00 class 0x0c0320
[ 0.180389] pci 0000:00:10.4: reg 0x10: [mem 0xff6ffc00-0xff6ffcff]
[ 0.180487] pci 0000:00:10.4: supports D1 D2
[ 0.180490] pci 0000:00:10.4: PME# supported from D0 D1 D2 D3hot D3cold
[ 0.180648] pci 0000:00:10.4: System wakeup disabled by ACPI
[ 0.180889] pci 0000:00:11.0: [1106:3287] type 00 class 0x060100
[ 0.181299] pci 0000:00:11.7: [1106:287e] type 00 class 0x060000
[ 0.181654] pci 0000:00:12.0: [1106:3065] type 00 class 0x020000
[ 0.181674] pci 0000:00:12.0: reg 0x10: [io 0xe000-0xe0ff]
[ 0.181688] pci 0000:00:12.0: reg 0x14: [mem 0xff6ff800-0xff6ff8ff]
[ 0.181774] pci 0000:00:12.0: supports D1 D2
[ 0.181778] pci 0000:00:12.0: PME# supported from D0 D1 D2 D3hot D3cold
[ 0.181933] pci 0000:00:12.0: System wakeup disabled by ACPI
[ 0.182168] pci 0000:00:13.0: [1106:287b] type 01 class 0x060400
[ 0.182484] pci 0000:00:13.1: [1106:287a] type 01 class 0x060400
[ 0.182680] pci 0000:00:13.1: System wakeup disabled by ACPI
[ 0.182930] pci 0000:00:18.0: [1022:1100] type 00 class 0x060000
[ 0.183226] pci 0000:00:18.1: [1022:1101] type 00 class 0x060000
[ 0.183517] pci 0000:00:18.2: [1022:1102] type 00 class 0x060000
[ 0.183807] pci 0000:00:18.3: [1022:1103] type 00 class 0x060000
[ 0.184240] pci 0000:01:00.0: [1002:5964] type 00 class 0x030000
[ 0.184259] pci 0000:01:00.0: reg 0x10: [mem 0xb0000000-0xb7ffffff pref]
[ 0.184270] pci 0000:01:00.0: reg 0x14: [io 0xc000-0xc0ff]
[ 0.184280] pci 0000:01:00.0: reg 0x18: [mem 0xff4f0000-0xff4fffff]
[ 0.184313] pci 0000:01:00.0: reg 0x30: [mem 0xff4c0000-0xff4dffff pref]
[ 0.184358] pci 0000:01:00.0: supports D1 D2
[ 0.184516] pci 0000:01:00.1: [1002:5d44] type 00 class 0x038000
[ 0.184532] pci 0000:01:00.1: reg 0x10: [mem 0xa8000000-0xafffffff pref]
[ 0.184543] pci 0000:01:00.1: reg 0x14: [mem 0xff4e0000-0xff4effff]
[ 0.184619] pci 0000:01:00.1: supports D1 D2
[ 0.184806] pci 0000:00:01.0: PCI bridge to [bus 01]
[ 0.184867] pci 0000:00:01.0: bridge window [io 0xa000-0xcfff]
[ 0.184873] pci 0000:00:01.0: bridge window [mem 0xff400000-0xff4fffff]
[ 0.184879] pci 0000:00:01.0: bridge window [mem 0x9ff00000-0xbfefffff pref]
[ 0.185077] pci 0000:02:00.0: [1106:287c] type 01 class 0x060400
[ 0.185154] pci 0000:02:00.0: PME# supported from D0 D3hot D3cold
[ 0.185218] pci 0000:02:00.0: System wakeup disabled by ACPI
[ 0.185455] pci 0000:02:00.1: [1106:287d] type 01 class 0x060400
[ 0.185531] pci 0000:02:00.1: PME# supported from D0 D3hot D3cold
[ 0.185757] pci 0000:02:00.0: disabling ASPM on pre-1.1 PCIe device. You can enable it with 'pcie_aspm=force'
[ 0.185882] pci 0000:00:13.0: PCI bridge to [bus 02-04]
[ 0.186074] pci 0000:02:00.0: PCI bridge to [bus 03]
[ 0.186265] pci 0000:02:00.1: PCI bridge to [bus 04]
[ 0.186490] pci 0000:05:0b.0: [1102:0004] type 00 class 0x040100
[ 0.186511] pci 0000:05:0b.0: reg 0x10: [io 0xd800-0xd83f]
[ 0.186612] pci 0000:05:0b.0: supports D1 D2
[ 0.186768] pci 0000:05:0b.1: [1102:7003] type 00 class 0x098000
[ 0.186788] pci 0000:05:0b.1: reg 0x10: [io 0xdc00-0xdc07]
[ 0.186888] pci 0000:05:0b.1: supports D1 D2
[ 0.187043] pci 0000:05:0b.2: [1102:4001] type 00 class 0x0c0010
[ 0.187065] pci 0000:05:0b.2: reg 0x10: [mem 0xff5ef800-0xff5effff]
[ 0.187078] pci 0000:05:0b.2: reg 0x14: [mem 0xff5e8000-0xff5ebfff]
[ 0.187173] pci 0000:05:0b.2: supports D1 D2
[ 0.187176] pci 0000:05:0b.2: PME# supported from D0 D1 D2 D3hot
[ 0.187375] pci 0000:05:0c.0: [1044:a400] type 00 class 0x010000
[ 0.187393] pci 0000:05:0c.0: reg 0x10: [io 0xd880-0xd89f]
[ 0.187455] pci 0000:05:0c.0: reg 0x30: [mem 0xff5f0000-0xff5f7fff pref]
[ 0.187652] pci 0000:00:13.1: PCI bridge to [bus 05]
[ 0.187714] pci 0000:00:13.1: bridge window [io 0xd000-0xdfff]
[ 0.187720] pci 0000:00:13.1: bridge window [mem 0xff500000-0xff5fffff]
[ 0.187742] pci_bus 0000:00: on NUMA node 0
[ 0.190327] ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 6 7 10 *11 12 14 15)
[ 0.191058] ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 6 7 *10 11 12 14 15)
[ 0.191764] ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 *5 6 7 10 11 12 14 15)
[ 0.192457] ACPI: PCI Interrupt Link [LNKD] (IRQs *3 4 5 6 7 10 11 12 14 15)
[ 0.193163] ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 7 10 11 12 14 15) *0, disabled.
[ 0.193962] ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 7 10 11 12 14 15) *0, disabled.
[ 0.194761] ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 5 6 7 10 11 12 14 15) *0, disabled.
[ 0.195576] ACPI: PCI Interrupt Link [LNKH] (IRQs 3 4 5 6 7 10 11 12 14 15) *0, disabled.
[ 0.197285] vgaarb: setting as boot device: PCI:0000:01:00.0
[ 0.197345] vgaarb: device added: PCI:0000:01:00.0,decodes=io+mem,owns=io+mem,locks=none
[ 0.197421] vgaarb: loaded
[ 0.197476] vgaarb: bridge control possible 0000:01:00.0
[ 0.197861] PCI: Using ACPI for IRQ routing
[ 0.197922] PCI: pci_cache_line_size set to 64 bytes
[ 0.198029] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
[ 0.198044] e820: reserve RAM buffer [mem 0x3ffb0000-0x3fffffff]
[ 0.199258] Switched to clocksource refined-jiffies
[ 0.217702] pnp: PnP ACPI init
[ 0.218117] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active)
[ 0.219256] pnp 00:01: [dma 3]
[ 0.219569] pnp 00:01: Plug and Play ACPI device, IDs PNP0401 (active)
[ 0.219939] system 00:02: [io 0x0290-0x0297] has been reserved
[ 0.220090] system 00:02: Plug and Play ACPI device, IDs PNP0c02 (active)
[ 0.220520] system 00:03: [io 0x03e0-0x03e7] has been reserved
[ 0.220583] system 00:03: [io 0x04d0-0x04d1] has been reserved
[ 0.220645] system 00:03: [io 0x0800-0x087f] could not be reserved
[ 0.220707] system 00:03: [io 0x0400-0x041f] has been reserved
[ 0.220769] system 00:03: [mem 0xff780000-0xffffffff] has been reserved
[ 0.220831] system 00:03: [mem 0xf0000000-0xf7ffffff] has been reserved
[ 0.220897] system 00:03: Plug and Play ACPI device, IDs PNP0c02 (active)
[ 0.221169] system 00:04: [mem 0xfec00000-0xfec00fff] could not be reserved
[ 0.221233] system 00:04: [mem 0xfee00000-0xfee00fff] has been reserved
[ 0.221298] system 00:04: Plug and Play ACPI device, IDs PNP0c02 (active)
[ 0.221494] pnp 00:05: Plug and Play ACPI device, IDs PNP0303 PNP030b (active)
[ 0.221722] pnp 00:06: Plug and Play ACPI device, IDs PNP0f03 PNP0f13 (active)
[ 0.222299] pnp 00:07: [dma 0 disabled]
[ 0.222472] pnp 00:07: Plug and Play ACPI device, IDs PNP0501 (active)
[ 0.222682] system 00:08: [mem 0xe0000000-0xefffffff] has been reserved
[ 0.222748] system 00:08: Plug and Play ACPI device, IDs PNP0c02 (active)
[ 0.223368] system 00:09: [mem 0x00000000-0x0009ffff] could not be reserved
[ 0.223432] system 00:09: [mem 0x000e0000-0x000fffff] could not be reserved
[ 0.223495] system 00:09: [mem 0x00100000-0x3fffffff] could not be reserved
[ 0.223561] system 00:09: Plug and Play ACPI device, IDs PNP0c01 (active)
[ 0.223873] pnp: PnP ACPI: found 10 devices
[ 0.266362] clocksource acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
[ 0.266461] Switched to clocksource acpi_pm
[ 0.266560] pci 0000:00:01.0: PCI bridge to [bus 01]
[ 0.266621] pci 0000:00:01.0: bridge window [io 0xa000-0xcfff]
[ 0.266686] pci 0000:00:01.0: bridge window [mem 0xff400000-0xff4fffff]
[ 0.266749] pci 0000:00:01.0: bridge window [mem 0x9ff00000-0xbfefffff pref]
[ 0.266825] pci 0000:02:00.0: PCI bridge to [bus 03]
[ 0.266895] pci 0000:02:00.1: PCI bridge to [bus 04]
[ 0.266964] pci 0000:00:13.0: PCI bridge to [bus 02-04]
[ 0.267034] pci 0000:00:13.1: PCI bridge to [bus 05]
[ 0.267094] pci 0000:00:13.1: bridge window [io 0xd000-0xdfff]
[ 0.267157] pci 0000:00:13.1: bridge window [mem 0xff500000-0xff5fffff]
[ 0.267157] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]
[ 0.267157] pci_bus 0000:00: resource 5 [mem 0x000a0000-0x000bffff]
[ 0.267157] pci_bus 0000:00: resource 6 [mem 0x40000000-0xffffffff]
[ 0.267157] pci_bus 0000:01: resource 0 [io 0xa000-0xcfff]
[ 0.267157] pci_bus 0000:01: resource 1 [mem 0xff400000-0xff4fffff]
[ 0.267157] pci_bus 0000:01: resource 2 [mem 0x9ff00000-0xbfefffff pref]
[ 0.267157] pci_bus 0000:05: resource 0 [io 0xd000-0xdfff]
[ 0.267157] pci_bus 0000:05: resource 1 [mem 0xff500000-0xff5fffff]
[ 0.267157] NET: Registered protocol family 2
[ 0.267157] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
[ 0.267157] TCP bind hash table entries: 8192 (order: 6, 294912 bytes)
[ 0.267673] TCP: Hash tables configured (established 8192 bind 8192)
[ 0.267854] UDP hash table entries: 512 (order: 3, 40960 bytes)
[ 0.267993] UDP-Lite hash table entries: 512 (order: 3, 40960 bytes)
[ 0.268397] NET: Registered protocol family 1
[ 0.268478] pci 0000:00:00.0: MSI quirk detected; MSI disabled
[ 0.268559] pci 0000:00:01.0: disabling DAC on VIA PCI bridge
[ 0.270504] pci 0000:01:00.0: Video device with shadowed ROM
[ 0.270531] PCI: CLS 64 bytes, default 64
[ 0.270908] Unpacking initramfs...
[ 0.779613] Freeing initrd memory: 15692K (f614a000 - f709d000)
[ 0.779818] clocksource tsc: mask: 0xffffffffffffffff max_cycles: 0x39a80b72e7e, max_idle_ns: 881590548927 ns
[ 0.779957] microcode: AMD CPU family 0xf not supported
[ 0.781180] futex hash table entries: 512 (order: 3, 32768 bytes)
[ 0.781328] audit: initializing netlink subsys (disabled)
[ 0.781495] audit: type=2000 audit(1436119567.779:1): initialized
[ 0.782467] HugeTLB registered 4 MB page size, pre-allocated 0 pages
[ 0.782914] VFS: Disk quotas dquot_6.6.0
[ 0.783003] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[ 0.785644] alg: No test for stdrng (krng)
[ 0.785779] bounce: pool size: 64 pages
[ 0.785870] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
[ 0.786115] io scheduler noop registered
[ 0.786175] io scheduler deadline registered
[ 0.786244] io scheduler cfq registered (default)
[ 0.786864] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
[ 0.787156] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
[ 0.787344] GHES: HEST is not enabled!
[ 0.787558] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[ 0.808536] 00:07: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[ 0.810458] Linux agpgart interface v0.103
[ 0.810552] agpgart-amd64 0000:00:00.0: AGP bridge [1106/0204]
[ 0.817764] agpgart-amd64 0000:00:00.0: AGP aperture is 256M @ 0xd0000000
[ 0.818661] i8042: PNP: PS/2 Controller [PNP0303:PS2K,PNP0f03:PS2M] at 0x60,0x64 irq 1,12
[ 0.819476] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 0.820079] serio: i8042 AUX port at 0x60,0x64 irq 12
[ 0.820710] mousedev: PS/2 mouse device common for all mice
[ 0.821262] rtc_cmos 00:00: RTC can wake from S4
[ 0.821838] rtc_cmos 00:00: rtc core: registered rtc_cmos as rtc0
[ 0.821939] rtc_cmos 00:00: alarms up to one year, y3k, 114 bytes nvram
[ 0.822395] NET: Registered protocol family 10
[ 0.823196] mip6: Mobile IPv6
[ 0.823278] NET: Registered protocol family 17
[ 0.823345] mpls_gso: MPLS GSO support
[ 0.823868] Using IPI No-Shortcut mode
[ 0.824840] registered taskstats version 1
[ 0.826516] rtc_cmos 00:00: setting system clock to 2015-07-05 18:06:08 UTC (1436119568)
[ 0.826864] PM: Hibernation image not present or could not be loaded.
[ 0.827906] Freeing unused kernel memory: 528K (c17d3000 - c1857000)
[ 0.828154] Write protecting the kernel text: 5436k
[ 0.828356] Write protecting the kernel read-only data: 2048k
[ 0.843615] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
[ 0.924978] random: systemd-udevd urandom read with 0 bits of entropy available
[ 1.073662] SCSI subsystem initialized
[ 1.088956] via_rhine: v1.10-LK1.5.1 2010-10-09 Written by Donald Becker
[ 1.090398] via-rhine 0000:00:12.0 eth0: VIA Rhine II at 0x1e000, 00:13:d4:cc:9b:57, IRQ 23
[ 1.091244] via-rhine 0000:00:12.0 eth0: MII PHY found at address 1, status 0x786d advertising 01e1 Link 45e1
[ 1.094724] ACPI: bus type USB registered
[ 1.094904] usbcore: registered new interface driver usbfs
[ 1.095102] usbcore: registered new interface driver hub
[ 1.100328] EATA0: IRQ 10 mapped to IO-APIC IRQ 17.
[ 1.100585] usbcore: registered new device driver usb
[ 1.101716] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 1.102358] uhci_hcd: USB Universal Host Controller Interface driver
[ 1.103410] ehci-pci: EHCI PCI platform driver
[ 1.108147] EATA/DMA 2.0x: Copyright (C) 1994-2003 Dario Ballabio.
[ 1.108214] EATA config options -> tm:1, lc:y, mq:16, rs:y, et:n, ip:n, ep:n, pp:y.
[ 1.108287] EATA0: 2.0C, PCI 0xd890, IRQ 17, BMST, SG 122, MB 64.
[ 1.108346] EATA0: wide SCSI support enabled, max_id 16, max_lun 8.
[ 1.108405] EATA0: SCSI channel 0 enabled, host target ID 7.
[ 1.108472] scsi host0: EATA/DMA 2.0x rev. 8.10.00
[ 1.110734] uhci_hcd 0000:00:10.0: UHCI Host Controller
[ 1.111274] uhci_hcd 0000:00:10.0: new USB bus registered, assigned bus number 1
[ 1.111511] uhci_hcd 0000:00:10.0: detected 2 ports
[ 1.111737] uhci_hcd 0000:00:10.0: irq 20, io base 0x0000ec00
[ 1.113371] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001
[ 1.113435] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 1.113507] usb usb1: Product: UHCI Host Controller
[ 1.113565] usb usb1: Manufacturer: Linux 4.1.0 uhci_hcd
[ 1.113623] usb usb1: SerialNumber: 0000:00:10.0
[ 1.114465] libata version 3.00 loaded.
[ 1.119476] hub 1-0:1.0: USB hub found
[ 1.122300] hub 1-0:1.0: 2 ports detected
[ 1.132373] ehci-pci 0000:00:10.4: EHCI Host Controller
[ 1.132500] ehci-pci 0000:00:10.4: new USB bus registered, assigned bus number 2
[ 1.132600] ehci-pci 0000:00:10.4: debug port 1
[ 1.132825] ehci-pci 0000:00:10.4: irq 22, io mem 0xff6ffc00
[ 1.144390] ehci-pci 0000:00:10.4: USB 2.0 started, EHCI 1.00
[ 1.144786] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002
[ 1.144847] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 1.144918] usb usb2: Product: EHCI Host Controller
[ 1.144976] usb usb2: Manufacturer: Linux 4.1.0 ehci_hcd
[ 1.145035] usb usb2: SerialNumber: 0000:00:10.4
[ 1.145964] hub 2-0:1.0: USB hub found
[ 1.146079] hub 2-0:1.0: 8 ports detected
[ 1.169093] hub 1-0:1.0: USB hub found
[ 1.169214] firewire_ohci 0000:05:0b.2: added OHCI v1.10 device as card 0, 4 IR + 8 IT contexts, quirks 0x2
[ 1.169516] hub 1-0:1.0: 2 ports detected
[ 1.170210] pata_via 0000:00:0f.0: version 0.3.4
[ 1.179507] scsi host1: pata_via
[ 1.186650] scsi host2: pata_via
[ 1.186968] ata1: PATA max UDMA/133 cmd 0x1f0 ctl 0x3f6 bmdma 0xfc00 irq 14
[ 1.187029] ata2: PATA max UDMA/133 cmd 0x170 ctl 0x376 bmdma 0xfc08 irq 15
[ 1.187957] uhci_hcd 0000:00:10.1: UHCI Host Controller
[ 1.188102] uhci_hcd 0000:00:10.1: new USB bus registered, assigned bus number 3
[ 1.188183] uhci_hcd 0000:00:10.1: detected 2 ports
[ 1.188265] uhci_hcd 0000:00:10.1: irq 22, io base 0x0000e880
[ 1.188564] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001
[ 1.188626] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 1.188697] usb usb3: Product: UHCI Host Controller
[ 1.188755] usb usb3: Manufacturer: Linux 4.1.0 uhci_hcd
[ 1.188814] usb usb3: SerialNumber: 0000:00:10.1
[ 1.189440] hub 3-0:1.0: USB hub found
[ 1.189528] hub 3-0:1.0: 2 ports detected
[ 1.190420] uhci_hcd 0000:00:10.2: UHCI Host Controller
[ 1.190493] uhci_hcd 0000:00:10.2: new USB bus registered, assigned bus number 4
[ 1.190572] uhci_hcd 0000:00:10.2: detected 2 ports
[ 1.190677] uhci_hcd 0000:00:10.2: irq 21, io base 0x0000e800
[ 1.190905] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001
[ 1.190967] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 1.191038] usb usb4: Product: UHCI Host Controller
[ 1.191096] usb usb4: Manufacturer: Linux 4.1.0 uhci_hcd
[ 1.191154] usb usb4: SerialNumber: 0000:00:10.2
[ 1.194641] hub 4-0:1.0: USB hub found
[ 1.196000] hub 4-0:1.0: 2 ports detected
[ 1.199618] uhci_hcd 0000:00:10.3: UHCI Host Controller
[ 1.199699] uhci_hcd 0000:00:10.3: new USB bus registered, assigned bus number 5
[ 1.199786] uhci_hcd 0000:00:10.3: detected 2 ports
[ 1.199896] uhci_hcd 0000:00:10.3: irq 23, io base 0x0000e480
[ 1.204118] usb usb5: New USB device found, idVendor=1d6b, idProduct=0001
[ 1.204184] usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 1.204255] usb usb5: Product: UHCI Host Controller
[ 1.204314] usb usb5: Manufacturer: Linux 4.1.0 uhci_hcd
[ 1.204372] usb usb5: SerialNumber: 0000:00:10.3
[ 1.208867] hub 5-0:1.0: USB hub found
[ 1.209671] hub 5-0:1.0: 2 ports detected
[ 1.361333] ata1.00: ATA-8: WDC WD3200AAJB-00WGA0, 00.02C01, max UDMA/100
[ 1.361400] ata1.00: 625142448 sectors, multi 16: LBA48
[ 1.368708] ata1.00: configured for UDMA/100
[ 1.456071] usb 2-6: new high-speed USB device number 2 using ehci-pci
[ 1.598103] usb 2-6: New USB device found, idVendor=13fe, idProduct=1e23
[ 1.598165] usb 2-6: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[ 1.598230] usb 2-6: Product: STORE N GO
[ 1.598288] usb 2-6: Manufacturer: Verbatim
[ 1.598345] usb 2-6: SerialNumber: 078A18B40293
[ 1.618199] uas: Unknown symbol usb_stor_adjust_quirks (err 0)
[ 1.619372] uas: Unknown symbol usb_stor_sense_invalidCDB (err 0)
[ 1.669048] firewire_core 0000:05:0b.2: created device fw0: GUID 00023c0153000612, S400
[ 2.641420] scsi 0:0:6:0: Direct-Access IBM DCAS-34330W S65A PQ: 0 ANSI: 2
[ 2.641500] scsi 0:0:6:0: cmds/lun 16, sorted, simple tags.
[ 4.072489] floppy0: no floppy controllers found
[ 4.675533] scsi 1:0:0:0: Direct-Access ATA WDC WD3200AAJB-0 2C01 PQ: 0 ANSI: 5
[ 4.676874] sd 1:0:0:0: [sdb] 625142448 512-byte logical blocks: (320 GB/298 GiB)
[ 4.677079] sd 1:0:0:0: [sdb] Write Protect is off
[ 4.677139] sd 1:0:0:0: [sdb] Mode Sense: 00 3a 00 00
[ 4.677197] sd 1:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 4.677435] sd 0:0:6:0: [sda] 8466688 512-byte logical blocks: (4.33 GB/4.03 GiB)
[ 4.716307] sd 0:0:6:0: [sda] Write Protect is off
[ 4.716372] sd 0:0:6:0: [sda] Mode Sense: b3 00 00 08
[ 4.719184] sdb: sdb1 sdb2 < sdb5 sdb6 sdb7 >
[ 4.722584] sd 1:0:0:0: [sdb] Attached SCSI disk
[ 4.737188] sd 0:0:6:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 4.807508] sda: sda1 sda2 < sda5 >
[ 4.848376] ata2.00: ATAPI: HL-DT-ST DVDRAM GSA-4163B, A103, max UDMA/33
[ 4.848825] ata2.01: HPA detected: current 66055248, native 78242976
[ 4.848887] ata2.01: ATA-6: SAMSUNG SP4002H, QU100-57, max UDMA/100
[ 4.848948] ata2.01: 66055248 sectors, multi 16: LBA
[ 4.849011] ata2.01: limited to UDMA/33 due to 40-wire cable
[ 4.864229] ata2.00: configured for UDMA/33
[ 4.875959] sd 0:0:6:0: [sda] Attached SCSI disk
[ 4.880653] ata2.01: configured for UDMA/33
[ 4.887102] scsi 2:0:0:0: CD-ROM HL-DT-ST DVDRAM GSA-4163B A103 PQ: 0 ANSI: 5
[ 4.898854] scsi 2:0:1:0: Direct-Access ATA SAMSUNG SP4002H 0-57 PQ: 0 ANSI: 5
[ 4.899584] sd 2:0:1:0: [sdc] 66055248 512-byte logical blocks: (33.8 GB/31.4 GiB)
[ 4.899829] sd 2:0:1:0: [sdc] Write Protect is off
[ 4.899888] sd 2:0:1:0: [sdc] Mode Sense: 00 3a 00 00
[ 4.899962] sd 2:0:1:0: [sdc] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 4.945233] sdc: sdc1 sdc2 < sdc5 sdc6 sdc7 > sdc3
[ 4.945730] sdc: p3 size 13333950 extends beyond EOD, enabling native capacity
[ 4.945968] ata2: soft resetting link
[ 5.116359] ata2.01: n_sectors mismatch 66055248 != 78242976
[ 5.116420] ata2.01: new n_sectors matches native, probably late HPA unlock, n_sectors updated
[ 5.140259] ata2.00: configured for UDMA/33
[ 5.156640] ata2.01: configured for UDMA/33
[ 5.158852] ata2: EH complete
[ 5.159343] sd 2:0:1:0: [sdc] 78242976 512-byte logical blocks: (40.0 GB/37.3 GiB)
[ 5.162058] sdc: detected capacity change from 33820286976 to 40060403712
[ 5.220641] sdc: sdc1 sdc2 < sdc5 sdc6 sdc7 > sdc3
[ 5.222880] sd 2:0:1:0: [sdc] Attached SCSI disk
[ 5.244301] sr 2:0:0:0: [sr0] scsi3-mmc drive: 40x/40x writer dvd-ram cd/rw xa/form2 cdda tray
[ 5.244381] cdrom: Uniform CD-ROM driver Revision: 3.20
[ 5.245974] sr 2:0:0:0: Attached scsi CD-ROM sr0