Re: Performance counters in kvm?

["Binh Q. Pham" <binhpham@cs.rutgers.edu>]

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

I am using: QEMU emulator version 1.5.0 (Debian 1.5.0+dfsg-3ubuntu5), 
Copyright (c) 2003-2008 Fabrice Bellard
Attached files are output from cpuinfo and dmesg that you asked for.

Thanks,
Binh
On 11/14/2013 02:16 AM, Gleb Natapov wrote:
> On Wed, Nov 13, 2013 at 10:22:54PM -0500, Binh Q. Pham wrote:
>> Hi Gleb,
>> Thanks for the suggestion, but I just tried to specify the cpu type
>> to QEMU: -cpu host and I got the same output.
>>
> Which QEMU version are you using, what is the output of "cat
> /proc/cpuinfo" in the guest and attach guest's dmesg too.
>
>> Binh
>> On 11/13/2013 12:54 PM, Gleb Natapov wrote:
>>> On Wed, Nov 13, 2013 at 11:52:01AM -0500, Binh Q. Pham wrote:
>>>> Hi all,
>>>>
>>>> I just started using kvm and want to use linux 'perf' tool inside
>>>> the virtual machine to get some information about the hardware
>>>> performance counters. I noticed in kvm source, there is pmu.c and
>>>> pmu-stubs.c, so I assume they provide support for PMU. However, when
>>>> I ran 'perf stat' in the VM, all hardware events are not supported.
>>>> Sample screen shot:
>>>>
>>>> perf stat /bin/ls
>>>> Performance counter stats for '/bin/ls':
>>>> <not supported> cycles
>>>> <not supported> stalled-cycles-frontend
>>>> ....
>>>>
>>>> Could someone clarify for me if I can use 'perf' in VM with the
>>>> current kvm state?
>>>>
>>> You need to specify host cpu type to QEMU: -cpu host.
>>>
>>> --
>>> 			Gleb.
> --
> 			Gleb.


[-- Attachment #2: cpuinfo.out --]
[-- Type: text/plain, Size: 568 bytes --]

processor	: 0
vendor_id	: GenuineIntel
cpu family	: 6
model		: 42
model name	: Intel Xeon E312xx (Sandy Bridge)
stepping	: 1
cpu MHz		: 3392.365
cache size	: 4096 KB
fpu		: yes
fpu_exception	: yes
cpuid level	: 13
wp		: yes
flags		: fpu pse tsc msr pae mce cx8 apic sep mtrr pge mca cmov pat pse36 clflush mmx fxsr sse sse2 syscall nx rdtscp lm constant_tsc rep_good nopl pni pclmulqdq ssse3 cx16 sse4_1 sse4_2 popcnt aes hypervisor lahf_lm
bogomips	: 6784.73
clflush size	: 64
cache_alignment	: 64
address sizes	: 40 bits physical, 48 bits virtual
power management:


[-- Attachment #3: dmesg.out --]
[-- Type: text/plain, Size: 25303 bytes --]

[    0.000000] Initializing cgroup subsys cpuset
[    0.000000] Initializing cgroup subsys cpu
[    0.000000] Linux version 3.8.0-29-generic (buildd@panlong) (gcc version 4.6.3 (Ubuntu/Linaro 4.6.3-1ubuntu5) ) #42~precise1-Ubuntu SMP Wed Aug 14 16:19:23 UTC 2013 (Ubuntu 3.8.0-29.42~precise1-generic 3.8.13.5)
[    0.000000] Command line: BOOT_IMAGE=/boot/vmlinuz-3.8.0-29-generic root=UUID=12c55b5b-2807-4bd3-becd-87224f111bdf ro
[    0.000000] KERNEL supported cpus:
[    0.000000]   Intel GenuineIntel
[    0.000000]   AMD AuthenticAMD
[    0.000000]   Centaur CentaurHauls
[    0.000000] e820: BIOS-provided physical RAM map:
[    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
[    0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
[    0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007fffdfff] usable
[    0.000000] BIOS-e820: [mem 0x000000007fffe000-0x000000007fffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
[    0.000000] NX (Execute Disable) protection: active
[    0.000000] SMBIOS 2.4 present.
[    0.000000] DMI: Bochs Bochs, BIOS Bochs 01/01/2011
[    0.000000] e820: update [mem 0x00000000-0x0000ffff] usable ==> reserved
[    0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
[    0.000000] No AGP bridge found
[    0.000000] e820: last_pfn = 0x7fffe max_arch_pfn = 0x400000000
[    0.000000] MTRR default type: write-back
[    0.000000] MTRR fixed ranges enabled:
[    0.000000]   00000-9FFFF write-back
[    0.000000]   A0000-BFFFF uncachable
[    0.000000]   C0000-FFFFF write-protect
[    0.000000] MTRR variable ranges enabled:
[    0.000000]   0 base 0080000000 mask FF80000000 uncachable
[    0.000000]   1 disabled
[    0.000000]   2 disabled
[    0.000000]   3 disabled
[    0.000000]   4 disabled
[    0.000000]   5 disabled
[    0.000000]   6 disabled
[    0.000000]   7 disabled
[    0.000000] x86 PAT enabled: cpu 0, old 0x7040600070406, new 0x7010600070106
[    0.000000] found SMP MP-table at [mem 0x000f1800-0x000f180f] mapped at [ffff8800000f1800]
[    0.000000] initial memory mapped: [mem 0x00000000-0x1fffffff]
[    0.000000] Base memory trampoline at [ffff880000099000] 99000 size 24576
[    0.000000] init_memory_mapping: [mem 0x00000000-0x7fffdfff]
[    0.000000]  [mem 0x00000000-0x7fdfffff] page 2M
[    0.000000]  [mem 0x7fe00000-0x7fffdfff] page 4k
[    0.000000] kernel direct mapping tables up to 0x7fffdfff @ [mem 0x1fffc000-0x1fffffff]
[    0.000000] RAMDISK: [mem 0x3615c000-0x370a5fff]
[    0.000000] ACPI: RSDP 00000000000f16a0 00014 (v00 BOCHS )
[    0.000000] ACPI: RSDT 000000007fffe450 00034 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: FACP 000000007fffff80 00074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
[    0.000000] ACPI: DSDT 000000007fffe490 01137 (v01   BXPC   BXDSDT 00000001 INTL 20100528)
[    0.000000] ACPI: FACS 000000007fffff40 00040
[    0.000000] ACPI: SSDT 000000007ffff700 00838 (v01 BOCHS  BXPCSSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: APIC 000000007ffff610 00078 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
[    0.000000] ACPI: HPET 000000007ffff5d0 00038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)
[    0.000000] ACPI: Local APIC address 0xfee00000
[    0.000000] No NUMA configuration found
[    0.000000] Faking a node at [mem 0x0000000000000000-0x000000007fffdfff]
[    0.000000] Initmem setup node 0 [mem 0x00000000-0x7fffdfff]
[    0.000000]   NODE_DATA [mem 0x7fff9000-0x7fffdfff]
[    0.000000]  [ffffea0000000000-ffffea0001ffffff] PMD -> [ffff88007d600000-ffff88007f5fffff] on node 0
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x00010000-0x00ffffff]
[    0.000000]   DMA32    [mem 0x01000000-0xffffffff]
[    0.000000]   Normal   empty
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x00010000-0x0009efff]
[    0.000000]   node   0: [mem 0x00100000-0x7fffdfff]
[    0.000000] On node 0 totalpages: 524173
[    0.000000]   DMA zone: 64 pages used for memmap
[    0.000000]   DMA zone: 6 pages reserved
[    0.000000]   DMA zone: 3913 pages, LIFO batch:0
[    0.000000]   DMA32 zone: 8128 pages used for memmap
[    0.000000]   DMA32 zone: 512062 pages, LIFO batch:31
[    0.000000] ACPI: PM-Timer IO Port: 0xb008
[    0.000000] ACPI: Local APIC address 0xfee00000
[    0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
[    0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
[    0.000000] ACPI: IOAPIC (id[0x00] address[0xfec00000] gsi_base[0])
[    0.000000] IOAPIC[0]: apic_id 0, version 17, 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 5 global_irq 5 high level)
[    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 10 global_irq 10 high level)
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
[    0.000000] ACPI: IRQ0 used by override.
[    0.000000] ACPI: IRQ2 used by override.
[    0.000000] ACPI: IRQ5 used by override.
[    0.000000] ACPI: IRQ9 used by override.
[    0.000000] ACPI: IRQ10 used by override.
[    0.000000] ACPI: IRQ11 used by override.
[    0.000000] Using ACPI (MADT) for SMP configuration information
[    0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
[    0.000000] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
[    0.000000] nr_irqs_gsi: 40
[    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] e820: [mem 0x80000000-0xfffbffff] available for PCI devices
[    0.000000] Booting paravirtualized kernel on bare hardware
[    0.000000] setup_percpu: NR_CPUS:256 nr_cpumask_bits:256 nr_cpu_ids:1 nr_node_ids:1
[    0.000000] PERCPU: Embedded 28 pages/cpu @ffff88007fc00000 s85056 r8192 d21440 u2097152
[    0.000000] pcpu-alloc: s85056 r8192 d21440 u2097152 alloc=1*2097152
[    0.000000] pcpu-alloc: [0] 0 
[    0.000000] Built 1 zonelists in Node order, mobility grouping on.  Total pages: 515975
[    0.000000] Policy zone: DMA32
[    0.000000] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-3.8.0-29-generic root=UUID=12c55b5b-2807-4bd3-becd-87224f111bdf ro
[    0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes)
[    0.000000] __ex_table already sorted, skipping sort
[    0.000000] Checking aperture...
[    0.000000] No AGP bridge found
[    0.000000] Calgary: detecting Calgary via BIOS EBDA area
[    0.000000] Calgary: Unable to locate Rio Grande table in EBDA - bailing!
[    0.000000] Memory: 2032316k/2097144k available (7170k kernel code, 452k absent, 64376k reserved, 6073k data, 1012k init)
[    0.000000] SLUB: Genslabs=15, HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[    0.000000] Hierarchical RCU implementation.
[    0.000000] 	RCU dyntick-idle grace-period acceleration is enabled.
[    0.000000] 	RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=1.
[    0.000000] NR_IRQS:16640 nr_irqs:256 16
[    0.000000] Console: colour VGA+ 80x25
[    0.000000] console [tty0] enabled
[    0.000000] allocated 8388608 bytes of page_cgroup
[    0.000000] please try 'cgroup_disable=memory' option if you don't want memory cgroups
[    0.000000] hpet clockevent registered
[    0.000000] tsc: Fast TSC calibration using PIT
[    0.000000] tsc: Detected 3392.365 MHz processor
[    0.008436] Calibrating delay loop (skipped), value calculated using timer frequency.. 6784.73 BogoMIPS (lpj=13569460)
[    0.012490] pid_max: default: 32768 minimum: 301
[    0.015584] Security Framework initialized
[    0.017357] AppArmor: AppArmor initialized
[    0.017425] Yama: becoming mindful.
[    0.022379] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes)
[    0.025732] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes)
[    0.027598] Mount-cache hash table entries: 256
[    0.033751] Initializing cgroup subsys cpuacct
[    0.033904] Initializing cgroup subsys memory
[    0.034374] Initializing cgroup subsys devices
[    0.034459] Initializing cgroup subsys freezer
[    0.034570] Initializing cgroup subsys blkio
[    0.034637] Initializing cgroup subsys perf_event
[    0.034728] Initializing cgroup subsys hugetlb
[    0.036441] mce: CPU supports 10 MCE banks
[    0.037444] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[    0.037444] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0
[    0.037444] tlb_flushall_shift: 5
[    0.238001] Freeing SMP alternatives: 24k freed
[    0.248119] ACPI: Core revision 20121018
[    0.269009] ftrace: allocating 29358 entries in 115 pages
[    0.342114] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[    0.382710] smpboot: CPU0: Intel Xeon E312xx (Sandy Bridge) (fam: 06, model: 2a, stepping: 01)
[    0.384000] Performance Events: unsupported p6 CPU model 42 no PMU driver, software events only.
[    0.394815] Brought up 1 CPUs
[    0.394919] smpboot: Total of 1 processors activated (6784.73 BogoMIPS)
[    0.398941] NMI watchdog: disabled (cpu0): hardware events not enabled
[    0.405694] devtmpfs: initialized
[    0.413603] EVM: security.selinux
[    0.413642] EVM: security.SMACK64
[    0.413674] EVM: security.capability
[    0.423843] regulator-dummy: no parameters
[    0.425648] NET: Registered protocol family 16
[    0.434542] ACPI: bus type pci registered
[    0.435823] PCI: Using configuration type 1 for base access
[    0.447772] bio: create slab <bio-0> at 0
[    0.449675] ACPI: Added _OSI(Module Device)
[    0.449731] ACPI: Added _OSI(Processor Device)
[    0.449772] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.449812] ACPI: Added _OSI(Processor Aggregator Device)
[    0.454504] ACPI: EC: Look up EC in DSDT
[    0.482043] ACPI: Interpreter enabled
[    0.482120] ACPI: (supports S0 S3 S4 S5)
[    0.482683] ACPI: Using IOAPIC for interrupt routing
[    0.513621] ACPI: No dock devices found.
[    0.513752] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[    0.515540] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[    0.515631] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
[    0.524296] pci_root PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
[    0.525047] PCI host bridge to bus 0000:00
[    0.525219] pci_bus 0000:00: root bus resource [bus 00-ff]
[    0.525364] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7]
[    0.525413] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff]
[    0.525466] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff]
[    0.525515] pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff]
[    0.525976] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
[    0.526955] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
[    0.527153] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
[    0.528990] pci 0000:00:01.1: reg 20: [io  0xc040-0xc04f]
[    0.529789] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
[    0.530069] pci 0000:00:01.3: quirk: [io  0xb000-0xb03f] claimed by PIIX4 ACPI
[    0.530153] pci 0000:00:01.3: quirk: [io  0xb100-0xb10f] claimed by PIIX4 SMB
[    0.530300] pci 0000:00:02.0: [1013:00b8] type 00 class 0x030000
[    0.530999] pci 0000:00:02.0: reg 10: [mem 0xfc000000-0xfdffffff pref]
[    0.531654] pci 0000:00:02.0: reg 14: [mem 0xfebf0000-0xfebf0fff]
[    0.534845] pci 0000:00:02.0: reg 30: [mem 0xfebe0000-0xfebeffff pref]
[    0.534916] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000
[    0.535574] pci 0000:00:03.0: reg 10: [mem 0xfeba0000-0xfebbffff]
[    0.536346] pci 0000:00:03.0: reg 14: [io  0xc000-0xc03f]
[    0.539493] pci 0000:00:03.0: reg 30: [mem 0xfebc0000-0xfebdffff pref]
[    0.541414]  pci0000:00: ACPI _OSC support notification failed, disabling PCIe ASPM
[    0.541504]  pci0000:00: Unable to request _OSC control (_OSC support mask: 0x08)
[    0.545202] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
[    0.548133] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
[    0.548634] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
[    0.549120] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
[    0.549400] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
[    0.552104] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
[    0.552189] vgaarb: loaded
[    0.552240] vgaarb: bridge control possible 0000:00:02.0
[    0.554707] SCSI subsystem initialized
[    0.554808] ACPI: bus type scsi registered
[    0.555312] libata version 3.00 loaded.
[    0.555567] ACPI: bus type usb registered
[    0.556093] usbcore: registered new interface driver usbfs
[    0.556335] usbcore: registered new interface driver hub
[    0.556613] usbcore: registered new device driver usb
[    0.558066] PCI: Using ACPI for IRQ routing
[    0.558199] PCI: pci_cache_line_size set to 64 bytes
[    0.558516] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
[    0.558624] e820: reserve RAM buffer [mem 0x7fffe000-0x7fffffff]
[    0.562850] NetLabel: Initializing
[    0.562894] NetLabel:  domain hash size = 128
[    0.562932] NetLabel:  protocols = UNLABELED CIPSOv4
[    0.563580] NetLabel:  unlabeled traffic allowed by default
[    0.564280] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
[    0.564481] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
[    0.564612] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
[    0.569215] Switching to clocksource hpet
[    0.646466] AppArmor: AppArmor Filesystem Enabled
[    0.646967] pnp: PnP ACPI init
[    0.647122] ACPI: bus type pnp registered
[    0.648876] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active)
[    0.649241] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active)
[    0.649508] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active)
[    0.649899] pnp 00:03: [dma 2]
[    0.650046] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active)
[    0.650406] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active)
[    0.650767] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active)
[    0.652155] pnp 00:06: Plug and Play ACPI device, IDs PNP0103 (active)
[    0.652879] pnp: PnP ACPI: found 7 devices
[    0.652951] ACPI: ACPI bus type pnp unregistered
[    0.678234] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7]
[    0.678267] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff]
[    0.678286] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff]
[    0.678303] pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff]
[    0.678728] NET: Registered protocol family 2
[    0.681716] TCP established hash table entries: 16384 (order: 6, 262144 bytes)
[    0.682223] TCP bind hash table entries: 16384 (order: 6, 262144 bytes)
[    0.682608] TCP: Hash tables configured (established 16384 bind 16384)
[    0.682881] TCP: reno registered
[    0.683039] UDP hash table entries: 1024 (order: 3, 32768 bytes)
[    0.683206] UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes)
[    0.684675] NET: Registered protocol family 1
[    0.684913] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[    0.685161] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[    0.685293] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[    0.685393] pci 0000:00:02.0: Boot video device
[    0.685479] PCI: CLS 0 bytes, default 64
[    0.688248] Trying to unpack rootfs image as initramfs...
[    1.679308] Freeing initrd memory: 15656k freed
[    1.693095] Initialise module verification
[    1.694099] audit: initializing netlink socket (disabled)
[    1.694642] type=2000 audit(1384445421.692:1): initialized
[    1.786602] HugeTLB registered 2 MB page size, pre-allocated 0 pages
[    1.800911] VFS: Disk quotas dquot_6.5.2
[    1.801279] Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[    1.808520] fuse init (API version 7.20)
[    1.809359] msgmni has been set to 3999
[    1.812626] Key type asymmetric registered
[    1.812707] Asymmetric key parser 'x509' registered
[    1.813081] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
[    1.813543] io scheduler noop registered
[    1.813618] io scheduler deadline registered (default)
[    1.813756] io scheduler cfq registered
[    1.815049] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
[    1.815797] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
[    1.816604] intel_idle: does not run on family 6 model 42
[    1.817916] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
[    1.818361] ACPI: Power Button [PWRF]
[    1.835825] GHES: HEST is not enabled!
[    1.836936] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled
[    1.859002] 00:05: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[    1.874586] Linux agpgart interface v0.103
[    1.886900] brd: module loaded
[    1.892426] loop: module loaded
[    1.895123] ata_piix 0000:00:01.1: version 2.13
[    1.897372] ata_piix 0000:00:01.1: setting latency timer to 64
[    1.900649] scsi0 : ata_piix
[    1.901551] scsi1 : ata_piix
[    1.902011] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc040 irq 14
[    1.902085] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc048 irq 15
[    1.907388] libphy: Fixed MDIO Bus: probed
[    1.908239] tun: Universal TUN/TAP device driver, 1.6
[    1.908287] tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com>
[    1.909121] PPP generic driver version 2.4.2
[    1.909633] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    1.909705] ehci-pci: EHCI PCI platform driver
[    1.909871] ehci-platform: EHCI generic platform driver
[    1.909988] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[    1.910192] uhci_hcd: USB Universal Host Controller Interface driver
[    1.911038] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
[    1.913056] serio: i8042 KBD port at 0x60,0x64 irq 1
[    1.913247] serio: i8042 AUX port at 0x60,0x64 irq 12
[    1.914459] mousedev: PS/2 mouse device common for all mice
[    1.916745] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1
[    1.918073] rtc_cmos 00:00: RTC can wake from S4
[    1.919476] rtc_cmos 00:00: rtc core: registered rtc_cmos as rtc0
[    1.919869] rtc0: alarms up to one day, 114 bytes nvram, hpet irqs
[    1.920751] device-mapper: uevent: version 1.0.3
[    1.921419] device-mapper: ioctl: 4.23.1-ioctl (2012-12-18) initialised: dm-devel@redhat.com
[    1.921848] cpuidle: using governor ladder
[    1.921936] cpuidle: using governor menu
[    1.922087] ledtrig-cpu: registered to indicate activity on CPUs
[    1.922141] EFI Variables Facility v0.08 2004-May-17
[    1.928867] ashmem: initialized
[    1.930028] TCP: cubic registered
[    1.930859] NET: Registered protocol family 10
[    1.934725] NET: Registered protocol family 17
[    1.934992] Key type dns_resolver registered
[    1.937095] Loading module verification certificates
[    1.943491] MODSIGN: Loaded cert 'Magrathea: Glacier signing key: 38550890b1fce75cc801d8fb942703db919b9386'
[    1.943730] registered taskstats version 1
[    2.054934] Key type trusted registered
[    2.065419] ata1.01: NODEV after polling detection
[    2.067843] ata2.01: NODEV after polling detection
[    2.068819] ata2.00: ATAPI: QEMU DVD-ROM, 1.5.0, max UDMA/100
[    2.074810] ata1.00: ATA-7: QEMU HARDDISK, 1.5.0, max UDMA/100
[    2.075195] ata1.00: 20971520 sectors, multi 16: LBA48 
[    2.076631] ata2.00: configured for MWDMA2
[    2.084680] ata1.00: configured for MWDMA2
[    2.093410] scsi 0:0:0:0: Direct-Access     ATA      QEMU HARDDISK    1.5. PQ: 0 ANSI: 5
[    2.095924] sd 0:0:0:0: [sda] 20971520 512-byte logical blocks: (10.7 GB/10.0 GiB)
[    2.097607] sd 0:0:0:0: [sda] Write Protect is off
[    2.097675] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
[    2.098058] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    2.107120] sd 0:0:0:0: Attached scsi generic sg0 type 0
[    2.109608] scsi 1:0:0:0: CD-ROM            QEMU     QEMU DVD-ROM     1.5. PQ: 0 ANSI: 5
[    2.112475] sr0: scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
[    2.112625] cdrom: Uniform CD-ROM driver Revision: 3.20
[    2.113566] sr 1:0:0:0: Attached scsi CD-ROM sr0
[    2.119262]  sda: sda1 sda2 < sda5 >
[    2.119833] sr 1:0:0:0: Attached scsi generic sg1 type 5
[    2.132303] sd 0:0:0:0: [sda] Attached SCSI disk
[    2.157968] Key type encrypted registered
[    2.212341] rtc_cmos 00:00: setting system clock to 2013-11-14 16:10:22 UTC (1384445422)
[    2.213767] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found
[    2.213827] EDD information not available.
[    2.230836] Freeing unused kernel memory: 1012k freed
[    2.245628] Write protecting the kernel read-only data: 12288k
[    2.308449] Freeing unused kernel memory: 1012k freed
[    2.397793] Freeing unused kernel memory: 1008k freed
[    2.688585] tsc: Refined TSC clocksource calibration: 3392.303 MHz
[    2.688900] Switching to clocksource tsc
[    3.031115] udevd[93]: starting version 175
[    5.421498] Disabling lock debugging due to kernel taint
[    5.554499] e1000: Intel(R) PRO/1000 Network Driver - version 7.3.21-k8-NAPI
[    5.555973] e1000: Copyright (c) 1999-2006 Intel Corporation.
[    5.739723] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 11
[    5.792451] e1000 0000:00:03.0: setting latency timer to 64
[    6.267370] e1000 0000:00:03.0 eth0: (PCI:33MHz:32-bit) 52:54:00:12:34:56
[    6.267598] e1000 0000:00:03.0 eth0: Intel(R) PRO/1000 Network Connection
[    7.170163] Floppy drive(s): fd0 is 1.44M
[    7.191924] FDC 0 is a S82078B
[    7.676279] EXT4-fs (sda1): INFO: recovery required on readonly filesystem
[    7.676456] EXT4-fs (sda1): write access will be enabled during recovery
[    7.868826] EXT4-fs (sda1): recovery complete
[    7.885820] EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts: (null)
[   10.182058] init: ureadahead main process (232) terminated with status 5
[   13.110248] Adding 2095100k swap on /dev/sda5.  Priority:-1 extents:1 across:2095100k 
[   13.337297] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro
[   16.382766] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[   16.493638] udevd[344]: starting version 175
[   19.542790] lp: driver loaded but no devices found
[   25.941739] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0xb100, revision 0
[   26.433495] [drm] Initialized drm 1.1.0 20060810
[   27.960715] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2
[   28.620764] [TTM] Zone  kernel: Available graphics memory: 1025514 kiB
[   28.620889] [TTM] Initializing pool allocator
[   28.621031] [TTM] Initializing DMA pool allocator
[   29.749847] type=1400 audit(1384445450.035:2): apparmor="STATUS" operation="profile_load" name="/sbin/dhclient" pid=528 comm="apparmor_parser"
[   29.763995] type=1400 audit(1384445450.047:3): apparmor="STATUS" operation="profile_load" name="/usr/lib/NetworkManager/nm-dhcp-client.action" pid=528 comm="apparmor_parser"
[   29.774061] type=1400 audit(1384445450.059:4): apparmor="STATUS" operation="profile_load" name="/usr/lib/connman/scripts/dhclient-script" pid=528 comm="apparmor_parser"
[   30.054775] [drm] fb mappable at 0x0
[   30.054843] [drm] vram aper at 0x0
[   30.054859] [drm] size 0
[   30.054876] [drm] fb depth is 24
[   30.054890] [drm]    pitch is 3840
[   30.655887] fbcon: cirrusdrmfb (fb0) is primary device
[   35.112700] Console: switching to colour frame buffer device 160x64
[   35.131443] cirrus 0000:00:02.0: fb0: cirrusdrmfb frame buffer device
[   35.131562] cirrus 0000:00:02.0: registered panic notifier
[   38.161344] microcode: CPU0 sig=0x206a1, pf=0x1, revision=0x0
[   38.455726] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[   38.928480] [drm] Initialized cirrus 1.0.0 20110418 for 0000:00:02.0 on minor 0
[   40.461321] e1000: eth0 NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX
[   40.463035] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[   44.605492] parport_pc 00:04: reported by Plug and Play ACPI
[   44.606381] parport0: PC-style at 0x378, irq 7 [PCSPP,TRISTATE]
[   44.988867] lp0: using parport0 (interrupt-driven).
[   48.287563] microcode: Microcode Update Driver: v2.00 <tigran@aivazian.fsnet.co.uk>, Peter Oruba
[   48.604392] ppdev: user-space parallel port driver
[   50.828448] init: failsafe main process (545) killed by TERM signal
[   53.927979] type=1400 audit(1384445474.211:5): apparmor="STATUS" operation="profile_replace" name="/sbin/dhclient" pid=845 comm="apparmor_parser"
[   53.935706] type=1400 audit(1384445474.219:6): apparmor="STATUS" operation="profile_replace" name="/usr/lib/NetworkManager/nm-dhcp-client.action" pid=845 comm="apparmor_parser"
[   53.941989] type=1400 audit(1384445474.227:7): apparmor="STATUS" operation="profile_replace" name="/usr/lib/connman/scripts/dhclient-script" pid=845 comm="apparmor_parser"
[   54.141417] type=1400 audit(1384445474.427:8): apparmor="STATUS" operation="profile_load" name="/usr/sbin/tcpdump" pid=847 comm="apparmor_parser"