fhem startet nach Restore nicht mehr

Christian72D · 14 Dezember 2019, 17:26:49

Ich sitze gerade bei einem Freund, wir haben von seinem stabil laufendem fhem ein Backup erstellt (mit dem Backup Befehl), dieses auf einen USB Stick gesichert.
Dann ganz frisch Raspbian Buster installiert und nach Anleitung https://wiki.fhem.de/wiki/Raspberry_Pi fhem installiert, es lief auch sofort.

Also Backup eingespielt nach dieser Anleitung https://waschto.eu/fhem-umzug-bei-einem-systemwechsel/#Backup_wieder_einspielen und es läuft nichts mehr.

Was kann das jetzt sein?

Otto123 · 14 Dezember 2019, 17:38:00

Weil die Anleitung uralt und fehlerhaft ist?

Oder weil Voraussetzungen fehlen und FHEM nicht mehr startet?

Was sagt denn das fhem.log ?

Code Auswählen

tail /opt/fhem/log/fhem-2019-12.log

Gruß Otto

Christian72D · 14 Dezember 2019, 17:41:04

Zitat von: Otto123 am 14 Dezember 2019, 17:38:00
Weil die Anleitung uralt und fehlerhaft ist?

Oder weil Voraussetzungen fehlen und FHEM nicht mehr startet?

Was sagt denn das fhem.log ?
Code Auswählen Erweitern
tail /opt/fhem/log/fhem-2019-12.log

Gruß Otto

Welche ist uralt und fehlerhaft? Die vom Wiki oder die vom Restore?

Otto123 · 14 Dezember 2019, 17:43:32

die vom Restore - das setup vom Wiki hat ja funktioniert

Wzut · 14 Dezember 2019, 17:45:14

@Christian72D , deine wasch.to Anleitung geht mit keinem Wort auf zusätzliche Perl Pakete ein , daher liefere bitte das von Otto geforderte .....

Otto123 · 14 Dezember 2019, 17:49:48

und in der Anleitung wird fhem nicht beendet:

Zitatinvoke-rc.d fhem stop

dürfte ohne sudo nicht funktionieren. Keine Ahnung was passiert wenn das restore bei laufendem Dienst passiert... Vielleicht passiert nichts schlimmes, aber es läuft ja nicht.

Ich hoffe ihr habt die alte SD Card noch?

Zumindest was an debian Paketen installiert wurde kann man herausfinden: https://heinz-otto.blogspot.com/2019/07/infos-zur-installation-von-modulen-und.html

Christian72D · 14 Dezember 2019, 17:56:46

Ich habe es jetzt anders gemacht: Raspi inkl fhem noch mal frisch aufgesetzt, geht ja flott, läuft auch.

Wie genau spiele ich das Backup denn jetzt RICHTIG ein?

Otto123 · 14 Dezember 2019, 17:59:08

Ich hole mir das alte backup immer als User pi

Code Auswählen

sudo systemctl stop fhem
sudo tar -xvzf /home/pi/FHEM-201xxxxx_xxxxxx.tar.gz -C /opt/fhem/
sudo systemctl start fhem

Manchmal ist das aber nicht alles:
wie schon gesagt: Software Pakete fehlen.
ssh usw. https://heinz-otto.blogspot.com/2019/07/neues-linux-system-nacharbeit.html

Christian72D · 14 Dezember 2019, 18:01:32

Zitat von: Otto123 am 14 Dezember 2019, 17:59:08
Ich hole mir das alte backup immer als User pi
Code Auswählen Erweitern
sudo systemctl stop fhem sudo tar -xvzf /home/pi/FHEM-201xxxxx_xxxxxx.tar.gz -C /opt/fhem/ sudo systemctl start fhem

Im Wiki wird fhem mit

Code Auswählen

sudo /etc/init.d/fhem stop beendet... da soll ein Laie mal durchblicken...

Otto123 · 14 Dezember 2019, 18:03:45

naja das ist Software Entwicklung

linux hat sich verändert ... und viele Wege ....

Wichtig ist, dass fhem beendet wird: zum prüfen

Code Auswählen

ps -aux|grep fhem

Frank_Huber · 14 Dezember 2019, 18:06:24

sudo service fhem stop
sudo service fhem start

Geht btw auch. [emoji6]

Gesendet von meinem Doogee S60 mit Tapatalk

Christian72D · 14 Dezember 2019, 19:57:22

So, alles nach Anleitung gemacht, zumindest scheint es zu laufen, es kommt im Brwoser keine Meldung mehr, daß nichts gefunden, es kommt eine leere Seite.

Ich habe mal die über 200 Zeilen Sonos rausgeworfen... liegts am Token?

Code Auswählen

2019.12.14 19:21:41 1: Including fhem.cfg
2019.12.14 19:21:41 3: telnetPort: port 7072 opened
2019.12.14 19:21:42 3: WEB: port 8083 opened
2019.12.14 19:21:42 3: WEBphone: port 8084 opened
2019.12.14 19:21:42 3: WEBtablet: port 8085 opened
2019.12.14 19:21:42 2: eventTypes: loaded 4135 events from ./log/eventTypes.txt
2019.12.14 19:21:42 1: HMLAN_Parse: HMLAN1 new condition disconnected
2019.12.14 19:21:42 3: Opening HMLAN1 device 192.168.178.44:1000
2019.12.14 19:21:42 1: HMLAN_Parse: HMLAN1 new condition init
2019.12.14 19:21:42 3: HMLAN1 device opened
2019.12.14 19:21:42 3: Opening CUL0 device /dev/ttyACM0
2019.12.14 19:21:42 1: CUL0: Can't open /dev/ttyACM0: No such file or directory
2019.12.14 19:21:42 2: Switched CUL0 rfmode to HomeMatic
2019.12.14 19:21:46 3: HUEDevice4: I/O device is HUE
2019.12.14 19:21:46 3: HUEDevice3: I/O device is HUE
2019.12.14 19:21:46 3: HUEDevice2: I/O device is HUE
2019.12.14 19:21:46 3: HUEGroup1: I/O device is HUE
2019.12.14 19:21:46 3: HUEGroup0: I/O device is HUE
2019.12.14 19:21:46 3: HUEGroup2: I/O device is HUE
2019.12.14 19:21:47 3: TABLETUI: new ext defined infix:ftui/: dir:./www/tablet/:
2019.12.14 19:21:47 3: Registering HTTPSRV TABLETUI for URL /ftui   and assigned link ftui/ ...
2019.12.14 19:21:47 1: Including ./log/fhem.save
2019.12.14 19:21:48 3: Device Aussenfuehler added to ActionDetector with 000:10 time
2019.12.14 19:21:48 3: Device BA.Fenster added to ActionDetector with 002:50 time
2019.12.14 19:21:48 3: Device BA_Heizung added to ActionDetector with 000:10 time
2019.12.14 19:21:48 3: Device BU.Fenster added to ActionDetector with 002:50 time
2019.12.14 19:21:48 3: Device BU_Heizung added to ActionDetector with 000:10 time
2019.12.14 19:21:48 3: Device KU.Fenster added to ActionDetector with 002:50 time
2019.12.14 19:21:48 3: Device KU.Tuer added to ActionDetector with 002:50 time
2019.12.14 19:21:48 3: Device KU.TuerGriff added to ActionDetector with 028:00 time
2019.12.14 19:21:48 3: Device KU_Heizung added to ActionDetector with 000:10 time
2019.12.14 19:21:48 3: Device SZ.FensterLinks added to ActionDetector with 002:50 time
2019.12.14 19:21:48 3: Device SZ.FensterRechts added to ActionDetector with 002:50 time
2019.12.14 19:21:48 3: Device SZ.TuerGriff added to ActionDetector with 028:00 time
2019.12.14 19:21:48 3: Device SZ_Heizung added to ActionDetector with 000:10 time
2019.12.14 19:21:48 3: Device WZ.FensterLinks added to ActionDetector with 002:50 time
2019.12.14 19:21:48 3: Device WZ.FensterMitte added to ActionDetector with 002:50 time
2019.12.14 19:21:48 3: Device WZ.FensterRechts added to ActionDetector with 002:50 time
2019.12.14 19:21:48 3: Device WZ.FensterSeite added to ActionDetector with 002:50 time
2019.12.14 19:21:48 3: Device WZ_Heizung added to ActionDetector with 000:10 time
2019.12.14 19:21:49 2: HUEBridge_OpenDev: error reading description: http://192.168.2.70/description.xml: Can't connect(1) to http://192.168.2.70:80: IO::Socket::INET: connect: Network is unreachable
2019.12.14 19:21:49 2: HUE: empty answer received for http://192.168.2.70/api/Qcs8ARWUeC5Vr9z5xAKlUQtJflSpSImD7gqxYN8A/config
2019.12.14 19:21:49 2: HUEBridge_OpenDev: got empty config
2019.12.14 19:21:49 1: usb create starting
2019.12.14 19:21:49 3: Probing ZWDongle device /dev/serial1
2019.12.14 19:21:49 3: Probing CUL device /dev/ttyAMA0
2019.12.14 19:21:50 3: Probing TCM_ESP3 device /dev/ttyAMA0
2019.12.14 19:21:50 3: Probing ZWDongle device /dev/ttyAMA0
2019.12.14 19:21:50 3: Probing SIGNALDuino device /dev/ttyAMA0
2019.12.14 19:21:50 3: Probing MYSENSORS device /dev/ttyAMA0
2019.12.14 19:21:50 3: Probing ArduCounter device /dev/ttyAMA0
2019.12.14 19:21:50 3: Probing ElsnerWS device /dev/ttyAMA0
2019.12.14 19:21:51 3: Probing FRM device /dev/ttyAMA0
2019.12.14 19:21:57 1: usb create end
2019.12.14 19:21:57 0: Featurelevel: 5.9
2019.12.14 19:21:57 0: Server started with 190 defined entities (fhem.pl:20651/2019-12-03 perl:5.028001 os:linux user:fhem pid:545)
2019.12.14 19:21:57 1: SONOS0: Kein UPnP-Server gefunden... Starte selber einen und warte 8 Sekunde(n) darauf...
2019.12.14 19:21:57 3: CUL_HM set BA.Rolladen statusRequest
2019.12.14 19:21:57 2: HUE: http request failed: 192.168.2.70: Network is unreachable (101)
2019.12.14 19:21:57 2: HUE: http request failed: 192.168.2.70: Network is unreachable (101)
2019.12.14 19:21:57 2: HUE: http request failed: 192.168.2.70: Network is unreachable (101)
2019.12.14 19:21:57 1: HMLAN_Parse: HMLAN1 new condition ok
2019.12.14 19:21:57 2: HUE: http request failed: 192.168.2.70: Network is unreachable (101)
2019.12.14 19:21:57 2: HUE: http request failed: 192.168.2.70: Network is unreachable (101)
2019.12.14 19:21:57 2: HUE: http request failed: 192.168.2.70: Network is unreachable (101)
2019.12.14 19:21:57 3: CUL_HM set SZ.Heizung desired-temp 16.0
2019.12.14 19:21:57 1: Calendar Dienstplan: retrieval failed with HTTP response code 404
2019.12.14 19:21:57 1: Calendar Dienstplan: retrieved no or empty data
2019.12.14 19:21:58 3: CUL_HM set SZ.Fenster statusRequest
2019.12.14 19:21:58 1: SONOS0: ./FHEM/00_SONOS.pm is started by fhem...
2019.12.14 19:21:58 1: SONOS0: ./FHEM/00_SONOS.pm is listening to Port 4711
2019.12.14 19:21:59 3: CUL_HM set SZ.Tuer statusRequest
2019.12.14 19:22:00 3: CUL_HM set Steckdose1 statusRequest
2019.12.14 19:22:01 3: CUL_HM set Steckdose2 statusRequest
2019.12.14 19:22:02 3: CUL_HM set Steckdose3 statusRequest
2019.12.14 19:22:12 3: Opening Sonos device localhost:4711
2019.12.14 19:22:12 3: SONOS0: Connection accepted from localhost:42260
2019.12.14 19:22:12 3: Sonos device opened
2019.12.14 19:22:13 1: SONOS1: UPnP-Thread gestartet.
2019.12.14 19:22:13 2: SONOS1: Discover Sonosplayer 'Wohnzimmer' (S9) Software Revision 10.5.1 with ID 'RINCON_B8E93778BE1A01400_MR'
Subscription request failed with error: 503 Service Unavailable at ./FHEM/00_SONOS.pm line 6098 thread 1.
Subscription request failed with error: 503 Service Unavailable at ./FHEM/00_SONOS.pm line 6098 thread 1.
2019.12.14 19:22:21 1: SONOS1: Rendering-Service-subscribing NOT successful: 
2019.12.14 19:22:53 3: CUL_HM set WZ.FensterLinks getConfig
2019.12.14 19:22:57 1: checkFritzMACpresent (FB_SZ): mac_D8_1C_79_DB_6A_7A nicht gefunden, abwesend.
2019.12.14 19:22:57 3: CUL_HM set SZ.Heizung desired-temp 16.0
2019.12.14 19:22:57 1: checkFritzMACpresent (FB_WZ): mac_D8_1C_79_DB_6A_7A gefunden, Gerät heißt >PC-192-168-178-56 (WLAN, 520 / 390 Mbit/s, -64)<.
2019.12.14 19:23:57 1: checkFritzMACpresent (FB_SZ): mac_D8_1C_79_DB_6A_7A nicht gefunden, abwesend.
2019.12.14 19:23:57 3: CUL_HM set SZ.Heizung desired-temp 16.0
2019.12.14 19:23:57 1: checkFritzMACpresent (FB_WZ): mac_D8_1C_79_DB_6A_7A gefunden, Gerät heißt >PC-192-168-178-56 (WLAN, 520 / 390 Mbit/s, -64)<.
2019.12.14 19:24:10 3: FHEMWEB WEB CSRF error: csrf_91594460736835 ne csrf_257874174591546 for client WEB_192.168.178.49_57031 / command backup. For details see the csrfToken FHEMWEB attribute.
2019.12.14 19:24:22 3: FHEMWEB WEB CSRF error: csrf_91594460736835 ne csrf_257874174591546 for client WEB_192.168.178.49_57031 / command backup. For details see the csrfToken FHEMWEB attribute.
2019.12.14 19:24:27 3: FHEMWEB WEB CSRF error: csrf_91594460736835 ne csrf_257874174591546 for client WEB_192.168.178.49_57036 / command backup. For details see the csrfToken FHEMWEB attribute.
2019.12.14 19:24:41 0: Server shutdown

Die HUE Meldung ist OK, er hatte zwischendurch mal das Netzwerk komplett umgestellt.

Christian72D · 14 Dezember 2019, 20:01:47

Zitat von: Christian72D am 14 Dezember 2019, 19:57:22

Ich habe mal die über 200 Zeilen Sonos rausgeworfen... liegts am Token?

Daran lags... per Nano rein gepackt, es läuft!

DANKE!!!!!!!!!

Otto123 · 14 Dezember 2019, 20:15:00

den versteh ich nicht ganz? Du meinst den csrfToken? Was hat der mit Sonos zu tun?

Wo hast Du was per nano reingepackt?

Mach bitte in der Kommandozeile:

Code Auswählen

attr initialUsbCheck disable 1
und dann save