[ 0.000000] Linux version 2.6.21-rc5 (evil@sheep) (gcc version 4.1.2 20061115 (prerelease) (Debian 4.1.1-21)) #2 Sun Apr 1 16:46:13 BST 2007 [ 0.000000] BIOS-provided physical RAM map: [ 0.000000] sanitize start [ 0.000000] sanitize end [ 0.000000] copy_e820_map() start: 0000000000000000 size: 000000000009fc00 end: 000000000009fc00 type: 1 [ 0.000000] copy_e820_map() type is E820_RAM [ 0.000000] copy_e820_map() start: 000000000009fc00 size: 0000000000000400 end: 00000000000a0000 type: 2 [ 0.000000] copy_e820_map() start: 00000000000f0000 size: 0000000000010000 end: 0000000000100000 type: 2 [ 0.000000] copy_e820_map() start: 0000000000100000 size: 000000007fef0000 end: 000000007fff0000 type: 1 [ 0.000000] copy_e820_map() type is E820_RAM [ 0.000000] copy_e820_map() start: 000000007fff0000 size: 0000000000003000 end: 000000007fff3000 type: 4 [ 0.000000] copy_e820_map() start: 000000007fff3000 size: 000000000000d000 end: 0000000080000000 type: 3 [ 0.000000] copy_e820_map() start: 00000000fec00000 size: 0000000000001000 end: 00000000fec01000 type: 2 [ 0.000000] copy_e820_map() start: 00000000fee00000 size: 0000000000001000 end: 00000000fee01000 type: 2 [ 0.000000] copy_e820_map() start: 00000000ffff0000 size: 0000000000010000 end: 0000000100000000 type: 2 [ 0.000000] BIOS-e820: 0000000000000000 - 000000000009fc00 (usable) [ 0.000000] BIOS-e820: 000000000009fc00 - 00000000000a0000 (reserved) [ 0.000000] BIOS-e820: 00000000000f0000 - 0000000000100000 (reserved) [ 0.000000] BIOS-e820: 0000000000100000 - 000000007fff0000 (usable) [ 0.000000] BIOS-e820: 000000007fff0000 - 000000007fff3000 (ACPI NVS) [ 0.000000] BIOS-e820: 000000007fff3000 - 0000000080000000 (ACPI data) [ 0.000000] BIOS-e820: 00000000fec00000 - 00000000fec01000 (reserved) [ 0.000000] BIOS-e820: 00000000fee00000 - 00000000fee01000 (reserved) [ 0.000000] BIOS-e820: 00000000ffff0000 - 0000000100000000 (reserved) [ 0.000000] 1151MB HIGHMEM available. [ 0.000000] 896MB LOWMEM available. [ 0.000000] Entering add_active_range(0, 0, 524272) 0 entries of 256 used [ 0.000000] Zone PFN ranges: [ 0.000000] DMA 0 -> 4096 [ 0.000000] Normal 4096 -> 229376 [ 0.000000] HighMem 229376 -> 524272 [ 0.000000] early_node_map[1] active PFN ranges [ 0.000000] 0: 0 -> 524272 [ 0.000000] On node 0 totalpages: 524272 [ 0.000000] DMA zone: 32 pages used for memmap [ 0.000000] DMA zone: 0 pages reserved [ 0.000000] DMA zone: 4064 pages, LIFO batch:0 [ 0.000000] Normal zone: 1760 pages used for memmap [ 0.000000] Normal zone: 223520 pages, LIFO batch:31 [ 0.000000] HighMem zone: 2303 pages used for memmap [ 0.000000] HighMem zone: 292593 pages, LIFO batch:31 [ 0.000000] DMI 2.2 present. [ 0.000000] Allocating PCI resources starting at 88000000 (gap: 80000000:7ec00000) [ 0.000000] Built 1 zonelists. Total pages: 520177 [ 0.000000] Kernel command line: root=/dev/sda5 ro noacpi [ 0.000000] Found and enabled local APIC! [ 0.000000] mapped APIC to ffffd000 (fee00000) [ 0.000000] Enabling fast FPU save and restore... done. [ 0.000000] Enabling unmasked SIMD FPU exception support... done. [ 0.000000] Initializing CPU#0 [ 0.000000] CPU 0 irqstacks, hard=c04f3000 soft=c04f2000 [ 0.000000] PID hash table entries: 4096 (order: 12, 16384 bytes) [ 0.000000] Detected 1913.249 MHz processor. [ 23.290794] Console: colour dummy device 80x25 [ 23.290872] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 23.290877] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 23.290880] ... MAX_LOCK_DEPTH: 30 [ 23.290884] ... MAX_LOCKDEP_KEYS: 2048 [ 23.290887] ... CLASSHASH_SIZE: 1024 [ 23.290890] ... MAX_LOCKDEP_ENTRIES: 8192 [ 23.290893] ... MAX_LOCKDEP_CHAINS: 16384 [ 23.290897] ... CHAINHASH_SIZE: 8192 [ 23.290900] memory used by lock dependency info: 1096 kB [ 23.290904] per task-struct memory footprint: 1200 bytes [ 23.290907] ------------------------ [ 23.290910] | Locking API testsuite: [ 23.290913] ---------------------------------------------------------------------------- [ 23.290918] | spin |wlock |rlock |mutex | wsem | rsem | [ 23.290923] -------------------------------------------------------------------------- [ 23.290934] A-A deadlock: ok | ok | ok | ok | ok | ok | [ 23.291710] A-B-B-A deadlock: ok | ok | ok | ok | ok | ok | [ 23.292463] A-B-B-C-C-A deadlock: ok | ok | ok | ok | ok | ok | [ 23.293269] A-B-C-A-B-C deadlock: ok | ok | ok | ok | ok | ok | [ 23.294076] A-B-B-C-C-D-D-A deadlock: ok | ok | ok | ok | ok | ok | [ 23.294939] A-B-C-D-B-D-D-A deadlock: ok | ok | ok | ok | ok | ok | [ 23.295803] A-B-C-D-B-C-D-A deadlock: ok | ok | ok | ok | ok | ok | [ 23.296669] double unlock: ok | ok | ok | ok | ok | ok | [ 23.297369] initialize held: ok | ok | ok | ok | ok | ok | [ 23.298069] bad unlock order: ok | ok | ok | ok | ok | ok | [ 23.298825] -------------------------------------------------------------------------- [ 23.298831] recursive read-lock: | ok | | ok | [ 23.299070] recursive read-lock #2: | ok | | ok | [ 23.299309] mixed read-write-lock: | ok | | ok | [ 23.299555] mixed write-read-lock: | ok | | ok | [ 23.299801] -------------------------------------------------------------------------- [ 23.299806] hard-irqs-on + irq-safe-A/12: ok | ok | ok | [ 23.300162] soft-irqs-on + irq-safe-A/12: ok | ok | ok | [ 23.300522] hard-irqs-on + irq-safe-A/21: ok | ok | ok | [ 23.300881] soft-irqs-on + irq-safe-A/21: ok | ok | ok | [ 23.301239] sirq-safe-A => hirqs-on/12: ok | ok | ok | [ 23.301597] sirq-safe-A => hirqs-on/21: ok | ok | ok | [ 23.301954] hard-safe-A + irqs-on/12: ok | ok | ok | [ 23.302308] soft-safe-A + irqs-on/12: ok | ok | ok | [ 23.302667] hard-safe-A + irqs-on/21: ok | ok | ok | [ 23.303023] soft-safe-A + irqs-on/21: ok | ok | ok | [ 23.303382] hard-safe-A + unsafe-B #1/123: ok | ok | ok | [ 23.303767] soft-safe-A + unsafe-B #1/123: ok | ok | ok | [ 23.304153] hard-safe-A + unsafe-B #1/132: ok | ok | ok | [ 23.304539] soft-safe-A + unsafe-B #1/132: ok | ok | ok | [ 23.304925] hard-safe-A + unsafe-B #1/213: ok | ok | ok | [ 23.305310] soft-safe-A + unsafe-B #1/213: ok | ok | ok | [ 23.305697] hard-safe-A + unsafe-B #1/231: ok | ok | ok | [ 23.306072] soft-safe-A + unsafe-B #1/231: ok | ok | ok | [ 23.306450] hard-safe-A + unsafe-B #1/312: ok | ok | ok | [ 23.306812] soft-safe-A + unsafe-B #1/312: ok | ok | ok | [ 23.307178] hard-safe-A + unsafe-B #1/321: ok | ok | ok | [ 23.307553] soft-safe-A + unsafe-B #1/321: ok | ok | ok | [ 23.307932] hard-safe-A + unsafe-B #2/123: ok | ok | ok | [ 23.308308] soft-safe-A + unsafe-B #2/123: ok | ok | ok | [ 23.308689] hard-safe-A + unsafe-B #2/132: ok | ok | ok | [ 23.309061] soft-safe-A + unsafe-B #2/132: ok | ok | ok | [ 23.309444] hard-safe-A + unsafe-B #2/213: ok | ok | ok | [ 23.309820] soft-safe-A + unsafe-B #2/213: ok | ok | ok | [ 23.310202] hard-safe-A + unsafe-B #2/231: ok | ok | ok | [ 23.310571] soft-safe-A + unsafe-B #2/231: ok | ok | ok | [ 23.310947] hard-safe-A + unsafe-B #2/312: ok | ok | ok | [ 23.311320] soft-safe-A + unsafe-B #2/312: ok | ok | ok | [ 23.311702] hard-safe-A + unsafe-B #2/321: ok | ok | ok | [ 23.312072] soft-safe-A + unsafe-B #2/321: ok | ok | ok | [ 23.312448] hard-irq lock-inversion/123: ok | ok | ok | [ 23.312825] soft-irq lock-inversion/123: ok | ok | ok | [ 23.313209] hard-irq lock-inversion/132: ok | ok | ok | [ 23.313582] soft-irq lock-inversion/132: ok | ok | ok | [ 23.313966] hard-irq lock-inversion/213: ok | ok | ok | [ 23.314344] soft-irq lock-inversion/213: ok | ok | ok | [ 23.314727] hard-irq lock-inversion/231: ok | ok | ok | [ 23.315098] soft-irq lock-inversion/231: ok | ok | ok | [ 23.315476] hard-irq lock-inversion/312: ok | ok | ok | [ 23.315849] soft-irq lock-inversion/312: ok | ok | ok | [ 23.316233] hard-irq lock-inversion/321: ok | ok | ok | [ 23.316604] soft-irq lock-inversion/321: ok | ok | ok | [ 23.316981] hard-irq read-recursion/123: ok | [ 23.317109] soft-irq read-recursion/123: ok | [ 23.317239] hard-irq read-recursion/132: ok | [ 23.317367] soft-irq read-recursion/132: ok | [ 23.317497] hard-irq read-recursion/213: ok | [ 23.317624] soft-irq read-recursion/213: ok | [ 23.317755] hard-irq read-recursion/231: ok | [ 23.317882] soft-irq read-recursion/231: ok | [ 23.318012] hard-irq read-recursion/312: ok | [ 23.318140] soft-irq read-recursion/312: ok | [ 23.318270] hard-irq read-recursion/321: ok | [ 23.318398] soft-irq read-recursion/321: ok | [ 23.318528] ------------------------------------------------------- [ 23.318532] Good, all 218 testcases passed! | [ 23.318535] --------------------------------- [ 23.319100] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes) [ 23.319595] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes) [ 23.399058] Memory: 2072140k/2097088k available (2876k kernel code, 23764k reserved, 981k data, 156k init, 1179584k highmem) [ 23.399078] virtual kernel memory layout: [ 23.399080] fixmap : 0xfffaf000 - 0xfffff000 ( 320 kB) [ 23.399081] pkmap : 0xff800000 - 0xffc00000 (4096 kB) [ 23.399083] vmalloc : 0xf8800000 - 0xff7fe000 ( 111 MB) [ 23.399084] lowmem : 0xc0000000 - 0xf8000000 ( 896 MB) [ 23.399086] .init : 0xc04c6000 - 0xc04ed000 ( 156 kB) [ 23.399087] .data : 0xc03cf378 - 0xc04c48d8 ( 981 kB) [ 23.399089] .text : 0xc0100000 - 0xc03cf378 (2876 kB) [ 23.399104] Checking if this processor honours the WP bit even in supervisor mode... Ok. [ 23.549263] Calibrating delay using timer specific routine.. 3829.01 BogoMIPS (lpj=19145076) [ 23.549357] Mount-cache hash table entries: 512 [ 23.549889] CPU: After generic identify, caps: 0383fbff c1c3fbff 00000000 00000000 00000000 00000000 00000000 [ 23.549898] CPU: L1 I Cache: 64K (64 bytes/line), D cache 64K (64 bytes/line) [ 23.549904] CPU: L2 Cache: 512K (64 bytes/line) [ 23.549908] CPU: After all inits, caps: 0383fbff c1c3fbff 00000000 00000420 00000000 00000000 00000000 [ 23.549915] Intel machine check architecture supported. [ 23.549919] Intel machine check reporting enabled on CPU#0. [ 23.549927] Compat vDSO mapped to ffffe000. [ 23.549940] CPU: AMD Athlon(tm) XP 2600+ stepping 00 [ 23.549948] Checking 'hlt' instruction... OK. [ 23.829537] NET: Registered protocol family 16 [ 23.861792] PCI: PCI BIOS revision 2.10 entry at 0xfb4a0, last bus=2 [ 23.861797] PCI: Using configuration type 1 [ 23.861801] Setting up standard PCI resources [ 23.865692] SCSI subsystem initialized [ 23.865810] usbcore: registered new interface driver usbfs [ 23.865876] usbcore: registered new interface driver hub [ 23.865957] usbcore: registered new device driver usb [ 23.866018] PCI: Probing PCI hardware [ 23.866038] PCI: Probing PCI hardware (bus 00) [ 23.866185] PCI: nForce2 C1 Halt Disconnect fixup [ 23.866812] 0000:00:09.0: cannot adjust BAR0 (not I/O) [ 23.866816] 0000:00:09.0: cannot adjust BAR1 (not I/O) [ 23.866820] 0000:00:09.0: cannot adjust BAR2 (not I/O) [ 23.866824] 0000:00:09.0: cannot adjust BAR3 (not I/O) [ 23.868732] PCI: Discovered primary peer bus ff [IRQ] [ 23.868740] PCI: Using IRQ router default [10de/01e0] at 0000:00:00.0 [ 23.902852] PCI: Bridge: 0000:00:08.0 [ 23.902858] IO window: c000-cfff [ 23.902866] MEM window: e2000000-e3ffffff [ 23.902873] PREFETCH window: 88000000-880fffff [ 23.902880] PCI: Bridge: 0000:00:1e.0 [ 23.902882] IO window: disabled. [ 23.902888] MEM window: disabled. [ 23.902893] PREFETCH window: disabled. [ 23.902908] PCI: Setting latency timer of device 0000:00:08.0 to 64 [ 23.902941] NET: Registered protocol family 2 [ 23.909129] Time: tsc clocksource has been installed. [ 23.979170] IP route cache hash table entries: 32768 (order: 5, 131072 bytes) [ 23.979413] TCP established hash table entries: 65536 (order: 9, 2883584 bytes) [ 23.985721] TCP bind hash table entries: 65536 (order: 9, 2883584 bytes) [ 23.992086] TCP: Hash tables configured (established 65536 bind 65536) [ 23.992127] TCP reno registered [ 24.019519] Machine check exception polling timer started. [ 24.020371] Initializing RT-Tester: OK [ 24.020483] highmem bounce pool size: 64 pages [ 24.020630] VFS: Disk quotas dquot_6.5.1 [ 24.020646] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) [ 24.020829] JFS: nTxBlock = 8192, nTxLock = 65536 [ 24.027746] SGI XFS with ACLs, no debug enabled [ 24.028043] io scheduler noop registered [ 24.028049] io scheduler deadline registered (default) [ 24.093029] Real Time Clock Driver v1.12ac [ 24.093138] 3c59x: Donald Becker and others. www.scyld.com/network/vortex.html [ 24.093149] 0000:01:08.0: 3Com PCI 3c905B Cyclone 100baseTx at f8d4a000. [ 24.115379] forcedeth.c: Reverse Engineered nForce ethernet driver. Version 0.60. [ 24.115468] PCI: Setting latency timer of device 0000:00:04.0 to 64 [ 24.639102] eth1: forcedeth.c: subsystem: 01043:80a7 bound to 0000:00:04.0 [ 24.639126] netconsole: not configured, aborting [ 24.639131] Uniform Multi-Platform E-IDE driver Revision: 7.00alpha2 [ 24.639138] ide: Assuming 33MHz system bus speed for PIO modes; override with idebus=xx [ 24.639217] NFORCE2: IDE controller at PCI slot 0000:00:09.0 [ 24.639237] NFORCE2: chipset revision 162 [ 24.639241] NFORCE2: not 100% native mode: will probe irqs later [ 24.639249] NFORCE2: BIOS didn't set cable bits correctly. Enabling workaround. [ 24.639254] NFORCE2: BIOS didn't set cable bits correctly. Enabling workaround. [ 24.639263] NFORCE2: 0000:00:09.0 (rev a2) UDMA133 controller [ 24.639274] ide0: BM-DMA at 0xf000-0xf007, BIOS settings: hda:DMA, hdb:DMA [ 24.639289] ide1: BM-DMA at 0xf008-0xf00f, BIOS settings: hdc:DMA, hdd:DMA [ 24.639302] Probing IDE interface ide0... [ 24.938821] hda: SAMSUNG HD400LD, ATA DISK drive [ 25.238695] hdb: SAMSUNG SP1604N, ATA DISK drive [ 25.298906] ide0 at 0x1f0-0x1f7,0x3f6 on irq 14 [ 25.299018] Probing IDE interface ide1... [ 25.598545] hdc: SAMSUNG HD400LD, ATA DISK drive [ 25.898419] hdd: WDC WD1600BB-00GUA0, ATA DISK drive [ 25.960926] ide1 at 0x170-0x177,0x376 on irq 15 [ 25.961194] hda: max request size: 512KiB [ 25.963744] hda: 781422768 sectors (400088 MB) w/8192KiB Cache, CHS=48641/255/63, UDMA(100) [ 25.963937] hda: cache flushes supported [ 25.964053] hda: hda1 hda2 hda3 [ 25.972566] hdb: max request size: 512KiB [ 25.974650] hdb: 312581808 sectors (160041 MB) w/2048KiB Cache, CHS=19457/255/63, UDMA(100) [ 25.974875] hdb: cache flushes supported [ 25.974916] hdb: hdb1 hdb2 [ 25.981911] hdc: max request size: 512KiB [ 25.984273] hdc: 781422768 sectors (400088 MB) w/8192KiB Cache, CHS=48641/255/63, UDMA(100) [ 25.984461] hdc: cache flushes supported [ 25.984494] hdc: hdc1 hdc2 hdc3 [ 25.987352] hdd: max request size: 512KiB [ 26.003807] hdd: 312581808 sectors (160041 MB) w/2048KiB Cache, CHS=19457/255/63, UDMA(100) [ 26.005484] hdd: cache flushes supported [ 26.005525] hdd: hdd1 hdd2 [ 26.201286] sym0: <895> rev 0x1 at pci 0000:01:06.0 irq 11 [ 26.203469] sym0: Tekram NVRAM, ID 7, Fast-40, LVD, parity checking [ 26.210066] sym0: SCSI BUS has been reset. [ 26.210086] scsi0 : sym-2.2.3 [ 29.207887] target0:0:0: FAST-40 WIDE SCSI 80.0 MB/s ST (25 ns, offset 31) [ 29.208819] scsi 0:0:0:0: Direct-Access IBM-ESXS ST336607LW FN B258 PQ: 0 ANSI: 3 [ 29.208829] target0:0:0: tagged command queuing enabled, command queue depth 16. [ 29.208928] target0:0:0: Beginning Domain Validation [ 29.210368] target0:0:0: asynchronous [ 29.213818] target0:0:0: wide asynchronous [ 29.215539] target0:0:0: FAST-40 WIDE SCSI 80.0 MB/s ST (25 ns, offset 31) [ 29.217561] target0:0:0: Domain Validation skipping write tests [ 29.217565] target0:0:0: Ending Domain Validation [ 29.221190] target0:0:1: FAST-40 WIDE SCSI 80.0 MB/s ST (25 ns, offset 31) [ 29.224280] scsi 0:0:1:0: Direct-Access IBM-ESXS ST318305LW !# B244 PQ: 0 ANSI: 3 [ 29.224288] target0:0:1: tagged command queuing enabled, command queue depth 16. [ 29.224298] target0:0:1: Beginning Domain Validation [ 29.227962] target0:0:1: asynchronous [ 29.239802] target0:0:1: wide asynchronous [ 29.245776] target0:0:1: FAST-40 WIDE SCSI 80.0 MB/s ST (25 ns, offset 31) [ 29.253924] target0:0:1: Domain Validation skipping write tests [ 29.253929] target0:0:1: Ending Domain Validation [ 33.099613] SCSI device sda: 71096640 512-byte hdwr sectors (36401 MB) [ 33.100753] sda: Write Protect is off [ 33.100758] sda: Mode Sense: b3 00 10 08 [ 33.102168] SCSI device sda: write cache: disabled, read cache: enabled, supports DPO and FUA [ 33.102857] SCSI device sda: 71096640 512-byte hdwr sectors (36401 MB) [ 33.103994] sda: Write Protect is off [ 33.103998] sda: Mode Sense: b3 00 10 08 [ 33.105409] SCSI device sda: write cache: disabled, read cache: enabled, supports DPO and FUA [ 33.105416] sda: sda1 sda2 < sda5 sda6 sda7 > [ 33.131891] sd 0:0:0:0: Attached scsi disk sda [ 33.133370] SCSI device sdb: 35548320 512-byte hdwr sectors (18201 MB) [ 33.134730] sdb: Write Protect is off [ 33.134734] sdb: Mode Sense: ab 00 10 08 [ 33.136685] SCSI device sdb: write cache: disabled, read cache: enabled, supports DPO and FUA [ 33.137647] SCSI device sdb: 35548320 512-byte hdwr sectors (18201 MB) [ 33.138996] sdb: Write Protect is off [ 33.139000] sdb: Mode Sense: ab 00 10 08 [ 33.140951] SCSI device sdb: write cache: disabled, read cache: enabled, supports DPO and FUA [ 33.140958] sdb: sdb1 sdb2 [ 33.149792] sd 0:0:1:0: Attached scsi disk sdb [ 33.149890] PCI: Setting latency timer of device 0000:00:02.2 to 64 [ 33.149895] ehci_hcd 0000:00:02.2: EHCI Host Controller [ 33.150301] ehci_hcd 0000:00:02.2: new USB bus registered, assigned bus number 1 [ 33.150358] ehci_hcd 0000:00:02.2: debug port 1 [ 33.150366] PCI: cache line size of 64 is not supported by device 0000:00:02.2 [ 33.150374] ehci_hcd 0000:00:02.2: irq 11, io mem 0xe4001000 [ 33.150384] ehci_hcd 0000:00:02.2: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004 [ 33.150752] usb usb1: configuration #1 chosen from 1 choice [ 33.150869] hub 1-0:1.0: USB hub found [ 33.150927] hub 1-0:1.0: 6 ports detected [ 33.255603] ohci_hcd: 2006 August 04 USB 1.1 'Open' Host Controller (OHCI) Driver [ 33.255703] PCI: Setting latency timer of device 0000:00:02.0 to 64 [ 33.255707] ohci_hcd 0000:00:02.0: OHCI Host Controller [ 33.255764] ohci_hcd 0000:00:02.0: new USB bus registered, assigned bus number 2 [ 33.255782] ohci_hcd 0000:00:02.0: irq 12, io mem 0xe4005000 [ 33.317370] usb usb2: configuration #1 chosen from 1 choice [ 33.317445] hub 2-0:1.0: USB hub found [ 33.317460] hub 2-0:1.0: 3 ports detected [ 33.425310] PCI: Setting latency timer of device 0000:00:02.1 to 64 [ 33.425315] ohci_hcd 0000:00:02.1: OHCI Host Controller [ 33.425374] ohci_hcd 0000:00:02.1: new USB bus registered, assigned bus number 3 [ 33.425393] ohci_hcd 0000:00:02.1: irq 10, io mem 0xe4000000 [ 33.487321] usb usb3: configuration #1 chosen from 1 choice [ 33.487382] hub 3-0:1.0: USB hub found [ 33.487398] hub 3-0:1.0: 3 ports detected [ 33.894954] usb 3-2: new low speed USB device using ohci_hcd and address 2 [ 34.074947] usb 3-2: configuration #1 chosen from 1 choice [ 34.078108] input: USB HIDBP Keyboard 046a:0001 as /class/input/input0 [ 34.078199] usbcore: registered new interface driver usbkbd [ 34.078205] drivers/usb/input/usbkbd.c: :USB HID Boot Protocol keyboard driver [ 34.325239] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 34.325404] mice: PS/2 mouse device common for all mice [ 34.325524] md: raid0 personality registered for level 0 [ 34.325529] md: raid1 personality registered for level 1 [ 34.325728] device-mapper: ioctl: 4.11.0-ioctl (2006-10-12) initialised: dm-devel@redhat.com [ 34.325859] TCP cubic registered [ 34.325871] NET: Registered protocol family 1 [ 34.325912] NET: Registered protocol family 10 [ 34.326015] lo: Disabled Privacy Extensions [ 34.326201] IPv6 over IPv4 tunneling driver [ 34.326346] sit0: Disabled Privacy Extensions [ 34.326364] NET: Registered protocol family 17 [ 34.326384] Testing NMI watchdog ... OK. [ 34.426419] Using IPI Shortcut mode [ 34.644975] md: Autodetecting RAID arrays. [ 34.789560] md: autorun ... [ 34.789565] md: considering sdb2 ... [ 34.789577] md: adding sdb2 ... [ 34.789583] md: adding hdd2 ... [ 34.789588] md: hdd1 has different UUID to sdb2 [ 34.789592] md: hdc3 has different UUID to sdb2 [ 34.789597] md: hdc2 has different UUID to sdb2 [ 34.789601] md: hdc1 has different UUID to sdb2 [ 34.789608] md: adding hdb2 ... [ 34.789613] md: hdb1 has different UUID to sdb2 [ 34.789617] md: hda3 has different UUID to sdb2 [ 34.789622] md: hda2 has different UUID to sdb2 [ 34.789627] md: hda1 has different UUID to sdb2 [ 34.789737] md: created md4 [ 34.789742] md: bind [ 34.789817] md: bind [ 34.789834] md: bind [ 34.789850] md: running: [ 34.790060] md4: setting max_sectors to 128, segment boundary to 32767 [ 34.790066] raid0: looking at sdb2 [ 34.790070] raid0: comparing sdb2(12891072) with sdb2(12891072) [ 34.790075] raid0: END [ 34.790077] raid0: ==> UNIQUE [ 34.790080] raid0: 1 zones [ 34.790083] raid0: looking at hdd2 [ 34.790086] raid0: comparing hdd2(12297664) with sdb2(12891072) [ 34.790091] raid0: NOT EQUAL [ 34.790094] raid0: comparing hdd2(12297664) with hdd2(12297664) [ 34.790099] raid0: END [ 34.790101] raid0: ==> UNIQUE [ 34.790104] raid0: 2 zones [ 34.790106] raid0: looking at hdb2 [ 34.790110] raid0: comparing hdb2(12297664) with sdb2(12891072) [ 34.790114] raid0: NOT EQUAL [ 34.790117] raid0: comparing hdb2(12297664) with hdd2(12297664) [ 34.790122] raid0: EQUAL [ 34.790124] raid0: FINAL 2 zones [ 34.790129] raid0: zone 1 [ 34.790131] raid0: checking sdb2 ... contained as device 0 [ 34.790136] (12891072) is smallest!. [ 34.790139] raid0: checking hdb2 ... nope. [ 34.790142] raid0: checking hdd2 ... nope. [ 34.790146] raid0: zone->nb_dev: 1, size: 593408 [ 34.790150] raid0: current zone offset: 12891072 [ 34.790153] raid0: done. [ 34.790156] raid0 : md_size is 37486400 blocks. [ 34.790159] raid0 : conf->hash_spacing is 36892992 blocks. [ 34.790163] raid0 : nb_zone is 2. [ 34.790166] raid0 : Allocating 8 bytes for hash. [ 34.790306] md: considering hdd1 ... [ 34.790321] md: adding hdd1 ... [ 34.790325] md: hdc3 has different UUID to hdd1 [ 34.790330] md: hdc2 has different UUID to hdd1 [ 34.790335] md: hdc1 has different UUID to hdd1 [ 34.790341] md: adding hdb1 ... [ 34.790346] md: hda3 has different UUID to hdd1 [ 34.790351] md: hda2 has different UUID to hdd1 [ 34.790355] md: hda1 has different UUID to hdd1 [ 34.790434] md: created md3 [ 34.790438] md: bind [ 34.790470] md: bind [ 34.790486] md: running: [ 34.790673] raid1: raid set md3 active with 2 out of 2 mirrors [ 34.790752] md: considering hdc3 ... [ 34.790767] md: adding hdc3 ... [ 34.790771] md: hdc2 has different UUID to hdc3 [ 34.790776] md: hdc1 has different UUID to hdc3 [ 34.790783] md: adding hda3 ... [ 34.790787] md: hda2 has different UUID to hdc3 [ 34.790792] md: hda1 has different UUID to hdc3 [ 34.790913] md: created md2 [ 34.790917] md: bind [ 34.790947] md: bind [ 34.790966] md: running: [ 34.791030] md2: setting max_sectors to 128, segment boundary to 32767 [ 34.791035] raid0: looking at hdc3 [ 34.791039] raid0: comparing hdc3(771008) with hdc3(771008) [ 34.791044] raid0: END [ 34.791046] raid0: ==> UNIQUE [ 34.791049] raid0: 1 zones [ 34.791052] raid0: looking at hda3 [ 34.791055] raid0: comparing hda3(771008) with hdc3(771008) [ 34.791059] raid0: EQUAL [ 34.791062] raid0: FINAL 1 zones [ 34.791065] raid0: done. [ 34.791068] raid0 : md_size is 1542016 blocks. [ 34.791071] raid0 : conf->hash_spacing is 1542016 blocks. [ 34.791075] raid0 : nb_zone is 1. [ 34.791078] raid0 : Allocating 4 bytes for hash. [ 34.791126] md: considering hdc2 ... [ 34.791141] md: adding hdc2 ... [ 34.791146] md: hdc1 has different UUID to hdc2 [ 34.791153] md: adding hda2 ... [ 34.791157] md: hda1 has different UUID to hdc2 [ 34.791232] md: created md1 [ 34.791236] md: bind [ 34.791252] md: bind [ 34.791282] md: running: [ 34.791446] raid1: raid set md1 active with 2 out of 2 mirrors [ 34.791511] md: considering hdc1 ... [ 34.791525] md: adding hdc1 ... [ 34.791532] md: adding hda1 ... [ 34.791537] md: created md0 [ 34.791540] md: bind [ 34.791565] md: bind [ 34.791581] md: running: [ 34.791723] raid1: raid set md0 active with 2 out of 2 mirrors [ 34.791789] md: ... autorun DONE. [ 34.826065] kjournald starting. Commit interval 5 seconds [ 34.826203] EXT3-fs: mounted filesystem with ordered data mode. [ 34.826282] VFS: Mounted root (ext3 filesystem) readonly. [ 34.826495] Freeing unused kernel memory: 156k freed [ 37.110951] EXT3 FS on sda5, internal journal [ 37.949109] loop: loaded (max 8 devices) [ 48.179280] ReiserFS: sdb1: found reiserfs format "3.6" with standard journal [ 48.179336] ReiserFS: sdb1: using ordered data mode [ 48.185947] ReiserFS: sdb1: journal params: device sdb1, size 8192, journal first block 18, max trans len 1024, max batch 900, max commit age 30, max trans age 30 [ 48.187007] ReiserFS: sdb1: checking transaction log (sdb1) [ 48.221914] ReiserFS: sdb1: Using r5 hash to sort names [ 48.352246] ReiserFS: md4: found reiserfs format "3.6" with standard journal [ 48.352267] ReiserFS: md4: using ordered data mode [ 48.354121] ReiserFS: md4: journal params: device md4, size 8192, journal first block 18, max trans len 1024, max batch 900, max commit age 30, max trans age 30 [ 48.355034] ReiserFS: md4: checking transaction log (md4) [ 48.368538] ReiserFS: md4: Using r5 hash to sort names [ 48.450271] Adding 1542008k swap on /dev/mapper/md2. Priority:1 extents:1 across:1542008k [ 49.190725] eth1: setting full-duplex. [ 56.185544] spurious 8259A interrupt: IRQ7. [ 58.646920] Installing knfsd (copyright (C) 1996 okir@monad.swb.de). [ 58.714971] NFSD: Using /var/lib/nfs/v4recovery as the NFSv4 state recovery directory [ 58.715763] NFSD: starting 90-second grace period [ 59.434157] eth0: no IPv6 routers present [ 60.013915] eth1: no IPv6 routers present [ 118.662287] kjournald starting. Commit interval 5 seconds [ 118.662934] EXT3-fs: mounted filesystem with ordered data mode. [ 125.457221] XFS mounting filesystem dm-2 [ 125.737178] Ending clean XFS mount for filesystem: dm-2 [ 131.681230] XFS mounting filesystem dm-3 [ 132.013168] Ending clean XFS mount for filesystem: dm-3 [ 141.894688] kjournald starting. Commit interval 5 seconds [ 141.902098] EXT3 FS on dm-4, internal journal [ 141.902105] EXT3-fs: recovery complete. [ 141.912631] EXT3-fs: mounted filesystem with ordered data mode. [ 153.426882] ip_tables: (C) 2000-2006 Netfilter Core Team [ 416.943415] nfsd: last server has exited [ 416.943428] nfsd: unexporting all filesystems [ 464.764659] NFSD: Using /var/lib/nfs/v4recovery as the NFSv4 state recovery directory [ 464.764698] NFSD: starting 90-second grace period [ 782.339162] nf_conntrack version 0.5.0 (8192 buckets, 65536 max) [ 4019.499383] nfsd: last server has exited [ 4019.499395] nfsd: unexporting all filesystems [ 4019.501033] RPC: failed to contact portmap (errno -5). [ 4020.582008] NFSD: Using /var/lib/nfs/v4recovery as the NFSv4 state recovery directory [ 4020.582656] NFSD: starting 90-second grace period [ 7584.150947] parport0: PC-style at 0x378 (0x778) [PCSPP,TRISTATE] [ 7584.290588] parport0: irq 7 detected [ 7584.371303] lp0: using parport0 (polling). [ 8587.556839] usb 3-2: USB disconnect, address 2 [48117.979313] u32 classifier [48117.979325] Performance counters on [48117.979328] Actions configured [48362.435208] i2c_adapter i2c-0: nForce2 SMBus adapter at 0x5000 [48363.015186] i2c_adapter i2c-1: nForce2 SMBus adapter at 0x5500 [93422.248250] [93422.248254] ============================================= [93422.248268] [ INFO: possible recursive locking detected ] [93422.248273] 2.6.21-rc5 #2 [93422.248276] --------------------------------------------- [93422.248280] rm/32198 is trying to acquire lock: [93422.248284] (&(&ip->i_lock)->mr_lock){----}, at: [] xfs_ilock+0x71/0xa0 [93422.248299] [93422.248300] but task is already holding lock: [93422.248304] (&(&ip->i_lock)->mr_lock){----}, at: [] xfs_ilock+0x71/0xa0 [93422.248314] [93422.248314] other info that might help us debug this: [93422.248320] 3 locks held by rm/32198: [93422.248323] #0: (&inode->i_mutex/1){--..}, at: [] do_unlinkat+0x96/0x160 [93422.248334] #1: (&inode->i_mutex){--..}, at: [] vfs_unlink+0x75/0xe0 [93422.248346] #2: (&(&ip->i_lock)->mr_lock){----}, at: [] xfs_ilock+0x71/0xa0 [93422.248356] [93422.248357] stack backtrace: [93422.248362] [] __lock_acquire+0xa99/0x1010 [93422.248373] [] lock_acquire+0x57/0x70 [93422.248379] [] xfs_ilock+0x71/0xa0 [93422.248385] [] down_write+0x38/0x50 [93422.248393] [] xfs_ilock+0x71/0xa0 [93422.248399] [] xfs_ilock+0x71/0xa0 [93422.248405] [] xfs_lock_dir_and_entry+0xf6/0x100 [93422.248413] [] xfs_remove+0x197/0x4e0 [93422.248419] [] d_instantiate+0x19/0x40 [93422.248426] [] d_rehash+0x20/0x50 [93422.248434] [] vfs_unlink+0x75/0xe0 [93422.248442] [] xfs_vn_unlink+0x23/0x60 [93422.248449] [] __mutex_lock_slowpath+0x13f/0x280 [93422.248459] [] mark_held_locks+0x6b/0x90 [93422.248464] [] __mutex_lock_slowpath+0x13f/0x280 [93422.248471] [] __mutex_lock_slowpath+0x13f/0x280 [93422.248478] [] trace_hardirqs_on+0xb9/0x160 [93422.248484] [] vfs_unlink+0x75/0xe0 [93422.248491] [] __mutex_lock_slowpath+0x132/0x280 [93422.248498] [] vfs_unlink+0x75/0xe0 [93422.248504] [] permission+0x91/0xf0 [93422.248512] [] vfs_unlink+0x89/0xe0 [93422.248518] [] do_unlinkat+0xd2/0x160 [93422.248526] [] sysenter_past_esp+0x8d/0x99 [93422.248533] [] trace_hardirqs_on+0xb9/0x160 [93422.248541] [] sysenter_past_esp+0x5d/0x99 [93422.248550] =======================