xen-devel.lists.xenproject.org archive mirror
 help / color / mirror / Atom feed
From: "MadLoisae@gmx.net" <MadLoisae@gmx.net>
To: Konrad Rzeszutek Wilk <konrad.wilk@oracle.com>, keir.xen@gmail.com
Cc: xen-devel@lists.xensource.com
Subject: Re: on starting HVM-domU whole system freezes with "soft lockup - CPU X stuck for XXs! [qemu-dm:...]"
Date: Thu, 14 Apr 2011 18:29:30 +0200	[thread overview]
Message-ID: <4DA720EA.9040907@gmx.net> (raw)
In-Reply-To: <20110414130940.GD5548@dumpdata.com>

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

Hi Keir, Hi Konrad,

thanks for your time.
at first, Keir: I've added the lines to xen boot, attached a new xm 
dmesg. until the line "(XEN) HVM1: HVM Loader" all logs were generated 
from boot, the logs afterwards from starting/killing the domU-machine. 
also attached a dmesg from dom0. My config is still xen-4.1-amd64 with 
dom0 debian squeeze kernel i686.
my hvm domain config is also attached here.
I am sure that to this domU I've configured 512MB ram, my dom0 is 
limited to 1024MB ram, so there should be no bottleneck (host with 
2048MB ram, if I do not limit dom0 memory with xen I can allocate there 
about 1800MB). nevertheless the issue also occurs with a 256MB ram domU.

Konrad, I do not know if this is happening also to other machines, first 
time for me with xen, have never tried or seen on other hardware - or do 
you mean other domUs on my host? if last then yes, this happens if I use 
HVM, as soon as I try paravirt it works flawless. I have tried about 10 
or 15 different configurations of HVM domUs, always the same problem.
I ran your code, the output is attached. also xen ran this time with 
loglvl=all.
If I was running only dom0 the first 4 lines in the output of your code 
always repeated, the two big output blocks with 8 lines were generated 
in the about 15 to 20 seconds stucking, afterwards the 4 lines like on 
beginning repeated again.

hopefully this helps, just contact me if you need more information.

Alois

On 04/14/2011 03:09 PM, Konrad Rzeszutek Wilk wrote:
> On Wed, Apr 13, 2011 at 09:30:51AM +0200, MadLoisae@gmx.net wrote:
>    
>> Hi xen-devel,
>>
>> ----
>> I already posted this on xen-users - Todd Deshane asked me to post
>> this here for feedback.
>> He also asked if I can test xen 4.1 - I am looking if I can find and
>> install backports but if not I'm afraid I think I'm not able to
>> compiling on myself.
>> ----
>>
>> I am trying since a few days my first steps with xen.
>> Hardware: Core2 T7200, Intel 945GME, 2GB RAM
>> Software: debian squeeze, i686, with debian delivered xen 4.0.1
>> CPU and BIOS support hardware virtualisation: (XEN) HVM: VMX enabled
>>
>> I can successfully boot with xen my dom0 with squeeze-delivered i686 kernel.
>> As soon as I start a HVM (paravirtualisation works without problems)
>> my dom0 stucks immediately.
>> I can see about 10 seconds after starting domU "nothing", then the
>> first messages like "hrtimer: interrupt took 1739955444 ns" messages
>> appear, then my disk gets timeouts. then kernel panics like below
>> are starting - normally they are not written to messages-log, one
>> time i had "luck":
>>      
> That is indeed "lucky" as it looks as all the interrupts got disabled
> on your machine. And all the drivers started to hit their error handling
> code as they hit their timeouts.
>
> But the weird part is that this message got written to disk so the interrupts
> did get re-enabled.. Is this happening only on this machine?
> Can you run the attached code and see what happens when the
> guest starts?
>
> Also, how much memory do you give to your domain?
>
>    
>> kernel: : [ 4815.144473] saa7146 (0) vpeirq: used 3 times>80% of
>> buffer (1049604 bytes now)
>> kernel: : [ 4815.144473] Modules linked in: tun xt_physdev loop
>> ipt_REJECT ip6table_filter ip6_tables ebtable_nat ebtables bridge
>> stp xen_evtchn xenfs nfsd lockd nfs_acl auth_rpcgss sunrpc exportfs
>> xt_recent ipt_MASQUERADE xt_tcpudp xt_state iptable_nat nf_nat
>> nf_conntrack_ipv4 nf_conntrack nf_defrag_ipv4 iptable_filter
>> ip_tables x_tables fuse ext4 jbd2 crc16 it87 hwmon_vid coretemp
>> tda10021 snd_hda_codec_via budget_av snd_hda_intel snd_hda_codec
>> saa7146_vv snd_hwdep videodev v4l1_compat snd_pcm_oss snd_mixer_oss
>> videobuf_dma_sg videobuf_core snd_pcm snd_seq_midi snd_rawmidi
>> snd_seq_midi_event snd_seq budget_core i915 drm_kms_helper dvb_core
>> snd_timer saa7146 snd_seq_device ttpci_eeprom drm rng_core pcspkr
>> evdev i2c_i801 i2c_algo_bit snd i2c_core soundcore video output
>> button snd_page_alloc processor acpi_processor ext3 jbd mbcache
>> dm_mod sd_mod crc_t10dif ata_generic uhci_hcd ata_piix fan ehci_hcd
>> libata scsi_mod e1000e usbcore nls_base thermal thermal_sys [last
>> unloaded: scsi_wait_scan]
>> kernel: : [ 4815.144473]
>> kernel: : [ 4815.324579] saa7146 (0) saa7146_i2c_writeout [irq]:
>> timed out waiting for end of xfer
>> kernel: : [ 4815.324722] ata1: lost interrupt (Status 0x50)
>> kernel: : [ 4815.324772] sd 0:0:0:0: [sda] Unhandled error code
>> kernel: : [ 4815.324775] sd 0:0:0:0: [sda] Result: hostbyte=DID_OK
>> driverbyte=DRIVER_TIMEOUT
>> kernel: : [ 4815.324780] sd 0:0:0:0: [sda] CDB: Write(10): 2a 00 00
>> d3 41 9f 00 00 28 00
>> kernel: : [ 4815.324806] lost page write due to I/O error on sda1
>> kernel: : [ 4815.324817] lost page write due to I/O error on sda1
>> kernel: : [ 4815.324826] lost page write due to I/O error on sda1
>> kernel: : [ 4815.324834] lost page write due to I/O error on sda1
>> kernel: : [ 4815.324843] lost page write due to I/O error on sda1
>> kernel: : [ 4815.450483] Pid: 1337, comm: qemu-dm Not tainted
>> (2.6.32-5-xen-686 #1) 945GM/E-ITE8712
>> kernel: : [ 4815.450483] EIP: 0061:[<c1002227>] EFLAGS: 00200246 CPU: 0
>> kernel: : [ 4815.450483] EIP is at hypercall_page+0x227/0x1001
>> kernel: : [ 4815.450483] EAX: 00040000 EBX: 00000000 ECX: 00000000
>> EDX: c357a7b4
>> kernel: : [ 4815.450483] ESI: 00000009 EDI: 00000028 EBP: c13959e4
>> ESP: ddb6defc
>> kernel: : [ 4815.450483]  DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0069
>> kernel: : [ 4815.450483] CR0: 8005003b CR2: 0807f9d0 CR3: 1da42000
>> CR4: 00002660
>> kernel: : [ 4815.450483] DR0: 00000000 DR1: 00000000 DR2: 00000000
>> DR3: 00000000
>> kernel: : [ 4815.450483] DR6: ffff0ff0 DR7: 00000400
>> kernel: : [ 4815.450483] Call Trace:
>> kernel: : [ 4815.450483]  [<c1006048>] ? xen_force_evtchn_callback+0xc/0x10
>> kernel: : [ 4815.450483]  [<c1006778>] ? check_events+0x8/0xc
>> kernel: : [ 4815.450483]  [<c1006737>] ? xen_irq_enable_direct_end+0x0/0x1
>> kernel: : [ 4815.450483]  [<c103c80b>] ? __do_softirq+0x4b/0x156
>> kernel: : [ 4815.450483]  [<c103c947>] ? do_softirq+0x31/0x3c
>> kernel: : [ 4815.450483]  [<c103ca21>] ? irq_exit+0x26/0x58
>> kernel: : [ 4815.450483]  [<c1199a16>] ? xen_evtchn_do_upcall+0x22/0x2c
>> kernel: : [ 4815.653736]  [<c1009b5f>] ? xen_do_upcall+0x7/0xc
>> kernel: : [ 4815.653736]  [<c104a74c>] ? sys_clock_gettime+0x46/0x7e
>> kernel: : [ 4815.653736]  [<c1008f9c>] ? syscall_call+0x7/0xb
>> kernel: : [ 4815.676006] saa7146 (0) vpeirq: used 1 times>80% of
>> buffer (1300396 bytes now)
>>
>> on monitor I can see frequently messages which look like:
>> soft lockup - CPU X stuck for XXs! [qemu-dm:...]
>> always i saw qemu-dm is listed with PID in this message. these
>> messages I can never find in messages-log, i think the machine is
>> too dead to write them down onto disc.
>>
>> the only way to get the machine back is to be fast enough after
>> starting (means less than about 10 seconds) do a xm destroy<name>.
>> otherwise the system needs to be powercycled, rarely ctrl-alt-delete
>> on console initiates a reboot, most time this also does not work.
>>
>> can anybody tell me where I can search for the issue?
>> currently I tried to change architecture to amd64, but as it is not
>> only the kernel and xen itself this is not a "fast try", so
>> hopefully somebody can help me here.
>> attached: xm dmesg (from i686)
>> in there I've limited memory of dom0 to 1GB because I tought maybe
>> balooning causes the issue. my HVM machines never had more than
>> 512MB configured RAM, but nevertheless the problem also occurs with
>> 128 or 256MB configured.
>>
>> thank you for your investigations.
>>      


[-- Attachment #2: dmesg_dom0_amd64xen41_loglvl=all --]
[-- Type: text/plain, Size: 48580 bytes --]

[    0.000000] Reserving virtual address space above 0xffc00000
[    0.000000] Initializing cgroup subsys cpuset
[    0.000000] Initializing cgroup subsys cpu
[    0.000000] Linux version 2.6.32-5-xen-686 (Debian 2.6.32-31) (ben@decadent.org.uk) (gcc version 4.3.5 (Debian 4.3.5-4) ) #1 SMP Wed Mar 9 01:27:54 UTC 2011
[    0.000000] KERNEL supported cpus:
[    0.000000]   Intel GenuineIntel
[    0.000000]   AMD AuthenticAMD
[    0.000000]   NSC Geode by NSC
[    0.000000]   Cyrix CyrixInstead
[    0.000000]   Centaur CentaurHauls
[    0.000000]   Transmeta GenuineTMx86
[    0.000000]   Transmeta TransmetaCPU
[    0.000000]   UMC UMC UMC UMC
[    0.000000] released 0 pages of unused memory
[    0.000000] BIOS-provided physical RAM map:
[    0.000000]  Xen: 0000000000000000 - 000000000009f000 (usable)
[    0.000000]  Xen: 000000000009f000 - 0000000000100000 (reserved)
[    0.000000]  Xen: 0000000000100000 - 0000000040000000 (usable)
[    0.000000]  Xen: 000000007f690000 - 000000007f6e0000 (reserved)
[    0.000000]  Xen: 000000007f6e0000 - 000000007f6e3000 (ACPI NVS)
[    0.000000]  Xen: 000000007f6e3000 - 000000007f6f0000 (ACPI data)
[    0.000000]  Xen: 000000007f6f0000 - 000000007f700000 (reserved)
[    0.000000]  Xen: 00000000e0000000 - 00000000f0000000 (reserved)
[    0.000000]  Xen: 00000000fec00000 - 0000000100000000 (reserved)
[    0.000000] DMI 2.2 present.
[    0.000000] Phoenix BIOS detected: BIOS may corrupt low RAM, working around it.
[    0.000000] e820 update range: 0000000000000000 - 0000000000010000 (usable) ==> (reserved)
[    0.000000] last_pfn = 0x40000 max_arch_pfn = 0x1000000
[    0.000000] x86 PAT enabled: cpu 0, old 0x50100070406, new 0x7010600070106
[    0.000000] initial memory mapped : 0 - 037ff000
[    0.000000] init_memory_mapping: 0000000000000000-00000000373fe000
[    0.000000] NX (Execute Disable) protection: active
[    0.000000]  0000000000 - 00373fe000 page 4k
[    0.000000] kernel direct mapping tables up to 373fe000 @ 100000-2bf000
[    0.000000] RAMDISK: 01651000 - 02c50c00
[    0.000000] ACPI: RSDP 000f7c90 00014 (v00 IntelR)
[    0.000000] ACPI: RSDT 7f6e3000 00038 (v01 IntelR AWRDACPI 42302E31 AWRD 00000000)
[    0.000000] ACPI: FACP 7f6e3080 00074 (v01 IntelR AWRDACPI 42302E31 AWRD 00000000)
[    0.000000] ACPI: DSDT 7f6e3100 05122 (v01 INTELR AWRDACPI 00001000 MSFT 03000000)
[    0.000000] ACPI: FACS 7f6e0000 00040
[    0.000000] ACPI: IDTS 7f6e82c0 00028 (v01 IntelR AWRDACPI 42302E31 AWRD 00000000)
[    0.000000] ACPI: MCFG 7f6e8300 0003C (v01 IntelR AWRDACPI 42302E31 AWRD 00000000)
[    0.000000] ACPI: APIC 7f6e8240 00068 (v01 IntelR AWRDACPI 42302E31 AWRD 00000000)
[    0.000000] ACPI: SSDT 7f6e89a0 00482 (v01  PmRef    CpuPm 00003000 INTL 20050930)
[    0.000000] ACPI: Local APIC address 0xfee00000
[    0.000000] 140MB HIGHMEM available.
[    0.000000] 883MB LOWMEM available.
[    0.000000]   mapped low ram: 0 - 373fe000
[    0.000000]   low ram: 0 - 373fe000
[    0.000000]   node 0 low ram: 00000000 - 373fe000
[    0.000000]   node 0 bootmap 00010000 - 00016e80
[    0.000000] (10 early reservations) ==> bootmem [0000000000 - 00373fe000]
[    0.000000]   #0 [0000000000 - 0000001000]   BIOS data page ==> [0000000000 - 0000001000]
[    0.000000]   #1 [0002d54000 - 0002d72000]   XEN PAGETABLES ==> [0002d54000 - 0002d72000]
[    0.000000]   #2 [0000001000 - 0000002000]    EX TRAMPOLINE ==> [0000001000 - 0000002000]
[    0.000000]   #3 [0000006000 - 0000007000]       TRAMPOLINE ==> [0000006000 - 0000007000]
[    0.000000]   #4 [0001000000 - 000152b8f4]    TEXT DATA BSS ==> [0001000000 - 000152b8f4]
[    0.000000]   #5 [0001651000 - 0002c50c00]          RAMDISK ==> [0001651000 - 0002c50c00]
[    0.000000]   #6 [0002c51000 - 0002d54000]   XEN START INFO ==> [0002c51000 - 0002d54000]
[    0.000000]   #7 [000152c000 - 000152c0a6]              BRK ==> [000152c000 - 000152c0a6]
[    0.000000]   #8 [0000100000 - 00002a1000]          PGTABLE ==> [0000100000 - 00002a1000]
[    0.000000]   #9 [0000010000 - 0000017000]          BOOTMAP ==> [0000010000 - 0000017000]
[    0.000000] found SMP MP-table at [c00f38d0] f38d0
[    0.000000] Zone PFN ranges:
[    0.000000]   DMA      0x00000010 -> 0x00001000
[    0.000000]   Normal   0x00001000 -> 0x000373fe
[    0.000000]   HighMem  0x000373fe -> 0x00040000
[    0.000000] Movable zone start PFN for each node
[    0.000000] early_node_map[2] active PFN ranges
[    0.000000]     0: 0x00000010 -> 0x0000009f
[    0.000000]     0: 0x00000100 -> 0x00040000
[    0.000000] On node 0 totalpages: 262031
[    0.000000] free_area_init_node: node 0, pgdat c13f4d00, node_mem_map c2d72200
[    0.000000]   DMA zone: 32 pages used for memmap
[    0.000000]   DMA zone: 0 pages reserved
[    0.000000]   DMA zone: 3951 pages, LIFO batch:0
[    0.000000]   Normal zone: 1736 pages used for memmap
[    0.000000]   Normal zone: 220470 pages, LIFO batch:31
[    0.000000]   HighMem zone: 281 pages used for memmap
[    0.000000]   HighMem zone: 35561 pages, LIFO batch:7
[    0.000000] Using APIC driver default
[    0.000000] ACPI: PM-Timer IO Port: 0x408
[    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-0
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[    0.000000] ERROR: Unable to locate IOAPIC for GSI 2
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[    0.000000] ERROR: Unable to locate IOAPIC for GSI 9
[    0.000000] Using ACPI (MADT) for SMP configuration information
[    0.000000] SMP: Allowing 2 CPUs, 0 hotplug CPUs
[    0.000000] nr_irqs_gsi: 256
[    0.000000] PM: Registered nosave memory: 000000000009f000 - 0000000000100000
[    0.000000] Allocating PCI resources starting at 7f700000 (gap: 7f700000:60900000)
[    0.000000] Booting paravirtualized kernel on Xen
[    0.000000] Xen version: 4.1.0 (preserve-AD) (dom0)
[    0.000000] NR_CPUS:32 nr_cpumask_bits:32 nr_cpu_ids:2 nr_node_ids:1
[    0.000000] PERCPU: Embedded 15 pages/cpu @c3579000 s37688 r0 d23752 u65536
[    0.000000] pcpu-alloc: s37688 r0 d23752 u65536 alloc=16*4096
[    0.000000] pcpu-alloc: [0] 0 [0] 1 
[    0.000000] trying to map vcpu_info 0 at c357a010, mfn 7bf7a, offset 16
[    0.000000] cpu 0 using vcpu_info at c357a010
[    0.000000] trying to map vcpu_info 1 at c358a010, mfn 7bf8a, offset 16
[    0.000000] cpu 1 using vcpu_info at c358a010
[    0.000000] Xen: using vcpu_info placement
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 259982
[    0.000000] Kernel command line: placeholder root=UUID=d2f5597b-9c57-4df6-8653-29bb3160cf66 ro acpi_enforce_resources=lax fastboot vga=0x31A profile=2 panic=300
[    0.000000] kernel profiling enabled (shift: 2)
[    0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)
[    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[    0.000000] Enabling fast FPU save and restore... done.
[    0.000000] Enabling unmasked SIMD FPU exception support... done.
[    0.000000] Initializing CPU#0
[    0.000000] DMA: Placing 64MB software IO TLB between c365d000 - c765d000
[    0.000000] DMA: software IO TLB at phys 0x365d000 - 0x765d000
[    0.000000] xen_swiotlb_fixup: buf=c365d000 size=67108864
[    0.000000] xen_swiotlb_fixup: buf=c76bd000 size=32768
[    0.000000] Initializing HighMem for node 0 (000373fe:00040000)
[    0.000000] Memory: 941852k/1048576k available (2635k kernel code, 105756k reserved, 1455k data, 404k init, 143368k highmem)
[    0.000000] virtual kernel memory layout:
[    0.000000]     fixmap  : 0xff956000 - 0xffbff000   (2724 kB)
[    0.000000]     pkmap   : 0xff400000 - 0xff600000   (2048 kB)
[    0.000000]     vmalloc : 0xf7bfe000 - 0xff3fe000   ( 120 MB)
[    0.000000]     lowmem  : 0xc0000000 - 0xf73fe000   ( 883 MB)
[    0.000000]       .init : 0xc13ff000 - 0xc1464000   ( 404 kB)
[    0.000000]       .data : 0xc1292d81 - 0xc13feb18   (1455 kB)
[    0.000000]       .text : 0xc1000000 - 0xc1292d81   (2635 kB)
[    0.000000] SLUB: Genslabs=13, HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
[    0.000000] Hierarchical RCU implementation.
[    0.000000] NR_IRQS:1536
[    0.000000] xen: --> irq=0
[    0.000000] xen: --> irq=1
[    0.000000] xen: --> irq=2
[    0.000000] xen: --> irq=3
[    0.000000] xen: --> irq=4
[    0.000000] xen: --> irq=5
[    0.000000] xen: --> irq=6
[    0.000000] xen: --> irq=7
[    0.000000] xen: --> irq=8
[    0.000000] xen: --> irq=9
[    0.000000] xen: --> irq=10
[    0.000000] xen: --> irq=11
[    0.000000] xen: --> irq=12
[    0.000000] xen: --> irq=13
[    0.000000] xen: --> irq=14
[    0.000000] xen: --> irq=15
[    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] xen: sci override: source_irq=9 global_irq=9 trigger=c polarity=1
[    0.000000] xen: registering gsi 9 triggering 0 polarity 0
[    0.000000] xen_allocate_pirq: returning irq 9 for gsi 9
[    0.000000] xen: --> irq=9
[    0.000000] xen: acpi sci 9
[    0.000000] Console: colour VGA+ 80x25
[    0.000000] console [tty0] enabled
[    0.000000] Xen: using vcpuop timer interface
[    0.000000] installing Xen timer for CPU 0
[    0.000000] Detected 1995.076 MHz processor.
[    0.004000] Calibrating delay loop (skipped), value calculated using timer frequency.. 3990.15 BogoMIPS (lpj=7980304)
[    0.004000] Security Framework initialized
[    0.004000] SELinux:  Disabled at boot.
[    0.004000] Mount-cache hash table entries: 512
[    0.004000] Initializing cgroup subsys ns
[    0.004000] Initializing cgroup subsys cpuacct
[    0.004000] Initializing cgroup subsys devices
[    0.004000] Initializing cgroup subsys freezer
[    0.004000] Initializing cgroup subsys net_cls
[    0.004000] CPU: L1 I cache: 32K, L1 D cache: 32K
[    0.004000] CPU: L2 cache: 4096K
[    0.004000] CPU: Physical Processor ID: 0
[    0.004000] CPU: Processor Core ID: 0
[    0.004000] mce: CPU supports 6 MCE banks
[    0.004000] Performance Events: unsupported p6 CPU model 15 no PMU driver, software events only.
[    0.004000] SMP alternatives: switching to UP code
[    0.004000] ACPI: Core revision 20090903
[    0.016439] installing Xen timer for CPU 1
[    0.016535] SMP alternatives: switching to SMP code
[    0.004000] Initializing CPU#1
[    0.004000] CPU: L1 I cache: 32K, L1 D cache: 32K
[    0.004000] CPU: L2 cache: 4096K
[    0.004000] CPU: Physical Processor ID: 0
[    0.004000] CPU: Processor Core ID: 1
[    0.020139] Brought up 2 CPUs
[    0.020449] CPU0 attaching sched-domain:
[    0.020454]  domain 0: span 0-1 level CPU
[    0.020461]   groups: 0 1
[    0.020475] CPU1 attaching sched-domain:
[    0.020479]  domain 0: span 0-1 level CPU
[    0.020486]   groups: 1 0
[    0.020585] devtmpfs: initialized
[    0.020585] Grant table initialized
[    0.020585] regulator: core version 0.5
[    0.020585] NET: Registered protocol family 16
[    0.020585] ACPI: bus type pci registered
[    0.020585] sync cpu 0 get result 1 max_id 1
[    0.020585] sync cpu 1 get result 1 max_id 1
[    0.020585] PCI: MCFG configuration 0: base e0000000 segment 0 buses 0 - 255
[    0.020585] PCI: MCFG area at e0000000 reserved in E820
[    0.020585] PCI: Using MMCONFIG for extended config space
[    0.020585] PCI: Using configuration type 1 for base access
[    0.021349] bio: create slab <bio-0> at 0
[    0.026756] ERROR: Unable to locate IOAPIC for GSI 9
[    0.026850] ACPI: EC: Look up EC in DSDT
[    0.047094] ACPI: Interpreter enabled
[    0.047151] ACPI: (supports S0 S1 S4 S5)
[    0.047373] ACPI: Using IOAPIC for interrupt routing
[    0.061430] ACPI: No dock devices found.
[    0.061663] ACPI: PCI Root Bridge [PCI0] (0000:00)
[    0.061988] pci 0000:00:02.0: reg 10 32bit mmio: [0xfdf00000-0xfdf7ffff]
[    0.062003] pci 0000:00:02.0: reg 14 io port: [0xff00-0xff07]
[    0.062018] pci 0000:00:02.0: reg 18 32bit mmio pref: [0xd0000000-0xdfffffff]
[    0.062033] pci 0000:00:02.0: reg 1c 32bit mmio: [0xfdf80000-0xfdfbffff]
[    0.062301] pci 0000:00:1b.0: reg 10 64bit mmio: [0xfdff8000-0xfdffbfff]
[    0.062433] pci 0000:00:1b.0: PME# supported from D0 D3hot D3cold
[    0.062499] pci 0000:00:1b.0: PME# disabled
[    0.062750] pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold
[    0.062815] pci 0000:00:1c.0: PME# disabled
[    0.063072] pci 0000:00:1c.1: PME# supported from D0 D3hot D3cold
[    0.063137] pci 0000:00:1c.1: PME# disabled
[    0.063394] pci 0000:00:1c.2: PME# supported from D0 D3hot D3cold
[    0.063459] pci 0000:00:1c.2: PME# disabled
[    0.063716] pci 0000:00:1c.3: PME# supported from D0 D3hot D3cold
[    0.063781] pci 0000:00:1c.3: PME# disabled
[    0.063972] pci 0000:00:1d.0: reg 20 io port: [0xfe00-0xfe1f]
[    0.064001] pci 0000:00:1d.1: reg 20 io port: [0xfd00-0xfd1f]
[    0.064001] pci 0000:00:1d.2: reg 20 io port: [0xfc00-0xfc1f]
[    0.064001] pci 0000:00:1d.3: reg 20 io port: [0xfb00-0xfb1f]
[    0.064001] pci 0000:00:1d.7: reg 10 32bit mmio: [0xfdfff000-0xfdfff3ff]
[    0.064001] pci 0000:00:1d.7: PME# supported from D0 D3hot D3cold
[    0.064001] pci 0000:00:1d.7: PME# disabled
[    0.064001] pci 0000:00:1f.0: Force enabled HPET at 0xfed00000
[    0.064001] pci 0000:00:1f.0: quirk: region 0400-047f claimed by ICH6 ACPI/GPIO/TCO
[    0.064001] pci 0000:00:1f.0: quirk: region 0480-04bf claimed by ICH6 GPIO
[    0.064001] pci 0000:00:1f.0: ICH7 LPC Generic IO decode 1 PIO at 0800 (mask 003f)
[    0.064001] pci 0000:00:1f.0: ICH7 LPC Generic IO decode 2 PIO at 0290 (mask 0007)
[    0.064050] pci 0000:00:1f.1: reg 10 io port: [0x00-0x07]
[    0.064066] pci 0000:00:1f.1: reg 14 io port: [0x00-0x03]
[    0.064083] pci 0000:00:1f.1: reg 18 io port: [0x00-0x07]
[    0.064100] pci 0000:00:1f.1: reg 1c io port: [0x00-0x03]
[    0.064117] pci 0000:00:1f.1: reg 20 io port: [0xfa00-0xfa0f]
[    0.064235] pci 0000:00:1f.2: reg 10 io port: [0xf900-0xf907]
[    0.064252] pci 0000:00:1f.2: reg 14 io port: [0xf800-0xf803]
[    0.064268] pci 0000:00:1f.2: reg 18 io port: [0xf700-0xf707]
[    0.064285] pci 0000:00:1f.2: reg 1c io port: [0xf600-0xf603]
[    0.064302] pci 0000:00:1f.2: reg 20 io port: [0xf500-0xf50f]
[    0.064319] pci 0000:00:1f.2: reg 24 32bit mmio: [0xfdffe000-0xfdffe3ff]
[    0.064382] pci 0000:00:1f.2: PME# supported from D3hot
[    0.064445] pci 0000:00:1f.2: PME# disabled
[    0.064613] pci 0000:00:1f.3: reg 20 io port: [0x500-0x51f]
[    0.064811] pci 0000:01:00.0: reg 10 32bit mmio: [0xfd8e0000-0xfd8fffff]
[    0.064851] pci 0000:01:00.0: reg 18 io port: [0xbf00-0xbf1f]
[    0.065020] pci 0000:01:00.0: PME# supported from D0 D3hot D3cold
[    0.065088] pci 0000:01:00.0: PME# disabled
[    0.065226] pci 0000:01:00.0: disabling ASPM on pre-1.1 PCIe device.  You can enable it with 'pcie_aspm=force'
[    0.065509] pci 0000:00:1c.0: bridge io port: [0xb000-0xbfff]
[    0.065520] pci 0000:00:1c.0: bridge 32bit mmio: [0xfd800000-0xfd8fffff]
[    0.065537] pci 0000:00:1c.0: bridge 64bit mmio pref: [0xfd500000-0xfd5fffff]
[    0.065673] pci 0000:02:00.0: reg 10 32bit mmio: [0xfdee0000-0xfdefffff]
[    0.065713] pci 0000:02:00.0: reg 18 io port: [0xaf00-0xaf1f]
[    0.065882] pci 0000:02:00.0: PME# supported from D0 D3hot D3cold
[    0.065950] pci 0000:02:00.0: PME# disabled
[    0.066087] pci 0000:02:00.0: disabling ASPM on pre-1.1 PCIe device.  You can enable it with 'pcie_aspm=force'
[    0.066368] pci 0000:00:1c.1: bridge io port: [0xa000-0xafff]
[    0.066379] pci 0000:00:1c.1: bridge 32bit mmio: [0xfde00000-0xfdefffff]
[    0.066396] pci 0000:00:1c.1: bridge 64bit mmio pref: [0xfdd00000-0xfddfffff]
[    0.066536] pci 0000:03:00.0: reg 10 32bit mmio: [0xfdce0000-0xfdcfffff]
[    0.066576] pci 0000:03:00.0: reg 18 io port: [0xef00-0xef1f]
[    0.066745] pci 0000:03:00.0: PME# supported from D0 D3hot D3cold
[    0.066813] pci 0000:03:00.0: PME# disabled
[    0.066950] pci 0000:03:00.0: disabling ASPM on pre-1.1 PCIe device.  You can enable it with 'pcie_aspm=force'
[    0.067232] pci 0000:00:1c.2: bridge io port: [0xe000-0xefff]
[    0.067242] pci 0000:00:1c.2: bridge 32bit mmio: [0xfdc00000-0xfdcfffff]
[    0.067259] pci 0000:00:1c.2: bridge 64bit mmio pref: [0xfdb00000-0xfdbfffff]
[    0.067395] pci 0000:04:00.0: reg 10 32bit mmio: [0xfdae0000-0xfdafffff]
[    0.067435] pci 0000:04:00.0: reg 18 io port: [0xdf00-0xdf1f]
[    0.067604] pci 0000:04:00.0: PME# supported from D0 D3hot D3cold
[    0.067672] pci 0000:04:00.0: PME# disabled
[    0.067810] pci 0000:04:00.0: disabling ASPM on pre-1.1 PCIe device.  You can enable it with 'pcie_aspm=force'
[    0.068001] pci 0000:00:1c.3: bridge io port: [0xd000-0xdfff]
[    0.068001] pci 0000:00:1c.3: bridge 32bit mmio: [0xfda00000-0xfdafffff]
[    0.068001] pci 0000:00:1c.3: bridge 64bit mmio pref: [0xfd900000-0xfd9fffff]
[    0.068001] pci 0000:05:00.0: reg 10 32bit mmio: [0xfd7ff000-0xfd7ff1ff]
[    0.068001] pci 0000:00:1e.0: transparent bridge
[    0.068001] pci 0000:00:1e.0: bridge io port: [0xc000-0xcfff]
[    0.068001] pci 0000:00:1e.0: bridge 32bit mmio: [0xfd700000-0xfd7fffff]
[    0.068001] pci 0000:00:1e.0: bridge 64bit mmio pref: [0xfd600000-0xfd6fffff]
[    0.068001] pci_bus 0000:00: on NUMA node 0
[    0.068001] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
[    0.068001] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PEX0._PRT]
[    0.068001] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PEX1._PRT]
[    0.068001] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PEX2._PRT]
[    0.068001] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PEX3._PRT]
[    0.068001] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.HUB0._PRT]
[    0.103238] ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 *5 7 9 10 11 12 14 15)
[    0.103819] ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 7 9 10 *11 12 14 15)
[    0.104359] ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 5 7 9 *10 11 12 14 15)
[    0.104938] ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 7 9 10 11 12 14 *15)
[    0.105513] ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 7 9 10 11 12 14 15) *0, disabled.
[    0.106160] ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 7 9 10 11 12 14 15) *0, disabled.
[    0.106808] ACPI: PCI Interrupt Link [LNK0] (IRQs 3 4 5 7 9 10 11 12 14 15) *0, disabled.
[    0.107453] ACPI: PCI Interrupt Link [LNK1] (IRQs 3 4 5 *7 9 10 11 12 14 15)
[    0.107965] xen_balloon: Initialising balloon driver with page order 0.
[    0.108067] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
[    0.108174] vgaarb: loaded
[    0.108276] PCI: Using ACPI for IRQ routing
[    0.108515] Switching to clocksource xen
[    0.110892] pnp: PnP ACPI init
[    0.110965] ACPI: bus type pnp registered
[    0.112010] xen: registering gsi 8 triggering 1 polarity 0
[    0.112015] xen_allocate_pirq: returning irq 8 for gsi 8
[    0.112073] xen: --> irq=8
[    0.112240] xen: registering gsi 13 triggering 1 polarity 0
[    0.112244] xen_allocate_pirq: returning irq 13 for gsi 13
[    0.112303] xen: --> irq=13
[    0.113344] xen: registering gsi 4 triggering 1 polarity 0
[    0.113349] xen_allocate_pirq: returning irq 4 for gsi 4
[    0.113406] xen: --> irq=4
[    0.114793] xen: registering gsi 1 triggering 1 polarity 0
[    0.114798] xen_allocate_pirq: returning irq 1 for gsi 1
[    0.114855] xen: --> irq=1
[    0.117435] pnp: PnP ACPI: found 12 devices
[    0.117492] ACPI: ACPI bus type pnp unregistered
[    0.117549] PnPBIOS: Disabled
[    0.117614] system 00:01: ioport range 0x4d0-0x4d1 has been reserved
[    0.117676] system 00:01: ioport range 0x290-0x29f has been reserved
[    0.117738] system 00:01: ioport range 0x880-0x88f has been reserved
[    0.117808] system 00:08: ioport range 0x400-0x4bf could not be reserved
[    0.117876] system 00:0a: iomem range 0xe0000000-0xefffffff has been reserved
[    0.117947] system 00:0b: iomem range 0xf0000-0xfffff could not be reserved
[    0.118010] system 00:0b: iomem range 0x7f6e0000-0x7f6fffff could not be reserved
[    0.118091] system 00:0b: iomem range 0x0-0x9ffff could not be reserved
[    0.118154] system 00:0b: iomem range 0x100000-0x7f6dffff could not be reserved
[    0.118235] system 00:0b: iomem range 0xfec00000-0xfec00fff could not be reserved
[    0.118316] system 00:0b: iomem range 0xfed13000-0xfed1dfff has been reserved
[    0.118378] system 00:0b: iomem range 0xfed20000-0xfed8ffff has been reserved
[    0.118441] system 00:0b: iomem range 0xfee00000-0xfee00fff has been reserved
[    0.118504] system 00:0b: iomem range 0xffb00000-0xffb7ffff has been reserved
[    0.118567] system 00:0b: iomem range 0xfff00000-0xffffffff has been reserved
[    0.118630] system 00:0b: iomem range 0xe0000-0xeffff could not be reserved
[    0.125066] PM-Timer failed consistency check  (0x0xffffff) - aborting.
[    0.125265] pci 0000:00:1c.0: PCI bridge, secondary bus 0000:01
[    0.125327] pci 0000:00:1c.0:   IO window: 0xb000-0xbfff
[    0.125394] pci 0000:00:1c.0:   MEM window: 0xfd800000-0xfd8fffff
[    0.125459] pci 0000:00:1c.0:   PREFETCH window: 0x000000fd500000-0x000000fd5fffff
[    0.125550] pci 0000:00:1c.1: PCI bridge, secondary bus 0000:02
[    0.125612] pci 0000:00:1c.1:   IO window: 0xa000-0xafff
[    0.125678] pci 0000:00:1c.1:   MEM window: 0xfde00000-0xfdefffff
[    0.125743] pci 0000:00:1c.1:   PREFETCH window: 0x000000fdd00000-0x000000fddfffff
[    0.125834] pci 0000:00:1c.2: PCI bridge, secondary bus 0000:03
[    0.125896] pci 0000:00:1c.2:   IO window: 0xe000-0xefff
[    0.125962] pci 0000:00:1c.2:   MEM window: 0xfdc00000-0xfdcfffff
[    0.126027] pci 0000:00:1c.2:   PREFETCH window: 0x000000fdb00000-0x000000fdbfffff
[    0.126118] pci 0000:00:1c.3: PCI bridge, secondary bus 0000:04
[    0.126179] pci 0000:00:1c.3:   IO window: 0xd000-0xdfff
[    0.126245] pci 0000:00:1c.3:   MEM window: 0xfda00000-0xfdafffff
[    0.126310] pci 0000:00:1c.3:   PREFETCH window: 0x000000fd900000-0x000000fd9fffff
[    0.126401] pci 0000:00:1e.0: PCI bridge, secondary bus 0000:05
[    0.126464] pci 0000:00:1e.0:   IO window: 0xc000-0xcfff
[    0.126530] pci 0000:00:1e.0:   MEM window: 0xfd700000-0xfd7fffff
[    0.126595] pci 0000:00:1e.0:   PREFETCH window: 0x000000fd600000-0x000000fd6fffff
[    0.126703] xen: registering gsi 16 triggering 0 polarity 1
[    0.126720] xen: --> irq=16
[    0.126729] pci 0000:00:1c.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[    0.126797] pci 0000:00:1c.0: setting latency timer to 64
[    0.126819] xen: registering gsi 17 triggering 0 polarity 1
[    0.126828] xen: --> irq=17
[    0.126835] pci 0000:00:1c.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17
[    0.126902] pci 0000:00:1c.1: setting latency timer to 64
[    0.126925] xen: registering gsi 18 triggering 0 polarity 1
[    0.126933] xen: --> irq=18
[    0.126940] pci 0000:00:1c.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18
[    0.127008] pci 0000:00:1c.2: setting latency timer to 64
[    0.127030] xen: registering gsi 19 triggering 0 polarity 1
[    0.127039] xen: --> irq=19
[    0.127046] pci 0000:00:1c.3: PCI INT D -> GSI 19 (level, low) -> IRQ 19
[    0.127113] pci 0000:00:1c.3: setting latency timer to 64
[    0.127132] pci 0000:00:1e.0: setting latency timer to 64
[    0.127140] pci_bus 0000:00: resource 0 io:  [0x00-0xffff]
[    0.127145] pci_bus 0000:00: resource 1 mem: [0x000000-0xffffffffffffffff]
[    0.127150] pci_bus 0000:01: resource 0 io:  [0xb000-0xbfff]
[    0.127155] pci_bus 0000:01: resource 1 mem: [0xfd800000-0xfd8fffff]
[    0.127160] pci_bus 0000:01: resource 2 pref mem [0xfd500000-0xfd5fffff]
[    0.127165] pci_bus 0000:02: resource 0 io:  [0xa000-0xafff]
[    0.127170] pci_bus 0000:02: resource 1 mem: [0xfde00000-0xfdefffff]
[    0.127175] pci_bus 0000:02: resource 2 pref mem [0xfdd00000-0xfddfffff]
[    0.127180] pci_bus 0000:03: resource 0 io:  [0xe000-0xefff]
[    0.127185] pci_bus 0000:03: resource 1 mem: [0xfdc00000-0xfdcfffff]
[    0.127190] pci_bus 0000:03: resource 2 pref mem [0xfdb00000-0xfdbfffff]
[    0.127195] pci_bus 0000:04: resource 0 io:  [0xd000-0xdfff]
[    0.127200] pci_bus 0000:04: resource 1 mem: [0xfda00000-0xfdafffff]
[    0.127205] pci_bus 0000:04: resource 2 pref mem [0xfd900000-0xfd9fffff]
[    0.127210] pci_bus 0000:05: resource 0 io:  [0xc000-0xcfff]
[    0.127214] pci_bus 0000:05: resource 1 mem: [0xfd700000-0xfd7fffff]
[    0.127219] pci_bus 0000:05: resource 2 pref mem [0xfd600000-0xfd6fffff]
[    0.127224] pci_bus 0000:05: resource 3 io:  [0x00-0xffff]
[    0.127229] pci_bus 0000:05: resource 4 mem: [0x000000-0xffffffffffffffff]
[    0.127261] NET: Registered protocol family 2
[    0.127403] IP route cache hash table entries: 32768 (order: 5, 131072 bytes)
[    0.127800] TCP established hash table entries: 131072 (order: 8, 1048576 bytes)
[    0.128454] TCP bind hash table entries: 65536 (order: 7, 524288 bytes)
[    0.128791] TCP: Hash tables configured (established 131072 bind 65536)
[    0.128853] TCP reno registered
[    0.128996] NET: Registered protocol family 1
[    0.129054] pci 0000:00:02.0: Boot video device
[    0.129364] Unpacking initramfs...
[    0.218476] Freeing initrd memory: 22527k freed
[    0.233743] PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
[    0.233819] DMA: Placing 64MB software IO TLB between c365d000 - c765d000
[    0.233880] DMA: software IO TLB at phys 0x365d000 - 0x765d000
[    0.234547] audit: initializing netlink socket (disabled)
[    0.234630] type=2000 audit(1302796294.409:1): initialized
[    0.238616] highmem bounce pool size: 64 pages
[    0.238679] HugeTLB registered 2 MB page size, pre-allocated 0 pages
[    0.241900] VFS: Disk quotas dquot_6.5.2
[    0.242027] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[    0.242223] msgmni has been set to 1604
[    0.242653] alg: No test for stdrng (krng)
[    0.242795] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253)
[    0.242876] io scheduler noop registered
[    0.242930] io scheduler anticipatory registered
[    0.242986] io scheduler deadline registered
[    0.243090] io scheduler cfq registered (default)
[    0.243536] pcieport 0000:00:1c.0: setting latency timer to 64
[    0.243895] pcieport 0000:00:1c.1: setting latency timer to 64
[    0.244253] pcieport 0000:00:1c.2: setting latency timer to 64
[    0.244606] pcieport 0000:00:1c.3: setting latency timer to 64
[    0.245023] isapnp: Scanning for PnP cards...
[    0.600341] isapnp: No Plug & Play device found
[    0.606959] registering netback
[    0.609640] Linux agpgart interface v0.103
[    0.609827] agpgart-intel 0000:00:00.0: Intel 945GME Chipset
[    0.611993] agpgart-intel 0000:00:00.0: detected 7932K stolen memory
[    0.615357] agpgart-intel 0000:00:00.0: AGP aperture is 256M @ 0xd0000000
[    0.615534] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[    0.615764] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[    0.616323] 00:06: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[    0.616624] PNP: PS/2 Controller [PNP0303:PS2K] at 0x60,0x64 irq 1
[    0.616683] PNP: PS/2 appears to have AUX port disabled, if this is incorrect please boot with i8042.nopnp
[    0.617061] serio: i8042 KBD port at 0x60,0x64 irq 1
[    0.617790] mice: PS/2 mouse device common for all mice
[    0.617937] rtc_cmos 00:03: RTC can wake from S4
[    0.618059] rtc_cmos 00:03: rtc core: registered rtc_cmos as rtc0
[    0.618163] rtc0: alarms up to one month, 242 bytes nvram
[    0.618237] cpuidle: using governor ladder
[    0.618292] cpuidle: using governor menu
[    0.618351] No iBFT detected.
[    0.618745] TCP cubic registered
[    0.619018] NET: Registered protocol family 10
[    0.619871] Mobile IPv6
[    0.619925] NET: Registered protocol family 17
[    0.619997] Using IPI No-Shortcut mode
[    0.620158] PM: Resume from disk failed.
[    0.620177] registered taskstats version 1
[    0.621230] rtc_cmos 00:03: setting system clock to 2011-04-14 15:51:34 UTC (1302796294)
[    0.621360] Initalizing network drop monitor service
[    0.621460] Freeing unused kernel memory: 404k freed
[    0.622646] Write protecting the kernel text: 2636k
[    0.623073] Write protecting the kernel read-only data: 968k
[    0.643525] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
[    0.668754] udev[62]: starting version 164
[    0.773451] e1000e: Intel(R) PRO/1000 Network Driver - 1.0.2-k2
[    0.773525] e1000e: Copyright (c) 1999-2008 Intel Corporation.
[    0.773674] xen: registering gsi 16 triggering 0 polarity 1
[    0.773680] xen_allocate_pirq: returning irq 16 for gsi 16
[    0.773740] xen: --> irq=16
[    0.773748] Already setup the GSI :16
[    0.773805] e1000e 0000:01:00.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[    0.773933] e1000e 0000:01:00.0: setting latency timer to 64
[    0.775618] thermal LNXTHERM:00: registered as thermal_zone0
[    0.775701] ACPI: Thermal Zone [TZ00] (59 C)
[    0.776707] thermal LNXTHERM:02: registered as thermal_zone1
[    0.776789] ACPI: Thermal Zone [THRM] (40 C)
[    0.902441] 0000:01:00.0: eth0: (PCI Express:2.5GB/s:Width x1) 00:06:4f:8f:96:f7
[    0.902528] 0000:01:00.0: eth0: Intel(R) PRO/1000 Network Connection
[    0.902661] 0000:01:00.0: eth0: MAC: 2, PHY: 2, PBA No: ffffff-0ff
[    0.902810] xen: registering gsi 17 triggering 0 polarity 1
[    0.902817] xen_allocate_pirq: returning irq 17 for gsi 17
[    0.902876] xen: --> irq=17
[    0.902885] Already setup the GSI :17
[    0.903903] e1000e 0000:02:00.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17
[    0.904029] e1000e 0000:02:00.0: setting latency timer to 64
[    0.919844] usbcore: registered new interface driver usbfs
[    0.919943] usbcore: registered new interface driver hub
[    0.920652] usbcore: registered new device driver usb
[    0.924436] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    0.924544] xen: registering gsi 23 triggering 0 polarity 1
[    0.924564] xen: --> irq=23
[    0.924576] ehci_hcd 0000:00:1d.7: PCI INT A -> GSI 23 (level, low) -> IRQ 23
[    0.924661] ehci_hcd 0000:00:1d.7: setting latency timer to 64
[    0.924669] ehci_hcd 0000:00:1d.7: EHCI Host Controller
[    0.924752] ehci_hcd 0000:00:1d.7: new USB bus registered, assigned bus number 1
[    0.924899] ehci_hcd 0000:00:1d.7: using broken periodic workaround
[    0.924978] ehci_hcd 0000:00:1d.7: debug port 1
[    0.926476] uhci_hcd: USB Universal Host Controller Interface driver
[    0.928636] SCSI subsystem initialized
[    0.928930] ehci_hcd 0000:00:1d.7: cache line size of 32 is not supported
[    0.930213] ehci_hcd 0000:00:1d.7: irq 23, io mem 0xfdfff000
[    0.945265] ehci_hcd 0000:00:1d.7: USB 2.0 started, EHCI 1.00
[    0.945377] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
[    0.945441] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    0.945465] libata version 3.00 loaded.
[    0.945523] usb usb1: Product: EHCI Host Controller
[    0.945580] usb usb1: Manufacturer: Linux 2.6.32-5-xen-686 ehci_hcd
[    0.945639] usb usb1: SerialNumber: 0000:00:1d.7
[    0.945814] usb usb1: configuration #1 chosen from 1 choice
[    0.945921] hub 1-0:1.0: USB hub found
[    0.946000] hub 1-0:1.0: 8 ports detected
[    0.948410] xen: registering gsi 23 triggering 0 polarity 1
[    0.948415] xen_allocate_pirq: returning irq 23 for gsi 23
[    0.948475] xen: --> irq=23
[    0.948482] Already setup the GSI :23
[    0.948538] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 23 (level, low) -> IRQ 23
[    0.948611] uhci_hcd 0000:00:1d.0: setting latency timer to 64
[    0.948619] uhci_hcd 0000:00:1d.0: UHCI Host Controller
[    0.948687] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2
[    0.948810] uhci_hcd 0000:00:1d.0: irq 23, io base 0x0000fe00
[    0.948966] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001
[    0.949028] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    0.949108] usb usb2: Product: UHCI Host Controller
[    0.949165] usb usb2: Manufacturer: Linux 2.6.32-5-xen-686 uhci_hcd
[    0.949224] usb usb2: SerialNumber: 0000:00:1d.0
[    0.949379] usb usb2: configuration #1 chosen from 1 choice
[    0.949480] hub 2-0:1.0: USB hub found
[    0.949553] hub 2-0:1.0: 2 ports detected
[    0.949701] ata_piix 0000:00:1f.1: version 2.13
[    0.949717] xen: registering gsi 18 triggering 0 polarity 1
[    0.949722] xen_allocate_pirq: returning irq 18 for gsi 18
[    0.949780] xen: --> irq=18
[    0.949785] Already setup the GSI :18
[    0.949845] ata_piix 0000:00:1f.1: PCI INT A -> GSI 18 (level, low) -> IRQ 18
[    0.949968] ata_piix 0000:00:1f.1: setting latency timer to 64
[    0.953923] fan PNP0C0B:00: registered as cooling_device0
[    0.953994] ACPI: Fan [FAN] (on)
[    0.954476] scsi0 : ata_piix
[    0.954659] scsi1 : ata_piix
[    0.956876] ata1: PATA max UDMA/100 cmd 0x1f0 ctl 0x3f6 bmdma 0xfa00 irq 14
[    0.956939] ata2: PATA max UDMA/100 cmd 0x170 ctl 0x376 bmdma 0xfa08 irq 15
[    0.957059] xen: registering gsi 19 triggering 0 polarity 1
[    0.957064] xen_allocate_pirq: returning irq 19 for gsi 19
[    0.957123] xen: --> irq=19
[    0.957130] Already setup the GSI :19
[    0.957192] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 19 (level, low) -> IRQ 19
[    0.957296] uhci_hcd 0000:00:1d.1: setting latency timer to 64
[    0.957303] uhci_hcd 0000:00:1d.1: UHCI Host Controller
[    0.957373] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3
[    0.957393] ata2: port disabled. ignoring.
[    0.957531] uhci_hcd 0000:00:1d.1: irq 19, io base 0x0000fd00
[    0.957687] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001
[    0.957749] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    0.957828] usb usb3: Product: UHCI Host Controller
[    0.957884] usb usb3: Manufacturer: Linux 2.6.32-5-xen-686 uhci_hcd
[    0.957943] usb usb3: SerialNumber: 0000:00:1d.1
[    0.958171] usb usb3: configuration #1 chosen from 1 choice
[    0.958339] hub 3-0:1.0: USB hub found
[    0.958413] hub 3-0:1.0: 2 ports detected
[    0.958580] xen: registering gsi 19 triggering 0 polarity 1
[    0.958585] xen_allocate_pirq: returning irq 19 for gsi 19
[    0.958643] xen: --> irq=19
[    0.958648] Already setup the GSI :19
[    0.958702] ata_piix 0000:00:1f.2: PCI INT B -> GSI 19 (level, low) -> IRQ 19
[    0.958771] ata_piix 0000:00:1f.2: MAP [ P0 P2 -- -- ]
[    1.020675] 0000:02:00.0: eth1: (PCI Express:2.5GB/s:Width x1) 00:06:4f:8f:96:f8
[    1.020756] 0000:02:00.0: eth1: Intel(R) PRO/1000 Network Connection
[    1.020887] 0000:02:00.0: eth1: MAC: 2, PHY: 2, PBA No: ffffff-0ff
[    1.021013] xen: registering gsi 18 triggering 0 polarity 1
[    1.021018] xen_allocate_pirq: returning irq 18 for gsi 18
[    1.021055] xen: --> irq=18
[    1.021093] Already setup the GSI :18
[    1.021147] e1000e 0000:03:00.0: PCI INT A -> GSI 18 (level, low) -> IRQ 18
[    1.021268] e1000e 0000:03:00.0: setting latency timer to 64
[    1.112158] ata_piix 0000:00:1f.2: setting latency timer to 64
[    1.112432] scsi2 : ata_piix
[    1.112598] scsi3 : ata_piix
[    1.114316] ata3: SATA max UDMA/133 cmd 0xf900 ctl 0xf800 bmdma 0xf500 irq 19
[    1.114380] ata4: SATA max UDMA/133 cmd 0xf700 ctl 0xf600 bmdma 0xf508 irq 19
[    1.114520] xen: registering gsi 18 triggering 0 polarity 1
[    1.114525] xen_allocate_pirq: returning irq 18 for gsi 18
[    1.114584] xen: --> irq=18
[    1.114590] Already setup the GSI :18
[    1.114645] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18
[    1.114716] uhci_hcd 0000:00:1d.2: setting latency timer to 64
[    1.114725] uhci_hcd 0000:00:1d.2: UHCI Host Controller
[    1.114795] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4
[    1.114947] uhci_hcd 0000:00:1d.2: irq 18, io base 0x0000fc00
[    1.115099] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001
[    1.115160] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.115239] usb usb4: Product: UHCI Host Controller
[    1.115295] usb usb4: Manufacturer: Linux 2.6.32-5-xen-686 uhci_hcd
[    1.115354] usb usb4: SerialNumber: 0000:00:1d.2
[    1.115577] usb usb4: configuration #1 chosen from 1 choice
[    1.115743] hub 4-0:1.0: USB hub found
[    1.115816] hub 4-0:1.0: 2 ports detected
[    1.115964] xen: registering gsi 16 triggering 0 polarity 1
[    1.115969] xen_allocate_pirq: returning irq 16 for gsi 16
[    1.116027] xen: --> irq=16
[    1.116033] Already setup the GSI :16
[    1.116082] uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 16 (level, low) -> IRQ 16
[    1.116082] uhci_hcd 0000:00:1d.3: setting latency timer to 64
[    1.116082] uhci_hcd 0000:00:1d.3: UHCI Host Controller
[    1.116082] uhci_hcd 0000:00:1d.3: new USB bus registered, assigned bus number 5
[    1.116376] uhci_hcd 0000:00:1d.3: irq 16, io base 0x0000fb00
[    1.116521] usb usb5: New USB device found, idVendor=1d6b, idProduct=0001
[    1.116583] usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.116663] usb usb5: Product: UHCI Host Controller
[    1.116719] usb usb5: Manufacturer: Linux 2.6.32-5-xen-686 uhci_hcd
[    1.116778] usb usb5: SerialNumber: 0000:00:1d.3
[    1.117017] usb usb5: configuration #1 chosen from 1 choice
[    1.117181] hub 5-0:1.0: USB hub found
[    1.117256] hub 5-0:1.0: 2 ports detected
[    1.142115] 0000:03:00.0: eth2: (PCI Express:2.5GB/s:Width x1) 00:06:4f:8f:96:f9
[    1.142196] 0000:03:00.0: eth2: Intel(R) PRO/1000 Network Connection
[    1.142327] 0000:03:00.0: eth2: MAC: 2, PHY: 2, PBA No: ffffff-0ff
[    1.142455] xen: registering gsi 19 triggering 0 polarity 1
[    1.142460] xen_allocate_pirq: returning irq 19 for gsi 19
[    1.142517] xen: --> irq=19
[    1.142523] Already setup the GSI :19
[    1.142578] e1000e 0000:04:00.0: PCI INT A -> GSI 19 (level, low) -> IRQ 19
[    1.142699] e1000e 0000:04:00.0: setting latency timer to 64
[    1.144209] ata1.00: CFA: TRANSCEND, 20091215, max UDMA/66
[    1.144268] ata1.00: 31293360 sectors, multi 0: LBA 
[    1.193953] ata1.01: ATA-8: WDC WD3200BEVE-00A0HT0, 11.01A11, max UDMA/100
[    1.194041] ata1.01: 625142448 sectors, multi 16: LBA48 
[    1.212517] ata1.00: configured for UDMA/66
[    1.220773] ata1.01: configured for UDMA/100
[    1.236462] ata1.00: configured for UDMA/66
[    1.244794] ata1.01: configured for UDMA/100
[    1.244876] ata1: EH complete
[    1.245213] scsi 0:0:0:0: Direct-Access     ATA      TRANSCEND        2009 PQ: 0 ANSI: 5
[    1.245731] scsi 0:0:1:0: Direct-Access     ATA      WDC WD3200BEVE-0 11.0 PQ: 0 ANSI: 5
[    1.262267] 0000:04:00.0: eth3: (PCI Express:2.5GB/s:Width x1) 00:06:4f:8f:96:fa
[    1.262348] 0000:04:00.0: eth3: Intel(R) PRO/1000 Network Connection
[    1.262480] 0000:04:00.0: eth3: MAC: 2, PHY: 2, PBA No: ffffff-0ff
[    1.305793] sd 0:0:0:0: [sda] 31293360 512-byte logical blocks: (16.0 GB/14.9 GiB)
[    1.306030] sd 0:0:0:0: [sda] Write Protect is off
[    1.306087] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
[    1.306154] sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
[    1.306567]  sda:
[    1.307034] sd 0:0:1:0: [sdb] 625142448 512-byte logical blocks: (320 GB/298 GiB)
[    1.307308] sd 0:0:1:0: [sdb] Write Protect is off
[    1.307364] sd 0:0:1:0: [sdb] Mode Sense: 00 3a 00 00
[    1.307431] sd 0:0:1:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[    1.307832]  sdb: sda1
[    1.321302]  sdb1 sdb2 sdb3 sdb4
[    1.321984] sd 0:0:0:0: [sda] Attached SCSI disk
[    1.322866] sd 0:0:1:0: [sdb] Attached SCSI disk
[    1.848825] device-mapper: uevent: version 1.0.3
[    1.849098] device-mapper: ioctl: 4.15.0-ioctl (2009-04-01) initialised: dm-devel@redhat.com
[    1.881834] EXT3-fs: INFO: recovery required on readonly filesystem.
[    1.881921] EXT3-fs: write access will be enabled during recovery.
[   28.009007] kjournald starting.  Commit interval 5 seconds
[   28.009033] EXT3-fs: recovery complete.
[   28.011630] EXT3-fs: mounted filesystem with ordered data mode.
[   28.379325] udev[328]: starting version 164
[   28.476419] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input1
[   28.476515] ACPI: Power Button [PWRB]
[   28.476657] input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input2
[   28.476751] ACPI: Sleep Button [SLPB]
[   28.476901] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
[   28.476983] ACPI: Power Button [PWRF]
[   28.558151] ACPI: SSDT 7f6e8380 002AE (v01  PmRef  Cpu0Ist 00003000 INTL 20050930)
[   28.638245] ACPI: SSDT 7f6e8840 00152 (v01  PmRef  Cpu1Ist 00003000 INTL 20050930)
[   28.787174] [drm] Initialized drm 1.1.0 20060810
[   28.791592] xen: registering gsi 19 triggering 0 polarity 1
[   28.791598] xen_allocate_pirq: returning irq 19 for gsi 19
[   28.791658] xen: --> irq=19
[   28.791666] Already setup the GSI :19
[   28.791721] i801_smbus 0000:00:1f.3: PCI INT B -> GSI 19 (level, low) -> IRQ 19
[   28.794717] input: PC Speaker as /devices/platform/pcspkr/input/input4
[   28.813710] intel_rng: Firmware space is locked read-only. If you can't or
[   28.813712] intel_rng: don't want to disable this in firmware setup, and if
[   28.813714] intel_rng: you are certain that your system has a functional
[   28.813716] intel_rng: RNG, try using the 'no_fwh_detect' option.
[   29.377627] xen: registering gsi 16 triggering 0 polarity 1
[   29.377633] xen_allocate_pirq: returning irq 16 for gsi 16
[   29.377701] xen: --> irq=16
[   29.377798] Already setup the GSI :16
[   29.377855] i915 0000:00:02.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[   29.377923] i915 0000:00:02.0: setting latency timer to 64
[   29.387554] Linux video capture interface: v2.00
[   29.390422] [drm] set up 7M of stolen space
[   29.393606] [drm] initialized overlay support
[   29.445482] saa7146: register extension 'budget_av'.
[   29.445630] xen: registering gsi 16 triggering 0 polarity 1
[   29.445640] xen_allocate_pirq: returning irq 16 for gsi 16
[   29.445722] xen: --> irq=16
[   29.445735] Already setup the GSI :16
[   29.445814] budget_av 0000:05:00.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[   29.445932] budget_av 0000:05:00.0: setting latency timer to 64
[   29.445980] IRQ 16/: IRQF_DISABLED is not guaranteed on shared IRQs
[   29.446127] saa7146: found saa7146 @ mem f7f40000 (revision 1, irq 16) (0x153b,0x1156).
[   29.446283] saa7146 (0): dma buffer size 1347584
[   29.446361] DVB: registering new adapter (Terratec Cinergy 1200 DVB-C)
[   29.485103] adapter failed MAC signature check
[   29.485161] encoded MAC from EEPROM was ff:ff:ff:ff:ff:ff:ff:ff:ff:ff:ff:ff:ff:ff:ff:ff:ff:ff:ff:ff
[   29.752487] KNC1-0: MAC addr = 00:0a:ac:01:da:a5
[   29.876370] Console: switching to colour frame buffer device 240x90
[   29.889129] fb0: inteldrmfb frame buffer device
[   29.889167] registered panic notifier
[   29.889208] [drm] Initialized i915 1.6.0 20080730 for 0000:00:02.0 on minor 0
[   29.889334] xen: registering gsi 16 triggering 0 polarity 1
[   29.889339] xen_allocate_pirq: returning irq 16 for gsi 16
[   29.889394] xen: --> irq=16
[   29.889404] Already setup the GSI :16
[   29.889437] HDA Intel 0000:00:1b.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[   29.889536] HDA Intel 0000:00:1b.0: setting latency timer to 64
[   29.904933] TDA10021: i2c-addr = 0x0c, id = 0x7c
[   29.905035] DVB: registering adapter 0 frontend 0 (Philips TDA10021 DVB-C)...
[   29.905431] budget-av: ci interface initialised.
[   30.412079] EXT3 FS on sda1, internal journal
[   30.528411] it87: Found IT8712F chip at 0x290, revision 7
[   30.528587] ACPI: I/O resource it87 [0x295-0x296] conflicts with ACPI region IP__ [0x295-0x296]
[   30.528720] ACPI: This conflict may cause random problems and system instability
[   30.528835] ACPI: If an ACPI driver is available for this device, you should use it instead of the native driver
[   30.529591] it87 it87.656: Detected broken BIOS defaults, disabling PWM interface
[   31.149594] EXT4-fs (sdb1): warning: maximal mount count reached, running e2fsck is recommended
[   31.150931] EXT4-fs (sdb1): recovery complete
[   31.151376] EXT4-fs (sdb1): mounted filesystem with ordered data mode
[   31.275756] EXT4-fs (sdb2): warning: maximal mount count reached, running e2fsck is recommended
[   31.276516] EXT4-fs (sdb2): recovery complete
[   31.276614] EXT4-fs (sdb2): mounted filesystem with ordered data mode
[   31.374695] EXT4-fs (sdb3): recovery complete
[   31.374800] EXT4-fs (sdb3): mounted filesystem with ordered data mode
[   31.544223] EXT4-fs (sdb4): recovery complete
[   31.544683] EXT4-fs (sdb4): mounted filesystem with ordered data mode
[   32.201262] ADDRCONF(NETDEV_UP): eth0: link is not ready
[   33.750644] e1000e: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: None
[   33.756326] 0000:01:00.0: eth0: 10/100 speed: disabling TSO
[   33.762457] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[   36.537282] ADDRCONF(NETDEV_UP): eth1: link is not ready
[   36.883041] fuse init (API version 7.13)
[   38.110650] e1000e: eth1 NIC Link is Up 100 Mbps Full Duplex, Flow Control: None
[   38.112063] 0000:02:00.0: eth1: 10/100 speed: disabling TSO
[   38.124869] ADDRCONF(NETDEV_CHANGE): eth1: link becomes ready
[   44.644074] eth0: no IPv6 routers present
[   48.728074] eth1: no IPv6 routers present
[   75.725658] ip_tables: (C) 2000-2006 Netfilter Core Team
[   75.766444] nf_conntrack version 0.5.0 (16314 buckets, 65256 max)
[   75.770901] CONFIG_NF_CT_ACCT is deprecated and will be removed soon. Please use
[   75.773988] nf_conntrack.acct=1 kernel parameter, acct=1 nf_conntrack module option or
[   75.773988] sysctl net.netfilter.nf_conntrack_acct=1 to enable it.
[   91.903391] RPC: Registered udp transport module.
[   91.904055] RPC: Registered tcp transport module.
[   91.904055] RPC: Registered tcp NFSv4.1 backchannel transport module.
[   91.962838] Installing knfsd (copyright (C) 1996 okir@monad.swb.de).
[   92.012654] svc: failed to register lockdv1 RPC service (errno 97).
[   92.019025] NFSD: Using /var/lib/nfs/v4recovery as the NFSv4 state recovery directory
[   92.023424] NFSD: starting 90-second grace period
[   92.390208] Event-channel device installed.
[   92.432237] XENBUS: Unable to read cpu state
[   92.436718] XENBUS: Unable to read cpu state
[   92.874990] Bridge firewalling registered
[   93.187502] ADDRCONF(NETDEV_UP): peth1: link is not ready
[   94.710617] e1000e: peth1 NIC Link is Up 100 Mbps Full Duplex, Flow Control: None
[   94.712056] 0000:02:00.0: peth1: 10/100 speed: disabling TSO
[   94.718996] ADDRCONF(NETDEV_CHANGE): peth1: link becomes ready
[   95.220246] device peth1 entered promiscuous mode
[   95.253124] eth1: port 1(peth1) entering forwarding state
[  104.856073] peth1: no IPv6 routers present
[  106.233072] eth1: no IPv6 routers present
[  127.649727] virbr0: starting userspace STP failed, starting kernel STP
[  128.132942] Ebtables v2.0 registered
[  128.621245] ip6_tables: (C) 2000-2006 Netfilter Core Team
[  683.004359] tun: Universal TUN/TAP device driver, 1.6
[  683.006483] tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com>
[  683.050056] device tap1.0 entered promiscuous mode
[  683.052487] virbr0: topology change detected, propagating
[  683.052487] virbr0: port 1(tap1.0) entering forwarding state
[  683.166602] device vif1.0 entered promiscuous mode
[  683.177583] loop: module loaded
[  683.181876] virbr0: topology change detected, propagating
[  683.185304] virbr0: port 2(vif1.0) entering forwarding state
[  683.217629] virbr0: port 1(tap1.0) entering disabled state
[  683.249278] virbr0: topology change detected, propagating
[  683.252934] virbr0: port 1(tap1.0) entering forwarding state
[  686.480914] hrtimer: interrupt took 2644300487 ns
[  697.840170] vif1.0: no IPv6 routers present
[  697.840170] tap1.0: no IPv6 routers present
[  706.101891] saa7146 (0) vpeirq: used 1 times >80% of buffer (1229332 bytes now)
[  706.741377] virbr0: port 1(tap1.0) entering disabled state
[  706.757543] virbr0: port 1(tap1.0) entering disabled state
[  706.888725] virbr0: port 2(vif1.0) entering disabled state
[  706.901275] virbr0: port 2(vif1.0) entering disabled state

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

-----------------------------------------------------------
irq  cpu: delta avg/s max/s driver
1518   0: 67    12    14    eth0
1517   0: 112   24    52    peth1
  16   0: 536   107   108   uhci_hcd:usb5, i915, saa7146 (0), HDA Intel
-----------------------------------------------------------
irq  cpu: delta avg/s max/s driver
 CAL   1: 101   10    20    call interrupts
1526   1: 101   10    20    callfuncsingle1
1525   0: 645   64    129   xenbus
1518   0: 77    14    15    eth0
1517   0: 70    19    52    peth1
1514   0: 370   37    74    evtchn:xenstored
  16 CPU0 going backwards (-67934)!
  14   0: 50808 5080  10161 ata_piix
   4 CPU0 going backwards (-710)!
   1 CPU0 going backwards (-8)!
-----------------------------------------------------------
irq  cpu: delta avg/s max/s driver
1525   0: 597   91    129   xenbus
1518   0: 74    14    15    eth0
1517   0: 76    17    52    peth1
1514   0: 363   54    74    evtchn:xenstored
1512 CPU0 going backwards (-1)!
1511 CPU0 going backwards (-13664)!
  16 CPU0 going backwards (-50687)!
  14 CPU0 going backwards (-17764)!
-----------------------------------------------------------
irq  cpu: delta avg/s max/s driver
1518   0: 77    14    15    eth0
1517   0: 113   19    52    peth1
  16   0: 538   107   108   uhci_hcd:usb5, i915, saa7146 (0), HDA Intel
-----------------------------------------------------------


[-- Attachment #4: xm_dmesg_4.1_amd64_loglvl=all --]
[-- Type: text/plain, Size: 8025 bytes --]

(XEN) Xen version 4.1.0 (Debian 4.1.0-1) (waldi@debian.org) (gcc version 4.5.2 (Debian 4.5.2-7) ) Sun Mar 27 18:23:30 UTC 2011
(XEN) Bootloader: GRUB 1.98+20100804-14
(XEN) Command line: placeholder cpufreq=xen cpuidle dom0_mem=1024M loglvl=all guest_loglvl=all
(XEN) Video information:
(XEN)  VGA is text mode 80x25, font 8x16
(XEN)  VBE/DDC methods: V2; EDID transfer time: 1 seconds
(XEN) Disc information:
(XEN)  Found 2 MBR signatures
(XEN)  Found 2 EDD information structures
(XEN) Xen-e820 RAM map:
(XEN)  0000000000000000 - 000000000009f000 (usable)
(XEN)  000000000009f000 - 00000000000a0000 (reserved)
(XEN)  00000000000f0000 - 0000000000100000 (reserved)
(XEN)  0000000000100000 - 000000007f690000 (usable)
(XEN)  000000007f690000 - 000000007f6e0000 (reserved)
(XEN)  000000007f6e0000 - 000000007f6e3000 (ACPI NVS)
(XEN)  000000007f6e3000 - 000000007f6f0000 (ACPI data)
(XEN)  000000007f6f0000 - 000000007f700000 (reserved)
(XEN)  00000000e0000000 - 00000000f0000000 (reserved)
(XEN)  00000000fec00000 - 0000000100000000 (reserved)
(XEN) System RAM: 2038MB (2087100kB)
(XEN) ACPI: RSDP 000F7C90, 0014 (r0 IntelR)
(XEN) ACPI: RSDT 7F6E3000, 0038 (r1 IntelR AWRDACPI 42302E31 AWRD        0)
(XEN) ACPI: FACP 7F6E3080, 0074 (r1 IntelR AWRDACPI 42302E31 AWRD        0)
(XEN) ACPI: DSDT 7F6E3100, 5122 (r1 INTELR AWRDACPI     1000 MSFT  3000000)
(XEN) ACPI: FACS 7F6E0000, 0040
(XEN) ACPI: IDTS 7F6E82C0, 0028 (r1 IntelR AWRDACPI 42302E31 AWRD        0)
(XEN) ACPI: MCFG 7F6E8300, 003C (r1 IntelR AWRDACPI 42302E31 AWRD        0)
(XEN) ACPI: APIC 7F6E8240, 0068 (r1 IntelR AWRDACPI 42302E31 AWRD        0)
(XEN) ACPI: SSDT 7F6E89A0, 0482 (r1  PmRef    CpuPm     3000 INTL 20050930)
(XEN) No NUMA configuration found
(XEN) Faking a node at 0000000000000000-000000007f690000
(XEN) Domain heap initialised
(XEN) found SMP MP-table at 000f38d0
(XEN) DMI 2.2 present.
(XEN) Using APIC driver default
(XEN) ACPI: PM-Timer IO Port: 0x408
(XEN) ACPI: ACPI SLEEP INFO: pm1x_cnt[404,0], pm1x_evt[400,0]
(XEN) ACPI:                  wakeup_vec[7f6e000c], vec_size[20]
(XEN) ACPI: Local APIC address 0xfee00000
(XEN) ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
(XEN) Processor #0 6:15 APIC version 20
(XEN) ACPI: LAPIC (acpi_id[0x01] lapic_id[0x01] enabled)
(XEN) Processor #1 6:15 APIC version 20
(XEN) ACPI: LAPIC_NMI (acpi_id[0x00] high edge lint[0x1])
(XEN) ACPI: LAPIC_NMI (acpi_id[0x01] high edge lint[0x1])
(XEN) ACPI: IOAPIC (id[0x02] address[0xfec00000] gsi_base[0])
(XEN) IOAPIC[0]: apic_id 2, version 32, address 0xfec00000, GSI 0-23
(XEN) ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
(XEN) ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
(XEN) ACPI: IRQ0 used by override.
(XEN) ACPI: IRQ2 used by override.
(XEN) ACPI: IRQ9 used by override.
(XEN) Enabling APIC mode:  Flat.  Using 1 I/O APICs
(XEN) PCI: MCFG configuration 0: base e0000000 segment 0 buses 0 - 255
(XEN) PCI: MCFG area at e0000000 reserved in E820
(XEN) Table is not found!
(XEN) Using ACPI (MADT) for SMP configuration information
(XEN) IRQ limits: 24 GSI, 376 MSI/MSI-X
(XEN) Using scheduler: SMP Credit Scheduler (credit)
(XEN) Detected 1995.076 MHz processor.
(XEN) Initing memory sharing.
(XEN) mce_intel.c:1162: MCA Capability: BCAST 1 SER 0 CMCI 0 firstbank 1 extended MCE MSR 0
(XEN) Intel machine check reporting enabled
(XEN) I/O virtualisation disabled
(XEN) ENABLING IO-APIC IRQs
(XEN)  -> Using new ACK method
(XEN) ..TIMER: vector=0xF0 apic1=0 pin1=2 apic2=-1 pin2=-1
(XEN) Platform timer is 3.579MHz ACPI PM Timer
(XEN) Allocated console ring of 16 KiB.
(XEN) VMX: Supported advanced features:
(XEN)  - APIC TPR shadow
(XEN)  - MSR direct-access bitmap
(XEN) HVM: ASIDs disabled.
(XEN) HVM: VMX enabled
(XEN) Brought up 2 CPUs
(XEN) HPET broadcast init failed, turn to PIT broadcast.
(XEN) ACPI sleep modes: S3
(XEN) mcheck_poll: Machine check polling timer started.
(XEN) *** LOADING DOMAIN 0 ***
(XEN)  Xen  kernel: 64-bit, lsb, compat32
(XEN)  Dom0 kernel: 32-bit, PAE, lsb, paddr 0x1000000 -> 0x1651000
(XEN) PHYSICAL MEMORY ARRANGEMENT:
(XEN)  Dom0 alloc.:   000000007a000000->000000007c000000 (248320 pages to be allocated)
(XEN)  Init. ramdisk: 000000007dc00000->000000007f1ffc00
(XEN) VIRTUAL MEMORY ARRANGEMENT:
(XEN)  Loaded kernel: 00000000c1000000->00000000c1651000
(XEN)  Init. ramdisk: 00000000c1651000->00000000c2c50c00
(XEN)  Phys-Mach map: 00000000c2c51000->00000000c2d51000
(XEN)  Start info:    00000000c2d51000->00000000c2d514b4
(XEN)  Page tables:   00000000c2d52000->00000000c2d70000
(XEN)  Boot stack:    00000000c2d70000->00000000c2d71000
(XEN)  TOTAL:         00000000c0000000->00000000c3000000
(XEN)  ENTRY ADDRESS: 00000000c13ff000
(XEN) Dom0 has maximum 2 VCPUs
(XEN) Scrubbing Free RAM: .........done.
(XEN) Xen trace buffers: disabled
(XEN) Std. Loglevel: All
(XEN) Guest Loglevel: All
(XEN) Xen is relinquishing VGA console.
(XEN) *** Serial input -> DOM0 (type 'CTRL-a' three times to switch input to Xen)
(XEN) Freed 220kB init memory.
(XEN) PCI add device 00:00.0
(XEN) PCI add device 00:02.0
(XEN) PCI add device 00:1b.0
(XEN) PCI add device 00:1c.0
(XEN) PCI add device 00:1c.1
(XEN) PCI add device 00:1c.2
(XEN) PCI add device 00:1c.3
(XEN) PCI add device 00:1d.0
(XEN) PCI add device 00:1d.1
(XEN) PCI add device 00:1d.2
(XEN) PCI add device 00:1d.3
(XEN) PCI add device 00:1d.7
(XEN) PCI add device 00:1e.0
(XEN) PCI add device 00:1f.0
(XEN) PCI add device 00:1f.1
(XEN) PCI add device 00:1f.2
(XEN) PCI add device 00:1f.3
(XEN) PCI add device 01:00.0
(XEN) PCI add device 02:00.0
(XEN) PCI add device 03:00.0
(XEN) PCI add device 04:00.0
(XEN) PCI add device 05:00.0
(XEN) HVM1: HVM Loader
(XEN) HVM1: Detected Xen v4.1.0
(XEN) HVM1: CPU speed is 1995 MHz
(XEN) irq.c:258: Dom1 PCI link 0 changed 0 -> 5
(XEN) HVM1: PCI-ISA link 0 routed to IRQ5
(XEN) irq.c:258: Dom1 PCI link 1 changed 0 -> 10
(XEN) HVM1: PCI-ISA link 1 routed to IRQ10
(XEN) irq.c:258: Dom1 PCI link 2 changed 0 -> 11
(XEN) HVM1: PCI-ISA link 2 routed to IRQ11
(XEN) irq.c:258: Dom1 PCI link 3 changed 0 -> 5
(XEN) HVM1: PCI-ISA link 3 routed to IRQ5
(XEN) HVM1: pci dev 01:2 INTD->IRQ5
(XEN) HVM1: pci dev 01:3 INTA->IRQ10
(XEN) HVM1: pci dev 03:0 INTA->IRQ5
(XEN) HVM1: pci dev 04:0 INTA->IRQ5
(XEN) HVM1: pci dev 02:0 bar 10 size 02000000: f0000008
(XEN) HVM1: pci dev 03:0 bar 14 size 01000000: f2000008
(XEN) HVM1: pci dev 02:0 bar 14 size 00001000: f3000000
(XEN) HVM1: pci dev 03:0 bar 10 size 00000100: 0000c001
(XEN) HVM1: pci dev 04:0 bar 10 size 00000100: 0000c101
(XEN) HVM1: pci dev 04:0 bar 14 size 00000100: f3001000
(XEN) HVM1: pci dev 01:2 bar 20 size 00000020: 0000c201
(XEN) HVM1: pci dev 01:1 bar 20 size 00000010: 0000c221
(XEN) HVM1: Multiprocessor initialisation:
(XEN) HVM1:  - CPU0 ... 36-bit phys ... fixed MTRRs ... var MTRRs [2/8] ... done.
(XEN) HVM1: Writing SMBIOS tables ...
(XEN) HVM1: Loading ROMBIOS ...
(XEN) HVM1: 10588 bytes of ROMBIOS high-memory extensions:
(XEN) HVM1:   Relocating to 0xfc000000-0xfc00295c ... done
(XEN) HVM1: Creating MP tables ...
(XEN) HVM1: Loading Cirrus VGABIOS ...
(XEN) HVM1: Loading PCI Option ROM ...
(XEN) HVM1:  - Manufacturer: http://etherboot.org
(XEN) HVM1:  - Product name: gPXE
(XEN) HVM1: Loading ACPI ...
(XEN) HVM1:  - Lo data: 000ea020-000ea04f
(XEN) HVM1:  - Hi data: fc002c00-fc012d1f
(XEN) HVM1: vm86 TSS at fc013000
(XEN) HVM1: BIOS map:
(XEN) HVM1:  c0000-c8fff: VGA BIOS
(XEN) HVM1:  c9000-d57ff: Etherboot ROM
(XEN) HVM1:  eb000-eb140: SMBIOS tables
(XEN) HVM1:  f0000-fffff: Main BIOS
(XEN) HVM1: Invoking ROMBIOS ...
(XEN) HVM1: $Revision: 1.221 $ $Date: 2008/12/07 17:32:29 $
(XEN) stdvga.c:147:d1 entering stdvga and caching modes
(XEN) HVM1: VGABios $Id: vgabios.c,v 1.67 2008/01/27 09:44:12 vruppert Exp $
(XEN) HVM1: Bochs BIOS - build: 06/23/99
(XEN) HVM1: $Revision: 1.221 $ $Date: 2008/12/07 17:32:29 $
(XEN) HVM1: Options: apmbios pcibios eltorito PMM 
(XEN) HVM1: 
(XEN) HVM1: ata0-0: PCHS=2/16/63 translation=none LCHS=2/16/63
(XEN) HVM1: ata0 master: QEMU HARDDISK ATA-7 Hard-Disk (   0 MBytes)

[-- Attachment #5: config.sxp --]
[-- Type: text/plain, Size: 3359 bytes --]

(domain
    (domid 1)
    (vcpus_params ((cap 0) (weight 256)))
    (PV_args '')
    (memory_static_min 0)
    (HVM_boot_policy 'BIOS order')
    (PV_bootloader '')
    (pool_name Pool-0)
    (auto_power_on False)
    (memory_static_max 536870912)
    (cpus (()))
    (actions_after_shutdown destroy)
    (memory_dynamic_max 536870912)
    (memory_sharing 0)
    (superpages 0)
    (is_a_template False)
    (PV_bootloader_args '')
    (memory_dynamic_min 536870912)
    (VCPUs_live 1)
    (target 0)
    (actions_after_crash restart)
    (uuid b4b625ee-3ca5-7921-9bec-affbc54edff4)
    (PV_ramdisk '')
    (other_config ())
    (name_label websrv)
    (PV_kernel '')
    (actions_after_reboot restart)
    (VCPUs_at_startup 1)
    (HVM_boot_params ((order c)))
    (platform
        ((timer_mode 1)
            (hpet 0)
            (vpt_align 1)
            (apic 1)
            (loader /usr/lib/xen-default/boot/hvmloader)
            (rtc_timeoffset 0)
            (serial pty)
            (nomigrate 0)
            (tsc_mode 0)
            (usb 1)
            (device_model /usr/lib/xen/bin/qemu-dm)
            (boot c)
            (parallel none)
            (xen_platform_pci 1)
            (pci ())
            (pae 1)
            (viridian 0)
            (acpi 1)
        )
    )
    (VCPUs_max 1)
    (Description '')
    (pool_name Pool-0)
    (bootloader '')
    (vcpus 1)
    (cpus (()))
    (on_poweroff destroy)
    (description '')
    (on_crash restart)
    (uuid b4b625ee-3ca5-7921-9bec-affbc54edff4)
    (bootloader_args '')
    (name websrv)
    (on_reboot restart)
    (maxmem 512)
    (memory 512)
    (shadow_memory 5)
    (vcpu_avail '1')
    (features '')
    (on_xend_start ignore)
    (on_xend_stop ignore)
    (start_time 1302796976.83)
    (cpu_time 0.0)
    (image
        (hvm
            (kernel '')
            (superpages 0)
            (hpet 0)
            (loader /usr/lib/xen-default/boot/hvmloader)
            (xen_platform_pci 1)
            (rtc_timeoffset 0)
            (parallel none)
            (pci ())
            (timer_mode 1)
            (apic 1)
            (vpt_align 1)
            (serial pty)
            (boot c)
            (pae 1)
            (viridian 0)
            (acpi 1)
            (nomigrate 0)
            (usb 1)
            (tsc_mode 0)
            (device_model /usr/lib/xen/bin/qemu-dm)
            (notes (SUSPEND_CANCEL 1))
        )
    )
    (status 1)
    (state ------)
    (store_mfn '1044476')
    (device
        (vif
            (bridge virbr0)
            (mac 00:16:36:13:81:93)
            (script /etc/xen/scripts/vif-bridge)
            (uuid 4a6ef9e2-ba31-cc76-d364-bdbb496d4984)
            (backend 0)
        )
    )
    (device (vkbd (backend 0)))
    (device
        (console
            (protocol vt100)
            (location 3)
            (uuid 08f24b3c-f4c9-03cf-ebb2-f5cdf9912f85)
        )
    )
    (device
        (vbd
            (uuid c4f12299-973e-4c36-9c85-0628d09a8c77)
            (bootable 1)
            (dev hda:disk)
            (uname file:/home/guest2.dsk)
            (mode w)
            (backend 0)
            (VDI '')
        )
    )
    (device
        (vfb
            (vncunused 1)
            (keymap de)
            (vnc 1)
            (uuid 6ad8d0f9-b12c-2707-7635-72269fb7ff5a)
            (location 127.0.0.1:5900)
        )
    )
)

[-- Attachment #6: Type: text/plain, Size: 138 bytes --]

_______________________________________________
Xen-devel mailing list
Xen-devel@lists.xensource.com
http://lists.xensource.com/xen-devel

      reply	other threads:[~2011-04-14 16:29 UTC|newest]

Thread overview: 3+ messages / expand[flat|nested]  mbox.gz  Atom feed  top
2011-04-13  7:30 on starting HVM-domU whole system freezes with "soft lockup - CPU X stuck for XXs! [qemu-dm:...]" MadLoisae
2011-04-14 13:09 ` Konrad Rzeszutek Wilk
2011-04-14 16:29   ` MadLoisae [this message]

Reply instructions:

You may reply publicly to this message via plain-text email
using any one of the following methods:

* Save the following mbox file, import it into your mail client,
  and reply-to-all from there: mbox

  Avoid top-posting and favor interleaved quoting:
  https://en.wikipedia.org/wiki/Posting_style#Interleaved_style

* Reply using the --to, --cc, and --in-reply-to
  switches of git-send-email(1):

  git send-email \
    --in-reply-to=4DA720EA.9040907@gmx.net \
    --to=madloisae@gmx.net \
    --cc=keir.xen@gmail.com \
    --cc=konrad.wilk@oracle.com \
    --cc=xen-devel@lists.xensource.com \
    /path/to/YOUR_REPLY

  https://kernel.org/pub/software/scm/git/docs/git-send-email.html

* If your mail client supports setting the In-Reply-To header
  via mailto: links, try the mailto: link
Be sure your reply has a Subject: header at the top and a blank line before the message body.
This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox;
as well as URLs for NNTP newsgroup(s).