Homematic Bridge uninitialized

MartinE · November 18, 2017, 4:18pm

I have been trying to reinstall the homematic bridge as it was not working after I changed the callback-host address to see if I could get the items values to update in paperUI, and then saved. I have downloaded the latest SNAPSHOT ( 2.2.0.201711171328) of the binding and verified that it is active with the console. The problem now is that the bridge is not initializing, it’s showing an “ERROR 500- Internal server error”.
Part of the error log:

2017-11-17 19:22:24.844 [ERROR] [ome.io.rest.core.thing.ThingResource] - Exception during HTTP PUT request for update config at 'things/homematic:bridge:9723d911/config' for thing 'homematic:bridge:9723d911': Thing with UID homematic:bridge:9723d911 has no handler attached.
2017-11-17 19:22:24.845 [DEBUG] [e.internal.WriterInterceptorExecutor] - Message body writer (class org.eclipse.smarthome.io.rest.core.internal.GsonProvider) is trying to close the entity output stream. Not closing.
2017-11-17 19:22:24.845 [DEBUG] [.eclipse.jetty.server.HttpConnection] - org.eclipse.jetty.server.HttpConnection$SendCallback@197b03b1[PROCESSING][i=ResponseInfo{HTTP/1.1 500 Internal Server Error,105,false},cb=org.eclipse.jetty.server.HttpChannel$CommitCallback@13505bb9] generate: NEED_HEADER (null,[p=0,l=105,c=8192,r=105],true)@START
2017-11-17 19:22:24.845 [DEBUG] [.eclipse.jetty.server.HttpConnection] - org.eclipse.jetty.server.HttpConnection$SendCallback@197b03b1[PROCESSING][i=ResponseInfo{HTTP/1.1 500 Internal Server Error,105,false},cb=org.eclipse.jetty.server.HttpChannel$CommitCallback@13505bb9] generate: FLUSH ([p=0,l=124,c=8192,r=124],[p=0,l=105,c=8192,r=105],true)@COMPLETING
2017-11-17 19:22:24.845 [DEBUG] [org.eclipse.jetty.io.WriteFlusher   ] - write: WriteFlusher@4a7ea73a{IDLE} [HeapByteBuffer@8f072d9[p=0,l=124,c=8192,r=124]={<<<HTTP/1.1 500 Inte....v20160908)\r\n\r\n>>>\n8000\r\nth: 289\r\nS...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00},HeapByteBuffer@5c3bf22d[p=0,l=105,c=8192,r=105]={<<<{"error":{"messag...ttp-code":500}}>>>\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}]
2017-11-17 19:22:24.845 [DEBUG] [org.eclipse.jetty.io.WriteFlusher   ] - update WriteFlusher@4a7ea73a{WRITING}:IDLE-->WRITING
2017-11-17 19:22:24.845 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@48c94984{NOT_HANDSHAKING,eio=-1/-1,di=-1} -> HttpConnection@16cabe63[FILLING,DecryptedEndPoint@16991896{/192.168.0.175:50409<->8443,Open,in,out,-,W,1164/30000,HttpConnection}->SelectChannelEndPoint@439f6e36{/192.168.0.175:50409<->8443,Open,in,out,-,-,7/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=END,235 of 235},g=HttpGenerator{s=COMPLETING},c=HttpChannelOverHttp@599a6af3{r=4,c=true,a=DISPATCHED,uri=/rest/things/homematic:bridge:9723d911/config}] flush enter [java.nio.HeapByteBuffer[pos=0 lim=124 cap=8192], java.nio.HeapByteBuffer[pos=0 lim=105 cap=8192]]
2017-11-17 19:22:24.845 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@48c94984{NOT_HANDSHAKING,eio=-1/258,di=-1} -> HttpConnection@16cabe63[FILLING,DecryptedEndPoint@16991896{/192.168.0.175:50409<->8443,Open,in,out,-,W,1164/30000,HttpConnection}->SelectChannelEndPoint@439f6e36{/192.168.0.175:50409<->8443,Open,in,out,-,-,7/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=END,235 of 235},g=HttpGenerator{s=COMPLETING},c=HttpChannelOverHttp@599a6af3{r=4,c=true,a=DISPATCHED,uri=/rest/things/homematic:bridge:9723d911/config}] wrap Status = OK HandshakeStatus = NOT_HANDSHAKING
bytesConsumed = 229 bytesProduced = 258
2017-11-17 19:22:24.845 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - DecryptedEndPoint@16991896{/192.168.0.175:50409<->8443,Open,in,out,-,W,1164/30000,HttpConnection}->SelectChannelEndPoint@439f6e36{/192.168.0.175:50409<->8443,Open,in,out,-,-,7/30000,SslConnection}{io=0,kio=0,kro=1} OK HeapByteBuffer@4955c3d3[p=0,l=258,c=17408,r=258]={<<<\x17\x03\x03\x00\xFd\x00\x00\x00\x00\x00\x00\x00\t\xCcUO/...\xF6\xAe\xB0B\xC0\x96\xC7!c"\x9d\x92}\x12\xC4>>> like Gecko) Chro...\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00}
2017-11-17 19:22:24.846 [DEBUG] [org.eclipse.jetty.io.ChannelEndPoint] - flushed 258 SelectChannelEndPoint@439f6e36{/192.168.0.175:50409<->8443,Open,in,out,-,-,8/30000,SslConnection}{io=0,kio=0,kro=1}
2017-11-17 19:22:24.846 [DEBUG] [g.eclipse.jetty.io.ssl.SslConnection] - SslConnection@48c94984{NOT_HANDSHAKING,eio=-1/0,di=-1} -> HttpConnection@16cabe63[FILLING,DecryptedEndPoint@16991896{/192.168.0.175:50409<->8443,Open,in,out,-,W,1165/30000,HttpConnection}->SelectChannelEndPoint@439f6e36{/192.168.0.175:50409<->8443,Open,in,out,-,-,0/30000,SslConnection}{io=0,kio=0,kro=1}][p=HttpParser{s=END,235 of 235},g=HttpGenerator{s=COMPLETING},c=HttpChannelOverHttp@599a6af3{r=4,c=true,a=DISPATCHED,uri=/rest/things/homematic:bridge:9723d911/config}] flush exit, consumed 229
2017-11-17 19:22:24.846 [DEBUG] [org.eclipse.jetty.io.WriteFlusher   ] - update WriteFlusher@4a7ea73a{IDLE}:WRITING-->IDLE
2017-11-17 19:22:24.846 [DEBUG] [.eclipse.jetty.server.HttpConnection] - org.eclipse.jetty.server.HttpConnection$SendCallback@197b03b1[PROCESSING][i=ResponseInfo{HTTP/1.1 500 Internal Server Error,105,false},cb=org.eclipse.jetty.server.HttpChannel$CommitCallback@13505bb9] generate: DONE ([p=124,l=124,c=8192,r=0],[p=105,l=105,c=8192,r=0],true)@END
2017-11-17 19:22:24.846 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/things/homematic:bridge:9723d911/config @ o.e.j.s.h.ContextHandler@72353f8{/static,null,AVAILABLE}
2017-11-17 19:22:24.846 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/things/homematic:bridge:9723d911/config @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.eclipse.smarthome.core.audio_0.9.0.b5 [99], contextID=default]}
2017-11-17 19:22:24.846 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/things/homematic:bridge:9723d911/config @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.eclipse.smarthome.ui_0.9.0.b5 [136], contextID=default]}
2017-11-17 19:22:24.846 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/things/homematic:bridge:9723d911/config @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.eclipse.smarthome.ui.icon_0.9.0.b5 [137], contextID=default]}
2017-11-17 19:22:24.846 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/things/homematic:bridge:9723d911/config @ HttpServiceContext{httpContext=org.jupnp.transport.impl.osgi.DisableAuthenticationHttpContext@6782e51b}
2017-11-17 19:22:24.846 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/things/homematic:bridge:9723d911/config @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.openhab.ui.dashboard_2.1.0 [170], contextID=default]}
2017-11-17 19:22:24.846 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/things/homematic:bridge:9723d911/config @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.eclipse.smarthome.ui.basic_0.9.0.b5 [176], contextID=default]}
2017-11-17 19:22:24.846 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/things/homematic:bridge:9723d911/config @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.eclipse.smarthome.ui.paper_0.9.0.b5 [177], contextID=default]}
2017-11-17 19:22:24.846 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/things/homematic:bridge:9723d911/config @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.openhab.ui.habpanel_2.1.0 [179], contextID=default]}
2017-11-17 19:22:24.846 [DEBUG] [.jetty.server.handler.ContextHandler] - scope null||/rest/things/homematic:bridge:9723d911/config @ HttpServiceContext{httpContext=DefaultHttpContext [bundle=org.openhab.core_2.1.0 [166], contextID=default]}
2017-11-17 19:22:24.846 [DEBUG] [org.eclipse.jetty.server.Server     ] - RESPONSE /rest/things/homematic:bridge:9723d911/config  500 handled=true
2017-11-17 19:22:24.847 [DEBUG] [clipse.jetty.server.HttpChannelState] - HttpChannelState@2e9c9b58{s=DISPATCHED i=true a=null} unhandle DISPATCHED
2017-11-17 19:22:24.847 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - reset HttpParser{s=END,235 of 235}
2017-11-17 19:22:24.847 [DEBUG] [org.eclipse.jetty.http.HttpParser   ] - END --> START

Anybody know what the problem might be?

Udo_Hartmann · November 18, 2017, 6:45pm

Please use code fences to mark code or logs:
```

2017-11-17 19:22:24.846 [DEBUG] [org.eclipse.jetty.server.Server ] - RESPONSE /rest/things/homematic:bridge:9723d911/config 500 handled=true
2017-11-17 19:22:24.847 [DEBUG] [clipse.jetty.server.HttpChannelState] - HttpChannelState@2e9c9b58{s=DISPATCHED i=true a=null} unhandle DISPATCHED
2017-11-17 19:22:24.847 [DEBUG] [org.eclipse.jetty.http.HttpParser ] - reset HttpParser{s=END,235 of 235}
2017-11-17 19:22:24.847 [DEBUG] [org.eclipse.jetty.http.HttpParser ] - END --> START

```
(these are only the last 4 lines)
You can edit your posting and add the code fences.

MARZIMA · September 17, 2018, 2:20pm

Hi all,

i ve the same problem and no real clue why this happened.
Any homematic guru who can help

MHerbst · September 18, 2018, 5:45pm

Hi Mehmet,

I haven’t seen this error before in my installation but maybe I can help with this list of possible problem causes:

if the machine where you are running openHAB has more than one IP address you should set a callback address in the Homematic binding
there were some problems with HM IP devices in some the last 2.4 snapshots
I also remember some problems if Philips Hue or Osram Lightify devices are connected to your CCU (or whatever you are using)

Some more information about your configuration would be helpful because there exist so many different ways to use HomeMatic (CCU2, CCU3, Raspberrymatic, Homegear, …).
Maybe a debug log can provide some additional information. As far as I remember it prints the messages sent by the CCU.

Martin

olivercha11 · September 30, 2018, 5:24pm

I got his the mi light bride work when you add but when you power the pi and up again sometime it does changed from UNINITIALIZED to UNINITIALIZED (BRIDGE_UNINITIALIZED) ibox but it does work but you have to keep adding the bridge but the older bride for mi light does more automatic