Fibaro FGMS-001 pairing

rm65453 · September 28, 2015, 11:35pm

I have spent the last 2 hours trying to pair this device with my openhab system, running on a raspberry pi 2 with razberry.

Have rebooted countless time, presses the pairing dozens of times and also reset the sensor.

All this time I am thinking to myself that this should not be this difficult. Am i missing something here.

Every now and then my log will show “neither inclusion nor exclusion was active” but not every time.

so basically i press include on habmin and then press the b button three times on the device. the blue light comes on and then disappears after a few seconds. then this red light keeps flashing signaling that it is not connected.

thoughts?

edit: 2015-09-28 18:29:55.634 [ERROR] [.z.i.config.ZWaveConfiguration] - Neither inclusion nor exclusion was active!

rm65453 · September 29, 2015, 12:43am

So i just left the sensor lying around and now it is showing up as a new node in habmin although all the other information is blank. Will it just fix it out on its own over the next little while or do i need to do something?

chris · September 30, 2015, 3:41pm

A few thoughts from me…

You need to include the sensor in range of the controller. Once included, you need to initialise it also in range of the openhab controller
It may take a couple of times to wake the device up before it initialises fully. If you move the device so that it is not able to directly communicate with OH during this time, it may not initialise properly.
Once it’s initialised, you can move it, and OH should have configured it so that it can route through other nearby nodes.
Without a debug log it’s hard to say what else is happening…

Cheers
Chrsi

rm65453 · September 30, 2015, 4:01pm

Hi Chris,

I have successfully completed steps 1 and 2. Am currently trying to reinitialize the node.

The trouble is that habmin does not seem to recognize the node.


2015-09-29 05:49:11.630 [ERROR] [.z.i.config.ZWaveConfiguration] - NODE 4: Error in doSet - no database found
2015-09-29 05:49:21.111 [ERROR] [.z.i.config.ZWaveConfiguration] - NODE 4: Error in doSet - no database found

here is a screenshot

chris · September 30, 2015, 4:03pm

So this means it has not managed to download this data from the device yet. This should normally happen very quickly after you wake the device up… This presumably isn’t the case so maybe you can provide a log of what is happening.

rm65453 · September 30, 2015, 4:12pm

my log is huge, do you want me to paste the whole thing?openhab.pdf (607.9 KB)

chris · September 30, 2015, 4:14pm

Nope

Somehow you should filter out the stuff associated with this device. It’s a battery device, so the data should appear in blocks - maybe you can just cut and past a couple of blocks?

rm65453 · September 30, 2015, 4:26pm

hope this helps

  2015-09-28 19:32:39.005 [INFO ]
  [.service.AbstractActiveService] - Nest Refresh Service has been started
 
 
  2015-09-28
  19:32:42.170 [INFO ] [rialApiGetInitDataMessageClass] - NODE 1: Node found
  
  
  
 
 
  2015-09-28
  19:32:42.829 [INFO ] [rialApiGetInitDataMessageClass] - NODE 2: Node found
  
  
  
 
 
  2015-09-28
  19:32:42.830 [INFO ] [rialApiGetInitDataMessageClass] - NODE 3: Node found
  
  
  
 
 
  2015-09-28
  19:32:42.831 [INFO ] [rialApiGetInitDataMessageClass] - NODE 4: Node found
  
  
  
 
 
  2015-09-28
  19:32:42.832 [INFO ] [rialApiGetInitDataMessageClass] - ZWave Controller
  using Controller API
 
 
  2015-09-28
  19:32:42.833 [INFO ] [rialApiGetInitDataMessageClass] - ZWave Controller is
  Primary Controller
 
 
  2015-09-28
  19:32:42.833 [INFO ] [rialApiGetInitDataMessageClass] - ------------Number of
  Nodes Found Registered to ZWave Controller------------
 
 
  2015-09-28
  19:32:42.834 [INFO ] [rialApiGetInitDataMessageClass] - # Nodes = 4
  
  
  
  
 
 
  2015-09-28
  19:32:42.834 [INFO ] [rialApiGetInitDataMessageClass] -
  ----------------------------------------------------------------------------
 
 
  2015-09-28
  19:32:44.496 [ERROR] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item
  'MainFloorWashroom' for widget org.openhab.model.sitemap.Group
 
 
  2015-09-28
  19:32:44.497 [ERROR] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item
  'MainFloorWashroom' for widget org.openhab.model.sitemap.Group
 
 
  2015-09-28
  19:32:44.498 [ERROR] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item
  'MainFloorWashroom' for widget org.openhab.model.sitemap.Group
 
 
  2015-09-28
  19:32:44.504 [WARN ] [o.u.i.items.ItemUIRegistryImpl] - Group 'null' could
  not be found.
  
 
 
  org.openhab.core.items.ItemNotFoundException:
  Item 'MainFloorWashroom' could not be found in the item registry
 
 
  
  at
  org.openhab.core.internal.items.ItemRegistryImpl.getItem(ItemRegistryImpl.java:80)
  ~[na:na]
  
 
 
  
  at
  org.openhab.ui.internal.items.ItemUIRegistryImpl.getItem(ItemUIRegistryImpl.java:531)
  [org.openhab.ui_1.6.2.jar:na]
 
 
  
  at
  org.openhab.ui.internal.items.ItemUIRegistryImpl.getDynamicGroupChildren(ItemUIRegistryImpl.java:475)
  [org.openhab.ui_1.6.2.jar:na]
 
 
  
  at
  org.openhab.ui.internal.items.ItemUIRegistryImpl.getChildren(ItemUIRegistryImpl.java:457)
  [org.openhab.ui_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.resources.SitemapResource.createWidgetBean(SitemapResource.java:307)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.resources.SitemapResource.createWidgetBean(SitemapResource.java:312)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.resources.SitemapResource.createPageBean(SitemapResource.java:274)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.resources.SitemapResource.getPageBean(SitemapResource.java:182)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.listeners.SitemapStateChangeListener.getPageBean(SitemapStateChangeListener.java:136)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.listeners.SitemapStateChangeListener.getResponseObject(SitemapStateChangeListener.java:49)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.listeners.ResourceStateChangeListener$1.filter(ResourceStateChangeListener.java:95)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.atmosphere.cpr.BroadcasterConfig.filter(BroadcasterConfig.java:455)
  [atmosphere-runtime-2.0.9.jar:2.0.9]
 
 
  
  at
  org.atmosphere.cpr.DefaultBroadcaster.perRequestFilter(DefaultBroadcaster.java:836)
  [atmosphere-runtime-2.0.9.jar:2.0.9]
 
 
  
  at
  org.atmosphere.cpr.DefaultBroadcaster.deliverPush(DefaultBroadcaster.java:726)
  [atmosphere-runtime-2.0.9.jar:2.0.9]
 
 
  
  at
  org.atmosphere.cpr.DefaultBroadcaster.push(DefaultBroadcaster.java:632)
  [atmosphere-runtime-2.0.9.jar:2.0.9]
 
 
  
  at
  org.atmosphere.cpr.DefaultBroadcaster$2.run(DefaultBroadcaster.java:494)
  [atmosphere-runtime-2.0.9.jar:2.0.9]
 
 
  
  at
  java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  [na:1.8.0]
  
  
 
 
  
  at
  java.util.concurrent.FutureTask.run(FutureTask.java:266) [na:1.8.0]
  
  
  
  
 
 
  
  at
  java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  [na:1.8.0]
  
 
 
  
  at
  java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  [na:1.8.0]
  
 
 
  
  at
  java.lang.Thread.run(Thread.java:744) [na:1.8.0]
  
  
  
  
  
  
 
 
  2015-09-28
  19:32:44.539 [ERROR] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item
  'MainFloorWashroom' for widget org.openhab.model.sitemap.Group
 
 
  2015-09-28
  19:32:44.541 [ERROR] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item
  'MainFloorWashroom' for widget org.openhab.model.sitemap.Group
 
 
  2015-09-28
  19:32:44.542 [ERROR] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item
  'MainFloorWashroom' for widget org.openhab.model.sitemap.Group
 
 
  2015-09-28
  19:32:44.549 [WARN ] [o.u.i.items.ItemUIRegistryImpl] - Group 'null' could
  not be found.
  
 
 
  org.openhab.core.items.ItemNotFoundException:
  Item 'MainFloorWashroom' could not be found in the item registry
 
 
  
  at
  org.openhab.core.internal.items.ItemRegistryImpl.getItem(ItemRegistryImpl.java:80)
  ~[na:na]
  
 
 
  
  at
  org.openhab.ui.internal.items.ItemUIRegistryImpl.getItem(ItemUIRegistryImpl.java:531)
  [org.openhab.ui_1.6.2.jar:na]
 
 
  
  at
  org.openhab.ui.internal.items.ItemUIRegistryImpl.getDynamicGroupChildren(ItemUIRegistryImpl.java:475)
  [org.openhab.ui_1.6.2.jar:na]
 
 
  
  at
  org.openhab.ui.internal.items.ItemUIRegistryImpl.getChildren(ItemUIRegistryImpl.java:457)
  [org.openhab.ui_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.resources.SitemapResource.createWidgetBean(SitemapResource.java:307)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.resources.SitemapResource.createWidgetBean(SitemapResource.java:312)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.resources.SitemapResource.createPageBean(SitemapResource.java:274)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.resources.SitemapResource.getPageBean(SitemapResource.java:182)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.listeners.SitemapStateChangeListener.getPageBean(SitemapStateChangeListener.java:136)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.listeners.SitemapStateChangeListener.getResponseObject(SitemapStateChangeListener.java:49)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.listeners.ResourceStateChangeListener$1.filter(ResourceStateChangeListener.java:95)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.atmosphere.cpr.BroadcasterConfig.filter(BroadcasterConfig.java:455)
  [atmosphere-runtime-2.0.9.jar:2.0.9]
 
 
  
  at
  org.atmosphere.cpr.DefaultBroadcaster.perRequestFilter(DefaultBroadcaster.java:836)
  [atmosphere-runtime-2.0.9.jar:2.0.9]
 
 
  
  at
  org.atmosphere.cpr.DefaultBroadcaster.deliverPush(DefaultBroadcaster.java:726)
  [atmosphere-runtime-2.0.9.jar:2.0.9]
 
 
  
  at
  org.atmosphere.cpr.DefaultBroadcaster.push(DefaultBroadcaster.java:632)
  [atmosphere-runtime-2.0.9.jar:2.0.9]
 
 
  
  at
  org.atmosphere.cpr.DefaultBroadcaster$2.run(DefaultBroadcaster.java:494)
  [atmosphere-runtime-2.0.9.jar:2.0.9]
 
 
  
  at
  java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  [na:1.8.0]
  
  
 
 
  
  at
  java.util.concurrent.FutureTask.run(FutureTask.java:266) [na:1.8.0]
  
  
  
  
 
 
  
  at
  java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  [na:1.8.0]
  
 
 
  
  at
  java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  [na:1.8.0]
  
 
 
  
  at
  java.lang.Thread.run(Thread.java:744) [na:1.8.0]
  
  
  
  
  
  
 
 
  2015-09-28
  19:32:44.578 [ERROR] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item
  'MainFloorWashroom' for widget org.openhab.model.sitemap.Group
 
 
  2015-09-28
  19:32:44.580 [ERROR] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item
  'MainFloorWashroom' for widget org.openhab.model.sitemap.Group
 
 
  2015-09-28
  19:32:44.581 [ERROR] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item
  'MainFloorWashroom' for widget org.openhab.model.sitemap.Group
 
 
  2015-09-28
  19:32:44.587 [WARN ] [o.u.i.items.ItemUIRegistryImpl] - Group 'null' could
  not be found.
  
 
 
  org.openhab.core.items.ItemNotFoundException:
  Item 'MainFloorWashroom' could not be found in the item registry
 
 
  
  at
  org.openhab.core.internal.items.ItemRegistryImpl.getItem(ItemRegistryImpl.java:80)
  ~[na:na]
  
 
 
  
  at
  org.openhab.ui.internal.items.ItemUIRegistryImpl.getItem(ItemUIRegistryImpl.java:531)
  [org.openhab.ui_1.6.2.jar:na]
 
 
  
  at
  org.openhab.ui.internal.items.ItemUIRegistryImpl.getDynamicGroupChildren(ItemUIRegistryImpl.java:475)
  [org.openhab.ui_1.6.2.jar:na]
 
 
  
  at
  org.openhab.ui.internal.items.ItemUIRegistryImpl.getChildren(ItemUIRegistryImpl.java:457)
  [org.openhab.ui_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.resources.SitemapResource.createWidgetBean(SitemapResource.java:307)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.resources.SitemapResource.createWidgetBean(SitemapResource.java:312)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.resources.SitemapResource.createPageBean(SitemapResource.java:274)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.resources.SitemapResource.getPageBean(SitemapResource.java:182)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.listeners.SitemapStateChangeListener.getPageBean(SitemapStateChangeListener.java:136)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.listeners.SitemapStateChangeListener.getResponseObject(SitemapStateChangeListener.java:49)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.listeners.ResourceStateChangeListener$1.filter(ResourceStateChangeListener.java:95)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.atmosphere.cpr.BroadcasterConfig.filter(BroadcasterConfig.java:455)
  [atmosphere-runtime-2.0.9.jar:2.0.9]
 
 
  
  at
  org.atmosphere.cpr.DefaultBroadcaster.perRequestFilter(DefaultBroadcaster.java:836)
  [atmosphere-runtime-2.0.9.jar:2.0.9]
 
 
  
  at
  org.atmosphere.cpr.DefaultBroadcaster.deliverPush(DefaultBroadcaster.java:726)
  [atmosphere-runtime-2.0.9.jar:2.0.9]
 
 
  
  at
  org.atmosphere.cpr.DefaultBroadcaster.push(DefaultBroadcaster.java:632)
  [atmosphere-runtime-2.0.9.jar:2.0.9]
 
 
  
  at
  org.atmosphere.cpr.DefaultBroadcaster$2.run(DefaultBroadcaster.java:494)
  [atmosphere-runtime-2.0.9.jar:2.0.9]
 
 
  
  at
  java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  [na:1.8.0]
  
  
 
 
  
  at
  java.util.concurrent.FutureTask.run(FutureTask.java:266) [na:1.8.0]
  
  
  
  
 
 
  
  at
  java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  [na:1.8.0]
  
 
 
  
  at
  java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  [na:1.8.0]
  
 
 
  
  at
  java.lang.Thread.run(Thread.java:744) [na:1.8.0]
  
  
  
  
  
  
 
 
  2015-09-28
  19:32:44.616 [ERROR] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item
  'MainFloorWashroom' for widget org.openhab.model.sitemap.Group
 
 
  2015-09-28
  19:32:44.617 [ERROR] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item
  'MainFloorWashroom' for widget org.openhab.model.sitemap.Group
 
 
  2015-09-28
  19:32:44.618 [ERROR] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item
  'MainFloorWashroom' for widget org.openhab.model.sitemap.Group
 
 
  2015-09-28
  19:32:44.623 [WARN ] [o.u.i.items.ItemUIRegistryImpl] - Group 'null' could
  not be found.
  
 
 
  org.openhab.core.items.ItemNotFoundException:
  Item 'MainFloorWashroom' could not be found in the item registry
 
 
  
  at
  org.openhab.core.internal.items.ItemRegistryImpl.getItem(ItemRegistryImpl.java:80)
  ~[na:na]
  
 
 
  
  at
  org.openhab.ui.internal.items.ItemUIRegistryImpl.getItem(ItemUIRegistryImpl.java:531)
  [org.openhab.ui_1.6.2.jar:na]
 
 
  
  at
  org.openhab.ui.internal.items.ItemUIRegistryImpl.getDynamicGroupChildren(ItemUIRegistryImpl.java:475)
  [org.openhab.ui_1.6.2.jar:na]
 
 
  
  at
  org.openhab.ui.internal.items.ItemUIRegistryImpl.getChildren(ItemUIRegistryImpl.java:457)
  [org.openhab.ui_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.resources.SitemapResource.createWidgetBean(SitemapResource.java:307)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.resources.SitemapResource.createWidgetBean(SitemapResource.java:312)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.resources.SitemapResource.createPageBean(SitemapResource.java:274)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.resources.SitemapResource.getPageBean(SitemapResource.java:182)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.listeners.SitemapStateChangeListener.getPageBean(SitemapStateChangeListener.java:136)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.listeners.SitemapStateChangeListener.getResponseObject(SitemapStateChangeListener.java:49)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.openhab.io.rest.internal.listeners.ResourceStateChangeListener$1.filter(ResourceStateChangeListener.java:95)
  [org.openhab.io.rest_1.6.2.jar:na]
 
 
  
  at
  org.atmosphere.cpr.BroadcasterConfig.filter(BroadcasterConfig.java:455)
  [atmosphere-runtime-2.0.9.jar:2.0.9]
 
 
  
  at
  org.atmosphere.cpr.DefaultBroadcaster.perRequestFilter(DefaultBroadcaster.java:836)
  [atmosphere-runtime-2.0.9.jar:2.0.9]
 
 
  
  at
  org.atmosphere.cpr.DefaultBroadcaster.deliverPush(DefaultBroadcaster.java:726)
  [atmosphere-runtime-2.0.9.jar:2.0.9]
 
 
  
  at
  org.atmosphere.cpr.DefaultBroadcaster.push(DefaultBroadcaster.java:632)
  [atmosphere-runtime-2.0.9.jar:2.0.9]
 
 
  
  at
  org.atmosphere.cpr.DefaultBroadcaster$2.run(DefaultBroadcaster.java:494)
  [atmosphere-runtime-2.0.9.jar:2.0.9]
 
 
  
  at
  java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
  [na:1.8.0]
  
  
 
 
  
  at
  java.util.concurrent.FutureTask.run(FutureTask.java:266) [na:1.8.0]
  
  
  
  
 
 
  
  at
  java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
  [na:1.8.0]
  
 
 
  
  at
  java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
  [na:1.8.0]
  
 
 
  
  at
  java.lang.Thread.run(Thread.java:744) [na:1.8.0]
  
  
  
  
  
  
 
 
  2015-09-28
  19:32:44.652 [ERROR] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item
  'MainFloorWashroom' for widget org.openhab.model.sitemap.Group
 
 
  2015-09-28
  19:32:44.653 [ERROR] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item
  'MainFloorWashroom' for widget org.openhab.model.sitemap.Group
 
 
  2015-09-28
  19:32:44.654 [ERROR] [o.u.i.items.ItemUIRegistryImpl] - Cannot retrieve item
  'MainFloorWashroom' for widget org.openhab.model.sitemap.Group
 
 
  2015-09-28
  19:32:44.660 [WARN ] [o.u.i.items.ItemUIRegistryImpl] - Group 'null' could
  not be found.
  
 
 
  org.openhab.core.items.ItemNotFoundException:
  Item 'MainFloorWashroom' could not be found in the item registry

also it keeps saying

2015-09-28 19:26:58.171 [ERROR]
[.z.i.config.ZWaveConfiguration] - NODE 4: Error in doSet - no database found

chris · September 30, 2015, 4:31pm

Sorry - this isn’t very useful. It looks like an exception dump, but I’m not sure what from. I don’t think it’s from zwave though…

rm65453 · September 30, 2015, 4:49pm

i posted the entire dump above as well. am not really sure how to filter the data you are looking for.openhab.pdf (607.9 KB) link to the entire dump again.

sorry if this is not being helpful

rm65453 · September 30, 2015, 4:52pm

should I just exclude the node and try including it again?

chris · September 30, 2015, 5:01pm

I doubt it would help if you exclude and re-include…

A PDF log file is really not usable as I can’t process the file with the tools I have…

For the log, just wake up the device and get the log during that time - so I just need the info for the node that is causing the problem (node 4 I guess?)

rm65453 · September 30, 2015, 5:05pm

ok gonna try that now.

rm65453 · September 30, 2015, 9:38pm

this is what i got after waking the device. i dont think its related to the node 4.


2015-09-29 18:18:19.392 [ERROR] [enhab.binding.xbmc.rpc.RpcCall] - Error handling POST response from XBMC

java.net.ConnectException: connection timed out: /192.168.1.123:8080 to http://192.168.1.123:8080/jsonrpc

at com.ning.http.client.providers.netty.NettyConnectListener.operationComplete(NettyConnectListener.java:103) ~[async-http-client-1.8.4.jar:na]

at org.jboss.netty.channel.DefaultChannelFuture.notifyListener(DefaultChannelFuture.java:427) [netty-3.9.0.Final.jar:na]

at org.jboss.netty.channel.DefaultChannelFuture.notifyListeners(DefaultChannelFuture.java:418) [netty-3.9.0.Final.jar:na]

at org.jboss.netty.channel.DefaultChannelFuture.setFailure(DefaultChannelFuture.java:380) [netty-3.9.0.Final.jar:na]

at org.jboss.netty.channel.socket.nio.NioClientBoss.processConnectTimeout(NioClientBoss.java:140) [netty-3.9.0.Final.jar:na]

at org.jboss.netty.channel.socket.nio.NioClientBoss.process(NioClientBoss.java:83) [netty-3.9.0.Final.jar:na]

at org.jboss.netty.channel.socket.nio.AbstractNioSelector.run(AbstractNioSelector.java:318) [netty-3.9.0.Final.jar:na]

at org.jboss.netty.channel.socket.nio.NioClientBoss.run(NioClientBoss.java:42) [netty-3.9.0.Final.jar:na]

at org.jboss.netty.util.ThreadRenamingRunnable.run(ThreadRenamingRunnable.java:108) [netty-3.9.0.Final.jar:na]

at org.jboss.netty.util.internal.DeadLockProofWorker$1.run(DeadLockProofWorker.java:42) [netty-3.9.0.Final.jar:na]

at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [na:1.8.0]

at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [na:1.8.0]

at java.lang.Thread.run(Thread.java:744) [na:1.8.0]

Caused by: org.jboss.netty.channel.ConnectTimeoutException: connection timed out: /192.168.1.123:8080

at org.jboss.netty.channel.socket.nio.NioClientBoss.processConnectTimeout(NioClientBoss.java:137) [netty-3.9.0.Final.jar:na]

… 8 common frames omitted

2015-09-29 18:18:19.406 [ERROR] [enhab.binding.xbmc.rpc.RpcCall] - Error handling POST response from XBMC

java.net.ConnectException: connection timed out: /192.168.1.123:8080 to http://192.168.1.123:8080/jsonrpc

at com.ning.http.client.providers.netty.NettyConnectListener.operationComplete(NettyConnectListener.java:103) ~[async-http-client-1.8.4.jar:na]

at org.jboss.netty.channel.DefaultChannelFuture.notifyListener(DefaultChannelFuture.java:427) [netty-3.9.0.Final.jar:na]

at org.jboss.netty.channel.DefaultChannelFuture.notifyListeners(DefaultChannelFuture.java:418) [netty-3.9.0.Final.jar:na]

at org.jboss.netty.channel.DefaultChannelFuture.setFailure(DefaultChannelFuture.java:380) [netty-3.9.0.Final.jar:na]

at org.jboss.netty.channel.socket.nio.NioClientBoss.processConnectTimeout(NioClientBoss.java:140) [netty-3.9.0.Final.jar:na]

at org.jboss.netty.channel.socket.nio.NioClientBoss.process(NioClientBoss.java:83) [netty-3.9.0.Final.jar:na]

at org.jboss.netty.channel.socket.nio.AbstractNioSelector.run(AbstractNioSelector.java:318) [netty-3.9.0.Final.jar:na]

at org.jboss.netty.channel.socket.nio.NioClientBoss.run(NioClientBoss.java:42) [netty-3.9.0.Final.jar:na]

at org.jboss.netty.util.ThreadRenamingRunnable.run(ThreadRenamingRunnable.java:108) [netty-3.9.0.Final.jar:na]

at org.jboss.netty.util.internal.DeadLockProofWorker$1.run(DeadLockProofWorker.java:42) [netty-3.9.0.Final.jar:na]

at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [na:1.8.0]

at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [na:1.8.0]

at java.lang.Thread.run(Thread.java:744) [na:1.8.0]

Caused by: org.jboss.netty.channel.ConnectTimeoutException: connection timed out: /192.168.1.123:8080

at org.jboss.netty.channel.socket.nio.NioClientBoss.processConnectTimeout(NioClientBoss.java:137) [netty-3.9.0.Final.jar:na]

… 8 common frames omitted

2015-09-29 18:18:19.492 [ERROR] [enhab.binding.xbmc.rpc.RpcCall] - Error handling POST response from XBMC

java.net.ConnectException: connection timed out: /192.168.1.123:8080 to http://192.168.1.123:8080/jsonrpc

at com.ning.http.client.providers.netty.NettyConnectListener.operationComplete(NettyConnectListener.java:103) ~[async-http-client-1.8.4.jar:na]

at org.jboss.netty.channel.DefaultChannelFuture.notifyListener(DefaultChannelFuture.java:427) [netty-3.9.0.Final.jar:na]

at org.jboss.netty.channel.DefaultChannelFuture.notifyListeners(DefaultChannelFuture.java:418) [netty-3.9.0.Final.jar:na]

at org.jboss.netty.channel.DefaultChannelFuture.setFailure(DefaultChannelFuture.java:380) [netty-3.9.0.Final.jar:na]

at org.jboss.netty.channel.socket.nio.NioClientBoss.processConnectTimeout(NioClientBoss.java:140) [netty-3.9.0.Final.jar:na]

at org.jboss.netty.channel.socket.nio.NioClientBoss.process(NioClientBoss.java:83) [netty-3.9.0.Final.jar:na]

at org.jboss.netty.channel.socket.nio.AbstractNioSelector.run(AbstractNioSelector.java:318) [netty-3.9.0.Final.jar:na]

at org.jboss.netty.channel.socket.nio.NioClientBoss.run(NioClientBoss.java:42) [netty-3.9.0.Final.jar:na]

at org.jboss.netty.util.ThreadRenamingRunnable.run(ThreadRenamingRunnable.java:108) [netty-3.9.0.Final.jar:na]

at org.jboss.netty.util.internal.DeadLockProofWorker$1.run(DeadLockProofWorker.java:42) [netty-3.9.0.Final.jar:na]

at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [na:1.8.0]

at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [na:1.8.0]

at java.lang.Thread.run(Thread.java:744) [na:1.8.0]

Caused by: org.jboss.netty.channel.ConnectTimeoutException: connection timed out: /192.168.1.123:8080

at org.jboss.netty.channel.socket.nio.NioClientBoss.processConnectTimeout(NioClientBoss.java:137) [netty-3.9.0.Final.jar:na]

… 8 common frames omitted

2015-09-29 18:18:34.492 [WARN ] [binding.xbmc.rpc.XbmcConnector] - [192.168.1.123]: Websocket closed

2015-09-29 18:19:16.894 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.osgi_3.8.2.v20130124-134944 [0]

2015-09-29 18:19:16.895 [INFO ] [h.services.osgi.BundleResource] - javax.transaction_1.1.1.v201105210645 [1]

2015-09-29 18:19:16.896 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.simpleconfigurator_1.0.301.v20120914-163612 [2]

2015-09-29 18:19:16.897 [INFO ] [h.services.osgi.BundleResource] - ch.qos.logback.classic_1.0.7.v20121108-1250 [3]

2015-09-29 18:19:16.897 [INFO ] [h.services.osgi.BundleResource] - ch.qos.logback.core_1.0.7.v20121108-1250 [4]

2015-09-29 18:19:16.897 [INFO ] [h.services.osgi.BundleResource] - ch.qos.logback.slf4j_1.0.7.v20121108-1250 [5]

2015-09-29 18:19:16.898 [INFO ] [h.services.osgi.BundleResource] - com.google.guava_10.0.1.v201203051515 [6]

2015-09-29 18:19:16.898 [INFO ] [h.services.osgi.BundleResource] - com.google.inject_3.0.0.v201203062045 [7]

2015-09-29 18:19:16.898 [INFO ] [h.services.osgi.BundleResource] - com.ibm.icu.base_50.1.1.v201304230130 [9]

2015-09-29 18:19:16.899 [INFO ] [h.services.osgi.BundleResource] - javax.activation_1.1.0.v201211130549 [10]

2015-09-29 18:19:16.899 [INFO ] [h.services.osgi.BundleResource] - javax.annotation_1.1.0.v201209060031 [11]

2015-09-29 18:19:16.899 [INFO ] [h.services.osgi.BundleResource] - javax.inject_1.0.0.v20091030 [12]

2015-09-29 18:19:16.900 [INFO ] [h.services.osgi.BundleResource] - javax.mail_1.4.0.v201005080615 [13]

2015-09-29 18:19:16.900 [INFO ] [h.services.osgi.BundleResource] - javax.servlet_3.0.0.v201112011016 [14]

2015-09-29 18:19:16.900 [INFO ] [h.services.osgi.BundleResource] - javax.xml_1.3.4.v201005080400 [15]

2015-09-29 18:19:16.901 [INFO ] [h.services.osgi.BundleResource] - javax.xml.bind_2.2.0.v201105210648 [16]

2015-09-29 18:19:16.901 [INFO ] [h.services.osgi.BundleResource] - javax.xml.stream_1.0.1.v201004272200 [17]

2015-09-29 18:19:16.901 [INFO ] [h.services.osgi.BundleResource] - org.antlr.runtime_3.2.0.v201101311130 [18]

2015-09-29 18:19:16.902 [INFO ] [h.services.osgi.BundleResource] - org.apache.ant_1.8.3.v201301120609 [19]

2015-09-29 18:19:16.902 [INFO ] [h.services.osgi.BundleResource] - org.apache.batik.css_1.

rm65453 · September 30, 2015, 10:14pm

Hi Chris,

So I excluded and included the node again and just like you said it did the same thing again.

here is the corresponding log


2015-09-30 16:50:55.664 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.p2.metadata.repository_1.2.100.v20120524-1717 [113]
2015-09-30 16:50:55.664 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.p2.ql_2.0.100.v20110808-1657 [114]
2015-09-30 16:50:55.664 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.p2.repository_2.2.0.v20120524-1945 [115]
2015-09-30 16:50:55.664 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.p2.touchpoint.eclipse_2.1.100.v20120428-0117 [116]
2015-09-30 16:50:55.664 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.p2.touchpoint.natives_1.1.0.v20130121-021919 [117]
2015-09-30 16:50:55.665 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.p2.transport.ecf_1.0.100.v20120913-155635 [118]
2015-09-30 16:50:55.665 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.preferences_3.5.1.v20121031-182809 [119]
2015-09-30 16:50:55.665 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.registry_3.5.200.v20120522-1841 [120]
2015-09-30 16:50:55.665 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.security_1.1.100.v20120522-1841 [121]
2015-09-30 16:50:55.665 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.simpleconfigurator.manipulator_2.0.0.v20110808-1657 [122]
2015-09-30 16:50:55.666 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.util_1.0.400.v20120917-192807 [123]
2015-09-30 16:50:55.666 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jdt.debug_3.7.101.v20120913-153601 [128]
2015-09-30 16:50:55.666 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.client_8.1.3.v20120522 [132]
2015-09-30 16:50:55.666 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.continuation_8.1.3.v20120522 [133]
2015-09-30 16:50:55.666 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.deploy_8.1.3.v20120522 [134]
2015-09-30 16:50:55.667 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.http_8.1.3.v20120522 [135]
2015-09-30 16:50:55.667 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.io_8.1.3.v20120522 [136]
2015-09-30 16:50:55.667 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.jmx_8.1.3.v20120522 [137]
2015-09-30 16:50:55.667 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.jndi_8.1.3.v20120522 [138]
2015-09-30 16:50:55.667 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.osgi.boot_8.1.3.v20120522 [139]
2015-09-30 16:50:55.668 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.osgi.boot.warurl_8.1.3.qualifier [140]
2015-09-30 16:50:55.668 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.osgi.httpservice_8.1.3.qualifier [141]
2015-09-30 16:50:55.668 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.plus_8.1.3.v20120522 [142]
2015-09-30 16:50:55.668 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.rewrite_8.1.3.v20120522 [143]
2015-09-30 16:50:55.668 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.security_8.1.3.v20120522 [144]
2015-09-30 16:50:55.669 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.server_8.1.3.v20120522 [145]
2015-09-30 16:50:55.669 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.servlet_8.1.3.v20120522 [146]
2015-09-30 16:50:55.669 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.servlets_8.1.3.v20120522 [147]
2015-09-30 16:50:55.669 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.util_8.1.3.v20120522 [148]
2015-09-30 16:50:55.669 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.webapp_8.1.3.v20120522 [149]
2015-09-30 16:50:55.669 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.websocket_8.1.3.v20120522 [150]
2015-09-30 16:50:55.670 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.xml_8.1.3.v20120522 [151]
2015-09-30 16:50:55.670 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.ltk.core.refactoring_3.6.0.v20120523-1543 [155]
2015-09-30 16:50:55.670 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.osgi.services_3.3.100.v20120522-1822 [157]
2015-09-30 16:50:55.670 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.swt_3.100.1.v4236b [159]
2015-09-30 16:50:55.671 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.text_3.5.200.v20120523-1310 [162]
2015-09-30 16:50:55.671 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.xpand_1.1.0.v201108020519 [174]
2015-09-30 16:50:55.671 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.xtend_1.1.0.v201108020519 [175]
2015-09-30 16:50:55.671 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.xtend.lib_2.3.1.v201208210947 [176]
2015-09-30 16:50:55.671 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.xtend.typesystem.emf_1.0.1.v201108020519 [177]
2015-09-30 16:50:55.672 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.xtext_2.3.0.v201206120633 [178]
2015-09-30 16:50:55.672 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.xtext.common.types_2.3.0.v201206120633 [179]
2015-09-30 16:50:55.672 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.xtext.ecore_2.3.0.v201206120633 [180]
2015-09-30 16:50:55.672 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.xtext.generator_2.3.0.v201206120633 [181]
2015-09-30 16:50:55.672 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.xtext.smap_2.3.0.v201206120633 [182]
2015-09-30 16:50:55.673 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.xtext.util_2.3.0.v201206120633 [183]
2015-09-30 16:50:55.673 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.xtext.xbase_2.3.0.v201206120633 [184]
2015-09-30 16:50:55.673 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.xtext.xbase.lib_2.3.0.v201206120633 [185]
2015-09-30 16:50:55.673 [INFO ] [h.services.osgi.BundleResource] - org.openhab.config.core_1.6.2 [186]
2015-09-30 16:50:55.673 [INFO ] [h.services.osgi.BundleResource] - org.openhab.core_1.6.2 [187]
2015-09-30 16:50:55.673 [INFO ] [h.services.osgi.BundleResource] - org.openhab.core.autoupdate_1.6.2 [188]
2015-09-30 16:50:55.674 [INFO ] [h.services.osgi.BundleResource] - org.openhab.core.library_1.6.2 [189]
2015-09-30 16:50:55.674 [INFO ] [h.services.osgi.BundleResource] - org.openhab.core.persistence_1.6.2 [190]
2015-09-30 16:50:55.674 [INFO ] [h.services.osgi.BundleResource] - org.openhab.core.scheduler_1.6.2 [191]
2015-09-30 16:50:55.674 [INFO ] [h.services.osgi.BundleResource] - org.openhab.core.scriptengine_1.6.2 [192]
2015-09-30 16:50:55.674 [INFO ] [h.services.osgi.BundleResource] - org.openhab.core.transform_1.6.2 [193]
2015-09-30 16:50:55.675 [INFO ] [h.services.osgi.BundleResource] - org.openhab.io.console_1.6.2 [194]
2015-09-30 16:50:55.675 [INFO ] [h.services.osgi.BundleResource] - org.openhab.io.monitor_1.6.2 [195]
2015-09-30 16:50:55.675 [INFO ] [h.services.osgi.BundleResource] - org.openhab.io.multimedia_1.6.2 [196]
2015-09-30 16:50:55.675 [INFO ] [h.services.osgi.BundleResource] - org.openhab.io.net_1.6.2 [197]
2015-09-30 16:50:55.675 [INFO ] [h.services.osgi.BundleResource] - org.openhab.io.rest_1.6.2 [198]
2015-09-30 16:50:55.676 [INFO ] [h.services.osgi.BundleResource] - org.openhab.io.rest.lib_1.6.2 [199]
2015-09-30 16:50:55.676 [INFO ] [h.services.osgi.BundleResource] - org.openhab.io.servicediscovery_1.6.2 [200]
2015-09-30 16:50:55.676 [INFO ] [h.services.osgi.BundleResource] - org.openhab.io.transport.mqtt_1.6.2 [201]
2015-09-30 16:50:55.676 [INFO ] [h.services.osgi.BundleResource] - org.openhab.io.transport.serial_1.6.2 [202]
2015-09-30 16:50:55.676 [INFO ] [h.services.osgi.BundleResource] - org.openhab.library.tel_1.6.2 [203]
2015-09-30 16:50:55.676 [INFO ] [h.services.osgi.BundleResource] - org.openhab.model.core_1.6.2 [204]
2015-09-30 16:50:55.677 [INFO ] [h.services.osgi.BundleResource] - org.openhab.model.item_1.6.2 [205]
2015-09-30 16:50:55.677 [INFO ] [h.services.osgi.BundleResource] - org.openhab.model.persistence_1.6.2 [206]
2015-09-30 16:50:55.677 [INFO ] [h.services.osgi.BundleResource] - org.openhab.model.rule_1.6.2 [207]
2015-09-30 16:50:55.677 [INFO ] [h.services.osgi.BundleResource] - org.openhab.model.script_1.6.2 [208]
2015-09-30 16:50:55.677 [INFO ] [h.services.osgi.BundleResource] - org.openhab.model.sitemap_1.6.2 [209]
2015-09-30 16:50:55.677 [INFO ] [h.services.osgi.BundleResource] - org.openhab.ui_1.6.2 [210]
2015-09-30 16:50:55.678 [INFO ] [h.services.osgi.BundleResource] - org.openhab.ui.webapp_1.6.2 [211]
2015-09-30 16:50:55.678 [INFO ] [h.services.osgi.BundleResource] - org.sat4j.core_2.3.0.v20110329 [212]
2015-09-30 16:50:55.678 [INFO ] [h.services.osgi.BundleResource] - org.sat4j.pb_2.3.0.v20110329 [213]
2015-09-30 16:50:55.678 [INFO ] [h.services.osgi.BundleResource] - org.slf4j.api_1.7.2.v20121108-1250 [214]
2015-09-30 16:50:55.678 [INFO ] [h.services.osgi.BundleResource] - org.slf4j.jcl_1.7.2.v20130115-1340 [215]
2015-09-30 16:50:55.679 [INFO ] [h.services.osgi.BundleResource] - org.slf4j.jul_1.7.2.v20121108-1250 [216]
2015-09-30 16:50:55.679 [INFO ] [h.services.osgi.BundleResource] - org.slf4j.log4j_1.7.2.v20130115-1340 [217]
2015-09-30 16:50:55.679 [INFO ] [h.services.osgi.BundleResource] - org.w3c.css.sac_1.3.1.v200903091627 [218]
2015-09-30 16:50:55.679 [INFO ] [h.services.osgi.BundleResource] - org.w3c.dom.smil_1.0.0.v200806040011 [219]
2015-09-30 16:50:55.679 [INFO ] [h.services.osgi.BundleResource] - org.w3c.dom.svg_1.1.0.v201011041433 [220]
2015-09-30 16:50:55.679 [INFO ] [h.services.osgi.BundleResource] - org.openhab.binding.xbmc_1.7.0.201505230103 [221]
2015-09-30 16:50:55.680 [INFO ] [h.services.osgi.BundleResource] - org.openhab.binding.nest_1.7.0.201505230103 [222]
2015-09-30 16:50:55.680 [INFO ] [h.services.osgi.BundleResource] - org.openhab.binding.zwave_1.7.0.201505230103 [223]
2015-09-30 16:50:55.680 [INFO ] [h.services.osgi.BundleResource] - org.openhab.io.habmin_1.4.0.201404281845 [224]
2015-09-30 16:52:31.272 [ERROR] [.z.i.config.ZWaveConfiguration] - Neither inclusion nor exclusion was active!
2015-09-30 16:52:48.387 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.osgi_3.8.2.v20130124-134944 [0]
2015-09-30 16:52:48.388 [INFO ] [h.services.osgi.BundleResource] - javax.transaction_1.1.1.v201105210645 [1]
2015-09-30 16:52:48.388 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.simpleconfigurator_1.0.301.v20120914-163612 [2]
2015-09-30 16:52:48.388 [INFO ] [h.services.osgi.BundleResource] - ch.qos.logback.classic_1.0.7.v20121108-1250 [3]
2015-09-30 16:52:48.389 [INFO ] [h.services.osgi.BundleResource] - ch.qos.logback.core_1.0.7.v20121108-1250 [4]
2015-09-30 16:52:48.389 [INFO ] [h.services.osgi.BundleResource] - ch.qos.logback.slf4j_1.0.7.v20121108-1250 [5]
2015-09-30 16:52:48.389 [INFO ] [h.services.osgi.BundleResource] - com.google.guava_10.0.1.v201203051515 [6]
2015-09-30 16:52:48.390 [INFO ] [h.services.osgi.BundleResource] - com.google.inject_3.0.0.v201203062045 [7]
2015-09-30 16:52:48.390 [INFO ] [h.services.osgi.BundleResource] - com.ibm.icu.base_50.1.1.v201304230130 [9]
2015-09-30 16:52:48.391 [INFO ] [h.services.osgi.BundleResource] - javax.activation_1.1.0.v201211130549 [10]
2015-09-30 16:52:48.391 [INFO ] [h.services.osgi.BundleResource] - javax.annotation_1.1.0.v201209060031 [11]
2015-09-30 16:52:48.392 [INFO ] [h.services.osgi.BundleResource] - javax.inject_1.0.0.v20091030 [12]
2015-09-30 16:52:48.392 [INFO ] [h.services.osgi.BundleResource] - javax.mail_1.4.0.v201005080615 [13]
2015-09-30 16:52:48.392 [INFO ] [h.services.osgi.BundleResource] - javax.servlet_3.0.0.v201112011016 [14]
2015-09-30 16:52:48.392 [INFO ] [h.services.osgi.BundleResource] - javax.xml_1.3.4.v201005080400 [15]
2015-09-30 16:52:48.393 [INFO ] [h.services.osgi.BundleResource] - javax.xml.bind_2.2.0.v201105210648 [16]
2015-09-30 16:52:48.393 [INFO ] [h.services.osgi.BundleResource] - javax.xml.stream_1.0.1.v201004272200 [17]
2015-09-30 16:52:48.393 [INFO ] [h.services.osgi.BundleResource] - org.antlr.runtime_3.2.0.v201101311130 [18]
2015-09-30 16:52:48.393 [INFO ] [h.services.osgi.BundleResource] - org.apache.ant_1.8.3.v201301120609 [19]
2015-09-30 16:52:48.394 [INFO ] [h.services.osgi.BundleResource] - org.apache.batik.css_1.6.0.v201011041432 [20]
2015-09-30 16:52:48.394 [INFO ] [h.services.osgi.BundleResource] - org.apache.batik.util_1.6.0.v201011041432 [21]
2015-09-30 16:52:48.394 [INFO ] [h.services.osgi.BundleResource] - org.apache.batik.util.gui_1.6.0.v201011041432 [22]
2015-09-30 16:52:48.394 [INFO ] [h.services.osgi.BundleResource] - org.apache.commons.cli_1.2.0.v201105210650 [23]
2015-09-30 16:52:48.395 [INFO ] [h.services.osgi.BundleResource] - org.apache.commons.codec_1.4.0.v201209201156 [24]
2015-09-30 16:52:48.395 [INFO ] [h.services.osgi.BundleResource] - org.apache.commons.codec_1.3.0.v201101211617 [25]
2015-09-30 16:52:48.395 [INFO ] [h.services.osgi.BundleResource] - org.apache.commons.collections_3.2.0.v2013030210310 [26]
2015-09-30 16:52:48.395 [INFO ] [h.services.osgi.BundleResource] - org.apache.commons.exec_1.1.0.v201301240602 [27]
2015-09-30 16:52:48.395 [INFO ] [h.services.osgi.BundleResource] - org.apache.commons.httpclient_3.1.0.v201012070820 [28]
2015-09-30 16:52:48.396 [INFO ] [h.services.osgi.BundleResource] - org.apache.commons.io_2.0.1.v201105210651 [29]
2015-09-30 16:52:48.396 [INFO ] [h.services.osgi.BundleResource] - org.apache.commons.lang_2.6.0.v201205030909 [30]
2015-09-30 16:52:48.396 [INFO ] [h.services.osgi.BundleResource] - org.apache.commons.logging_1.0.4.v201101211617 [31]
2015-09-30 16:52:48.396 [INFO ] [h.services.osgi.BundleResource] - org.apache.commons.net_3.2.0.v201305141515 [32]
2015-09-30 16:52:48.397 [INFO ] [h.services.osgi.BundleResource] - org.apache.felix.fileinstall_3.2.6 [33]
2015-09-30 16:52:48.397 [INFO ] [h.services.osgi.BundleResource] - org.apache.felix.gogo.command_0.8.0.v201108120515 [34]
2015-09-30 16:52:48.397 [INFO ] [h.services.osgi.BundleResource] - org.apache.felix.gogo.runtime_0.10.0.v201209301036 [35]
2015-09-30 16:52:48.398 [INFO ] [h.services.osgi.BundleResource] - org.apache.felix.gogo.shell_0.8.0.v201110170705 [36]
2015-09-30 16:52:48.398 [INFO ] [h.services.osgi.BundleResource] - org.apache.httpcomponents.httpclient_4.1.3.v201209201135 [37]
2015-09-30 16:52:48.399 [INFO ] [h.services.osgi.BundleResource] - org.apache.httpcomponents.httpcore_4.1.4.v201203221030 [38]
2015-09-30 16:52:48.399 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.core.commands_3.6.2.v20130123-162658 [41]
2015-09-30 16:52:48.399 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.core.contenttype_3.4.200.v20120523-2004 [42]
2015-09-30 16:52:48.399 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.core.databinding_1.4.1.v20120912-132807 [43]
2015-09-30 16:52:48.400 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.core.databinding.observable_1.4.1.v20120521-2329 [44]
2015-09-30 16:52:48.400 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.core.databinding.property_1.4.100.v20120523-1955 [45]
2015-09-30 16:52:48.400 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.core.expressions_3.4.401.v20120912-155018 [46]
2015-09-30 16:52:48.400 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.core.filebuffers_3.5.200.v20120523-1310 [47]
2015-09-30 16:52:48.400 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.core.filesystem_1.3.200.v20130115-145044 [48]
2015-09-30 16:52:48.401 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.core.jobs_3.5.300.v20120912-155018 [49]
2015-09-30 16:52:48.401 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.core.resources_3.8.1.v20121114-124432 [50]
2015-09-30 16:52:48.401 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.core.runtime_3.8.0.v20120912-155025 [51]
2015-09-30 16:52:48.401 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.core.variables_3.2.600.v20120521-2012 [52]
2015-09-30 16:52:48.401 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.e4.core.commands_0.10.1.v20120523-1955 [55]
2015-09-30 16:52:48.402 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.e4.core.contexts_1.2.0.v20121221-192508 [56]
2015-09-30 16:52:48.402 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.e4.core.di_1.2.0.v20121024-173149 [57]
2015-09-30 16:52:48.402 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.e4.core.di.extensions_0.11.100.v20121024-182359 [58]
2015-09-30 16:52:48.402 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.e4.core.services_1.0.0.v20120521-2346 [59]
2015-09-30 16:52:48.402 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.ecf_3.1.300.v20120610-1946 [73]
2015-09-30 16:52:48.403 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.ecf.filetransfer_5.0.0.v20120610-1946 [74]
2015-09-30 16:52:48.403 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.ecf.identity_3.1.200.v20120610-1946 [75]
2015-09-30 16:52:48.403 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.ecf.provider.filetransfer_3.2.0.v20120610-1946 [76]
2015-09-30 16:52:48.403 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.ecf.provider.filetransfer.httpclient_4.0.200.v20120610-1946 [77]
2015-09-30 16:52:48.403 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.ecf.provider.filetransfer.httpclient.ssl_1.0.0.v20120610-1946 [78]
2015-09-30 16:52:48.404 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.ecf.provider.filetransfer.ssl_1.0.0.v20120610-1946 [79]
2015-09-30 16:52:48.404 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.ecf.ssl_1.0.100.v20120610-1946 [80]
2015-09-30 16:52:48.404 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.emf.codegen_2.8.0.v20130125-0826 [81]
2015-09-30 16:52:48.404 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.emf.codegen.ecore_2.8.2.v20130125-0826 [82]
2015-09-30 16:52:48.404 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.emf.common_2.8.0.v20130125-0546 [83]
2015-09-30 16:52:48.404 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.emf.ecore_2.8.3.v20130125-0546 [84]
2015-09-30 16:52:48.405 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.emf.ecore.change_2.8.0.v20130125-0546 [85]
2015-09-30 16:52:48.405 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.emf.ecore.xmi_2.8.1.v20130125-0546 [86]
2015-09-30 16:52:48.405 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.emf.mwe.core_1.2.1.v201206110920 [87]
2015-09-30 16:52:48.405 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.emf.mwe.utils_1.2.1.v201206110920 [88]
2015-09-30 16:52:48.405 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.emf.mwe2.language_2.3.0.v201206120758 [89]
2015-09-30 16:52:48.406 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.emf.mwe2.launch_2.3.0.v201206120758 [90]
2015-09-30 16:52:48.406 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.emf.mwe2.lib_2.3.0.v201206110920 [91]
2015-09-30 16:52:48.406 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.emf.mwe2.runtime_2.3.0.v201206110920 [92]
2015-09-30 16:52:48.406 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.app_1.3.100.v20120522-1841 [93]
2015-09-30 16:52:48.406 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.cm_1.0.400.v20120522-1841 [94]
2015-09-30 16:52:48.407 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.common_3.6.100.v20120522-1841 [95]
2015-09-30 16:52:48.407 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.concurrent_1.0.300.v20120912-130548 [96]
2015-09-30 16:52:48.407 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.console_1.0.0.v20120522-1841 [97]
2015-09-30 16:52:48.407 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.ds_1.4.1.v20120926-201320 [98]
2015-09-30 16:52:48.407 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.event_1.2.200.v20120522-2049 [99]
2015-09-30 16:52:48.407 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.frameworkadmin_2.0.100.v20120913-155515 [100]
2015-09-30 16:52:48.408 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.frameworkadmin.equinox_1.0.400.v20120913-155709 [101]
2015-09-30 16:52:48.408 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.http.registry_1.1.200.v20120912-130548 [102]
2015-09-30 16:52:48.408 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.http.servlet_1.1.300.v20120522-1841 [103]
2015-09-30 16:52:48.408 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.launcher_1.3.0.v20120522-1813 [104]
2015-09-30 16:52:48.408 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.p2.artifact.repository_1.1.200.v20120430-1959 [105]
2015-09-30 16:52:48.409 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.p2.console_1.0.300.v20120429-0125 [106]
2015-09-30 16:52:48.409 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.p2.core_2.2.0.v20120430-0525 [107]
2015-09-30 16:52:48.409 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.p2.director_2.2.0.v20120524-0542 [108]
2015-09-30 16:52:48.409 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.p2.engine_2.2.0.v20130121-021919 [109]
2015-09-30 16:52:48.409 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.p2.garbagecollector_1.0.200.v20110808-1657 [110]
2015-09-30 16:52:48.410 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.p2.jarprocessor_1.0.200.v20110808-1657 [111]
2015-09-30 16:52:48.410 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.p2.metadata_2.1.0.v20120430-2001 [112]
2015-09-30 16:52:48.410 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.p2.metadata.repository_1.2.100.v20120524-1717 [113]
2015-09-30 16:52:48.410 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.p2.ql_2.0.100.v20110808-1657 [114]
2015-09-30 16:52:48.410 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.p2.repository_2.2.0.v20120524-1945 [115]
2015-09-30 16:52:48.411 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.p2.touchpoint.eclipse_2.1.100.v20120428-0117 [116]
2015-09-30 16:52:48.411 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.p2.touchpoint.natives_1.1.0.v20130121-021919 [117]
2015-09-30 16:52:48.411 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.p2.transport.ecf_1.0.100.v20120913-155635 [118]
2015-09-30 16:52:48.411 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.preferences_3.5.1.v20121031-182809 [119]
2015-09-30 16:52:48.411 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.registry_3.5.200.v20120522-1841 [120]
2015-09-30 16:52:48.412 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.security_1.1.100.v20120522-1841 [121]
2015-09-30 16:52:48.412 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.simpleconfigurator.manipulator_2.0.0.v20110808-1657 [122]
2015-09-30 16:52:48.412 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.equinox.util_1.0.400.v20120917-192807 [123]
2015-09-30 16:52:48.412 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jdt.debug_3.7.101.v20120913-153601 [128]
2015-09-30 16:52:48.412 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.client_8.1.3.v20120522 [132]
2015-09-30 16:52:48.413 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.continuation_8.1.3.v20120522 [133]
2015-09-30 16:52:48.413 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.deploy_8.1.3.v20120522 [134]
2015-09-30 16:52:48.413 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.http_8.1.3.v20120522 [135]
2015-09-30 16:52:48.413 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.io_8.1.3.v20120522 [136]
2015-09-30 16:52:48.413 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.jmx_8.1.3.v20120522 [137]
2015-09-30 16:52:48.413 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.jndi_8.1.3.v20120522 [138]
2015-09-30 16:52:48.414 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.osgi.boot_8.1.3.v20120522 [139]
2015-09-30 16:52:48.414 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.osgi.boot.warurl_8.1.3.qualifier [140]
2015-09-30 16:52:48.414 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.osgi.httpservice_8.1.3.qualifier [141]
2015-09-30 16:52:48.414 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.plus_8.1.3.v20120522 [142]
2015-09-30 16:52:48.414 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.rewrite_8.1.3.v20120522 [143]
2015-09-30 16:52:48.415 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.security_8.1.3.v20120522 [144]
2015-09-30 16:52:48.415 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.server_8.1.3.v20120522 [145]
2015-09-30 16:52:48.415 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.servlet_8.1.3.v20120522 [146]
2015-09-30 16:52:48.415 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.servlets_8.1.3.v20120522 [147]
2015-09-30 16:52:48.415 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.util_8.1.3.v20120522 [148]
2015-09-30 16:52:48.415 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.webapp_8.1.3.v20120522 [149]
2015-09-30 16:52:48.416 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.websocket_8.1.3.v20120522 [150]
2015-09-30 16:52:48.416 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.jetty.xml_8.1.3.v20120522 [151]
2015-09-30 16:52:48.416 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.ltk.core.refactoring_3.6.0.v20120523-1543 [155]
2015-09-30 16:52:48.416 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.osgi.services_3.3.100.v20120522-1822 [157]
2015-09-30 16:52:48.416 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.swt_3.100.1.v4236b [159]
2015-09-30 16:52:48.417 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.text_3.5.200.v20120523-1310 [162]
2015-09-30 16:52:48.417 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.xpand_1.1.0.v201108020519 [174]
2015-09-30 16:52:48.417 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.xtend_1.1.0.v201108020519 [175]
2015-09-30 16:52:48.417 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.xtend.lib_2.3.1.v201208210947 [176]
2015-09-30 16:52:48.417 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.xtend.typesystem.emf_1.0.1.v201108020519 [177]
2015-09-30 16:52:48.418 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.xtext_2.3.0.v201206120633 [178]
2015-09-30 16:52:48.418 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.xtext.common.types_2.3.0.v201206120633 [179]
2015-09-30 16:52:48.418 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.xtext.ecore_2.3.0.v201206120633 [180]
2015-09-30 16:52:48.418 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.xtext.generator_2.3.0.v201206120633 [181]
2015-09-30 16:52:48.418 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.xtext.smap_2.3.0.v201206120633 [182]
2015-09-30 16:52:48.419 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.xtext.util_2.3.0.v201206120633 [183]
2015-09-30 16:52:48.419 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.xtext.xbase_2.3.0.v201206120633 [184]
2015-09-30 16:52:48.419 [INFO ] [h.services.osgi.BundleResource] - org.eclipse.xtext.xbase.lib_2.3.0.v201206120633 [185]
2015-09-30 16:52:48.419 [INFO ] [h.services.osgi.BundleResource] - org.openhab.config.core_1.6.2 [186]
2015-09-30 16:52:48.419 [INFO ] [h.services.osgi.BundleResource] - org.openhab.core_1.6.2 [187]
2015-09-30 16:52:48.419 [INFO ] [h.services.osgi.BundleResource] - org.openhab.core.autoupdate_1.6.2 [188]
2015-09-30 16:52:48.420 [INFO ] [h.services.osgi.BundleResource] - org.openhab.core.library_1.6.2 [189]
2015-09-30 16:52:48.420 [INFO ] [h.services.osgi.BundleResource] - org.openhab.core.persistence_1.6.2 [190]
2015-09-30 16:52:48.420 [INFO ] [h.services.osgi.BundleResource] - org.openhab.core.scheduler_1.6.2 [191]
2015-09-30 16:52:48.420 [INFO ] [h.services.osgi.BundleResource] - org.openhab.core.scriptengine_1.6.2 [192]
2015-09-30 16:52:48.421 [INFO ] [h.services.osgi.BundleResource] - org.openhab.core.transform_1.6.2 [193]
2015-09-30 16:52:48.421 [INFO ] [h.services.osgi.BundleResource] - org.openhab.io.console_1.6.2 [194]
2015-09-30 16:52:48.421 [INFO ] [h.services.osgi.BundleResource] - org.openhab.io.monitor_1.6.2 [195]
2015-09-30 16:52:48.421 [INFO ] [h.services.osgi.BundleResource] - org.openhab.io.multimedia_1.6.2 [196]
2015-09-30 16:52:48.421 [INFO ] [h.services.osgi.BundleResource] - org.openhab.io.net_1.6.2 [197]
2015-09-30 16:52:48.422 [INFO ] [h.services.osgi.BundleResource] - org.openhab.io.rest_1.6.2 [198]
2015-09-30 16:52:48.422 [INFO ] [h.services.osgi.BundleResource] - org.openhab.io.rest.lib_1.6.2 [199]
2015-09-30 16:52:48.422 [INFO ] [h.services.osgi.BundleResource] - org.openhab.io.servicediscovery_1.6.2 [200]
2015-09-30 16:52:48.422 [INFO ] [h.services.osgi.BundleResource] - org.openhab.io.transport.mqtt_1.6.2 [201]
2015-09-30 16:52:48.422 [INFO ] [h.services.osgi.BundleResource] - org.openhab.io.transport.serial_1.6.2 [202]
2015-09-30 16:52:48.422 [INFO ] [h.services.osgi.BundleResource] - org.openhab.library.tel_1.6.2 [203]
2015-09-30 16:52:48.423 [INFO ] [h.services.osgi.BundleResource] - org.openhab.model.core_1.6.2 [204]
2015-09-30 16:52:48.423 [INFO ] [h.services.osgi.BundleResource] - org.openhab.model.item_1.6.2 [205]
2015-09-30 16:52:48.423 [INFO ] [h.services.osgi.BundleResource] - org.openhab.model.persistence_1.6.2 [206]
2015-09-30 16:52:48.423 [INFO ] [h.services.osgi.BundleResource] - org.openhab.model.rule_1.6.2 [207]
2015-09-30 16:52:48.423 [INFO ] [h.services.osgi.BundleResource] - org.openhab.model.script_1.6.2 [208]
2015-09-30 16:52:48.424 [INFO ] [h.services.osgi.BundleResource] - org.openhab.model.sitemap_1.6.2 [209]
2015-09-30 16:52:48.424 [INFO ] [h.services.osgi.BundleResource] - org.openhab.ui_1.6.2 [210]
2015-09-30 16:52:48.424 [INFO ] [h.services.osgi.BundleResource] - org.openhab.ui.webapp_1.6.2 [211]
2015-09-30 16:52:48.424 [INFO ] [h.services.osgi.BundleResource] - org.sat4j.core_2.3.0.v20110329 [212]
2015-09-30 16:52:48.424 [INFO ] [h.services.osgi.BundleResource] - org.sat4j.pb_2.3.0.v20110329 [213]
2015-09-30 16:52:48.424 [INFO ] [h.services.osgi.BundleResource] - org.slf4j.api_1.7.2.v20121108-1250 [214]
2015-09-30 16:52:48.425 [INFO ] [h.services.osgi.BundleResource] - org.slf4j.jcl_1.7.2.v20130115-1340 [215]
2015-09-30 16:52:48.425 [INFO ] [h.services.osgi.BundleResource] - org.slf4j.jul_1.7.2.v20121108-1250 [216]
2015-09-30 16:52:48.425 [INFO ] [h.services.osgi.BundleResource] - org.slf4j.log4j_1.7.2.v20130115-1340 [217]
2015-09-30 16:52:48.425 [INFO ] [h.services.osgi.BundleResource] - org.w3c.css.sac_1.3.1.v200903091627 [218]
2015-09-30 16:52:48.426 [INFO ] [h.services.osgi.BundleResource] - org.w3c.dom.smil_1.0.0.v200806040011 [219]
2015-09-30 16:52:48.426 [INFO ] [h.services.osgi.BundleResource] - org.w3c.dom.svg_1.1.0.v201011041433 [220]
2015-09-30 16:52:48.426 [INFO ] [h.services.osgi.BundleResource] - org.openhab.binding.xbmc_1.7.0.201505230103 [221]
2015-09-30 16:52:48.426 [INFO ] [h.services.osgi.BundleResource] - org.openhab.binding.nest_1.7.0.201505230103 [222]
2015-09-30 16:52:48.426 [INFO ] [h.services.osgi.BundleResource] - org.openhab.binding.zwave_1.7.0.201505230103 [223]
2015-09-30 16:52:48.426 [INFO ] [h.services.osgi.BundleResource] - org.openhab.io.habmin_1.4.0.201404281845 [224]
2015-09-30 16:53:37.421 [ERROR] [.z.i.config.ZWaveConfiguration] - Neither inclusion nor exclusion was active!

rm65453 · October 2, 2015, 12:52am

alright @chris making some progress now. has finally paired with habmin but cannot retrieve data


2015-10-01 18:06:17.999 [INFO ] [rialApiGetInitDataMessageClass] - ZWave Controller is Primary Controller

2015-10-01 18:06:18.000 [INFO ] [rialApiGetInitDataMessageClass] - ------------Number of Nodes Found Registered to ZWave Controller------------

2015-10-01 18:06:18.002 [INFO ] [rialApiGetInitDataMessageClass] - # Nodes = 5

2015-10-01 18:06:18.003 [INFO ] [rialApiGetInitDataMessageClass] - ----------------------------------------------------------------------------

2015-10-01 18:06:21.954 [WARN ] [.o.b.z.i.p.c.ZWaveCommandClass] - NODE 2: Unsupported command class SWITCH_ALL

2015-10-01 18:06:22.073 [WARN ] [.o.b.z.i.p.c.ZWaveCommandClass] - NODE 6: Unsupported command class SWITCH_ALL

2015-10-01 18:07:16.275 [ERROR] [b.x.internal.XbmcActiveBinding] - Connection failed for ‘#bedroom’ on 192.168.1.105

2015-10-01 18:08:16.312 [ERROR] [b.x.internal.XbmcActiveBinding] - Connection failed for ‘#living’ on 192.168.1.123

2015-10-01 18:31:23.879 [INFO ] [c.internal.ModelRepositoryImpl] - Refreshing model ‘default.sitemap’

2015-10-01 18:35:51.520 [WARN ] [.o.b.z.i.p.c.ZWaveCommandClass] - NODE 5: Unsupported command class MULTI_INSTANCE_ASSOCIATION

2015-10-01 18:35:54.884 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@8f7eb8, ignoring.

2015-10-01 18:35:55.052 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@d9003a, ignoring.

2015-10-01 18:35:55.202 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@17c96de, ignoring.

2015-10-01 18:35:55.352 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@14fff48, ignoring.

2015-10-01 18:35:55.503 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@e32742, ignoring.

2015-10-01 18:35:55.652 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@53987d, ignoring.

2015-10-01 18:35:55.802 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@1e6525, ignoring.

2015-10-01 18:35:55.952 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@2cbb7b, ignoring.

2015-10-01 18:35:56.102 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@b0613b, ignoring.

2015-10-01 18:35:56.252 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@18b51d4, ignoring.

2015-10-01 18:35:56.402 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@103c720, ignoring.

2015-10-01 18:35:56.553 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@b28aae, ignoring.

2015-10-01 18:35:56.702 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@11d2f2a, ignoring.

2015-10-01 18:35:56.852 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@15f9103, ignoring.

2015-10-01 18:35:57.020 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@1afdc1a, ignoring.

2015-10-01 18:35:57.154 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@1c11724, ignoring.

2015-10-01 18:35:57.312 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@12a3c98, ignoring.

2015-10-01 18:35:57.447 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@a12d91, ignoring.

2015-10-01 18:35:57.612 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@18020b7, ignoring.

2015-10-01 18:35:57.763 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@558922, ignoring.

2015-10-01 18:35:57.912 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@1f6e749, ignoring.

2015-10-01 18:35:58.063 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@164ce8a, ignoring.

2015-10-01 18:35:58.212 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@173f773, ignoring.

2015-10-01 18:35:58.362 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@1673aa6, ignoring.

2015-10-01 18:35:58.512 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@fa10e5, ignoring.

2015-10-01 18:35:58.662 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@1ecf3f2, ignoring.

2015-10-01 18:35:58.812 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = CONFIGURATION, value = org.openhab.binding.zwave.internal.protocol.ConfigurationParameter@158a65, ignoring.

2015-10-01 18:35:59.153 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = BATTERY, value = 100, ignoring.

2015-10-01 18:35:59.313 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = SENSOR_ALARM, value = 0, ignoring.

2015-10-01 18:35:59.453 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = SENSOR_BINARY, value = 0, ignoring.

2015-10-01 18:36:01.243 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 5: No item bound for event, endpoint = 0, command class = SENSOR_MULTILEVEL, value = 3, ignoring.

2015-10-01 18:36:12.833 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 2: No item bound for event, endpoint = 1, command class = SWITCH_MULTILEVEL, value = 3, ignoring.

2015-10-01 18:36:17.923 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 2: No item bound for event, endpoint = 1, command class = SWITCH_MULTILEVEL, value = 99, ignoring.

2015-10-01 18:36:26.273 [WARN ] [.z.internal.ZWaveActiveBinding] - NODE 2: No item bound for event, endpoint = 1, command class = SWITCH_MULTILEVEL, value = 0, ignoring.

2015-10-01 18:39:54.116 [INFO ] [c.internal.ModelRepositoryImpl] - Refreshing model ‘default.items’

2015-10-01 18:39:54.226 [WARN ] [.b.z.i.c.ZWaveConverterHandler] - NODE 2: Generating message failed for command class = SWITCH_MULTILEVEL

2015-10-01 18:39:54.228 [WARN ] [.b.z.i.c.ZWaveConverterHandler] - NODE 2: Generating message failed for command class = SWITCH_MULTILEVEL

2015-10-01 18:39:54.230 [WARN ] [.b.z.i.c.ZWaveConverterHandler] - NODE 2: Generating message failed for command class = SWITCH_MULTILEVEL

2015-10-01 18:39:54.231 [WARN ] [.b.z.i.c.ZWaveConverterHandler] - NODE 2: Generating message failed for command class = SWITCH_MULTILEVEL

2015-10-01 18:39:54.237 [WARN ] [.b.z.i.c.ZWaveConverterHandler] - NODE 5: Generating message failed for command class = SENSOR_MULTILEVEL

2015-10-01 18:39:54.243 [WARN ] [.b.z.i.c.ZWaveConverterHandler] - NODE 5: Generating message failed for command class = SENSOR_MULTILEVEL

2015-10-01 18:40:04.271 [INFO ] [c.internal.ModelRepositoryImpl] - Refreshing model ‘default.sitemap’

rm65453 · October 2, 2015, 2:52am

This is how I resolved this.

Excluded the device and included it back and then placed the sensor next to the controller for a few hours. Slowly all problems resolved.