Hello together,
my OH 2.3 runs on a Synology NAS.
But I have a problem with the WEMO binding.
The gateway is a brand for an Arduino. That it is because I can exclude, without it works. This will be used to power outlets from Brennenstuhl.
The binding in the OH works only one day. After that you can no longer switch sockets.
only after the removal and the subsequent reinstallation of the binding, the articles can be operated again. In the appendix an excerpt from the LOG.
Maybe someone can give me a hint, what could be the cause?
Blockquote
2018-12-13 18:02:29.756 [INFO ] [ui.habmin.internal.servlet.HABminApp] - Started HABmin servlet at /habmin
2018-12-13 18:02:30.027 [INFO ] [assic.internal.servlet.WebAppServlet] - Started Classic UI at /classicui/app
2018-12-13 18:02:30.707 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing ‘wemo:socket:Socket-1_0-44455697D1A50B’ to inbox.
2018-12-13 18:02:30.852 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing ‘wemo:socket:Socket-1_0-44455697D1A50C’ to inbox.
2018-12-13 18:02:31.134 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing ‘wemo:socket:Socket-1_0-44455697D1A50D’ to inbox.
2018-12-13 18:02:32.359 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing ‘wemo:socket:Socket-1_0-44455697D1A503’ to inbox.
2018-12-13 18:02:32.607 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing ‘wemo:socket:Socket-1_0-44455697D1A504’ to inbox.
2018-12-13 18:02:32.860 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing ‘wemo:socket:Socket-1_0-44455697D1A507’ to inbox.
2018-12-13 18:02:33.136 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing ‘wemo:socket:Socket-1_0-44455697D1A508’ to inbox.
2018-12-13 18:02:34.609 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing ‘wemo:socket:Socket-1_0-44455697D1A500’ to inbox.
2018-12-13 18:02:35.131 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing ‘wemo:socket:Socket-1_0-44455697D1A505’ to inbox.
2018-12-13 18:02:35.386 [INFO ] [g.discovery.internal.PersistentInbox] - Added new thing ‘wemo:socket:Socket-1_0-44455697D1A506’ to inbox.
2018-12-13 18:02:44.980 [INFO ] [control.internal.WebSocketConnection] - Web Socket close 1000. Reason: null
2018-12-13 18:02:45.856 [INFO ] [.handler.FlashBriefingProfileHandler] - FlashBriefingProfileHandler initialized
2018-12-13 18:02:45.913 [WARN ] [org.apache.felix.fileinstall ] - Error while starting bundle: file:/volume1/SmartHome/openHAB/addons/org.openhab.binding.denonmarantz-2.2.0-SNAPSHOT.jar
org.osgi.framework.BundleException: Could not resolve module: org.openhab.binding.denonmarantz [189]
Another singleton bundle selected: osgi.identity; type=“osgi.bundle”; version:Version=“2.3.0”; osgi.identity=“org.openhab.binding.denonmarantz”; singleton:=“true”
at org.eclipse.osgi.container.Module.start(Module.java:444) [?:?]
at org.eclipse.osgi.internal.framework.EquinoxBundle.start(EquinoxBundle.java:383) [?:?]
at org.apache.felix.fileinstall.internal.DirectoryWatcher.startBundle(DirectoryWatcher.java:1260) [9:org.apache.felix.fileinstall:3.6.4]
at org.apache.felix.fileinstall.internal.DirectoryWatcher.startBundles(DirectoryWatcher.java:1233) [9:org.apache.felix.fileinstall:3.6.4]
at org.apache.felix.fileinstall.internal.DirectoryWatcher.startAllBundles(DirectoryWatcher.java:1221) [9:org.apache.felix.fileinstall:3.6.4]
at org.apache.felix.fileinstall.internal.DirectoryWatcher.doProcess(DirectoryWatcher.java:515) [9:org.apache.felix.fileinstall:3.6.4]
at org.apache.felix.fileinstall.internal.DirectoryWatcher.process(DirectoryWatcher.java:365) [9:org.apache.felix.fileinstall:3.6.4]
at org.apache.felix.fileinstall.internal.DirectoryWatcher.run(DirectoryWatcher.java:316) [9:org.apache.felix.fileinstall:3.6.4]
2018-12-13 18:02:45.929 [WARN ] [org.apache.felix.fileinstall ] - Error while starting bundle: file:/volume1/SmartHome/openHAB/addons/org.openhab.binding.denonmarantz-2.2.0-SNAPSHOT.jar
org.osgi.framework.BundleException: Could not resolve module: org.openhab.binding.denonmarantz [189]
Another singleton bundle selected: osgi.identity; type=“osgi.bundle”; version:Version=“2.3.0”; osgi.identity=“org.openhab.binding.denonmarantz”; singleton:=“true”
at org.eclipse.osgi.container.Module.start(Module.java:444) [?:?]
at org.eclipse.osgi.internal.framework.EquinoxBundle.start(EquinoxBundle.java:383) [?:?]
at org.apache.felix.fileinstall.internal.DirectoryWatcher.startBundle(DirectoryWatcher.java:1260) [9:org.apache.felix.fileinstall:3.6.4]
at org.apache.felix.fileinstall.internal.DirectoryWatcher.startBundles(DirectoryWatcher.java:1233) [9:org.apache.felix.fileinstall:3.6.4]
at org.apache.felix.fileinstall.internal.DirectoryWatcher.doProcess(DirectoryWatcher.java:520) [9:org.apache.felix.fileinstall:3.6.4]
at org.apache.felix.fileinstall.internal.DirectoryWatcher.process(DirectoryWatcher.java:365) [9:org.apache.felix.fileinstall:3.6.4]
at org.apache.felix.fileinstall.internal.DirectoryWatcher.run(DirectoryWatcher.java:316) [9:org.apache.felix.fileinstall:3.6.4]
2018-12-13 18:02:46.058 [ERROR] [home.internal.api.EvohomeApiClientV2] - Authorization failed
2018-12-14 00:00:30.043 [INFO ] [thome.binding.astro.internal.job.Job] - Scheduled Astro event-jobs for thing astro:moon:local
2018-12-14 00:00:30.069 [INFO ] [thome.binding.astro.internal.job.Job] - Scheduled Astro event-jobs for thing astro:sun:local
2018-12-14 07:17:49.767 [ERROR] [.jupnp.transport.impl.DatagramIOImpl] - Exception sending datagram to: /239.255.255.250: java.io.IOException: Invalid argument (sendto failed)
java.io.IOException: Invalid argument (sendto failed)
at java.net.PlainDatagramSocketImpl.send(Native Method) ~[?:?]
at java.net.DatagramSocket.send(DatagramSocket.java:693) [?:?]
at org.jupnp.transport.impl.DatagramIOImpl.send(DatagramIOImpl.java:156) [173:org.jupnp:2.3.0]
at org.jupnp.transport.impl.DatagramIOImpl.send(DatagramIOImpl.java:149) [173:org.jupnp:2.3.0]
at org.jupnp.transport.RouterImpl.send(RouterImpl.java:300) [173:org.jupnp:2.3.0]
at org.jupnp.protocol.async.SendingSearch.execute(SendingSearch.java:90) [173:org.jupnp:2.3.0]
at org.jupnp.protocol.SendingAsync.run(SendingAsync.java:52) [173:org.jupnp:2.3.0]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:?]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:?]
at java.lang.Thread.run(Thread.java:748) [?:?]
2018-12-14 07:17:49.769 [ERROR] [.jupnp.transport.impl.DatagramIOImpl] - Details: datagram.socketAddress=/239.255.255.250:1900, length=101, offfset=0, data.bytes=101
2018-12-14 07:17:49.770 [ERROR] [.jupnp.transport.impl.DatagramIOImpl] - Details: socket=false, closed=true, bound=null, inetAddress=null, remoteSocketAddress=name:0.0.0.0, networkInterface=java.net.MulticastSocket@44ffc048
2018-12-14 07:17:49.871 [ERROR] [core.karaf.internal.FeatureInstaller] - Failed installing ‘openhab-binding-wemo’: Error restarting bundles:
Could not resolve module: org.openhab.binding.amazonechocontrol [200]
Another singleton bundle selected: osgi.identity; type=“osgi.bundle”; version:Version=“2.4.0.201811161948”; osgi.identity=“org.openhab.binding.amazonechocontrol”; singleton:=“true”
2018-12-14 07:17:50.300 [ERROR] [.jupnp.transport.impl.DatagramIOImpl] - Exception sending datagram to: /239.255.255.250: java.io.IOException: Invalid argument (sendto failed)
java.io.IOException: Invalid argument (sendto failed)
at java.net.PlainDatagramSocketImpl.send(Native Method) ~[?:?]
at java.net.DatagramSocket.send(DatagramSocket.java:693) [?:?]
at org.jupnp.transport.impl.DatagramIOImpl.send(DatagramIOImpl.java:156) [173:org.jupnp:2.3.0]
at org.jupnp.transport.impl.DatagramIOImpl.send(DatagramIOImpl.java:149) [173:org.jupnp:2.3.0]
at org.jupnp.transport.RouterImpl.send(RouterImpl.java:300) [173:org.jupnp:2.3.0]
at org.jupnp.protocol.async.SendingSearch.execute(SendingSearch.java:90) [173:org.jupnp:2.3.0]
at org.jupnp.protocol.SendingAsync.run(SendingAsync.java:52) [173:org.jupnp:2.3.0]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:?]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:?]
at java.lang.Thread.run(Thread.java:748) [?:?]
2018-12-14 07:17:50.301 [ERROR] [.jupnp.transport.impl.DatagramIOImpl] - Details: datagram.socketAddress=/239.255.255.250:1900, length=101, offfset=0, data.bytes=101
2018-12-14 07:17:50.302 [ERROR] [.jupnp.transport.impl.DatagramIOImpl] - Details: socket=false, closed=true, bound=null, inetAddress=null, remoteSocketAddress=name:0.0.0.0, networkInterface=java.net.MulticastSocket@44ffc048
2018-12-14 07:17:50.805 [ERROR] [.jupnp.transport.impl.DatagramIOImpl] - Exception sending datagram to: /239.255.255.250: java.io.IOException: Invalid argument (sendto failed)
java.io.IOException: Invalid argument (sendto failed)
at java.net.PlainDatagramSocketImpl.send(Native Method) ~[?:?]
at java.net.DatagramSocket.send(DatagramSocket.java:693) [?:?]
at org.jupnp.transport.impl.DatagramIOImpl.send(DatagramIOImpl.java:156) [173:org.jupnp:2.3.0]
at org.jupnp.transport.impl.DatagramIOImpl.send(DatagramIOImpl.java:149) [173:org.jupnp:2.3.0]
at org.jupnp.transport.RouterImpl.send(RouterImpl.java:300) [173:org.jupnp:2.3.0]
at org.jupnp.protocol.async.SendingSearch.execute(SendingSearch.java:90) [173:org.jupnp:2.3.0]
at org.jupnp.protocol.SendingAsync.run(SendingAsync.java:52) [173:org.jupnp:2.3.0]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:?]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:?]
at java.lang.Thread.run(Thread.java:748) [?:?]
2018-12-14 07:17:50.807 [ERROR] [.jupnp.transport.impl.DatagramIOImpl] - Details: datagram.socketAddress=/239.255.255.250:1900, length=101, offfset=0, data.bytes=101
2018-12-14 07:17:50.807 [ERROR] [.jupnp.transport.impl.DatagramIOImpl] - Details: socket=false, closed=true, bound=null, inetAddress=null, remoteSocketAddress=name:0.0.0.0, networkInterface=java.net.MulticastSocket@44ffc048
2018-12-14 07:17:51.309 [ERROR] [.jupnp.transport.impl.DatagramIOImpl] - Exception sending datagram to: /239.255.255.250: java.io.IOException: Invalid argument (sendto failed)
java.io.IOException: Invalid argument (sendto failed)
at java.net.PlainDatagramSocketImpl.send(Native Method) ~[?:?]
at java.net.DatagramSocket.send(DatagramSocket.java:693) [?:?]
at org.jupnp.transport.impl.DatagramIOImpl.send(DatagramIOImpl.java:156) [173:org.jupnp:2.3.0]
at org.jupnp.transport.impl.DatagramIOImpl.send(DatagramIOImpl.java:149) [173:org.jupnp:2.3.0]
at org.jupnp.transport.RouterImpl.send(RouterImpl.java:300) [173:org.jupnp:2.3.0]
at org.jupnp.protocol.async.SendingSearch.execute(SendingSearch.java:90) [173:org.jupnp:2.3.0]
at org.jupnp.protocol.SendingAsync.run(SendingAsync.java:52) [173:org.jupnp:2.3.0]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:?]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:?]
at java.lang.Thread.run(Thread.java:748) [?:?]
2018-12-14 07:17:51.310 [ERROR] [.jupnp.transport.impl.DatagramIOImpl] - Details: datagram.socketAddress=/239.255.255.250:1900, length=101, offfset=0, data.bytes=101
2018-12-14 07:17:51.311 [ERROR] [.jupnp.transport.impl.DatagramIOImpl] - Details: socket=false, closed=true, bound=null, inetAddress=null, remoteSocketAddress=name:0.0.0.0, networkInterface=java.net.MulticastSocket@44ffc048
2018-12-14 07:17:51.813 [ERROR] [.jupnp.transport.impl.DatagramIOImpl] - Exception sending datagram to: /239.255.255.250: java.io.IOException: Invalid argument (sendto failed)
java.io.IOException: Invalid argument (sendto failed)
at java.net.PlainDatagramSocketImpl.send(Native Method) ~[?:?]
at java.net.DatagramSocket.send(DatagramSocket.java:693) [?:?]
at org.jupnp.transport.impl.DatagramIOImpl.send(DatagramIOImpl.java:156) [173:org.jupnp:2.3.0]
at org.jupnp.transport.impl.DatagramIOImpl.send(DatagramIOImpl.java:149) [173:org.jupnp:2.3.0]
at org.jupnp.transport.RouterImpl.send(RouterImpl.java:300) [173:org.jupnp:2.3.0]
at org.jupnp.protocol.async.SendingSearch.execute(SendingSearch.java:90) [173:org.jupnp:2.3.0]
at org.jupnp.protocol.SendingAsync.run(SendingAsync.java:52) [173:org.jupnp:2.3.0]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:?]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:?]
at java.lang.Thread.run(Thread.java:748) [?:?]
2018-12-14 07:17:51.814 [ERROR] [.jupnp.transport.impl.DatagramIOImpl] - Details: datagram.socketAddress=/239.255.255.250:1900, length=101, offfset=0, data.bytes=101
2018-12-14 07:17:51.815 [ERROR] [.jupnp.transport.impl.DatagramIOImpl] - Details: socket=false, closed=true, bound=null, inetAddress=null, remoteSocketAddress=name:0.0.0.0, networkInterface=java.net.MulticastSocket@44ffc048
2018-12-14 23:37:55.616 [WARN ] [shd.server.session.ServerSessionImpl] - exceptionCaught(ServerSessionImpl[null@/127.0.0.1:51111])[state=Opened] IOException: Connection reset by peer
2018-12-14 23:38:16.816 [WARN ] [shd.server.session.ServerSessionImpl] - exceptionCaught(ServerSessionImpl[null@/127.0.0.1:51160])[state=Opened] IOException: Connection reset by peer
2018-12-14 23:38:27.941 [WARN ] [shd.server.session.ServerSessionImpl] - exceptionCaught(ServerSessionImpl[null@/127.0.0.1:51197])[state=Opened] IOException: Connection reset by peer
2018-12-14 23:40:12.223 [WARN ] [shd.server.session.ServerSessionImpl] - exceptionCaught(ServerSessionImpl[null@/127.0.0.1:51435])[state=Opened] IOException: Connection reset by peer
2018-12-14 23:43:18.004 [WARN ] [shd.server.session.ServerSessionImpl] - exceptionCaught(ServerSessionImpl[null@/127.0.0.1:51892])[state=Opened] IOException: Connection reset by peer
2018-12-14 23:54:36.460 [WARN ] [shd.server.session.ServerSessionImpl] - exceptionCaught(ServerSessionImpl[null@/127.0.0.1:53586])[state=Opened] IOException: Connection reset by peer
2018-12-14 23:54:40.915 [WARN ] [shd.server.session.ServerSessionImpl] - exceptionCaught(ServerSessionImpl[null@/127.0.0.1:53611])[state=Opened] IOException: Connection reset by peer
2018-12-15 00:00:30.028 [INFO ] [thome.binding.astro.internal.job.Job] - Scheduled Astro event-jobs for thing astro:sun:local
2018-12-15 00:00:30.033 [INFO ] [thome.binding.astro.internal.job.Job] - Scheduled Astro event-jobs for thing astro:moon:local
2018-12-15 00:06:47.777 [WARN ] [shd.server.session.ServerSessionImpl] - exceptionCaught(ServerSessionImpl[null@/127.0.0.1:55479])[state=Opened] IOException: Connection reset by peer
2018-12-15 09:34:40.971 [WARN ] [shd.server.session.ServerSessionImpl] - exceptionCaught(ServerSessionImpl[null@/127.0.0.1:36460])[state=Opened] IOException: Connection reset by peer
2018-12-15 09:49:22.862 [WARN ] [shd.server.session.ServerSessionImpl] - exceptionCaught(ServerSessionImpl[null@/127.0.0.1:36561])[state=Opened] IOException: Connection reset by peer
2018-12-15 09:49:52.314 [WARN ] [shd.server.session.ServerSessionImpl] - exceptionCaught(ServerSessionImpl[null@/127.0.0.1:36580])[state=Opened] IOException: Connection reset by peer
2018-12-15 11:45:25.183 [WARN ] [shd.server.session.ServerSessionImpl] - exceptionCaught(ServerSessionImpl[null@/127.0.0.1:37368])[state=Opened] IOException: Connection reset by peer
2018-12-15 11:47:03.500 [WARN ] [shd.server.session.ServerSessionImpl] - exceptionCaught(ServerSessionImpl[null@/127.0.0.1:37383])[state=Opened] IOException: Connection reset by peer
2018-12-15 12:36:30.472 [WARN ] [shd.server.session.ServerSessionImpl] - exceptionCaught(ServerSessionImpl[null@/127.0.0.1:37719])[state=Opened] IOException: Connection reset by peer
2018-12-15 12:46:43.464 [WARN ] [shd.server.session.ServerSessionImpl] - exceptionCaught(ServerSessionImpl[null@/127.0.0.1:37793])[state=Opened] IOException: Connection reset by peer
2018-12-15 12:52:57.497 [WARN ] [shd.server.session.ServerSessionImpl] - exceptionCaught(ServerSessionImpl[null@/127.0.0.1:37836])[state=Opened] IOException: Connection reset by peer
2018-12-15 13:00:19.850 [WARN ] [shd.server.session.ServerSessionImpl] - exceptionCaught(ServerSessionImpl[null@/127.0.0.1:37878])[state=Opened] IOException: Connection reset by peer
2018-12-15 13:06:49.971 [WARN ] [shd.server.session.ServerSessionImpl] - exceptionCaught(ServerSessionImpl[null@/127.0.0.1:37947])[state=Opened] IOException: Connection reset by peer
2018-12-15 13:09:19.432 [WARN ] [shd.server.session.ServerSessionImpl] - exceptionCaught(ServerSessionImpl[null@/127.0.0.1:37961])[state=Opened] IOException: Connection reset by peer
2018-12-15 13:14:10.810 [WARN ] [shd.server.session.ServerSessionImpl] - exceptionCaught(ServerSessionImpl[null@/127.0.0.1:38014])[state=Opened] IOException: Connection reset by peer
2018-12-15 13:28:24.299 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - WeMo UPnP device Socket-1_0-44455697D1A509 not yet registered
2018-12-15 13:28:24.299 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - WeMo UPnP device Socket-1_0-44455697D1A501 not yet registered
2018-12-15 13:28:24.301 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Setting up WeMo GENA subscription for ‘org.eclipse.smarthome.binding.wemo.handler.WemoHandler@786e107c’ FAILED - service.isRegistered(this) is FALSE
2018-12-15 13:28:24.299 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - WeMo UPnP device Socket-1_0-44455697D1A50A not yet registered
2018-12-15 13:28:24.302 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Setting up WeMo GENA subscription for ‘org.eclipse.smarthome.binding.wemo.handler.WemoHandler@696318a5’ FAILED - service.isRegistered(this) is FALSE
2018-12-15 13:28:24.302 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Setting up WeMo GENA subscription for ‘org.eclipse.smarthome.binding.wemo.handler.WemoHandler@2a789e9’ FAILED - service.isRegistered(this) is FALSE
2018-12-15 13:28:35.458 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - WeMo UPnP device Socket-1_0-44455697D1A502 not yet registered
2018-12-15 13:28:35.459 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Setting up WeMo GENA subscription for ‘org.eclipse.smarthome.binding.wemo.handler.WemoHandler@a428431’ FAILED - service.isRegistered(this) is FALSE
2018-12-15 13:30:24.302 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - WeMo UPnP device Socket-1_0-44455697D1A509 not yet registered
2018-12-15 13:30:24.303 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Setting up WeMo GENA subscription for ‘org.eclipse.smarthome.binding.wemo.handler.WemoHandler@786e107c’ FAILED - service.isRegistered(this) is FALSE
2018-12-15 13:30:24.303 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - WeMo UPnP device Socket-1_0-44455697D1A501 not yet registered
2018-12-15 13:30:24.303 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - WeMo UPnP device Socket-1_0-44455697D1A50A not yet registered
2018-12-15 13:30:24.303 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Setting up WeMo GENA subscription for ‘org.eclipse.smarthome.binding.wemo.handler.WemoHandler@696318a5’ FAILED - service.isRegistered(this) is FALSE
2018-12-15 13:30:24.303 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Setting up WeMo GENA subscription for ‘org.eclipse.smarthome.binding.wemo.handler.WemoHandler@2a789e9’ FAILED - service.isRegistered(this) is FALSE
2018-12-15 13:30:35.460 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - WeMo UPnP device Socket-1_0-44455697D1A502 not yet registered
2018-12-15 13:30:35.461 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Setting up WeMo GENA subscription for ‘org.eclipse.smarthome.binding.wemo.handler.WemoHandler@a428431’ FAILED - service.isRegistered(this) is FALSE
2018-12-15 13:32:24.303 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - WeMo UPnP device Socket-1_0-44455697D1A509 not yet registered
2018-12-15 13:32:24.304 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Setting up WeMo GENA subscription for ‘org.eclipse.smarthome.binding.wemo.handler.WemoHandler@786e107c’ FAILED - service.isRegistered(this) is FALSE
2018-12-15 13:32:24.304 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - WeMo UPnP device Socket-1_0-44455697D1A501 not yet registered
2018-12-15 13:32:24.304 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - WeMo UPnP device Socket-1_0-44455697D1A50A not yet registered
2018-12-15 13:32:24.305 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Setting up WeMo GENA subscription for ‘org.eclipse.smarthome.binding.wemo.handler.WemoHandler@696318a5’ FAILED - service.isRegistered(this) is FALSE
2018-12-15 13:32:24.305 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Setting up WeMo GENA subscription for ‘org.eclipse.smarthome.binding.wemo.handler.WemoHandler@2a789e9’ FAILED - service.isRegistered(this) is FALSE
2018-12-15 13:32:35.461 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - WeMo UPnP device Socket-1_0-44455697D1A502 not yet registered
2018-12-15 13:32:35.462 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Setting up WeMo GENA subscription for ‘org.eclipse.smarthome.binding.wemo.handler.WemoHandler@a428431’ FAILED - service.isRegistered(this) is FALSE
2018-12-15 13:32:43.467 [DEBUG] [org.eclipse.smarthome.binding.wemo ] - BundleEvent STOPPING - org.eclipse.smarthome.binding.wemo
2018-12-15 13:32:43.477 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - WeMoHandler disposed.
2018-12-15 13:32:43.478 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Removing WeMo GENA subscription for ‘org.eclipse.smarthome.binding.wemo.handler.WemoHandler@786e107c’
2018-12-15 13:32:43.486 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - WeMoHandler disposed.
2018-12-15 13:32:43.487 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Removing WeMo GENA subscription for ‘org.eclipse.smarthome.binding.wemo.handler.WemoHandler@a428431’
2018-12-15 13:32:43.492 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - WeMoHandler disposed.
2018-12-15 13:32:43.492 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Removing WeMo GENA subscription for ‘org.eclipse.smarthome.binding.wemo.handler.WemoHandler@696318a5’
2018-12-15 13:32:43.500 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - WeMoHandler disposed.
2018-12-15 13:32:43.501 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Removing WeMo GENA subscription for ‘org.eclipse.smarthome.binding.wemo.handler.WemoHandler@2a789e9’
2018-12-15 13:32:43.510 [DEBUG] [org.eclipse.smarthome.binding.wemo ] - ServiceEvent UNREGISTERING - {org.eclipse.smarthome.core.thing.binding.ThingHandlerFactory}={service.id=428, service.bundleid=240, service.scope=bundle, component.name=org.eclipse.smarthome.binding.wemo.internal.WemoHandlerFactory, component.id=288} - org.eclipse.smarthome.binding.wemo
2018-12-15 13:32:43.513 [DEBUG] [org.eclipse.smarthome.binding.wemo ] - ServiceEvent UNREGISTERING - {org.eclipse.smarthome.config.discovery.DiscoveryService}={service.id=429, service.bundleid=240, service.scope=bundle, component.name=org.eclipse.smarthome.binding.wemo.internal.discovery.WemoDiscoveryService, component.id=289} - org.eclipse.smarthome.binding.wemo
2018-12-15 13:32:43.514 [DEBUG] [ernal.discovery.WemoDiscoveryService] - Stopping WeMo UPnP discovery…
2018-12-15 13:32:43.516 [DEBUG] [org.eclipse.smarthome.binding.wemo ] - ServiceEvent UNREGISTERING - {org.eclipse.smarthome.config.discovery.upnp.UpnpDiscoveryParticipant}={service.id=430, service.bundleid=240, service.scope=bundle, component.name=org.eclipse.smarthome.binding.wemo.internal.discovery.WemoDiscoveryParticipant, component.id=290} - org.eclipse.smarthome.binding.wemo
2018-12-15 13:32:43.529 [DEBUG] [org.eclipse.smarthome.binding.wemo ] - BundleEvent STOPPED - org.eclipse.smarthome.binding.wemo
2018-12-15 13:32:43.589 [DEBUG] [org.eclipse.smarthome.binding.wemo ] - BundleEvent UNRESOLVED - org.eclipse.smarthome.binding.wemo
2018-12-15 13:32:43.616 [DEBUG] [org.eclipse.smarthome.binding.wemo ] - BundleEvent UNINSTALLED - org.eclipse.smarthome.binding.wemo
2018-12-15 13:39:34.020 [DEBUG] [org.eclipse.smarthome.binding.wemo ] - BundleEvent INSTALLED - org.eclipse.smarthome.binding.wemo
2018-12-15 13:39:34.078 [DEBUG] [org.eclipse.smarthome.binding.wemo ] - BundleEvent RESOLVED - org.eclipse.smarthome.binding.wemo
2018-12-15 13:39:34.121 [DEBUG] [org.eclipse.smarthome.binding.wemo ] - BundleEvent STARTING - org.eclipse.smarthome.binding.wemo
2018-12-15 13:39:34.122 [DEBUG] [org.eclipse.smarthome.binding.wemo ] - BundleEvent STARTED - org.eclipse.smarthome.binding.wemo
2018-12-15 13:39:34.173 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - Trying to create a handler for ThingType 'wemo:socket
2018-12-15 13:39:34.176 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - Creating a WemoHandler for thing ‘wemo:socket:Socket-1_0-44455697D1A509’ with UDN ‘Socket-1_0-44455697D1A509’
2018-12-15 13:39:34.185 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Creating a WemoHandler for thing ‘wemo:socket:Socket-1_0-44455697D1A509’
2018-12-15 13:39:34.196 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Initializing WemoHandler for UDN ‘Socket-1_0-44455697D1A509’
2018-12-15 13:39:34.197 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Setting up WeMo GENA subscription for ‘org.eclipse.smarthome.binding.wemo.handler.WemoHandler@71049464’ FAILED - service.isRegistered(this) is FALSE
2018-12-15 13:39:34.198 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - WeMo UPnP device Socket-1_0-44455697D1A509 not yet registered
2018-12-15 13:39:34.200 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Setting up WeMo GENA subscription for ‘org.eclipse.smarthome.binding.wemo.handler.WemoHandler@71049464’ FAILED - service.isRegistered(this) is FALSE
2018-12-15 13:39:34.200 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - Trying to create a handler for ThingType 'wemo:socket
2018-12-15 13:39:34.202 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - Creating a WemoHandler for thing ‘wemo:socket:Socket-1_0-44455697D1A50A’ with UDN ‘Socket-1_0-44455697D1A50A’
2018-12-15 13:39:34.203 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Creating a WemoHandler for thing ‘wemo:socket:Socket-1_0-44455697D1A50A’
2018-12-15 13:39:34.207 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Initializing WemoHandler for UDN ‘Socket-1_0-44455697D1A50A’
2018-12-15 13:39:34.208 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Setting up WeMo GENA subscription for ‘org.eclipse.smarthome.binding.wemo.handler.WemoHandler@6efcc4a4’ FAILED - service.isRegistered(this) is FALSE
2018-12-15 13:39:34.209 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - WeMo UPnP device Socket-1_0-44455697D1A50A not yet registered
2018-12-15 13:39:34.210 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Setting up WeMo GENA subscription for ‘org.eclipse.smarthome.binding.wemo.handler.WemoHandler@6efcc4a4’ FAILED - service.isRegistered(this) is FALSE
2018-12-15 13:39:34.211 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - Trying to create a handler for ThingType 'wemo:socket
2018-12-15 13:39:34.212 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - Creating a WemoHandler for thing ‘wemo:socket:Socket-1_0-44455697D1A502’ with UDN ‘Socket-1_0-44455697D1A502’
2018-12-15 13:39:34.214 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Creating a WemoHandler for thing ‘wemo:socket:Socket-1_0-44455697D1A502’
2018-12-15 13:39:34.219 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Initializing WemoHandler for UDN ‘Socket-1_0-44455697D1A502’
2018-12-15 13:39:34.220 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Setting up WeMo GENA subscription for ‘org.eclipse.smarthome.binding.wemo.handler.WemoHandler@579e1424’ FAILED - service.isRegistered(this) is FALSE
2018-12-15 13:39:34.220 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - WeMo UPnP device Socket-1_0-44455697D1A502 not yet registered
2018-12-15 13:39:34.221 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Setting up WeMo GENA subscription for ‘org.eclipse.smarthome.binding.wemo.handler.WemoHandler@579e1424’ FAILED - service.isRegistered(this) is FALSE
2018-12-15 13:39:34.223 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - Trying to create a handler for ThingType 'wemo:socket
2018-12-15 13:39:34.225 [DEBUG] [ing.wemo.internal.WemoHandlerFactory] - Creating a WemoHandler for thing ‘wemo:socket:Socket-1_0-44455697D1A501’ with UDN ‘Socket-1_0-44455697D1A501’
2018-12-15 13:39:34.226 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Creating a WemoHandler for thing ‘wemo:socket:Socket-1_0-44455697D1A501’
2018-12-15 13:39:34.230 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Initializing WemoHandler for UDN ‘Socket-1_0-44455697D1A501’
2018-12-15 13:39:34.230 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Setting up WeMo GENA subscription for ‘org.eclipse.smarthome.binding.wemo.handler.WemoHandler@26c0d07’ FAILED - service.isRegistered(this) is FALSE
2018-12-15 13:39:34.231 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - WeMo UPnP device Socket-1_0-44455697D1A501 not yet registered
2018-12-15 13:39:34.232 [DEBUG] [ome.binding.wemo.handler.WemoHandler] - Setting up WeMo GENA subscription for ‘org.eclipse.smarthome.binding.wemo.handler.WemoHandler@26c0d07’ FAILED - service.isRegistered(this) is FALSE
2018-12-15 13:39:34.236 [DEBUG] [org.eclipse.smarthome.binding.wemo ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.thing.binding.ThingHandlerFactory}={service.id=435, service.bundleid=241, service.scope=bundle, component.name=org.eclipse.smarthome.binding.wemo.internal.WemoHandlerFactory, component.id=295} - org.eclipse.smarthome.binding.wemo
2018-12-15 13:39:34.242 [DEBUG] [ernal.discovery.WemoDiscoveryService] - Starting WeMo UPnP discovery…
2018-12-15 13:39:34.243 [DEBUG] [ernal.discovery.WemoDiscoveryService] - Starting UPnP RootDevice search…
2018-12-15 13:39:34.246 [ERROR] [.jupnp.transport.impl.DatagramIOImpl] - Exception sending datagram to: /239.255.255.250: java.io.IOException: Invalid argument (sendto failed)
java.io.IOException: Invalid argument (sendto failed)
at java.net.PlainDatagramSocketImpl.send(Native Method) ~[?:?]
at java.net.DatagramSocket.send(DatagramSocket.java:693) [?:?]
at org.jupnp.transport.impl.DatagramIOImpl.send(DatagramIOImpl.java:156) [173:org.jupnp:2.3.0]
at org.jupnp.transport.impl.DatagramIOImpl.send(DatagramIOImpl.java:149) [173:org.jupnp:2.3.0]
at org.jupnp.transport.RouterImpl.send(RouterImpl.java:300) [173:org.jupnp:2.3.0]
at org.jupnp.protocol.async.SendingSearch.execute(SendingSearch.java:90) [173:org.jupnp:2.3.0]
at org.jupnp.protocol.SendingAsync.run(SendingAsync.java:52) [173:org.jupnp:2.3.0]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:?]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:?]
at java.lang.Thread.run(Thread.java:748) [?:?]
2018-12-15 13:39:34.250 [ERROR] [.jupnp.transport.impl.DatagramIOImpl] - Details: datagram.socketAddress=/239.255.255.250:1900, length=101, offfset=0, data.bytes=101
2018-12-15 13:39:34.250 [DEBUG] [org.eclipse.smarthome.binding.wemo ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.discovery.DiscoveryService}={service.id=436, service.bundleid=241, service.scope=bundle, component.name=org.eclipse.smarthome.binding.wemo.internal.discovery.WemoDiscoveryService, component.id=296} - org.eclipse.smarthome.binding.wemo
2018-12-15 13:39:34.251 [ERROR] [.jupnp.transport.impl.DatagramIOImpl] - Details: socket=false, closed=true, bound=null, inetAddress=null, remoteSocketAddress=name:0.0.0.0, networkInterface=java.net.MulticastSocket@44ffc048
2018-12-15 13:39:34.258 [DEBUG] [org.eclipse.smarthome.binding.wemo ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.discovery.upnp.UpnpDiscoveryParticipant}={service.id=437, service.bundleid=241, service.scope=bundle, component.name=org.eclipse.smarthome.binding.wemo.internal.discovery.WemoDiscoveryParticipant, component.id=297} - org.eclipse.smarthome.binding.wemo
2018-12-15 13:39:34.279 [ERROR] [core.karaf.internal.FeatureInstaller] - Failed installing ‘openhab-binding-wemo’: Error restarting bundles:
Could not resolve module: org.openhab.binding.amazonechocontrol [200]
Another singleton bundle selected: osgi.identity; type=“osgi.bundle”; version:Version=“2.4.0.201811161948”; osgi.identity=“org.openhab.binding.amazonechocontrol”; singleton:=“true”