openHAB 2.0 binding
-
@TimO: Thanks to you this weekend, while kids slept or napped, I managed to setup RPi gateway/controller with NRF24 and OH2.
Following the OH2 install instructions caused me some trouble, not sure why, but following your install instructions it came right up.
Thank you for the time and effort here. -
Having a couple issues:
- while adding 2nd node (tried power and temp/hum) OH2 would not assign node ID.
- assigned node ID manually (ID=2) and OH2 recognized power node but will not respond to V_VAR1 request.
16:23:58.850 [DEBUG] [rs.internal.protocol.MySensorsReader] - 1;1;1;0;0;20.4 16:23:58.874 [DEBUG] [rs.internal.protocol.MySensorsReader] - 1;0;1;0;1;47.3 16:24:01.910 [DEBUG] [col.serial.MySensorsSerialConnection] - Bridge is connected, connection skipped 16:24:09.293 [DEBUG] [rs.internal.protocol.MySensorsReader] - 1;0;1;0;1;47.5 16:24:11.911 [DEBUG] [col.serial.MySensorsSerialConnection] - Bridge is connected, connection skipped 16:24:11.942 [DEBUG] [rs.internal.protocol.MySensorsReader] - 2;0;2;0;24; 16:24:19.736 [DEBUG] [rs.internal.protocol.MySensorsReader] - 1;0;1;0;1;47.7 16:24:21.912 [DEBUG] [col.serial.MySensorsSerialConnection] - Bridge is connected, connection skipped 16:24:26.987 [DEBUG] [rs.internal.protocol.MySensorsReader] - 2;0;2;0;24; 16:24:30.177 [DEBUG] [rs.internal.protocol.MySensorsReader] - 1;0;1;0;1;47.6 16:24:31.913 [DEBUG] [col.serial.MySensorsSerialConnection] - Bridge is connected, connection skipped 16:24:40.604 [DEBUG] [rs.internal.protocol.MySensorsReader] - 1;0;1;0;1;47.5 16:24:41.914 [DEBUG] [col.serial.MySensorsSerialConnection] - Bridge is connected, connection skipped 16:24:42.044 [DEBUG] [rs.internal.protocol.MySensorsReader] - 2;0;2;0;24; 16:24:51.916 [DEBUG] [col.serial.MySensorsSerialConnection] - Bridge is connected, connection skipped 16:24:57.102 [DEBUG] [rs.internal.protocol.MySensorsReader] - 2;0;2;0;24; 16:25:01.917 [DEBUG] [col.serial.MySensorsSerialConnection] - Bridge is connected, connection skipped 16:25:11.919 [DEBUG] [col.serial.MySensorsSerialConnection] - Bridge is connected, connection skipped 16:25:12.145 [DEBUG] [rs.internal.protocol.MySensorsReader] - 2;0;2;0;24; 16:25:21.921 [DEBUG] [col.serial.MySensorsSerialConnection] - Bridge is connected, connection skipped 16:25:22.304 [DEBUG] [rs.internal.protocol.MySensorsReader] - 1;0;1;0;1;47.6Things:
Bridge mysensors:bridge-ser:gateway [ serialPort="/dev/pts/2", sendDelay=200 ] { /** define things connected to that bridge here */ humidity hum01 [ nodeId="1", childId="0" ] temperature temp01 [ nodeId="1", childId="1" ] power power01 [ nodeId="2", childId="0" ] }Items:
Number hum01 "Humidity" <humidity> { channel="mysensors:humidity:gateway:hum01:hum" } Number temp01 "Temperature" <temperature> { channel="mysensors:temperature:gateway:temp01:temp" } Number temp01F "Temperature [%.1f °F]" <temperature> DateTime Sensor01LastUpdate "Last seen [%1$ta %1$tR]" <clock> DateTime Sensor02LastUpdate "Last seen [%1$ta %1$tR]" <clock> Number watt01 "Current Demand [%.0f Watt]" { channel="mysensors:power:gateway:power01:watt" } Number kwh01 "Daily Use [%.1f kWh]" { channel="mysensors:power:gateway:power01:kwh" }What am i doing wrong?
-
OK, I think I got past that, I reinstalled everything and cleaned up my MySensors libraries.There is a chance I was pulling from different version when compiling the different examples from different packages.
But, I noticed this exception at OH2 startup:
06:29:26.838 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:bridge-ser:gateway' changed from UNINITIALIZED to INITIALIZING 06:29:26.924 [DEBUG] [ternal.handler.MySensorsThingHandler] - Configuration: node 1, chiledId: 1, revertState: false 06:29:26.924 [DEBUG] [ternal.handler.MySensorsThingHandler] - Configuration: node 1, chiledId: 0, revertState: false 06:29:26.932 [DEBUG] [ternal.handler.MySensorsThingHandler] - Configuration: node 2, chiledId: 0, revertState: false 06:29:26.951 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:humidity:gateway:hum01' changed from UNINITIALIZED to INITIALIZING 06:29:26.946 [DEBUG] [col.serial.MySensorsSerialConnection] - Set skip check on startup to: false 06:29:26.956 [DEBUG] [col.serial.MySensorsSerialConnection] - Enabling connection watchdog 06:29:26.964 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:temperature:gateway:temp01' changed from UNINITIALIZED to INITIALIZING 06:29:26.969 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:power:gateway:power01' changed from UNINITIALIZED to INITIALIZING 06:29:26.993 [DEBUG] [ternal.factory.MySensorsCacheFactory] - Cache file: given_ids.cached exist. 06:29:27.001 [DEBUG] [col.serial.MySensorsSerialConnection] - Connecting to /dev/pts/3 [baudRate:115200] 06:29:27.032 [DEBUG] [ternal.factory.MySensorsCacheFactory] - Cache (given_ids) content: [] 06:29:27.067 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:bridge-ser:gateway' changed from INITIALIZING to UNINITIALIZED (HANDLER_INITIALIZING_ERROR) 06:29:27.041 [ERROR] [ome.core.thing.internal.ThingManager] - Exception occured while initializing handler of thing 'mysensors:bridge-ser:gateway': java.lang.UnsupportedOperationException java.util.concurrent.ExecutionException: java.lang.UnsupportedOperationException at java.util.concurrent.FutureTask.report(FutureTask.java:122)[:1.8.0_65] at java.util.concurrent.FutureTask.get(FutureTask.java:206)[:1.8.0_65] at org.eclipse.smarthome.core.common.SafeMethodCaller.callAsynchronous(SafeMethodCaller.java:186)[99:org.eclipse.smarthome.core:0.9.0.201610220816] at org.eclipse.smarthome.core.common.SafeMethodCaller.call(SafeMethodCaller.java:79)[99:org.eclipse.smarthome.core:0.9.0.201610220816] at org.eclipse.smarthome.core.common.SafeMethodCaller.call(SafeMethodCaller.java:63)[99:org.eclipse.smarthome.core:0.9.0.201610220816] at org.eclipse.smarthome.core.thing.internal.ThingManager$9.run(ThingManager.java:755)[106:org.eclipse.smarthome.core.thing:0.9.0.201610220816] at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)[:1.8.0_65] at java.util.concurrent.FutureTask.run(FutureTask.java:266)[:1.8.0_65] at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)[:1.8.0_65] at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)[:1.8.0_65] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)[:1.8.0_65] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)[:1.8.0_65] at java.lang.Thread.run(Thread.java:745)[:1.8.0_65] Caused by: java.lang.UnsupportedOperationException at java.util.AbstractList.add(AbstractList.java:148)[:1.8.0_65] at java.util.AbstractList.add(AbstractList.java:108)[:1.8.0_65] at org.openhab.binding.mysensors.internal.handler.MySensorsBridgeHandler.loadCacheFile(MySensorsBridgeHandler.java:176)[10:org.openhab.binding.mysensors:2.0.0.201610021604] at org.openhab.binding.mysensors.internal.handler.MySensorsBridgeHandler.initialize(MySensorsBridgeHandler.java:90)[10:org.openhab.binding.mysensors:2.0.0.201610021604] at org.eclipse.smarthome.core.thing.internal.ThingManager$9$1.call(ThingManager.java:758)[106:org.eclipse.smarthome.core.thing:0.9.0.201610220816] at org.eclipse.smarthome.core.thing.internal.ThingManager$9$1.call(ThingManager.java:1)[106:org.eclipse.smarthome.core.thing:0.9.0.201610220816] at org.eclipse.smarthome.core.common.SafeMethodCaller$CallableWrapper.call(SafeMethodCaller.java:177)[99:org.eclipse.smarthome.core:0.9.0.201610220816] at java.util.concurrent.FutureTask.run(FutureTask.java:266)[:1.8.0_65] ... 3 more 06:29:27.198 [DEBUG] [col.serial.MySensorsSerialConnection] - Final port list: /dev/pts/3 06:29:27.232 [DEBUG] [col.serial.MySensorsSerialConnection] - Successfully connected to serial port. 06:29:27.234 [DEBUG] [col.serial.MySensorsSerialConnection] - Waiting 3 seconds to allow correct reset trigger on serial connection opening 06:29:29.428 [INFO ] [basic.internal.servlet.WebAppServlet] - Started Basic UI at /basicui/app 06:29:29.897 [INFO ] [assic.internal.servlet.WebAppServlet] - Started Classic UI at /classicui/app 06:29:30.262 [DEBUG] [rs.internal.protocol.MySensorsReader] - ;255;3;0;14;Gateway startup complete. 06:29:30.274 [ERROR] [rs.internal.protocol.MySensorsReader] - (java.lang.NumberFormatException: For input string: "") on reading from serial port, message: class org.openhab.binding.mysensors.internal.protocol.serial.MySensorsSerialReader 06:29:30.283 [DEBUG] [rs.internal.protocol.MySensorsReader] - 0;255;0;0;18;2.0.1-betaThings still seem to work, but do I have something wrong?
-
OK, I think I got past that, I reinstalled everything and cleaned up my MySensors libraries.There is a chance I was pulling from different version when compiling the different examples from different packages.
But, I noticed this exception at OH2 startup:
06:29:26.838 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:bridge-ser:gateway' changed from UNINITIALIZED to INITIALIZING 06:29:26.924 [DEBUG] [ternal.handler.MySensorsThingHandler] - Configuration: node 1, chiledId: 1, revertState: false 06:29:26.924 [DEBUG] [ternal.handler.MySensorsThingHandler] - Configuration: node 1, chiledId: 0, revertState: false 06:29:26.932 [DEBUG] [ternal.handler.MySensorsThingHandler] - Configuration: node 2, chiledId: 0, revertState: false 06:29:26.951 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:humidity:gateway:hum01' changed from UNINITIALIZED to INITIALIZING 06:29:26.946 [DEBUG] [col.serial.MySensorsSerialConnection] - Set skip check on startup to: false 06:29:26.956 [DEBUG] [col.serial.MySensorsSerialConnection] - Enabling connection watchdog 06:29:26.964 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:temperature:gateway:temp01' changed from UNINITIALIZED to INITIALIZING 06:29:26.969 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:power:gateway:power01' changed from UNINITIALIZED to INITIALIZING 06:29:26.993 [DEBUG] [ternal.factory.MySensorsCacheFactory] - Cache file: given_ids.cached exist. 06:29:27.001 [DEBUG] [col.serial.MySensorsSerialConnection] - Connecting to /dev/pts/3 [baudRate:115200] 06:29:27.032 [DEBUG] [ternal.factory.MySensorsCacheFactory] - Cache (given_ids) content: [] 06:29:27.067 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:bridge-ser:gateway' changed from INITIALIZING to UNINITIALIZED (HANDLER_INITIALIZING_ERROR) 06:29:27.041 [ERROR] [ome.core.thing.internal.ThingManager] - Exception occured while initializing handler of thing 'mysensors:bridge-ser:gateway': java.lang.UnsupportedOperationException java.util.concurrent.ExecutionException: java.lang.UnsupportedOperationException at java.util.concurrent.FutureTask.report(FutureTask.java:122)[:1.8.0_65] at java.util.concurrent.FutureTask.get(FutureTask.java:206)[:1.8.0_65] at org.eclipse.smarthome.core.common.SafeMethodCaller.callAsynchronous(SafeMethodCaller.java:186)[99:org.eclipse.smarthome.core:0.9.0.201610220816] at org.eclipse.smarthome.core.common.SafeMethodCaller.call(SafeMethodCaller.java:79)[99:org.eclipse.smarthome.core:0.9.0.201610220816] at org.eclipse.smarthome.core.common.SafeMethodCaller.call(SafeMethodCaller.java:63)[99:org.eclipse.smarthome.core:0.9.0.201610220816] at org.eclipse.smarthome.core.thing.internal.ThingManager$9.run(ThingManager.java:755)[106:org.eclipse.smarthome.core.thing:0.9.0.201610220816] at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)[:1.8.0_65] at java.util.concurrent.FutureTask.run(FutureTask.java:266)[:1.8.0_65] at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)[:1.8.0_65] at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)[:1.8.0_65] at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)[:1.8.0_65] at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)[:1.8.0_65] at java.lang.Thread.run(Thread.java:745)[:1.8.0_65] Caused by: java.lang.UnsupportedOperationException at java.util.AbstractList.add(AbstractList.java:148)[:1.8.0_65] at java.util.AbstractList.add(AbstractList.java:108)[:1.8.0_65] at org.openhab.binding.mysensors.internal.handler.MySensorsBridgeHandler.loadCacheFile(MySensorsBridgeHandler.java:176)[10:org.openhab.binding.mysensors:2.0.0.201610021604] at org.openhab.binding.mysensors.internal.handler.MySensorsBridgeHandler.initialize(MySensorsBridgeHandler.java:90)[10:org.openhab.binding.mysensors:2.0.0.201610021604] at org.eclipse.smarthome.core.thing.internal.ThingManager$9$1.call(ThingManager.java:758)[106:org.eclipse.smarthome.core.thing:0.9.0.201610220816] at org.eclipse.smarthome.core.thing.internal.ThingManager$9$1.call(ThingManager.java:1)[106:org.eclipse.smarthome.core.thing:0.9.0.201610220816] at org.eclipse.smarthome.core.common.SafeMethodCaller$CallableWrapper.call(SafeMethodCaller.java:177)[99:org.eclipse.smarthome.core:0.9.0.201610220816] at java.util.concurrent.FutureTask.run(FutureTask.java:266)[:1.8.0_65] ... 3 more 06:29:27.198 [DEBUG] [col.serial.MySensorsSerialConnection] - Final port list: /dev/pts/3 06:29:27.232 [DEBUG] [col.serial.MySensorsSerialConnection] - Successfully connected to serial port. 06:29:27.234 [DEBUG] [col.serial.MySensorsSerialConnection] - Waiting 3 seconds to allow correct reset trigger on serial connection opening 06:29:29.428 [INFO ] [basic.internal.servlet.WebAppServlet] - Started Basic UI at /basicui/app 06:29:29.897 [INFO ] [assic.internal.servlet.WebAppServlet] - Started Classic UI at /classicui/app 06:29:30.262 [DEBUG] [rs.internal.protocol.MySensorsReader] - ;255;3;0;14;Gateway startup complete. 06:29:30.274 [ERROR] [rs.internal.protocol.MySensorsReader] - (java.lang.NumberFormatException: For input string: "") on reading from serial port, message: class org.openhab.binding.mysensors.internal.protocol.serial.MySensorsSerialReader 06:29:30.283 [DEBUG] [rs.internal.protocol.MySensorsReader] - 0;255;0;0;18;2.0.1-betaThings still seem to work, but do I have something wrong?
Hi @carlyler :)
what version of JVM are you using? 1.7 or 1.8?
-
Hi @carlyler :)
what version of JVM are you using? 1.7 or 1.8?
@andreacioni after reading this thread I realized you have done a lot of work here as well, thank you.
I am running:
pi@raspberrypi:~ $ java -version
java version "1.8.0_65"
Java(TM) SE Runtime Environment (build 1.8.0_65-b17)
Java HotSpot(TM) Client VM (build 25.65-b01, mixed mode)
pi@raspberrypi:~ $ -
Hello community,
i have a small problem with openhab2 (on a orange pi with armbian - similar to raspberry) and mysensors Serial Gateway.
I installed openhab2 with the get methode and it works fine. I was able, to start it with openhab2.service (also automated) and openhab2 worked as it should. But if i want to connect the mysensors serial gateway to the orange pi with openhab2, openhab2 can't find my gateway. The log says "openhab is unable to connect to serial port, wrong serial port?"
But my serial port is ok.
If i stop openhab2.service and manual start openhab2, than all is fine, it can connect to serial gateway immediately and work fine. I don't know, why it can't work if openhab2 starts as service. Can you help me in this case?Thank you.
And sorry for my english, it's not my first language
-
Hello community,
i have a small problem with openhab2 (on a orange pi with armbian - similar to raspberry) and mysensors Serial Gateway.
I installed openhab2 with the get methode and it works fine. I was able, to start it with openhab2.service (also automated) and openhab2 worked as it should. But if i want to connect the mysensors serial gateway to the orange pi with openhab2, openhab2 can't find my gateway. The log says "openhab is unable to connect to serial port, wrong serial port?"
But my serial port is ok.
If i stop openhab2.service and manual start openhab2, than all is fine, it can connect to serial gateway immediately and work fine. I don't know, why it can't work if openhab2 starts as service. Can you help me in this case?Thank you.
And sorry for my english, it's not my first language
@hausinger Sounds like a problem with the permissions. The openhab2 service is running as user and group openhab and this user needs permission to the serial port (dialout).
sudo usermod -a -G dialout openhab -
Hi all
I have a problem when my raspberry pi and mysensors/openhab when i do a restart. The problems seems to be ralated to the serial gateway and that the openhab dont find it or has the wrong settings.Openhab starts when i make a reboot
I checked the serial by typing
stty -F /dev/ttyUSB0
response was

Seems here that the baudrate is wrong as my settings in the things file is

What i did to make it work was just to change this to use baud 9600 and then back to baud = 115200
after this it looked like

And everything started to work nicely
Does anyone now what the cause of this is and also how to fix it?
-
I have 2 simpel questions.
- What is the status of the PR for mysensors to get inside openhab native?
- What type of sensor do i need to use for a relay?
-
Sadly there is no progress at all: https://github.com/openhab/openhab2-addons/pull/1243 Till now nobody found the time to look into the PR.
-
Use "Light" for a Relay. If you discover the device via PaperUI it will be represented as a "Light" (Switch).
-
-
Sadly there is no progress at all: https://github.com/openhab/openhab2-addons/pull/1243 Till now nobody found the time to look into the PR.
-
Use "Light" for a Relay. If you discover the device via PaperUI it will be represented as a "Light" (Switch).
-
-
-
Sadly there is no progress at all: https://github.com/openhab/openhab2-addons/pull/1243 Till now nobody found the time to look into the PR.
-
Use "Light" for a Relay. If you discover the device via PaperUI it will be represented as a "Light" (Switch).
@blacey said:
I took a quick look at your pull request (personal curiosity) and noticed that one of your committed files includes a merge conflict
Hey @blacey, thank you for peeking in. :D
I haven't touched the PR for a long time, but it will be necessary soon because there were a lot changes in the development branch. I will fix that too! -
-
@blacey said:
I took a quick look at your pull request (personal curiosity) and noticed that one of your committed files includes a merge conflict
Hey @blacey, thank you for peeking in. :D
I haven't touched the PR for a long time, but it will be necessary soon because there were a lot changes in the development branch. I will fix that too!@TimO Nice! While I have been a longtime Vera user, I think my next move will be OpenHab. I sponsored the Pine64 project on KickStarter and have one sitting on my project desk ready for some prototyping. I think it is great that you are making MySensors a first-class OpenHab 2.0 citizen. Hopefully Kai or one of the OpenHab contributors will merge your binding into the distro.
-
@TimO It seems the binding does not support autoupdate="false" yet. Can you confirm this and do you consider adding this option? I could use the MQTT binding to get what I want (for example feedback of rollershutter position while moving based on the value sent by the sensor and not based on the command sent via the UI), but I don't want to move away from the MySensors binding.
-
Hi All
Big thumb up to all those who made it possible, awsome job here
Truely amazing for us diyers to have access to that technology so easily. Thanks a lotBUT! I have a problem with binding... in short :
1- I installed openhab2 on RPi3 with a fresh SDCard
2-Updated java (as per https://community.openhab.org/t/my-openhab-connectio-failed/12957/11)
3- I followed tobof 's excellent step-by-step howto
4- I installed mysGateway (RPi acting as controller AND gateway)
5- Withpi@raspberrypi:~/MySensors $ sudo ./examples_linux/mysGateway -di can see that my motion sensor and my RPi gateway get on wellmysGateway: Starting gateway... mysGateway: Protocol version - 2.0.1-beta mysGateway: MCO:BGN:INIT GW,CP=RNNG---,VER=2.0.1-beta mysGateway: TSF:LRT:OK mysGateway: TSM:INIT mysGateway: TSM:INIT:TSP OK mysGateway: TSM:INIT:GW MODE mysGateway: TSM:READY mysGateway: MCO:REG:NOT NEEDED mysGateway: MCO:BGN:STP mysGateway: MCO:BGN:INIT OK,ID=0,PAR=0,DIS=0,REG=1 mysGateway: TSF:MSG:READ,1-1-0,s=1,c=1,t=16,pt=0,l=1,sg=0:1 mysGateway: TSF:MSG:READ,1-1-0,s=1,c=1,t=16,pt=0,l=1,sg=0:0 mysGateway: TSF:MSG:READ,1-1-0,s=1,c=1,t=16,pt=0,l=1,sg=0:1 mysGateway: TSF:MSG:READ,1-1-0,s=1,c=1,t=16,pt=0,l=1,sg=0:06- created a thing (text editor) for the bridge
pi@raspberrypi:/usr/share/openhab2/conf/things $ nano home.thingsBridge mysensors:bridge-ser:gateway [ serialPort="/dev/pts/2", sendDelay=200 ] { }7- Following openhab2 "live" log with
pi@raspberrypi:/usr/share/openhab2 $ sudo ./start_debug.sh05:37:32.536 [DEBUG] [org.openhab.binding.mysensors ] - BundleEvent STARTING - org.openhab.binding.mysensors 05:37:32.561 [DEBUG] [org.openhab.binding.mysensors ] - BundleEvent STARTED - org.openhab.binding.mysensors 05:37:32.789 [DEBUG] [org.openhab.binding.mysensors ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.thing.binding.ThingHandlerFactory}={component.name=org.openhab.binding.mysensors.internal.MySensorsHandlerFactory, component.id=0, service.id=110, service.bundleid=10, service.scope=bundle} - org.openhab.binding.mysensors 05:37:50.539 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'home.items' 05:37:58.611 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'home.sitemap' 05:37:59.319 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'home.things' 05:37:59.664 [INFO ] [smarthome.event.ThingAddedEvent ] - Thing 'mysensors:bridge-ser:gateway' has been added. 05:38:00.412 [DEBUG] [org.openhab.binding.mysensors ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.discovery.DiscoveryService}={service.id=232, service.bundleid=10, service.scope=singleton} - org.openhab.binding.mysensors 05:38:00.435 [DEBUG] [org.openhab.binding.mysensors ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.thing.binding.ThingHandler}={thing.type=mysensors:bridge-ser, thing.id=mysensors:bridge-ser:gateway, service.id=233, service.bundleid=10, service.scope=singleton} - org.openhab.binding.mysensors 05:38:00.473 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:bridge-ser:gateway' changed from UNINITIALIZED to INITIALIZING 05:38:00.474 [DEBUG] [nsors.handler.MySensorsBridgeHandler] - Initialization of the MySensors Bridge 05:38:00.594 [INFO ] [home.event.ItemChannelLinkAddedEvent] - Link 'MotionTest-mysensors:motion:1584d6773a3:armed' has been added. 05:38:00.605 [INFO ] [home.event.ItemChannelLinkAddedEvent] - Link 'MotionTest-mysensors:motion:1584d6773a3:tripped' has been added. RXTX Warning: Removing stale lock file. /var/lock/LCK..ttyAMA0 05:38:00.658 [DEBUG] [col.serial.MySensorsSerialConnection] - Successfully connected to serial port. 05:38:00.677 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:bridge-ser:gateway' changed from INITIALIZING to ONLINE 05:38:05.333 [INFO ] [basic.internal.servlet.WebAppServlet] - Started Basic UI at /basicui/app 05:38:06.180 [INFO ] [assic.internal.servlet.WebAppServlet] - Started Classic UI at /classicui/app 05:38:08.009 [INFO ] [arthome.ui.paper.internal.PaperUIApp] - Started Paper UI at /ui 05:38:08.223 [INFO ] [.dashboard.internal.DashboardService] - Started dashboard at /start 05:38:08.951 [INFO ] [ui.habmin.internal.servlet.HABminApp] - Started HABmin servlet at /habmin 05:38:09.203 [INFO ] [panel.internal.HABPanelDashboardTile] - Started HABPanel at /habpanel 05:38:11.343 [INFO ] [o.myopenhab.internal.MyOpenHABClient] - Connected to my.openHAB service (UUID = 7c0faa03-e826-473a-b1f7-8b685b487bb8, base URL = http://localhost:8080)Looks pretty to me...
8- but then i try to register my sensor (arduino pro and 501PIR sensor) with paper UI
No luck. Discovery window stays on forever!
0_1479359161452_Scan.jpegsudo usermod -a -G dialout openhabreturns "unknown user" ...Any clue ?
Thanks a lot for your help ! -
Binding is still unsuccessful
Following error disapeared (Updated my previous post).
Guess that happened as RPi started reboot before openhab session was properly closed... 3 reboots cured that error...in
pi@raspberrypi:/usr/share/openhab2/userdata/logs $ nano openhab.log:2016-11-17 06:40:00.094 [DEBUG] [org.openhab.binding.mysensors ] - BundleEvent STARTING - org.openhab.binding.mysensors 2016-11-17 06:40:00.383 [DEBUG] [org.openhab.binding.mysensors ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.thing.binding.ThingHandlerFactory}={component.name=org.openhab.bindin$ 2016-11-17 06:40:00.480 [DEBUG] [org.openhab.binding.mysensors ] - BundleEvent STARTED - org.openhab.binding.mysensors 2016-11-17 06:40:11.249 [WARN ] [eclipse.jetty.servlet.ServletHandler] - javax.servlet.ServletException: A MultiException has 1 exceptions. They are: 1. java.lang.IllegalStateException: ServiceLocatorImpl(__HK2_Generated_0,0,33431755) has been shut down at org.glassfish.jersey.servlet.WebComponent.serviceImpl(WebComponent.java:489)[156:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2] at org.glassfish.jersey.servlet.WebComponent.service(WebComponent.java:427)[156:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2] at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:388)[156:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2] at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:341)[156:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2] at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:228)[156:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2] at com.eclipsesource.jaxrs.publisher.internal.ServletContainerBridge.service(ServletContainerBridge.java:76)[12:com.eclipsesource.jaxrs.publisher:5.3.1.201602281253] at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:812)[82:org.eclipse.jetty.servlet:9.2.14.v20151106] at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:587)[82:org.eclipse.jetty.servlet:9.2.14.v20151106] at org.ops4j.pax.web.service.jetty.internal.HttpServiceServletHandler.doHandle(HttpServiceServletHandler.java:70)[173:org.ops4j.pax.web.pax-web-jetty:4.2.4] at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:577)[80:org.eclipse.jetty.security:9.2.14.v20151106] at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:223)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1127)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.ops4j.pax.web.service.jetty.internal.HttpServiceContext.doHandle(HttpServiceContext.java:271)[173:org.ops4j.pax.web.pax-web-jetty:4.2.4] at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:515)[82:org.eclipse.jetty.servlet:9.2.14.v20151106] at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1061)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.ops4j.pax.web.service.jetty.internal.JettyServerHandlerCollection.handle(JettyServerHandlerCollection.java:80)[173:org.ops4j.pax.web.pax-web-jetty:4.2.4] at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.server.Server.handle(Server.java:499)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:311)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:257)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:544)[73:org.eclipse.jetty.io:9.2.14.v20151106] at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)[84:org.eclipse.jetty.util:9.2.14.v20151106] at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)[84:org.eclipse.jetty.util:9.2.14.v20151106] at java.lang.Thread.run(Thread.java:745)[:1.8.0_111] Caused by: A MultiException has 1 exceptions. They are: 1. java.lang.IllegalStateException: ServiceLocatorImpl(__HK2_Generated_0,0,33431755) has been shut down at org.jvnet.hk2.internal.FactoryCreator.getFactoryHandle(FactoryCreator.java:106)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.jvnet.hk2.internal.FactoryCreator.dispose(FactoryCreator.java:173)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.jvnet.hk2.internal.SystemDescriptor.dispose(SystemDescriptor.java:526)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.glassfish.jersey.process.internal.RequestScope$Instance.remove(RequestScope.java:532)[158:org.glassfish.jersey.core.jersey-common:2.22.2] at org.glassfish.jersey.process.internal.RequestScope$Instance.release(RequestScope.java:549)[158:org.glassfish.jersey.core.jersey-common:2.22.2] at org.glassfish.jersey.process.internal.RequestScope.runInScope(RequestScope.java:319)[158:org.glassfish.jersey.core.jersey-common:2.22.2] at org.glassfish.jersey.server.ServerRuntime.process(ServerRuntime.java:305)[159:org.glassfish.jersey.core.jersey-server:2.22.2] at org.glassfish.jersey.server.ApplicationHandler.handle(ApplicationHandler.java:1154)[159:org.glassfish.jersey.core.jersey-server:2.22.2] at org.glassfish.jersey.servlet.WebComponent.serviceImpl(WebComponent.java:473)[156:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2] ... 26 more Caused by: java.lang.IllegalStateException: ServiceLocatorImpl(__HK2_Generated_0,0,33431755) has been shut down at org.jvnet.hk2.internal.ServiceLocatorImpl.checkState(ServiceLocatorImpl.java:2288)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.jvnet.hk2.internal.ServiceLocatorImpl.getServiceHandleImpl(ServiceLocatorImpl.java:629)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.jvnet.hk2.internal.ServiceLocatorImpl.getServiceHandle(ServiceLocatorImpl.java:622)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.jvnet.hk2.internal.ServiceLocatorImpl.getServiceHandle(ServiceLocatorImpl.java:640)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.jvnet.hk2.internal.FactoryCreator.getFactoryHandle(FactoryCreator.java:103)[151:org.glassfish.hk2.locator:2.4.0.b34] ... 34 more 2016-11-17 06:40:11.296 [WARN ] [org.eclipse.jetty.server.HttpChannel] - /rest/events javax.servlet.ServletException: javax.servlet.ServletException: A MultiException has 1 exceptions. They are: 1. java.lang.IllegalStateException: ServiceLocatorImpl(__HK2_Generated_0,0,33431755) has been shut down at org.ops4j.pax.web.service.jetty.internal.JettyServerHandlerCollection.handle(JettyServerHandlerCollection.java:88)[173:org.ops4j.pax.web.pax-web-jetty:4.2.4] at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.server.Server.handle(Server.java:499)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:311)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:257)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:544)[73:org.eclipse.jetty.io:9.2.14.v20151106] at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)[84:org.eclipse.jetty.util:9.2.14.v20151106] at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)[84:org.eclipse.jetty.util:9.2.14.v20151106] at java.lang.Thread.run(Thread.java:745)[:1.8.0_111] Caused by: javax.servlet.ServletException: A MultiException has 1 exceptions. They are: 1. java.lang.IllegalStateException: ServiceLocatorImpl(__HK2_Generated_0,0,33431755) has been shut down at org.glassfish.jersey.servlet.WebComponent.serviceImpl(WebComponent.java:489)[156:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2] at org.glassfish.jersey.servlet.WebComponent.service(WebComponent.java:427)[156:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2] at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:388)[156:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2] at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:341)[156:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2] at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:228)[156:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2] at com.eclipsesource.jaxrs.publisher.internal.ServletContainerBridge.service(ServletContainerBridge.java:76)[12:com.eclipsesource.jaxrs.publisher:5.3.1.201602281253] at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:812)[82:org.eclipse.jetty.servlet:9.2.14.v20151106] at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:587)[82:org.eclipse.jetty.servlet:9.2.14.v20151106] at org.ops4j.pax.web.service.jetty.internal.HttpServiceServletHandler.doHandle(HttpServiceServletHandler.java:70)[173:org.ops4j.pax.web.pax-web-jetty:4.2.4] at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:577)[80:org.eclipse.jetty.security:9.2.14.v20151106] at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:223)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1127)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.ops4j.pax.web.service.jetty.internal.HttpServiceContext.doHandle(HttpServiceContext.java:271)[173:org.ops4j.pax.web.pax-web-jetty:4.2.4] at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:515)[82:org.eclipse.jetty.servlet:9.2.14.v20151106] at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1061)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.ops4j.pax.web.service.jetty.internal.JettyServerHandlerCollection.handle(JettyServerHandlerCollection.java:80)[173:org.ops4j.pax.web.pax-web-jetty:4.2.4] ... 8 more Caused by: A MultiException has 1 exceptions. They are: 1. java.lang.IllegalStateException: ServiceLocatorImpl(__HK2_Generated_0,0,33431755) has been shut down at org.jvnet.hk2.internal.FactoryCreator.getFactoryHandle(FactoryCreator.java:106)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.jvnet.hk2.internal.FactoryCreator.dispose(FactoryCreator.java:173)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.jvnet.hk2.internal.SystemDescriptor.dispose(SystemDescriptor.java:526)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.glassfish.jersey.process.internal.RequestScope$Instance.remove(RequestScope.java:532)[158:org.glassfish.jersey.core.jersey-common:2.22.2] at org.glassfish.jersey.process.internal.RequestScope$Instance.release(RequestScope.java:549)[158:org.glassfish.jersey.core.jersey-common:2.22.2] at org.glassfish.jersey.process.internal.RequestScope.runInScope(RequestScope.java:319)[158:org.glassfish.jersey.core.jersey-common:2.22.2] at org.glassfish.jersey.process.internal.RequestScope.runInScope(RequestScope.java:319)[158:org.glassfish.jersey.core.jersey-common:2.22.2] at org.glassfish.jersey.server.ServerRuntime.process(ServerRuntime.java:305)[159:org.glassfish.jersey.core.jersey-server:2.22.2] at org.glassfish.jersey.server.ApplicationHandler.handle(ApplicationHandler.java:1154)[159:org.glassfish.jersey.core.jersey-server:2.22.2] at org.glassfish.jersey.servlet.WebComponent.serviceImpl(WebComponent.java:473)[156:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2] ... 26 more Caused by: java.lang.IllegalStateException: ServiceLocatorImpl(__HK2_Generated_0,0,33431755) has been shut down at org.jvnet.hk2.internal.ServiceLocatorImpl.checkState(ServiceLocatorImpl.java:2288)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.jvnet.hk2.internal.ServiceLocatorImpl.getServiceHandleImpl(ServiceLocatorImpl.java:629)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.jvnet.hk2.internal.ServiceLocatorImpl.getServiceHandle(ServiceLocatorImpl.java:622)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.jvnet.hk2.internal.ServiceLocatorImpl.getServiceHandle(ServiceLocatorImpl.java:640)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.jvnet.hk2.internal.FactoryCreator.getFactoryHandle(FactoryCreator.java:103)[151:org.glassfish.hk2.locator:2.4.0.b34] ... 34 more 2016-11-17 06:40:11.330 [WARN ] [org.eclipse.jetty.server.HttpChannel] - Could not send response error 500: javax.servlet.ServletException: javax.servlet.ServletException: A MultiException has 1 e$ 1. java.lang.IllegalStateException: ServiceLocatorImpl(__HK2_Generated_0,0,33431755) has been shut down 2016-11-17 06:40:20.925 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'home.items' 2016-11-17 06:40:28.127 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'home.sitemap' 2016-11-17 06:40:29.101 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'home.things' 2016-11-17 06:40:30.364 [DEBUG] [org.openhab.binding.mysensors ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.discovery.DiscoveryService}={service.id=235, service.bundleid=10, s$ 2016-11-17 06:40:30.385 [DEBUG] [org.openhab.binding.mysensors ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.thing.binding.ThingHandler}={thing.type=mysensors:bridge-ser, thing.i$ 2016-11-17 06:40:30.435 [DEBUG] [nsors.handler.MySensorsBridgeHandler] - Initialization of the MySensors Bridge 2016-11-17 06:40:30.654 [DEBUG] [col.serial.MySensorsSerialConnection] - Successfully connected to serial port. 2016-11-17 06:40:36.145 [INFO ] [basic.internal.servlet.WebAppServlet] - Started Basic UI at /basicui/app 2016-11-17 06:40:38.163 [INFO ] [assic.internal.servlet.WebAppServlet] - Started Classic UI at /classicui/app 2016-11-17 06:40:38.712 [INFO ] [arthome.ui.paper.internal.PaperUIApp] - Started Paper UI at /ui 2016-11-17 06:40:39.160 [INFO ] [.dashboard.internal.DashboardService] - Started dashboard at /start 2016-11-17 06:40:39.955 [INFO ] [ui.habmin.internal.servlet.HABminApp] - Started HABmin servlet at /habmin 2016-11-17 06:40:40.396 [INFO ] [panel.internal.HABPanelDashboardTile] - Started HABPanel at /habpanel 2016-11-17 06:40:42.527 [INFO ] [o.myopenhab.internal.MyOpenHABClient] - Connected to my.openHAB service (UUID = 7c0faa03-e826-473a-b1f7-8b685b487bb8, base URL = http://localhost:8080) -
Binding is still unsuccessful
Following error disapeared (Updated my previous post).
Guess that happened as RPi started reboot before openhab session was properly closed... 3 reboots cured that error...in
pi@raspberrypi:/usr/share/openhab2/userdata/logs $ nano openhab.log:2016-11-17 06:40:00.094 [DEBUG] [org.openhab.binding.mysensors ] - BundleEvent STARTING - org.openhab.binding.mysensors 2016-11-17 06:40:00.383 [DEBUG] [org.openhab.binding.mysensors ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.thing.binding.ThingHandlerFactory}={component.name=org.openhab.bindin$ 2016-11-17 06:40:00.480 [DEBUG] [org.openhab.binding.mysensors ] - BundleEvent STARTED - org.openhab.binding.mysensors 2016-11-17 06:40:11.249 [WARN ] [eclipse.jetty.servlet.ServletHandler] - javax.servlet.ServletException: A MultiException has 1 exceptions. They are: 1. java.lang.IllegalStateException: ServiceLocatorImpl(__HK2_Generated_0,0,33431755) has been shut down at org.glassfish.jersey.servlet.WebComponent.serviceImpl(WebComponent.java:489)[156:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2] at org.glassfish.jersey.servlet.WebComponent.service(WebComponent.java:427)[156:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2] at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:388)[156:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2] at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:341)[156:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2] at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:228)[156:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2] at com.eclipsesource.jaxrs.publisher.internal.ServletContainerBridge.service(ServletContainerBridge.java:76)[12:com.eclipsesource.jaxrs.publisher:5.3.1.201602281253] at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:812)[82:org.eclipse.jetty.servlet:9.2.14.v20151106] at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:587)[82:org.eclipse.jetty.servlet:9.2.14.v20151106] at org.ops4j.pax.web.service.jetty.internal.HttpServiceServletHandler.doHandle(HttpServiceServletHandler.java:70)[173:org.ops4j.pax.web.pax-web-jetty:4.2.4] at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:577)[80:org.eclipse.jetty.security:9.2.14.v20151106] at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:223)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1127)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.ops4j.pax.web.service.jetty.internal.HttpServiceContext.doHandle(HttpServiceContext.java:271)[173:org.ops4j.pax.web.pax-web-jetty:4.2.4] at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:515)[82:org.eclipse.jetty.servlet:9.2.14.v20151106] at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1061)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.ops4j.pax.web.service.jetty.internal.JettyServerHandlerCollection.handle(JettyServerHandlerCollection.java:80)[173:org.ops4j.pax.web.pax-web-jetty:4.2.4] at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.server.Server.handle(Server.java:499)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:311)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:257)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:544)[73:org.eclipse.jetty.io:9.2.14.v20151106] at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)[84:org.eclipse.jetty.util:9.2.14.v20151106] at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)[84:org.eclipse.jetty.util:9.2.14.v20151106] at java.lang.Thread.run(Thread.java:745)[:1.8.0_111] Caused by: A MultiException has 1 exceptions. They are: 1. java.lang.IllegalStateException: ServiceLocatorImpl(__HK2_Generated_0,0,33431755) has been shut down at org.jvnet.hk2.internal.FactoryCreator.getFactoryHandle(FactoryCreator.java:106)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.jvnet.hk2.internal.FactoryCreator.dispose(FactoryCreator.java:173)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.jvnet.hk2.internal.SystemDescriptor.dispose(SystemDescriptor.java:526)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.glassfish.jersey.process.internal.RequestScope$Instance.remove(RequestScope.java:532)[158:org.glassfish.jersey.core.jersey-common:2.22.2] at org.glassfish.jersey.process.internal.RequestScope$Instance.release(RequestScope.java:549)[158:org.glassfish.jersey.core.jersey-common:2.22.2] at org.glassfish.jersey.process.internal.RequestScope.runInScope(RequestScope.java:319)[158:org.glassfish.jersey.core.jersey-common:2.22.2] at org.glassfish.jersey.server.ServerRuntime.process(ServerRuntime.java:305)[159:org.glassfish.jersey.core.jersey-server:2.22.2] at org.glassfish.jersey.server.ApplicationHandler.handle(ApplicationHandler.java:1154)[159:org.glassfish.jersey.core.jersey-server:2.22.2] at org.glassfish.jersey.servlet.WebComponent.serviceImpl(WebComponent.java:473)[156:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2] ... 26 more Caused by: java.lang.IllegalStateException: ServiceLocatorImpl(__HK2_Generated_0,0,33431755) has been shut down at org.jvnet.hk2.internal.ServiceLocatorImpl.checkState(ServiceLocatorImpl.java:2288)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.jvnet.hk2.internal.ServiceLocatorImpl.getServiceHandleImpl(ServiceLocatorImpl.java:629)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.jvnet.hk2.internal.ServiceLocatorImpl.getServiceHandle(ServiceLocatorImpl.java:622)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.jvnet.hk2.internal.ServiceLocatorImpl.getServiceHandle(ServiceLocatorImpl.java:640)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.jvnet.hk2.internal.FactoryCreator.getFactoryHandle(FactoryCreator.java:103)[151:org.glassfish.hk2.locator:2.4.0.b34] ... 34 more 2016-11-17 06:40:11.296 [WARN ] [org.eclipse.jetty.server.HttpChannel] - /rest/events javax.servlet.ServletException: javax.servlet.ServletException: A MultiException has 1 exceptions. They are: 1. java.lang.IllegalStateException: ServiceLocatorImpl(__HK2_Generated_0,0,33431755) has been shut down at org.ops4j.pax.web.service.jetty.internal.JettyServerHandlerCollection.handle(JettyServerHandlerCollection.java:88)[173:org.ops4j.pax.web.pax-web-jetty:4.2.4] at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:97)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.server.Server.handle(Server.java:499)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:311)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:257)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.io.AbstractConnection$2.run(AbstractConnection.java:544)[73:org.eclipse.jetty.io:9.2.14.v20151106] at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:635)[84:org.eclipse.jetty.util:9.2.14.v20151106] at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:555)[84:org.eclipse.jetty.util:9.2.14.v20151106] at java.lang.Thread.run(Thread.java:745)[:1.8.0_111] Caused by: javax.servlet.ServletException: A MultiException has 1 exceptions. They are: 1. java.lang.IllegalStateException: ServiceLocatorImpl(__HK2_Generated_0,0,33431755) has been shut down at org.glassfish.jersey.servlet.WebComponent.serviceImpl(WebComponent.java:489)[156:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2] at org.glassfish.jersey.servlet.WebComponent.service(WebComponent.java:427)[156:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2] at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:388)[156:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2] at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:341)[156:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2] at org.glassfish.jersey.servlet.ServletContainer.service(ServletContainer.java:228)[156:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2] at com.eclipsesource.jaxrs.publisher.internal.ServletContainerBridge.service(ServletContainerBridge.java:76)[12:com.eclipsesource.jaxrs.publisher:5.3.1.201602281253] at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:812)[82:org.eclipse.jetty.servlet:9.2.14.v20151106] at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:587)[82:org.eclipse.jetty.servlet:9.2.14.v20151106] at org.ops4j.pax.web.service.jetty.internal.HttpServiceServletHandler.doHandle(HttpServiceServletHandler.java:70)[173:org.ops4j.pax.web.pax-web-jetty:4.2.4] at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:577)[80:org.eclipse.jetty.security:9.2.14.v20151106] at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:223)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1127)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.ops4j.pax.web.service.jetty.internal.HttpServiceContext.doHandle(HttpServiceContext.java:271)[173:org.ops4j.pax.web.pax-web-jetty:4.2.4] at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:515)[82:org.eclipse.jetty.servlet:9.2.14.v20151106] at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1061)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)[81:org.eclipse.jetty.server:9.2.14.v20151106] at org.ops4j.pax.web.service.jetty.internal.JettyServerHandlerCollection.handle(JettyServerHandlerCollection.java:80)[173:org.ops4j.pax.web.pax-web-jetty:4.2.4] ... 8 more Caused by: A MultiException has 1 exceptions. They are: 1. java.lang.IllegalStateException: ServiceLocatorImpl(__HK2_Generated_0,0,33431755) has been shut down at org.jvnet.hk2.internal.FactoryCreator.getFactoryHandle(FactoryCreator.java:106)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.jvnet.hk2.internal.FactoryCreator.dispose(FactoryCreator.java:173)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.jvnet.hk2.internal.SystemDescriptor.dispose(SystemDescriptor.java:526)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.glassfish.jersey.process.internal.RequestScope$Instance.remove(RequestScope.java:532)[158:org.glassfish.jersey.core.jersey-common:2.22.2] at org.glassfish.jersey.process.internal.RequestScope$Instance.release(RequestScope.java:549)[158:org.glassfish.jersey.core.jersey-common:2.22.2] at org.glassfish.jersey.process.internal.RequestScope.runInScope(RequestScope.java:319)[158:org.glassfish.jersey.core.jersey-common:2.22.2] at org.glassfish.jersey.process.internal.RequestScope.runInScope(RequestScope.java:319)[158:org.glassfish.jersey.core.jersey-common:2.22.2] at org.glassfish.jersey.server.ServerRuntime.process(ServerRuntime.java:305)[159:org.glassfish.jersey.core.jersey-server:2.22.2] at org.glassfish.jersey.server.ApplicationHandler.handle(ApplicationHandler.java:1154)[159:org.glassfish.jersey.core.jersey-server:2.22.2] at org.glassfish.jersey.servlet.WebComponent.serviceImpl(WebComponent.java:473)[156:org.glassfish.jersey.containers.jersey-container-servlet-core:2.22.2] ... 26 more Caused by: java.lang.IllegalStateException: ServiceLocatorImpl(__HK2_Generated_0,0,33431755) has been shut down at org.jvnet.hk2.internal.ServiceLocatorImpl.checkState(ServiceLocatorImpl.java:2288)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.jvnet.hk2.internal.ServiceLocatorImpl.getServiceHandleImpl(ServiceLocatorImpl.java:629)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.jvnet.hk2.internal.ServiceLocatorImpl.getServiceHandle(ServiceLocatorImpl.java:622)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.jvnet.hk2.internal.ServiceLocatorImpl.getServiceHandle(ServiceLocatorImpl.java:640)[151:org.glassfish.hk2.locator:2.4.0.b34] at org.jvnet.hk2.internal.FactoryCreator.getFactoryHandle(FactoryCreator.java:103)[151:org.glassfish.hk2.locator:2.4.0.b34] ... 34 more 2016-11-17 06:40:11.330 [WARN ] [org.eclipse.jetty.server.HttpChannel] - Could not send response error 500: javax.servlet.ServletException: javax.servlet.ServletException: A MultiException has 1 e$ 1. java.lang.IllegalStateException: ServiceLocatorImpl(__HK2_Generated_0,0,33431755) has been shut down 2016-11-17 06:40:20.925 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'home.items' 2016-11-17 06:40:28.127 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'home.sitemap' 2016-11-17 06:40:29.101 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'home.things' 2016-11-17 06:40:30.364 [DEBUG] [org.openhab.binding.mysensors ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.discovery.DiscoveryService}={service.id=235, service.bundleid=10, s$ 2016-11-17 06:40:30.385 [DEBUG] [org.openhab.binding.mysensors ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.thing.binding.ThingHandler}={thing.type=mysensors:bridge-ser, thing.i$ 2016-11-17 06:40:30.435 [DEBUG] [nsors.handler.MySensorsBridgeHandler] - Initialization of the MySensors Bridge 2016-11-17 06:40:30.654 [DEBUG] [col.serial.MySensorsSerialConnection] - Successfully connected to serial port. 2016-11-17 06:40:36.145 [INFO ] [basic.internal.servlet.WebAppServlet] - Started Basic UI at /basicui/app 2016-11-17 06:40:38.163 [INFO ] [assic.internal.servlet.WebAppServlet] - Started Classic UI at /classicui/app 2016-11-17 06:40:38.712 [INFO ] [arthome.ui.paper.internal.PaperUIApp] - Started Paper UI at /ui 2016-11-17 06:40:39.160 [INFO ] [.dashboard.internal.DashboardService] - Started dashboard at /start 2016-11-17 06:40:39.955 [INFO ] [ui.habmin.internal.servlet.HABminApp] - Started HABmin servlet at /habmin 2016-11-17 06:40:40.396 [INFO ] [panel.internal.HABPanelDashboardTile] - Started HABPanel at /habpanel 2016-11-17 06:40:42.527 [INFO ] [o.myopenhab.internal.MyOpenHABClient] - Connected to my.openHAB service (UUID = 7c0faa03-e826-473a-b1f7-8b685b487bb8, base URL = http://localhost:8080)@ben999 The error in your second post does not seem to be related the to binding and I've no clue what it means. So I'm glad the error is gone. ;-)
Have you enabled DEBUG for the binding? Please show me the output after you started the discovery process. The connection to the serial gateway is successful, so no need to change the permissions with usermod at the moment.
With debug enabled you should see the messages incoming from the gateway. If you don't see the messages arriving please check the connection between serial gateway and the node.
-
@ben999 The error in your second post does not seem to be related the to binding and I've no clue what it means. So I'm glad the error is gone. ;-)
Have you enabled DEBUG for the binding? Please show me the output after you started the discovery process. The connection to the serial gateway is successful, so no need to change the permissions with usermod at the moment.
With debug enabled you should see the messages incoming from the gateway. If you don't see the messages arriving please check the connection between serial gateway and the node.
@TimO Thanks a lot for your message
Talking right to the boss !! :wink:Actually, except that https://forum.mysensors.org/uploads/files/1479359162183-scan.jpeg nothing else happens...
Log from sensor (arduino micro++nrf24+dth22) :
No change, even when i launch a "scan for things"Starting sensor (RNNNA-, 2.0.0) TSM:INIT TSM:RADIO:OK TSP:ASSIGNID:OK (ID=1) TSM:FPAR TSP:MSG:SEND 1-1-255-255 s=255,c=3,t=7,pt=0,l=0,sg=0,ft=0,st=bc: TSP:MSG:READ 0-0-1 s=255,c=3,t=8,pt=1,l=1,sg=0:0 TSP:MSG:FPAR RES (ID=0, dist=0) TSP:MSG:PAR OK (ID=0, dist=1) TSM:FPAR:OK TSM:ID TSM:CHKID:OK (ID=1) TSM:UPL TSP:PING:SEND (dest=0) TSP:MSG:SEND 1-1-0-0 s=255,c=3,t=24,pt=1,l=1,sg=0,ft=0,st=ok:1 TSP:MSG:READ 0-0-1 s=255,c=3,t=25,pt=1,l=1,sg=0:1 TSP:MSG:PONG RECV (hops=1) TSP:CHKUPL:OK TSM:UPL:OK TSM:READY TSP:MSG:SEND 1-1-0-0 s=255,c=3,t=15,pt=6,l=2,sg=0,ft=0,st=ok:0100 !TSP:MSG:SEND 1-1-0-0 s=255,c=0,t=17,pt=0,l=5,sg=0,ft=0,st=fail:2.0.0 TSP:MSG:SEND 1-1-0-0 s=255,c=3,t=6,pt=1,l=1,sg=0,ft=1,st=ok:0 TSP:MSG:SEND 1-1-0-0 s=255,c=3,t=11,pt=0,l=22,sg=0,ft=0,st=ok:TemperatureAndHumidity TSP:MSG:SEND 1-1-0-0 s=255,c=3,t=12,pt=0,l=3,sg=0,ft=0,st=ok:1.1 TSP:MSG:SEND 1-1-0-0 s=0,c=0,t=7,pt=0,l=0,sg=0,ft=0,st=ok: TSP:MSG:SEND 1-1-0-0 s=1,c=0,t=6,pt=0,l=0,sg=0,ft=0,st=ok: Request registration... TSP:MSG:SEND 1-1-0-0 s=255,c=3,t=26,pt=1,l=1,sg=0,ft=0,st=ok:2 TSP:MSG:READ 0-0-1 s=255,c=3,t=27,pt=1,l=1,sg=0:1 Node registration=1 Init complete, id=1, parent=0, distance=1, registration=1 TSP:MSG:SEND 1-1-0-0 s=1,c=1,t=0,pt=7,l=5,sg=0,ft=0,st=ok:18.5 T: 18.50 TSP:MSG:SEND 1-1-0-0 s=0,c=1,t=1,pt=7,l=5,sg=0,ft=0,st=ok:68.1 H: 68.10And that's the openhab log... again, no change when i start a "scan for things"... :
pi@raspberrypi:/usr/share/openhab2 $ sudo ./start_debug.sh Launching the openHAB runtime... Listening for transport dt_socket at address: 5005 __ _____ ____ ____ ____ ___ ____ / / / / | / __ ) / __ \/ __ \/ _ \/ __ \/ /_/ / /| | / __ | / /_/ / /_/ / __/ / / / __ / ___ |/ /_/ / \____/ .___/\___/_/ /_/_/ /_/_/ |_/_____/ /_/ 2.0.0-SNAPSHOT Build #574 Hit '<tab>' for a list of available commands and '[cmd] --help' for help on a specific command. Hit '<ctrl-d>' or type 'system:shutdown' or 'logout' to shutdown openHAB. openhab> log:set DEBUG org.openhab.binding.mysensors openhab> log:tail 19:47:20.265 [DEBUG] [org.openhab.binding.mysensors ] - BundleEvent STARTING - org.openhab.binding.mysensors 19:47:20.517 [DEBUG] [org.openhab.binding.mysensors ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.thing.binding.ThingHandlerFactory}={component.name=org.openhab.binding.mysensors.internal.MySensorsHandlerFactory, component.id=0, service.id=109, service.bundleid=10, service.scope=bundle} - org.openhab.binding.mysensors 19:47:20.619 [DEBUG] [org.openhab.binding.mysensors ] - BundleEvent STARTED - org.openhab.binding.mysensors 19:47:40.172 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'home.items' 19:47:48.877 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'home.sitemap' 19:47:49.580 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'home.things' 19:47:49.939 [INFO ] [smarthome.event.ThingAddedEvent ] - Thing 'mysensors:bridge-ser:gateway' has been added. 19:47:50.853 [DEBUG] [org.openhab.binding.mysensors ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.discovery.DiscoveryService}={service.id=234, service.bundleid=10, service.scope=singleton} - org.openhab.binding.mysensors 19:47:50.869 [DEBUG] [org.openhab.binding.mysensors ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.thing.binding.ThingHandler}={thing.type=mysensors:bridge-ser, thing.id=mysensors:bridge-ser:gateway, service.id=235, service.bundleid=10, service.scope=singleton} - org.openhab.binding.mysensors 19:47:50.908 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:bridge-ser:gateway' changed from UNINITIALIZED to INITIALIZING 19:47:50.915 [DEBUG] [nsors.handler.MySensorsBridgeHandler] - Initialization of the MySensors Bridge 19:47:51.047 [INFO ] [smarthome.event.ThingAddedEvent ] - Thing 'mysensors:humidity:4008f727' has been added. 19:47:51.072 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:humidity:4008f727' changed from UNINITIALIZED to INITIALIZING 19:47:51.073 [DEBUG] [org.openhab.binding.mysensors ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.thing.binding.ThingHandler}={thing.type=mysensors:humidity, thing.id=mysensors:humidity:4008f727, service.id=237, service.bundleid=10, service.scope=singleton} - org.openhab.binding.mysensors 19:47:51.084 [INFO ] [smarthome.event.ThingAddedEvent ] - Thing 'mysensors:temperature:762194fe' has been added. 19:47:51.210 [DEBUG] [org.openhab.binding.mysensors ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.thing.binding.ThingHandler}={thing.type=mysensors:temperature, thing.id=mysensors:temperature:762194fe, service.id=238, service.bundleid=10, service.scope=singleton} - org.openhab.binding.mysensors 19:47:51.212 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:temperature:762194fe' changed from UNINITIALIZED to INITIALIZING 19:47:51.329 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:humidity:4008f727' changed from INITIALIZING to ONLINE 19:47:51.330 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:temperature:762194fe' changed from INITIALIZING to ONLINE 19:47:51.332 [DEBUG] [col.serial.MySensorsSerialConnection] - Successfully connected to serial port. 19:47:51.341 [INFO ] [home.event.ItemChannelLinkAddedEvent] - Link 'MotionTest-mysensors:motion:1584d6773a3:armed' has been added. 19:47:51.345 [INFO ] [home.event.ItemChannelLinkAddedEvent] - Link 'MotionTest-mysensors:motion:1584d6773a3:tripped' has been added. 19:47:51.357 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:bridge-ser:gateway' changed from INITIALIZING to ONLINE 19:47:51.413 [INFO ] [smarthome.event.ItemAddedEvent ] - Item 'mysensors_humidity_4008f727_battery' has been added. 19:47:51.417 [INFO ] [home.event.ItemChannelLinkAddedEvent] - Link 'mysensors_humidity_4008f727_battery-mysensors:humidity:4008f727:battery' has been added. 19:47:51.421 [INFO ] [smarthome.event.ItemAddedEvent ] - Item 'mysensors_humidity_4008f727_hum' has been added. 19:47:51.425 [INFO ] [home.event.ItemChannelLinkAddedEvent] - Link 'mysensors_humidity_4008f727_hum-mysensors:humidity:4008f727:hum' has been added. 19:47:51.431 [INFO ] [smarthome.event.ItemAddedEvent ] - Item 'mysensors_temperature_762194fe_battery' has been added. 19:47:51.434 [INFO ] [home.event.ItemChannelLinkAddedEvent] - Link 'mysensors_temperature_762194fe_battery-mysensors:temperature:762194fe:battery' has been added. 19:47:51.440 [INFO ] [smarthome.event.ItemAddedEvent ] - Item 'mysensors_temperature_762194fe_temp' has been added. 19:47:51.454 [INFO ] [home.event.ItemChannelLinkAddedEvent] - Link 'mysensors_temperature_762194fe_temp-mysensors:temperature:762194fe:temp' has been added. 19:47:56.749 [INFO ] [basic.internal.servlet.WebAppServlet] - Started Basic UI at /basicui/app 19:47:57.810 [INFO ] [assic.internal.servlet.WebAppServlet] - Started Classic UI at /classicui/app 19:47:58.557 [INFO ] [arthome.ui.paper.internal.PaperUIApp] - Started Paper UI at /ui 19:47:59.161 [INFO ] [.dashboard.internal.DashboardService] - Started dashboard at /start 19:47:59.682 [INFO ] [ui.habmin.internal.servlet.HABminApp] - Started HABmin servlet at /habmin 19:47:59.807 [INFO ] [panel.internal.HABPanelDashboardTile] - Started HABPanel at /habpanel 19:48:04.034 [INFO ] [o.myopenhab.internal.MyOpenHABClient] - Connected to my.openHAB service (UUID = 7c0faa03-e826-473a-b1f7-8b685b487bb8, base URL = http://localhost:8080)Is there any other log that is worth having a look at ?
This is really strange, because when i hook up a PIR sensor to the same arduino and nrf24, and i launchpi@raspberrypi:~/MySensors $ sudo ./examples_linux/mysGateway -di can see that arduino and raspberry interract together...Thanks a lot for your time
-
@TimO Thanks a lot for your message
Talking right to the boss !! :wink:Actually, except that https://forum.mysensors.org/uploads/files/1479359162183-scan.jpeg nothing else happens...
Log from sensor (arduino micro++nrf24+dth22) :
No change, even when i launch a "scan for things"Starting sensor (RNNNA-, 2.0.0) TSM:INIT TSM:RADIO:OK TSP:ASSIGNID:OK (ID=1) TSM:FPAR TSP:MSG:SEND 1-1-255-255 s=255,c=3,t=7,pt=0,l=0,sg=0,ft=0,st=bc: TSP:MSG:READ 0-0-1 s=255,c=3,t=8,pt=1,l=1,sg=0:0 TSP:MSG:FPAR RES (ID=0, dist=0) TSP:MSG:PAR OK (ID=0, dist=1) TSM:FPAR:OK TSM:ID TSM:CHKID:OK (ID=1) TSM:UPL TSP:PING:SEND (dest=0) TSP:MSG:SEND 1-1-0-0 s=255,c=3,t=24,pt=1,l=1,sg=0,ft=0,st=ok:1 TSP:MSG:READ 0-0-1 s=255,c=3,t=25,pt=1,l=1,sg=0:1 TSP:MSG:PONG RECV (hops=1) TSP:CHKUPL:OK TSM:UPL:OK TSM:READY TSP:MSG:SEND 1-1-0-0 s=255,c=3,t=15,pt=6,l=2,sg=0,ft=0,st=ok:0100 !TSP:MSG:SEND 1-1-0-0 s=255,c=0,t=17,pt=0,l=5,sg=0,ft=0,st=fail:2.0.0 TSP:MSG:SEND 1-1-0-0 s=255,c=3,t=6,pt=1,l=1,sg=0,ft=1,st=ok:0 TSP:MSG:SEND 1-1-0-0 s=255,c=3,t=11,pt=0,l=22,sg=0,ft=0,st=ok:TemperatureAndHumidity TSP:MSG:SEND 1-1-0-0 s=255,c=3,t=12,pt=0,l=3,sg=0,ft=0,st=ok:1.1 TSP:MSG:SEND 1-1-0-0 s=0,c=0,t=7,pt=0,l=0,sg=0,ft=0,st=ok: TSP:MSG:SEND 1-1-0-0 s=1,c=0,t=6,pt=0,l=0,sg=0,ft=0,st=ok: Request registration... TSP:MSG:SEND 1-1-0-0 s=255,c=3,t=26,pt=1,l=1,sg=0,ft=0,st=ok:2 TSP:MSG:READ 0-0-1 s=255,c=3,t=27,pt=1,l=1,sg=0:1 Node registration=1 Init complete, id=1, parent=0, distance=1, registration=1 TSP:MSG:SEND 1-1-0-0 s=1,c=1,t=0,pt=7,l=5,sg=0,ft=0,st=ok:18.5 T: 18.50 TSP:MSG:SEND 1-1-0-0 s=0,c=1,t=1,pt=7,l=5,sg=0,ft=0,st=ok:68.1 H: 68.10And that's the openhab log... again, no change when i start a "scan for things"... :
pi@raspberrypi:/usr/share/openhab2 $ sudo ./start_debug.sh Launching the openHAB runtime... Listening for transport dt_socket at address: 5005 __ _____ ____ ____ ____ ___ ____ / / / / | / __ ) / __ \/ __ \/ _ \/ __ \/ /_/ / /| | / __ | / /_/ / /_/ / __/ / / / __ / ___ |/ /_/ / \____/ .___/\___/_/ /_/_/ /_/_/ |_/_____/ /_/ 2.0.0-SNAPSHOT Build #574 Hit '<tab>' for a list of available commands and '[cmd] --help' for help on a specific command. Hit '<ctrl-d>' or type 'system:shutdown' or 'logout' to shutdown openHAB. openhab> log:set DEBUG org.openhab.binding.mysensors openhab> log:tail 19:47:20.265 [DEBUG] [org.openhab.binding.mysensors ] - BundleEvent STARTING - org.openhab.binding.mysensors 19:47:20.517 [DEBUG] [org.openhab.binding.mysensors ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.thing.binding.ThingHandlerFactory}={component.name=org.openhab.binding.mysensors.internal.MySensorsHandlerFactory, component.id=0, service.id=109, service.bundleid=10, service.scope=bundle} - org.openhab.binding.mysensors 19:47:20.619 [DEBUG] [org.openhab.binding.mysensors ] - BundleEvent STARTED - org.openhab.binding.mysensors 19:47:40.172 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'home.items' 19:47:48.877 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'home.sitemap' 19:47:49.580 [INFO ] [el.core.internal.ModelRepositoryImpl] - Loading model 'home.things' 19:47:49.939 [INFO ] [smarthome.event.ThingAddedEvent ] - Thing 'mysensors:bridge-ser:gateway' has been added. 19:47:50.853 [DEBUG] [org.openhab.binding.mysensors ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.discovery.DiscoveryService}={service.id=234, service.bundleid=10, service.scope=singleton} - org.openhab.binding.mysensors 19:47:50.869 [DEBUG] [org.openhab.binding.mysensors ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.thing.binding.ThingHandler}={thing.type=mysensors:bridge-ser, thing.id=mysensors:bridge-ser:gateway, service.id=235, service.bundleid=10, service.scope=singleton} - org.openhab.binding.mysensors 19:47:50.908 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:bridge-ser:gateway' changed from UNINITIALIZED to INITIALIZING 19:47:50.915 [DEBUG] [nsors.handler.MySensorsBridgeHandler] - Initialization of the MySensors Bridge 19:47:51.047 [INFO ] [smarthome.event.ThingAddedEvent ] - Thing 'mysensors:humidity:4008f727' has been added. 19:47:51.072 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:humidity:4008f727' changed from UNINITIALIZED to INITIALIZING 19:47:51.073 [DEBUG] [org.openhab.binding.mysensors ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.thing.binding.ThingHandler}={thing.type=mysensors:humidity, thing.id=mysensors:humidity:4008f727, service.id=237, service.bundleid=10, service.scope=singleton} - org.openhab.binding.mysensors 19:47:51.084 [INFO ] [smarthome.event.ThingAddedEvent ] - Thing 'mysensors:temperature:762194fe' has been added. 19:47:51.210 [DEBUG] [org.openhab.binding.mysensors ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.thing.binding.ThingHandler}={thing.type=mysensors:temperature, thing.id=mysensors:temperature:762194fe, service.id=238, service.bundleid=10, service.scope=singleton} - org.openhab.binding.mysensors 19:47:51.212 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:temperature:762194fe' changed from UNINITIALIZED to INITIALIZING 19:47:51.329 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:humidity:4008f727' changed from INITIALIZING to ONLINE 19:47:51.330 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:temperature:762194fe' changed from INITIALIZING to ONLINE 19:47:51.332 [DEBUG] [col.serial.MySensorsSerialConnection] - Successfully connected to serial port. 19:47:51.341 [INFO ] [home.event.ItemChannelLinkAddedEvent] - Link 'MotionTest-mysensors:motion:1584d6773a3:armed' has been added. 19:47:51.345 [INFO ] [home.event.ItemChannelLinkAddedEvent] - Link 'MotionTest-mysensors:motion:1584d6773a3:tripped' has been added. 19:47:51.357 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'mysensors:bridge-ser:gateway' changed from INITIALIZING to ONLINE 19:47:51.413 [INFO ] [smarthome.event.ItemAddedEvent ] - Item 'mysensors_humidity_4008f727_battery' has been added. 19:47:51.417 [INFO ] [home.event.ItemChannelLinkAddedEvent] - Link 'mysensors_humidity_4008f727_battery-mysensors:humidity:4008f727:battery' has been added. 19:47:51.421 [INFO ] [smarthome.event.ItemAddedEvent ] - Item 'mysensors_humidity_4008f727_hum' has been added. 19:47:51.425 [INFO ] [home.event.ItemChannelLinkAddedEvent] - Link 'mysensors_humidity_4008f727_hum-mysensors:humidity:4008f727:hum' has been added. 19:47:51.431 [INFO ] [smarthome.event.ItemAddedEvent ] - Item 'mysensors_temperature_762194fe_battery' has been added. 19:47:51.434 [INFO ] [home.event.ItemChannelLinkAddedEvent] - Link 'mysensors_temperature_762194fe_battery-mysensors:temperature:762194fe:battery' has been added. 19:47:51.440 [INFO ] [smarthome.event.ItemAddedEvent ] - Item 'mysensors_temperature_762194fe_temp' has been added. 19:47:51.454 [INFO ] [home.event.ItemChannelLinkAddedEvent] - Link 'mysensors_temperature_762194fe_temp-mysensors:temperature:762194fe:temp' has been added. 19:47:56.749 [INFO ] [basic.internal.servlet.WebAppServlet] - Started Basic UI at /basicui/app 19:47:57.810 [INFO ] [assic.internal.servlet.WebAppServlet] - Started Classic UI at /classicui/app 19:47:58.557 [INFO ] [arthome.ui.paper.internal.PaperUIApp] - Started Paper UI at /ui 19:47:59.161 [INFO ] [.dashboard.internal.DashboardService] - Started dashboard at /start 19:47:59.682 [INFO ] [ui.habmin.internal.servlet.HABminApp] - Started HABmin servlet at /habmin 19:47:59.807 [INFO ] [panel.internal.HABPanelDashboardTile] - Started HABPanel at /habpanel 19:48:04.034 [INFO ] [o.myopenhab.internal.MyOpenHABClient] - Connected to my.openHAB service (UUID = 7c0faa03-e826-473a-b1f7-8b685b487bb8, base URL = http://localhost:8080)Is there any other log that is worth having a look at ?
This is really strange, because when i hook up a PIR sensor to the same arduino and nrf24, and i launchpi@raspberrypi:~/MySensors $ sudo ./examples_linux/mysGateway -di can see that arduino and raspberry interract together...Thanks a lot for your time
@ben999 The OH2 log looks good, but could you please enable debug output in OH2 for the binding as described in the Wiki?
In the log from the node I see that the presentation message is the one that failed to deliver. Does this happen all the time? The binding is looking for that message. This could be a power issue.