Seite 2 von 2
Re: Mal wieder : eBus
Verfasst: 29. Jun 2021 19:48
von udo1toni
Na ja, mehr als "Connection reset" steht ja nicht da, das ist eindeutig genug, hilft aber nicht.
Re: Mal wieder : eBus
Verfasst: 30. Jun 2021 18:56
von guinnes
So, es ist heute wieder passiert, der eBus ist ausgefallen, die Rule ist gelaufen, der eBus ist nicht wierder angelaufen, es gibt keine Meldungen, die einen Grund dafür liefern. Hier das Log :
Code: Alles auswählen
2021-06-30 17:10:08.023 [ERROR] [dev.ebus.core.EBusLowLevelController] - An IO exception has occured! Try to reconnect eBUS connector ...
java.net.SocketException: Connection reset
at java.net.SocketInputStream.read(SocketInputStream.java:210) ~[?:1.8.0_252]
at java.net.SocketInputStream.read(SocketInputStream.java:141) ~[?:1.8.0_252]
at java.net.SocketInputStream.read(SocketInputStream.java:127) ~[?:1.8.0_252]
at de.csdev.ebus.core.connection.AbstractEBusConnection.readBytes(AbstractEBusConnection.java:56) ~[bundleFile:?]
at de.csdev.ebus.core.EBusLowLevelController.run(EBusLowLevelController.java:200) [bundleFile:?]
2021-06-30 17:10:08.068 [WARN ] [dev.ebus.core.EBusLowLevelController] - Retry to connect to eBUS adapter in 5 seconds ...
2021-06-30 17:12:45.561 [INFO ] [.eclipse.smarthome.model.script.eBus] - eBus Abgelaufen
2021-06-30 17:12:46.184 [INFO ] [ng.ebus.internal.handler.EBusHandler] - Remove polling job for FF 15 B5 09 03 0D 27 00 1A
2021-06-30 17:12:46.186 [INFO ] [ng.ebus.internal.handler.EBusHandler] - Remove polling job for FF 15 B5 09 03 0D 42 00 EC
2021-06-30 17:12:46.187 [INFO ] [ng.ebus.internal.handler.EBusHandler] - Remove polling job for FF 15 B5 09 03 0D 00 00 89
2021-06-30 17:12:46.189 [INFO ] [ng.ebus.internal.handler.EBusHandler] - Remove polling job for FF 15 B5 09 03 0D 31 00 44
2021-06-30 17:12:46.190 [INFO ] [ng.ebus.internal.handler.EBusHandler] - Remove polling job for FF 15 B5 09 03 0D 30 00 DF
2021-06-30 17:12:46.192 [INFO ] [ng.ebus.internal.handler.EBusHandler] - Remove polling job for FF 15 B5 09 03 0D 01 00 12
2021-06-30 17:12:46.193 [INFO ] [ng.ebus.internal.handler.EBusHandler] - Remove polling job for FF 15 B5 09 03 0D 5D 00 30
2021-06-30 17:12:46.195 [INFO ] [ng.ebus.internal.handler.EBusHandler] - Remove polling job for FF 15 B5 09 03 0D 44 00 80
2021-06-30 17:12:46.196 [INFO ] [ng.ebus.internal.handler.EBusHandler] - Remove polling job for FF 15 B5 09 03 0D 2F 00 03
2021-06-30 17:12:46.282 [INFO ] [.eclipse.smarthome.model.script.eBus] - eBus Stop
2021-06-30 17:13:12.370 [INFO ] [internal.things.EBusTypeProviderImpl] - Load custom 'bundleUrl' configuration bundle 'file:///etc/openhab2/ebus/configuration-bundle.json' ...
2021-06-30 17:13:12.490 [WARN ] [internal.things.EBusTypeProviderImpl] - eBUS command boiler.control.setopdata only contains a setter channel!
2021-06-30 17:13:12.578 [WARN ] [internal.things.EBusTypeProviderImpl] - eBUS command boiler.control.setopdata only contains a setter channel!
2021-06-30 17:13:12.606 [INFO ] [ing.ebus.internal.EBusHandlerFactory] - Use eBUS binding 2.50.11 [eBUS core: 1.1.5, eBUS configuration: 1.1.4]
2021-06-30 17:13:12.610 [INFO ] [ing.ebus.internal.EBusHandlerFactory] - eBUS core -> timestamp 202101311144, commit: #79c19b7, build-no: #null
2021-06-30 17:13:12.614 [INFO ] [ing.ebus.internal.EBusHandlerFactory] - eBUS configuration -> timestamp 202012271447, commit: #101042c, build-no: #null
2021-06-30 17:13:12.669 [WARN ] [s.internal.handler.EBusBridgeHandler] - Enable advanced logging for eBUS commands!
2021-06-30 17:13:12.709 [INFO ] [ng.ebus.internal.handler.EBusHandler] - Register polling for "dhw.program_dhw_circuit" every 60 sec. (initial delay 6 sec.)
2021-06-30 17:13:12.713 [INFO ] [ng.ebus.internal.handler.EBusHandler] - Register polling for "heating.temp_hcurve" every 60 sec. (initial delay 4 sec.)
2021-06-30 17:13:12.714 [INFO ] [ng.ebus.internal.handler.EBusHandler] - Register polling for "heating.program_heating_circuit_special" every 60 sec. (initial delay 1 sec.)
2021-06-30 17:13:12.710 [INFO ] [ng.ebus.internal.handler.EBusHandler] - Register polling for "controller.temp_room" every 60 sec. (initial delay 2 sec.)
2021-06-30 17:13:12.711 [INFO ] [ng.ebus.internal.handler.EBusHandler] - Register polling for "heating.temp_d_day" every 60 sec. (initial delay 13 sec.)
2021-06-30 17:13:12.711 [INFO ] [ng.ebus.internal.handler.EBusHandler] - Register polling for "controller.temp_room" every 60 sec. (initial delay 16 sec.)
2021-06-30 17:13:12.714 [INFO ] [ng.ebus.internal.handler.EBusHandler] - Register polling for "dhw.temp_d_dhw" every 60 sec. (initial delay 10 sec.)
2021-06-30 17:13:12.717 [INFO ] [ng.ebus.internal.handler.EBusHandler] - Register polling for "heating.status_global_system_off" every 60 sec. (initial delay 1 sec.)
2021-06-30 17:13:12.717 [INFO ] [ng.ebus.internal.handler.EBusHandler] - Register polling for "heating.temp_d_night" every 60 sec. (initial delay 26 sec.)
2021-06-30 17:13:12.717 [INFO ] [ng.ebus.internal.handler.EBusHandler] - Register polling for "heating.program_heating_circuit" every 60 sec. (initial delay 5 sec.)
2021-06-30 17:13:12.736 [INFO ] [ng.ebus.internal.handler.EBusHandler] - (Re)Initialize all eBUS pollings for ebus:abgestaubt:guinnes:08 ...
2021-06-30 17:13:12.752 [INFO ] [ng.ebus.internal.handler.EBusHandler] - (Re)Initialize all eBUS pollings for ebus:broadcastguinnes:guinnes:FE ...
2021-06-30 17:13:12.857 [INFO ] [.eclipse.smarthome.model.script.eBus] - eBus Restart
Wieder einmal bin ich mit Putty nicht mehr reingekommen, nachdem der Fehler aufgetreten ist. Hat jemand dazu vielleicht eine Idee ?
Leider kann ich dem Stack-Trace nur innerhalb des Bindings folgen, java.net.socketinputstream wüsste ich nicht, wo das zu finden ist, jemand dazu eine Idee ?
Auch das "Retry to connect to eBUS adapter in 5 seconds ..." hat nicht stattgefunden
Re: Mal wieder : eBus
Verfasst: 30. Jun 2021 19:24
von udo1toni
Und die Weboberfläche funktioniert noch?
Re: Mal wieder : eBus
Verfasst: 30. Jun 2021 20:33
von guinnes
udo1toni hat geschrieben: 30. Jun 2021 19:24
Und die Weboberfläche funktioniert noch?
Alles an Openhab funktioniert anscheinend, auch das BasicUI und der Logviewer im Browser. Gibts da ne Möglichkeit, sich einzuloggen ?
Re: Mal wieder : eBus
Verfasst: 1. Jul 2021 08:30
von udo1toni
Der Punkt ist, ich hätte erwartet, dass, wenn schon Crash von Netz (in dem Fall sshd), dann alles Crash.
Re: Mal wieder : eBus
Verfasst: 1. Jul 2021 10:39
von guinnes
udo1toni hat geschrieben: 1. Jul 2021 08:30
Der Punkt ist, ich hätte erwartet, dass, wenn schon Crash von Netz (in dem Fall sshd), dann alles Crash.
Das ist jas nicht immer gleich, heute Morgen z.B. ging Putty noch und mit einem einfachen Sudo reboot konnte das System wieder gestartet werden.
Gestern war viel mehr Aufwand nötig :
Ausschalten, einschalten : Danach lief das Systeminfo-Binding nicht an, also
sudo poweroff Ausschalten, einschalten : Systeminfo-Binding lief immer noch nicht an, also
sudo reboot : danach war alles wieder ok, bis heute Morgen um 03:10
Re: Mal wieder : eBus
Verfasst: 1. Jul 2021 13:04
von udo1toni
Also, das spricht doch eher für ein grundsätzliches Problem (könntest Du allenfalls ausschließen, indem Du nur dieses eine Binding deaktivierst...)
Re: Mal wieder : eBus
Verfasst: 1. Jul 2021 16:43
von guinnes
udo1toni hat geschrieben: 1. Jul 2021 13:04
Also, das spricht doch eher für ein grundsätzliches Problem (könntest Du allenfalls ausschließen, indem Du nur dieses eine Binding deaktivierst...)
Wäre natürlich die beste Zeit ( Sommer ) dafür. Aber da alle anderen Bindings tuen, kann ich dann ja auch nichts feststellen. Ich werde erst mal versuchen, die anderen Quelltextstücke zu finden, die im Stack-Trace angegeben sind. Vielleicht werde ich ja da fündig.
Do weisst nicht zufälligerweise, wo auf dem Raspberry ich Java finde ?
Re: Mal wieder : eBus
Verfasst: 1. Jul 2021 20:43
von guinnes
Dieses Mal hat das Reconnect getan :
Code: Alles auswählen
2021-07-01 19:37:38.858 [ERROR] [dev.ebus.core.EBusLowLevelController] - An IO exception has occured! Try to reconnect eBUS connector ...
java.net.SocketException: Connection reset
at java.net.SocketInputStream.read(SocketInputStream.java:210) ~[?:1.8.0_252]
at java.net.SocketInputStream.read(SocketInputStream.java:141) ~[?:1.8.0_252]
at java.net.SocketInputStream.read(SocketInputStream.java:127) ~[?:1.8.0_252]
at de.csdev.ebus.core.connection.AbstractEBusConnection.readBytes(AbstractEBusConnection.java:56) ~[bundleFile:?]
at de.csdev.ebus.core.EBusLowLevelController.run(EBusLowLevelController.java:200) [bundleFile:?]
2021-07-01 19:37:38.867 [WARN ] [dev.ebus.core.EBusLowLevelController] - Retry to connect to eBUS adapter in 5 seconds ...
2021-07-01 19:37:46.972 [WARN ] [us.core.connection.EBusTCPConnection] - Keine Route zum Zielrechner (Host unreachable)
java.net.NoRouteToHostException: Keine Route zum Zielrechner (Host unreachable)
at java.net.PlainSocketImpl.socketConnect(Native Method) ~[?:1.8.0_252]
at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:350) ~[?:1.8.0_252]
at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206) ~[?:1.8.0_252]
at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188) ~[?:1.8.0_252]
at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392) ~[?:1.8.0_252]
at java.net.Socket.connect(Socket.java:607) ~[?:1.8.0_252]
at java.net.Socket.connect(Socket.java:556) ~[?:1.8.0_252]
at java.net.Socket.<init>(Socket.java:452) ~[?:1.8.0_252]
at java.net.Socket.<init>(Socket.java:229) ~[?:1.8.0_252]
at de.csdev.ebus.core.connection.EBusTCPConnection.open(EBusTCPConnection.java:55) [bundleFile:?]
at de.csdev.ebus.core.EBusLowLevelController.reconnect(EBusLowLevelController.java:135) [bundleFile:?]
at de.csdev.ebus.core.EBusLowLevelController.run(EBusLowLevelController.java:226) [bundleFile:?]
2021-07-01 19:37:46.977 [WARN ] [dev.ebus.core.EBusLowLevelController] - Retry to connect to eBUS adapter in 10 seconds ...
2021-07-01 19:37:56.980 [WARN ] [us.core.connection.EBusTCPConnection] - Das Netzwerk ist nicht erreichbar (connect failed)
java.net.SocketException: Das Netzwerk ist nicht erreichbar (connect failed)
at java.net.PlainSocketImpl.socketConnect(Native Method) ~[?:1.8.0_252]
at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:350) ~[?:1.8.0_252]
at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206) ~[?:1.8.0_252]
at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188) ~[?:1.8.0_252]
at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392) ~[?:1.8.0_252]
at java.net.Socket.connect(Socket.java:607) ~[?:1.8.0_252]
at java.net.Socket.connect(Socket.java:556) ~[?:1.8.0_252]
at java.net.Socket.<init>(Socket.java:452) ~[?:1.8.0_252]
at java.net.Socket.<init>(Socket.java:229) ~[?:1.8.0_252]
at de.csdev.ebus.core.connection.EBusTCPConnection.open(EBusTCPConnection.java:55) [bundleFile:?]
at de.csdev.ebus.core.EBusLowLevelController.reconnect(EBusLowLevelController.java:135) [bundleFile:?]
at de.csdev.ebus.core.EBusLowLevelController.run(EBusLowLevelController.java:192) [bundleFile:?]
2021-07-01 19:37:56.984 [WARN ] [dev.ebus.core.EBusLowLevelController] - Retry to connect to eBUS adapter in 15 seconds ...
Ich werde es wohl mal mit dem eBusD versuchen um die Low Level-Zugriffe zu vermeiden