Mein FHEM lässt sich nicht mehr starten

Gonzolo · 17 Januar 2020, 16:23:24

Hallo bauche mal wieder Eure Hilfe.

Ich weiß das Thema wurde hier schon öfters gepostet. Aber die gegebenen Antworten haben bei mir nicht geholfen.

Ich habe meinen Raspberry Pi etwas unsanft ausgeschaltet (Stecker gezogen) und nun will FHEM nicht mehr.

Nach dem Befehl

Code Auswählen

sudo systemctl start fhem

Bringt er folgende Fehlermeldung

Code Auswählen

Job for fhem.service failed. See 'systemctl status fhem.service' and 'journalctl -xn' for details.

Mache ich wie er mir vorschlägt bekomme ich folgendes:

Code Auswählen

● fhem.service - LSB: FHEM server
   Loaded: loaded (/etc/init.d/fhem)
   Active: failed (Result: exit-code) since Fri 2020-01-17 16:12:39 CET; 1min 37s ago
  Process: 1975 ExecStart=/etc/init.d/fhem start (code=exited, status=203/EXEC)

Kann mir jemand helfen!

ACHTUNG ... bin echt Neuling. War froh das ich FHEM zum laufen gebracht habe.

Danke für Eure Hilfe!

Folgende habe ich schon versucht:

https://wiki.fhem.de/wiki/FHEM_startet_nicht_-_Tipps_zur_Fehlersuche
Systemzeit auf dem Pi synkronisiert
fhem-2020.01.log ausgelesen .. da schreibt er beim Startversucht nix rein

Auch habe ich schon gelernt, dass immer nach der /etc/init.d/fhem gefragt wir. Deswegen gleich mal dabei.

Code Auswählen


#!/bin/sh
# description: Start or stop the fhem server
# Added by Alex Peuchert

### BEGIN INIT INFO
# Provides:             fhem.pl
# Required-Start:       $local_fs $remote_fs
# Required-Stop:        $local_fs $remote_fs
# Default-Start:        2 3 4 5
# Default-Stop:         0 1 6
# Short-Description:    FHEM server
### END INIT INFO

set -e
cd /opt/fhem
port=7072

if test "$2" != "noaptmark"; then
  apt-mark hold fhem > /dev/null
fi

case "$1" in
'start')

        echo "Starting fhem..."

# if you need to start hmland for use with
# Homematic, please start the hmland daemon
# like this (please use correct path and port,
# depending on your installation!)
#
#       /opt/hmcfgusb/hmland -d -p 1234 -r 0
#

        perl fhem.pl fhem.cfg

# if you want to use configDB for configuration,
# use this command to start fhem:
#
#       perl fhem.pl configDB
#
# and remove/comment the above line including fhem.cfg

        RETVAL=$?
        ;;
'stop')
        echo "Stopping fhem..."

# if you want to stop hmland during fhem stop:
#       pkill hmland

        pkill -U fhem perl
        RETVAL=$?
        ;;
'status')
        cnt=`ps -ef | grep "fhem.pl" | grep -v grep | wc -l`
        if [ "$cnt" -eq "0" ] ; then
                echo "fhem is not running"
        else
                echo "fhem is running"
        fi
        ;;
*)
        echo "Usage: $0 { start | stop | status }"
        RETVAL=1
        ;;
esac
exit $RETVAL

Vielen Dank für Eure Hilfe!

Beste Grüße

Gonzolo

Beta-User · 17 Januar 2020, 16:34:18

Stecker ziehen gefährdet die Integrität der SD-Karte...

Was sind denn die letzten Einträge im FHEM-log, wie auf der Wiki-Seite ja auch angegeben? In der Regel steht da was zum letzten Startvorgang, wenn nicht, ist es ziemlich sicher, dass die Karte was abekommen hat!

Wie ist es mit Ersatzkarte auspacken, dein Backup einspielen und die jetzige Karte einfach vergessen/ggf. nach einem Integritätscheck wegwerfen

?

(Da du noch ein System hast, das init.d nutzt, wäre es eh' mal an der Zeit...).

Gonzolo · 17 Januar 2020, 16:41:37

Hallo Beate-Use

also ich habe auch ein Backup Image auf eine zweite Karte. ABER da ist das FHEM noch nie wirklich gestartet (gleicher Fehler!)

Im Log sind Die eintrage von heute Morgen folgende:

Code Auswählen

2020.01.17 08:13:11 0: HMCCU: Periodical check found no RPC Servers
2020.01.17 08:13:11 0: HMCCU: All RPC servers stopped
2020.01.17 08:13:15 2: HMCCU: [myccu] Error during HTTP request: http://192.168.0.178:8181/tclrega.exe: Select timeout/error:
2020.01.17 08:13:15 1: PERL WARNING: Use of uninitialized value $response in concatenation (.) or string at ./FHEM/88_HMCCU.pm line 6185.
2020.01.17 08:13:15 1: HMCCUDEV: [Heizung_Bad] HMCCUDEV: Heizung_Bad Execution of CCU script or command failed
2020.01.17 08:13:15 2: Heizung_Bad_SetTemp: set Heizung_Bad datapoint 1.SET_POINT_TEMPERATURE 21: HMCCUDEV: Heizung_Bad Execution of CCU script or command failed
2020.01.17 08:13:19 2: HMCCU: [myccu] Error during HTTP request: http://192.168.0.178:8181/tclrega.exe: Select timeout/error:
2020.01.17 08:13:19 1: HMCCUDEV: [Heizung_Esszimmer] HMCCUDEV: Heizung_Esszimmer Execution of CCU script or command failed
2020.01.17 08:13:19 2: Heizung_Esszimmer_SetTemp: set Heizung_Esszimmer datapoint 1.SET_POINT_TEMPERATURE 22.0: HMCCUDEV: Heizung_Esszimmer Execution of CCU script or command failed
2020.01.17 08:13:23 2: HMCCU: [myccu] Error during HTTP request: http://192.168.0.178:8181/tclrega.exe: Select timeout/error:
2020.01.17 08:13:23 1: HMCCUDEV: [Heizung_Gastzimmer] HMCCUDEV: Heizung_Gastzimmer Execution of CCU script or command failed
2020.01.17 08:13:23 2: Heizung_Gastzimmer_SetTemp: set Heizung_Gastzimmer datapoint 1.SET_POINT_TEMPERATURE 21.0: HMCCUDEV: Heizung_Gastzimmer Execution of CCU script or command failed
2020.01.17 08:13:27 2: HMCCU: [myccu] Error during HTTP request: http://192.168.0.178:8181/tclrega.exe: Select timeout/error:
2020.01.17 08:13:27 1: HMCCUDEV: [Heizung_Kueche] HMCCUDEV: Heizung_Kueche Execution of CCU script or command failed
2020.01.17 08:13:27 2: Heizung_Kueche_SetTemp: set Heizung_Kueche datapoint 1.SET_POINT_TEMPERATURE 22.0: HMCCUDEV: Heizung_Kueche Execution of CCU script or command failed
2020.01.17 08:13:31 2: HMCCU: [myccu] Error during HTTP request: http://192.168.0.178:8181/tclrega.exe: Select timeout/error:
2020.01.17 08:13:31 1: HMCCUDEV: [Heizung_Wohnzimmer] HMCCUDEV: Heizung_Wohnzimmer Execution of CCU script or command failed
2020.01.17 08:13:31 2: Heizung_Wohnzimmer_SetTemp: set Heizung_Wohnzimmer datapoint 1.SET_POINT_TEMPERATURE 22.0: HMCCUDEV: Heizung_Wohnzimmer Execution of CCU script or command failed
2020.01.17 08:13:31 2: HMCCU: [myccu] Update success=13 failed=0
2020.01.17 08:13:57 1: HMCCU: [myccu] Internal RPC server is depricated and will be removed soon. Set ccuflags to procrpc
2020.01.17 08:13:57 1: HMCCU: [myccu] Can't connect to RPC host 192.168.0.178 port2001
2020.01.17 08:13:57 1: HMCCU: [myccu] HMCCU: myccu Start of RPC server failed
2020.01.17 08:14:08 1: HMCCU: [myccu] Internal RPC server is depricated and will be removed soon. Set ccuflags to procrpc
2020.01.17 08:14:23 1: HMCCU: [myccu] Can't connect to RPC host 192.168.0.178 port2001
2020.01.17 08:14:23 1: HMCCU: [myccu] HMCCU: myccu Start of RPC server failed
2020.01.17 08:14:23 3: BOSEST: BOSE_7C3866EBB631, WebSocket connection dropped - try reconnect.
2020.01.17 08:14:48 3: BOSEST: BOSE_7C3866EBB631, new IP (192.168.0.101)
2020.01.17 08:14:50 3: BOSEST: BOSE_7C3866EBB631, WebSocket connection succeed.
2020.01.17 08:15:06 1: HMCCU: [myccu] Internal RPC server is depricated and will be removed soon. Set ccuflags to procrpc
2020.01.17 08:15:06 2: HMCCU: Create child process with timeouts 0.01 and 0.25
2020.01.17 08:15:06 0: HMCCU: Child process for server CB2001 started with PID 3420
2020.01.17 08:15:06 0: CCURPC: CB2001 Creating file queue /tmp/ccuqueue_2001_1
2020.01.17 08:15:06 0: CCURPC: Initializing RPC server CB2001
2020.01.17 08:15:06 1: HMCCU: [myccu] All RPC servers starting
2020.01.17 08:15:06 0: HMCCU: [myccu] RPC server(s) starting
2020.01.17 08:15:06 0: CCURPC: Callback server created listening on port 7411
2020.01.17 08:15:06 1: CCURPC: CB2001 Adding callback for events
2020.01.17 08:15:06 1: CCURPC: CB2001 Adding callback for new devices
2020.01.17 08:15:06 1: CCURPC: CB2001 Adding callback for deleted devices
2020.01.17 08:15:06 1: CCURPC: CB2001 Adding callback for modified devices
2020.01.17 08:15:06 1: CCURPC: CB2001 Adding callback for replaced devices
2020.01.17 08:15:06 1: CCURPC: CB2001 Adding callback for readded devices
2020.01.17 08:15:06 1: CCURPC: CB2001 Adding callback for list devices
2020.01.17 08:15:06 0: CCURPC: CB2001 Entering server loop
2020.01.17 08:15:13 0: HMCCU: Received SL event. RPC server CB2001 enters server loop
2020.01.17 08:15:20 1: HMCCU: Registering callback http://192.168.0.242:7411/fh2001 with ID CB2001 at http://192.168.0.178:2001
2020.01.17 08:15:21 1: CCURPC: CB2001 ListDevices. Sending init to HMCCU
2020.01.17 08:15:21 1: HMCCU: RPC callback with URL http://192.168.0.242:7411/fh2001 initialized
2020.01.17 08:15:21 2: CCURPC: CB2001 NewDevice received 88 device specifications
2020.01.17 08:15:26 0: HMCCU: Received IN event. RPC server CB2001 initialized.
2020.01.17 08:15:26 1: HMCCU: [myccu] All RPC servers running
2020.01.17 08:15:26 2: HMCCU: [myccu] Updating 13 of 13 client devices matching devexp=.* filter=ccudevstate=active
2020.01.17 08:15:26 2: HMCCU: [myccu] Update success=0 failed=13
2020.01.17 08:24:47 2: HMCCU: [myccu] HMScript failed. http://192.168.0.178:8181/tclrega.exe: Select timeout/error:
2020.01.17 08:24:47 1: HMCCUDEV: [Heizung_Esszimmer] HMCCUDEV: Heizung_Esszimmer Execution of CCU script or command failed
2020.01.17 08:25:35 2: HMCCU: [myccu] Error during HTTP request: http://192.168.0.178:8181/tclrega.exe: Select timeout/error:
2020.01.17 08:25:35 1: HMCCUDEV: [Heizung_Bad] HMCCUDEV: Heizung_Bad Execution of CCU script or command failed
2020.01.17 08:25:35 2: Heizung_Bad_SetTemp: set Heizung_Bad datapoint 1.SET_POINT_TEMPERATURE 21: HMCCUDEV: Heizung_Bad Execution of CCU script or command failed
2020.01.17 08:25:39 2: HMCCU: [myccu] Error during HTTP request: http://192.168.0.178:8181/tclrega.exe: Select timeout/error:
2020.01.17 08:25:39 1: HMCCUDEV: [Heizung_Esszimmer] HMCCUDEV: Heizung_Esszimmer Execution of CCU script or command failed
2020.01.17 08:25:39 2: Heizung_Esszimmer_SetTemp: set Heizung_Esszimmer datapoint 1.SET_POINT_TEMPERATURE 22.0: HMCCUDEV: Heizung_Esszimmer Execution of CCU script or command failed
2020.01.17 08:25:43 2: HMCCU: [myccu] Error during HTTP request: http://192.168.0.178:8181/tclrega.exe: Select timeout/error:
2020.01.17 08:25:43 1: HMCCUDEV: [Heizung_Gastzimmer] HMCCUDEV: Heizung_Gastzimmer Execution of CCU script or command failed
2020.01.17 08:25:43 2: Heizung_Gastzimmer_SetTemp: set Heizung_Gastzimmer datapoint 1.SET_POINT_TEMPERATURE 21.0: HMCCUDEV: Heizung_Gastzimmer Execution of CCU script or command failed
2020.01.17 08:25:50 3: BOSEST: BOSE_7C3866EBB631, WebSocket connection dropped - try reconnect.
2020.01.17 08:26:25 2: HMCCU: Received no events from CCU since 600 seconds
2020.01.17 08:26:42 3: BOSEST: BOSE_7C3866EBB631, new IP (192.168.0.101)
2020.01.17 08:26:44 3: BOSEST: BOSE_7C3866EBB631, WebSocket connection succeed.
2020.01.17 09:09:56 1: Calendar FeiertageBW: retrieval failed with error message connect to http://www.ifeiertage.de:80 timed out
2020.01.17 09:09:56 1: Calendar FeiertageBW: retrieved no or empty data
2020.01.17 10:09:33 1: Calendar FeiertageBW: retrieval failed with error message www.ifeiertage.de: No route to host (113)
2020.01.17 10:09:33 1: Calendar FeiertageBW: retrieved no or empty data
2020.01.17 11:04:50 2: HMCCU: [myccu] Updating 13 of 13 client devices matching devexp=.* filter=ccudevstate=active
2020.01.17 11:04:54 2: HMCCU: [myccu] HMScript failed. http://192.168.0.178:8181/tclrega.exe: Select timeout/error:
2020.01.17 11:05:01 2: HMCCU: [myccu] HMCCU: Found no devices to update
2020.01.17 11:05:03 2: HMCCU: [myccu] HMCCU: Found no devices to update
Undefined subroutine &main::HMCCURPC_StopRPCServer called at ./FHEM/88_HMCCU.pm line 1714.

Beta-User · 17 Januar 2020, 16:58:10

Suchst du Helfer oder Spaß?

Ausgehend von der Annahme, dass die Backup-Karte nicht auch einen geklonten Fehler enthält: Vielleicht ist es so, dass du (teilweise?) "nur" alte Versionen von den HMCCU-Modulen hast, und da irgendwas nicht mehr zusammenpasst. Dann ggf. die aktuellen update/svn-Versionen holen. (Ungetestet: die aktuelle fhem-nightly-deb installieren, oder mit der Demo-cfg starten und darüber den update-Befehl absetzen).

Danach evtl. mal nachsehen, ob die CCU-Definition veraltet ist und was umgestellt werden muß ("deprecated" im log).

Wegen dem hier

ZitatUndefined subroutine &main::HMCCURPC_StopRPCServer called at ./FHEM/88_HMCCU.pm line 1714.

werde ich aber trotzdem den Verdacht nicht los, dass diese Datei nicht vollständig ist. Glaskugel sagt: die ist kaputt, Stecker ziehen war keine gute Idee...

Kann aber auch eine Kombi von beidem sein...

KernSani · 17 Januar 2020, 17:03:20

Ohne das jetzt im Detail zu betrachtet zu haben, würde ich behaupten, du hast ein Netzwerkproblem.

Interessant wäre aber nicht nur, warum FHEM gestorben ist, sondern warum es nicht startet. Stoppe den Service und starte perl so:

Code Auswählen


perl fhem.pl -d fhem.cfg

Gonzolo · 17 Januar 2020, 17:28:13

Hallo Beter-User,

Erstmal sorry! Ich habe tatsächlich falsch gelesen!

Ich suche Hilfe und kein Spaß!

KernSani werde ich versuchen wenn ich wieder am Rechner bin.

Habe bereits versucht mit

Code Auswählen

sudo systemctl stop fhem

FHEM zu beenden und dann wieder zu starten ... kein Erfolg!

Gonzolo · 17 Januar 2020, 17:51:04

Zitat von: KernSani am 17 Januar 2020, 17:03:20
Ohne das jetzt im Detail zu betrachtet zu haben, würde ich behaupten, du hast ein Netzwerkproblem.

Interessant wäre aber nicht nur, warum FHEM gestorben ist, sondern warum es nicht startet. Stoppe den Service und starte perl so:

Code Auswählen Erweitern
perl fhem.pl -d fhem.cfg

Leider kein erfolg!

Gonzolo · 17 Januar 2020, 18:18:46

Zitat von: Beta-User am 17 Januar 2020, 16:58:10
Suchst du Helfer oder Spaß?

Ausgehend von der Annahme, dass die Backup-Karte nicht auch einen geklonten Fehler enthält: Vielleicht ist es so, dass du (teilweise?) "nur" alte Versionen von den HMCCU-Modulen hast, und da irgendwas nicht mehr zusammenpasst. Dann ggf. die aktuellen update/svn-Versionen holen. (Ungetestet: die aktuelle fhem-nightly-deb installieren, oder mit der Demo-cfg starten und darüber den update-Befehl absetzen).

Danke Beta-User... habe versucht mit dem Befehl

Code Auswählen

sudo perl fhem.pl fhem.cfg.demo mit Demo-cfg zu starten. bekomme nach feuern des Befehls keine Rückmeldung. Aber wenn ich danach mit

Code Auswählen

service fhem status bekomme ich wieder die Fehlermeldung

Code Auswählen

● fhem.service - LSB: FHEM server
   Loaded: loaded (/etc/init.d/fhem)
   Active: failed (Result: exit-code) since Fri 2020-01-17 17:56:43 CET; 18min ago
  Process: 2898 ExecStart=/etc/init.d/fhem start (code=exited, status=139)
pi@raspberrypi:/opt/fhem $ sudo perl fhem.pl fhem.cfg.demo

ausgegeben?!

PS: Sorry noch mal!!

Beta-User · 17 Januar 2020, 18:25:06

Die demo sollte über den Browser wie sonst auch unter Port 8083 zu sehen sein. Darüber dann update machen...

Wernieman · 17 Januar 2020, 20:59:15

Gucke erstmal ob FHEM Reste laufen:

Code Auswählen

ps aux | grep [f]hem
Wenn keine Ausgabe gut, wenn doch ein Prozess erscheint bitte killen (oder hier schreiben)

Dann man schauen, ob der Kernel Probleme im io-Bereich hat

Code Auswählen

grep -i i/o /var/log/kern.log

Hinweis: Obiges ist etwas "aus dem kopf" geschrieben und aktuell nicht getestet
Wenn keine Ausgabe gut, wenn doch hier Ausgabe schreiben

Jetzt 2 Verbindungen zum PI aufmachen.
1.:

Code Auswählen

watch -n1 "ps aux | grep [f]hem"
2.:

Code Auswählen

sudo perl fhem.pl fhem.cfg.demo
Jetzt mal schauen ob im 1. Fenster ein FHEM-prozess erscheint ...

Gonzolo · 17 Januar 2020, 23:06:02

Zitat von: Beta-User am 17 Januar 2020, 18:25:06
Die demo sollte über den Browser wie sonst auch unter Port 8083 zu sehen sein. Darüber dann update machen...

Dem geht leider nicht! Über http/192.xxx.x.xxx/8083/fhem kommt kein web-gui

KölnSolar · 17 Januar 2020, 23:31:12

Code Auswählen

http://192.xxx.x.xxx:8083/fhem

Gonzolo · 17 Januar 2020, 23:34:54

Zitat von: Wernieman am 17 Januar 2020, 20:59:15
Gucke erstmal ob FHEM Reste laufen:
Code Auswählen Erweitern
ps aux | grep [f]hem
Wenn keine Ausgabe gut, wenn doch ein Prozess erscheint bitte killen (oder hier schreiben)

Wenn Du tatsächlich

Code Auswählen

ps aux | grep [f]hem

und nicht

Code Auswählen

ps aux | grep fhem

meinst, kommt keine Ausgabe.

mit

Code Auswählen

ps aux | grep fhem

kommt

Code Auswählen

pi 1159 0.0 0.2 4276 2012 pts/0 S+ 23:25 0:00 grep --color=auto fhem

Habe Euch gewarnt

ich bin ein Anfänger ... Wie killt man einen Prozess. Ich denke den mit der PI 1159

Bei...

Code Auswählen

grep -i i/o /var/log/kern.log

Kommt keine ausgabe!

auch bei dem lesen Beispiel passiert nix!

Gonzolo · 17 Januar 2020, 23:37:03

Zitat von: KölnSolar am 17 Januar 2020, 23:31:12
Code Auswählen Erweitern
http://192.xxx.x.xxx:8083/fhem

... Meinte ich ja auch!

Gonzolo · 17 Januar 2020, 23:49:02

sollte ich mich schon mal damit anfreunden, den Resbery Pi neu aufzubauen?

Wenn ich doch die fhem.cfg sichere und dann alles neu installiere müsste doch alles wieder gut sein? Oder?? Vorher noch ein Update machen wie Beta-User vorgeschlagen hat?!

Danke für Euch Hilfe!

Geb langsam auf!