All of lore.kernel.org
 help / color / mirror / Atom feed
* Nested KVM
@ 2008-12-23  2:55 Todd Deshane
  2008-12-23  6:26 ` Todd Deshane
  2008-12-23  9:00 ` Alexander Graf
  0 siblings, 2 replies; 15+ messages in thread
From: Todd Deshane @ 2008-12-23  2:55 UTC (permalink / raw)
  To: kvm

I have successfully built the latest kvm, kvm-userspace from git.

I loaded the kvm_amd module with the nested=1 option.

The kvm guest that I am working with has an older version
of kvm (Ubuntu 8.10 + kvm package) and during boot I get:

[   23.673107] Modules linked in: kvm_amd(+) kvm ppdev cpufreq_stats
cpufreq_powersave cpufreq_userspace cpufreq_conservative
cpufreq_ondemand freq_table container pci_slot wmi video output sbs
sbshc battery
 ipv6 iptable_filter ip_tables x_tables ac lp virtio_balloon
virtio_net serio_raw psmouse pcspkr evdev joydev i2c_piix4 i2c_core
parport_pc parport button ext3 jbd mbcache usbhid hid sr_mod cdrom sg
virtio_b
lk pata_acpi ata_piix ata_generic uhci_hcd virtio_pci virtio_ring
virtio usbcore libata scsi_mod dock thermal processor fan fbcon
tileblit font bitblit softcursor fuse
[   23.673107] Pid: 4278, comm: modprobe Tainted: G S        2.6.27-7-generic #1
[   23.673107] RIP: 0010:[<ffffffff8022d35a>]  [<ffffffff8022d35a>]
native_write_msr_safe+0xa/0x10
[   23.673107] RSP: 0018:ffff880018dc3dd8  EFLAGS: 00010002
[   23.673107] RAX: 0000000000001d01 RBX: ffff880018dc3e04 RCX: 00000000c0000080
[   23.673107] RDX: 0000000000000000 RSI: 0000000000001d01 RDI: 00000000c0000080
[   23.673107] RBP: ffff880018dc3dd8 R08: 0000000000000000 R09: ffffffff806e1e20
[   23.673107] R10: ffff880018dc3dfc R11: ffff880018dc3df8 R12: ffff880018c096c0
[   23.673107] R13: ffffffffa02b25e0 R14: ffffffffa02e1c80 R15: 00000000c0000080
[   23.673107] FS:  00007f2f14f946e0(0000) GS:ffffffff806e1a80(0000)
knlGS:0000000000000000
[   23.673107] CS:  0010 DS: 0000 ES: 0000 CR0: 000000008005003b
[   23.673107] CR2: 00007f2f14fa8000 CR3: 0000000018d4f000 CR4: 00000000000006e0
[   23.673107] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[   23.673107] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
[   23.673107] Process modprobe (pid: 4278, threadinfo
ffff880018dc2000, task ffff8800190f1670)
[   23.673107] Stack:  ffff880018dc3e38 ffffffffa02db196
88000100b000007f 000000000000ffff
[   23.673107]  0000000000000000 0000000000000010 0000000000000000
0000000000000000
[   23.673107]  0000000000000000 ffffffffa02b25e0 ffffffffa02e1c80
00007f2f14f9a000
[   23.673107] Call Trace:
[   23.673107]  [<ffffffffa02db196>] svm_hardware_enable+0xd6/0x140 [kvm_amd]
[   23.673107]  [<ffffffffa02b25e0>] ? hardware_enable+0x0/0x40 [kvm]
[   23.673107]  [<ffffffffa02b4693>] kvm_arch_hardware_enable+0x13/0x20 [kvm]
[   23.673107]  [<ffffffffa02b260f>] hardware_enable+0x2f/0x40 [kvm]
[   23.673107]  [<ffffffff80254a44>] on_each_cpu+0x34/0x50
[   23.673107]  [<ffffffffa02b0c85>] kvm_init+0x165/0x280 [kvm]
[   23.673107]  [<ffffffffa00b3000>] ? svm_init+0x0/0x23 [kvm_amd]
[   23.673107]  [<ffffffffa00b3021>] svm_init+0x21/0x23 [kvm_amd]
[   23.673107]  [<ffffffff8020a041>] do_one_initcall+0x41/0x170
[   23.673107]  [<ffffffff8026c261>] ? __blocking_notifier_call_chain+0x21/0x90
[   23.673107]  [<ffffffff8027d085>] sys_init_module+0xb5/0x1f0
[   23.673107]  [<ffffffff8021285a>] system_call_fastpath+0x16/0x1b
[   23.673107]
[   23.673107]
[   23.673107] Code: 00 55 89 f9 48 89 e5 0f 32 31 c9 89 c7 48 89 d0
89 0e 48 c1 e0 20 89 fa 48 09 d0 c9 c3 0f 1f 40 00 55 89 f9 89 f0 48
89 e5 0f 30 <31> c0 c9 c3 66 90 55 89 f9 48 89 e5 0f 33 89 c1 48 89 d0
48 c1
[   23.673107] RIP  [<ffffffff8022d35a>] native_write_msr_safe+0xa/0x10
[   23.673107]  RSP <ffff880018dc3dd8>
[   23.673107] ---[ end trace 0dc989f1cf9a296e ]---

Maybe it is just that a newer version of KVM is needed?

I will also try to build a newer version of KVM and test.

Thanks for any comments.

Cheers,
Todd

-- 
Todd Deshane
http://todddeshane.net
http://runningxen.com

^ permalink raw reply	[flat|nested] 15+ messages in thread

* Re: Nested KVM
  2008-12-23  2:55 Nested KVM Todd Deshane
@ 2008-12-23  6:26 ` Todd Deshane
  2008-12-23  9:00 ` Alexander Graf
  1 sibling, 0 replies; 15+ messages in thread
From: Todd Deshane @ 2008-12-23  6:26 UTC (permalink / raw)
  To: kvm

On Mon, Dec 22, 2008 at 9:55 PM, Todd Deshane <deshantm@gmail.com> wrote:
> I have successfully built the latest kvm, kvm-userspace from git.
>
> I loaded the kvm_amd module with the nested=1 option.
>
> The kvm guest that I am working with has an older version
> of kvm (Ubuntu 8.10 + kvm package) and during boot I get:
>
> [   23.673107] Modules linked in: kvm_amd(+) kvm ppdev cpufreq_stats
<snip>
> [   23.673107] ---[ end trace 0dc989f1cf9a296e ]---
>
> Maybe it is just that a newer version of KVM is needed?
>
> I will also try to build a newer version of KVM and test.

I built the latest KVM from git on the guest, but a
similar looking error comes up. Let me know if
it is useful for me to post it.

What else should I try to get nested kvm working?

Thanks,
Todd

-- 
Todd Deshane
http://todddeshane.net
http://runningxen.com

^ permalink raw reply	[flat|nested] 15+ messages in thread

* Re: Nested KVM
  2008-12-23  2:55 Nested KVM Todd Deshane
  2008-12-23  6:26 ` Todd Deshane
@ 2008-12-23  9:00 ` Alexander Graf
  2008-12-23 16:35   ` Todd Deshane
  2008-12-23 17:05   ` Avi Kivity
  1 sibling, 2 replies; 15+ messages in thread
From: Alexander Graf @ 2008-12-23  9:00 UTC (permalink / raw)
  To: deshantm; +Cc: kvm





On 23.12.2008, at 03:55, "Todd Deshane" <deshantm@gmail.com> wrote:

> I have successfully built the latest kvm, kvm-userspace from git.
>
> I loaded the kvm_amd module with the nested=1 option.
>
> The kvm guest that I am working with has an older version
> of kvm (Ubuntu 8.10 + kvm package) and during boot I get:
>
> [   23.673107] Modules linked in: kvm_amd(+) kvm ppdev cpufreq_stats
> cpufreq_powersave cpufreq_userspace cpufreq_conservative
> cpufreq_ondemand freq_table container pci_slot wmi video output sbs
> sbshc battery
> ipv6 iptable_filter ip_tables x_tables ac lp virtio_balloon
> virtio_net serio_raw psmouse pcspkr evdev joydev i2c_piix4 i2c_core
> parport_pc parport button ext3 jbd mbcache usbhid hid sr_mod cdrom sg
> virtio_b
> lk pata_acpi ata_piix ata_generic uhci_hcd virtio_pci virtio_ring
> virtio usbcore libata scsi_mod dock thermal processor fan fbcon
> tileblit font bitblit softcursor fuse
> [   23.673107] Pid: 4278, comm: modprobe Tainted: G S         
> 2.6.27-7-generic #1
> [   23.673107] RIP: 0010:[<ffffffff8022d35a>]  [<ffffffff8022d35a>]
> native_write_msr_safe+0xa/0x10
> [   23.673107] RSP: 0018:ffff880018dc3dd8  EFLAGS: 00010002
> [   23.673107] RAX: 0000000000001d01 RBX: ffff880018dc3e04 RCX:  
> 00000000c0000080
> [   23.673107] RDX: 0000000000000000 RSI: 0000000000001d01 RDI:  
> 00000000c0000080
> [   23.673107] RBP: ffff880018dc3dd8 R08: 0000000000000000 R09:  
> ffffffff806e1e20
> [   23.673107] R10: ffff880018dc3dfc R11: ffff880018dc3df8 R12:  
> ffff880018c096c0
> [   23.673107] R13: ffffffffa02b25e0 R14: ffffffffa02e1c80 R15:  
> 00000000c0000080
> [   23.673107] FS:  00007f2f14f946e0(0000) GS:ffffffff806e1a80(0000)
> knlGS:0000000000000000
> [   23.673107] CS:  0010 DS: 0000 ES: 0000 CR0: 000000008005003b
> [   23.673107] CR2: 00007f2f14fa8000 CR3: 0000000018d4f000 CR4:  
> 00000000000006e0
> [   23.673107] DR0: 0000000000000000 DR1: 0000000000000000 DR2:  
> 0000000000000000
> [   23.673107] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7:  
> 0000000000000400
> [   23.673107] Process modprobe (pid: 4278, threadinfo
> ffff880018dc2000, task ffff8800190f1670)
> [   23.673107] Stack:  ffff880018dc3e38 ffffffffa02db196
> 88000100b000007f 000000000000ffff
> [   23.673107]  0000000000000000 0000000000000010 0000000000000000
> 0000000000000000
> [   23.673107]  0000000000000000 ffffffffa02b25e0 ffffffffa02e1c80
> 00007f2f14f9a000
> [   23.673107] Call Trace:
> [   23.673107]  [<ffffffffa02db196>] svm_hardware_enable+0xd6/0x140  
> [kvm_amd]
> [   23.673107]  [<ffffffffa02b25e0>] ? hardware_enable+0x0/0x40 [kvm]
> [   23.673107]  [<ffffffffa02b4693>] kvm_arch_hardware_enable 
> +0x13/0x20 [kvm]
> [   23.673107]  [<ffffffffa02b260f>] hardware_enable+0x2f/0x40 [kvm]
> [   23.673107]  [<ffffffff80254a44>] on_each_cpu+0x34/0x50
> [   23.673107]  [<ffffffffa02b0c85>] kvm_init+0x165/0x280 [kvm]
> [   23.673107]  [<ffffffffa00b3000>] ? svm_init+0x0/0x23 [kvm_amd]
> [   23.673107]  [<ffffffffa00b3021>] svm_init+0x21/0x23 [kvm_amd]
> [   23.673107]  [<ffffffff8020a041>] do_one_initcall+0x41/0x170
> [   23.673107]  [<ffffffff8026c261>] ? __blocking_notifier_call_chain 
> +0x21/0x90
> [   23.673107]  [<ffffffff8027d085>] sys_init_module+0xb5/0x1f0
> [   23.673107]  [<ffffffff8021285a>] system_call_fastpath+0x16/0x1b
> [   23.673107]
> [   23.673107]
> [   23.673107] Code: 00 55 89 f9 48 89 e5 0f 32 31 c9 89 c7 48 89 d0
> 89 0e 48 c1 e0 20 89 fa 48 09 d0 c9 c3 0f 1f 40 00 55 89 f9 89 f0 48
> 89 e5 0f 30 <31> c0 c9 c3 66 90 55 89 f9 48 89 e5 0f 33 89 c1 48 89 d0
> 48 c1
> [   23.673107] RIP  [<ffffffff8022d35a>] native_write_msr_safe+0xa/ 
> 0x10
> [   23.673107]  RSP <ffff880018dc3dd8>
> [   23.673107] ---[ end trace 0dc989f1cf9a296e ]---
>
> Maybe it is just that a newer version of KVM is needed?
>
> I will also try to build a newer version of KVM and test.
>
> Thanks for any comments.

Your guest is writing to an MSR that is unknown to the kvm msr  
emulation. What does dmesg on the host say?

Alex

>
>
> Cheers,
> Todd
>
> -- 
> Todd Deshane
> http://todddeshane.net
> http://runningxen.com
> --
> To unsubscribe from this list: send the line "unsubscribe kvm" in
> the body of a message to majordomo@vger.kernel.org
> More majordomo info at  http://vger.kernel.org/majordomo-info.html

^ permalink raw reply	[flat|nested] 15+ messages in thread

* Re: Nested KVM
  2008-12-23  9:00 ` Alexander Graf
@ 2008-12-23 16:35   ` Todd Deshane
  2008-12-23 17:04     ` Alexander Graf
  2008-12-23 17:05   ` Avi Kivity
  1 sibling, 1 reply; 15+ messages in thread
From: Todd Deshane @ 2008-12-23 16:35 UTC (permalink / raw)
  To: Alexander Graf; +Cc: kvm

[-- Attachment #1: Type: text/plain, Size: 4211 bytes --]

On Tue, Dec 23, 2008 at 4:00 AM, Alexander Graf <agraf@suse.de> wrote:
>
>
>
>
> On 23.12.2008, at 03:55, "Todd Deshane" <deshantm@gmail.com> wrote:
>
>> I have successfully built the latest kvm, kvm-userspace from git.
>>
>> I loaded the kvm_amd module with the nested=1 option.
>>
>> The kvm guest that I am working with has an older version
>> of kvm (Ubuntu 8.10 + kvm package) and during boot I get:
>>
>> [   23.673107] Modules linked in: kvm_amd(+) kvm ppdev cpufreq_stats
>> cpufreq_powersave cpufreq_userspace cpufreq_conservative
>> cpufreq_ondemand freq_table container pci_slot wmi video output sbs
>> sbshc battery
>> ipv6 iptable_filter ip_tables x_tables ac lp virtio_balloon
>> virtio_net serio_raw psmouse pcspkr evdev joydev i2c_piix4 i2c_core
>> parport_pc parport button ext3 jbd mbcache usbhid hid sr_mod cdrom sg
>> virtio_b
>> lk pata_acpi ata_piix ata_generic uhci_hcd virtio_pci virtio_ring
>> virtio usbcore libata scsi_mod dock thermal processor fan fbcon
>> tileblit font bitblit softcursor fuse
>> [   23.673107] Pid: 4278, comm: modprobe Tainted: G S
>>  2.6.27-7-generic #1
>> [   23.673107] RIP: 0010:[<ffffffff8022d35a>]  [<ffffffff8022d35a>]
>> native_write_msr_safe+0xa/0x10
>> [   23.673107] RSP: 0018:ffff880018dc3dd8  EFLAGS: 00010002
>> [   23.673107] RAX: 0000000000001d01 RBX: ffff880018dc3e04 RCX:
>> 00000000c0000080
>> [   23.673107] RDX: 0000000000000000 RSI: 0000000000001d01 RDI:
>> 00000000c0000080
>> [   23.673107] RBP: ffff880018dc3dd8 R08: 0000000000000000 R09:
>> ffffffff806e1e20
>> [   23.673107] R10: ffff880018dc3dfc R11: ffff880018dc3df8 R12:
>> ffff880018c096c0
>> [   23.673107] R13: ffffffffa02b25e0 R14: ffffffffa02e1c80 R15:
>> 00000000c0000080
>> [   23.673107] FS:  00007f2f14f946e0(0000) GS:ffffffff806e1a80(0000)
>> knlGS:0000000000000000
>> [   23.673107] CS:  0010 DS: 0000 ES: 0000 CR0: 000000008005003b
>> [   23.673107] CR2: 00007f2f14fa8000 CR3: 0000000018d4f000 CR4:
>> 00000000000006e0
>> [   23.673107] DR0: 0000000000000000 DR1: 0000000000000000 DR2:
>> 0000000000000000
>> [   23.673107] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7:
>> 0000000000000400
>> [   23.673107] Process modprobe (pid: 4278, threadinfo
>> ffff880018dc2000, task ffff8800190f1670)
>> [   23.673107] Stack:  ffff880018dc3e38 ffffffffa02db196
>> 88000100b000007f 000000000000ffff
>> [   23.673107]  0000000000000000 0000000000000010 0000000000000000
>> 0000000000000000
>> [   23.673107]  0000000000000000 ffffffffa02b25e0 ffffffffa02e1c80
>> 00007f2f14f9a000
>> [   23.673107] Call Trace:
>> [   23.673107]  [<ffffffffa02db196>] svm_hardware_enable+0xd6/0x140
>> [kvm_amd]
>> [   23.673107]  [<ffffffffa02b25e0>] ? hardware_enable+0x0/0x40 [kvm]
>> [   23.673107]  [<ffffffffa02b4693>] kvm_arch_hardware_enable+0x13/0x20
>> [kvm]
>> [   23.673107]  [<ffffffffa02b260f>] hardware_enable+0x2f/0x40 [kvm]
>> [   23.673107]  [<ffffffff80254a44>] on_each_cpu+0x34/0x50
>> [   23.673107]  [<ffffffffa02b0c85>] kvm_init+0x165/0x280 [kvm]
>> [   23.673107]  [<ffffffffa00b3000>] ? svm_init+0x0/0x23 [kvm_amd]
>> [   23.673107]  [<ffffffffa00b3021>] svm_init+0x21/0x23 [kvm_amd]
>> [   23.673107]  [<ffffffff8020a041>] do_one_initcall+0x41/0x170
>> [   23.673107]  [<ffffffff8026c261>] ?
>> __blocking_notifier_call_chain+0x21/0x90
>> [   23.673107]  [<ffffffff8027d085>] sys_init_module+0xb5/0x1f0
>> [   23.673107]  [<ffffffff8021285a>] system_call_fastpath+0x16/0x1b
>> [   23.673107]
>> [   23.673107]
>> [   23.673107] Code: 00 55 89 f9 48 89 e5 0f 32 31 c9 89 c7 48 89 d0
>> 89 0e 48 c1 e0 20 89 fa 48 09 d0 c9 c3 0f 1f 40 00 55 89 f9 89 f0 48
>> 89 e5 0f 30 <31> c0 c9 c3 66 90 55 89 f9 48 89 e5 0f 33 89 c1 48 89 d0
>> 48 c1
>> [   23.673107] RIP  [<ffffffff8022d35a>] native_write_msr_safe+0xa/0x10
>> [   23.673107]  RSP <ffff880018dc3dd8>
>> [   23.673107] ---[ end trace 0dc989f1cf9a296e ]---
>>
>> Maybe it is just that a newer version of KVM is needed?
>>
>> I will also try to build a newer version of KVM and test.
>>
>> Thanks for any comments.
>
> Your guest is writing to an MSR that is unknown to the kvm msr emulation.
> What does dmesg on the host say?
>

Attached.

Thanks,
Todd

-- 
Todd Deshane
http://todddeshane.net
http://runningxen.com

[-- Attachment #2: dmesg.out --]
[-- Type: application/octet-stream, Size: 68981 bytes --]

[    0.000000] BIOS EBDA/lowmem at: 0009f000/0009f000
[    0.000000] Initializing cgroup subsys cpuset
[    0.000000] Initializing cgroup subsys cpu
[    0.000000] Linux version 2.6.28-rc9 (root@amdbox) (gcc version 4.3.2 (Ubuntu 4.3.2-1ubuntu11) ) #1 SMP Sun Dec 21 01:02:29 EST 2008 (Ubuntu 2.6.27-9.19-generic)
[    0.000000] Command line: root=UUID=03bec7c4-6d57-4298-9c50-1e3adc4f8b4b ro quiet splash 
[    0.000000] KERNEL supported cpus:
[    0.000000]   Intel GenuineIntel
[    0.000000]   AMD AuthenticAMD
[    0.000000]   Centaur CentaurHauls
[    0.000000] BIOS-provided physical RAM map:
[    0.000000]  BIOS-e820: 0000000000000000 - 000000000009f000 (usable)
[    0.000000]  BIOS-e820: 000000000009f000 - 00000000000a0000 (reserved)
[    0.000000]  BIOS-e820: 00000000000f0000 - 0000000000100000 (reserved)
[    0.000000]  BIOS-e820: 0000000000100000 - 00000000dfee0000 (usable)
[    0.000000]  BIOS-e820: 00000000dfee0000 - 00000000dfee3000 (ACPI NVS)
[    0.000000]  BIOS-e820: 00000000dfee3000 - 00000000dfef0000 (ACPI data)
[    0.000000]  BIOS-e820: 00000000dfef0000 - 00000000dff00000 (reserved)
[    0.000000]  BIOS-e820: 00000000f0000000 - 00000000f4000000 (reserved)
[    0.000000]  BIOS-e820: 00000000fec00000 - 0000000100000000 (reserved)
[    0.000000]  BIOS-e820: 0000000100000000 - 0000000120000000 (usable)
[    0.000000] DMI 2.4 present.
[    0.000000] Phoenix BIOS detected: BIOS may corrupt low RAM, working it around.
[    0.000000] last_pfn = 0x120000 max_arch_pfn = 0x3ffffffff
[    0.000000] last_pfn = 0xdfee0 max_arch_pfn = 0x3ffffffff
[    0.000000] init_memory_mapping: 0000000000000000-00000000dfee0000
[    0.000000]  0000000000 - 00dfe00000 page 2M
[    0.000000]  00dfe00000 - 00dfee0000 page 4k
[    0.000000] kernel direct mapping tables up to dfee0000 @ 10000-16000
[    0.000000] last_map_addr: dfee0000 end: dfee0000
[    0.000000] init_memory_mapping: 0000000100000000-0000000120000000
[    0.000000]  0100000000 - 0120000000 page 2M
[    0.000000] kernel direct mapping tables up to 120000000 @ 14000-1a000
[    0.000000] last_map_addr: 120000000 end: 120000000
[    0.000000] RAMDISK: 34919000 - 37fef234
[    0.000000] ACPI: RSDP 000F7B80, 0024 (r2 Nvidia)
[    0.000000] ACPI: XSDT DFEE30C0, 0044 (r1 Nvidia ASUSACPI 42302E31 AWRD        0)
[    0.000000] ACPI: FACP DFEEC540, 00F4 (r3 Nvidia ASUSACPI 42302E31 AWRD        0)
[    0.000000] FADT: X_PM1a_EVT_BLK.bit_width (8) does not match PM1_EVT_LEN (4)
[    0.000000] ACPI: DSDT DFEE3240, 92AD (r1 NVIDIA AWRDACPI     1000 MSFT  3000000)
[    0.000000] ACPI: FACS DFEE0000, 0040
[    0.000000] ACPI: HPET DFEEC740, 0038 (r1 Nvidia ASUSACPI 42302E31 AWRD       98)
[    0.000000] ACPI: MCFG DFEEC7C0, 003C (r1 Nvidia ASUSACPI 42302E31 AWRD        0)
[    0.000000] ACPI: APIC DFEEC680, 007C (r1 Nvidia ASUSACPI 42302E31 AWRD        0)
[    0.000000] ACPI: Local APIC address 0xfee00000
[    0.000000] Scanning NUMA topology in Northbridge 24
[    0.000000] No NUMA configuration found
[    0.000000] Faking a node at 0000000000000000-0000000120000000
[    0.000000] Bootmem setup node 0 0000000000000000-0000000120000000
[    0.000000]   NODE_DATA [0000000000015000 - 0000000000019fff]
[    0.000000]   bootmap [000000000001a000 -  000000000003dfff] pages 24
[    0.000000] (7 early reservations) ==> bootmem [0000000000 - 0120000000]
[    0.000000]   #0 [0000000000 - 0000001000]   BIOS data page ==> [0000000000 - 0000001000]
[    0.000000]   #1 [0000006000 - 0000008000]       TRAMPOLINE ==> [0000006000 - 0000008000]
[    0.000000]   #2 [0000200000 - 0000936bbc]    TEXT DATA BSS ==> [0000200000 - 0000936bbc]
[    0.000000]   #3 [0034919000 - 0037fef234]          RAMDISK ==> [0034919000 - 0037fef234]
[    0.000000]   #4 [000009f000 - 0000100000]    BIOS reserved ==> [000009f000 - 0000100000]
[    0.000000]   #5 [0000010000 - 0000014000]          PGTABLE ==> [0000010000 - 0000014000]
[    0.000000]   #6 [0000014000 - 0000015000]          PGTABLE ==> [0000014000 - 0000015000]
[    0.000000] found SMP MP-table at [ffff8800000f5b90] 000f5b90
[    0.000000]  [ffffe20000000000-ffffe20003ffffff] PMD -> [ffff880028200000-ffff88002bbfffff] on node 0
[    0.000000] Zone PFN ranges:
[    0.000000]   DMA      0x00000010 -> 0x00001000
[    0.000000]   DMA32    0x00001000 -> 0x00100000
[    0.000000]   Normal   0x00100000 -> 0x00120000
[    0.000000] Movable zone start PFN for each node
[    0.000000] early_node_map[3] active PFN ranges
[    0.000000]     0: 0x00000010 -> 0x0000009f
[    0.000000]     0: 0x00000100 -> 0x000dfee0
[    0.000000]     0: 0x00100000 -> 0x00120000
[    0.000000] On node 0 totalpages: 1048175
[    0.000000]   DMA zone: 56 pages used for memmap
[    0.000000]   DMA zone: 1953 pages reserved
[    0.000000]   DMA zone: 1974 pages, LIFO batch:0
[    0.000000]   DMA32 zone: 14280 pages used for memmap
[    0.000000]   DMA32 zone: 898840 pages, LIFO batch:31
[    0.000000]   Normal zone: 1792 pages used for memmap
[    0.000000]   Normal zone: 129280 pages, LIFO batch:31
[    0.000000]   Movable zone: 0 pages used for memmap
[    0.000000] ACPI: PM-Timer IO Port: 0x1008
[    0.000000] ACPI: Local APIC address 0xfee00000
[    0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
[    0.000000] ACPI: LAPIC (acpi_id[0x01] lapic_id[0x01] enabled)
[    0.000000] ACPI: LAPIC_NMI (acpi_id[0x00] high edge lint[0x1])
[    0.000000] ACPI: LAPIC_NMI (acpi_id[0x01] high edge lint[0x1])
[    0.000000] ACPI: IOAPIC (id[0x02] address[0xfec00000] gsi_base[0])
[    0.000000] IOAPIC[0]: apic_id 2, version 0, address 0xfec00000, GSI 0-23
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 14 global_irq 14 high edge)
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 15 global_irq 15 high edge)
[    0.000000] ACPI: IRQ0 used by override.
[    0.000000] ACPI: IRQ2 used by override.
[    0.000000] ACPI: IRQ9 used by override.
[    0.000000] ACPI: IRQ14 used by override.
[    0.000000] ACPI: IRQ15 used by override.
[    0.000000] ACPI: HPET id: 0x10de8201 base: 0xfefff000
[    0.000000] Using ACPI (MADT) for SMP configuration information
[    0.000000] SMP: Allowing 2 CPUs, 0 hotplug CPUs
[    0.000000] PM: Registered nosave memory: 000000000009f000 - 00000000000a0000
[    0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000f0000
[    0.000000] PM: Registered nosave memory: 00000000000f0000 - 0000000000100000
[    0.000000] PM: Registered nosave memory: 00000000dfee0000 - 00000000dfee3000
[    0.000000] PM: Registered nosave memory: 00000000dfee3000 - 00000000dfef0000
[    0.000000] PM: Registered nosave memory: 00000000dfef0000 - 00000000dff00000
[    0.000000] PM: Registered nosave memory: 00000000dff00000 - 00000000f0000000
[    0.000000] PM: Registered nosave memory: 00000000f0000000 - 00000000f4000000
[    0.000000] PM: Registered nosave memory: 00000000f4000000 - 00000000fec00000
[    0.000000] PM: Registered nosave memory: 00000000fec00000 - 0000000100000000
[    0.000000] Allocating PCI resources starting at e0000000 (gap: dff00000:10100000)
[    0.000000] PERCPU: Allocating 69632 bytes of per cpu data
[    0.000000] per cpu data for cpu0 on node0 at 000000002801f000
[    0.000000] per cpu data for cpu1 on node0 at 0000000028030000
[    0.000000] NR_CPUS: 64, nr_cpu_ids: 2, nr_node_ids 1
[    0.000000] Built 1 zonelists in Node order, mobility grouping on.  Total pages: 1030094
[    0.000000] Policy zone: Normal
[    0.000000] Kernel command line: root=UUID=03bec7c4-6d57-4298-9c50-1e3adc4f8b4b ro quiet splash 
[    0.000000] Initializing CPU#0
[    0.000000] PID hash table entries: 4096 (order: 12, 32768 bytes)
[    0.000000] Extended CMOS year: 2000
[    0.000000] Fast TSC calibration using PIT
[    0.000000] Detected 3013.609 MHz processor.
[    0.004000] spurious 8259A interrupt: IRQ7.
[    0.004000] Console: colour VGA+ 80x25
[    0.004000] console [tty0] enabled
[    0.004000] allocated 41943040 bytes of page_cgroup
[    0.004000] please try cgroup_disable=memory option if you don't want
[    0.004000] Checking aperture...
[    0.004000] No AGP bridge found
[    0.004000] Node 0: aperture @ d6e2000000 size 32 MB
[    0.004000] Aperture beyond 4GB. Ignoring.
[    0.004000] Your BIOS doesn't leave a aperture memory hole
[    0.004000] Please enable the IOMMU option in the BIOS setup
[    0.004000] This costs you 64 MB of RAM
[    0.004000] Mapping aperture over 65536 KB of RAM @ 20000000
[    0.004000] PM: Registered nosave memory: 0000000020000000 - 0000000024000000
[    0.004000] Memory: 3962896k/4718592k available (3137k kernel code, 525892k absent, 229804k reserved, 1774k data, 572k init)
[    0.004000] SLUB: Genslabs=13, HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
[    0.004000] hpet clockevent registered
[    0.004000] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
[    0.004000] Calibrating delay loop (skipped), value calculated using timer frequency.. 6027.21 BogoMIPS (lpj=12054436)
[    0.004000] Security Framework initialized
[    0.004000] SELinux:  Disabled at boot.
[    0.004000] AppArmor: AppArmor initialized
[    0.004000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes)
[    0.004000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes)
[    0.004000] Mount-cache hash table entries: 256
[    0.004000] Initializing cgroup subsys ns
[    0.004000] Initializing cgroup subsys cpuacct
[    0.004000] Initializing cgroup subsys memory
[    0.004000] CPU: L1 I Cache: 64K (64 bytes/line), D cache 64K (64 bytes/line)
[    0.004000] CPU: L2 Cache: 1024K (64 bytes/line)
[    0.004000] CPU 0/0x0 -> Node 0
[    0.004000] tseg: 00dff00000
[    0.004000] CPU: Physical Processor ID: 0
[    0.004000] CPU: Processor Core ID: 0
[    0.004000] using C1E aware idle routine
[    0.004000] ACPI: Core revision 20080926
[    0.006114] ACPI: Checking initramfs for custom DSDT
[    1.496044] Setting APIC routing to flat
[    1.496501] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[    1.536413] CPU0: AMD Athlon(tm) 64 X2 Dual Core Processor 6000+ stepping 03
[    1.540004] Booting processor 1 APIC 0x1 ip 0x6000
[    0.004000] Initializing CPU#1
[    0.004000] Calibrating delay using timer specific routine.. 6027.69 BogoMIPS (lpj=12055381)
[    0.004000] CPU: L1 I Cache: 64K (64 bytes/line), D cache 64K (64 bytes/line)
[    0.004000] CPU: L2 Cache: 1024K (64 bytes/line)
[    0.004000] CPU 1/0x1 -> Node 0
[    0.004000] CPU: Physical Processor ID: 0
[    0.004000] CPU: Processor Core ID: 1
[    1.624115] CPU1: AMD Athlon(tm) 64 X2 Dual Core Processor 6000+ stepping 03
[    1.624144] Brought up 2 CPUs
[    1.624146] Total of 2 processors activated (12054.90 BogoMIPS).
[    1.624224] CPU0 attaching sched-domain:
[    1.624226]  domain 0: span 0-1 level CPU
[    1.624228]   groups: 0 1
[    1.624230]   domain 1: span 0-1 level NODE
[    1.624231]    groups: 0-1
[    1.624234] CPU1 attaching sched-domain:
[    1.624235]  domain 0: span 0-1 level CPU
[    1.624236]   groups: 1 0
[    1.624238]   domain 1: span 0-1 level NODE
[    1.624239]    groups: 0-1
[    1.624294] net_namespace: 1400 bytes
[    1.624294] Booting paravirtualized kernel on bare hardware
[    1.624294] Time:  2:17:57  Date: 12/23/08
[    1.624294] NET: Registered protocol family 16
[    1.624294] node 0 link 0: io port [6000, ffff]
[    1.624294] TOM: 00000000e0000000 aka 3584M
[    1.624294] node 0 link 0: mmio [a0000, bffff]
[    1.624294] node 0 link 0: mmio [e0000000, efffffff]
[    1.624294] node 0 link 0: mmio [f4000000, fe02ffff]
[    1.624294] node 0 link 0: mmio [f0000000, f07fffff]
[    1.624294] TOM2: 0000000120000000 aka 4608M
[    1.624294] bus: [00,07] on node 0 link 0
[    1.624294] bus: 00 index 0 io port: [0, ffff]
[    1.624294] bus: 00 index 1 mmio: [a0000, bffff]
[    1.624294] bus: 00 index 2 mmio: [e0000000, f3ffffff]
[    1.624294] bus: 00 index 3 mmio: [f4000000, ffffffff]
[    1.624294] bus: 00 index 4 mmio: [120000000, fcffffffff]
[    1.624294] ACPI: bus type pci registered
[    1.624294] PCI: MCFG configuration 0: base f0000000 segment 0 buses 0 - 63
[    1.624294] PCI: MCFG area at f0000000 reserved in E820
[    1.626365] PCI: Using MMCONFIG at f0000000 - f3ffffff
[    1.626366] PCI: Using configuration type 1 for base access
[    1.628798] ACPI: EC: Look up EC in DSDT
[    1.639119] ACPI: Interpreter enabled
[    1.639121] ACPI: (supports S0 S1 S3 S4 S5)
[    1.639140] ACPI: Using IOAPIC for interrupt routing
[    1.648180] ACPI: No dock devices found.
[    1.648188] ACPI: PCI Root Bridge [PCI0] (0000:00)
[    1.648212] pci 0000:00:01.1: reg 10 io port: [0xfc00-0xfc3f]
[    1.648212] pci 0000:00:01.1: reg 20 io port: [0x1c00-0x1c3f]
[    1.648212] pci 0000:00:01.1: reg 24 io port: [0x1c40-0x1c7f]
[    1.648212] pci 0000:00:01.1: PME# supported from D3hot D3cold
[    1.648212] pci 0000:00:01.1: PME# disabled
[    1.648219] pci 0000:00:02.0: reg 10 32bit mmio: [0xfe02f000-0xfe02ffff]
[    1.648231] pci 0000:00:02.0: supports D1 D2
[    1.648232] pci 0000:00:02.0: PME# supported from D0 D1 D2 D3hot D3cold
[    1.648235] pci 0000:00:02.0: PME# disabled
[    1.648248] pci 0000:00:02.1: reg 10 32bit mmio: [0xfe02e000-0xfe02e0ff]
[    1.648259] pci 0000:00:02.1: supports D1 D2
[    1.648260] pci 0000:00:02.1: PME# supported from D0 D1 D2 D3hot D3cold
[    1.648262] pci 0000:00:02.1: PME# disabled
[    1.648281] pci 0000:00:04.0: reg 20 io port: [0xf000-0xf00f]
[    1.648299] pci 0000:00:05.0: reg 10 io port: [0x9f0-0x9f7]
[    1.648302] pci 0000:00:05.0: reg 14 io port: [0xbf0-0xbf3]
[    1.648304] pci 0000:00:05.0: reg 18 io port: [0x970-0x977]
[    1.648307] pci 0000:00:05.0: reg 1c io port: [0xb70-0xb73]
[    1.648309] pci 0000:00:05.0: reg 20 io port: [0xdc00-0xdc0f]
[    1.648312] pci 0000:00:05.0: reg 24 32bit mmio: [0xfe02d000-0xfe02dfff]
[    1.648330] pci 0000:00:05.1: reg 10 io port: [0x9e0-0x9e7]
[    1.648332] pci 0000:00:05.1: reg 14 io port: [0xbe0-0xbe3]
[    1.648334] pci 0000:00:05.1: reg 18 io port: [0x960-0x967]
[    1.648337] pci 0000:00:05.1: reg 1c io port: [0xb60-0xb63]
[    1.648339] pci 0000:00:05.1: reg 20 io port: [0xc800-0xc80f]
[    1.648342] pci 0000:00:05.1: reg 24 32bit mmio: [0xfe02c000-0xfe02cfff]
[    1.648359] pci 0000:00:05.2: reg 10 io port: [0xc400-0xc407]
[    1.648362] pci 0000:00:05.2: reg 14 io port: [0xc000-0xc003]
[    1.648364] pci 0000:00:05.2: reg 18 io port: [0xbc00-0xbc07]
[    1.648367] pci 0000:00:05.2: reg 1c io port: [0xb800-0xb803]
[    1.648369] pci 0000:00:05.2: reg 20 io port: [0xb400-0xb40f]
[    1.648372] pci 0000:00:05.2: reg 24 32bit mmio: [0xfe02b000-0xfe02bfff]
[    1.648408] pci 0000:00:06.1: reg 10 32bit mmio: [0xfe020000-0xfe023fff]
[    1.648420] pci 0000:00:06.1: PME# supported from D3hot D3cold
[    1.648422] pci 0000:00:06.1: PME# disabled
[    1.648448] pci 0000:00:08.0: reg 10 32bit mmio: [0xfe02a000-0xfe02afff]
[    1.648450] pci 0000:00:08.0: reg 14 io port: [0xb000-0xb007]
[    1.648453] pci 0000:00:08.0: reg 18 32bit mmio: [0xfe029000-0xfe0290ff]
[    1.648455] pci 0000:00:08.0: reg 1c 32bit mmio: [0xfe028000-0xfe02800f]
[    1.648463] pci 0000:00:08.0: supports D1 D2
[    1.648464] pci 0000:00:08.0: PME# supported from D0 D1 D2 D3hot D3cold
[    1.648468] pci 0000:00:08.0: PME# disabled
[    1.648490] pci 0000:00:09.0: reg 10 32bit mmio: [0xfe027000-0xfe027fff]
[    1.648492] pci 0000:00:09.0: reg 14 io port: [0xac00-0xac07]
[    1.648495] pci 0000:00:09.0: reg 18 32bit mmio: [0xfe026000-0xfe0260ff]
[    1.648497] pci 0000:00:09.0: reg 1c 32bit mmio: [0xfe025000-0xfe02500f]
[    1.648505] pci 0000:00:09.0: supports D1 D2
[    1.648507] pci 0000:00:09.0: PME# supported from D0 D1 D2 D3hot D3cold
[    1.648510] pci 0000:00:09.0: PME# disabled
[    1.648528] pci 0000:00:0a.0: PME# supported from D0 D1 D2 D3hot D3cold
[    1.648529] pci 0000:00:0a.0: PME# disabled
[    1.648545] pci 0000:00:0b.0: PME# supported from D0 D1 D2 D3hot D3cold
[    1.648547] pci 0000:00:0b.0: PME# disabled
[    1.648562] pci 0000:00:0c.0: PME# supported from D0 D1 D2 D3hot D3cold
[    1.648564] pci 0000:00:0c.0: PME# disabled
[    1.648580] pci 0000:00:0d.0: PME# supported from D0 D1 D2 D3hot D3cold
[    1.648581] pci 0000:00:0d.0: PME# disabled
[    1.648597] pci 0000:00:0e.0: PME# supported from D0 D1 D2 D3hot D3cold
[    1.648598] pci 0000:00:0e.0: PME# disabled
[    1.648615] pci 0000:00:0f.0: PME# supported from D0 D1 D2 D3hot D3cold
[    1.648617] pci 0000:00:0f.0: PME# disabled
[    1.648682] pci 0000:01:07.0: reg 10 io port: [0x9c00-0x9cff]
[    1.648686] pci 0000:01:07.0: reg 14 32bit mmio: [0xfdeff000-0xfdeff0ff]
[    1.648703] pci 0000:01:07.0: supports D1 D2
[    1.648704] pci 0000:01:07.0: PME# supported from D1 D2 D3hot D3cold
[    1.648706] pci 0000:01:07.0: PME# disabled
[    1.648725] pci 0000:01:0b.0: reg 10 32bit mmio: [0xfdefe000-0xfdefe7ff]
[    1.648729] pci 0000:01:0b.0: reg 14 32bit mmio: [0xfdef8000-0xfdefbfff]
[    1.648747] pci 0000:01:0b.0: supports D1 D2
[    1.648748] pci 0000:01:0b.0: PME# supported from D0 D1 D2 D3hot
[    1.648750] pci 0000:01:0b.0: PME# disabled
[    1.648766] pci 0000:00:06.0: transparent bridge
[    1.648768] pci 0000:00:06.0: bridge io port: [0x9000-0x9fff]
[    1.648770] pci 0000:00:06.0: bridge 32bit mmio: [0xfde00000-0xfdefffff]
[    1.648922] pci 0000:06:00.0: reg 24 32bit mmio: [0xfddfe000-0xfddfffff]
[    1.648927] pci 0000:06:00.0: reg 30 32bit mmio: [0xfdde0000-0xfddeffff]
[    1.648935] pci 0000:06:00.0: PME# supported from D3hot
[    1.648939] pci 0000:06:00.0: PME# disabled
[    1.648970] pci 0000:06:00.1: reg 10 io port: [0x8c00-0x8c07]
[    1.648976] pci 0000:06:00.1: reg 14 io port: [0x8800-0x8803]
[    1.648982] pci 0000:06:00.1: reg 18 io port: [0x8400-0x8407]
[    1.648987] pci 0000:06:00.1: reg 1c io port: [0x8000-0x8003]
[    1.648993] pci 0000:06:00.1: reg 20 io port: [0x7c00-0x7c0f]
[    1.649040] pci 0000:00:0e.0: bridge io port: [0x7000-0x8fff]
[    1.649042] pci 0000:00:0e.0: bridge 32bit mmio: [0xfdd00000-0xfddfffff]
[    1.649061] pci 0000:07:00.0: reg 10 32bit mmio: [0xfa000000-0xfaffffff]
[    1.649067] pci 0000:07:00.0: reg 14 64bit mmio: [0xe0000000-0xefffffff]
[    1.649073] pci 0000:07:00.0: reg 1c 64bit mmio: [0xf8000000-0xf9ffffff]
[    1.649076] pci 0000:07:00.0: reg 24 io port: [0x6c00-0x6c7f]
[    1.649080] pci 0000:07:00.0: reg 30 32bit mmio: [0xfbfe0000-0xfbffffff]
[    1.649111] pci 0000:00:0f.0: bridge io port: [0x6000-0x6fff]
[    1.649113] pci 0000:00:0f.0: bridge 32bit mmio: [0xf8000000-0xfbffffff]
[    1.649115] pci 0000:00:0f.0: bridge 64bit mmio pref: [0xe0000000-0xefffffff]
[    1.649128] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
[    1.649595] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.HUB0._PRT]
[    1.708775] ACPI: PCI Interrupt Link [LNK1] (IRQs 5 7 9 10 11 14 15) *0, disabled.
[    1.708775] ACPI: PCI Interrupt Link [LNK2] (IRQs 5 7 9 *10 11 14 15)
[    1.708775] ACPI: PCI Interrupt Link [LNK3] (IRQs 5 7 9 10 11 14 15) *0, disabled.
[    1.708775] ACPI: PCI Interrupt Link [LNK4] (IRQs 5 7 9 10 11 14 15) *0, disabled.
[    1.708834] ACPI: PCI Interrupt Link [LNK5] (IRQs 5 7 9 10 11 14 15) *0, disabled.
[    1.709008] ACPI: PCI Interrupt Link [LNK6] (IRQs *5 7 9 10 11 14 15)
[    1.709184] ACPI: PCI Interrupt Link [LNK7] (IRQs 5 7 9 10 *11 14 15)
[    1.709356] ACPI: PCI Interrupt Link [LNK8] (IRQs 5 7 9 10 11 14 15) *0, disabled.
[    1.709529] ACPI: PCI Interrupt Link [LP2P] (IRQs 5 7 9 10 11 14 15) *0, disabled.
[    1.709702] ACPI: PCI Interrupt Link [LUBA] (IRQs 5 7 9 *10 11 14 15)
[    1.709876] ACPI: PCI Interrupt Link [LMAC] (IRQs 5 7 9 *10 11 14 15)
[    1.710049] ACPI: PCI Interrupt Link [LMC1] (IRQs 5 7 9 *10 11 14 15)
[    1.710222] ACPI: PCI Interrupt Link [LAZA] (IRQs 5 7 9 10 *11 14 15)
[    1.710395] ACPI: PCI Interrupt Link [LPMU] (IRQs 5 7 9 10 11 14 15) *0, disabled.
[    1.710569] ACPI: PCI Interrupt Link [LSMB] (IRQs *5 7 9 10 11 14 15)
[    1.710743] ACPI: PCI Interrupt Link [LUB2] (IRQs 5 7 9 10 *11 14 15)
[    1.712067] ACPI: PCI Interrupt Link [LIDE] (IRQs 5 7 9 10 11 14 15) *0, disabled.
[    1.712241] ACPI: PCI Interrupt Link [LSID] (IRQs *5 7 9 10 11 14 15)
[    1.712414] ACPI: PCI Interrupt Link [LFID] (IRQs 5 7 9 *10 11 14 15)
[    1.712587] ACPI: PCI Interrupt Link [LSA2] (IRQs 5 7 9 10 *11 14 15)
[    1.712800] ACPI: PCI Interrupt Link [APC1] (IRQs 16) *0, disabled.
[    1.713009] ACPI: PCI Interrupt Link [APC2] (IRQs 17) *0
[    1.713217] ACPI: PCI Interrupt Link [APC3] (IRQs 18) *0, disabled.
[    1.713426] ACPI: PCI Interrupt Link [APC4] (IRQs 19) *0, disabled.
[    1.713634] ACPI: PCI Interrupt Link [APC5] (IRQs 16) *0, disabled.
[    1.713843] ACPI: PCI Interrupt Link [APC6] (IRQs 16) *0
[    1.714051] ACPI: PCI Interrupt Link [APC7] (IRQs 16) *0
[    1.714260] ACPI: PCI Interrupt Link [APC8] (IRQs 16) *0, disabled.
[    1.714469] ACPI: PCI Interrupt Link [APCF] (IRQs 20 21 22 23) *0
[    1.714685] ACPI: PCI Interrupt Link [APCH] (IRQs 20 21 22 23) *0
[    1.714895] ACPI: PCI Interrupt Link [AMC1] (IRQs 20 21 22 23) *0
[    1.715108] ACPI: PCI Interrupt Link [APMU] (IRQs 20 21 22 23) *0, disabled.
[    1.715317] ACPI: PCI Interrupt Link [AAZA] (IRQs 20 21 22 23) *0
[    1.715526] ACPI: PCI Interrupt Link [APCS] (IRQs 20 21 22 23) *0
[    1.715738] ACPI: PCI Interrupt Link [APCL] (IRQs 20 21 22 23) *0
[    1.715948] ACPI: PCI Interrupt Link [APCM] (IRQs 20 21 22 23) *0, disabled.
[    1.716169] ACPI: PCI Interrupt Link [APCZ] (IRQs 20 21 22 23) *0, disabled.
[    1.716378] ACPI: PCI Interrupt Link [APSI] (IRQs 20 21 22 23) *0
[    1.716587] ACPI: PCI Interrupt Link [APSJ] (IRQs 20 21 22 23) *0
[    1.716796] ACPI: PCI Interrupt Link [ASA2] (IRQs 20 21 22 23) *0
[    1.716851] PCI: Using ACPI for IRQ routing
[    1.732010] NET: Registered protocol family 8
[    1.732012] NET: Registered protocol family 20
[    1.732022] NetLabel: Initializing
[    1.732022] NetLabel:  domain hash size = 128
[    1.732022] NetLabel:  protocols = UNLABELED CIPSOv4
[    1.732031] NetLabel:  unlabeled traffic allowed by default
[    1.732104] PCI-DMA: Disabling AGP.
[    1.732155] PCI-DMA: aperture base @ 20000000 size 65536 KB
[    1.732155] PCI-DMA: using GART IOMMU.
[    1.732155] PCI-DMA: Reserving 64MB of IOMMU area in the AGP aperture
[    1.732536] hpet0: at MMIO 0xfefff000, IRQs 2, 8, 31
[    1.732541] hpet0: 3 comparators, 32-bit 25.000000 MHz counter
[    1.736064] AppArmor: AppArmor Filesystem Enabled
[    1.740014] Switched to high resolution mode on CPU 0
[    1.740153] Switched to high resolution mode on CPU 1
[    1.752013] pnp: PnP ACPI init
[    1.752028] ACPI: bus type pnp registered
[    1.758009] pnp: PnP ACPI: found 15 devices
[    1.758010] ACPI: ACPI bus type pnp unregistered
[    1.758018] system 00:01: ioport range 0x1000-0x107f has been reserved
[    1.758019] system 00:01: ioport range 0x1080-0x10ff has been reserved
[    1.758021] system 00:01: ioport range 0x1400-0x147f has been reserved
[    1.758023] system 00:01: ioport range 0x1480-0x14ff has been reserved
[    1.758024] system 00:01: ioport range 0x1800-0x187f has been reserved
[    1.758026] system 00:01: ioport range 0x1880-0x18ff has been reserved
[    1.758030] system 00:02: ioport range 0x4d0-0x4d1 has been reserved
[    1.758031] system 00:02: ioport range 0x800-0x87f has been reserved
[    1.758033] system 00:02: ioport range 0x290-0x297 has been reserved
[    1.758038] system 00:0d: iomem range 0xf0000000-0xf3ffffff has been reserved
[    1.758041] system 00:0e: iomem range 0xd2800-0xd3fff has been reserved
[    1.758043] system 00:0e: iomem range 0xf0000-0xf7fff could not be reserved
[    1.758045] system 00:0e: iomem range 0xf8000-0xfbfff could not be reserved
[    1.758046] system 00:0e: iomem range 0xfc000-0xfffff could not be reserved
[    1.758048] system 00:0e: iomem range 0xfefff000-0xfefff0ff has been reserved
[    1.758050] system 00:0e: iomem range 0xdfee0000-0xdfefffff could not be reserved
[    1.758051] system 00:0e: iomem range 0xffff0000-0xffffffff has been reserved
[    1.758053] system 00:0e: iomem range 0x0-0x9ffff could not be reserved
[    1.758055] system 00:0e: iomem range 0x100000-0xdfedffff could not be reserved
[    1.758056] system 00:0e: iomem range 0xfec00000-0xfec00fff has been reserved
[    1.758058] system 00:0e: iomem range 0xfee00000-0xfeefffff has been reserved
[    1.758060] system 00:0e: iomem range 0xfefff000-0xfeffffff could not be reserved
[    1.758062] system 00:0e: iomem range 0xfff80000-0xfff80fff has been reserved
[    1.758063] system 00:0e: iomem range 0xfff90000-0xfffbffff has been reserved
[    1.758065] system 00:0e: iomem range 0xfffed000-0xfffeffff has been reserved
[    1.762999] pci 0000:00:06.0: PCI bridge, secondary bus 0000:01
[    1.763001] pci 0000:00:06.0:   IO window: 0x9000-0x9fff
[    1.763003] pci 0000:00:06.0:   MEM window: 0xfde00000-0xfdefffff
[    1.763005] pci 0000:00:06.0:   PREFETCH window: disabled
[    1.763007] pci 0000:00:0a.0: PCI bridge, secondary bus 0000:02
[    1.763008] pci 0000:00:0a.0:   IO window: disabled
[    1.763010] pci 0000:00:0a.0:   MEM window: disabled
[    1.763011] pci 0000:00:0a.0:   PREFETCH window: disabled
[    1.763013] pci 0000:00:0b.0: PCI bridge, secondary bus 0000:03
[    1.763014] pci 0000:00:0b.0:   IO window: disabled
[    1.763016] pci 0000:00:0b.0:   MEM window: disabled
[    1.763018] pci 0000:00:0b.0:   PREFETCH window: disabled
[    1.763020] pci 0000:00:0c.0: PCI bridge, secondary bus 0000:04
[    1.763021] pci 0000:00:0c.0:   IO window: disabled
[    1.763022] pci 0000:00:0c.0:   MEM window: disabled
[    1.763024] pci 0000:00:0c.0:   PREFETCH window: disabled
[    1.763026] pci 0000:00:0d.0: PCI bridge, secondary bus 0000:05
[    1.763027] pci 0000:00:0d.0:   IO window: disabled
[    1.763029] pci 0000:00:0d.0:   MEM window: disabled
[    1.763030] pci 0000:00:0d.0:   PREFETCH window: disabled
[    1.763032] pci 0000:00:0e.0: PCI bridge, secondary bus 0000:06
[    1.763034] pci 0000:00:0e.0:   IO window: 0x7000-0x8fff
[    1.763036] pci 0000:00:0e.0:   MEM window: 0xfdd00000-0xfddfffff
[    1.763037] pci 0000:00:0e.0:   PREFETCH window: disabled
[    1.763039] pci 0000:00:0f.0: PCI bridge, secondary bus 0000:07
[    1.763041] pci 0000:00:0f.0:   IO window: 0x6000-0x6fff
[    1.763043] pci 0000:00:0f.0:   MEM window: 0xf8000000-0xfbffffff
[    1.763045] pci 0000:00:0f.0:   PREFETCH window: 0x000000e0000000-0x000000efffffff
[    1.763050] pci 0000:00:06.0: setting latency timer to 64
[    1.763053] pci 0000:00:0a.0: setting latency timer to 64
[    1.763056] pci 0000:00:0b.0: setting latency timer to 64
[    1.763059] pci 0000:00:0c.0: setting latency timer to 64
[    1.763062] pci 0000:00:0d.0: setting latency timer to 64
[    1.763065] pci 0000:00:0e.0: setting latency timer to 64
[    1.763068] pci 0000:00:0f.0: setting latency timer to 64
[    1.763070] bus: 00 index 0 io port: [0x00-0xffff]
[    1.763071] bus: 00 index 1 mmio: [0x000000-0xffffffffffffffff]
[    1.763073] bus: 01 index 0 io port: [0x9000-0x9fff]
[    1.763074] bus: 01 index 1 mmio: [0xfde00000-0xfdefffff]
[    1.763075] bus: 01 index 2 mmio: [0x0-0x0]
[    1.763076] bus: 01 index 3 io port: [0x00-0xffff]
[    1.763077] bus: 01 index 4 mmio: [0x000000-0xffffffffffffffff]
[    1.763079] bus: 02 index 0 mmio: [0x0-0x0]
[    1.763080] bus: 02 index 1 mmio: [0x0-0x0]
[    1.763081] bus: 02 index 2 mmio: [0x0-0x0]
[    1.763082] bus: 02 index 3 mmio: [0x0-0x0]
[    1.763083] bus: 03 index 0 mmio: [0x0-0x0]
[    1.763084] bus: 03 index 1 mmio: [0x0-0x0]
[    1.763085] bus: 03 index 2 mmio: [0x0-0x0]
[    1.763086] bus: 03 index 3 mmio: [0x0-0x0]
[    1.763087] bus: 04 index 0 mmio: [0x0-0x0]
[    1.763088] bus: 04 index 1 mmio: [0x0-0x0]
[    1.763089] bus: 04 index 2 mmio: [0x0-0x0]
[    1.763090] bus: 04 index 3 mmio: [0x0-0x0]
[    1.763091] bus: 05 index 0 mmio: [0x0-0x0]
[    1.763092] bus: 05 index 1 mmio: [0x0-0x0]
[    1.763093] bus: 05 index 2 mmio: [0x0-0x0]
[    1.763094] bus: 05 index 3 mmio: [0x0-0x0]
[    1.763095] bus: 06 index 0 io port: [0x7000-0x8fff]
[    1.763096] bus: 06 index 1 mmio: [0xfdd00000-0xfddfffff]
[    1.763097] bus: 06 index 2 mmio: [0x0-0x0]
[    1.763098] bus: 06 index 3 mmio: [0x0-0x0]
[    1.763099] bus: 07 index 0 io port: [0x6000-0x6fff]
[    1.763100] bus: 07 index 1 mmio: [0xf8000000-0xfbffffff]
[    1.763101] bus: 07 index 2 mmio: [0xe0000000-0xefffffff]
[    1.763103] bus: 07 index 3 mmio: [0x0-0x0]
[    1.763110] NET: Registered protocol family 2
[    1.804106] IP route cache hash table entries: 131072 (order: 8, 1048576 bytes)
[    1.804999] TCP established hash table entries: 524288 (order: 11, 8388608 bytes)
[    1.807681] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes)
[    1.808157] TCP: Hash tables configured (established 524288 bind 65536)
[    1.808159] TCP reno registered
[    1.820072] NET: Registered protocol family 1
[    1.820160] checking if image is initramfs... it is
[    5.724312] Freeing initrd memory: 56152k freed
[    5.748339] audit: initializing netlink socket (disabled)
[    5.748349] type=2000 audit(1229998680.748:1): initialized
[    5.752472] HugeTLB registered 2 MB page size, pre-allocated 0 pages
[    5.754430] VFS: Disk quotas dquot_6.5.1
[    5.754492] Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    5.754580] msgmni has been set to 7849
[    5.754732] alg: No test for stdrng (krng)
[    5.754742] io scheduler noop registered
[    5.754744] io scheduler anticipatory registered
[    5.754745] io scheduler deadline registered
[    5.754841] io scheduler cfq registered (default)
[    5.768070] pci 0000:00:05.0: Enabling HT MSI Mapping
[    5.768083] pci 0000:00:05.1: Enabling HT MSI Mapping
[    5.768096] pci 0000:00:05.2: Enabling HT MSI Mapping
[    5.768107] pci 0000:00:06.0: Enabling HT MSI Mapping
[    5.768120] pci 0000:00:06.1: Enabling HT MSI Mapping
[    5.768135] pci 0000:00:08.0: Enabling HT MSI Mapping
[    5.768149] pci 0000:00:09.0: Enabling HT MSI Mapping
[    5.768161] pci 0000:00:0a.0: Enabling HT MSI Mapping
[    5.768174] pci 0000:00:0b.0: Enabling HT MSI Mapping
[    5.768187] pci 0000:00:0c.0: Enabling HT MSI Mapping
[    5.768199] pci 0000:00:0d.0: Enabling HT MSI Mapping
[    5.768212] pci 0000:00:0e.0: Enabling HT MSI Mapping
[    5.768225] pci 0000:00:0f.0: Enabling HT MSI Mapping
[    5.768247] pci 0000:07:00.0: Boot video device
[    5.774906] pcieport-driver 0000:00:0a.0: setting latency timer to 64
[    5.774922] pcieport-driver 0000:00:0a.0: found MSI capability
[    5.774934] pcieport-driver 0000:00:0a.0: irq 2303 for MSI/MSI-X
[    5.774938] pci_express 0000:00:0a.0:pcie00: allocate port service
[    5.774981] pci_express 0000:00:0a.0:pcie03: allocate port service
[    5.775030] pcieport-driver 0000:00:0b.0: setting latency timer to 64
[    5.775045] pcieport-driver 0000:00:0b.0: found MSI capability
[    5.775054] pcieport-driver 0000:00:0b.0: irq 2302 for MSI/MSI-X
[    5.775058] pci_express 0000:00:0b.0:pcie00: allocate port service
[    5.775090] pci_express 0000:00:0b.0:pcie03: allocate port service
[    5.775137] pcieport-driver 0000:00:0c.0: setting latency timer to 64
[    5.775151] pcieport-driver 0000:00:0c.0: found MSI capability
[    5.775160] pcieport-driver 0000:00:0c.0: irq 2301 for MSI/MSI-X
[    5.775164] pci_express 0000:00:0c.0:pcie00: allocate port service
[    5.775195] pci_express 0000:00:0c.0:pcie03: allocate port service
[    5.775244] pcieport-driver 0000:00:0d.0: setting latency timer to 64
[    5.775259] pcieport-driver 0000:00:0d.0: found MSI capability
[    5.775267] pcieport-driver 0000:00:0d.0: irq 2300 for MSI/MSI-X
[    5.775271] pci_express 0000:00:0d.0:pcie00: allocate port service
[    5.775304] pci_express 0000:00:0d.0:pcie03: allocate port service
[    5.775353] pcieport-driver 0000:00:0e.0: setting latency timer to 64
[    5.775367] pcieport-driver 0000:00:0e.0: found MSI capability
[    5.775375] pcieport-driver 0000:00:0e.0: irq 2299 for MSI/MSI-X
[    5.775379] pci_express 0000:00:0e.0:pcie00: allocate port service
[    5.775412] pci_express 0000:00:0e.0:pcie03: allocate port service
[    5.775461] pcieport-driver 0000:00:0f.0: setting latency timer to 64
[    5.775475] pcieport-driver 0000:00:0f.0: found MSI capability
[    5.775483] pcieport-driver 0000:00:0f.0: irq 2298 for MSI/MSI-X
[    5.775488] pci_express 0000:00:0f.0:pcie00: allocate port service
[    5.775521] pci_express 0000:00:0f.0:pcie03: allocate port service
[    5.802491] Linux agpgart interface v0.103
[    5.802495] Serial: 8250/16550 driver4 ports, IRQ sharing enabled
[    5.802602] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[    5.803164] 00:09: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[    5.804724] brd: module loaded
[    5.804778] input: Macintosh mouse button emulation as /devices/virtual/input/input0
[    5.804869] PNP: PS/2 Controller [PNP0303:PS2K,PNP0f13:PS2M] at 0x60,0x64 irq 1,12
[    5.805239] serio: i8042 KBD port at 0x60,0x64 irq 1
[    5.805244] serio: i8042 AUX port at 0x60,0x64 irq 12
[    5.817121] mice: PS/2 mouse device common for all mice
[    5.817196] rtc_cmos 00:05: RTC can wake from S4
[    5.817255] rtc_cmos 00:05: rtc core: registered rtc_cmos as rtc0
[    5.817287] rtc0: alarms up to one year, y3k, 242 bytes nvram, hpet irqs
[    5.817328] cpuidle: using governor ladder
[    5.817330] cpuidle: using governor menu
[    5.817589] TCP cubic registered
[    5.817773] registered taskstats version 1
[    5.817895]   Magic number: 4:693:258
[    5.817915] tty ttyx0: hash matches
[    5.818020] rtc_cmos 00:05: setting system clock to 2008-12-23 02:18:01 UTC (1229998681)
[    5.818022] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found
[    5.818023] EDD information not available.
[    5.818054] Freeing unused kernel memory: 572k freed
[    5.818256] Write protecting the kernel read-only data: 4432k
[    5.845033] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1
[    5.922816] fuse init (API version 7.10)
[    5.926690] fan PNP0C0B:00: registered as cooling_device0
[    5.926694] ACPI: Fan [FAN] (on)
[    5.931390] processor ACPI_CPU:00: registered as cooling_device1
[    5.931432] processor ACPI_CPU:01: registered as cooling_device2
[    5.933465] thermal LNXTHERM:01: registered as thermal_zone0
[    5.933854] ACPI: Thermal Zone [THRM] (40 C)
[    5.944471] device-mapper: uevent: version 1.0.3
[    5.944611] device-mapper: ioctl: 4.14.0-ioctl (2008-04-23) initialised: dm-devel@redhat.com
[    6.319350] usbcore: registered new interface driver usbfs
[    6.319370] usbcore: registered new interface driver hub
[    6.320303] SCSI subsystem initialized
[    6.356402] 8139too Fast Ethernet driver 0.9.28
[    6.356789] ACPI: PCI Interrupt Link [APC2] enabled at IRQ 17
[    6.356799] 8139too 0000:01:07.0: PCI INT A -> Link[APC2] -> GSI 17 (level, low) -> IRQ 17
[    6.357272] eth0: RealTek RTL8139 at 0x9c00, 00:90:47:05:7c:b4, IRQ 17
[    6.357273] eth0:  Identified 8139 chip type 'RTL-8100B/8139D'
[    6.359418] 8139cp: 10/100 PCI Ethernet driver v1.3 (Mar 22, 2004)
[    6.359564] usbcore: registered new device driver usb
[    6.361227] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[    6.361586] ACPI: PCI Interrupt Link [APCF] enabled at IRQ 23
[    6.361596] ohci_hcd 0000:00:02.0: PCI INT A -> Link[APCF] -> GSI 23 (level, low) -> IRQ 23
[    6.361662] ohci_hcd 0000:00:02.0: setting latency timer to 64
[    6.361664] ohci_hcd 0000:00:02.0: OHCI Host Controller
[    6.361704] ohci_hcd 0000:00:02.0: new USB bus registered, assigned bus number 1
[    6.361733] ohci_hcd 0000:00:02.0: irq 23, io mem 0xfe02f000
[    6.363730] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    6.363732] Warning! ehci_hcd should always be loaded before uhci_hcd and ohci_hcd, not after
[    6.416322] ACPI: PCI Interrupt Link [APC4] enabled at IRQ 19
[    6.416333] ohci1394 0000:01:0b.0: PCI INT A -> Link[APC4] -> GSI 19 (level, low) -> IRQ 19
[    6.426114] usb usb1: configuration #1 chosen from 1 choice
[    6.426134] hub 1-0:1.0: USB hub found
[    6.426149] hub 1-0:1.0: 10 ports detected
[    6.426875] ACPI: PCI Interrupt Link [APCL] enabled at IRQ 22
[    6.426884] ehci_hcd 0000:00:02.1: PCI INT B -> Link[APCL] -> GSI 22 (level, low) -> IRQ 22
[    6.426904] ehci_hcd 0000:00:02.1: setting latency timer to 64
[    6.426905] ehci_hcd 0000:00:02.1: EHCI Host Controller
[    6.426929] ehci_hcd 0000:00:02.1: new USB bus registered, assigned bus number 2
[    6.426949] ehci_hcd 0000:00:02.1: debug port 1
[    6.426951] ehci_hcd 0000:00:02.1: cache line size of 64 is not supported
[    6.426967] ehci_hcd 0000:00:02.1: irq 22, io mem 0xfe02e000
[    6.436009] ehci_hcd 0000:00:02.1: USB 2.0 started, EHCI 1.00
[    6.436066] usb usb2: configuration #1 chosen from 1 choice
[    6.436082] hub 2-0:1.0: USB hub found
[    6.436088] hub 2-0:1.0: 10 ports detected
[    6.436385] forcedeth: Reverse Engineered nForce ethernet driver. Version 0.61.
[    6.436713] ACPI: PCI Interrupt Link [APCH] enabled at IRQ 21
[    6.436720] forcedeth 0000:00:08.0: PCI INT A -> Link[APCH] -> GSI 21 (level, low) -> IRQ 21
[    6.436722] forcedeth 0000:00:08.0: setting latency timer to 64
[    6.436749] nv_probe: set workaround bit for reversed mac addr
[    6.437248] libata version 3.00 loaded.
[    6.466078] ohci1394: fw-host0: OHCI-1394 1.1 (PCI): IRQ=[19]  MMIO=[fdefe000-fdefe7ff]  Max Packet=[2048]  IR/IT contexts=[4/8]
[    6.485079] ahci 0000:06:00.0: version 3.0
[    6.485450] ACPI: PCI Interrupt Link [APC7] enabled at IRQ 16
[    6.485459] ahci 0000:06:00.0: PCI INT A -> Link[APC7] -> GSI 16 (level, low) -> IRQ 16
[    6.501157] ahci 0000:06:00.0: AHCI 0001.0000 32 slots 2 ports 3 Gbps 0x3 impl SATA mode
[    6.501161] ahci 0000:06:00.0: flags: 64bit ncq pm led clo pmp pio slum part 
[    6.501165] ahci 0000:06:00.0: setting latency timer to 64
[    6.520305] scsi0 : ahci
[    6.528884] scsi1 : ahci
[    6.528938] ata1: SATA max UDMA/133 abar m8192@0xfddfe000 port 0xfddfe100 irq 16
[    6.528941] ata2: SATA max UDMA/133 abar m8192@0xfddfe000 port 0xfddfe180 irq 16
[    6.881130] ata1: SATA link down (SStatus 0 SControl 300)
[    6.956465] forcedeth 0000:00:08.0: ifname eth1, PHY OUI 0x5043 @ 1, addr 00:1a:92:97:26:50
[    6.956468] forcedeth 0000:00:08.0: highdma csum vlan pwrctl mgmt timirq gbit lnktim msi desc-v3
[    6.956482] pata_amd 0000:00:04.0: version 0.3.10
[    6.956514] pata_amd 0000:00:04.0: setting latency timer to 64
[    6.976031] scsi2 : pata_amd
[    6.976107] scsi3 : pata_amd
[    6.976696] ata3: PATA max UDMA/133 cmd 0x1f0 ctl 0x3f6 bmdma 0xf000 irq 14
[    6.976698] ata4: PATA max UDMA/133 cmd 0x170 ctl 0x376 bmdma 0xf008 irq 15
[    7.140242] ata3.00: ATAPI: LITE-ON CD-RW SOHR-5238S, 4S04, max UDMA/33
[    7.140258] ata3: nv_mode_filter: 0x739f&0x701f->0x701f, BIOS=0x7000 (0xc0000000) ACPI=0x701f (60:600:0x13)
[    7.156189] ata3.00: configured for UDMA/33
[    7.156666] ata4: port disabled. ignoring.
[    7.157479] scsi 2:0:0:0: CD-ROM            LITE-ON  CD-RW SOHR-5238S 4S04 PQ: 0 ANSI: 5
[    7.157567] sata_nv 0000:00:05.0: version 3.5
[    7.157927] ACPI: PCI Interrupt Link [APSI] enabled at IRQ 20
[    7.157936] sata_nv 0000:00:05.0: PCI INT A -> Link[APSI] -> GSI 20 (level, low) -> IRQ 20
[    7.157938] sata_nv 0000:00:05.0: Using SWNCQ mode
[    7.157984] sata_nv 0000:00:05.0: setting latency timer to 64
[    7.158080] scsi4 : sata_nv
[    7.158141] scsi5 : sata_nv
[    7.158282] ata5: SATA max UDMA/133 cmd 0x9f0 ctl 0xbf0 bmdma 0xdc00 irq 20
[    7.158284] ata6: SATA max UDMA/133 cmd 0x970 ctl 0xb70 bmdma 0xdc08 irq 20
[    7.216029] ata2: SATA link down (SStatus 0 SControl 300)
[    7.237375] scsi 2:0:0:0: Attached scsi generic sg0 type 5
[    7.624033] ata5: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[    7.633105] ata5.00: ATA-8: WDC WD10EACS-00D6B0, 01.01A01, max UDMA/133
[    7.633108] ata5.00: 1953525168 sectors, multi 1: LBA48 NCQ (depth 31/32)
[    7.641148] ata5.00: configured for UDMA/133
[    7.793142] ieee1394: Host added: ID:BUS[0-00:1023]  GUID[0011d800012df8c1]
[    7.952084] scsi 4:0:0:0: Direct-Access     ATA      WDC WD10EACS-00D 01.0 PQ: 0 ANSI: 5
[    7.952188] scsi 4:0:0:0: Attached scsi generic sg1 type 0
[    7.952787] ACPI: PCI Interrupt Link [AMC1] enabled at IRQ 23
[    7.952790] forcedeth 0000:00:09.0: PCI INT A -> Link[AMC1] -> GSI 23 (level, low) -> IRQ 23
[    7.952793] forcedeth 0000:00:09.0: setting latency timer to 64
[    7.952834] nv_probe: set workaround bit for reversed mac addr
[    8.472456] forcedeth 0000:00:09.0: ifname eth2, PHY OUI 0x5043 @ 1, addr 00:1a:92:97:32:4c
[    8.472458] forcedeth 0000:00:09.0: highdma csum vlan pwrctl mgmt timirq gbit lnktim msi desc-v3
[    8.473087] ACPI: PCI Interrupt Link [APSJ] enabled at IRQ 22
[    8.473090] sata_nv 0000:00:05.1: PCI INT B -> Link[APSJ] -> GSI 22 (level, low) -> IRQ 22
[    8.473091] sata_nv 0000:00:05.1: Using SWNCQ mode
[    8.473129] sata_nv 0000:00:05.1: setting latency timer to 64
[    8.474160] scsi6 : sata_nv
[    8.474232] scsi7 : sata_nv
[    8.474396] ata7: SATA max UDMA/133 cmd 0x9e0 ctl 0xbe0 bmdma 0xc800 irq 22
[    8.474398] ata8: SATA max UDMA/133 cmd 0x960 ctl 0xb60 bmdma 0xc808 irq 22
[    9.388033] ata7: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[    9.420757] ata7.00: ATA-8: WDC WD10EACS-00D6B0, 01.01A01, max UDMA/133
[    9.420759] ata7.00: 1953525168 sectors, multi 1: LBA48 NCQ (depth 31/32)
[    9.436769] ata7.00: configured for UDMA/133
[    9.905029] ata8: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[    9.912556] ata8.00: ATA-8: WDC WD10EACS-00D6B0, 01.01A01, max UDMA/133
[    9.912558] ata8.00: 1953525168 sectors, multi 1: LBA48 NCQ (depth 31/32)
[    9.920579] ata8.00: configured for UDMA/133
[    9.921024] scsi 6:0:0:0: Direct-Access     ATA      WDC WD10EACS-00D 01.0 PQ: 0 ANSI: 5
[    9.921141] scsi 6:0:0:0: Attached scsi generic sg2 type 0
[    9.922856] scsi 7:0:0:0: Direct-Access     ATA      WDC WD10EACS-00D 01.0 PQ: 0 ANSI: 5
[    9.922916] scsi 7:0:0:0: Attached scsi generic sg3 type 0
[    9.923279] ACPI: PCI Interrupt Link [ASA2] enabled at IRQ 21
[    9.923282] sata_nv 0000:00:05.2: PCI INT C -> Link[ASA2] -> GSI 21 (level, low) -> IRQ 21
[    9.923284] sata_nv 0000:00:05.2: Using SWNCQ mode
[    9.923322] sata_nv 0000:00:05.2: setting latency timer to 64
[    9.925153] scsi8 : sata_nv
[    9.925214] scsi9 : sata_nv
[    9.925408] ata9: SATA max UDMA/133 cmd 0xc400 ctl 0xc000 bmdma 0xb400 irq 21
[    9.925410] ata10: SATA max UDMA/133 cmd 0xbc00 ctl 0xb800 bmdma 0xb408 irq 21
[   10.392029] ata9: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[   10.401105] ata9.00: ATAPI: SONY    DVD RW AW-G170S, 1.72, max UDMA/66
[   10.416116] ata9.00: configured for UDMA/66
[   10.885027] ata10: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[   10.892578] ata10.00: ATA-8: WDC WD10EACS-00D6B0, 01.01A01, max UDMA/133
[   10.892580] ata10.00: 1953525168 sectors, multi 1: LBA48 NCQ (depth 31/32)
[   10.901602] ata10.00: configured for UDMA/133
[   10.902618] scsi 8:0:0:0: CD-ROM            SONY     DVD RW AW-G170S  1.72 PQ: 0 ANSI: 5
[   10.902729] scsi 8:0:0:0: Attached scsi generic sg4 type 5
[   10.902769] scsi 9:0:0:0: Direct-Access     ATA      WDC WD10EACS-00D 01.0 PQ: 0 ANSI: 5
[   10.902828] scsi 9:0:0:0: Attached scsi generic sg5 type 0
[   10.907000] pata_jmicron 0000:06:00.1: enabling device (0000 -> 0001)
[   10.907347] ACPI: PCI Interrupt Link [APC8] enabled at IRQ 16
[   10.907350] pata_jmicron 0000:06:00.1: PCI INT B -> Link[APC8] -> GSI 16 (level, low) -> IRQ 16
[   10.907378] pata_jmicron 0000:06:00.1: setting latency timer to 64
[   10.908687] scsi10 : pata_jmicron
[   10.908741] scsi11 : pata_jmicron
[   10.908768] ata11: PATA max UDMA/100 cmd 0x8c00 ctl 0x8800 bmdma 0x7c00 irq 16
[   10.908770] ata12: PATA max UDMA/100 cmd 0x8400 ctl 0x8000 bmdma 0x7c08 irq 16
[   11.260102] Driver 'sd' needs updating - please use bus_type methods
[   11.260207] sd 4:0:0:0: [sda] 1953525168 512-byte hardware sectors: (1.00 TB/931 GiB)
[   11.260219] sd 4:0:0:0: [sda] Write Protect is off
[   11.260220] sd 4:0:0:0: [sda] Mode Sense: 00 3a 00 00
[   11.260237] sd 4:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[   11.260285] sd 4:0:0:0: [sda] 1953525168 512-byte hardware sectors: (1.00 TB/931 GiB)
[   11.260294] sd 4:0:0:0: [sda] Write Protect is off
[   11.260295] sd 4:0:0:0: [sda] Mode Sense: 00 3a 00 00
[   11.260310] sd 4:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[   11.260313]  sda:<4>Driver 'sr' needs updating - please use bus_type methods
[   11.269045] sr0: scsi3-mmc drive: 63x/52x writer cd/rw xa/form2 cdda tray
[   11.269048] Uniform CD-ROM driver Revision: 3.20
[   11.269117] sr 2:0:0:0: Attached scsi CD-ROM sr0
[   11.270370]  sda1 sda2
[   11.279740] sd 4:0:0:0: [sda] Attached SCSI disk
[   11.279803] sd 6:0:0:0: [sdb] 1953525168 512-byte hardware sectors: (1.00 TB/931 GiB)
[   11.279814] sd 6:0:0:0: [sdb] Write Protect is off
[   11.279815] sd 6:0:0:0: [sdb] Mode Sense: 00 3a 00 00
[   11.279831] sd 6:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[   11.279877] sd 6:0:0:0: [sdb] 1953525168 512-byte hardware sectors: (1.00 TB/931 GiB)
[   11.279886] sd 6:0:0:0: [sdb] Write Protect is off
[   11.279888] sd 6:0:0:0: [sdb] Mode Sense: 00 3a 00 00
[   11.279903] sd 6:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[   11.279905]  sdb: sdb1
[   11.296241] sd 6:0:0:0: [sdb] Attached SCSI disk
[   11.296295] sd 7:0:0:0: [sdc] 1953525168 512-byte hardware sectors: (1.00 TB/931 GiB)
[   11.296305] sd 7:0:0:0: [sdc] Write Protect is off
[   11.296307] sd 7:0:0:0: [sdc] Mode Sense: 00 3a 00 00
[   11.296323] sd 7:0:0:0: [sdc] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[   11.296360] sd 7:0:0:0: [sdc] 1953525168 512-byte hardware sectors: (1.00 TB/931 GiB)
[   11.296369] sd 7:0:0:0: [sdc] Write Protect is off
[   11.296371] sd 7:0:0:0: [sdc] Mode Sense: 00 3a 00 00
[   11.296386] sd 7:0:0:0: [sdc] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[   11.296388]  sdc: sdc1
[   11.867154] sd 7:0:0:0: [sdc] Attached SCSI disk
[   11.869020] sd 9:0:0:0: [sdd] 1953525168 512-byte hardware sectors: (1.00 TB/931 GiB)
[   11.869094] sd 9:0:0:0: [sdd] Write Protect is off
[   11.869096] sd 9:0:0:0: [sdd] Mode Sense: 00 3a 00 00
[   11.869213] sd 9:0:0:0: [sdd] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[   11.869261] sd 9:0:0:0: [sdd] 1953525168 512-byte hardware sectors: (1.00 TB/931 GiB)
[   11.869270] sd 9:0:0:0: [sdd] Write Protect is off
[   11.869272] sd 9:0:0:0: [sdd] Mode Sense: 00 3a 00 00
[   11.869288] sd 9:0:0:0: [sdd] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[   11.869290]  sdd:sr1: scsi3-mmc drive: 125x/125x writer dvd-ram cd/rw xa/form2 cdda tray
[   11.870127] sr 8:0:0:0: Attached scsi CD-ROM sr1
[   12.428726]  sdd1
[   12.428799] sd 9:0:0:0: [sdd] Attached SCSI disk
[   13.063643] PM: Starting manual resume from disk
[   13.063645] PM: Resume from partition 8:2
[   13.063646] PM: Checking hibernation image.
[   13.063771] PM: Resume from disk failed.
[   13.077323] EXT3-fs: INFO: recovery required on readonly filesystem.
[   13.077326] EXT3-fs: write access will be enabled during recovery.
[   14.641707] kjournald starting.  Commit interval 5 seconds
[   14.641719] EXT3-fs: recovery complete.
[   14.642021] EXT3-fs: mounted filesystem with ordered data mode.
[   19.769626] udevd version 124 started
[   20.065980] input: Power Button (FF) as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2
[   20.068834] i2c-adapter i2c-0: nForce2 SMBus adapter at 0x1c00
[   20.068838] ACPI: I/O resource nForce2_smbus [0x1c40-0x1c7f] conflicts with ACPI region SM01 [0x1c40-0x1c45]
[   20.068840] ACPI: Device needs an ACPI driver
[   20.068853] i2c-adapter i2c-1: nForce2 SMBus adapter at 0x1c40
[   20.081019] ACPI: Power Button (FF) [PWRF]
[   20.081087] input: Power Button (CM) as /devices/LNXSYSTM:00/device:00/PNP0C0C:00/input/input3
[   20.097020] ACPI: Power Button (CM) [PWRB]
[   20.104240] ck804xrom ck804xrom_init_one(): Unable to register resource 0x00000000ff000000-0x00000000ffffffff - kernel bug?
[   20.104248] resource map sanity check conflict: 0xff000000 0xffffffff 0xfff80000 0xfff80fff pnp 00:0e
[   20.104255] ------------[ cut here ]------------
[   20.104257] WARNING: at arch/x86/mm/ioremap.c:226 __ioremap_caller+0x349/0x390()
[   20.104258] Modules linked in: ck804xrom(+) mtd chipreg i2c_nforce2 button map_funcs i2c_core ext3 jbd mbcache sr_mod cdrom sd_mod crc_t10dif pata_acpi pata_jmicron sg ata_generic ahci sata_nv pata_amd ohci1394 forcedeth ieee1394 ehci_hcd ohci_hcd 8139cp 8139too mii libata scsi_mod usbcore dm_mirror dm_region_hash dm_log dm_snapshot dm_mod thermal processor fan fuse
[   20.104275] Pid: 2850, comm: modprobe Not tainted 2.6.28-rc9 #1
[   20.104277] Call Trace:
[   20.104282]  [<ffffffff8025037f>] warn_on_slowpath+0x5f/0x90
[   20.104284]  [<ffffffff8022f599>] ? default_spin_lock_flags+0x9/0x10
[   20.104286]  [<ffffffff8022f599>] ? default_spin_lock_flags+0x9/0x10
[   20.104288]  [<ffffffff802366b9>] __ioremap_caller+0x349/0x390
[   20.104291]  [<ffffffffa026b11f>] ? init_ck804xrom+0x11f/0x600 [ck804xrom]
[   20.104294]  [<ffffffff80236812>] ioremap_nocache+0x12/0x20
[   20.104296]  [<ffffffffa026b11f>] init_ck804xrom+0x11f/0x600 [ck804xrom]
[   20.104298]  [<ffffffffa026b000>] ? init_ck804xrom+0x0/0x600 [ck804xrom]
[   20.104301]  [<ffffffff8020a03b>] do_one_initcall+0x3b/0x170
[   20.104304]  [<ffffffff8027d379>] ? load_module+0x19d9/0x1d00
[   20.104307]  [<ffffffff80241d32>] ? enqueue_entity+0x122/0x2b0
[   20.104310]  [<ffffffff80226c2a>] ? native_smp_send_reschedule+0x3a/0x50
[   20.104312]  [<ffffffff80247196>] ? resched_task+0x76/0x90
[   20.104313]  [<ffffffff80248325>] ? check_preempt_wakeup+0x205/0x220
[   20.104315]  [<ffffffff8024902c>] ? try_to_wake_up+0x12c/0x2e0
[   20.104318]  [<ffffffff8027d74d>] sys_init_module+0xad/0x1e0
[   20.104320]  [<ffffffff8021253a>] system_call_fastpath+0x16/0x1b
[   20.104321] ---[ end trace 8005737ef215d0df ]---
[   20.209277] Found: SST 49LF040B
[   20.209285] ck804xrom @fff80000: Found 1 x8 devices at 0x0 in 8-bit bank
[   20.299225] using fwh lock/unlock method
[   20.299228] number of JEDEC chips: 1
[   20.299230] cfi_cmdset_0002: Disabling erase-suspend-program due to code brokenness.
[   20.584830] parport_pc 00:0a: reported by Plug and Play ACPI
[   20.584854] parport0: PC-style at 0x378, irq 7 [PCSPP,TRISTATE,EPP]
[   20.870506] end_request: I/O error, dev sr1, sector 0
[   20.870511] Buffer I/O error on device sr1, logical block 0
[   20.871241] end_request: I/O error, dev sr1, sector 0
[   20.871243] Buffer I/O error on device sr1, logical block 0
[   21.007802] device-mapper: multipath: version 1.0.5 loaded
[   21.068647] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
[   21.173543] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
[   21.356782] udev: renamed network interface eth1 to eth0
[   21.385274] udev: renamed network interface eth2 to eth1
[   21.393753] udev: renamed network interface eth0_rename to eth2
[   21.404635] input: PC Speaker as /devices/platform/pcspkr/input/input4
[   21.555465] logips2pp: Detected unknown logitech mouse model 127
[   21.987236] ACPI: PCI Interrupt Link [AAZA] enabled at IRQ 20
[   21.987241] HDA Intel 0000:00:06.1: PCI INT B -> Link[AAZA] -> GSI 20 (level, low) -> IRQ 20
[   21.987381] HDA Intel 0000:00:06.1: setting latency timer to 64
[   22.032872] input: ImExPS/2 Logitech Explorer Mouse as /devices/platform/i8042/serio1/input/input5
[   23.692635] lp0: using parport0 (interrupt-driven).
[   23.808635] Adding 4000176k swap on /dev/sda2.  Priority:-1 extents:1 across:4000176k
[   24.351885] EXT3 FS on sda1, internal journal
[  603.482012] kjournald starting.  Commit interval 5 seconds
[  603.482994] EXT3 FS on sdb1, internal journal
[  603.482999] EXT3-fs: mounted filesystem with ordered data mode.
[  603.890667] type=1505 audit(1229999279.342:2): operation="profile_load" name="/usr/share/gdm/guest-session/Xsession" name2="default" pid=10479
[  604.012303] type=1505 audit(1229999279.462:3): operation="profile_load" name="/usr/lib/cups/backend/cups-pdf" name2="default" pid=10484
[  604.012434] type=1505 audit(1229999279.462:4): operation="profile_load" name="/usr/sbin/cupsd" name2="default" pid=10484
[  604.192788] ip_tables: (C) 2000-2006 Netfilter Core Team
[  604.359199] Bridge firewalling registered
[  604.381377] device eth2 entered promiscuous mode
[  604.386393] eth2: link up, 100Mbps, full-duplex, lpa 0xC5E1
[  604.390013] br0: port 1(eth2) entering learning state
[  613.388010] br0: topology change detected, propagating
[  613.388013] br0: port 1(eth2) entering forwarding state
[  614.164336] NET: Registered protocol family 10
[  614.164690] lo: Disabled Privacy Extensions
[  615.287223] ACPI: WMI: Mapper loaded
[  615.646051] powernow-k8: Found 1 AMD Athlon(tm) 64 X2 Dual Core Processor 6000+ processors (2 cpu cores) (version 2.20.00)
[  615.646072] powernow-k8: ACPI Processor support is required for SMP systems but is absent. Please load the ACPI Processor module before starting this driver.
[  615.646091] powernow-k8: ACPI Processor support is required for SMP systems but is absent. Please load the ACPI Processor module before starting this driver.
[  616.477236] warning: `avahi-daemon' uses 32-bit capabilities (legacy support in use)
[  616.718731] ppdev: user-space parallel port driver
[  623.622262] cdrom: This disc doesn't have any tracks I recognize!
[  623.802083] Bluetooth: Core ver 2.13
[  623.804706] NET: Registered protocol family 31
[  623.804708] Bluetooth: HCI device and connection manager initialized
[  623.804711] Bluetooth: HCI socket layer initialized
[  623.833167] Bluetooth: L2CAP ver 2.11
[  623.833169] Bluetooth: L2CAP socket layer initialized
[  623.892925] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[  623.892927] Bluetooth: BNEP filters: protocol multicast
[  623.967730] Bluetooth: RFCOMM socket layer initialized
[  623.967740] Bluetooth: RFCOMM TTY layer initialized
[  623.967741] Bluetooth: RFCOMM ver 1.10
[  623.984870] Bluetooth: SCO (Voice Link) ver 0.6
[  623.984872] Bluetooth: SCO socket layer initialized
[  624.588008] eth2: no IPv6 routers present
[  625.000013] br0: no IPv6 routers present
[  626.264524] mtrr: base(0xe0000000) is not aligned on a size(0xff00000) boundary
[  638.731683] tun: Universal TUN/TAP device driver, 1.6
[  638.731686] tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com>
[  639.344186] device tap0 entered promiscuous mode
[  639.344210] br0: port 2(tap0) entering learning state
[  639.870249] device tap1 entered promiscuous mode
[  648.344009] br0: topology change detected, propagating
[  648.344014] br0: port 2(tap0) entering forwarding state
[  648.794233] kvm: emulating exchange as write
[  648.920007] tap0: no IPv6 routers present
[  649.528007] tap1: no IPv6 routers present
[  771.621159] ppdev0: registered pardevice
[  771.669096] ppdev0: unregistered pardevice
[  771.723236] ppdev0: registered pardevice
[  771.769125] ppdev0: unregistered pardevice
[  774.250576] ppdev0: registered pardevice
[  774.297030] ppdev0: unregistered pardevice
[  774.996153] cdrom: This disc doesn't have any tracks I recognize!
[  919.537523] br0: port 2(tap0) entering disabled state
[  919.548667] device tap0 left promiscuous mode
[  919.548672] br0: port 2(tap0) entering disabled state
[  919.588590] device tap1 left promiscuous mode
[  919.588594] br1: port 1(tap1) entering disabled state
[ 1027.896245] kvm: 12638: cpu0 unhandled wrmsr: 0xc0010117 data 0
[ 1124.478956] kvm: 12641: cpu0 unhandled wrmsr: 0xc0010117 data 0
[ 1265.952326] device tap0 entered promiscuous mode
[ 1265.952351] br0: port 2(tap0) entering learning state
[ 1266.613604] kvm: 12659: cpu0 unhandled wrmsr: 0xc0010117 data 0
[ 1274.949009] br0: topology change detected, propagating
[ 1274.949014] br0: port 2(tap0) entering forwarding state
[ 1276.128018] tap0: no IPv6 routers present
[ 1299.445873] kvm: 12659: cpu0 unhandled rdmsr: 0xc0010114
[ 1299.446115] set_efer: 0x1d01 #GP, reserved bits
[ 1488.050343] br0: port 2(tap0) entering disabled state
[ 1488.062312] device tap0 left promiscuous mode
[ 1488.062316] br0: port 2(tap0) entering disabled state
[ 1500.038694] device tap0 entered promiscuous mode
[ 1500.038718] br0: port 2(tap0) entering learning state
[ 1500.700695] kvm: 12752: cpu0 unhandled wrmsr: 0xc0010117 data 0
[ 1509.040010] br0: topology change detected, propagating
[ 1509.040014] br0: port 2(tap0) entering forwarding state
[ 1510.353020] tap0: no IPv6 routers present
[ 1531.236817] kvm: 12752: cpu0 unhandled rdmsr: 0xc0010114
[ 1531.237070] set_efer: 0x1d01 #GP, reserved bits
[ 2382.222352] br0: port 2(tap0) entering disabled state
[ 2382.233650] device tap0 left promiscuous mode
[ 2382.233655] br0: port 2(tap0) entering disabled state
[ 2419.648145] device tap0 entered promiscuous mode
[ 2419.648169] br0: port 2(tap0) entering learning state
[ 2420.279841] kvm: 12838: cpu0 unhandled wrmsr: 0xc0010117 data 0
[ 2428.645012] br0: topology change detected, propagating
[ 2428.645017] br0: port 2(tap0) entering forwarding state
[ 2430.068010] tap0: no IPv6 routers present
[ 2452.067855] kvm: 12838: cpu0 unhandled rdmsr: 0xc0010114
[ 2452.068097] set_efer: 0x1d01 #GP, reserved bits
[ 2471.406522] br0: port 2(tap0) entering disabled state
[ 2471.417625] device tap0 left promiscuous mode
[ 2471.417630] br0: port 2(tap0) entering disabled state
[ 2480.470171] device tap0 entered promiscuous mode
[ 2480.470195] br0: port 2(tap0) entering learning state
[ 2481.047748] kvm: 12875: cpu0 unhandled wrmsr: 0xc0010117 data 0
[ 2489.469015] br0: topology change detected, propagating
[ 2489.469019] br0: port 2(tap0) entering forwarding state
[ 2490.697015] tap0: no IPv6 routers present
[ 2510.779115] kvm: 12875: cpu0 unhandled rdmsr: 0xc0010114
[ 2510.779347] set_efer: 0x1d01 #GP, reserved bits
[ 2530.282382] br0: port 2(tap0) entering disabled state
[ 2530.293613] device tap0 left promiscuous mode
[ 2530.293617] br0: port 2(tap0) entering disabled state
[ 2625.427252] device tap0 entered promiscuous mode
[ 2625.427276] br0: port 2(tap0) entering learning state
[ 2625.457617] br0: port 2(tap0) entering disabled state
[ 2625.469580] device tap0 left promiscuous mode
[ 2625.469584] br0: port 2(tap0) entering disabled state
[ 2908.262715] device tap0 entered promiscuous mode
[ 2908.262742] br0: port 2(tap0) entering learning state
[ 2908.289181] br0: port 2(tap0) entering disabled state
[ 2908.300617] device tap0 left promiscuous mode
[ 2908.300621] br0: port 2(tap0) entering disabled state
[ 2917.131116] cdrom: This disc doesn't have any tracks I recognize!
[ 2917.190089] end_request: I/O error, dev sr0, sector 0
[ 2917.190094] Buffer I/O error on device sr0, logical block 0
[ 2917.191155] end_request: I/O error, dev sr0, sector 0
[ 2917.191157] Buffer I/O error on device sr0, logical block 0
[ 2921.441781] cdrom: This disc doesn't have any tracks I recognize!
[ 2921.487124] end_request: I/O error, dev sr1, sector 0
[ 2921.487129] Buffer I/O error on device sr1, logical block 0
[ 2921.487876] end_request: I/O error, dev sr1, sector 0
[ 2921.487878] Buffer I/O error on device sr1, logical block 0
[ 3012.807306] device tap0 entered promiscuous mode
[ 3012.807331] br0: port 2(tap0) entering learning state
[ 3012.837156] br0: port 2(tap0) entering disabled state
[ 3012.848579] device tap0 left promiscuous mode
[ 3012.848583] br0: port 2(tap0) entering disabled state
[ 3154.993637] device tap0 entered promiscuous mode
[ 3154.993663] br0: port 2(tap0) entering learning state
[ 3156.142334] kvm: 13076: cpu0 unhandled wrmsr: 0xc0010117 data 0
[ 3163.992010] br0: topology change detected, propagating
[ 3163.992015] br0: port 2(tap0) entering forwarding state
[ 3165.172009] tap0: no IPv6 routers present
[ 3186.707930] kvm: 13076: cpu0 unhandled rdmsr: 0xc0010114
[ 3186.708154] set_efer: 0x1d01 #GP, reserved bits
[ 6666.633762] end_request: I/O error, dev sr0, sector 0
[ 6666.633768] Buffer I/O error on device sr0, logical block 0
[ 6666.634916] end_request: I/O error, dev sr0, sector 0
[ 6666.634919] Buffer I/O error on device sr0, logical block 0
[ 6666.850762] cdrom: This disc doesn't have any tracks I recognize!
[ 7011.681179] gtk-gnash[13725]: segfault at 0 ip 00007f4d4bb45182 sp 00007fff54709fc0 error 4 in libgnashcore-0.8.4.so[7f4d4ba09000+49c000]
[11437.270307] br0: port 2(tap0) entering disabled state
[11437.282225] device tap0 left promiscuous mode
[11437.282229] br0: port 2(tap0) entering disabled state
[11448.706012] device tap0 entered promiscuous mode
[11448.706037] br0: port 2(tap0) entering learning state
[11449.992867] kvm: 14100: cpu0 unhandled wrmsr: 0xc0010117 data 0
[11457.705012] br0: topology change detected, propagating
[11457.705017] br0: port 2(tap0) entering forwarding state
[11458.957012] tap0: no IPv6 routers present
[11488.835434] kvm: 14100: cpu0 unhandled rdmsr: 0xc0010114
[11488.835674] kvm: 14100: cpu0 unhandled rdmsr: 0xc0010117
[11488.835711] set_efer: 0x1d01 #GP, reserved bits
[14075.099722] kvm: 14100: cpu0 unhandled wrmsr: 0xc0010117 data 0
[14109.904791] kvm: 14100: cpu0 unhandled rdmsr: 0xc0010114
[14109.904995] kvm: 14100: cpu0 unhandled rdmsr: 0xc0010117
[14109.905037] set_efer: 0x1d01 #GP, reserved bits
[14617.516105] kvm: 14100: cpu0 unhandled wrmsr: 0xc0010117 data 0
[14647.017670] kvm: 14100: cpu0 unhandled rdmsr: 0xc0010114
[14647.017886] kvm: 14100: cpu0 unhandled rdmsr: 0xc0010117
[14647.017931] set_efer: 0x1d01 #GP, reserved bits
[15827.219203] device tap1 entered promiscuous mode
[15827.219230] br0: port 3(tap1) entering learning state
[15827.745256] device tap2 entered promiscuous mode
[15827.845519] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[15836.217009] br0: topology change detected, propagating
[15836.217013] br0: port 3(tap1) entering forwarding state
[15837.525012] tap1: no IPv6 routers present
[15838.072012] tap2: no IPv6 routers present
[15868.679379] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[15868.679703] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[15868.679894] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[15868.680627] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[15868.680956] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[15868.681100] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[15868.681211] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[15868.681307] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[15868.681411] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[16566.521574] __ratelimit: 25 callbacks suppressed
[16566.521577] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[16566.521859] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[16566.522049] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[16566.522230] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[16566.522450] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[16566.522632] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[16566.522822] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[16566.523015] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[16566.523205] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[16566.523385] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[16585.429696] __ratelimit: 1078 callbacks suppressed
[16585.429699] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[16585.430012] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[16585.430313] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[16585.430611] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[16585.430971] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[16585.431277] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[16585.431578] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[16585.431874] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[16585.432239] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[16585.432533] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[16592.766752] __ratelimit: 1172 callbacks suppressed
[16592.766755] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[16592.767178] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[16592.767602] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[16592.768023] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[16592.768488] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[16592.768865] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[16592.769267] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[16592.769646] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[16592.770037] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[16592.770408] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[17630.043209] __ratelimit: 424 callbacks suppressed
[17630.043211] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[17630.043710] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[17630.044466] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[17630.044897] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[17630.045318] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[17630.045630] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[17630.045959] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[17630.046263] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[17630.046592] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[17630.046895] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[17692.604575] __ratelimit: 714 callbacks suppressed
[17692.604578] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[17692.604699] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[17692.604749] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[17692.604795] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[17692.604864] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[17692.604910] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[17692.604960] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[17692.605020] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[17692.605071] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[17692.605117] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[18139.742347] mtrr: base(0xe0000000) is not aligned on a size(0xff00000) boundary
[18229.883256] ppdev0: registered pardevice
[18229.933096] ppdev0: unregistered pardevice
[18229.991527] ppdev0: registered pardevice
[18230.040206] ppdev0: unregistered pardevice
[18236.654372] ppdev0: registered pardevice
[18236.701215] ppdev0: unregistered pardevice
[20111.374637] cdrom: This disc doesn't have any tracks I recognize!
[20111.573797] end_request: I/O error, dev sr0, sector 0
[20111.573802] __ratelimit: 900 callbacks suppressed
[20111.573805] Buffer I/O error on device sr0, logical block 0
[20111.593769] end_request: I/O error, dev sr0, sector 0
[20111.593775] Buffer I/O error on device sr0, logical block 0
[24695.001586] Clocksource tsc unstable (delta = 62501417 ns)
[50867.780899] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[50867.781351] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[50867.781668] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[50867.781978] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[50867.782319] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[50867.782630] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[50867.782945] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[50867.783254] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[50867.783569] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[50867.783883] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[51056.177718] __ratelimit: 528 callbacks suppressed
[51056.177721] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[51056.177995] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[51056.178081] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[51056.178159] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[51056.178294] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[51056.178373] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[51056.178458] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[51056.178542] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[51056.178627] kvm: 14970: cpu0 unhandled rdmsr: 0xc0010117
[51056.178705] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
[51261.369945] device tap3 entered promiscuous mode
[51261.369969] br0: port 4(tap3) entering learning state
[51261.892675] device tap4 entered promiscuous mode
[51261.970162] br0: port 4(tap3) entering disabled state
[51261.981628] device tap3 left promiscuous mode
[51261.981632] br0: port 4(tap3) entering disabled state
[51262.017638] device tap4 left promiscuous mode
[51262.017642] br1: port 2(tap4) entering disabled state

^ permalink raw reply	[flat|nested] 15+ messages in thread

* Re: Nested KVM
  2008-12-23 16:35   ` Todd Deshane
@ 2008-12-23 17:04     ` Alexander Graf
  2008-12-24  4:18       ` Todd Deshane
  0 siblings, 1 reply; 15+ messages in thread
From: Alexander Graf @ 2008-12-23 17:04 UTC (permalink / raw)
  To: deshantm; +Cc: kvm

>>> [   23.673107] Call Trace:
>>> [   23.673107]  [<ffffffffa02db196>] svm_hardware_enable+0xd6/0x140
>>> [kvm_amd]
>>> [   23.673107]  [<ffffffffa02b25e0>] ? hardware_enable+0x0/0x40  
>>> [kvm]
>>> [   23.673107]  [<ffffffffa02b4693>] kvm_arch_hardware_enable 
>>> +0x13/0x20
>>> [kvm]
>>> [   23.673107]  [<ffffffffa02b260f>] hardware_enable+0x2f/0x40 [kvm]
>>> [   23.673107]  [<ffffffff80254a44>] on_each_cpu+0x34/0x50
>>> [   23.673107]  [<ffffffffa02b0c85>] kvm_init+0x165/0x280 [kvm]
>>> [   23.673107]  [<ffffffffa00b3000>] ? svm_init+0x0/0x23 [kvm_amd]
>>> [   23.673107]  [<ffffffffa00b3021>] svm_init+0x21/0x23 [kvm_amd]
>>> [   23.673107]  [<ffffffff8020a041>] do_one_initcall+0x41/0x170
>>> [   23.673107]  [<ffffffff8026c261>] ?
>>> __blocking_notifier_call_chain+0x21/0x90
>>> [   23.673107]  [<ffffffff8027d085>] sys_init_module+0xb5/0x1f0
>>> [   23.673107]  [<ffffffff8021285a>] system_call_fastpath+0x16/0x1b
>>> [   23.673107]
>>> [   23.673107]
>>> [   23.673107] Code: 00 55 89 f9 48 89 e5 0f 32 31 c9 89 c7 48 89 d0
>>> 89 0e 48 c1 e0 20 89 fa 48 09 d0 c9 c3 0f 1f 40 00 55 89 f9 89 f0 48
>>> 89 e5 0f 30 <31> c0 c9 c3 66 90 55 89 f9 48 89 e5 0f 33 89 c1 48  
>>> 89 d0
>>> 48 c1
>>> [   23.673107] RIP  [<ffffffff8022d35a>] native_write_msr_safe+0xa/ 
>>> 0x10
>>> [   23.673107]  RSP <ffff880018dc3dd8>
>>> [   23.673107] ---[ end trace 0dc989f1cf9a296e ]---
>>>
>>> Maybe it is just that a newer version of KVM is needed?
>>>
>>> I will also try to build a newer version of KVM and test.
>>>
>>> Thanks for any comments.
>>
>> Your guest is writing to an MSR that is unknown to the kvm msr  
>> emulation.
>> What does dmesg on the host say?
>>
>
> Attached.

Your KVM kernel module does not like that the guest writes into  
MSR_VM_HSAVE_PA. This is pretty fundamental and should always work if  
you build current git kvm kernel modules. Are you sure you're using  
the current git modules? Are you using the -enable-nesting option for  
qemu?

Please try to rmmod everything, take a fresh checkout from git,  
compile it and load the module with insmod kvm-amd.ko nested=1. I  
can't think of any way this could fail.

Alex


^ permalink raw reply	[flat|nested] 15+ messages in thread

* Re: Nested KVM
  2008-12-23  9:00 ` Alexander Graf
  2008-12-23 16:35   ` Todd Deshane
@ 2008-12-23 17:05   ` Avi Kivity
  2008-12-23 17:10     ` Alexander Graf
  1 sibling, 1 reply; 15+ messages in thread
From: Avi Kivity @ 2008-12-23 17:05 UTC (permalink / raw)
  To: Alexander Graf; +Cc: deshantm, kvm

Alexander Graf wrote:
>
>> I have successfully built the latest kvm, kvm-userspace from git.
>>
>> I loaded the kvm_amd module with the nested=1 option.
>>
>> The kvm guest that I am working with has an older version
>> of kvm (Ubuntu 8.10 + kvm package) and during boot I get:
>>
>> [   23.673107] Pid: 4278, comm: modprobe Tainted: G S        
>> 2.6.27-7-generic #1
>> [   23.673107] RIP: 0010:[<ffffffff8022d35a>]  [<ffffffff8022d35a>]
>> native_write_msr_safe+0xa/0x10
>> [   23.673107] RSP: 0018:ffff880018dc3dd8  EFLAGS: 00010002
>> [   23.673107] RAX: 0000000000001d01 RBX: ffff880018dc3e04 RCX: 
>> 00000000c0000080
>>
>> Maybe it is just that a newer version of KVM is needed?
>>
>> I will also try to build a newer version of KVM and test.
>>
>> Thanks for any comments.
>
> Your guest is writing to an MSR that is unknown to the kvm msr 
> emulation. What does dmesg on the host say?
>

You can actually see that it's writing to EFER (rcx = 0xc00000080).  But 
that should always be implemented on AMD.  It's probably complaining 
about the svme bit, but that can only happen if nested=0?

-- 
error compiling committee.c: too many arguments to function


^ permalink raw reply	[flat|nested] 15+ messages in thread

* Re: Nested KVM
  2008-12-23 17:05   ` Avi Kivity
@ 2008-12-23 17:10     ` Alexander Graf
  2008-12-23 17:18       ` Avi Kivity
  0 siblings, 1 reply; 15+ messages in thread
From: Alexander Graf @ 2008-12-23 17:10 UTC (permalink / raw)
  To: Avi Kivity; +Cc: deshantm, kvm


On 23.12.2008, at 18:05, Avi Kivity wrote:

> Alexander Graf wrote:
>>
>>> I have successfully built the latest kvm, kvm-userspace from git.
>>>
>>> I loaded the kvm_amd module with the nested=1 option.
>>>
>>> The kvm guest that I am working with has an older version
>>> of kvm (Ubuntu 8.10 + kvm package) and during boot I get:
>>>
>>> [   23.673107] Pid: 4278, comm: modprobe Tainted: G S         
>>> 2.6.27-7-generic #1
>>> [   23.673107] RIP: 0010:[<ffffffff8022d35a>]  [<ffffffff8022d35a>]
>>> native_write_msr_safe+0xa/0x10
>>> [   23.673107] RSP: 0018:ffff880018dc3dd8  EFLAGS: 00010002
>>> [   23.673107] RAX: 0000000000001d01 RBX: ffff880018dc3e04 RCX:  
>>> 00000000c0000080
>>>
>>> Maybe it is just that a newer version of KVM is needed?
>>>
>>> I will also try to build a newer version of KVM and test.
>>>
>>> Thanks for any comments.
>>
>> Your guest is writing to an MSR that is unknown to the kvm msr  
>> emulation. What does dmesg on the host say?
>>
>
> You can actually see that it's writing to EFER (rcx = 0xc00000080).   
> But that should always be implemented on AMD.  It's probably  
> complaining about the svme bit, but that can only happen if nested=0?

Oh, right. But then again dmesg spits out a lot of these:

[51056.178705] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0

So writing HSAVE fails too, which should only happen on older KVM  
versions.

But nevertheless, setting EFER only works if nested=1 is given as  
module option and -enable-nesting is used on qemu (read: the SVM CPUID  
capability is set).

Alex

^ permalink raw reply	[flat|nested] 15+ messages in thread

* Re: Nested KVM
  2008-12-23 17:10     ` Alexander Graf
@ 2008-12-23 17:18       ` Avi Kivity
  0 siblings, 0 replies; 15+ messages in thread
From: Avi Kivity @ 2008-12-23 17:18 UTC (permalink / raw)
  To: Alexander Graf; +Cc: deshantm, kvm

Alexander Graf wrote:
>
> Oh, right. But then again dmesg spits out a lot of these:
>
> [51056.178705] kvm: 14970: cpu0 unhandled wrmsr: 0xc0010117 data 0
>

I think that's actually userspace writing to the msr, not the guest. 
Something's confused.


-- 
error compiling committee.c: too many arguments to function


^ permalink raw reply	[flat|nested] 15+ messages in thread

* Re: Nested KVM
  2008-12-23 17:04     ` Alexander Graf
@ 2008-12-24  4:18       ` Todd Deshane
  2008-12-24  9:20         ` Alexander Graf
  0 siblings, 1 reply; 15+ messages in thread
From: Todd Deshane @ 2008-12-24  4:18 UTC (permalink / raw)
  To: Alexander Graf; +Cc: kvm

On Tue, Dec 23, 2008 at 12:04 PM, Alexander Graf <agraf@suse.de> wrote:
> Your KVM kernel module does not like that the guest writes into
> MSR_VM_HSAVE_PA. This is pretty fundamental and should always work if you
> build current git kvm kernel modules. Are you sure you're using the current
> git modules? Are you using the -enable-nesting option for qemu?
>
> Please try to rmmod everything, take a fresh checkout from git, compile it
> and load the module with insmod kvm-amd.ko nested=1. I can't think of any
> way this could fail.
>

OK, so I followed your directions above much more carefully, got the latest
checkout and insmod'd kvm, kvm-amd nested=1 and watched carefully
to the syslog (dmesg).

When the kvm_amd module was loaded I get:

kvm: Nested Virtualization enabled

Good sign.

So I booted up a guest with:

sudo qemu-system-x86_64 -enable-nesting -m 512 -drive
file=/dev/storage/deshantm-desktop,if=virtio,boot=on -drive
file=/dev/storage/deshantm-temp-space,if=virtio -usb -usbdevice tablet
 -net nic,macaddr=00:16:3e:16:00:00,model=virtio -net
tap,script=/usr/local/share/qemu-ifup -daemonize -vnc :16

I checked /proc/cpuinfo, which showed the svm flag (doesn't show the
svm flag without the -enable-nesting)

So all looks pretty good.

During the guest boot, some normal looking messages.
Dec 23 22:42:28 amdbox kernel: [15715.578035] device tap0 entered
promiscuous mode
Dec 23 22:42:28 amdbox kernel: [15715.578059] br0: port 2(tap0)
entering learning state
Dec 23 22:42:29 amdbox avahi-daemon[5457]: Registering new address
record for fe80::f01d:36ff:fe6f:597 on tap0.*.
Dec 23 22:42:37 amdbox kernel: [15724.576010] br0: topology change
detected, propagating
Dec 23 22:42:37 amdbox kernel: [15724.576014] br0: port 2(tap0)
entering forwarding state
Dec 23 22:42:38 amdbox kernel: [15725.185009] tap0: no IPv6 routers present


Then, in the guest I run a more simple command:
sudo qemu-system-x86_64 -hda ubuntu-server.img -cdrom install_cd.iso
which produces dmesg in the base as follows:

Dec 23 22:44:05 amdbox kernel: [15812.088706] __ratelimit: 20
callbacks suppressed
Dec 23 22:44:05 amdbox kernel: [15812.088710] emulation failed (mmio)
rip ffffffffa0370a11 0f 01 da 0f
Dec 23 22:44:05 amdbox kernel: [15812.088798] emulation failed (mmio)
rip ffffffffa0370a11 0f 01 da 0f
Dec 23 22:44:05 amdbox kernel: [15812.088865] emulation failed (mmio)
rip ffffffffa0370a11 0f 01 da 0f
Dec 23 22:44:05 amdbox kernel: [15812.088917] emulation failed (mmio)
rip ffffffffa0370a11 0f 01 da 0f
Dec 23 22:44:05 amdbox kernel: [15812.088977] emulation failed (mmio)
rip ffffffffa0370a11 0f 01 da 0f
Dec 23 22:44:05 amdbox kernel: [15812.089018] emulation failed (mmio)
rip ffffffffa0370a11 0f 01 da 0f
Dec 23 22:44:05 amdbox kernel: [15812.089069] emulation failed (mmio)
rip ffffffffa0370a11 0f 01 da 0f
Dec 23 22:44:05 amdbox kernel: [15812.089110] emulation failed (mmio)
rip ffffffffa0370a11 0f 01 da 0f
Dec 23 22:44:05 amdbox kernel: [15812.089151] emulation failed (mmio)
rip ffffffffa0370a11 0f 01 da 0f
Dec 23 22:44:05 amdbox kernel: [15812.089190] emulation failed (mmio)
rip ffffffffa0370a11 0f 01 da 0f

This gives a lockup of the guest.

I also then tried a simpler guest command:
sudo qemu-system-x86_64 -enable-nesting -m 512 -drive
file=/dev/storage/deshantm-desktop,if=virtio,boot=on
Which also produces the same syslog messages and locks up the guest
when it tries to start kvm.
(I tried to start the nested kvm with onlly a cdrom as well).

git-log for the kernel shows:

commit 7b8052aecd9c533661493d1140cbec0e1ab311d3
Author: Alexander Graf <agraf@suse.de>
Date:   Thu Dec 18 13:30:57 2008 +0100

    KVM: SVM: don't run into endless loop in nested svm

    With the emulation optimization after clgi, we can potentially
    run into an endless loop thanks to while(true).

    While this should never occur in practise, except for when
    the emulation is broken or really awkward code is executed in
    the VM, this wasn't a problem so far.

    Signed-off-by: Alexander Graf <agraf@suse.de>
    Signed-off-by: Avi Kivity <avi@redhat.com>

commit e72dcf1240f59174ff7c18bd461021a00ed3e38c
Author: Avi Kivity <avi@redhat.com>
Date:   Tue Dec 23 19:46:01 2008 +0200

git-log on kvm-userspace shows
commit cd5b58d8a2fbd134b09f0be1de33773f162b79d4
Merge: a0b5207... f9cac6f...
Author: Avi Kivity <avi@redhat.com>
Date:   Tue Dec 23 18:52:56 2008 +0200

    Merge branch 'qemu-cvs'

    Conflicts:
        qemu/Makefile
        qemu/Makefile.target
        qemu/configure
        qemu/hw/pc.c
        qemu/hw/pc.h
        qemu/hw/pci.c
        qemu/hw/virtio-net.c
        qemu/net.c
        qemu/net.h
        qemu/pc-bios/bios.bin
        qemu/pc-bios/vgabios-cirrus.bin
        qemu/pc-bios/vgabios.bin
        qemu/target-ppc/helper.c
        qemu/vl.c

Let me know if there is any other information I can provide to
help troubleshoot.

Thanks,
Todd

-- 
Todd Deshane
http://todddeshane.net
http://runningxen.com

^ permalink raw reply	[flat|nested] 15+ messages in thread

* Re: Nested KVM
  2008-12-24  4:18       ` Todd Deshane
@ 2008-12-24  9:20         ` Alexander Graf
  2008-12-25  9:59           ` Avi Kivity
  2008-12-29 23:47           ` Todd Deshane
  0 siblings, 2 replies; 15+ messages in thread
From: Alexander Graf @ 2008-12-24  9:20 UTC (permalink / raw)
  To: deshantm; +Cc: kvm

[-- Attachment #1: Type: text/plain, Size: 2734 bytes --]


On 24.12.2008, at 05:18, Todd Deshane wrote:

> On Tue, Dec 23, 2008 at 12:04 PM, Alexander Graf <agraf@suse.de>  
> wrote:
>> Your KVM kernel module does not like that the guest writes into
>> MSR_VM_HSAVE_PA. This is pretty fundamental and should always work  
>> if you
>> build current git kvm kernel modules. Are you sure you're using the  
>> current
>> git modules? Are you using the -enable-nesting option for qemu?
>>
>> Please try to rmmod everything, take a fresh checkout from git,  
>> compile it
>> and load the module with insmod kvm-amd.ko nested=1. I can't think  
>> of any
>> way this could fail.
>>
>
> OK, so I followed your directions above much more carefully, got the  
> latest
> checkout and insmod'd kvm, kvm-amd nested=1 and watched carefully
> to the syslog (dmesg).
>
> When the kvm_amd module was loaded I get:
>
> kvm: Nested Virtualization enabled
>
> Good sign.
>
> So I booted up a guest with:
>
> sudo qemu-system-x86_64 -enable-nesting -m 512 -drive
> file=/dev/storage/deshantm-desktop,if=virtio,boot=on -drive
> file=/dev/storage/deshantm-temp-space,if=virtio -usb -usbdevice tablet
> -net nic,macaddr=00:16:3e:16:00:00,model=virtio -net
> tap,script=/usr/local/share/qemu-ifup -daemonize -vnc :16
>
> I checked /proc/cpuinfo, which showed the svm flag (doesn't show the
> svm flag without the -enable-nesting)
>
> So all looks pretty good.

Yep. That looks all pretty good :-). A lot better than before!

>
>
> During the guest boot, some normal looking messages.
> Dec 23 22:42:28 amdbox kernel: [15715.578035] device tap0 entered
> promiscuous mode
> Dec 23 22:42:28 amdbox kernel: [15715.578059] br0: port 2(tap0)
> entering learning state
> Dec 23 22:42:29 amdbox avahi-daemon[5457]: Registering new address
> record for fe80::f01d:36ff:fe6f:597 on tap0.*.
> Dec 23 22:42:37 amdbox kernel: [15724.576010] br0: topology change
> detected, propagating
> Dec 23 22:42:37 amdbox kernel: [15724.576014] br0: port 2(tap0)
> entering forwarding state
> Dec 23 22:42:38 amdbox kernel: [15725.185009] tap0: no IPv6 routers  
> present
>
>
> Then, in the guest I run a more simple command:
> sudo qemu-system-x86_64 -hda ubuntu-server.img -cdrom install_cd.iso
> which produces dmesg in the base as follows:
>
> Dec 23 22:44:05 amdbox kernel: [15812.088706] __ratelimit: 20
> callbacks suppressed
> Dec 23 22:44:05 amdbox kernel: [15812.088710] emulation failed (mmio)
> rip ffffffffa0370a11 0f 01 da 0f

Ugh. Looks like the emulation part is still broken :-(. Please use the  
attached patch to disable the emulation optimization for now.

Avi, could you please apply that patch for kvm-82 too, so we get  
something working out? I'll take a closer look at what's broken  
exactly later on.

Alex


[-- Attachment #2: disable-emulation.patch --]
[-- Type: application/octet-stream, Size: 413 bytes --]

diff --git a/arch/x86/kvm/svm.c b/arch/x86/kvm/svm.c
index 6577934..8b87869 100644
--- a/arch/x86/kvm/svm.c
+++ b/arch/x86/kvm/svm.c
@@ -1848,7 +1848,7 @@ static int stgi_interception(struct vcpu_svm *svm, struct kvm_run *kvm_run)
 
 static int clgi_interception(struct vcpu_svm *svm, struct kvm_run *kvm_run)
 {
-	int loopcount = 0;
+	int loopcount = 100;
 
 	if (nested_svm_check_permissions(svm))
 		return 1;

[-- Attachment #3: Type: text/plain, Size: 1 bytes --]



^ permalink raw reply related	[flat|nested] 15+ messages in thread

* Re: Nested KVM
  2008-12-24  9:20         ` Alexander Graf
@ 2008-12-25  9:59           ` Avi Kivity
  2008-12-25 13:49             ` Alexander Graf
  2008-12-29 23:47           ` Todd Deshane
  1 sibling, 1 reply; 15+ messages in thread
From: Avi Kivity @ 2008-12-25  9:59 UTC (permalink / raw)
  To: Alexander Graf; +Cc: deshantm, kvm

Alexander Graf wrote:
>
> Avi, could you please apply that patch for kvm-82 too, so we get 
> something working out? I'll take a closer look at what's broken 
> exactly later on.

I'll just revert the emulation loop patch.  We can reapply it once we 
fix the problem.

-- 
error compiling committee.c: too many arguments to function


^ permalink raw reply	[flat|nested] 15+ messages in thread

* Re: Nested KVM
  2008-12-25  9:59           ` Avi Kivity
@ 2008-12-25 13:49             ` Alexander Graf
  0 siblings, 0 replies; 15+ messages in thread
From: Alexander Graf @ 2008-12-25 13:49 UTC (permalink / raw)
  To: Avi Kivity; +Cc: deshantm, kvm





On 25.12.2008, at 10:59, Avi Kivity <avi@redhat.com> wrote:

> Alexander Graf wrote:
>>
>> Avi, could you please apply that patch for kvm-82 too, so we get  
>> something working out? I'll take a closer look at what's broken  
>> exactly later on.
>
> I'll just revert the emulation loop patch.  We can reapply it once  
> we fix the problem.

Sounds good. It was rather meant as a draft/rfc anyways :-).

Alex

>
>
> -- 
> error compiling committee.c: too many arguments to function
>

^ permalink raw reply	[flat|nested] 15+ messages in thread

* Re: Nested KVM
  2008-12-24  9:20         ` Alexander Graf
  2008-12-25  9:59           ` Avi Kivity
@ 2008-12-29 23:47           ` Todd Deshane
  2008-12-30 17:19             ` Todd Deshane
  1 sibling, 1 reply; 15+ messages in thread
From: Todd Deshane @ 2008-12-29 23:47 UTC (permalink / raw)
  To: Alexander Graf; +Cc: kvm

On Wed, Dec 24, 2008 at 4:20 AM, Alexander Graf <agraf@suse.de> wrote:
>
>
> Ugh. Looks like the emulation part is still broken :-(. Please use the
> attached patch to disable the emulation optimization for now.
>
> Avi, could you please apply that patch for kvm-82 too, so we get something
> working out? I'll take a closer look at what's broken exactly later on.
>
> Alex
>
>

So I am working with the latest git, from today.

The emulation error went away and the nested KVM guest partially works.

The errors that I am seeing late in the normal guest boot (which seem
non-fatal) are:
Dec 29 18:33:31 amdbox kernel: [ 1060.446054] bad partial csum:
csum=5888/5694 len=80
Dec 29 18:33:33 amdbox kernel: [ 1061.934164] bad partial csum:
csum=5888/5694 len=80
Dec 29 18:33:33 amdbox kernel: [ 1062.170127] bad partial csum:
csum=5888/5694 len=60
Dec 29 18:33:34 amdbox kernel: [ 1063.419124] bad partial csum:
csum=5888/5694 len=270
Dec 29 18:33:35 amdbox kernel: [ 1063.667817] bad partial csum:
csum=5888/5694 len=270
Dec 29 18:33:35 amdbox kernel: [ 1063.927839] bad partial csum:
csum=5888/5694 len=270
Dec 29 18:33:35 amdbox kernel: [ 1064.126336] bad partial csum:
csum=5888/5694 len=252
Dec 29 18:33:35 amdbox kernel: [ 1064.274429] bad partial csum:
csum=5888/5694 len=152
Dec 29 18:33:35 amdbox kernel: [ 1064.522702] bad partial csum:
csum=5888/5694 len=152
Dec 29 18:33:36 amdbox kernel: [ 1064.776290] bad partial csum:
csum=5888/5694 len=152
Dec 29 18:33:38 amdbox kernel: [ 1067.309123] __ratelimit: 4 callbacks
suppressed
Dec 29 18:33:38 amdbox kernel: [ 1067.309126] bad partial csum:
csum=5888/5694 len=252
Dec 29 18:33:39 amdbox kernel: [ 1068.160737] bad partial csum:
csum=5888/5694 len=241
Dec 29 18:33:41 amdbox kernel: [ 1070.170049] bad partial csum:
csum=5888/5694 len=60

After that I am able to start the nested guest with:
sudo qemu-system-x86_64 -hda ubuntu-server.img -cdrom
Desktop/ubuntu-8.10-server-amd64.iso

The nested guest also has the latest git checkout

The nested guest shows the Ubuntu install CD welcome and selecting a
language and starting
the boot process starts a very little bit and the screen goes black.

The nested guest doesn't crash, but becomes very unresponsive, can't
ping it, can't ssh, etc.
It seems like it only runs for a short time before it becomes
unresponsive (less than 30
seconds).

I can attach to the qemu-system-x86_64

(gdb) where
#0  0x00007fa8cc4a1482 in select () from /lib/libc.so.6
#1  0x0000000000408bcb in main_loop_wait (timeout=0)
    at /backup/src/kvm-src/kvm-userspace/qemu/vl.c:3617
#2  0x00000000005160fa in kvm_main_loop ()
    at /backup/src/kvm-src/kvm-userspace/qemu/qemu-kvm.c:599
#3  0x000000000040d106 in main (argc=<value optimized out>,
    argv=0x7fffd58e9f48, envp=<value optimized out>)
    at /backup/src/kvm-src/kvm-userspace/qemu/vl.c:3779

After some time, the qemu-system-x86_64 process starts to take
between 97 and 100% of the CPU.

The base system is still running OK, but no new messages are printed
in /var/log/syslog

I am sure there are more KVM debugging tricks....

Any suggestions?

Thanks,
Todd

-- 
Todd Deshane
http://todddeshane.net
http://runningxen.com

^ permalink raw reply	[flat|nested] 15+ messages in thread

* Re: Nested KVM
  2008-12-29 23:47           ` Todd Deshane
@ 2008-12-30 17:19             ` Todd Deshane
  2008-12-31 15:17               ` Alexander Graf
  0 siblings, 1 reply; 15+ messages in thread
From: Todd Deshane @ 2008-12-30 17:19 UTC (permalink / raw)
  To: Alexander Graf; +Cc: kvm

Some more information on this one:

I just pulled and installed the latest userspace, Now I get
a kernel panic: not syncing: IO-APIC + timer doesn't work!
Boot with apic=debug and send a report. Then try booting
with the 'noapic' option. (this is during the ubuntu CD boot
with the qemu line as:
qemu-system-x86_64 -hda ubuntu-server.img -cdrom
ubuntu-8.10-server-amd64.iso

I will try as the error says, but I think I am going to need
a better console (serial or vnc or something), since the
crash leaves the guest in a non usable state. can't ssh
or anything and it is spinning the CPU over 100%.

I'll report back any new information. Any debugging tips
for this type of situation are most welcome.

Thanks,
Todd

-- 
Todd Deshane
http://todddeshane.net
http://runningxen.com

^ permalink raw reply	[flat|nested] 15+ messages in thread

* Re: Nested KVM
  2008-12-30 17:19             ` Todd Deshane
@ 2008-12-31 15:17               ` Alexander Graf
  0 siblings, 0 replies; 15+ messages in thread
From: Alexander Graf @ 2008-12-31 15:17 UTC (permalink / raw)
  To: deshantm; +Cc: kvm


On 30.12.2008, at 18:19, Todd Deshane wrote:

> Some more information on this one:
>
> I just pulled and installed the latest userspace, Now I get
> a kernel panic: not syncing: IO-APIC + timer doesn't work!
> Boot with apic=debug and send a report. Then try booting
> with the 'noapic' option. (this is during the ubuntu CD boot
> with the qemu line as:
> qemu-system-x86_64 -hda ubuntu-server.img -cdrom
> ubuntu-8.10-server-amd64.isoa

This message comes when less than n interrupts were received within m  
loop cycles. I actually do get that with native kvm too sometimes.  
Just try to boot the VM again.

> I will try as the error says, but I think I am going to need
> a better console (serial or vnc or something), since the
> crash leaves the guest in a non usable state. can't ssh
> or anything and it is spinning the CPU over 100%.

Eh - the l1 guest or the l2 (nested) guest? The l1 guest should never  
get to an unusable state.

> I'll report back any new information. Any debugging tips
> for this type of situation are most welcome.

Hum. I usually do a -monitor stdio for the nested kvm instance, but  
apart from that it's more a question of improvising :).

PS: I won't be around any AMD machine until next week, so I can't  
really see if it works reliably for me.

Alex


^ permalink raw reply	[flat|nested] 15+ messages in thread

end of thread, other threads:[~2008-12-31 15:17 UTC | newest]

Thread overview: 15+ messages (download: mbox.gz / follow: Atom feed)
-- links below jump to the message on this page --
2008-12-23  2:55 Nested KVM Todd Deshane
2008-12-23  6:26 ` Todd Deshane
2008-12-23  9:00 ` Alexander Graf
2008-12-23 16:35   ` Todd Deshane
2008-12-23 17:04     ` Alexander Graf
2008-12-24  4:18       ` Todd Deshane
2008-12-24  9:20         ` Alexander Graf
2008-12-25  9:59           ` Avi Kivity
2008-12-25 13:49             ` Alexander Graf
2008-12-29 23:47           ` Todd Deshane
2008-12-30 17:19             ` Todd Deshane
2008-12-31 15:17               ` Alexander Graf
2008-12-23 17:05   ` Avi Kivity
2008-12-23 17:10     ` Alexander Graf
2008-12-23 17:18       ` Avi Kivity

This is an external index of several public inboxes,
see mirroring instructions on how to clone and mirror
all data and code used by this external index.