[Date Prev][Date Next] [Thread Prev][Thread Next] [Date Index] [Thread Index]

Re: [2nd try] unassigned-hostname on Lanner EM7210 (Thermaltake Muse NAS-RAID N0001LN)



More details...
I've re-installed and I've verified that the same error occurs at the same step. Below the message:
Configuring flash memory to boot the system  ..33%..66%
Make the system bootable
------------------------

!! ERROR: Installation step failed

An installation step failed. You can try to run the failing item again from the
menu, or skip it and choose something else. The failing step is: Make the
system bootable
[Press enter to continue]

I've once again chose to continue without that knowing that I could interrupt the boot sequence and use TFTP.
This time I've managed to boot it almost properly with the following sequence:
RedBoot> fis load ramdisk.gz
RedBoot> load -r -v -h 192.168.1.101 -b 0x01008000 -m tftp vmlinuz-2.6.32-5-iop32x
-----------<suppressed output>-------------
Raw file loaded 0x01008000-0x0113a69f, assumed entry at 0x01008000
RedBoot> exec -c "console=ttyS0,115200n8 rw root=/dev/sda1 mem=512M@0xa0000000" -r 0x01800000

Eventually it hangs because of an error in communicating with the disk. Full log is attached.

Questions:
1. how to correctly write boot image to flash?
2. anybody is able to decode what the disk error (ata4.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen) means?

Thanks!



On Thu, Apr 21, 2011 at 9:39 AM, Mello <mellowiz@gmail.com> wrote:
I've tried installing once again with the stripped zImage. Boot is fine and "Machine: Intel IQ31244" is reported in the messages.
Installation, instead, stops at the boot loader step. I've chosen to continue but then the system won't reboot properly.

I assume the installer was not able to flash the proper kernel so I find myself booting the previous (unstripped) one. In fact at reboot "Machine: Lanner EM7210" is reported despite "force_ep80219" parameter.

Any troubleshooting/tricks?

Thanks,
mw


On Wed, Apr 20, 2011 at 1:20 PM, Mello <mellowiz@gmail.com> wrote:
Aha, I was looking for them in a reversed fashion :)
Thanks for looking into it!

Think I've done that:
$ hexdump -v -n 96 zImage.stripped
0000000 00 00 a0 e1 00 00 a0 e1 00 00 a0 e1 00 00 a0 e1
0000010 00 00 a0 e1 00 00 a0 e1 00 00 a0 e1 00 00 a0 e1
0000020 02 00 00 ea 18 28 6f 01 00 00 00 00 38 27 13 00
0000030 01 70 a0 e1 02 80 a0 e1 00 20 0f e1 03 00 12 e3
0000040 01 00 00 1a 17 00 a0 e3 56 34 12 ef 00 20 0f e1
0000050 c0 20 82 e3 02 f0 21 e1 1f 20 cf e3 01 38 82 e2

For the record, I've used this command:
$ dd if=zImage of=zImage.stripped bs=1 skip=8
1255224+0 records in
1255224+0 records out
1255224 bytes transferred in 6.907979 secs (181706 bytes/sec)

$ ls -l zImage*
...  1255232 Mar 29 09:11 zImage
...  1255224 Apr 20 13:11 zImage.stripped

I'll test it tonight and report back.

Thank you!



On Wed, Apr 20, 2011 at 12:35 PM, Arnaud Patard <arnaud.patard@rtp-net.org> wrote:
Mello <mellowiz@gmail.com> writes:

Hi,

> Hi Arnaud,
> sorry for a late reply and thanks a lot for your advice.
> I've done a dump of the entire file but I couldn't find those data. Just for
> a reference here's the first few lines:
> $ hexdump -n 96 zImage
> 0000000 04 1c a0 e3 bc 10 81 e3 00 00 a0 e1 00 00 a0 e1
         ^^^^^^^^^^^^^^^^^^^^^^^

theses are the bytes I was talking of.

Arnaud



+Ethernet eth0: MAC address 00:40:d0:8a:1f:99
IP: 192.168.1.11/255.255.255.0, Gateway: 192.168.1.1
Default server: 192.168.1.122, DNS server IP: 0.0.0.0

RedBoot(tm) bootstrap and debug environment [ROM]
Intel IOP RedBoot release
         version 2.2.V6-IOP-RedBoot
         built 13:51:51, Jan 12 2006

Platform: EP80219 (XScale) 
Copyright (C) 2000, 2001, 2002, Red Hat, Inc.

RAM: 0x00000000-0x20000000, 0x00021790-0x1ffd1000 available
FLASH: 0xf0000000 - 0xf0800000, 64 blocks of 0x00020000 bytes each.
== Executing boot script in 2.000 seconds - enter ^C to abort
^C

RedBoot> fis load ramdisk.gz
RedBoot> load -r -v -h 192.168.1.101 -b 0x01008000 -m tftp vmlinuz-2.6.32-5-iop32x
-----------<suppressed output>-------------
Raw file loaded 0x01008000-0x0113a69f, assumed entry at 0x01008000
RedBoot> exec -c "console=ttyS0,115200n8 rw root=/dev/sda1 mem=512M@0xa0000000" -r 0x01800000
Using base address 0x01008000 and length 0x001326a0
The boot tags are located at 0xA0000100
Booting the kernel...
Uncompressing Linux... done, booting the kernel.
[    0.000000] Initializing cgroup subsys cpuset
[    0.000000] Initializing cgroup subsys cpu
[    0.000000] Linux version 2.6.32-5-iop32x (Debian 2.6.32-29) (ben@decadent.org.uk) (gcc version 4.3.5 (Debian 4.3.5-4) ) #1 Fri Dec 10 19:47:27 UTC 2010
[    0.000000] CPU: XScale-80219 [69052e20] revision 0 (ARMv5TE), cr=0000397f
[    0.000000] CPU: VIVT data cache, VIVT instruction cache
[    0.000000] Machine: Intel IQ31244
[    0.000000] Memory policy: ECC disabled, Data cache writeback
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 130048
[    0.000000] Kernel command line: console=ttyS0,115200n8 rw root=/dev/sda1 mem=512M@0xa0000000
[    0.000000] PID hash table entries: 2048 (order: 1, 8192 bytes)
[    0.000000] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes)
[    0.000000] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes)
[    0.000000] Memory: 512MB = 512MB total
[    0.000000] Memory: 511744KB available (3080K code, 444K data, 112K 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:32
[    0.000000] Console: colour dummy device 80x30
[    0.000000] Calibrating delay loop... 394.85 BogoMIPS (lpj=1974272)
[    0.220000] Security Framework initialized
[    0.220000] SELinux:  Disabled at boot.
[    0.220000] Mount-cache hash table entries: 512
[    0.220000] Initializing cgroup subsys ns
[    0.220000] Initializing cgroup subsys cpuacct
[    0.220000] Initializing cgroup subsys devices
[    0.220000] Initializing cgroup subsys freezer
[    0.220000] Initializing cgroup subsys net_cls
[    0.220000] CPU: Testing write buffer coherency: ok
[    0.220000] devtmpfs: initialized
[    0.220000] regulator: core version 0.5
[    0.220000] NET: Registered protocol family 16
[    0.220000] note: iq31244 board type has been selected
[    0.220000] note: to select ep80219 operation:
[    0.220000]  1/ specify "force_ep80219" on the kernel command line
[    0.220000]  2/ update boot loader to pass the ep80219 id: 1281
[    0.230000] pci 0000:00:01.0: PME# supported from D0 D3hot D3cold
[    0.230000] pci 0000:00:01.0: PME# disabled
[    0.230000] PCI: bus0: Fast back to back transfers disabled
[    0.230000] bio: create slab <bio-0> at 0
[    0.230000] vgaarb: loaded
[    0.250000] NET: Registered protocol family 2
[    0.250000] IP route cache hash table entries: 4096 (order: 2, 16384 bytes)
[    0.250000] TCP established hash table entries: 16384 (order: 5, 131072 bytes)
[    0.250000] TCP bind hash table entries: 16384 (order: 4, 65536 bytes)
[    0.250000] TCP: Hash tables configured (established 16384 bind 16384)
[    0.250000] TCP reno registered
[    0.250000] NET: Registered protocol family 1
[    0.250000] Unpacking initramfs...
[    1.020000] Freeing initrd memory: 4096K
[    1.020000] NetWinder Floating Point Emulator V0.97 (double precision)
[    1.020000] audit: initializing netlink socket (disabled)
[    1.020000] type=2000 audit(1.020:1): initialized
[    1.040000] VFS: Disk quotas dquot_6.5.2
[    1.040000] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[    1.040000] msgmni has been set to 1007
[    1.040000] alg: No test for stdrng (krng)
[    1.040000] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253)
[    1.040000] io scheduler noop registered
[    1.040000] io scheduler anticipatory registered
[    1.040000] io scheduler deadline registered
[    1.040000] io scheduler cfq registered (default)
[    1.060000] Serial: 8250/16550 driver, 2 ports, IRQ sharing disabled
[    1.060000] serial8250.0: ttyS0 at MMIO 0xfe800000 (irq = 28) is a 16550A
[    1.400000] console [ttyS0] enabled
[    1.410000] physmap platform flash device: 00800000 at f0000000
[    1.410000] physmap-flash.0: Found 1 x16 devices at 0x0 in 16-bit bank
[    1.420000]  Intel/Sharp Extended Query Table at 0x0031
[    1.430000]  Intel/Sharp Extended Query Table at 0x0031
[    1.430000] Using buffer write method
[    1.430000] cfi_cmdset_0001: Erase suspend on write enabled
[    1.430000] Searching for RedBoot partition table in physmap-flash.0 at offset 0x7e0000
[    1.760000] 6 RedBoot partitions found on MTD device physmap-flash.0
[    1.760000] Creating 6 MTD partitions on "physmap-flash.0":
[    1.780000] 0x000000000000-0x000000040000 : "RedBoot"
[    1.780000] 0x000000040000-0x000000240000 : "zImage"
[    1.780000] 0x000000240000-0x000000640000 : "ramdisk.gz"
[    1.800000] 0x0000007a0000-0x0000007c0000 : "vendor"
[    1.800000] 0x0000007c0000-0x0000007c1000 : "RedBoot config"
[    1.800000] mtd: partition "RedBoot config" doesn't end on an erase block -- force read-only
[    1.820000] 0x0000007e0000-0x000000800000 : "FIS directory"
[    1.830000] mice: PS/2 mouse device common for all mice
[    1.840000] i2c /dev entries driver
[    1.860000] iop-adma iop-adma.0: Intel(R) IOP: ( cpy intr )
[    1.880000] iop-adma iop-adma.1: Intel(R) IOP: ( cpy intr )
[    1.880000] TCP cubic registered
[    1.900000] NET: Registered protocol family 17
[    1.900000] XScale DSP coprocessor detected.
[    1.910000] registered taskstats version 1
[    1.910000] /build/buildd-linux-2.6_2.6.32-29-armel-2LYIJf/linux-2.6-2.6.32/debian/build/source_armel_none/drivers/rtc/hctosys.c: unable to open rtc device (rtc0)
[    1.930000] Initalizing network drop monitor service
[    1.930000] Freeing init memory: 112K
Loading, please wait...
[    2.230000] udev[39]: starting version 164
[    3.190000] SCSI subsystem initialized
[    3.540000] scsi0 : sata_vsc
[    3.560000] scsi1 : sata_vsc
[    3.560000] scsi2 : sata_vsc
[    3.570000] scsi3 : sata_vsc
[    3.570000] ata1: SATA max UDMA/133 mmio m4096@0x80060000 port 0x80060200 irq 27
[    3.570000] ata2: SATA max UDMA/133 mmio m4096@0x80060000 port 0x80060400 irq 27
[    3.590000] ata3: SATA max UDMA/133 mmio m4096@0x80060000 port 0x80060600 irq 27
[    3.600000] ata4: SATA max UDMA/133 mmio m4096@0x80060000 port 0x80060800 irq 27
[    3.960000] ata1: SATA link down (SStatus 0 SControl 300)
[    4.310000] ata2: SATA link down (SStatus 0 SControl 300)
[    4.660000] ata3: SATA link down (SStatus 0 SControl 300)
[    5.010000] ata4: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[   10.030000] ata4.00: qc timeout (cmd 0x27)
[   10.030000] ata4.00: failed to read native max address (err_mask=0x4)
[   10.050000] ata4.00: HPA support seems broken, skipping HPA handling
[   10.400000] ata4: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[   10.420000] ata4.00: ATA-7: ST3320620AS, 3.AAE, max UDMA/133
[   10.420000] ata4.00: 625142448 sectors, multi 0: LBA48 NCQ (depth 0/32)
[   10.480000] ata4.00: configured for UDMA/133
[   10.480000] scsi 3:0:0:0: Direct-Access     ATA      ST3320620AS      3.AA PQ: 0 ANSI: 5
[   10.620000] sd 3:0:0:0: [sda] 625142448 512-byte logical blocks: (320 GB/298 GiB)
[   10.640000] sd 3:0:0:0: [sda] Write Protect is off
[   10.640000] sd 3:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[   10.650000]  sda:
[   41.040000] ata4.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[   41.040000] ata4.00: failed command: READ DMA
[   41.060000] ata4.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 dma 4096 in
[   41.060000]          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
[   41.070000] ata4.00: status: { DRDY }
[   41.070000] ata4: hard resetting link
[   41.420000] ata4: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[   41.480000] ata4.00: configured for UDMA/133
[   41.480000] ata4.00: device reported invalid CHS sector 0
[   41.490000] ata4: EH complete
[   72.040000] ata4: limiting SATA link speed to 1.5 Gbps
[   72.040000] ata4.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[   72.060000] ata4.00: failed command: READ DMA
[   72.060000] ata4.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 dma 4096 in
[   72.060000]          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
[   72.080000] ata4.00: status: { DRDY }
[   72.080000] ata4: hard resetting link
[   72.430000] ata4: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[   72.490000] ata4.00: configured for UDMA/133
[   72.490000] ata4.00: device reported invalid CHS sector 0
[   72.500000] ata4: EH complete
[  103.040000] ata4.00: limiting speed to UDMA/100:PIO4
[  103.040000] ata4.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[  103.060000] ata4.00: failed command: READ DMA
[  103.060000] ata4.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 dma 4096 in
[  103.060000]          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
[  103.080000] ata4.00: status: { DRDY }
[  103.080000] ata4: hard resetting link
[  103.430000] ata4: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[  103.490000] ata4.00: configured for UDMA/100
[  103.490000] ata4.00: device reported invalid CHS sector 0
[  103.500000] ata4: EH complete
[  134.040000] ata4.00: limiting speed to UDMA/33:PIO4
[  134.040000] ata4.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[  134.060000] ata4.00: failed command: READ DMA
[  134.060000] ata4.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 dma 4096 in
[  134.060000]          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
[  134.080000] ata4.00: status: { DRDY }
[  134.080000] ata4: hard resetting link
[  134.430000] ata4: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[  134.490000] ata4.00: configured for UDMA/33
[  134.490000] ata4.00: device reported invalid CHS sector 0
[  134.500000] ata4: EH complete
[  165.040000] ata4.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[  165.040000] ata4.00: failed command: READ DMA
[  165.060000] ata4.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 dma 4096 in
[  165.060000]          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
[  165.070000] ata4.00: status: { DRDY }
[  165.080000] ata4: hard resetting link
[  165.430000] ata4: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[  165.490000] ata4.00: configured for UDMA/33
[  165.490000] ata4.00: device reported invalid CHS sector 0
[  165.500000] ata4: EH complete

udevadm settle - timeout of 180 seconds reached, the event queue contains:
  /sys/devices/pci0000:00/0000:00:03.0/host3/target3:0:0/3:0:0:0 (396)
  /sys/devices/pci0000:00/0000:00:03.0/host3/target3:0:0/3:0:0:0/scsi_device/3:0:0:0 (397)
  /sys/devices/pci0000:00/0000:00:03.0/host3/target3:0:0/3:0:0:0/bsg/3:0:0:0 (398)
  /sys/devices/pci0000:00/0000:00:03.0/host3/target3:0:0/3:0:0:0/scsi_disk/3:0:0:0 (402)
udevd[39]: worker [41] unexpectedly returned with status 0x0100

udevd[39]: worker [41] failed while handling '/devices/pci0000:00/0000:00:03.0/host3/target3:0:0/3:0:0:0'

[  196.040000] ata4.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[  196.040000] ata4.00: failed command: READ DMA
[  196.060000] ata4.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 dma 4096 in
[  196.060000]          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
[  196.070000] ata4.00: status: { DRDY }
[  196.070000] ata4: hard resetting link
[  196.420000] ata4: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[  196.480000] ata4.00: configured for UDMA/33
[  196.480000] ata4.00: device reported invalid CHS sector 0
[  196.490000] sd 3:0:0:0: [sda] Result: hostbyte=0x00 driverbyte=0x08
[  196.490000] sd 3:0:0:0: [sda] Sense Key : 0xb [current] [descriptor]
[  196.510000] Descriptor sense data with sense descriptors (in hex):
[  196.510000]         72 0b 00 00 00 00 00 0c 00 0a 80 00 00 00 00 00 
[  196.520000]         00 00 00 00 
[  196.520000] sd 3:0:0:0: [sda] ASC=0x0 ASCQ=0x0
[  196.530000] sd 3:0:0:0: [sda] CDB: cdb[0]=0x28: 28 00 00 00 00 00 00 00 08 00
[  196.530000] end_request: I/O error, dev sda, sector 0
[  196.530000] Buffer I/O error on device sda, logical block 0
[  196.550000] ata4: EH complete
[  227.040000] ata4.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[  227.040000] ata4.00: failed command: READ DMA
[  227.060000] ata4.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 dma 4096 in
[  227.060000]          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
[  227.070000] ata4.00: status: { DRDY }
[  227.070000] ata4: hard resetting link
[  227.420000] ata4: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[  227.480000] ata4.00: configured for UDMA/33
[  227.480000] ata4.00: device reported invalid CHS sector 0
[  227.490000] ata4: EH complete
[  241.030000] INFO: task modprobe:66 blocked for more than 120 seconds.
[  241.030000] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[  241.050000] modprobe      D c025bce4     0    66      1 0x00000000
[  241.060000] [<c025bce4>] (schedule+0x424/0x488) from [<c005f3f0>] (async_synchronize_cookie_domain+0x1a0/0x264)
[  241.070000] [<c005f3f0>] (async_synchronize_cookie_domain+0x1a0/0x264) from [<c005f4d8>] (async_synchronize_full+0x18/0x40)
[  241.080000] [<c005f4d8>] (async_synchronize_full+0x18/0x40) from [<c006c454>] (sys_init_module+0x170/0x1f0)
[  241.090000] [<c006c454>] (sys_init_module+0x170/0x1f0) from [<c0024e80>] (ret_fast_syscall+0x0/0x38)
[  258.040000] ata4.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[  258.040000] ata4.00: failed command: READ DMA
[  258.060000] ata4.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 dma 4096 in
[  258.060000]          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
[  258.070000] ata4.00: status: { DRDY }
[  258.070000] ata4: hard resetting link
[  258.420000] ata4: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[  258.480000] ata4.00: configured for UDMA/33
[  258.480000] ata4.00: device reported invalid CHS sector 0
[  258.490000] ata4: EH complete
[  289.040000] ata4.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[  289.040000] ata4.00: failed command: READ DMA
[  289.060000] ata4.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 dma 4096 in
[  289.060000]          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
[  289.070000] ata4.00: status: { DRDY }
[  289.080000] ata4: hard resetting link
[  289.430000] ata4: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[  289.490000] ata4.00: configured for UDMA/33
[  289.490000] ata4.00: device reported invalid CHS sector 0
[  289.500000] ata4: EH complete
[  319.500000] ata4.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[  319.500000] ata4.00: failed command: READ DMA
[  319.520000] ata4.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 dma 4096 in
[  319.520000]          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
[  319.530000] ata4.00: status: { DRDY }
[  319.530000] ata4: hard resetting link
[  319.880000] ata4: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[  319.940000] ata4.00: configured for UDMA/33
[  319.940000] ata4.00: device reported invalid CHS sector 0
[  319.950000] ata4: EH complete

Reply to: