thr3ads.net - Xen users - [Xen-users] After memory upgrade - slow boot and "ERROR: Invalid checksum?" [Jan 2009]

If this information is useful, please help other people find it:
Share via:

Ralf Hornik Mailings

2009-Jan-29 12:21 UTC

[Xen-users] After memory upgrade - slow boot and "ERROR: Invalid checksum?"

Hi list,

since my memory upgrade from 2G to 6G RAM, the xen 2.6.18.8 kernel  
from xen 3.3.1 does boot very slow and with call traces (see dmesg  
output below).

root@dom0:~# dmesg
  0x000003a5 MSFT 0x01000013) @ 0x00000000ceff4000
ACPI:  (v001 INTEL  DQ3510J  0x000003a5 MSFT 0x01000013) @ 0x00000000ceff2000
   >>> ERROR: Invalid checksum
ACPI: ASPT (v001 INTEL  DQ3510J  0x000003a5 MSFT 0x01000013) @  
0x00000000ceff1000
ACPI: WDTT (v001 INTEL  DQ3510J  0x000003a5 MSFT 0x01000013) @  
0x00000000ceff0000
ACPI: SSDT (v001 INTEL     CpuPm 0x000003a5 MSFT 0x01000013) @  
0x00000000cefef000
ACPI: SSDT (v001 INTEL   Cpu0Ist 0x000003a5 MSFT 0x01000013) @  
0x00000000cefee000
ACPI: SSDT (v001 INTEL   Cpu1Ist 0x000003a5 MSFT 0x01000013) @  
0x00000000cefed000
ACPI: SSDT (v001 INTEL   Cpu2Ist 0x000003a5 MSFT 0x01000013) @  
0x00000000cefec000
ACPI: SSDT (v001 INTEL   Cpu3Ist 0x000003a5 MSFT 0x01000013) @  
0x00000000cefeb000
ACPI: SSDT (v001 INTEL   Cpu0Cst 0x000003a5 MSFT 0x01000013) @  
0x00000000cefea000
ACPI: SSDT (v001 INTEL   Cpu1Cst 0x000003a5 MSFT 0x01000013) @  
0x00000000cefe9000
ACPI: SSDT (v001 INTEL   Cpu2Cst 0x000003a5 MSFT 0x01000013) @  
0x00000000cefe8000
ACPI: SSDT (v001 INTEL   Cpu3Cst 0x000003a5 MSFT 0x01000013) @  
0x00000000cefe7000
ACPI: TCPA (v002 INTEL  TIANO    0x00000002 MSFT 0x01000013) @  
0x00000000cef7b000
ACPI: DSDT (v001 INTEL  DQ3510J  0x000003a5 MSFT 0x01000013) @  
0x0000000000000000
ACPI: Local APIC address 0xfee00000
ACPI: LAPIC (acpi_id[0x01] lapic_id[0x00] enabled)
ACPI: LAPIC (acpi_id[0x03] lapic_id[0x02] enabled)
ACPI: LAPIC (acpi_id[0x02] lapic_id[0x01] enabled)
ACPI: LAPIC (acpi_id[0x04] lapic_id[0x03] enabled)
ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1])
ACPI: LAPIC_NMI (acpi_id[0x02] dfl dfl lint[0x1])
ACPI: IOAPIC (id[0x02] address[0xfec00000] gsi_base[0])
IOAPIC[0]: apic_id 2, version 32, address 0xfec00000, GSI 0-23
ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
ACPI: IRQ0 used by override.
ACPI: IRQ2 used by override.
ACPI: IRQ9 used by override.
Setting APIC routing to xen
Using ACPI (MADT) for SMP configuration information
Allocating PCI resources starting at d2000000 (gap: d0000000:20000000)
Built 1 zonelists.  Total pages: 1470489
Kernel command line: root=/dev/mapper/sys_vol-sys_root ro console=tty0  
xencons=ttyS16 console=ttyS16,19200 selinux=0 pciback.hide=(00:1d.1)  
idebus=66
ide_setup: idebus=66
Initializing CPU#0
PID hash table entries: 4096 (order: 12, 32768 bytes)
Xen reported: 2388.006 MHz processor.
start_kernel(): bug: interrupts were enabled early
Console: colour VGA+ 80x25
Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes)
Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes)
Software IO TLB enabled:
  Aperture:     64 megabytes
  Kernel range: ffff880008e11000 - ffff88000ce11000
  Address size: 27 bits
PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
Memory: 5748184k/5963488k available (2085k kernel code, 206224k  
reserved, 909k data, 180k init)
Calibrating delay using timer specific routine.. 4776.77 BogoMIPS  
(lpj=2388388)
Security Framework v1.0.0 initialized
Capability LSM initialized
Mount-cache hash table entries: 256
CPU: L1 I cache: 32K, L1 D cache: 32K
CPU: L2 cache: 4096K
CPU: Physical Processor ID: 0
CPU: Processor Core ID: 0
SMP alternatives: switching to UP code
ACPI: Core revision 20060707
SMP alternatives: switching to SMP code
Initializing CPU#1
Initializing CPU#2
CPU: L1 I cache: 32K, L1 D cache: 32K
CPU: L2 cache: 4096K
CPU: Physical Processor ID: 0
CPU: Processor Core ID: 1
Brought up 4 CPUs
Initializing CPU#3
CPU: L1 I cache: 32K, L1 D cache: 32K
CPU: L2 cache: 4096K
CPU: Physical Processor ID: 0
CPU: Processor Core ID: 3
CPU: L1 I cache: 32K, L1 D cache: 32K
CPU: L2 cache: 4096K
CPU: Physical Processor ID: 0
CPU: Processor Core ID: 2
migration_cost=3871
checking if image is initramfs... it is
Freeing initrd memory: 18462k freed
PM: Adding info for No Bus:platform
NET: Registered protocol family 16
PM: Adding info for No Bus:xen
PM: Adding info for No Bus:xen-backend
ACPI: bus type pci registered
PCI: Using configuration type 1
ACPI: Interpreter enabled
ACPI: Using IOAPIC for interrupt routing
PM: Adding info for acpi:acpi
ACPI: PCI Root Bridge [PCI0] (0000:00)
PCI: Probing PCI hardware (bus 00)
PM: Adding info for No Bus:pci0000:00
ACPI: Assume root bridge [_SB_.PCI0] bus is 0
Boot video device is 0000:00:02.0
PCI: Transparent bridge - 0000:00:1e.0
ACPI: PCI Interrupt Routing Table [_SB_.PCI0._PRT]
PM: Adding info for pci:0000:00:00.0
PM: Adding info for pci:0000:00:02.0
PM: Adding info for pci:0000:00:03.0
PM: Adding info for pci:0000:00:03.2
PM: Adding info for pci:0000:00:03.3
PM: Adding info for pci:0000:00:19.0
PM: Adding info for pci:0000:00:1a.0
PM: Adding info for pci:0000:00:1a.1
PM: Adding info for pci:0000:00:1a.2
PM: Adding info for pci:0000:00:1a.7
PM: Adding info for pci:0000:00:1b.0
PM: Adding info for pci:0000:00:1c.0
PM: Adding info for pci:0000:00:1c.1
PM: Adding info for pci:0000:00:1c.2
PM: Adding info for pci:0000:00:1c.3
PM: Adding info for pci:0000:00:1c.4
PM: Adding info for pci:0000:00:1d.0
PM: Adding info for pci:0000:00:1d.1
PM: Adding info for pci:0000:00:1d.2
PM: Adding info for pci:0000:00:1d.7
PM: Adding info for pci:0000:00:1e.0
PM: Adding info for pci:0000:00:1f.0
PM: Adding info for pci:0000:00:1f.2
PM: Adding info for pci:0000:00:1f.3
PM: Adding info for pci:0000:00:1f.5
PM: Adding info for pci:0000:03:00.0
PM: Adding info for pci:0000:06:00.0
ACPI: PCI Interrupt Routing Table [_SB_.PCI0.P32_._PRT]
ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 7 9 10 *11 12)
ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 7 9 *10 11 12)
ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 5 7 *9 10 11 12)
ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 7 9 10 *11 12)
ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 7 9 10 *11 12)
ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 7 *9 10 11 12)
ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 5 7 9 *10 11 12)
ACPI: PCI Interrupt Link [LNKH] (IRQs 3 4 5 7 9 10 *11 12)
ACPI: PCI Interrupt Routing Table [_SB_.PCI0.PEX0._PRT]
ACPI: PCI Interrupt Routing Table [_SB_.PCI0.PEX1._PRT]
ACPI: PCI Interrupt Routing Table [_SB_.PCI0.PEX2._PRT]
ACPI: PCI Interrupt Routing Table [_SB_.PCI0.PEX3._PRT]
ACPI: PCI Interrupt Routing Table [_SB_.PCI0.PEX4._PRT]
Linux Plug and Play Support v0.97 (c) Adam Belay
pnp: PnP ACPI init
PM: Adding info for No Bus:pnp0
pnp: ACPI device : hid PNP0A03
PM: Adding info for pnp:00:00
pnp: ACPI device : hid PNP0C02
PM: Adding info for pnp:00:01
pnp: ACPI device : hid PNP0200
PM: Adding info for pnp:00:02
pnp: ACPI device : hid PNP0B00
PM: Adding info for pnp:00:03
pnp: ACPI device : hid PNP0C04
PM: Adding info for pnp:00:04
pnp: ACPI device : hid PNP0800
PM: Adding info for pnp:00:05
pnp: ACPI device : hid PNP0C02
PM: Adding info for pnp:00:06
pnp: ACPI device : hid WEC1000
PM: Adding info for pnp:00:07
pnp: ACPI device : hid PNP0C02
PM: Adding info for pnp:00:08
pnp: ACPI device : hid PNP0501
PM: Adding info for pnp:00:09
pnp: ACPI device : hid PNP0003
PM: Adding info for pnp:00:0a
pnp: PnP ACPI: found 11 devices
xen_mem: Initialising balloon driver.
PCI: Using ACPI for IRQ routing
PCI: If a device doesn''t work, try "pci=routeirq".  If it
helps, post a report
pnp: the driver ''system'' has been registered
pnp: match found with the PnP device ''00:01'' and the driver
''system''
pnp: match found with the PnP device ''00:06'' and the driver
''system''
pnp: 00:06: ioport range 0x500-0x53f has been reserved
pnp: 00:06: ioport range 0x400-0x47f could not be reserved
pnp: 00:06: ioport range 0x680-0x6ff has been reserved
pnp: match found with the PnP device ''00:08'' and the driver
''system''
pciback 0000:00:1d.1: seizing device
PCI: Ignore bogus resource 6 [0:0] of 0000:00:02.0
PCI: Bridge: 0000:00:1c.0
   IO window: disabled.
   MEM window: disabled.
   PREFETCH window: disabled.
PCI: Bridge: 0000:00:1c.1
   IO window: disabled.
   MEM window: disabled.
   PREFETCH window: disabled.
PCI: Bridge: 0000:00:1c.2
   IO window: 2000-2fff
   MEM window: e0100000-e01fffff
   PREFETCH window: disabled.
PCI: Bridge: 0000:00:1c.3
   IO window: disabled.
   MEM window: disabled.
   PREFETCH window: disabled.
PCI: Bridge: 0000:00:1c.4
   IO window: disabled.
   MEM window: disabled.
   PREFETCH window: disabled.
PCI: Bridge: 0000:00:1e.0
   IO window: 1000-1fff
   MEM window: e0000000-e00fffff
   PREFETCH window: e0400000-e04fffff
GSI 16 sharing vector 0xC0 and IRQ 16
ACPI: PCI Interrupt 0000:00:1c.0[A] -> GSI 17 (level, low) -> IRQ 16
PCI: Setting latency timer of device 0000:00:1c.0 to 64
GSI 17 sharing vector 0xC8 and IRQ 17
ACPI: PCI Interrupt 0000:00:1c.1[B] -> GSI 20 (level, low) -> IRQ 17
PCI: Setting latency timer of device 0000:00:1c.1 to 64
GSI 18 sharing vector 0xD0 and IRQ 18
ACPI: PCI Interrupt 0000:00:1c.2[C] -> GSI 18 (level, low) -> IRQ 18
PCI: Setting latency timer of device 0000:00:1c.2 to 64
GSI 19 sharing vector 0xD8 and IRQ 19
ACPI: PCI Interrupt 0000:00:1c.3[D] -> GSI 19 (level, low) -> IRQ 19
PCI: Setting latency timer of device 0000:00:1c.3 to 64
ACPI: PCI Interrupt 0000:00:1c.4[A] -> GSI 17 (level, low) -> IRQ 16
PCI: Setting latency timer of device 0000:00:1c.4 to 64
PCI: Setting latency timer of device 0000:00:1e.0 to 64
NET: Registered protocol family 2
IP route cache hash table entries: 262144 (order: 9, 2097152 bytes)
TCP established hash table entries: 262144 (order: 10, 4194304 bytes)
TCP bind hash table entries: 65536 (order: 8, 1048576 bytes)
TCP: Hash tables configured (established 262144 bind 65536)
TCP reno registered
PM: Adding info for platform:pcspkr
IA-32 Microcode Update Driver: v1.14a-xen <tigran@veritas.com>
audit: initializing netlink socket (disabled)
audit(1233229473.844:1): initialized
VFS: Disk quotas dquot_6.5.1
Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
Initializing Cryptographic API
io scheduler noop registered
io scheduler anticipatory registered
io scheduler deadline registered
io scheduler cfq registered (default)
PM: Adding info for platform:vesafb.0
Real Time Clock Driver v1.12ac
Non-volatile memory driver v1.2
Serial: 8250/16550 driver $Revision: 1.90 $ 4 ports, IRQ sharing enabled
PM: Adding info for platform:serial8250
serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
pnp: the driver ''serial'' has been registered
pnp: match found with the PnP device ''00:09'' and the driver
''serial''
00:09: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
ACPI: PCI Interrupt 0000:00:03.3[B] -> GSI 17 (level, low) -> IRQ 16
0000:00:03.3: ttyS1 at I/O 0x3470 (irq = 16) is a 16550A
RAMDISK driver initialized: 16 RAM disks of 16384K size 1024 blocksize
loop: loaded (max 8 devices)
Xen virtual console successfully installed as ttyS16
Event-channel device installed.
netfront: Initialising virtual ethernet driver.
ACPI: PCI Interrupt 0000:00:1d.1[B] -> GSI 19 (level, low) -> IRQ 19
ACPI: PCI interrupt for device 0000:00:1d.1 disabled
Uniform Multi-Platform E-IDE driver Revision: 7.00alpha2
ide: Assuming 66MHz system bus speed for PIO modes
pnp: the driver ''ide'' has been registered
pnp: the driver ''i8042 kbd'' has been registered
pnp: the driver ''i8042 aux'' has been registered
pnp: the driver ''i8042 kbd'' has been unregistered
pnp: the driver ''i8042 aux'' has been unregistered
PNP: No PS/2 controller found. Probing ports directly.
PM: Adding info for platform:i8042
serio: i8042 AUX port at 0x60,0x64 irq 12
serio: i8042 KBD port at 0x60,0x64 irq 1
PM: Adding info for serio:serio0
PM: Adding info for serio:serio1
mice: PS/2 mouse device common for all mice
md: md driver 0.90.3 MAX_MD_DEVS=256, MD_SB_DISKS=27
md: bitmap version 4.39
device-mapper: ioctl: 4.7.0-ioctl (2006-06-24) initialised:  
dm-devel@redhat.com
NET: Registered protocol family 1
NET: Registered protocol family 17
ACPI: (supports S0 S1 S3 S4 S5)
BIOS EDD facility v0.16 2004-Jun-25, 2 devices found
Freeing unused kernel memory: 180k freed
fuse init (API version 7.7)
ACPI: Processor [CPU0] (supports 8 throttling states)
ACPI: Processor [CPU1] (supports 8 throttling states)
ACPI: Processor [CPU2] (supports 8 throttling states)
ACPI: Processor [CPU3] (supports 8 throttling states)
usbcore: registered new driver usbfs
usbcore: registered new driver hub
SCSI subsystem initialized
PDC20269: IDE controller at PCI slot 0000:06:00.0
GSI 20 sharing vector 0x21 and IRQ 20
ACPI: PCI Interrupt 0000:06:00.0[A] -> GSI 21 (level, low) -> IRQ 20
PDC20269: chipset revision 2
PDC20269: ROM enabled at 0xe0400000
PDC20269: 100% native mode on irq 20
     ide0: BM-DMA at 0x1000-0x1007, BIOS settings: hda:pio, hdb:pio
     ide1: BM-DMA at 0x1008-0x100f, BIOS settings: hdc:pio, hdd:pio
Probing IDE interface ide0...
USB Universal Host Controller Interface driver v3.0
ACPI: PCI Interrupt 0000:00:1a.0[A] -> <7>libata version 2.00 loaded.
GSI 18 (level, low) -> IRQ 18
PCI: Setting latency timer of device 0000:00:1a.0 to 64
uhci_hcd 0000:00:1a.0: UHCI Host Controller
uhci_hcd 0000:00:1a.0: new USB bus registered, assigned bus number 1
uhci_hcd 0000:00:1a.0: irq 18, io base 0x000030c0
PM: Adding info for usb:usb1
PM: Adding info for No Bus:usbdev1.1_ep00
usb usb1: configuration #1 chosen from 1 choice
PM: Adding info for usb:1-0:1.0
hub 1-0:1.0: USB hub found
hub 1-0:1.0: 2 ports detected
PM: Adding info for No Bus:usbdev1.1_ep81
ACPI: PCI Interrupt 0000:00:1a.1[B] -> hda: SAMSUNG HD300LD, ATA DISK drive
PM: Adding info for No Bus:ide0
usb 1-1: new low speed USB device using uhci_hcd and address 2
PM: Adding info for usb:1-1
PM: Adding info for No Bus:usbdev1.2_ep00
usb 1-1: configuration #1 chosen from 1 choice
PM: Adding info for usb:1-1:1.0
PM: Adding info for No Bus:usbdev1.2_ep81
PM: Adding info for usb:1-1:1.1
PM: Adding info for No Bus:usbdev1.2_ep82
ide0 at 0x1018-0x101f,0x1026 on irq 20
PM: Adding info for ide:0.0
Probing IDE interface ide1...
GSI 21 (level, low) -> IRQ 20
PCI: Setting latency timer of device 0000:00:1a.1 to 64
uhci_hcd 0000:00:1a.1: UHCI Host Controller
uhci_hcd 0000:00:1a.1: new USB bus registered, assigned bus number 2
uhci_hcd 0000:00:1a.1: irq 20, io base 0x000030a0
PM: Adding info for usb:usb2
PM: Adding info for No Bus:usbdev2.1_ep00
usb usb2: configuration #1 chosen from 1 choice
PM: Adding info for usb:2-0:1.0
hub 2-0:1.0: USB hub found
hub 2-0:1.0: 2 ports detected
hda: max request size: 512KiB
PM: Adding info for No Bus:usbdev2.1_ep81
ACPI: PCI Interrupt 0000:00:1a.2[C] -> GSI 17 (level, low) -> IRQ 16
PCI: Setting latency timer of device 0000:00:1a.2 to 64
uhci_hcd 0000:00:1a.2: UHCI Host Controller
uhci_hcd 0000:00:1a.2: new USB bus registered, assigned bus number 3
uhci_hcd 0000:00:1a.2: irq 16, io base 0x00003080
PM: Adding info for usb:usb3
PM: Adding info for No Bus:usbdev3.1_ep00
usb usb3: configuration #1 chosen from 1 choice
PM: Adding info for usb:3-0:1.0
hub 3-0:1.0: USB hub found
hub 3-0:1.0: 2 ports detected
PM: Adding info for No Bus:usbdev3.1_ep81
GSI 21 sharing vector 0x29 and IRQ 21
ACPI: PCI Interrupt 0000:00:1d.0[A] -> GSI 23 (level, low) -> IRQ 21
PCI: Setting latency timer of device 0000:00:1d.0 to 64
uhci_hcd 0000:00:1d.0: UHCI Host Controller
uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 4
uhci_hcd 0000:00:1d.0: irq 21, io base 0x00003060
PM: Adding info for usb:usb4
PM: Adding info for No Bus:usbdev4.1_ep00
usb usb4: configuration #1 chosen from 1 choice
PM: Adding info for usb:4-0:1.0
hub 4-0:1.0: USB hub found
hub 4-0:1.0: 2 ports detected
PM: Adding info for No Bus:usbdev4.1_ep81
ACPI: PCI Interrupt 0000:00:1d.2[C] -> GSI 18 (level, low) -> IRQ 18
PCI: Setting latency timer of device 0000:00:1d.2 to 64
uhci_hcd 0000:00:1d.2: UHCI Host Controller
uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 5
uhci_hcd 0000:00:1d.2: irq 18, io base 0x00003020
PM: Adding info for usb:usb5
PM: Adding info for No Bus:usbdev5.1_ep00
usb usb5: configuration #1 chosen from 1 choice
PM: Adding info for usb:5-0:1.0
hub 5-0:1.0: USB hub found
hub 5-0:1.0: 2 ports detected
PM: Adding info for No Bus:usbdev5.1_ep81
ACPI: PCI Interrupt 0000:00:1a.7[C] -> GSI 17 (level, low) -> IRQ 16
PCI: Setting latency timer of device 0000:00:1a.7 to 64
ehci_hcd 0000:00:1a.7: EHCI Host Controller
ehci_hcd 0000:00:1a.7: new USB bus registered, assigned bus number 6
ehci_hcd 0000:00:1a.7: debug port 1
PCI: cache line size of 32 is not supported by device 0000:00:1a.7
ehci_hcd 0000:00:1a.7: irq 16, io mem 0xe03a6400
ehci_hcd 0000:00:1a.7: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004
PM: Adding info for usb:usb6
PM: Adding info for No Bus:usbdev6.1_ep00
usb usb6: configuration #1 chosen from 1 choice
PM: Adding info for usb:6-0:1.0
hub 6-0:1.0: USB hub found
hub 6-0:1.0: 6 ports detected
usb 1-1: USB disconnect, address 2
PM: Adding info for No Bus:usbdev6.1_ep81
ACPI: PCI Interrupt 0000:00:1d.7[A] -> GSI 23 (level, low) -> IRQ 21
PCI: Setting latency timer of device 0000:00:1d.7 to 64
ehci_hcd 0000:00:1d.7: EHCI Host Controller
ehci_hcd 0000:00:1d.7: new USB bus registered, assigned bus number 7
ehci_hcd 0000:00:1d.7: debug port 1
PCI: cache line size of 32 is not supported by device 0000:00:1d.7
ehci_hcd 0000:00:1d.7: irq 21, io mem 0xe03a6000
ehci_hcd 0000:00:1d.7: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004
PM: Adding info for usb:usb7
PM: Adding info for No Bus:usbdev7.1_ep00
usb usb7: configuration #1 chosen from 1 choice
PM: Adding info for usb:7-0:1.0
hub 7-0:1.0: USB hub found
hub 7-0:1.0: 6 ports detected
hda: 586072368 sectors (300069 MB) w/8192KiB Cache, CHS=36481/255/63,  
UDMA(100)
hda: cache flushes supported
  hda: hda1
PM: Adding info for No Bus:usbdev7.1_ep81
ata_piix 0000:00:1f.2: version 2.00
ata_piix 0000:00:1f.2: MAP [ P0 P2 P1 P3 ]
ACPI: PCI Interrupt 0000:00:1f.2[A] -> GSI 21 (level, low) -> IRQ 20
PCI: Setting latency timer of device 0000:00:1f.2 to 64
BUG: soft lockup detected on CPU#0!

Call Trace:
  <IRQ> [<ffffffff80257898>] softlockup_tick+0xd5/0xe7
  [<ffffffff8020f03f>] timer_interrupt+0x3db/0x439
  [<ffffffff80257b83>] handle_IRQ_event+0x4d/0x95
  [<ffffffff80257c6f>] __do_IRQ+0xa4/0x105
  [<ffffffff8020cda7>] do_IRQ+0x44/0x4d
  [<ffffffff80352737>] evtchn_do_upcall+0x189/0x236
  [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
  [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
  [<ffffffff8020adce>] do_hypervisor_callback+0x1e/0x2c
  <EOI> [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
  [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
  [<ffffffff80213ade>] __smp_call_function+0x68/0x89
  [<ffffffff80213ad6>] __smp_call_function+0x60/0x89
  [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
  [<ffffffff80213d39>] smp_call_function+0x32/0x49
  [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
  [<ffffffff80233356>] on_each_cpu+0xf/0x5d
  [<ffffffff802804ba>] invalidate_bdev+0x2b/0x36
  [<ffffffff80284f4e>] kill_bdev+0xe/0x21
  [<ffffffff80285507>] __blkdev_put+0x4c/0x159
  [<ffffffff802b9f31>] register_disk+0x146/0x199
  [<ffffffff802dfcb1>] add_disk+0x34/0x3d
  [<ffffffff880be9e7>] :ide_disk:ide_disk_probe+0x77b/0x7a8
  [<ffffffff8034b950>] driver_probe_device+0x52/0xa2
  [<ffffffff8034b9ff>] __driver_attach+0x0/0x8f
  [<ffffffff8034ba57>] __driver_attach+0x58/0x8f
  [<ffffffff8034b9ff>] __driver_attach+0x0/0x8f
  [<ffffffff8034b374>] bus_for_each_dev+0x43/0x6e
  [<ffffffff8034afdc>] bus_add_driver+0x73/0x122
  [<ffffffff8024b13d>] sys_init_module+0x1720/0x184f
  [<ffffffff8020a5e4>] system_call+0x68/0x6d
  [<ffffffff8020a57c>] system_call+0x0/0x6d

PM: Removing info for No Bus:usbdev1.2_ep81
PM: Removing info for usb:1-1:1.0
PM: Removing info for No Bus:usbdev1.2_ep82
PM: Removing info for usb:1-1:1.1
PM: Removing info for No Bus:usbdev1.2_ep00
PM: Removing info for usb:1-1
ata1: SATA max UDMA/133 cmd 0x3468 ctl 0x349E bmdma 0x3430 irq 20
usbcore: registered new driver hiddev
usb 7-2: new high speed USB device using ehci_hcd and address 2
PM: Adding info for usb:7-2
PM: Adding info for No Bus:usbdev7.2_ep00
usb 7-2: configuration #1 chosen from 1 choice
PM: Adding info for usb:7-2:1.0
PM: Adding info for No Bus:usbdev7.2_ep01
PM: Adding info for No Bus:usbdev7.2_ep82
usbcore: registered new driver usbhid
/opt/install/xen/xen-3.3.1/linux-2.6.18-xen.hg/drivers/usb/input/hid-core.c:  
v2.6:USB HID core driver
usb 1-1: new low speed USB device using uhci_hcd and address 3
PM: Adding info for usb:1-1
PM: Adding info for No Bus:usbdev1.3_ep00
usb 1-1: configuration #1 chosen from 1 choice
PM: Adding info for usb:1-1:1.0
input: Plus More Enterprise LTD. USB-compliant keyboard as /class/input/input0
input: USB HID v1.10 Keyboard [Plus More Enterprise LTD. USB-compliant  
keyboard] on usb-0000:00:1a.0-1
PM: Adding info for No Bus:usbdev1.3_ep81
PM: Adding info for usb:1-1:1.1
input: Plus More Enterprise LTD. USB-compliant keyboard as /class/input/input1
input: USB HID v1.10 Mouse [Plus More Enterprise LTD. USB-compliant  
keyboard] on usb-0000:00:1a.0-1
PM: Adding info for No Bus:usbdev1.3_ep82
BUG: soft lockup detected on CPU#0!

Call Trace:
  <IRQ> [<ffffffff80257898>] softlockup_tick+0xd5/0xe7
  [<ffffffff8020f03f>] timer_interrupt+0x3db/0x439
  [<ffffffff80257b83>] handle_IRQ_event+0x4d/0x95
  [<ffffffff80257c6f>] __do_IRQ+0xa4/0x105
  [<ffffffff8020cda7>] do_IRQ+0x44/0x4d
  [<ffffffff80352737>] evtchn_do_upcall+0x189/0x236
  [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
  [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
  [<ffffffff8020adce>] do_hypervisor_callback+0x1e/0x2c
  <EOI> [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
  [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
  [<ffffffff80213ada>] __smp_call_function+0x64/0x89
  [<ffffffff80213ad6>] __smp_call_function+0x60/0x89
  [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
  [<ffffffff80213d39>] smp_call_function+0x32/0x49
  [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
  [<ffffffff80233356>] on_each_cpu+0xf/0x5d
  [<ffffffff802804ba>] invalidate_bdev+0x2b/0x36
  [<ffffffff80284f4e>] kill_bdev+0xe/0x21
  [<ffffffff80285507>] __blkdev_put+0x4c/0x159
  [<ffffffff8027f002>] __fput+0x9e/0x16e
  [<ffffffff8027c7ac>] filp_close+0x5c/0x64
  [<ffffffff8022fec6>] put_files_struct+0x6c/0xc3
  [<ffffffff80231224>] do_exit+0x29b/0x921
  [<ffffffff802ea213>] __up_write+0x1d/0x112
  [<ffffffff80231988>] sys_exit_group+0x0/0xe
  [<ffffffff8020a5e4>] system_call+0x68/0x6d
  [<ffffffff8020a57c>] system_call+0x0/0x6d

ata2: SATA max UDMA/133 cmd 0x3460 ctl 0x349A bmdma 0x3438 irq 20
scsi0 : ata_piix
PM: Adding info for No Bus:host0
Initializing USB Mass Storage driver...
scsi2 : SCSI emulation for USB Mass Storage devices
ATA: abnormal status 0x7F on port 0x346F
scsi1 : ata_piix
PM: Adding info for No Bus:host1
ATA: abnormal status 0x7F on port 0x3467
ATA: abnormal status 0x7F on port 0x3467
ata2.01: ATA-7, max UDMA/133, 488397168 sectors: LBA48 NCQ (depth 0/32)
ata2.01: ata2: dev 1 multi count 16
ata2.01: configured for UDMA/133
PM: Adding info for No Bus:target1:0:1
   Vendor: ATA       Model: MAXTOR STM325031  Rev: 3.AA
   Type:   Direct-Access                      ANSI SCSI revision: 05
PM: Adding info for scsi:1:0:1:0
ata_piix 0000:00:1f.5: MAP [ P0 P2 P1 P3 ]
ACPI: PCI Interrupt 0000:00:1f.5[A] -> GSI 21 (level, low) -> IRQ 20
PCI: Setting latency timer of device 0000:00:1f.5 to 64
ata3: SATA max UDMA/133 cmd 0x3458 ctl 0x3496 bmdma 0x3410 irq 20
ata4: SATA max UDMA/133 cmd 0x3450 ctl 0x3492 bmdma 0x3418 irq 20
scsi3 : ata_piix
PM: Adding info for No Bus:host3
ATA: abnormal status 0x7F on port 0x345F
scsi4 : ata_piix
PM: Adding info for No Bus:host4
ATA: abnormal status 0x7F on port 0x3457
BUG: soft lockup detected on CPU#0!

Call Trace:
  <IRQ> [<ffffffff80257898>] softlockup_tick+0xd5/0xe7
  [<ffffffff8020f03f>] timer_interrupt+0x3db/0x439
  [<ffffffff80257b83>] handle_IRQ_event+0x4d/0x95
  [<ffffffff80257c6f>] __do_IRQ+0xa4/0x105
  [<ffffffff8020cda7>] do_IRQ+0x44/0x4d
  [<ffffffff80352737>] evtchn_do_upcall+0x189/0x236
  [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
  [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
  [<ffffffff8020adce>] do_hypervisor_callback+0x1e/0x2c
  <EOI> [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
  [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
  [<ffffffff80213ada>] __smp_call_function+0x64/0x89
  [<ffffffff80213ad6>] __smp_call_function+0x60/0x89
  [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
  [<ffffffff80213d39>] smp_call_function+0x32/0x49
  [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
  [<ffffffff80233356>] on_each_cpu+0xf/0x5d
  [<ffffffff802804ba>] invalidate_bdev+0x2b/0x36
  [<ffffffff80284f4e>] kill_bdev+0xe/0x21
  [<ffffffff80285507>] __blkdev_put+0x4c/0x159
  [<ffffffff8027f002>] __fput+0x9e/0x16e
  [<ffffffff8027c7ac>] filp_close+0x5c/0x64
  [<ffffffff8022fec6>] put_files_struct+0x6c/0xc3
  [<ffffffff80231224>] do_exit+0x29b/0x921
  [<ffffffff8027e7ec>] vfs_write+0x13f/0x174
  [<ffffffff80231988>] sys_exit_group+0x0/0xe
  [<ffffffff8020a5e4>] system_call+0x68/0x6d
  [<ffffffff8020a57c>] system_call+0x0/0x6d

PM: Adding info for No Bus:host2
usbcore: registered new driver usb-storage
usb-storage: device found at 2
usb-storage: waiting for device to settle before scanning
USB Mass Storage support registered.
SCSI device sda: 488397168 512-byte hdwr sectors (250059 MB)
sda: Write Protect is off
sda: Mode Sense: 00 3a 00 00
SCSI device sda: drive cache: write back
PM: Adding info for No Bus:target2:0:0
   Vendor: Generic   Model: USB SD Reader     Rev: 1.00
   Type:   Direct-Access                      ANSI SCSI revision: 00
PM: Adding info for scsi:2:0:0:0
PM: Adding info for No Bus:target2:0:1
PM: Removing info for No Bus:target2:0:1
PM: Adding info for No Bus:target2:0:2
PM: Removing info for No Bus:target2:0:2
PM: Adding info for No Bus:target2:0:3
PM: Removing info for No Bus:target2:0:3
PM: Adding info for No Bus:target2:0:4
PM: Removing info for No Bus:target2:0:4
PM: Adding info for No Bus:target2:0:5
PM: Removing info for No Bus:target2:0:5
PM: Adding info for No Bus:target2:0:6
PM: Removing info for No Bus:target2:0:6
PM: Adding info for No Bus:target2:0:7
PM: Removing info for No Bus:target2:0:7
usb-storage: device scan complete
SCSI device sda: 488397168 512-byte hdwr sectors (250059 MB)
sda: Write Protect is off
sda: Mode Sense: 00 3a 00 00
SCSI device sda: drive cache: write back
  sda: sda1 sda2 sda3
sd 1:0:1:0: Attached scsi disk sda
sd 2:0:0:0: Attached scsi removable disk sdb
sd 1:0:1:0: Attached scsi generic sg0 type 0
sd 2:0:0:0: Attached scsi generic sg1 type 0
kjournald starting.  Commit interval 5 seconds
EXT3-fs: mounted filesystem with ordered data mode.
input: PC Speaker as /class/input/input2
device-mapper: multipath: version 1.0.4 loaded
e1000e: Intel(R) PRO/1000 Network Driver - 0.4.1.12-NAPI
e1000e: Copyright (c) 1999-2008 Intel Corporation.
ACPI: PCI Interrupt 0000:00:19.0[A] -> GSI 20 (level, low) -> IRQ 17
PCI: Setting latency timer of device 0000:00:19.0 to 64
0000:00:19.0: : Failed to initialize MSI interrupts.  Falling back to  
legacy interrupts.
0000:00:19.0: eth0: (PCI Express:2.5GB/s:Width x1) 00:1c:c0:41:0e:2c
0000:00:19.0: eth0: Intel(R) PRO/1000 Network Connection
0000:00:19.0: eth0: MAC: 7, PHY: 6, PBA No: ffffff-0ff
GSI 22 sharing vector 0x31 and IRQ 22
ACPI: PCI Interrupt 0000:00:1b.0[A] -> GSI 22 (level, low) -> IRQ 22
PCI: Setting latency timer of device 0000:00:1b.0 to 64
pnp: the driver ''parport_pc'' has been registered
lp: driver loaded but no devices found
Adding 2097144k swap on /dev/mapper/sys_vol-sys_swap.  Priority:-1  
extents:1 across:2097144k
EXT3 FS on dm-17, internal journal
kjournald starting.  Commit interval 5 seconds
EXT3 FS on sda1, internal journal
EXT3-fs: mounted filesystem with ordered data mode.
kjournald starting.  Commit interval 5 seconds
EXT3 FS on dm-19, internal journal
EXT3-fs: mounted filesystem with ordered data mode.
kjournald starting.  Commit interval 5 seconds
EXT3 FS on dm-20, internal journal
EXT3-fs: mounted filesystem with ordered data mode.
Bridge firewalling registered
device eth0 entered promiscuous mode
audit(1233229874.464:2): dev=eth0 prom=256 old_prom=0 auid=4294967295
0000:00:19.0: eth0: Link is Up 100 Mbps Full Duplex, Flow Control: RX/TX
0000:00:19.0: eth0: 10/100 speed: disabling TSO
br0: port 1(eth0) entering learning state
br0: topology change detected, propagating
br0: port 1(eth0) entering forwarding state
NET: Registered protocol family 10
lo: Disabled Privacy Extensions
IPv6 over IPv4 tunneling driver
suspend: event channel 26
PM: Adding info for xen-backend:vfb-1-0
PM: Adding info for xen-backend:vbd-1-768
PM: Adding info for xen-backend:vif-1-0
pciback 0000:00:1d.1: enabling permissive mode configuration space accesses!
pciback 0000:00:1d.1: permissive mode is potentially unsafe!
PM: Adding info for xen-backend:pci-1-0
device vif1.0 entered promiscuous mode
audit(1233229901.660:3): dev=vif1.0 prom=256 old_prom=0 auid=4294967295
br0: port 2(vif1.0) entering learning state
ip_tables: (C) 2000-2006 Netfilter Core Team
tun: Universal TUN/TAP device driver, 1.6
tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com>
device tap1.0 entered promiscuous mode
audit(1233229902.193:4): dev=tap1.0 prom=256 old_prom=0 auid=4294967295
br0: port 3(tap1.0) entering learning state
eth0: no IPv6 routers present
PM: Adding info for xen-backend:console-1-0
PM: Adding info for xen-backend:vbd-2-51712
PM: Adding info for xen-backend:vbd-2-51715
PM: Adding info for xen-backend:vif-2-0
PM: Adding info for xen-backend:console-2-0
device vif2.0 entered promiscuous mode
audit(1233229908.988:5): dev=vif2.0 prom=256 old_prom=0 auid=4294967295
br0: port 4(vif2.0) entering learning state
PM: Removing info for xen-backend:console-2-0
PM: Removing info for xen-backend:vbd-2-51712
PM: Removing info for xen-backend:vbd-2-51715
br0: port 4(vif2.0) entering disabled state
device vif2.0 left promiscuous mode
audit(1233229909.419:6): dev=vif2.0 prom=0 old_prom=256 auid=4294967295
br0: port 4(vif2.0) entering disabled state
PM: Removing info for xen-backend:vif-2-0
vif1.0: no IPv6 routers present
tap1.0: no IPv6 routers present
br0: topology change detected, propagating
br0: port 2(vif1.0) entering forwarding state
br0: topology change detected, propagating
br0: port 3(tap1.0) entering forwarding state
PM: Adding info for xen-backend:vbd-3-51712
PM: Adding info for xen-backend:vbd-3-51715
PM: Adding info for xen-backend:vif-3-0
PM: Adding info for xen-backend:console-3-0
device vif3.0 entered promiscuous mode
audit(1233230236.962:7): dev=vif3.0 prom=256 old_prom=0 auid=4294967295
br0: port 4(vif3.0) entering learning state
blkback: ring-ref 2047, event-channel 4, protocol 1 (x86_64-abi)
blkback: ring-ref 2046, event-channel 5, protocol 1 (x86_64-abi)
frontend_changed: backend/vbd/3/51712: prepare for reconnect
frontend_changed: backend/vbd/3/51715: prepare for reconnect
blkback: ring-ref 8, event-channel 15, protocol 1 (x86_64-abi)
blkback: ring-ref 9, event-channel 16, protocol 1 (x86_64-abi)
vif3.0: no IPv6 routers present
br0: topology change detected, propagating
br0: port 4(vif3.0) entering forwarding state
root@dom0:~#

It takes about 10 minutes for booting, other (newer) kernels such as  
2.6.24-xen from ubuntu do not have this behavior.

My Mainboard is a Intel vPro DQ35MP with QuadCore Q6600.

Can anybody help me? I do not find the reason for this problem.
A memtest86+ did not show errors and I even replaced the RAM with  
another, more expensive...:-(

Thank you and best regards


Ralf



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

Ralf Hornik Mailings

2009-Jan-30 09:47 UTC

head link

Re: [Xen-users] After memory upgrade - slow boot and "ERROR: Invalid checksum?"

No ideas?

No hints, suggestions, help?
TBH, this only (and many other hardware issues) happens with 2.6.18  
kernel from xen. Any other (newer) kernel doesn''t have such problems.

Is the 2.6.18 kernel simply to old for new hardware?? Do I really need  
to use a patched kernel from my distribution?

Or, is there a newer kernel from xen under development, which I could try?

Ralf

Ralf Hornik Mailings <ralf@best.homeunix.org> schreibte:
> Hi list,
>
> since my memory upgrade from 2G to 6G RAM, the xen 2.6.18.8 kernel  
> from xen 3.3.1 does boot very slow and with call traces (see dmesg  
> output below).
>
> root@dom0:~# dmesg
> 0x000003a5 MSFT 0x01000013) @ 0x00000000ceff4000
> ACPI:  (v001 INTEL  DQ3510J  0x000003a5 MSFT 0x01000013) @
0x00000000ceff2000
>  >>> ERROR: Invalid checksum
> ACPI: ASPT (v001 INTEL  DQ3510J  0x000003a5 MSFT 0x01000013) @  
> 0x00000000ceff1000
> ACPI: WDTT (v001 INTEL  DQ3510J  0x000003a5 MSFT 0x01000013) @  
> 0x00000000ceff0000
> ACPI: SSDT (v001 INTEL     CpuPm 0x000003a5 MSFT 0x01000013) @  
> 0x00000000cefef000
> ACPI: SSDT (v001 INTEL   Cpu0Ist 0x000003a5 MSFT 0x01000013) @  
> 0x00000000cefee000
> ACPI: SSDT (v001 INTEL   Cpu1Ist 0x000003a5 MSFT 0x01000013) @  
> 0x00000000cefed000
> ACPI: SSDT (v001 INTEL   Cpu2Ist 0x000003a5 MSFT 0x01000013) @  
> 0x00000000cefec000
> ACPI: SSDT (v001 INTEL   Cpu3Ist 0x000003a5 MSFT 0x01000013) @  
> 0x00000000cefeb000
> ACPI: SSDT (v001 INTEL   Cpu0Cst 0x000003a5 MSFT 0x01000013) @  
> 0x00000000cefea000
> ACPI: SSDT (v001 INTEL   Cpu1Cst 0x000003a5 MSFT 0x01000013) @  
> 0x00000000cefe9000
> ACPI: SSDT (v001 INTEL   Cpu2Cst 0x000003a5 MSFT 0x01000013) @  
> 0x00000000cefe8000
> ACPI: SSDT (v001 INTEL   Cpu3Cst 0x000003a5 MSFT 0x01000013) @  
> 0x00000000cefe7000
> ACPI: TCPA (v002 INTEL  TIANO    0x00000002 MSFT 0x01000013) @  
> 0x00000000cef7b000
> ACPI: DSDT (v001 INTEL  DQ3510J  0x000003a5 MSFT 0x01000013) @  
> 0x0000000000000000
> ACPI: Local APIC address 0xfee00000
> ACPI: LAPIC (acpi_id[0x01] lapic_id[0x00] enabled)
> ACPI: LAPIC (acpi_id[0x03] lapic_id[0x02] enabled)
> ACPI: LAPIC (acpi_id[0x02] lapic_id[0x01] enabled)
> ACPI: LAPIC (acpi_id[0x04] lapic_id[0x03] enabled)
> ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1])
> ACPI: LAPIC_NMI (acpi_id[0x02] dfl dfl lint[0x1])
> ACPI: IOAPIC (id[0x02] address[0xfec00000] gsi_base[0])
> IOAPIC[0]: apic_id 2, version 32, address 0xfec00000, GSI 0-23
> ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
> ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
> ACPI: IRQ0 used by override.
> ACPI: IRQ2 used by override.
> ACPI: IRQ9 used by override.
> Setting APIC routing to xen
> Using ACPI (MADT) for SMP configuration information
> Allocating PCI resources starting at d2000000 (gap: d0000000:20000000)
> Built 1 zonelists.  Total pages: 1470489
> Kernel command line: root=/dev/mapper/sys_vol-sys_root ro  
> console=tty0 xencons=ttyS16 console=ttyS16,19200 selinux=0  
> pciback.hide=(00:1d.1) idebus=66
> ide_setup: idebus=66
> Initializing CPU#0
> PID hash table entries: 4096 (order: 12, 32768 bytes)
> Xen reported: 2388.006 MHz processor.
> start_kernel(): bug: interrupts were enabled early
> Console: colour VGA+ 80x25
> Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes)
> Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes)
> Software IO TLB enabled:
> Aperture:     64 megabytes
> Kernel range: ffff880008e11000 - ffff88000ce11000
> Address size: 27 bits
> PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
> Memory: 5748184k/5963488k available (2085k kernel code, 206224k  
> reserved, 909k data, 180k init)
> Calibrating delay using timer specific routine.. 4776.77 BogoMIPS  
> (lpj=2388388)
> Security Framework v1.0.0 initialized
> Capability LSM initialized
> Mount-cache hash table entries: 256
> CPU: L1 I cache: 32K, L1 D cache: 32K
> CPU: L2 cache: 4096K
> CPU: Physical Processor ID: 0
> CPU: Processor Core ID: 0
> SMP alternatives: switching to UP code
> ACPI: Core revision 20060707
> SMP alternatives: switching to SMP code
> Initializing CPU#1
> Initializing CPU#2
> CPU: L1 I cache: 32K, L1 D cache: 32K
> CPU: L2 cache: 4096K
> CPU: Physical Processor ID: 0
> CPU: Processor Core ID: 1
> Brought up 4 CPUs
> Initializing CPU#3
> CPU: L1 I cache: 32K, L1 D cache: 32K
> CPU: L2 cache: 4096K
> CPU: Physical Processor ID: 0
> CPU: Processor Core ID: 3
> CPU: L1 I cache: 32K, L1 D cache: 32K
> CPU: L2 cache: 4096K
> CPU: Physical Processor ID: 0
> CPU: Processor Core ID: 2
> migration_cost=3871
> checking if image is initramfs... it is
> Freeing initrd memory: 18462k freed
> PM: Adding info for No Bus:platform
> NET: Registered protocol family 16
> PM: Adding info for No Bus:xen
> PM: Adding info for No Bus:xen-backend
> ACPI: bus type pci registered
> PCI: Using configuration type 1
> ACPI: Interpreter enabled
> ACPI: Using IOAPIC for interrupt routing
> PM: Adding info for acpi:acpi
> ACPI: PCI Root Bridge [PCI0] (0000:00)
> PCI: Probing PCI hardware (bus 00)
> PM: Adding info for No Bus:pci0000:00
> ACPI: Assume root bridge [_SB_.PCI0] bus is 0
> Boot video device is 0000:00:02.0
> PCI: Transparent bridge - 0000:00:1e.0
> ACPI: PCI Interrupt Routing Table [_SB_.PCI0._PRT]
> PM: Adding info for pci:0000:00:00.0
> PM: Adding info for pci:0000:00:02.0
> PM: Adding info for pci:0000:00:03.0
> PM: Adding info for pci:0000:00:03.2
> PM: Adding info for pci:0000:00:03.3
> PM: Adding info for pci:0000:00:19.0
> PM: Adding info for pci:0000:00:1a.0
> PM: Adding info for pci:0000:00:1a.1
> PM: Adding info for pci:0000:00:1a.2
> PM: Adding info for pci:0000:00:1a.7
> PM: Adding info for pci:0000:00:1b.0
> PM: Adding info for pci:0000:00:1c.0
> PM: Adding info for pci:0000:00:1c.1
> PM: Adding info for pci:0000:00:1c.2
> PM: Adding info for pci:0000:00:1c.3
> PM: Adding info for pci:0000:00:1c.4
> PM: Adding info for pci:0000:00:1d.0
> PM: Adding info for pci:0000:00:1d.1
> PM: Adding info for pci:0000:00:1d.2
> PM: Adding info for pci:0000:00:1d.7
> PM: Adding info for pci:0000:00:1e.0
> PM: Adding info for pci:0000:00:1f.0
> PM: Adding info for pci:0000:00:1f.2
> PM: Adding info for pci:0000:00:1f.3
> PM: Adding info for pci:0000:00:1f.5
> PM: Adding info for pci:0000:03:00.0
> PM: Adding info for pci:0000:06:00.0
> ACPI: PCI Interrupt Routing Table [_SB_.PCI0.P32_._PRT]
> ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 7 9 10 *11 12)
> ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 7 9 *10 11 12)
> ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 5 7 *9 10 11 12)
> ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 7 9 10 *11 12)
> ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 7 9 10 *11 12)
> ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 7 *9 10 11 12)
> ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 5 7 9 *10 11 12)
> ACPI: PCI Interrupt Link [LNKH] (IRQs 3 4 5 7 9 10 *11 12)
> ACPI: PCI Interrupt Routing Table [_SB_.PCI0.PEX0._PRT]
> ACPI: PCI Interrupt Routing Table [_SB_.PCI0.PEX1._PRT]
> ACPI: PCI Interrupt Routing Table [_SB_.PCI0.PEX2._PRT]
> ACPI: PCI Interrupt Routing Table [_SB_.PCI0.PEX3._PRT]
> ACPI: PCI Interrupt Routing Table [_SB_.PCI0.PEX4._PRT]
> Linux Plug and Play Support v0.97 (c) Adam Belay
> pnp: PnP ACPI init
> PM: Adding info for No Bus:pnp0
> pnp: ACPI device : hid PNP0A03
> PM: Adding info for pnp:00:00
> pnp: ACPI device : hid PNP0C02
> PM: Adding info for pnp:00:01
> pnp: ACPI device : hid PNP0200
> PM: Adding info for pnp:00:02
> pnp: ACPI device : hid PNP0B00
> PM: Adding info for pnp:00:03
> pnp: ACPI device : hid PNP0C04
> PM: Adding info for pnp:00:04
> pnp: ACPI device : hid PNP0800
> PM: Adding info for pnp:00:05
> pnp: ACPI device : hid PNP0C02
> PM: Adding info for pnp:00:06
> pnp: ACPI device : hid WEC1000
> PM: Adding info for pnp:00:07
> pnp: ACPI device : hid PNP0C02
> PM: Adding info for pnp:00:08
> pnp: ACPI device : hid PNP0501
> PM: Adding info for pnp:00:09
> pnp: ACPI device : hid PNP0003
> PM: Adding info for pnp:00:0a
> pnp: PnP ACPI: found 11 devices
> xen_mem: Initialising balloon driver.
> PCI: Using ACPI for IRQ routing
> PCI: If a device doesn''t work, try "pci=routeirq".  If
it helps,
> post a report
> pnp: the driver ''system'' has been registered
> pnp: match found with the PnP device ''00:01'' and the
driver ''system''
> pnp: match found with the PnP device ''00:06'' and the
driver ''system''
> pnp: 00:06: ioport range 0x500-0x53f has been reserved
> pnp: 00:06: ioport range 0x400-0x47f could not be reserved
> pnp: 00:06: ioport range 0x680-0x6ff has been reserved
> pnp: match found with the PnP device ''00:08'' and the
driver ''system''
> pciback 0000:00:1d.1: seizing device
> PCI: Ignore bogus resource 6 [0:0] of 0000:00:02.0
> PCI: Bridge: 0000:00:1c.0
>  IO window: disabled.
>  MEM window: disabled.
>  PREFETCH window: disabled.
> PCI: Bridge: 0000:00:1c.1
>  IO window: disabled.
>  MEM window: disabled.
>  PREFETCH window: disabled.
> PCI: Bridge: 0000:00:1c.2
>  IO window: 2000-2fff
>  MEM window: e0100000-e01fffff
>  PREFETCH window: disabled.
> PCI: Bridge: 0000:00:1c.3
>  IO window: disabled.
>  MEM window: disabled.
>  PREFETCH window: disabled.
> PCI: Bridge: 0000:00:1c.4
>  IO window: disabled.
>  MEM window: disabled.
>  PREFETCH window: disabled.
> PCI: Bridge: 0000:00:1e.0
>  IO window: 1000-1fff
>  MEM window: e0000000-e00fffff
>  PREFETCH window: e0400000-e04fffff
> GSI 16 sharing vector 0xC0 and IRQ 16
> ACPI: PCI Interrupt 0000:00:1c.0[A] -> GSI 17 (level, low) -> IRQ 16
> PCI: Setting latency timer of device 0000:00:1c.0 to 64
> GSI 17 sharing vector 0xC8 and IRQ 17
> ACPI: PCI Interrupt 0000:00:1c.1[B] -> GSI 20 (level, low) -> IRQ 17
> PCI: Setting latency timer of device 0000:00:1c.1 to 64
> GSI 18 sharing vector 0xD0 and IRQ 18
> ACPI: PCI Interrupt 0000:00:1c.2[C] -> GSI 18 (level, low) -> IRQ 18
> PCI: Setting latency timer of device 0000:00:1c.2 to 64
> GSI 19 sharing vector 0xD8 and IRQ 19
> ACPI: PCI Interrupt 0000:00:1c.3[D] -> GSI 19 (level, low) -> IRQ 19
> PCI: Setting latency timer of device 0000:00:1c.3 to 64
> ACPI: PCI Interrupt 0000:00:1c.4[A] -> GSI 17 (level, low) -> IRQ 16
> PCI: Setting latency timer of device 0000:00:1c.4 to 64
> PCI: Setting latency timer of device 0000:00:1e.0 to 64
> NET: Registered protocol family 2
> IP route cache hash table entries: 262144 (order: 9, 2097152 bytes)
> TCP established hash table entries: 262144 (order: 10, 4194304 bytes)
> TCP bind hash table entries: 65536 (order: 8, 1048576 bytes)
> TCP: Hash tables configured (established 262144 bind 65536)
> TCP reno registered
> PM: Adding info for platform:pcspkr
> IA-32 Microcode Update Driver: v1.14a-xen <tigran@veritas.com>
> audit: initializing netlink socket (disabled)
> audit(1233229473.844:1): initialized
> VFS: Disk quotas dquot_6.5.1
> Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
> Initializing Cryptographic API
> io scheduler noop registered
> io scheduler anticipatory registered
> io scheduler deadline registered
> io scheduler cfq registered (default)
> PM: Adding info for platform:vesafb.0
> Real Time Clock Driver v1.12ac
> Non-volatile memory driver v1.2
> Serial: 8250/16550 driver $Revision: 1.90 $ 4 ports, IRQ sharing enabled
> PM: Adding info for platform:serial8250
> serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
> pnp: the driver ''serial'' has been registered
> pnp: match found with the PnP device ''00:09'' and the
driver ''serial''
> 00:09: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
> ACPI: PCI Interrupt 0000:00:03.3[B] -> GSI 17 (level, low) -> IRQ 16
> 0000:00:03.3: ttyS1 at I/O 0x3470 (irq = 16) is a 16550A
> RAMDISK driver initialized: 16 RAM disks of 16384K size 1024 blocksize
> loop: loaded (max 8 devices)
> Xen virtual console successfully installed as ttyS16
> Event-channel device installed.
> netfront: Initialising virtual ethernet driver.
> ACPI: PCI Interrupt 0000:00:1d.1[B] -> GSI 19 (level, low) -> IRQ 19
> ACPI: PCI interrupt for device 0000:00:1d.1 disabled
> Uniform Multi-Platform E-IDE driver Revision: 7.00alpha2
> ide: Assuming 66MHz system bus speed for PIO modes
> pnp: the driver ''ide'' has been registered
> pnp: the driver ''i8042 kbd'' has been registered
> pnp: the driver ''i8042 aux'' has been registered
> pnp: the driver ''i8042 kbd'' has been unregistered
> pnp: the driver ''i8042 aux'' has been unregistered
> PNP: No PS/2 controller found. Probing ports directly.
> PM: Adding info for platform:i8042
> serio: i8042 AUX port at 0x60,0x64 irq 12
> serio: i8042 KBD port at 0x60,0x64 irq 1
> PM: Adding info for serio:serio0
> PM: Adding info for serio:serio1
> mice: PS/2 mouse device common for all mice
> md: md driver 0.90.3 MAX_MD_DEVS=256, MD_SB_DISKS=27
> md: bitmap version 4.39
> device-mapper: ioctl: 4.7.0-ioctl (2006-06-24) initialised:  
> dm-devel@redhat.com
> NET: Registered protocol family 1
> NET: Registered protocol family 17
> ACPI: (supports S0 S1 S3 S4 S5)
> BIOS EDD facility v0.16 2004-Jun-25, 2 devices found
> Freeing unused kernel memory: 180k freed
> fuse init (API version 7.7)
> ACPI: Processor [CPU0] (supports 8 throttling states)
> ACPI: Processor [CPU1] (supports 8 throttling states)
> ACPI: Processor [CPU2] (supports 8 throttling states)
> ACPI: Processor [CPU3] (supports 8 throttling states)
> usbcore: registered new driver usbfs
> usbcore: registered new driver hub
> SCSI subsystem initialized
> PDC20269: IDE controller at PCI slot 0000:06:00.0
> GSI 20 sharing vector 0x21 and IRQ 20
> ACPI: PCI Interrupt 0000:06:00.0[A] -> GSI 21 (level, low) -> IRQ 20
> PDC20269: chipset revision 2
> PDC20269: ROM enabled at 0xe0400000
> PDC20269: 100% native mode on irq 20
>    ide0: BM-DMA at 0x1000-0x1007, BIOS settings: hda:pio, hdb:pio
>    ide1: BM-DMA at 0x1008-0x100f, BIOS settings: hdc:pio, hdd:pio
> Probing IDE interface ide0...
> USB Universal Host Controller Interface driver v3.0
> ACPI: PCI Interrupt 0000:00:1a.0[A] -> <7>libata version 2.00
loaded.
> GSI 18 (level, low) -> IRQ 18
> PCI: Setting latency timer of device 0000:00:1a.0 to 64
> uhci_hcd 0000:00:1a.0: UHCI Host Controller
> uhci_hcd 0000:00:1a.0: new USB bus registered, assigned bus number 1
> uhci_hcd 0000:00:1a.0: irq 18, io base 0x000030c0
> PM: Adding info for usb:usb1
> PM: Adding info for No Bus:usbdev1.1_ep00
> usb usb1: configuration #1 chosen from 1 choice
> PM: Adding info for usb:1-0:1.0
> hub 1-0:1.0: USB hub found
> hub 1-0:1.0: 2 ports detected
> PM: Adding info for No Bus:usbdev1.1_ep81
> ACPI: PCI Interrupt 0000:00:1a.1[B] -> hda: SAMSUNG HD300LD, ATA DISK
drive
> PM: Adding info for No Bus:ide0
> usb 1-1: new low speed USB device using uhci_hcd and address 2
> PM: Adding info for usb:1-1
> PM: Adding info for No Bus:usbdev1.2_ep00
> usb 1-1: configuration #1 chosen from 1 choice
> PM: Adding info for usb:1-1:1.0
> PM: Adding info for No Bus:usbdev1.2_ep81
> PM: Adding info for usb:1-1:1.1
> PM: Adding info for No Bus:usbdev1.2_ep82
> ide0 at 0x1018-0x101f,0x1026 on irq 20
> PM: Adding info for ide:0.0
> Probing IDE interface ide1...
> GSI 21 (level, low) -> IRQ 20
> PCI: Setting latency timer of device 0000:00:1a.1 to 64
> uhci_hcd 0000:00:1a.1: UHCI Host Controller
> uhci_hcd 0000:00:1a.1: new USB bus registered, assigned bus number 2
> uhci_hcd 0000:00:1a.1: irq 20, io base 0x000030a0
> PM: Adding info for usb:usb2
> PM: Adding info for No Bus:usbdev2.1_ep00
> usb usb2: configuration #1 chosen from 1 choice
> PM: Adding info for usb:2-0:1.0
> hub 2-0:1.0: USB hub found
> hub 2-0:1.0: 2 ports detected
> hda: max request size: 512KiB
> PM: Adding info for No Bus:usbdev2.1_ep81
> ACPI: PCI Interrupt 0000:00:1a.2[C] -> GSI 17 (level, low) -> IRQ 16
> PCI: Setting latency timer of device 0000:00:1a.2 to 64
> uhci_hcd 0000:00:1a.2: UHCI Host Controller
> uhci_hcd 0000:00:1a.2: new USB bus registered, assigned bus number 3
> uhci_hcd 0000:00:1a.2: irq 16, io base 0x00003080
> PM: Adding info for usb:usb3
> PM: Adding info for No Bus:usbdev3.1_ep00
> usb usb3: configuration #1 chosen from 1 choice
> PM: Adding info for usb:3-0:1.0
> hub 3-0:1.0: USB hub found
> hub 3-0:1.0: 2 ports detected
> PM: Adding info for No Bus:usbdev3.1_ep81
> GSI 21 sharing vector 0x29 and IRQ 21
> ACPI: PCI Interrupt 0000:00:1d.0[A] -> GSI 23 (level, low) -> IRQ 21
> PCI: Setting latency timer of device 0000:00:1d.0 to 64
> uhci_hcd 0000:00:1d.0: UHCI Host Controller
> uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 4
> uhci_hcd 0000:00:1d.0: irq 21, io base 0x00003060
> PM: Adding info for usb:usb4
> PM: Adding info for No Bus:usbdev4.1_ep00
> usb usb4: configuration #1 chosen from 1 choice
> PM: Adding info for usb:4-0:1.0
> hub 4-0:1.0: USB hub found
> hub 4-0:1.0: 2 ports detected
> PM: Adding info for No Bus:usbdev4.1_ep81
> ACPI: PCI Interrupt 0000:00:1d.2[C] -> GSI 18 (level, low) -> IRQ 18
> PCI: Setting latency timer of device 0000:00:1d.2 to 64
> uhci_hcd 0000:00:1d.2: UHCI Host Controller
> uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 5
> uhci_hcd 0000:00:1d.2: irq 18, io base 0x00003020
> PM: Adding info for usb:usb5
> PM: Adding info for No Bus:usbdev5.1_ep00
> usb usb5: configuration #1 chosen from 1 choice
> PM: Adding info for usb:5-0:1.0
> hub 5-0:1.0: USB hub found
> hub 5-0:1.0: 2 ports detected
> PM: Adding info for No Bus:usbdev5.1_ep81
> ACPI: PCI Interrupt 0000:00:1a.7[C] -> GSI 17 (level, low) -> IRQ 16
> PCI: Setting latency timer of device 0000:00:1a.7 to 64
> ehci_hcd 0000:00:1a.7: EHCI Host Controller
> ehci_hcd 0000:00:1a.7: new USB bus registered, assigned bus number 6
> ehci_hcd 0000:00:1a.7: debug port 1
> PCI: cache line size of 32 is not supported by device 0000:00:1a.7
> ehci_hcd 0000:00:1a.7: irq 16, io mem 0xe03a6400
> ehci_hcd 0000:00:1a.7: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004
> PM: Adding info for usb:usb6
> PM: Adding info for No Bus:usbdev6.1_ep00
> usb usb6: configuration #1 chosen from 1 choice
> PM: Adding info for usb:6-0:1.0
> hub 6-0:1.0: USB hub found
> hub 6-0:1.0: 6 ports detected
> usb 1-1: USB disconnect, address 2
> PM: Adding info for No Bus:usbdev6.1_ep81
> ACPI: PCI Interrupt 0000:00:1d.7[A] -> GSI 23 (level, low) -> IRQ 21
> PCI: Setting latency timer of device 0000:00:1d.7 to 64
> ehci_hcd 0000:00:1d.7: EHCI Host Controller
> ehci_hcd 0000:00:1d.7: new USB bus registered, assigned bus number 7
> ehci_hcd 0000:00:1d.7: debug port 1
> PCI: cache line size of 32 is not supported by device 0000:00:1d.7
> ehci_hcd 0000:00:1d.7: irq 21, io mem 0xe03a6000
> ehci_hcd 0000:00:1d.7: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004
> PM: Adding info for usb:usb7
> PM: Adding info for No Bus:usbdev7.1_ep00
> usb usb7: configuration #1 chosen from 1 choice
> PM: Adding info for usb:7-0:1.0
> hub 7-0:1.0: USB hub found
> hub 7-0:1.0: 6 ports detected
> hda: 586072368 sectors (300069 MB) w/8192KiB Cache,  
> CHS=36481/255/63, UDMA(100)
> hda: cache flushes supported
> hda: hda1
> PM: Adding info for No Bus:usbdev7.1_ep81
> ata_piix 0000:00:1f.2: version 2.00
> ata_piix 0000:00:1f.2: MAP [ P0 P2 P1 P3 ]
> ACPI: PCI Interrupt 0000:00:1f.2[A] -> GSI 21 (level, low) -> IRQ 20
> PCI: Setting latency timer of device 0000:00:1f.2 to 64
> BUG: soft lockup detected on CPU#0!
>
> Call Trace:
> <IRQ> [<ffffffff80257898>] softlockup_tick+0xd5/0xe7
> [<ffffffff8020f03f>] timer_interrupt+0x3db/0x439
> [<ffffffff80257b83>] handle_IRQ_event+0x4d/0x95
> [<ffffffff80257c6f>] __do_IRQ+0xa4/0x105
> [<ffffffff8020cda7>] do_IRQ+0x44/0x4d
> [<ffffffff80352737>] evtchn_do_upcall+0x189/0x236
> [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
> [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
> [<ffffffff8020adce>] do_hypervisor_callback+0x1e/0x2c
> <EOI> [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
> [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
> [<ffffffff80213ade>] __smp_call_function+0x68/0x89
> [<ffffffff80213ad6>] __smp_call_function+0x60/0x89
> [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
> [<ffffffff80213d39>] smp_call_function+0x32/0x49
> [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
> [<ffffffff80233356>] on_each_cpu+0xf/0x5d
> [<ffffffff802804ba>] invalidate_bdev+0x2b/0x36
> [<ffffffff80284f4e>] kill_bdev+0xe/0x21
> [<ffffffff80285507>] __blkdev_put+0x4c/0x159
> [<ffffffff802b9f31>] register_disk+0x146/0x199
> [<ffffffff802dfcb1>] add_disk+0x34/0x3d
> [<ffffffff880be9e7>] :ide_disk:ide_disk_probe+0x77b/0x7a8
> [<ffffffff8034b950>] driver_probe_device+0x52/0xa2
> [<ffffffff8034b9ff>] __driver_attach+0x0/0x8f
> [<ffffffff8034ba57>] __driver_attach+0x58/0x8f
> [<ffffffff8034b9ff>] __driver_attach+0x0/0x8f
> [<ffffffff8034b374>] bus_for_each_dev+0x43/0x6e
> [<ffffffff8034afdc>] bus_add_driver+0x73/0x122
> [<ffffffff8024b13d>] sys_init_module+0x1720/0x184f
> [<ffffffff8020a5e4>] system_call+0x68/0x6d
> [<ffffffff8020a57c>] system_call+0x0/0x6d
>
> PM: Removing info for No Bus:usbdev1.2_ep81
> PM: Removing info for usb:1-1:1.0
> PM: Removing info for No Bus:usbdev1.2_ep82
> PM: Removing info for usb:1-1:1.1
> PM: Removing info for No Bus:usbdev1.2_ep00
> PM: Removing info for usb:1-1
> ata1: SATA max UDMA/133 cmd 0x3468 ctl 0x349E bmdma 0x3430 irq 20
> usbcore: registered new driver hiddev
> usb 7-2: new high speed USB device using ehci_hcd and address 2
> PM: Adding info for usb:7-2
> PM: Adding info for No Bus:usbdev7.2_ep00
> usb 7-2: configuration #1 chosen from 1 choice
> PM: Adding info for usb:7-2:1.0
> PM: Adding info for No Bus:usbdev7.2_ep01
> PM: Adding info for No Bus:usbdev7.2_ep82
> usbcore: registered new driver usbhid
>
/opt/install/xen/xen-3.3.1/linux-2.6.18-xen.hg/drivers/usb/input/hid-core.c:
> v2.6:USB HID core driver
> usb 1-1: new low speed USB device using uhci_hcd and address 3
> PM: Adding info for usb:1-1
> PM: Adding info for No Bus:usbdev1.3_ep00
> usb 1-1: configuration #1 chosen from 1 choice
> PM: Adding info for usb:1-1:1.0
> input: Plus More Enterprise LTD. USB-compliant keyboard as  
> /class/input/input0
> input: USB HID v1.10 Keyboard [Plus More Enterprise LTD.  
> USB-compliant keyboard] on usb-0000:00:1a.0-1
> PM: Adding info for No Bus:usbdev1.3_ep81
> PM: Adding info for usb:1-1:1.1
> input: Plus More Enterprise LTD. USB-compliant keyboard as  
> /class/input/input1
> input: USB HID v1.10 Mouse [Plus More Enterprise LTD. USB-compliant  
> keyboard] on usb-0000:00:1a.0-1
> PM: Adding info for No Bus:usbdev1.3_ep82
> BUG: soft lockup detected on CPU#0!
>
> Call Trace:
> <IRQ> [<ffffffff80257898>] softlockup_tick+0xd5/0xe7
> [<ffffffff8020f03f>] timer_interrupt+0x3db/0x439
> [<ffffffff80257b83>] handle_IRQ_event+0x4d/0x95
> [<ffffffff80257c6f>] __do_IRQ+0xa4/0x105
> [<ffffffff8020cda7>] do_IRQ+0x44/0x4d
> [<ffffffff80352737>] evtchn_do_upcall+0x189/0x236
> [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
> [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
> [<ffffffff8020adce>] do_hypervisor_callback+0x1e/0x2c
> <EOI> [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
> [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
> [<ffffffff80213ada>] __smp_call_function+0x64/0x89
> [<ffffffff80213ad6>] __smp_call_function+0x60/0x89
> [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
> [<ffffffff80213d39>] smp_call_function+0x32/0x49
> [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
> [<ffffffff80233356>] on_each_cpu+0xf/0x5d
> [<ffffffff802804ba>] invalidate_bdev+0x2b/0x36
> [<ffffffff80284f4e>] kill_bdev+0xe/0x21
> [<ffffffff80285507>] __blkdev_put+0x4c/0x159
> [<ffffffff8027f002>] __fput+0x9e/0x16e
> [<ffffffff8027c7ac>] filp_close+0x5c/0x64
> [<ffffffff8022fec6>] put_files_struct+0x6c/0xc3
> [<ffffffff80231224>] do_exit+0x29b/0x921
> [<ffffffff802ea213>] __up_write+0x1d/0x112
> [<ffffffff80231988>] sys_exit_group+0x0/0xe
> [<ffffffff8020a5e4>] system_call+0x68/0x6d
> [<ffffffff8020a57c>] system_call+0x0/0x6d
>
> ata2: SATA max UDMA/133 cmd 0x3460 ctl 0x349A bmdma 0x3438 irq 20
> scsi0 : ata_piix
> PM: Adding info for No Bus:host0
> Initializing USB Mass Storage driver...
> scsi2 : SCSI emulation for USB Mass Storage devices
> ATA: abnormal status 0x7F on port 0x346F
> scsi1 : ata_piix
> PM: Adding info for No Bus:host1
> ATA: abnormal status 0x7F on port 0x3467
> ATA: abnormal status 0x7F on port 0x3467
> ata2.01: ATA-7, max UDMA/133, 488397168 sectors: LBA48 NCQ (depth 0/32)
> ata2.01: ata2: dev 1 multi count 16
> ata2.01: configured for UDMA/133
> PM: Adding info for No Bus:target1:0:1
>  Vendor: ATA       Model: MAXTOR STM325031  Rev: 3.AA
>  Type:   Direct-Access                      ANSI SCSI revision: 05
> PM: Adding info for scsi:1:0:1:0
> ata_piix 0000:00:1f.5: MAP [ P0 P2 P1 P3 ]
> ACPI: PCI Interrupt 0000:00:1f.5[A] -> GSI 21 (level, low) -> IRQ 20
> PCI: Setting latency timer of device 0000:00:1f.5 to 64
> ata3: SATA max UDMA/133 cmd 0x3458 ctl 0x3496 bmdma 0x3410 irq 20
> ata4: SATA max UDMA/133 cmd 0x3450 ctl 0x3492 bmdma 0x3418 irq 20
> scsi3 : ata_piix
> PM: Adding info for No Bus:host3
> ATA: abnormal status 0x7F on port 0x345F
> scsi4 : ata_piix
> PM: Adding info for No Bus:host4
> ATA: abnormal status 0x7F on port 0x3457
> BUG: soft lockup detected on CPU#0!
>
> Call Trace:
> <IRQ> [<ffffffff80257898>] softlockup_tick+0xd5/0xe7
> [<ffffffff8020f03f>] timer_interrupt+0x3db/0x439
> [<ffffffff80257b83>] handle_IRQ_event+0x4d/0x95
> [<ffffffff80257c6f>] __do_IRQ+0xa4/0x105
> [<ffffffff8020cda7>] do_IRQ+0x44/0x4d
> [<ffffffff80352737>] evtchn_do_upcall+0x189/0x236
> [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
> [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
> [<ffffffff8020adce>] do_hypervisor_callback+0x1e/0x2c
> <EOI> [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
> [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
> [<ffffffff80213ada>] __smp_call_function+0x64/0x89
> [<ffffffff80213ad6>] __smp_call_function+0x60/0x89
> [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
> [<ffffffff80213d39>] smp_call_function+0x32/0x49
> [<ffffffff8027f990>] invalidate_bh_lru+0x0/0x42
> [<ffffffff80233356>] on_each_cpu+0xf/0x5d
> [<ffffffff802804ba>] invalidate_bdev+0x2b/0x36
> [<ffffffff80284f4e>] kill_bdev+0xe/0x21
> [<ffffffff80285507>] __blkdev_put+0x4c/0x159
> [<ffffffff8027f002>] __fput+0x9e/0x16e
> [<ffffffff8027c7ac>] filp_close+0x5c/0x64
> [<ffffffff8022fec6>] put_files_struct+0x6c/0xc3
> [<ffffffff80231224>] do_exit+0x29b/0x921
> [<ffffffff8027e7ec>] vfs_write+0x13f/0x174
> [<ffffffff80231988>] sys_exit_group+0x0/0xe
> [<ffffffff8020a5e4>] system_call+0x68/0x6d
> [<ffffffff8020a57c>] system_call+0x0/0x6d
>
> PM: Adding info for No Bus:host2
> usbcore: registered new driver usb-storage
> usb-storage: device found at 2
> usb-storage: waiting for device to settle before scanning
> USB Mass Storage support registered.
> SCSI device sda: 488397168 512-byte hdwr sectors (250059 MB)
> sda: Write Protect is off
> sda: Mode Sense: 00 3a 00 00
> SCSI device sda: drive cache: write back
> PM: Adding info for No Bus:target2:0:0
>  Vendor: Generic   Model: USB SD Reader     Rev: 1.00
>  Type:   Direct-Access                      ANSI SCSI revision: 00
> PM: Adding info for scsi:2:0:0:0
> PM: Adding info for No Bus:target2:0:1
> PM: Removing info for No Bus:target2:0:1
> PM: Adding info for No Bus:target2:0:2
> PM: Removing info for No Bus:target2:0:2
> PM: Adding info for No Bus:target2:0:3
> PM: Removing info for No Bus:target2:0:3
> PM: Adding info for No Bus:target2:0:4
> PM: Removing info for No Bus:target2:0:4
> PM: Adding info for No Bus:target2:0:5
> PM: Removing info for No Bus:target2:0:5
> PM: Adding info for No Bus:target2:0:6
> PM: Removing info for No Bus:target2:0:6
> PM: Adding info for No Bus:target2:0:7
> PM: Removing info for No Bus:target2:0:7
> usb-storage: device scan complete
> SCSI device sda: 488397168 512-byte hdwr sectors (250059 MB)
> sda: Write Protect is off
> sda: Mode Sense: 00 3a 00 00
> SCSI device sda: drive cache: write back
> sda: sda1 sda2 sda3
> sd 1:0:1:0: Attached scsi disk sda
> sd 2:0:0:0: Attached scsi removable disk sdb
> sd 1:0:1:0: Attached scsi generic sg0 type 0
> sd 2:0:0:0: Attached scsi generic sg1 type 0
> kjournald starting.  Commit interval 5 seconds
> EXT3-fs: mounted filesystem with ordered data mode.
> input: PC Speaker as /class/input/input2
> device-mapper: multipath: version 1.0.4 loaded
> e1000e: Intel(R) PRO/1000 Network Driver - 0.4.1.12-NAPI
> e1000e: Copyright (c) 1999-2008 Intel Corporation.
> ACPI: PCI Interrupt 0000:00:19.0[A] -> GSI 20 (level, low) -> IRQ 17
> PCI: Setting latency timer of device 0000:00:19.0 to 64
> 0000:00:19.0: : Failed to initialize MSI interrupts.  Falling back  
> to legacy interrupts.
> 0000:00:19.0: eth0: (PCI Express:2.5GB/s:Width x1) 00:1c:c0:41:0e:2c
> 0000:00:19.0: eth0: Intel(R) PRO/1000 Network Connection
> 0000:00:19.0: eth0: MAC: 7, PHY: 6, PBA No: ffffff-0ff
> GSI 22 sharing vector 0x31 and IRQ 22
> ACPI: PCI Interrupt 0000:00:1b.0[A] -> GSI 22 (level, low) -> IRQ 22
> PCI: Setting latency timer of device 0000:00:1b.0 to 64
> pnp: the driver ''parport_pc'' has been registered
> lp: driver loaded but no devices found
> Adding 2097144k swap on /dev/mapper/sys_vol-sys_swap.  Priority:-1  
> extents:1 across:2097144k
> EXT3 FS on dm-17, internal journal
> kjournald starting.  Commit interval 5 seconds
> EXT3 FS on sda1, internal journal
> EXT3-fs: mounted filesystem with ordered data mode.
> kjournald starting.  Commit interval 5 seconds
> EXT3 FS on dm-19, internal journal
> EXT3-fs: mounted filesystem with ordered data mode.
> kjournald starting.  Commit interval 5 seconds
> EXT3 FS on dm-20, internal journal
> EXT3-fs: mounted filesystem with ordered data mode.
> Bridge firewalling registered
> device eth0 entered promiscuous mode
> audit(1233229874.464:2): dev=eth0 prom=256 old_prom=0 auid=4294967295
> 0000:00:19.0: eth0: Link is Up 100 Mbps Full Duplex, Flow Control: RX/TX
> 0000:00:19.0: eth0: 10/100 speed: disabling TSO
> br0: port 1(eth0) entering learning state
> br0: topology change detected, propagating
> br0: port 1(eth0) entering forwarding state
> NET: Registered protocol family 10
> lo: Disabled Privacy Extensions
> IPv6 over IPv4 tunneling driver
> suspend: event channel 26
> PM: Adding info for xen-backend:vfb-1-0
> PM: Adding info for xen-backend:vbd-1-768
> PM: Adding info for xen-backend:vif-1-0
> pciback 0000:00:1d.1: enabling permissive mode configuration space
accesses!
> pciback 0000:00:1d.1: permissive mode is potentially unsafe!
> PM: Adding info for xen-backend:pci-1-0
> device vif1.0 entered promiscuous mode
> audit(1233229901.660:3): dev=vif1.0 prom=256 old_prom=0 auid=4294967295
> br0: port 2(vif1.0) entering learning state
> ip_tables: (C) 2000-2006 Netfilter Core Team
> tun: Universal TUN/TAP device driver, 1.6
> tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com>
> device tap1.0 entered promiscuous mode
> audit(1233229902.193:4): dev=tap1.0 prom=256 old_prom=0 auid=4294967295
> br0: port 3(tap1.0) entering learning state
> eth0: no IPv6 routers present
> PM: Adding info for xen-backend:console-1-0
> PM: Adding info for xen-backend:vbd-2-51712
> PM: Adding info for xen-backend:vbd-2-51715
> PM: Adding info for xen-backend:vif-2-0
> PM: Adding info for xen-backend:console-2-0
> device vif2.0 entered promiscuous mode
> audit(1233229908.988:5): dev=vif2.0 prom=256 old_prom=0 auid=4294967295
> br0: port 4(vif2.0) entering learning state
> PM: Removing info for xen-backend:console-2-0
> PM: Removing info for xen-backend:vbd-2-51712
> PM: Removing info for xen-backend:vbd-2-51715
> br0: port 4(vif2.0) entering disabled state
> device vif2.0 left promiscuous mode
> audit(1233229909.419:6): dev=vif2.0 prom=0 old_prom=256 auid=4294967295
> br0: port 4(vif2.0) entering disabled state
> PM: Removing info for xen-backend:vif-2-0
> vif1.0: no IPv6 routers present
> tap1.0: no IPv6 routers present
> br0: topology change detected, propagating
> br0: port 2(vif1.0) entering forwarding state
> br0: topology change detected, propagating
> br0: port 3(tap1.0) entering forwarding state
> PM: Adding info for xen-backend:vbd-3-51712
> PM: Adding info for xen-backend:vbd-3-51715
> PM: Adding info for xen-backend:vif-3-0
> PM: Adding info for xen-backend:console-3-0
> device vif3.0 entered promiscuous mode
> audit(1233230236.962:7): dev=vif3.0 prom=256 old_prom=0 auid=4294967295
> br0: port 4(vif3.0) entering learning state
> blkback: ring-ref 2047, event-channel 4, protocol 1 (x86_64-abi)
> blkback: ring-ref 2046, event-channel 5, protocol 1 (x86_64-abi)
> frontend_changed: backend/vbd/3/51712: prepare for reconnect
> frontend_changed: backend/vbd/3/51715: prepare for reconnect
> blkback: ring-ref 8, event-channel 15, protocol 1 (x86_64-abi)
> blkback: ring-ref 9, event-channel 16, protocol 1 (x86_64-abi)
> vif3.0: no IPv6 routers present
> br0: topology change detected, propagating
> br0: port 4(vif3.0) entering forwarding state
> root@dom0:~#
>
> It takes about 10 minutes for booting, other (newer) kernels such as  
> 2.6.24-xen from ubuntu do not have this behavior.
>
> My Mainboard is a Intel vPro DQ35MP with QuadCore Q6600.
>
> Can anybody help me? I do not find the reason for this problem.
> A memtest86+ did not show errors and I even replaced the RAM with  
> another, more expensive...:-(
>
> Thank you and best regards
>
>
> Ralf
>
>
>
> _______________________________________________
> Xen-users mailing list
> Xen-users@lists.xensource.com
> http://lists.xensource.com/xen-users
>


-- 
alles bleibt anders...




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

Fajar A. Nugraha

2009-Jan-30 11:46 UTC

head link

Re: [Xen-users] After memory upgrade - slow boot and "ERROR: Invalid checksum?"

On Fri, Jan 30, 2009 at 4:47 PM, Ralf Hornik Mailings
<ralf@best.homeunix.org> wrote:> No ideas?
>
> No hints, suggestions, help?
> TBH, this only (and many other hardware issues) happens with 2.6.18 kernel
> from xen. Any other (newer) kernel doesn''t have such problems.
If you know that newer kernels doesn''t have problems with your
hardware, then why bother sticking with xen.org''s kernel?

For example, on RHEL/Centos5, the easy method to use Xen 3.3.1 is to
use xen RPMs from Gitco while still using RH''s kernel (which is
actively maintained and contains lots of bugfixes and backports).

Regards,

Fajar

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

Ralf Hornik Mailings

2009-Jan-30 13:25 UTC

head link

Re: [Xen-users] After memory upgrade - slow boot and "ERROR: Invalid checksum?"

"Fajar A. Nugraha" <fajar@fajar.net> wrote:
> For example, on RHEL/Centos5, the easy method to use Xen 3.3.1 is to
> use xen RPMs from Gitco while still using RH''s kernel (which is
> actively maintained and contains lots of bugfixes and backports).
I''m recently using ubuntu 8.04 but it is a nightmare with xen, so I  
decided to walk away from depending on that (or any) distribution.

And then I preferred to install all_in_one from source to not come  
into trouble with incompatible kernels. I do not know how the  
hypervisor is "in sync" with a non xen.org kernel.

What I know, any linux distribution has some bad capabilities. If I  
could choose the OS, I would use (Open)Solaris xVM or *BSD as dom0.

But xVM is not as sophesticated as xen 3.3.x, and I need at least pci  
passthrough which isn''t supported (yet). NetBSD actually supports xen  
dom0 but most documentation ends with version 2.0...

Regards
Ralf

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

Fajar A. Nugraha

2009-Jan-30 14:53 UTC

head link

Re: [Xen-users] After memory upgrade - slow boot and "ERROR: Invalid checksum?"

On Fri, Jan 30, 2009 at 8:25 PM, Ralf Hornik Mailings
<ralf@best.homeunix.org> wrote:> I''m recently using ubuntu 8.04 but it is a nightmare with xen, so
I decided
> to walk away from depending on that (or any) distribution.
>
> And then I preferred to install all_in_one from source to not come into
> trouble with incompatible kernels. I do not know how the hypervisor is
"in
> sync" with a non xen.org kernel.
Fair enough. All I can say is that (on Linux anyway) you can mostly
mix-and-match hypervisor and kernel (both dom0 and domU) versions,
provided they''re compatible enough. For example, RH''s
kernel-xen is
built against a modified Xen-3.1.2 sources, while Gitco''s Xen 3.3.1
RPM is (obviously) built from Xen-3.3.1 sources.

This is NOT the case on Solaris dom0 though.

In short, use whatever kernel that works :)

Regards,

Fajar

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

Ralf Hornik Mailings

2009-Feb-16 21:44 UTC

head link

Re: [Xen-users] After memory upgrade - slow boot and "ERROR: Invalid checksum?"

Thank you for your hints.

However, compiling xen from source does not work at all on a "virgin" 
linux. Obviously there are a lot of missing prerequisites.
Even if it has compiled well, it simply does not start any vm later. 
(tested with opensuse 11.x netinstall and centos 5.2 netinstall. hvm 
starts into qemu, pv-grub starts mini-os and hangs ).
A configure script might help here and is indeed widely common for 
building source.

At least I used your suggestion - centos 5.2 + gitco. This seems to work 
now with 3.3.1.
Hopefully it will do in future. :-)

Ralf

Fajar A. Nugraha schrieb:> On Fri, Jan 30, 2009 at 8:25 PM, Ralf Hornik Mailings
> <ralf@best.homeunix.org> wrote:
>   
>> I''m recently using ubuntu 8.04 but it is a nightmare with xen,
so I decided
>> to walk away from depending on that (or any) distribution.
>>
>> And then I preferred to install all_in_one from source to not come into
>> trouble with incompatible kernels. I do not know how the hypervisor is
"in
>> sync" with a non xen.org kernel.
>>     
>
> Fair enough. All I can say is that (on Linux anyway) you can mostly
> mix-and-match hypervisor and kernel (both dom0 and domU) versions,
> provided they''re compatible enough. For example, RH''s
kernel-xen is
> built against a modified Xen-3.1.2 sources, while Gitco''s Xen
3.3.1
> RPM is (obviously) built from Xen-3.3.1 sources.
>
> This is NOT the case on Solaris dom0 though.
>
> In short, use whatever kernel that works :)
>
> Regards,
>
> Fajar
>   

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

Xen users - Jan 2009 - After memory upgrade - slow boot and "ERROR: Invalid checksum?"

[Xen-users] After memory upgrade - slow boot and "ERROR: Invalid checksum?"

Re: [Xen-users] After memory upgrade - slow boot and "ERROR: Invalid checksum?"

Re: [Xen-users] After memory upgrade - slow boot and "ERROR: Invalid checksum?"

Re: [Xen-users] After memory upgrade - slow boot and "ERROR: Invalid checksum?"

Re: [Xen-users] After memory upgrade - slow boot and "ERROR: Invalid checksum?"

Re: [Xen-users] After memory upgrade - slow boot and "ERROR: Invalid checksum?"