* WARNING: at arch/x86/kernel/apic/apic.c:249 native_apic_write_dummy
@ 2009-06-17 15:11 Vegard Nossum
2009-06-17 15:14 ` Cyrill Gorcunov
0 siblings, 1 reply; 6+ messages in thread
From: Vegard Nossum @ 2009-06-17 15:11 UTC (permalink / raw)
To: Ingo Molnar, Cyrill Gorcunov; +Cc: LKML, Yinghai Lu
Hi,
I just saw this warning on latest mainline when shutting down a box:
[ 503.576724] ACPI: Preparing to enter system sleep state S5
[ 503.710857] Disabling non-boot CPUs ...
[ 503.716853] Power down.
[ 503.717770] ------------[ cut here ]------------
[ 503.717770] WARNING: at arch/x86/kernel/apic/apic.c:249 native_apic_write_du)
[ 503.717770] Hardware name: OptiPlex GX100
[ 503.717770] Modules linked in:
[ 503.717770] Pid: 2136, comm: halt Not tainted 2.6.30 #443
[ 503.717770] Call Trace:
[ 503.717770] [<c154d327>] ? printk+0x18/0x1a
[ 503.717770] [<c1017358>] ? native_apic_write_dummy+0x38/0x50
[ 503.717770] [<c10360fc>] warn_slowpath_common+0x6c/0xc0
[ 503.717770] [<c1017358>] ? native_apic_write_dummy+0x38/0x50
[ 503.717770] [<c1036165>] warn_slowpath_null+0x15/0x20
[ 503.717770] [<c1017358>] native_apic_write_dummy+0x38/0x50
[ 503.717770] [<c1017173>] disconnect_bsp_APIC+0x63/0x100
[ 503.717770] [<c1019e48>] disable_IO_APIC+0xb8/0xc0
[ 503.717770] [<c1214231>] ? acpi_power_off+0x0/0x29
[ 503.717770] [<c1015e55>] native_machine_shutdown+0x65/0x80
[ 503.717770] [<c1015c36>] native_machine_power_off+0x26/0x30
[ 503.717770] [<c1015c49>] machine_power_off+0x9/0x10
[ 503.717770] [<c1046596>] kernel_power_off+0x36/0x40
[ 503.717770] [<c104680d>] sys_reboot+0xfd/0x1f0
[ 503.717770] [<c109daa0>] ? perf_swcounter_event+0xb0/0x130
[ 503.717770] [<c109db7d>] ? perf_counter_task_sched_out+0x5d/0x120
[ 503.717770] [<c102dfc6>] ? finish_task_switch+0x56/0xd0
[ 503.717770] [<c154da1e>] ? schedule+0x49e/0xb40
[ 503.717770] [<c10444b0>] ? sys_kill+0x70/0x160
[ 503.717770] [<c119d9db>] ? selinux_file_ioctl+0x3b/0x50
[ 503.717770] [<c10dd443>] ? sys_ioctl+0x63/0x70
[ 503.717770] [<c1003024>] sysenter_do_call+0x12/0x22
[ 503.717770] ---[ end trace 8157b5d0ed378f15 ]---
[ 503.717770] acpi_power_off called
That's including this commit:
commit 103428e57be323c3c5545db8ad12667099bc6005
Author: Cyrill Gorcunov <gorcunov@openvz.org>
Date: Sun Jun 7 16:48:40 2009 +0400
x86, apic: Fix dummy apic read operation together with broken MP handling
Vegard
^ permalink raw reply [flat|nested] 6+ messages in thread
* Re: WARNING: at arch/x86/kernel/apic/apic.c:249 native_apic_write_dummy
2009-06-17 15:11 WARNING: at arch/x86/kernel/apic/apic.c:249 native_apic_write_dummy Vegard Nossum
@ 2009-06-17 15:14 ` Cyrill Gorcunov
2009-06-17 15:46 ` Vegard Nossum
0 siblings, 1 reply; 6+ messages in thread
From: Cyrill Gorcunov @ 2009-06-17 15:14 UTC (permalink / raw)
To: Vegard Nossum; +Cc: Ingo Molnar, LKML, Yinghai Lu
[Vegard Nossum - Wed, Jun 17, 2009 at 05:11:20PM +0200]
| Hi,
|
| I just saw this warning on latest mainline when shutting down a box:
|
| [ 503.576724] ACPI: Preparing to enter system sleep state S5
| [ 503.710857] Disabling non-boot CPUs ...
| [ 503.716853] Power down.
| [ 503.717770] ------------[ cut here ]------------
| [ 503.717770] WARNING: at arch/x86/kernel/apic/apic.c:249 native_apic_write_du)
| [ 503.717770] Hardware name: OptiPlex GX100
| [ 503.717770] Modules linked in:
| [ 503.717770] Pid: 2136, comm: halt Not tainted 2.6.30 #443
| [ 503.717770] Call Trace:
| [ 503.717770] [<c154d327>] ? printk+0x18/0x1a
| [ 503.717770] [<c1017358>] ? native_apic_write_dummy+0x38/0x50
| [ 503.717770] [<c10360fc>] warn_slowpath_common+0x6c/0xc0
| [ 503.717770] [<c1017358>] ? native_apic_write_dummy+0x38/0x50
| [ 503.717770] [<c1036165>] warn_slowpath_null+0x15/0x20
| [ 503.717770] [<c1017358>] native_apic_write_dummy+0x38/0x50
| [ 503.717770] [<c1017173>] disconnect_bsp_APIC+0x63/0x100
| [ 503.717770] [<c1019e48>] disable_IO_APIC+0xb8/0xc0
| [ 503.717770] [<c1214231>] ? acpi_power_off+0x0/0x29
| [ 503.717770] [<c1015e55>] native_machine_shutdown+0x65/0x80
| [ 503.717770] [<c1015c36>] native_machine_power_off+0x26/0x30
| [ 503.717770] [<c1015c49>] machine_power_off+0x9/0x10
| [ 503.717770] [<c1046596>] kernel_power_off+0x36/0x40
| [ 503.717770] [<c104680d>] sys_reboot+0xfd/0x1f0
| [ 503.717770] [<c109daa0>] ? perf_swcounter_event+0xb0/0x130
| [ 503.717770] [<c109db7d>] ? perf_counter_task_sched_out+0x5d/0x120
| [ 503.717770] [<c102dfc6>] ? finish_task_switch+0x56/0xd0
| [ 503.717770] [<c154da1e>] ? schedule+0x49e/0xb40
| [ 503.717770] [<c10444b0>] ? sys_kill+0x70/0x160
| [ 503.717770] [<c119d9db>] ? selinux_file_ioctl+0x3b/0x50
| [ 503.717770] [<c10dd443>] ? sys_ioctl+0x63/0x70
| [ 503.717770] [<c1003024>] sysenter_do_call+0x12/0x22
| [ 503.717770] ---[ end trace 8157b5d0ed378f15 ]---
| [ 503.717770] acpi_power_off called
|
| That's including this commit:
|
| commit 103428e57be323c3c5545db8ad12667099bc6005
| Author: Cyrill Gorcunov <gorcunov@openvz.org>
| Date: Sun Jun 7 16:48:40 2009 +0400
|
| x86, apic: Fix dummy apic read operation together with broken MP handling
|
|
| Vegard
|
Thanks Vegard, will take a look.
-- Cyrill
^ permalink raw reply [flat|nested] 6+ messages in thread
* Re: WARNING: at arch/x86/kernel/apic/apic.c:249 native_apic_write_dummy
2009-06-17 15:14 ` Cyrill Gorcunov
@ 2009-06-17 15:46 ` Vegard Nossum
2009-06-17 15:53 ` Cyrill Gorcunov
0 siblings, 1 reply; 6+ messages in thread
From: Vegard Nossum @ 2009-06-17 15:46 UTC (permalink / raw)
To: Cyrill Gorcunov; +Cc: Ingo Molnar, LKML, Yinghai Lu
[-- Attachment #1: Type: text/plain, Size: 303 bytes --]
2009/6/17 Cyrill Gorcunov <gorcunov@gmail.com>:
> [Vegard Nossum - Wed, Jun 17, 2009 at 05:11:20PM +0200]
> | Hi,
> |
> | I just saw this warning on latest mainline when shutting down a box:
[...]
> Thanks Vegard, will take a look.
I've attached full boot log (it's a different boot though).
Vegard
[-- Attachment #2: minicom162.txt --]
[-- Type: text/plain, Size: 94328 bytes --]
root (hd0,0)
Filesystem type is ext2fs, partition type 0x83
kernel /boot/testing/bzImage root=/dev/sda1 ro console=ttyS0,115200 ignore_logl
evel debug initcall_debug nmi_watchdog=1 panic=30 kmemcheck=1 sysrq_always_enab
led
[Linux-bzImage, setup=0x2e00, size=0x4358c0]
[ 0.000000] Initializing cgroup subsys cpuset
[ 0.000000] Initializing cgroup subsys cpu
[ 0.000000] Linux version 2.6.30 (vegard@damson) (gcc version 4.3.2 20081105 (Red Hat 4.3.2-7) (GCC) ) #445 SMP Wed Jun 17 17:39:02 CEST 2009
[ 0.000000] KERNEL supported cpus:
[ 0.000000] Intel GenuineIntel
[ 0.000000] AMD AuthenticAMD
[ 0.000000] NSC Geode by NSC
[ 0.000000] Cyrix CyrixInstead
[ 0.000000] Centaur CentaurHauls
[ 0.000000] Transmeta GenuineTMx86
[ 0.000000] Transmeta TransmetaCPU
[ 0.000000] UMC UMC UMC UMC
[ 0.000000] BIOS-provided physical RAM map:
[ 0.000000] BIOS-e820: 0000000000000000 - 00000000000a0000 (usable)
[ 0.000000] BIOS-e820: 00000000000f0000 - 0000000000100000 (reserved)
[ 0.000000] BIOS-e820: 0000000000100000 - 000000000feac000 (usable)
[ 0.000000] BIOS-e820: 000000000feac000 - 0000000010000000 (reserved)
[ 0.000000] BIOS-e820: 00000000ffb00000 - 0000000100000000 (reserved)
[ 0.000000] debug: ignoring loglevel setting.
[ 0.000000] DMI 2.3 present.
[ 0.000000] last_pfn = 0xfeac max_arch_pfn = 0x100000
[ 0.000000] MTRR default type: uncachable
[ 0.000000] MTRR fixed ranges enabled:
[ 0.000000] 00000-9FFFF write-back
[ 0.000000] A0000-BFFFF uncachable
[ 0.000000] C0000-CFFFF write-protect
[ 0.000000] D0000-EFFFF uncachable
[ 0.000000] F0000-FFFFF write-protect
[ 0.000000] MTRR variable ranges enabled:
[ 0.000000] 0 base 000000000 mask FF0000000 write-back
[ 0.000000] 1 base 00FF00000 mask FFFF00000 uncachable
[ 0.000000] 2 disabled
[ 0.000000] 3 disabled
[ 0.000000] 4 disabled
[ 0.000000] 5 disabled
[ 0.000000] 6 disabled
[ 0.000000] 7 disabled
[ 0.000000] PAT not supported by CPU.
[ 0.000000] e820 update range: 0000000000002000 - 0000000000006000 (usable) ==> (reserved)
[ 0.000000] Scanning 1 areas for low memory corruption
[ 0.000000] modified physical RAM map:
[ 0.000000] modified: 0000000000000000 - 0000000000002000 (usable)
[ 0.000000] modified: 0000000000002000 - 0000000000006000 (reserved)
[ 0.000000] modified: 0000000000006000 - 00000000000a0000 (usable)
[ 0.000000] modified: 00000000000f0000 - 0000000000100000 (reserved)
[ 0.000000] modified: 0000000000100000 - 000000000feac000 (usable)
[ 0.000000] modified: 000000000feac000 - 0000000010000000 (reserved)
[ 0.000000] modified: 00000000ffb00000 - 0000000100000000 (reserved)
[ 0.000000] initial memory mapped : 0 - 01c00000
[ 0.000000] init_memory_mapping: 0000000000000000-000000000feac000
[ 0.000000] 0000000000 - 000feac000 page 4k
[ 0.000000] kernel direct mapping tables up to feac000 @ 7000-4a000
[ 0.000000] ACPI: RSDP 000fd790 00014 (v00 DELL )
[ 0.000000] ACPI: RSDT 000fd7a4 00028 (v01 DELL GX100 00000007 ASL 00000061)
[ 0.000000] ACPI: FACP 000fd7cc 00074 (v01 DELL GX100 00000007 ASL 00000061)
[ 0.000000] ACPI: DSDT fffe5000 01801 (v01 DELL dt_ex 00001000 MSFT 0100000B)
[ 0.000000] ACPI: FACS 0feac000 00040
[ 0.000000] 0MB HIGHMEM available.
[ 0.000000] 254MB LOWMEM available.
[ 0.000000] mapped low ram: 0 - 0feac000
[ 0.000000] low ram: 0 - 0feac000
[ 0.000000] node 0 low ram: 00000000 - 0feac000
[ 0.000000] node 0 bootmap 00040000 - 00041fd8
[ 0.000000] (8 early reservations) ==> bootmem [0000000000 - 000feac000]
[ 0.000000] #0 [0000000000 - 0000001000] BIOS data page ==> [0000000000 - 0000001000]
[ 0.000000] #1 [0000001000 - 0000002000] EX TRAMPOLINE ==> [0000001000 - 0000002000]
[ 0.000000] #2 [0000006000 - 0000007000] TRAMPOLINE ==> [0000006000 - 0000007000]
[ 0.000000] #3 [0001000000 - 00018cfba8] TEXT DATA BSS ==> [0001000000 - 00018cfba8]
[ 0.000000] #4 [000009fc00 - 0000100000] BIOS reserved ==> [000009fc00 - 0000100000]
[ 0.000000] #5 [00018d0000 - 00018d7168] BRK ==> [00018d0000 - 00018d7168]
[ 0.000000] #6 [0000007000 - 0000040000] PGTABLE ==> [0000007000 - 0000040000]
[ 0.000000] #7 [0000040000 - 0000042000] BOOTMAP ==> [0000040000 - 0000042000]
[ 0.000000] Zone PFN ranges:
[ 0.000000] DMA 0x00000000 -> 0x00001000
[ 0.000000] Normal 0x00001000 -> 0x0000feac
[ 0.000000] HighMem 0x0000feac -> 0x0000feac
[ 0.000000] Movable zone start PFN for each node
[ 0.000000] early_node_map[3] active PFN ranges
[ 0.000000] 0: 0x00000000 -> 0x00000002
[ 0.000000] 0: 0x00000006 -> 0x000000a0
[ 0.000000] 0: 0x00000100 -> 0x0000feac
[ 0.000000] On node 0 totalpages: 65096
[ 0.000000] DMA zone: 36 pages used for memmap
[ 0.000000] DMA zone: 0 pages reserved
[ 0.000000] DMA zone: 3960 pages, LIFO batch:0
[ 0.000000] Normal zone: 538 pages used for memmap
[ 0.000000] Normal zone: 60562 pages, LIFO batch:15
[ 0.000000] Using APIC driver default
[ 0.000000] ACPI: PM-Timer IO Port: 0x808
[ 0.000000] SMP: Allowing 1 CPUs, 0 hotplug CPUs
[ 0.000000] Local APIC disabled by BIOS -- you can enable it with "lapic"
[ 0.000000] APIC: disable apic facility
[ 0.000000] nr_irqs_gsi: 16
[ 0.000000] PM: Registered nosave memory: 0000000000002000 - 0000000000006000
[ 0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000f0000
[ 0.000000] PM: Registered nosave memory: 00000000000f0000 - 0000000000100000
[ 0.000000] Allocating PCI resources starting at 10000000 (gap: 10000000:efb00000)
[ 0.000000] NR_CPUS:8 nr_cpumask_bits:8 nr_cpu_ids:1 nr_node_ids:1
[ 0.000000] PERCPU: Embedded 14 pages at c1b1c000, static data 34268 bytes
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 64522
[ 0.000000] Kernel command line: root=/dev/sda1 ro console=ttyS0,115200 ignore_loglevel debug initcall_debug nmi_watchdog=1 panic=30 kmemcheck=1 sysrq_always_enabled
[ 0.000000] debug: sysrq always enabled.
[ 0.000000] PID hash table entries: 1024 (order: 10, 4096 bytes)
[ 0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes)
[ 0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes)
[ 0.000000] Enabling fast FPU save and restore... done.
[ 0.000000] Initializing CPU#0
[ 0.000000] Initializing HighMem for node 0 (00000000:00000000)
[ 0.000000] Memory: 248428k/260784k available (5476k kernel code, 11888k reserved, 2376k data, 424k init, 0k highmem)
[ 0.000000] virtual kernel memory layout:
[ 0.000000] fixmap : 0xfff37000 - 0xfffff000 ( 800 kB)
[ 0.000000] pkmap : 0xff800000 - 0xffc00000 (4096 kB)
[ 0.000000] vmalloc : 0xd06ac000 - 0xff7fe000 ( 753 MB)
[ 0.000000] lowmem : 0xc0000000 - 0xcfeac000 ( 254 MB)
[ 0.000000] .init : 0xc17b4000 - 0xc181e000 ( 424 kB)
[ 0.000000] .data : 0xc15590db - 0xc17ab478 (2376 kB)
[ 0.000000] .text : 0xc1000000 - 0xc15590db (5476 kB)
[ 0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok.
[ 0.000000] SLUB: Genslabs=13, HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[ 0.000000] Experimental hierarchical RCU implementation.
[ 0.000000] Experimental hierarchical RCU init done.
[ 0.000000] NR_IRQS:2304 nr_irqs:256
[ 0.000000] Fast TSC calibration using PIT
[ 0.000000] Detected 498.446 MHz processor.
[ 0.000999] Console: colour VGA+ 80x25
[ 0.000999] console [ttyS0] enabled
[ 0.001050] Calibrating delay loop (skipped), value calculated using timer frequency.. 996.89 BogoMIPS (lpj=498446)
[ 0.010277] Security Framework initialized
[ 0.011045] SELinux: Initializing.
[ 0.013947] SELinux: Starting in permissive mode
[ 0.015960] Mount-cache hash table entries: 512
[ 0.065528] Initializing cgroup subsys ns
[ 0.066153] Initializing cgroup subsys cpuacct
[ 0.067462] Initializing cgroup subsys freezer
[ 0.070602] CPU: L1 I cache: 16K, L1 D cache: 16K
[ 0.072000] CPU: L2 cache: 128K
[ 0.073013] mce: CPU supports 5 MCE banks
[ 0.074170] Performance Counters: no PMU driver, software counters only.
[ 0.076163] Checking 'hlt' instruction... OK.
[ 0.081770] SMP alternatives: switching to UP code
[ 0.094038] Freeing SMP alternatives: 21k freed
[ 0.095093] ACPI: Core revision 20090521
[ 0.643738] ACPI: setting ELCR to 0200 (from 0e20)
[ 0.647477] weird, boot CPU (#0) not listed by the BIOS.
[ 0.648024] SMP motherboard not detected.
[ 0.649023] Local APIC not detected. Using dummy APIC emulation.
[ 0.651019] SMP disabled
[ 0.652048] calling kmemcheck_init+0x0/0x62 @ 1
[ 0.653020] kmemcheck: Limiting number of CPUs to 1.
[ 0.654020] kmemcheck: Initialized
[ 0.655027] initcall kmemcheck_init+0x0/0x62 returned 0 after 1953 usecs
[ 0.656026] calling migration_init+0x0/0x4b @ 1
[ 0.657806] initcall migration_init+0x0/0x4b returned 1 after 0 usecs
[ 0.658034] initcall migration_init+0x0/0x4b returned with error code 1
[ 0.659027] calling spawn_ksoftirqd+0x0/0x47 @ 1
[ 0.660808] initcall spawn_ksoftirqd+0x0/0x47 returned 0 after 0 usecs
[ 0.661045] calling init_call_single_data+0x0/0x6d @ 1
[ 0.662029] initcall init_call_single_data+0x0/0x6d returned 0 after 0 usecs
[ 0.663033] calling relay_init+0x0/0x11 @ 1
[ 0.664029] initcall relay_init+0x0/0x11 returned 0 after 0 usecs
[ 0.665030] calling tracer_alloc_buffers+0x0/0x13d @ 1
[ 0.667689] initcall tracer_alloc_buffers+0x0/0x13d returned 0 after 976 usecs
[ 0.669048] calling init_trace_printk+0x0/0xf @ 1
[ 0.670034] initcall init_trace_printk+0x0/0xf returned 0 after 0 usecs
[ 0.671025] Brought up 1 CPUs
[ 0.672025] Total of 1 processors activated (996.89 BogoMIPS).
[ 0.694403] khelper used greatest stack depth: 6876 bytes left
[ 0.705432] khelper used greatest stack depth: 6844 bytes left
[ 0.729261] calling init_cpufreq_transition_notifier_list+0x0/0x18 @ 1
[ 0.731561] initcall init_cpufreq_transition_notifier_list+0x0/0x18 returned 0 after 976 usecs
[ 0.732030] calling net_ns_init+0x0/0xf5 @ 1
[ 0.735889] initcall net_ns_init+0x0/0xf5 returned 0 after 1953 usecs
[ 0.736074] calling e820_mark_nvs_memory+0x0/0x47 @ 1
[ 0.737030] initcall e820_mark_nvs_memory+0x0/0x47 returned 0 after 0 usecs
[ 0.738032] calling cpufreq_tsc+0x0/0x25 @ 1
[ 0.739031] initcall cpufreq_tsc+0x0/0x25 returned 0 after 0 usecs
[ 0.740037] calling reboot_init+0x0/0x11 @ 1
[ 0.741074] initcall reboot_init+0x0/0x11 returned 0 after 0 usecs
[ 0.742033] calling init_lapic_sysfs+0x0/0x2a @ 1
[ 0.743029] initcall init_lapic_sysfs+0x0/0x2a returned 0 after 0 usecs
[ 0.744035] calling init_smp_flush+0x0/0x26 @ 1
[ 0.745028] initcall init_smp_flush+0x0/0x26 returned 0 after 0 usecs
[ 0.746037] calling alloc_frozen_cpus+0x0/0x10 @ 1
[ 0.747028] initcall alloc_frozen_cpus+0x0/0x10 returned 0 after 0 usecs
[ 0.748037] calling sysctl_init+0x0/0x29 @ 1
[ 0.750693] initcall sysctl_init+0x0/0x29 returned 0 after 976 usecs
[ 0.751029] calling ksysfs_init+0x0/0xa0 @ 1
[ 0.754400] initcall ksysfs_init+0x0/0xa0 returned 0 after 1953 usecs
[ 0.755028] calling async_init+0x0/0x70 @ 1
[ 0.757158] initcall async_init+0x0/0x70 returned 0 after 976 usecs
[ 0.758067] calling init_jiffies_clocksource+0x0/0xf @ 1
[ 0.760039] initcall init_jiffies_clocksource+0x0/0xf returned 0 after 0 usecs
[ 0.761027] calling pm_init+0x0/0x2d @ 1
[ 0.763453] initcall pm_init+0x0/0x2d returned 0 after 976 usecs
[ 0.764029] calling pm_disk_init+0x0/0x14 @ 1
[ 0.765613] initcall pm_disk_init+0x0/0x14 returned 0 after 0 usecs
[ 0.766055] calling swsusp_header_init+0x0/0x30 @ 1
[ 0.768038] initcall swsusp_header_init+0x0/0x30 returned 0 after 0 usecs
[ 0.769029] calling filelock_init+0x0/0x2f @ 1
[ 0.770268] initcall filelock_init+0x0/0x2f returned 0 after 0 usecs
[ 0.771026] calling init_misc_binfmt+0x0/0x37 @ 1
[ 0.772035] initcall init_misc_binfmt+0x0/0x37 returned 0 after 0 usecs
[ 0.773027] calling init_script_binfmt+0x0/0x11 @ 1
[ 0.774028] initcall init_script_binfmt+0x0/0x11 returned 0 after 0 usecs
[ 0.775026] calling init_elf_binfmt+0x0/0x11 @ 1
[ 0.776027] initcall init_elf_binfmt+0x0/0x11 returned 0 after 0 usecs
[ 0.777032] calling debugfs_init+0x0/0x4a @ 1
[ 0.778509] initcall debugfs_init+0x0/0x4a returned 0 after 0 usecs
[ 0.779036] calling random32_init+0x0/0xb8 @ 1
[ 0.780029] initcall random32_init+0x0/0xb8 returned 0 after 0 usecs
[ 0.781040] calling early_resume_init+0x0/0x1a0 @ 1
[ 0.782044] Time: 17:39:44 Date: 06/17/09
[ 0.783029] initcall early_resume_init+0x0/0x1a0 returned 0 after 976 usecs
[ 0.784037] calling cpufreq_core_init+0x0/0x5c @ 1
[ 0.785029] initcall cpufreq_core_init+0x0/0x5c returned 0 after 0 usecs
[ 0.786028] calling cpuidle_init+0x0/0x32 @ 1
[ 0.788228] initcall cpuidle_init+0x0/0x32 returned 0 after 976 usecs
[ 0.789029] calling sock_init+0x0/0x60 @ 1
[ 0.807841] initcall sock_init+0x0/0x60 returned 0 after 16601 usecs
[ 0.808030] calling net_inuse_init+0x0/0x24 @ 1
[ 0.810030] initcall net_inuse_init+0x0/0x24 returned 0 after 976 usecs
[ 0.811027] calling netpoll_init+0x0/0x2f @ 1
[ 0.812027] initcall netpoll_init+0x0/0x2f returned 0 after 0 usecs
[ 0.813028] calling netlink_proto_init+0x0/0x181 @ 1
[ 0.817463] NET: Registered protocol family 16
[ 0.821182] initcall netlink_proto_init+0x0/0x181 returned 0 after 6835 usecs
[ 0.822049] calling bdi_class_init+0x0/0x35 @ 1
[ 0.834878] initcall bdi_class_init+0x0/0x35 returned 0 after 10742 usecs
[ 0.835045] calling kobject_uevent_init+0x0/0x60 @ 1
[ 0.838121] initcall kobject_uevent_init+0x0/0x60 returned 0 after 1953 usecs
[ 0.839030] calling pcibus_class_init+0x0/0x14 @ 1
[ 0.849697] initcall pcibus_class_init+0x0/0x14 returned 0 after 8789 usecs
[ 0.850108] calling pci_driver_init+0x0/0x1e @ 1
[ 0.862721] initcall pci_driver_init+0x0/0x1e returned 0 after 10742 usecs
[ 0.863034] calling backlight_class_init+0x0/0x53 @ 1
[ 0.874421] khelper used greatest stack depth: 6832 bytes left
[ 0.875496] initcall backlight_class_init+0x0/0x53 returned 0 after 10742 usecs
[ 0.876150] calling video_output_class_init+0x0/0x14 @ 1
[ 0.887553] initcall video_output_class_init+0x0/0x14 returned 0 after 9765 usecs
[ 0.888162] calling tty_class_init+0x0/0x28 @ 1
[ 0.899560] initcall tty_class_init+0x0/0x28 returned 0 after 9765 usecs
[ 0.900148] calling vtconsole_class_init+0x0/0xcd @ 1
[ 0.924700] initcall vtconsole_class_init+0x0/0xcd returned 0 after 22460 usecs
[ 0.925379] calling i2c_init+0x0/0x56 @ 1
[ 0.959502] initcall i2c_init+0x0/0x56 returned 0 after 32226 usecs
[ 0.960152] calling amd_postcore_init+0x0/0x6f @ 1
[ 0.961028] initcall amd_postcore_init+0x0/0x6f returned 0 after 0 usecs
[ 0.962032] calling arch_kdebugfs_init+0x0/0x350 @ 1
[ 0.967830] initcall arch_kdebugfs_init+0x0/0x350 returned 0 after 3906 usecs
[ 0.968033] calling init_pit_clocksource+0x0/0x93 @ 1
[ 0.969047] initcall init_pit_clocksource+0x0/0x93 returned 0 after 0 usecs
[ 0.970030] calling mtrr_if_init+0x0/0x60 @ 1
[ 0.972346] initcall mtrr_if_init+0x0/0x60 returned 0 after 976 usecs
[ 0.973033] calling ffh_cstate_init+0x0/0x3a @ 1
[ 0.974192] initcall ffh_cstate_init+0x0/0x3a returned 0 after 0 usecs
[ 0.975038] calling kdump_buf_page_init+0x0/0x83 @ 1
[ 0.976043] initcall kdump_buf_page_init+0x0/0x83 returned 0 after 0 usecs
[ 0.977041] calling acpi_pci_init+0x0/0x5b @ 1
[ 0.978025] ACPI: bus type pci registered
[ 0.979029] initcall acpi_pci_init+0x0/0x5b returned 0 after 976 usecs
[ 0.980034] calling dmi_id_init+0x0/0x302 @ 1
[ 0.990305] khelper used greatest stack depth: 6824 bytes left
[ 1.013588] initcall dmi_id_init+0x0/0x302 returned 0 after 31250 usecs
[ 1.014155] calling pci_arch_init+0x0/0x70 @ 1
[ 1.043739] PCI: PCI BIOS revision 2.10 entry at 0xfc0ce, last bus=1
[ 1.044025] PCI: Using configuration type 1 for base access
[ 1.045109] initcall pci_arch_init+0x0/0x70 returned 0 after 28320 usecs
[ 1.046038] calling topology_init+0x0/0x3f @ 1
[ 1.056621] khelper used greatest stack depth: 6628 bytes left
[ 1.058265] initcall topology_init+0x0/0x3f returned 0 after 10742 usecs
[ 1.059035] calling mtrr_init_finialize+0x0/0x36 @ 1
[ 1.060029] initcall mtrr_init_finialize+0x0/0x36 returned 0 after 0 usecs
[ 1.061038] calling param_sysfs_init+0x0/0x202 @ 1
[ 3.230478] initcall param_sysfs_init+0x0/0x202 returned 0 after 2117189 usecs
[ 3.231171] calling pm_sysrq_init+0x0/0x20 @ 1
[ 3.232031] initcall pm_sysrq_init+0x0/0x20 returned 0 after 0 usecs
[ 3.233039] calling default_bdi_init+0x0/0x3b @ 1
[ 3.250259] initcall default_bdi_init+0x0/0x3b returned 0 after 15625 usecs
[ 3.251032] calling init_bio+0x0/0x11a @ 1
[ 3.255281] bio: create slab <bio-0> at 0
[ 3.257286] initcall init_bio+0x0/0x11a returned 0 after 4882 usecs
[ 3.258032] calling fsnotify_init+0x0/0xf @ 1
[ 3.259201] initcall fsnotify_init+0x0/0xf returned 0 after 0 usecs
[ 3.260028] calling fsnotify_notification_init+0x0/0xf0 @ 1
[ 3.262168] initcall fsnotify_notification_init+0x0/0xf0 returned 0 after 976 usecs
[ 3.263036] calling cryptomgr_init+0x0/0xf @ 1
[ 3.264030] initcall cryptomgr_init+0x0/0xf returned 0 after 0 usecs
[ 3.265032] calling blk_settings_init+0x0/0x21 @ 1
[ 3.266029] initcall blk_settings_init+0x0/0x21 returned 0 after 0 usecs
[ 3.267027] calling blk_ioc_init+0x0/0x2f @ 1
[ 3.268302] initcall blk_ioc_init+0x0/0x2f returned 0 after 0 usecs
[ 3.269030] calling blk_softirq_init+0x0/0x64 @ 1
[ 3.270040] initcall blk_softirq_init+0x0/0x64 returned 0 after 0 usecs
[ 3.271028] calling genhd_device_init+0x0/0x61 @ 1
[ 3.286167] initcall genhd_device_init+0x0/0x61 returned 0 after 13671 usecs
[ 3.287041] calling pci_slot_init+0x0/0x50 @ 1
[ 3.289463] initcall pci_slot_init+0x0/0x50 returned 0 after 976 usecs
[ 3.290036] calling fbmem_init+0x0/0x8e @ 1
[ 3.302262] initcall fbmem_init+0x0/0x8e returned 0 after 10742 usecs
[ 3.303202] calling acpi_init+0x0/0x262 @ 1
[ 3.379787] ACPI: EC: Look up EC in DSDT
[ 3.469044] Clocksource tsc unstable (delta = 128030047 ns)
[ 4.215688] ACPI: Interpreter enabled
[ 4.216047] ACPI: (supports S0 S1 S4 S5)
[ 4.229517] ACPI: Using PIC for interrupt routing
[ 5.454344] initcall acpi_init+0x0/0x262 returned 0 after 2099610 usecs
[ 5.456035] calling dock_init+0x0/0x7d @ 1
[ 5.479080] ACPI: No dock devices found.
[ 5.480034] initcall dock_init+0x0/0x7d returned 0 after 22460 usecs
[ 5.481031] calling acpi_pci_root_init+0x0/0x25 @ 1
[ 5.485327] ACPI: PCI Root Bridge [PCI0] (0000:00)
[ 5.507771] pci 0000:00:01.0: reg 10 32bit mmio: [0xf8000000-0xfbffffff]
[ 5.508231] pci 0000:00:01.0: reg 14 32bit mmio: [0xff000000-0xff07ffff]
[ 5.517234] pci 0000:00:1f.0: quirk: region 0800-087f claimed by ICH4 ACPI/GPIO/TCO
[ 5.519134] pci 0000:00:1f.0: quirk: region 0880-08bf claimed by ICH4 GPIO
[ 5.522272] pci 0000:00:1f.1: reg 20 io port: [0xffa0-0xffaf]
[ 5.526184] pci 0000:00:1f.2: reg 20 io port: [0xff80-0xff9f]
[ 5.531113] pci 0000:00:1f.3: reg 20 io port: [0xdcd0-0xdcdf]
[ 5.536962] pci 0000:01:08.0: reg 10 io port: [0xecc0-0xecff]
[ 5.539217] pci 0000:01:08.0: supports D1 D2
[ 5.542485] pci 0000:01:0c.0: reg 10 io port: [0xec00-0xec7f]
[ 5.543232] pci 0000:01:0c.0: reg 14 32bit mmio: [0xfdfffc00-0xfdfffc7f]
[ 5.544601] pci 0000:01:0c.0: reg 30 32bit mmio: [0xfe000000-0xfe01ffff]
[ 5.546449] pci 0000:01:0c.0: supports D1 D2
[ 5.547110] pci 0000:01:0c.0: PME# supported from D0 D1 D2 D3hot D3cold
[ 5.548172] pci 0000:01:0c.0: PME# disabled
[ 5.550780] pci 0000:00:1e.0: transparent bridge
[ 5.551266] pci 0000:00:1e.0: bridge io port: [0xe000-0xefff]
[ 5.552176] pci 0000:00:1e.0: bridge 32bit mmio: [0xfd000000-0xfeffffff]
[ 5.553430] pci_bus 0000:00: on NUMA node 0
[ 5.556237] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
[ 5.648872] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PCI1._PRT]
[ 6.311504] initcall acpi_pci_root_init+0x0/0x25 returned 0 after 809571 usecs
[ 6.312181] calling acpi_pci_link_init+0x0/0x3f @ 1
[ 6.347656] ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 6 7 *9 10 11 12 15)
[ 6.396919] ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 6 7 9 *10 11 12 15)
[ 6.446225] ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 *5 6 7 9 10 11 12 15)
[ 6.496593] ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 7 9 10 *11 12 15)
[ 6.524841] initcall acpi_pci_link_init+0x0/0x3f returned 0 after 206054 usecs
[ 6.525184] calling pnp_init+0x0/0xf @ 1
[ 6.537879] initcall pnp_init+0x0/0xf returned 0 after 10742 usecs
[ 6.538036] calling misc_init+0x0/0xa2 @ 1
[ 6.550271] initcall misc_init+0x0/0xa2 returned 0 after 10742 usecs
[ 6.551049] calling cn_init+0x0/0xe6 @ 1
[ 6.554803] initcall cn_init+0x0/0xe6 returned 0 after 1953 usecs
[ 6.555039] calling init_scsi+0x0/0x9d @ 1
[ 6.609165] SCSI subsystem initialized
[ 6.611379] initcall init_scsi+0x0/0x9d returned 0 after 53710 usecs
[ 6.612035] calling ata_init+0x0/0x328 @ 1
[ 6.615564] libata version 3.00 loaded.
[ 6.616082] initcall ata_init+0x0/0x328 returned 0 after 2929 usecs
[ 6.617033] calling phy_init+0x0/0x32 @ 1
[ 6.654856] initcall phy_init+0x0/0x32 returned 0 after 34179 usecs
[ 6.655154] calling init_pcmcia_cs+0x0/0x30 @ 1
[ 6.667455] initcall init_pcmcia_cs+0x0/0x30 returned 0 after 9765 usecs
[ 6.668203] calling usb_init+0x0/0x18d @ 1
[ 6.703564] usbcore: registered new interface driver usbfs
[ 6.716720] usbcore: registered new interface driver hub
[ 6.729443] usbcore: registered new device driver usb
[ 6.730173] initcall usb_init+0x0/0x18d returned 0 after 59570 usecs
[ 6.731034] calling serio_init+0x0/0x90 @ 1
[ 6.744854] initcall serio_init+0x0/0x90 returned 0 after 11718 usecs
[ 6.745314] calling input_init+0x0/0x130 @ 1
[ 6.757489] initcall input_init+0x0/0x130 returned 0 after 10742 usecs
[ 6.758036] calling rtc_init+0x0/0x64 @ 1
[ 6.769499] initcall rtc_init+0x0/0x64 returned 0 after 9765 usecs
[ 6.771157] calling power_supply_class_init+0x0/0x2f @ 1
[ 6.782863] initcall power_supply_class_init+0x0/0x2f returned 0 after 9765 usecs
[ 6.783206] calling hwmon_init+0x0/0xfc @ 1
[ 6.795538] initcall hwmon_init+0x0/0xfc returned 0 after 10742 usecs
[ 6.796187] calling thermal_init+0x0/0x38 @ 1
[ 6.807816] initcall thermal_init+0x0/0x38 returned 0 after 9765 usecs
[ 6.808184] calling md_init+0x0/0xf0 @ 1
[ 6.810869] initcall md_init+0x0/0xf0 returned 0 after 976 usecs
[ 6.811035] calling leds_init+0x0/0x45 @ 1
[ 6.822261] initcall leds_init+0x0/0x45 returned 0 after 9765 usecs
[ 6.823325] calling pci_subsys_init+0x0/0x130 @ 1
[ 6.824027] PCI: Using ACPI for IRQ routing
[ 6.831323] initcall pci_subsys_init+0x0/0x130 returned 0 after 6835 usecs
[ 6.832033] calling proto_init+0x0/0xf @ 1
[ 6.833467] initcall proto_init+0x0/0xf returned 0 after 0 usecs
[ 6.835034] calling net_dev_init+0x0/0x145 @ 1
[ 6.882440] initcall net_dev_init+0x0/0x145 returned 0 after 44921 usecs
[ 6.883034] calling neigh_init+0x0/0x7c @ 1
[ 6.884048] initcall neigh_init+0x0/0x7c returned 0 after 0 usecs
[ 6.885034] calling fib_rules_init+0x0/0xa6 @ 1
[ 6.886059] initcall fib_rules_init+0x0/0xa6 returned 0 after 0 usecs
[ 6.887030] calling pktsched_init+0x0/0xc6 @ 1
[ 6.889091] initcall pktsched_init+0x0/0xc6 returned 0 after 976 usecs
[ 6.890031] calling tc_filter_init+0x0/0x52 @ 1
[ 6.891044] initcall tc_filter_init+0x0/0x52 returned 0 after 0 usecs
[ 6.892030] calling tc_action_init+0x0/0x57 @ 1
[ 6.893046] initcall tc_action_init+0x0/0x57 returned 0 after 0 usecs
[ 6.894029] calling genl_init+0x0/0xcf @ 1
[ 6.897739] initcall genl_init+0x0/0xcf returned 0 after 1953 usecs
[ 6.898038] calling cipso_v4_init+0x0/0x5b @ 1
[ 6.902977] initcall cipso_v4_init+0x0/0x5b returned 0 after 2929 usecs
[ 6.903036] calling wireless_nlevent_init+0x0/0x2f @ 1
[ 6.904035] initcall wireless_nlevent_init+0x0/0x2f returned 0 after 0 usecs
[ 6.905047] calling cfg80211_init+0x0/0x70 @ 1
[ 6.938820] cfg80211: Using static regulatory domain info
[ 6.939201] cfg80211: Regulatory domain: US
[ 6.940024] (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
[ 6.941027] (2402000 KHz - 2472000 KHz @ 40000 KHz), (600 mBi, 2700 mBm)
[ 6.942027] (5170000 KHz - 5190000 KHz @ 40000 KHz), (600 mBi, 2300 mBm)
[ 6.943031] (5190000 KHz - 5210000 KHz @ 40000 KHz), (600 mBi, 2300 mBm)
[ 6.944027] (5210000 KHz - 5230000 KHz @ 40000 KHz), (600 mBi, 2300 mBm)
[ 6.945027] (5230000 KHz - 5330000 KHz @ 40000 KHz), (600 mBi, 2300 mBm)
[ 6.946027] (5735000 KHz - 5835000 KHz @ 40000 KHz), (600 mBi, 3000 mBm)
[ 6.948163] cfg80211: Calling CRDA for country: US
[ 6.960721] initcall cfg80211_init+0x0/0x70 returned 0 after 52734 usecs
[ 6.961129] calling ieee80211_init+0x0/0xa @ 1
[ 6.962066] initcall ieee80211_init+0x0/0xa returned 0 after 0 usecs
[ 6.963034] calling netlbl_init+0x0/0x8a @ 1
[ 6.964025] NetLabel: Initializing
[ 6.965027] NetLabel: domain hash size = 128
[ 6.966022] NetLabel: protocols = UNLABELED CIPSOv4
[ 6.976574] NetLabel: unlabeled traffic allowed by default
[ 6.977047] initcall netlbl_init+0x0/0x8a returned 0 after 12695 usecs
[ 6.978035] calling rfkill_init+0x0/0x77 @ 1
[ 7.003661] initcall rfkill_init+0x0/0x77 returned 0 after 23437 usecs
[ 7.004173] calling sysctl_init+0x0/0x3b @ 1
[ 7.005040] initcall sysctl_init+0x0/0x3b returned 0 after 0 usecs
[ 7.006037] calling pci_iommu_init+0x0/0x11 @ 1
[ 7.007049] initcall pci_iommu_init+0x0/0x11 returned 0 after 0 usecs
[ 7.008053] calling print_all_ICs+0x0/0x565 @ 1
[ 7.009033] initcall print_all_ICs+0x0/0x565 returned 0 after 0 usecs
[ 7.010042] calling clocksource_done_booting+0x0/0x11 @ 1
[ 7.012035] initcall clocksource_done_booting+0x0/0x11 returned 0 after 0 usecs
[ 7.013056] calling rb_init_debugfs+0x0/0x30 @ 1
[ 7.015520] initcall rb_init_debugfs+0x0/0x30 returned 0 after 1636 usecs
[ 7.016396] calling tracer_init_debugfs+0x0/0x2e6 @ 1
[ 7.072981] initcall tracer_init_debugfs+0x0/0x2e6 returned 0 after 53987 usecs
[ 7.074380] calling init_trace_printk_function_export+0x0/0x33 @ 1
[ 7.075518] initcall init_trace_printk_function_export+0x0/0x33 returned 0 after 770 usecs
[ 7.075859] calling event_trace_init+0x0/0x185 @ 1
[ 7.894144] initcall event_trace_init+0x0/0x185 returned 0 after 798126 usecs
[ 7.895391] calling init_pipe_fs+0x0/0x3f @ 1
[ 7.898346] initcall init_pipe_fs+0x0/0x3f returned 0 after 2360 usecs
[ 7.898952] calling eventpoll_init+0x0/0xbb @ 1
[ 7.900446] initcall eventpoll_init+0x0/0xbb returned 0 after 771 usecs
[ 7.901133] calling anon_inode_init+0x0/0xf3 @ 1
[ 7.904708] initcall anon_inode_init+0x0/0xf3 returned 0 after 2716 usecs
[ 7.905591] calling acpi_event_init+0x0/0x6f @ 1
[ 7.910577] initcall acpi_event_init+0x0/0x6f returned 0 after 3112 usecs
[ 7.912442] calling pnpacpi_init+0x0/0x89 @ 1
[ 7.912963] pnp: PnP ACPI init
[ 7.915594] ACPI: bus type pnp registered
[ 9.302456] pnp 00:0d: io resource (0x800-0x85f) overlaps 0000:00:1f.0 BAR 7 (0x800-0x87f), disabling
[ 9.303975] pnp 00:0d: io resource (0x860-0x8ff) overlaps 0000:00:1f.0 BAR 7 (0x800-0x87f), disabling
[ 9.414987] pnp: PnP ACPI: found 14 devices
[ 9.416302] ACPI: ACPI bus type pnp unregistered
[ 9.418017] initcall pnpacpi_init+0x0/0x89 returned 0 after 1469759 usecs
[ 9.418878] calling pnp_system_init+0x0/0x1b @ 1
[ 9.421549] system 00:00: iomem range 0x0-0x9ffff could not be reserved
[ 9.423475] system 00:00: iomem range 0x100000-0xffffff could not be reserved
[ 9.424874] system 00:00: iomem range 0x1000000-0xfeabfff could not be reserved
[ 9.426494] system 00:00: iomem range 0xf0000-0xfffff could not be reserved
[ 9.427760] system 00:00: iomem range 0xffc00000-0xffffffff has been reserved
[ 9.431467] system 00:0d: ioport range 0xc00-0xc7f has been reserved
[ 9.443750] initcall pnp_system_init+0x0/0x1b returned 0 after 23499 usecs
[ 9.444848] calling chr_dev_init+0x0/0xa6 @ 1
[ 9.599950] initcall chr_dev_init+0x0/0xa6 returned 0 after 150925 usecs
[ 9.600922] calling firmware_class_init+0x0/0x77 @ 1
[ 9.613067] initcall firmware_class_init+0x0/0x77 returned 0 after 10725 usecs
[ 9.613507] calling init_pcmcia_bus+0x0/0x72 @ 1
[ 9.627752] initcall init_pcmcia_bus+0x0/0x72 returned 0 after 13112 usecs
[ 9.628720] calling cpufreq_gov_performance_init+0x0/0xf @ 1
[ 9.629557] initcall cpufreq_gov_performance_init+0x0/0xf returned 0 after 10 usecs
[ 9.630285] calling cpufreq_gov_userspace_init+0x0/0xf @ 1
[ 9.631945] initcall cpufreq_gov_userspace_init+0x0/0xf returned 0 after 10 usecs
[ 9.632507] calling init_acpi_pm_clocksource+0x0/0x228 @ 1
[ 9.668713] initcall init_acpi_pm_clocksource+0x0/0x228 returned 0 after 33740 usecs
[ 9.669557] Switched to high resolution mode on CPU 0
[ 9.674707] calling pcibios_assign_resources+0x0/0x7d @ 1
[ 9.684148] pci 0000:00:1e.0: PCI bridge, secondary bus 0000:01
[ 9.690255] pci 0000:00:1e.0: IO window: 0xe000-0xefff
[ 9.695799] pci 0000:00:1e.0: MEM window: 0xfd000000-0xfeffffff
[ 9.702155] pci 0000:00:1e.0: PREFETCH window: 0x00000010000000-0x000000100fffff
[ 9.710291] pci 0000:00:1e.0: setting latency timer to 64
[ 9.715907] pci_bus 0000:00: resource 0 io: [0x00-0xffff]
[ 9.721525] pci_bus 0000:00: resource 1 mem: [0x000000-0xffffffff]
[ 9.727923] pci_bus 0000:01: resource 0 io: [0xe000-0xefff]
[ 9.733732] pci_bus 0000:01: resource 1 mem: [0xfd000000-0xfeffffff]
[ 9.740230] pci_bus 0000:01: resource 2 pref mem [0x10000000-0x100fffff]
[ 9.747058] pci_bus 0000:01: resource 3 io: [0x00-0xffff]
[ 9.752675] pci_bus 0000:01: resource 4 mem: [0x000000-0xffffffff]
[ 9.759022] initcall pcibios_assign_resources+0x0/0x7d returned 0 after 76895 usecs
[ 9.766750] calling sysctl_core_init+0x0/0x30 @ 1
[ 9.779149] initcall sysctl_core_init+0x0/0x30 returned 0 after 7350 usecs
[ 9.786102] calling inet_init+0x0/0x285 @ 1
[ 9.792408] NET: Registered protocol family 2
[ 9.830217] IP route cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 9.994099] TCP established hash table entries: 8192 (order: 4, 65536 bytes)
[ 10.002373] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
[ 10.009265] TCP: Hash tables configured (established 8192 bind 8192)
[ 10.015745] TCP reno registered
[ 10.044847] initcall inet_init+0x0/0x285 returned 0 after 248401 usecs
[ 10.051471] calling af_unix_init+0x0/0x4f @ 1
[ 10.056824] NET: Registered protocol family 1
[ 10.066957] initcall af_unix_init+0x0/0x4f returned 0 after 10700 usecs
[ 10.073680] calling populate_rootfs+0x0/0x262 @ 1
[ 10.090952] initcall populate_rootfs+0x0/0x262 returned 0 after 12074 usecs
[ 10.098017] calling i8259A_init_sysfs+0x0/0x30 @ 1
[ 10.123610] initcall i8259A_init_sysfs+0x0/0x30 returned 0 after 20138 usecs
[ 10.130838] calling sbf_init+0x0/0x102 @ 1
[ 10.135105] initcall sbf_init+0x0/0x102 returned 0 after 2 usecs
[ 10.141187] calling i8237A_init_sysfs+0x0/0x21 @ 1
[ 10.166648] initcall i8237A_init_sysfs+0x0/0x21 returned 0 after 20004 usecs
[ 10.173930] calling add_rtc_cmos+0x0/0xae @ 1
[ 10.178871] initcall add_rtc_cmos+0x0/0xae returned 0 after 405 usecs
[ 10.185408] calling cache_sysfs_init+0x0/0x5d @ 1
[ 10.190279] initcall cache_sysfs_init+0x0/0x5d returned 0 after 1 usecs
[ 10.196971] calling mce_init_device+0x0/0x15b @ 1
[ 10.241631] initcall mce_init_device+0x0/0x15b returned 0 after 38829 usecs
[ 10.248848] calling thermal_throttle_init_device+0x0/0x83 @ 1
[ 10.254764] initcall thermal_throttle_init_device+0x0/0x83 returned 0 after 1 usecs
[ 10.262497] calling threshold_init_device+0x0/0x80 @ 1
[ 10.267804] initcall threshold_init_device+0x0/0x80 returned 0 after 2 usecs
[ 10.274929] calling msr_init+0x0/0x140 @ 1
[ 10.304844] initcall msr_init+0x0/0x140 returned 0 after 25025 usecs
[ 10.311471] calling cpuid_init+0x0/0x140 @ 1
[ 10.342019] initcall cpuid_init+0x0/0x140 returned 0 after 25466 usecs
[ 10.348809] calling ioapic_init_sysfs+0x0/0x95 @ 1
[ 10.363858] initcall ioapic_init_sysfs+0x0/0x95 returned 0 after 9814 usecs
[ 10.371120] calling add_pcspkr+0x0/0x2f @ 1
[ 10.390438] initcall add_pcspkr+0x0/0x2f returned 0 after 14563 usecs
[ 10.397383] calling microcode_init+0x0/0x12d @ 1
[ 10.417151] microcode: CPU0 sig=0x665, pf=0x10, revision=0x3
[ 10.437631] Microcode Update Driver: v2.00 <tigran@aivazian.fsnet.co.uk>, Peter Oruba
[ 10.445763] initcall microcode_init+0x0/0x12d returned 0 after 42536 usecs
[ 10.452729] calling start_periodic_check_for_corruption+0x0/0x40 @ 1
[ 10.459235] Scanning for low memory corruption every 60 seconds
[ 10.465262] initcall start_periodic_check_for_corruption+0x0/0x40 returned 0 after 5877 usecs
[ 10.473867] calling proc_schedstat_init+0x0/0x27 @ 1
[ 10.479700] initcall proc_schedstat_init+0x0/0x27 returned 0 after 684 usecs
[ 10.486826] calling proc_execdomains_init+0x0/0x34 @ 1
[ 10.492734] initcall proc_execdomains_init+0x0/0x34 returned 0 after 594 usecs
[ 10.500060] calling ioresources_init+0x0/0x44 @ 1
[ 10.506313] initcall ioresources_init+0x0/0x44 returned 0 after 1356 usecs
[ 10.513271] calling uid_cache_init+0x0/0x80 @ 1
[ 10.518613] initcall uid_cache_init+0x0/0x80 returned 0 after 630 usecs
[ 10.525307] calling init_posix_timers+0x0/0xb2 @ 1
[ 10.530824] initcall init_posix_timers+0x0/0xb2 returned 0 after 550 usecs
[ 10.537775] calling init_posix_cpu_timers+0x0/0x8d @ 1
[ 10.543080] initcall init_posix_cpu_timers+0x0/0x8d returned 0 after 2 usecs
[ 10.550198] calling nsproxy_cache_init+0x0/0x40 @ 1
[ 10.555575] initcall nsproxy_cache_init+0x0/0x40 returned 0 after 324 usecs
[ 10.562614] calling create_proc_profile+0x0/0x1f0 @ 1
[ 10.567825] initcall create_proc_profile+0x0/0x1f0 returned 0 after 1 usecs
[ 10.574861] calling timekeeping_init_device+0x0/0x21 @ 1
[ 10.602266] initcall timekeeping_init_device+0x0/0x21 returned 0 after 21386 usecs
[ 10.609930] calling init_clocksource_sysfs+0x0/0x45 @ 1
[ 10.636667] khelper used greatest stack depth: 6524 bytes left
[ 10.643803] initcall init_clocksource_sysfs+0x0/0x45 returned 0 after 27792 usecs
[ 10.651375] calling init_timer_list_procfs+0x0/0x30 @ 1
[ 10.657518] initcall init_timer_list_procfs+0x0/0x30 returned 0 after 730 usecs
[ 10.664903] calling init_tstats_procfs+0x0/0x30 @ 1
[ 10.670734] initcall init_tstats_procfs+0x0/0x30 returned 0 after 754 usecs
[ 10.677770] calling futex_init+0x0/0x85 @ 1
[ 10.682153] initcall futex_init+0x0/0x85 returned 0 after 32 usecs
[ 10.688412] calling proc_dma_init+0x0/0x27 @ 1
[ 10.693769] initcall proc_dma_init+0x0/0x27 returned 0 after 729 usecs
[ 10.700369] calling proc_modules_init+0x0/0x27 @ 1
[ 10.706112] initcall proc_modules_init+0x0/0x27 returned 0 after 767 usecs
[ 10.713060] calling kallsyms_init+0x0/0x2a @ 1
[ 10.718439] initcall kallsyms_init+0x0/0x2a returned 0 after 754 usecs
[ 10.725065] calling snapshot_device_init+0x0/0x1c @ 1
[ 10.744861] initcall snapshot_device_init+0x0/0x1c returned 0 after 14209 usecs
[ 10.752409] calling crash_save_vmcoreinfo_init+0x0/0x508 @ 1
[ 10.758346] initcall crash_save_vmcoreinfo_init+0x0/0x508 returned 0 after 109 usecs
[ 10.766178] calling crash_notes_memory_init+0x0/0x37 @ 1
[ 10.771931] initcall crash_notes_memory_init+0x0/0x37 returned 0 after 275 usecs
[ 10.779405] calling pid_namespaces_init+0x0/0x37 @ 1
[ 10.784864] initcall pid_namespaces_init+0x0/0x37 returned 0 after 322 usecs
[ 10.791986] calling audit_init+0x0/0x167 @ 1
[ 10.796415] audit: initializing netlink socket (disabled)
[ 10.803870] type=2000 audit(1245260392.803:1): initialized
[ 10.809589] initcall audit_init+0x0/0x167 returned 0 after 12851 usecs
[ 10.816200] calling audit_tree_init+0x0/0x3d @ 1
[ 10.821105] initcall audit_tree_init+0x0/0x3d returned 0 after 118 usecs
[ 10.827873] calling init_kprobes+0x0/0x132 @ 1
[ 10.872149] initcall init_kprobes+0x0/0x132 returned 0 after 38714 usecs
[ 10.878952] calling utsname_sysctl_init+0x0/0x11 @ 1
[ 10.888416] initcall utsname_sysctl_init+0x0/0x11 returned 0 after 4228 usecs
[ 10.895656] calling init_markers+0x0/0x10 @ 1
[ 10.900182] initcall init_markers+0x0/0x10 returned 0 after 2 usecs
[ 10.906520] calling init_tracepoints+0x0/0x10 @ 1
[ 10.911397] initcall init_tracepoints+0x0/0x10 returned 0 after 2 usecs
[ 10.918082] calling init_events+0x0/0x6d @ 1
[ 10.922525] initcall init_events+0x0/0x6d returned 0 after 8 usecs
[ 10.928784] calling init_sched_switch_trace+0x0/0xf @ 1
[ 10.934179] initcall init_sched_switch_trace+0x0/0xf returned 0 after 6 usecs
[ 10.941391] calling init_blk_tracer+0x0/0x5e @ 1
[ 10.946179] initcall init_blk_tracer+0x0/0x5e returned 0 after 4 usecs
[ 10.952776] calling perf_counter_sysfs_init+0x0/0x14 @ 1
[ 10.959333] initcall perf_counter_sysfs_init+0x0/0x14 returned 0 after 1050 usecs
[ 10.966900] calling init_per_zone_wmark_min+0x0/0x6b @ 1
[ 10.972439] initcall init_per_zone_wmark_min+0x0/0x6b returned 0 after 57 usecs
[ 10.979829] calling pdflush_init+0x0/0x1b @ 1
[ 10.986335] initcall pdflush_init+0x0/0x1b returned 0 after 1902 usecs
[ 10.993109] calling kswapd_init+0x0/0x2b @ 1
[ 10.998985] initcall kswapd_init+0x0/0x2b returned 0 after 1388 usecs
[ 11.005572] calling init_tmpfs+0x0/0xca @ 1
[ 11.021381] initcall init_tmpfs+0x0/0xca returned 0 after 11173 usecs
[ 11.027911] calling setup_vmstat+0x0/0xd4 @ 1
[ 11.035698] initcall setup_vmstat+0x0/0xd4 returned 0 after 3185 usecs
[ 11.042301] calling mm_sysfs_init+0x0/0x22 @ 1
[ 11.047593] initcall mm_sysfs_init+0x0/0x22 returned 0 after 664 usecs
[ 11.054228] calling proc_vmalloc_init+0x0/0x2a @ 1
[ 11.060016] initcall proc_vmalloc_init+0x0/0x2a returned 0 after 802 usecs
[ 11.066972] calling init_emergency_pool+0x0/0x65 @ 1
[ 11.072105] initcall init_emergency_pool+0x0/0x65 returned 0 after 5 usecs
[ 11.079056] calling procswaps_init+0x0/0x2b @ 1
[ 11.084653] initcall procswaps_init+0x0/0x2b returned 0 after 875 usecs
[ 11.091347] calling hugetlb_init+0x0/0x4a6 @ 1
[ 11.095956] HugeTLB registered 4 MB page size, pre-allocated 0 pages
[ 11.105215] initcall hugetlb_init+0x0/0x4a6 returned 0 after 9040 usecs
[ 11.111909] calling slab_proc_init+0x0/0x2a @ 1
[ 11.117538] initcall slab_proc_init+0x0/0x2a returned 0 after 907 usecs
[ 11.124231] calling slab_sysfs_init+0x0/0xc7 @ 1
[ 12.760280] initcall slab_sysfs_init+0x0/0xc7 returned 0 after 1592986 usecs
[ 12.767421] calling fasync_init+0x0/0x3c @ 1
[ 12.776762] initcall fasync_init+0x0/0x3c returned 0 after 4779 usecs
[ 12.783286] calling proc_filesystems_init+0x0/0x27 @ 1
[ 12.789540] initcall proc_filesystems_init+0x0/0x27 returned 0 after 932 usecs
[ 12.796842] calling dnotify_init+0x0/0x83 @ 1
[ 12.810948] initcall dnotify_init+0x0/0x83 returned 0 after 9351 usecs
[ 12.817556] calling inotify_setup+0x0/0x11 @ 1
[ 12.822161] initcall inotify_setup+0x0/0x11 returned 0 after 1 usecs
[ 12.828589] calling inotify_user_setup+0x0/0x100 @ 1
[ 12.846478] initcall inotify_user_setup+0x0/0x100 returned 0 after 12446 usecs
[ 12.853785] calling aio_setup+0x0/0x84 @ 1
[ 12.897433] initcall aio_setup+0x0/0x84 returned 0 after 38421 usecs
[ 12.903884] calling proc_locks_init+0x0/0x27 @ 1
[ 12.909628] initcall proc_locks_init+0x0/0x27 returned 0 after 935 usecs
[ 12.916407] calling init_mbcache+0x0/0x11 @ 1
[ 12.920930] initcall init_mbcache+0x0/0x11 returned 0 after 4 usecs
[ 12.927269] calling dquot_init+0x0/0x105 @ 1
[ 12.931699] VFS: Disk quotas dquot_6.5.2
[ 12.974181] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[ 12.982009] initcall dquot_init+0x0/0x105 returned 0 after 49104 usecs
[ 12.988616] calling init_v2_quota_format+0x0/0x11 @ 1
[ 12.993829] initcall init_v2_quota_format+0x0/0x11 returned 0 after 2 usecs
[ 13.000863] calling proc_cmdline_init+0x0/0x27 @ 1
[ 13.006806] initcall proc_cmdline_init+0x0/0x27 returned 0 after 947 usecs
[ 13.013762] calling proc_cpuinfo_init+0x0/0x27 @ 1
[ 13.019673] initcall proc_cpuinfo_init+0x0/0x27 returned 0 after 935 usecs
[ 13.026630] calling proc_devices_init+0x0/0x27 @ 1
[ 13.032559] initcall proc_devices_init+0x0/0x27 returned 0 after 952 usecs
[ 13.039512] calling proc_interrupts_init+0x0/0x27 @ 1
[ 13.045743] initcall proc_interrupts_init+0x0/0x27 returned 0 after 990 usecs
[ 13.052953] calling proc_loadavg_init+0x0/0x27 @ 1
[ 13.058912] initcall proc_loadavg_init+0x0/0x27 returned 0 after 979 usecs
[ 13.065864] calling proc_meminfo_init+0x0/0x27 @ 1
[ 13.071858] initcall proc_meminfo_init+0x0/0x27 returned 0 after 1013 usecs
[ 13.078896] calling proc_stat_init+0x0/0x27 @ 1
[ 13.084653] initcall proc_stat_init+0x0/0x27 returned 0 after 1034 usecs
[ 13.091432] calling proc_uptime_init+0x0/0x27 @ 1
[ 13.097352] initcall proc_uptime_init+0x0/0x27 returned 0 after 1023 usecs
[ 13.104298] calling proc_version_init+0x0/0x27 @ 1
[ 13.110329] initcall proc_version_init+0x0/0x27 returned 0 after 1047 usecs
[ 13.117366] calling proc_kcore_init+0x0/0x50 @ 1
[ 13.123235] initcall proc_kcore_init+0x0/0x50 returned 0 after 1065 usecs
[ 13.130097] calling vmcore_init+0x0/0xbf6 @ 1
[ 13.134622] initcall vmcore_init+0x0/0xbf6 returned 0 after 2 usecs
[ 13.140962] calling proc_kmsg_init+0x0/0x2a @ 1
[ 13.146775] initcall proc_kmsg_init+0x0/0x2a returned 0 after 1075 usecs
[ 13.153556] calling proc_page_init+0x0/0x4a @ 1
[ 13.160571] initcall proc_page_init+0x0/0x4a returned 0 after 2265 usecs
[ 13.167352] calling init_devpts_fs+0x0/0x3f @ 1
[ 13.174849] initcall init_devpts_fs+0x0/0x3f returned 0 after 2703 usecs
[ 13.181633] calling init_ext3_fs+0x0/0x69 @ 1
[ 13.246630] initcall init_ext3_fs+0x0/0x69 returned 0 after 59037 usecs
[ 13.253493] calling journal_init+0x0/0xa7 @ 1
[ 13.359693] initcall journal_init+0x0/0xa7 returned 0 after 99270 usecs
[ 13.366396] calling init_ramfs_fs+0x0/0xf @ 1
[ 13.370937] initcall init_ramfs_fs+0x0/0xf returned 0 after 15 usecs
[ 13.377367] calling init_hugetlbfs_fs+0x0/0x92 @ 1
[ 13.418497] initcall init_hugetlbfs_fs+0x0/0x92 returned 0 after 35300 usecs
[ 13.425635] calling init_fat_fs+0x0/0x4f @ 1
[ 13.486528] initcall init_fat_fs+0x0/0x4f returned 0 after 55112 usecs
[ 13.493305] calling init_vfat_fs+0x0/0xf @ 1
[ 13.497756] initcall init_vfat_fs+0x0/0xf returned 0 after 16 usecs
[ 13.504097] calling init_msdos_fs+0x0/0xf @ 1
[ 13.508625] initcall init_msdos_fs+0x0/0xf returned 0 after 5 usecs
[ 13.514960] calling init_iso9660_fs+0x0/0x69 @ 1
[ 13.548032] initcall init_iso9660_fs+0x0/0x69 returned 0 after 27608 usecs
[ 13.555207] calling init_nfs_fs+0x0/0x144 @ 1
[ 13.683032] initcall init_nfs_fs+0x0/0x144 returned 0 after 120383 usecs
[ 13.689829] calling init_nlm+0x0/0x1c @ 1
[ 13.699926] initcall init_nlm+0x0/0x1c returned 0 after 5781 usecs
[ 13.706218] calling init_nls_cp437+0x0/0xf @ 1
[ 13.710830] initcall init_nls_cp437+0x0/0xf returned 0 after 3 usecs
[ 13.717261] calling init_nls_ascii+0x0/0xf @ 1
[ 13.721871] initcall init_nls_ascii+0x0/0xf returned 0 after 2 usecs
[ 13.728301] calling init_nls_iso8859_1+0x0/0xf @ 1
[ 13.733273] initcall init_nls_iso8859_1+0x0/0xf returned 0 after 2 usecs
[ 13.740076] calling init_nls_utf8+0x0/0x21 @ 1
[ 13.744690] initcall init_nls_utf8+0x0/0x21 returned 0 after 3 usecs
[ 13.751116] calling init_autofs4_fs+0x0/0x1e @ 1
[ 13.770759] initcall init_autofs4_fs+0x0/0x1e returned 0 after 14491 usecs
[ 13.777866] calling ipc_init+0x0/0x20 @ 1
[ 13.782835] msgmni has been set to 485
[ 13.788289] initcall ipc_init+0x0/0x20 returned 0 after 6072 usecs
[ 13.794548] calling ipc_sysctl_init+0x0/0x11 @ 1
[ 13.806999] initcall ipc_sysctl_init+0x0/0x11 returned 0 after 7486 usecs
[ 13.813861] calling init_mqueue_fs+0x0/0xa3 @ 1
[ 13.862164] initcall init_mqueue_fs+0x0/0xa3 returned 0 after 42555 usecs
[ 13.869067] calling key_proc_init+0x0/0x64 @ 1
[ 13.876138] initcall key_proc_init+0x0/0x64 returned 0 after 2399 usecs
[ 13.882829] calling selinux_nf_ip_init+0x0/0x66 @ 1
[ 13.887864] SELinux: Registering netfilter hooks
[ 13.892649] initcall selinux_nf_ip_init+0x0/0x66 returned 0 after 4665 usecs
[ 13.899767] calling init_sel_fs+0x0/0x60 @ 1
[ 13.965283] initcall init_sel_fs+0x0/0x60 returned 0 after 59621 usecs
[ 13.971907] calling selnl_init+0x0/0x64 @ 1
[ 13.977529] initcall selnl_init+0x0/0x64 returned 0 after 1239 usecs
[ 13.983964] calling sel_netif_init+0x0/0x80 @ 1
[ 13.988709] initcall sel_netif_init+0x0/0x80 returned 0 after 52 usecs
[ 13.995313] calling sel_netnode_init+0x0/0x90 @ 1
[ 14.000236] initcall sel_netnode_init+0x0/0x90 returned 0 after 39 usecs
[ 14.007007] calling sel_netport_init+0x0/0x81 @ 1
[ 14.011909] initcall sel_netport_init+0x0/0x81 returned 0 after 37 usecs
[ 14.018681] calling aurule_init+0x0/0x46 @ 1
[ 14.023142] initcall aurule_init+0x0/0x46 returned 0 after 24 usecs
[ 14.029484] calling crypto_wq_init+0x0/0x3a @ 1
[ 14.035636] initcall crypto_wq_init+0x0/0x3a returned 0 after 1412 usecs
[ 14.042466] calling crypto_algapi_init+0x0/0xc @ 1
[ 14.048661] initcall crypto_algapi_init+0x0/0xc returned 0 after 1202 usecs
[ 14.055703] calling chainiv_module_init+0x0/0xf @ 1
[ 14.060749] initcall chainiv_module_init+0x0/0xf returned 0 after 7 usecs
[ 14.067615] calling eseqiv_module_init+0x0/0xf @ 1
[ 14.072573] initcall eseqiv_module_init+0x0/0xf returned 0 after 3 usecs
[ 14.079348] calling hmac_module_init+0x0/0xf @ 1
[ 14.084132] initcall hmac_module_init+0x0/0xf returned 0 after 3 usecs
[ 14.090732] calling md5_mod_init+0x0/0xf @ 1
[ 14.100612] cryptomgr_test used greatest stack depth: 6508 bytes left
[ 14.107414] initcall md5_mod_init+0x0/0xf returned 0 after 11940 usecs
[ 14.114114] calling sha1_generic_mod_init+0x0/0xf @ 1
[ 14.122747] cryptomgr_test used greatest stack depth: 6324 bytes left
[ 14.129545] initcall sha1_generic_mod_init+0x0/0xf returned 0 after 9958 usecs
[ 14.136901] calling crypto_ecb_module_init+0x0/0xf @ 1
[ 14.142211] initcall crypto_ecb_module_init+0x0/0xf returned 0 after 5 usecs
[ 14.149336] calling crypto_cbc_module_init+0x0/0xf @ 1
[ 14.154641] initcall crypto_cbc_module_init+0x0/0xf returned 0 after 2 usecs
[ 14.161760] calling des_generic_mod_init+0x0/0x35 @ 1
[ 14.184222] initcall des_generic_mod_init+0x0/0x35 returned 0 after 16815 usecs
[ 14.191620] calling aes_init+0x0/0xf @ 1
[ 14.205207] initcall aes_init+0x0/0xf returned 0 after 9257 usecs
[ 14.211383] calling arc4_init+0x0/0xf @ 1
[ 14.284310] initcall arc4_init+0x0/0xf returned 0 after 67121 usecs
[ 14.290741] calling crypto_authenc_module_init+0x0/0xf @ 1
[ 14.296402] initcall crypto_authenc_module_init+0x0/0xf returned 0 after 5 usecs
[ 14.303872] calling krng_mod_init+0x0/0x14 @ 1
[ 14.310035] alg: No test for stdrng (krng)
[ 14.314731] initcall krng_mod_init+0x0/0x14 returned 0 after 6088 usecs
[ 14.321480] calling proc_genhd_init+0x0/0x44 @ 1
[ 14.328752] initcall proc_genhd_init+0x0/0x44 returned 0 after 2425 usecs
[ 14.335621] calling bsg_init+0x0/0x11f @ 1
[ 14.356271] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
[ 14.363781] initcall bsg_init+0x0/0x11f returned 0 after 23317 usecs
[ 14.370214] calling noop_init+0x0/0x11 @ 1
[ 14.374469] io scheduler noop registered
[ 14.378468] initcall noop_init+0x0/0x11 returned 0 after 3900 usecs
[ 14.384812] calling as_init+0x0/0x11 @ 1
[ 14.388894] io scheduler anticipatory registered
[ 14.393590] initcall as_init+0x0/0x11 returned 0 after 4578 usecs
[ 14.399759] calling deadline_init+0x0/0x18 @ 1
[ 14.404355] io scheduler deadline registered
[ 14.408701] initcall deadline_init+0x0/0x18 returned 0 after 4238 usecs
[ 14.415390] calling cfq_init+0x0/0xb0 @ 1
[ 14.461648] io scheduler cfq registered (default)
[ 14.466466] initcall cfq_init+0x0/0xb0 returned 0 after 45788 usecs
[ 14.472813] calling percpu_counter_startup+0x0/0x31 @ 1
[ 14.478227] initcall percpu_counter_startup+0x0/0x31 returned 0 after 14 usecs
[ 14.485520] calling audit_classes_init+0x0/0x51 @ 1
[ 14.491913] initcall audit_classes_init+0x0/0x51 returned 0 after 1317 usecs
[ 14.499070] calling pci_init+0x0/0x3f @ 1
[ 14.505167] pci 0000:00:01.0: Boot video device
[ 14.513588] pci 0000:00:1f.2: uhci_check_and_reset_hc: legsup = 0x2f00
[ 14.520264] pci 0000:00:1f.2: Performing full reset
[ 14.527717] initcall pci_init+0x0/0x3f returned 0 after 23901 usecs
[ 14.534068] calling pci_proc_init+0x0/0x76 @ 1
[ 14.546735] initcall pci_proc_init+0x0/0x76 returned 0 after 7868 usecs
[ 14.553432] calling pcie_portdrv_init+0x0/0x50 @ 1
[ 14.587045] initcall pcie_portdrv_init+0x0/0x50 returned 0 after 27953 usecs
[ 14.594437] calling aer_service_init+0x0/0x21 @ 1
[ 14.610723] initcall aer_service_init+0x0/0x21 returned 0 after 11119 usecs
[ 14.617920] calling pci_hotplug_init+0x0/0x1f @ 1
[ 14.622780] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
[ 14.628427] initcall pci_hotplug_init+0x0/0x1f returned 0 after 5507 usecs
[ 14.635377] calling fb_console_init+0x0/0x12d @ 1
[ 14.655255] initcall fb_console_init+0x0/0x12d returned 0 after 14629 usecs
[ 14.662308] calling genericbl_init+0x0/0x12 @ 1
[ 14.678974] initcall genericbl_init+0x0/0x12 returned 0 after 11655 usecs
[ 14.685973] calling efifb_init+0x0/0x1b3 @ 1
[ 14.690473] initcall efifb_init+0x0/0x1b3 returned -19 after 58 usecs
[ 14.696990] calling acpi_reserve_resources+0x0/0xc8 @ 1
[ 14.702889] initcall acpi_reserve_resources+0x0/0xc8 returned 0 after 500 usecs
[ 14.710304] calling irqrouter_init_sysfs+0x0/0x33 @ 1
[ 14.736930] initcall irqrouter_init_sysfs+0x0/0x33 returned 0 after 20867 usecs
[ 14.744497] calling acpi_ac_init+0x0/0x3d @ 1
[ 14.763952] initcall acpi_ac_init+0x0/0x3d returned 0 after 14544 usecs
[ 14.770772] calling acpi_button_init+0x0/0x4a @ 1
[ 14.810046] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
[ 14.817767] ACPI: Power Button [PWRF]
[ 14.836312] initcall acpi_button_init+0x0/0x4a returned 0 after 59204 usecs
[ 14.843651] calling acpi_fan_init+0x0/0x4a @ 1
[ 14.861669] initcall acpi_fan_init+0x0/0x4a returned 0 after 13052 usecs
[ 14.868608] calling acpi_video_init+0x0/0x6b @ 1
[ 14.888873] initcall acpi_video_init+0x0/0x6b returned 0 after 15078 usecs
[ 14.896010] calling acpi_processor_init+0x0/0xe3 @ 1
[ 14.930413] processor ACPI_CPU:00: registered as cooling_device0
[ 14.957266] initcall acpi_processor_init+0x0/0xe3 returned 0 after 54768 usecs
[ 14.964578] calling acpi_container_init+0x0/0x3d @ 1
[ 15.401524] initcall acpi_container_init+0x0/0x3d returned 0 after 421638 usecs
[ 15.408929] calling acpi_thermal_init+0x0/0x6f @ 1
[ 15.430630] initcall acpi_thermal_init+0x0/0x6f returned 0 after 16312 usecs
[ 15.437906] calling acpi_battery_init+0x0/0x13 @ 1
[ 15.442946] initcall acpi_battery_init+0x0/0x13 returned 0 after 75 usecs
[ 15.449829] calling rand_initialize+0x0/0x30 @ 1
[ 15.454698] initcall rand_initialize+0x0/0x30 returned 0 after 80 usecs
[ 15.461389] calling tty_init+0x0/0x104 @ 1
[ 15.481586] calling 1_acpi_battery_init_async+0x0/0x43 @ 445
[ 15.501572] initcall 1_acpi_battery_init_async+0x0/0x43 returned 0 after 13619 usecs
[ 16.772534] initcall tty_init+0x0/0x104 returned 0 after 1276227 usecs
[ 16.779152] calling pty_init+0x0/0x372 @ 1
[ 16.806526] initcall pty_init+0x0/0x372 returned 0 after 22546 usecs
[ 16.813299] calling sysrq_init+0x0/0x2a @ 1
[ 16.818974] initcall sysrq_init+0x0/0x2a returned 0 after 1291 usecs
[ 16.825410] calling hpet_init+0x0/0x57 @ 1
[ 16.862612] initcall hpet_init+0x0/0x57 returned 0 after 32148 usecs
[ 16.869194] calling nvram_init+0x0/0x7f @ 1
[ 16.890517] Non-volatile memory driver v1.3
[ 16.894812] initcall nvram_init+0x0/0x7f returned 0 after 20753 usecs
[ 16.901324] calling mod_init+0x0/0x98 @ 1
[ 16.907507] initcall mod_init+0x0/0x98 returned -19 after 1958 usecs
[ 16.913929] calling mod_init+0x0/0x4b @ 1
[ 16.918100] initcall mod_init+0x0/0x4b returned -19 after 1 usecs
[ 16.924266] calling agp_init+0x0/0x31 @ 1
[ 16.928430] Linux agpgart interface v0.103
[ 16.932602] initcall agp_init+0x0/0x31 returned 0 after 4069 usecs
[ 16.938849] calling agp_intel_init+0x0/0x27 @ 1
[ 16.945976] agpgart-intel 0000:00:00.0: Intel i810 Chipset
[ 17.111436] pci 0000:00:01.0: detected 4MB dedicated video ram
[ 17.186492] agpgart-intel 0000:00:00.0: AGP aperture is 64M @ 0xf8000000
[ 17.208566] initcall agp_intel_init+0x0/0x27 returned 0 after 258789 usecs
[ 17.215533] calling drm_core_init+0x0/0x125 @ 1
[ 17.233517] [drm] Initialized drm 1.1.0 20060810
[ 17.238253] initcall drm_core_init+0x0/0x125 returned 0 after 17586 usecs
[ 17.245116] calling i915_init+0x0/0x48 @ 1
[ 17.264808] initcall i915_init+0x0/0x48 returned 0 after 15044 usecs
[ 17.271251] calling cn_proc_init+0x0/0x37 @ 1
[ 17.275965] initcall cn_proc_init+0x0/0x37 returned 0 after 184 usecs
[ 17.282480] calling serial8250_init+0x0/0x13b @ 1
[ 17.287346] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[ 17.321539] async_waiting @ 1
[ 17.324595] async_continuing @ 1 after 2 usec
[ 17.452703] async_waiting @ 1
[ 17.455744] async_continuing @ 1 after 1 usec
ÿ[ 17.584828] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[ 17.611664] async_waiting @ 1
[ 17.614942] async_continuing @ 1 after 2 usec
[ 17.743700] async_waiting @ 1
[ 17.746742] async_continuing @ 1 after 2 usec
[ 17.875870] serial8250: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A
[ 17.945267] Platform driver 'serial8250' needs updating - please use dev_pm_ops
[ 17.965639] initcall serial8250_init+0x0/0x13b returned 0 after 662366 usecs
[ 17.972940] calling serial8250_pnp_init+0x0/0xf @ 1
[ 18.020445] 00:0a: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[ 18.069388] 00:0b: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A
[ 18.110490] initcall serial8250_pnp_init+0x0/0xf returned 0 after 129378 usecs
[ 18.117926] calling serial8250_pci_init+0x0/0x16 @ 1
[ 18.143766] initcall serial8250_pci_init+0x0/0x16 returned 0 after 20203 usecs
[ 18.151095] calling topology_sysfs_init+0x0/0x57 @ 1
[ 18.158486] initcall topology_sysfs_init+0x0/0x57 returned 0 after 2206 usecs
[ 18.165709] calling brd_init+0x0/0x188 @ 1
[ 19.001734] brd: module loaded
[ 19.004914] initcall brd_init+0x0/0x188 returned 0 after 815350 usecs
[ 19.011431] calling loop_init+0x0/0x1a3 @ 1
[ 19.439876] loop: module loaded
[ 19.443137] initcall loop_init+0x0/0x1a3 returned 0 after 417322 usecs
[ 19.449742] calling mac_hid_init+0x0/0x75 @ 1
[ 19.482944] input: Macintosh mouse button emulation as /devices/virtual/input/input1
[ 19.496468] initcall mac_hid_init+0x0/0x75 returned 0 after 41196 usecs
[ 19.503168] calling spi_transport_init+0x0/0x34 @ 1
[ 19.530210] initcall spi_transport_init+0x0/0x34 returned 0 after 21469 usecs
[ 19.537429] calling init_sd+0x0/0xe5 @ 1
[ 19.552790] Driver 'sd' needs updating - please use bus_type methods
[ 19.570566] initcall init_sd+0x0/0xe5 returned 0 after 28348 usecs
[ 19.577000] calling init_sr+0x0/0x4b @ 1
[ 19.581111] Driver 'sr' needs updating - please use bus_type methods
[ 19.598748] initcall init_sr+0x0/0x4b returned 0 after 17224 usecs
[ 19.605208] calling init_sg+0x0/0x150 @ 1
[ 19.624851] initcall init_sg+0x0/0x150 returned 0 after 15086 usecs
[ 19.631204] calling ahci_init+0x0/0x16 @ 1
[ 19.653989] initcall ahci_init+0x0/0x16 returned 0 after 18071 usecs
[ 19.660774] calling piix_init+0x0/0x24 @ 1
[ 19.668807] ata_piix 0000:00:1f.1: version 2.13
[ 19.676674] ata_piix 0000:00:1f.1: setting latency timer to 64
[ 19.686744] scsi0 : ata_piix
[ 19.740888] scsi1 : ata_piix
[ 19.779261] ata1: PATA max UDMA/66 cmd 0x1f0 ctl 0x3f6 bmdma 0xffa0 irq 14
[ 19.786242] ata2: PATA max UDMA/66 cmd 0x170 ctl 0x376 bmdma 0xffa8 irq 15
[ 19.807557] calling 2_async_port_probe+0x0/0xc0 @ 598
[ 19.814619] calling 3_async_port_probe+0x0/0xc0 @ 600
[ 19.821528] initcall piix_init+0x0/0x24 returned 0 after 152774 usecs
[ 19.828075] calling amd_init+0x0/0x16 @ 1
[ 19.846482] initcall amd_init+0x0/0x16 returned 0 after 13874 usecs
[ 19.852837] calling oldpiix_init+0x0/0x16 @ 1
[ 19.871659] initcall oldpiix_init+0x0/0x16 returned 0 after 13936 usecs
[ 19.878366] calling sch_init+0x0/0x22 @ 1
[ 19.896648] initcall sch_init+0x0/0x22 returned 0 after 13751 usecs
[ 19.903000] calling e1000_init_module+0x0/0x80 @ 1
[ 19.907956] Intel(R) PRO/1000 Network Driver - version 7.3.21-k3-NAPI
[ 19.914463] Copyright (c) 1999-2006 Intel Corporation.
[ 19.936423] initcall e1000_init_module+0x0/0x80 returned 0 after 27769 usecs
[ 19.943568] calling vortex_init+0x0/0xaa @ 1
[ 20.021992] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 5
[ 20.027762] PCI: setting IRQ 5 as level-triggered
[ 20.032667] 3c59x 0000:01:0c.0: PCI INT A -> Link[LNKC] -> GSI 5 (level, low) -> IRQ 5
[ 20.041142] 3c59x: Donald Becker and others.
[ 20.047609] 0000:01:0c.0: 3Com PCI 3c905C Tornado at d06c6c00.
[ 20.243712] ata2.00: ATAPI: TOSHIBA DVD-ROM SD-C2402, 1009, max UDMA/33
[ 20.251975] ata1.00: ATA-6: Maxtor 30768H1, BAC51KJ0, max UDMA/100
[ 20.258320] ata1.00: 15007104 sectors, multi 8: LBA
[ 20.265707] initcall vortex_init+0x0/0xaa returned 0 after 310234 usecs
[ 20.272429] calling e100_init_module+0x0/0x5c @ 1
[ 20.277295] e100: Intel(R) PRO/100 Network Driver, 3.5.24-k2-NAPI
[ 20.283456] e100: Copyright(c) 1999-2006 Intel Corporation
[ 20.304376] ata2.00: configured for UDMA/33
[ 20.309861] async_waiting @ 600
[ 20.313313] ata1.00: configured for UDMA/66
[ 20.317888] async_waiting @ 598
[ 20.321189] async_continuing @ 598 after 7 usec
[ 20.361033] scsi 0:0:0:0: Direct-Access ATA Maxtor 30768H1 BAC5 PQ: 0 ANSI: 5
[ 20.473758] calling 4_sd_probe_async+0x0/0x1b0 @ 611
[ 20.486202] sd 0:0:0:0: [sda] 15007104 512-byte hardware sectors: (7.68 GB/7.15 GiB)
[ 20.497546] sd 0:0:0:0: [sda] Write Protect is off
[ 20.502512] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
[ 20.514324] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 20.552887] sda:
[ 20.573823] sd 0:0:0:0: Attached scsi generic sg0 type 0
[ 20.603504] initcall e100_init_module+0x0/0x5c returned 0 after 318528 usecs
[ 20.612100] calling tg3_init+0x0/0x16 @ 1
[ 20.638224] sda1 sda2 <initcall 2_async_port_probe+0x0/0xc0 returned 0 after 816280 usecs
[ 20.654956] async_continuing @ 600 after 333807 usec
[ 20.671970] initcall tg3_init+0x0/0x16 returned 0 after 54357 usecs
[ 20.679712] calling sky2_init_module+0x0/0x34 @ 1
[ 20.684583] sky2 driver version 1.22
[ 20.701870] sda5 >
[ 20.750489] scsi 1:0:0:0: CD-ROM TOSHIBA DVD-ROM SD-C2402 1009 PQ: 0 ANSI: 5
[ 20.923627] sr0: scsi3-mmc drive: 24x/24x cd/rw xa/form2 cdda tray
[ 20.930160] Uniform CD-ROM driver Revision: 3.20
[ 21.014339] initcall sky2_init_module+0x0/0x34 returned 0 after 321993 usecs
[ 21.021484] calling net_olddevs_init+0x0/0x86 @ 1
[ 21.026430] initcall net_olddevs_init+0x0/0x86 returned 0 after 74 usecs
[ 21.033206] calling init_nic+0x0/0x16 @ 1
[ 21.067349] sr 1:0:0:0: Attached scsi CD-ROM sr0
[ 21.141570] sd 0:0:0:0: [sda] Attached SCSI disk
[ 21.146313] initcall 4_sd_probe_async+0x0/0x1b0 returned 0 after 651635 usecs
[ 21.156696] sr 1:0:0:0: Attached scsi generic sg1 type 5
[ 21.185032] initcall 3_async_port_probe+0x0/0xc0 returned 0 after 1333083 usecs
[ 21.193291] initcall init_nic+0x0/0x16 returned 0 after 152238 usecs
[ 21.199732] calling rtl8139_init_module+0x0/0x16 @ 1
[ 21.218932] initcall rtl8139_init_module+0x0/0x16 returned 0 after 13711 usecs
[ 21.226424] calling init_ath5k_pci+0x0/0x42 @ 1
[ 21.247383] initcall init_ath5k_pci+0x0/0x42 returned 0 after 15855 usecs
[ 21.254263] calling init_netconsole+0x0/0x210 @ 1
[ 21.259166] console [netcon0] enabled
[ 21.262893] netconsole: network logging started
[ 21.267495] initcall init_netconsole+0x0/0x210 returned 0 after 8164 usecs
[ 21.274445] calling cdrom_init+0x0/0x5b @ 1
[ 21.278796] initcall cdrom_init+0x0/0x5b returned 0 after 2 usecs
[ 21.284963] calling nonstatic_sysfs_init+0x0/0xf @ 1
[ 21.290132] initcall nonstatic_sysfs_init+0x0/0xf returned 0 after 45 usecs
[ 21.297163] calling yenta_socket_init+0x0/0x16 @ 1
[ 21.318567] initcall yenta_socket_init+0x0/0x16 returned 0 after 16044 usecs
[ 21.325713] calling mon_init+0x0/0xed @ 1
[ 21.360245] initcall mon_init+0x0/0xed returned 0 after 29620 usecs
[ 21.366614] calling ehci_hcd_init+0x0/0xe3 @ 1
[ 21.371216] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 21.377815] ehci_hcd: block sizes: qh 128 qtd 96 itd 160 sitd 96
[ 21.399718] initcall ehci_hcd_init+0x0/0xe3 returned 0 after 27803 usecs
[ 21.406515] calling ohci_hcd_mod_init+0x0/0xb3 @ 1
[ 21.411465] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[ 21.417708] ohci_hcd: block sizes: ed 64 td 64
[ 21.436796] initcall ohci_hcd_mod_init+0x0/0xb3 returned 0 after 24710 usecs
[ 21.443941] calling uhci_hcd_init+0x0/0x140 @ 1
[ 21.448632] uhci_hcd: USB Universal Host Controller Interface driver
[ 21.534879] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11
[ 21.540735] PCI: setting IRQ 11 as level-triggered
[ 21.545726] uhci_hcd 0000:00:1f.2: PCI INT D -> Link[LNKD] -> GSI 11 (level, low) -> IRQ 11
[ 21.555152] uhci_hcd 0000:00:1f.2: setting latency timer to 64
[ 21.561166] uhci_hcd 0000:00:1f.2: UHCI Host Controller
[ 21.593614] uhci_hcd 0000:00:1f.2: new USB bus registered, assigned bus number 1
[ 21.602584] uhci_hcd 0000:00:1f.2: detected 2 ports
[ 21.607651] uhci_hcd 0000:00:1f.2: uhci_check_and_reset_hc: cmd = 0x0000
[ 21.614500] uhci_hcd 0000:00:1f.2: Performing full reset
[ 21.620033] uhci_hcd 0000:00:1f.2: supports USB remote wakeup
[ 21.626665] uhci_hcd 0000:00:1f.2: irq 11, io base 0x0000ff80
[ 21.649217] usb usb1: default language 0x0409
[ 21.656007] usb usb1: udev 1, busnum 1, minor = 0
[ 21.660849] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001
[ 21.667751] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 21.675245] usb usb1: Product: UHCI Host Controller
[ 21.680363] usb usb1: Manufacturer: Linux 2.6.30 uhci_hcd
[ 21.685944] usb usb1: SerialNumber: 0000:00:1f.2
[ 21.716802] usb usb1: uevent
[ 21.726432] async/0 used greatest stack depth: 6192 bytes left
[ 21.735148] usb usb1: usb_probe_device
[ 21.739113] usb usb1: configuration #1 chosen from 1 choice
[ 21.745911] usb usb1: adding 1-0:1.0 (config #1, interface 0)
[ 21.762568] usb 1-0:1.0: uevent
[ 21.774904] hub 1-0:1.0: usb_probe_interface
[ 21.779338] hub 1-0:1.0: usb_probe_interface - got id
[ 21.784581] hub 1-0:1.0: USB hub found
[ 21.790919] hub 1-0:1.0: 2 ports detected
[ 21.795117] hub 1-0:1.0: standalone hub
[ 21.799099] hub 1-0:1.0: no power switching (usb 1.0)
[ 21.804273] hub 1-0:1.0: individual port over-current protection
[ 21.810435] hub 1-0:1.0: power on to power good time: 2ms
[ 21.816915] hub 1-0:1.0: local power source is good
[ 21.822164] hub 1-0:1.0: trying to enable port power on non-switchable hub
[ 21.855726] initcall uhci_hcd_init+0x0/0x140 returned 0 after 397514 usecs
[ 21.862695] calling usblp_init+0x0/0x16 @ 1
[ 21.880299] usbcore: registered new interface driver usblp
[ 21.886568] initcall usblp_init+0x0/0x16 returned 0 after 19023 usecs
[ 21.893102] calling usb_stor_init+0x0/0x4a @ 1
[ 21.897701] Initializing USB Mass Storage driver...
[ 21.918839] usbcore: registered new interface driver usb-storage
[ 21.925469] USB Mass Storage support registered.
[ 21.930276] initcall usb_stor_init+0x0/0x4a returned 0 after 31785 usecs
[ 21.937081] calling usb_usual_init+0x0/0x3e @ 1
[ 21.958457] hub 1-0:1.0: state 7 ports 2 chg 0000 evt 0000
[ 21.967395] usbcore: registered new interface driver libusual
[ 21.973718] initcall usb_usual_init+0x0/0x3e returned 0 after 31177 usecs
[ 21.980593] calling i8042_init+0x0/0x3f5 @ 1
[ 22.014609] PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
[ 22.022390] Platform driver 'i8042' needs updating - please use dev_pm_ops
[ 22.060281] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 22.065618] serio: i8042 AUX port at 0x60,0x64 irq 12
[ 22.071214] initcall i8042_init+0x0/0x3f5 returned 0 after 84119 usecs
[ 22.077818] calling serport_init+0x0/0x3b @ 1
[ 22.082345] initcall serport_init+0x0/0x3b returned 0 after 5 usecs
[ 22.088683] calling mousedev_init+0x0/0x5a @ 1
[ 22.161177] async/2 used greatest stack depth: 6060 bytes left
[ 22.168561] mice: PS/2 mouse device common for all mice
[ 22.174360] initcall mousedev_init+0x0/0x5a returned 0 after 79146 usecs
[ 22.181157] calling evdev_init+0x0/0xf @ 1
[ 22.205506] async/1 used greatest stack depth: 6020 bytes left
[ 22.231447] initcall evdev_init+0x0/0xf returned 0 after 44918 usecs
[ 22.237900] calling atkbd_init+0x0/0x20 @ 1
[ 22.255302] initcall atkbd_init+0x0/0x20 returned 0 after 12722 usecs
[ 22.261842] calling psmouse_init+0x0/0x74 @ 1
[ 22.287805] initcall psmouse_init+0x0/0x74 returned 0 after 20913 usecs
[ 22.294738] calling cmos_init+0x0/0x3f @ 1
[ 22.330601] rtc_cmos 00:06: rtc core: registered rtc_cmos as rtc0
[ 22.338006] rtc0: alarms up to one day, 242 bytes nvram
[ 22.355283] initcall cmos_init+0x0/0x3f returned 0 after 54935 usecs
[ 22.361738] calling i2c_i801_init+0x0/0x16 @ 1
[ 22.439411] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 10
[ 22.445262] PCI: setting IRQ 10 as level-triggered
[ 22.450245] i801_smbus 0000:00:1f.3: PCI INT B -> Link[LNKB] -> GSI 10 (level, low) -> IRQ 10
[ 22.459556] i801_smbus 0000:00:1f.3: Enabling SMBus device
[ 22.500876] initcall i2c_i801_init+0x0/0x16 returned 0 after 131219 usecs
[ 22.507768] calling dm_init+0x0/0x42 @ 1
[ 22.592727] device-mapper: ioctl: 4.14.0-ioctl (2008-04-23) initialised: dm-devel@redhat.com
[ 22.601421] initcall dm_init+0x0/0x42 returned 0 after 87443 usecs
[ 22.607685] calling dm_mirror_init+0x0/0x78 @ 1
[ 22.618870] initcall dm_mirror_init+0x0/0x78 returned 0 after 6321 usecs
[ 22.625653] calling dm_dirty_log_init+0x0/0x53 @ 1
[ 22.630609] initcall dm_dirty_log_init+0x0/0x53 returned 0 after 3 usecs
[ 22.637381] calling dm_zero_init+0x0/0x31 @ 1
[ 22.641909] initcall dm_zero_init+0x0/0x31 returned 0 after 3 usecs
[ 22.648248] calling cpufreq_gov_dbs_init+0x0/0x93 @ 1
[ 22.655350] initcall cpufreq_gov_dbs_init+0x0/0x93 returned 0 after 1827 usecs
[ 22.662659] calling init_ladder+0x0/0xf @ 1
[ 22.667006] cpuidle: using governor ladder
[ 22.671188] initcall init_ladder+0x0/0xf returned 0 after 4081 usecs
[ 22.677614] calling init_menu+0x0/0xf @ 1
[ 22.681785] cpuidle: using governor menu
[ 22.685787] initcall init_menu+0x0/0xf returned 0 after 3901 usecs
[ 22.692081] calling efivars_init+0x0/0x1ee @ 1
[ 22.696690] initcall efivars_init+0x0/0x1ee returned -19 after 1 usecs
[ 22.703288] calling hid_init+0x0/0x42 @ 1
[ 22.730648] initcall hid_init+0x0/0x42 returned 0 after 22257 usecs
[ 22.737222] calling a4_init+0x0/0x20 @ 1
[ 22.753963] initcall a4_init+0x0/0x20 returned 0 after 12319 usecs
[ 22.760372] calling apple_init+0x0/0x40 @ 1
[ 22.778396] initcall apple_init+0x0/0x40 returned 0 after 13323 usecs
[ 22.784935] calling belkin_init+0x0/0x20 @ 1
[ 22.801911] initcall belkin_init+0x0/0x20 returned 0 after 12208 usecs
[ 22.808690] calling ch_init+0x0/0x20 @ 1
[ 22.825510] initcall ch_init+0x0/0x20 returned 0 after 12401 usecs
[ 22.831789] calling ch_init+0x0/0x20 @ 1
[ 22.848611] initcall ch_init+0x0/0x20 returned 0 after 12403 usecs
[ 22.855243] calling cp_init+0x0/0x20 @ 1
[ 22.871901] initcall cp_init+0x0/0x20 returned 0 after 12235 usecs
[ 22.878328] calling dr_init+0x0/0x16 @ 1
[ 22.895456] initcall dr_init+0x0/0x16 returned 0 after 12706 usecs
[ 22.901752] calling ez_init+0x0/0x20 @ 1
[ 22.918607] initcall ez_init+0x0/0x20 returned 0 after 12433 usecs
[ 22.924891] calling gyration_init+0x0/0x20 @ 1
[ 22.942717] initcall gyration_init+0x0/0x20 returned 0 after 12876 usecs
[ 22.949786] calling ks_init+0x0/0x20 @ 1
[ 22.954405] usb usb1: suspend_rh (auto-stop)
[ 22.971893] initcall ks_init+0x0/0x20 returned 0 after 17557 usecs
[ 22.978306] calling kye_init+0x0/0x20 @ 1
[ 22.996523] initcall kye_init+0x0/0x20 returned 0 after 13675 usecs
[ 23.002883] calling lg_init+0x0/0x20 @ 1
[ 23.019989] initcall lg_init+0x0/0x20 returned 0 after 12680 usecs
[ 23.026437] calling ms_init+0x0/0x20 @ 1
[ 23.043644] initcall ms_init+0x0/0x20 returned 0 after 12776 usecs
[ 23.050317] calling mr_init+0x0/0x20 @ 1
[ 23.067447] initcall mr_init+0x0/0x20 returned 0 after 12693 usecs
[ 23.073723] calling ntrig_init+0x0/0x20 @ 1
[ 23.090913] initcall ntrig_init+0x0/0x20 returned 0 after 12509 usecs
[ 23.097601] calling pl_init+0x0/0x20 @ 1
[ 23.114977] initcall pl_init+0x0/0x20 returned 0 after 12924 usecs
[ 23.121414] calling pl_init+0x0/0x20 @ 1
[ 23.138663] initcall pl_init+0x0/0x20 returned 0 after 12807 usecs
[ 23.145278] calling samsung_init+0x0/0x20 @ 1
[ 23.162927] initcall samsung_init+0x0/0x20 returned 0 after 12779 usecs
[ 23.169775] calling sjoy_init+0x0/0x20 @ 1
[ 23.187475] initcall sjoy_init+0x0/0x20 returned 0 after 13056 usecs
[ 23.193925] calling sony_init+0x0/0x20 @ 1
[ 23.211464] initcall sony_init+0x0/0x20 returned 0 after 12929 usecs
[ 23.217911] calling sp_init+0x0/0x20 @ 1
[ 23.235437] initcall sp_init+0x0/0x20 returned 0 after 13081 usecs
[ 23.241725] calling ga_init+0x0/0x21 @ 1
[ 23.259414] initcall ga_init+0x0/0x21 returned 0 after 13258 usecs
[ 23.265715] calling tm_init+0x0/0x20 @ 1
[ 23.283526] initcall tm_init+0x0/0x20 returned 0 after 13362 usecs
[ 23.289801] calling ts_init+0x0/0x20 @ 1
[ 23.307434] initcall ts_init+0x0/0x20 returned 0 after 13209 usecs
[ 23.313708] calling zp_init+0x0/0x20 @ 1
[ 23.331394] initcall zp_init+0x0/0x20 returned 0 after 13263 usecs
[ 23.337685] calling hid_init+0x0/0xc2 @ 1
[ 23.373354] usbcore: registered new interface driver hiddev
[ 23.392738] usbcore: registered new interface driver usbhid
[ 23.398904] usbhid: v2.6:USB HID core driver
[ 23.403285] initcall hid_init+0x0/0xc2 returned 0 after 59967 usecs
[ 23.409630] calling eeepc_laptop_init+0x0/0x200 @ 1
[ 23.439803] initcall eeepc_laptop_init+0x0/0x200 returned -19 after 24515 usecs
[ 23.447365] calling init_soundcore+0x0/0x70 @ 1
[ 23.462999] initcall init_soundcore+0x0/0x70 returned 0 after 10656 usecs
[ 23.469996] calling alsa_sound_init+0x0/0x81 @ 1
[ 23.481074] Advanced Linux Sound Architecture Driver Version 1.0.20.
[ 23.487514] initcall alsa_sound_init+0x0/0x81 returned 0 after 12427 usecs
[ 23.494473] calling alsa_hwdep_init+0x0/0x4c @ 1
[ 23.499958] initcall alsa_hwdep_init+0x0/0x4c returned 0 after 688 usecs
[ 23.506740] calling alsa_timer_init+0x0/0x205 @ 1
[ 23.530746] initcall alsa_timer_init+0x0/0x205 returned 0 after 18664 usecs
[ 23.537803] calling snd_hrtimer_init+0x0/0x151 @ 1
[ 23.543428] initcall snd_hrtimer_init+0x0/0x151 returned 0 after 650 usecs
[ 23.550375] calling alsa_pcm_init+0x0/0x4f @ 1
[ 23.555936] initcall alsa_pcm_init+0x0/0x4f returned 0 after 922 usecs
[ 23.562548] calling snd_mem_init+0x0/0x2f @ 1
[ 23.567868] initcall snd_mem_init+0x0/0x2f returned 0 after 780 usecs
[ 23.574392] calling alsa_mixer_oss_init+0x0/0x2f @ 1
[ 23.579533] initcall alsa_mixer_oss_init+0x0/0x2f returned 0 after 2 usecs
[ 23.586480] calling alsa_pcm_oss_init+0x0/0x8d @ 1
[ 23.591436] initcall alsa_pcm_oss_init+0x0/0x8d returned 0 after 5 usecs
[ 23.598217] calling alsa_seq_oss_init+0x0/0x16d @ 1
[ 23.646876] initcall alsa_seq_oss_init+0x0/0x16d returned 0 after 42571 usecs
[ 23.654112] calling alsa_seq_init+0x0/0x60 @ 1
[ 23.679622] initcall alsa_seq_init+0x0/0x60 returned 0 after 20391 usecs
[ 23.686419] calling alsa_seq_device_init+0x0/0x50 @ 1
[ 23.692421] initcall alsa_seq_device_init+0x0/0x50 returned 0 after 761 usecs
[ 23.699636] calling alsa_seq_midi_event_init+0x0/0x7 @ 1
[ 23.705146] initcall alsa_seq_midi_event_init+0x0/0x7 returned 0 after 1 usecs
[ 23.712444] calling alsa_seq_dummy_init+0x0/0xc7 @ 1
[ 23.718569] initcall alsa_seq_dummy_init+0x0/0xc7 returned 0 after 972 usecs
[ 23.725691] calling patch_realtek_init+0x0/0xf @ 1
[ 23.730649] initcall patch_realtek_init+0x0/0xf returned 0 after 2 usecs
[ 23.737424] calling patch_cmedia_init+0x0/0xf @ 1
[ 23.742296] initcall patch_cmedia_init+0x0/0xf returned 0 after 2 usecs
[ 23.748983] calling patch_analog_init+0x0/0xf @ 1
[ 23.753853] initcall patch_analog_init+0x0/0xf returned 0 after 2 usecs
[ 23.760542] calling patch_sigmatel_init+0x0/0xf @ 1
[ 23.765589] initcall patch_sigmatel_init+0x0/0xf returned 0 after 2 usecs
[ 23.772449] calling patch_si3054_init+0x0/0xf @ 1
[ 23.777321] initcall patch_si3054_init+0x0/0xf returned 0 after 2 usecs
[ 23.784008] calling patch_atihdmi_init+0x0/0xf @ 1
[ 23.788965] initcall patch_atihdmi_init+0x0/0xf returned 0 after 1 usecs
[ 23.795740] calling patch_ca0110_init+0x0/0xf @ 1
[ 23.800612] initcall patch_ca0110_init+0x0/0xf returned 0 after 2 usecs
[ 23.807301] calling patch_conexant_init+0x0/0xf @ 1
[ 23.812344] initcall patch_conexant_init+0x0/0xf returned 0 after 2 usecs
[ 23.819206] calling patch_via_init+0x0/0xf @ 1
[ 23.823832] initcall patch_via_init+0x0/0xf returned 0 after 2 usecs
[ 23.830263] calling patch_nvhdmi_init+0x0/0xf @ 1
[ 23.835134] initcall patch_nvhdmi_init+0x0/0xf returned 0 after 2 usecs
[ 23.841823] calling patch_intelhdmi_init+0x0/0xf @ 1
[ 23.846955] initcall patch_intelhdmi_init+0x0/0xf returned 0 after 2 usecs
[ 23.853900] calling alsa_card_azx_init+0x0/0x23 @ 1
[ 23.876844] initcall alsa_card_azx_init+0x0/0x23 returned 0 after 17448 usecs
[ 23.884077] calling alsa_sound_last_init+0x0/0x70 @ 1
[ 23.889282] ALSA device list:
[ 23.892320] No soundcards found.
[ 23.895797] initcall alsa_sound_last_init+0x0/0x70 returned 0 after 6352 usecs
[ 23.903094] calling flow_cache_init+0x0/0x164 @ 1
[ 23.914578] initcall flow_cache_init+0x0/0x164 returned 0 after 6448 usecs
[ 23.921540] calling llc_init+0x0/0x1b @ 1
[ 23.925724] initcall llc_init+0x0/0x1b returned 0 after 6 usecs
[ 23.931712] calling snap_init+0x0/0x37 @ 1
[ 23.936101] initcall snap_init+0x0/0x37 returned 0 after 131 usecs
[ 23.942352] calling rif_init+0x0/0x70 @ 1
[ 23.952612] initcall rif_init+0x0/0x70 returned 0 after 5940 usecs
[ 23.958878] calling blackhole_module_init+0x0/0xf @ 1
[ 23.964092] initcall blackhole_module_init+0x0/0xf returned 0 after 3 usecs
[ 23.971122] calling nfnetlink_init+0x0/0x75 @ 1
[ 23.975803] Netfilter messages via NETLINK v0.30.
[ 23.981800] initcall nfnetlink_init+0x0/0x75 returned 0 after 5848 usecs
[ 23.988574] calling nfnetlink_log_init+0x0/0xca @ 1
[ 23.994133] initcall nfnetlink_log_init+0x0/0xca returned 0 after 503 usecs
[ 24.001168] calling nf_conntrack_standalone_init+0x0/0xf @ 1
[ 24.006989] nf_conntrack version 0.5.0 (4074 buckets, 16296 max)
[ 24.123408] initcall nf_conntrack_standalone_init+0x0/0xf returned 0 after 113663 usecs
[ 24.131496] calling ctnetlink_init+0x0/0x6b @ 1
[ 24.136183] ctnetlink v0.93: registering with nfnetlink.
[ 24.141571] initcall ctnetlink_init+0x0/0x6b returned 0 after 5255 usecs
[ 24.148344] calling nf_conntrack_ftp_init+0x0/0x1c3 @ 1
[ 24.153753] initcall nf_conntrack_ftp_init+0x0/0x1c3 returned 0 after 19 usecs
[ 24.161075] calling nf_conntrack_irc_init+0x0/0x196 @ 1
[ 24.166475] initcall nf_conntrack_irc_init+0x0/0x196 returned 0 after 11 usecs
[ 24.173772] calling nf_conntrack_sip_init+0x0/0x16e @ 1
[ 24.179164] initcall nf_conntrack_sip_init+0x0/0x16e returned 0 after 7 usecs
[ 24.186367] calling xt_init+0x0/0x108 @ 1
[ 24.190967] initcall xt_init+0x0/0x108 returned 0 after 418 usecs
[ 24.197142] calling tcpudp_mt_init+0x0/0x14 @ 1
[ 24.201964] initcall tcpudp_mt_init+0x0/0x14 returned 0 after 125 usecs
[ 24.208654] calling connsecmark_tg_init+0x0/0xf @ 1
[ 24.213724] initcall connsecmark_tg_init+0x0/0xf returned 0 after 25 usecs
[ 24.220671] calling mark_tg_init+0x0/0x14 @ 1
[ 24.225248] initcall mark_tg_init+0x0/0x14 returned 0 after 60 usecs
[ 24.231676] calling nflog_tg_init+0x0/0xf @ 1
[ 24.236227] initcall nflog_tg_init+0x0/0xf returned 0 after 21 usecs
[ 24.242654] calling secmark_tg_init+0x0/0xf @ 1
[ 24.247367] initcall secmark_tg_init+0x0/0xf returned 0 after 22 usecs
[ 24.253965] calling tcpmss_tg_init+0x0/0x14 @ 1
[ 24.258711] initcall tcpmss_tg_init+0x0/0x14 returned 0 after 47 usecs
[ 24.265307] calling conntrack_mt_init+0x0/0x14 @ 1
[ 24.270309] initcall conntrack_mt_init+0x0/0x14 returned 0 after 44 usecs
[ 24.277169] calling mark_mt_init+0x0/0x14 @ 1
[ 24.281727] initcall mark_mt_init+0x0/0x14 returned 0 after 41 usecs
[ 24.288158] calling policy_mt_init+0x0/0x14 @ 1
[ 24.292895] initcall policy_mt_init+0x0/0x14 returned 0 after 41 usecs
[ 24.299490] calling state_mt_init+0x0/0x18 @ 1
[ 24.304134] initcall state_mt_init+0x0/0x18 returned 0 after 41 usecs
[ 24.310645] calling sysctl_ipv4_init+0x0/0x41 @ 1
[ 24.499662] initcall sysctl_ipv4_init+0x0/0x41 returned 0 after 179821 usecs
[ 24.506797] calling init_syncookies+0x0/0x16 @ 1
[ 24.511759] initcall init_syncookies+0x0/0x16 returned 0 after 180 usecs
[ 24.518532] calling tunnel4_init+0x0/0x6e @ 1
[ 24.523060] initcall tunnel4_init+0x0/0x6e returned 0 after 4 usecs
[ 24.529418] calling ipv4_netfilter_init+0x0/0x10 @ 1
[ 24.534551] initcall ipv4_netfilter_init+0x0/0x10 returned 0 after 4 usecs
[ 24.541505] calling nf_conntrack_l3proto_ipv4_init+0x0/0x13a @ 1
[ 24.686414] initcall nf_conntrack_l3proto_ipv4_init+0x0/0x13a returned 0 after 135451 usecs
[ 24.694848] calling nf_nat_init+0x0/0xf4 @ 1
[ 24.699372] initcall nf_nat_init+0x0/0xf4 returned 0 after 83 usecs
[ 24.705847] calling nf_defrag_init+0x0/0x14 @ 1
[ 24.710553] initcall nf_defrag_init+0x0/0x14 returned 0 after 3 usecs
[ 24.717069] calling nf_nat_ftp_init+0x0/0x1e @ 1
[ 24.721854] initcall nf_nat_ftp_init+0x0/0x1e returned 0 after 1 usecs
[ 24.728468] calling nf_nat_irc_init+0x0/0x1e @ 1
[ 24.733248] initcall nf_nat_irc_init+0x0/0x1e returned 0 after 1 usecs
[ 24.739849] calling nf_nat_sip_init+0x0/0x93 @ 1
[ 24.744636] initcall nf_nat_sip_init+0x0/0x93 returned 0 after 2 usecs
[ 24.751235] calling ip_tables_init+0x0/0xa0 @ 1
[ 24.759242] ip_tables: (C) 2000-2006 Netfilter Core Team
[ 24.764638] initcall ip_tables_init+0x0/0xa0 returned 0 after 8497 usecs
[ 24.771411] calling iptable_filter_init+0x0/0x6a @ 1
[ 24.778268] initcall iptable_filter_init+0x0/0x6a returned 0 after 1686 usecs
[ 24.785482] calling iptable_mangle_init+0x0/0x46 @ 1
[ 24.793101] initcall iptable_mangle_init+0x0/0x46 returned 0 after 2426 usecs
[ 24.800309] calling nf_nat_standalone_init+0x0/0x82 @ 1
[ 24.807490] initcall nf_nat_standalone_init+0x0/0x82 returned 0 after 1745 usecs
[ 24.814960] calling log_tg_init+0x0/0x24 @ 1
[ 24.819424] initcall log_tg_init+0x0/0x24 returned 0 after 24 usecs
[ 24.825765] calling masquerade_tg_init+0x0/0x2d @ 1
[ 24.830869] initcall masquerade_tg_init+0x0/0x2d returned 0 after 58 usecs
[ 24.837820] calling reject_tg_init+0x0/0xf @ 1
[ 24.842454] initcall reject_tg_init+0x0/0xf returned 0 after 22 usecs
[ 24.848972] calling ulog_tg_init+0x0/0xd1 @ 1
[ 24.854794] initcall ulog_tg_init+0x0/0xd1 returned 0 after 1263 usecs
[ 24.861400] calling cubictcp_register+0x0/0x88 @ 1
[ 24.866351] TCP cubic registered
[ 24.869653] initcall cubictcp_register+0x0/0x88 returned 0 after 3219 usecs
[ 24.876691] calling xfrm_user_init+0x0/0x47 @ 1
[ 24.881380] Initializing XFRM netlink socket
[ 24.886963] initcall xfrm_user_init+0x0/0x47 returned 0 after 5440 usecs
[ 24.893739] calling inet6_init+0x0/0x2c0 @ 1
[ 24.926936] hub 1-0:1.0: hub_suspend
[ 24.930911] usb usb1: bus auto-suspend
[ 24.934792] usb usb1: suspend_rh
[ 25.074865] NET: Registered protocol family 10
[ 25.928431] initcall inet6_init+0x0/0x2c0 returned 0 after 1006077 usecs
[ 25.935226] calling ah6_init+0x0/0x67 @ 1
[ 25.939409] initcall ah6_init+0x0/0x67 returned 0 after 5 usecs
[ 25.945401] calling esp6_init+0x0/0x67 @ 1
[ 25.949668] initcall esp6_init+0x0/0x67 returned 0 after 3 usecs
[ 25.955747] calling xfrm6_transport_init+0x0/0x14 @ 1
[ 25.960967] initcall xfrm6_transport_init+0x0/0x14 returned 0 after 3 usecs
[ 25.967999] calling xfrm6_mode_tunnel_init+0x0/0x14 @ 1
[ 25.973393] initcall xfrm6_mode_tunnel_init+0x0/0x14 returned 0 after 2 usecs
[ 25.980599] calling xfrm6_beet_init+0x0/0x1c @ 1
[ 25.985385] initcall xfrm6_beet_init+0x0/0x1c returned 0 after 2 usecs
[ 25.991984] calling ip6_tables_init+0x0/0xa0 @ 1
[ 26.001185] ip6_tables: (C) 2000-2006 Netfilter Core Team
[ 26.006670] initcall ip6_tables_init+0x0/0xa0 returned 0 after 9667 usecs
[ 26.013535] calling ip6table_filter_init+0x0/0x6a @ 1
[ 26.021932] initcall ip6table_filter_init+0x0/0x6a returned 0 after 3098 usecs
[ 26.029231] calling ip6table_mangle_init+0x0/0x46 @ 1
[ 26.038984] initcall ip6table_mangle_init+0x0/0x46 returned 0 after 4427 usecs
[ 26.046298] calling nf_conntrack_l3proto_ipv6_init+0x0/0x10a @ 1
[ 26.075911] initcall nf_conntrack_l3proto_ipv6_init+0x0/0x10a returned 0 after 22883 usecs
[ 26.084262] calling ipv6header_mt6_init+0x0/0xf @ 1
[ 26.089331] initcall ipv6header_mt6_init+0x0/0xf returned 0 after 22 usecs
[ 26.096282] calling log_tg6_init+0x0/0x24 @ 1
[ 26.100830] initcall log_tg6_init+0x0/0x24 returned 0 after 25 usecs
[ 26.107260] calling reject_tg6_init+0x0/0xf @ 1
[ 26.111979] initcall reject_tg6_init+0x0/0xf returned 0 after 22 usecs
[ 26.118585] calling sit_init+0x0/0x67 @ 1
[ 26.122764] IPv6 over IPv4 tunneling driver
[ 26.661532] initcall sit_init+0x0/0x67 returned 0 after 526090 usecs
[ 26.667980] calling packet_init+0x0/0x3d @ 1
[ 26.672414] NET: Registered protocol family 17
[ 26.678349] initcall packet_init+0x0/0x3d returned 0 after 5786 usecs
[ 26.684871] calling init_sunrpc+0x0/0x6a @ 1
[ 26.774099] RPC: Registered udp transport module.
[ 26.778893] RPC: Registered tcp transport module.
[ 26.783700] initcall init_sunrpc+0x0/0x6a returned 0 after 92163 usecs
[ 26.790306] calling init_rpcsec_gss+0x0/0x41 @ 1
[ 26.797885] initcall init_rpcsec_gss+0x0/0x41 returned 0 after 2722 usecs
[ 26.804756] calling init_kerberos_module+0x0/0x2d @ 1
[ 26.810527] initcall init_kerberos_module+0x0/0x2d returned 0 after 540 usecs
[ 26.817749] calling severities_debugfs_init+0x0/0x5b @ 1
[ 26.824892] initcall severities_debugfs_init+0x0/0x5b returned 0 after 1621 usecs
[ 26.832460] calling acpi_cpufreq_init+0x0/0x127 @ 1
[ 26.839636] initcall acpi_cpufreq_init+0x0/0x127 returned -19 after 2077 usecs
[ 26.846937] calling update_mp_table+0x0/0x67d @ 1
[ 26.851811] initcall update_mp_table+0x0/0x67d returned 0 after 1 usecs
[ 26.858499] calling lapic_insert_resource+0x0/0x35 @ 1
[ 26.863805] initcall lapic_insert_resource+0x0/0x35 returned -1 after 1 usecs
[ 26.871011] initcall lapic_insert_resource+0x0/0x35 returned with error code -1
[ 26.878481] calling print_ipi_mode+0x0/0x2f @ 1
[ 26.883170] Using IPI No-Shortcut mode
[ 26.886995] initcall print_ipi_mode+0x0/0x2f returned 0 after 3727 usecs
[ 26.893774] calling init_lapic_nmi_sysfs+0x0/0x33 @ 1
[ 26.898994] initcall init_lapic_nmi_sysfs+0x0/0x33 returned 0 after 1 usecs
[ 26.906055] calling ioapic_insert_resources+0x0/0x5e @ 1
[ 26.911532] initcall ioapic_insert_resources+0x0/0x5e returned 0 after 2 usecs
[ 26.918824] calling io_apic_bug_finalize+0x0/0x1a @ 1
[ 26.924071] initcall io_apic_bug_finalize+0x0/0x1a returned 0 after 1 usecs
[ 26.931106] calling check_early_ioremap_leak+0x0/0x73 @ 1
[ 26.936668] initcall check_early_ioremap_leak+0x0/0x73 returned 0 after 2 usecs
[ 26.944074] calling pat_memtype_list_init+0x0/0x2e @ 1
[ 26.951648] initcall pat_memtype_list_init+0x0/0x2e returned 0 after 2210 usecs
[ 26.959068] calling init_oops_id+0x0/0x50 @ 1
[ 26.963616] initcall init_oops_id+0x0/0x50 returned 0 after 25 usecs
[ 26.970086] calling disable_boot_consoles+0x0/0x3e @ 1
[ 26.975394] initcall disable_boot_consoles+0x0/0x3e returned 0 after 1 usecs
[ 26.982514] calling pm_qos_power_init+0x0/0xca @ 1
[ 27.040862] initcall pm_qos_power_init+0x0/0xca returned 0 after 52113 usecs
[ 27.048276] calling software_resume+0x0/0x1e0 @ 1
[ 27.053145] PM: Resume from disk failed.
[ 27.057150] initcall software_resume+0x0/0x1e0 returned -2 after 3903 usecs
[ 27.064186] initcall software_resume+0x0/0x1e0 returned with error code -2
[ 27.071247] calling debugfs_kprobe_init+0x0/0x90 @ 1
[ 27.078852] initcall debugfs_kprobe_init+0x0/0x90 returned 0 after 2407 usecs
[ 27.086078] calling taskstats_init+0x0/0x86 @ 1
[ 27.091951] registered taskstats version 1
[ 27.096132] initcall taskstats_init+0x0/0x86 returned 0 after 5233 usecs
[ 27.102911] calling clear_boot_tracer+0x0/0x2f @ 1
[ 27.107869] initcall clear_boot_tracer+0x0/0x2f returned 0 after 1 usecs
[ 27.114650] calling max_swapfiles_check+0x0/0x7 @ 1
[ 27.119697] initcall max_swapfiles_check+0x0/0x7 returned 0 after 1 usecs
[ 27.126565] calling random32_reseed+0x0/0x85 @ 1
[ 27.131387] initcall random32_reseed+0x0/0x85 returned 0 after 37 usecs
[ 27.138075] calling pci_resource_alignment_sysfs_init+0x0/0x14 @ 1
[ 27.144804] initcall pci_resource_alignment_sysfs_init+0x0/0x14 returned 0 after 374 usecs
[ 27.153146] calling pci_sysfs_init+0x0/0x4a @ 1
[ 27.178380] initcall pci_sysfs_init+0x0/0x4a returned 0 after 20047 usecs
[ 27.185253] calling seqgen_init+0x0/0xe @ 1
[ 27.189685] initcall seqgen_init+0x0/0xe returned 0 after 86 usecs
[ 27.195953] calling late_resume_init+0x0/0x190 @ 1
[ 27.200899] Magic number: 13:213:694
[ 27.212478] initcall late_resume_init+0x0/0x190 returned 0 after 11286 usecs
[ 27.219625] calling scsi_complete_async_scans+0x0/0x150 @ 1
[ 27.225363] initcall scsi_complete_async_scans+0x0/0x150 returned 0 after 2 usecs
[ 27.232936] calling memmap_init+0x0/0xaa @ 1
[ 27.243811] initcall memmap_init+0x0/0xaa returned 0 after 6291 usecs
[ 27.250343] calling pci_mmcfg_late_insert_resources+0x0/0x136 @ 1
[ 27.256600] initcall pci_mmcfg_late_insert_resources+0x0/0x136 returned 1 after 2 usecs
[ 27.264674] initcall pci_mmcfg_late_insert_resources+0x0/0x136 returned with error code 1
[ 27.273013] calling tcp_congestion_default+0x0/0xf @ 1
[ 27.278327] initcall tcp_congestion_default+0x0/0xf returned 0 after 4 usecs
[ 27.285451] calling ip_auto_config+0x0/0x1083 @ 1
[ 27.291649] initcall ip_auto_config+0x0/0x1083 returned 0 after 1293 usecs
[ 27.298601] calling initialize_hashrnd+0x0/0x16 @ 1
[ 27.303662] initcall initialize_hashrnd+0x0/0x16 returned 0 after 21 usecs
[ 27.311791] async_waiting @ 1
[ 27.314847] async_continuing @ 1 after 2 usec
[ 27.321847] md: Waiting for all devices to be available before autodetect
[ 27.328712] md: If you don't use raid, use raid=noautodetect
[ 27.334435] async_waiting @ 1
[ 27.337478] async_continuing @ 1 after 1 usec
[ 27.407452] md: Autodetecting RAID arrays.
[ 27.411648] md: Scanned 0 and added 0 devices.
[ 27.416153] md: autorun ...
[ 27.419012] md: ... autorun DONE.
[ 27.573419] kjournald starting. Commit interval 5 seconds
[ 27.580428] EXT3-fs: mounted filesystem with writeback data mode.
[ 27.587556] VFS: Mounted root (ext3 filesystem) readonly on device 8:1.
[ 27.595379] async_waiting @ 1
[ 27.598432] async_continuing @ 1 after 2 usec
[ 27.603005] Freeing unused kernel memory: 424k freed
[ 27.611301] Write protecting the kernel text: 5480k
[ 27.616526] Write protecting the kernel read-only data: 1872k
[ 27.717874] spurious 8259A interrupt: IRQ7.
[ 30.641840] SELinux: 4096 avtab hash slots, 13762 rules.
[ 31.371747] SELinux: 4096 avtab hash slots, 13762 rules.
[ 31.718107] SELinux: 3 users, 7 roles, 856 types, 73 bools, 1 sens, 1024 cats
[ 31.725558] SELinux: 58 classes, 13762 rules
[ 32.310575] SELinux: class dccp_socket not defined in policy
[ 32.316431] SELinux: class memprotect not defined in policy
[ 32.322156] SELinux: class peer not defined in policy
[ 32.327362] SELinux: class capability2 not defined in policy
[ 32.333177] SELinux: class kernel_service not defined in policy
[ 32.343980] SELinux: permission open in class dir not defined in policy
[ 32.351772] SELinux: permission open in class file not defined in policy
[ 32.359884] SELinux: permission open in class chr_file not defined in policy
[ 32.367327] SELinux: permission open in class blk_file not defined in policy
[ 32.374818] SELinux: permission open in class sock_file not defined in policy
[ 32.382369] SELinux: permission open in class fifo_file not defined in policy
[ 32.394468] SELinux: permission dccp_recv in class node not defined in policy
[ 32.401938] SELinux: permission dccp_send in class node not defined in policy
[ 32.409408] SELinux: permission recvfrom in class node not defined in policy
[ 32.416788] SELinux: permission sendto in class node not defined in policy
[ 32.425664] SELinux: permission dccp_recv in class netif not defined in policy
[ 32.433255] SELinux: permission dccp_send in class netif not defined in policy
[ 32.440823] SELinux: permission ingress in class netif not defined in policy
[ 32.448259] SELinux: permission egress in class netif not defined in policy
[ 32.468469] SELinux: permission setsockcreate in class process not defined in policy
[ 32.493740] SELinux: permission setfcap in class capability not defined in policy
[ 32.508668] SELinux: permission nlmsg_tty_audit in class netlink_audit_socket not defined in policy
[ 32.521513] SELinux: permission flow_in in class packet not defined in policy
[ 32.529025] SELinux: permission flow_out in class packet not defined in policy
[ 32.536615] SELinux: permission forward_in in class packet not defined in policy
[ 32.544379] SELinux: permission forward_out in class packet not defined in policy
[ 32.620661] SELinux: the above unknown classes and permissions will be denied
[ 32.627866] SELinux: Completing initialization.
[ 32.632548] SELinux: Setting up existing superblocks.
[ 32.638267] SELinux: initialized (dev sda1, type ext3), uses xattr
[ 32.650779] SELinux: initialized (dev selinuxfs, type selinuxfs), uses genfs_contexts
[ 32.667345] SELinux: initialized (dev mqueue, type mqueue), uses transition SIDs
[ 32.679014] SELinux: initialized (dev hugetlbfs, type hugetlbfs), uses genfs_contexts
[ 32.689830] SELinux: initialized (dev devpts, type devpts), uses transition SIDs
[ 32.701654] SELinux: initialized (dev inotifyfs, type inotifyfs), uses genfs_contexts
[ 32.710957] SELinux: initialized (dev tmpfs, type tmpfs), uses transition SIDs
[ 32.719690] SELinux: initialized (dev anon_inodefs, type anon_inodefs), not configured for labeling
[ 32.729383] SELinux: initialized (dev pipefs, type pipefs), uses task SIDs
[ 32.739655] SELinux: initialized (dev debugfs, type debugfs), uses genfs_contexts
[ 32.797965] SELinux: initialized (dev sockfs, type sockfs), uses task SIDs
[ 32.809372] SELinux: initialized (dev proc, type proc), uses genfs_contexts
[ 32.820938] SELinux: initialized (dev bdev, type bdev), uses genfs_contexts
[ 32.831670] SELinux: initialized (dev rootfs, type rootfs), uses genfs_contexts
[ 32.843258] SELinux: initialized (dev sysfs, type sysfs), uses genfs_contexts
[ 34.292035] type=1403 audit(1245260416.291:2): policy loaded auid=4294967295 ses=4294967295
INIT: version 2.86 booting
[ 36.178458] stty used greatest stack depth: 5624 bytes left
[ 39.597875] SELinux: initialized (dev tmpfs, type tmpfs), uses transition SIDs
[ 39.623259] mount used greatest stack depth: 5024 bytes left
[ 42.622565] SELinux: initialized (dev tmpfs, type tmpfs), uses transition SIDs
Starting the hotplug events dispatcher: udevd[ 52.989922] udevd used greatest stack depth: 4900 bytes left
.
Synthesizing the initial hotplug events...[ 62.992458] usb usb1: uevent
[ 63.055844] usb 1-0:1.0: uevent
done.
Waiting for /dev to be fully populated...
^ permalink raw reply [flat|nested] 6+ messages in thread
* Re: WARNING: at arch/x86/kernel/apic/apic.c:249 native_apic_write_dummy
2009-06-17 15:46 ` Vegard Nossum
@ 2009-06-17 15:53 ` Cyrill Gorcunov
2009-06-17 16:33 ` Vegard Nossum
0 siblings, 1 reply; 6+ messages in thread
From: Cyrill Gorcunov @ 2009-06-17 15:53 UTC (permalink / raw)
To: Vegard Nossum; +Cc: Ingo Molnar, LKML, Yinghai Lu
[Vegard Nossum - Wed, Jun 17, 2009 at 05:46:18PM +0200]
| 2009/6/17 Cyrill Gorcunov <gorcunov@gmail.com>:
| > [Vegard Nossum - Wed, Jun 17, 2009 at 05:11:20PM +0200]
| > | Hi,
| > |
| > | I just saw this warning on latest mainline when shutting down a box:
| [...]
|
| > Thanks Vegard, will take a look.
|
| I've attached full boot log (it's a different boot though).
|
|
| Vegard
...
Vegard, could you test the patch?
-- Cyrill
---
If we have apic disabled we don't even switch to APIC mode and do not
calling for connect_bsp_APIC. Though on SMP compiled kernel the
native_machine_shutdown does try to write the apic register anyway.
Fix it with explicit check if we really should touch apic registers.
Reported-by: Vegard Nossum <vegard.nossum@gmail.com>
Signed-off-by: Cyrill Gorcunov <gorcunov@openvz.org>
---
arch/x86/kernel/apic/io_apic.c | 4 +++-
1 file changed, 3 insertions(+), 1 deletion(-)
Index: linux-2.6.git/arch/x86/kernel/apic/io_apic.c
=====================================================================
--- linux-2.6.git.orig/arch/x86/kernel/apic/io_apic.c
+++ linux-2.6.git/arch/x86/kernel/apic/io_apic.c
@@ -2003,7 +2003,9 @@ void disable_IO_APIC(void)
/*
* Use virtual wire A mode when interrupt remapping is enabled.
*/
- disconnect_bsp_APIC(!intr_remapping_enabled && ioapic_i8259.pin != -1);
+ if (cpu_has_apic)
+ disconnect_bsp_APIC(!intr_remapping_enabled &&
+ ioapic_i8259.pin != -1);
}
#ifdef CONFIG_X86_32
^ permalink raw reply [flat|nested] 6+ messages in thread
* Re: WARNING: at arch/x86/kernel/apic/apic.c:249 native_apic_write_dummy
2009-06-17 15:53 ` Cyrill Gorcunov
@ 2009-06-17 16:33 ` Vegard Nossum
2009-06-17 16:37 ` Cyrill Gorcunov
0 siblings, 1 reply; 6+ messages in thread
From: Vegard Nossum @ 2009-06-17 16:33 UTC (permalink / raw)
To: Cyrill Gorcunov; +Cc: Ingo Molnar, LKML, Yinghai Lu
2009/6/17 Cyrill Gorcunov <gorcunov@gmail.com>:
> Vegard, could you test the patch?
>
> -- Cyrill
> ---
>
> If we have apic disabled we don't even switch to APIC mode and do not
> calling for connect_bsp_APIC. Though on SMP compiled kernel the
> native_machine_shutdown does try to write the apic register anyway.
> Fix it with explicit check if we really should touch apic registers.
>
> Reported-by: Vegard Nossum <vegard.nossum@gmail.com>
> Signed-off-by: Cyrill Gorcunov <gorcunov@openvz.org>
> ---
> arch/x86/kernel/apic/io_apic.c | 4 +++-
> 1 file changed, 3 insertions(+), 1 deletion(-)
>
> Index: linux-2.6.git/arch/x86/kernel/apic/io_apic.c
> =====================================================================
> --- linux-2.6.git.orig/arch/x86/kernel/apic/io_apic.c
> +++ linux-2.6.git/arch/x86/kernel/apic/io_apic.c
> @@ -2003,7 +2003,9 @@ void disable_IO_APIC(void)
> /*
> * Use virtual wire A mode when interrupt remapping is enabled.
> */
> - disconnect_bsp_APIC(!intr_remapping_enabled && ioapic_i8259.pin != -1);
> + if (cpu_has_apic)
> + disconnect_bsp_APIC(!intr_remapping_enabled &&
> + ioapic_i8259.pin != -1);
> }
>
> #ifdef CONFIG_X86_32
>
Seems to work here:
[ 317.596743] ACPI: Preparing to enter system sleep state S5
[ 317.633421] Disabling non-boot CPUs ...
[ 317.637493] Power down.
[ 317.638305] acpi_power_off called
and no warning.
Thanks!
Vegard
--
"The animistic metaphor of the bug that maliciously sneaked in while
the programmer was not looking is intellectually dishonest as it
disguises that the error is the programmer's own creation."
-- E. W. Dijkstra, EWD1036
^ permalink raw reply [flat|nested] 6+ messages in thread
* Re: WARNING: at arch/x86/kernel/apic/apic.c:249 native_apic_write_dummy
2009-06-17 16:33 ` Vegard Nossum
@ 2009-06-17 16:37 ` Cyrill Gorcunov
0 siblings, 0 replies; 6+ messages in thread
From: Cyrill Gorcunov @ 2009-06-17 16:37 UTC (permalink / raw)
To: Vegard Nossum; +Cc: Ingo Molnar, LKML, Yinghai Lu
[Vegard Nossum - Wed, Jun 17, 2009 at 06:33:31PM +0200]
| 2009/6/17 Cyrill Gorcunov <gorcunov@gmail.com>:
| > Vegard, could you test the patch?
| >
| > -- Cyrill
| > ---
| >
| > If we have apic disabled we don't even switch to APIC mode and do not
| > calling for connect_bsp_APIC. Though on SMP compiled kernel the
| > native_machine_shutdown does try to write the apic register anyway.
| > Fix it with explicit check if we really should touch apic registers.
| >
| > Reported-by: Vegard Nossum <vegard.nossum@gmail.com>
| > Signed-off-by: Cyrill Gorcunov <gorcunov@openvz.org>
| > ---
| > arch/x86/kernel/apic/io_apic.c | 4 +++-
| > 1 file changed, 3 insertions(+), 1 deletion(-)
| >
| > Index: linux-2.6.git/arch/x86/kernel/apic/io_apic.c
| > =====================================================================
| > --- linux-2.6.git.orig/arch/x86/kernel/apic/io_apic.c
| > +++ linux-2.6.git/arch/x86/kernel/apic/io_apic.c
| > @@ -2003,7 +2003,9 @@ void disable_IO_APIC(void)
| > /*
| > * Use virtual wire A mode when interrupt remapping is enabled.
| > */
| > - disconnect_bsp_APIC(!intr_remapping_enabled && ioapic_i8259.pin != -1);
| > + if (cpu_has_apic)
| > + disconnect_bsp_APIC(!intr_remapping_enabled &&
| > + ioapic_i8259.pin != -1);
| > }
| >
| > #ifdef CONFIG_X86_32
| >
|
| Seems to work here:
|
| [ 317.596743] ACPI: Preparing to enter system sleep state S5
| [ 317.633421] Disabling non-boot CPUs ...
| [ 317.637493] Power down.
| [ 317.638305] acpi_power_off called
|
| and no warning.
|
| Thanks!
|
|
| Vegard
|
Thanks for testing Vegard! I'll recheck again and send
properly formed patch a bit later.
-- Cyrill
^ permalink raw reply [flat|nested] 6+ messages in thread
end of thread, other threads:[~2009-06-17 16:38 UTC | newest]
Thread overview: 6+ messages (download: mbox.gz follow: Atom feed
-- links below jump to the message on this page --
2009-06-17 15:11 WARNING: at arch/x86/kernel/apic/apic.c:249 native_apic_write_dummy Vegard Nossum
2009-06-17 15:14 ` Cyrill Gorcunov
2009-06-17 15:46 ` Vegard Nossum
2009-06-17 15:53 ` Cyrill Gorcunov
2009-06-17 16:33 ` Vegard Nossum
2009-06-17 16:37 ` Cyrill Gorcunov
This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox