* on starting HVM-domU whole system freezes with "soft lockup - CPU X stuck for XXs! [qemu-dm:...]"
@ 2011-04-13 7:30 MadLoisae
2011-04-14 13:09 ` Konrad Rzeszutek Wilk
0 siblings, 1 reply; 3+ messages in thread
From: MadLoisae @ 2011-04-13 7:30 UTC (permalink / raw)
To: xen-devel
[-- Attachment #1: Type: text/plain, Size: 5420 bytes --]
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":
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.
best regards
Alois
[-- Attachment #2: xm_dmesg --]
[-- Type: text/plain, Size: 3473 bytes --]
(XEN) Xen version 4.0.1 (Debian 4.0.1-2) (waldi@debian.org) (gcc version 4.4.5 (Debian 4.4.5-10) ) Wed Jan 12 15:04:50 UTC 2011
(XEN) Bootloader: GRUB 1.98+20100804-14
(XEN) Command line: placeholder cpufreq=xen cpuidle dom0_mem=1024M
(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) Xen heap: 8MB (8852kB)
(XEN) Domain heap initialised
(XEN) Processor #0 6:15 APIC version 20
(XEN) Processor #1 6:15 APIC version 20
(XEN) IOAPIC[0]: apic_id 2, version 32, address 0xfec00000, GSI 0-23
(XEN) Enabling APIC mode: Flat. Using 1 I/O APICs
(XEN) Using scheduler: SMP Credit Scheduler (credit)
(XEN) Detected 1995.074 MHz processor.
(XEN) VMX: Supported advanced features:
(XEN) - MSR direct-access bitmap
(XEN) HVM: ASIDs disabled.
(XEN) HVM: VMX enabled
(XEN) I/O virtualisation disabled
(XEN) Total of 2 processors activated.
(XEN) ENABLING IO-APIC IRQs
(XEN) -> Using new ACK method
(XEN) checking TSC synchronization across 2 CPUs: passed.
(XEN) Platform timer is 3.579MHz ACPI PM Timer
(XEN) Allocated console ring of 16 KiB.
(XEN) Brought up 2 CPUs
(XEN) HPET broadcast init failed, turn to PIT broadcast.
(XEN) *** LOADING DOMAIN 0 ***
(XEN) Xen kernel: 32-bit, PAE, lsb
(XEN) Dom0 kernel: 32-bit, PAE, lsb, paddr 0x1000000 -> 0x1651000
(XEN) PHYSICAL MEMORY ARRANGEMENT:
(XEN) Dom0 alloc.: 0000000038000000->000000003c000000 (245760 pages to be allocated)
(XEN) VIRTUAL MEMORY ARRANGEMENT:
(XEN) Loaded kernel: c1000000->c1651000
(XEN) Init. ramdisk: c1651000->c2c50c00
(XEN) Phys-Mach map: c2c51000->c2d51000
(XEN) Start info: c2d51000->c2d5147c
(XEN) Page tables: c2d52000->c2d6f000
(XEN) Boot stack: c2d6f000->c2d70000
(XEN) TOTAL: c0000000->c3000000
(XEN) ENTRY ADDRESS: c13ff000
(XEN) Dom0 has maximum 2 VCPUs
(XEN) Scrubbing Free RAM: .........done.
(XEN) Xen trace buffers: disabled
(XEN) Std. Loglevel: Errors and warnings
(XEN) Guest Loglevel: Nothing (Rate-limited: Errors and warnings)
(XEN) Xen is relinquishing VGA console.
(XEN) *** Serial input -> DOM0 (type 'CTRL-a' three times to switch input to Xen)
(XEN) Freed 152kB init memory.
[-- Attachment #3: Type: text/plain, Size: 138 bytes --]
_______________________________________________
Xen-devel mailing list
Xen-devel@lists.xensource.com
http://lists.xensource.com/xen-devel
^ permalink raw reply [flat|nested] 3+ messages in thread
* Re: on starting HVM-domU whole system freezes with "soft lockup - CPU X stuck for XXs! [qemu-dm:...]"
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
0 siblings, 1 reply; 3+ messages in thread
From: Konrad Rzeszutek Wilk @ 2011-04-14 13:09 UTC (permalink / raw)
To: MadLoisae@gmx.net; +Cc: xen-devel
[-- Attachment #1: Type: text/plain, Size: 6079 bytes --]
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: read_interrupts.c --]
[-- Type: text/x-csrc, Size: 5129 bytes --]
#include <stdio.h>
#include <string.h>
#include <stdlib.h>
/*
*/
char *interrupts = "/proc/interrupts";
static int DELTA = 30;
static int MAX_CNT = -1;
static int MAX_SLEEP = 5;
#define MAX_CPUS 64
#define MAX_NAME 64
#define MAX_LINE 300
struct irq {
int nr;
char name[5];
int number[MAX_CPUS];
int avg[MAX_CPUS];
int max[MAX_CPUS];
char type[MAX_NAME];
char drivers[MAX_NAME];
struct irq *next;
};
struct snapshot {
int cpu_cnt;
int cnt;
struct irq *irq;
};
int get_cpu_count()
{
FILE *fp;
int cpu_count;
char buf[MAX_LINE];
char *s;
fp = fopen("/proc/cpuinfo","r");
if (!fp)
return -1;
cpu_count = 0;
// Get CPUs out of the way.
while (1) {
s = fgets(buf, MAX_LINE, fp);
if (!s) {
if (!feof(fp)) {
printf("%s: termianted before eof.\n", __FUNCTION__);
}
break;
}
if (strlen(buf) < 1)
continue;
if (buf[strlen(buf)-1] == '\n')
buf[strlen(buf)-1] = '\0';
s = strchr(buf, ':');
if (!s)
continue;
if (strncmp(buf,"processor", strlen("processor")) == 0) {
cpu_count ++;
}
}
fclose(fp);
return cpu_count;
}
static struct snapshot *
get_snapshot(int cpu_count)
{
FILE *fp;
int i;
char buf[MAX_LINE];
char *s,*temp;
struct snapshot *now;
struct irq *irq;
now = malloc(sizeof(struct snapshot));
now->cpu_cnt = cpu_count;
now->irq = NULL;
fp = fopen(interrupts,"r");
if (!fp)
return NULL;
while (1) {
s = fgets(buf, MAX_LINE, fp);
if (!s) {
if (!feof(fp)) {
printf("%s: termianted before eof.\n", __FUNCTION__);
}
break;
}
if (strlen(buf) < 1)
continue;
if (buf[strlen(buf)-1] == '\n')
buf[strlen(buf)-1] = '\0';
// Skip the CPU0.. CPU1..
s = buf;
while (s) {
char *p;
p = strstr(s, "CPU");
if (!p)
break;
s = strchr(s+3, ' ');
while (*s == ' ')
s++;
}
if (*s == '\0')
continue;
/* List re-order */
irq = malloc(sizeof(struct irq));
memset(irq, 0, sizeof(struct irq));
irq->next = now->irq;
now->irq = irq;
//printf("[%s]\n", s);
/* Get IRQ, or the string value */
temp = strchr(s,':');
strncpy(irq->name, s, 4);
irq->nr = 0;
irq->nr = atoi(irq->name);
s = ++temp;
// For CPU count write values
for (i = 0; i < cpu_count; i++) {
while (isblank(*s))
s++;
/*
if (i == 0)
printf("%d:%d<---", irq->nr, atoi(s)); */
irq->number[i] = atoi(s);
while (isdigit(*s))
s++;
}
while (isblank(*s))
s++;
temp = strchr(s,' ');
if (!temp)
temp = s + strlen(s);
//printf("![%s]\n", s);
strncpy(irq->type, s, temp-s > MAX_NAME ? MAX_NAME : temp-s);
s = temp;
while (isblank(*s))
s++;
//printf("[%s]\n",s);
strncpy(irq->drivers, s, strlen(s) >MAX_NAME ? MAX_NAME : strlen(s));
}
/* CPU0 CPU1 CPU2 CPU3
16: 9 0 0 0 xen-pirq-ioapic-level uhci_hcd:usb3, nouveau, pata_jmicron
274: 47 0 0 0 xen-dyn-event pcifront
275: 0 0 0 0 xen-dyn-event vkbd
276: 54 0 0 0 xen-dyn-event eth0
277: 324 21 0 0 xen-dyn-event hvc_console
*/
fclose(fp);
return now;
}
void cleanup(struct snapshot *now) {
struct irq *p,*q;
p = now->irq;
while (p) {
q = p->next;
free(p);
p = q;
}
free(now);
}
static const char *blacklist[] = {"timer", "resched","interrupts", NULL};
void get_delta(struct snapshot *b, struct snapshot *n)
{
struct irq *p_old,*q_old, *p_new, *q_new;
int i, delta;
char *p;
p_old = b->irq;
p_new = n->irq;
printf("-----------------------------------------------------------\n");
printf("irq cpu: delta avg/s max/s driver\n");
while (p_new && p_old) {
q_old = p_old->next;
q_new = p_new->next;
for (i = 0; blacklist[i]; i++) {
if (blacklist[i] == NULL)
break;
if (strncmp(blacklist[i],
p_old->drivers,
strlen(blacklist[i])) == 0) {
goto skip;
}
}
for (i = 0; i < b->cpu_cnt; i++) {
p_new->avg[i] = p_old->avg[i];
p_new->max[i] = p_old->max[i];
delta = 0;
delta = p_new->number[i] - p_old->number[i];
if ((delta == p_old->number[i]) ||
delta == p_new->number[i])
continue;
if (delta < 0) {
printf("%s CPU%d going backwards (%d)!\n", p_old->name, i, delta);
continue;
}
p_new->avg[i] = (delta + p_old->avg[i]) / 2;
if (delta > p_new->max[i])
p_new->max[i] = delta;
if (delta > DELTA) {
printf("%-5s %2d: %-5d %-5d %-5d %s\n",
p_old->name, i, delta,
p_new->avg[i] / MAX_SLEEP, p_new->max[i] / MAX_SLEEP,
p_old->drivers);
}
}
skip:
p_old = q_old;
p_new = q_new;
}
}
int main(int argc, char *argv[])
{
struct snapshot *before, *now;
struct irq *p,*q;
int cnt;
int cpu_count;
cpu_count = get_cpu_count();
if (cpu_count == 0)
return;
cnt = MAX_CNT;
before = get_snapshot(cpu_count);
while (cnt--) {
sleep(MAX_SLEEP);
now = get_snapshot(cpu_count);
get_delta(before ,now);
cleanup(before);
before = now;
if (cnt - 1 == 0 && MAX_CNT == -1)
cnt = MAX_CNT;
}
cleanup(before);
return;
return cnt;
}
[-- Attachment #3: Type: text/plain, Size: 138 bytes --]
_______________________________________________
Xen-devel mailing list
Xen-devel@lists.xensource.com
http://lists.xensource.com/xen-devel
^ permalink raw reply [flat|nested] 3+ messages in thread
* Re: on starting HVM-domU whole system freezes with "soft lockup - CPU X stuck for XXs! [qemu-dm:...]"
2011-04-14 13:09 ` Konrad Rzeszutek Wilk
@ 2011-04-14 16:29 ` MadLoisae
0 siblings, 0 replies; 3+ messages in thread
From: MadLoisae @ 2011-04-14 16:29 UTC (permalink / raw)
To: Konrad Rzeszutek Wilk, keir.xen; +Cc: xen-devel
[-- 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
^ permalink raw reply [flat|nested] 3+ messages in thread
end of thread, other threads:[~2011-04-14 16:29 UTC | newest]
Thread overview: 3+ messages (download: mbox.gz follow: Atom feed
-- links below jump to the message on this page --
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 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).