[ 0.000000] Linux version 2.6.24-rc6 (evil@sheep) (gcc version 4.2.3 20080102 (prerelease) (Debian 4.2.2-5)) #1 Thu Jan 3 22:37:41 CET 2008 [ 0.000000] BIOS-provided physical RAM map: [ 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] Movable zone start PFN for each node [ 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] Movable zone: 0 pages used for memmap [ 0.000000] DMI 2.2 present. [ 0.000000] Allocating PCI resources starting at 88000000 (gap: 80000000:7ec00000) [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 520177 [ 0.000000] Kernel command line: root=/dev/sda5 ro netconsole=@192.168.10.10/eth0,514@192.168.10.29/00:0D:93:C9:95:CA [ 0.000000] Found and enabled local APIC! [ 0.000000] mapped APIC to ffffb000 (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=c055f000 soft=c055e000 [ 0.000000] PID hash table entries: 4096 (order: 12, 16384 bytes) [ 0.000000] Detected 1913.196 MHz processor. [ 33.757627] Console: colour VGA+ 80x25 [ 33.757633] console [tty0] enabled [ 33.766715] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 33.767388] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 33.767755] ... MAX_LOCK_DEPTH: 30 [ 33.768120] ... MAX_LOCKDEP_KEYS: 2048 [ 33.768490] ... CLASSHASH_SIZE: 1024 [ 33.768862] ... MAX_LOCKDEP_ENTRIES: 8192 [ 33.769232] ... MAX_LOCKDEP_CHAINS: 16384 [ 33.769604] ... CHAINHASH_SIZE: 8192 [ 33.769974] memory used by lock dependency info: 992 kB [ 33.770372] per task-struct memory footprint: 1200 bytes [ 33.770772] ------------------------ [ 33.771119] | Locking API testsuite: [ 33.771465] ---------------------------------------------------------------------------- [ 33.772147] | spin |wlock |rlock |mutex | wsem | rsem | [ 33.772830] -------------------------------------------------------------------------- [ 33.773517] A-A deadlock: ok | ok | ok | ok | ok | ok | [ 33.775375] A-B-B-A deadlock: ok | ok | ok | ok | ok | ok | [ 33.777172] A-B-B-C-C-A deadlock: ok | ok | ok | ok | ok | ok | [ 33.778916] A-B-C-A-B-C deadlock: ok | ok | ok | ok | ok | ok | [ 33.780324] A-B-B-C-C-D-D-A deadlock: ok | ok | ok | ok | ok | ok | [ 33.782072] A-B-C-D-B-D-D-A deadlock: ok | ok | ok | ok | ok | ok | [ 33.783901] A-B-C-D-B-C-D-A deadlock: ok | ok | ok | ok | ok | ok | [ 33.785732] double unlock: ok | ok | ok | ok | ok | ok | [ 33.787515] initialize held: ok | ok | ok | ok | ok | ok | [ 33.789297] bad unlock order: ok | ok | ok | ok | ok | ok | [ 33.791095] -------------------------------------------------------------------------- [ 33.791778] recursive read-lock: | ok | | ok | [ 33.792941] recursive read-lock #2: | ok | | ok | [ 33.793785] mixed read-write-lock: | ok | | ok | [ 33.794554] mixed write-read-lock: | ok | | ok | [ 33.795621] -------------------------------------------------------------------------- [ 33.796304] hard-irqs-on + irq-safe-A/12: ok | ok | ok | [ 33.797303] soft-irqs-on + irq-safe-A/12: ok | ok | ok | [ 33.798304] hard-irqs-on + irq-safe-A/21: ok | ok | ok | [ 33.799302] soft-irqs-on + irq-safe-A/21: ok | ok | ok | [ 33.800300] sirq-safe-A => hirqs-on/12: ok | ok | ok | [ 33.801300] sirq-safe-A => hirqs-on/21: ok | ok | ok | [ 33.802299] hard-safe-A + irqs-on/12: ok | ok | ok | [ 33.803297] soft-safe-A + irqs-on/12: ok | ok | ok | [ 33.804298] hard-safe-A + irqs-on/21: ok | ok | ok | [ 33.805298] soft-safe-A + irqs-on/21: ok | ok | ok | [ 33.806297] hard-safe-A + unsafe-B #1/123: ok | ok | ok | [ 33.807302] soft-safe-A + unsafe-B #1/123: ok | ok | ok | [ 33.808110] hard-safe-A + unsafe-B #1/132: ok | ok | ok | [ 33.808878] soft-safe-A + unsafe-B #1/132: ok | ok | ok | [ 33.809817] hard-safe-A + unsafe-B #1/213: ok | ok | ok | [ 33.810824] soft-safe-A + unsafe-B #1/213: ok | ok | ok | [ 33.811830] hard-safe-A + unsafe-B #1/231: ok | ok | ok | [ 33.812837] soft-safe-A + unsafe-B #1/231: ok | ok | ok | [ 33.813842] hard-safe-A + unsafe-B #1/312: ok | ok | ok | [ 33.814844] soft-safe-A + unsafe-B #1/312: ok | ok | ok | [ 33.815848] hard-safe-A + unsafe-B #1/321: ok | ok | ok | [ 33.816855] soft-safe-A + unsafe-B #1/321: ok | ok | ok | [ 33.817861] hard-safe-A + unsafe-B #2/123: ok | ok | ok | [ 33.818868] soft-safe-A + unsafe-B #2/123: ok | ok | ok | [ 33.819876] hard-safe-A + unsafe-B #2/132: ok | ok | ok | [ 33.820882] soft-safe-A + unsafe-B #2/132: ok | ok | ok | [ 33.821765] hard-safe-A + unsafe-B #2/213: ok | ok | ok | [ 33.822533] soft-safe-A + unsafe-B #2/213: ok | ok | ok | [ 33.823413] hard-safe-A + unsafe-B #2/231: ok | ok | ok | [ 33.824418] soft-safe-A + unsafe-B #2/231: ok | ok | ok | [ 33.825426] hard-safe-A + unsafe-B #2/312: ok | ok | ok | [ 33.826433] soft-safe-A + unsafe-B #2/312: ok | ok | ok | [ 33.827441] hard-safe-A + unsafe-B #2/321: ok | ok | ok | [ 33.828446] soft-safe-A + unsafe-B #2/321: ok | ok | ok | [ 33.829454] hard-irq lock-inversion/123: ok | ok | ok | [ 33.830462] soft-irq lock-inversion/123: ok | ok | ok | [ 33.831470] hard-irq lock-inversion/132: ok | ok | ok | [ 33.832477] soft-irq lock-inversion/132: ok | ok | ok | [ 33.833485] hard-irq lock-inversion/213: ok | ok | ok | [ 33.834494] soft-irq lock-inversion/213: ok | ok | ok | [ 33.835501] hard-irq lock-inversion/231: ok | ok | ok | [ 33.836373] soft-irq lock-inversion/231: ok | ok | ok | [ 33.837147] hard-irq lock-inversion/312: ok | ok | ok | [ 33.838054] soft-irq lock-inversion/312: ok | ok | ok | [ 33.839065] hard-irq lock-inversion/321: ok | ok | ok | [ 33.840075] soft-irq lock-inversion/321: ok | ok | ok | [ 33.841085] hard-irq read-recursion/123: ok | [ 33.841699] soft-irq read-recursion/123: ok | [ 33.842313] hard-irq read-recursion/132: ok | [ 33.842925] soft-irq read-recursion/132: ok | [ 33.843539] hard-irq read-recursion/213: ok | [ 33.844152] soft-irq read-recursion/213: ok | [ 33.844766] hard-irq read-recursion/231: ok | [ 33.845378] soft-irq read-recursion/231: ok | [ 33.845992] hard-irq read-recursion/312: ok | [ 33.846606] soft-irq read-recursion/312: ok | [ 33.847220] hard-irq read-recursion/321: ok | [ 33.847832] soft-irq read-recursion/321: ok | [ 33.848447] ------------------------------------------------------- [ 33.848873] Good, all 218 testcases passed! | [ 33.849242] --------------------------------- [ 33.850170] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes) [ 33.850991] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes) [ 33.956122] Memory: 2071816k/2097088k available (3178k kernel code, 24044k reserved, 1101k data, 172k init, 1179584k highmem) [ 33.956908] virtual kernel memory layout: [ 33.956910] fixmap : 0xfffad000 - 0xfffff000 ( 328 kB) [ 33.956911] pkmap : 0xff800000 - 0xffc00000 (4096 kB) [ 33.956913] vmalloc : 0xf8800000 - 0xff7fe000 ( 111 MB) [ 33.956914] lowmem : 0xc0000000 - 0xf8000000 ( 896 MB) [ 33.956915] .init : 0xc0530000 - 0xc055b000 ( 172 kB) [ 33.956917] .data : 0xc041aab2 - 0xc052e154 (1101 kB) [ 33.956918] .text : 0xc0100000 - 0xc041aab2 (3178 kB) [ 33.960134] Checking if this processor honours the WP bit even in supervisor mode... Ok. [ 33.960910] SLUB: Genslabs=11, HWalign=32, Order=0-1, MinObjects=4, CPUs=1, Nodes=1 [ 34.111547] Calibrating delay using timer specific routine.. 3829.39 BogoMIPS (lpj=19146969) [ 34.112327] Mount-cache hash table entries: 512 [ 34.112998] CPU: After generic identify, caps: 0383fbff c1c3fbff 00000000 00000000 00000000 00000000 00000000 00000000 [ 34.113010] CPU: L1 I Cache: 64K (64 bytes/line), D cache 64K (64 bytes/line) [ 34.113463] CPU: L2 Cache: 512K (64 bytes/line) [ 34.113837] CPU: After all inits, caps: 0383fbff c1c3fbff 00000000 00000420 00000000 00000000 00000000 00000000 [ 34.113847] Intel machine check architecture supported. [ 34.114243] Intel machine check reporting enabled on CPU#0. [ 34.114651] Compat vDSO mapped to ffffe000. [ 34.115026] CPU: AMD Athlon(tm) XP 2600+ stepping 00 [ 34.115502] Checking 'hlt' instruction... OK. [ 34.152018] Freeing SMP alternatives: 0k freed [ 34.391758] net_namespace: 76 bytes [ 34.392673] NET: Registered protocol family 16 [ 34.425193] PCI: PCI BIOS revision 2.10 entry at 0xfb4a0, last bus=2 [ 34.425622] PCI: Using configuration type 1 [ 34.425987] Setting up standard PCI resources [ 34.430818] SCSI subsystem initialized [ 34.431360] usbcore: registered new interface driver usbfs [ 34.431840] usbcore: registered new interface driver hub [ 34.432324] usbcore: registered new device driver usb [ 34.432893] PCI: Probing PCI hardware [ 34.433261] PCI: Probing PCI hardware (bus 00) [ 34.433398] PCI: nForce2 C1 Halt Disconnect fixup [ 34.436892] PCI: Discovered primary peer bus ff [IRQ] [ 34.437287] PCI: Using IRQ router default [10de/01e0] at 0000:00:00.0 [ 34.522180] PCI: Bridge: 0000:00:08.0 [ 34.522402] IO window: c000-cfff [ 34.522748] MEM window: e2000000-e3ffffff [ 34.523115] PREFETCH window: e4000000-e4ffffff [ 34.523503] PCI: Bridge: 0000:00:1e.0 [ 34.523852] IO window: disabled. [ 34.537887] Time: tsc clocksource has been installed. [ 34.538292] MEM window: disabled. [ 34.538640] PREFETCH window: disabled. [ 34.539008] PCI: Setting latency timer of device 0000:00:08.0 to 64 [ 34.539030] NET: Registered protocol family 2 [ 34.631450] IP route cache hash table entries: 32768 (order: 5, 131072 bytes) [ 34.632487] TCP established hash table entries: 131072 (order: 8, 1048576 bytes) [ 34.634525] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes) [ 34.640643] TCP: Hash tables configured (established 131072 bind 65536) [ 34.641110] TCP reno registered [ 34.671923] Machine check exception polling timer started. [ 34.673476] Initializing RT-Tester: OK [ 34.674029] highmem bounce pool size: 64 pages [ 34.678694] VFS: Disk quotas dquot_6.5.1 [ 34.679021] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) [ 34.680513] JFS: nTxBlock = 8192, nTxLock = 65536 [ 34.687620] SGI XFS with ACLs, no debug enabled [ 34.689469] io scheduler noop registered [ 34.689828] io scheduler anticipatory registered [ 34.690207] io scheduler deadline registered (default) [ 34.690723] io scheduler cfq registered [ 34.733464] spurious 8259A interrupt: IRQ7. [ 34.751316] Boot video device is 0000:01:0a.0 [ 34.755836] Real Time Clock Driver v1.12ac [ 34.756203] Serial: 8250/16550 driver $Revision: 1.90 $ 4 ports, IRQ sharing disabled [ 34.757075] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A [ 34.757668] serial8250: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A [ 34.758607] 3c59x: Donald Becker and others. [ 34.758980] 0000:01:08.0: 3Com PCI 3c905B Cyclone 100baseTx at f8d1a000. [ 34.781772] forcedeth: Reverse Engineered nForce ethernet driver. Version 0.61. [ 34.782453] PCI: Setting latency timer of device 0000:00:04.0 to 64 [ 35.311692] forcedeth 0000:00:04.0: ifname eth1, PHY OUI 0x20 @ 1, addr 00:11:2f:23:1e:7f [ 35.312380] forcedeth 0000:00:04.0: timirq lnktim desc-v1 [ 35.312833] netconsole: local port 6665 [ 35.313189] netconsole: local IP 192.168.10.10 [ 35.313561] netconsole: interface eth0 [ 35.313913] netconsole: remote port 514 [ 35.314268] netconsole: remote IP 192.168.10.29 [ 35.314643] netconsole: remote ethernet address 00:0d:93:c9:95:ca [ 35.315068] netconsole: device eth0 not up yet, forcing it [ 35.316851] eth0: setting full-duplex. [ 35.327995] netconsole: carrier detect appears untrustworthy, waiting 4 seconds [ 39.359346] console [netcon0] enabled [ 39.456811] netconsole: network logging started [ 39.457123] Uniform Multi-Platform E-IDE driver Revision: 7.00alpha2 [ 39.457341] ide: Assuming 33MHz system bus speed for PIO modes; override with idebus=xx [ 39.457764] NFORCE2: IDE controller (0x10de:0x0065 rev 0xa2) at PCI slot 0000:00:09.0 [ 39.458090] NFORCE2: not 100% native mode: will probe irqs later [ 39.458287] NFORCE2: BIOS didn't set cable bits correctly. Enabling workaround. [ 39.458592] NFORCE2: BIOS didn't set cable bits correctly. Enabling workaround. [ 39.459259] NFORCE2: 0000:00:09.0 (rev a2) UDMA133 controller [ 39.459708] ide0: BM-DMA at 0xf000-0xf007, BIOS settings: hda:DMA, hdb:DMA [ 39.460485] ide1: BM-DMA at 0xf008-0xf00f, BIOS settings: hdc:DMA, hdd:DMA [ 39.461282] Probing IDE interface ide0... [ 39.479293] Clocksource tsc unstable (delta = 80005539 ns) [ 39.489289] Time: pit clocksource has been installed. [ 39.769291] hdb: SAMSUNG SP1604N, ATA DISK drive [ 40.129139] hda: SAMSUNG HD400LD, ATA DISK drive [ 40.129587] hda: host max PIO5 wanted PIO255(auto-tune) selected PIO4 [ 40.129681] hda: UDMA/100 mode selected [ 40.130143] hdb: host max PIO5 wanted PIO255(auto-tune) selected PIO4 [ 40.130201] hdb: UDMA/100 mode selected [ 40.130670] ide0 at 0x1f0-0x1f7,0x3f6 on irq 14 [ 40.131279] Probing IDE interface ide1... [ 40.318940] hdd: probing with STATUS(0x51) instead of ALTSTATUS(0x7f) [ 40.439008] hdd: ST3160023A, ATA DISK drive [ 40.678788] hdc: probing with STATUS(0x51) instead of ALTSTATUS(0x7f) [ 40.798855] hdc: SAMSUNG HD400LD, ATA DISK drive [ 40.799096] hdc: host max PIO5 wanted PIO255(auto-tune) selected PIO4 [ 40.799253] hdc: UDMA/100 mode selected [ 40.799593] hdd: host max PIO5 wanted PIO255(auto-tune) selected PIO4 [ 40.799919] hdd: UDMA/100 mode selected [ 40.800552] ide1 at 0x170-0x177,0x376 on irq 15 [ 40.801294] hda: max request size: 512KiB [ 40.802495] hda: 781422768 sectors (400088 MB) w/8192KiB Cache, CHS=48641/255/63 [ 40.803455] hda: cache flushes supported [ 40.803887] hda: hda1 hda2 hda3 [ 40.807457] hdb: max request size: 512KiB [ 40.808316] hdb: 312581808 sectors (160041 MB) w/2048KiB Cache, CHS=19457/255/63 [ 40.809331] hdb: cache flushes supported [ 40.809738] hdb: hdb1 hdb2 [ 40.815448] hdc: max request size: 512KiB [ 40.819156] hdc: Host Protected Area detected. [ 40.819157] current capacity is 781422768 sectors (400088 MB) [ 40.819159] native capacity is 162249630257328 sectors (83071810691 MB) [ 40.820777] hdc: task_no_data_intr: status=0x51 { DriveReady SeekComplete Error } [ 40.821634] hdc: task_no_data_intr: error=0x10 { SectorIdNotFound }, LBAsect=162249630257327, high=9670831, low=9670831, sector=0 [ 40.822672] ide: failed opcode was: 0x37 [ 40.823125] hdc: 781422768 sectors (400088 MB) w/8192KiB Cache, CHS=48641/255/63 [ 40.824157] hdc: cache flushes supported [ 40.824576] hdc: hdc1 hdc2 hdc3 [ 40.830957] hdd: max request size: 512KiB [ 40.831689] hdd: Host Protected Area detected. [ 40.831690] current capacity is 312581808 sectors (160041 MB) [ 40.831692] native capacity is 177702923509424 sectors (90983896836 MB) [ 40.988664] hdd: task_no_data_intr: status=0x51 { DriveReady SeekComplete Error } [ 40.989521] hdd: task_no_data_intr: error=0x04 { DriveStatusError } [ 40.990093] ide: failed opcode was: 0x37 [ 40.990549] hdd: 312581808 sectors (160041 MB) w/8192KiB Cache, CHS=19457/255/63 [ 40.991624] hdd: cache flushes supported [ 40.992032] hdd: hdd1 hdd2 [ 41.186401] sym0: <895> rev 0x1 at pci 0000:01:06.0 irq 11 [ 41.188953] sym0: Tekram NVRAM, ID 7, Fast-40, LVD, parity checking [ 41.195984] sym0: SCSI BUS has been reset. [ 41.196376] scsi0 : sym-2.2.3 [ 44.188270] target0:0:0: FAST-40 WIDE SCSI 80.0 MB/s ST (25 ns, offset 31) [ 44.189637] scsi 0:0:0:0: Direct-Access IBM-ESXS ST336607LW FN B258 PQ: 0 ANSI: 3 [ 44.190329] target0:0:0: tagged command queuing enabled, command queue depth 16. [ 44.191036] target0:0:0: Beginning Domain Validation [ 44.192805] target0:0:0: asynchronous [ 44.196611] target0:0:0: wide asynchronous [ 44.209672] target0:0:0: FAST-40 WIDE SCSI 80.0 MB/s ST (25 ns, offset 31) [ 44.212143] target0:0:0: Domain Validation skipping write tests [ 44.212565] target0:0:0: Ending Domain Validation [ 44.216652] target0:0:1: FAST-40 WIDE SCSI 80.0 MB/s ST (25 ns, offset 31) [ 44.220214] scsi 0:0:1:0: Direct-Access IBM-ESXS ST318305LW !# B244 PQ: 0 ANSI: 3 [ 44.220903] target0:0:1: tagged command queuing enabled, command queue depth 16. [ 44.221595] target0:0:1: Beginning Domain Validation [ 44.225715] target0:0:1: asynchronous [ 44.237982] target0:0:1: wide asynchronous [ 44.244278] target0:0:1: FAST-40 WIDE SCSI 80.0 MB/s ST (25 ns, offset 31) [ 44.252851] target0:0:1: Domain Validation skipping write tests [ 44.253274] target0:0:1: Ending Domain Validation [ 48.085698] sd 0:0:0:0: [sda] 71096640 512-byte hardware sectors (36401 MB) [ 48.087285] sd 0:0:0:0: [sda] Write Protect is off [ 48.087679] sd 0:0:0:0: [sda] Mode Sense: b3 00 10 08 [ 48.089109] sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA [ 48.090047] sd 0:0:0:0: [sda] 71096640 512-byte hardware sectors (36401 MB) [ 48.091631] sd 0:0:0:0: [sda] Write Protect is off [ 48.092018] sd 0:0:0:0: [sda] Mode Sense: b3 00 10 08 [ 48.093447] sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, supports DPO and FUA [ 48.094151] sda: sda1 sda2 < sda5 sda6 sda7 > [ 48.126160] sd 0:0:0:0: [sda] Attached SCSI disk [ 48.128062] sd 0:0:1:0: [sdb] 35548320 512-byte hardware sectors (18201 MB) [ 48.129846] sd 0:0:1:0: [sdb] Write Protect is off [ 48.130234] sd 0:0:1:0: [sdb] Mode Sense: ab 00 10 08 [ 48.132166] sd 0:0:1:0: [sdb] Write cache: disabled, read cache: enabled, supports DPO and FUA [ 48.133447] sd 0:0:1:0: [sdb] 35548320 512-byte hardware sectors (18201 MB) [ 48.135250] sd 0:0:1:0: [sdb] Write Protect is off [ 48.135663] sd 0:0:1:0: [sdb] Mode Sense: ab 00 10 08 [ 48.137633] sd 0:0:1:0: [sdb] Write cache: disabled, read cache: enabled, supports DPO and FUA [ 48.138337] sdb: sdb1 sdb2 [ 48.147116] sd 0:0:1:0: [sdb] Attached SCSI disk [ 48.147685] PCI: Setting latency timer of device 0000:00:02.2 to 64 [ 48.147690] ehci_hcd 0000:00:02.2: EHCI Host Controller [ 48.148307] ehci_hcd 0000:00:02.2: new USB bus registered, assigned bus number 1 [ 48.149033] ehci_hcd 0000:00:02.2: debug port 1 [ 48.149417] PCI: cache line size of 64 is not supported by device 0000:00:02.2 [ 48.149437] ehci_hcd 0000:00:02.2: irq 11, io mem 0xe5000000 [ 48.165616] ehci_hcd 0000:00:02.2: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004 [ 48.166680] usb usb1: configuration #1 chosen from 1 choice [ 48.167202] hub 1-0:1.0: USB hub found [ 48.167594] hub 1-0:1.0: 6 ports detected [ 48.275739] ohci_hcd: 2006 August 04 USB 1.1 'Open' Host Controller (OHCI) Driver [ 48.275854] PCI: Setting latency timer of device 0000:00:02.0 to 64 [ 48.275858] ohci_hcd 0000:00:02.0: OHCI Host Controller [ 48.276352] ohci_hcd 0000:00:02.0: new USB bus registered, assigned bus number 2 [ 48.277045] ohci_hcd 0000:00:02.0: irq 12, io mem 0xe5004000 [ 48.337787] usb usb2: configuration #1 chosen from 1 choice [ 48.338292] hub 2-0:1.0: USB hub found [ 48.338675] hub 2-0:1.0: 3 ports detected [ 48.445652] PCI: Setting latency timer of device 0000:00:02.1 to 64 [ 48.445657] ohci_hcd 0000:00:02.1: OHCI Host Controller [ 48.445952] ohci_hcd 0000:00:02.1: new USB bus registered, assigned bus number 3 [ 48.446269] ohci_hcd 0000:00:02.1: irq 10, io mem 0xe5005000 [ 48.507713] usb usb3: configuration #1 chosen from 1 choice [ 48.508218] hub 3-0:1.0: USB hub found [ 48.508600] hub 3-0:1.0: 3 ports detected [ 48.835331] usb 1-2: new high speed USB device using ehci_hcd and address 3 [ 48.986202] usb 1-2: configuration #1 chosen from 1 choice [ 49.565015] usb 2-1: new full speed USB device using ohci_hcd and address 2 [ 49.751944] usb 2-1: configuration #1 chosen from 1 choice [ 50.054808] usb 3-1: new full speed USB device using ohci_hcd and address 2 [ 50.241672] usb 3-1: configuration #1 chosen from 1 choice [ 50.251026] usbcore: registered new interface driver libusual [ 50.495074] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 50.495632] mice: PS/2 mouse device common for all mice [ 50.496167] md: raid0 personality registered for level 0 [ 50.496578] md: raid1 personality registered for level 1 [ 50.497175] device-mapper: ioctl: 4.12.0-ioctl (2007-10-02) initialised: dm-devel@redhat.com [ 50.498037] usbcore: registered new interface driver usbkbd [ 50.498449] drivers/hid/usbhid/usbkbd.c: :USB HID Boot Protocol keyboard driver [ 50.499235] TCP cubic registered [ 50.499602] NET: Registered protocol family 1 [ 50.500100] NET: Registered protocol family 10 [ 50.500765] lo: Disabled Privacy Extensions [ 50.503030] IPv6 over IPv4 tunneling driver [ 50.504113] sit0: Disabled Privacy Extensions [ 50.505099] NET: Registered protocol family 17 [ 50.505502] Using IPI Shortcut mode [ 50.506024] BIOS EDD facility v0.16 2004-Jun-25, 6 devices found [ 50.518957] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 [ 50.614776] md: Autodetecting RAID arrays. [ 50.772151] md: Scanned 11 and added 11 devices. [ 50.772494] md: autorun ... [ 50.772841] md: considering sdb2 ... [ 50.773219] md: adding sdb2 ... [ 50.773565] md: adding hdd2 ... [ 50.773925] md: hdd1 has different UUID to sdb2 [ 50.774307] md: hdc3 has different UUID to sdb2 [ 50.774725] md: hdc2 has different UUID to sdb2 [ 50.775107] md: hdc1 has different UUID to sdb2 [ 50.775509] md: adding hdb2 ... [ 50.775853] md: hdb1 has different UUID to sdb2 [ 50.776256] md: hda3 has different UUID to sdb2 [ 50.776638] md: hda2 has different UUID to sdb2 [ 50.777036] md: hda1 has different UUID to sdb2 [ 50.777547] md: created md4 [ 50.777878] md: bind [ 50.778255] md: bind [ 50.778614] md: bind [ 50.778977] md: running: [ 50.779698] md4: setting max_sectors to 128, segment boundary to 32767 [ 50.780137] raid0: looking at sdb2 [ 50.780499] raid0: comparing sdb2(12891072) with sdb2(12891072) [ 50.780988] raid0: END [ 50.781307] raid0: ==> UNIQUE [ 50.781662] raid0: 1 zones [ 50.781986] raid0: looking at hdd2 [ 50.782349] raid0: comparing hdd2(12297664) with sdb2(12891072) [ 50.782835] raid0: NOT EQUAL [ 50.783171] raid0: comparing hdd2(12297664) with hdd2(12297664) [ 50.783658] raid0: END [ 50.783995] raid0: ==> UNIQUE [ 50.784332] raid0: 2 zones [ 50.784693] raid0: looking at hdb2 [ 50.784976] raid0: comparing hdb2(12297664) with sdb2(12891072) [ 50.785230] raid0: NOT EQUAL [ 50.785407] raid0: comparing hdb2(12297664) with hdd2(12297664) [ 50.785660] raid0: EQUAL [ 50.785814] raid0: FINAL 2 zones [ 50.785992] raid0: zone 1 [ 50.786147] raid0: checking sdb2 ... contained as device 0 [ 50.786402] (12891072) is smallest!. [ 50.786707] raid0: checking hdb2 ... nope. [ 50.787134] raid0: checking hdd2 ... nope. [ 50.787561] raid0: zone->nb_dev: 1, size: 593408 [ 50.787942] raid0: current zone offset: 12891072 [ 50.788338] raid0: done. [ 50.788657] raid0 : md_size is 37486400 blocks. [ 50.789052] raid0 : conf->hash_spacing is 36892992 blocks. [ 50.789459] raid0 : nb_zone is 2. [ 50.789817] raid0 : Allocating 8 bytes for hash. [ 50.790290] md: considering hdd1 ... [ 50.790669] md: adding hdd1 ... [ 50.791013] md: hdc3 has different UUID to hdd1 [ 50.791413] md: hdc2 has different UUID to hdd1 [ 50.791795] md: hdc1 has different UUID to hdd1 [ 50.792198] md: adding hdb1 ... [ 50.792541] md: hda3 has different UUID to hdd1 [ 50.792939] md: hda2 has different UUID to hdd1 [ 50.793320] md: hda1 has different UUID to hdd1 [ 50.793817] md: created md3 [ 50.794147] md: bind [ 50.794524] md: bind [ 50.794881] md: running: [ 50.795587] raid1: raid set md3 active with 2 out of 2 mirrors [ 50.796125] md: considering hdc3 ... [ 50.796511] md: adding hdc3 ... [ 50.796855] md: hdc2 has different UUID to hdc3 [ 50.797254] md: hdc1 has different UUID to hdc3 [ 50.797639] md: adding hda3 ... [ 50.797997] md: hda2 has different UUID to hdc3 [ 50.798379] md: hda1 has different UUID to hdc3 [ 50.798893] md: created md2 [ 50.799210] md: bind [ 50.799403] md: bind [ 50.799592] md: running: [ 50.800023] md2: setting max_sectors to 128, segment boundary to 32767 [ 50.800225] raid0: looking at hdc3 [ 50.800407] raid0: comparing hdc3(771008) with hdc3(771008) [ 50.800659] raid0: END [ 50.800898] raid0: ==> UNIQUE [ 50.801253] raid0: 1 zones [ 50.801577] raid0: looking at hda3 [ 50.801940] raid0: comparing hda3(771008) with hdc3(771008) [ 50.802418] raid0: EQUAL [ 50.802742] raid0: FINAL 1 zones [ 50.803100] raid0: done. [ 50.803420] raid0 : md_size is 1542016 blocks. [ 50.803812] raid0 : conf->hash_spacing is 1542016 blocks. [ 50.804216] raid0 : nb_zone is 1. [ 50.804632] raid0 : Allocating 4 bytes for hash. [ 50.805093] md: considering hdc2 ... [ 50.805467] md: adding hdc2 ... [ 50.805811] md: hdc1 has different UUID to hdc2 [ 50.806213] md: adding hda2 ... [ 50.820295] md: hda1 has different UUID to hdc2 [ 50.820794] md: created md1 [ 50.821123] md: bind [ 50.821484] md: bind [ 50.821841] md: running: [ 50.822540] raid1: raid set md1 active with 2 out of 2 mirrors [ 50.823073] md: considering hdc1 ... [ 50.823450] md: adding hdc1 ... [ 50.823796] md: adding hda1 ... [ 50.824155] md: created md0 [ 50.824523] md: bind [ 50.824883] md: bind [ 50.825241] md: running: [ 50.825928] raid1: raid set md0 active with 2 out of 2 mirrors [ 50.826451] md: ... autorun DONE. [ 50.850724] kjournald starting. Commit interval 5 seconds [ 50.851192] EXT3-fs: mounted filesystem with ordered data mode. [ 50.851637] VFS: Mounted root (ext3 filesystem) readonly. [ 50.852275] Freeing unused kernel memory: 172k freed [ 52.079704] ieee80211_crypt: registered algorithm 'NULL' [ 52.265013] ieee80211: 802.11 data/management/control stack, git-1.1.13 [ 52.265465] ieee80211: Copyright (C) 2004-2005 Intel Corporation [ 52.731228] usbcore: registered new interface driver usbserial [ 52.731658] drivers/usb/serial/usb-serial.c: USB Serial Driver core [ 52.740727] drivers/usb/serial/usb-serial.c: USB Serial support registered for pl2303 [ 52.741088] pl2303 2-1:1.0: pl2303 converter detected [ 52.741641] usb 2-1: pl2303 converter now attached to ttyUSB0 [ 52.742097] usbcore: registered new interface driver pl2303 [ 52.742508] drivers/usb/serial/pl2303.c: Prolific PL2303 USB to serial adaptor driver [ 52.819523] PCI: Setting latency timer of device 0000:00:06.0 to 64 [ 52.993562] usb 1-2: reset high speed USB device using ehci_hcd and address 3 [ 53.145766] zd1211rw 1-2:1.0: eth1 [ 53.146168] usbcore: registered new interface driver zd1211rw [ 53.153969] intel8x0_measure_ac97_clock: measured 59194 usecs [ 53.154171] intel8x0: clocking to 47487 [ 53.154914] i2c-adapter i2c-0: nForce2 SMBus adapter at 0x5000 [ 53.155384] i2c-adapter i2c-1: nForce2 SMBus adapter at 0x5500 [ 53.156527] udev: renamed network interface eth1 to eth2 [ 61.100076] eth0: no IPv6 routers present [ 89.548775] EXT3 FS on sda5, internal journal [ 98.464017] fuse init (API version 7.9) [ 98.519173] ReiserFS: sdb1: found reiserfs format "3.6" with standard journal [ 98.519191] ReiserFS: sdb1: using ordered data mode [ 98.525839] 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 [ 98.526830] ReiserFS: sdb1: checking transaction log (sdb1) [ 98.562626] ReiserFS: sdb1: Using r5 hash to sort names [ 98.704655] kjournald2 starting. Commit interval 5 seconds [ 98.706742] EXT4 FS on md4, internal journal [ 98.706789] EXT4-fs: mounted filesystem with ordered data mode. [ 98.706792] EXT4-fs: file extents enabled [ 98.736292] Adding 1542008k swap on /dev/mapper/md2. Priority:1 extents:1 across:1542008k [ 102.815686] zd1211rw 1-2:1.0: firmware version 4605 [ 102.855664] zd1211rw 1-2:1.0: zd1211 chip 0ace:1211 v4330 high 00-30-95 RF2959_RF pa0 ----- [ 102.881969] ADDRCONF(NETDEV_UP): eth2: link is not ready [ 104.500847] SoftMAC: Open Authentication completed with 00:04:0e:78:9f:2e [ 104.523757] ADDRCONF(NETDEV_CHANGE): eth2: link becomes ready [ 104.547618] ieee80211_crypt: registered algorithm 'CCMP' [ 104.569625] ieee80211_crypt: registered algorithm 'TKIP' [ 107.645609] tun: Universal TUN/TAP device driver, 1.6 [ 107.645614] tun: (C) 1999-2004 Max Krasnyansky [ 107.646703] tun: Disabled Privacy Extensions [ 109.349043] RPC: Registered udp transport module. [ 109.349048] RPC: Registered tcp transport module. [ 124.772144] Installing knfsd (copyright (C) 1996 okir@monad.swb.de). [ 124.991626] NFSD: Using /var/lib/nfs/v4recovery as the NFSv4 state recovery directory [ 124.992486] NFSD: starting 90-second grace period [ 135.078520] device eth2 entered promiscuous mode [ 135.108492] device eth2 left promiscuous mode [ 135.138525] device eth2 entered promiscuous mode [ 156.141963] ip_tables: (C) 2000-2006 Netfilter Core Team [ 156.240021] nf_conntrack version 0.5.0 (16384 buckets, 65536 max) [ 156.661641] u32 classifier [ 156.661647] Performance counters on [ 156.661649] Actions configured [ 258.626180] kjournald starting. Commit interval 5 seconds [ 258.626995] EXT3-fs: mounted filesystem with ordered data mode. [ 267.002668] XFS mounting filesystem dm-2 [ 267.772449] Ending clean XFS mount for filesystem: dm-2 [ 276.258644] XFS mounting filesystem dm-3 [ 277.188291] Ending clean XFS mount for filesystem: dm-3 [ 289.073204] kjournald starting. Commit interval 5 seconds [ 289.103167] EXT3 FS on dm-4, internal journal [ 289.103187] EXT3-fs: mounted filesystem with ordered data mode. [ 1089.766819] EXT3 FS on dm-1, internal journal [ 1310.670981] [ 1310.670986] ============================================= [ 1310.671690] [ INFO: possible recursive locking detected ] [ 1310.672097] 2.6.24-rc6 #1 [ 1310.672421] --------------------------------------------- [ 1310.672828] FahCore_a0.exe/3692 is trying to acquire lock: [ 1310.673238] (&q->lock){++..}, at: [] __wake_up+0x1b/0x50 [ 1310.673869] [ 1310.673870] but task is already holding lock: [ 1310.674567] (&q->lock){++..}, at: [] __wake_up+0x1b/0x50 [ 1310.675267] [ 1310.675268] other info that might help us debug this: [ 1310.675952] 5 locks held by FahCore_a0.exe/3692: [ 1310.676334] #0: (rcu_read_lock){..--}, at: [] net_rx_action+0x60/0x1b0 [ 1310.677251] #1: (rcu_read_lock){..--}, at: [] netif_receive_skb+0x100/0x470 [ 1310.677924] #2: (rcu_read_lock){..--}, at: [] ip_local_deliver_finish+0x32/0x210 [ 1310.678460] #3: (clock-AF_INET){-.-?}, at: [] sock_def_readable+0x1e/0x80 [ 1310.679250] #4: (&q->lock){++..}, at: [] __wake_up+0x1b/0x50 [ 1310.680151] [ 1310.680152] stack backtrace: [ 1310.680772] Pid: 3692, comm: FahCore_a0.exe Not tainted 2.6.24-rc6 #1 [ 1310.681209] [] show_trace_log_lvl+0x1a/0x30 [ 1310.681659] [] show_trace+0x12/0x20 [ 1310.682085] [] dump_stack+0x6a/0x70 [ 1310.682512] [] __lock_acquire+0x971/0x10c0 [ 1310.682961] [] lock_acquire+0x5e/0x80 [ 1310.683392] [] _spin_lock_irqsave+0x38/0x50 [ 1310.683914] [] __wake_up+0x1b/0x50 [ 1310.684337] [] ep_poll_safewake+0x9a/0xc0 [ 1310.684822] [] ep_poll_callback+0x8b/0xe0 [ 1310.685265] [] __wake_up_common+0x48/0x70 [ 1310.685712] [] __wake_up+0x37/0x50 [ 1310.686136] [] sock_def_readable+0x7a/0x80 [ 1310.686579] [] sock_queue_rcv_skb+0xeb/0x150 [ 1310.687028] [] udp_queue_rcv_skb+0x139/0x2a0 [ 1310.687554] [] __udp4_lib_rcv+0x2f1/0x7e0 [ 1310.687996] [] udp_rcv+0x12/0x20 [ 1310.688415] [] ip_local_deliver_finish+0x125/0x210 [ 1310.688881] [] ip_local_deliver+0x2d/0x90 [ 1310.689323] [] ip_rcv_finish+0xeb/0x300 [ 1310.689760] [] ip_rcv+0x195/0x230 [ 1310.690182] [] netif_receive_skb+0x37c/0x470 [ 1310.690632] [] process_backlog+0x69/0xc0 [ 1310.691175] [] net_rx_action+0x137/0x1b0 [ 1310.691681] [] __do_softirq+0x52/0xb0 [ 1310.692006] [] do_softirq+0x94/0xe0 [ 1310.692301] =======================