Gebrickte DS409+ wiederherstellen

asmodeus · 17. Aug. 2016

Hallo,

ich versuche mit einer seriellen Konsole eine gebrickte DS409+ wiederherzustellen. Bin soweit, dass ich sie per tftpboot starten konnte und die DiskStation im Synology Assistant auftaucht. Der Status wird mit "Configuration lost" angezeigt.
Ich habe das aktuelle Image von DSM von Synology heruntergeladen (DSM_DS409+_3256, was neueres gibt es wohl nicht) und die md5sum ueberprueft - sie stimmt mit der auf der Download page ueberein. Der Assistant meldet bei der Installation leider ein Problem: "Fail to update the file. The file is probably corrupt.

In /var/log/messages steht dazu noch mehr. Habt ihr vielleicht eine Idee wie DSM wieder auf der Diskstation installiert bekomme?

Rich (BBCode):

Jan  1 00:00:01 syslog: format start, szBuf = ^R4VxSYNONI^A^D^A
Jan  1 00:00:02 syslog: ninstaller.c:708 Dev: sda, DiskPath: /dev/sda, Check Partitions: 1
Jan  1 00:00:02 syslog: ninstaller.c:575 failed to get upnpmodelname from [/tmpMnt1234/etc.defaults/synoinfo.conf].
Jan  1 00:00:02 syslog: ninstaller.c:582 failed to get buildnumber from [/tmpMnt1234/etc.defaults/VERSION].
Jan  1 00:00:02 syslog: ../libsynosdk/lib/system/system_platform_get.c:35 failed to get unique from /tmpMnt1234/etc.defaults/synoinfo.conf errno=[0x0900]
Jan  1 00:00:02 syslog: ninstaller.c:598 failed to get platform from [/tmpMnt1234/etc.defaults/synoinfo.conf].
Jan  1 00:00:02 syslog: ../libsynosdk/lib/system/system_max_align_get.c:85 [/tmpMnt1234/.system_info/pgsql_alignment] doesn't exist, check model name for alignment
Jan  1 00:00:02 syslog: ../libsynosdk/lib/system/system_endian_get.c:61 [/tmpMnt1234/.system_info/endian] doesn't exist, check model name for endian
Jan  1 00:00:02 syslog: ../libsynosdk/lib/system/system_bit_get.c:57 [/tmpMnt1234/.system_info/bits] doesn't exist, check model name for bits
Jan  1 00:00:02 syslog: ninstaller.c:842(BlCheckSystemStatusRAID): Has Syno Partition = 1, System Status: 2
Jan  1 00:00:02 syslog: ninstaller.c:849(BlCheckSystemStatusRAID): gszUpgradeVolDev = /dev/md0
Jan  1 00:00:02 syslog: ninstaller.c:851(BlCheckSystemStatusRAID): gszUpgradeVolMnt = /tmpData
Jan  1 00:00:02 syslog: ninstaller.c:852(BlCheckSystemStatusRAID): we use md0 to upgrade.
Jan  1 00:00:02 syslog: ninstaller.c:1509 gblSupportRaid: 1, gSysStatus: 2, gblCreateDataVol: 0, gblSystemRecoverable: 0
Jan  1 00:00:02 syslog: ninstaller.c:2595 CreateDataVol=[0], CheckBadblocks=[0]
Jan  1 00:00:02 kernel: [ 5622.854002] synoacl module [synoacl_ext4] is not loaded
Jan  1 00:00:02 kernel: [ 5622.859324] synoacl module [synoacl_vfs] is not loaded
Jan  1 00:00:02 syslog: ninstaller.c:2661(ErrFHOSTDoFdiskFormat) retv=[0]
Jan  1 00:00:02 syslog: ErrFHOSTTcpResponseCmd: cmd=[2], ulErr=[0]
Jan  1 00:00:02 syslog: query prog, szBuf = ^R4VxSYNONI^A^D^A
Jan  1 00:00:02 syslog: ninstaller.c:2498(ErrFHOSTUpdateMkfsProgress) gInstallStage=[3] ret:0
Jan  1 00:00:02 syslog: index=[0], ulRate=[101]
Jan  1 00:00:02 kernel: [ 5622.901084] md: md1: set sda2 to auto_remap [0]
Jan  1 00:00:02 kernel: [ 5622.947588] md: md0: set sda1 to auto_remap [0]
Jan  1 00:00:04 syslog: query prog, szBuf = ^R4VxSYNONI^A^D^A
Jan  1 00:00:04 syslog: ninstaller.c:2498(ErrFHOSTUpdateMkfsProgress) gInstallStage=[3] ret:0
Jan  1 00:00:04 syslog: index=[0], ulRate=[102]
[ 5626.289629] md: bind<sda1>
[ 5626.299748] raid1: raid set md0 active with 1 out of 4 mirrors
[ 5626.305645] md0: detected capacity change from 0 to 2549940224
Jan  1 00:00:06 syslog: query prog, szBuf = ^R4VxSYNONI^A^D^A
Jan  1 00:00:06 syslog: ninstaller.c:2498(ErrFHOSTUpdateMkfsProgress) gInstallStage=[3] ret:0
Jan  1 00:00:06 syslog: index=[0], ulRate=[103]
Jan  1 00:00:08 syslog: query prog, szBuf = ^R4VxSYNONI^A^D^A
Jan  1 00:00:08 syslog: ninstaller.c:2498(ErrFHOSTUpdateMkfsProgress) gInstallStage=[3] ret:0
Jan  1 00:00:08 syslog: index=[0], ulRate=[104]
[ 5629.344787] md: bind<sda2>
[ 5629.347863] raid1: raid set md1 active with 1 out of 4 mirrors
[ 5629.353752] md1: detected capacity change from 0 to 2147418112
[ 5629.363281]  md1: unknown partition table
[ 5629.407556]  md0: unknown partition table
Jan  1 00:00:08 syslog: raidtool.c:448 system inited on [/dev/sda1 ], [/dev/sda2 ]
[ 5630.796949] EXT4-fs (md0): barriers disabled
[ 5630.808569] EXT4-fs (md0): mounted filesystem with ordered data mode
[ 5630.838161] synoacl module [synoacl_ext4] is not loaded
[ 5630.843488] synoacl module [synoacl_vfs] is not loaded
[ 5630.868775] EXT4-fs (md0): barriers disabled
[ 5630.879679] EXT4-fs (md0): mounted filesystem with ordered data mode
[ 5630.941538] synoacl module [synoacl_ext4] is not loaded
[ 5630.946864] synoacl module [synoacl_vfs] is not loaded
Jan  1 00:00:10 kernel: [ 5630.838161] synoacl module [synoacl_ext4] is not loaded
Jan  1 00:00:10 kernel: [ 5630.843488] synoacl module [synoacl_vfs] is not loaded
Jan  1 00:00:10 syslog: ninstaller.c:2615 /bin/mount /dev/md0 /tmpRoot
Jan  1 00:00:10 syslog: query prog, szBuf = ^R4VxSYNONI^A^D^A
Jan  1 00:00:10 syslog: ninstaller.c:2498(ErrFHOSTUpdateMkfsProgress) gInstallStage=[3] ret:0
Jan  1 00:00:10 syslog: ninstaller.c:2622 /bin/echo 0 > /tmpRoot/.upgrade_vol
Jan  1 00:00:10 syslog: ninstaller.c:2535(ErrFHOSTUpdateMkfsProgress) gInstallStage=[3] , process=[/dev/md0]
Jan  1 00:00:10 syslog: ninstaller.c:2539(ErrFHOSTUpdateMkfsProgress) switch to PROG_FORMAT_DATA
Jan  1 00:00:10 syslog: ninstaller.c:2498(ErrFHOSTUpdateMkfsProgress) gInstallStage=[4] ret:0
Jan  1 00:00:10 syslog: ninstaller.c:2568(ErrFHOSTUpdateMkfsProgress) skip format data volume...
Jan  1 00:00:10 syslog: index=[1], ulRate=[100]
Jan  1 00:00:10 kernel: [ 5630.941538] synoacl module [synoacl_ext4] is not loaded
Jan  1 00:00:10 kernel: [ 5630.946864] synoacl module [synoacl_vfs] is not loaded
Jan  1 00:00:10 syslog: ninstaller.c:2656 retv=[0]
Jan  1 00:00:12 syslog: query prog, szBuf = ^R4VxSYNONI^A^D^A
Jan  1 00:00:12 syslog: ninstaller.c:2498(ErrFHOSTUpdateMkfsProgress) gInstallStage=[4] ret:0
Jan  1 00:00:12 syslog: ninstaller.c:2568(ErrFHOSTUpdateMkfsProgress) skip format data volume...
Jan  1 00:00:12 syslog: index=[1], ulRate=[100]
[ 5634.927896] EXT4-fs (md0): barriers disabled
[ 5634.961736] EXT4-fs (md0): mounted filesystem with ordered data mode
Jan  1 00:00:14 syslog: pat start, szBuf = ^R4VxSYNONI^A^D^A
Jan  1 00:00:14 syslog: ninstaller.c:1724(ErrFHOSTReceiveUpgradeFile): szUpgradeFile = /tmpData//upd@te.pat
Jan  1 00:00:19 syslog: ninstaller.c:1755(ErrFHOSTReceiveUpgradeFile) cRead=[4], ulFileSize=[113233920]
Jan  1 00:00:20 syslog: Estimated time =[2]
Jan  1 00:00:21 syslog: ErrFHOSTTcpResponseCmd: cmd=[5], ulErr=[0]
Jan  1 00:00:21 syslog: Starting ErrFHOSTDoUpgrade()...
Jan  1 00:00:21 syslog: ErrFHOSTTcpResponseCmd: cmd=[5], ulErr=[0]
Jan  1 00:00:21 syslog: ErrFHOSTTcpResponseCmd: cmd=[5], ulErr=[0]
Jan  1 00:00:21 syslog: ninstaller.c:2712(ErrFHOSTDoUpgrade) retv=[0]
Jan  1 00:00:21 syslog: ErrFHOSTDoUpgrade() Done
Jan  1 00:00:21 syslog: query prog, szBuf = ^R4VxSYNONI^A^D^A
Jan  1 00:00:21 syslog: alz=[0], prg=[0], cfg=[0], retv=[0]
Jan  1 00:00:21 syslog: Remove /tmpData/upd@te...cmd=[/bin/rm -rf /tmpData/upd@te > /dev/null 2>&1]
Jan  1 00:00:21 syslog: Create /tmpData/upd@te...cmd=[/bin/mkdir -p /tmpData/upd@te > /dev/null 2>&1]
Jan  1 00:00:21 syslog: Untar /tmpData/upd@te.pat...cmd=[/bin/tar xpf "/tmpData/upd@te.pat" -C /tmpData/upd@te > /dev/null 2>&1]
Jan  1 00:00:22 syslog: Verify checksum of [/tmpData/upd@te]...
Jan  1 00:00:23 syslog: query prog, szBuf = ^R4VxSYNONI^A^D^A
Jan  1 00:00:23 syslog: alz=[0], prg=[0], cfg=[0], retv=[0]
Jan  1 00:00:23 syslog: ErrFHOSTCheckUpgradeFile: Fail to verify checksum of /tmpData/upd@te...(retv=0x3800)
Jan  1 00:00:23 syslog: ErrFHOSTCheckUpgradeFile: set error code cmd=[/bin/echo "A:-13:" > /tmp/update.progress]
Jan  1 00:00:23 syslog: ninstaller.c:2702(ErrFHOSTDoUpgrade) err=[-1]
Jan  1 00:00:25 syslog: query prog, szBuf = ^R4VxSYNONI^A^D^A
Jan  1 00:00:25 syslog: alz=[0], prg=[0], cfg=[0], retv=[-13]
Jan  1 00:00:25 syslog: ninstaller.c:2212(ErrFHOSTUpdaterProgress) retv=-13
Jan  1 00:00:27 syslog: query prog, szBuf = ^R4VxSYNONI^A^D^A
Jan  1 00:00:27 syslog: alz=[0], prg=[0], cfg=[0], retv=[-13]
Jan  1 00:00:27 syslog: ninstaller.c:2212(ErrFHOSTUpdaterProgress) retv=-13
Jan  1 00:00:27 syslog: ninstaller.c:1546(ErrFHOSTNetInstaller) read socket fail, ret=[0], errno=[10]
Jan  1 00:00:27 syslog: ninstaller.c:1630(ErrFHOSTNetInstaller) retSel=[1] err=(10)[No child processes]
Jan  1 00:00:27 syslog: ninstaller.c:1645(ErrFHOSTNetInstaller)
Jan  1 00:00:27 syslog: Return from TcpServer()

goetz · 17. Aug. 2016

Hallo,
probiere mal 4.2-3250 per tftpboot zu laden und 4.2-3254 dann per Webinterface.
http://download.synology.com/download/DSM/release/4.2/3250/
http://download.synology.com/download/DSM/release/4.2/3254/

Gruß Götz

asmodeus · 17. Aug. 2016

Hallo Götz,

hat leider nicht weitergeholfen, gleiche Fehlermeldung vom Assistant und im log:

Rich (BBCode):

Jan  1 00:00:23 syslog: ErrFHOSTCheckUpgradeFile: Fail to verify checksum of /tmpData/upd@te...(retv=0x3800)
Jan  1 00:00:23 syslog: ErrFHOSTCheckUpgradeFile: set error code cmd=[/bin/echo "A:-13:" > /tmp/update.progress

goetz · 18. Aug. 2016

Hallo,
scheinbar hattest Du 4.0-2228 auf der DS. Probiere es mit 2219 als tftp und dann Update auf 2228.

Gruß Götz

asmodeus · 21. Aug. 2016

Gerade getestet, gleiche Problematik.

asmodeus · 23. Aug. 2016

Mit dem Synology-Support zusammen habe ich folgendes herausgefunden: beim Pruefen der Checksumme des .pat gibt es einen Fehler. Tatsaechlich ist es noch viel interessanter:

Code:

DiskStation> cksum upd@te.pat
429484046 183715840 upd@te.pat
DiskStation> cksum upd@te.pat
3678677910 183715840 upd@te.pat
DiskStation> cksum upd@te.pat
1368561111 183715840 upd@te.pat
DiskStation> cksum upd@te.pat
2813842683 183715840 upd@te.pat

Bei mehrmaligen Aufruf kommt cksum also immer auf eine andere Checksumme. Das passiert bei anderen Dateien, die aus dem pat file extrahiert wurden und auch auf der Festplatte liegen nicht:

Code:

DiskStation> cksum hda1.tgz
2292349882 121567413 hda1.tgz
DiskStation> cksum hda1.tgz
2292349882 121567413 hda1.tgz
DiskStation> cksum hda1.tgz
2292349882 121567413 hda1.tgz

Der Support empfahl, einen anderen Disk Slot zu probieren, das zeigt in 1-3 aber das gleiche Verhalten. Ausser einem Hardwaredefekt habe ich gerade auch keine Idee mehr woran das liegen koennte.

asmodeus · 23. Aug. 2016

Die Odysee geht weiter... nachdem klar war, dass die Berechnung der cksum irgendwie kaputt ist, habe ich das einfach gefaked. Im .pat file befindet sich eine checksum.syno in der alle erwarteten Werte stehen. Auf der DiskStation wird /usr/bin/cksum zur Berechnung benutzt. Dabei wird das .pat file als /tmpData/upd@te.pat abgelegt und dann nach /tmpData/upd@te extrahiert. Der updater benutzt z.B. fuer die VERSION Datei /usr/bin/cksum -o3 /tmpData/upd@te/VERSION als Aufruf.

Ich habe das einfach ausgetauscht durch ein Programm dass die erwarteten Werte vorgaukelt (hier im Beispiel DSM 4.1-2228):

Code:

#!/bin/sh
if [ $3 = "/tmpData/upd@te/VERSION" ]; then
       	echo 981380080 167 /tmpData/upd@te/VERSION 174 445
elif [ $3 = "/tmpData/upd@te/hda1.tgz" ]; then
       	echo 1755591817 121567413 /tmpData/upd@te/hda1.tgz 223913014 649
elif [ $3 = "/tmpData/upd@te/zImage" ]; then
       	echo 2536953361 1722894 /tmpData/upd@te/zImage 2142259 617
elif [ $3 = "/tmpData/upd@te/updater" ]; then
       	echo 3571838234 3685476 /tmpData/upd@te/updater 5777095 565
elif [ $3 = "/tmpData/upd@te/rd.bin" ]; then
       	echo 3995425286 734875 /tmpData/upd@te/rd.bin 906133 746
elif [ $3 = "/tmpData/upd@te/packages/MediaServer-ppc853x-1.0-2201.spk" ]; then
       	echo 3165450237 1024000 /tmpData/upd@te/packages/MediaServer-ppc853x-1.0-2201.spk 1025383 707
elif [ $3 = "/tmpData/upd@te/packages/iTunesServer-ppc853x-1.0-2199.spk" ]; then
       	echo 3050659980 307200 /tmpData/upd@te/packages/iTunesServer-ppc853x-1.0-2199.spk 410983 509
elif [ $3 = "/tmpData/upd@te/packages/AudioStation-ppc853x-3.0-2204.spk" ]; then
       	echo 83766731 5068800 /tmpData/upd@te/packages/AudioStation-ppc853x-3.0-2204.spk 9934183 507
elif [ $3 = "/tmpData/upd@te/packages/PhotoStation-ppc853x-5.1-2207.spk" ]; then
       	echo 170110242 3256320 /tmpData/upd@te/packages/PhotoStation-ppc853x-5.1-2207.spk 3544423 611
elif [ $3 = "/tmpData/upd@te/packages/DownloadStation-ppc853x-3.1-2206.spk" ]; then
       	echo 2942251879 5498880 /tmpData/upd@te/packages/DownloadStation-ppc853x-3.1-2206.spk 6155623 704
elif [ $3 = "/tmpData/upd@te/packages/SurveillanceStation-ppc853x-5.1-2208.spk"  ]; then
       	echo 1190269931 40837120 /tmpData/upd@te/packages/SurveillanceStation-ppc853x-5.1-2208.spk 48293223 604
else
       	echo $*
fi

Und siehe da: der Updater schrieb ein korrektes kernel image und root fs ins flash und das Ding bootet danach wieder ohne serielle Konsole! Leider geht danach wieder was schief im Update-Prozess.

Auf zum naechsten Schritt

tschortsch · 23. Aug. 2016

Kreative Lösung ;-)
Ab hier könnte ein doppelreset helfen und das nochmalige einspielen des orginalen pat File mit der gleichen Versionsnummer.

asmodeus · 23. Aug. 2016

Danke, ich hoffe ich kann Deinen Tipp irgendwann ausprobieren! Bin vorerst am Ende angelangt, nachdem der Speichertest seit dem erfolgreichen flashen nun reproduzierbar Probleme meldet:

Code:

DiskStation> memtester -max 3

pagesize is 4096
pagesizemask is 0xfffff000
want 482MB (505413632 bytes)
got  482MB (505413632 bytes), trying mlock ...locked.
Loop 1/3:
  Stuck Address       : testing   0FAILURE: possible bad address line at offset 0x00af541b.
Skipping to next test...
Done.

Der Speichertest des Synology Supports vor dem flashen - da war die DS noch per tftp gebootet - lief 3x ohne Fehler komplett durch. Alles sehr merkwuerdig... Ich werde passende SO-Dimms besorgen und den Speicher ersetzen, falls mir Synology nicht noch ein Reparaturangebot macht.

Das Internet meint es passen DDR2 533 oder 667 SO-Dimms bis 512MB oder 1GB. Habe Erfolgsberichte mit Kingston KVR667D2S5/1G und KVR667D2SO gefunden.

asmodeus · 09. Sep. 2016

Mein letztes Update mit einem Erfolgsbericht

Ich habe den Speicher ersetzt durch 1 GB Kingston KVR667D2S5/1G (amazon DE link) und konnte danach mit dem Synology Assistant die DiskStation erfolgreich wieder zum Leben erwecken. Damit endet die Odyssee, ich hoffe die der Thread ist noch vielen anderen behilflich. Danke nochmal an alle Tipgeber und Helfer!

dil88 · 09. Sep. 2016

Sehr schön, danke für den Hinweis auf die Ursache RAM.

Suche

Suche

Gebrickte DS409+ wiederherstellen

asmodeus

Benutzer

goetz

Super-Moderator

asmodeus

Benutzer

goetz

Super-Moderator

asmodeus

Benutzer

asmodeus

Benutzer

asmodeus

Benutzer

tschortsch

Benutzer

asmodeus

Benutzer

asmodeus

Benutzer

dil88

Benutzer

Kaffeautomat