2007-10-04 16:14:22

by Valerie Clement

[permalink] [raw]
Subject: 2.6.23-rc9: Oops in cache_alloc_refill() mm/slab.c

Linux version 2.6.23-rc9 (clementv@ext1) (gcc version 4.1.3 20070629 (prerelease) (Debian 4.1.2-13)) #2 SMP Thu Oct 4 19:32:38 CEST 2007
Command line: console=ttyS0,57600n8
BIOS-provided physical RAM map:
BIOS-e820: 0000000000000000 - 000000000009b400 (usable)
BIOS-e820: 000000000009b400 - 00000000000a0000 (reserved)
BIOS-e820: 00000000000cc000 - 00000000000d8000 (reserved)
BIOS-e820: 00000000000e0000 - 0000000000100000 (reserved)
BIOS-e820: 0000000000100000 - 000000007ff70000 (usable)
BIOS-e820: 000000007ff70000 - 000000007ff7b000 (ACPI data)
BIOS-e820: 000000007ff7b000 - 000000007ff80000 (ACPI NVS)
BIOS-e820: 000000007ff80000 - 0000000080000000 (reserved)
BIOS-e820: 00000000e0000000 - 00000000f0000000 (reserved)
BIOS-e820: 00000000fec00000 - 00000000fec10000 (reserved)
BIOS-e820: 00000000fee00000 - 00000000fee01000 (reserved)
BIOS-e820: 00000000ff800000 - 00000000ffc00000 (reserved)
BIOS-e820: 00000000fffffc00 - 0000000100000000 (reserved)
Entering add_active_range(0, 0, 155) 0 entries of 3200 used
Entering add_active_range(0, 256, 524144) 1 entries of 3200 used
end_pfn_map = 1047552
DMI 2.3 present.
ACPI: RSDP 000F6940, 0014 (r0 PTLTD )
ACPI: RSDT 7FF766C5, 0034 (r1 PTLTD RSDT 6040000 LTP 0)
ACPI: FACP 7FF7AE94, 0074 (r1 INTEL LINDHRST 6040000 PTL 3)
ACPI: DSDT 7FF766F9, 479B (r1 Intel LINDHRST 6040000 MSFT 100000E)
ACPI: FACS 7FF7BFC0, 0040
ACPI: MCFG 7FF7AF08, 0040 (r1 PTLTD MCFG 6040000 LTP 0)
ACPI: APIC 7FF7AF48, 0090 (r1 PTLTD APIC 6040000 LTP 0)
ACPI: BOOT 7FF7AFD8, 0028 (r1 PTLTD $SBFTBL$ 6040000 LTP 1)
No NUMA configuration found
Faking a node at 0000000000000000-000000007ff70000
Entering add_active_range(0, 0, 155) 0 entries of 3200 used
Entering add_active_range(0, 256, 524144) 1 entries of 3200 used
Bootmem setup node 0 0000000000000000-000000007ff70000
Zone PFN ranges:
DMA 0 -> 4096
DMA32 4096 -> 1048576
Normal 1048576 -> 1048576
Movable zone start PFN for each node
early_node_map[2] active PFN ranges
0: 0 -> 155
0: 256 -> 524144
On node 0 totalpages: 524043
DMA zone: 56 pages used for memmap
DMA zone: 1752 pages reserved
DMA zone: 2187 pages, LIFO batch:0
DMA32 zone: 7110 pages used for memmap
DMA32 zone: 512938 pages, LIFO batch:31
Normal zone: 0 pages used for memmap
Movable zone: 0 pages used for memmap
ACPI: PM-Timer IO Port: 0x1008
ACPI: Local APIC address 0xfee00000
ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
Processor #0 (Bootup-CPU)
ACPI: LAPIC (acpi_id[0x01] lapic_id[0x06] enabled)
Processor #6
ACPI: LAPIC (acpi_id[0x02] lapic_id[0x01] enabled)
Processor #1
ACPI: LAPIC (acpi_id[0x03] lapic_id[0x07] enabled)
Processor #7
ACPI: LAPIC_NMI (acpi_id[0x00] high edge lint[0x1])
ACPI: LAPIC_NMI (acpi_id[0x01] high edge lint[0x1])
ACPI: LAPIC_NMI (acpi_id[0x02] high edge lint[0x1])
ACPI: LAPIC_NMI (acpi_id[0x03] high edge lint[0x1])
ACPI: IOAPIC (id[0x02] address[0xfec00000] gsi_base[0])
IOAPIC[0]: apic_id 2, address 0xfec00000, GSI 0-23
ACPI: IOAPIC (id[0x03] address[0xfec10000] gsi_base[24])
IOAPIC[1]: apic_id 3, address 0xfec10000, GSI 24-47
ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 high edge)
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 flat
Using ACPI (MADT) for SMP configuration information
Allocating PCI resources starting at 88000000 (gap: 80000000:60000000)
SMP: Allowing 4 CPUs, 0 hotplug CPUs
PERCPU: Allocating 35304 bytes of per cpu data
Built 1 zonelists in Node order. Total pages: 515125
Policy zone: DMA32
Kernel command line: console=ttyS0,57600n8
Initializing CPU#0
PID hash table entries: 4096 (order: 12, 32768 bytes)
time.c: Detected 2793.050 MHz processor.
Console: colour VGA+ 80x25
console [ttyS0] enabled
Checking aperture...
Memory: 2059980k/2096576k available (3971k kernel code, 36192k reserved, 1772k data, 344k init)
Calibrating delay using timer specific routine.. 5590.49 BogoMIPS (lpj=11180993)
Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes)
Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes)
Mount-cache hash table entries: 256
CPU: Trace cache: 12K uops, L1 D cache: 16K
CPU: L2 cache: 1024K
CPU 0/0 -> Node 0
using mwait in idle threads.
CPU: Physical Processor ID: 0
CPU: Processor Core ID: 0
CPU0: Thermal monitoring enabled (TM1)
SMP alternatives: switching to UP code
ACPI: Core revision 20070126
Using local APIC timer interrupts.
result 12468953
Detected 12.468 MHz APIC timer.
SMP alternatives: switching to SMP code
Booting processor 1/4 APIC 0x6
Initializing CPU#1
Calibrating delay using timer specific routine.. 5586.51 BogoMIPS (lpj=11173037)
CPU: Trace cache: 12K uops, L1 D cache: 16K
CPU: L2 cache: 1024K
CPU 1/6 -> Node 0
CPU: Physical Processor ID: 3
CPU: Processor Core ID: 0
CPU1: Thermal monitoring enabled (TM1)
Intel(R) Xeon(TM) CPU 2.80GHz stepping 01
checking TSC synchronization [CPU#0 -> CPU#1]: passed.
SMP alternatives: switching to SMP code
Booting processor 2/4 APIC 0x1
Initializing CPU#2
Calibrating delay using timer specific routine.. 5586.43 BogoMIPS (lpj=11172860)
CPU: Trace cache: 12K uops, L1 D cache: 16K
CPU: L2 cache: 1024K
CPU 2/1 -> Node 0
CPU: Physical Processor ID: 0
CPU: Processor Core ID: 0
CPU2: Thermal monitoring enabled (TM1)
Intel(R) Xeon(TM) CPU 2.80GHz stepping 01
checking TSC synchronization [CPU#0 -> CPU#2]: passed.
SMP alternatives: switching to SMP code
Booting processor 3/4 APIC 0x7
Initializing CPU#3
Calibrating delay using timer specific routine.. 5586.51 BogoMIPS (lpj=11173034)
CPU: Trace cache: 12K uops, L1 D cache: 16K
CPU: L2 cache: 1024K
CPU 3/7 -> Node 0
CPU: Physical Processor ID: 3
CPU: Processor Core ID: 0
CPU3: Thermal monitoring enabled (TM1)
Intel(R) Xeon(TM) CPU 2.80GHz stepping 01
checking TSC synchronization [CPU#0 -> CPU#3]: passed.
Brought up 4 CPUs
NET: Registered protocol family 16
ACPI: bus type pci registered
PCI: Found Intel Corporation E7520 Memory Controller Hub with MMCONFIG support.
PCI: Using MMCONFIG at e0000000 - efffffff
ACPI: EC: Look up EC in DSDT
ACPI: Interpreter enabled
ACPI: (supports S0 S1 S5)
ACPI: Using IOAPIC for interrupt routing
ACPI: PCI Root Bridge [PCI0] (0000:00)
PCI quirk: region 1000-107f claimed by ICH4 ACPI/GPIO/TCO
PCI quirk: region 1180-11bf claimed by ICH4 GPIO
PCI: PXH quirk detected, disabling MSI for SHPC device
PCI: PXH quirk detected, disabling MSI for SHPC device
PCI: Transparent bridge - 0000:00:1e.0
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PE1A._PRT]
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PE1A.PXHA._PRT]
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PE1A.PXHB._PRT]
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PE2A._PRT]
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PE2B._PRT]
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PE3A._PRT]
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PE3B._PRT]
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PCIB._PRT]
ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PCIX._PRT]
ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 6 7 *10 14 15)
ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 6 7 *10 14 15)
ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 5 6 7 *10 14 15)
ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 7 *10 14 15)
ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 7 10 14 15) *0, disabled.
ACPI: PCI Interrupt Link [LNKF] (IRQs 4 5 6 7 10 14 15) *0, disabled.
ACPI: PCI Interrupt Link [LNKG] (IRQs *9)
ACPI: PCI Interrupt Link [LNKH] (IRQs 4 5 6 7 *10 14 15)
Linux Plug and Play Support v0.97 (c) Adam Belay
pnp: PnP ACPI init
ACPI: bus type pnp registered
pnp: PnP ACPI: found 12 devices
ACPI: ACPI bus type pnp unregistered
SCSI subsystem initialized
libata version 2.21 loaded.
usbcore: registered new interface driver usbfs
usbcore: registered new interface driver hub
usbcore: registered new device driver usb
PCI: Using ACPI for IRQ routing
PCI: If a device doesn't work, try "pci=routeirq". If it helps, post a report
PCI-GART: No AMD northbridge found.
Time: tsc clocksource has been installed.
pnp: 00:01: iomem range 0xe0000000-0xefffffff could not be reserved
pnp: 00:01: iomem range 0xfee00000-0xfee0ffff could not be reserved
pnp: 00:01: iomem range 0xfec81000-0xfec81fff has been reserved
pnp: 00:01: iomem range 0xfec81400-0xfec823ff could not be reserved
PCI: Bridge: 0000:01:00.0
IO window: 2000-3fff
MEM window: d0100000-d01fffff
PREFETCH window: 88000000-881fffff
PCI: Bridge: 0000:01:00.2
IO window: 4000-4fff
MEM window: d0200000-d02fffff
PREFETCH window: 88200000-882fffff
PCI: Bridge: 0000:00:02.0
IO window: 2000-4fff
MEM window: d0100000-d02fffff
PREFETCH window: 88000000-882fffff
PCI: Bridge: 0000:00:04.0
IO window: disabled.
MEM window: disabled.
PREFETCH window: disabled.
PCI: Bridge: 0000:00:05.0
IO window: disabled.
MEM window: disabled.
PREFETCH window: disabled.
PCI: Bridge: 0000:00:06.0
IO window: disabled.
MEM window: disabled.
PREFETCH window: disabled.
PCI: Bridge: 0000:00:07.0
IO window: disabled.
MEM window: disabled.
PREFETCH window: disabled.
PCI: Bridge: 0000:00:1c.0
IO window: 5000-5fff
MEM window: d0300000-d03fffff
PREFETCH window: d8000000-dfffffff
PCI: Bridge: 0000:00:1e.0
IO window: disabled.
MEM window: disabled.
PREFETCH window: disabled.
ACPI: PCI Interrupt 0000:00:02.0[A] -> GSI 16 (level, low) -> IRQ 16
PCI: Setting latency timer of device 0000:00:02.0 to 64
PCI: Setting latency timer of device 0000:01:00.0 to 64
PCI: Setting latency timer of device 0000:01:00.2 to 64
ACPI: PCI Interrupt 0000:00:04.0[A] -> GSI 16 (level, low) -> IRQ 16
PCI: Setting latency timer of device 0000:00:04.0 to 64
ACPI: PCI Interrupt 0000:00:05.0[A] -> GSI 16 (level, low) -> IRQ 16
PCI: Setting latency timer of device 0000:00:05.0 to 64
ACPI: PCI Interrupt 0000:00:06.0[A] -> GSI 16 (level, low) -> IRQ 16
PCI: Setting latency timer of device 0000:00:06.0 to 64
ACPI: PCI Interrupt 0000:00:07.0[A] -> GSI 16 (level, low) -> IRQ 16
PCI: Setting latency timer of device 0000:00:07.0 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: 65536 (order: 7, 524288 bytes)
TCP established hash table entries: 262144 (order: 10, 6291456 bytes)
TCP bind hash table entries: 65536 (order: 8, 1048576 bytes)
TCP: Hash tables configured (established 262144 bind 65536)
TCP reno registered
Simple Boot Flag at 0x3a set to 0x1
Total HugeTLB memory allocated, 0
Installing knfsd (copyright (C) 1996 [email protected]).
SGI XFS with large block/inode numbers, no debug enabled
io scheduler noop registered
io scheduler anticipatory registered
io scheduler deadline registered
io scheduler cfq registered (default)
Boot video device is 0000:08:01.0
PCI: Setting latency timer of device 0000:00:02.0 to 64
Allocate Port Service[0000:00:02.0:pcie00]
Allocate Port Service[0000:00:02.0:pcie01]
PCI: Setting latency timer of device 0000:00:04.0 to 64
Allocate Port Service[0000:00:04.0:pcie00]
Allocate Port Service[0000:00:04.0:pcie01]
PCI: Setting latency timer of device 0000:00:05.0 to 64
Allocate Port Service[0000:00:05.0:pcie00]
Allocate Port Service[0000:00:05.0:pcie01]
PCI: Setting latency timer of device 0000:00:06.0 to 64
Allocate Port Service[0000:00:06.0:pcie00]
Allocate Port Service[0000:00:06.0:pcie01]
PCI: Setting latency timer of device 0000:00:07.0 to 64
Allocate Port Service[0000:00:07.0:pcie00]
Allocate Port Service[0000:00:07.0:pcie01]
AER service couldn't init device 0000:00:02.0:pcie01 - no _OSC support
AER service couldn't init device 0000:00:04.0:pcie01 - no _OSC support
AER service couldn't init device 0000:00:05.0:pcie01 - no _OSC support
AER service couldn't init device 0000:00:06.0:pcie01 - no _OSC support
AER service couldn't init device 0000:00:07.0:pcie01 - no _OSC support
input: Power Button (FF) as /class/input/input0
ACPI: Power Button (FF) [PWRF]
input: Power Button (CM) as /class/input/input1
ACPI: Power Button (CM) [PWRB]
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)
Real Time Clock Driver v1.12ac
intel_rng: FWH not detected
Linux agpgart interface v0.102
Serial: 8250/16550 driver $Revision: 1.90 $ 4 ports, IRQ sharing disabled
serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
serial8250: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A
00:0a: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A
00:0b: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
Floppy drive(s): fd0 is 1.44M
FDC 0 is a National Semiconductor PC87306
RAMDISK driver initialized: 16 RAM disks of 4096K size 1024 blocksize
loop: module loaded
Intel(R) PRO/1000 Network Driver - version 7.3.20-k2
Copyright (c) 1999-2006 Intel Corporation.
ACPI: PCI Interrupt 0000:02:01.0[A] -> GSI 16 (level, low) -> IRQ 16
e1000: 0000:02:01.0: e1000_probe: (PCI-X:100MHz:64-bit) 00:0e:0c:6d:b2:98
e1000: eth0: e1000_probe: Intel(R) PRO/1000 Network Connection
ACPI: PCI Interrupt 0000:03:01.0[A] -> GSI 16 (level, low) -> IRQ 16
e1000: 0000:03:01.0: e1000_probe: (PCI-X:133MHz:64-bit) 00:0e:0c:6d:b2:3f
e1000: eth1: e1000_probe: Intel(R) PRO/1000 Network Connection
ACPI: PCI Interrupt 0000:08:02.0[A] -> GSI 25 (level, low) -> IRQ 25
e1000: 0000:08:02.0: e1000_probe: (PCI:66MHz:32-bit) 00:11:09:ab:d0:12
e1000: eth2: e1000_probe: Intel(R) PRO/1000 Network Connection
ACPI: PCI Interrupt 0000:08:03.0[A] -> GSI 26 (level, low) -> IRQ 26
e1000: 0000:08:03.0: e1000_probe: (PCI:66MHz:32-bit) 00:11:09:ab:d0:13
e1000: eth3: e1000_probe: Intel(R) PRO/1000 Network Connection
e100: Intel(R) PRO/100 Network Driver, 3.5.23-k4-NAPI
e100: Copyright(c) 1999-2006 Intel Corporation
forcedeth.c: Reverse Engineered nForce ethernet driver. Version 0.60.
tun: Universal TUN/TAP device driver, 1.6
tun: (C) 1999-2004 Max Krasnyansky <[email protected]>
netconsole: not configured, aborting
Uniform Multi-Platform E-IDE driver Revision: 7.00alpha2
ide: Assuming 33MHz system bus speed for PIO modes; override with idebus=xx
ICH5: IDE controller at PCI slot 0000:00:1f.1
ACPI: PCI Interrupt 0000:00:1f.1[A] -> GSI 18 (level, low) -> IRQ 18
ICH5: chipset revision 2
ICH5: not 100% native mode: will probe irqs later
ide0: BM-DMA at 0x1460-0x1467, BIOS settings: hda:pio, hdb:pio
ide1: BM-DMA at 0x1468-0x146f, BIOS settings: hdc:DMA, hdd:pio
Probing IDE interface ide0...
Probing IDE interface ide1...
hdc: LITE-ON COMBO SOHC-4832K, ATAPI CD/DVD-ROM drive
hdc: selected mode 0x42
ide1 at 0x170-0x177,0x376 on irq 15
Probing IDE interface ide0...
hdc: ATAPI 48X DVD-ROM CD-R/RW drive, 2048kB Cache, UDMA(33)
Uniform CD-ROM driver Revision: 3.20
ACPI: PCI Interrupt 0000:02:03.0[A] -> GSI 18 (level, low) -> IRQ 18
scsi0 : Adaptec AIC79XX PCI-X SCSI HBA DRIVER, Rev 3.0
<Adaptec AIC7902 Ultra320 SCSI adapter>
aic7902: Ultra320 Wide Channel A, SCSI Id=7, PCI-X 67-100Mhz, 512 SCBs
scsi 0:0:0:0: Direct-Access MAXTOR ATLAS10K5_73SCA JNZ3 PQ: 0 ANSI: 3
target0:0:0: asynchronous
scsi0:A:0:0: Tagged Queuing enabled. Depth 32
target0:0:0: Beginning Domain Validation
target0:0:0: wide asynchronous
target0:0:0: FAST-160 WIDE SCSI 320.0 MB/s DT IU QAS RTI (6.25 ns, offset 127)
target0:0:0: Ending Domain Validation
scsi 0:0:1:0: Direct-Access MAXTOR ATLAS10K5_73SCA JNZ3 PQ: 0 ANSI: 3
target0:0:1: asynchronous
scsi0:A:1:0: Tagged Queuing enabled. Depth 32
target0:0:1: Beginning Domain Validation
target0:0:1: wide asynchronous
target0:0:1: FAST-160 WIDE SCSI 320.0 MB/s DT IU QAS RTI (6.25 ns, offset 127)
target0:0:1: Ending Domain Validation
scsi 0:0:2:0: Direct-Access MAXTOR ATLAS10K4_73SCA DFV0 PQ: 0 ANSI: 3
target0:0:2: asynchronous
scsi0:A:2:0: Tagged Queuing enabled. Depth 32
target0:0:2: Beginning Domain Validation
target0:0:2: wide asynchronous
target0:0:2: FAST-160 WIDE SCSI 320.0 MB/s DT IU QAS RTI (6.25 ns, offset 127)
target0:0:2: Ending Domain Validation
scsi 0:0:3:0: Direct-Access MAXTOR ATLAS10K5_73SCA JNZ3 PQ: 0 ANSI: 3
target0:0:3: asynchronous
scsi0:A:3:0: Tagged Queuing enabled. Depth 32
target0:0:3: Beginning Domain Validation
target0:0:3: wide asynchronous
target0:0:3: FAST-160 WIDE SCSI 320.0 MB/s DT IU QAS RTI (6.25 ns, offset 127)
target0:0:3: Ending Domain Validation
scsi 0:0:8:0: Processor NEC GEM318 0 PQ: 0 ANSI: 2
target0:0:8: asynchronous
target0:0:8: Beginning Domain Validation
target0:0:8: Ending Domain Validation
ACPI: PCI Interrupt 0000:02:03.1[B] -> GSI 19 (level, low) -> IRQ 19
scsi1 : Adaptec AIC79XX PCI-X SCSI HBA DRIVER, Rev 3.0
<Adaptec AIC7902 Ultra320 SCSI adapter>
aic7902: Ultra320 Wide Channel B, SCSI Id=7, PCI-X 67-100Mhz, 512 SCBs
megaraid cmm: 2.20.2.7 (Release Date: Sun Jul 16 00:01:03 EST 2006)
megaraid: 2.20.5.1 (Release Date: Thu Nov 16 15:32:35 EST 2006)
megasas: 00.00.03.10-rc5 Thu May 17 10:09:32 PDT 2007
sd 0:0:0:0: [sda] 142969680 512-byte hardware sectors (73200 MB)
sd 0:0:0:0: [sda] Write Protect is off
sd 0:0:0:0: [sda] Mode Sense: bf 00 10 08
sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA
sd 0:0:0:0: [sda] 142969680 512-byte hardware sectors (73200 MB)
sd 0:0:0:0: [sda] Write Protect is off
sd 0:0:0:0: [sda] Mode Sense: bf 00 10 08
sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA
sda: sda1 sda2 < sda5 sda6 sda7 sda8 sda9 >
sd 0:0:0:0: [sda] Attached SCSI disk
sd 0:0:1:0: [sdb] 142969680 512-byte hardware sectors (73200 MB)
sd 0:0:1:0: [sdb] Write Protect is off
sd 0:0:1:0: [sdb] Mode Sense: bf 00 10 08
sd 0:0:1:0: [sdb] Write cache: disabled, read cache: enabled, supports DPO and FUA
sd 0:0:1:0: [sdb] 142969680 512-byte hardware sectors (73200 MB)
sd 0:0:1:0: [sdb] Write Protect is off
sd 0:0:1:0: [sdb] Mode Sense: bf 00 10 08
sd 0:0:1:0: [sdb] Write cache: disabled, read cache: enabled, supports DPO and FUA
sdb: sdb1
sd 0:0:1:0: [sdb] Attached SCSI disk
sd 0:0:2:0: [sdc] 142969680 512-byte hardware sectors (73200 MB)
sd 0:0:2:0: [sdc] Write Protect is off
sd 0:0:2:0: [sdc] Mode Sense: fd 00 10 08
sd 0:0:2:0: [sdc] Write cache: disabled, read cache: enabled, supports DPO and FUA
sd 0:0:2:0: [sdc] 142969680 512-byte hardware sectors (73200 MB)
sd 0:0:2:0: [sdc] Write Protect is off
sd 0:0:2:0: [sdc] Mode Sense: fd 00 10 08
sd 0:0:2:0: [sdc] Write cache: disabled, read cache: enabled, supports DPO and FUA
sdc: unknown partition table
sd 0:0:2:0: [sdc] Attached SCSI disk
sd 0:0:3:0: [sdd] 142969680 512-byte hardware sectors (73200 MB)
sd 0:0:3:0: [sdd] Write Protect is off
sd 0:0:3:0: [sdd] Mode Sense: bf 00 10 08
sd 0:0:3:0: [sdd] Write cache: disabled, read cache: enabled, supports DPO and FUA
sd 0:0:3:0: [sdd] 142969680 512-byte hardware sectors (73200 MB)
sd 0:0:3:0: [sdd] Write Protect is off
sd 0:0:3:0: [sdd] Mode Sense: bf 00 10 08
sd 0:0:3:0: [sdd] Write cache: disabled, read cache: enabled, supports DPO and FUA
sdd: unknown partition table
sd 0:0:3:0: [sdd] Attached SCSI disk
sd 0:0:0:0: Attached scsi generic sg0 type 0
sd 0:0:1:0: Attached scsi generic sg1 type 0
sd 0:0:2:0: Attached scsi generic sg2 type 0
sd 0:0:3:0: Attached scsi generic sg3 type 0
scsi 0:0:8:0: Attached scsi generic sg4 type 3
Fusion MPT base driver 3.04.05
Copyright (c) 1999-2007 LSI Logic Corporation
Fusion MPT SPI Host driver 3.04.05
Fusion MPT SAS Host driver 3.04.05
ieee1394: raw1394: /dev/raw1394 device initialized
ACPI: PCI Interrupt 0000:00:1d.7[D] -> GSI 23 (level, low) -> IRQ 23
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 1
ehci_hcd 0000:00:1d.7: debug port 1
PCI: cache line size of 128 is not supported by device 0000:00:1d.7
ehci_hcd 0000:00:1d.7: irq 23, io mem 0xd0001400
ehci_hcd 0000:00:1d.7: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004
usb usb1: configuration #1 chosen from 1 choice
hub 1-0:1.0: USB hub found
hub 1-0:1.0: 4 ports detected
ohci_hcd: 2006 August 04 USB 1.1 'Open' Host Controller (OHCI) Driver
USB Universal Host Controller Interface driver v3.0
ACPI: PCI Interrupt 0000:00:1d.0[A] -> GSI 16 (level, low) -> IRQ 16
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 2
uhci_hcd 0000:00:1d.0: irq 16, io base 0x00001400
usb usb2: configuration #1 chosen from 1 choice
hub 2-0:1.0: USB hub found
hub 2-0:1.0: 2 ports detected
ACPI: PCI Interrupt 0000:00:1d.1[B] -> GSI 19 (level, low) -> IRQ 19
PCI: Setting latency timer of device 0000:00:1d.1 to 64
uhci_hcd 0000:00:1d.1: UHCI Host Controller
uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3
uhci_hcd 0000:00:1d.1: irq 19, io base 0x00001420
usb usb3: configuration #1 chosen from 1 choice
hub 3-0:1.0: USB hub found
hub 3-0:1.0: 2 ports detected
usbcore: registered new interface driver usblp
Initializing USB Mass Storage driver...
usbcore: registered new interface driver usb-storage
USB Mass Storage support registered.
PNP: PS/2 Controller [PNP0303:KBC0,PNP0f13:MSE0] at 0x60,0x64 irq 1,12
serio: i8042 KBD port at 0x60,0x64 irq 1
serio: i8042 AUX port at 0x60,0x64 irq 12
mice: PS/2 mouse device common for all mice
input: AT Translated Set 2 keyboard as /class/input/input2
md: linear personality registered for level -1
md: raid0 personality registered for level 0
device-mapper: ioctl: 4.11.0-ioctl (2006-10-12) initialised: [email protected]
usbcore: registered new interface driver usbhid
/home/clementv/src/linux-2.6.23-rc9/drivers/hid/usbhid/hid-core.c: v2.6:USB HID core driver
oprofile: using NMI interrupt.
TCP cubic registered
NET: Registered protocol family 1
NET: Registered protocol family 10
IPv6 over IPv4 tunneling driver
NET: Registered protocol family 17
input: ImExPS/2 Generic Explorer Mouse as /class/input/input3
md: Autodetecting RAID arrays.
md: autorun ...
md: ... autorun DONE.
VFS: Mounted root (ext2 filesystem) readonly.
Freeing unused kernel memory: 344k freed
QLogic Fibre Channel HBA Driver
ACPI: PCI Interrupt 0000:02:02.0[A] -> GSI 16 (level, low) -> IRQ 16
qla2xxx 0000:02:02.0: Found an ISP2312, irq 16, iobase 0xffffc20000320000
qla2xxx 0000:02:02.0: Configuring PCI space...
qla2xxx 0000:02:02.0: Configure NVRAM parameters...
qla2xxx 0000:02:02.0: Verifying loaded RISC code...
qla2xxx 0000:02:02.0: Allocated (412 KB) for firmware dump...
qla2xxx 0000:02:02.0: LIP reset occured (f8f7).
scsi2 : qla2xxx
qla2xxx 0000:02:02.0: LIP occured (f8f7).
qla2xxx 0000:02:02.0: LOOP UP detected (2 Gbps).
scsi 2:0:0:0: Direct-Access IBM 1724-100 FAStT 0542 PQ: 0 ANSI: 3
sd 2:0:0:0: [sde] 4269790986 512-byte hardware sectors (2186133 MB)
qla2xxx 0000:02:02.0:
QLogic Fibre Channel HBA Driver: 8.02.00-k3
QLogic QLA2340 - 133MHz PCI-X to 2Gb FC, Single Channel
ISP2312: PCI-X (100 MHz) @ 0000:02:02.0 hdma-, host#=2, fw=3.03.20 IPX
sd 2:0:0:0: [sde] Write Protect is off
sd 2:0:0:0: [sde] Mode Sense: 77 00 10 08
sd 2:0:0:0: [sde] Write cache: enabled, read cache: enabled, supports DPO and FUA
sd 2:0:0:0: [sde] 4269790986 512-byte hardware sectors (2186133 MB)
sd 2:0:0:0: [sde] Write Protect is off
sd 2:0:0:0: [sde] Mode Sense: 77 00 10 08
sd 2:0:0:0: [sde] Write cache: enabled, read cache: enabled, supports DPO and FUA
sde: unknown partition table
sd 2:0:0:0: [sde] Attached SCSI disk
sd 2:0:0:0: Attached scsi generic sg5 type 0
scsi 2:0:0:1: Direct-Access IBM 1724-100 FAStT 0542 PQ: 0 ANSI: 3
sd 2:0:0:1: [sdf] 4269790986 512-byte hardware sectors (2186133 MB)
sd 2:0:0:1: [sdf] Write Protect is off
sd 2:0:0:1: [sdf] Mode Sense: 77 00 10 08
sd 2:0:0:1: [sdf] Write cache: enabled, read cache: enabled, supports DPO and FUA
sd 2:0:0:1: [sdf] 4269790986 512-byte hardware sectors (2186133 MB)
sd 2:0:0:1: [sdf] Write Protect is off
sd 2:0:0:1: [sdf] Mode Sense: 77 00 10 08
sd 2:0:0:1: [sdf] Write cache: enabled, read cache: enabled, supports DPO and FUA
sdf: unknown partition table
sd 2:0:0:1: [sdf] Attached SCSI disk
sd 2:0:0:1: Attached scsi generic sg6 type 0
scsi 2:0:0:2: Direct-Access IBM 1724-100 FAStT 0542 PQ: 0 ANSI: 3
sd 2:0:0:2: [sdg] 2385539072 512-byte hardware sectors (1221396 MB)
sd 2:0:0:2: [sdg] Write Protect is off
sd 2:0:0:2: [sdg] Mode Sense: 77 00 10 08
sd 2:0:0:2: [sdg] Write cache: enabled, read cache: enabled, supports DPO and FUA
sd 2:0:0:2: [sdg] 2385539072 512-byte hardware sectors (1221396 MB)
sd 2:0:0:2: [sdg] Write Protect is off
sd 2:0:0:2: [sdg] Mode Sense: 77 00 10 08
sd 2:0:0:2: [sdg] Write cache: enabled, read cache: enabled, supports DPO and FUA
sdg: unknown partition table
sd 2:0:0:2: [sdg] Attached SCSI disk
sd 2:0:0:2: Attached scsi generic sg7 type 0
scsi 2:0:0:31: Direct-Access IBM Universal Xport 0542 PQ: 0 ANSI: 3
scsi 2:0:0:31: Attached scsi generic sg8 type 0
Adding 6024332k swap on /dev/sda7. Priority:-1 extents:1 across:6024332k
md: md0 stopped.
ADDRCONF(NETDEV_UP): eth0: link is not ready
e1000: eth0: e1000_watchdog: NIC Link is Up 1000 Mbps Full Duplex, Flow Control: RX/TX
ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
eth0: no IPv6 routers present
kjournald2 starting. Commit interval 5 seconds
EXT4 FS on sde, internal journal
EXT4-fs: mounted filesystem with writeback data mode.
EXT4-fs: file extents enabled


Attachments:
config (34.72 kB)
dmesg (24.97 kB)
Download all attachments

2007-10-04 21:40:54

by Badari Pulavarty

[permalink] [raw]
Subject: Re: 2.6.23-rc9: Oops in cache_alloc_refill() mm/slab.c

On Thu, 2007-10-04 at 18:13 +0200, Valerie Clement wrote:
> While running ffsb tests on my ext4 filesystem, I got an Oops in
> cache_alloc_refill().
> I turned on SLAB debugging and here is the message I got:
>
> slab: Internal list corruption detected in cache 'buffer_head'(30),
> slabp ffff81007e100100(1515870810). Hexdump:

slabp->inuse = 1515870810 looks bogus. Is this easily reproducible ?
What tests are you running through ffsb ?

> 000: 5a 5a 5a 5a 5a 5a 5a 5a b8 23 34 7e 00 81 ff ff
> 010: 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a
> 020: 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a
> 030: 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a
> 040: 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a
> 050: 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a
> 060: 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a a5
> 070: c0 88 56 63 c5 56 41 d8 f1 37 4a 80 ff ff ff ff
> 080: c0 88 56 63 c5 56 41 d8 80 33 53 7d 00 81 ff ff
> 090: e8 25 60 7d 00 81 ff ff 68 cb 3b 01 00 81 ff ff
> 0a0: 18 68 50 7d 00 81 ff ff
> ------------[ cut here ]------------
> kernel BUG at /home/clementv/src/linux-2.6.23-rc9/mm/slab.c:2923!
> invalid opcode: 0000 [1] SMP
> CPU 2
> Modules linked in: qla2xxx
> Pid: 4041, comm: ffsb Not tainted 2.6.23-rc9 #2
> RIP: 0010:[<ffffffff802758b6>] [<ffffffff802758b6>] check_slabp+0xb5/0xc1
> RSP: 0018:ffff8100774bb958 EFLAGS: 00010096
> RAX: 0000000000000001 RBX: ffff81007e100100 RCX: 0000000000006d20
> RDX: 00000000ffffffff RSI: 0000000000000046 RDI: ffff81007e347280
> RBP: 00000000000000a8 R08: 0000000000000005 R09: ffffffff8060bb10
> R10: 00000000000ae468 R11: 0000000500000002 R12: 00000000000000a8
> R13: ffff81007e347280 R14: ffff81007e347280 R15: 0000000000000002
> FS: 0000000041802950(0063) GS:ffff81007e0c4728(0000) knlGS:0000000000000000
> CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b
> CR2: 000000005f83d00c CR3: 0000000078149000 CR4: 00000000000006e0
> DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
> DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
> Process ffsb (pid: 4041, threadinfo ffff8100774ba000, task ffff81007dbdc7a0)
> Stack: 000000000000000d 000000000000000e ffff81007e100100 ffff81007e342398
> ffff81007e078488 ffffffff80277069 0000000000008050 ffff81007e347280
> 0000000000008050 0000000000000246 ffffffff80299539 fffffffffffff000
> Call Trace:
> [<ffffffff80277069>] cache_alloc_refill+0xc8/0x23f
> [<ffffffff80299539>] alloc_buffer_head+0x14/0x45
> [<ffffffff802774cd>] kmem_cache_alloc+0x94/0xe9
> [<ffffffff80299539>] alloc_buffer_head+0x14/0x45
> [<ffffffff80299cf7>] alloc_page_buffers+0x38/0xd5
> [<ffffffff80299da8>] create_empty_buffers+0x14/0x9b
> [<ffffffff8029a875>] __block_prepare_write+0x7c/0x45b
> [<ffffffff802f6e29>] ext4_get_block+0x0/0x139
> [<ffffffff8029ac6e>] block_prepare_write+0x1a/0x25
> [<ffffffff802f8340>] ext4_prepare_write+0xaf/0x175
> [<ffffffff802576c2>] generic_file_buffered_write+0x288/0x631
> [<ffffffff80257daa>] __generic_file_aio_write_nolock+0x33f/0x3a9
> [<ffffffff8022b7d5>] enqueue_entity+0x17c/0x1a3
> [<ffffffff80257e75>] generic_file_aio_write+0x61/0xc1
> [<ffffffff8022c512>] __check_preempt_curr_fair+0x56/0x76
> [<ffffffff802f4022>] ext4_file_write+0x16/0x91
> [<ffffffff8027c4f4>] do_sync_write+0xc9/0x10c
> [<ffffffff8027d50a>] file_move+0x1d/0x4c
> [<ffffffff80245992>] autoremove_wake_function+0x0/0x2e
> [<ffffffff8027b216>] do_filp_open+0x2a/0x38
> [<ffffffff80275f7a>] poison_obj+0x26/0x30
> [<ffffffff8027cc34>] vfs_write+0xad/0x136
> [<ffffffff8027d171>] sys_write+0x45/0x6e
> [<ffffffff8020b32e>] system_call+0x7e/0x83
>
>
> Valérie


2007-10-05 13:41:29

by Valerie Clement

[permalink] [raw]
Subject: Re: 2.6.23-rc9: Oops in cache_alloc_refill() mm/slab.c

Badari Pulavarty wrote:
> On Thu, 2007-10-04 at 18:13 +0200, Valerie Clement wrote:
>> While running ffsb tests on my ext4 filesystem, I got an Oops in
>> cache_alloc_refill().
>> I turned on SLAB debugging and here is the message I got:
>>
>> slab: Internal list corruption detected in cache 'buffer_head'(30),
>> slabp ffff81007e100100(1515870810). Hexdump:
>
> slabp->inuse = 1515870810 looks bogus. Is this easily reproducible ?

Hi Badari,
Thanks for your answer.
I didn't reproduce it without the latest ext4 patches. So I suspect a
bug in one of them.
But how debugging this?
Which other debug traces can I turn on?

Valérie

2007-10-05 14:51:21

by Badari Pulavarty

[permalink] [raw]
Subject: Re: 2.6.23-rc9: Oops in cache_alloc_refill() mm/slab.c

On Fri, 2007-10-05 at 15:41 +0200, Valerie Clement wrote:
> Badari Pulavarty wrote:
> > On Thu, 2007-10-04 at 18:13 +0200, Valerie Clement wrote:
> >> While running ffsb tests on my ext4 filesystem, I got an Oops in
> >> cache_alloc_refill().
> >> I turned on SLAB debugging and here is the message I got:
> >>
> >> slab: Internal list corruption detected in cache 'buffer_head'(30),
> >> slabp ffff81007e100100(1515870810). Hexdump:
> >
> > slabp->inuse = 1515870810 looks bogus. Is this easily reproducible ?
>
> Hi Badari,
> Thanks for your answer.
> I didn't reproduce it without the latest ext4 patches. So I suspect a
> bug in one of them.
> But how debugging this?
> Which other debug traces can I turn on?

Let me understand. You applied latest ext4 patchsets ? If so, Mingming
has some slab-cleanup changes in the patchset. You can try backing them
out and see.

Thanks,
Badari

2007-10-05 20:31:21

by Mingming Cao

[permalink] [raw]
Subject: Re: 2.6.23-rc9: Oops in cache_alloc_refill() mm/slab.c

On Fri, 2007-10-05 at 07:54 -0700, Badari Pulavarty wrote:
> On Fri, 2007-10-05 at 15:41 +0200, Valerie Clement wrote:
> > Badari Pulavarty wrote:
> > > On Thu, 2007-10-04 at 18:13 +0200, Valerie Clement wrote:
> > >> While running ffsb tests on my ext4 filesystem, I got an Oops in
> > >> cache_alloc_refill().
> > >> I turned on SLAB debugging and here is the message I got:
> > >>
> > >> slab: Internal list corruption detected in cache 'buffer_head'(30),
> > >> slabp ffff81007e100100(1515870810). Hexdump:
> > >
> > > slabp->inuse = 1515870810 looks bogus. Is this easily reproducible ?
> >
> > Hi Badari,
> > Thanks for your answer.
> > I didn't reproduce it without the latest ext4 patches. So I suspect a
> > bug in one of them.
> > But how debugging this?
> > Which other debug traces can I turn on?
>
> Let me understand. You applied latest ext4 patchsets ? If so, Mingming
> has some slab-cleanup changes in the patchset. You can try backing them
> out and see.
>

It's unlikely to be the jbd_slab_cleanup.patch, which actually get rid
of slab allocation for buffers passing down to disk IO, and replace with
get_free_page directly.

Could you send me the profile used for ffsb test?

Thanks,
Mingming

2007-10-05 22:07:25

by Mingming Cao

[permalink] [raw]
Subject: Re: 2.6.23-rc9: Oops in cache_alloc_refill() mm/slab.c

-------- Forwarded Message --------
From: Valerie Clement <[email protected]>
To: Linux Kernel Mailing List <[email protected]>
Subject: 2.6.23-rc9: Oops in cache_alloc_refill() mm/slab.c
Date: Thu, 04 Oct 2007 18:13:46 +0200
While running ffsb tests on my ext4 filesystem, I got an Oops in
cache_alloc_refill().
I turned on SLAB debugging and here is the message I got:

slab: Internal list corruption detected in cache 'buffer_head'(30),
slabp ffff81007e100100(1515870810). Hexdump:

=======================>

slabp->inuse counter looks corrupted (1515870810), it should not greater
than cachep->num looks valid (30)


000: 5a 5a 5a 5a 5a 5a 5a 5a b8 23 34 7e 00 81 ff ff
010: 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a
020: 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a
030: 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a
040: 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a
050: 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a
060: 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a 5a a5
070: c0 88 56 63 c5 56 41 d8 f1 37 4a 80 ff ff ff ff
080: c0 88 56 63 c5 56 41 d8 80 33 53 7d 00 81 ff ff
090: e8 25 60 7d 00 81 ff ff 68 cb 3b 01 00 81 ff ff
0a0: 18 68 50 7d 00 81 ff ff
------------[ cut here ]------------
kernel BUG at /home/clementv/src/linux-2.6.23-rc9/mm/slab.c:2923!
invalid opcode: 0000 [1] SMP
CPU 2
Modules linked in: qla2xxx
Pid: 4041, comm: ffsb Not tainted 2.6.23-rc9 #2
RIP: 0010:[<ffffffff802758b6>] [<ffffffff802758b6>] check_slabp+0xb5/0xc1
RSP: 0018:ffff8100774bb958 EFLAGS: 00010096
RAX: 0000000000000001 RBX: ffff81007e100100 RCX: 0000000000006d20
RDX: 00000000ffffffff RSI: 0000000000000046 RDI: ffff81007e347280
RBP: 00000000000000a8 R08: 0000000000000005 R09: ffffffff8060bb10
R10: 00000000000ae468 R11: 0000000500000002 R12: 00000000000000a8
R13: ffff81007e347280 R14: ffff81007e347280 R15: 0000000000000002
FS: 0000000041802950(0063) GS:ffff81007e0c4728(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b
CR2: 000000005f83d00c CR3: 0000000078149000 CR4: 00000000000006e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
Process ffsb (pid: 4041, threadinfo ffff8100774ba000, task ffff81007dbdc7a0)
Stack: 000000000000000d 000000000000000e ffff81007e100100 ffff81007e342398
ffff81007e078488 ffffffff80277069 0000000000008050 ffff81007e347280
0000000000008050 0000000000000246 ffffffff80299539 fffffffffffff000
Call Trace:
[<ffffffff80277069>] cache_alloc_refill+0xc8/0x23f
[<ffffffff80299539>] alloc_buffer_head+0x14/0x45
[<ffffffff802774cd>] kmem_cache_alloc+0x94/0xe9
[<ffffffff80299539>] alloc_buffer_head+0x14/0x45
[<ffffffff80299cf7>] alloc_page_buffers+0x38/0xd5
[<ffffffff80299da8>] create_empty_buffers+0x14/0x9b
[<ffffffff8029a875>] __block_prepare_write+0x7c/0x45b
[<ffffffff802f6e29>] ext4_get_block+0x0/0x139
[<ffffffff8029ac6e>] block_prepare_write+0x1a/0x25
[<ffffffff802f8340>] ext4_prepare_write+0xaf/0x175
[<ffffffff802576c2>] generic_file_buffered_write+0x288/0x631
[<ffffffff80257daa>] __generic_file_aio_write_nolock+0x33f/0x3a9
[<ffffffff8022b7d5>] enqueue_entity+0x17c/0x1a3
[<ffffffff80257e75>] generic_file_aio_write+0x61/0xc1
[<ffffffff8022c512>] __check_preempt_curr_fair+0x56/0x76
[<ffffffff802f4022>] ext4_file_write+0x16/0x91
[<ffffffff8027c4f4>] do_sync_write+0xc9/0x10c
[<ffffffff8027d50a>] file_move+0x1d/0x4c
[<ffffffff80245992>] autoremove_wake_function+0x0/0x2e
[<ffffffff8027b216>] do_filp_open+0x2a/0x38
[<ffffffff80275f7a>] poison_obj+0x26/0x30
[<ffffffff8027cc34>] vfs_write+0xad/0x136
[<ffffffff8027d171>] sys_write+0x45/0x6e
[<ffffffff8020b32e>] system_call+0x7e/0x83


=============>

The stack track shows ext4_new_block(), is the problem repeatable? Does away without
multiple block allocation patch?

Mingming