openHAB 2.0 binding
-
@ZoTyA said:
after OH2 restart I got "UNINITIALIZED - HANDLER_INITIALIZING_ERROR" for all already existing sensors. If I add a new sensors it works until OH2 restart
This should be fixed but I don't think @Tim0 has released the fix yet? Might be wrong.
-
What do you want to keep updated? The OH2 runtime? The binding?
I update the link of the binding (jar-file) in the first post here whenever I add or fix something. You only have to switch this jar file in your installation. In the current alpha phase it is an good idea to delete the userdata folder, but with that you will lose all already discovered and added things. I have configured all things/items that should survive a deletion of the userdata in the thing.conf, items.conf etc.
For the future I plan to make a pull request so that the mysensors binding will be a fixed part of OH2, but I want to ensure its stability before I do so. Additionally there are some features I would like to add before making a pull request.
-
@Qu3Uk I asked a similar question about persistence on the OH2 forum and the response was you could set up a group and configure persistence for it. Then as the new items are dynamically found they just need to be added to the group without adding them to the config files. Possibly the same thing would work for rules.
-
@TimO Slightly off topic but am I right in thinking even with discovered things you still have to manually create an item for the thing in the item.conf for stuff like rules to work?
-
@TimO I'm having difficulty with the mysensors binding and the zwave binding on OH2 startup. If both bindings are present, then mysensors gets loaded first (port=/dev/ttyS2) and then zwave tries to load (port=/dev/ttyUSB0) however it reports that it's serial port is not present. If I remove the mysensors binding jar file from addons and then start OH2, the zwave binding connects to its serial port correctly and works fine. I can then mv the mysensors binding back into addons and it will get loaded and bind correctly to it's serial port. I've tried to turn the logging up to debug and not got anything more from the bindings to tell me what's happening. any help is appreciated. thanks.
-
@BenCranston : Thanks for the bug report! You're right I'm able to reproduce this error. The zwave and mysensors binding both use the same library (gnu.io) to access serial ports.
-
@TimO I'm beginning to think this might be platform specific to the gnu.io library and manifest on ARM architectures. I moved my OH2 installation over to my Mac and "Viola!" both services started working without an issue. Are you on an ARM platform as well? Initially I was running the MySensors gateway off of a GPIO serial port on my Pi. As part of working this I moved the gateway to an FTDI USB connection, so both devices were /dev/ttyUSB[01]. That didn't change the behavior and they still failed to co-exist from boot. I'm going to take a look at the gnu.io RXTX stuff and see if I can find a lead there... I'm not a java programmer, so this should be fun.
-
@TimO It looks like someone else ran into the same issue trying to do z-wave and enocean, both being serial connections. The discussion over on the community at openhab.org is here: https://community.openhab.org/t/serial-ports-issue/2516
I wonder if that sheds any further lights on the issue. They did get a fix implemented in the EnOcean binding to play nice with the zwave binding. -
@BenCranston : Thanks for looking further into the problem. I was able to reproduce the problem on a x86 architecture.
I've looked into the fix for insteon and I'm not sure if that helps, because I don't use the updateProperties() method that is fixed.I don't know zwave, so to be sure: I've changed:
port=/dev/pts/1in zwave.cfg. Is that correct?
(I've running a serial emulation on /dev/pts/1). -
@TimO : Yes sir, that's the config step to tell the zwave binding where it's serial port is. The rest is done via files, or the habmin interface.
-
@BenCranston : Thanks for looking further into the problem. I was able to reproduce the problem on a x86 architecture.
I've looked into the fix for insteon and I'm not sure if that helps, because I don't use the updateProperties() method that is fixed.I don't know zwave, so to be sure: I've changed:
port=/dev/pts/1in zwave.cfg. Is that correct?
(I've running a serial emulation on /dev/pts/1).Hi @TimO
I have a ESP8266 as Ethernet GW and a Nano with a S_HUM, S_TEMP and a S_LIGHT_LEVEL.
I follow as described steps and the S_TEMP sensor is updated almost immediately, the S_HUM takes some minutes and the S_LIGHT_LEVEL is never updated.Can you take a look please?
Launching the openHAB runtime... Listening for transport dt_socket at address: 8001 2015-09-26 11:42:26 [DEBUG] [s.m.i.r.i.ItemRuntimeActivator:23 ] - Registered 'item' configuration parser 2015-09-26 11:42:26 [INFO ] [uartz.impl.StdSchedulerFactory:1184 ] - Using default implementation for ThreadExecutor 2015-09-26 11:42:26 [INFO ] [rtz.core.SchedulerSignalerImpl:61 ] - Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl 2015-09-26 11:42:26 [INFO ] [rg.quartz.core.QuartzScheduler:240 ] - Quartz Scheduler v.2.2.1 created. 2015-09-26 11:42:26 [INFO ] [org.quartz.simpl.RAMJobStore :155 ] - RAMJobStore initialized. 2015-09-26 11:42:26 [INFO ] [rg.quartz.core.QuartzScheduler:305 ] - Scheduler meta-data: Quartz Scheduler (v2.2.1) 'openHAB-job-scheduler' with instanceId 'NON_CLUSTERED' Scheduler class: 'org.quartz.core.QuartzScheduler' - running locally. NOT STARTED. Currently in standby mode. Number of jobs executed: 0 Using thread pool 'org.quartz.simpl.SimpleThreadPool' - with 2 threads. Using job-store 'org.quartz.simpl.RAMJobStore' - which does not support persistence. and is not clustered. 2015-09-26 11:42:26 [INFO ] [uartz.impl.StdSchedulerFactory:1339 ] - Quartz scheduler 'openHAB-job-scheduler' initialized from specified file: './runtime/etc/quartz.properties' 2015-09-26 11:42:26 [INFO ] [uartz.impl.StdSchedulerFactory:1343 ] - Quartz scheduler version: 2.2.1 2015-09-26 11:42:26 [DEBUG] [.i.PersistenceRuntimeActivator:23 ] - Registered 'persistence' configuration parser 2015-09-26 11:42:26 [DEBUG] [s.m.r.r.i.RuleRuntimeActivator:35 ] - Registered 'rule' configuration parser 2015-09-26 11:42:26 [DEBUG] [m.s.r.i.ScriptRuntimeActivator:22 ] - Registered 'script' configuration parser 2015-09-26 11:42:26 [DEBUG] [.s.r.i.SitemapRuntimeActivator:23 ] - Registered 'sitemap' configuration parser 2015-09-26 11:42:26 [DEBUG] [.m.t.r.i.ThingRuntimeActivator:23 ] - Registered 'thing' configuration parser osgi> 2015-09-26 11:42:27 [WARN ] [.j.s.handler.RequestLogHandler:137 ] - !RequestLog 2015-09-26 11:42:27 [DEBUG] [.c.d.internal.ConfigDispatcher:222 ] - Processing config file 'services.cfg' 2015-09-26 11:42:27 [DEBUG] [.c.d.internal.ConfigDispatcher:222 ] - Processing config file 'runtime.cfg' 2015-09-26 11:42:28 [DEBUG] [.s.core.internal.CoreActivator:30 ] - Core bundle has been started. 2015-09-26 11:42:28 [DEBUG] [.e.s.c.a.i.AutoUpdateActivator:29 ] - AutoUpdate binding has been started. 2015-09-26 11:42:28 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/binding/binding.xml' in module 'org.openhab.binding.mysensors'... 2015-09-26 11:42:28 [DEBUG] [o.e.s.c.s.i.SchedulerActivator:34 ] - Scheduler has been started. 2015-09-26 11:42:28 [INFO ] [rg.quartz.core.QuartzScheduler:575 ] - Scheduler openHAB-job-scheduler_$_NON_CLUSTERED started. 2015-09-26 11:42:28 [DEBUG] [c.x.o.XmlDocumentBundleTracker:159 ] - Create an empty XmlDocumentProvider for the module 'org.openhab.binding.mysensors'. 2015-09-26 11:42:28 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/channels.xml' in module 'org.openhab.binding.mysensors'... 2015-09-26 11:42:28 [DEBUG] [.c.t.i.TransformationActivator:34 ] - Transformation Service has been started. 2015-09-26 11:42:28 [DEBUG] [c.x.o.XmlDocumentBundleTracker:159 ] - Create an empty XmlDocumentProvider for the module 'org.openhab.binding.mysensors'. 2015-09-26 11:42:28 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/thing-types.xml' in module 'org.openhab.binding.mysensors'... 2015-09-26 11:42:28 [DEBUG] [.e.s.i.m.i.MultimediaActivator:32 ] - Multimedia I/O bundle has been started. 2015-09-26 11:42:28 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/bridges.xml' in module 'org.openhab.binding.mysensors'... 2015-09-26 11:42:28 [DEBUG] [io.rest.internal.RESTActivator:32 ] - REST API has been started. 2015-09-26 11:42:28 [DEBUG] [s.i.t.m.internal.MDNSActivator:27 ] - mDNS service has been started. 2015-09-26 11:42:28 [DEBUG] [.i.t.m.internal.MDNSClientImpl:37 ] - mDNS service has been started 2015-09-26 11:42:28 [DEBUG] [i.t.m.internal.MDNSServiceImpl:85 ] - Registering new service _openhab-server._tcp.local. at port 8080 2015-09-26 11:42:28 [DEBUG] [i.t.m.internal.MDNSServiceImpl:85 ] - Registering new service _openhab-server-ssl._tcp.local. at port 8443 2015-09-26 11:42:28 [DEBUG] [.i.r.sse.internal.SseActivator:46 ] - SSE API - SseFeature registered. 2015-09-26 11:42:28 [DEBUG] [.i.r.sse.internal.SseActivator:55 ] - SSE API has been started. 2015-09-26 11:42:28 [DEBUG] [.io.transport.mqtt.MqttService:118 ] - Starting MQTT Service... 2015-09-26 11:42:28 [DEBUG] [.s.s.mapdb.MapDbStorageService:50 ] - Opened MapDB file at 'D:\Downloads\openhab2\.\userdata\mapdb\storage.mapdb'. 2015-09-26 11:42:28 [DEBUG] [.c.c.registry.AbstractRegistry:190 ] - Provider 'org.eclipse.smarthome.core.items.ManagedItemProvider' has been added. 2015-09-26 11:42:28 [DEBUG] [.c.c.registry.AbstractRegistry:190 ] - Provider 'org.eclipse.smarthome.core.thing.ManagedThingProvider' has been added. 2015-09-26 11:42:28 [DEBUG] [.core.common.ThreadPoolManager:141 ] - Created scheduled thread pool 'discovery' of size 3 2015-09-26 11:42:28 [DEBUG] [.c.thing.internal.ThingManager:549 ] - Thing handler factory 'MySensorsHandlerFactory' added 2015-09-26 11:42:28 [DEBUG] [.c.c.registry.AbstractRegistry:190 ] - Provider 'org.eclipse.smarthome.core.thing.link.ManagedItemChannelLinkProvider' has been added. 2015-09-26 11:42:28 [DEBUG] [.c.c.registry.AbstractRegistry:190 ] - Provider 'org.eclipse.smarthome.core.thing.link.ManagedItemThingLinkProvider' has been added. 2015-09-26 11:42:28 [DEBUG] [ui.internal.chart.ChartServlet:122 ] - Starting up chart servlet at /chart 2015-09-26 11:42:28 [DEBUG] [u.i.chart.DefaultChartProvider:97 ] - Starting up default chart provider. 2015-09-26 11:42:28 [DEBUG] [o.e.s.u.c.i.servlet.CmdServlet:56 ] - Starting up CMD servlet at /classicui/CMD 2015-09-26 11:42:28 [DEBUG] [s.ui.icon.internal.IconServlet:76 ] - Starting up icon servlet at /icon 2015-09-26 11:42:28 [INFO ] [ui.internal.servlet.PaperUIApp:31 ] - Started Paper UI at /ui 2015-09-26 11:42:29 [DEBUG] [e.s.i.t.upnp.UpnpIOServiceImpl:152 ] - Starting UPnP IO service... 2015-09-26 11:42:29 [INFO ] [.u.d.internal.DashboardService:55 ] - Started dashboard at /start 2015-09-26 11:42:29 [DEBUG] [.c.c.registry.AbstractRegistry:190 ] - Provider 'org.eclipse.smarthome.model.item.internal.GenericItemProvider' has been added. 2015-09-26 11:42:29 [INFO ] [rg.quartz.core.QuartzScheduler:2311 ] - JobFactory set to: org.eclipse.smarthome.model.rule.runtime.internal.engine.GuiceAwareJobFactory@1762bd77 2015-09-26 11:42:29 [DEBUG] [.m.r.r.i.engine.RuleEngineImpl:96 ] - Started rule engine 2015-09-26 11:42:29 [INFO ] [.s.u.c.i.servlet.WebAppServlet:85 ] - Started Classic UI at /classicui/app 2015-09-26 11:42:29 [DEBUG] [e.s.m.t.i.GenericThingProvider:696 ] - ThingHandlerFactory added org.openhab.binding.mysensors.internal.MySensorsHandlerFactory@25ceff93 2015-09-26 11:42:29 [DEBUG] [.c.c.registry.AbstractRegistry:190 ] - Provider 'org.eclipse.smarthome.model.thing.internal.GenericThingProvider' has been added. 2015-09-26 11:42:29 [DEBUG] [.c.c.registry.AbstractRegistry:190 ] - Provider 'org.eclipse.smarthome.model.thing.internal.GenericItemChannelLinkProvider' has been added. 2015-09-26 11:42:29 [DEBUG] [ui.internal.proxy.ProxyServlet:94 ] - Starting up proxy servlet at /proxy 2015-09-26 11:42:29 [INFO ] [.o.core.internal.CoreActivator:41 ] - openHAB runtime has been started (v2.0.0, build 201509240103). 2015-09-26 11:42:29 [DEBUG] [.o.core.internal.CoreActivator:47 ] - Startup took 6896 ms 2015-09-26 11:42:36 [DEBUG] [io.rest.core.item.ItemResource:127 ] - Received HTTP GET request at 'items' 2015-09-26 11:42:49 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element home_group_daef4dc3 to ManagedItemProvider. 2015-09-26 11:42:49 [DEBUG] [.core.common.ThreadPoolManager:171 ] - Created thread pool 'safeCall' with size 3-10 2015-09-26 11:42:49 [INFO ] [smarthome.event.ItemAddedEvent:43 ] - Item 'home_group_daef4dc3' has been added. 2015-09-26 11:43:31 [DEBUG] [.c.thing.internal.ThingManager:363 ] - Thing 'mysensors:bridge-eth:c27764bd' is tracked by ThingManager. 2015-09-26 11:43:31 [INFO ] [marthome.event.ThingAddedEvent:43 ] - Thing 'mysensors:bridge-eth:c27764bd' has been added. 2015-09-26 11:43:31 [DEBUG] [.c.thing.internal.ThingManager:487 ] - Calling registerHandler handler for thing 'mysensors:bridge-eth:c27764bd' at 'org.openhab.binding.mysensors.intern erFactory@25ceff93'. 2015-09-26 11:43:31 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - mysensors:bridge-eth:c27764bd' updated: INITIALIZING 2015-09-26 11:43:31 [DEBUG] [.core.common.ThreadPoolManager:141 ] - Created scheduled thread pool 'thingHandler' of size 3 2015-09-26 11:43:31 [DEBUG] [o.b.m.h.MySensorsBridgeHandler:58 ] - Initialization of the MySensors Bridge 2015-09-26 11:43:31 [DEBUG] [.e.s.config.core.Configuration:89 ] - Setting value (String) 192.168.0.17 to field 'ipAddress' in configuration class org.openhab.binding.mysensors.conf eConfiguration 2015-09-26 11:43:31 [DEBUG] [.e.s.config.core.Configuration:89 ] - Setting value (String) 5003 to field 'tcpPort' in configuration class org.openhab.binding.mysensors.config.MySenso tion 2015-09-26 11:43:31 [DEBUG] [b.m.p.ip.MySensorsIpConnection:40 ] - Connecting to bridge ... 2015-09-26 11:43:31 [DEBUG] [b.m.p.ip.MySensorsIpConnection:56 ] - Connection to ethernet gateway successful! 2015-09-26 11:43:31 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - mysensors:bridge-eth:c27764bd' updated: ONLINE 2015-09-26 11:43:31 [DEBUG] [.c.thing.internal.ThingManager:84 ] - Thing handler for thing 'mysensors:bridge-eth:c27764bd' added. 2015-09-26 11:43:31 [DEBUG] [.c.thing.internal.ThingManager:252 ] - Assigning handler for thing 'mysensors:bridge-eth:c27764bd'. 2015-09-26 11:43:31 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors:bridge-eth:c27764bd to ManagedThingProvider. 2015-09-26 11:43:31 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 0;0;3;0;14;Gateway startup complete. 2015-09-26 11:43:32 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_bridge_eth_c27764bd to ManagedItemProvider. 2015-09-26 11:43:32 [INFO ] [smarthome.event.ItemAddedEvent:43 ] - Item 'mysensors_bridge_eth_c27764bd' has been added. 2015-09-26 11:43:32 [DEBUG] [.c.t.internal.ThingLinkManager:328 ] - Assigning linked group item 'mysensors_bridge_eth_c27764bd' to thing 'mysensors:bridge-eth:c27764bd'. 2015-09-26 11:43:32 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_bridge_eth_c27764bd -> mysensors:bridge-eth:c27764bd to ManagedItemThingLinkProvider. 2015-09-26 11:43:32 [DEBUG] [i.DiscoveryServiceRegistryImpl:333 ] - Triggering scan for thing types '[mysensors:humidity, mysensors:temperature, mysensors:light, mysensors:volt, myse nsors:baro, mysensors:door, mysensors:motion, mysensors:smoke, mysensors:dimmer, mysensors:cover, mysensors:wind, mysensors:rain, mysensors:uv, mysensors:weight, mysensors:distance, m vel]' on 'MySensorsDiscoveryService'... 2015-09-26 11:44:02 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;37 2015-09-26 11:44:14 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;38 2015-09-26 11:44:16 [DEBUG] [.c.thing.internal.ThingManager:363 ] - Thing 'mysensors:humidity:7d1da077' is tracked by ThingManager. 2015-09-26 11:44:16 [DEBUG] [.c.thing.internal.ThingManager:487 ] - Calling registerHandler handler for thing 'mysensors:humidity:7d1da077' at 'org.openhab.binding.mysensors.internal Factory@25ceff93'. 2015-09-26 11:44:16 [INFO ] [marthome.event.ThingAddedEvent:43 ] - Thing 'mysensors:humidity:7d1da077' has been added. 2015-09-26 11:44:16 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - mysensors:humidity:7d1da077' updated: INITIALIZING 2015-09-26 11:44:16 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - mysensors:humidity:7d1da077' updated: ONLINE 2015-09-26 11:44:16 [DEBUG] [.e.s.config.core.Configuration:89 ] - Setting value (String) 1 to field 'nodeId' in configuration class org.openhab.binding.mysensors.config.MySensorsSe 2015-09-26 11:44:16 [DEBUG] [.e.s.config.core.Configuration:89 ] - Setting value (String) 0 to field 'childId' in configuration class org.openhab.binding.mysensors.config.MySensorsS n 2015-09-26 11:44:16 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - mysensors:humidity:7d1da077' updated: ONLINE 2015-09-26 11:44:16 [DEBUG] [.c.thing.internal.ThingManager:84 ] - Thing handler for thing 'mysensors:humidity:7d1da077' added. 2015-09-26 11:44:16 [DEBUG] [.c.thing.internal.ThingManager:252 ] - Assigning handler for thing 'mysensors:humidity:7d1da077'. 2015-09-26 11:44:16 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors:humidity:7d1da077 to ManagedThingProvider. 2015-09-26 11:44:16 [INFO ] [smarthome.event.ItemAddedEvent:43 ] - Item 'mysensors_humidity_7d1da077' has been added. 2015-09-26 11:44:16 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_humidity_7d1da077 to ManagedItemProvider. 2015-09-26 11:44:16 [DEBUG] [.c.t.internal.ThingLinkManager:328 ] - Assigning linked group item 'mysensors_humidity_7d1da077' to thing 'mysensors:humidity:7d1da077'. 2015-09-26 11:44:16 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_humidity_7d1da077 -> mysensors:humidity:7d1da077 to ManagedItemThingLinkProvider. 2015-09-26 11:44:17 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_humidity_7d1da077_hum to ManagedItemProvider. 2015-09-26 11:44:17 [INFO ] [smarthome.event.ItemAddedEvent:43 ] - Item 'mysensors_humidity_7d1da077_hum' has been added. 2015-09-26 11:44:17 [DEBUG] [.c.t.internal.ThingLinkManager:317 ] - Adding linked item 'mysensors_humidity_7d1da077_hum' to channel 'mysensors:humidity:7d1da077:hum'. 2015-09-26 11:44:17 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_humidity_7d1da077_hum -> mysensors:humidity:7d1da077:hum to ManagedItemChannelLinkProv 2015-09-26 11:44:17 [DEBUG] [i.DiscoveryServiceRegistryImpl:333 ] - Triggering scan for thing types '[mysensors:humidity, mysensors:temperature, mysensors:light, mysensors:volt, myse nsors:baro, mysensors:door, mysensors:motion, mysensors:smoke, mysensors:dimmer, mysensors:cover, mysensors:wind, mysensors:rain, mysensors:uv, mysensors:weight, mysensors:distance, m vel]' on 'MySensorsDiscoveryService'... 2015-09-26 11:44:27 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;37 2015-09-26 11:44:48 [DEBUG] [.c.thing.internal.ThingManager:363 ] - Thing 'mysensors:light-level:9e706943' is tracked by ThingManager. 2015-09-26 11:44:48 [INFO ] [marthome.event.ThingAddedEvent:43 ] - Thing 'mysensors:light-level:9e706943' has been added. 2015-09-26 11:44:48 [DEBUG] [.c.thing.internal.ThingManager:487 ] - Calling registerHandler handler for thing 'mysensors:light-level:9e706943' at 'org.openhab.binding.mysensors.inter lerFactory@25ceff93'. 2015-09-26 11:44:48 [DEBUG] [.e.s.config.core.Configuration:89 ] - Setting value (String) 1 to field 'nodeId' in configuration class org.openhab.binding.mysensors.config.MySensorsSe 2015-09-26 11:44:48 [DEBUG] [.e.s.config.core.Configuration:89 ] - Setting value (String) 2 to field 'childId' in configuration class org.openhab.binding.mysensors.config.MySensorsS n 2015-09-26 11:44:48 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - mysensors:light-level:9e706943' updated: INITIALIZING 2015-09-26 11:44:48 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - mysensors:light-level:9e706943' updated: ONLINE 2015-09-26 11:44:48 [DEBUG] [.c.thing.internal.ThingManager:84 ] - Thing handler for thing 'mysensors:light-level:9e706943' added. 2015-09-26 11:44:48 [DEBUG] [.c.thing.internal.ThingManager:252 ] - Assigning handler for thing 'mysensors:light-level:9e706943'. 2015-09-26 11:44:48 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - mysensors:light-level:9e706943' updated: ONLINE 2015-09-26 11:44:48 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors:light-level:9e706943 to ManagedThingProvider. 2015-09-26 11:44:48 [INFO ] [smarthome.event.ItemAddedEvent:43 ] - Item 'mysensors_light_level_9e706943' has been added. 2015-09-26 11:44:48 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_light_level_9e706943 to ManagedItemProvider. 2015-09-26 11:44:48 [DEBUG] [.c.t.internal.ThingLinkManager:328 ] - Assigning linked group item 'mysensors_light_level_9e706943' to thing 'mysensors:light-level:9e706943'. 2015-09-26 11:44:48 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_light_level_9e706943 -> mysensors:light-level:9e706943 to ManagedItemThingLinkProvider 2015-09-26 11:44:48 [INFO ] [smarthome.event.ItemAddedEvent:43 ] - Item 'mysensors_light_level_9e706943_light_level' has been added. 2015-09-26 11:44:48 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_light_level_9e706943_light_level to ManagedItemProvider. 2015-09-26 11:44:48 [DEBUG] [.c.t.internal.ThingLinkManager:317 ] - Adding linked item 'mysensors_light_level_9e706943_light_level' to channel 'mysensors:light-level:9e706943:light-l 2015-09-26 11:44:48 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_light_level_9e706943_light_level -> mysensors:light-level:9e706943:light-level to Mana kProvider. 2015-09-26 11:44:48 [DEBUG] [i.DiscoveryServiceRegistryImpl:333 ] - Triggering scan for thing types '[mysensors:humidity, mysensors:temperature, mysensors:light, mysensors:volt, myse nsors:baro, mysensors:door, mysensors:motion, mysensors:smoke, mysensors:dimmer, mysensors:cover, mysensors:wind, mysensors:rain, mysensors:uv, mysensors:weight, mysensors:distance, m vel]' on 'MySensorsDiscoveryService'... 2015-09-26 11:45:05 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;36 2015-09-26 11:45:06 [INFO ] [marthome.event.ThingAddedEvent:43 ] - Thing 'mysensors:temperature:4a73d1fa' has been added. 2015-09-26 11:45:06 [DEBUG] [.c.thing.internal.ThingManager:363 ] - Thing 'mysensors:temperature:4a73d1fa' is tracked by ThingManager. 2015-09-26 11:45:06 [DEBUG] [.c.thing.internal.ThingManager:487 ] - Calling registerHandler handler for thing 'mysensors:temperature:4a73d1fa' at 'org.openhab.binding.mysensors.inter lerFactory@25ceff93'. 2015-09-26 11:45:06 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - mysensors:temperature:4a73d1fa' updated: INITIALIZING 2015-09-26 11:45:06 [DEBUG] [.e.s.config.core.Configuration:89 ] - Setting value (String) 1 to field 'nodeId' in configuration class org.openhab.binding.mysensors.config.MySensorsSe 2015-09-26 11:45:06 [DEBUG] [.e.s.config.core.Configuration:89 ] - Setting value (String) 1 to field 'childId' in configuration class org.openhab.binding.mysensors.config.MySensorsS n 2015-09-26 11:45:06 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - mysensors:temperature:4a73d1fa' updated: ONLINE 2015-09-26 11:45:06 [DEBUG] [.c.thing.internal.ThingManager:84 ] - Thing handler for thing 'mysensors:temperature:4a73d1fa' added. 2015-09-26 11:45:06 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - mysensors:temperature:4a73d1fa' updated: ONLINE 2015-09-26 11:45:06 [DEBUG] [.c.thing.internal.ThingManager:252 ] - Assigning handler for thing 'mysensors:temperature:4a73d1fa'. 2015-09-26 11:45:06 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors:temperature:4a73d1fa to ManagedThingProvider. 2015-09-26 11:45:06 [INFO ] [smarthome.event.ItemAddedEvent:43 ] - Item 'mysensors_temperature_4a73d1fa' has been added. 2015-09-26 11:45:06 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_temperature_4a73d1fa to ManagedItemProvider. 2015-09-26 11:45:06 [DEBUG] [.c.t.internal.ThingLinkManager:328 ] - Assigning linked group item 'mysensors_temperature_4a73d1fa' to thing 'mysensors:temperature:4a73d1fa'. 2015-09-26 11:45:06 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_temperature_4a73d1fa -> mysensors:temperature:4a73d1fa to ManagedItemThingLinkProvider 2015-09-26 11:45:06 [INFO ] [smarthome.event.ItemAddedEvent:43 ] - Item 'mysensors_temperature_4a73d1fa_temp' has been added. 2015-09-26 11:45:06 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_temperature_4a73d1fa_temp to ManagedItemProvider. 2015-09-26 11:45:06 [DEBUG] [.c.t.internal.ThingLinkManager:317 ] - Adding linked item 'mysensors_temperature_4a73d1fa_temp' to channel 'mysensors:temperature:4a73d1fa:temp'. 2015-09-26 11:45:06 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_temperature_4a73d1fa_temp -> mysensors:temperature:4a73d1fa:temp to ManagedItemChannel 2015-09-26 11:45:06 [DEBUG] [i.DiscoveryServiceRegistryImpl:333 ] - Triggering scan for thing types '[mysensors:humidity, mysensors:temperature, mysensors:light, mysensors:volt, myse nsors:baro, mysensors:door, mysensors:motion, mysensors:smoke, mysensors:dimmer, mysensors:cover, mysensors:wind, mysensors:rain, mysensors:uv, mysensors:weight, mysensors:distance, m vel]' on 'MySensorsDiscoveryService'... 2015-09-26 11:45:14 [DEBUG] [io.rest.core.item.ItemResource:127 ] - Received HTTP GET request at 'items' 2015-09-26 11:45:40 [DEBUG] [io.rest.core.item.ItemResource:127 ] - Received HTTP GET request at 'items' 2015-09-26 11:46:00 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 0;0;3;0;14;Gateway startup complete. 2015-09-26 11:46:09 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;37 2015-09-26 11:46:21 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;38 2015-09-26 11:46:27 [DEBUG] [io.rest.core.item.ItemResource:127 ] - Received HTTP GET request at 'items' 2015-09-26 11:48:03 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;1;1;0;0;22.2 2015-09-26 11:48:03 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_temperature_4a73d1fa_temp updated to 22.2 2015-09-26 11:48:03 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;37 2015-09-26 11:49:32 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;36 2015-09-26 11:49:45 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;1;1;0;0;22.1 2015-09-26 11:49:45 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_temperature_4a73d1fa_temp updated to 22.1 2015-09-26 11:49:45 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;35 2015-09-26 11:49:57 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;36 2015-09-26 11:50:10 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;35 2015-09-26 11:50:23 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;0;1;0;1;45 2015-09-26 11:50:23 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_humidity_7d1da077_hum updated to 45 2015-09-26 11:50:23 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;34 2015-09-26 11:50:36 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;35 2015-09-26 11:51:01 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;36 2015-09-26 11:51:14 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;35 2015-09-26 11:52:05 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;34 2015-09-26 11:52:30 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;35 2015-09-26 11:53:08 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2; 7 2015-09-26 11:53:21 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;1;1;0;0;22.2 2015-09-26 11:53:21 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_temperature_4a73d1fa_temp updated to 22.2 2015-09-26 11:53:21 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;33 2015-09-26 11:53:33 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2; 6 2015-09-26 11:53:46 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;33 2015-09-26 11:53:59 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;34 2015-09-26 11:56:06 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2; 5 2015-09-26 11:56:19 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;1;1;0;0;23.8 2015-09-26 11:56:19 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_temperature_4a73d1fa_temp updated to 23.8 2015-09-26 11:56:19 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;0;1;0;1;69 2015-09-26 11:56:19 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_humidity_7d1da077_hum updated to 69 2015-09-26 11:56:19 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2; 3 2015-09-26 11:56:31 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;1;1;0;0;22.5 2015-09-26 11:56:31 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_temperature_4a73d1fa_temp updated to 22.5 2015-09-26 11:56:31 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;0;1;0;1;81 2015-09-26 11:56:31 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_humidity_7d1da077_hum updated to 81 2015-09-26 11:56:31 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;32 2015-09-26 11:56:44 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;1;1;0;0;22.2 2015-09-26 11:56:44 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_temperature_4a73d1fa_temp updated to 22.2 2015-09-26 11:56:44 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;0;1;0;1;77 2015-09-26 11:56:44 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_humidity_7d1da077_hum updated to 77 2015-09-26 11:56:44 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2; 8 2015-09-26 11:56:57 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;1;1;0;0;22.4 2015-09-26 11:56:57 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_temperature_4a73d1fa_temp updated to 22.4 2015-09-26 11:56:57 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;0;1;0;1;65 2015-09-26 11:56:57 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_humidity_7d1da077_hum updated to 65 2015-09-26 11:56:57 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;34 2015-09-26 11:57:10 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;0;1;0;1;57 2015-09-26 11:57:10 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_humidity_7d1da077_hum updated to 57 2015-09-26 11:57:22 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;0;1;0;1;53 2015-09-26 11:57:22 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_humidity_7d1da077_hum updated to 53 2015-09-26 11:57:22 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;35 2015-09-26 11:57:35 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;0;1;0;1;50 2015-09-26 11:57:35 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_humidity_7d1da077_hum updated to 50 2015-09-26 11:57:35 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;19 2015-09-26 11:57:48 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;0;1;0;1;49 2015-09-26 11:57:48 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_humidity_7d1da077_hum updated to 49 2015-09-26 11:57:48 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;30 2015-09-26 11:58:00 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;1;1;0;0;22.3 2015-09-26 11:58:00 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_temperature_4a73d1fa_temp updated to 22.3 2015-09-26 11:58:00 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;0;1;0;1;48 2015-09-26 11:58:00 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_humidity_7d1da077_hum updated to 48 2015-09-26 11:58:00 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;26 2015-09-26 11:58:13 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;0;1;0;1;47 2015-09-26 11:58:13 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_humidity_7d1da077_hum updated to 47 2015-09-26 11:58:26 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;29 2015-09-26 11:58:39 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;0;1;0;1;46 2015-09-26 11:58:39 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_humidity_7d1da077_hum updated to 46 2015-09-26 11:58:39 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;27 2015-09-26 11:58:51 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;1;1;0;0;22.2 2015-09-26 11:59:09 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;1;1;0;0;22.3 2015-09-26 11:59:09 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_temperature_4a73d1fa_temp updated to 22.2 2015-09-26 11:59:09 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_temperature_4a73d1fa_temp updated to 22.3 2015-09-26 11:59:17 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;32Thank you
-
@BenCranston I finally found some time to further investigate this issue. Your guess according to the serial port issue was right. I've managed to "fix" the zwave binding using the code found while following the thread you mentioned.
I've created a modified version of the zwave binding:
org.openhab.binding.zwave-1.8.0-SNAPSHOT.jar
org.openhab.binding.mysensors-2.0.0-SNAPSHOT.jar
(I've not changed the mysensors binding, just added it for reference)Could you please test it? The binding is throwing messages and trying to contact the zwave gateway/stick:
2015-10-13 08:32:44 [DEBUG] [o.b.z.i.protocol.SerialMessage:109 ] - NODE 255: Creating empty message of class = GetVersion (0x15), type = Request (0x00) 2015-10-13 08:32:44 [DEBUG] [b.z.i.protocol.ZWaveController:637 ] - Enqueueing message. Queue length = 1 2015-10-13 08:32:44 [DEBUG] [WaveController$ZWaveSendThread:1228 ] - Took message from queue for sending. Queue length = 0 2015-10-13 08:32:44 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ] - Assembled message buffer = 01 03 00 15 E9 2015-10-13 08:32:44 [DEBUG] [o.b.z.i.protocol.SerialMessage:109 ] - NODE 255: Creating empty message of class = MemoryGetId (0x20), type = Request (0x00) 2015-10-13 08:32:44 [DEBUG] [b.z.i.protocol.ZWaveController:637 ] - Enqueueing message. Queue length = 1 2015-10-13 08:32:44 [DEBUG] [WaveController$ZWaveSendThread:1285 ] - NODE 255: Sending REQUEST Message = 01 03 00 15 E9 2015-10-13 08:32:44 [DEBUG] [o.b.z.i.protocol.SerialMessage:109 ] - NODE 255: Creating empty message of class = SerialApiGetCapabilities (0x07), type = Request (0x00) 2015-10-13 08:32:44 [DEBUG] [b.z.i.protocol.ZWaveController:637 ] - Enqueueing message. Queue length = 2 2015-10-13 08:32:44 [DEBUG] [o.b.z.i.protocol.SerialMessage:109 ] - NODE 255: Creating empty message of class = SerialApiSetTimeouts (0x06), type = Request (0x00) 2015-10-13 08:32:44 [DEBUG] [b.z.i.protocol.ZWaveController:637 ] - Enqueueing message. Queue length = 3 2015-10-13 08:32:44 [DEBUG] [i.p.s.GetSucNodeIdMessageClass:30 ] - Get SUC NodeID 2015-10-13 08:32:44 [DEBUG] [o.b.z.i.protocol.SerialMessage:109 ] - NODE 255: Creating empty message of class = GetSucNodeId (0x56), type = Request (0x00) 2015-10-13 08:32:44 [DEBUG] [b.z.i.protocol.ZWaveController:637 ] - Enqueueing message. Queue length = 4 2015-10-13 08:32:46 [DEBUG] [z.internal.ZWaveNetworkMonitor:315 ] - Network Monitor: Queue length is 4 - deferring network monitor functions. 2015-10-13 08:32:49 [ERROR] [WaveController$ZWaveSendThread:1326 ] - NODE 255: Timeout while sending message. Requeueing - 2 attempts left! 2015-10-13 08:32:49 [DEBUG] [b.z.i.protocol.ZWaveController:637 ] - Enqueueing message. Queue length = 5 2015-10-13 08:32:49 [DEBUG] [WaveController$ZWaveSendThread:1228 ] - Took message from queue for sending. Queue length = 4 2015-10-13 08:32:49 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ] - Assembled message buffer = 01 03 00 15 E9 2015-10-13 08:32:49 [DEBUG] [WaveController$ZWaveSendThread:1285 ] - NODE 255: Sending REQUEST Message = 01 03 00 15 E9 -
Hi @TimO
I have a ESP8266 as Ethernet GW and a Nano with a S_HUM, S_TEMP and a S_LIGHT_LEVEL.
I follow as described steps and the S_TEMP sensor is updated almost immediately, the S_HUM takes some minutes and the S_LIGHT_LEVEL is never updated.Can you take a look please?
Launching the openHAB runtime... Listening for transport dt_socket at address: 8001 2015-09-26 11:42:26 [DEBUG] [s.m.i.r.i.ItemRuntimeActivator:23 ] - Registered 'item' configuration parser 2015-09-26 11:42:26 [INFO ] [uartz.impl.StdSchedulerFactory:1184 ] - Using default implementation for ThreadExecutor 2015-09-26 11:42:26 [INFO ] [rtz.core.SchedulerSignalerImpl:61 ] - Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl 2015-09-26 11:42:26 [INFO ] [rg.quartz.core.QuartzScheduler:240 ] - Quartz Scheduler v.2.2.1 created. 2015-09-26 11:42:26 [INFO ] [org.quartz.simpl.RAMJobStore :155 ] - RAMJobStore initialized. 2015-09-26 11:42:26 [INFO ] [rg.quartz.core.QuartzScheduler:305 ] - Scheduler meta-data: Quartz Scheduler (v2.2.1) 'openHAB-job-scheduler' with instanceId 'NON_CLUSTERED' Scheduler class: 'org.quartz.core.QuartzScheduler' - running locally. NOT STARTED. Currently in standby mode. Number of jobs executed: 0 Using thread pool 'org.quartz.simpl.SimpleThreadPool' - with 2 threads. Using job-store 'org.quartz.simpl.RAMJobStore' - which does not support persistence. and is not clustered. 2015-09-26 11:42:26 [INFO ] [uartz.impl.StdSchedulerFactory:1339 ] - Quartz scheduler 'openHAB-job-scheduler' initialized from specified file: './runtime/etc/quartz.properties' 2015-09-26 11:42:26 [INFO ] [uartz.impl.StdSchedulerFactory:1343 ] - Quartz scheduler version: 2.2.1 2015-09-26 11:42:26 [DEBUG] [.i.PersistenceRuntimeActivator:23 ] - Registered 'persistence' configuration parser 2015-09-26 11:42:26 [DEBUG] [s.m.r.r.i.RuleRuntimeActivator:35 ] - Registered 'rule' configuration parser 2015-09-26 11:42:26 [DEBUG] [m.s.r.i.ScriptRuntimeActivator:22 ] - Registered 'script' configuration parser 2015-09-26 11:42:26 [DEBUG] [.s.r.i.SitemapRuntimeActivator:23 ] - Registered 'sitemap' configuration parser 2015-09-26 11:42:26 [DEBUG] [.m.t.r.i.ThingRuntimeActivator:23 ] - Registered 'thing' configuration parser osgi> 2015-09-26 11:42:27 [WARN ] [.j.s.handler.RequestLogHandler:137 ] - !RequestLog 2015-09-26 11:42:27 [DEBUG] [.c.d.internal.ConfigDispatcher:222 ] - Processing config file 'services.cfg' 2015-09-26 11:42:27 [DEBUG] [.c.d.internal.ConfigDispatcher:222 ] - Processing config file 'runtime.cfg' 2015-09-26 11:42:28 [DEBUG] [.s.core.internal.CoreActivator:30 ] - Core bundle has been started. 2015-09-26 11:42:28 [DEBUG] [.e.s.c.a.i.AutoUpdateActivator:29 ] - AutoUpdate binding has been started. 2015-09-26 11:42:28 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/binding/binding.xml' in module 'org.openhab.binding.mysensors'... 2015-09-26 11:42:28 [DEBUG] [o.e.s.c.s.i.SchedulerActivator:34 ] - Scheduler has been started. 2015-09-26 11:42:28 [INFO ] [rg.quartz.core.QuartzScheduler:575 ] - Scheduler openHAB-job-scheduler_$_NON_CLUSTERED started. 2015-09-26 11:42:28 [DEBUG] [c.x.o.XmlDocumentBundleTracker:159 ] - Create an empty XmlDocumentProvider for the module 'org.openhab.binding.mysensors'. 2015-09-26 11:42:28 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/channels.xml' in module 'org.openhab.binding.mysensors'... 2015-09-26 11:42:28 [DEBUG] [.c.t.i.TransformationActivator:34 ] - Transformation Service has been started. 2015-09-26 11:42:28 [DEBUG] [c.x.o.XmlDocumentBundleTracker:159 ] - Create an empty XmlDocumentProvider for the module 'org.openhab.binding.mysensors'. 2015-09-26 11:42:28 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/thing-types.xml' in module 'org.openhab.binding.mysensors'... 2015-09-26 11:42:28 [DEBUG] [.e.s.i.m.i.MultimediaActivator:32 ] - Multimedia I/O bundle has been started. 2015-09-26 11:42:28 [DEBUG] [c.x.o.XmlDocumentBundleTracker:118 ] - Reading the XML document '/ESH-INF/thing/bridges.xml' in module 'org.openhab.binding.mysensors'... 2015-09-26 11:42:28 [DEBUG] [io.rest.internal.RESTActivator:32 ] - REST API has been started. 2015-09-26 11:42:28 [DEBUG] [s.i.t.m.internal.MDNSActivator:27 ] - mDNS service has been started. 2015-09-26 11:42:28 [DEBUG] [.i.t.m.internal.MDNSClientImpl:37 ] - mDNS service has been started 2015-09-26 11:42:28 [DEBUG] [i.t.m.internal.MDNSServiceImpl:85 ] - Registering new service _openhab-server._tcp.local. at port 8080 2015-09-26 11:42:28 [DEBUG] [i.t.m.internal.MDNSServiceImpl:85 ] - Registering new service _openhab-server-ssl._tcp.local. at port 8443 2015-09-26 11:42:28 [DEBUG] [.i.r.sse.internal.SseActivator:46 ] - SSE API - SseFeature registered. 2015-09-26 11:42:28 [DEBUG] [.i.r.sse.internal.SseActivator:55 ] - SSE API has been started. 2015-09-26 11:42:28 [DEBUG] [.io.transport.mqtt.MqttService:118 ] - Starting MQTT Service... 2015-09-26 11:42:28 [DEBUG] [.s.s.mapdb.MapDbStorageService:50 ] - Opened MapDB file at 'D:\Downloads\openhab2\.\userdata\mapdb\storage.mapdb'. 2015-09-26 11:42:28 [DEBUG] [.c.c.registry.AbstractRegistry:190 ] - Provider 'org.eclipse.smarthome.core.items.ManagedItemProvider' has been added. 2015-09-26 11:42:28 [DEBUG] [.c.c.registry.AbstractRegistry:190 ] - Provider 'org.eclipse.smarthome.core.thing.ManagedThingProvider' has been added. 2015-09-26 11:42:28 [DEBUG] [.core.common.ThreadPoolManager:141 ] - Created scheduled thread pool 'discovery' of size 3 2015-09-26 11:42:28 [DEBUG] [.c.thing.internal.ThingManager:549 ] - Thing handler factory 'MySensorsHandlerFactory' added 2015-09-26 11:42:28 [DEBUG] [.c.c.registry.AbstractRegistry:190 ] - Provider 'org.eclipse.smarthome.core.thing.link.ManagedItemChannelLinkProvider' has been added. 2015-09-26 11:42:28 [DEBUG] [.c.c.registry.AbstractRegistry:190 ] - Provider 'org.eclipse.smarthome.core.thing.link.ManagedItemThingLinkProvider' has been added. 2015-09-26 11:42:28 [DEBUG] [ui.internal.chart.ChartServlet:122 ] - Starting up chart servlet at /chart 2015-09-26 11:42:28 [DEBUG] [u.i.chart.DefaultChartProvider:97 ] - Starting up default chart provider. 2015-09-26 11:42:28 [DEBUG] [o.e.s.u.c.i.servlet.CmdServlet:56 ] - Starting up CMD servlet at /classicui/CMD 2015-09-26 11:42:28 [DEBUG] [s.ui.icon.internal.IconServlet:76 ] - Starting up icon servlet at /icon 2015-09-26 11:42:28 [INFO ] [ui.internal.servlet.PaperUIApp:31 ] - Started Paper UI at /ui 2015-09-26 11:42:29 [DEBUG] [e.s.i.t.upnp.UpnpIOServiceImpl:152 ] - Starting UPnP IO service... 2015-09-26 11:42:29 [INFO ] [.u.d.internal.DashboardService:55 ] - Started dashboard at /start 2015-09-26 11:42:29 [DEBUG] [.c.c.registry.AbstractRegistry:190 ] - Provider 'org.eclipse.smarthome.model.item.internal.GenericItemProvider' has been added. 2015-09-26 11:42:29 [INFO ] [rg.quartz.core.QuartzScheduler:2311 ] - JobFactory set to: org.eclipse.smarthome.model.rule.runtime.internal.engine.GuiceAwareJobFactory@1762bd77 2015-09-26 11:42:29 [DEBUG] [.m.r.r.i.engine.RuleEngineImpl:96 ] - Started rule engine 2015-09-26 11:42:29 [INFO ] [.s.u.c.i.servlet.WebAppServlet:85 ] - Started Classic UI at /classicui/app 2015-09-26 11:42:29 [DEBUG] [e.s.m.t.i.GenericThingProvider:696 ] - ThingHandlerFactory added org.openhab.binding.mysensors.internal.MySensorsHandlerFactory@25ceff93 2015-09-26 11:42:29 [DEBUG] [.c.c.registry.AbstractRegistry:190 ] - Provider 'org.eclipse.smarthome.model.thing.internal.GenericThingProvider' has been added. 2015-09-26 11:42:29 [DEBUG] [.c.c.registry.AbstractRegistry:190 ] - Provider 'org.eclipse.smarthome.model.thing.internal.GenericItemChannelLinkProvider' has been added. 2015-09-26 11:42:29 [DEBUG] [ui.internal.proxy.ProxyServlet:94 ] - Starting up proxy servlet at /proxy 2015-09-26 11:42:29 [INFO ] [.o.core.internal.CoreActivator:41 ] - openHAB runtime has been started (v2.0.0, build 201509240103). 2015-09-26 11:42:29 [DEBUG] [.o.core.internal.CoreActivator:47 ] - Startup took 6896 ms 2015-09-26 11:42:36 [DEBUG] [io.rest.core.item.ItemResource:127 ] - Received HTTP GET request at 'items' 2015-09-26 11:42:49 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element home_group_daef4dc3 to ManagedItemProvider. 2015-09-26 11:42:49 [DEBUG] [.core.common.ThreadPoolManager:171 ] - Created thread pool 'safeCall' with size 3-10 2015-09-26 11:42:49 [INFO ] [smarthome.event.ItemAddedEvent:43 ] - Item 'home_group_daef4dc3' has been added. 2015-09-26 11:43:31 [DEBUG] [.c.thing.internal.ThingManager:363 ] - Thing 'mysensors:bridge-eth:c27764bd' is tracked by ThingManager. 2015-09-26 11:43:31 [INFO ] [marthome.event.ThingAddedEvent:43 ] - Thing 'mysensors:bridge-eth:c27764bd' has been added. 2015-09-26 11:43:31 [DEBUG] [.c.thing.internal.ThingManager:487 ] - Calling registerHandler handler for thing 'mysensors:bridge-eth:c27764bd' at 'org.openhab.binding.mysensors.intern erFactory@25ceff93'. 2015-09-26 11:43:31 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - mysensors:bridge-eth:c27764bd' updated: INITIALIZING 2015-09-26 11:43:31 [DEBUG] [.core.common.ThreadPoolManager:141 ] - Created scheduled thread pool 'thingHandler' of size 3 2015-09-26 11:43:31 [DEBUG] [o.b.m.h.MySensorsBridgeHandler:58 ] - Initialization of the MySensors Bridge 2015-09-26 11:43:31 [DEBUG] [.e.s.config.core.Configuration:89 ] - Setting value (String) 192.168.0.17 to field 'ipAddress' in configuration class org.openhab.binding.mysensors.conf eConfiguration 2015-09-26 11:43:31 [DEBUG] [.e.s.config.core.Configuration:89 ] - Setting value (String) 5003 to field 'tcpPort' in configuration class org.openhab.binding.mysensors.config.MySenso tion 2015-09-26 11:43:31 [DEBUG] [b.m.p.ip.MySensorsIpConnection:40 ] - Connecting to bridge ... 2015-09-26 11:43:31 [DEBUG] [b.m.p.ip.MySensorsIpConnection:56 ] - Connection to ethernet gateway successful! 2015-09-26 11:43:31 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - mysensors:bridge-eth:c27764bd' updated: ONLINE 2015-09-26 11:43:31 [DEBUG] [.c.thing.internal.ThingManager:84 ] - Thing handler for thing 'mysensors:bridge-eth:c27764bd' added. 2015-09-26 11:43:31 [DEBUG] [.c.thing.internal.ThingManager:252 ] - Assigning handler for thing 'mysensors:bridge-eth:c27764bd'. 2015-09-26 11:43:31 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors:bridge-eth:c27764bd to ManagedThingProvider. 2015-09-26 11:43:31 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 0;0;3;0;14;Gateway startup complete. 2015-09-26 11:43:32 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_bridge_eth_c27764bd to ManagedItemProvider. 2015-09-26 11:43:32 [INFO ] [smarthome.event.ItemAddedEvent:43 ] - Item 'mysensors_bridge_eth_c27764bd' has been added. 2015-09-26 11:43:32 [DEBUG] [.c.t.internal.ThingLinkManager:328 ] - Assigning linked group item 'mysensors_bridge_eth_c27764bd' to thing 'mysensors:bridge-eth:c27764bd'. 2015-09-26 11:43:32 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_bridge_eth_c27764bd -> mysensors:bridge-eth:c27764bd to ManagedItemThingLinkProvider. 2015-09-26 11:43:32 [DEBUG] [i.DiscoveryServiceRegistryImpl:333 ] - Triggering scan for thing types '[mysensors:humidity, mysensors:temperature, mysensors:light, mysensors:volt, myse nsors:baro, mysensors:door, mysensors:motion, mysensors:smoke, mysensors:dimmer, mysensors:cover, mysensors:wind, mysensors:rain, mysensors:uv, mysensors:weight, mysensors:distance, m vel]' on 'MySensorsDiscoveryService'... 2015-09-26 11:44:02 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;37 2015-09-26 11:44:14 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;38 2015-09-26 11:44:16 [DEBUG] [.c.thing.internal.ThingManager:363 ] - Thing 'mysensors:humidity:7d1da077' is tracked by ThingManager. 2015-09-26 11:44:16 [DEBUG] [.c.thing.internal.ThingManager:487 ] - Calling registerHandler handler for thing 'mysensors:humidity:7d1da077' at 'org.openhab.binding.mysensors.internal Factory@25ceff93'. 2015-09-26 11:44:16 [INFO ] [marthome.event.ThingAddedEvent:43 ] - Thing 'mysensors:humidity:7d1da077' has been added. 2015-09-26 11:44:16 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - mysensors:humidity:7d1da077' updated: INITIALIZING 2015-09-26 11:44:16 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - mysensors:humidity:7d1da077' updated: ONLINE 2015-09-26 11:44:16 [DEBUG] [.e.s.config.core.Configuration:89 ] - Setting value (String) 1 to field 'nodeId' in configuration class org.openhab.binding.mysensors.config.MySensorsSe 2015-09-26 11:44:16 [DEBUG] [.e.s.config.core.Configuration:89 ] - Setting value (String) 0 to field 'childId' in configuration class org.openhab.binding.mysensors.config.MySensorsS n 2015-09-26 11:44:16 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - mysensors:humidity:7d1da077' updated: ONLINE 2015-09-26 11:44:16 [DEBUG] [.c.thing.internal.ThingManager:84 ] - Thing handler for thing 'mysensors:humidity:7d1da077' added. 2015-09-26 11:44:16 [DEBUG] [.c.thing.internal.ThingManager:252 ] - Assigning handler for thing 'mysensors:humidity:7d1da077'. 2015-09-26 11:44:16 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors:humidity:7d1da077 to ManagedThingProvider. 2015-09-26 11:44:16 [INFO ] [smarthome.event.ItemAddedEvent:43 ] - Item 'mysensors_humidity_7d1da077' has been added. 2015-09-26 11:44:16 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_humidity_7d1da077 to ManagedItemProvider. 2015-09-26 11:44:16 [DEBUG] [.c.t.internal.ThingLinkManager:328 ] - Assigning linked group item 'mysensors_humidity_7d1da077' to thing 'mysensors:humidity:7d1da077'. 2015-09-26 11:44:16 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_humidity_7d1da077 -> mysensors:humidity:7d1da077 to ManagedItemThingLinkProvider. 2015-09-26 11:44:17 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_humidity_7d1da077_hum to ManagedItemProvider. 2015-09-26 11:44:17 [INFO ] [smarthome.event.ItemAddedEvent:43 ] - Item 'mysensors_humidity_7d1da077_hum' has been added. 2015-09-26 11:44:17 [DEBUG] [.c.t.internal.ThingLinkManager:317 ] - Adding linked item 'mysensors_humidity_7d1da077_hum' to channel 'mysensors:humidity:7d1da077:hum'. 2015-09-26 11:44:17 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_humidity_7d1da077_hum -> mysensors:humidity:7d1da077:hum to ManagedItemChannelLinkProv 2015-09-26 11:44:17 [DEBUG] [i.DiscoveryServiceRegistryImpl:333 ] - Triggering scan for thing types '[mysensors:humidity, mysensors:temperature, mysensors:light, mysensors:volt, myse nsors:baro, mysensors:door, mysensors:motion, mysensors:smoke, mysensors:dimmer, mysensors:cover, mysensors:wind, mysensors:rain, mysensors:uv, mysensors:weight, mysensors:distance, m vel]' on 'MySensorsDiscoveryService'... 2015-09-26 11:44:27 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;37 2015-09-26 11:44:48 [DEBUG] [.c.thing.internal.ThingManager:363 ] - Thing 'mysensors:light-level:9e706943' is tracked by ThingManager. 2015-09-26 11:44:48 [INFO ] [marthome.event.ThingAddedEvent:43 ] - Thing 'mysensors:light-level:9e706943' has been added. 2015-09-26 11:44:48 [DEBUG] [.c.thing.internal.ThingManager:487 ] - Calling registerHandler handler for thing 'mysensors:light-level:9e706943' at 'org.openhab.binding.mysensors.inter lerFactory@25ceff93'. 2015-09-26 11:44:48 [DEBUG] [.e.s.config.core.Configuration:89 ] - Setting value (String) 1 to field 'nodeId' in configuration class org.openhab.binding.mysensors.config.MySensorsSe 2015-09-26 11:44:48 [DEBUG] [.e.s.config.core.Configuration:89 ] - Setting value (String) 2 to field 'childId' in configuration class org.openhab.binding.mysensors.config.MySensorsS n 2015-09-26 11:44:48 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - mysensors:light-level:9e706943' updated: INITIALIZING 2015-09-26 11:44:48 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - mysensors:light-level:9e706943' updated: ONLINE 2015-09-26 11:44:48 [DEBUG] [.c.thing.internal.ThingManager:84 ] - Thing handler for thing 'mysensors:light-level:9e706943' added. 2015-09-26 11:44:48 [DEBUG] [.c.thing.internal.ThingManager:252 ] - Assigning handler for thing 'mysensors:light-level:9e706943'. 2015-09-26 11:44:48 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - mysensors:light-level:9e706943' updated: ONLINE 2015-09-26 11:44:48 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors:light-level:9e706943 to ManagedThingProvider. 2015-09-26 11:44:48 [INFO ] [smarthome.event.ItemAddedEvent:43 ] - Item 'mysensors_light_level_9e706943' has been added. 2015-09-26 11:44:48 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_light_level_9e706943 to ManagedItemProvider. 2015-09-26 11:44:48 [DEBUG] [.c.t.internal.ThingLinkManager:328 ] - Assigning linked group item 'mysensors_light_level_9e706943' to thing 'mysensors:light-level:9e706943'. 2015-09-26 11:44:48 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_light_level_9e706943 -> mysensors:light-level:9e706943 to ManagedItemThingLinkProvider 2015-09-26 11:44:48 [INFO ] [smarthome.event.ItemAddedEvent:43 ] - Item 'mysensors_light_level_9e706943_light_level' has been added. 2015-09-26 11:44:48 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_light_level_9e706943_light_level to ManagedItemProvider. 2015-09-26 11:44:48 [DEBUG] [.c.t.internal.ThingLinkManager:317 ] - Adding linked item 'mysensors_light_level_9e706943_light_level' to channel 'mysensors:light-level:9e706943:light-l 2015-09-26 11:44:48 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_light_level_9e706943_light_level -> mysensors:light-level:9e706943:light-level to Mana kProvider. 2015-09-26 11:44:48 [DEBUG] [i.DiscoveryServiceRegistryImpl:333 ] - Triggering scan for thing types '[mysensors:humidity, mysensors:temperature, mysensors:light, mysensors:volt, myse nsors:baro, mysensors:door, mysensors:motion, mysensors:smoke, mysensors:dimmer, mysensors:cover, mysensors:wind, mysensors:rain, mysensors:uv, mysensors:weight, mysensors:distance, m vel]' on 'MySensorsDiscoveryService'... 2015-09-26 11:45:05 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;36 2015-09-26 11:45:06 [INFO ] [marthome.event.ThingAddedEvent:43 ] - Thing 'mysensors:temperature:4a73d1fa' has been added. 2015-09-26 11:45:06 [DEBUG] [.c.thing.internal.ThingManager:363 ] - Thing 'mysensors:temperature:4a73d1fa' is tracked by ThingManager. 2015-09-26 11:45:06 [DEBUG] [.c.thing.internal.ThingManager:487 ] - Calling registerHandler handler for thing 'mysensors:temperature:4a73d1fa' at 'org.openhab.binding.mysensors.inter lerFactory@25ceff93'. 2015-09-26 11:45:06 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - mysensors:temperature:4a73d1fa' updated: INITIALIZING 2015-09-26 11:45:06 [DEBUG] [.e.s.config.core.Configuration:89 ] - Setting value (String) 1 to field 'nodeId' in configuration class org.openhab.binding.mysensors.config.MySensorsSe 2015-09-26 11:45:06 [DEBUG] [.e.s.config.core.Configuration:89 ] - Setting value (String) 1 to field 'childId' in configuration class org.openhab.binding.mysensors.config.MySensorsS n 2015-09-26 11:45:06 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - mysensors:temperature:4a73d1fa' updated: ONLINE 2015-09-26 11:45:06 [DEBUG] [.c.thing.internal.ThingManager:84 ] - Thing handler for thing 'mysensors:temperature:4a73d1fa' added. 2015-09-26 11:45:06 [INFO ] [ome.event.ThingStatusInfoEvent:43 ] - mysensors:temperature:4a73d1fa' updated: ONLINE 2015-09-26 11:45:06 [DEBUG] [.c.thing.internal.ThingManager:252 ] - Assigning handler for thing 'mysensors:temperature:4a73d1fa'. 2015-09-26 11:45:06 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors:temperature:4a73d1fa to ManagedThingProvider. 2015-09-26 11:45:06 [INFO ] [smarthome.event.ItemAddedEvent:43 ] - Item 'mysensors_temperature_4a73d1fa' has been added. 2015-09-26 11:45:06 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_temperature_4a73d1fa to ManagedItemProvider. 2015-09-26 11:45:06 [DEBUG] [.c.t.internal.ThingLinkManager:328 ] - Assigning linked group item 'mysensors_temperature_4a73d1fa' to thing 'mysensors:temperature:4a73d1fa'. 2015-09-26 11:45:06 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_temperature_4a73d1fa -> mysensors:temperature:4a73d1fa to ManagedItemThingLinkProvider 2015-09-26 11:45:06 [INFO ] [smarthome.event.ItemAddedEvent:43 ] - Item 'mysensors_temperature_4a73d1fa_temp' has been added. 2015-09-26 11:45:06 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_temperature_4a73d1fa_temp to ManagedItemProvider. 2015-09-26 11:45:06 [DEBUG] [.c.t.internal.ThingLinkManager:317 ] - Adding linked item 'mysensors_temperature_4a73d1fa_temp' to channel 'mysensors:temperature:4a73d1fa:temp'. 2015-09-26 11:45:06 [DEBUG] [.c.c.r.AbstractManagedProvider:62 ] - Added new element mysensors_temperature_4a73d1fa_temp -> mysensors:temperature:4a73d1fa:temp to ManagedItemChannel 2015-09-26 11:45:06 [DEBUG] [i.DiscoveryServiceRegistryImpl:333 ] - Triggering scan for thing types '[mysensors:humidity, mysensors:temperature, mysensors:light, mysensors:volt, myse nsors:baro, mysensors:door, mysensors:motion, mysensors:smoke, mysensors:dimmer, mysensors:cover, mysensors:wind, mysensors:rain, mysensors:uv, mysensors:weight, mysensors:distance, m vel]' on 'MySensorsDiscoveryService'... 2015-09-26 11:45:14 [DEBUG] [io.rest.core.item.ItemResource:127 ] - Received HTTP GET request at 'items' 2015-09-26 11:45:40 [DEBUG] [io.rest.core.item.ItemResource:127 ] - Received HTTP GET request at 'items' 2015-09-26 11:46:00 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 0;0;3;0;14;Gateway startup complete. 2015-09-26 11:46:09 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;37 2015-09-26 11:46:21 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;38 2015-09-26 11:46:27 [DEBUG] [io.rest.core.item.ItemResource:127 ] - Received HTTP GET request at 'items' 2015-09-26 11:48:03 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;1;1;0;0;22.2 2015-09-26 11:48:03 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_temperature_4a73d1fa_temp updated to 22.2 2015-09-26 11:48:03 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;37 2015-09-26 11:49:32 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;36 2015-09-26 11:49:45 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;1;1;0;0;22.1 2015-09-26 11:49:45 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_temperature_4a73d1fa_temp updated to 22.1 2015-09-26 11:49:45 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;35 2015-09-26 11:49:57 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;36 2015-09-26 11:50:10 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;35 2015-09-26 11:50:23 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;0;1;0;1;45 2015-09-26 11:50:23 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_humidity_7d1da077_hum updated to 45 2015-09-26 11:50:23 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;34 2015-09-26 11:50:36 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;35 2015-09-26 11:51:01 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;36 2015-09-26 11:51:14 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;35 2015-09-26 11:52:05 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;34 2015-09-26 11:52:30 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;35 2015-09-26 11:53:08 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2; 7 2015-09-26 11:53:21 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;1;1;0;0;22.2 2015-09-26 11:53:21 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_temperature_4a73d1fa_temp updated to 22.2 2015-09-26 11:53:21 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;33 2015-09-26 11:53:33 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2; 6 2015-09-26 11:53:46 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;33 2015-09-26 11:53:59 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;34 2015-09-26 11:56:06 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2; 5 2015-09-26 11:56:19 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;1;1;0;0;23.8 2015-09-26 11:56:19 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_temperature_4a73d1fa_temp updated to 23.8 2015-09-26 11:56:19 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;0;1;0;1;69 2015-09-26 11:56:19 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_humidity_7d1da077_hum updated to 69 2015-09-26 11:56:19 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2; 3 2015-09-26 11:56:31 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;1;1;0;0;22.5 2015-09-26 11:56:31 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_temperature_4a73d1fa_temp updated to 22.5 2015-09-26 11:56:31 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;0;1;0;1;81 2015-09-26 11:56:31 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_humidity_7d1da077_hum updated to 81 2015-09-26 11:56:31 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;32 2015-09-26 11:56:44 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;1;1;0;0;22.2 2015-09-26 11:56:44 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_temperature_4a73d1fa_temp updated to 22.2 2015-09-26 11:56:44 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;0;1;0;1;77 2015-09-26 11:56:44 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_humidity_7d1da077_hum updated to 77 2015-09-26 11:56:44 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2; 8 2015-09-26 11:56:57 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;1;1;0;0;22.4 2015-09-26 11:56:57 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_temperature_4a73d1fa_temp updated to 22.4 2015-09-26 11:56:57 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;0;1;0;1;65 2015-09-26 11:56:57 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_humidity_7d1da077_hum updated to 65 2015-09-26 11:56:57 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;34 2015-09-26 11:57:10 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;0;1;0;1;57 2015-09-26 11:57:10 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_humidity_7d1da077_hum updated to 57 2015-09-26 11:57:22 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;0;1;0;1;53 2015-09-26 11:57:22 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_humidity_7d1da077_hum updated to 53 2015-09-26 11:57:22 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;35 2015-09-26 11:57:35 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;0;1;0;1;50 2015-09-26 11:57:35 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_humidity_7d1da077_hum updated to 50 2015-09-26 11:57:35 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;19 2015-09-26 11:57:48 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;0;1;0;1;49 2015-09-26 11:57:48 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_humidity_7d1da077_hum updated to 49 2015-09-26 11:57:48 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;30 2015-09-26 11:58:00 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;1;1;0;0;22.3 2015-09-26 11:58:00 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_temperature_4a73d1fa_temp updated to 22.3 2015-09-26 11:58:00 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;0;1;0;1;48 2015-09-26 11:58:00 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_humidity_7d1da077_hum updated to 48 2015-09-26 11:58:00 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;26 2015-09-26 11:58:13 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;0;1;0;1;47 2015-09-26 11:58:13 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_humidity_7d1da077_hum updated to 47 2015-09-26 11:58:26 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;29 2015-09-26 11:58:39 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;0;1;0;1;46 2015-09-26 11:58:39 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_humidity_7d1da077_hum updated to 46 2015-09-26 11:58:39 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;27 2015-09-26 11:58:51 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;1;1;0;0;22.2 2015-09-26 11:59:09 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;1;1;0;0;22.3 2015-09-26 11:59:09 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_temperature_4a73d1fa_temp updated to 22.2 2015-09-26 11:59:09 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_temperature_4a73d1fa_temp updated to 22.3 2015-09-26 11:59:17 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;2;1;0;2;32Thank you
Hello @Daniel-Oliveira!
- S_Temp looks good:
2015-09-26 11:56:57 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;1;1;0;0;22.4 2015-09-26 11:56:57 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_temperature_4a73d1fa_temp updated to 22.4- S_HUM looks good too:
2015-09-26 11:56:57 [DEBUG] [b.m.p.ip.MySensorsIpConnection:72 ] - 1;0;1;0;1;65 2015-09-26 11:56:57 [INFO ] [smarthome.event.ItemStateEvent:43 ] - mysensors_humidity_7d1da077_hum updated to 65I can't see a reason why it should not update correctly. Could be a bug in the OH2 runtime? Does this bug persist with a current runtime?
- S_LIGHT_LEVEL
1;2;1;0;2;36With subtype 2 (V_STATUS) the binding is expecting 1 == ON or 2 == OFF.
For light level the binding is expecting V_PERCENTAGE.So a message like this should work:
1;2;1;0;3;36 -
Hi @TimO . Great work so far. I'd like to join in and extend your module with a lot more S_ and V_ types. Your Github repo code was updated 3 months ago. Do you want to push your commits so I can fork it?
Also another question: Do I need something special or is the default OpenHAB 2 IDE as described on the OpenHAB2 page enough to start?
-
Hi @SiLeX !
I would really appreciate your help!
My Repo is up to date, there are no open code changes. I've merged my Repo with the master/upstream, so OH2 too is up to date.The instructions here should work just fine, although I didn't set up my environment this way:
https://github.com/wishmoooop/openhab2/blob/master/docs/sources/development/ide.mdThere is only one step needed to activate the MySensors binding, it is an addition to the step 8 in the instructions:
- Click on "Run"
- Click on "Run Configurations ..."
- Select "OpenHAB_Runtime" on the left
- Switch to "Plug-Ins" on the right
- Search for "org.openhab.binding.mysensors" and mark it
(At this step I disable yahooweather and astro so they stop to annoy me with newly discovered locations) ;-)
If "strange" errors occure while testing code changes, delete the content of the "userdata" directory in "distribution/openhabhome".
-
@TimO said:
Search for "org.openhab.binding.mysensors" and mark it
Unfortunately I cannot find this in the list. I already added your fork as upstream master and pulled it. Anything else to change in there?

edit: solved by throwing away the openhab2 dev repo and cloning @TimO 's repo richt after installing the OpenHAB IDE. Alternatively you can create a new workspace and import/clone @TimO 's repo from there.
Run a product stays empty, interesting files are in addons/binding/org.openhab.binding.mysensors/ESH-INF/thing/
-
@powermta : What is your problem? :)
-
@BenCranston I finally found some time to further investigate this issue. Your guess according to the serial port issue was right. I've managed to "fix" the zwave binding using the code found while following the thread you mentioned.
I've created a modified version of the zwave binding:
org.openhab.binding.zwave-1.8.0-SNAPSHOT.jar
org.openhab.binding.mysensors-2.0.0-SNAPSHOT.jar
(I've not changed the mysensors binding, just added it for reference)Could you please test it? The binding is throwing messages and trying to contact the zwave gateway/stick:
2015-10-13 08:32:44 [DEBUG] [o.b.z.i.protocol.SerialMessage:109 ] - NODE 255: Creating empty message of class = GetVersion (0x15), type = Request (0x00) 2015-10-13 08:32:44 [DEBUG] [b.z.i.protocol.ZWaveController:637 ] - Enqueueing message. Queue length = 1 2015-10-13 08:32:44 [DEBUG] [WaveController$ZWaveSendThread:1228 ] - Took message from queue for sending. Queue length = 0 2015-10-13 08:32:44 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ] - Assembled message buffer = 01 03 00 15 E9 2015-10-13 08:32:44 [DEBUG] [o.b.z.i.protocol.SerialMessage:109 ] - NODE 255: Creating empty message of class = MemoryGetId (0x20), type = Request (0x00) 2015-10-13 08:32:44 [DEBUG] [b.z.i.protocol.ZWaveController:637 ] - Enqueueing message. Queue length = 1 2015-10-13 08:32:44 [DEBUG] [WaveController$ZWaveSendThread:1285 ] - NODE 255: Sending REQUEST Message = 01 03 00 15 E9 2015-10-13 08:32:44 [DEBUG] [o.b.z.i.protocol.SerialMessage:109 ] - NODE 255: Creating empty message of class = SerialApiGetCapabilities (0x07), type = Request (0x00) 2015-10-13 08:32:44 [DEBUG] [b.z.i.protocol.ZWaveController:637 ] - Enqueueing message. Queue length = 2 2015-10-13 08:32:44 [DEBUG] [o.b.z.i.protocol.SerialMessage:109 ] - NODE 255: Creating empty message of class = SerialApiSetTimeouts (0x06), type = Request (0x00) 2015-10-13 08:32:44 [DEBUG] [b.z.i.protocol.ZWaveController:637 ] - Enqueueing message. Queue length = 3 2015-10-13 08:32:44 [DEBUG] [i.p.s.GetSucNodeIdMessageClass:30 ] - Get SUC NodeID 2015-10-13 08:32:44 [DEBUG] [o.b.z.i.protocol.SerialMessage:109 ] - NODE 255: Creating empty message of class = GetSucNodeId (0x56), type = Request (0x00) 2015-10-13 08:32:44 [DEBUG] [b.z.i.protocol.ZWaveController:637 ] - Enqueueing message. Queue length = 4 2015-10-13 08:32:46 [DEBUG] [z.internal.ZWaveNetworkMonitor:315 ] - Network Monitor: Queue length is 4 - deferring network monitor functions. 2015-10-13 08:32:49 [ERROR] [WaveController$ZWaveSendThread:1326 ] - NODE 255: Timeout while sending message. Requeueing - 2 attempts left! 2015-10-13 08:32:49 [DEBUG] [b.z.i.protocol.ZWaveController:637 ] - Enqueueing message. Queue length = 5 2015-10-13 08:32:49 [DEBUG] [WaveController$ZWaveSendThread:1228 ] - Took message from queue for sending. Queue length = 4 2015-10-13 08:32:49 [DEBUG] [o.b.z.i.protocol.SerialMessage:233 ] - Assembled message buffer = 01 03 00 15 E9 2015-10-13 08:32:49 [DEBUG] [WaveController$ZWaveSendThread:1285 ] - NODE 255: Sending REQUEST Message = 01 03 00 15 E9@TimO Sorry it took so long to test this. I've been flat on my back due to illness. Regardless, I tested it a bunch this morning and the changes to the zwave binding totally broke zwave functionality. The USB stick initializes but then the port gets "lost" and any attempts to interact with it fail. The change does allow for the MySensors binding to run. I removed the MySensors binding and just left your modified zwave binding in the addons folder to try to isolate the issue. It would appear that the modified zwave binding is broken. I'm going to pull the latest build from cloudbees and try your latest build of the MySensors binding and see what happens.
-
For what it's worth, I'm using openhab 2 with a version from yesterday together with the latest my sensor binding I found here. Serial gateway and serial aeon stick zwave controller (latest binding from the build server). Absolutely no issues for me.
-
For what it's worth, I'm using openhab 2 with a version from yesterday together with the latest my sensor binding I found here. Serial gateway and serial aeon stick zwave controller (latest binding from the build server). Absolutely no issues for me.
@kolaf I concur. I just refreshed everything to latest snapshots and holy smokes it all works. :) I'm watching my zwave rules and MySensors controls all working together. At this point, I'm not sure what was broken with my install, but both bindings are now playing with each other very well without issue.