Hello, On 10/31/2010 12:20 AM, Wolfgang Karall wrote:
One thing I forgot to mention in the intial mail is that what I think the problem might be is that the disks spin up one after the other in this NAS box (both when powering on, but also at reboots there is a audible delay), and the old version 2.6.26 waited long enough while the newer versions don't. At least that's what I gather from the "retrying in 5 secs" lines.
Finally got around to testing this out further (on both version 2.6.32 and 2.6.36), and this is indeed a timing issue. Adding a simple "sleep" to my initramfs setup (as init-top script) led to the drives all being recognized properly again, see the attached dmesg outputs.
Glad this can be worked around in userland at least. Cheers Wolfgang
[ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Linux version 2.6.32-5-orion5x (Debian 2.6.32-13) (maks@xxxxxxxxxx) (gcc version 4.3.4 (Debian 4.3.4-10) ) #1 Sat May 22 02:17:44 UTC 2010 [ 0.000000] CPU: Feroceon [41069260] revision 0 (ARMv5TEJ), cr=00053177 [ 0.000000] CPU: VIVT data cache, VIVT instruction cache [ 0.000000] Machine: QNAP TS-409 [ 0.000000] Clearing invalid memory bank 0KB@0x00000000 [ 0.000000] Clearing invalid memory bank 0KB@0x00000000 [ 0.000000] Clearing invalid memory bank 0KB@0x00000000 [ 0.000000] Ignoring unrecognised tag 0x00000000 [ 0.000000] Ignoring unrecognised tag 0x00000000 [ 0.000000] Ignoring unrecognised tag 0x00000000 [ 0.000000] Ignoring unrecognised tag 0x41000403 [ 0.000000] Memory policy: ECC disabled, Data cache writeback [ 0.000000] On node 0 totalpages: 65536 [ 0.000000] free_area_init_node: node 0, pgdat c038d010, node_mem_map c03f7000 [ 0.000000] Normal zone: 512 pages used for memmap [ 0.000000] Normal zone: 0 pages reserved [ 0.000000] Normal zone: 65024 pages, LIFO batch:15 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 65024 [ 0.000000] Kernel command line: console=ttyS0,115200n8 root=/dev/ram rw initrd=0x800000,0x3fffff [ 0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes) [ 0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes) [ 0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes) [ 0.000000] Memory: 256MB = 256MB total [ 0.000000] Memory: 251520KB available (3244K code, 568K data, 120K init, 0K highmem) [ 0.000000] SLUB: Genslabs=11, HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 [ 0.000000] Hierarchical RCU implementation. [ 0.000000] NR_IRQS:64 [ 0.000000] Console: colour dummy device 80x30 [ 0.000194] Calibrating delay loop... 498.07 BogoMIPS (lpj=2490368) [ 0.250134] Security Framework initialized [ 0.250169] SELinux: Disabled at boot. [ 0.250214] Mount-cache hash table entries: 512 [ 0.250850] Initializing cgroup subsys ns [ 0.250876] Initializing cgroup subsys cpuacct [ 0.250896] Initializing cgroup subsys devices [ 0.250916] Initializing cgroup subsys freezer [ 0.250935] Initializing cgroup subsys net_cls [ 0.251020] CPU: Testing write buffer coherency: ok [ 0.252891] devtmpfs: initialized [ 0.255332] regulator: core version 0.5 [ 0.255716] NET: Registered protocol family 16 [ 0.256560] Orion ID: MV88F5281-D0. TCLK=166666667. [ 0.256590] Orion: Applying 5281 D0 WFI workaround. [ 0.305041] pci 0000:00:00.0: reg 10 64bit mmio pref: [0xf1000000-0xf10fffff] [ 0.305076] pci 0000:00:00.0: reg 18 32bit mmio: [0x000000-0x1fffffff] [ 0.305210] pci 0000:00:01.0: reg 10 64bit mmio: [0x40000000-0x400fffff] [ 0.305244] pci 0000:00:01.0: reg 18 io port: [0xf0000000-0xf00000ff] [ 0.305381] PCI: bus0: Fast back to back transfers disabled [ 0.305966] pci 0000:01:00.0: reg 10 64bit mmio pref: [0x000000-0xfffffff] [ 0.306003] pci 0000:01:00.0: reg 18 64bit mmio pref: [0x10000000-0x1fffffff] [ 0.306039] pci 0000:01:00.0: reg 20 64bit mmio: [0xf1000000-0xf10fffff] [ 0.306071] pci 0000:01:00.0: reg 30 32bit mmio pref: [0xe0000000-0xe7ffffff] [ 0.306124] pci 0000:01:00.0: supports D1 D2 [ 0.306145] pci 0000:01:00.0: PME# supported from D0 D1 D2 D3hot [ 0.306169] pci 0000:01:00.0: PME# disabled [ 0.306266] PCI: bus1: Fast back to back transfers enabled [ 0.309444] bio: create slab <bio-0> at 0 [ 0.310150] vgaarb: loaded [ 0.311250] Switching to clocksource orion_clocksource [ 0.320212] NET: Registered protocol family 2 [ 0.320643] IP route cache hash table entries: 2048 (order: 1, 8192 bytes) [ 0.322100] TCP established hash table entries: 8192 (order: 4, 65536 bytes) [ 0.322512] TCP bind hash table entries: 8192 (order: 3, 32768 bytes) [ 0.322723] TCP: Hash tables configured (established 8192 bind 8192) [ 0.322745] TCP reno registered [ 0.323156] NET: Registered protocol family 1 [ 0.323567] Unpacking initramfs... [ 0.928742] Freeing initrd memory: 4092K [ 0.928889] NetWinder Floating Point Emulator V0.97 (double precision) [ 0.929488] audit: initializing netlink socket (disabled) [ 0.929557] type=2000 audit(0.920:1): initialized [ 0.943267] VFS: Disk quotas dquot_6.5.2 [ 0.943800] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) [ 0.944040] msgmni has been set to 499 [ 0.945457] alg: No test for stdrng (krng) [ 0.945733] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253) [ 0.945761] io scheduler noop registered [ 0.945779] io scheduler anticipatory registered [ 0.945798] io scheduler deadline registered [ 0.946275] io scheduler cfq registered (default) [ 0.958746] Serial: 8250/16550 driver, 2 ports, IRQ sharing disabled [ 0.959698] serial8250.0: ttyS0 at MMIO 0xf1012000 (irq = 3) is a 16550A [ 1.320053] console [ttyS0] enabled [ 1.324125] serial8250.1: ttyS1 at MMIO 0xf1012100 (irq = 4) is a 16550A [ 1.331690] physmap platform flash device: 00800000 at ff800000 [ 1.337834] physmap-flash.0: Found 1 x16 devices at 0x0 in 8-bit bank [ 1.344356] Intel/Sharp Extended Query Table at 0x0031 [ 1.349581] Intel/Sharp Extended Query Table at 0x0031 [ 1.354839] Using buffer write method [ 1.358491] cfi_cmdset_0001: Erase suspend on write enabled [ 1.364082] erase region 0: offset=0x0,size=0x20000,blocks=64 [ 1.401960] RedBoot partition parsing not available [ 1.406833] Using physmap partition information [ 1.411407] Creating 6 MTD partitions on "physmap-flash.0": [ 1.416978] 0x000000780000-0x000000800000 : "U-Boot" [ 1.423133] 0x000000000000-0x000000200000 : "Kernel" [ 1.429085] 0x000000200000-0x000000600000 : "RootFS1" [ 1.435201] 0x000000600000-0x000000700000 : "RootFS2" [ 1.441266] 0x000000760000-0x000000780000 : "U-Boot Config" [ 1.447895] 0x000000700000-0x000000760000 : "NAS Config" [ 1.455013] mice: PS/2 mouse device common for all mice [ 1.461007] i2c /dev entries driver [ 1.467591] rtc-s35390a 0-0030: rtc core: registered rtc-s35390a as rtc0 [ 1.474849] Registered led device: ts409:red:sata1 [ 1.479740] Registered led device: ts409:red:sata2 [ 1.484683] Registered led device: ts409:red:sata3 [ 1.489603] Registered led device: ts409:red:sata4 [ 1.496518] TCP cubic registered [ 1.499750] NET: Registered protocol family 17 [ 1.504253] VFP support v0.3: implementor 41 architecture 1 part 10 variant 9 rev 0 [ 1.512574] registered taskstats version 1 [ 1.517737] rtc-s35390a 0-0030: setting system clock to 2010-11-30 10:32:04 UTC (1291113124) [ 1.526200] Initalizing network drop monitor service [ 1.531337] Freeing init memory: 120K [ 62.035876] SCSI subsystem initialized [ 62.231761] libata version 3.00 loaded. [ 62.274034] sata_mv 0000:00:01.0: version 1.28 [ 62.279217] sata_mv 0000:00:01.0: Gen-IIE 32 slots 4 ports SCSI mode IRQ via INTx [ 62.290191] scsi0 : sata_mv [ 62.293684] scsi1 : sata_mv [ 62.296923] scsi2 : sata_mv [ 62.300136] scsi3 : sata_mv [ 62.303287] ata1: SATA max UDMA/133 mmio m1048576@0xe0000000 port 0xe0022000 irq 11 [ 62.310935] ata2: SATA max UDMA/133 mmio m1048576@0xe0000000 port 0xe0024000 irq 11 [ 62.318622] ata3: SATA max UDMA/133 mmio m1048576@0xe0000000 port 0xe0026000 irq 11 [ 62.326287] ata4: SATA max UDMA/133 mmio m1048576@0xe0000000 port 0xe0028000 irq 11 [ 62.841366] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [ 62.861874] ata1.00: ATA-7: SAMSUNG HD154UI, 1AG01118, max UDMA7 [ 62.867877] ata1.00: 2930277168 sectors, multi 0: LBA48 NCQ (depth 31/32) [ 62.891962] ata1.00: configured for UDMA/133 [ 62.896837] scsi 0:0:0:0: Direct-Access ATA SAMSUNG HD154UI 1AG0 PQ: 0 ANSI: 5 [ 63.411365] ata2: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [ 63.431872] ata2.00: ATA-7: SAMSUNG HD154UI, 1AG01118, max UDMA7 [ 63.437875] ata2.00: 2930277168 sectors, multi 0: LBA48 NCQ (depth 31/32) [ 63.461961] ata2.00: configured for UDMA/133 [ 63.466798] scsi 1:0:0:0: Direct-Access ATA SAMSUNG HD154UI 1AG0 PQ: 0 ANSI: 5 [ 63.981367] ata3: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [ 64.001874] ata3.00: ATA-7: SAMSUNG HD154UI, 1AG01118, max UDMA7 [ 64.007874] ata3.00: 2930277168 sectors, multi 0: LBA48 NCQ (depth 31/32) [ 64.031963] ata3.00: configured for UDMA/133 [ 64.036809] scsi 2:0:0:0: Direct-Access ATA SAMSUNG HD154UI 1AG0 PQ: 0 ANSI: 5 [ 64.551366] ata4: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [ 64.571871] ata4.00: ATA-7: SAMSUNG HD154UI, 1AG01118, max UDMA7 [ 64.577871] ata4.00: 2930277168 sectors, multi 0: LBA48 NCQ (depth 31/32) [ 64.601961] ata4.00: configured for UDMA/133 [ 64.606807] scsi 3:0:0:0: Direct-Access ATA SAMSUNG HD154UI 1AG0 PQ: 0 ANSI: 5 [ 65.705636] sd 0:0:0:0: [sda] 2930277168 512-byte logical blocks: (1.50 TB/1.36 TiB) [ 65.720999] sd 1:0:0:0: [sdb] 2930277168 512-byte logical blocks: (1.50 TB/1.36 TiB) [ 65.732499] sd 2:0:0:0: [sdc] 2930277168 512-byte logical blocks: (1.50 TB/1.36 TiB) [ 65.743061] sd 3:0:0:0: [sdd] 2930277168 512-byte logical blocks: (1.50 TB/1.36 TiB) [ 65.806934] sd 0:0:0:0: [sda] Write Protect is off [ 65.811838] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00 [ 65.821152] sd 1:0:0:0: [sdb] Write Protect is off [ 65.826031] sd 1:0:0:0: [sdb] Mode Sense: 00 3a 00 00 [ 65.832413] sd 2:0:0:0: [sdc] Write Protect is off [ 65.837203] sd 2:0:0:0: [sdc] Mode Sense: 00 3a 00 00 [ 65.841373] sd 3:0:0:0: [sdd] Write Protect is off [ 65.846163] sd 3:0:0:0: [sdd] Mode Sense: 00 3a 00 00 [ 65.877820] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 65.894536] sd 1:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 65.909414] sd 2:0:0:0: [sdc] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 65.923613] sd 3:0:0:0: [sdd] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 66.027646] sda: [ 66.036703] sdb: [ 66.041915] sdc: [ 66.051095] sdd: sda1 sda2 sda3 sda4 [ 66.074164] sdb1 sdb2 sdb3 sdb4 [ 66.096354] sdc1 sdc2 sdc3 sdc4 [ 66.115566] sdd1 sdd2 sdd3 sdd4 [ 66.121374] sd 0:0:0:0: [sda] Attached SCSI disk [ 66.148464] sd 1:0:0:0: [sdb] Attached SCSI disk [ 66.155141] sd 2:0:0:0: [sdc] Attached SCSI disk [ 66.163244] sd 3:0:0:0: [sdd] Attached SCSI disk [ 67.974112] md: raid1 personality registered for level 1 [ 68.018135] async_tx: api initialized (async) [ 68.045216] xor: measuring software checksum speed [ 68.091311] arm4regs : 429.200 MB/sec [ 68.141303] 8regs : 377.200 MB/sec [ 68.191309] 32regs : 416.800 MB/sec [ 68.195488] xor: using function: arm4regs (429.200 MB/sec) [ 68.393450] raid6: int32x1 24 MB/s [ 68.561996] raid6: int32x2 35 MB/s [ 68.732225] raid6: int32x4 47 MB/s [ 68.902008] raid6: int32x8 42 MB/s [ 68.905754] raid6: using algorithm int32x4 (47 MB/s) [ 68.993845] md: raid6 personality registered for level 6 [ 68.999153] md: raid5 personality registered for level 5 [ 69.004532] md: raid4 personality registered for level 4 [ 69.099243] md: md0 stopped. [ 69.212518] md: bind<sdb1> [ 69.215732] md: bind<sda1> [ 69.242851] raid1: raid set md0 active with 2 out of 2 mirrors [ 69.248879] md0: detected capacity change from 0 to 1998585856 [ 69.265686] md: md1 stopped. [ 69.288292] md0: unknown partition table [ 69.393272] md: bind<sdd1> [ 69.399996] md: bind<sdc1> [ 69.436289] raid1: raid set md1 active with 2 out of 2 mirrors [ 69.442407] md1: detected capacity change from 0 to 1998585856 [ 69.458921] md: md2 stopped. [ 69.478996] md1: unknown partition table [ 69.585764] md: bind<sdb2> [ 69.588992] md: bind<sdc2> [ 69.604215] md: bind<sdd2> [ 69.607450] md: bind<sda2> [ 69.639308] raid5: device sda2 operational as raid disk 0 [ 69.644767] raid5: device sdd2 operational as raid disk 3 [ 69.650162] raid5: device sdc2 operational as raid disk 2 [ 69.655580] raid5: device sdb2 operational as raid disk 1 [ 69.666185] raid5: allocated 4228kB for md2 [ 69.674384] 0: w=1 pa=0 pr=4 m=1 a=2 r=4 op1=0 op2=0 [ 69.679352] 3: w=2 pa=0 pr=4 m=1 a=2 r=4 op1=0 op2=0 [ 69.684372] 2: w=3 pa=0 pr=4 m=1 a=2 r=4 op1=0 op2=0 [ 69.689331] 1: w=4 pa=0 pr=4 m=1 a=2 r=4 op1=0 op2=0 [ 69.694315] raid5: raid level 5 set md2 active with 4 out of 4 devices, algorithm 2 [ 69.701977] RAID5 conf printout: [ 69.705204] --- rd:4 wd:4 [ 69.707914] disk 0, o:1, dev:sda2 [ 69.711332] disk 1, o:1, dev:sdb2 [ 69.714729] disk 2, o:1, dev:sdc2 [ 69.718124] disk 3, o:1, dev:sdd2 [ 69.721835] md2: detected capacity change from 0 to 1499994390528 [ 69.738680] md: md3 stopped. [ 69.758987] md2: unknown partition table [ 69.862784] md: bind<sdb3> [ 69.867489] md: bind<sdc3> [ 69.870710] md: bind<sdd3> [ 69.881774] md: bind<sda3> [ 69.921166] raid5: device sda3 operational as raid disk 0 [ 69.926628] raid5: device sdd3 operational as raid disk 3 [ 69.932043] raid5: device sdc3 operational as raid disk 2 [ 69.937433] raid5: device sdb3 operational as raid disk 1 [ 69.945899] raid5: allocated 4228kB for md3 [ 69.950265] 0: w=1 pa=0 pr=4 m=1 a=2 r=4 op1=0 op2=0 [ 69.955337] 3: w=2 pa=0 pr=4 m=1 a=2 r=4 op1=0 op2=0 [ 69.960300] 2: w=3 pa=0 pr=4 m=1 a=2 r=4 op1=0 op2=0 [ 69.965290] 1: w=4 pa=0 pr=4 m=1 a=2 r=4 op1=0 op2=0 [ 69.970251] raid5: raid level 5 set md3 active with 4 out of 4 devices, algorithm 2 [ 69.977906] RAID5 conf printout: [ 69.981131] --- rd:4 wd:4 [ 69.983866] disk 0, o:1, dev:sda3 [ 69.987260] disk 1, o:1, dev:sdb3 [ 69.990656] disk 2, o:1, dev:sdc3 [ 69.994078] disk 3, o:1, dev:sdd3 [ 69.997781] md3: detected capacity change from 0 to 1499994390528 [ 70.007221] md3: unknown partition table [ 70.409194] device-mapper: uevent: version 1.0.3 [ 70.422194] device-mapper: ioctl: 4.15.0-ioctl (2009-04-01) initialised: dm-devel@xxxxxxxxxx [ 70.914203] kjournald starting. Commit interval 5 seconds [ 70.971869] EXT3 FS on md0, internal journal [ 70.976158] EXT3-fs: mounted filesystem with ordered data mode. [ 75.099472] NET: Registered protocol family 10 [ 75.106784] lo: Disabled Privacy Extensions [ 75.580935] udevd version 125 started [ 86.695017] usbcore: registered new interface driver usbfs [ 86.731673] usbcore: registered new interface driver hub [ 86.749677] usbcore: registered new device driver usb [ 86.831543] input: gpio-keys as /devices/platform/gpio-keys/input/input0 [ 86.894874] MV-643xx 10/100/1000 ethernet driver version 1.4 [ 86.940006] mv643xx_eth smi: probed [ 86.977144] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 88.238912] net eth0: port 0 with MAC address 00:00:00:00:51:81 [ 88.245962] orion-ehci orion-ehci.0: Marvell Orion EHCI [ 88.259151] orion-ehci orion-ehci.0: new USB bus registered, assigned bus number 1 [ 88.341481] orion-ehci orion-ehci.0: irq 17, io mem 0xf1050000 [ 88.361428] orion-ehci orion-ehci.0: USB 2.0 started, EHCI 1.00 [ 88.367439] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 88.374305] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 88.381536] usb usb1: Product: Marvell Orion EHCI [ 88.386235] usb usb1: Manufacturer: Linux 2.6.32-5-orion5x ehci_hcd [ 88.392515] usb usb1: SerialNumber: orion-ehci.0 [ 88.451396] usb usb1: configuration #1 chosen from 1 choice [ 88.458247] hub 1-0:1.0: USB hub found [ 88.465210] hub 1-0:1.0: 1 port detected [ 88.781377] usb 1-1: new high speed USB device using orion-ehci and address 2 [ 88.953118] usb 1-1: New USB device found, idVendor=05e3, idProduct=0608 [ 88.959814] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 [ 88.966973] usb 1-1: Product: USB2.0 Hub [ 89.004396] usb 1-1: configuration #1 chosen from 1 choice [ 89.032689] hub 1-1:1.0: USB hub found [ 89.043026] hub 1-1:1.0: 4 ports detected [ 89.351844] usb 1-1.2: new full speed USB device using orion-ehci and address 3 [ 89.591876] usb 1-1.2: New USB device found, idVendor=04f9, idProduct=000e [ 89.598742] usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 [ 89.606066] usb 1-1.2: Product: HL-1450 series [ 89.610505] usb 1-1.2: Manufacturer: Brother [ 89.614844] usb 1-1.2: SerialNumber: K2J988892 [ 89.664354] usb 1-1.2: configuration #1 chosen from 1 choice [ 90.407483] usblp0: USB Bidirectional printer dev 3 if 0 alt 0 proto 2 vid 0x04F9 pid 0x000E [ 90.428045] usbcore: registered new interface driver usblp [ 92.562926] Adding 1951736k swap on /dev/md1. Priority:-1 extents:1 across:1951736k [ 94.418638] loop: module loaded [ 97.001733] device-mapper: table: 253:1: adding target device (start sect 2761900032 len 1533067264) caused an alignment inconsistency [ 99.650159] ADDRCONF(NETDEV_UP): eth0: link is not ready [ 103.026683] eth0: link up, 1000 Mb/s, full duplex, flow control disabled [ 103.033526] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 109.633141] RPC: Registered udp transport module. [ 109.637843] RPC: Registered tcp transport module. [ 109.642612] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 110.054952] Slow work thread pool: Starting up [ 110.068060] Slow work thread pool: Ready [ 110.075148] FS-Cache: Loaded [ 110.317080] FS-Cache: Netfs 'nfs' registered for caching [ 110.752180] Installing knfsd (copyright (C) 1996 okir@xxxxxxxxxxxx). [ 147.459237] IPv6 over IPv4 tunneling driver [ 147.477454] sit0: Disabled Privacy Extensions [ 147.862277] tun: Universal TUN/TAP device driver, 1.6 [ 147.867568] tun: (C) 1999-2004 Max Krasnyansky <maxk@xxxxxxxxxxxx> [ 149.117726] sixxs: Disabled Privacy Extensions [ 156.760012] svc: failed to register lockdv1 RPC service (errno 97). [ 156.778894] NFSD: Using /var/lib/nfs/v4recovery as the NFSv4 state recovery directory [ 156.800946] NFSD: starting 90-second grace period [ 166.228219] warning: `ntpd' uses 32-bit capabilities (legacy support in use) [ 256.339700] kjournald starting. Commit interval 5 seconds [ 256.392440] EXT3 FS on dm-1, internal journal [ 256.396814] EXT3-fs: mounted filesystem with ordered data mode. [ 260.260653] kjournald starting. Commit interval 5 seconds [ 260.349405] EXT3 FS on dm-0, internal journal [ 260.354704] EXT3-fs: mounted filesystem with ordered data mode.
[ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Linux version 2.6.36-trunk-orion5x (Debian 2.6.36-1~experimental.1) (max@xxxxxxx) (gcc version 4.3.2 (Debian 4.3.2-1.1) ) #1 Sat Oct 30 14:21:25 UTC 2010 [ 0.000000] CPU: Feroceon [41069260] revision 0 (ARMv5TEJ), cr=00053177 [ 0.000000] CPU: VIVT data cache, VIVT instruction cache [ 0.000000] Machine: QNAP TS-409 [ 0.000000] Clearing invalid memory bank 0KB@0x00000000 [ 0.000000] Clearing invalid memory bank 0KB@0x00000000 [ 0.000000] Clearing invalid memory bank 0KB@0x00000000 [ 0.000000] Ignoring unrecognised tag 0x00000000 [ 0.000000] Ignoring unrecognised tag 0x00000000 [ 0.000000] Ignoring unrecognised tag 0x00000000 [ 0.000000] Ignoring unrecognised tag 0x41000403 [ 0.000000] Memory policy: ECC disabled, Data cache writeback [ 0.000000] On node 0 totalpages: 65536 [ 0.000000] free_area_init_node: node 0, pgdat c03b18d4, node_mem_map c041b000 [ 0.000000] Normal zone: 512 pages used for memmap [ 0.000000] Normal zone: 0 pages reserved [ 0.000000] Normal zone: 65024 pages, LIFO batch:15 [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 65024 [ 0.000000] Kernel command line: console=ttyS0,115200n8 root=/dev/ram rw initrd=0x800000,0x3fffff [ 0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes) [ 0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes) [ 0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes) [ 0.000000] Memory: 256MB = 256MB total [ 0.000000] Memory: 251600k/251600k available, 10544k reserved, 0K highmem [ 0.000000] Virtual kernel memory layout: [ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB) [ 0.000000] fixmap : 0xfff00000 - 0xfffe0000 ( 896 kB) [ 0.000000] DMA : 0xffc00000 - 0xffe00000 ( 2 MB) [ 0.000000] vmalloc : 0xd0800000 - 0xfd800000 ( 720 MB) [ 0.000000] lowmem : 0xc0000000 - 0xd0000000 ( 256 MB) [ 0.000000] modules : 0xbf000000 - 0xc0000000 ( 16 MB) [ 0.000000] .init : 0xc0008000 - 0xc0029000 ( 132 kB) [ 0.000000] .text : 0xc0029000 - 0xc036f000 (3352 kB) [ 0.000000] .data : 0xc038a000 - 0xc03b5ba0 ( 175 kB) [ 0.000000] SLUB: Genslabs=11, HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 [ 0.000000] Hierarchical RCU implementation. [ 0.000000] RCU-based detection of stalled CPUs is disabled. [ 0.000000] Verbose stalled-CPUs detection is disabled. [ 0.000000] NR_IRQS:64 [ 0.000000] Console: colour dummy device 80x30 [ 0.000206] Calibrating delay loop... 498.07 BogoMIPS (lpj=2490368) [ 0.250060] pid_max: default: 32768 minimum: 301 [ 0.250173] Security Framework initialized [ 0.250207] SELinux: Disabled at boot. [ 0.250270] Mount-cache hash table entries: 512 [ 0.250890] Initializing cgroup subsys ns [ 0.250921] Initializing cgroup subsys cpuacct [ 0.250944] Initializing cgroup subsys devices [ 0.250966] Initializing cgroup subsys freezer [ 0.250988] Initializing cgroup subsys net_cls [ 0.251008] Initializing cgroup subsys blkio [ 0.251146] CPU: Testing write buffer coherency: ok [ 0.253268] devtmpfs: initialized [ 0.255098] regulator: core version 0.5 [ 0.255418] NET: Registered protocol family 16 [ 0.256460] Orion ID: MV88F5281-D0. TCLK=166666667. [ 0.256493] Orion: Applying 5281 D0 WFI workaround. [ 0.318434] pci 0000:00:00.0: reg 10: [mem 0xf1000000-0xf10fffff 64bit pref] [ 0.318473] pci 0000:00:00.0: reg 18: [mem 0x00000000-0x1fffffff] [ 0.318610] pci 0000:00:01.0: reg 10: [mem 0x40000000-0x400fffff 64bit] [ 0.318650] pci 0000:00:01.0: reg 18: [io 0xf0000000-0xf00000ff] [ 0.318805] PCI: bus0: Fast back to back transfers disabled [ 0.319480] pci 0000:01:00.0: reg 10: [mem 0x00000000-0x0fffffff 64bit pref] [ 0.319527] pci 0000:01:00.0: reg 18: [mem 0x10000000-0x1fffffff 64bit pref] [ 0.319569] pci 0000:01:00.0: reg 20: [mem 0xf1000000-0xf10fffff 64bit] [ 0.319607] pci 0000:01:00.0: reg 30: [mem 0xe0000000-0xe7ffffff pref] [ 0.319664] pci 0000:01:00.0: supports D1 D2 [ 0.319691] pci 0000:01:00.0: PME# supported from D0 D1 D2 D3hot [ 0.319718] pci 0000:01:00.0: PME# disabled [ 0.319824] PCI: bus1: Fast back to back transfers enabled [ 0.320154] pci 0000:00:01.0: BAR 0: assigned [mem 0xe0000000-0xe00fffff 64bit] [ 0.320205] pci 0000:00:01.0: BAR 0: set to [mem 0xe0000000-0xe00fffff 64bit] (PCI address [0xe0000000-0xe00fffff] [ 0.320248] pci 0000:00:01.0: BAR 2: assigned [io 0x1000-0x10ff] [ 0.320288] pci 0000:00:01.0: BAR 2: set to [io 0x1000-0x10ff] (PCI address [0x1000-0x10ff] [ 0.323657] bio: create slab <bio-0> at 0 [ 0.324412] vgaarb: loaded [ 0.325881] Switching to clocksource orion_clocksource [ 0.347331] NET: Registered protocol family 2 [ 0.347629] IP route cache hash table entries: 2048 (order: 1, 8192 bytes) [ 0.348642] TCP established hash table entries: 8192 (order: 4, 65536 bytes) [ 0.349071] TCP bind hash table entries: 8192 (order: 3, 32768 bytes) [ 0.349284] TCP: Hash tables configured (established 8192 bind 8192) [ 0.349308] TCP reno registered [ 0.349337] UDP hash table entries: 256 (order: 0, 4096 bytes) [ 0.349390] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes) [ 0.349765] NET: Registered protocol family 1 [ 0.349872] PCI: CLS 32 bytes, default 32 [ 0.350149] Unpacking initramfs... [ 1.059366] Freeing initrd memory: 4092K [ 1.059533] NetWinder Floating Point Emulator V0.97 (double precision) [ 1.060195] audit: initializing netlink socket (disabled) [ 1.060272] type=2000 audit(1.050:1): initialized [ 1.076405] VFS: Disk quotas dquot_6.5.2 [ 1.076895] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes) [ 1.077126] msgmni has been set to 499 [ 1.078513] alg: No test for stdrng (krng) [ 1.079141] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253) [ 1.079177] io scheduler noop registered [ 1.079198] io scheduler deadline registered [ 1.079314] io scheduler cfq registered (default) [ 1.080016] Serial: 8250/16550 driver, 2 ports, IRQ sharing disabled [ 1.101040] serial8250.0: ttyS0 at MMIO 0xf1012000 (irq = 3) is a 16550A [ 1.566234] console [ttyS0] enabled [ 1.590419] serial8250.1: ttyS1 at MMIO 0xf1012100 (irq = 4) is a 16550A [ 1.598324] physmap platform flash device: 00800000 at ff800000 [ 1.604490] physmap-flash.0: Found 1 x16 devices at 0x0 in 8-bit bank. Manufacturer ID 0x000089 Chip ID 0x000017 [ 1.614730] Intel/Sharp Extended Query Table at 0x0031 [ 1.619903] Intel/Sharp Extended Query Table at 0x0031 [ 1.625043] Using buffer write method [ 1.628721] cfi_cmdset_0001: Erase suspend on write enabled [ 1.634327] erase region 0: offset=0x0,size=0x20000,blocks=64 [ 1.676708] RedBoot partition parsing not available [ 1.681582] Using physmap partition information [ 1.686170] Creating 6 MTD partitions on "physmap-flash.0": [ 1.691813] 0x000000780000-0x000000800000 : "U-Boot" [ 1.698518] 0x000000000000-0x000000200000 : "Kernel" [ 1.705123] 0x000000200000-0x000000600000 : "RootFS1" [ 1.711921] 0x000000600000-0x000000700000 : "RootFS2" [ 1.718749] 0x000000760000-0x000000780000 : "U-Boot Config" [ 1.726046] 0x000000700000-0x000000760000 : "NAS Config" [ 1.733761] mice: PS/2 mouse device common for all mice [ 1.739652] i2c /dev entries driver [ 1.746410] rtc-s35390a 0-0030: rtc core: registered rtc-s35390a as rtc0 [ 1.753662] Registered led device: ts409:red:sata1 [ 1.753810] Registered led device: ts409:red:sata2 [ 1.753985] Registered led device: ts409:red:sata3 [ 1.754132] Registered led device: ts409:red:sata4 [ 1.755770] TCP cubic registered [ 1.759057] NET: Registered protocol family 17 [ 1.763524] Registering the dns_resolver key type [ 1.768294] VFP support v0.3: implementor 41 architecture 1 part 10 variant 9 rev 0 [ 1.776746] registered taskstats version 1 [ 1.781905] rtc-s35390a 0-0030: setting system clock to 2010-11-30 17:19:55 UTC (1291137595) [ 1.790365] Initalizing network drop monitor service [ 1.795665] Freeing init memory: 132K [ 17.342596] SCSI subsystem initialized [ 17.551813] libata version 3.00 loaded. [ 17.596693] sata_mv 0000:00:01.0: version 1.28 [ 17.602005] sata_mv 0000:00:01.0: Gen-IIE 32 slots 4 ports SCSI mode IRQ via INTx [ 17.612999] scsi0 : sata_mv [ 17.616503] scsi1 : sata_mv [ 17.619887] scsi2 : sata_mv [ 17.623183] scsi3 : sata_mv [ 17.626321] ata1: SATA max UDMA/133 mmio m1048576@0xe0000000 port 0xe0022000 irq 11 [ 17.634024] ata2: SATA max UDMA/133 mmio m1048576@0xe0000000 port 0xe0024000 irq 11 [ 17.641709] ata3: SATA max UDMA/133 mmio m1048576@0xe0000000 port 0xe0026000 irq 11 [ 17.649388] ata4: SATA max UDMA/133 mmio m1048576@0xe0000000 port 0xe0028000 irq 11 [ 18.167103] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [ 18.187494] ata1.00: ATA-7: SAMSUNG HD154UI, 1AG01118, max UDMA7 [ 18.193497] ata1.00: 2930277168 sectors, multi 0: LBA48 NCQ (depth 31/32) [ 18.217462] ata1.00: configured for UDMA/133 [ 18.222375] scsi 0:0:0:0: Direct-Access ATA SAMSUNG HD154UI 1AG0 PQ: 0 ANSI: 5 [ 18.736496] ata2: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [ 18.756852] ata2.00: ATA-7: SAMSUNG HD154UI, 1AG01118, max UDMA7 [ 18.762855] ata2.00: 2930277168 sectors, multi 0: LBA48 NCQ (depth 31/32) [ 18.806416] ata2.00: configured for UDMA/133 [ 18.811336] scsi 1:0:0:0: Direct-Access ATA SAMSUNG HD154UI 1AG0 PQ: 0 ANSI: 5 [ 19.326152] ata3: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [ 19.366126] ata3.00: ATA-7: SAMSUNG HD154UI, 1AG01118, max UDMA7 [ 19.372131] ata3.00: 2930277168 sectors, multi 0: LBA48 NCQ (depth 31/32) [ 19.416125] ata3.00: configured for UDMA/133 [ 19.421040] scsi 2:0:0:0: Direct-Access ATA SAMSUNG HD154UI 1AG0 PQ: 0 ANSI: 5 [ 22.456011] ata4: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [ 22.476487] ata4.00: ATA-7: SAMSUNG HD154UI, 1AG01118, max UDMA7 [ 22.482496] ata4.00: 2930277168 sectors, multi 0: LBA48 NCQ (depth 31/32) [ 22.506507] ata4.00: configured for UDMA/133 [ 22.511409] scsi 3:0:0:0: Direct-Access ATA SAMSUNG HD154UI 1AG0 PQ: 0 ANSI: 5 [ 22.699640] udevd (100): /proc/100/oom_adj is deprecated, please use /proc/100/oom_score_adj instead. [ 23.554886] sd 0:0:0:0: [sda] 2930277168 512-byte logical blocks: (1.50 TB/1.36 TiB) [ 23.616726] sd 1:0:0:0: [sdb] 2930277168 512-byte logical blocks: (1.50 TB/1.36 TiB) [ 23.626824] sd 0:0:0:0: [sda] Write Protect is off [ 23.631628] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00 [ 23.632491] sd 2:0:0:0: [sdc] 2930277168 512-byte logical blocks: (1.50 TB/1.36 TiB) [ 23.641099] sd 3:0:0:0: [sdd] 2930277168 512-byte logical blocks: (1.50 TB/1.36 TiB) [ 23.686688] sd 1:0:0:0: [sdb] Write Protect is off [ 23.691522] sd 1:0:0:0: [sdb] Mode Sense: 00 3a 00 00 [ 23.692347] sd 3:0:0:0: [sdd] Write Protect is off [ 23.697223] sd 3:0:0:0: [sdd] Mode Sense: 00 3a 00 00 [ 23.698512] sd 2:0:0:0: [sdc] Write Protect is off [ 23.703315] sd 2:0:0:0: [sdc] Mode Sense: 00 3a 00 00 [ 23.703685] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 23.741940] sd 1:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 23.751387] sd 3:0:0:0: [sdd] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 23.762744] sd 2:0:0:0: [sdc] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 23.992120] sdb: sdb1 sdb2 sdb3 sdb4 [ 24.036260] sd 1:0:0:0: [sdb] Attached SCSI disk [ 24.124030] sda: sda1 sda2 sda3 sda4 [ 24.149148] sdd: sdd1 sdd2 sdd3 sdd4 [ 24.171174] sd 0:0:0:0: [sda] Attached SCSI disk [ 24.176191] sdc: sdc1 sdc2 sdc3 sdc4 [ 24.197231] sd 3:0:0:0: [sdd] Attached SCSI disk [ 24.215795] sd 2:0:0:0: [sdc] Attached SCSI disk [ 27.251383] md: raid1 personality registered for level 1 [ 27.297611] async_tx: api initialized (async) [ 27.321454] xor: measuring software checksum speed [ 27.375956] arm4regs : 429.200 MB/sec [ 27.425952] 8regs : 377.200 MB/sec [ 27.475950] 32regs : 416.800 MB/sec [ 27.480136] xor: using function: arm4regs (429.200 MB/sec) [ 27.686274] raid6: int32x1 23 MB/s [ 27.856971] raid6: int32x2 35 MB/s [ 28.026641] raid6: int32x4 46 MB/s [ 28.197061] raid6: int32x8 42 MB/s [ 28.200812] raid6: using algorithm int32x4 (46 MB/s) [ 28.300638] md: raid6 personality registered for level 6 [ 28.306004] md: raid5 personality registered for level 5 [ 28.311309] md: raid4 personality registered for level 4 [ 28.401323] md: md0 stopped. [ 28.491804] md: bind<sdb1> [ 28.495093] md: bind<sda1> [ 28.522205] md/raid1:md0: active with 2 out of 2 mirrors [ 28.527812] md0: detected capacity change from 0 to 1998585856 [ 28.543644] md: md1 stopped. [ 28.575068] md0: unknown partition table [ 28.671778] md: bind<sdd1> [ 28.677205] md: bind<sdc1> [ 28.714039] md/raid1:md1: active with 2 out of 2 mirrors [ 28.719663] md1: detected capacity change from 0 to 1998585856 [ 28.735273] md: md2 stopped. [ 28.766815] md1: unknown partition table [ 28.862342] md: bind<sdb2> [ 28.866419] md: bind<sdc2> [ 28.876446] md: bind<sdd2> [ 28.879749] md: bind<sda2> [ 28.920509] md/raid:md2: device sda2 operational as raid disk 0 [ 28.926508] md/raid:md2: device sdd2 operational as raid disk 3 [ 28.932428] md/raid:md2: device sdc2 operational as raid disk 2 [ 28.938378] md/raid:md2: device sdb2 operational as raid disk 1 [ 28.949376] md/raid:md2: allocated 4228kB [ 28.957095] md/raid:md2: raid level 5 active with 4 out of 4 devices, algorithm 2 [ 28.964568] RAID conf printout: [ 28.964589] --- level:5 rd:4 wd:4 [ 28.964614] disk 0, o:1, dev:sda2 [ 28.964638] disk 1, o:1, dev:sdb2 [ 28.964662] disk 2, o:1, dev:sdc2 [ 28.964686] disk 3, o:1, dev:sdd2 [ 28.965019] md2: detected capacity change from 0 to 1499994390528 [ 28.980984] md: md3 stopped. [ 29.013397] md2: unknown partition table [ 29.090468] md: bind<sdb3> [ 29.099660] md: bind<sdc3> [ 29.106238] md: bind<sdd3> [ 29.116226] md: bind<sda3> [ 29.160723] md/raid:md3: device sda3 operational as raid disk 0 [ 29.166711] md/raid:md3: device sdd3 operational as raid disk 3 [ 29.172629] md/raid:md3: device sdc3 operational as raid disk 2 [ 29.178577] md/raid:md3: device sdb3 operational as raid disk 1 [ 29.187241] md/raid:md3: allocated 4228kB [ 29.191440] md/raid:md3: raid level 5 active with 4 out of 4 devices, algorithm 2 [ 29.199029] RAID conf printout: [ 29.199053] --- level:5 rd:4 wd:4 [ 29.199078] disk 0, o:1, dev:sda3 [ 29.199103] disk 1, o:1, dev:sdb3 [ 29.199127] disk 2, o:1, dev:sdc3 [ 29.199151] disk 3, o:1, dev:sdd3 [ 29.199494] md3: detected capacity change from 0 to 1499994390528 [ 29.213593] md3: unknown partition table [ 29.739696] device-mapper: uevent: version 1.0.3 [ 29.758284] device-mapper: ioctl: 4.18.0-ioctl (2010-06-29) initialised: dm-devel@xxxxxxxxxx [ 30.250718] EXT3-fs: barriers not enabled [ 30.269549] kjournald starting. Commit interval 5 seconds [ 30.316579] EXT3-fs (md0): using internal journal [ 30.321309] EXT3-fs (md0): mounted filesystem with ordered data mode [ 34.649017] NET: Registered protocol family 10 [ 34.655640] lo: Disabled Privacy Extensions [ 35.134951] udevd version 125 started [ 46.972185] usbcore: registered new interface driver usbfs [ 47.023994] usbcore: registered new interface driver hub [ 47.049097] input: gpio-keys as /devices/platform/gpio-keys/input/input0 [ 47.057043] usbcore: registered new device driver usb [ 47.143905] MV-643xx 10/100/1000 ethernet driver version 1.4 [ 47.167917] mv643xx_eth smi: probed [ 47.231214] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 48.681953] net eth0: port 0 with MAC address 00:00:00:00:51:81 [ 48.688126] orion-ehci orion-ehci.0: Marvell Orion EHCI [ 48.693479] orion-ehci orion-ehci.0: new USB bus registered, assigned bus number 1 [ 48.776135] orion-ehci orion-ehci.0: irq 17, io mem 0xf1050000 [ 48.796098] orion-ehci orion-ehci.0: USB 2.0 started, EHCI 1.00 [ 48.802125] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 48.808971] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 48.816225] usb usb1: Product: Marvell Orion EHCI [ 48.820927] usb usb1: Manufacturer: Linux 2.6.36-trunk-orion5x ehci_hcd [ 48.827556] usb usb1: SerialNumber: orion-ehci.0 [ 48.852373] hub 1-0:1.0: USB hub found [ 48.856240] hub 1-0:1.0: 1 port detected [ 49.176042] usb 1-1: new high speed USB device using orion-ehci and address 2 [ 49.347780] usb 1-1: New USB device found, idVendor=05e3, idProduct=0608 [ 49.354480] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0 [ 49.361642] usb 1-1: Product: USB2.0 Hub [ 49.401864] hub 1-1:1.0: USB hub found [ 49.426076] hub 1-1:1.0: 4 ports detected [ 49.736464] usb 1-1.2: new full speed USB device using orion-ehci and address 3 [ 50.113397] usb 1-1.2: New USB device found, idVendor=04f9, idProduct=000e [ 50.120358] usb 1-1.2: New USB device strings: Mfr=1, Product=2, SerialNumber=3 [ 50.127688] usb 1-1.2: Product: HL-1450 series [ 50.132125] usb 1-1.2: Manufacturer: Brother [ 50.136421] usb 1-1.2: SerialNumber: K2J988892 [ 50.180041] usbcore: registered new interface driver usbserial [ 50.225526] USB Serial support registered for generic [ 50.272536] usbcore: registered new interface driver usbserial_generic [ 50.279115] usbserial: USB Serial Driver core [ 50.486245] USB Serial support registered for GSM modem (1-port) [ 50.522099] usbcore: registered new interface driver option [ 50.527754] option: v0.7.2:USB Driver for GSM modems [ 51.339791] usblp0: USB Bidirectional printer dev 3 if 0 alt 0 proto 2 vid 0x04F9 pid 0x000E [ 51.363000] usbcore: registered new interface driver usblp [ 52.682877] Adding 1951740k swap on /dev/md1. Priority:-1 extents:1 across:1951740k [ 54.579033] loop: module loaded [ 57.184931] device-mapper: table: 253:1: adding target device (start sect 2761900032 len 1533067264) caused an alignment inconsistency [ 59.824027] ADDRCONF(NETDEV_UP): eth0: link is not ready [ 63.028868] eth0: link up, 1000 Mb/s, full duplex, flow control disabled [ 63.035743] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready [ 71.601099] RPC: Registered udp transport module. [ 71.605806] RPC: Registered tcp transport module. [ 71.610712] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 72.043341] FS-Cache: Loaded [ 72.298830] FS-Cache: Netfs 'nfs' registered for caching [ 72.759725] Installing knfsd (copyright (C) 1996 okir@xxxxxxxxxxxx). [ 100.778616] IPv6 over IPv4 tunneling driver [ 100.796920] sit0: Disabled Privacy Extensions [ 101.227206] tun: Universal TUN/TAP device driver, 1.6 [ 101.232253] tun: (C) 1999-2004 Max Krasnyansky <maxk@xxxxxxxxxxxx> [ 102.587931] sixxs: Disabled Privacy Extensions [ 110.296626] svc: failed to register lockdv1 RPC service (errno 97). [ 110.304355] NFSD: Using /var/lib/nfs/v4recovery as the NFSv4 state recovery directory [ 110.317207] NFSD: starting 90-second grace period
