Hello Volker,
after a long time I restarted with a new openhab installation.
Now I red that the binding is in the official release, but I can not find it in the paperUI at bindings.
How to install the binding?
Do I still need to download a jar file?
If so, do you have a link?
The last lines show that the sensors come online. They only do that when they get a reading. If you enable TRACE, you will most likely see that something is read from the lgw.
I have now updated the binding once again to support LGWs (and added more logging). Can you please test if this works better? If not, please enable TRACE level and post the relevant part of the log.
Edit: just to make that clear, discovery still needs a high polling rate set by an init command, but you should now be able to control the socket with the LGW. I have also fixed a bug in the TCP connection code.
Hi Volker,
these logs were with enabled TRACE.
TRACE shows the raw readings, but as you see, there was the problem, no readings.
I try your new version and report back.
Thanks!
P.S. I use the 2.2.0 SNAPSHOT under 2.1, is it ok?
The part you just posted only contains an ongoing connection. Is 192.168.179.4:82 your LGW?
There is no entry at all about the connection being lost. Have you updated to the newest version? I have used ser2net to make the serial port of my Jeelink clone available on my pc. After defining the Jeelink TCP to the PC, the following happens when I kill ser2net and restart it:
2017-12-01 14:51:12.504 [ERROR] [rnal.connection.JeeLinkTcpConnection] - IO exception
java.io.IOException: Got EOF on port 192.168.178.33:6666
at org.openhab.binding.jeelink.internal.connection.JeeLinkTcpConnection$Reader.run(JeeLinkTcpConnection.java:122) [228:org.openhab.binding.jeelink:2.2.0.201712010856]
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:?]
at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:?]
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180) [?:?]
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293) [?:?]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [?:?]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [?:?]
at java.lang.Thread.run(Thread.java:745) [?:?]
2017-12-01 14:51:12.516 [DEBUG] [rnal.connection.JeeLinkTcpConnection] - Closing TCP connection to port 192.168.178.33:6666ā¦
2017-12-01 14:51:12.519 [DEBUG] [rnal.connection.JeeLinkTcpConnection] - Shutting down reader for TCP port 192.168.178.33:6666ā¦
2017-12-01 14:51:12.545 [DEBUG] [ding.jeelink.internal.JeeLinkHandler] - Connection to port 192.168.178.33:6666 aborted (Got EOF on port 192.168.178.33:6666). Reconnect scheduled.
2017-12-01 14:51:12.550 [DEBUG] [rnal.connection.JeeLinkTcpConnection] - Reader for TCP port 192.168.178.33:6666 finishedā¦
2017-12-01 14:51:22.546 [DEBUG] [rnal.connection.JeeLinkTcpConnection] - Opening TCP connection to host 192.168.178.33 port 6666ā¦
2017-12-01 14:51:22.549 [DEBUG] [rnal.connection.JeeLinkTcpConnection] - Creating TCP socket to 192.168.178.33:6666ā¦
2017-12-01 14:51:22.554 [ERROR] [rnal.connection.JeeLinkTcpConnection] - Uncaught exception
java.net.ConnectException: Connection refused (Connection refused)
at java.net.PlainSocketImpl.socketConnect(Native Method) ~[?:?]
at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:350) ~[?:?]
at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206) ~[?:?]
at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188) ~[?:?]
at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392) ~[?:?]
at java.net.Socket.connect(Socket.java:589) ~[?:?]
at java.net.Socket.connect(Socket.java:538) ~[?:?]
at java.net.Socket.(Socket.java:434) ~[?:?]
at java.net.Socket.(Socket.java:211) ~[?:?]
at org.openhab.binding.jeelink.internal.connection.JeeLinkTcpConnection.openConnection(JeeLinkTcpConnection.java:71) ~[?:?]
at org.openhab.binding.jeelink.internal.JeeLinkHandler.lambda$0(JeeLinkHandler.java:93) ~[?:?]
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:?]
at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:?]
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180) [?:?]
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293) [?:?]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [?:?]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [?:?]
at java.lang.Thread.run(Thread.java:745) [?:?]
2017-12-01 14:51:22.581 [DEBUG] [ding.jeelink.internal.JeeLinkHandler] - Connection to port 192.168.178.33:6666 aborted (Connection refused (Connection refused)). Reconnect scheduled.
2017-12-01 14:51:32.581 [DEBUG] [rnal.connection.JeeLinkTcpConnection] - Opening TCP connection to host 192.168.178.33 port 6666ā¦
2017-12-01 14:51:32.584 [DEBUG] [rnal.connection.JeeLinkTcpConnection] - Creating TCP socket to 192.168.178.33:6666ā¦
2017-12-01 14:51:32.588 [DEBUG] [rnal.connection.JeeLinkTcpConnection] - TCP socket created.
2017-12-01 14:51:32.591 [DEBUG] [ding.jeelink.internal.JeeLinkHandler] - Connection to port 192.168.178.33:6666 opened.
2017-12-01 14:51:32.592 [DEBUG] [rnal.connection.JeeLinkTcpConnection] - Reader for TCP port 192.168.178.33:6666 startingā¦
2017-12-01 14:51:32.607 [DEBUG] [ding.jeelink.internal.JeeLinkHandler] - Connection to port 192.168.178.33:6666 established. Reconnect cancelled.
2017-12-01 14:51:32.614 [DEBUG] [.internal.pca301.Pca301SensorHandler] - updating states for thing PCA301 power monitoring wireless socket (1-160-236): state=true, current=0.0, total=170
You can see that the connection has been dropped and re-established. This should be exactly what happens when you reboot the LGW.
Forget this post.
After some minutes the binding show up.
Thank you for the reply.
I downloaded the jar file and added it into /usr/share/openhab2/addons
After that I installed the feature openhab-transport-serial via Karaf Console
Then I restarted the openhab service
Unfortunately I still can not find the binding in the binding list of the Paper UI.
Hi Volker, thanks a lot for implementing the PCA301 socket support. I tested the the new binding from your link. The discovery of the new things (PCA301) was working like a charm.
Inside the thing-configuration of a PCA301 socket I was not able to configure/see details like values or turning off/on to bind them to items (I was using Paper-UI).
Log-Output (Discovery):
2017-12-01 22:16:47.983 [InboxAddedEvent ] - Discovery Result with UID ājeelink:pca301:1-160-236ā has been added.
2017-12-01 22:16:48.063 [InboxAddedEvent ] - Discovery Result with UID ājeelink:pca301:3-205-137ā has been added.
2017-12-01 22:16:48.087 [InboxAddedEvent ] - Discovery Result with UID ājeelink:pca301:3-204-80ā has been added.
2017-12-01 22:16:48.110 [InboxAddedEvent ] - Discovery Result with UID ājeelink:pca301:3-205-30ā has been added.
2017-12-01 22:16:48.133 [InboxAddedEvent ] - Discovery Result with UID ājeelink:pca301:1-163-61ā has been added.
2017-12-01 22:16:48.158 [InboxAddedEvent ] - Discovery Result with UID ājeelink:pca301:3-132-127ā has been added.
2017-12-01 22:16:48.181 [InboxAddedEvent ] - Discovery Result with UID ājeelink:pca301:3-241-53ā has been added.
2017-12-01 22:16:48.205 [InboxAddedEvent ] - Discovery Result with UID ājeelink:pca301:3-137-41ā has been added.
2017-12-01 22:16:48.233 [InboxAddedEvent ] - Discovery Result with UID ājeelink:pca301:3-183-74ā has been added.
2017-12-01 22:16:48.256 [InboxAddedEvent ] - Discovery Result with UID ājeelink:pca301:3-181-249ā has been added.
2017-12-01 22:16:48.280 [InboxAddedEvent ] - Discovery Result with UID ājeelink:pca301:187-199-255ā has been added.
2017-12-01 22:16:48.302 [InboxAddedEvent ] - Discovery Result with UID ājeelink:pca301:3-240-203ā has been added.
2017-12-01 22:16:48.334 [InboxAddedEvent ] - Discovery Result with UID ājeelink:pca301:1-160-172ā has been added.
2017-12-01 22:17:00.480 [InboxAddedEvent ] - Discovery Result with UID ājeelink:pca301:2-241-96ā has been added.
2017-12-01 22:17:00.505 [InboxAddedEvent ] - Discovery Result with UID ājeelink:pca301:3-241-49ā has been added.
2017-12-01 22:17:00.529 [InboxAddedEvent ] - Discovery Result with UID ājeelink:pca301:48-64-124ā has been added.
2017-12-01 22:17:00.552 [InboxAddedEvent ] - Discovery Result with UID ājeelink:pca301:195-243-181ā has been added.
2017-12-01 22:17:00.576 [InboxAddedEvent ] - Discovery Result with UID ājeelink:pca301:5-132-63ā has been added.
2017-12-01 22:17:00.599 [InboxAddedEvent ] - Discovery Result with UID ājeelink:pca301:67-137-41ā has been added.
2017-12-01 22:17:00.624 [InboxAddedEvent ] - Discovery Result with UID ājeelink:pca301:131-132-127ā has been added.
2017-12-01 22:17:00.648 [InboxAddedEvent ] - Discovery Result with UID ājeelink:pca301:4-81-195ā has been added.
2017-12-01 22:17:00.672 [InboxAddedEvent ] - Discovery Result with UID ājeelink:pca301:255-255-255ā has been added.
2017-12-01 22:17:00.694 [InboxAddedEvent ] - Discovery Result with UID ājeelink:pca301:0-0-0ā has been added.
2017-12-01 22:17:39.685 [InboxRemovedEvent ] - Discovery Result with UID ājeelink:pca301:1-160-236ā has been removed.
2017-12-01 22:17:39.686 [ThingAddedEvent ] - Thing ājeelink:pca301:1-160-236ā has been added.
2017-12-01 22:17:39.688 [hingStatusInfoChangedEvent] - ājeelink:pca301:1-160-236ā changed from UNINITIALIZED to INITIALIZING
2017-12-01 22:17:39.689 [hingStatusInfoChangedEvent] - ājeelink:pca301:1-160-236ā changed from INITIALIZING to UNKNOWN
2017-12-01 22:17:43.946 [InboxRemovedEvent ] - Discovery Result with UID ājeelink:pca301:3-205-30ā has been removed.
2017-12-01 22:17:43.947 [ThingAddedEvent ] - Thing ājeelink:pca301:3-205-30ā has been added.
2017-12-01 22:17:43.950 [hingStatusInfoChangedEvent] - ājeelink:pca301:3-205-30ā changed from UNINITIALIZED to INITIALIZING
2017-12-01 22:17:43.951 [hingStatusInfoChangedEvent] - ājeelink:pca301:3-205-30ā changed from INITIALIZING to UNKNOWN
2017-12-01 22:17:46.423 [InboxRemovedEvent ] - Discovery Result with UID ājeelink:pca301:1-160-172ā has been removed.
2017-12-01 22:17:46.426 [ThingAddedEvent ] - Thing ājeelink:pca301:1-160-172ā has been added.
2017-12-01 22:17:46.428 [hingStatusInfoChangedEvent] - ājeelink:pca301:1-160-172ā changed from UNINITIALIZED to INITIALIZING
2017-12-01 22:17:46.429 [hingStatusInfoChangedEvent] - ājeelink:pca301:1-160-172ā changed from INITIALIZING to UNKNOWN
2017-12-01 22:17:54.638 [InboxRemovedEvent ] - Discovery Result with UID ājeelink:pca301:131-132-127ā has been removed.
2017-12-01 22:17:54.639 [ThingAddedEvent ] - Thing ājeelink:pca301:131-132-127ā has been added.
2017-12-01 22:17:54.640 [hingStatusInfoChangedEvent] - ājeelink:pca301:131-132-127ā changed from UNINITIALIZED to INITIALIZING
2017-12-01 22:17:54.640 [hingStatusInfoChangedEvent] - ājeelink:pca301:131-132-127ā changed from INITIALIZING to UNKNOWN
2017-12-01 22:17:58.288 [InboxRemovedEvent ] - Discovery Result with UID ājeelink:pca301:2-241-96ā has been removed.
2017-12-01 22:17:58.289 [ThingAddedEvent ] - Thing ājeelink:pca301:2-241-96ā has been added.
2017-12-01 22:17:58.292 [hingStatusInfoChangedEvent] - ājeelink:pca301:2-241-96ā changed from UNINITIALIZED to INITIALIZING
2017-12-01 22:17:58.294 [hingStatusInfoChangedEvent] - ājeelink:pca301:2-241-96ā changed from INITIALIZING to UNKNOWN
2017-12-01 22:18:02.627 [InboxRemovedEvent ] - Discovery Result with UID ājeelink:pca301:3-240-203ā has been removed.
2017-12-01 22:18:02.629 [ThingAddedEvent ] - Thing ājeelink:pca301:3-240-203ā has been added.
2017-12-01 22:18:02.632 [hingStatusInfoChangedEvent] - ājeelink:pca301:3-240-203ā changed from UNINITIALIZED to INITIALIZING
2017-12-01 22:18:02.632 [hingStatusInfoChangedEvent] - ājeelink:pca301:3-240-203ā changed from INITIALIZING to UNKNOWN
2017-12-01 22:18:02.963 [hingStatusInfoChangedEvent] - ājeelink:pca301:3-205-30ā changed from UNKNOWN to ONLINE
2017-12-01 22:18:08.668 [InboxRemovedEvent ] - Discovery Result with UID ājeelink:pca301:255-255-255ā has been removed.
2017-12-01 22:18:08.669 [ThingAddedEvent ] - Thing ājeelink:pca301:255-255-255ā has been added.
2017-12-01 22:18:08.671 [hingStatusInfoChangedEvent] - ājeelink:pca301:255-255-255ā changed from UNINITIALIZED to INITIALIZING
2017-12-01 22:18:08.671 [hingStatusInfoChangedEvent] - ājeelink:pca301:255-255-255ā changed from INITIALIZING to UNKNOWN
2017-12-01 22:18:11.425 [InboxRemovedEvent ] - Discovery Result with UID ājeelink:pca301:4-81-195ā has been removed.
2017-12-01 22:18:11.426 [ThingAddedEvent ] - Thing ājeelink:pca301:4-81-195ā has been added.
2017-12-01 22:18:11.427 [hingStatusInfoChangedEvent] - ājeelink:pca301:4-81-195ā changed from INITIALIZING to UNKNOWN
2017-12-01 22:18:11.427 [hingStatusInfoChangedEvent] - ājeelink:pca301:4-81-195ā changed from UNINITIALIZED to INITIALIZING
2017-12-01 22:18:13.769 [InboxRemovedEvent ] - Discovery Result with UID ājeelink:pca301:3-137-41ā has been removed.
2017-12-01 22:18:13.769 [ThingAddedEvent ] - Thing ājeelink:pca301:3-137-41ā has been added.
2017-12-01 22:18:13.772 [hingStatusInfoChangedEvent] - ājeelink:pca301:3-137-41ā changed from INITIALIZING to UNKNOWN
2017-12-01 22:18:13.774 [hingStatusInfoChangedEvent] - ājeelink:pca301:3-137-41ā changed from UNINITIALIZED to INITIALIZING
2017-12-01 22:18:16.910 [InboxRemovedEvent ] - Discovery Result with UID ājeelink:pca301:3-204-80ā has been removed.
2017-12-01 22:18:16.910 [ThingAddedEvent ] - Thing ājeelink:pca301:3-204-80ā has been added.
2017-12-01 22:18:16.911 [hingStatusInfoChangedEvent] - ājeelink:pca301:3-204-80ā changed from UNINITIALIZED to INITIALIZING
2017-12-01 22:18:16.912 [hingStatusInfoChangedEvent] - ājeelink:pca301:3-204-80ā changed from INITIALIZING to UNKNOWN
2017-12-01 22:18:18.946 [InboxRemovedEvent ] - Discovery Result with UID ājeelink:pca301:48-64-124ā has been removed.
2017-12-01 22:18:18.947 [ThingAddedEvent ] - Thing ājeelink:pca301:48-64-124ā has been added.
2017-12-01 22:18:18.950 [hingStatusInfoChangedEvent] - ājeelink:pca301:48-64-124ā changed from UNINITIALIZED to INITIALIZING
2017-12-01 22:18:18.950 [hingStatusInfoChangedEvent] - ājeelink:pca301:48-64-124ā changed from INITIALIZING to UNKNOWN
2017-12-01 22:18:22.649 [InboxRemovedEvent ] - Discovery Result with UID ājeelink:pca301:3-181-249ā has been removed.
2017-12-01 22:18:22.650 [ThingAddedEvent ] - Thing ājeelink:pca301:3-181-249ā has been added.
2017-12-01 22:18:22.651 [hingStatusInfoChangedEvent] - ājeelink:pca301:3-181-249ā changed from UNINITIALIZED to INITIALIZING
2017-12-01 22:18:22.652 [hingStatusInfoChangedEvent] - ājeelink:pca301:3-181-249ā changed from INITIALIZING to UNKNOWN
2017-12-01 22:18:24.924 [InboxRemovedEvent ] - Discovery Result with UID ājeelink:pca301:3-205-137ā has been removed.
2017-12-01 22:18:24.925 [ThingAddedEvent ] - Thing ājeelink:pca301:3-205-137ā has been added.
2017-12-01 22:18:24.926 [hingStatusInfoChangedEvent] - ājeelink:pca301:3-205-137ā changed from UNINITIALIZED to INITIALIZING
2017-12-01 22:18:24.927 [hingStatusInfoChangedEvent] - ājeelink:pca301:3-205-137ā changed from INITIALIZING to UNKNOWN
2017-12-01 22:18:27.520 [InboxRemovedEvent ] - Discovery Result with UID ājeelink:pca301:5-132-63ā has been removed.
2017-12-01 22:18:27.521 [ThingAddedEvent ] - Thing ājeelink:pca301:5-132-63ā has been added.
2017-12-01 22:18:27.522 [hingStatusInfoChangedEvent] - ājeelink:pca301:5-132-63ā changed from UNINITIALIZED to INITIALIZING
2017-12-01 22:18:27.524 [hingStatusInfoChangedEvent] - ājeelink:pca301:5-132-63ā changed from INITIALIZING to UNKNOWN
2017-12-01 22:18:30.043 [InboxRemovedEvent ] - Discovery Result with UID ājeelink:pca301:1-163-61ā has been removed.
2017-12-01 22:18:30.043 [ThingAddedEvent ] - Thing ājeelink:pca301:1-163-61ā has been added.
2017-12-01 22:18:30.045 [hingStatusInfoChangedEvent] - ājeelink:pca301:1-163-61ā changed from UNINITIALIZED to INITIALIZING
2017-12-01 22:18:30.045 [hingStatusInfoChangedEvent] - ājeelink:pca301:1-163-61ā changed from INITIALIZING to UNKNOWN
2017-12-01 22:18:32.645 [InboxRemovedEvent ] - Discovery Result with UID ājeelink:pca301:3-132-127ā has been removed.
2017-12-01 22:18:32.647 [ThingAddedEvent ] - Thing ājeelink:pca301:3-132-127ā has been added.
2017-12-01 22:18:32.647 [hingStatusInfoChangedEvent] - ājeelink:pca301:3-132-127ā changed from INITIALIZING to UNKNOWN
2017-12-01 22:18:32.647 [hingStatusInfoChangedEvent] - ājeelink:pca301:3-132-127ā changed from UNINITIALIZED to INITIALIZING
2017-12-01 22:18:34.544 [hingStatusInfoChangedEvent] - ājeelink:pca301:3-137-41ā changed from UNKNOWN to ONLINE
2017-12-01 22:18:35.041 [InboxRemovedEvent ] - Discovery Result with UID ājeelink:pca301:3-241-53ā has been removed.
2017-12-01 22:18:35.042 [ThingAddedEvent ] - Thing ājeelink:pca301:3-241-53ā has been added.
2017-12-01 22:18:35.046 [hingStatusInfoChangedEvent] - ājeelink:pca301:3-241-53ā changed from INITIALIZING to UNKNOWN
2017-12-01 22:18:35.047 [hingStatusInfoChangedEvent] - ājeelink:pca301:3-241-53ā changed from UNINITIALIZED to INITIALIZING
2017-12-01 22:18:35.856 [hingStatusInfoChangedEvent] - ājeelink:pca301:3-132-127ā changed from UNKNOWN to ONLINE
2017-12-01 22:18:36.960 [hingStatusInfoChangedEvent] - ājeelink:pca301:3-241-53ā changed from UNKNOWN to ONLINE
2017-12-01 22:18:37.783 [InboxRemovedEvent ] - Discovery Result with UID ājeelink:pca301:187-199-255ā has been removed.
2017-12-01 22:18:37.784 [ThingAddedEvent ] - Thing ājeelink:pca301:187-199-255ā has been added.
2017-12-01 22:18:37.785 [hingStatusInfoChangedEvent] - ājeelink:pca301:187-199-255ā changed from UNINITIALIZED to INITIALIZING
2017-12-01 22:18:37.786 [hingStatusInfoChangedEvent] - ājeelink:pca301:187-199-255ā changed from INITIALIZING to UNKNOWN
2017-12-01 22:18:39.454 [hingStatusInfoChangedEvent] - ājeelink:pca301:1-163-61ā changed from UNKNOWN to ONLINE
2017-12-01 22:18:40.004 [InboxRemovedEvent ] - Discovery Result with UID ājeelink:pca301:3-183-74ā has been removed.
2017-12-01 22:18:40.005 [ThingAddedEvent ] - Thing ājeelink:pca301:3-183-74ā has been added.
2017-12-01 22:18:40.007 [hingStatusInfoChangedEvent] - ājeelink:pca301:3-183-74ā changed from UNINITIALIZED to INITIALIZING
2017-12-01 22:18:40.008 [hingStatusInfoChangedEvent] - ājeelink:pca301:3-183-74ā changed from INITIALIZING to UNKNOWN
2017-12-01 22:18:40.558 [hingStatusInfoChangedEvent] - ājeelink:pca301:3-204-80ā changed from UNKNOWN to ONLINE
2017-12-01 22:18:42.759 [InboxRemovedEvent ] - Discovery Result with UID ājeelink:pca301:3-241-49ā has been removed.
2017-12-01 22:18:42.760 [ThingAddedEvent ] - Thing ājeelink:pca301:3-241-49ā has been added.
2017-12-01 22:18:42.765 [hingStatusInfoChangedEvent] - ājeelink:pca301:3-241-49ā changed from UNINITIALIZED to INITIALIZING
2017-12-01 22:18:42.765 [hingStatusInfoChangedEvent] - ājeelink:pca301:3-241-49ā changed from INITIALIZING to UNKNOWN
2017-12-01 22:18:44.917 [InboxRemovedEvent ] - Discovery Result with UID ājeelink:pca301:67-137-41ā has been removed.
2017-12-01 22:18:44.918 [ThingAddedEvent ] - Thing ājeelink:pca301:67-137-41ā has been added.
2017-12-01 22:18:44.919 [hingStatusInfoChangedEvent] - ājeelink:pca301:67-137-41ā changed from UNINITIALIZED to INITIALIZING
2017-12-01 22:18:44.920 [hingStatusInfoChangedEvent] - ājeelink:pca301:67-137-41ā changed from INITIALIZING to UNKNOWN
2017-12-01 22:18:45.260 [hingStatusInfoChangedEvent] - ājeelink:pca301:3-181-249ā changed from UNKNOWN to ONLINE
2017-12-01 22:18:47.289 [InboxRemovedEvent ] - Discovery Result with UID ājeelink:pca301:0-0-0ā has been removed.
2017-12-01 22:18:47.290 [ThingAddedEvent ] - Thing ājeelink:pca301:0-0-0ā has been added.
2017-12-01 22:18:47.296 [hingStatusInfoChangedEvent] - ājeelink:pca301:0-0-0ā changed from UNINITIALIZED to INITIALIZING
2017-12-01 22:18:47.300 [hingStatusInfoChangedEvent] - ājeelink:pca301:0-0-0ā changed from INITIALIZING to UNKNOWN
2017-12-01 22:18:49.962 [InboxRemovedEvent ] - Discovery Result with UID ājeelink:pca301:195-243-181ā has been removed.
2017-12-01 22:18:49.962 [ThingAddedEvent ] - Thing ājeelink:pca301:195-243-181ā has been added.
2017-12-01 22:18:49.965 [hingStatusInfoChangedEvent] - ājeelink:pca301:195-243-181ā changed from UNINITIALIZED to INITIALIZING
2017-12-01 22:18:49.967 [hingStatusInfoChangedEvent] - ājeelink:pca301:195-243-181ā changed from INITIALIZING to UNKNOWN
Yes, newest version.
Looks like the binding doesnt see that the connection is lost.
Here again a log before the reboot.
10:17:52.296 [TRACE] [connection.AbstractJeeLinkConnection] - Read line from port 192.168.179.4:82: OK 22 188 129 1 90 21 248 0 226 188 63 0 1 231 199 0 59 8 190 2 0
10:17:52.306 [DEBUG] [link.internal.ec3k.Ec3kSensorHandler] - updating states for thing BC81: currWatt=5.9 (5.9), maxWatt=223.8, consumption=124, secondsOn=14859327, secondsTotal=22681080
10:17:52.549 [TRACE] [connection.AbstractJeeLinkConnection] - Read line from port 192.168.179.4:82: OK 9 29 1 4 184 70
10:17:52.556 [TRACE] [.LaCrosseTemperatureReadingConverter] - Creating reading from: OK 9 29 1 4 184 70
10:17:52.576 [DEBUG] [sse.LaCrosseTemperatureSensorHandler] - updating states for thing Thermometer Schlafzimmer (29): temp=20.8 (20.8), humidity=70, batteryNew=false, batteryLow=false
10:17:52.623 [TRACE] [connection.AbstractJeeLinkConnection] - Read line from port 192.168.179.4:82: OK 22 89 30 1 149 200 238 1 149 199 143 0 11 56 74 11 111 43 32 1 0
10:17:52.651 [DEBUG] [link.internal.ec3k.Ec3kSensorHandler] - updating states for thing 591E: currWatt=292.7 (292.7), maxWatt=1104.0, consumption=735, secondsOn=26593167, secondsTotal=26593518
10:17:52.955 [TRACE] [connection.AbstractJeeLinkConnection] - Read line from port 192.168.179.4:82: OK 22 88 40 1 123 99 254 1 123 66 213 0 8 91 195 0 51 11 45 1 0
10:17:52.959 [DEBUG] [link.internal.ec3k.Ec3kSensorHandler] - updating states for thing 5828: currWatt=5.1 (5.1), maxWatt=286.1, consumption=547, secondsOn=24855253, secondsTotal=24863742
10:17:53.857 [TRACE] [connection.AbstractJeeLinkConnection] - Read line from port 192.168.179.4:82: OK 9 46 1 4 190 59
10:17:53.859 [TRACE] [.LaCrosseTemperatureReadingConverter] - Creating reading from: OK 9 46 1 4 190 59
10:17:53.864 [DEBUG] [sse.LaCrosseTemperatureSensorHandler] - updating states for thing Thermometer Bad (46): temp=21.4 (21.4), humidity=59, batteryNew=false, batteryLow=false
Maybe the LGW reboots too fast?
I try to set a bootup delay.
Edit:
The Startup-delay (s) parameter doesnt seem to interrupt the network, ping is only lost 1 sec.
Maybe the connection is coming up again too fast so the binding doesnt realize it.
It should not make a difference how fast the LGW reboots. The connection will be dropped regardless. What does your log above show? From what I can see, there is a steady connection.
Once again, is 192.168.179.4:82 your LGW? If yes, then this looks like you either did not reboot, or pasted the wrong part of the log.
I have not yet used paper ui to create items. I only start the discovery for creating the things and then add my items definition in an items file. These are the items definitions I have for the PCA sensor:
Switch SocketSwitch {channel=ājeelink:pca301:1-160-236:switchingStateā}
Number SocketWattage {channel=ājeelink:pca301:1-160-236:currentWattā}
Number SocketConsumption {channel=ājeelink:pca301:1-160-236:consumptionTotalā}
If you use paper ui you have to provide more details on what exactly you did and what went wrong.
192.168.179.4 is the LGW with the ports 81,82,83 open.
I tried all three.
Iām pretty sure that the LGW reboots because the ping is lost 1 time and the UpTimeSeconds is set to 0.
So the log above ends at the point you press reboot? What does pushing reboot mean? Does the LGW have a dedicated button for rebooting or is this a function of the web interface?
Yes, it stops after i press reboot on the web interface of the LGW.
Did a power cutoff but still nothing in the logsā¦
Maybe because i use openhab 2.1 or so?
Edit:
Did a bundle:stop and bundle:start and getting this
10:48:43.072 [DEBUG] [org.openhab.binding.jeelink ] - BundleEvent STARTING - org.openhab.binding.jeelink
10:48:43.128 [DEBUG] [org.openhab.binding.jeelink ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.thing.binding.ThingHandlerFactory}={component.name=binding.jeelink, component.id=202, service.id=337, service.bundleid=245, service.scope=bundle} - org.openhab.binding.jeelink
10:48:43.242 [DEBUG] [org.openhab.binding.jeelink ] - BundleEvent STARTED - org.openhab.binding.jeelink
10:48:43.412 [DEBUG] [elink.internal.JeeLinkHandlerFactory] - creating JeeLinkHandler for thing lgw...
10:48:43.415 [DEBUG] [elink.internal.JeeLinkHandlerFactory] - registering sensor discovery service...
10:48:43.432 [DEBUG] [org.openhab.binding.jeelink ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.discovery.DiscoveryService}={service.id=338, service.bundleid=245, service.scope=singleton} - org.openhab.binding.jeelink
10:48:43.476 [DEBUG] [rnal.connection.JeeLinkTcpConnection] - Opening TCP connection to host 192.168.179.4 port 82...
10:48:43.480 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'jeelink:jeelinkTcp:lgw' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
10:48:43.483 [DEBUG] [rnal.connection.JeeLinkTcpConnection] - Creating TCP socket to 192.168.179.4:82...
10:48:43.489 [DEBUG] [rnal.connection.JeeLinkTcpConnection] - TCP socket created.
10:48:43.498 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'jeelink:jeelinkTcp:lgw' changed from INITIALIZING to ONLINE
10:48:43.557 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'jeelink:lacrosse:46' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
10:48:43.565 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'jeelink:lacrosse:46' changed from INITIALIZING to UNKNOWN
10:48:43.593 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'jeelink:lacrosse:13' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
10:48:43.601 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'jeelink:lacrosse:13' changed from INITIALIZING to UNKNOWN
10:48:43.648 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'jeelink:lacrosse:16' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
10:48:43.671 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'jeelink:lacrosse:16' changed from INITIALIZING to UNKNOWN
10:48:43.689 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'jeelink:lacrosse:29' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
10:48:43.713 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'jeelink:lacrosse:29' changed from INITIALIZING to UNKNOWN
10:48:43.753 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'jeelink:ec3k:5828' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
10:48:43.760 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'jeelink:ec3k:5828' changed from INITIALIZING to UNKNOWN
10:48:43.798 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'jeelink:ec3k:591E' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
10:48:43.808 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'jeelink:ec3k:591E' changed from INITIALIZING to UNKNOWN
10:48:43.835 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'jeelink:ec3k:BC81' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
10:48:43.841 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'jeelink:ec3k:BC81' changed from INITIALIZING to UNKNOWN
10:48:43.861 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'jeelink:ec3k:B0A7' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
10:48:43.873 [INFO ] [me.event.ThingStatusInfoChangedEvent] - 'jeelink:ec3k:B0A7' changed from INITIALIZING to UNKNOWN
10:48:44.041 [DEBUG] [rnal.connection.JeeLinkTcpConnection] - Closing TCP connection to port 192.168.179.4:82...
10:48:44.044 [DEBUG] [rnal.connection.JeeLinkTcpConnection] - Shutting down reader for TCP port 192.168.179.4:82...
10:48:44.053 [DEBUG] [rnal.connection.JeeLinkTcpConnection] - Opening TCP connection to host 192.168.179.4 port 82...
10:48:44.055 [DEBUG] [rnal.connection.JeeLinkTcpConnection] - Creating TCP socket to 192.168.179.4:82...
10:48:44.061 [DEBUG] [rnal.connection.JeeLinkTcpConnection] - TCP socket created.
10:48:44.073 [INFO ] [smarthome.event.ThingUpdatedEvent ] - Thing 'jeelink:jeelinkTcp:lgw' has been updated.
10:48:44.091 [INFO ] [smarthome.event.ThingUpdatedEvent ] - Thing 'jeelink:lacrosse:46' has been updated.
10:48:44.118 [INFO ] [smarthome.event.ThingUpdatedEvent ] - Thing 'jeelink:lacrosse:13' has been updated.
10:48:44.135 [INFO ] [smarthome.event.ThingUpdatedEvent ] - Thing 'jeelink:lacrosse:16' has been updated.
10:48:44.153 [INFO ] [smarthome.event.ThingUpdatedEvent ] - Thing 'jeelink:lacrosse:29' has been updated.
10:48:44.170 [INFO ] [smarthome.event.ThingUpdatedEvent ] - Thing 'jeelink:ec3k:5828' has been updated.
10:48:44.189 [INFO ] [smarthome.event.ThingUpdatedEvent ] - Thing 'jeelink:ec3k:591E' has been updated.
10:48:44.208 [INFO ] [smarthome.event.ThingUpdatedEvent ] - Thing 'jeelink:ec3k:BC81' has been updated.
10:48:44.226 [INFO ] [smarthome.event.ThingUpdatedEvent ] - Thing 'jeelink:ec3k:B0A7' has been updated.
after that, nothing more
When i restart the whole openhab, than it works again.
The reader is stopped after the bundle has been started, without any indication why. Is it possible that you have two different versions running at the same time? Did you also get messages when the bundle was stopped, or is what you pasted everything you got?
Does the LGW status in the paper ui show an additional error message?
Nope only
245 | Active | 80 | 2.2.0.201712011340 | JeeLink Binding
This is the complete log from bundle:stop and bundle:start, nothing more.
Paper UI says online to everything.
