2015-09-16 22:08:27.440 [INFO ] [penhab.io.rest.RESTApplication] - Stopped REST API 2015-09-16 22:08:36.243 [INFO ] [.o.u.w.i.servlet.WebAppServlet] - Stopped Classic UI 2015-09-16 22:08:56.524 [INFO ] [.o.core.internal.CoreActivator] - openHAB runtime has been started (v1.7.1). 2015-09-16 22:09:01.695 [INFO ] [o.o.i.s.i.DiscoveryServiceImpl] - mDNS service has been started 2015-09-16 22:09:01.882 [INFO ] [o.o.i.s.i.DiscoveryServiceImpl] - Service Discovery initialization completed. 2015-09-16 22:09:10.112 [INFO ] [c.internal.ModelRepositoryImpl] - Loading model 'Haus.sitemap' 2015-09-16 22:09:10.964 [INFO ] [c.internal.ModelRepositoryImpl] - Loading model 'mysql.persist' 2015-09-16 22:09:11.154 [INFO ] [c.internal.ModelRepositoryImpl] - Loading model 'Haus.items' 2015-09-16 22:09:12.338 [INFO ] [penhab.io.rest.RESTApplication] - Started REST API at /rest 2015-09-16 22:09:17.692 [INFO ] [.o.u.w.i.servlet.WebAppServlet] - Started Classic UI at /openhab.app 2015-09-16 22:09:22.149 [INFO ] [o.o.b.h.i.bus.HomematicBinding] - HomematicConfig[host=127.0.0.1,callbackHost=192.168.125.20,callbackPort=9123,aliveInterval=disabled,reconnectInterval=3600] 2015-09-16 22:09:22.151 [INFO ] [.b.h.i.c.HomematicCommunicator] - Starting Homematic communicator 2015-09-16 22:09:22.195 [INFO ] [.b.h.i.c.HomematicCommunicator] - Homematic ServerId[name=Homegear,version=0.5.25] 2015-09-16 22:09:22.206 [INFO ] [.b.h.i.c.client.HomegearClient] - Starting HomegearClient 2015-09-16 22:09:22.214 [INFO ] [b.h.i.communicator.StateHolder] - Loading Homematic datapoints 2015-09-16 22:09:22.236 [INFO ] [c.internal.ModelRepositoryImpl] - Loading model 'rule1.rules' 2015-09-16 22:09:22.534 [INFO ] [b.h.i.communicator.StateHolder] - Finished loading 147 Homematic datapoints 2015-09-16 22:09:22.535 [INFO ] [b.h.i.communicator.StateHolder] - Loading Homematic Server variables 2015-09-16 22:09:22.544 [INFO ] [b.h.i.communicator.StateHolder] - Finished loading 0 Homematic server variables 2015-09-16 22:09:22.546 [INFO ] [b.h.i.c.s.BinRpcCallbackServer] - Starting BinRpcCallbackServer at port 9123 2015-09-16 22:09:22.557 [INFO ] [.b.h.i.c.HomematicCommunicator] - Scheduling one datapoint reload job in one minute 2015-09-16 22:09:22.562 [INFO ] [.service.AbstractActiveService] - Homematic server connection tracker has been started 2015-09-16 22:09:25.083 [INFO ] [.service.AbstractActiveService] - Exec Refresh Service has been started -> hier habe ich einen Befehl über openhanb zur einer Steckdose gesendet 2015-09-16 22:10:14.006 [ERROR] [.b.h.i.c.HomematicCommunicator] - Read timed out (sending BinRpcRequest[methodName=setValue,args={KEQ0462699:1,LEVEL,1.0}]) org.openhab.binding.homematic.internal.communicator.client.HomematicClientException: Read timed out (sending BinRpcRequest[methodName=setValue,args={KEQ0462699:1,LEVEL,1.0}]) at org.openhab.binding.homematic.internal.communicator.client.BinRpcClient.sendMessage(BinRpcClient.java:224) ~[bundlefile:na] at org.openhab.binding.homematic.internal.communicator.client.BinRpcClient.setDatapointValue(BinRpcClient.java:158) ~[bundlefile:na] at org.openhab.binding.homematic.internal.communicator.client.BaseHomematicClient.setDatapointValue(BaseHomematicClient.java:72) ~[bundlefile:na] at org.openhab.binding.homematic.internal.communicator.HomematicPublisher.sendToClient(HomematicPublisher.java:78) ~[bundlefile:na] at org.openhab.binding.homematic.internal.communicator.HomematicPublisher.execute(HomematicPublisher.java:65) ~[bundlefile:na] at org.openhab.binding.homematic.internal.communicator.HomematicCommunicator.publishToHomematicServer(HomematicCommunicator.java:317) [bundlefile:na] at org.openhab.binding.homematic.internal.communicator.HomematicCommunicator.receiveType(HomematicCommunicator.java:278) [bundlefile:na] at org.openhab.binding.homematic.internal.communicator.HomematicCommunicator.receiveCommand(HomematicCommunicator.java:245) [bundlefile:na] at org.openhab.binding.homematic.internal.bus.HomematicBinding.internalReceiveCommand(HomematicBinding.java:168) [bundlefile:na] at org.openhab.core.binding.AbstractBinding.receiveCommand(AbstractBinding.java:96) [org.openhab.core_1.7.1.jar:na] at org.openhab.core.events.AbstractEventSubscriber.handleEvent(AbstractEventSubscriber.java:42) [org.openhab.core_1.7.1.jar:na] at org.eclipse.equinox.internal.event.EventHandlerWrapper.handleEvent(EventHandlerWrapper.java:197) [org.eclipse.equinox.event_1.2.200.v20120522-2049.jar:na] at org.eclipse.equinox.internal.event.EventHandlerTracker.dispatchEvent(EventHandlerTracker.java:197) [org.eclipse.equinox.event_1.2.200.v20120522-2049.jar:na] at org.eclipse.equinox.internal.event.EventHandlerTracker.dispatchEvent(EventHandlerTracker.java:1) [org.eclipse.equinox.event_1.2.200.v20120522-2049.jar:na] at org.eclipse.osgi.framework.eventmgr.EventManager.dispatchEvent(EventManager.java:230) [org.eclipse.osgi_3.8.2.v20130124-134944.jar:na] at org.eclipse.osgi.framework.eventmgr.ListenerQueue.dispatchEventSynchronous(ListenerQueue.java:148) [org.eclipse.osgi_3.8.2.v20130124-134944.jar:na] at org.eclipse.equinox.internal.event.EventAdminImpl.dispatchEvent(EventAdminImpl.java:135) [org.eclipse.equinox.event_1.2.200.v20120522-2049.jar:na] at org.eclipse.equinox.internal.event.EventAdminImpl.sendEvent(EventAdminImpl.java:78) [org.eclipse.equinox.event_1.2.200.v20120522-2049.jar:na] at org.eclipse.equinox.internal.event.EventComponent.sendEvent(EventComponent.java:39) [org.eclipse.equinox.event_1.2.200.v20120522-2049.jar:na] at org.openhab.core.internal.events.EventPublisherImpl.sendCommand(EventPublisherImpl.java:56) [org.openhab.core_1.7.1.jar:na] at org.openhab.ui.webapp.internal.servlet.CmdServlet.service(CmdServlet.java:95) [org.openhab.ui.webapp_1.7.1.jar:na] at org.eclipse.equinox.http.servlet.internal.ServletRegistration.service(ServletRegistration.java:61) [org.eclipse.equinox.http.servlet_1.1.300.v20120522-1841.jar:na] at org.eclipse.equinox.http.servlet.internal.ProxyServlet.processAlias(ProxyServlet.java:128) [org.eclipse.equinox.http.servlet_1.1.300.v20120522-1841.jar:na] at org.eclipse.equinox.http.servlet.internal.ProxyServlet.service(ProxyServlet.java:60) [org.eclipse.equinox.http.servlet_1.1.300.v20120522-1841.jar:na] at javax.servlet.http.HttpServlet.service(HttpServlet.java:848) [javax.servlet_3.0.0.v201112011016.jar:na] at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:598) [org.eclipse.jetty.servlet_8.1.3.v20120522.jar:8.1.3.v20120522] at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:486) [org.eclipse.jetty.servlet_8.1.3.v20120522.jar:8.1.3.v20120522] at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:231) [org.eclipse.jetty.server_8.1.3.v20120522.jar:8.1.3.v20120522] at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1065) [org.eclipse.jetty.server_8.1.3.v20120522.jar:8.1.3.v20120522] at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:413) [org.eclipse.jetty.servlet_8.1.3.v20120522.jar:8.1.3.v20120522] at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:192) [org.eclipse.jetty.server_8.1.3.v20120522.jar:8.1.3.v20120522] at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:999) [org.eclipse.jetty.server_8.1.3.v20120522.jar:8.1.3.v20120522] at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:117) [org.eclipse.jetty.server_8.1.3.v20120522.jar:8.1.3.v20120522] at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:250) [org.eclipse.jetty.server_8.1.3.v20120522.jar:8.1.3.v20120522] at org.eclipse.jetty.server.handler.HandlerCollection.handle(HandlerCollection.java:149) [org.eclipse.jetty.server_8.1.3.v20120522.jar:8.1.3.v20120522] at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:111) [org.eclipse.jetty.server_8.1.3.v20120522.jar:8.1.3.v20120522] at org.eclipse.jetty.server.Server.handle(Server.java:350) [org.eclipse.jetty.server_8.1.3.v20120522.jar:8.1.3.v20120522] at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:454) [org.eclipse.jetty.server_8.1.3.v20120522.jar:8.1.3.v20120522] at org.eclipse.jetty.server.AbstractHttpConnection.headerComplete(AbstractHttpConnection.java:890) [org.eclipse.jetty.server_8.1.3.v20120522.jar:8.1.3.v20120522] at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.headerComplete(AbstractHttpConnection.java:944) [org.eclipse.jetty.server_8.1.3.v20120522.jar:8.1.3.v20120522] at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:630) [org.eclipse.jetty.http_8.1.3.v20120522.jar:8.1.3.v20120522] at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:230) [org.eclipse.jetty.http_8.1.3.v20120522.jar:8.1.3.v20120522] at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:77) [org.eclipse.jetty.server_8.1.3.v20120522.jar:8.1.3.v20120522] at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:606) [org.eclipse.jetty.io_8.1.3.v20120522.jar:8.1.3.v20120522] at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:46) [org.eclipse.jetty.io_8.1.3.v20120522.jar:8.1.3.v20120522] at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:603) [org.eclipse.jetty.util_8.1.3.v20120522.jar:8.1.3.v20120522] at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:538) [org.eclipse.jetty.util_8.1.3.v20120522.jar:8.1.3.v20120522] at java.lang.Thread.run(Thread.java:744) [na:1.8.0] Caused by: java.net.SocketTimeoutException: Read timed out at java.net.SocketInputStream.socketRead0(Native Method) ~[na:1.8.0] at java.net.SocketInputStream.read(SocketInputStream.java:150) ~[na:1.8.0] at java.net.SocketInputStream.read(SocketInputStream.java:121) ~[na:1.8.0] at java.net.SocketInputStream.read(SocketInputStream.java:107) ~[na:1.8.0] at org.openhab.binding.homematic.internal.binrpc.BinRpcResponse.(BinRpcResponse.java:48) ~[bundlefile:na] at org.openhab.binding.homematic.internal.communicator.client.BinRpcClient.sendMessage(BinRpcClient.java:196) ~[bundlefile:na] ... 47 common frames omitted LOG AUS EVENTS.log Daten werden über Homegear ABER alle empfangen 2015-09-16 22:09:27 - HM_Kontakt_7c_PRESSs state updated to 0.00 2015-09-16 22:09:27 - HM_Kontakt_6a_Batterie state updated to 0.00 2015-09-16 22:09:27 - HM_Steckdo_3_Frequenz state updated to 49.98 2015-09-16 22:09:28 - HM_Kontakt_7b_PRESSs state updated to 0.00 2015-09-16 22:09:28 - HM_Kontakt_4_Error state updated to 0 2015-09-16 22:09:28 - HM_Kontakt_5_Error state updated to 0 2015-09-16 22:09:28 - HM_Steckdo_3_Spannung state updated to 224.90 2015-09-16 22:09:28 - HM_Kontakt_7d_MOTION state updated to 0.00 2015-09-16 22:09:28 - HM_Steckdo_3 state updated to OFF 2015-09-16 22:09:28 - HM_Kontakt_6c_Status state updated to 1.00 2015-09-16 22:09:28 - Panikhandsender_StatusB state updated to 0.00 2015-09-16 22:09:28 - Panikhandsender_StatusA state updated to 0.00 2015-09-16 22:09:28 - HM_Steckdo_3_Strom state updated to 0.00 2015-09-16 22:09:28 - HM_Kontakt_6b_Status state updated to 1.00 2015-09-16 22:09:28 - HM_Steckdo_3_Leistung state updated to 0.00 2015-09-16 22:09:28 - HM_Kontakt_4_Batterie state updated to 0.00 2015-09-16 22:09:28 - HM_Steckdo_3_Status state updated to 0.00 2015-09-16 22:09:28 - HM_Steckdo_2 state updated to OFF 2015-09-16 22:09:28 - HM_Steckdo_1 state updated to OFF 2015-09-16 22:09:28 - HM_Kontakt_4_Status state updated to 1.00 2015-09-16 22:09:28 - HM_Kontakt_7d_BRIGHT state updated to 110 2015-09-16 22:09:28 - WassertempA state updated to 21.40 2015-09-16 22:09:28 - HM_Kontakt_7d_NEXT state updated to 281 2015-09-16 22:09:28 - HM_Kontakt_5_Batterie state updated to 0.00 2015-09-16 22:09:28 - gpio_18 state updated to OFF 2015-09-16 22:09:28 - HM_Kontakt_7d_MOT1 state updated to 2015-09-16T22:09:28 2015-09-16 22:10:14 - HM_Steckdo_2 received command ON 2015-09-16 22:10:14 - HM_Steckdo_2 state updated to ON