Homegear Shutdown alle 10 Minuten

Hallo zusammen,
folgendes Problem: homegear startet alle 10 Minuten (immer um x:00, x:10, x:20, x:40, x:50) neu.
Keine Ahnung warum, aber der Ärger auf weiblicher Seite ist groß, da Rollos nicht schließen etc.

Config: homegear 0.8.0-2373 mit openhab 2.3.0 auf dem gleichen RasPi. Betriebssystem ist ein homegear image für den Raspi (damals noch 0.6.0), openHAB 2.3.0 gemäß der manuellen Upgrade Anleitung nachinstalliert. Homegear steuert zwei Homematic LAN Config (EG und DG).

openHAB2 events.log
2018-11-15 06:33:00.046 [vent.ChannelTriggeredEvent] - astro:sun:home_delayed:astroDawn#event triggered END
2018-11-15 06:37:45.546 [vent.ItemStateChangedEvent] - WettersensorGartenTemp changed from 4.40 to 4.30
2018-11-15 06:40:11.100 [hingStatusInfoChangedEvent] - ‘homematic:bridge:c76327ef’ changed from ONLINE to OFFLINE (COMMUNICATION_ERROR): Connection lost
2018-11-15 06:40:11.137 [hingStatusInfoChangedEvent] - ‘homematic:HG-HM-LC-Bl1PBU-FM:c76327ef:JEQ0105809’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-11-15 06:40:11.146 [hingStatusInfoChangedEvent] - ‘homematic:HG-HM-LC-Bl1PBU-FM:c76327ef:JEQ0105802’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-11-15 06:40:11.155 [hingStatusInfoChangedEvent] - ‘homematic:HG-HM-Sen-RD-O:c76327ef:KEQ0883987’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-11-15 06:40:11.160 [hingStatusInfoChangedEvent] - ‘homematic:HG-HM-Sec-MDIR:c76327ef:JEQ0265295’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-11-15 06:40:11.181 [hingStatusInfoChangedEvent] - ‘homematic:HG-HM-Sec-MDIR:c76327ef:JEQ0265722’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-11-15 06:40:11.198 [hingStatusInfoChangedEvent] - ‘homematic:HG-HM-Sec-MDIR:c76327ef:JEQ0263304’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-11-15 06:40:11.223 [hingStatusInfoChangedEvent] - ‘homematic:GATEWAY-EXTRAS-C76327EF:c76327ef:GWE00000000’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-11-15 06:40:11.231 [hingStatusInfoChangedEvent] - ‘homematic:HG-HM-LC-Bl1PBU-FM:c76327ef:JEQ0105760’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)

openhab.log
2018-11-15 06:40:11.050 [WARN ] [ommunicator.AbstractHomematicGateway] - Connection lost on gateway ‘c76327ef’
2018-11-15 06:40:16.038 [WARN ] [eclipse.jetty.servlet.ServletHandler] -
javax.servlet.ServletException: java.lang.UnsupportedOperationException: Asynchronous processing not supported on Servlet 2.x container.
at org.glassfish.jersey.servlet.WebComponent.serviceImpl(WebComponent.java:489) [167:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2]
at org.glassfish.jersey.servlet.WebComponent.service(WebComponent.java:427) [167:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2]
at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:388) [167:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2]

homegear.log
11/15/18 06:39:57.489 HomeMatic BidCoS packet received (HM-CFG-LAN-DG, RSSI: -64 dBm): 0CC286701B3E1F00000080E02D
11/15/18 06:40:00.543 HomeMatic BidCoS packet received (HM-CFG-LAN-EG, RSSI: -72 dBm): 0CB286701ED360000000010064
11/15/18 06:40:00.545 Module HomeMatic BidCoS: Info: TEMPERATURE on channel 1 of HomeMatic BidCoS peer 67 with serial number JEQ0685798 was set to 0x0100.
11/15/18 06:40:00.545 HomeMatic BidCoS packet received (HM-CFG-LAN-DG, RSSI: -83 dBm): 0CB286701ED360000000010064
11/15/18 06:40:01.896 (Shutdown) => Stopping Homegear (Signal: 15)
11/15/18 06:40:01.896 Node-BLUE Server: Info: Stopping nodes.
11/15/18 06:40:01.896 Script Engine Server: Info: Stopping devices.
11/15/18 06:40:01.897 Info: Shutting down family modules…
11/15/18 06:40:01.897 Info: Shutting down family module “HomeMatic BidCoS”…
11/15/18 06:40:01.903 Info: Shutting down family module “Miscellaneous”…
11/15/18 06:40:01.903 Stopping UPnP server…
11/15/18 06:40:01.923 (Shutdown) => Stopping Event handler
11/15/18 06:40:01.924 (Shutdown) => Stopping RPC servers
11/15/18 06:40:01.929 RPC Server (Port 2001): Info: Waiting for threads to finish.
11/15/18 06:40:02.003 RPC Server (Port 2002): Info: Waiting for threads to finish.
11/15/18 06:40:02.014 (Shutdown) => Stopping RPC client
11/15/18 06:40:02.015 (Shutdown) => Closing physical interfaces
11/15/18 06:40:03.566 HomeMatic BidCoS packet received (HM-CFG-LAN-EG, RSSI: -59 dBm): 0CBC86701B3E4600000000DC30
11/15/18 06:40:03.567 Module HomeMatic BidCoS: Info: HUMIDITY on channel 1 of HomeMatic BidCoS peer 18 with serial number JEQ0121690 was set to 0x30.
11/15/18 06:40:03.567 Module HomeMatic BidCoS: Info: TEMPERATURE on channel 1 of HomeMatic BidCoS peer 18 with serial number JEQ0121690 was set to 0x00DC.
11/15/18 06:40:03.568 HomeMatic BidCoS packet received (HM-CFG-LAN-DG, RSSI: -70 dBm): 0CBC86701B3E4600000000DC30
11/15/18 06:40:06.268 HomeMatic BidCoS packet received (HM-CFG-LAN-EG, RSSI: -74 dBm): 0C6786701B3F5200000000E22F
11/15/18 06:40:06.269 (Shutdown) => Stopping IPC server…
11/15/18 06:40:06.322 (Shutdown) => Stopping Node-BLUE server…
11/15/18 06:40:06.420 (Shutdown) => Stopping script engine server…
11/15/18 06:40:06.460 (Shutdown) => Saving device families
11/15/18 06:40:06.460 (Shutdown) => Saving devices
11/15/18 06:40:06.460 (Shutdown) => Saving HomeMatic BidCoS central…
11/15/18 06:40:06.460 Module HomeMatic BidCoS: (Shutdown) => Saving HomeMatic BidCoS peer 1 with address 0x2C9FF3
11/15/18 06:40:06.460 Module HomeMatic BidCoS: (Shutdown) => Saving HomeMatic BidCoS peer 2 with address 0x1B434B
11/15/18 06:40:06.461 Module HomeMatic BidCoS: (Shutdown) => Saving HomeMatic BidCoS peer 4 with address 0x1C56DD

openHAB events.log
2018-11-15 06:11:10.508 [hingStatusInfoChangedEvent] - ‘homematic:HG-HM-LC-Bl1PBU-FM:c76327ef:JEQ0105937’ changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE
2018-11-15 06:11:10.520 [hingStatusInfoChangedEvent] - ‘homematic:HG-HM-LC-Bl1PBU-FM:c76327ef:JEQ0105840’ changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE
2018-11-15 06:12:18.152 [vent.ItemStateChangedEvent] - WettersensorGartenHumid changed from 92 to 93
2018-11-15 06:19:47.936 [vent.ItemStateChangedEvent] - WettersensorGartenHumid changed from 93 to 92
2018-11-15 06:20:10.410 [hingStatusInfoChangedEvent] - ‘homematic:bridge:c76327ef’ changed from ONLINE to OFFLINE (COMMUNICATION_ERROR): Connection lost
2018-11-15 06:20:10.437 [hingStatusInfoChangedEvent] - ‘homematic:HG-HM-Sec-MDIR:c76327ef:JEQ0265295’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-11-15 06:20:10.455 [hingStatusInfoChangedEvent] - ‘homematic:HG-HM-LC-Bl1PBU-FM:c76327ef:JEQ0105809’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-11-15 06:20:10.465 [hingStatusInfoChangedEvent] - ‘homematic:HG-HM-LC-Bl1PBU-FM:c76327ef:JEQ0105802’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-11-15 06:20:10.471 [hingStatusInfoChangedEvent] - ‘homematic:HG-HM-Sen-RD-O:c76327ef:KEQ0883987’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-11-15 06:20:10.478 [hingStatusInfoChangedEvent] - ‘homematic:HG-HM-Sec-MDIR:c76327ef:JEQ0263304’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-11-15 06:20:10.487 [hingStatusInfoChangedEvent] - ‘homematic:HG-HM-Sec-MDIR:c76327ef:JEQ0265722’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-11-15 06:20:10.494 [hingStatusInfoChangedEvent] - ‘homematic:GATEWAY-EXTRAS-C76327EF:c76327ef:GWE00000000’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-11-15 06:20:10.501 [hingStatusInfoChangedEvent] - ‘homematic:HG-HM-LC-Sw4-DR:c76327ef:JEQ0490729’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-11-15 06:20:10.510 [hingStatusInfoChangedEvent] - ‘homematic:HG-HM-CC-TC:c76327ef:JEQ0121626’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-11-15 06:20:10.519 [hingStatusInfoChangedEvent] - ‘homematic:HG-HM-LC-Bl1PBU-FM:c76327ef:JEQ0105795’ changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)

Noch läuft auf dem neuen System nicht so viel (da sich die openHAB Scripte ja leider nicht übernehmen ließen und neu geschrieben werden müssen). Daher fällt halt auf, dass in openHAB events.log minutenlang nichts passieren muss (von 6:12 bis 6:20) und um 6:20 geht auf einmal die bridge offline.

Woran kann das liegen?
Die Config Parameter der Bridge sind:

Die weitere config noch (weil nur ein Bild gepostet werden darf)

Hallo @wbuh2018,

auf was für einem System läuft das Ganze? Homegear bekommt irgendwoher ein Signal 15 und wird dann ordnungsgemäß heruntergefahren. Was ist bei dir in cron eingetragen (/etc/cron.d/*, crontab -e, crontab -u homegear -e)? Startet es nach dem Herunterfahren selbstständig wieder?

Viele Grüße

Sathya

Hallo sathya,
es ist das homegear image für raspi (Linux 3.18.6-v7+ armv71 GNU/Linux).
Unter /etc/cron.d/* liegt nur eine php5

Aber das hier sieht nach 10 Minuten Takt aus

grafik

Und darin steht
grafik

Das endet mit homegear restart
Ist das der Auslöser?

homegear -e bringt folgenden output. (Oder ich nutze das Kommando falsch)
grafik

Zu Deiner letzten Frage: ja, homegear startet automatisch neu, bis dann wieder x:10 x:20 x:30 x:40 x:50 ist.

Ja.
Du scheinst nur diesen cronjob zu haben.
contab -r löst dein Problem. -> Achtung löscht alle Cronjobs!

Das ist ein altes Skript zur Überwachung des Homegear Dienstes.
Das scheint nicht mehr mit der neuen Version kompatibel zu sein.

1 Like

Ok, hab ich gemacht:

Jetzt: Spannung! Bin auf 23:10 gespannt…

Bis heute morgen (7:17) keine Neustarts mehr :slightly_smiling_face:
Jetzt bin ich mal auf heute Abend gespannt, ob die Rollos schließen (der Auslöser für die Fehlersuche. Das lief nicht zuverlässig, weil mitten im Programm die shutdown Meldung kam - jedenfalls gehe ich von diesem Zusammenhang aus)

1 Like