[BUG] HMIP-SWDO funktionieren nach eine Weile nicht mehr

Einrichtung, Nutzung und Hilfe zu RaspberryMatic (OCCU auf Raspberry Pi)

Moderatoren: jmaus, Co-Administratoren

Antworten
Dalamar
Beiträge: 19
Registriert: 01.06.2016, 13:08

[BUG] HMIP-SWDO funktionieren nach eine Weile nicht mehr

Beitrag von Dalamar » 04.11.2018, 20:59

Hallo Gemeinde,

wir haben aktuell folgendes Problem. Wir haben in unserem Haus drei Etagen - auf zwei Etagen sind HMIP-SWDO-Aktoren und auf einer Etage HM-Sec-SCo-Aktoren installiert. Im Einsatz ist ein Tinkerboard mit der aktuellen Firmware 3.37.8.20181026 und dem neuen Funkmodul. Im Keller haben wir noch einen Gateway laufen, das mit dem Tinkerboard verbunden ist. Soweit so schlecht. Nach dem Neustart der "CCU" funktioniert unser Alarmsystem und die 3 installierten Homematic Easy Display 7 einwandfrei, doch irgendwann, ca. nach einem Tag, funktionieren alle IP-Aktoren nicht mehr. Löst man Sie aus, dann blinken sie eine Weile gelb um dann ein rotes Signal anzuzeigen. Dieses Problem tritt jetzt ständig auf und ich meine seit wir die Firmware 3.37 nutzen.

Anbei ein Ausschnitt aus der Logdatei.

Code: Alles auswählen

Nov 4 10:06:07 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-5] SYSTEM: 0 Accesspoints in Queue 
Nov 4 10:06:06 de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega INFO  [vert.x-eventloop-thread-5] (un)registerCallback on VirtualDeviceHandlerRega called from url: http://127.0.0.1:2016/ 
Nov 4 10:06:02 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-0] init finished 
Nov 4 10:06:07 de.eq3.cbcs.legacy.bidcos.rpc.internal.InterfaceInitializer INFO  [vert.x-worker-thread-4] Added InterfaceId: EASY_APP__HomeMaticIp 
Nov 4 10:06:07 de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega INFO  [vert.x-eventloop-thread-5] Added InterfaceId: EASY_APP__HomeMaticInternalDevices 
Nov 4 10:06:07 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-5] SYSTEM: Permanent-/Burstlistener Handler utilization: 0/50 used 
Nov 4 10:06:07 de.eq3.cbcs.server.core.otau.DeviceBackgroundUpdateSubsystem INFO  [vert.x-eventloop-thread-5] SYSTEM: Eventlistener Handler utilization: 0/50 used 
Nov 4 10:06:07 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-0] (un)registerCallback on LegacyServiceHandler called from url: http://127.0.0.1:2016/ 
Nov 4 10:06:07 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-0] init finished 
Nov 4 10:06:07 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-0] (un)registerCallback on LegacyServiceHandler called from url: http://127.0.0.1:2016/ 
Nov 4 10:06:08 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-0] init finished 
Nov 4 10:06:12 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-0] (un)registerCallback on LegacyServiceHandler called from url: http://127.0.0.1:2016/ 
Nov 4 10:06:12 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-0] init finished 
Nov 4 10:06:13 de.eq3.ccu.virtualdevice.service.internal.rega.BackendWorker INFO  [vert.x-worker-thread-5] Execute BackendCommand: de.eq3.ccu.virtualdevice.service.internal.rega.BackendUpdateDevicesCommand 
Nov 4 10:06:13 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-0] (un)registerCallback on LegacyServiceHandler called from url: http://127.0.0.1:2016/ 
Nov 4 10:06:13 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-0] init finished 
Nov 4 10:06:14 de.eq3.cbcs.legacy.bidcos.rpc.internal.InterfaceInitializer ERROR [vert.x-worker-thread-4] IO Exception: Could not add interface: EASY_APP__HomeMaticIp 
de.eq3.cbcs.legacy.communication.rpc.RpcIOException: java.net.ConnectException: Connection refused (Connection refused)
	at de.eq3.cbcs.legacy.communication.rpc.internal.transport.http.HttpTransport.sendRequest(HttpTransport.java:90)
	at de.eq3.cbcs.legacy.communication.rpc.internal.rpc.RpcClient.sendRequest(RpcClient.java:99)
	at de.eq3.cbcs.legacy.communication.rpc.internal.rpc.RpcClient.invoke(RpcClient.java:87)
	at com.sun.proxy.$Proxy12.listDevices(Unknown Source)
	at de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyBackendClient.listDevices(LegacyBackendClient.java:140)
	at de.eq3.cbcs.legacy.bidcos.rpc.internal.DeviceUtil.synchronizedBackendDevices(DeviceUtil.java:116)
	at de.eq3.cbcs.legacy.bidcos.rpc.internal.InterfaceInitializer.handle(InterfaceInitializer.java:107)
	at de.eq3.cbcs.legacy.bidcos.rpc.internal.InterfaceInitializer.handle(InterfaceInitializer.java:31)
	at io.vertx.core.eventbus.impl.HandlerRegistration.deliver(HandlerRegistration.java:212)
	at io.vertx.core.eventbus.impl.HandlerRegistration.handle(HandlerRegistration.java:191)
	at io.vertx.core.eventbus.impl.EventBusImpl.lambda$deliverToHandler$3(EventBusImpl.java:505)
	at io.vertx.core.impl.ContextImpl.lambda$wrapTask$2(ContextImpl.java:337)
	at io.vertx.core.impl.TaskQueue.lambda$new$0(TaskQueue.java:60)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
	at java.lang.Thread.run(Thread.java:748)
Caused by: java.net.ConnectException: Connection refused (Connection refused)
	at java.net.PlainSocketImpl.socketConnect(Native Method)
	at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:350)
	at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206)
	at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188)
	at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
	at java.net.Socket.connect(Socket.java:589)
	at org.apache.http.conn.scheme.PlainSocketFactory.connectSocket(PlainSocketFactory.java:120)
	at org.apache.http.impl.conn.DefaultClientConnectionOperator.openConnection(DefaultClientConnectionOperator.java:179)
	at org.apache.http.impl.conn.AbstractPoolEntry.open(AbstractPoolEntry.java:144)
	at org.apache.http.impl.conn.AbstractPooledConnAdapter.open(AbstractPooledConnAdapter.java:134)
	at org.apache.http.impl.client.DefaultRequestDirector.tryConnect(DefaultRequestDirector.java:612)
	at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:447)
	at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:884)
	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107)
	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
	at de.eq3.cbcs.legacy.communication.rpc.internal.transport.http.HttpTransport.sendRequest(HttpTransport.java:86)
	... 15 more
Nov 4 10:06:19 de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega INFO  [vert.x-eventloop-thread-5] (un)registerCallback on VirtualDeviceHandlerRega called from url: http://127.0.0.1:2016/ 
Nov 4 10:06:19 de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega INFO  [vert.x-eventloop-thread-5] Added InterfaceId: EASY_APP__HomeMaticVirtualDevices 
Nov 4 10:06:19 de.eq3.cbcs.legacy.bidcos.rpc.internal.InterfaceInitializer INFO  [vert.x-worker-thread-4] Added InterfaceId: EASY_APP__HomeMaticIp 
Nov 4 10:06:21 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-3] (un)registerCallback on LegacyServiceHandler called from url: http://127.0.0.1:2016/ 
Nov 4 10:06:22 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-3] init finished 
Nov 4 10:06:24 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-3] (un)registerCallback on LegacyServiceHandler called from url: http://127.0.0.1:2016/ 
Nov 4 10:06:24 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-3] init finished 
Nov 4 10:06:24 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-3] (un)registerCallback on LegacyServiceHandler called from url: http://127.0.0.1:2016/ 
Nov 4 10:06:24 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-3] Removed InterfaceId: EASY_APP__HomeMaticIp 
Nov 4 10:06:24 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-3] init finished 
Nov 4 10:06:24 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-3] (un)registerCallback on LegacyServiceHandler called from url: http://127.0.0.1:2016/ 
Nov 4 10:06:24 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-3] init finished 
Nov 4 10:06:24 de.eq3.cbcs.legacy.bidcos.rpc.internal.InterfaceInitializer ERROR [vert.x-worker-thread-4] IO Exception: Could not add interface: EASY_APP__HomeMaticIp 
de.eq3.cbcs.legacy.communication.rpc.RpcIOException: java.net.ConnectException: Connection refused (Connection refused)
	at de.eq3.cbcs.legacy.communication.rpc.internal.transport.http.HttpTransport.sendRequest(HttpTransport.java:90)
	at de.eq3.cbcs.legacy.communication.rpc.internal.rpc.RpcClient.sendRequest(RpcClient.java:99)
	at de.eq3.cbcs.legacy.communication.rpc.internal.rpc.RpcClient.invoke(RpcClient.java:87)
	at com.sun.proxy.$Proxy12.listDevices(Unknown Source)
	at de.eq3.cbcs.legacy.bidcos.rpc.internal.LegacyBackendClient.listDevices(LegacyBackendClient.java:140)
	at de.eq3.cbcs.legacy.bidcos.rpc.internal.DeviceUtil.synchronizedBackendDevices(DeviceUtil.java:116)
	at de.eq3.cbcs.legacy.bidcos.rpc.internal.InterfaceInitializer.handle(InterfaceInitializer.java:107)
	at de.eq3.cbcs.legacy.bidcos.rpc.internal.InterfaceInitializer.handle(InterfaceInitializer.java:31)
	at io.vertx.core.eventbus.impl.HandlerRegistration.deliver(HandlerRegistration.java:212)
	at io.vertx.core.eventbus.impl.HandlerRegistration.handle(HandlerRegistration.java:191)
	at io.vertx.core.eventbus.impl.EventBusImpl.lambda$deliverToHandler$3(EventBusImpl.java:505)
	at io.vertx.core.impl.ContextImpl.lambda$wrapTask$2(ContextImpl.java:337)
	at io.vertx.core.impl.TaskQueue.lambda$new$0(TaskQueue.java:60)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
	at java.lang.Thread.run(Thread.java:748)
Caused by: java.net.ConnectException: Connection refused (Connection refused)
	at java.net.PlainSocketImpl.socketConnect(Native Method)
	at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:350)
	at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206)
	at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188)
	at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
	at java.net.Socket.connect(Socket.java:589)
	at org.apache.http.conn.scheme.PlainSocketFactory.connectSocket(PlainSocketFactory.java:120)
	at org.apache.http.impl.conn.DefaultClientConnectionOperator.openConnection(DefaultClientConnectionOperator.java:179)
	at org.apache.http.impl.conn.AbstractPoolEntry.open(AbstractPoolEntry.java:144)
	at org.apache.http.impl.conn.AbstractPooledConnAdapter.open(AbstractPooledConnAdapter.java:134)
	at org.apache.http.impl.client.DefaultRequestDirector.tryConnect(DefaultRequestDirector.java:612)
	at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:447)
	at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:884)
	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107)
	at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
	at de.eq3.cbcs.legacy.communication.rpc.internal.transport.http.HttpTransport.sendRequest(HttpTransport.java:86)
	... 15 more
Nov 4 10:06:26 de.eq3.cbcs.legacy.bidcos.rpc.internal.InterfaceInitializer INFO  [vert.x-worker-thread-4] Added InterfaceId: EASY_APP__HomeMaticIp 
Nov 4 10:06:25 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-3] (un)registerCallback on LegacyServiceHandler called from url: http://127.0.0.1:2016/ 
Nov 4 10:06:25 de.eq3.ccu.virtualdevice.service.internal.rega.BackendWorker INFO  [vert.x-worker-thread-5] Execute BackendCommand: de.eq3.ccu.virtualdevice.service.internal.rega.BackendUpdateDevicesCommand 
Nov 4 10:06:30 de.eq3.cbcs.legacy.bidcos.rpc.LegacyServiceHandler INFO  [vert.x-worker-thread-3] init finished 
Nov 4 10:06:32 de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega INFO  [vert.x-eventloop-thread-5] (un)registerCallback on VirtualDeviceHandlerRega called from url: http://127.0.0.1:2016/ 
Nov 4 10:06:32 de.eq3.ccu.virtualdevice.service.internal.rega.VirtualDeviceHandlerRega INFO  [vert.x-eventloop-thread-5] Added InterfaceId: EASY_APP__HomeMaticInternalDevices 

Code: Alles auswählen

Nov  4 11:39:54 homematic-ccu2 user.err rfd: XmlRpc transport error calling listDevices({"EASY_APP__BidCos_RF"}) on http://127.0.0.1:2016/:
Nov  4 11:39:55 homematic-ccu2 user.err rfd: XmlRpcClient error calling event({[methodName:"event",params:{"EASY_APP__BidCos_RF","NEQ0093102:1","STATE",false}]}) on http://127.0.0.1:2016/:
Nov  4 11:39:55 homematic-ccu2 user.err rfd: XmlRpc transport error
Nov  4 11:39:55 homematic-ccu2 user.err rfd: XmlRpcClient error calling event({[methodName:"event",params:{"EASY_APP__BidCos_RF","NEQ0093102:1","ERROR",0}],[methodName:"event",params:{"EASY_APP__BidCos_RF","NEQ0093102:1","LOWBAT",false}]}) on http://127.0.0.1:2016/:
Nov  4 11:39:55 homematic-ccu2 user.err rfd: XmlRpc transport error
Nov  4 11:39:56 homematic-ccu2 user.err rfd: XmlRpcClient error calling event({[methodName:"event",params:{"EASY_APP__BidCos_RF","NEQ0092809:1","STATE",false}],[methodName:"event",params:{"EASY_APP__BidCos_RF","NEQ0092809:1","ERROR",0}],[methodName:"event",params:{"EASY_APP__BidCos_RF","NEQ0092809:1","LOWBAT",false}]}) on http://127.0.0.1:2016/:
Nov  4 11:39:56 homematic-ccu2 user.err rfd: XmlRpc transport error
Nov  4 11:39:58 homematic-ccu2 user.err rfd: XmlRpc transport error calling system.listMethods({"EASY_APP__BidCos_RF"}) on http://127.0.0.1:2016/:
Nov  4 11:39:58 homematic-ccu2 user.err rfd: XmlRpc transport error calling listDevices({"EASY_APP__BidCos_RF"}) on http://127.0.0.1:2016/:
Nov  4 11:40:01 homematic-ccu2 user.notice rfkill: unblock set for id 0
Nov  4 11:40:01 homematic-ccu2 user.info kernel: [65388.448769] rtl8723bs: acquire FW from file:rtlwifi/rtl8723bs_nic.bin
Nov  4 11:40:03 homematic-ccu2 daemon.err ifplugd(wlan0)[432]: NLAPI: Packet too small or truncated!
Nov  4 11:40:03 homematic-ccu2 daemon.info ifplugd(wlan0)[432]: Exiting.
Nov  4 11:40:03 homematic-ccu2 user.info kernel: [65389.812070] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
Nov  4 11:40:04 homematic-ccu2 user.notice rfkill: block set for id 0
Nov  4 11:40:14 homematic-ccu2 user.err rfd: XmlRpcClient error calling event({[methodName:"event",params:{"EASY_APP__BidCos_RF","NEQ0044481:1","BRIGHTNESS",39}]}) on http://127.0.0.1:2016/:
Nov  4 11:40:14 homematic-ccu2 user.err rfd: XmlRpc transport error
Nov  4 11:40:14 homematic-ccu2 user.err rfd: XmlRpcClient error calling event({[methodName:"event",params:{"EASY_APP__BidCos_RF","NEQ0044481:1","MOTION",true}],[methodName:"event",params:{"EASY_APP__BidCos_RF","NEQ0044481:1","INSTALL_TEST",true}]}) on http://127.0.0.1:2016/:
Nov  4 11:40:14 homematic-ccu2 user.err rfd: XmlRpc transport error
Nov  4 11:40:19 homematic-ccu2 user.err rfd: XmlRpc transport error calling system.listMethods({"EASY_APP__BidCos_RF"}) on http://127.0.0.1:2016/:
Nov  4 11:40:19 homematic-ccu2 user.err rfd: XmlRpc transport error calling listDevices({"EASY_APP__BidCos_RF"}) on http://127.0.0.1:2016/:
Nov  4 11:40:24 homematic-ccu2 user.err rfd: XmlRpcClient error calling event({[methodName:"event",params:{"EASY_APP__BidCos_RF","NEQ0045119:1","BRIGHTNESS",44}]}) on http://127.0.0.1:2016/:
Nov  4 11:40:24 homematic-ccu2 user.err rfd: XmlRpc transport error
Nov  4 11:40:24 homematic-ccu2 user.err rfd: XmlRpcClient error calling event({[methodName:"event",params:{"EASY_APP__BidCos_RF","NEQ0045119:1","MOTION",true}],[methodName:"event",params:{"EASY_APP__BidCos_RF","NEQ0045119:1","INSTALL_TEST",true}]}) on http://127.0.0.1:2016/:
Nov  4 11:40:24 homematic-ccu2 user.err rfd: XmlRpc transport error
Nov  4 11:40:24 homematic-ccu2 user.err rfd: XmlRpc transport error calling system.listMethods({"EASY_APP__BidCos_RF"}) on http://127.0.0.1:2016/:
Nov  4 11:40:24 homematic-ccu2 user.err rfd: XmlRpc transport error calling listDevices({"EASY_APP__BidCos_RF"}) on http://127.0.0.1:2016/:
Nov  4 11:40:29 homematic-ccu2 user.err rfd: XmlRpc transport error calling system.listMethods({"EASY_APP__BidCos_RF"}) on http://127.0.0.1:2016/:
Nov  4 11:40:29 homematic-ccu2 user.err rfd: XmlRpc transport error calling listDevices({"EASY_APP__BidCos_RF"}) on http://127.0.0.1:2016/:
Nov  4 11:40:31 homematic-ccu2 user.err rfd: XmlRpcClient error calling event({[methodName:"event",params:{"EASY_APP__BidCos_RF","NEQ0044481:1","MOTION",false}]}) on http://127.0.0.1:2016/:
Nov  4 11:40:31 homematic-ccu2 user.err rfd: XmlRpc transport error
Kennt jemand das Problem und kann uns helfen.

VG, Christian
Dateianhänge
homematic-ccu2-2018-11-04.log
(2.98 MiB) 31-mal heruntergeladen

Antworten

Zurück zu „RaspberryMatic“