I meant to sent the original message to linux-scsi, but somehow posted it to LKML. So resending it into proper mailinglist. Please forgive me for double post. -------- Original Message -------- Subject: WARNING: at block/genhd.c:1474 __disk_unblock_events+0xe1/0xf0() -- should I be concerned? Date: Sun, 04 Mar 2012 18:19:33 +0400 From: Michael Tokarev <mjt@xxxxxxxxxx> To: Linux-kernel <linux-kernel@xxxxxxxxxxxxxxx> I booted a 3.0 kernel (i686) on a relatively old hardware, on a server which was running 2.6.32 stable series for a long while. And at the first boot I see the following messages in dmesg: ... [ 2.817314] mptbase: ioc0: Initiating bringup [ 3.230016] ioc0: LSI53C1030 B2: Capabilities={Initiator} [ 4.120665] scsi2 : ioc0: LSI53C1030 B2, FwRev=01000e00h, Ports=1, MaxQ=222, IRQ=27 [ 4.489143] mptspi 0000:08:07.1: PCI INT B -> GSI 28 (level, low) -> IRQ 28 [ 4.489361] mptbase: ioc1: Initiating bringup [ 19.486696] mptbase: ioc0: WARNING - Issuing Reset from mpt_config!!, doorbell=0x24000000 [ 20.126685] mptbase: ioc0: Attempting Retry Config request type 0x4, page 0x1, action 2 [ 20.126831] mptbase: ioc0: Retry completed ret=0x0 timeleft=4500 [ 20.127697] scsi 2:0:0:0: Direct-Access IBM-ESXS DTN073C3UCDY10FN S25J PQ: 0 ANSI: 3 ... [ 22.604075] sd 2:0:3:0: [sdd] Attached SCSI disk [ 22.635177] ------------[ cut here ]------------ [ 22.635290] WARNING: at block/genhd.c:1474 __disk_unblock_events+0xe1/0xf0() [ 22.635371] Hardware name: eserver xSeries 345 -[867052G]- [ 22.635448] Modules linked in: mptspi(+) mptscsih mptbase scsi_transport_spi e1000 ohci_hcd pata_serverworks libata usbhid hid usbcore sd_mod scsi_mod crc_t10dif [ 22.636260] Pid: 271, comm: blkid Not tainted 3.0.0-i686 #3.0.23 [ 22.636334] Call Trace: [ 22.636407] [<c1040118>] ? warn_slowpath_common+0x78/0xb0 [ 22.636482] [<c1188d81>] ? __disk_unblock_events+0xe1/0xf0 [ 22.636556] [<c1188d81>] ? __disk_unblock_events+0xe1/0xf0 [ 22.636631] [<c104016b>] ? warn_slowpath_null+0x1b/0x20 [ 22.636705] [<c1188d81>] ? __disk_unblock_events+0xe1/0xf0 [ 22.636783] [<c1124f57>] ? __blkdev_get+0x157/0x3c0 [ 22.636856] [<c1125203>] ? blkdev_get+0x43/0x2b0 [ 22.636931] [<c11616b0>] ? security_dentry_open+0x70/0x80 [ 22.637006] [<c11245f8>] ? bd_acquire+0x28/0xc0 [ 22.637080] [<c10f70c8>] ? __dentry_open+0x118/0x2b0 [ 22.637154] [<c10f7348>] ? nameidata_to_filp+0x68/0x70 [ 22.637228] [<c1125470>] ? blkdev_get+0x2b0/0x2b0 [ 22.637302] [<c110429d>] ? do_last+0xcd/0x820 [ 22.637375] [<c10fa48b>] ? get_empty_filp+0x11b/0x1d0 [ 22.637449] [<c1105601>] ? path_openat+0xa1/0x370 [ 22.637523] [<c11059b4>] ? do_filp_open+0x34/0x90 [ 22.637597] [<c10464c1>] ? irq_exit+0x31/0xa0 [ 22.637672] [<c12e69d2>] ? call_function_interrupt+0x2a/0x30 [ 22.637746] [<c10f6cce>] ? do_sys_open+0xee/0x1c0 [ 22.637820] [<c10f6e1c>] ? sys_open+0x2c/0x40 [ 22.637892] [<c12e70d8>] ? sysenter_do_call+0x12/0x28 [ 22.637963] ---[ end trace 9071b164502805fa ]--- [ 22.645185] sd 2:0:2:0: [sdc] Attached SCSI disk [ 22.659254] sd 2:0:4:0: [sde] Attached SCSI disk [ 34.493348] mptbase: ioc1: ERROR - Wait IOC_READY state (0x20000000) timeout(15)! [ 38.883345] ioc1: LSI53C1030 B2: Capabilities={Initiator} [ 39.283343] ioc0: LSI53C1030 B2: Capabilities={Initiator} [ 40.567328] scsi3 : ioc1: LSI53C1030 B2, FwRev=01000e00h, Ports=1, MaxQ=222, IRQ=28 ... This is 3.0.23. Line 1474 of block/genhd.c is like this: static void __disk_unblock_events(struct gendisk *disk, bool check_now) { struct disk_events *ev = disk->ev; ... if (WARN_ON_ONCE(ev->block <= 0)) <==== this one goto out_unlock; ... The machine has the following SCSI controller: 08:07.1 SCSI storage controller: LSI Logic / Symbios Logic 53c1030 PCI-X Fusion-MPT Dual Ultra320 SCSI (rev 07) Subsystem: IBM Device 026c Control: I/O+ Mem+ BusMaster+ SpecCycle- MemWINV+ VGASnoop- ParErr+ Stepping- SERR+ FastB2B- DisINTx- Status: Cap+ 66MHz+ UDF- FastB2B- ParErr- DEVSEL=medium >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx- Latency: 72 (4250ns min, 4500ns max), Cache Line Size: 32 bytes Interrupt: pin B routed to IRQ 28 Region 0: I/O ports at 2700 [size=256] Region 1: Memory at f9fd0000 (64-bit, non-prefetchable) [size=64K] Region 3: Memory at f9fc0000 (64-bit, non-prefetchable) [size=64K] [virtual] Expansion ROM at a0200000 [disabled] [size=1M] Capabilities: [50] Power Management version 2 Flags: PMEClk- DSI- D1+ D2+ AuxCurrent=0mA PME(D0-,D1-,D2-,D3hot-,D3cold-) Status: D0 NoSoftRst- PME-Enable- DSel=0 DScale=0 PME- Capabilities: [58] MSI: Enable- Count=1/1 Maskable- 64bit+ Address: 0000000000000000 Data: 0000 Capabilities: [68] PCI-X non-bridge device Command: DPERE- ERO- RBC=512 OST=1 Status: Dev=08:07.1 64bit+ 133MHz+ SCD- USC- DC=simple DMMRBC=2048 DMOST=8 DMCRS=16 RSCEM- 266MHz- 533MHz- Kernel driver in use: mptspi with 5 parallel scsi drives attached to it. In the kernel config, SCSI bus asyncronous scanning (CONFIG_SCSI_SCAN_ASYNC) is enabled. The system appears to work fine so far, but these messages, together with a few errors and delays around, are a bit worrying. What the problem is, any suggestion? Complete bootup dmesg is attached. Thank you! /mjt
[ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Linux version 3.0.0-i686 (mjt@xxxxxxxxxxxxxxxxxxxxxxx) (gcc version 4.4.5 (Debian 4.4.5-8) ) #3.0.23 SMP Thu Mar 1 15:46:05 MSK 2012 [ 0.000000] BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: 0000000000000000 - 000000000009d400 (usable) [ 0.000000] BIOS-e820: 000000000009d400 - 00000000000a0000 (reserved) [ 0.000000] BIOS-e820: 00000000000e0000 - 0000000000100000 (reserved) [ 0.000000] BIOS-e820: 0000000000100000 - 000000009ffeb2c0 (usable) [ 0.000000] BIOS-e820: 000000009ffeb2c0 - 000000009fff0000 (ACPI data) [ 0.000000] BIOS-e820: 000000009fff0000 - 00000000a0000000 (reserved) [ 0.000000] BIOS-e820: 00000000fec00000 - 0000000100000000 (reserved) [ 0.000000] Notice: NX (Execute Disable) protection missing in CPU! [ 0.000000] DMI 2.3 present. [ 0.000000] DMI: IBM eserver xSeries 345 -[867052G]-/, BIOS -[GEE149AUS-1.12]- 07/14/2003 [ 0.000000] e820 update range: 0000000000000000 - 0000000000010000 (usable) ==> (reserved) [ 0.000000] e820 remove range: 00000000000a0000 - 0000000000100000 (usable) [ 0.000000] last_pfn = 0x9ffeb max_arch_pfn = 0x100000 [ 0.000000] MTRR default type: uncachable [ 0.000000] MTRR fixed ranges enabled: [ 0.000000] 00000-9FFFF write-back [ 0.000000] A0000-BFFFF uncachable [ 0.000000] C0000-CFFFF write-protect [ 0.000000] D0000-DFFFF uncachable [ 0.000000] E0000-FFFFF write-protect [ 0.000000] MTRR variable ranges enabled: [ 0.000000] 0 base 000000000 mask F80000000 write-back [ 0.000000] 1 base 080000000 mask FE0000000 write-back [ 0.000000] 2 disabled [ 0.000000] 3 disabled [ 0.000000] 4 disabled [ 0.000000] 5 disabled [ 0.000000] 6 disabled [ 0.000000] 7 disabled [ 0.000000] x86 PAT enabled: cpu 0, old 0x7040600070406, new 0x7010600070106 [ 0.000000] found SMP MP-table at [c009d540] 9d540 [ 0.000000] initial memory mapped : 0 - 01800000 [ 0.000000] Base memory trampoline at [c0099000] 99000 size 16384 [ 0.000000] init_memory_mapping: 0000000000000000-00000000377fe000 [ 0.000000] 0000000000 - 0000400000 page 4k [ 0.000000] 0000400000 - 0037400000 page 2M [ 0.000000] 0037400000 - 00377fe000 page 4k [ 0.000000] kernel direct mapping tables up to 377fe000 @ 17fb000-1800000 [ 0.000000] RAMDISK: 7fe0b000 - 7ffff000 [ 0.000000] Allocated new RAMDISK: 3760a000 - 377fd880 [ 0.000000] Move RAMDISK from 000000007fe0b000 - 000000007fffe87f to 3760a000 - 377fd87f [ 0.000000] ACPI: RSDP 000fdfc0 00014 (v00 IBM ) [ 0.000000] ACPI: RSDT 9ffeff80 00030 (v01 IBM SERONYXP 00001000 IBM 45444F43) [ 0.000000] ACPI: FACP 9ffeff00 00074 (v01 IBM SERONYXP 00001000 IBM 45444F43) [ 0.000000] ACPI: DSDT 9ffeb2c0 04A4E (v01 IBM SERGEODE 00001000 MSFT 0100000B) [ 0.000000] ACPI: FACS 9ffefe00 00040 [ 0.000000] ACPI: APIC 9ffefe40 00092 (v01 IBM SERONYXP 00001000 IBM 45444F43) [ 0.000000] ACPI: ASF! 9ffefd80 0004B (v16 IBM SERONYXP 00000001 IBM 45444F43) [ 0.000000] ACPI: Local APIC address 0xfee00000 [ 0.000000] 1671MB HIGHMEM available. [ 0.000000] 887MB LOWMEM available. [ 0.000000] mapped low ram: 0 - 377fe000 [ 0.000000] low ram: 0 - 377fe000 [ 0.000000] Zone PFN ranges: [ 0.000000] DMA 0x00000010 -> 0x00001000 [ 0.000000] Normal 0x00001000 -> 0x000377fe [ 0.000000] HighMem 0x000377fe -> 0x0009ffeb [ 0.000000] Movable zone start PFN for each node [ 0.000000] early_node_map[2] active PFN ranges [ 0.000000] 0: 0x00000010 -> 0x0000009d [ 0.000000] 0: 0x00000100 -> 0x0009ffeb [ 0.000000] On node 0 totalpages: 655224 [ 0.000000] free_area_init_node: node 0, pgdat c13eb840, node_mem_map f6209200 [ 0.000000] DMA zone: 32 pages used for memmap [ 0.000000] DMA zone: 0 pages reserved [ 0.000000] DMA zone: 3949 pages, LIFO batch:0 [ 0.000000] Normal zone: 1744 pages used for memmap [ 0.000000] Normal zone: 221486 pages, LIFO batch:31 [ 0.000000] HighMem zone: 3344 pages used for memmap [ 0.000000] HighMem zone: 424669 pages, LIFO batch:31 [ 0.000000] Using APIC driver default [ 0.000000] ACPI: PM-Timer IO Port: 0x488 [ 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[0x06] enabled) [ 0.000000] ACPI: LAPIC (acpi_id[0x02] lapic_id[0x01] enabled) [ 0.000000] ACPI: LAPIC (acpi_id[0x03] lapic_id[0x07] enabled) [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x00] dfl dfl lint[0x1]) [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x06] dfl dfl lint[0x1]) [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x01] dfl dfl lint[0x1]) [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x07] dfl dfl lint[0x1]) [ 0.000000] ACPI: IOAPIC (id[0x0e] address[0xfec00000] gsi_base[0]) [ 0.000000] IOAPIC[0]: apic_id 14, version 17, address 0xfec00000, GSI 0-15 [ 0.000000] ACPI: IOAPIC (id[0x0d] address[0xfec01000] gsi_base[16]) [ 0.000000] IOAPIC[1]: apic_id 13, version 17, address 0xfec01000, GSI 16-31 [ 0.000000] ACPI: IOAPIC (id[0x0c] address[0xfec02000] gsi_base[32]) [ 0.000000] IOAPIC[2]: apic_id 12, version 17, address 0xfec02000, GSI 32-47 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: IRQ0 used by override. [ 0.000000] ACPI: IRQ2 used by override. [ 0.000000] ACPI: IRQ7 used by override. [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] SMP: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] nr_irqs_gsi: 64 [ 0.000000] PM: Registered nosave memory: 000000000009d000 - 000000000009e000 [ 0.000000] PM: Registered nosave memory: 000000000009e000 - 00000000000a0000 [ 0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000e0000 [ 0.000000] PM: Registered nosave memory: 00000000000e0000 - 0000000000100000 [ 0.000000] Allocating PCI resources starting at a0000000 (gap: a0000000:5ec00000) [ 0.000000] Booting paravirtualized kernel on bare hardware [ 0.000000] setup_percpu: NR_CPUS:8 nr_cpumask_bits:8 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] PERCPU: Embedded 12 pages/cpu @f5c00000 s25280 r0 d23872 u1048576 [ 0.000000] pcpu-alloc: s25280 r0 d23872 u1048576 alloc=1*4194304 [ 0.000000] pcpu-alloc: [0] 0 1 2 3 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 650104 [ 0.000000] Kernel command line: panic=30 elevator=deadline ipv6.disable=1 initrd=initrd-3.0.0-i686 BOOT_IMAGE=vmlinuz-3.0.0-i686 linux-test [ 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] Initializing CPU#0 [ 0.000000] Initializing HighMem for node 0 (000377fe:0009ffeb) [ 0.000000] Memory: 2592400k/2621356k available (2976k kernel code, 28496k reserved, 1061k data, 388k init, 1712052k highmem) [ 0.000000] virtual kernel memory layout: [ 0.000000] fixmap : 0xfff16000 - 0xfffff000 ( 932 kB) [ 0.000000] pkmap : 0xff800000 - 0xffc00000 (4096 kB) [ 0.000000] vmalloc : 0xf7ffe000 - 0xff7fe000 ( 120 MB) [ 0.000000] lowmem : 0xc0000000 - 0xf77fe000 ( 887 MB) [ 0.000000] .init : 0xc13f2000 - 0xc1453000 ( 388 kB) [ 0.000000] .data : 0xc12e8162 - 0xc13f1940 (1061 kB) [ 0.000000] .text : 0xc1000000 - 0xc12e8162 (2976 kB) [ 0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok. [ 0.000000] Hierarchical RCU implementation. [ 0.000000] NR_IRQS:512 [ 0.000000] CPU 0 irqstacks, hard=f580a000 soft=f580c000 [ 0.000000] Console: colour VGA+ 80x25 [ 0.000000] console [tty0] enabled [ 0.000000] Fast TSC calibration using PIT [ 0.000000] Detected 2660.640 MHz processor. [ 0.006670] Calibrating delay loop (skipped), value calculated using timer frequency.. 5323.00 BogoMIPS (lpj=8868800) [ 0.006813] pid_max: default: 32768 minimum: 301 [ 0.006934] Security Framework initialized [ 0.007030] Mount-cache hash table entries: 512 [ 0.007323] Initializing cgroup subsys cpuacct [ 0.007406] Initializing cgroup subsys devices [ 0.007475] Initializing cgroup subsys freezer [ 0.007544] Initializing cgroup subsys net_cls [ 0.007613] Initializing cgroup subsys blkio [ 0.007727] CPU: Physical Processor ID: 0 [ 0.007794] CPU: Processor Core ID: 0 [ 0.007862] mce: CPU supports 4 MCE banks [ 0.007941] CPU0: Thermal monitoring enabled (TM1) [ 0.010156] ACPI: Core revision 20110413 [ 0.013416] Enabling APIC mode: Flat. Using 3 I/O APICs [ 0.014114] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.047752] CPU0: Intel(R) Xeon(TM) CPU 2.66GHz stepping 09 [ 0.049997] Performance Events: Netburst events, Netburst P4/Xeon PMU driver. [ 0.049997] ... version: 0 [ 0.049997] ... bit width: 40 [ 0.049997] ... generic registers: 18 [ 0.049997] ... value mask: 000000ffffffffff [ 0.049997] ... max period: 0000007fffffffff [ 0.049997] ... fixed-purpose events: 0 [ 0.049997] ... event mask: 000000000003ffff [ 0.049997] NMI watchdog enabled, takes one hw-pmu counter. [ 0.049997] CPU 1 irqstacks, hard=f5896000 soft=f5898000 [ 0.049997] Booting Node 0, Processors #1 [ 0.049997] smpboot cpu 1: start_ip = 99000 [ 0.009999] Initializing CPU#1 [ 0.143362] NMI watchdog enabled, takes one hw-pmu counter. [ 0.143666] CPU 2 irqstacks, hard=f58a8000 soft=f58aa000 [ 0.143669] #2 [ 0.143720] smpboot cpu 2: start_ip = 99000 [ 0.009999] Initializing CPU#2 [ 0.240030] NMI watchdog enabled, takes one hw-pmu counter. [ 0.240377] CPU 3 irqstacks, hard=f58d8000 soft=f58da000 [ 0.240381] #3 Ok. [ 0.240446] smpboot cpu 3: start_ip = 99000 [ 0.009999] Initializing CPU#3 [ 0.336674] NMI watchdog enabled, takes one hw-pmu counter. [ 0.336843] Brought up 4 CPUs [ 0.336913] Total of 4 processors activated (21294.45 BogoMIPS). [ 0.337915] devtmpfs: initialized [ 0.337915] NET: Registered protocol family 16 [ 0.337915] ACPI: bus type pci registered [ 0.337915] PCI: PCI BIOS revision 2.10 entry at 0xfd7dc, last bus=8 [ 0.337915] PCI: Using configuration type 1 for base access [ 0.337915] bio: create slab <bio-0> at 0 [ 0.341500] ACPI: EC: Look up EC in DSDT [ 0.344564] ACPI: Interpreter enabled [ 0.344638] ACPI: (supports S0 S4 S5) [ 0.344860] ACPI: Using IOAPIC for interrupt routing [ 0.350925] HEST: Table not found. [ 0.351001] PCI: Ignoring host bridge windows from ACPI; if necessary, use "pci=use_crs" and report a bug [ 0.352708] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-01]) [ 0.355968] pci_root PNP0A03:00: host bridge window [io 0x03c0-0x03df] (ignored) [ 0.355975] pci_root PNP0A03:00: host bridge window [io 0x03b0-0x03bb] (ignored) [ 0.355982] pci_root PNP0A03:00: host bridge window [mem 0x000a0000-0x000bffff] (ignored) [ 0.355988] pci_root PNP0A03:00: host bridge window [mem 0xfc000000-0xffffffff] (ignored) [ 0.355995] pci_root PNP0A03:00: host bridge window [io 0x03e0-0x24ff] (ignored) [ 0.356001] pci_root PNP0A03:00: host bridge window [io 0x03bc-0x03bf] (ignored) [ 0.356006] pci_root PNP0A03:00: host bridge window [io 0x0000-0x03af] (ignored) [ 0.356023] pci 0000:00:00.0: [1166:0014] type 0 class 0x000600 [ 0.356066] pci 0000:00:00.1: [1166:0014] type 0 class 0x000600 [ 0.356100] pci 0000:00:00.2: [1166:0014] type 0 class 0x000600 [ 0.356153] pci 0000:00:06.0: [1002:4752] type 0 class 0x000300 [ 0.356176] pci 0000:00:06.0: reg 10: [mem 0xfd000000-0xfdffffff] [ 0.356189] pci 0000:00:06.0: reg 14: [io 0x2400-0x24ff] [ 0.356201] pci 0000:00:06.0: reg 18: [mem 0xfebff000-0xfebfffff] [ 0.356241] pci 0000:00:06.0: reg 30: [mem 0x00000000-0x0001ffff pref] [ 0.356274] pci 0000:00:06.0: supports D1 D2 [ 0.356303] pci 0000:00:0f.0: [1166:0201] type 0 class 0x000600 [ 0.356362] pci 0000:00:0f.1: [1166:0212] type 0 class 0x000101 [ 0.356380] pci 0000:00:0f.1: reg 10: [io 0x01f0-0x01f7] [ 0.356391] pci 0000:00:0f.1: reg 14: [io 0x03f4-0x03f7] [ 0.356402] pci 0000:00:0f.1: reg 18: [io 0x0170-0x0177] [ 0.356414] pci 0000:00:0f.1: reg 1c: [io 0x0374-0x0377] [ 0.356425] pci 0000:00:0f.1: reg 20: [io 0x0700-0x070f] [ 0.356464] pci 0000:00:0f.2: [1166:0220] type 0 class 0x000c03 [ 0.356482] pci 0000:00:0f.2: reg 10: [mem 0xfebfe000-0xfebfefff] [ 0.356553] pci 0000:00:0f.3: [1166:0225] type 0 class 0x000601 [ 0.356660] pci 0000:00:10.0: [1166:0101] type 0 class 0x000600 [ 0.356725] pci 0000:00:10.2: [1166:0101] type 0 class 0x000600 [ 0.356796] pci 0000:00:11.0: [1166:0101] type 0 class 0x000600 [ 0.356860] pci 0000:00:11.2: [1166:0101] type 0 class 0x000600 [ 0.356939] pci_bus 0000:00: on NUMA node 0 [ 0.356945] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT] [ 0.357057] pci0000:00: Unable to request _OSC control (_OSC support mask: 0x1e) [ 0.359272] ACPI: PCI Root Bridge [PCI1] (domain 0000 [bus 02-03]) [ 0.359838] pci_bus 0000:02: on NUMA node 0 [ 0.359842] ACPI: PCI Interrupt Routing Table [\_SB_.PCI1._PRT] [ 0.359897] pci0000:02: Unable to request _OSC control (_OSC support mask: 0x1e) [ 0.360441] ACPI: PCI Root Bridge [PCI2] (domain 0000 [bus 04-05]) [ 0.361006] pci_bus 0000:04: on NUMA node 0 [ 0.361010] ACPI: PCI Interrupt Routing Table [\_SB_.PCI2._PRT] [ 0.361065] pci0000:04: Unable to request _OSC control (_OSC support mask: 0x1e) [ 0.362036] ACPI: PCI Root Bridge [PCI3] (domain 0000 [bus 06-07]) [ 0.363904] pci_root PNP0A03:03: host bridge window [mem 0xfa000000-0xfbffffff] (ignored) [ 0.363912] pci_root PNP0A03:03: host bridge window [io 0x2500-0x257f] (ignored) [ 0.363942] pci 0000:06:08.0: [8086:1010] type 0 class 0x000200 [ 0.363967] pci 0000:06:08.0: reg 10: [mem 0xfbfe0000-0xfbffffff 64bit] [ 0.363990] pci 0000:06:08.0: reg 20: [io 0x2500-0x253f] [ 0.364044] pci 0000:06:08.0: PME# supported from D0 D3hot D3cold [ 0.364051] pci 0000:06:08.0: PME# disabled [ 0.364079] pci 0000:06:08.1: [8086:1010] type 0 class 0x000200 [ 0.364104] pci 0000:06:08.1: reg 10: [mem 0xfbfc0000-0xfbfdffff 64bit] [ 0.364127] pci 0000:06:08.1: reg 20: [io 0x2540-0x257f] [ 0.364178] pci 0000:06:08.1: PME# supported from D0 D3hot D3cold [ 0.364185] pci 0000:06:08.1: PME# disabled [ 0.364226] pci_bus 0000:06: on NUMA node 0 [ 0.364230] ACPI: PCI Interrupt Routing Table [\_SB_.PCI3._PRT] [ 0.364296] pci0000:06: Unable to request _OSC control (_OSC support mask: 0x1e) [ 0.365362] ACPI: PCI Root Bridge [PCI4] (domain 0000 [bus 08]) [ 0.367203] pci_root PNP0A03:04: host bridge window [mem 0xf8000000-0xf9ffffff] (ignored) [ 0.367210] pci_root PNP0A03:04: host bridge window [io 0x2580-0xffff] (ignored) [ 0.367239] pci 0000:08:07.0: [1000:0030] type 0 class 0x000100 [ 0.367262] pci 0000:08:07.0: reg 10: [io 0x2600-0x26ff] [ 0.367276] pci 0000:08:07.0: reg 14: [mem 0xf9ff0000-0xf9ffffff 64bit] [ 0.367290] pci 0000:08:07.0: reg 1c: [mem 0xf9fe0000-0xf9feffff 64bit] [ 0.367307] pci 0000:08:07.0: reg 30: [mem 0x00000000-0x000fffff pref] [ 0.367346] pci 0000:08:07.0: supports D1 D2 [ 0.367375] pci 0000:08:07.1: [1000:0030] type 0 class 0x000100 [ 0.367397] pci 0000:08:07.1: reg 10: [io 0x2700-0x27ff] [ 0.367411] pci 0000:08:07.1: reg 14: [mem 0xf9fd0000-0xf9fdffff 64bit] [ 0.367425] pci 0000:08:07.1: reg 1c: [mem 0xf9fc0000-0xf9fcffff 64bit] [ 0.367442] pci 0000:08:07.1: reg 30: [mem 0x00000000-0x000fffff pref] [ 0.367480] pci 0000:08:07.1: supports D1 D2 [ 0.367524] pci_bus 0000:08: on NUMA node 0 [ 0.367528] ACPI: PCI Interrupt Routing Table [\_SB_.PCI4._PRT] [ 0.367594] pci0000:08: Unable to request _OSC control (_OSC support mask: 0x1e) [ 0.367916] ACPI: PCI Interrupt Link [LP00] (IRQs) *0, disabled. [ 0.368293] ACPI: PCI Interrupt Link [LP01] (IRQs) *0, disabled. [ 0.368668] ACPI: PCI Interrupt Link [LP02] (IRQs) *0, disabled. [ 0.369044] ACPI: PCI Interrupt Link [LP03] (IRQs) *0, disabled. [ 0.369418] ACPI: PCI Interrupt Link [LP04] (IRQs) *0, disabled. [ 0.369791] ACPI: PCI Interrupt Link [LP05] (IRQs) *0, disabled. [ 0.370173] ACPI: PCI Interrupt Link [LP06] (IRQs) *0, disabled. [ 0.370547] ACPI: PCI Interrupt Link [LP07] (IRQs) *0, disabled. [ 0.370923] ACPI: PCI Interrupt Link [LP08] (IRQs) *0, disabled. [ 0.371300] ACPI: PCI Interrupt Link [LP09] (IRQs) *0, disabled. [ 0.371680] ACPI: PCI Interrupt Link [LP0A] (IRQs *11) [ 0.372009] ACPI: PCI Interrupt Link [LP0B] (IRQs *9) [ 0.372340] ACPI: PCI Interrupt Link [LP0C] (IRQs *10) [ 0.372668] ACPI: PCI Interrupt Link [LP0D] (IRQs *4) [ 0.372996] ACPI: PCI Interrupt Link [LP0E] (IRQs *5) [ 0.373357] ACPI: PCI Interrupt Link [LP0F] (IRQs) *0, disabled. [ 0.373732] ACPI: PCI Interrupt Link [LP10] (IRQs) *0, disabled. [ 0.374108] ACPI: PCI Interrupt Link [LP11] (IRQs) *0, disabled. [ 0.374482] ACPI: PCI Interrupt Link [LP12] (IRQs) *0, disabled. [ 0.374855] ACPI: PCI Interrupt Link [LP13] (IRQs) *0, disabled. [ 0.375232] ACPI: PCI Interrupt Link [LP14] (IRQs) *0, disabled. [ 0.375607] ACPI: PCI Interrupt Link [LP15] (IRQs) *0, disabled. [ 0.375983] ACPI: PCI Interrupt Link [LP16] (IRQs) *0, disabled. [ 0.376356] ACPI: PCI Interrupt Link [LP17] (IRQs) *0, disabled. [ 0.376745] ACPI: PCI Interrupt Link [LP18] (IRQs) *0, disabled. [ 0.377122] ACPI: PCI Interrupt Link [LP19] (IRQs) *0, disabled. [ 0.377497] ACPI: PCI Interrupt Link [LP1A] (IRQs) *0, disabled. [ 0.377870] ACPI: PCI Interrupt Link [LP1B] (IRQs) *0, disabled. [ 0.378243] ACPI: PCI Interrupt Link [LP1C] (IRQs) *0, disabled. [ 0.378617] ACPI: PCI Interrupt Link [LP1D] (IRQs) *0, disabled. [ 0.378994] ACPI: PCI Interrupt Link [LP1E] (IRQs) *0, disabled. [ 0.379369] ACPI: PCI Interrupt Link [LP1F] (IRQs) *0, disabled. [ 0.380106] ACPI: PCI Interrupt Link [LPUS] (IRQs *3) [ 0.380434] vgaarb: device added: PCI:0000:00:06.0,decodes=io+mem,owns=io+mem,locks=none [ 0.380539] vgaarb: loaded [ 0.380605] vgaarb: bridge control possible 0000:00:06.0 [ 0.380723] PCI: Using ACPI for IRQ routing [ 0.380916] PCI: pci_cache_line_size set to 64 bytes [ 0.380997] reserve RAM buffer: 000000000009d400 - 000000000009ffff [ 0.381001] reserve RAM buffer: 000000009ffeb2c0 - 000000009fffffff [ 0.384404] pnp: PnP ACPI init [ 0.384497] ACPI: bus type pnp registered [ 0.386202] pnp 00:00: [io 0x03c0-0x03df window] [ 0.386206] pnp 00:00: [io 0x03b0-0x03bb window] [ 0.386210] pnp 00:00: [mem 0x000a0000-0x000bffff window] [ 0.386214] pnp 00:00: [bus 00-01] [ 0.386217] pnp 00:00: [mem 0xfc000000-0xffffffff window] [ 0.386221] pnp 00:00: [io 0x03e0-0x24ff window] [ 0.386224] pnp 00:00: [io 0x03bc-0x03bf window] [ 0.386228] pnp 00:00: [io 0x0000-0x03af window] [ 0.386318] pnp 00:00: Plug and Play ACPI device, IDs PNP0a03 (active) [ 0.387195] pnp 00:01: [io 0x0510-0x0517] [ 0.387199] pnp 00:01: [io 0x0504-0x0507] [ 0.387202] pnp 00:01: [io 0x0500-0x0503] [ 0.387205] pnp 00:01: [io 0x0420-0x0427] [ 0.387211] pnp 00:01: [io 0x0460-0x0461] [ 0.387214] pnp 00:01: [io 0x002e-0x002f] [ 0.387289] system 00:01: [io 0x0510-0x0517] has been reserved [ 0.387366] system 00:01: [io 0x0504-0x0507] has been reserved [ 0.387441] system 00:01: [io 0x0500-0x0503] has been reserved [ 0.387513] system 00:01: [io 0x0420-0x0427] has been reserved [ 0.387586] system 00:01: [io 0x0460-0x0461] has been reserved [ 0.387659] system 00:01: Plug and Play ACPI device, IDs PNP0c02 (active) [ 0.387747] pnp 00:02: Plug and Play ACPI device, IDs PNP0303 (active) [ 0.387884] pnp 00:03: [irq 12] [ 0.387925] pnp 00:03: Plug and Play ACPI device, IDs PNP0f13 (active) [ 0.388268] pnp 00:04: [dma 2] [ 0.388275] pnp 00:04: [irq 6] [ 0.388280] pnp 00:04: [io 0x03f0-0x03f5] [ 0.388330] pnp 00:04: Plug and Play ACPI device, IDs PNP0700 (active) [ 0.388417] pnp 00:05: [io 0x0020-0x0021] [ 0.388421] pnp 00:05: [io 0x00a0-0x00a1] [ 0.388467] pnp 00:05: Plug and Play ACPI device, IDs PNP0003 (active) [ 0.388492] pnp 00:06: [dma 4] [ 0.388495] pnp 00:06: [io 0x0000-0x001f] [ 0.388499] pnp 00:06: [io 0x0080-0x008f] [ 0.388501] pnp 00:06: [io 0x00c0-0x00df] [ 0.388536] pnp 00:06: Plug and Play ACPI device, IDs PNP0200 (active) [ 0.388570] pnp 00:07: [io 0x0070-0x0073] [ 0.388576] pnp 00:07: [irq 8] [ 0.388613] pnp 00:07: Plug and Play ACPI device, IDs PNP0b00 (active) [ 0.388636] pnp 00:08: [io 0x0061] [ 0.388674] pnp 00:08: Plug and Play ACPI device, IDs PNP0800 (active) [ 0.388697] pnp 00:09: [io 0x00f0-0x00ff] [ 0.388704] pnp 00:09: [irq 13] [ 0.388743] pnp 00:09: Plug and Play ACPI device, IDs PNP0c04 (active) [ 0.388769] pnp 00:0a: [io 0x0092] [ 0.388772] pnp 00:0a: [io 0x00eb-0x00ec] [ 0.388775] pnp 00:0a: [io 0x01ec-0x01ef] [ 0.388778] pnp 00:0a: [io 0x0400-0x04fe] [ 0.388781] pnp 00:0a: [io 0x0600] [ 0.388784] pnp 00:0a: [io 0x0800-0x080f] [ 0.388787] pnp 00:0a: [io 0x0c00-0x0cfe] [ 0.388790] pnp 00:0a: [io 0x0f50-0x0f58] [ 0.388793] pnp 00:0a: [mem 0xfec00000-0xffffffff] [ 0.388858] system 00:0a: [io 0x01ec-0x01ef] has been reserved [ 0.388934] system 00:0a: [io 0x0400-0x04fe] could not be reserved [ 0.389008] system 00:0a: [io 0x0600] has been reserved [ 0.389082] system 00:0a: [io 0x0800-0x080f] has been reserved [ 0.389154] system 00:0a: [io 0x0c00-0x0cfe] could not be reserved [ 0.389228] system 00:0a: [io 0x0f50-0x0f58] has been reserved [ 0.389302] system 00:0a: [mem 0xfec00000-0xffffffff] could not be reserved [ 0.389377] system 00:0a: Plug and Play ACPI device, IDs PNP0c02 (active) [ 0.389860] pnp 00:0b: [bus 02-03] [ 0.389927] pnp 00:0b: Plug and Play ACPI device, IDs PNP0a03 (active) [ 0.390395] pnp 00:0c: [bus 04-05] [ 0.390456] pnp 00:0c: Plug and Play ACPI device, IDs PNP0a03 (active) [ 0.391312] pnp 00:0d: [bus 06-07] [ 0.391317] pnp 00:0d: [mem 0xfa000000-0xfbffffff window] [ 0.391321] pnp 00:0d: [io 0x2500-0x257f window] [ 0.391383] pnp 00:0d: Plug and Play ACPI device, IDs PNP0a03 (active) [ 0.392240] pnp 00:0e: [bus 08] [ 0.392245] pnp 00:0e: [mem 0xf8000000-0xf9ffffff window] [ 0.392248] pnp 00:0e: [io 0x2580-0xffff window] [ 0.392306] pnp 00:0e: Plug and Play ACPI device, IDs PNP0a03 (active) [ 0.393184] pnp: PnP ACPI: found 15 devices [ 0.393254] ACPI: ACPI bus type pnp unregistered [ 0.393317] PnPBIOS: Disabled by ACPI PNP [ 0.430257] Switching to clocksource acpi_pm [ 0.430336] PCI: max bus depth: 0 pci_try_num: 1 [ 0.430336] pci 0000:00:06.0: BAR 6: assigned [mem 0xa0000000-0xa001ffff pref] [ 0.430336] pci 0000:08:07.0: BAR 6: assigned [mem 0xa0100000-0xa01fffff pref] [ 0.430336] pci 0000:08:07.1: BAR 6: assigned [mem 0xa0200000-0xa02fffff pref] [ 0.430336] pci_bus 0000:00: resource 0 [io 0x0000-0xffff] [ 0.430336] pci_bus 0000:00: resource 1 [mem 0x00000000-0xffffffff] [ 0.430336] pci_bus 0000:02: resource 0 [io 0x0000-0xffff] [ 0.430339] pci_bus 0000:02: resource 1 [mem 0x00000000-0xffffffff] [ 0.430343] pci_bus 0000:04: resource 0 [io 0x0000-0xffff] [ 0.430346] pci_bus 0000:04: resource 1 [mem 0x00000000-0xffffffff] [ 0.430350] pci_bus 0000:06: resource 0 [io 0x0000-0xffff] [ 0.430353] pci_bus 0000:06: resource 1 [mem 0x00000000-0xffffffff] [ 0.430357] pci_bus 0000:08: resource 0 [io 0x0000-0xffff] [ 0.430360] pci_bus 0000:08: resource 1 [mem 0x00000000-0xffffffff] [ 0.430485] NET: Registered protocol family 2 [ 0.430652] IP route cache hash table entries: 32768 (order: 5, 131072 bytes) [ 0.431035] TCP established hash table entries: 131072 (order: 8, 1048576 bytes) [ 0.431971] TCP bind hash table entries: 65536 (order: 7, 524288 bytes) [ 0.432554] TCP: Hash tables configured (established 131072 bind 65536) [ 0.432633] TCP reno registered [ 0.432706] UDP hash table entries: 512 (order: 2, 16384 bytes) [ 0.432794] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes) [ 0.433014] Switched to NOHz mode on CPU #0 [ 0.433024] Switched to NOHz mode on CPU #3 [ 0.433068] Switched to NOHz mode on CPU #1 [ 0.433083] Switched to NOHz mode on CPU #2 [ 0.433473] NET: Registered protocol family 1 [ 0.433570] pci 0000:00:06.0: Boot video device [ 0.433575] PCI: CLS mismatch (64 != 32), using 64 bytes [ 0.433764] ACPI: PCI Interrupt Link [LPUS] enabled at IRQ 3 [ 0.433851] pci 0000:00:0f.2: PCI INT A -> Link[LPUS] -> GSI 3 (level, low) -> IRQ 3 [ 0.500033] pci 0000:00:0f.2: PCI INT A disabled [ 0.500203] Unpacking initramfs... [ 1.003988] Freeing initrd memory: 2000k freed [ 1.006578] audit: initializing netlink socket (disabled) [ 1.006710] type=2000 audit(1330858318.006:1): initialized [ 1.014499] highmem bounce pool size: 64 pages [ 1.014579] HugeTLB registered 4 MB page size, pre-allocated 0 pages [ 1.029699] VFS: Disk quotas dquot_6.5.2 [ 1.029824] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) [ 1.030034] msgmni has been set to 1723 [ 1.030201] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253) [ 1.030294] io scheduler noop registered [ 1.030361] io scheduler deadline registered (default) [ 1.030458] io scheduler cfq registered [ 1.030689] ERST: Table is not found! [ 1.030778] isapnp: Scanning for PnP cards... [ 1.387854] isapnp: No Plug & Play device found [ 1.388033] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 1.577223] i8042: PNP: PS/2 Controller [PNP0303:PS2K,PNP0f13:PS2M] at 0x0,0x0 irq 0,12 [ 1.577317] i8042: PNP: PS/2 controller has invalid data port 0x0; using default 0x60 [ 1.577406] i8042: PNP: PS/2 controller has invalid command port 0x0; using default 0x64 [ 1.577496] i8042: PNP: PS/2 controller doesn't have KBD irq; using default 1 [ 1.579279] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 1.579360] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 1.579537] mousedev: PS/2 mouse device common for all mice [ 1.579691] input: PC Speaker as /devices/platform/pcspkr/input/input0 [ 1.579956] rtc_cmos 00:07: rtc core: registered rtc_cmos as rtc0 [ 1.580092] rtc0: alarms up to one year, 242 bytes nvram [ 1.580179] cpuidle: using governor ladder [ 1.580248] cpuidle: using governor menu [ 1.580452] TCP cubic registered [ 1.580521] NET: Registered protocol family 17 [ 1.580598] Registering the dns_resolver key type [ 1.580699] Using IPI No-Shortcut mode [ 1.580896] registered taskstats version 1 [ 1.588621] rtc_cmos 00:07: setting system clock to 2012-03-04 10:51:58 UTC (1330858318) [ 1.588875] Freeing unused kernel memory: 388k freed [ 1.592065] Processing INITRAMFS [ 1.600372] loading module sd_mod [ 1.605254] SCSI subsystem initialized [ 1.606296] loading module usbhid [ 1.610663] usbcore: registered new interface driver usbfs [ 1.610784] usbcore: registered new interface driver hub [ 1.610999] usbcore: registered new device driver usb [ 1.612559] usbcore: registered new interface driver usbhid [ 1.612636] usbhid: USB HID core driver [ 1.755458] libata version 3.00 loaded. [ 1.761744] scsi0 : pata_serverworks [ 1.763847] scsi1 : pata_serverworks [ 1.764462] ata1: PATA max UDMA/100 cmd 0x1f0 ctl 0x3f6 bmdma 0x700 irq 14 [ 1.764551] ata2: PATA max UDMA/100 cmd 0x170 ctl 0x376 bmdma 0x708 irq 15 [ 1.940382] ata1.00: ATAPI: LG CD-ROM CRN-8245B, 1.16, max UDMA/33 [ 1.970368] ata1.00: configured for UDMA/33 [ 1.972200] scsi 0:0:0:0: CD-ROM LG CD-ROM CRN-8245B 1.16 PQ: 0 ANSI: 5 [ 2.016707] Refined TSC clocksource calibration: 2660.836 MHz. [ 2.016789] Switching to clocksource tsc [ 2.130653] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 2.130800] ohci_hcd 0000:00:0f.2: PCI INT A -> Link[LPUS] -> GSI 3 (level, low) -> IRQ 3 [ 2.130936] ohci_hcd 0000:00:0f.2: OHCI Host Controller [ 2.131069] ohci_hcd 0000:00:0f.2: new USB bus registered, assigned bus number 1 [ 2.131204] ohci_hcd 0000:00:0f.2: irq 3, io mem 0xfebfe000 [ 2.185419] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001 [ 2.185499] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 2.185589] usb usb1: Product: OHCI Host Controller [ 2.185658] usb usb1: Manufacturer: Linux 3.0.0-i686 ohci_hcd [ 2.185730] usb usb1: SerialNumber: 0000:00:0f.2 [ 2.186405] hub 1-0:1.0: USB hub found [ 2.186497] hub 1-0:1.0: 4 ports detected [ 2.200670] e1000: Intel(R) PRO/1000 Network Driver - version 7.3.21-k8-NAPI [ 2.200758] e1000: Copyright (c) 1999-2006 Intel Corporation. [ 2.200888] e1000 0000:06:08.0: PCI INT A -> GSI 29 (level, low) -> IRQ 29 [ 2.503548] e1000 0000:06:08.0: eth0: (PCI-X:100MHz:64-bit) 00:0d:60:19:14:1c [ 2.503649] e1000 0000:06:08.0: eth0: Intel(R) PRO/1000 Network Connection [ 2.503788] e1000 0000:06:08.1: PCI INT B -> GSI 30 (level, low) -> IRQ 30 [ 2.806894] e1000 0000:06:08.1: eth1: (PCI-X:100MHz:64-bit) 00:0d:60:19:14:1d [ 2.806993] e1000 0000:06:08.1: eth1: Intel(R) PRO/1000 Network Connection [ 2.814642] Fusion MPT base driver 3.04.19 [ 2.814732] Copyright (c) 1999-2008 LSI Corporation [ 2.816841] Fusion MPT SPI Host driver 3.04.19 [ 2.817022] mptspi 0000:08:07.0: PCI INT A -> GSI 27 (level, low) -> IRQ 27 [ 2.817314] mptbase: ioc0: Initiating bringup [ 3.230016] ioc0: LSI53C1030 B2: Capabilities={Initiator} [ 4.120665] scsi2 : ioc0: LSI53C1030 B2, FwRev=01000e00h, Ports=1, MaxQ=222, IRQ=27 [ 4.489143] mptspi 0000:08:07.1: PCI INT B -> GSI 28 (level, low) -> IRQ 28 [ 4.489361] mptbase: ioc1: Initiating bringup [ 19.486696] mptbase: ioc0: WARNING - Issuing Reset from mpt_config!!, doorbell=0x24000000 [ 20.126685] mptbase: ioc0: Attempting Retry Config request type 0x4, page 0x1, action 2 [ 20.126831] mptbase: ioc0: Retry completed ret=0x0 timeleft=4500 [ 20.127697] scsi 2:0:0:0: Direct-Access IBM-ESXS DTN073C3UCDY10FN S25J PQ: 0 ANSI: 3 [ 20.127805] scsi target2:0:0: Beginning Domain Validation [ 20.138358] scsi target2:0:0: Ending Domain Validation [ 20.138485] scsi target2:0:0: FAST-160 WIDE SCSI 320.0 MB/s DT IU QAS HMCS (6.25 ns, offset 127) [ 20.139657] scsi 2:0:1:0: Direct-Access IBM-ESXS DTN073C3UCDY10FN S27M PQ: 0 ANSI: 3 [ 20.139757] scsi target2:0:1: Beginning Domain Validation [ 20.150181] scsi target2:0:1: Ending Domain Validation [ 20.150308] scsi target2:0:1: FAST-160 WIDE SCSI 320.0 MB/s DT IU QAS HMCS (6.25 ns, offset 127) [ 20.151467] scsi 2:0:2:0: Direct-Access IBM-ESXS DTN073C3UCDY10FN S27M PQ: 0 ANSI: 3 [ 20.151568] scsi target2:0:2: Beginning Domain Validation [ 20.161983] scsi target2:0:2: Ending Domain Validation [ 20.162111] scsi target2:0:2: FAST-160 WIDE SCSI 320.0 MB/s DT IU QAS HMCS (6.25 ns, offset 127) [ 20.163285] scsi 2:0:3:0: Direct-Access IBM-ESXS DTN073C3UCDY10FN S27M PQ: 0 ANSI: 3 [ 20.163399] scsi target2:0:3: Beginning Domain Validation [ 20.173803] scsi target2:0:3: Ending Domain Validation [ 20.173932] scsi target2:0:3: FAST-160 WIDE SCSI 320.0 MB/s DT IU QAS HMCS (6.25 ns, offset 127) [ 20.177932] scsi 2:0:4:0: Direct-Access IBM-ESXS MAW3073NC FN C206 PQ: 0 ANSI: 4 [ 20.178036] scsi target2:0:4: Beginning Domain Validation [ 20.197999] scsi target2:0:4: Ending Domain Validation [ 20.198126] scsi target2:0:4: FAST-160 WIDE SCSI 320.0 MB/s DT IU HMCS (6.25 ns, offset 127) [ 20.699166] scsi 2:0:8:0: Processor IBM 32P0032a S320 1 1 PQ: 0 ANSI: 2 [ 20.699271] scsi target2:0:8: Beginning Domain Validation [ 20.701305] scsi target2:0:8: Ending Domain Validation [ 20.701433] scsi target2:0:8: asynchronous [ 22.455641] sd 2:0:0:0: [sda] 143374000 512-byte logical blocks: (73.4 GB/68.3 GiB) [ 22.456769] sd 2:0:0:0: [sda] Write Protect is off [ 22.456884] sd 2:0:0:0: [sda] Mode Sense: cb 00 00 08 [ 22.458039] sd 2:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA [ 22.461351] sd 2:0:1:0: [sdb] 143374000 512-byte logical blocks: (73.4 GB/68.3 GiB) [ 22.462396] sd 2:0:1:0: [sdb] Write Protect is off [ 22.462513] sd 2:0:1:0: [sdb] Mode Sense: cb 00 00 08 [ 22.463600] sd 2:0:1:0: [sdb] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA [ 22.466840] sd 2:0:2:0: [sdc] 143374000 512-byte logical blocks: (73.4 GB/68.3 GiB) [ 22.467968] sd 2:0:2:0: [sdc] Write Protect is off [ 22.468057] sd 2:0:2:0: [sdc] Mode Sense: cb 00 00 08 [ 22.469469] sd 2:0:2:0: [sdc] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA [ 22.471825] sd 2:0:3:0: [sdd] 143374000 512-byte logical blocks: (73.4 GB/68.3 GiB) [ 22.472990] sd 2:0:3:0: [sdd] Write Protect is off [ 22.473079] sd 2:0:3:0: [sdd] Mode Sense: cb 00 00 08 [ 22.474481] sd 2:0:3:0: [sdd] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA [ 22.478704] sd 2:0:4:0: [sde] 143374000 512-byte logical blocks: (73.4 GB/68.3 GiB) [ 22.481389] sd 2:0:4:0: [sde] Write Protect is off [ 22.481484] sd 2:0:4:0: [sde] Mode Sense: cf 00 00 08 [ 22.482867] sd 2:0:4:0: [sde] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA [ 22.488021] sda: sda1 sda2 sda3 sda4 < sda5 sda6 sda7 > [ 22.495096] sdb: sdb1 sdb2 sdb3 sdb4 < sdb5 sdb6 sdb7 > [ 22.497675] sd 2:0:0:0: [sda] Attached SCSI disk [ 22.500312] sdd: sdd1 sdd2 sdd3 sdd4 < sdd5 sdd6 sdd7 > [ 22.506406] sdc: sdc1 sdc2 sdc3 sdc4 < sdc5 sdc6 sdc7 > [ 22.508003] sde: sde1 sde2 sde3 sde4 < sde5 sde6 sde7 > [ 22.586994] sd 2:0:1:0: [sdb] Attached SCSI disk [ 22.604075] sd 2:0:3:0: [sdd] Attached SCSI disk [ 22.635177] ------------[ cut here ]------------ [ 22.635290] WARNING: at block/genhd.c:1474 __disk_unblock_events+0xe1/0xf0() [ 22.635371] Hardware name: eserver xSeries 345 -[867052G]- [ 22.635448] Modules linked in: mptspi(+) mptscsih mptbase scsi_transport_spi e1000 ohci_hcd pata_serverworks libata usbhid hid usbcore sd_mod scsi_mod crc_t10dif [ 22.636260] Pid: 271, comm: blkid Not tainted 3.0.0-i686 #3.0.23 [ 22.636334] Call Trace: [ 22.636407] [<c1040118>] ? warn_slowpath_common+0x78/0xb0 [ 22.636482] [<c1188d81>] ? __disk_unblock_events+0xe1/0xf0 [ 22.636556] [<c1188d81>] ? __disk_unblock_events+0xe1/0xf0 [ 22.636631] [<c104016b>] ? warn_slowpath_null+0x1b/0x20 [ 22.636705] [<c1188d81>] ? __disk_unblock_events+0xe1/0xf0 [ 22.636783] [<c1124f57>] ? __blkdev_get+0x157/0x3c0 [ 22.636856] [<c1125203>] ? blkdev_get+0x43/0x2b0 [ 22.636931] [<c11616b0>] ? security_dentry_open+0x70/0x80 [ 22.637006] [<c11245f8>] ? bd_acquire+0x28/0xc0 [ 22.637080] [<c10f70c8>] ? __dentry_open+0x118/0x2b0 [ 22.637154] [<c10f7348>] ? nameidata_to_filp+0x68/0x70 [ 22.637228] [<c1125470>] ? blkdev_get+0x2b0/0x2b0 [ 22.637302] [<c110429d>] ? do_last+0xcd/0x820 [ 22.637375] [<c10fa48b>] ? get_empty_filp+0x11b/0x1d0 [ 22.637449] [<c1105601>] ? path_openat+0xa1/0x370 [ 22.637523] [<c11059b4>] ? do_filp_open+0x34/0x90 [ 22.637597] [<c10464c1>] ? irq_exit+0x31/0xa0 [ 22.637672] [<c12e69d2>] ? call_function_interrupt+0x2a/0x30 [ 22.637746] [<c10f6cce>] ? do_sys_open+0xee/0x1c0 [ 22.637820] [<c10f6e1c>] ? sys_open+0x2c/0x40 [ 22.637892] [<c12e70d8>] ? sysenter_do_call+0x12/0x28 [ 22.637963] ---[ end trace 9071b164502805fa ]--- [ 22.645185] sd 2:0:2:0: [sdc] Attached SCSI disk [ 22.659254] sd 2:0:4:0: [sde] Attached SCSI disk [ 34.493348] mptbase: ioc1: ERROR - Wait IOC_READY state (0x20000000) timeout(15)! [ 38.883345] ioc1: LSI53C1030 B2: Capabilities={Initiator} [ 39.283343] ioc0: LSI53C1030 B2: Capabilities={Initiator} [ 40.567328] scsi3 : ioc1: LSI53C1030 B2, FwRev=01000e00h, Ports=1, MaxQ=222, IRQ=28 [ 41.087234] configuring raid array md1 [ 41.089401] mdadm: sending ioctl 800c0910 to a partition! [ 41.089480] mdadm: sending ioctl 800c0910 to a partition! [ 41.089567] mdadm: sending ioctl 1261 to a partition! [ 41.089638] mdadm: sending ioctl 1261 to a partition! [ 41.106558] mdadm: sending ioctl 1261 to a partition! [ 41.106630] mdadm: sending ioctl 1261 to a partition! [ 41.108013] mdadm: sending ioctl 1261 to a partition! [ 41.108084] mdadm: sending ioctl 1261 to a partition! [ 41.108832] mdadm: sending ioctl 1261 to a partition! [ 41.108903] mdadm: sending ioctl 1261 to a partition! [ 41.485564] md: md1 stopped. [ 41.623942] md: bind<sdb1> [ 41.627272] md: bind<sdc1> [ 41.636989] md: bind<sdd1> [ 41.690496] md: bind<sde1> [ 41.759812] md: bind<sda1> [ 41.763241] md: raid1 personality registered for level 1 [ 41.763610] bio: create slab <bio-1> at 1 [ 41.763853] md/raid1:md1: active with 5 out of 5 mirrors [ 41.763978] md1: detected capacity change from 0 to 263061504 [ 41.764407] mdadm: /dev/md1 has been started with 5 drives. [ 41.765219] mounting ext4 fs on /dev/md1 (options: relatime,nodiratime,data=ordered) [ 41.798356] md1: unknown partition table [ 41.868159] EXT4-fs (md1): warning: checktime reached, running e2fsck is recommended [ 41.990762] EXT4-fs (md1): mounted filesystem with ordered data mode. Opts: data=ordered [ 42.155948] mount: mounting /run on /root/run failed: No such file or directory [ 44.708416] EXT4-fs (md1): re-mounted. Opts: (null) [ 57.520667] EXT4-fs (md1): re-mounted. Opts: data=ordered [ 57.777857] scsi_verify_blk_ioctl: 224 callbacks suppressed [ 57.777935] mdadm: sending ioctl 800c0910 to a partition! [ 57.778007] mdadm: sending ioctl 800c0910 to a partition! [ 57.778092] mdadm: sending ioctl 1261 to a partition! [ 57.778162] mdadm: sending ioctl 1261 to a partition! [ 57.796934] mdadm: sending ioctl 1261 to a partition! [ 57.797007] mdadm: sending ioctl 1261 to a partition! [ 57.798379] mdadm: sending ioctl 1261 to a partition! [ 57.798450] mdadm: sending ioctl 1261 to a partition! [ 57.811598] mdadm: sending ioctl 1261 to a partition! [ 57.811670] mdadm: sending ioctl 1261 to a partition! [ 58.614204] md: md2 stopped. [ 58.663890] md: bind<sdb2> [ 58.665318] md: bind<sdc2> [ 58.666644] md: bind<sdd2> [ 58.669065] md: bind<sde2> [ 58.670420] md: bind<sda2> [ 58.833384] raid6: int32x1 731 MB/s [ 58.890028] raid6: int32x2 905 MB/s [ 58.946721] raid6: int32x4 862 MB/s [ 59.003434] raid6: int32x8 567 MB/s [ 59.060022] raid6: mmxx1 2200 MB/s [ 59.116679] raid6: mmxx2 2763 MB/s [ 59.173374] raid6: sse1x1 1498 MB/s [ 59.230029] raid6: sse1x2 2442 MB/s [ 59.286676] raid6: sse2x1 2968 MB/s [ 59.343340] raid6: sse2x2 2997 MB/s [ 59.343409] raid6: using algorithm sse2x2 (2997 MB/s) [ 59.363383] xor: automatically using best checksumming function: pIII_sse [ 59.380002] pIII_sse : 3386.400 MB/sec [ 59.380074] xor: using function: pIII_sse (3386.400 MB/sec) [ 59.432762] md: raid6 personality registered for level 6 [ 59.432847] md: raid5 personality registered for level 5 [ 59.432922] md: raid4 personality registered for level 4 [ 59.433280] md/raid:md2: device sda2 operational as raid disk 0 [ 59.433423] md/raid:md2: device sde2 operational as raid disk 4 [ 59.433505] md/raid:md2: device sdd2 operational as raid disk 3 [ 59.433591] md/raid:md2: device sdc2 operational as raid disk 2 [ 59.433676] md/raid:md2: device sdb2 operational as raid disk 1 [ 59.434627] md/raid:md2: allocated 5265kB [ 59.434783] md/raid:md2: raid level 5 active with 5 out of 5 devices, algorithm 2 [ 59.434873] RAID conf printout: [ 59.434876] --- level:5 rd:5 wd:5 [ 59.434879] disk 0, o:1, dev:sda2 [ 59.434882] disk 1, o:1, dev:sdb2 [ 59.434885] disk 2, o:1, dev:sdc2 [ 59.434888] disk 3, o:1, dev:sdd2 [ 59.434891] disk 4, o:1, dev:sde2 [ 59.435241] created bitmap (1 pages) for device md2 [ 59.435679] md2: bitmap initialized from disk: read 1/1 pages, set 0 of 2040 bits [ 59.447002] md2: detected capacity change from 0 to 4276617216 [ 59.450131] md2: unknown partition table [ 59.624321] md: md3 stopped. [ 59.635243] md: bind<sdb3> [ 59.636578] md: bind<sdc3> [ 59.637967] md: bind<sdd3> [ 59.640357] md: bind<sde3> [ 59.641749] md: bind<sda3> [ 59.659807] md: raid10 personality registered for level 10 [ 59.661696] md/raid10:md3: active with 5 out of 5 devices [ 59.661818] md3: detected capacity change from 0 to 2672558080 [ 59.668310] md3: unknown partition table [ 59.770927] md: md5 stopped. [ 59.790201] md: bind<sdb5> [ 59.791551] md: bind<sdc5> [ 59.792843] md: bind<sdd5> [ 59.795230] md: bind<sde5> [ 59.796582] md: bind<sda5> [ 59.798759] md/raid:md5: device sda5 operational as raid disk 0 [ 59.798834] md/raid:md5: device sde5 operational as raid disk 4 [ 59.798907] md/raid:md5: device sdd5 operational as raid disk 3 [ 59.798979] md/raid:md5: device sdc5 operational as raid disk 2 [ 59.799051] md/raid:md5: device sdb5 operational as raid disk 1 [ 59.799896] md/raid:md5: allocated 5265kB [ 59.800108] md/raid:md5: raid level 5 active with 5 out of 5 devices, algorithm 2 [ 59.800198] RAID conf printout: [ 59.800201] --- level:5 rd:5 wd:5 [ 59.800205] disk 0, o:1, dev:sda5 [ 59.800208] disk 1, o:1, dev:sdb5 [ 59.800210] disk 2, o:1, dev:sdc5 [ 59.800213] disk 3, o:1, dev:sdd5 [ 59.800216] disk 4, o:1, dev:sde5 [ 59.800544] created bitmap (2 pages) for device md5 [ 59.801164] md5: bitmap initialized from disk: read 1/1 pages, set 0 of 4095 bits [ 59.810979] md5: detected capacity change from 0 to 17173577728 [ 59.814005] md5: unknown partition table [ 59.893269] md: md6 stopped. [ 59.912734] md: bind<sdb6> [ 59.914073] md: bind<sdc6> [ 59.915366] md: bind<sdd6> [ 59.917752] md: bind<sde6> [ 59.919148] md: bind<sda6> [ 59.921278] md/raid:md6: device sda6 operational as raid disk 0 [ 59.921352] md/raid:md6: device sde6 operational as raid disk 4 [ 59.921425] md/raid:md6: device sdd6 operational as raid disk 3 [ 59.921497] md/raid:md6: device sdc6 operational as raid disk 2 [ 59.921570] md/raid:md6: device sdb6 operational as raid disk 1 [ 59.922416] md/raid:md6: allocated 5265kB [ 59.922555] md/raid:md6: raid level 5 active with 5 out of 5 devices, algorithm 2 [ 59.922646] RAID conf printout: [ 59.922649] --- level:5 rd:5 wd:5 [ 59.922652] disk 0, o:1, dev:sda6 [ 59.922655] disk 1, o:1, dev:sdb6 [ 59.922658] disk 2, o:1, dev:sdc6 [ 59.922661] disk 3, o:1, dev:sdd6 [ 59.922663] disk 4, o:1, dev:sde6 [ 59.923029] created bitmap (2 pages) for device md6 [ 59.923693] md6: bitmap initialized from disk: read 1/1 pages, set 0 of 4095 bits [ 59.931475] md6: detected capacity change from 0 to 8586788864 [ 59.934532] md6: unknown partition table [ 59.986496] md: md7 stopped. [ 60.006071] md: bind<sdb7> [ 60.007411] md: bind<sdc7> [ 60.008707] md: bind<sdd7> [ 60.011095] md: bind<sde7> [ 60.012490] md: bind<sda7> [ 60.014613] md/raid:md7: device sda7 operational as raid disk 0 [ 60.014688] md/raid:md7: device sde7 operational as raid disk 4 [ 60.014760] md/raid:md7: device sdd7 operational as raid disk 3 [ 60.014833] md/raid:md7: device sdc7 operational as raid disk 2 [ 60.014906] md/raid:md7: device sdb7 operational as raid disk 1 [ 60.015743] md/raid:md7: allocated 5265kB [ 60.015875] md/raid:md7: raid level 5 active with 5 out of 5 devices, algorithm 2 [ 60.015965] RAID conf printout: [ 60.015968] --- level:5 rd:5 wd:5 [ 60.015971] disk 0, o:1, dev:sda7 [ 60.015974] disk 1, o:1, dev:sdb7 [ 60.015977] disk 2, o:1, dev:sdc7 [ 60.015979] disk 3, o:1, dev:sdd7 [ 60.015982] disk 4, o:1, dev:sde7 [ 60.016345] created bitmap (8 pages) for device md7 [ 60.017696] md7: bitmap initialized from disk: read 1/1 pages, set 0 of 15279 bits [ 60.032209] md7: detected capacity change from 0 to 256331743232 [ 60.035474] md7: unknown partition table [ 60.163404] Adding 2609916k swap on /dev/md3. Priority:-1 extents:1 across:2609916k [ 596.221382] EXT4-fs (md2): mounted filesystem with ordered data mode. Opts: data=ordered [ 596.322628] EXT4-fs (md5): mounted filesystem with ordered data mode. Opts: data=ordered [ 596.416414] EXT4-fs (md6): mounted filesystem with ordered data mode. Opts: data=ordered,usrquota,grpquota [ 596.773165] SGI XFS with ACLs, security attributes, large block/inode numbers, no debug enabled [ 596.773849] SGI XFS Quota Management subsystem [ 596.830744] XFS (md7): Mounting Filesystem [ 599.085866] XFS (md7): Ending clean mount [ 603.084899] IPv6: Loaded, but administratively disabled, reboot required to enable [ 603.147044] e1000: eth0 NIC Link is Up 100 Mbps Full Duplex, Flow Control: RX [ 605.489829] ip_tables: (C) 2000-2006 Netfilter Core Team [ 605.533016] nf_conntrack version 0.5.0 (16384 buckets, 65536 max) [ 607.803732] sshd (1037): /proc/1037/oom_adj is deprecated, please use /proc/1037/oom_score_adj instead. [ 645.153899] RPC: Registered named UNIX socket transport module. [ 645.153941] RPC: Registered udp transport module. [ 645.153975] RPC: Registered tcp transport module. [ 645.154006] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 645.295822] Installing knfsd (copyright (C) 1996 okir@xxxxxxxxxxxx). [ 645.350044] NFSD: Using /var/lib/nfs/v4recovery as the NFSv4 state recovery directory [ 645.356085] NFSD: starting 90-second grace period [ 649.531126] tun: Universal TUN/TAP device driver, 1.6 [ 649.531167] tun: (C) 1999-2004 Max Krasnyansky <maxk@xxxxxxxxxxxx>