(gelöst) FHEM startet nach update nicht mehr

[krijeck]

Hallo

ich habe heute in meiner (relativ frischen) fhem installation ein check update und danach ein update und ein shutdown restart gemacht. Danach war fhem weg.
Fhem lässt sich nun nicht mehr mittels web interface aufrufen!

ich hab fhem auf meinem Homeserver laufen (Ubuntu 16.04.3 LTS (GNU/Linux 4.4.0-112-generic x86_64)), ZWave USB Stick, ein paar webcams mittels iFrame und Netatmo waren bis dato eingebunden.

jetzt wollte ich den Jeelink einbinden um meine Temperatur und Feuchtemesser wieder in Betrieb zu nehmen. dann wie geschrieben - jetzt geht nix mehr.

ich habe einen restore Ordner "gefunden" - kann man mittels diesem wieder zu einer lauffähigen Version wechseln? Wenn ja, wie? Welche Dateien muss ich verwenden? kann mir hier wer weiterhelfen?

danke schon mal ...

[marvin78]

Schau bitte erst einmal ins Log. Was steht dort in den letzten Zeilen?

[Wernieman]

Was steht denn in den "Logfiles"?

Siehe auch: https://forum.fhem.de/index.php/topic,54271.msg467373.html#msg467373
Gibt auch einen WIKI-Artikel zur Fehlersuche, wo analoge Angaben drin stehen.

[Otto123]

Hi,

was bedeutet frisch? hattest Du

Code Auswählen Erweitern

attr initialUsbCheck disable 1 gesetzt?
https://wiki.fhem.de/wiki/FHEM_startet_nicht_-_Tipps_zur_Fehlersuche

Hast Du ein backup?

In den Restore Ordner sind die Dateien drin, die beim update ausgetauscht wurden. Wenn es wirklich daran liegt (was ich ein bisschen bezweifle) kannst Du die zurückspielen.

Gruß  Otto

[krijeck]

Hallo,
danke für die raschen Antworten.

Frisch bedeutet, dass ich erst einige wenige Dinge installiert hatte und mich damit etwas "herumgespielt" habe. Wollte nach meinen ersten Versuchen auf dem RPI jetzt fhem am Homeserver installieren - was ja auch funktioniert hat.

zu

Code Auswählen Erweitern

attr initialUsbCheck disable 1
hab ich jetzt in meiner config nur das gefunden:

Code Auswählen Erweitern

# Disable this to avoid looking for new USB devices on startup
define initialUsbCheck notify global:INITIALIZED usb create

Backup hatt ich jetzt keins - leider noch nicht.

hier das LOG File (die letzten paar Zeilen des Files "fhem-2018-02.log"):

Code Auswählen Erweitern

2018.02.16 10:37:22 3: telnetPort: port 7072 opened
2018.02.16 10:37:22 3: WEB: port 8083 opened
2018.02.16 10:37:22 3: WEBphone: port 8084 opened
2018.02.16 10:37:22 3: WEBtablet: port 8085 opened
2018.02.16 10:37:22 2: eventTypes: loaded 358 events from ./log/eventTypes.txt
2018.02.16 10:37:22 3: Opening ZWDongle device /dev/ttyACM0
2018.02.16 10:37:22 3: Setting ZWDongle serial parameters to 115200,8,N,1
2018.02.16 10:37:23 3: ZWDongle device opened
2018.02.16 10:37:23 3: ZWave: cannot load Crypt::Rijndael, SECURITY class disabled
2018.02.16 10:37:23 3: HUEDevice7: I/O device is HUE_bridge
2018.02.16 10:37:23 3: HUEDevice3: I/O device is HUE_bridge
2018.02.16 10:37:23 3: HUEDevice6: I/O device is HUE_bridge
2018.02.16 10:37:23 3: HUEDevice1: I/O device is HUE_bridge
2018.02.16 10:37:23 3: HUEDevice5: I/O device is HUE_bridge
2018.02.16 10:37:23 3: HUEDevice2: I/O device is HUE_bridge
2018.02.16 10:37:23 3: HUEDevice4: I/O device is HUE_bridge
2018.02.16 10:37:23 3: HUEGroup0: I/O device is HUE_bridge
2018.02.16 10:37:23 3: HUEGroup4: I/O device is HUE_bridge
2018.02.16 10:37:23 3: HUEGroup2: I/O device is HUE_bridge
2018.02.16 10:37:23 3: HUEGroup3: I/O device is HUE_bridge
2018.02.16 10:37:23 3: HUEGroup5: I/O device is HUE_bridge
2018.02.16 10:37:23 3: Kueche: I/O device is HUE_bridge
2018.02.16 10:37:24 3: HUEGroup7: I/O device is HUE_bridge
2018.02.16 10:37:24 1: PERL WARNING: Subroutine YAAHM_restore redefined at ./FHEM/95_YAAHM.pm line 970, <$fh> line 1003.
2018.02.16 10:37:24 1: PERL WARNING: Subroutine YAAHM_setWeeklyTime redefined at ./FHEM/95_YAAHM.pm line 1688, <$fh> line 1003.
2018.02.16 10:37:24 1: [YAAHM_Define] data hash restored from save file with date Sun Feb 11 20:32:27 2018
2018.02.16 10:37:24 1: [YAAHM] does not find an Astro device, loading module Astro separately
2018.02.16 10:37:24 3: HUEGroup1: I/O device is HUE_bridge
2018.02.16 10:37:24 1: Including ./log/fhem.save
2018.02.16 10:37:24 3: LHhub: connected
2018.02.16 10:37:24 3: Wetter getDevices (devicelist)
2018.02.16 10:37:24 1: usb create starting
2018.02.16 10:37:24 3: Probing CUL device /dev/ttyS0
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS1
2018.02.16 10:37:25 1: PERL WARNING: can't getattr: Input/output error at ./FHEM/DevIo.pm line 394.
2018.02.16 10:37:25 3: Can't open /dev/ttyS1: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS10
2018.02.16 10:37:25 3: Can't open /dev/ttyS10: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS11
2018.02.16 10:37:25 3: Can't open /dev/ttyS11: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS12
2018.02.16 10:37:25 3: Can't open /dev/ttyS12: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS13
2018.02.16 10:37:25 3: Can't open /dev/ttyS13: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS14
2018.02.16 10:37:25 3: Can't open /dev/ttyS14: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS15
2018.02.16 10:37:25 3: Can't open /dev/ttyS15: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS16
2018.02.16 10:37:25 3: Can't open /dev/ttyS16: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS17
2018.02.16 10:37:25 3: Can't open /dev/ttyS17: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS18
2018.02.16 10:37:25 3: Can't open /dev/ttyS18: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS19
2018.02.16 10:37:25 3: Can't open /dev/ttyS19: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS2
2018.02.16 10:37:25 3: Can't open /dev/ttyS2: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS20
2018.02.16 10:37:25 3: Can't open /dev/ttyS20: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS21
2018.02.16 10:37:25 3: Can't open /dev/ttyS21: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS22
2018.02.16 10:37:25 3: Can't open /dev/ttyS22: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS23
2018.02.16 10:37:25 3: Can't open /dev/ttyS23: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS24
2018.02.16 10:37:25 3: Can't open /dev/ttyS24: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS25
2018.02.16 10:37:25 3: Can't open /dev/ttyS25: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS26
2018.02.16 10:37:25 3: Can't open /dev/ttyS26: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS27
2018.02.16 10:37:25 3: Can't open /dev/ttyS27: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS28
2018.02.16 10:37:25 3: Can't open /dev/ttyS28: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS29
2018.02.16 10:37:25 3: Can't open /dev/ttyS29: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS3
2018.02.16 10:37:25 3: Can't open /dev/ttyS3: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS30
2018.02.16 10:37:25 3: Can't open /dev/ttyS30: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS31
2018.02.16 10:37:25 3: Can't open /dev/ttyS31: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS4
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS5
2018.02.16 10:37:25 3: Can't open /dev/ttyS5: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS6
2018.02.16 10:37:25 3: Can't open /dev/ttyS6: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS7
2018.02.16 10:37:25 3: Can't open /dev/ttyS7: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS8
2018.02.16 10:37:25 3: Can't open /dev/ttyS8: Input/output error
2018.02.16 10:37:25 3: Probing CUL device /dev/ttyS9
2018.02.16 10:37:25 3: Can't open /dev/ttyS9: Input/output error
2018.02.16 10:37:25 3: Probing TCM_ESP3 device /dev/ttyUSB0
2018.02.16 10:37:25 3: Probing TCM_ESP2 device /dev/ttyUSB0
2018.02.16 10:37:25 3: Probing FHZ device /dev/ttyUSB0
2018.02.16 10:37:25 3: Probing TRX device /dev/ttyUSB0
2018.02.16 10:37:26 3: Probing ZWDongle device /dev/ttyUSB0
2018.02.16 10:37:26 3: Probing FRM device /dev/ttyUSB0
2018.02.16 10:40:28 1: Including fhem.cfg
2018.02.16 10:40:28 1: telnetPort: Can't open server port at 7072: Address already in use. Exiting.
2018.02.16 10:40:28 1: usb create end
2018.02.16 10:40:28 3: netatmo_D70_ee_50_1a_f8_c8: I/O device is Wetter
2018.02.16 10:40:28 3: Wetter getDevices (devicelist)
2018.02.16 10:40:29 3: Wetter getHomecoachs (homecoachlist)
2018.02.16 10:40:29 3: netatmo_M02_00_00_1b_2b_56: I/O device is Wetter
2018.02.16 10:40:29 0: Featurelevel: 5.8
2018.02.16 10:40:29 0: Server started with 43 defined entities (fhem.pl:16170/2018-02-13 perl:5.022001 os:linux user:fhem pid:1577)
2018.02.16 10:40:29 2: ZWDongle_ProcessSendStack: no ACK, resending message 0107000301020100f9
2018.02.16 10:40:29 3: [Tagesplanung V1.47] Weblink Tagesplanung_weblink created
2018.02.16 10:40:29 3: [Tagesplanung V1.47] Weblink Tagesplanung_shortlink created
2018.02.16 10:40:29 3: Wetter: poll (ACCOUNT)
2018.02.16 10:40:29 0: Server shutdown


fhem sollte laufen:

Code Auswählen Erweitern

sudo service fhem status
● fhem.service - LSB: FHEM server
   Loaded: loaded (/etc/init.d/fhem; bad; vendor preset: enabled)
   Active: active (exited) since Fri 2018-02-16 10:40:28 CET; 1h 2min ago
     Docs: man:systemd-sysv-generator(8)
  Process: 2556 ExecStop=/etc/init.d/fhem stop (code=exited, status=0/SUCCESS)
  Process: 2563 ExecStart=/etc/init.d/fhem start (code=exited, status=0/SUCCESS)
    Tasks: 0
   Memory: 0B
      CPU: 0

Feb 16 10:40:28 lenovo systemd[1]: Starting LSB: FHEM server...
Feb 16 10:40:28 lenovo fhem[2563]: Starting fhem...
Feb 16 10:40:28 lenovo systemd[1]: Started LSB: FHEM server.

Wenn ich aber wie im WIKI mache und Perl suche:

Code Auswählen Erweitern

ps ax | grep perl
2164 ?        S      0:01 /usr/bin/perl -wT /usr/bin/zmdc.pl startup
2169 ?        Ss     0:00 /usr/bin/perl /usr/share/webmin/miniserv.pl /etc/webmin/miniserv.conf
2219 ?        S      0:00 /usr/bin/perl -wT /usr/bin/zmfilter.pl
2225 ?        S      0:00 /usr/bin/perl -wT /usr/bin/zmaudit.pl -c
2230 ?        S      0:00 /usr/bin/perl -wT /usr/bin/zmwatch.pl
2238 ?        S      0:00 /usr/bin/perl -w /usr/bin/zmupdate.pl -c
2243 ?        S      0:00 /usr/bin/perl -w /usr/bin/zmtelemetry.pl
5174 pts/0    S+     0:00 grep --color=auto perl

sehe ich kein fhem. (zm ist der ZoneMinder - hatte ich schon vorher installiert und gab keine Probleme mit fhem gemeinsam)

[betateilchen]

zu

Code Auswählen Erweitern

attr initialUsbCheck disable 1
hab ich jetzt in meiner config nur das gefunden:

Code Auswählen Erweitern

# Disable this to avoid looking for new USB devices on startup
define initialUsbCheck notify global:INITIALIZED usb create

kommentiere die Zeile "define..." einfach einmal komplett aus, dann verschwinden auf jeden Fall die ganzen I/O Fehler bei /dev/tty...

Nach diesem Logeintrag:

2018.02.16 10:40:29 0: Server shutdown[/code]

läuft Dein FHEM nicht mehr. Das steht auch im Status:

sudo service fhem status
● fhem.service - LSB: FHEM server
   Loaded: loaded (/etc/init.d/fhem; bad; vendor preset: enabled)
   Active: active (exited) since Fri 2018-02-16 10:40:28 CET; 1h 2min ago
     Docs: man:systemd-sysv-generator(

Bei einem laufenden FHEM würde da "running" anstatt "exited" stehen.

Die Frage ist, woher das ausgeführte "shutdown" kommt.

[Wernieman]

Mich wundert auch das...

Code Auswählen Erweitern

2018.02.16 10:40:28 1: telnetPort: Can't open server port at 7072: Address already in use. Exiting.

Kannst Du uns bitte geben:

Code Auswählen Erweitern

netstat -lntp
(Auf der Console (Putty))

[krijeck]

hallo,

ok, ich hab zwischenzeitlich was versucht. ich habe ja eigentlich das update gemacht, weil ich den Jeelink USB wieder ansteckte. danach ging das fhem web nicht mehr. Ich hab den USB Stick jetzt rausgegeben und reboot und fhem ging wieder.
So jetzt Stick wieder rein und "shutdown restart" in fehm - nix geht mehr!

netstat -lntp gibt (scheinbar sowohl vor als auch nach "shutdown restart" in fehm, also einmal wenn fhem läuft und einmal wenn nicht):

Code Auswählen Erweitern

(Not all processes could be identified, non-owned process info
will not be shown, you would have to be root to see it all.)
Active Internet connections (only servers)
Proto Recv-Q Send-Q Local Address           Foreign Address         State       PID/Program name
tcp        0      0 0.0.0.0:22              0.0.0.0:*               LISTEN      -               
tcp        0      0 0.0.0.0:9981            0.0.0.0:*               LISTEN      -               
tcp        0      0 0.0.0.0:445             0.0.0.0:*               LISTEN      -               
tcp        0      0 0.0.0.0:9982            0.0.0.0:*               LISTEN      -               
tcp        0      0 0.0.0.0:7072            0.0.0.0:*               LISTEN      -               
tcp        0      0 0.0.0.0:8000            0.0.0.0:*               LISTEN      -               
tcp        0      0 127.0.0.1:3306          0.0.0.0:*               LISTEN      -               
tcp        0      0 0.0.0.0:139             0.0.0.0:*               LISTEN      -               
tcp        0      0 0.0.0.0:10000           0.0.0.0:*               LISTEN      -               
tcp        0      0 0.0.0.0:8083            0.0.0.0:*               LISTEN      -               
tcp        0      0 0.0.0.0:8084            0.0.0.0:*               LISTEN      -               
tcp        0      0 0.0.0.0:8085            0.0.0.0:*               LISTEN      -               
tcp6       0      0 :::22                   :::*                    LISTEN      -               
tcp6       0      0 :::445                  :::*                    LISTEN      -               
tcp6       0      0 127.0.0.1:8005          :::*                    LISTEN      -               
tcp6       0      0 :::139                  :::*                    LISTEN      -               
tcp6       0      0 :::10000                :::*                    LISTEN      -               
tcp6       0      0 :::8080                 :::*                    LISTEN      -               
tcp6       0      0 :::80                   :::*                    LISTEN      -   

das mit exited ist mir peinlich - ich hab nur auf "Started LSB: FHEM server." geschaut ...

So scheinbar hat es was mit dem Jeelink USB zu tun. nach dem ersten einstecken hatte ich ein

Code Auswählen Erweitern

sudo mknod /dev/ttyUSB0 c 188 0 gemacht - kann das mit dem zwave USB Probleme machen?
Ich hatte das selbe Setup (also Jeelink und zwave) am RPI problemlos ...

lsusb gibt mir:

Code Auswählen Erweitern

Bus 002 Device 002: ID 8087:0024 Intel Corp. Integrated Rate Matching Hub
Bus 002 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
Bus 001 Device 002: ID 8087:0024 Intel Corp. Integrated Rate Matching Hub
Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
Bus 004 Device 001: ID 1d6b:0003 Linux Foundation 3.0 root hub
Bus 003 Device 003: ID 0403:6001 Future Technology Devices International, Ltd FT232 USB-Serial (UART) IC
Bus 003 Device 002: ID 0658:0200 Sigma Designs, Inc.
Bus 003 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub

[CoolTux]

Hi,

was bedeutet frisch? hattest Du

Code Auswählen Erweitern

attr initialUsbCheck disable 1 gesetzt?
https://wiki.fhem.de/wiki/FHEM_startet_nicht_-_Tipps_zur_Fehlersuche

Hast Du ein backup?

In den Restore Ordner sind die Dateien drin, die beim update ausgetauscht wurden. Wenn es wirklich daran liegt (was ich ein bisschen bezweifle) kannst Du die zurückspielen.

Gruß  Otto

[Otto123]

Dann nimm den Stick raus, starte FHEM neu, wirf diese Zeile in die Eingabezeile von FHEM

Code Auswählen Erweitern

attr initialUsbCheck disable 1
Drücke save und starte FHEM neu.
Jetzt kannst Du Deinen Stick einstecken.

Auf die Art musst du nicht die cfg zerfummeln.

Gruß Otto

[CoolTux]

Daher mein Zitat von Dir

[Otto123]

Daher mein Zitat von Dir

Ja ich weiß. Ich wollte es zur Sicherheit nochmal ausformulieren   

[krijeck]

 
danke. ich wusste nicht, dass mit initialUsbCheck disable dieser (neue) USB Adapter dann erkannt wird.
ich habe das jetzt ausgeführt und den Stick ab und an gesteckt ... jetzt funktioniert fhem wieder und der Stick wurde auch erkannt.

Was wenn (vielleicht passiert das ja auch noch) einen weiteren USB Stick ins fhem System integrieren will. brauche ich dann das initialUsbCheck oder nicht - brauche ich das überhaupt?

danke auf jeden Fall für eure Hilfe ...
lg

[Otto123]

initialUsbCheck ist eine Routine die versucht alles mögliche am USB zu erkennen, in FHEM zu definieren und zu pampern.

Ich will darüber nicht weiter meckern, aber ich mache unmittelbar nach dem Setup auf Systemebene

Code Auswählen Erweitern

echo 'attr initialUsbCheck disable 1' >> /opt/fhem/fhem.cfg

Ob und wozu man das normalerweise brauchen kann, weiß ich nicht. Ich denke mit einem ordentlichen define und allen Installationsvoraussetzungen bekommt man jeden Stick zum laufen der in Ordnung ist.

Gruß Otto

[betateilchen]

Ob und wozu man das normalerweise brauchen kann, weiß ich nicht.

Ich auch nicht. Deshalb hatte ich ja oben empfohlen, den Quatsch komplett aus der fhem.cfg auszukommentieren. Denn erst zu definieren, um es dann per disable abzuschalten, ist ja noch größerer Quatsch als das device selbst.