* radeon testing
@ 2012-08-16 15:51 Alex Deucher
2012-08-20 12:30 ` Luca Tettamanti
0 siblings, 1 reply; 8+ messages in thread
From: Alex Deucher @ 2012-08-16 15:51 UTC (permalink / raw)
To: Maling list - DRI developers
I've gathered up the various outstanding radeon patches and put them
up in a tree for testing:
http://cgit.freedesktop.org/~agd5f/linux/log/?h=drm-next-3.7-wip
Some of these may end up in -fixes, but most of them are -next
material. I haven't had a chance to go through Christian's last set
of VM patches yet.
Highlights:
- rom fetch fixes (UEFI, thunderbolt docks)
- major ACPI rework
- backlight control for newer asics
Alex
^ permalink raw reply [flat|nested] 8+ messages in thread
* Re: radeon testing
2012-08-16 15:51 radeon testing Alex Deucher
@ 2012-08-20 12:30 ` Luca Tettamanti
2012-08-20 14:24 ` Alex Deucher
0 siblings, 1 reply; 8+ messages in thread
From: Luca Tettamanti @ 2012-08-20 12:30 UTC (permalink / raw)
To: Alex Deucher; +Cc: Maling list - DRI developers
[-- Attachment #1: Type: text/plain, Size: 1077 bytes --]
On Thu, Aug 16, 2012 at 11:51:10AM -0400, Alex Deucher wrote:
> I've gathered up the various outstanding radeon patches and put them
> up in a tree for testing:
> http://cgit.freedesktop.org/~agd5f/linux/log/?h=drm-next-3.7-wip
> Some of these may end up in -fixes, but most of them are -next
> material. I haven't had a chance to go through Christian's last set
> of VM patches yet.
>
> Highlights:
> - rom fetch fixes (UEFI, thunderbolt docks)
> - major ACPI rework
> - backlight control for newer asics
Hi Alex,
I just tested the rebased acpi_patches branch: ACPI part works fine, but
I see a big slow down during radeon driver initialization when the
screen goes black for a couple of seconds (with 3.5.0 + acpi patches the
screen just flickers during boot). With initcall_debug I see:
[ 2.355300] calling radeon_init+0x0/0x1000 [radeon] @ 552
...
[ 5.530310] initcall radeon_init+0x0/0x1000 [radeon] returned 0 after 3102147 usecs
For reference 3.5 takes ~1 sec. With drm.debug=2 the log (attached) is not very
informative, I'll try and get more info...
Luca
[-- Attachment #2: dmesg-slow1.txt --]
[-- Type: text/plain, Size: 119011 bytes --]
[ 0.000000] BIOS-e820: [mem 0x00000000aa99f000-0x00000000af2befff] usable
[ 0.000000] BIOS-e820: [mem 0x00000000af2bf000-0x00000000af6befff] reserved
[ 0.000000] BIOS-e820: [mem 0x00000000af6bf000-0x00000000af7befff] ACPI NVS
[ 0.000000] BIOS-e820: [mem 0x00000000af7bf000-0x00000000af7fefff] ACPI data
[ 0.000000] BIOS-e820: [mem 0x00000000af7ff000-0x00000000af7fffff] usable
[ 0.000000] BIOS-e820: [mem 0x00000000af800000-0x00000000afffffff] reserved
[ 0.000000] BIOS-e820: [mem 0x00000000e0000000-0x00000000efffffff] reserved
[ 0.000000] BIOS-e820: [mem 0x00000000feb00000-0x00000000feb03fff] reserved
[ 0.000000] BIOS-e820: [mem 0x00000000fec00000-0x00000000fec00fff] reserved
[ 0.000000] BIOS-e820: [mem 0x00000000fed10000-0x00000000fed19fff] reserved
[ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved
[ 0.000000] BIOS-e820: [mem 0x00000000fee00000-0x00000000fee00fff] reserved
[ 0.000000] BIOS-e820: [mem 0x00000000ffd80000-0x00000000ffffffff] reserved
[ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x00000001ceffffff] usable
[ 0.000000] NX (Execute Disable) protection: active
[ 0.000000] DMI 2.7 present.
[ 0.000000] DMI: TOSHIBA SATELLITE L855/Portable PC, BIOS 1.60 04/20/2012
[ 0.000000] e820: update [mem 0x00000000-0x0000ffff] usable ==> reserved
[ 0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
[ 0.000000] No AGP bridge found
[ 0.000000] e820: last_pfn = 0x1cf000 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-E7FFF write-protect
[ 0.000000] E8000-EFFFF write-combining
[ 0.000000] F0000-FFFFF write-protect
[ 0.000000] MTRR variable ranges enabled:
[ 0.000000] 0 base 000000000 mask F80000000 write-back
[ 0.000000] 1 base 080000000 mask FC0000000 write-back
[ 0.000000] 2 base 0AF800000 mask FFF800000 uncachable
[ 0.000000] 3 base 0B0000000 mask FF0000000 uncachable
[ 0.000000] 4 base 0FFC00000 mask FFFC00000 write-protect
[ 0.000000] 5 base 100000000 mask F00000000 write-back
[ 0.000000] 6 base 1CF000000 mask FFF000000 uncachable
[ 0.000000] 7 base 1D0000000 mask FF0000000 uncachable
[ 0.000000] 8 base 1E0000000 mask FE0000000 uncachable
[ 0.000000] 9 disabled
[ 0.000000] x86 PAT enabled: cpu 0, old 0x7040600070406, new 0x7010600070106
[ 0.000000] e820: last_pfn = 0xaf800 max_arch_pfn = 0x400000000
[ 0.000000] found SMP MP-table at [mem 0x000fe1b0-0x000fe1bf] mapped at [ffff8800000fe1b0]
[ 0.000000] initial memory mapped: [mem 0x00000000-0x1fffffff]
[ 0.000000] Base memory trampoline at [ffff880000097000] 97000 size 24576
[ 0.000000] init_memory_mapping: [mem 0x00000000-0xaf7fffff]
[ 0.000000] [mem 0x00000000-0xaf7fffff] page 2M
[ 0.000000] kernel direct mapping tables up to 0xaf7fffff @ [mem 0x1fa80000-0x1fffffff]
[ 0.000000] init_memory_mapping: [mem 0x100000000-0x1ceffffff]
[ 0.000000] [mem 0x100000000-0x1ceffffff] page 2M
[ 0.000000] kernel direct mapping tables up to 0x1ceffffff @ [mem 0xaf2b6000-0xaf2befff]
[ 0.000000] RAMDISK: [mem 0x3763c000-0x37b15fff]
[ 0.000000] ACPI: RSDP 00000000000fe020 00024 (v02 TOSINV)
[ 0.000000] ACPI: XSDT 00000000af7fe210 0009C (v01 TOSINV TOSINV00 00000001 01000013)
[ 0.000000] ACPI: FACP 00000000af7fb000 0010C (v05 TOSINV TOSINV00 00000001 ACPI 00040000)
[ 0.000000] ACPI: DSDT 00000000af7f0000 07F66 (v01 TOSINV TOSINV00 00000000 ACPI 00040000)
[ 0.000000] ACPI: FACS 00000000af7bb000 00040
[ 0.000000] ACPI: UEFI 00000000af7fd000 00236 (v01 TOSINV TOSINV00 00000001 ACPI 00040000)
[ 0.000000] ACPI: ASF! 00000000af7fc000 000A5 (v32 TOSINV TOSINV00 00000001 ACPI 00040000)
[ 0.000000] ACPI: HPET 00000000af7fa000 00038 (v01 TOSINV TOSINV00 00000001 ACPI 00040000)
[ 0.000000] ACPI: APIC 00000000af7f9000 0008C (v03 TOSINV TOSINV00 00000001 ACPI 00040000)
[ 0.000000] ACPI: MCFG 00000000af7f8000 0003C (v01 TOSINV TOSINV00 00000001 ACPI 00040000)
[ 0.000000] ACPI: SLIC 00000000af7ef000 00176 (v01 TOSINV TOSINV00 00000001 ACPI 00040000)
[ 0.000000] ACPI: WDAT 00000000af7ee000 00224 (v01 TOSINV TOSINV00 00000001 ACPI 00040000)
[ 0.000000] ACPI: SSDT 00000000af7ec000 01068 (v01 INSYDE CR CRB 00001000 ACPI 00040000)
[ 0.000000] ACPI: BOOT 00000000af7ea000 00028 (v01 TOSINV TOSINV00 00000001 ACPI 00040000)
[ 0.000000] ACPI: ASPT 00000000af7e6000 00034 (v07 TOSINV TOSINV00 00000001 ACPI 00040000)
[ 0.000000] ACPI: SSDT 00000000af7e1000 047DF (v01 TOSINV TsbOdm 00001000 ACPI 00040000)
[ 0.000000] ACPI: FPDT 00000000af7df000 00044 (v01 TOSINV TOSINV00 00000001 ACPI 00040000)
[ 0.000000] ACPI: SSDT 00000000af7de000 008D6 (v01 INSYDE CR CRB 00003000 ACPI 00040000)
[ 0.000000] ACPI: SSDT 00000000af7dd000 00A92 (v01 INSYDE CR CRB 00003000 ACPI 00040000)
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] No NUMA configuration found
[ 0.000000] Faking a node at [mem 0x0000000000000000-0x00000001ceffffff]
[ 0.000000] Initmem setup node 0 [mem 0x00000000-0x1ceffffff]
[ 0.000000] NODE_DATA [mem 0x1ceffc000-0x1ceffffff]
[ 0.000000] [ffffea0000000000-ffffea00065fffff] PMD -> [ffff8801c8600000-ffff8801cdbfffff] on node 0
[ 0.000000] Zone ranges:
[ 0.000000] DMA [mem 0x00010000-0x00ffffff]
[ 0.000000] DMA32 [mem 0x01000000-0xffffffff]
[ 0.000000] Normal [mem 0x100000000-0x1ceffffff]
[ 0.000000] Movable zone start for each node
[ 0.000000] Early memory node ranges
[ 0.000000] node 0: [mem 0x00010000-0x0009cfff]
[ 0.000000] node 0: [mem 0x00100000-0xaa1edfff]
[ 0.000000] node 0: [mem 0xaa977000-0xaa999fff]
[ 0.000000] node 0: [mem 0xaa99f000-0xaf2befff]
[ 0.000000] node 0: [mem 0xaf7ff000-0xaf7fffff]
[ 0.000000] node 0: [mem 0x100000000-0x1ceffffff]
[ 0.000000] On node 0 totalpages: 1563327
[ 0.000000] DMA zone: 56 pages used for memmap
[ 0.000000] DMA zone: 6 pages reserved
[ 0.000000] DMA zone: 3919 pages, LIFO batch:0
[ 0.000000] DMA32 zone: 14280 pages used for memmap
[ 0.000000] DMA32 zone: 697194 pages, LIFO batch:31
[ 0.000000] Normal zone: 11592 pages used for memmap
[ 0.000000] Normal zone: 836280 pages, LIFO batch:31
[ 0.000000] ACPI: PM-Timer IO Port: 0x408
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] ACPI: LAPIC (acpi_id[0x01] lapic_id[0x00] enabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x02] lapic_id[0x01] enabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x03] lapic_id[0x02] enabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x04] lapic_id[0x03] enabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x05] lapic_id[0x04] enabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x06] lapic_id[0x05] enabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x07] lapic_id[0x06] enabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x08] lapic_id[0x07] enabled)
[ 0.000000] ACPI: IOAPIC (id[0x00] address[0xfec00000] gsi_base[0])
[ 0.000000] IOAPIC[0]: apic_id 0, version 32, 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 high level)
[ 0.000000] ACPI: IRQ0 used by override.
[ 0.000000] ACPI: IRQ2 used by override.
[ 0.000000] ACPI: IRQ9 used by override.
[ 0.000000] Using ACPI (MADT) for SMP configuration information
[ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
[ 0.000000] smpboot: Allowing 8 CPUs, 0 hotplug CPUs
[ 0.000000] nr_irqs_gsi: 40
[ 0.000000] PM: Registered nosave memory: 000000000009d000 - 000000000009e000
[ 0.000000] PM: Registered nosave memory: 000000000009e000 - 00000000000a0000
[ 0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000e0000
[ 0.000000] PM: Registered nosave memory: 00000000000e0000 - 0000000000100000
[ 0.000000] PM: Registered nosave memory: 00000000aa1ee000 - 00000000aa977000
[ 0.000000] PM: Registered nosave memory: 00000000aa99a000 - 00000000aa99f000
[ 0.000000] PM: Registered nosave memory: 00000000af2bf000 - 00000000af6bf000
[ 0.000000] PM: Registered nosave memory: 00000000af6bf000 - 00000000af7bf000
[ 0.000000] PM: Registered nosave memory: 00000000af7bf000 - 00000000af7ff000
[ 0.000000] PM: Registered nosave memory: 00000000af800000 - 00000000b0000000
[ 0.000000] PM: Registered nosave memory: 00000000b0000000 - 00000000e0000000
[ 0.000000] PM: Registered nosave memory: 00000000e0000000 - 00000000f0000000
[ 0.000000] PM: Registered nosave memory: 00000000f0000000 - 00000000feb00000
[ 0.000000] PM: Registered nosave memory: 00000000feb00000 - 00000000feb04000
[ 0.000000] PM: Registered nosave memory: 00000000feb04000 - 00000000fec00000
[ 0.000000] PM: Registered nosave memory: 00000000fec00000 - 00000000fec01000
[ 0.000000] PM: Registered nosave memory: 00000000fec01000 - 00000000fed10000
[ 0.000000] PM: Registered nosave memory: 00000000fed10000 - 00000000fed1a000
[ 0.000000] PM: Registered nosave memory: 00000000fed1a000 - 00000000fed1c000
[ 0.000000] PM: Registered nosave memory: 00000000fed1c000 - 00000000fed20000
[ 0.000000] PM: Registered nosave memory: 00000000fed20000 - 00000000fee00000
[ 0.000000] PM: Registered nosave memory: 00000000fee00000 - 00000000fee01000
[ 0.000000] PM: Registered nosave memory: 00000000fee01000 - 00000000ffd80000
[ 0.000000] PM: Registered nosave memory: 00000000ffd80000 - 0000000100000000
[ 0.000000] e820: [mem 0xb0000000-0xdfffffff] available for PCI devices
[ 0.000000] setup_percpu: NR_CPUS:32 nr_cpumask_bits:32 nr_cpu_ids:8 nr_node_ids:1
[ 0.000000] PERCPU: Embedded 27 pages/cpu @ffff8801cec00000 s78528 r8192 d23872 u262144
[ 0.000000] pcpu-alloc: s78528 r8192 d23872 u262144 alloc=1*2097152
[ 0.000000] pcpu-alloc: [0] 0 1 2 3 4 5 6 7
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 1537393
[ 0.000000] Policy zone: Normal
[ 0.000000] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-3.6.0-rc1+ root=UUID=37a7cda7-02cb-442d-8235-89301be191f6 ro initcall_debug drm.debug=2
[ 0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes)
[ 0.000000] __ex_table already sorted, skipping sort
[ 0.000000] xsave: enabled xstate_bv 0x7, cntxt size 0x340
[ 0.000000] Checking aperture...
[ 0.000000] No AGP bridge found
[ 0.000000] Memory: 6085068k/7585792k available (3099k kernel code, 1332484k absent, 168240k reserved, 3551k data, 516k init)
[ 0.000000] Hierarchical RCU implementation.
[ 0.000000] RCU dyntick-idle grace-period acceleration is enabled.
[ 0.000000] RCU restricting CPUs from NR_CPUS=32 to nr_cpu_ids=8.
[ 0.000000] NR_IRQS:4352 nr_irqs:744 16
[ 0.000000] Console: colour VGA+ 80x25
[ 0.000000] console [tty0] enabled
[ 0.000000] hpet clockevent registered
[ 0.000000] tsc: Fast TSC calibration using PIT
[ 0.004000] tsc: Detected 2294.611 MHz processor
[ 0.000002] Calibrating delay loop (skipped), value calculated using timer frequency.. 4589.22 BogoMIPS (lpj=9178444)
[ 0.000133] pid_max: default: 32768 minimum: 301
[ 0.000662] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes)
[ 0.002801] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes)
[ 0.003794] Mount-cache hash table entries: 256
[ 0.004043] Initializing cgroup subsys cpuacct
[ 0.004109] Initializing cgroup subsys devices
[ 0.004174] Initializing cgroup subsys freezer
[ 0.004239] Initializing cgroup subsys net_cls
[ 0.004304] Initializing cgroup subsys blkio
[ 0.004368] Initializing cgroup subsys perf_event
[ 0.004455] CPU: Physical Processor ID: 0
[ 0.004519] CPU: Processor Core ID: 0
[ 0.004587] ENERGY_PERF_BIAS: Set to 'normal', was 'performance'
[ 0.004587] ENERGY_PERF_BIAS: View and update with x86_energy_perf_policy(8)
[ 0.005048] mce: CPU supports 9 MCE banks
[ 0.005120] CPU0: Thermal monitoring handled by SMI
[ 0.005126] process: using mwait in idle threads
[ 0.005194] Last level iTLB entries: 4KB 512, 2MB 0, 4MB 0
[ 0.005194] Last level dTLB entries: 4KB 512, 2MB 32, 4MB 32
[ 0.005194] tlb_flushall_shift is 0x1
[ 0.005338] ACPI: Core revision 20120711
[ 0.023359] ..TIMER: vector=0x51 apic1=0 pin1=2 apic2=-1 pin2=-1
[ 0.063085] smpboot: CPU0: Intel(R) Core(TM) i7-3610QM CPU @ 2.30GHz stepping 09
[ 0.167730] calling trace_init_flags_sys_exit+0x0/0xd @ 1
[ 0.167732] initcall trace_init_flags_sys_exit+0x0/0xd returned 0 after 0 usecs
[ 0.167734] calling trace_init_flags_sys_enter+0x0/0xd @ 1
[ 0.167736] initcall trace_init_flags_sys_enter+0x0/0xd returned 0 after 0 usecs
[ 0.167738] calling init_hw_perf_events+0x0/0x37c @ 1
[ 0.167739] Performance Events: PEBS fmt1+, 16-deep LBR, SandyBridge events, Intel PMU driver.
[ 0.168040] ... version: 3
[ 0.168104] ... bit width: 48
[ 0.168168] ... generic registers: 4
[ 0.168232] ... value mask: 0000ffffffffffff
[ 0.168297] ... max period: 000000007fffffff
[ 0.168363] ... fixed-purpose events: 3
[ 0.168428] ... event mask: 000000070000000f
[ 0.168505] initcall init_hw_perf_events+0x0/0x37c returned 0 after 0 usecs
[ 0.168507] calling register_trigger_all_cpu_backtrace+0x0/0x13 @ 1
[ 0.168509] initcall register_trigger_all_cpu_backtrace+0x0/0x13 returned 0 after 0 usecs
[ 0.168512] calling spawn_ksoftirqd+0x0/0x4a @ 1
[ 0.168525] initcall spawn_ksoftirqd+0x0/0x4a returned 0 after 0 usecs
[ 0.168528] calling init_workqueues+0x0/0x2f3 @ 1
[ 0.168588] initcall init_workqueues+0x0/0x2f3 returned 0 after 0 usecs
[ 0.168591] calling migration_init+0x0/0x65 @ 1
[ 0.168594] initcall migration_init+0x0/0x65 returned 0 after 0 usecs
[ 0.168596] calling cpu_stop_init+0x0/0x9d @ 1
[ 0.168609] initcall cpu_stop_init+0x0/0x9d returned 0 after 0 usecs
[ 0.168611] calling rcu_scheduler_really_started+0x0/0xd @ 1
[ 0.168612] initcall rcu_scheduler_really_started+0x0/0xd returned 0 after 0 usecs
[ 0.168614] calling relay_init+0x0/0x11 @ 1
[ 0.168615] initcall relay_init+0x0/0x11 returned 0 after 0 usecs
[ 0.168617] calling tracer_alloc_buffers+0x0/0x185 @ 1
[ 0.168631] initcall tracer_alloc_buffers+0x0/0x185 returned 0 after 0 usecs
[ 0.168632] calling init_events+0x0/0x5c @ 1
[ 0.168635] initcall init_events+0x0/0x5c returned 0 after 0 usecs
[ 0.168636] calling init_trace_printk+0x0/0xc @ 1
[ 0.168638] initcall init_trace_printk+0x0/0xc returned 0 after 0 usecs
[ 0.168690] NMI watchdog: enabled on all CPUs, permanently consumes one hw-PMU counter.
[ 0.180514] CPU1: Thermal monitoring handled by SMI
[ 0.194210] CPU2: Thermal monitoring handled by SMI
[ 0.207899] CPU3: Thermal monitoring handled by SMI
[ 0.221600] CPU4: Thermal monitoring handled by SMI
[ 0.235290] CPU5: Thermal monitoring handled by SMI
[ 0.248983] CPU6: Thermal monitoring handled by SMI
[ 0.168874] smpboot: Booting Node 0, Processors #1 #2 #3 #4 #5 #6 #7 OK
[ 0.262674] CPU7: Thermal monitoring handled by SMI
[ 0.264790] Brought up 8 CPUs
[ 0.264858] smpboot: Total of 8 processors activated (36713.77 BogoMIPS)
[ 0.274517] devtmpfs: initialized
[ 0.277710] calling ipc_ns_init+0x0/0x13 @ 1
[ 0.277713] initcall ipc_ns_init+0x0/0x13 returned 0 after 0 usecs
[ 0.277716] calling init_mmap_min_addr+0x0/0x11 @ 1
[ 0.277718] initcall init_mmap_min_addr+0x0/0x11 returned 0 after 0 usecs
[ 0.277722] calling init_cpufreq_transition_notifier_list+0x0/0x18 @ 1
[ 0.277726] initcall init_cpufreq_transition_notifier_list+0x0/0x18 returned 0 after 0 usecs
[ 0.277728] calling net_ns_init+0x0/0xdf @ 1
[ 0.277749] initcall net_ns_init+0x0/0xdf returned 0 after 0 usecs
[ 0.277767] calling e820_mark_nvs_memory+0x0/0x36 @ 1
[ 0.277769] PM: Registering ACPI NVS region [mem 0xaa1ee000-0xaa976fff] (7901184 bytes)
[ 0.278032] PM: Registering ACPI NVS region [mem 0xaa99a000-0xaa99efff] (20480 bytes)
[ 0.278105] PM: Registering ACPI NVS region [mem 0xaf6bf000-0xaf7befff] (1048576 bytes)
[ 0.278203] initcall e820_mark_nvs_memory+0x0/0x36 returned 0 after 0 usecs
[ 0.278206] calling cpufreq_tsc+0x0/0x32 @ 1
[ 0.278207] initcall cpufreq_tsc+0x0/0x32 returned 0 after 0 usecs
[ 0.278210] calling reboot_init+0x0/0x1d @ 1
[ 0.278215] initcall reboot_init+0x0/0x1d returned 0 after 0 usecs
[ 0.278217] calling init_lapic_sysfs+0x0/0x22 @ 1
[ 0.278220] initcall init_lapic_sysfs+0x0/0x22 returned 0 after 0 usecs
[ 0.278222] calling cpu_hotplug_pm_sync_init+0x0/0x11 @ 1
[ 0.278225] initcall cpu_hotplug_pm_sync_init+0x0/0x11 returned 0 after 0 usecs
[ 0.278227] calling alloc_frozen_cpus+0x0/0x3 @ 1
[ 0.278229] initcall alloc_frozen_cpus+0x0/0x3 returned 0 after 0 usecs
[ 0.278231] calling ksysfs_init+0x0/0x90 @ 1
[ 0.278237] initcall ksysfs_init+0x0/0x90 returned 0 after 0 usecs
[ 0.278239] calling pm_init+0x0/0x79 @ 1
[ 0.278246] initcall pm_init+0x0/0x79 returned 0 after 0 usecs
[ 0.278248] calling pm_disk_init+0x0/0x13 @ 1
[ 0.278252] initcall pm_disk_init+0x0/0x13 returned 0 after 0 usecs
[ 0.278255] calling swsusp_header_init+0x0/0x29 @ 1
[ 0.278258] initcall swsusp_header_init+0x0/0x29 returned 0 after 0 usecs
[ 0.278260] calling init_jiffies_clocksource+0x0/0xc @ 1
[ 0.278263] initcall init_jiffies_clocksource+0x0/0xc returned 0 after 0 usecs
[ 0.278265] calling init_zero_pfn+0x0/0x32 @ 1
[ 0.278267] initcall init_zero_pfn+0x0/0x32 returned 0 after 0 usecs
[ 0.278269] calling memory_failure_init+0x0/0x98 @ 1
[ 0.278272] initcall memory_failure_init+0x0/0x98 returned 0 after 0 usecs
[ 0.278274] calling fsnotify_init+0x0/0x23 @ 1
[ 0.278277] initcall fsnotify_init+0x0/0x23 returned 0 after 0 usecs
[ 0.278279] calling filelock_init+0x0/0x28 @ 1
[ 0.278287] initcall filelock_init+0x0/0x28 returned 0 after 0 usecs
[ 0.278289] calling init_script_binfmt+0x0/0x13 @ 1
[ 0.278291] initcall init_script_binfmt+0x0/0x13 returned 0 after 0 usecs
[ 0.278293] calling init_elf_binfmt+0x0/0x13 @ 1
[ 0.278295] initcall init_elf_binfmt+0x0/0x13 returned 0 after 0 usecs
[ 0.278297] calling init_compat_elf_binfmt+0x0/0x13 @ 1
[ 0.278299] initcall init_compat_elf_binfmt+0x0/0x13 returned 0 after 0 usecs
[ 0.278301] calling debugfs_init+0x0/0x5c @ 1
[ 0.278306] initcall debugfs_init+0x0/0x5c returned 0 after 0 usecs
[ 0.278308] calling random32_init+0x0/0xb9 @ 1
[ 0.278311] initcall random32_init+0x0/0xb9 returned 0 after 0 usecs
[ 0.278313] calling sfi_sysfs_init+0x0/0xd2 @ 1
[ 0.278315] initcall sfi_sysfs_init+0x0/0xd2 returned 0 after 0 usecs
[ 0.278318] calling cpufreq_core_init+0x0/0xad @ 1
[ 0.278322] initcall cpufreq_core_init+0x0/0xad returned 0 after 0 usecs
[ 0.278324] calling cpuidle_init+0x0/0x38 @ 1
[ 0.278328] initcall cpuidle_init+0x0/0x38 returned 0 after 0 usecs
[ 0.278330] calling sock_init+0x0/0x84 @ 1
[ 0.278369] initcall sock_init+0x0/0x84 returned 0 after 0 usecs
[ 0.278371] calling net_inuse_init+0x0/0x24 @ 1
[ 0.278374] initcall net_inuse_init+0x0/0x24 returned 0 after 0 usecs
[ 0.278376] calling netpoll_init+0x0/0x2b @ 1
[ 0.278378] initcall netpoll_init+0x0/0x2b returned 0 after 0 usecs
[ 0.278380] calling netlink_proto_init+0x0/0x196 @ 1
[ 0.278386] NET: Registered protocol family 16
[ 0.278458] initcall netlink_proto_init+0x0/0x196 returned 0 after 0 usecs
[ 0.278475] calling bdi_class_init+0x0/0x47 @ 1
[ 0.278492] initcall bdi_class_init+0x0/0x47 returned 0 after 0 usecs
[ 0.278494] calling kobject_uevent_init+0x0/0x1d @ 1
[ 0.278499] initcall kobject_uevent_init+0x0/0x1d returned 0 after 0 usecs
[ 0.278501] calling pcibus_class_init+0x0/0x13 @ 1
[ 0.278505] initcall pcibus_class_init+0x0/0x13 returned 0 after 0 usecs
[ 0.278507] calling pci_driver_init+0x0/0x13 @ 1
[ 0.278515] initcall pci_driver_init+0x0/0x13 returned 0 after 0 usecs
[ 0.278516] calling backlight_class_init+0x0/0x5a @ 1
[ 0.278521] initcall backlight_class_init+0x0/0x5a returned 0 after 0 usecs
[ 0.278523] calling tty_class_init+0x0/0x31 @ 1
[ 0.278527] initcall tty_class_init+0x0/0x31 returned 0 after 0 usecs
[ 0.278529] calling vtconsole_class_init+0x0/0xd8 @ 1
[ 0.278550] initcall vtconsole_class_init+0x0/0xd8 returned 0 after 0 usecs
[ 0.278552] calling wakeup_sources_debugfs_init+0x0/0x28 @ 1
[ 0.278556] initcall wakeup_sources_debugfs_init+0x0/0x28 returned 0 after 0 usecs
[ 0.278559] calling register_node_type+0x0/0x2a @ 1
[ 0.278576] initcall register_node_type+0x0/0x2a returned 0 after 0 usecs
[ 0.278578] calling amd_postcore_init+0x0/0x13a @ 1
[ 0.278580] initcall amd_postcore_init+0x0/0x13a returned 0 after 0 usecs
[ 0.278597] calling set_real_mode_permissions+0x0/0x94 @ 1
[ 0.278612] initcall set_real_mode_permissions+0x0/0x94 returned 0 after 0 usecs
[ 0.278614] calling arch_kdebugfs_init+0x0/0x21 @ 1
[ 0.278617] initcall arch_kdebugfs_init+0x0/0x21 returned 0 after 0 usecs
[ 0.278619] calling mtrr_if_init+0x0/0x62 @ 1
[ 0.278622] initcall mtrr_if_init+0x0/0x62 returned 0 after 0 usecs
[ 0.278624] calling ffh_cstate_init+0x0/0x2a @ 1
[ 0.278627] initcall ffh_cstate_init+0x0/0x2a returned 0 after 0 usecs
[ 0.278629] calling acpi_pci_init+0x0/0x59 @ 1
[ 0.278630] ACPI FADT declares the system doesn't support PCIe ASPM, so disable it
[ 0.278704] ACPI: bus type pci registered
[ 0.278768] initcall acpi_pci_init+0x0/0x59 returned 0 after 0 usecs
[ 0.278770] calling dma_bus_init+0x0/0x13 @ 1
[ 0.278776] initcall dma_bus_init+0x0/0x13 returned 0 after 0 usecs
[ 0.278778] calling dma_channel_table_init+0x0/0xcd @ 1
[ 0.278788] initcall dma_channel_table_init+0x0/0xcd returned 0 after 0 usecs
[ 0.278790] calling dmi_id_init+0x0/0x312 @ 1
[ 0.278820] initcall dmi_id_init+0x0/0x312 returned 0 after 0 usecs
[ 0.278822] calling pci_arch_init+0x0/0x63 @ 1
[ 0.278849] PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xe0000000-0xefffffff] (base 0xe0000000)
[ 0.278923] PCI: MMCONFIG at [mem 0xe0000000-0xefffffff] reserved in E820
[ 0.292798] PCI: Using configuration type 1 for base access
[ 0.292868] initcall pci_arch_init+0x0/0x63 returned 0 after 15625 usecs
[ 0.292885] calling topology_init+0x0/0x84 @ 1
[ 0.293139] initcall topology_init+0x0/0x84 returned 0 after 0 usecs
[ 0.293142] calling mtrr_init_finialize+0x0/0x34 @ 1
[ 0.293144] initcall mtrr_init_finialize+0x0/0x34 returned 0 after 0 usecs
[ 0.293146] calling init_vdso+0x0/0x248 @ 1
[ 0.293150] initcall init_vdso+0x0/0x248 returned 0 after 0 usecs
[ 0.293152] calling sysenter_setup+0x0/0x2c6 @ 1
[ 0.293155] initcall sysenter_setup+0x0/0x2c6 returned 0 after 0 usecs
[ 0.293157] calling param_sysfs_init+0x0/0x19a @ 1
[ 0.293479] initcall param_sysfs_init+0x0/0x19a returned 0 after 0 usecs
[ 0.293482] calling pm_sysrq_init+0x0/0x16 @ 1
[ 0.293484] initcall pm_sysrq_init+0x0/0x16 returned 0 after 0 usecs
[ 0.293486] calling default_bdi_init+0x0/0xa3 @ 1
[ 0.293535] initcall default_bdi_init+0x0/0xa3 returned 0 after 0 usecs
[ 0.293537] calling init_bio+0x0/0xf2 @ 1
[ 0.293596] bio: create slab <bio-0> at 0
[ 0.293666] initcall init_bio+0x0/0xf2 returned 0 after 0 usecs
[ 0.293668] calling fsnotify_notification_init+0x0/0x8a @ 1
[ 0.293682] initcall fsnotify_notification_init+0x0/0x8a returned 0 after 0 usecs
[ 0.293684] calling cryptomgr_init+0x0/0xc @ 1
[ 0.293687] initcall cryptomgr_init+0x0/0xc returned 0 after 0 usecs
[ 0.293689] calling blk_settings_init+0x0/0x25 @ 1
[ 0.293691] initcall blk_settings_init+0x0/0x25 returned 0 after 0 usecs
[ 0.293693] calling blk_ioc_init+0x0/0x27 @ 1
[ 0.293700] initcall blk_ioc_init+0x0/0x27 returned 0 after 0 usecs
[ 0.293702] calling blk_softirq_init+0x0/0x61 @ 1
[ 0.293705] initcall blk_softirq_init+0x0/0x61 returned 0 after 0 usecs
[ 0.293707] calling blk_iopoll_setup+0x0/0x61 @ 1
[ 0.293710] initcall blk_iopoll_setup+0x0/0x61 returned 0 after 0 usecs
[ 0.293712] calling genhd_device_init+0x0/0x71 @ 1
[ 0.293741] initcall genhd_device_init+0x0/0x71 returned 0 after 0 usecs
[ 0.293743] calling blk_dev_integrity_init+0x0/0x27 @ 1
[ 0.293750] initcall blk_dev_integrity_init+0x0/0x27 returned 0 after 0 usecs
[ 0.293753] calling pci_slot_init+0x0/0x42 @ 1
[ 0.293757] initcall pci_slot_init+0x0/0x42 returned 0 after 0 usecs
[ 0.293758] calling fbmem_init+0x0/0x95 @ 1
[ 0.293766] initcall fbmem_init+0x0/0x95 returned 0 after 0 usecs
[ 0.293768] calling acpi_init+0x0/0x2b4 @ 1
[ 0.293777] ACPI: Added _OSI(Module Device)
[ 0.293842] ACPI: Added _OSI(Processor Device)
[ 0.293907] ACPI: Added _OSI(3.0 _SCP Extensions)
[ 0.293972] ACPI: Added _OSI(Processor Aggregator Device)
[ 0.295543] ACPI: EC: Look up EC in DSDT
[ 0.297193] ACPI: Executed 1 blocks of module-level executable AML code
[ 0.357050] ACPI: SSDT 00000000af5f9018 0080E (v01 PmRef Cpu0Cst 00003001 INTL 20120215)
[ 0.357643] ACPI: Dynamic OEM Table Load:
[ 0.357820] ACPI: SSDT (null) 0080E (v01 PmRef Cpu0Cst 00003001 INTL 20120215)
[ 0.358342] ACPI: SSDT 00000000af5faa98 00303 (v01 PmRef ApIst 00003000 INTL 20120215)
[ 0.358977] ACPI: Dynamic OEM Table Load:
[ 0.359152] ACPI: SSDT (null) 00303 (v01 PmRef ApIst 00003000 INTL 20120215)
[ 0.359477] ACPI: SSDT 00000000af5f8d98 00119 (v01 PmRef ApCst 00003000 INTL 20120215)
[ 0.360052] ACPI: Dynamic OEM Table Load:
[ 0.360233] ACPI: SSDT (null) 00119 (v01 PmRef ApCst 00003000 INTL 20120215)
[ 0.361947] ACPI: Interpreter enabled
[ 0.362014] ACPI: (supports S0 S3 S4 S5)
[ 0.362320] ACPI: Using IOAPIC for interrupt routing
[ 0.367600] ACPI: Power Resource [FN00] (on)
[ 0.367954] initcall acpi_init+0x0/0x2b4 returned 0 after 35158 usecs
[ 0.367956] calling dock_init+0x0/0xa7 @ 1
[ 0.368389] ACPI: ACPI Dock Station Driver: 1 docks/bays found
[ 0.368456] initcall dock_init+0x0/0xa7 returned 0 after 0 usecs
[ 0.368458] calling acpi_pci_root_init+0x0/0x2b @ 1
[ 0.368462] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[ 0.368968] \_SB_.PCI0:_OSC invalid UUID
[ 0.368970] _OSC request data:1 8 1f
[ 0.368973] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-fe])
[ 0.369753] PCI host bridge to bus 0000:00
[ 0.369819] pci_bus 0000:00: busn_res: [bus 00-fe] is inserted under domain [bus 00-ff]
[ 0.369821] pci_bus 0000:00: root bus resource [bus 00-fe]
[ 0.369888] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7]
[ 0.369953] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff]
[ 0.370022] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff]
[ 0.370087] pci_bus 0000:00: root bus resource [mem 0xb0000000-0xfeafffff]
[ 0.370159] pci 0000:00:00.0: [8086:0154] type 00 class 0x060000
[ 0.370195] pci 0000:00:01.0: [8086:0151] type 01 class 0x060400
[ 0.370226] pci 0000:00:01.0: PME# supported from D0 D3hot D3cold
[ 0.370269] pci 0000:00:14.0: [8086:1e31] type 00 class 0x0c0330
[ 0.370291] pci 0000:00:14.0: reg 10: [mem 0xc1200000-0xc120ffff 64bit]
[ 0.370364] pci 0000:00:14.0: PME# supported from D3hot D3cold
[ 0.370389] pci 0000:00:16.0: [8086:1e3a] type 00 class 0x078000
[ 0.370411] pci 0000:00:16.0: reg 10: [mem 0xc1214000-0xc121400f 64bit]
[ 0.370489] pci 0000:00:16.0: PME# supported from D0 D3hot D3cold
[ 0.370524] pci 0000:00:1a.0: [8086:1e2d] type 00 class 0x0c0320
[ 0.370687] pci 0000:00:1a.0: reg 10: [mem 0xc1219000-0xc12193ff]
[ 0.372606] pci 0000:00:1a.0: PME# supported from D0 D3hot D3cold
[ 0.372636] pci 0000:00:1b.0: [8086:1e20] type 00 class 0x040300
[ 0.372650] pci 0000:00:1b.0: reg 10: [mem 0xc1210000-0xc1213fff 64bit]
[ 0.372721] pci 0000:00:1b.0: PME# supported from D0 D3hot D3cold
[ 0.372745] pci 0000:00:1c.0: [8086:1e10] type 01 class 0x060400
[ 0.372825] pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold
[ 0.372852] pci 0000:00:1c.1: [8086:1e12] type 01 class 0x060400
[ 0.372932] pci 0000:00:1c.1: PME# supported from D0 D3hot D3cold
[ 0.372968] pci 0000:00:1d.0: [8086:1e26] type 00 class 0x0c0320
[ 0.373129] pci 0000:00:1d.0: reg 10: [mem 0xc1218000-0xc12183ff]
[ 0.375056] pci 0000:00:1d.0: PME# supported from D0 D3hot D3cold
[ 0.375085] pci 0000:00:1f.0: [8086:1e59] type 00 class 0x060100
[ 0.375210] pci 0000:00:1f.2: [8086:1e03] type 00 class 0x010601
[ 0.375228] pci 0000:00:1f.2: reg 10: [io 0x4048-0x404f]
[ 0.375237] pci 0000:00:1f.2: reg 14: [io 0x4054-0x4057]
[ 0.375245] pci 0000:00:1f.2: reg 18: [io 0x4040-0x4047]
[ 0.375253] pci 0000:00:1f.2: reg 1c: [io 0x4050-0x4053]
[ 0.375261] pci 0000:00:1f.2: reg 20: [io 0x4020-0x403f]
[ 0.375269] pci 0000:00:1f.2: reg 24: [mem 0xc1217000-0xc12177ff]
[ 0.375316] pci 0000:00:1f.2: PME# supported from D3hot
[ 0.375336] pci 0000:00:1f.3: [8086:1e22] type 00 class 0x0c0500
[ 0.375351] pci 0000:00:1f.3: reg 10: [mem 0xc1215000-0xc12150ff 64bit]
[ 0.375373] pci 0000:00:1f.3: reg 20: [io 0x4000-0x401f]
[ 0.375420] pci_bus 0000:01: busn_res: [bus 01-06] is inserted under [bus 00-fe]
[ 0.375431] pci 0000:01:00.0: [1002:6840] type 00 class 0x030000
[ 0.375443] pci 0000:01:00.0: reg 10: [mem 0xb0000000-0xbfffffff 64bit pref]
[ 0.375452] pci 0000:01:00.0: reg 18: [mem 0xc0000000-0xc001ffff 64bit]
[ 0.375459] pci 0000:01:00.0: reg 20: [io 0x3000-0x30ff]
[ 0.375471] pci 0000:01:00.0: reg 30: [mem 0xfffe0000-0xffffffff pref]
[ 0.375500] pci 0000:01:00.0: supports D1 D2
[ 0.375519] pci 0000:01:00.1: [1002:aa90] type 00 class 0x040300
[ 0.375530] pci 0000:01:00.1: reg 10: [mem 0xc0020000-0xc0023fff 64bit]
[ 0.375582] pci 0000:01:00.1: supports D1 D2
[ 0.380220] pci 0000:00:01.0: PCI bridge to [bus 01-06]
[ 0.380298] pci 0000:00:01.0: bridge window [io 0x3000-0x3fff]
[ 0.380301] pci 0000:00:01.0: bridge window [mem 0xc0000000-0xc0ffffff]
[ 0.380304] pci 0000:00:01.0: bridge window [mem 0xb0000000-0xbfffffff 64bit pref]
[ 0.380351] pci_bus 0000:07: busn_res: [bus 07] is inserted under [bus 00-fe]
[ 0.380374] pci 0000:07:00.0: [1969:1091] type 00 class 0x020000
[ 0.380400] pci 0000:07:00.0: reg 10: [mem 0xc1100000-0xc113ffff 64bit]
[ 0.380415] pci 0000:07:00.0: reg 18: [io 0x2000-0x207f]
[ 0.380548] pci 0000:07:00.0: PME# supported from D0 D1 D2 D3hot D3cold
[ 0.388224] pci 0000:00:1c.0: PCI bridge to [bus 07]
[ 0.388302] pci 0000:00:1c.0: bridge window [io 0x2000-0x2fff]
[ 0.388306] pci 0000:00:1c.0: bridge window [mem 0xc1100000-0xc11fffff]
[ 0.388356] pci_bus 0000:08: busn_res: [bus 08] is inserted under [bus 00-fe]
[ 0.388382] pci 0000:08:00.0: [168c:0032] type 00 class 0x028000
[ 0.388407] pci 0000:08:00.0: reg 10: [mem 0xc1000000-0xc107ffff 64bit]
[ 0.388471] pci 0000:08:00.0: reg 30: [mem 0xffff0000-0xffffffff pref]
[ 0.388541] pci 0000:08:00.0: supports D1 D2
[ 0.388542] pci 0000:08:00.0: PME# supported from D0 D1 D2 D3hot D3cold
[ 0.396216] pci 0000:00:1c.1: PCI bridge to [bus 08]
[ 0.396296] pci 0000:00:1c.1: bridge window [mem 0xc1000000-0xc10fffff]
[ 0.396317] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
[ 0.396491] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP01._PRT]
[ 0.396529] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.RP02._PRT]
[ 0.396583] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PEG0._PRT]
[ 0.396690] \_SB_.PCI0:_OSC invalid UUID
[ 0.396691] _OSC request data:1 1f 1f
[ 0.396695] pci0000:00: Requesting ACPI _OSC control (0x1d)
[ 0.396816] \_SB_.PCI0:_OSC invalid UUID
[ 0.396817] _OSC request data:1 0 1d
[ 0.396820] pci0000:00: ACPI _OSC request failed (AE_ERROR), returned control mask: 0x1d
[ 0.396893] ACPI _OSC control for PCIe not granted, disabling ASPM
[ 0.400894] initcall acpi_pci_root_init+0x0/0x2b returned 0 after 31251 usecs
[ 0.400897] calling acpi_pci_link_init+0x0/0x3b @ 1
[ 0.400948] ACPI: PCI Interrupt Link [LNKA] (IRQs 1 3 4 5 6 10 11 12 14 15) *7
[ 0.401797] ACPI: PCI Interrupt Link [LNKB] (IRQs 1 3 4 5 6 *10 11 12 14 15)
[ 0.402587] ACPI: PCI Interrupt Link [LNKC] (IRQs 1 3 4 5 6 10 11 12 14 15) *0, disabled.
[ 0.403496] ACPI: PCI Interrupt Link [LNKD] (IRQs 1 3 4 5 6 *10 11 12 14 15)
[ 0.404286] ACPI: PCI Interrupt Link [LNKE] (IRQs 1 3 4 5 6 10 11 12 14 15) *0, disabled.
[ 0.405193] ACPI: PCI Interrupt Link [LNKF] (IRQs 1 3 4 5 6 10 11 12 14 15) *7
[ 0.406040] ACPI: PCI Interrupt Link [LNKG] (IRQs 1 3 4 5 6 10 *11 12 14 15)
[ 0.406824] ACPI: PCI Interrupt Link [LNKH] (IRQs 1 3 4 5 6 10 *11 12 14 15)
[ 0.407583] initcall acpi_pci_link_init+0x0/0x3b returned 0 after 3906 usecs
[ 0.407585] calling pnp_init+0x0/0x13 @ 1
[ 0.407594] initcall pnp_init+0x0/0x13 returned 0 after 0 usecs
[ 0.407596] calling misc_init+0x0/0xad @ 1
[ 0.407604] initcall misc_init+0x0/0xad returned 0 after 3906 usecs
[ 0.407606] calling vga_arb_device_init+0x0/0xe2 @ 1
[ 0.407640] vgaarb: device added: PCI:0000:01:00.0,decodes=io+mem,owns=io+mem,locks=none
[ 0.407713] vgaarb: loaded
[ 0.407777] vgaarb: bridge control possible 0000:01:00.0
[ 0.407844] initcall vga_arb_device_init+0x0/0xe2 returned 0 after 0 usecs
[ 0.407846] calling serio_init+0x0/0x2e @ 1
[ 0.407854] initcall serio_init+0x0/0x2e returned 0 after 0 usecs
[ 0.407856] calling input_init+0x0/0x10a @ 1
[ 0.407864] initcall input_init+0x0/0x10a returned 0 after 0 usecs
[ 0.407866] calling rtc_init+0x0/0x69 @ 1
[ 0.407871] initcall rtc_init+0x0/0x69 returned 0 after 0 usecs
[ 0.407874] calling power_supply_class_init+0x0/0x3d @ 1
[ 0.407879] initcall power_supply_class_init+0x0/0x3d returned 0 after 0 usecs
[ 0.407881] calling hwmon_init+0x0/0xf2 @ 1
[ 0.407887] initcall hwmon_init+0x0/0xf2 returned 0 after 0 usecs
[ 0.407889] calling watchdog_init+0x0/0x64 @ 1
[ 0.407897] initcall watchdog_init+0x0/0x64 returned 0 after 0 usecs
[ 0.407899] calling leds_init+0x0/0x41 @ 1
[ 0.407904] initcall leds_init+0x0/0x41 returned 0 after 0 usecs
[ 0.407906] calling iommu_init+0x0/0x55 @ 1
[ 0.407910] initcall iommu_init+0x0/0x55 returned 0 after 0 usecs
[ 0.407912] calling pci_subsys_init+0x0/0x43 @ 1
[ 0.407913] PCI: Using ACPI for IRQ routing
[ 0.414441] PCI: pci_cache_line_size set to 64 bytes
[ 0.414509] e820: reserve RAM buffer [mem 0x0009d800-0x0009ffff]
[ 0.414511] e820: reserve RAM buffer [mem 0xaa1ee000-0xabffffff]
[ 0.414512] e820: reserve RAM buffer [mem 0xaa99a000-0xabffffff]
[ 0.414514] e820: reserve RAM buffer [mem 0xaf2bf000-0xafffffff]
[ 0.414516] e820: reserve RAM buffer [mem 0xaf800000-0xafffffff]
[ 0.414517] e820: reserve RAM buffer [mem 0x1cf000000-0x1cfffffff]
[ 0.414520] initcall pci_subsys_init+0x0/0x43 returned 0 after 3906 usecs
[ 0.414521] calling proto_init+0x0/0xc @ 1
[ 0.414524] initcall proto_init+0x0/0xc returned 0 after 0 usecs
[ 0.414526] calling net_dev_init+0x0/0x1ae @ 1
[ 0.414596] initcall net_dev_init+0x0/0x1ae returned 0 after 0 usecs
[ 0.414598] calling neigh_init+0x0/0x7d @ 1
[ 0.414600] initcall neigh_init+0x0/0x7d returned 0 after 0 usecs
[ 0.414602] calling fib_rules_init+0x0/0xa5 @ 1
[ 0.414604] initcall fib_rules_init+0x0/0xa5 returned 0 after 0 usecs
[ 0.414606] calling pktsched_init+0x0/0xf4 @ 1
[ 0.414610] initcall pktsched_init+0x0/0xf4 returned 0 after 0 usecs
[ 0.414612] calling tc_filter_init+0x0/0x52 @ 1
[ 0.414614] initcall tc_filter_init+0x0/0x52 returned 0 after 0 usecs
[ 0.414615] calling tc_action_init+0x0/0x52 @ 1
[ 0.414617] initcall tc_action_init+0x0/0x52 returned 0 after 0 usecs
[ 0.414619] calling genl_init+0x0/0x8c @ 1
[ 0.414627] initcall genl_init+0x0/0x8c returned 0 after 0 usecs
[ 0.414630] calling wireless_nlevent_init+0x0/0xc @ 1
[ 0.414632] initcall wireless_nlevent_init+0x0/0xc returned 0 after 0 usecs
[ 0.414651] calling hpet_late_init+0x0/0xdc @ 1
[ 0.414660] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0, 0, 0, 0, 0, 0
[ 0.415234] hpet0: 8 comparators, 64-bit 14.318180 MHz counter
[ 0.418307] initcall hpet_late_init+0x0/0xdc returned 0 after 3906 usecs
[ 0.418309] calling init_amd_nbs+0x0/0x97 @ 1
[ 0.418317] initcall init_amd_nbs+0x0/0x97 returned 0 after 0 usecs
[ 0.418320] calling clocksource_done_booting+0x0/0x57 @ 1
[ 0.418322] Switching to clocksource hpet
[ 0.418399] initcall clocksource_done_booting+0x0/0x57 returned 0 after 3 usecs
[ 0.418402] calling tracer_init_debugfs+0x0/0x3d9 @ 1
[ 0.418491] initcall tracer_init_debugfs+0x0/0x3d9 returned 0 after 84 usecs
[ 0.418493] calling init_trace_printk_function_export+0x0/0x2c @ 1
[ 0.418499] initcall init_trace_printk_function_export+0x0/0x2c returned 0 after 2 usecs
[ 0.418500] calling event_trace_init+0x0/0x2bf @ 1
[ 0.419576] initcall event_trace_init+0x0/0x2bf returned 0 after 1047 usecs
[ 0.419578] calling init_pipe_fs+0x0/0x42 @ 1
[ 0.419592] initcall init_pipe_fs+0x0/0x42 returned 0 after 10 usecs
[ 0.419594] calling eventpoll_init+0x0/0xd7 @ 1
[ 0.419623] initcall eventpoll_init+0x0/0xd7 returned 0 after 25 usecs
[ 0.419625] calling anon_inode_init+0x0/0x52 @ 1
[ 0.419637] initcall anon_inode_init+0x0/0x52 returned 0 after 7 usecs
[ 0.419639] calling blk_scsi_ioctl_init+0x0/0x284 @ 1
[ 0.419644] initcall blk_scsi_ioctl_init+0x0/0x284 returned 0 after 1 usecs
[ 0.419646] calling acpi_event_init+0x0/0x52 @ 1
[ 0.419655] initcall acpi_event_init+0x0/0x52 returned 0 after 5 usecs
[ 0.419657] calling pnp_system_init+0x0/0xc @ 1
[ 0.419668] initcall pnp_system_init+0x0/0xc returned 0 after 7 usecs
[ 0.419670] calling pnpacpi_init+0x0/0x89 @ 1
[ 0.419672] pnp: PnP ACPI init
[ 0.419744] ACPI: bus type pnp registered
[ 0.420180] pnp 00:00: [bus 00-fe]
[ 0.420192] pnp 00:00: [io 0x0000-0x0cf7 window]
[ 0.420193] pnp 00:00: [io 0x0cf8-0x0cff]
[ 0.420195] pnp 00:00: [io 0x0d00-0xffff window]
[ 0.420197] pnp 00:00: [mem 0x000a0000-0x000bffff window]
[ 0.420199] pnp 00:00: [mem 0x000c0000-0x000c3fff window]
[ 0.420200] pnp 00:00: [mem 0x000c4000-0x000c7fff window]
[ 0.420202] pnp 00:00: [mem 0x000c8000-0x000cbfff window]
[ 0.420203] pnp 00:00: [mem 0x000cc000-0x000cffff window]
[ 0.420205] pnp 00:00: [mem 0x000d0000-0x000d3fff window]
[ 0.420207] pnp 00:00: [mem 0x000d4000-0x000d7fff window]
[ 0.420208] pnp 00:00: [mem 0x000d8000-0x000dbfff window]
[ 0.420210] pnp 00:00: [mem 0x000dc000-0x000dffff window]
[ 0.420212] pnp 00:00: [mem 0x000e0000-0x000e3fff window]
[ 0.420213] pnp 00:00: [mem 0x000e4000-0x000e7fff window]
[ 0.420215] pnp 00:00: [mem 0x000e8000-0x000ebfff window]
[ 0.420216] pnp 00:00: [mem 0x000ec000-0x000effff window]
[ 0.420218] pnp 00:00: [mem 0x000f0000-0x000fffff window]
[ 0.420220] pnp 00:00: [mem 0xb0000000-0xfeafffff window]
[ 0.420221] pnp 00:00: [mem 0x00010000-0x0001ffff window]
[ 0.420264] pnp 00:00: Plug and Play ACPI device, IDs PNP0a08 PNP0a03 (active)
[ 0.420280] pnp 00:01: [io 0x0000-0x001f]
[ 0.420282] pnp 00:01: [io 0x0081-0x0091]
[ 0.420283] pnp 00:01: [io 0x0093-0x009f]
[ 0.420284] pnp 00:01: [io 0x00c0-0x00df]
[ 0.420286] pnp 00:01: [dma 4]
[ 0.420305] pnp 00:01: Plug and Play ACPI device, IDs PNP0200 (active)
[ 0.420313] pnp 00:02: [mem 0xff000000-0xffffffff]
[ 0.420330] pnp 00:02: Plug and Play ACPI device, IDs INT0800 (active)
[ 0.420423] pnp 00:03: [mem 0xfed00000-0xfed003ff]
[ 0.420442] pnp 00:03: Plug and Play ACPI device, IDs PNP0103 (active)
[ 0.420452] pnp 00:04: [io 0x00f0]
[ 0.420456] pnp 00:04: [irq 13]
[ 0.420475] pnp 00:04: Plug and Play ACPI device, IDs PNP0c04 (active)
[ 0.420486] pnp 00:05: [io 0x002e-0x002f]
[ 0.420488] pnp 00:05: [io 0x004e-0x004f]
[ 0.420490] pnp 00:05: [io 0x0061]
[ 0.420491] pnp 00:05: [io 0x0063]
[ 0.420492] pnp 00:05: [io 0x0062]
[ 0.420494] pnp 00:05: [io 0x0065]
[ 0.420495] pnp 00:05: [io 0x0066]
[ 0.420497] pnp 00:05: [io 0x0067]
[ 0.420498] pnp 00:05: [io 0x0068]
[ 0.420499] pnp 00:05: [io 0x006c]
[ 0.420501] pnp 00:05: [io 0x0070]
[ 0.420502] pnp 00:05: [io 0x0080]
[ 0.420504] pnp 00:05: [io 0x0092]
[ 0.420505] pnp 00:05: [io 0x00b2-0x00b3]
[ 0.420507] pnp 00:05: [io 0x0680-0x069f]
[ 0.420508] pnp 00:05: [io 0x1000-0x100f]
[ 0.420510] pnp 00:05: [io 0xffff]
[ 0.420511] pnp 00:05: [io 0xffff]
[ 0.420513] pnp 00:05: [io 0x0400-0x0453]
[ 0.420514] pnp 00:05: [io 0x0458-0x047f]
[ 0.420515] pnp 00:05: [io 0x0500-0x057f]
[ 0.420518] pnp 00:05: [io 0x164e-0x164f]
[ 0.420554] system 00:05: [io 0x0680-0x069f] has been reserved
[ 0.420621] system 00:05: [io 0x1000-0x100f] has been reserved
[ 0.420696] system 00:05: [io 0xffff] has been reserved
[ 0.420762] system 00:05: [io 0xffff] has been reserved
[ 0.420827] system 00:05: [io 0x0400-0x0453] has been reserved
[ 0.420893] system 00:05: [io 0x0458-0x047f] has been reserved
[ 0.420961] system 00:05: [io 0x0500-0x057f] has been reserved
[ 0.421028] system 00:05: [io 0x164e-0x164f] has been reserved
[ 0.421096] system 00:05: Plug and Play ACPI device, IDs PNP0c02 (active)
[ 0.421105] pnp 00:06: [io 0x0070-0x0077]
[ 0.421107] pnp 00:06: [irq 8]
[ 0.421126] pnp 00:06: Plug and Play ACPI device, IDs PNP0b00 (active)
[ 0.421147] pnp 00:07: [io 0x0454-0x0457]
[ 0.421175] system 00:07: [io 0x0454-0x0457] has been reserved
[ 0.421241] system 00:07: Plug and Play ACPI device, IDs INT3f0d PNP0c02 (active)
[ 0.421249] pnp 00:08: [io 0x0060]
[ 0.421251] pnp 00:08: [io 0x0064]
[ 0.421253] pnp 00:08: [irq 1]
[ 0.421273] pnp 00:08: Plug and Play ACPI device, IDs PNP0303 (active)
[ 0.421282] pnp 00:09: [irq 12]
[ 0.421303] pnp 00:09: Plug and Play ACPI device, IDs TOS0310 SYN1900 SYN0002 PNP0f13 (active)
[ 0.421504] pnp 00:0a: [mem 0xfed1c000-0xfed1ffff]
[ 0.421506] pnp 00:0a: [mem 0xfed10000-0xfed17fff]
[ 0.421508] pnp 00:0a: [mem 0xfed18000-0xfed18fff]
[ 0.421509] pnp 00:0a: [mem 0xfed19000-0xfed19fff]
[ 0.421511] pnp 00:0a: [mem 0xe0000000-0xefffffff]
[ 0.421512] pnp 00:0a: [mem 0xfed20000-0xfed3ffff]
[ 0.421514] pnp 00:0a: [mem 0xfed90000-0xfed93fff]
[ 0.421515] pnp 00:0a: [mem 0xff000000-0xffffffff]
[ 0.421517] pnp 00:0a: [mem 0xfee00000-0xfeefffff]
[ 0.421518] pnp 00:0a: [mem 0xc1300000-0xc1300fff]
[ 0.421520] pnp 00:0a: [mem 0xff800000-0xff8001ff]
[ 0.421555] system 00:0a: [mem 0xfed1c000-0xfed1ffff] has been reserved
[ 0.421622] system 00:0a: [mem 0xfed10000-0xfed17fff] has been reserved
[ 0.421689] system 00:0a: [mem 0xfed18000-0xfed18fff] has been reserved
[ 0.421757] system 00:0a: [mem 0xfed19000-0xfed19fff] has been reserved
[ 0.421824] system 00:0a: [mem 0xe0000000-0xefffffff] has been reserved
[ 0.421899] system 00:0a: [mem 0xfed20000-0xfed3ffff] has been reserved
[ 0.421966] system 00:0a: [mem 0xfed90000-0xfed93fff] has been reserved
[ 0.422034] system 00:0a: [mem 0xff000000-0xffffffff] could not be reserved
[ 0.422100] system 00:0a: [mem 0xfee00000-0xfeefffff] could not be reserved
[ 0.422166] system 00:0a: [mem 0xc1300000-0xc1300fff] has been reserved
[ 0.422234] system 00:0a: [mem 0xff800000-0xff8001ff] has been reserved
[ 0.422302] system 00:0a: Plug and Play ACPI device, IDs PNP0c02 (active)
[ 0.422603] pnp 00:0b: [mem 0x20000000-0x201fffff]
[ 0.422604] pnp 00:0b: [mem 0x40004000-0x40004fff]
[ 0.422654] system 00:0b: [mem 0x20000000-0x201fffff] could not be reserved
[ 0.422721] system 00:0b: [mem 0x40004000-0x40004fff] could not be reserved
[ 0.422789] system 00:0b: Plug and Play ACPI device, IDs PNP0c01 (active)
[ 0.422847] pnp: PnP ACPI: found 12 devices
[ 0.422912] ACPI: ACPI bus type pnp unregistered
[ 0.422979] initcall pnpacpi_init+0x0/0x89 returned 0 after 3230 usecs
[ 0.422982] calling chr_dev_init+0x0/0xc2 @ 1
[ 0.424649] initcall chr_dev_init+0x0/0xc2 returned 0 after 1625 usecs
[ 0.424652] calling firmware_class_init+0x0/0x13 @ 1
[ 0.424661] initcall firmware_class_init+0x0/0x13 returned 0 after 4 usecs
[ 0.424664] calling cpufreq_gov_performance_init+0x0/0xc @ 1
[ 0.424668] initcall cpufreq_gov_performance_init+0x0/0xc returned 0 after 1 usecs
[ 0.424671] calling cpufreq_gov_dbs_init+0x0/0x54 @ 1
[ 0.424676] initcall cpufreq_gov_dbs_init+0x0/0x54 returned 0 after 1 usecs
[ 0.424678] calling init_acpi_pm_clocksource+0x0/0xe0 @ 1
[ 0.429168] initcall init_acpi_pm_clocksource+0x0/0xe0 returned 0 after 4382 usecs
[ 0.429170] calling pcibios_assign_resources+0x0/0xe7 @ 1
[ 0.429178] pci 0000:01:00.0: no compatible bridge window for [mem 0xfffe0000-0xffffffff pref]
[ 0.429254] pci 0000:08:00.0: no compatible bridge window for [mem 0xffff0000-0xffffffff pref]
[ 0.429352] pci 0000:00:1c.1: BAR 15: assigned [mem 0xc1400000-0xc14fffff pref]
[ 0.429426] pci 0000:01:00.0: BAR 6: assigned [mem 0xc0040000-0xc005ffff pref]
[ 0.429498] pci 0000:00:01.0: PCI bridge to [bus 01-06]
[ 0.429564] pci 0000:00:01.0: bridge window [io 0x3000-0x3fff]
[ 0.429632] pci 0000:00:01.0: bridge window [mem 0xc0000000-0xc0ffffff]
[ 0.429699] pci 0000:00:01.0: bridge window [mem 0xb0000000-0xbfffffff 64bit pref]
[ 0.429774] pci 0000:00:1c.0: PCI bridge to [bus 07]
[ 0.429840] pci 0000:00:1c.0: bridge window [io 0x2000-0x2fff]
[ 0.429909] pci 0000:00:1c.0: bridge window [mem 0xc1100000-0xc11fffff]
[ 0.429982] pci 0000:08:00.0: BAR 6: assigned [mem 0xc1400000-0xc140ffff pref]
[ 0.430054] pci 0000:00:1c.1: PCI bridge to [bus 08]
[ 0.430123] pci 0000:00:1c.1: bridge window [mem 0xc1000000-0xc10fffff]
[ 0.430192] pci 0000:00:1c.1: bridge window [mem 0xc1400000-0xc14fffff pref]
[ 0.430288] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7]
[ 0.430289] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff]
[ 0.430291] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff]
[ 0.430293] pci_bus 0000:00: resource 7 [mem 0xb0000000-0xfeafffff]
[ 0.430294] pci_bus 0000:01: resource 0 [io 0x3000-0x3fff]
[ 0.430296] pci_bus 0000:01: resource 1 [mem 0xc0000000-0xc0ffffff]
[ 0.430298] pci_bus 0000:01: resource 2 [mem 0xb0000000-0xbfffffff 64bit pref]
[ 0.430299] pci_bus 0000:07: resource 0 [io 0x2000-0x2fff]
[ 0.430301] pci_bus 0000:07: resource 1 [mem 0xc1100000-0xc11fffff]
[ 0.430303] pci_bus 0000:08: resource 1 [mem 0xc1000000-0xc10fffff]
[ 0.430304] pci_bus 0000:08: resource 2 [mem 0xc1400000-0xc14fffff pref]
[ 0.430308] initcall pcibios_assign_resources+0x0/0xe7 returned 0 after 1108 usecs
[ 0.430310] calling sysctl_core_init+0x0/0x28 @ 1
[ 0.430323] initcall sysctl_core_init+0x0/0x28 returned 0 after 9 usecs
[ 0.430325] calling inet_init+0x0/0x293 @ 1
[ 0.430408] NET: Registered protocol family 2
[ 0.431092] TCP established hash table entries: 524288 (order: 11, 8388608 bytes)
[ 0.432207] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes)
[ 0.432390] TCP: Hash tables configured (established 524288 bind 65536)
[ 0.432465] TCP: reno registered
[ 0.432541] UDP hash table entries: 4096 (order: 5, 131072 bytes)
[ 0.432631] UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes)
[ 0.432799] initcall inet_init+0x0/0x293 returned 0 after 2410 usecs
[ 0.432802] calling af_unix_init+0x0/0x4b @ 1
[ 0.432815] NET: Registered protocol family 1
[ 0.432887] initcall af_unix_init+0x0/0x4b returned 0 after 80 usecs
[ 0.432890] calling pci_apply_final_quirks+0x0/0xed @ 1
[ 0.462408] pci 0000:01:00.0: Boot video device
[ 0.462421] PCI: CLS 64 bytes, default 64
[ 0.462425] initcall pci_apply_final_quirks+0x0/0xed returned 0 after 28854 usecs
[ 0.462427] calling populate_rootfs+0x0/0x9c @ 1
[ 0.462464] Unpacking initramfs...
[ 0.554165] Freeing initrd memory: 4968k freed
[ 0.554721] initcall populate_rootfs+0x0/0x9c returned 0 after 90171 usecs
[ 0.554724] calling pci_iommu_init+0x0/0x37 @ 1
[ 0.554727] PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
[ 0.554793] software IO TLB [mem 0xab2b6000-0xaf2b5fff] (64MB) mapped at [ffff8800ab2b6000-ffff8800af2b5fff]
[ 0.554869] initcall pci_iommu_init+0x0/0x37 returned 0 after 138 usecs
[ 0.554872] calling ir_dev_scope_init+0x0/0x11 @ 1
[ 0.554875] initcall ir_dev_scope_init+0x0/0x11 returned 0 after 1 usecs
[ 0.554896] calling i8259A_init_ops+0x0/0x21 @ 1
[ 0.554900] initcall i8259A_init_ops+0x0/0x21 returned 0 after 1 usecs
[ 0.554901] calling vsyscall_init+0x0/0x24 @ 1
[ 0.554915] initcall vsyscall_init+0x0/0x24 returned 0 after 10 usecs
[ 0.554916] calling sbf_init+0x0/0xed @ 1
[ 0.554921] Simple Boot Flag at 0x44 set to 0x1
[ 0.554990] initcall sbf_init+0x0/0xed returned 0 after 69 usecs
[ 0.554992] calling init_tsc_clocksource+0x0/0x82 @ 1
[ 0.554998] initcall init_tsc_clocksource+0x0/0x82 returned 0 after 2 usecs
[ 0.555000] calling add_rtc_cmos+0x0/0x92 @ 1
[ 0.555007] initcall add_rtc_cmos+0x0/0x92 returned 0 after 4 usecs
[ 0.555009] calling i8237A_init_ops+0x0/0x11 @ 1
[ 0.555018] initcall i8237A_init_ops+0x0/0x11 returned 0 after 5 usecs
[ 0.555021] calling cache_sysfs_init+0x0/0x4d @ 1
[ 0.555225] initcall cache_sysfs_init+0x0/0x4d returned 0 after 194 usecs
[ 0.555227] calling intel_uncore_init+0x0/0x2fe @ 1
[ 0.555231] initcall intel_uncore_init+0x0/0x2fe returned 0 after 1 usecs
[ 0.555233] calling thermal_throttle_init_device+0x0/0x8a @ 1
[ 0.555237] initcall thermal_throttle_init_device+0x0/0x8a returned 0 after 1 usecs
[ 0.555239] calling amd_ibs_init+0x0/0x24e @ 1
[ 0.555244] initcall amd_ibs_init+0x0/0x24e returned -19 after 1 usecs
[ 0.555246] calling ioapic_init_ops+0x0/0x12 @ 1
[ 0.555249] initcall ioapic_init_ops+0x0/0x12 returned 0 after 1 usecs
[ 0.555250] calling add_pcspkr+0x0/0x63 @ 1
[ 0.555276] initcall add_pcspkr+0x0/0x63 returned 0 after 22 usecs
[ 0.555279] calling ia32_binfmt_init+0x0/0x11 @ 1
[ 0.555288] initcall ia32_binfmt_init+0x0/0x11 returned 0 after 5 usecs
[ 0.555289] calling init_aout_binfmt+0x0/0x13 @ 1
[ 0.555293] initcall init_aout_binfmt+0x0/0x13 returned 0 after 1 usecs
[ 0.555296] calling proc_execdomains_init+0x0/0x1f @ 1
[ 0.555303] initcall proc_execdomains_init+0x0/0x1f returned 0 after 3 usecs
[ 0.555305] calling ioresources_init+0x0/0x39 @ 1
[ 0.555311] initcall ioresources_init+0x0/0x39 returned 0 after 2 usecs
[ 0.555313] calling uid_cache_init+0x0/0x85 @ 1
[ 0.555330] initcall uid_cache_init+0x0/0x85 returned 0 after 13 usecs
[ 0.555333] calling init_posix_timers+0x0/0x1e0 @ 1
[ 0.555349] initcall init_posix_timers+0x0/0x1e0 returned 0 after 12 usecs
[ 0.555351] calling init_posix_cpu_timers+0x0/0xc1 @ 1
[ 0.555356] initcall init_posix_cpu_timers+0x0/0xc1 returned 0 after 1 usecs
[ 0.555358] calling init_sched_debug_procfs+0x0/0x29 @ 1
[ 0.555364] initcall init_sched_debug_procfs+0x0/0x29 returned 0 after 2 usecs
[ 0.555367] calling snapshot_device_init+0x0/0xc @ 1
[ 0.555419] initcall snapshot_device_init+0x0/0xc returned 0 after 45 usecs
[ 0.555423] calling create_proc_profile+0x0/0x23a @ 1
[ 0.555427] initcall create_proc_profile+0x0/0x23a returned 0 after 1 usecs
[ 0.555430] calling timekeeping_init_ops+0x0/0x11 @ 1
[ 0.555434] initcall timekeeping_init_ops+0x0/0x11 returned 0 after 1 usecs
[ 0.555436] calling init_clocksource_sysfs+0x0/0x52 @ 1
[ 0.555473] initcall init_clocksource_sysfs+0x0/0x52 returned 0 after 31 usecs
[ 0.555475] calling init_timer_list_procfs+0x0/0x2b @ 1
[ 0.555482] initcall init_timer_list_procfs+0x0/0x2b returned 0 after 3 usecs
[ 0.555485] calling alarmtimer_init+0x0/0x17c @ 1
[ 0.555510] initcall alarmtimer_init+0x0/0x17c returned 0 after 21 usecs
[ 0.555512] calling init_tstats_procfs+0x0/0x29 @ 1
[ 0.555519] initcall init_tstats_procfs+0x0/0x29 returned 0 after 2 usecs
[ 0.555521] calling futex_init+0x0/0x60 @ 1
[ 0.555529] initcall futex_init+0x0/0x60 returned 0 after 4 usecs
[ 0.555531] calling proc_dma_init+0x0/0x1f @ 1
[ 0.555537] initcall proc_dma_init+0x0/0x1f returned 0 after 2 usecs
[ 0.555540] calling proc_modules_init+0x0/0x21 @ 1
[ 0.555546] initcall proc_modules_init+0x0/0x21 returned 0 after 2 usecs
[ 0.555548] calling kallsyms_init+0x0/0x24 @ 1
[ 0.555554] initcall kallsyms_init+0x0/0x24 returned 0 after 2 usecs
[ 0.555556] calling pid_namespaces_init+0x0/0x2a @ 1
[ 0.555573] initcall pid_namespaces_init+0x0/0x2a returned 0 after 12 usecs
[ 0.555575] calling init_kprobes+0x0/0x16e @ 1
[ 0.570798] initcall init_kprobes+0x0/0x16e returned 0 after 14868 usecs
[ 0.570801] calling hung_task_init+0x0/0x4c @ 1
[ 0.570832] initcall hung_task_init+0x0/0x4c returned 0 after 25 usecs
[ 0.570834] calling irq_pm_init_ops+0x0/0x11 @ 1
[ 0.570837] initcall irq_pm_init_ops+0x0/0x11 returned 0 after 0 usecs
[ 0.570838] calling utsname_sysctl_init+0x0/0x11 @ 1
[ 0.570850] initcall utsname_sysctl_init+0x0/0x11 returned 0 after 8 usecs
[ 0.570853] calling init_tracepoints+0x0/0xc @ 1
[ 0.570858] initcall init_tracepoints+0x0/0xc returned 0 after 1 usecs
[ 0.570859] calling init_blk_tracer+0x0/0x55 @ 1
[ 0.570863] initcall init_blk_tracer+0x0/0x55 returned 0 after 1 usecs
[ 0.570865] calling perf_event_sysfs_init+0x0/0x93 @ 1
[ 0.570926] initcall perf_event_sysfs_init+0x0/0x93 returned 0 after 56 usecs
[ 0.570929] calling init_per_zone_wmark_min+0x0/0x7c @ 1
[ 0.571112] initcall init_per_zone_wmark_min+0x0/0x7c returned 0 after 176 usecs
[ 0.571114] calling kswapd_init+0x0/0x69 @ 1
[ 0.571147] initcall kswapd_init+0x0/0x69 returned 0 after 28 usecs
[ 0.571148] calling extfrag_debug_init+0x0/0x70 @ 1
[ 0.571158] initcall extfrag_debug_init+0x0/0x70 returned 0 after 5 usecs
[ 0.571160] calling setup_vmstat+0x0/0xa9 @ 1
[ 0.571178] initcall setup_vmstat+0x0/0xa9 returned 0 after 13 usecs
[ 0.571180] calling mm_sysfs_init+0x0/0x26 @ 1
[ 0.571187] initcall mm_sysfs_init+0x0/0x26 returned 0 after 2 usecs
[ 0.571189] calling proc_vmalloc_init+0x0/0x24 @ 1
[ 0.571195] initcall proc_vmalloc_init+0x0/0x24 returned 0 after 2 usecs
[ 0.571197] calling procswaps_init+0x0/0x20 @ 1
[ 0.571202] initcall procswaps_init+0x0/0x20 returned 0 after 2 usecs
[ 0.571204] calling init_frontswap+0x0/0x8e @ 1
[ 0.571215] initcall init_frontswap+0x0/0x8e returned 0 after 7 usecs
[ 0.571217] calling hugetlb_init+0x0/0x39b @ 1
[ 0.571220] HugeTLB registered 2 MB page size, pre-allocated 0 pages
[ 0.571300] initcall hugetlb_init+0x0/0x39b returned 0 after 77 usecs
[ 0.571302] calling ksm_init+0x0/0x15f @ 1
[ 0.571366] initcall ksm_init+0x0/0x15f returned 0 after 58 usecs
[ 0.571368] calling slab_proc_init+0x0/0x22 @ 1
[ 0.571374] initcall slab_proc_init+0x0/0x22 returned 0 after 2 usecs
[ 0.571376] calling cpucache_init+0x0/0x33 @ 1
[ 0.571381] initcall cpucache_init+0x0/0x33 returned 0 after 2 usecs
[ 0.571383] calling hugepage_init+0x0/0x159 @ 1
[ 0.571754] initcall hugepage_init+0x0/0x159 returned 0 after 358 usecs
[ 0.571756] calling fcntl_init+0x0/0x27 @ 1
[ 0.571772] initcall fcntl_init+0x0/0x27 returned 0 after 12 usecs
[ 0.571774] calling proc_filesystems_init+0x0/0x1f @ 1
[ 0.571780] initcall proc_filesystems_init+0x0/0x1f returned 0 after 2 usecs
[ 0.571782] calling dio_init+0x0/0x2a @ 1
[ 0.571797] initcall dio_init+0x0/0x2a returned 0 after 11 usecs
[ 0.571799] calling fsnotify_mark_init+0x0/0x3d @ 1
[ 0.571825] initcall fsnotify_mark_init+0x0/0x3d returned 0 after 22 usecs
[ 0.571827] calling dnotify_init+0x0/0x78 @ 1
[ 0.571854] initcall dnotify_init+0x0/0x78 returned 0 after 22 usecs
[ 0.571856] calling inotify_user_setup+0x0/0x6d @ 1
[ 0.571881] initcall inotify_user_setup+0x0/0x6d returned 0 after 21 usecs
[ 0.571883] calling fanotify_user_setup+0x0/0x4f @ 1
[ 0.571911] initcall fanotify_user_setup+0x0/0x4f returned 0 after 23 usecs
[ 0.571912] calling aio_setup+0x0/0x77 @ 1
[ 0.571941] initcall aio_setup+0x0/0x77 returned 0 after 24 usecs
[ 0.571943] calling proc_locks_init+0x0/0x21 @ 1
[ 0.571949] initcall proc_locks_init+0x0/0x21 returned 0 after 2 usecs
[ 0.571951] calling init_sys32_ioctl+0x0/0x25 @ 1
[ 0.572022] initcall init_sys32_ioctl+0x0/0x25 returned 0 after 65 usecs
[ 0.572024] calling dquot_init+0x0/0x10f @ 1
[ 0.572026] VFS: Disk quotas dquot_6.5.2
[ 0.572117] Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[ 0.572185] initcall dquot_init+0x0/0x10f returned 0 after 154 usecs
[ 0.572186] calling quota_init+0x0/0x23 @ 1
[ 0.572197] initcall quota_init+0x0/0x23 returned 0 after 7 usecs
[ 0.572199] calling proc_cmdline_init+0x0/0x1f @ 1
[ 0.572205] initcall proc_cmdline_init+0x0/0x1f returned 0 after 2 usecs
[ 0.572207] calling proc_consoles_init+0x0/0x1f @ 1
[ 0.572213] initcall proc_consoles_init+0x0/0x1f returned 0 after 2 usecs
[ 0.572215] calling proc_cpuinfo_init+0x0/0x1f @ 1
[ 0.572221] initcall proc_cpuinfo_init+0x0/0x1f returned 0 after 2 usecs
[ 0.572223] calling proc_devices_init+0x0/0x1f @ 1
[ 0.572229] initcall proc_devices_init+0x0/0x1f returned 0 after 2 usecs
[ 0.572231] calling proc_interrupts_init+0x0/0x1f @ 1
[ 0.572237] initcall proc_interrupts_init+0x0/0x1f returned 0 after 2 usecs
[ 0.572239] calling proc_loadavg_init+0x0/0x1f @ 1
[ 0.572245] initcall proc_loadavg_init+0x0/0x1f returned 0 after 2 usecs
[ 0.572247] calling proc_meminfo_init+0x0/0x1f @ 1
[ 0.572253] initcall proc_meminfo_init+0x0/0x1f returned 0 after 2 usecs
[ 0.572255] calling proc_stat_init+0x0/0x1f @ 1
[ 0.572260] initcall proc_stat_init+0x0/0x1f returned 0 after 2 usecs
[ 0.572262] calling proc_uptime_init+0x0/0x20 @ 1
[ 0.572268] initcall proc_uptime_init+0x0/0x20 returned 0 after 2 usecs
[ 0.572270] calling proc_version_init+0x0/0x1f @ 1
[ 0.572276] initcall proc_version_init+0x0/0x1f returned 0 after 2 usecs
[ 0.572278] calling proc_softirqs_init+0x0/0x1f @ 1
[ 0.572284] initcall proc_softirqs_init+0x0/0x1f returned 0 after 2 usecs
[ 0.572286] calling proc_kcore_init+0x0/0xb2 @ 1
[ 0.572297] initcall proc_kcore_init+0x0/0xb2 returned 0 after 7 usecs
[ 0.572299] calling proc_kmsg_init+0x0/0x24 @ 1
[ 0.572305] initcall proc_kmsg_init+0x0/0x24 returned 0 after 2 usecs
[ 0.572307] calling proc_page_init+0x0/0x3f @ 1
[ 0.572314] initcall proc_page_init+0x0/0x3f returned 0 after 3 usecs
[ 0.572316] calling init_devpts_fs+0x0/0x5d @ 1
[ 0.572339] initcall init_devpts_fs+0x0/0x5d returned 0 after 19 usecs
[ 0.572341] calling init_ramfs_fs+0x0/0xc @ 1
[ 0.572347] initcall init_ramfs_fs+0x0/0xc returned 0 after 2 usecs
[ 0.572349] calling init_hugetlbfs_fs+0x0/0x91 @ 1
[ 0.572378] initcall init_hugetlbfs_fs+0x0/0x91 returned 0 after 24 usecs
[ 0.572380] calling init_pstore_fs+0x0/0xc @ 1
[ 0.572386] initcall init_pstore_fs+0x0/0xc returned 0 after 2 usecs
[ 0.572388] calling ipc_init+0x0/0x2c @ 1
[ 0.572392] msgmni has been set to 11894
[ 0.572461] initcall ipc_init+0x0/0x2c returned 0 after 68 usecs
[ 0.572463] calling ipc_sysctl_init+0x0/0x11 @ 1
[ 0.572475] initcall ipc_sysctl_init+0x0/0x11 returned 0 after 8 usecs
[ 0.572477] calling init_mqueue_fs+0x0/0x99 @ 1
[ 0.572505] initcall init_mqueue_fs+0x0/0x99 returned 0 after 23 usecs
[ 0.572507] calling key_proc_init+0x0/0x32 @ 1
[ 0.572514] initcall key_proc_init+0x0/0x32 returned 0 after 2 usecs
[ 0.572516] calling crypto_wq_init+0x0/0x30 @ 1
[ 0.572545] initcall crypto_wq_init+0x0/0x30 returned 0 after 25 usecs
[ 0.572548] calling crypto_algapi_init+0x0/0xa @ 1
[ 0.572555] initcall crypto_algapi_init+0x0/0xa returned 0 after 4 usecs
[ 0.572558] calling skcipher_module_init+0x0/0x2d @ 1
[ 0.572562] initcall skcipher_module_init+0x0/0x2d returned 0 after 1 usecs
[ 0.572564] calling chainiv_module_init+0x0/0xc @ 1
[ 0.572569] initcall chainiv_module_init+0x0/0xc returned 0 after 1 usecs
[ 0.572571] calling eseqiv_module_init+0x0/0xc @ 1
[ 0.572575] initcall eseqiv_module_init+0x0/0xc returned 0 after 1 usecs
[ 0.572578] calling md5_mod_init+0x0/0xc @ 1
[ 0.572631] initcall md5_mod_init+0x0/0xc returned 0 after 48 usecs
[ 0.572633] calling krng_mod_init+0x0/0xc @ 1
[ 0.572662] alg: No test for stdrng (krng)
[ 0.572742] initcall krng_mod_init+0x0/0xc returned 0 after 102 usecs
[ 0.572744] calling proc_genhd_init+0x0/0x3b @ 1
[ 0.572750] initcall proc_genhd_init+0x0/0x3b returned 0 after 2 usecs
[ 0.572753] calling bsg_init+0x0/0x16c @ 1
[ 0.572771] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
[ 0.572853] initcall bsg_init+0x0/0x16c returned 0 after 94 usecs
[ 0.572855] calling noop_init+0x0/0xc @ 1
[ 0.572858] io scheduler noop registered
[ 0.572925] initcall noop_init+0x0/0xc returned 0 after 65 usecs
[ 0.572927] calling deadline_init+0x0/0xc @ 1
[ 0.572930] io scheduler deadline registered
[ 0.572997] initcall deadline_init+0x0/0xc returned 0 after 64 usecs
[ 0.572999] calling cfq_init+0x0/0xb8 @ 1
[ 0.573023] io scheduler cfq registered (default)
[ 0.573091] initcall cfq_init+0x0/0xb8 returned 0 after 86 usecs
[ 0.573092] calling percpu_counter_startup+0x0/0x16 @ 1
[ 0.573096] initcall percpu_counter_startup+0x0/0x16 returned 0 after 1 usecs
[ 0.573098] calling pci_proc_init+0x0/0x60 @ 1
[ 0.573129] initcall pci_proc_init+0x0/0x60 returned 0 after 27 usecs
[ 0.573131] calling pcie_portdrv_init+0x0/0x6c @ 1
[ 0.573175] pcieport 0000:00:01.0: irq 40 for MSI/MSI-X
[ 0.573299] initcall pcie_portdrv_init+0x0/0x6c returned 0 after 160 usecs
[ 0.573301] calling aer_service_init+0x0/0x27 @ 1
[ 0.573309] initcall aer_service_init+0x0/0x27 returned 0 after 5 usecs
[ 0.573311] calling pcie_pme_service_init+0x0/0xc @ 1
[ 0.573319] initcall pcie_pme_service_init+0x0/0xc returned 0 after 5 usecs
[ 0.573321] calling ioapic_init+0x0/0x15 @ 1
[ 0.573331] initcall ioapic_init+0x0/0x15 returned 0 after 7 usecs
[ 0.573333] calling pci_hotplug_init+0x0/0x1a @ 1
[ 0.573335] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
[ 0.573403] initcall pci_hotplug_init+0x0/0x1a returned 0 after 65 usecs
[ 0.573404] calling pcied_init+0x0/0xa3 @ 1
[ 0.573421] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
[ 0.573488] initcall pcied_init+0x0/0xa3 returned 0 after 79 usecs
[ 0.573490] calling acpiphp_init+0x0/0x49 @ 1
[ 0.573492] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
[ 0.573717] acpiphp_glue: can't evaluate _ADR (0x5)
[ 0.573963] initcall acpiphp_init+0x0/0x49 returned -19 after 459 usecs
[ 0.573965] calling fb_console_init+0x0/0x10b @ 1
[ 0.573985] initcall fb_console_init+0x0/0x10b returned 0 after 16 usecs
[ 0.573987] calling vesafb_init+0x0/0x25c @ 1
[ 0.574022] initcall vesafb_init+0x0/0x25c returned -19 after 31 usecs
[ 0.574023] calling efifb_init+0x0/0x27a @ 1
[ 0.574032] initcall efifb_init+0x0/0x27a returned -19 after 5 usecs
[ 0.574034] calling intel_idle_init+0x0/0x2c4 @ 1
[ 0.574036] intel_idle: MWAIT substates: 0x21120
[ 0.574038] intel_idle: v0.4 model 0x3A
[ 0.574039] intel_idle: lapic_timer_reliable_states 0xffffffff
[ 0.574056] initcall intel_idle_init+0x0/0x2c4 returned 0 after 18 usecs
[ 0.574057] calling acpi_reserve_resources+0x0/0xe8 @ 1
[ 0.574064] initcall acpi_reserve_resources+0x0/0xe8 returned 0 after 3 usecs
[ 0.574066] calling irqrouter_init_ops+0x0/0x28 @ 1
[ 0.574070] initcall irqrouter_init_ops+0x0/0x28 returned 0 after 1 usecs
[ 0.574072] calling acpi_hed_init+0x0/0x2d @ 1
[ 0.574091] initcall acpi_hed_init+0x0/0x2d returned 0 after 15 usecs
[ 0.574093] calling erst_init+0x0/0x28b @ 1
[ 0.574098] initcall erst_init+0x0/0x28b returned 0 after 1 usecs
[ 0.574099] calling ghes_init+0x0/0x145 @ 1
[ 0.574102] GHES: HEST is not enabled!
[ 0.574168] initcall ghes_init+0x0/0x145 returned -22 after 64 usecs
[ 0.574170] initcall ghes_init+0x0/0x145 returned with error code -22
[ 0.574236] calling pty_init+0x0/0x24b @ 1
[ 0.574274] initcall pty_init+0x0/0x24b returned 0 after 32 usecs
[ 0.574276] calling sysrq_init+0x0/0x41 @ 1
[ 0.574283] initcall sysrq_init+0x0/0x41 returned 0 after 3 usecs
[ 0.574285] calling serial8250_init+0x0/0x188 @ 1
[ 0.574287] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[ 0.574573] initcall serial8250_init+0x0/0x188 returned 0 after 277 usecs
[ 0.574575] calling serial8250_pnp_init+0x0/0xc @ 1
[ 0.574674] initcall serial8250_pnp_init+0x0/0xc returned 0 after 93 usecs
[ 0.574676] calling serial8250_pci_init+0x0/0x15 @ 1
[ 0.574708] initcall serial8250_pci_init+0x0/0x15 returned 0 after 27 usecs
[ 0.574711] calling rand_initialize+0x0/0x2b @ 1
[ 0.574745] initcall rand_initialize+0x0/0x2b returned 0 after 31 usecs
[ 0.574747] calling hpet_init+0x0/0x62 @ 1
[ 0.574899] initcall hpet_init+0x0/0x62 returned 0 after 143 usecs
[ 0.574901] calling agp_init+0x0/0x26 @ 1
[ 0.574903] Linux agpgart interface v0.103
[ 0.574970] initcall agp_init+0x0/0x26 returned 0 after 64 usecs
[ 0.574972] calling agp_amd64_mod_init+0x0/0x1b @ 1
[ 0.574992] initcall agp_amd64_mod_init+0x0/0x1b returned -19 after 15 usecs
[ 0.574994] calling agp_intel_init+0x0/0x24 @ 1
[ 0.575008] initcall agp_intel_init+0x0/0x24 returned 0 after 9 usecs
[ 0.575010] calling agp_sis_init+0x0/0x24 @ 1
[ 0.575023] initcall agp_sis_init+0x0/0x24 returned 0 after 9 usecs
[ 0.575025] calling agp_via_init+0x0/0x24 @ 1
[ 0.575037] initcall agp_via_init+0x0/0x24 returned 0 after 8 usecs
[ 0.575040] calling topology_sysfs_init+0x0/0x51 @ 1
[ 0.575073] initcall topology_sysfs_init+0x0/0x51 returned 0 after 29 usecs
[ 0.575075] calling net_olddevs_init+0x0/0x7b @ 1
[ 0.575083] initcall net_olddevs_init+0x0/0x7b returned 0 after 3 usecs
[ 0.575085] calling i8042_init+0x0/0x3c2 @ 1
[ 0.575123] i8042: PNP: PS/2 Controller [PNP0303:KBC,PNP0f13:MOUE] at 0x60,0x64 irq 1,12
[ 0.577306] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 0.577375] serio: i8042 AUX port at 0x60,0x64 irq 12
[ 0.577478] initcall i8042_init+0x0/0x3c2 returned 0 after 2334 usecs
[ 0.577480] calling mousedev_init+0x0/0x83 @ 1
[ 0.577528] mousedev: PS/2 mouse device common for all mice
[ 0.577596] initcall mousedev_init+0x0/0x83 returned 0 after 110 usecs
[ 0.577599] calling atkbd_init+0x0/0x23 @ 1
[ 0.577611] initcall atkbd_init+0x0/0x23 returned 0 after 8 usecs
[ 0.577613] calling cmos_init+0x0/0x6b @ 1
[ 0.577643] rtc_cmos 00:06: RTC can wake from S4
[ 0.577827] rtc_cmos 00:06: rtc core: registered rtc_cmos as rtc0
[ 0.577917] rtc0: alarms up to one month, 242 bytes nvram, hpet irqs
[ 0.577991] initcall cmos_init+0x0/0x6b returned 0 after 365 usecs
[ 0.577994] calling init_ladder+0x0/0xc @ 1
[ 0.578143] cpuidle: using governor ladder
[ 0.578209] initcall init_ladder+0x0/0xc returned 0 after 207 usecs
[ 0.578211] calling init_menu+0x0/0xc @ 1
[ 0.578410] cpuidle: using governor menu
[ 0.578477] initcall init_menu+0x0/0xc returned 0 after 255 usecs
[ 0.578479] calling staging_init+0x0/0x3 @ 1
[ 0.578483] initcall staging_init+0x0/0x3 returned 0 after 1 usecs
[ 0.578485] calling sock_diag_init+0x0/0xc @ 1
[ 0.578496] initcall sock_diag_init+0x0/0xc returned 0 after 6 usecs
[ 0.578498] calling flow_cache_init_global+0x0/0x173 @ 1
[ 0.578530] initcall flow_cache_init_global+0x0/0x173 returned 0 after 27 usecs
[ 0.578532] calling init_net_drop_monitor+0x0/0x101 @ 1
[ 0.578534] drop_monitor: Initializing network drop monitor service
[ 0.578613] initcall init_net_drop_monitor+0x0/0x101 returned 0 after 76 usecs
[ 0.578615] calling blackhole_module_init+0x0/0xc @ 1
[ 0.578619] initcall blackhole_module_init+0x0/0xc returned 0 after 1 usecs
[ 0.578621] calling init_cgroup_cls+0x0/0x3d @ 1
[ 0.578625] initcall init_cgroup_cls+0x0/0x3d returned 0 after 1 usecs
[ 0.578628] calling sysctl_ipv4_init+0x0/0x7f @ 1
[ 0.578678] initcall sysctl_ipv4_init+0x0/0x7f returned 0 after 45 usecs
[ 0.578680] calling init_syncookies+0x0/0x16 @ 1
[ 0.578700] initcall init_syncookies+0x0/0x16 returned 0 after 16 usecs
[ 0.578703] calling ipv4_netfilter_init+0x0/0xc @ 1
[ 0.578708] initcall ipv4_netfilter_init+0x0/0xc returned 0 after 1 usecs
[ 0.578710] calling cubictcp_register+0x0/0x64 @ 1
[ 0.578712] TCP: cubic registered
[ 0.578778] initcall cubictcp_register+0x0/0x64 returned 0 after 63 usecs
[ 0.578780] calling unix_diag_init+0x0/0xc @ 1
[ 0.578784] initcall unix_diag_init+0x0/0xc returned 0 after 1 usecs
[ 0.578786] calling inet6_init+0x0/0x2bb @ 1
[ 0.578919] NET: Registered protocol family 10
[ 0.579232] initcall inet6_init+0x0/0x2bb returned 0 after 431 usecs
[ 0.579234] calling mip6_init+0x0/0xbb @ 1
[ 0.579236] mip6: Mobile IPv6
[ 0.579304] initcall mip6_init+0x0/0xbb returned 0 after 64 usecs
[ 0.579306] calling packet_init+0x0/0x3d @ 1
[ 0.579308] NET: Registered protocol family 17
[ 0.579377] initcall packet_init+0x0/0x3d returned 0 after 66 usecs
[ 0.579379] calling init_dns_resolver+0x0/0xf6 @ 1
[ 0.579388] Key type dns_resolver registered
[ 0.579454] initcall init_dns_resolver+0x0/0xf6 returned 0 after 70 usecs
[ 0.579456] calling mcheck_init_device+0x0/0xe0 @ 1
[ 0.579710] initcall mcheck_init_device+0x0/0xe0 returned 0 after 242 usecs
[ 0.579732] calling tboot_late_init+0x0/0x207 @ 1
[ 0.579736] initcall tboot_late_init+0x0/0x207 returned 0 after 1 usecs
[ 0.579738] calling mcheck_debugfs_init+0x0/0x39 @ 1
[ 0.579749] initcall mcheck_debugfs_init+0x0/0x39 returned 0 after 6 usecs
[ 0.579751] calling severities_debugfs_init+0x0/0x3a @ 1
[ 0.579757] initcall severities_debugfs_init+0x0/0x3a returned 0 after 2 usecs
[ 0.579759] calling threshold_init_device+0x0/0x40 @ 1
[ 0.579764] initcall threshold_init_device+0x0/0x40 returned 0 after 1 usecs
[ 0.579766] calling hpet_insert_resource+0x0/0x1e @ 1
[ 0.579771] initcall hpet_insert_resource+0x0/0x1e returned 0 after 1 usecs
[ 0.579773] calling update_mp_table+0x0/0x446 @ 1
[ 0.579778] initcall update_mp_table+0x0/0x446 returned 0 after 1 usecs
[ 0.579780] calling lapic_insert_resource+0x0/0x40 @ 1
[ 0.579785] initcall lapic_insert_resource+0x0/0x40 returned 0 after 1 usecs
[ 0.579787] calling io_apic_bug_finalize+0x0/0x16 @ 1
[ 0.579790] initcall io_apic_bug_finalize+0x0/0x16 returned 0 after 1 usecs
[ 0.579791] calling print_ICs+0x0/0x56e @ 1
[ 0.579795] initcall print_ICs+0x0/0x56e returned 0 after 1 usecs
[ 0.579797] calling check_early_ioremap_leak+0x0/0x4d @ 1
[ 0.579801] initcall check_early_ioremap_leak+0x0/0x4d returned 0 after 1 usecs
[ 0.579803] calling pat_memtype_list_init+0x0/0x34 @ 1
[ 0.579809] initcall pat_memtype_list_init+0x0/0x34 returned 0 after 2 usecs
[ 0.579812] calling init_oops_id+0x0/0x31 @ 1
[ 0.579819] initcall init_oops_id+0x0/0x31 returned 0 after 3 usecs
[ 0.579821] calling printk_late_init+0x0/0x4f @ 1
[ 0.579826] initcall printk_late_init+0x0/0x4f returned 0 after 1 usecs
[ 0.579828] calling sched_init_debug+0x0/0x23 @ 1
[ 0.579834] initcall sched_init_debug+0x0/0x23 returned 0 after 2 usecs
[ 0.579836] calling pm_qos_power_init+0x0/0x5a @ 1
[ 0.580094] initcall pm_qos_power_init+0x0/0x5a returned 0 after 247 usecs
[ 0.580098] calling pm_debugfs_init+0x0/0x21 @ 1
[ 0.580106] initcall pm_debugfs_init+0x0/0x21 returned 0 after 4 usecs
[ 0.580109] calling software_resume+0x0/0x26b @ 1
[ 0.580112] PM: Hibernation image not present or could not be loaded.
[ 0.580115] initcall software_resume+0x0/0x26b returned -2 after 2 usecs
[ 0.580117] initcall software_resume+0x0/0x26b returned with error code -2
[ 0.580187] calling debugfs_kprobe_init+0x0/0x83 @ 1
[ 0.580197] initcall debugfs_kprobe_init+0x0/0x83 returned 0 after 6 usecs
[ 0.580199] calling taskstats_init+0x0/0x8f @ 1
[ 0.580206] registered taskstats version 1
[ 0.580271] initcall taskstats_init+0x0/0x8f returned 0 after 67 usecs
[ 0.580273] calling clear_boot_tracer+0x0/0x2d @ 1
[ 0.580276] initcall clear_boot_tracer+0x0/0x2d returned 0 after 1 usecs
[ 0.580278] calling max_swapfiles_check+0x0/0x3 @ 1
[ 0.580282] initcall max_swapfiles_check+0x0/0x3 returned 0 after 1 usecs
[ 0.580285] calling set_recommended_min_free_kbytes+0x0/0x78 @ 1
[ 0.580453] initcall set_recommended_min_free_kbytes+0x0/0x78 returned 0 after 160 usecs
[ 0.580456] calling random32_reseed+0x0/0x95 @ 1
[ 0.580480] initcall random32_reseed+0x0/0x95 returned 0 after 19 usecs
[ 0.580482] calling pci_resource_alignment_sysfs_init+0x0/0x17 @ 1
[ 0.580487] initcall pci_resource_alignment_sysfs_init+0x0/0x17 returned 0 after 2 usecs
[ 0.580489] calling pci_sysfs_init+0x0/0x4e @ 1
[ 0.580731] initcall pci_sysfs_init+0x0/0x4e returned 0 after 233 usecs
[ 0.580734] calling random_int_secret_init+0x0/0x16 @ 1
[ 0.580746] initcall random_int_secret_init+0x0/0x16 returned 0 after 8 usecs
[ 0.580749] calling deferred_probe_initcall+0x0/0x52 @ 1
[ 0.580870] initcall deferred_probe_initcall+0x0/0x52 returned 0 after 111 usecs
[ 0.580874] calling rtc_hctosys+0x0/0x109 @ 1
[ 0.580930] rtc_cmos 00:06: setting system clock to 2012-08-19 21:15:31 UTC (1345410931)
[ 0.581023] initcall rtc_hctosys+0x0/0x109 returned 0 after 142 usecs
[ 0.581026] calling memmap_init+0x0/0x2a @ 1
[ 0.581082] initcall memmap_init+0x0/0x2a returned 0 after 51 usecs
[ 0.581084] calling pci_mmcfg_late_insert_resources+0x0/0x46 @ 1
[ 0.581090] initcall pci_mmcfg_late_insert_resources+0x0/0x46 returned 0 after 2 usecs
[ 0.581092] calling net_secret_init+0x0/0x16 @ 1
[ 0.581104] initcall net_secret_init+0x0/0x16 returned 0 after 9 usecs
[ 0.581106] calling tcp_congestion_default+0x0/0xc @ 1
[ 0.581111] initcall tcp_congestion_default+0x0/0xc returned 0 after 1 usecs
[ 0.581113] calling tcp_fastopen_init+0x0/0x3 @ 1
[ 0.581117] initcall tcp_fastopen_init+0x0/0x3 returned 0 after 1 usecs
[ 0.581118] calling initialize_hashrnd+0x0/0x17 @ 1
[ 0.581125] initcall initialize_hashrnd+0x0/0x17 returned 0 after 2 usecs
[ 0.582166] Freeing unused kernel memory: 516k freed
[ 0.582282] Write protecting the kernel read-only data: 6144k
[ 0.588535] Freeing unused kernel memory: 988k freed
[ 0.590938] Freeing unused kernel memory: 780k freed
[ 0.596384] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
[ 0.646873] udevd[91]: starting version 175
[ 0.656507] calling usb_init+0x0/0x178 [usbcore] @ 117
[ 0.656518] ACPI: bus type usb registered
[ 0.656623] usbcore: registered new interface driver usbfs
[ 0.656711] usbcore: registered new interface driver hub
[ 0.657609] calling thermal_init+0x0/0x1000 [thermal_sys] @ 125
[ 0.657635] initcall thermal_init+0x0/0x1000 [thermal_sys] returned 0 after 18 usecs
[ 0.657829] calling acpi_fan_init+0x0/0x1000 [fan] @ 125
[ 0.657941] ACPI: Fan [FAN] (on)
[ 0.658376] calling acpi_thermal_init+0x0/0x1000 [thermal] @ 124
[ 0.659422] usbcore: registered new device driver usb
[ 0.659508] initcall usb_init+0x0/0x178 [usbcore] returned 0 after 2913 usecs
[ 0.659909] calling ehci_hcd_init+0x0/0x1000 [ehci_hcd] @ 117
[ 0.659912] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 0.660022] ehci_hcd 0000:00:1a.0: setting latency timer to 64
[ 0.660027] ehci_hcd 0000:00:1a.0: EHCI Host Controller
[ 0.660048] initcall acpi_fan_init+0x0/0x1000 [fan] returned 0 after 2160 usecs
[ 0.660104] ehci_hcd 0000:00:1a.0: new USB bus registered, assigned bus number 1
[ 0.660593] thermal LNXTHERM:00: registered as thermal_zone0
[ 0.660688] ACPI: Thermal Zone [THRM] (65 C)
[ 0.660806] initcall acpi_thermal_init+0x0/0x1000 [thermal] returned 0 after 2367 usecs
[ 0.661949] calling init_scsi+0x0/0x77 [scsi_mod] @ 142
[ 0.662068] SCSI subsystem initialized
[ 0.662174] initcall init_scsi+0x0/0x77 [scsi_mod] returned 0 after 205 usecs
[ 0.663427] calling ata_init+0x0/0x317 [libata] @ 142
[ 0.663432] ACPI: bus type scsi registered
[ 0.664089] ehci_hcd 0000:00:1a.0: debug port 2
[ 0.664170] ehci_hcd 0000:00:1a.0: cache line size of 64 is not supported
[ 0.664195] ehci_hcd 0000:00:1a.0: irq 16, io mem 0xc1219000
[ 0.665853] libata version 3.00 loaded.
[ 0.665873] initcall ata_init+0x0/0x317 [libata] returned 0 after 2370 usecs
[ 0.666753] calling ahci_pci_driver_init+0x0/0x1000 [ahci] @ 142
[ 0.672707] calling microcode_init+0x0/0x1cd [microcode] @ 203
[ 0.672746] microcode: CPU0 sig=0x306a9, pf=0x10, revision=0x12
[ 0.674306] ehci_hcd 0000:00:1a.0: USB 2.0 started, EHCI 1.00
[ 0.674462] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
[ 0.674545] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 0.674632] usb usb1: Product: EHCI Host Controller
[ 0.674712] usb usb1: Manufacturer: Linux 3.6.0-rc1+ ehci_hcd
[ 0.674803] usb usb1: SerialNumber: 0000:00:1a.0
[ 0.674927] calling xhci_hcd_init+0x0/0x22 [xhci_hcd] @ 128
[ 0.675155] hub 1-0:1.0: USB hub found
[ 0.675238] hub 1-0:1.0: 2 ports detected
[ 0.675433] ehci_hcd 0000:00:1d.0: setting latency timer to 64
[ 0.675438] ehci_hcd 0000:00:1d.0: EHCI Host Controller
[ 0.675514] ehci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2
[ 0.679488] ehci_hcd 0000:00:1d.0: debug port 2
[ 0.679573] ehci_hcd 0000:00:1d.0: cache line size of 64 is not supported
[ 0.679595] ehci_hcd 0000:00:1d.0: irq 23, io mem 0xc1218000
[ 0.683855] microcode: CPU1 sig=0x306a9, pf=0x10, revision=0x12
[ 0.685627] microcode: CPU2 sig=0x306a9, pf=0x10, revision=0x12
[ 0.687463] microcode: CPU3 sig=0x306a9, pf=0x10, revision=0x12
[ 0.689303] microcode: CPU4 sig=0x306a9, pf=0x10, revision=0x12
[ 0.690292] ehci_hcd 0000:00:1d.0: USB 2.0 started, EHCI 1.00
[ 0.690464] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002
[ 0.690568] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 0.690642] usb usb2: Product: EHCI Host Controller
[ 0.690707] usb usb2: Manufacturer: Linux 3.6.0-rc1+ ehci_hcd
[ 0.690773] usb usb2: SerialNumber: 0000:00:1d.0
[ 0.690972] hub 2-0:1.0: USB hub found
[ 0.691050] hub 2-0:1.0: 2 ports detected
[ 0.691191] initcall ehci_hcd_init+0x0/0x1000 [ehci_hcd] returned 0 after 30556 usecs
[ 0.691193] ahci 0000:00:1f.2: version 3.0
[ 0.691251] microcode: CPU5 sig=0x306a9, pf=0x10, revision=0x12
[ 0.691291] ahci 0000:00:1f.2: irq 41 for MSI/MSI-X
[ 0.691342] ahci: SSS flag set, parallel bus scan disabled
[ 0.691423] ahci 0000:00:1f.2: AHCI 0001.0300 32 slots 6 ports 6 Gbps 0x39 impl SATA mode
[ 0.691426] ahci 0000:00:1f.2: flags: 64bit ncq stag pm led clo pio slum part ems sxs apst
[ 0.691433] ahci 0000:00:1f.2: setting latency timer to 64
[ 0.693317] microcode: CPU6 sig=0x306a9, pf=0x10, revision=0x12
[ 0.695238] microcode: CPU7 sig=0x306a9, pf=0x10, revision=0x12
[ 0.697135] microcode: Microcode Update Driver: v2.00 <tigran@aivazian.fsnet.co.uk>, Peter Oruba
[ 0.697222] initcall microcode_init+0x0/0x1cd [microcode] returned 0 after 23944 usecs
[ 0.714833] scsi0 : ahci
[ 0.715178] scsi1 : ahci
[ 0.715335] scsi2 : ahci
[ 0.715478] scsi3 : ahci
[ 0.715621] scsi4 : ahci
[ 0.715759] scsi5 : ahci
[ 0.715867] ata1: SATA max UDMA/133 abar m2048@0xc1217000 port 0xc1217100 irq 41
[ 0.715946] ata2: DUMMY
[ 0.716009] ata3: DUMMY
[ 0.716072] ata4: SATA max UDMA/133 abar m2048@0xc1217000 port 0xc1217280 irq 41
[ 0.716146] ata5: SATA max UDMA/133 abar m2048@0xc1217000 port 0xc1217300 irq 41
[ 0.716218] ata6: SATA max UDMA/133 abar m2048@0xc1217000 port 0xc1217380 irq 41
[ 0.716321] initcall ahci_pci_driver_init+0x0/0x1000 [ahci] returned 0 after 48421 usecs
[ 0.716396] xhci_hcd 0000:00:14.0: setting latency timer to 64
[ 0.716402] xhci_hcd 0000:00:14.0: xHCI Host Controller
[ 0.716515] xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 3
[ 0.716726] xhci_hcd 0000:00:14.0: cache line size of 64 is not supported
[ 0.716743] xhci_hcd 0000:00:14.0: irq 21, io mem 0xc1200000
[ 0.716855] xhci_hcd 0000:00:14.0: irq 42 for MSI/MSI-X
[ 0.716906] usb usb3: New USB device found, idVendor=1d6b, idProduct=0002
[ 0.716973] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 0.717046] usb usb3: Product: xHCI Host Controller
[ 0.717111] usb usb3: Manufacturer: Linux 3.6.0-rc1+ xhci_hcd
[ 0.717176] usb usb3: SerialNumber: 0000:00:14.0
[ 0.717361] xHCI xhci_add_endpoint called for root hub
[ 0.717363] xHCI xhci_check_bandwidth called for root hub
[ 0.717390] hub 3-0:1.0: USB hub found
[ 0.717464] hub 3-0:1.0: 4 ports detected
[ 0.717587] xhci_hcd 0000:00:14.0: xHCI Host Controller
[ 0.717653] xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 4
[ 0.717745] usb usb4: New USB device found, idVendor=1d6b, idProduct=0003
[ 0.717811] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 0.717884] usb usb4: Product: xHCI Host Controller
[ 0.717950] usb usb4: Manufacturer: Linux 3.6.0-rc1+ xhci_hcd
[ 0.718015] usb usb4: SerialNumber: 0000:00:14.0
[ 0.718176] xHCI xhci_add_endpoint called for root hub
[ 0.718177] xHCI xhci_check_bandwidth called for root hub
[ 0.718198] hub 4-0:1.0: USB hub found
[ 0.718327] hub 4-0:1.0: 4 ports detected
[ 0.718562] initcall xhci_hcd_init+0x0/0x22 [xhci_hcd] returned 0 after 42624 usecs
[ 0.986170] usb 1-1: new high-speed USB device number 2 using ehci_hcd
[ 1.034154] ata1: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
[ 1.046172] ata1.00: ATA-8: OCZ-VERTEX3, 2.22, max UDMA/133
[ 1.046244] ata1.00: 468862128 sectors, multi 16: LBA48 NCQ (depth 31/32), AA
[ 1.056166] ata1.00: configured for UDMA/133
[ 1.056450] scsi 0:0:0:0: Direct-Access ATA OCZ-VERTEX3 2.22 PQ: 0 ANSI: 5
[ 1.118503] usb 1-1: New USB device found, idVendor=8087, idProduct=0024
[ 1.118575] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[ 1.119007] hub 1-1:1.0: USB hub found
[ 1.119207] hub 1-1:1.0: 6 ports detected
[ 1.230051] usb 2-1: new high-speed USB device number 2 using ehci_hcd
[ 1.362396] usb 2-1: New USB device found, idVendor=8087, idProduct=0024
[ 1.362469] usb 2-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[ 1.362882] hub 2-1:1.0: USB hub found
[ 1.363080] hub 2-1:1.0: 6 ports detected
[ 1.373979] ata4: SATA link down (SStatus 0 SControl 300)
[ 1.529897] usb 3-3: new low-speed USB device number 2 using xhci_hcd
[ 1.553161] usb 3-3: New USB device found, idVendor=046d, idProduct=c045
[ 1.553233] usb 3-3: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[ 1.553299] usb 3-3: Product: USB-PS/2 Optical Mouse
[ 1.553366] usb 3-3: Manufacturer: Logitech
[ 1.553740] usb 3-3: ep 0x81 - rounding interval to 64 microframes, ep desc says 80 microframes
[ 1.553837] tsc: Refined TSC clocksource calibration: 2294.786 MHz
[ 1.553840] Switching to clocksource tsc
[ 1.625987] usb 1-1.1: new high-speed USB device number 3 using ehci_hcd
[ 1.693808] ata5: SATA link down (SStatus 0 SControl 300)
[ 1.718689] usb 1-1.1: New USB device found, idVendor=0bda, idProduct=0129
[ 1.718760] usb 1-1.1: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[ 1.718833] usb 1-1.1: Product: USB2.0-CRW
[ 1.718898] usb 1-1.1: Manufacturer: Generic
[ 1.718962] usb 1-1.1: SerialNumber: 20100201396000000
[ 1.789904] usb 1-1.3: new high-speed USB device number 4 using ehci_hcd
[ 1.961187] usb 1-1.3: New USB device found, idVendor=10f1, idProduct=1a43
[ 1.961261] usb 1-1.3: New USB device strings: Mfr=2, Product=1, SerialNumber=0
[ 1.961334] usb 1-1.3: Product: TOSHIBA Web Camera - HD
[ 1.961400] usb 1-1.3: Manufacturer: Importek
[ 2.013647] ata6: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[ 2.015649] ata6.00: ATAPI: MATSHITADVD-RAM UJ8B0, 1.40, max UDMA/100
[ 2.017956] ata6.00: configured for UDMA/100
[ 2.020210] scsi 5:0:0:0: CD-ROM MATSHITA DVD-RAM UJ8B0 1.40 PQ: 0 ANSI: 5
[ 2.024051] calling cdrom_init+0x0/0x1000 [cdrom] @ 259
[ 2.024117] initcall cdrom_init+0x0/0x1000 [cdrom] returned 0 after 5 usecs
[ 2.024211] calling init_sd+0x0/0x1000 [sd_mod] @ 260
[ 2.024338] calling hid_init+0x0/0x63 [hid] @ 262
[ 2.020526] ACPI: Invalid Power Resource to register!
[ 2.024389] sd 0:0:0:0: [sda] 468862128 512-byte logical blocks: (240 GB/223 GiB)
[ 2.024448] sd 0:0:0:0: [sda] Write Protect is off
[ 2.024450] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
[ 2.024467] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 2.024621] initcall init_sd+0x0/0x1000 [sd_mod] returned 0 after 337 usecs
[ 2.024640] initcall hid_init+0x0/0x63 [hid] returned 0 after 23 usecs
[ 2.024727] calling init_sr+0x0/0x1000 [sr_mod] @ 259
[ 2.026609] sr0: scsi3-mmc drive: 24x/24x writer dvd-ram cd/rw xa/form2 cdda tray
[ 2.026686] cdrom: Uniform CD-ROM driver Revision: 3.20
[ 2.026935] sr 5:0:0:0: Attached scsi CD-ROM sr0
[ 2.026993] initcall init_sr+0x0/0x1000 [sr_mod] returned 0 after 2205 usecs
[ 2.027041] sda: sda1 sda2 sda3
[ 2.027608] sd 0:0:0:0: [sda] Attached SCSI disk
[ 2.028149] calling hid_init+0x0/0x1000 [usbhid] @ 262
[ 2.029168] calling init_sg+0x0/0x1000 [sg] @ 265
[ 2.029235] sd 0:0:0:0: Attached scsi generic sg0 type 0
[ 2.029335] sr 5:0:0:0: Attached scsi generic sg1 type 5
[ 2.029405] initcall init_sg+0x0/0x1000 [sg] returned 0 after 226 usecs
[ 2.031030] usbcore: registered new interface driver usbhid
[ 2.031098] usbhid: USB HID core driver
[ 2.031166] initcall hid_init+0x0/0x1000 [usbhid] returned 0 after 2941 usecs
[ 2.070910] calling dm_init+0x0/0x43 [dm_mod] @ 289
[ 2.070975] device-mapper: uevent: version 1.0.3
[ 2.071104] device-mapper: ioctl: 4.23.0-ioctl (2012-07-25) initialised: dm-devel@redhat.com
[ 2.071182] initcall dm_init+0x0/0x43 [dm_mod] returned 0 after 257 usecs
[ 2.076316] PM: Starting manual resume from disk
[ 2.076388] PM: Hibernation image partition 8:2 present
[ 2.076389] PM: Looking for hibernation image.
[ 2.076499] PM: Image not found (code -22)
[ 2.076501] PM: Hibernation image not present or could not be loaded.
[ 2.078846] PM: Marking nosave pages: [mem 0x0009d000-0x000fffff]
[ 2.078850] PM: Marking nosave pages: [mem 0xaa1ee000-0xaa976fff]
[ 2.078878] PM: Marking nosave pages: [mem 0xaa99a000-0xaa99efff]
[ 2.078879] PM: Marking nosave pages: [mem 0xaf2bf000-0xaf7fefff]
[ 2.078899] PM: Marking nosave pages: [mem 0xaf800000-0xffffffff]
[ 2.080213] PM: Basic memory bitmaps created
[ 2.103664] PM: Basic memory bitmaps freed
[ 2.106138] calling init_mbcache+0x0/0x1000 [mbcache] @ 303
[ 2.106143] initcall init_mbcache+0x0/0x1000 [mbcache] returned 0 after 0 usecs
[ 2.106772] calling journal_init+0x0/0xf49 [jbd2] @ 303
[ 2.106873] initcall journal_init+0x0/0xf49 [jbd2] returned 0 after 92 usecs
[ 2.109143] calling ext4_init_fs+0x0/0x1f4 [ext4] @ 303
[ 2.109205] initcall ext4_init_fs+0x0/0x1f4 [ext4] returned 0 after 49 usecs
[ 2.139745] EXT4-fs (sda3): mounted filesystem with ordered data mode. Opts: (null)
[ 2.278890] udevd[434]: starting version 175
[ 2.322142] calling acpi_processor_init+0x0/0x1000 [processor] @ 485
[ 2.322250] ACPI: Requesting acpi_cpufreq
[ 2.322969] calling acpi_button_init+0x0/0x1000 [button] @ 497
[ 2.323066] input: Power Button as /devices/LNXSYSTM:00/device:00/PNP0C0C:00/input/input1
[ 2.323149] ACPI: Power Button [PWRB]
[ 2.323302] input: Lid Switch as /devices/LNXSYSTM:00/device:00/PNP0C0D:00/input/input2
[ 2.323663] ACPI: Lid Switch [LID0]
[ 2.324467] calling acpi_video_init+0x0/0xff3 [video] @ 503
[ 2.327381] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
[ 2.327464] ACPI: Power Button [PWRF]
[ 2.327557] initcall acpi_button_init+0x0/0x1000 [button] returned 0 after 4474 usecs
[ 2.328875] calling acpi_ac_init+0x0/0x1000 [ac] @ 528
[ 2.329256] calling acpi_battery_init+0x0/0xfea [battery] @ 545
[ 2.329264] initcall acpi_battery_init+0x0/0xfea [battery] returned 0 after 2 usecs
[ 2.329495] ACPI: AC Adapter [ADP0] (on-line)
[ 2.329606] initcall acpi_ac_init+0x0/0x1000 [ac] returned 0 after 707 usecs
[ 2.330242] acpi device:3a: registered as cooling_device9
[ 2.330713] calling toshiba_bt_rfkill_init+0x0/0x1000 [toshiba_bluetooth] @ 546
[ 2.331392] ACPI: Battery Slot [BAT0] (battery present)
[ 2.331855] toshiba_bluetooth: Detected Toshiba ACPI Bluetooth device - installing RFKill handler
[ 2.331904] ACPI: Video Device [VGA] (multi-head: yes rom: no post: no)
[ 2.332111] toshiba_bluetooth: Re-enabling Toshiba Bluetooth
[ 2.332257] input: Video Bus as /devices/LNXSYSTM:00/device:00/PNP0A08:00/device:37/LNXVIDEO:00/input/input4
[ 2.335032] initcall toshiba_bt_rfkill_init+0x0/0x1000 [toshiba_bluetooth] returned 0 after 4212 usecs
[ 2.335743] calling init_soundcore+0x0/0x1000 [soundcore] @ 555
[ 2.335758] initcall init_soundcore+0x0/0x1000 [soundcore] returned 0 after 9 usecs
[ 2.335963] calling mei_driver_init+0x0/0x1000 [mei] @ 554
[ 2.335990] mei 0000:00:16.0: setting latency timer to 64
[ 2.336052] mei 0000:00:16.0: irq 43 for MSI/MSI-X
[ 2.336703] calling i2c_init+0x0/0x1000 [i2c_core] @ 552
[ 2.336740] initcall i2c_init+0x0/0x1000 [i2c_core] returned 0 after 29 usecs
[ 2.337106] initcall acpi_video_init+0x0/0xff3 [video] returned 0 after 12342 usecs
[ 2.339151] calling alsa_sound_init+0x0/0x84 [snd] @ 562
[ 2.339179] initcall alsa_sound_init+0x0/0x84 [snd] returned 0 after 18 usecs
[ 2.339301] calling rfkill_init+0x0/0x8f [rfkill] @ 557
[ 2.339419] initcall mei_driver_init+0x0/0x1000 [mei] returned 0 after 3369 usecs
[ 2.339586] initcall rfkill_init+0x0/0x8f [rfkill] returned 0 after 271 usecs
[ 2.339751] initcall acpi_processor_init+0x0/0x1000 [processor] returned 0 after 17195 usecs
[ 2.339931] calling acpi_cpufreq_init+0x0/0x1000 [acpi_cpufreq] @ 513
[ 2.341541] calling drm_core_init+0x0/0x1000 [drm] @ 552
[ 2.341562] [drm] Initialized drm 1.1.0 20060810
[ 2.341655] initcall drm_core_init+0x0/0x1000 [drm] returned 0 after 98 usecs
[ 2.341683] initcall acpi_cpufreq_init+0x0/0x1000 [acpi_cpufreq] returned 0 after 1706 usecs
[ 2.341806] mei 0000:00:16.0: wd: failed to find the client
[ 2.342243] calling cfg80211_init+0x0/0xbe [cfg80211] @ 557
[ 2.342276] calling lpc_ich_init+0x0/0x1000 [lpc_ich] @ 559
[ 2.342304] cfg80211: Calling CRDA to update world regulatory domain
[ 2.342369] ACPI Warning: 0x0000000000000460-0x000000000000047f SystemIO conflicts with Region \PMIO 1 (20120711/utaddress-251)
[ 2.342547] ACPI: If an ACPI driver is available for this device, you should use it instead of the native driver
[ 2.342624] lpc_ich: Resource conflict(s) found affecting iTCO_wdt
[ 2.342692] ACPI Warning: 0x0000000000000428-0x000000000000042f SystemIO conflicts with Region \PMIO 1 (20120711/utaddress-251)
[ 2.342842] initcall cfg80211_init+0x0/0xbe [cfg80211] returned 0 after 575 usecs
[ 2.342866] ACPI: If an ACPI driver is available for this device, you should use it instead of the native driver
[ 2.342935] ACPI Warning: 0x0000000000000500-0x000000000000053f SystemIO conflicts with Region \GPIO 1 (20120711/utaddress-251)
[ 2.343114] ACPI: If an ACPI driver is available for this device, you should use it instead of the native driver
[ 2.343181] lpc_ich: Resource conflict(s) found affecting gpio_ich
[ 2.343261] calling i2c_i801_init+0x0/0x1000 [i2c_i801] @ 572
[ 2.343271] initcall lpc_ich_init+0x0/0x1000 [lpc_ich] returned 0 after 966 usecs
[ 2.343284] ACPI Warning: 0x0000000000004000-0x000000000000401f SystemIO conflicts with Region \_SB_.PCI0.SBUS.SMBI 1 (20120711/utaddress-251)
[ 2.343453] ACPI: If an ACPI driver is available for this device, you should use it instead of the native driver
[ 2.343535] initcall i2c_i801_init+0x0/0x1000 [i2c_i801] returned 0 after 263 usecs
[ 2.344272] calling ttm_init+0x0/0x1000 [ttm] @ 552
[ 2.344299] initcall ttm_init+0x0/0x1000 [ttm] returned 0 after 20 usecs
[ 2.344353] calling pcspkr_platform_driver_init+0x0/0x1000 [pcspkr] @ 566
[ 2.344481] calling serio_raw_drv_init+0x0/0x1000 [serio_raw] @ 567
[ 2.344484] input: PC Speaker as /devices/platform/pcspkr/input/input5
[ 2.344499] initcall serio_raw_drv_init+0x0/0x1000 [serio_raw] returned 0 after 12 usecs
[ 2.344561] calling alsa_timer_init+0x0/0x1000 [snd_timer] @ 573
[ 2.344605] initcall alsa_timer_init+0x0/0x1000 [snd_timer] returned 0 after 39 usecs
[ 2.345140] initcall pcspkr_platform_driver_init+0x0/0x1000 [pcspkr] returned 0 after 764 usecs
[ 2.345745] calling alsa_seq_device_init+0x0/0x1000 [snd_seq_device] @ 573
[ 2.345750] initcall alsa_seq_device_init+0x0/0x1000 [snd_seq_device] returned 0 after 1 usecs
[ 2.345790] calling evdev_init+0x0/0x1000 [evdev] @ 569
[ 2.346040] initcall evdev_init+0x0/0x1000 [evdev] returned 0 after 239 usecs
[ 2.346902] calling psmouse_init+0x0/0x81 [psmouse] @ 567
[ 2.347187] calling alsa_seq_init+0x0/0x4d [snd_seq] @ 573
[ 2.347247] initcall psmouse_init+0x0/0x81 [psmouse] returned 0 after 333 usecs
[ 2.347334] initcall alsa_seq_init+0x0/0x4d [snd_seq] returned 0 after 138 usecs
[ 2.348311] calling ieee80211_init+0x0/0x3e [mac80211] @ 557
[ 2.348448] initcall ieee80211_init+0x0/0x3e [mac80211] returned 0 after 121 usecs
[ 2.348454] calling cryptd_init+0x0/0x1000 [cryptd] @ 579
[ 2.348462] initcall cryptd_init+0x0/0x1000 [cryptd] returned 0 after 3 usecs
[ 2.348558] calling snd_mem_init+0x0/0x1000 [snd_page_alloc] @ 555
[ 2.348568] initcall snd_mem_init+0x0/0x1000 [snd_page_alloc] returned 0 after 5 usecs
[ 2.352651] calling ath9k_init+0x0/0x1000 [ath9k_hw] @ 557
[ 2.352659] initcall ath9k_init+0x0/0x1000 [ath9k_hw] returned 0 after 0 usecs
[ 2.353768] calling aes_init+0x0/0x1000 [aes_generic] @ 579
[ 2.353870] calling alsa_pcm_init+0x0/0x1000 [snd_pcm] @ 553
[ 2.353881] initcall alsa_pcm_init+0x0/0x1000 [snd_pcm] returned 0 after 3 usecs
[ 2.354575] calling ath9k_cmn_init+0x0/0x1000 [ath9k_common] @ 557
[ 2.354579] initcall ath9k_cmn_init+0x0/0x1000 [ath9k_common] returned 0 after 0 usecs
[ 2.354926] calling alsa_hwdep_init+0x0/0x1000 [snd_hwdep] @ 553
[ 2.354932] initcall alsa_hwdep_init+0x0/0x1000 [snd_hwdep] returned 0 after 2 usecs
[ 2.355300] calling radeon_init+0x0/0x1000 [radeon] @ 552
[ 2.355302] [drm] radeon kernel modesetting enabled.
[ 2.355477] initcall aes_init+0x0/0x1000 [aes_generic] returned 0 after 1664 usecs
[ 2.355532] [drm] initializing kernel modesetting (TURKS 0x1002:0x6840 0x1179:0xFB22).
[ 2.355626] [drm] register mmio base: 0xC0000000
[ 2.355693] [drm] register mmio size: 131072
[ 2.355822] ATOM BIOS: Toshiba/IEC
[ 2.355903] radeon 0000:01:00.0: VRAM: 2048M 0x0000000000000000 - 0x000000007FFFFFFF (2048M used)
[ 2.355975] radeon 0000:01:00.0: GTT: 512M 0x0000000080000000 - 0x000000009FFFFFFF
[ 2.356050] mtrr: type mismatch for b0000000,10000000 old: write-back new: write-combining
[ 2.356118] [drm] Detected VRAM RAM=2048M, BAR=256M
[ 2.356181] [drm] RAM width 128bits DDR
[ 2.356272] [TTM] Zone kernel: Available graphics memory: 3046160 kiB
[ 2.356330] [TTM] Zone dma32: Available graphics memory: 2097152 kiB
[ 2.356387] [TTM] Initializing pool allocator
[ 2.356445] [TTM] Initializing DMA pool allocator
[ 2.356525] [drm] radeon: 2048M of VRAM memory ready
[ 2.356590] [drm] radeon: 512M of GTT memory ready.
[ 2.356659] [drm] Supports vblank timestamp caching Rev 1 (10.10.2010).
[ 2.356721] [drm] Driver supports precise vblank timestamp query.
[ 2.356815] radeon 0000:01:00.0: irq 44 for MSI/MSI-X
[ 2.356822] radeon 0000:01:00.0: radeon: using MSI.
[ 2.356901] [drm] radeon: irq initialized.
[ 2.356961] [drm] GART: num cpu pages 131072, num gpu pages 131072
[ 2.357269] calling ath9k_init+0x0/0x1000 [ath9k] @ 557
[ 2.357305] [drm] probing gen 2 caps for device 8086:151 = 3/e
[ 2.357378] [drm] enabling PCIE gen 2 link speeds, disable with radeon.pcie_gen2=0
[ 2.357654] [drm] Loading TURKS Microcode
[ 2.358234] calling hid_init+0x0/0x1000 [hid_generic] @ 603
[ 2.358476] input: Logitech USB-PS/2 Optical Mouse as /devices/pci0000:00/0000:00:14.0/usb3/3-3/3-3:1.0/input/input6
[ 2.358637] hid-generic 0003:046D:C045.0001: input,hidraw0: USB HID v1.10 Mouse [Logitech USB-PS/2 Optical Mouse] on usb-0000:00:14.0-3/input0
[ 2.358720] initcall hid_init+0x0/0x1000 [hid_generic] returned 0 after 470 usecs
[ 2.358760] calling media_devnode_init+0x0/0x1000 [media] @ 599
[ 2.358762] Linux media interface: v0.10
[ 2.358841] initcall media_devnode_init+0x0/0x1000 [media] returned 0 after 74 usecs
[ 2.359122] calling azx_driver_init+0x0/0x1000 [snd_hda_intel] @ 553
[ 2.359203] snd_hda_intel 0000:00:1b.0: irq 45 for MSI/MSI-X
[ 2.359337] calling aes_init+0x0/0x1000 [aes_x86_64] @ 580
[ 2.360426] calling videodev_init+0x0/0x1000 [videodev] @ 599
[ 2.360429] Linux video capture interface: v2.00
[ 2.360600] initcall videodev_init+0x0/0x1000 [videodev] returned 0 after 163 usecs
[ 2.360931] initcall aes_init+0x0/0x1000 [aes_x86_64] returned 0 after 1552 usecs
[ 2.361566] calling aesni_init+0x0/0x5a [aesni_intel] @ 580
[ 2.363397] calling uvc_init+0x0/0x1000 [uvcvideo] @ 599
[ 2.363434] uvcvideo: Found UVC 1.00 device TOSHIBA Web Camera - HD (10f1:1a43)
[ 2.364531] rts5139: module is from the staging directory, the quality is unknown, you have been warned.
[ 2.364664] alg: No test for __gcm-aes-aesni (__driver-gcm-aes-aesni)
[ 2.364709] initcall aesni_init+0x0/0x5a [aesni_intel] returned 0 after 3064 usecs
[ 2.365123] ath: phy0: ASPM enabled: 0x42
[ 2.365180] ath: EEPROM regdomain: 0x6a
[ 2.365181] ath: EEPROM indicates we should expect a direct regpair map
[ 2.365183] ath: Country alpha2 being used: 00
[ 2.365184] ath: Regpair used: 0x6a
[ 2.365564] calling ghash_pclmulqdqni_mod_init+0x0/0x1000 [ghash_clmulni_intel] @ 580
[ 2.365704] calling rts51x_driver_init+0x0/0x1000 [rts5139] @ 615
[ 2.366660] calling arc4_init+0x0/0x1000 [arc4] @ 647
[ 2.366734] initcall arc4_init+0x0/0x1000 [arc4] returned 0 after 68 usecs
[ 2.366998] initcall ghash_pclmulqdqni_mod_init+0x0/0x1000 [ghash_clmulni_intel] returned 0 after 1395 usecs
[ 2.367273] calling crc32c_intel_mod_init+0x0/0x1000 [crc32c_intel] @ 580
[ 2.367308] initcall crc32c_intel_mod_init+0x0/0x1000 [crc32c_intel] returned 0 after 30 usecs
[ 2.367410] ieee80211 phy0: Selected rate control algorithm 'ath9k_rate_control'
[ 2.367558] Registered led device: ath9k-phy0
[ 2.367562] ieee80211 phy0: Atheros AR9485 Rev:1 mem=0xffffc90011700000, irq=17
[ 2.367638] initcall ath9k_init+0x0/0x1000 [ath9k] returned 0 after 10123 usecs
[ 2.368426] scsi6 : SCSI emulation for RTS5139 USB card reader
[ 2.368547] usbcore: registered new interface driver rts5139
[ 2.368581] scsi 6:0:0:0: Direct-Access Generic- xD/SD/M.S. 1.00 PQ: 0 ANSI: 0 CCS
[ 2.368660] initcall rts51x_driver_init+0x0/0x1000 [rts5139] returned 0 after 2882 usecs
[ 2.368996] sd 6:0:0:0: Attached scsi generic sg2 type 0
[ 2.370929] calling irqfd_module_init+0x0/0x1000 [kvm] @ 580
[ 2.370965] initcall irqfd_module_init+0x0/0x1000 [kvm] returned 0 after 21 usecs
[ 2.371923] sd 6:0:0:0: [sdb] Attached SCSI removable disk
[ 2.372115] calling vmx_init+0x0/0xac7 [kvm_intel] @ 577
[ 2.372231] initcall vmx_init+0x0/0xac7 [kvm_intel] returned 0 after 108 usecs
[ 2.372991] calling coretemp_init+0x0/0x1000 [coretemp] @ 577
[ 2.373093] initcall coretemp_init+0x0/0x1000 [coretemp] returned 0 after 94 usecs
[ 2.382389] input: TOSHIBA Web Camera - HD as /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.3/1-1.3:1.0/input/input7
[ 2.382508] usbcore: registered new interface driver uvcvideo
[ 2.382573] USB Video Class driver (1.1.1)
[ 2.382643] initcall uvc_init+0x0/0x1000 [uvcvideo] returned 0 after 18796 usecs
[ 2.398926] calling patch_realtek_init+0x0/0x1000 [snd_hda_codec_realtek] @ 709
[ 2.398930] initcall patch_realtek_init+0x0/0x1000 [snd_hda_codec_realtek] returned 0 after 0 usecs
[ 2.400871] input: HDA Digital PCBeep as /devices/pci0000:00/0000:00:1b.0/input/input8
[ 2.403001] input: HDA Intel PCH Mic as /devices/pci0000:00/0000:00:1b.0/sound/card0/input9
[ 2.403131] input: HDA Intel PCH Headphone as /devices/pci0000:00/0000:00:1b.0/sound/card0/input10
[ 3.080182] psmouse serio1: synaptics: Touchpad model: 1, fw: 7.5, id: 0x1e0b1, caps: 0xd00073/0x240000/0xa0400, board id: 1680, fw id: 706145
[ 3.113867] input: SynPS/2 Synaptics TouchPad as /devices/platform/i8042/serio1/input/input11
[ 3.116563] calling joydev_init+0x0/0x1000 [joydev] @ 716
[ 3.116568] initcall joydev_init+0x0/0x1000 [joydev] returned 0 after 2 usecs
[ 4.242600] [drm] PCIE GART of 512M enabled (table at 0x0000000000040000).
[ 4.242888] radeon 0000:01:00.0: WB enabled
[ 4.242961] radeon 0000:01:00.0: fence driver on ring 0 use gpu addr 0x0000000080000c00 and cpu addr 0xffff8801c4deec00
[ 4.259522] [drm] ring test on 0 succeeded in 1 usecs
[ 4.259942] [drm] ib test on ring 0 succeeded in 0 usecs
[ 4.316442] [drm] radeon atom DIG backlight initialized
[ 4.316524] [drm] Radeon Display Connectors
[ 4.316594] [drm] Connector 0:
[ 4.316664] [drm] LVDS-1
[ 4.316733] [drm] DDC: 0x6560 0x6560 0x6564 0x6564 0x6568 0x6568 0x656c 0x656c
[ 4.316815] [drm] Encoders:
[ 4.316883] [drm] LCD1: INTERNAL_UNIPHY
[ 4.316952] [drm] Connector 1:
[ 4.317020] [drm] HDMI-A-1
[ 4.317087] [drm] HPD1
[ 4.317156] [drm] DDC: 0x6430 0x6430 0x6434 0x6434 0x6438 0x6438 0x643c 0x643c
[ 4.317238] [drm] Encoders:
[ 4.317305] [drm] DFP1: INTERNAL_UNIPHY1
[ 4.317375] [drm] Connector 2:
[ 4.317442] [drm] VGA-1
[ 4.317510] [drm] DDC: 0x64d8 0x64d8 0x64dc 0x64dc 0x64e0 0x64e0 0x64e4 0x64e4
[ 4.317593] [drm] Encoders:
[ 4.317662] [drm] CRT1: INTERNAL_KLDSCP_DAC1
[ 4.317809] [drm] Internal thermal controller with fan control
[ 4.317888] [drm:radeon_pm_print_states], 6 Power State(s)
[ 4.317892] [drm:radeon_pm_print_states], State 0: Default
[ 4.317895] [drm:radeon_pm_print_states], Default
[ 4.317897] [drm:radeon_pm_print_states], 16 PCIE Lanes
[ 4.317965] [drm:radeon_pm_print_states], 3 Clock Mode(s)
[ 4.317967] [drm:radeon_pm_print_states], 0 e: 600000 m: 900000 v: 1000 No display only
[ 4.317970] [drm:radeon_pm_print_states], 1 e: 600000 m: 900000 v: 1000
[ 4.317973] [drm:radeon_pm_print_states], 2 e: 600000 m: 900000 v: 1000
[ 4.317976] [drm:radeon_pm_print_states], State 1: Performance
[ 4.317979] [drm:radeon_pm_print_states], 16 PCIE Lanes
[ 4.317981] [drm:radeon_pm_print_states], 3 Clock Mode(s)
[ 4.317983] [drm:radeon_pm_print_states], 0 e: 300000 m: 150000 v: 900 No display only
[ 4.317986] [drm:radeon_pm_print_states], 1 e: 500000 m: 900000 v: 1000
[ 4.317989] [drm:radeon_pm_print_states], 2 e: 600000 m: 900000 v: 1000
[ 4.317992] [drm:radeon_pm_print_states], State 2: Default
[ 4.317994] [drm:radeon_pm_print_states], 16 PCIE Lanes
[ 4.317996] [drm:radeon_pm_print_states], 3 Clock Mode(s)
[ 4.317998] [drm:radeon_pm_print_states], 0 e: 500000 m: 900000 v: 1000 No display only
[ 4.318001] [drm:radeon_pm_print_states], 1 e: 500000 m: 900000 v: 1000
[ 4.318004] [drm:radeon_pm_print_states], 2 e: 600000 m: 900000 v: 1000
[ 4.318007] [drm:radeon_pm_print_states], State 3: Battery
[ 4.318009] [drm:radeon_pm_print_states], 1 PCIE Lanes
[ 4.318011] [drm:radeon_pm_print_states], 3 Clock Mode(s)
[ 4.318013] [drm:radeon_pm_print_states], 0 e: 300000 m: 150000 v: 900 No display only
[ 4.318016] [drm:radeon_pm_print_states], 1 e: 300000 m: 150000 v: 900
[ 4.318019] [drm:radeon_pm_print_states], 2 e: 400000 m: 400000 v: 900
[ 4.318022] [drm:radeon_pm_print_states], State 4: Battery
[ 4.318024] [drm:radeon_pm_print_states], 8 PCIE Lanes
[ 4.318026] [drm:radeon_pm_print_states], 3 Clock Mode(s)
[ 4.318029] [drm:radeon_pm_print_states], 0 e: 400000 m: 400000 v: 900 No display only
[ 4.318031] [drm:radeon_pm_print_states], 1 e: 400000 m: 400000 v: 900
[ 4.318034] [drm:radeon_pm_print_states], 2 e: 400000 m: 400000 v: 900
[ 4.318037] [drm:radeon_pm_print_states], State 5: Default
[ 4.318039] [drm:radeon_pm_print_states], 16 PCIE Lanes
[ 4.318042] [drm:radeon_pm_print_states], 3 Clock Mode(s)
[ 4.318044] [drm:radeon_pm_print_states], 0 e: 300000 m: 150000 v: 900 No display only
[ 4.318047] [drm:radeon_pm_print_states], 1 e: 300000 m: 150000 v: 900
[ 4.318049] [drm:radeon_pm_print_states], 2 e: 300000 m: 150000 v: 900
[ 4.319095] [drm] radeon: power management initialized
[ 4.700386] usb 1-1.2: new full-speed USB device number 5 using ehci_hcd
[ 4.738005] [drm] fb mappable at 0xB0142000
[ 4.738079] [drm] vram apper at 0xB0000000
[ 4.738147] [drm] size 4325376
[ 4.738213] [drm] fb depth is 24
[ 4.738278] [drm] pitch is 5632
[ 4.738511] fbcon: radeondrmfb (fb0) is primary device
[ 4.794487] usb 1-1.2: New USB device found, idVendor=0930, idProduct=0219
[ 4.794491] usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
[ 4.794493] usb 1-1.2: Product: Bluetooth USB Host Controller
[ 4.794496] usb 1-1.2: Manufacturer: Atheros Communications
[ 4.794497] usb 1-1.2: SerialNumber: Alaska Day 2006
[ 4.805421] calling bt_init+0x0/0x9b [bluetooth] @ 728
[ 4.805423] Bluetooth: Core ver 2.16
[ 4.805446] NET: Registered protocol family 31
[ 4.805447] Bluetooth: HCI device and connection manager initialized
[ 4.805449] Bluetooth: HCI socket layer initialized
[ 4.805450] Bluetooth: L2CAP socket layer initialized
[ 4.805458] Bluetooth: SCO socket layer initialized
[ 4.805469] initcall bt_init+0x0/0x9b [bluetooth] returned 0 after 35 usecs
[ 4.806735] calling btusb_driver_init+0x0/0x1000 [btusb] @ 728
[ 4.807189] usbcore: registered new interface driver btusb
[ 4.807198] initcall btusb_driver_init+0x0/0x1000 [btusb] returned 0 after 444 usecs
[ 4.807950] calling ath3k_driver_init+0x0/0x1000 [ath3k] @ 728
[ 4.807986] usbcore: registered new interface driver ath3k
[ 4.807992] initcall ath3k_driver_init+0x0/0x1000 [ath3k] returned 0 after 35 usecs
[ 5.444350] [drm:radeon_set_power_state], Setting: e: 60000
[ 5.444856] [drm:radeon_set_power_state], Setting: m: 90000
[ 5.522713] Console: switching to colour frame buffer device 170x48
[ 5.529916] fb0: radeondrmfb frame buffer device
[ 5.529917] drm: registered panic notifier
[ 5.529937] [drm:radeon_acpi_init], Call to ATCS verify_interface failed: -5
[ 5.530051] [drm:radeon_atif_verify_interface], ATIF version 1
[ 5.530118] [drm:radeon_atif_get_notification_params], SYSTEM_PARAMS: mask = 0x1, flags = 0x3
[ 5.530122] [drm:radeon_atif_get_notification_params], Notification enabled, command code = 0x81
[ 5.530130] [drm] Initialized radeon 2.20.0 20080528 for 0000:01:00.0 on minor 0
[ 5.530310] initcall radeon_init+0x0/0x1000 [radeon] returned 0 after 3102147 usecs
[ 5.530313] hda-intel: 0000:01:00.1: Handle VGA-switcheroo audio client
[ 5.530465] snd_hda_intel 0000:01:00.1: irq 46 for MSI/MSI-X
[ 5.548541] calling patch_hdmi_init+0x0/0x1000 [snd_hda_codec_hdmi] @ 738
[ 5.548552] initcall patch_hdmi_init+0x0/0x1000 [snd_hda_codec_hdmi] returned 0 after 0 usecs
[ 5.549383] input: HD-Audio Generic HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:01.0/0000:01:00.1/sound/card1/input12
[ 5.549990] initcall azx_driver_init+0x0/0x1000 [snd_hda_intel] returned 0 after 3117666 usecs
[ 5.813214] Adding 12583420k swap on /dev/sda2. Priority:-1 extents:1 across:12583420k SS
[ 5.837427] EXT4-fs (sda3): re-mounted. Opts: (null)
[ 5.878787] EXT4-fs (sda3): re-mounted. Opts: errors=remount-ro
[ 5.909976] calling fuse_init+0x0/0x140 [fuse] @ 1049
[ 5.909982] fuse init (API version 7.19)
[ 5.912216] initcall fuse_init+0x0/0x140 [fuse] returned 0 after 2171 usecs
[ 5.929991] calling loop_init+0x0/0x1000 [loop] @ 1106
[ 5.935050] loop: module loaded
[ 5.937785] initcall loop_init+0x0/0x1000 [loop] returned 0 after 7597 usecs
[ 6.804971] calling init_sunrpc+0x0/0x5f [sunrpc] @ 1954
[ 6.805246] RPC: Registered named UNIX socket transport module.
[ 6.807289] RPC: Registered udp transport module.
[ 6.809336] RPC: Registered tcp transport module.
[ 6.811371] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 6.813441] initcall init_sunrpc+0x0/0x5f [sunrpc] returned 0 after 8245 usecs
[ 6.817420] calling fscache_init+0x0/0x1ec [fscache] @ 1956
[ 6.817487] FS-Cache: Loaded
[ 6.819603] initcall fscache_init+0x0/0x1ec [fscache] returned 0 after 2116 usecs
[ 6.821057] calling init_nlm+0x0/0x1000 [lockd] @ 1956
[ 6.821079] initcall init_nlm+0x0/0x1000 [lockd] returned 0 after 11 usecs
[ 6.825850] calling init_nfs_fs+0x0/0x145 [nfs] @ 1956
[ 6.825862] FS-Cache: Netfs 'nfs' registered for caching
[ 6.828357] initcall init_nfs_fs+0x0/0x145 [nfs] returned 0 after 2423 usecs
[ 6.832345] calling init_rpcsec_gss+0x0/0x1000 [auth_rpcgss] @ 1958
[ 6.832389] initcall init_rpcsec_gss+0x0/0x1000 [auth_rpcgss] returned 0 after 32 usecs
[ 6.834355] calling init_nfsd+0x0/0x1000 [nfsd] @ 1958
[ 6.834357] Installing knfsd (copyright (C) 1996 okir@monad.swb.de).
[ 6.835362] initcall init_nfsd+0x0/0x1000 [nfsd] returned 0 after 976 usecs
[ 7.952142] calling uinput_init+0x0/0x1000 [uinput] @ 2475
[ 7.952240] initcall uinput_init+0x0/0x1000 [uinput] returned 0 after 84 usecs
[ 7.958002] calling init_misc_binfmt+0x0/0x1000 [binfmt_misc] @ 2491
[ 7.958019] initcall init_misc_binfmt+0x0/0x1000 [binfmt_misc] returned 0 after 6 usecs
[ 8.958640] input: ACPI Virtual Keyboard Device as /devices/virtual/input/input13
[ 9.161119] calling rfcomm_init+0x0/0xde [rfcomm] @ 2946
[ 9.161156] Bluetooth: RFCOMM TTY layer initialized
[ 9.162560] calling bnep_init+0x0/0x9b [bnep] @ 2951
[ 9.162562] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[ 9.162576] Bluetooth: RFCOMM socket layer initialized
[ 9.162577] Bluetooth: RFCOMM ver 1.11
[ 9.162581] initcall rfcomm_init+0x0/0xde [rfcomm] returned 0 after 1422 usecs
[ 9.165443] Bluetooth: BNEP filters: protocol multicast
[ 9.166430] initcall bnep_init+0x0/0x9b [bnep] returned 0 after 3777 usecs
[ 9.182163] calling cpufreq_gov_userspace_init+0x0/0x1000 [cpufreq_userspace] @ 3106
[ 9.182168] initcall cpufreq_gov_userspace_init+0x0/0x1000 [cpufreq_userspace] returned 0 after 0 usecs
[ 9.185185] calling cpufreq_gov_powersave_init+0x0/0x1000 [cpufreq_powersave] @ 3126
[ 9.185189] initcall cpufreq_gov_powersave_init+0x0/0x1000 [cpufreq_powersave] returned 0 after 0 usecs
[ 9.187677] calling cpufreq_gov_dbs_init+0x0/0x1000 [cpufreq_conservative] @ 3156
[ 9.187681] initcall cpufreq_gov_dbs_init+0x0/0x1000 [cpufreq_conservative] returned 0 after 0 usecs
[ 9.189305] calling cpufreq_stats_init+0x0/0x1000 [cpufreq_stats] @ 3173
[ 9.189358] initcall cpufreq_stats_init+0x0/0x1000 [cpufreq_stats] returned 0 after 46 usecs
[ 9.287952] calling xt_init+0x0/0x1000 [x_tables] @ 3516
[ 9.287957] initcall xt_init+0x0/0x1000 [x_tables] returned 0 after 1 usecs
[ 9.288627] calling ebtables_init+0x0/0x1000 [ebtables] @ 3516
[ 9.288629] Ebtables v2.0 registered
[ 9.289689] initcall ebtables_init+0x0/0x1000 [ebtables] returned 0 after 1033 usecs
[ 9.290548] calling ebtable_nat_init+0x0/0x1000 [ebtable_nat] @ 3518
[ 9.290555] initcall ebtable_nat_init+0x0/0x1000 [ebtable_nat] returned 0 after 3 usecs
[ 9.295894] calling ip_tables_init+0x0/0x1000 [ip_tables] @ 3521
[ 9.295902] ip_tables: (C) 2000-2006 Netfilter Core Team
[ 9.296948] initcall ip_tables_init+0x0/0x1000 [ip_tables] returned 0 after 1025 usecs
[ 9.298532] calling iptable_filter_init+0x0/0x1000 [iptable_filter] @ 3523
[ 9.298571] initcall iptable_filter_init+0x0/0x1000 [iptable_filter] returned 0 after 27 usecs
[ 9.304844] calling ip6_tables_init+0x0/0x1000 [ip6_tables] @ 3526
[ 9.304862] ip6_tables: (C) 2000-2006 Netfilter Core Team
[ 9.307016] initcall ip6_tables_init+0x0/0x1000 [ip6_tables] returned 0 after 2110 usecs
[ 9.308785] calling ip6table_filter_init+0x0/0x1000 [ip6table_filter] @ 3532
[ 9.308800] initcall ip6table_filter_init+0x0/0x1000 [ip6table_filter] returned 0 after 10 usecs
[ 10.327479] ------------[ cut here ]------------
[ 10.327548] WARNING: at block/blk-cgroup.h:251 blkg_put+0x27/0x41()
[ 10.327610] Hardware name: SATELLITE L855
[ 10.327651] Modules linked in: ip6table_filter ip6_tables iptable_filter ip_tables ebtable_nat ebtables x_tables cpufreq_stats cpufreq_conservative cpufreq_powersave cpufreq_userspace bnep rfcomm binfmt_misc uinput nfsd auth_rpcgss nfs_acl nfs lockd fscache sunrpc loop fuse snd_hda_codec_hdmi ath3k btusb bluetooth joydev snd_hda_codec_realtek coretemp kvm_intel kvm crc32c_intel arc4 rts5139(C) ghash_clmulni_intel uvcvideo videobuf2_vmalloc videobuf2_memops aesni_intel videobuf2_core videodev snd_hda_intel media aes_x86_64 hid_generic snd_hda_codec ath9k radeon snd_hwdep ath9k_common aes_generic snd_pcm ablk_helper ath9k_hw ath snd_page_alloc cryptd mac80211 snd_seq psmouse i2c_algo_bit evdev snd_seq_device snd_timer serio_raw pcspkr ttm i2c_i801 drm_kms_helper lpc_ich cfg80211 mfd_core drm acpi_cpufreq rfkill snd i2c_core mei soundcore mperf toshiba_bluetooth battery ac video button processor ext4 crc16 jbd2 mbcache dm_mod sg usbhid sr_mod hid sd_mod cdrom crc_t10dif xhci_hcd microcode ahci libahci libata scsi_mod ehci_hcd thermal fan thermal_sys usbcore usb_common
[ 10.329074] Pid: 0, comm: swapper/0 Tainted: G C 3.6.0-rc1+ #27
[ 10.329140] Call Trace:
[ 10.329166] <IRQ> [<ffffffff8102bdf3>] ? warn_slowpath_common+0x76/0x8a
[ 10.329253] [<ffffffff81153bbc>] ? blkg_put+0x27/0x41
[ 10.329311] [<ffffffff81156e29>] ? blk_end_bidi_request+0x36/0x52
[ 10.329395] [<ffffffffa00a25d9>] ? scsi_io_completion+0x1a8/0x46c [scsi_mod]
[ 10.329469] [<ffffffff8115b079>] ? blk_done_softirq+0x5d/0x6c
[ 10.329531] [<ffffffff8103252f>] ? __do_softirq+0xa8/0x1c9
[ 10.329591] [<ffffffff8107d4b1>] ? handle_irq_event_percpu+0x15e/0x1a2
[ 10.329660] [<ffffffff813049ac>] ? call_softirq+0x1c/0x30
[ 10.329718] [<ffffffff8100311d>] ? do_softirq+0x2c/0x5f
[ 10.329774] [<ffffffff81032801>] ? irq_exit+0x3a/0x91
[ 10.329828] [<ffffffff81002e97>] ? do_IRQ+0x81/0x97
[ 10.329883] [<ffffffff812fea67>] ? common_interrupt+0x67/0x67
[ 10.329940] <EOI> [<ffffffff81066594>] ? clockevents_program_event+0x9a/0xb6
[ 10.330027] [<ffffffff811ab490>] ? intel_idle+0xdf/0x104
[ 10.330083] [<ffffffff811ab46b>] ? intel_idle+0xba/0x104
[ 10.330141] [<ffffffff812259d7>] ? cpuidle_enter_state+0xa/0x31
[ 10.330203] [<ffffffff81225ac7>] ? cpuidle_idle_call+0xc9/0x180
[ 10.330267] [<ffffffff81008533>] ? cpu_idle+0x98/0xe2
[ 10.330322] [<ffffffff81694acb>] ? start_kernel+0x390/0x39b
[ 10.330382] [<ffffffff81694551>] ? repair_env_string+0x57/0x57
[ 10.330441] ---[ end trace fa19775fbcde9d77 ]---
[-- Attachment #3: Type: text/plain, Size: 159 bytes --]
_______________________________________________
dri-devel mailing list
dri-devel@lists.freedesktop.org
http://lists.freedesktop.org/mailman/listinfo/dri-devel
^ permalink raw reply [flat|nested] 8+ messages in thread
* Re: radeon testing
2012-08-20 12:30 ` Luca Tettamanti
@ 2012-08-20 14:24 ` Alex Deucher
2012-08-20 19:30 ` Luca Tettamanti
0 siblings, 1 reply; 8+ messages in thread
From: Alex Deucher @ 2012-08-20 14:24 UTC (permalink / raw)
To: Luca Tettamanti; +Cc: Maling list - DRI developers
On Mon, Aug 20, 2012 at 8:30 AM, Luca Tettamanti <kronos.it@gmail.com> wrote:
> On Thu, Aug 16, 2012 at 11:51:10AM -0400, Alex Deucher wrote:
>> I've gathered up the various outstanding radeon patches and put them
>> up in a tree for testing:
>> http://cgit.freedesktop.org/~agd5f/linux/log/?h=drm-next-3.7-wip
>> Some of these may end up in -fixes, but most of them are -next
>> material. I haven't had a chance to go through Christian's last set
>> of VM patches yet.
>>
>> Highlights:
>> - rom fetch fixes (UEFI, thunderbolt docks)
>> - major ACPI rework
>> - backlight control for newer asics
>
> Hi Alex,
> I just tested the rebased acpi_patches branch: ACPI part works fine, but
> I see a big slow down during radeon driver initialization when the
> screen goes black for a couple of seconds (with 3.5.0 + acpi patches the
> screen just flickers during boot). With initcall_debug I see:
>
> [ 2.355300] calling radeon_init+0x0/0x1000 [radeon] @ 552
> ...
> [ 5.530310] initcall radeon_init+0x0/0x1000 [radeon] returned 0 after 3102147 usecs
>
> For reference 3.5 takes ~1 sec. With drm.debug=2 the log (attached) is not very
> informative, I'll try and get more info...
Can you bisect?
Alex
^ permalink raw reply [flat|nested] 8+ messages in thread
* Re: radeon testing
2012-08-20 14:24 ` Alex Deucher
@ 2012-08-20 19:30 ` Luca Tettamanti
2012-08-21 13:51 ` Alex Deucher
0 siblings, 1 reply; 8+ messages in thread
From: Luca Tettamanti @ 2012-08-20 19:30 UTC (permalink / raw)
To: Alex Deucher; +Cc: Mailing list - DRI developers
On Mon, Aug 20, 2012 at 10:24:01AM -0400, Alex Deucher wrote:
> > I just tested the rebased acpi_patches branch: ACPI part works fine, but
> > I see a big slow down during radeon driver initialization when the
> > screen goes black for a couple of seconds (with 3.5.0 + acpi patches the
> > screen just flickers during boot). With initcall_debug I see:
> >
> > [ 2.355300] calling radeon_init+0x0/0x1000 [radeon] @ 552
> > ...
> > [ 5.530310] initcall radeon_init+0x0/0x1000 [radeon] returned 0 after 3102147 usecs
> >
> > For reference 3.5 takes ~1 sec. With drm.debug=2 the log (attached) is not very
> > informative, I'll try and get more info...
>
> Can you bisect?
I've put in some printk, this is the result:
[ 2.403138] evergreen_mc_program
[ 2.403196] evergreen_mc_stop
...
[ 4.268491] evergreen_mc_resume done
[ 4.268548] evergreen_mc_program done
This is the patch:
--- a/drivers/gpu/drm/radeon/evergreen.c
+++ b/drivers/gpu/drm/radeon/evergreen.c
@@ -1349,6 +1349,8 @@ void evergreen_mc_program(struct radeon_device *rdev)
u32 tmp;
int i, j;
+ printk(KERN_INFO "%s\n", __func__);
+
/* Initialize HDP */
for (i = 0, j = 0; i < 32; i++, j += 0x18) {
WREG32((0x2c14 + j), 0x00000000);
@@ -1359,10 +1361,14 @@ void evergreen_mc_program(struct radeon_device *rdev)
}
WREG32(HDP_REG_COHERENCY_FLUSH_CNTL, 0);
+ printk(KERN_INFO "evergreen_mc_stop\n");
evergreen_mc_stop(rdev, &save);
+// printk(KERN_INFO "evergreen_mc_wait_for_idle\n");
if (evergreen_mc_wait_for_idle(rdev)) {
dev_warn(rdev->dev, "Wait for MC idle timedout !\n");
}
+// printk(KERN_INFO "evergreen_mc_wait_for_idle done\n");
+
/* Lockout access through VGA aperture*/
WREG32(VGA_HDP_CONTROL, VGA_MEMORY_DISABLE);
/* Update configuration */
@@ -1411,10 +1417,13 @@ void evergreen_mc_program(struct radeon_device *rdev)
WREG32(MC_VM_AGP_TOP, 0x0FFFFFFF);
WREG32(MC_VM_AGP_BOT, 0x0FFFFFFF);
}
+// printk(KERN_INFO "evergreen_mc_wait_for_idle\n");
if (evergreen_mc_wait_for_idle(rdev)) {
dev_warn(rdev->dev, "Wait for MC idle timedout !\n");
}
+// printk(KERN_INFO "evergreen_mc_resume\n");
evergreen_mc_resume(rdev, &save);
+ printk(KERN_INFO "evergreen_mc_resume done\n");
/* we need to own VRAM, so turn off the VGA renderer here
* to stop it overwriting our objects */
rv515_vga_render_disable(rdev);
Any printk between evergreen_mc_stop and evergreen_mc_resume locks up
the machine. The likely culprit is commit 023e188e:
commit 023e188ec102330eb05ad264f675e869637478eb
Author: Alex Deucher <alexander.deucher@amd.com>
Date: Wed Aug 15 17:18:42 2012 -0400
drm/radeon: properly handle mc_stop/mc_resume on evergreen+
- Stop the displays from accessing the FB
- Block CPU access
- Turn off MC client access
This should fix issues some users have seen, especially
with UEFI, when changing the MC FB location that result
in hangs or display corruption.
<i don't know what i'm talking about>
I haven't tried backing out the commit yet, but looking at the diff I
see that you call radeon_wait_for_vblank and radeon_get_vblank_counter,
but evergreen_mc_program is called way before IRQ is set up. Is the
vblank counter running? Looks like we just hitting the timeout here...
</i don't know what i'm talking about>
Luca
^ permalink raw reply [flat|nested] 8+ messages in thread
* Re: radeon testing
2012-08-20 19:30 ` Luca Tettamanti
@ 2012-08-21 13:51 ` Alex Deucher
2012-08-21 14:17 ` Christian König
2012-08-21 20:33 ` Luca Tettamanti
0 siblings, 2 replies; 8+ messages in thread
From: Alex Deucher @ 2012-08-21 13:51 UTC (permalink / raw)
To: Luca Tettamanti; +Cc: Mailing list - DRI developers
On Mon, Aug 20, 2012 at 3:30 PM, Luca Tettamanti <kronos.it@gmail.com> wrote:
> On Mon, Aug 20, 2012 at 10:24:01AM -0400, Alex Deucher wrote:
>> > I just tested the rebased acpi_patches branch: ACPI part works fine, but
>> > I see a big slow down during radeon driver initialization when the
>> > screen goes black for a couple of seconds (with 3.5.0 + acpi patches the
>> > screen just flickers during boot). With initcall_debug I see:
>> >
>> > [ 2.355300] calling radeon_init+0x0/0x1000 [radeon] @ 552
>> > ...
>> > [ 5.530310] initcall radeon_init+0x0/0x1000 [radeon] returned 0 after 3102147 usecs
>> >
>> > For reference 3.5 takes ~1 sec. With drm.debug=2 the log (attached) is not very
>> > informative, I'll try and get more info...
>>
>> Can you bisect?
>
> I've put in some printk, this is the result:
>
> [ 2.403138] evergreen_mc_program
> [ 2.403196] evergreen_mc_stop
> ...
> [ 4.268491] evergreen_mc_resume done
> [ 4.268548] evergreen_mc_program done
>
> This is the patch:
>
> --- a/drivers/gpu/drm/radeon/evergreen.c
> +++ b/drivers/gpu/drm/radeon/evergreen.c
> @@ -1349,6 +1349,8 @@ void evergreen_mc_program(struct radeon_device *rdev)
> u32 tmp;
> int i, j;
>
> + printk(KERN_INFO "%s\n", __func__);
> +
> /* Initialize HDP */
> for (i = 0, j = 0; i < 32; i++, j += 0x18) {
> WREG32((0x2c14 + j), 0x00000000);
> @@ -1359,10 +1361,14 @@ void evergreen_mc_program(struct radeon_device *rdev)
> }
> WREG32(HDP_REG_COHERENCY_FLUSH_CNTL, 0);
>
> + printk(KERN_INFO "evergreen_mc_stop\n");
> evergreen_mc_stop(rdev, &save);
> +// printk(KERN_INFO "evergreen_mc_wait_for_idle\n");
> if (evergreen_mc_wait_for_idle(rdev)) {
> dev_warn(rdev->dev, "Wait for MC idle timedout !\n");
> }
> +// printk(KERN_INFO "evergreen_mc_wait_for_idle done\n");
> +
> /* Lockout access through VGA aperture*/
> WREG32(VGA_HDP_CONTROL, VGA_MEMORY_DISABLE);
> /* Update configuration */
> @@ -1411,10 +1417,13 @@ void evergreen_mc_program(struct radeon_device *rdev)
> WREG32(MC_VM_AGP_TOP, 0x0FFFFFFF);
> WREG32(MC_VM_AGP_BOT, 0x0FFFFFFF);
> }
> +// printk(KERN_INFO "evergreen_mc_wait_for_idle\n");
> if (evergreen_mc_wait_for_idle(rdev)) {
> dev_warn(rdev->dev, "Wait for MC idle timedout !\n");
> }
> +// printk(KERN_INFO "evergreen_mc_resume\n");
> evergreen_mc_resume(rdev, &save);
> + printk(KERN_INFO "evergreen_mc_resume done\n");
> /* we need to own VRAM, so turn off the VGA renderer here
> * to stop it overwriting our objects */
> rv515_vga_render_disable(rdev);
>
>
> Any printk between evergreen_mc_stop and evergreen_mc_resume locks up
> the machine. The likely culprit is commit 023e188e:
yeah, vram is locked out at that point. I guess we probably need to
block anyone from trying to access it.
>
> commit 023e188ec102330eb05ad264f675e869637478eb
> Author: Alex Deucher <alexander.deucher@amd.com>
> Date: Wed Aug 15 17:18:42 2012 -0400
>
> drm/radeon: properly handle mc_stop/mc_resume on evergreen+
>
> - Stop the displays from accessing the FB
> - Block CPU access
> - Turn off MC client access
>
> This should fix issues some users have seen, especially
> with UEFI, when changing the MC FB location that result
> in hangs or display corruption.
>
> <i don't know what i'm talking about>
>
> I haven't tried backing out the commit yet, but looking at the diff I
> see that you call radeon_wait_for_vblank and radeon_get_vblank_counter,
> but evergreen_mc_program is called way before IRQ is set up. Is the
> vblank counter running? Looks like we just hitting the timeout here...
>
We aren't waiting for an interrupt, just polling the current crtc
status until it enters the vblank region. The status and counters
should be working as we only wait on displays that are enabled. I'll
double check the code however. Thanks for testing.
Alex
> </i don't know what i'm talking about>
>
>
> Luca
^ permalink raw reply [flat|nested] 8+ messages in thread
* Re: radeon testing
2012-08-21 13:51 ` Alex Deucher
@ 2012-08-21 14:17 ` Christian König
2012-08-21 20:33 ` Luca Tettamanti
1 sibling, 0 replies; 8+ messages in thread
From: Christian König @ 2012-08-21 14:17 UTC (permalink / raw)
To: Alex Deucher; +Cc: Mailing list - DRI developers
On 21.08.2012 15:51, Alex Deucher wrote:
> On Mon, Aug 20, 2012 at 3:30 PM, Luca Tettamanti <kronos.it@gmail.com> wrote:
>> On Mon, Aug 20, 2012 at 10:24:01AM -0400, Alex Deucher wrote:
>>>> I just tested the rebased acpi_patches branch: ACPI part works fine, but
>>>> I see a big slow down during radeon driver initialization when the
>>>> screen goes black for a couple of seconds (with 3.5.0 + acpi patches the
>>>> screen just flickers during boot). With initcall_debug I see:
>>>>
>>>> [ 2.355300] calling radeon_init+0x0/0x1000 [radeon] @ 552
>>>> ...
>>>> [ 5.530310] initcall radeon_init+0x0/0x1000 [radeon] returned 0 after 3102147 usecs
>>>>
>>>> For reference 3.5 takes ~1 sec. With drm.debug=2 the log (attached) is not very
>>>> informative, I'll try and get more info...
>>> Can you bisect?
>> I've put in some printk, this is the result:
>>
>> [ 2.403138] evergreen_mc_program
>> [ 2.403196] evergreen_mc_stop
>> ...
>> [ 4.268491] evergreen_mc_resume done
>> [ 4.268548] evergreen_mc_program done
>>
>> This is the patch:
>>
>> --- a/drivers/gpu/drm/radeon/evergreen.c
>> +++ b/drivers/gpu/drm/radeon/evergreen.c
>> @@ -1349,6 +1349,8 @@ void evergreen_mc_program(struct radeon_device *rdev)
>> u32 tmp;
>> int i, j;
>>
>> + printk(KERN_INFO "%s\n", __func__);
>> +
>> /* Initialize HDP */
>> for (i = 0, j = 0; i < 32; i++, j += 0x18) {
>> WREG32((0x2c14 + j), 0x00000000);
>> @@ -1359,10 +1361,14 @@ void evergreen_mc_program(struct radeon_device *rdev)
>> }
>> WREG32(HDP_REG_COHERENCY_FLUSH_CNTL, 0);
>>
>> + printk(KERN_INFO "evergreen_mc_stop\n");
>> evergreen_mc_stop(rdev, &save);
>> +// printk(KERN_INFO "evergreen_mc_wait_for_idle\n");
>> if (evergreen_mc_wait_for_idle(rdev)) {
>> dev_warn(rdev->dev, "Wait for MC idle timedout !\n");
>> }
>> +// printk(KERN_INFO "evergreen_mc_wait_for_idle done\n");
>> +
>> /* Lockout access through VGA aperture*/
>> WREG32(VGA_HDP_CONTROL, VGA_MEMORY_DISABLE);
>> /* Update configuration */
>> @@ -1411,10 +1417,13 @@ void evergreen_mc_program(struct radeon_device *rdev)
>> WREG32(MC_VM_AGP_TOP, 0x0FFFFFFF);
>> WREG32(MC_VM_AGP_BOT, 0x0FFFFFFF);
>> }
>> +// printk(KERN_INFO "evergreen_mc_wait_for_idle\n");
>> if (evergreen_mc_wait_for_idle(rdev)) {
>> dev_warn(rdev->dev, "Wait for MC idle timedout !\n");
>> }
>> +// printk(KERN_INFO "evergreen_mc_resume\n");
>> evergreen_mc_resume(rdev, &save);
>> + printk(KERN_INFO "evergreen_mc_resume done\n");
>> /* we need to own VRAM, so turn off the VGA renderer here
>> * to stop it overwriting our objects */
>> rv515_vga_render_disable(rdev);
>>
>>
>> Any printk between evergreen_mc_stop and evergreen_mc_resume locks up
>> the machine. The likely culprit is commit 023e188e:
> yeah, vram is locked out at that point. I guess we probably need to
> block anyone from trying to access it.
IIRC we have a rw-semaphore that you can writelock to prevent anything
from accessing vram.
But if you try to access VRAM from within the critical section (by using
a printk that tries to write something to the console) you probably end
up deadlocking the kernel.
Christian.
>
>> commit 023e188ec102330eb05ad264f675e869637478eb
>> Author: Alex Deucher <alexander.deucher@amd.com>
>> Date: Wed Aug 15 17:18:42 2012 -0400
>>
>> drm/radeon: properly handle mc_stop/mc_resume on evergreen+
>>
>> - Stop the displays from accessing the FB
>> - Block CPU access
>> - Turn off MC client access
>>
>> This should fix issues some users have seen, especially
>> with UEFI, when changing the MC FB location that result
>> in hangs or display corruption.
>>
>> <i don't know what i'm talking about>
>>
>> I haven't tried backing out the commit yet, but looking at the diff I
>> see that you call radeon_wait_for_vblank and radeon_get_vblank_counter,
>> but evergreen_mc_program is called way before IRQ is set up. Is the
>> vblank counter running? Looks like we just hitting the timeout here...
>>
> We aren't waiting for an interrupt, just polling the current crtc
> status until it enters the vblank region. The status and counters
> should be working as we only wait on displays that are enabled. I'll
> double check the code however. Thanks for testing.
>
> Alex
>
>> </i don't know what i'm talking about>
>>
>>
>> Luca
> _______________________________________________
> dri-devel mailing list
> dri-devel@lists.freedesktop.org
> http://lists.freedesktop.org/mailman/listinfo/dri-devel
>
^ permalink raw reply [flat|nested] 8+ messages in thread
* Re: radeon testing
2012-08-21 13:51 ` Alex Deucher
2012-08-21 14:17 ` Christian König
@ 2012-08-21 20:33 ` Luca Tettamanti
2012-08-21 20:39 ` Alex Deucher
1 sibling, 1 reply; 8+ messages in thread
From: Luca Tettamanti @ 2012-08-21 20:33 UTC (permalink / raw)
To: Alex Deucher; +Cc: Mailing list - DRI developers
On Tue, Aug 21, 2012 at 09:51:46AM -0400, Alex Deucher wrote:
> On Mon, Aug 20, 2012 at 3:30 PM, Luca Tettamanti <kronos.it@gmail.com> wrote:
> > Any printk between evergreen_mc_stop and evergreen_mc_resume locks up
> > the machine. The likely culprit is commit 023e188e:
>
> yeah, vram is locked out at that point. I guess we probably need to
> block anyone from trying to access it.
I see; the 2 dev_warn would probably lock up the machine as well right?
> > I haven't tried backing out the commit yet, but looking at the diff I
> > see that you call radeon_wait_for_vblank and radeon_get_vblank_counter,
> > but evergreen_mc_program is called way before IRQ is set up. Is the
> > vblank counter running? Looks like we just hitting the timeout here...
>
> We aren't waiting for an interrupt, just polling the current crtc
> status until it enters the vblank region. The status and counters
> should be working as we only wait on displays that are enabled.
It appears that all the crtcs are considered active:
[ 4.260766] crtc 0 enabled 272696081 (this is the value of crtc_enabled)
[ 4.260766] crtc 0 wait for vblank 0x1 (0x1 means no timeout)
[ 4.260766] crtc 0: waited 33 [100000] (number of loops of radeon_get_vblank_counter)
[ 4.260766] crtc 1 enabled 272630544
[ 4.260766] crtc 1 wait for vblank 0x1
[ 4.260766] crtc 1: waited 100000 [100000]
[ 4.260766] crtc 2 enabled 4195088
[ 4.260766] crtc 2 wait for vblank 0x1
[ 4.260766] crtc 2: waited 100000 [100000]
[ 4.260766] crtc 3 enabled 4195088
[ 4.260766] crtc 3 wait for vblank 0x1
[ 4.260766] crtc 3: waited 100000 [100000]
[ 4.260766] crtc 4 enabled 4195088
[ 4.260766] crtc 4 wait for vblank 0x1
[ 4.260766] crtc 4: waited 100000 [100000]
[ 4.260766] crtc 5 enabled 4195088
[ 4.260766] crtc 5 wait for vblank 0x1
[ 4.260766] crtc 5: waited 100000 [100000]
Maybe the code should be checking EVERGREEN_CRTC_MASTER_EN?
I'm testing this patch and the boot is fast again:
diff --git a/drivers/gpu/drm/radeon/evergreen.c b/drivers/gpu/drm/radeon/evergreen.c
index 2308c7d..72bf721 100644
--- a/drivers/gpu/drm/radeon/evergreen.c
+++ b/drivers/gpu/drm/radeon/evergreen.c
@@ -1251,7 +1251,8 @@ void evergreen_mc_stop(struct radeon_device *rdev, struct evergreen_mc_save *sav
WREG32(VGA_RENDER_CONTROL, 0);
/* blank the display controllers */
for (i = 0; i < rdev->num_crtc; i++) {
- crtc_enabled = RREG32(EVERGREEN_CRTC_CONTROL + crtc_offsets[i]);
+ crtc_enabled = RREG32(EVERGREEN_CRTC_CONTROL + crtc_offsets[i]) &
+ EVERGREEN_CRTC_MASTER_EN;
if (crtc_enabled) {
save->crtc_enabled[i] = true;
if (ASIC_IS_DCE6(rdev)) {
Luca
^ permalink raw reply related [flat|nested] 8+ messages in thread
* Re: radeon testing
2012-08-21 20:33 ` Luca Tettamanti
@ 2012-08-21 20:39 ` Alex Deucher
0 siblings, 0 replies; 8+ messages in thread
From: Alex Deucher @ 2012-08-21 20:39 UTC (permalink / raw)
To: Luca Tettamanti; +Cc: Mailing list - DRI developers
On Tue, Aug 21, 2012 at 4:33 PM, Luca Tettamanti <kronos.it@gmail.com> wrote:
> On Tue, Aug 21, 2012 at 09:51:46AM -0400, Alex Deucher wrote:
>> On Mon, Aug 20, 2012 at 3:30 PM, Luca Tettamanti <kronos.it@gmail.com> wrote:
>> > Any printk between evergreen_mc_stop and evergreen_mc_resume locks up
>> > the machine. The likely culprit is commit 023e188e:
>>
>> yeah, vram is locked out at that point. I guess we probably need to
>> block anyone from trying to access it.
>
> I see; the 2 dev_warn would probably lock up the machine as well right?
>
>> > I haven't tried backing out the commit yet, but looking at the diff I
>> > see that you call radeon_wait_for_vblank and radeon_get_vblank_counter,
>> > but evergreen_mc_program is called way before IRQ is set up. Is the
>> > vblank counter running? Looks like we just hitting the timeout here...
>>
>> We aren't waiting for an interrupt, just polling the current crtc
>> status until it enters the vblank region. The status and counters
>> should be working as we only wait on displays that are enabled.
>
> It appears that all the crtcs are considered active:
>
> [ 4.260766] crtc 0 enabled 272696081 (this is the value of crtc_enabled)
> [ 4.260766] crtc 0 wait for vblank 0x1 (0x1 means no timeout)
> [ 4.260766] crtc 0: waited 33 [100000] (number of loops of radeon_get_vblank_counter)
> [ 4.260766] crtc 1 enabled 272630544
> [ 4.260766] crtc 1 wait for vblank 0x1
> [ 4.260766] crtc 1: waited 100000 [100000]
> [ 4.260766] crtc 2 enabled 4195088
> [ 4.260766] crtc 2 wait for vblank 0x1
> [ 4.260766] crtc 2: waited 100000 [100000]
> [ 4.260766] crtc 3 enabled 4195088
> [ 4.260766] crtc 3 wait for vblank 0x1
> [ 4.260766] crtc 3: waited 100000 [100000]
> [ 4.260766] crtc 4 enabled 4195088
> [ 4.260766] crtc 4 wait for vblank 0x1
> [ 4.260766] crtc 4: waited 100000 [100000]
> [ 4.260766] crtc 5 enabled 4195088
> [ 4.260766] crtc 5 wait for vblank 0x1
> [ 4.260766] crtc 5: waited 100000 [100000]
>
> Maybe the code should be checking EVERGREEN_CRTC_MASTER_EN?
>
> I'm testing this patch and the boot is fast again:
Yes, that's correct. I'll fix that up.
Alex
>
> diff --git a/drivers/gpu/drm/radeon/evergreen.c b/drivers/gpu/drm/radeon/evergreen.c
> index 2308c7d..72bf721 100644
> --- a/drivers/gpu/drm/radeon/evergreen.c
> +++ b/drivers/gpu/drm/radeon/evergreen.c
> @@ -1251,7 +1251,8 @@ void evergreen_mc_stop(struct radeon_device *rdev, struct evergreen_mc_save *sav
> WREG32(VGA_RENDER_CONTROL, 0);
> /* blank the display controllers */
> for (i = 0; i < rdev->num_crtc; i++) {
> - crtc_enabled = RREG32(EVERGREEN_CRTC_CONTROL + crtc_offsets[i]);
> + crtc_enabled = RREG32(EVERGREEN_CRTC_CONTROL + crtc_offsets[i]) &
> + EVERGREEN_CRTC_MASTER_EN;
> if (crtc_enabled) {
> save->crtc_enabled[i] = true;
> if (ASIC_IS_DCE6(rdev)) {
>
>
> Luca
^ permalink raw reply [flat|nested] 8+ messages in thread
end of thread, other threads:[~2012-08-21 20:39 UTC | newest]
Thread overview: 8+ messages (download: mbox.gz follow: Atom feed
-- links below jump to the message on this page --
2012-08-16 15:51 radeon testing Alex Deucher
2012-08-20 12:30 ` Luca Tettamanti
2012-08-20 14:24 ` Alex Deucher
2012-08-20 19:30 ` Luca Tettamanti
2012-08-21 13:51 ` Alex Deucher
2012-08-21 14:17 ` Christian König
2012-08-21 20:33 ` Luca Tettamanti
2012-08-21 20:39 ` Alex Deucher
This is an external index of several public inboxes,
see mirroring instructions on how to clone and mirror
all data and code used by this external index.