search

tobof / openhab-addons

The next-generation open Home Automation Bus (openHAB)
Eclipse Public License 2.0
39 stars 30 forks source link

Gateway connection failed on MS 2.0 beta #10

Closed andreacioni closed 8 years ago

andreacioni commented 8 years ago

Hi Tim,

I'll report here the Francois issue just to remeber to take a look at it.

Additional info:

Attached log:

12:49:05.469 [DEBUG] [nsors.handler.MySensorsBridgeHandler] - Initialization of the MySensors Bridge 12:49:05.543 [DEBUG] [col.serial.MySensorsSerialConnection] - Connecting to /dev/ttyUSB0 [baudRate:115200] 12:49:06.140 [INFO ] [smarthome.event.ItemAddedEvent ] - Item 'mysensors_bridge_ser_bb7302f6' has been added. 12:49:06.390 [DEBUG] [col.serial.MySensorsSerialConnection] - Successfully connected to serial port. 12:49:06.446 [INFO ] [rthome.event.ItemThingLinkAddedEvent] - Link 'mysensors_bridge_ser_bb7302f6-mysensors:bridge-ser:bb7302f6' has been added. 12:49:09.409 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 0;255;3;0;9;Starting gateway (RRNGA-, 2.0.0-beta) 12:49:09.426 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 0;255;3;0;9;Radio init successful. 12:49:09.434 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 0;255;3;0;14;Gateway startup complete. 12:49:09.441 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 0;255;3;0;9;Init complete, id=0, parent=0, distance=0 12:49:09.506 [DEBUG] [g.mysensors.protocol.MySensorsWriter] - Sending to MySensors: 0;0;3;0;2; 12:49:10.488 [WARN ] [ome.core.thing.internal.ThingManager] - Initializing handler for thing 'mysensors:bridge-ser:bb7302f6' takes more than 5000ms. 12:49:10.763 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 0;255;3;0;9;read: 40-40-0 s=1,c=1,t=16,pt=0,l=1,sg=0:1 12:49:10.767 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 40;1;1;0;16;1 12:49:11.676 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 0;255;3;0;9;read: 40-40-0 s=1,c=1,t=16,pt=0,l=1,sg=0:1 12:49:11.680 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 40;1;1;0;16;1 12:49:11.778 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 0;255;3;0;9;read: 40-40-0 s=0,c=1,t=23,pt=2,l=2,sg=0:72 12:49:11.783 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 40;0;1;0;23;72 12:49:11.792 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 0;255;3;0;9;read: 40-40-0 s=5,c=1,t=38,pt=7,l=5,sg=0:3.07 12:49:11.796 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 40;5;1;0;38;3.07 12:49:11.838 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 0;255;3;0;9;read: 40-40-0 s=5,c=1,t=38,pt=7,l=5,sg=0:3.07 12:49:11.843 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 40;5;1;0;38;3.07 12:49:11.861 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 0;255;3;0;9;read: 40-40-0 s=255,c=3,t=0,pt=1,l=1,sg=0:100 12:49:11.866 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 40;255;3;0;0;100 12:49:12.079 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 0;255;3;0;9;read: 66-66-0 s=1,c=1,t=24,pt=5,l=4,sg=0:3579898 12:49:12.083 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 66;1;1;0;24;3579898 12:49:14.409 [ERROR] [s.internal.MySensorsBridgeConnection] - Cannot start reading/writing thread, probably sync message (I_VERSION) not received 12:49:14.410 [DEBUG] [col.serial.MySensorsSerialConnection] - Shutting down serial connection! 12:49:14.412 [DEBUG] [g.mysensors.protocol.MySensorsWriter] - Stopping Writer thread 12:49:14.418 [WARN ] [g.mysensors.protocol.MySensorsWriter] - Writer thread interrupted 12:49:14.428 [DEBUG] [g.mysensors.protocol.MySensorsReader] - Stopping Reader thread 12:49:14.528 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:bridge-ser:bb7302f6' changed from INITIALIZING to OFFLINE

Forum discussion

tobof commented 8 years ago

Ok, I've updated a serial gateway (without RF) to the most recent development version.

Here is an excerpt of the OH2 startup:

2016-04-19 16:34:07.526 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 0;255;3;0;9;Starting gateway (R-NGA-, 2.0.0-beta) 2016-04-19 16:34:07.526 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 0;255;3;0;14;Gateway startup complete. 2016-04-19 16:34:07.526 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 0;255;3;0;11;RelaisKeller 2016-04-19 16:34:07.526 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 0;255;3;0;12;2.0 2016-04-19 16:34:07.526 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 0;0;0;0;5; 2016-04-19 16:34:07.526 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 0;1;0;0;5; 2016-04-19 16:34:07.527 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 0;2;0;0;5; 2016-04-19 16:34:07.527 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 0;3;0;0;5; 2016-04-19 16:34:07.527 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 0;4;0;0;5; 2016-04-19 16:34:07.537 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 0;5;0;0;3; 2016-04-19 16:34:07.537 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 0;6;0;0;3; 2016-04-19 16:34:07.537 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 0;7;0;0;13; 2016-04-19 16:34:07.537 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 0;255;3;0;9;Init complete, id=0, parent=0, distance=0 2016-04-19 16:34:07.609 [DEBUG] [g.mysensors.protocol.MySensorsWriter] - Sending to MySensors: 0;0;3;0;2; 2016-04-19 16:34:07.615 [DEBUG] [g.mysensors.protocol.MySensorsReader] - 0;255;3;0;2;2.0.0-beta 2016-04-19 16:34:07.616 [DEBUG] [s.internal.MySensorsBridgeConnection] - Good,Gateway is up and running! (Ver:2.0.0-beta) 2016-04-19 16:34:07.624 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:bridge-ser:MySGWKeller' changed from INITIALIZING to ONLINE

Everything is working as expected!

andreacioni commented 8 years ago

The best thing, by now, is to allow user to omit (as you say on MS forum) the check. We can do it by adding a configuration entry on the binding config.

andreacioni commented 8 years ago

Now can omit check on startup.

andreacioni commented 8 years ago

The problem seems to be related only to version 2.0 beta used with RFM69 module