Tradfri binding kills my Tradfri Gateway

Thedannymullen · June 8, 2018, 2:53pm

@sonni Are you still having the issue only when gateway and openhab connected?

Here is what I would do. Best option reinstall openhab and setup the server to a point it is just running and let it sit on your network. DO NOT INSTALL TRADFRI BINDING . In fact make sure the gateway is not referenced in your *.things file if you have one. Let openhab sit on your network for several days and make sure that you have not issues.

Second Best option Delete Tradfri binding and remove gateway from your *.things file. Reboot openhab server and let sit on your network for several days.

Also, in the process check the ip address of the openhab server using the command “ifconfig” look for the active adapter on your network. You can find by looking for your network ip prefix 192.168.xxx.

Ping the gateway using the hostname “ping gwhostname” this will tell you the ip address of the gateway. Make sure it is what you have set in your router.

Once you have done this work, lets see where you stand and go from there.

Sonni · June 8, 2018, 5:10pm

@Thedannymullen thanks for your input.
Stange thing are that my setup has been running just fine since december 2017. So you know when or hos i can see when/if the trådfri gateway updated its firmware doing the last week or so.

The ikea lights are some of my primary light in my house, so I simply disabling them is not the best option.

The ikea app however seams to work fairly well, with the exception that it sometimes appear to be reconnection to the gateway.

If there are something which openhab does in its communication, what might this bee?

I could try to setup iptables (running openhabian) only to allow the tradfri gw port traffic.

Is there a way to configure additional debug logging on the tradfri binding. Perhaps it would give me some hints?

Sonni · June 18, 2018, 7:21pm

Given that my ikea gateway also appeared unstable with the ikea app on android, I went to ikea and got a replacement.

This new gateway came with firmware 1.2.42 which it upgraded to 1.3.14. It was discovered by openhab and I added it as a thing. At this point I did not pair it with any devices. Just wanted to see if it stayed online in openhab, sadly it did not after some time it went offline with communication error. Tried that a couple of times and event added a few devices to see if that made any difference, but none.

I then blocked internet access for the gateway and did a factory reset. I came up with the original 1.2.42 firmware. I can the same test, with the same result - after some time the connection is lost and not re-established.

In this process I removed the trådfri binding from openhab and rebooted openhabian in the pi. Installed the trådfri binding again.

I enabled debug logging and captured the log … see next…

The TradfriOnlineStatus item is just a switch item, which is updated by a rule when the gateway thing is updated.

At 20:02 I update the gateway thing with the security code and at 20:12 gateway communication fails.

Can anyone see what is happening from this log?

I find it strange that there are no more debug logs when the gateway thing goes offline. Am I missing something here ?

Sonni · June 18, 2018, 7:24pm

openhab.log
2018-06-18 20:02:19.245 [DEBUG] [e.californium.scandium.DTLSConnector] - Re-transmitting flight for [/172.21.2.25:5684], [3] retransmissions left
2018-06-18 20:02:19.260 [DEBUG] [e.californium.scandium.DTLSConnector] - Received Handshake (22) record from peer [/172.21.2.25:5684]
2018-06-18 20:02:19.263 [DEBUG] [e.californium.scandium.DTLSConnector] - Received Handshake (22) record from peer [/172.21.2.25:5684]
2018-06-18 20:02:20.222 [INFO ] [e.californium.scandium.DTLSConnector] - Stopping DTLS connector on [0.0.0.0/0.0.0.0:48216]
2018-06-18 20:02:20.226 [INFO ] [e.californium.scandium.DTLSConnector] - Worker thread [DTLS-Sender-0.0.0.0/0.0.0.0:48216] has terminated
2018-06-18 20:02:20.226 [INFO ] [e.californium.scandium.DTLSConnector] - Worker thread [DTLS-Receiver-0.0.0.0/0.0.0.0:48216] has terminated
2018-06-18 20:02:20.276 [INFO ] [pse.californium.core.network.Matcher] - Matcher uses USE_RANDOM_MID_START=true and TOKEN_SIZE_LIMIT=8
2018-06-18 20:02:20.294 [INFO ] [alifornium.core.network.CoapEndpoint] - Endpoint org.eclipse.californium.core.network.CoapEndpoint@13922c3 requires an executor to start. Using default single-threaded daemon executor.
2018-06-18 20:02:20.312 [INFO ] [e.californium.scandium.DTLSConnector] - Cannot determine MTU of network interface, using minimum MTU [1280] of IPv6 instead
2018-06-18 20:02:20.321 [INFO ] [e.californium.scandium.DTLSConnector] - Starting worker thread [DTLS-Receiver-0.0.0.0/0.0.0.0:59182]
2018-06-18 20:02:20.325 [INFO ] [e.californium.scandium.DTLSConnector] - DTLS connector listening on [0.0.0.0/0.0.0.0:59182] with MTU [1,280] using (inbound) datagram buffer size [16,474 bytes]
2018-06-18 20:02:20.344 [INFO ] [e.californium.scandium.DTLSConnector] - Starting worker thread [DTLS-Sender-0.0.0.0/0.0.0.0:59182]
2018-06-18 20:02:20.348 [INFO ] [.eclipse.californium.core.CoapClient] - Started set client endpoint 0.0.0.0/0.0.0.0:59182
2018-06-18 20:02:20.351 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[25877 for null:0], KeyToken[3b1fc8fd8aa6fc1b]
2018-06-18 20:02:20.356 [DEBUG] [californium.scandium.dtls.Connection] - Handshake with [/172.21.2.25:5684] has been started
2018-06-18 20:02:20.359 [DEBUG] [e.californium.scandium.DTLSConnector] - Received Handshake (22) record from peer [/172.21.2.25:5684]
2018-06-18 20:02:20.373 [DEBUG] [rnium.scandium.dtls.ClientHandshaker] - Processing Handshake (22) message from peer [/172.21.2.25:5684]
2018-06-18 20:02:20.377 [DEBUG] [rnium.scandium.dtls.ClientHandshaker] - Processed HELLO_VERIFY_REQUEST (3) message with sequence no [0] from peer [/172.21.2.25:5684]
2018-06-18 20:02:20.388 [DEBUG] [e.californium.scandium.DTLSConnector] - Received Handshake (22) record from peer [/172.21.2.25:5684]
2018-06-18 20:02:20.391 [DEBUG] [rnium.scandium.dtls.ClientHandshaker] - Processing Handshake (22) message from peer [/172.21.2.25:5684]
2018-06-18 20:02:20.394 [DEBUG] [rnium.scandium.dtls.ClientHandshaker] - Processed SERVER_HELLO (2) message with sequence no [1] from peer [/172.21.2.25:5684]
2018-06-18 20:02:20.402 [DEBUG] [e.californium.scandium.DTLSConnector] - Received Handshake (22) record from peer [/172.21.2.25:5684]
2018-06-18 20:02:20.407 [DEBUG] [rnium.scandium.dtls.ClientHandshaker] - Processing Handshake (22) message from peer [/172.21.2.25:5684]
2018-06-18 20:02:20.427 [DEBUG] [rnium.scandium.dtls.ClientHandshaker] - Processed SERVER_HELLO_DONE (14) message with sequence no [2] from peer [/172.21.2.25:5684]
2018-06-18 20:02:20.451 [DEBUG] [rnium.scandium.dtls.ClientHandshaker] - Processing Change Cipher Spec (20) message from peer [/172.21.2.25:5684]
2018-06-18 20:02:20.454 [DEBUG] [rnium.scandium.dtls.ClientHandshaker] - Processed Change Cipher Spec (20) message from peer [/172.21.2.25:5684]
2018-06-18 20:02:20.457 [DEBUG] [e.californium.scandium.DTLSConnector] - Received Handshake (22) record from peer [/172.21.2.25:5684]
2018-06-18 20:02:20.461 [DEBUG] [rnium.scandium.dtls.ClientHandshaker] - Processing Handshake (22) message from peer [/172.21.2.25:5684]
2018-06-18 20:02:20.475 [DEBUG] [californium.scandium.dtls.Connection] - Session with [/172.21.2.25:5684] has been established
2018-06-18 20:02:20.478 [DEBUG] [californium.scandium.dtls.Connection] - Handshake with [/172.21.2.25:5684] has been completed
2018-06-18 20:02:20.503 [DEBUG] [rnium.scandium.dtls.ClientHandshaker] - Processed FINISHED (20) message with sequence no [3] from peer [/172.21.2.25:5684]
2018-06-18 20:02:20.557 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[25877 for null:0]
2018-06-18 20:02:20.562 [INFO ] [e.californium.scandium.DTLSConnector] - Stopping DTLS connector on [0.0.0.0/0.0.0.0:59182]
2018-06-18 20:02:20.578 [INFO ] [e.californium.scandium.DTLSConnector] - Worker thread [DTLS-Receiver-0.0.0.0/0.0.0.0:59182] has terminated
2018-06-18 20:02:20.584 [INFO ] [e.californium.scandium.DTLSConnector] - Worker thread [DTLS-Sender-0.0.0.0/0.0.0.0:59182] has terminated
2018-06-18 20:02:20.692 [INFO ] [pse.californium.core.network.Matcher] - Matcher uses USE_RANDOM_MID_START=true and TOKEN_SIZE_LIMIT=8
2018-06-18 20:02:20.715 [INFO ] [e.californium.scandium.DTLSConnector] - Cannot determine MTU of network interface, using minimum MTU [1280] of IPv6 instead
2018-06-18 20:02:20.718 [INFO ] [e.californium.scandium.DTLSConnector] - DTLS connector listening on [0.0.0.0/0.0.0.0:36542] with MTU [1,280] using (inbound) datagram buffer size [16,474 bytes]
2018-06-18 20:02:20.720 [INFO ] [.eclipse.californium.core.CoapClient] - Started set client endpoint 0.0.0.0/0.0.0.0:36542
2018-06-18 20:02:20.751 [INFO ] [e.californium.scandium.DTLSConnector] - Starting worker thread [DTLS-Receiver-0.0.0.0/0.0.0.0:36542]
2018-06-18 20:02:20.765 [INFO ] [e.californium.scandium.DTLSConnector] - Starting worker thread [DTLS-Sender-0.0.0.0/0.0.0.0:36542]
2018-06-18 20:02:20.812 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62817 for null:0], KeyToken[2f2133122505]
2018-06-18 20:02:20.815 [DEBUG] [californium.scandium.dtls.Connection] - Handshake with [/172.21.2.25:5684] has been started
2018-06-18 20:02:20.815 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62818 for null:0], KeyToken[daf6877c6326]
2018-06-18 20:02:20.818 [DEBUG] [e.californium.scandium.DTLSConnector] - Received Handshake (22) record from peer [/172.21.2.25:5684]
2018-06-18 20:02:20.823 [DEBUG] [californium.scandium.dtls.Connection] - Handshake with [/172.21.2.25:5684] has been started
2018-06-18 20:02:20.833 [DEBUG] [rnium.scandium.dtls.ClientHandshaker] - Processing Handshake (22) message from peer [/172.21.2.25:5684]
2018-06-18 20:02:20.843 [DEBUG] [rnium.scandium.dtls.ClientHandshaker] - Processed HELLO_VERIFY_REQUEST (3) message with sequence no [0] from peer [/172.21.2.25:5684]
2018-06-18 20:02:20.849 [DEBUG] [e.californium.scandium.DTLSConnector] - Received Handshake (22) record from peer [/172.21.2.25:5684]
2018-06-18 20:02:21.849 [DEBUG] [e.californium.scandium.DTLSConnector] - Re-transmitting flight for [/172.21.2.25:5684], [3] retransmissions left
2018-06-18 20:02:22.850 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62818 for null:0], KeyToken[daf6877c6326]
2018-06-18 20:02:22.852 [DEBUG] [californium.scandium.dtls.Connection] - Handshake with [/172.21.2.25:5684] has been started
2018-06-18 20:02:22.856 [DEBUG] [e.californium.scandium.DTLSConnector] - Received Handshake (22) record from peer [/172.21.2.25:5684]
2018-06-18 20:02:22.864 [DEBUG] [rnium.scandium.dtls.ClientHandshaker] - Processing Handshake (22) message from peer [/172.21.2.25:5684]
2018-06-18 20:02:22.866 [DEBUG] [rnium.scandium.dtls.ClientHandshaker] - Processed HELLO_VERIFY_REQUEST (3) message with sequence no [0] from peer [/172.21.2.25:5684]
2018-06-18 20:02:22.871 [DEBUG] [e.californium.scandium.DTLSConnector] - Received Handshake (22) record from peer [/172.21.2.25:5684]
2018-06-18 20:02:22.873 [DEBUG] [rnium.scandium.dtls.ClientHandshaker] - Processing Handshake (22) message from peer [/172.21.2.25:5684]
2018-06-18 20:02:22.875 [DEBUG] [rnium.scandium.dtls.ClientHandshaker] - Processed SERVER_HELLO (2) message with sequence no [1] from peer [/172.21.2.25:5684]
2018-06-18 20:02:22.876 [DEBUG] [e.californium.scandium.DTLSConnector] - Received Handshake (22) record from peer [/172.21.2.25:5684]
2018-06-18 20:02:22.878 [DEBUG] [rnium.scandium.dtls.ClientHandshaker] - Processing Handshake (22) message from peer [/172.21.2.25:5684]
2018-06-18 20:02:22.883 [DEBUG] [rnium.scandium.dtls.ClientHandshaker] - Processed SERVER_HELLO_DONE (14) message with sequence no [2] from peer [/172.21.2.25:5684]
2018-06-18 20:02:22.886 [DEBUG] [rnium.scandium.dtls.ClientHandshaker] - Processing Change Cipher Spec (20) message from peer [/172.21.2.25:5684]
2018-06-18 20:02:22.887 [DEBUG] [rnium.scandium.dtls.ClientHandshaker] - Processed Change Cipher Spec (20) message from peer [/172.21.2.25:5684]
2018-06-18 20:02:22.889 [DEBUG] [e.californium.scandium.DTLSConnector] - Received Handshake (22) record from peer [/172.21.2.25:5684]
2018-06-18 20:02:22.892 [DEBUG] [rnium.scandium.dtls.ClientHandshaker] - Processing Handshake (22) message from peer [/172.21.2.25:5684]
2018-06-18 20:02:22.894 [DEBUG] [californium.scandium.dtls.Connection] - Session with [/172.21.2.25:5684] has been established
2018-06-18 20:02:22.895 [DEBUG] [californium.scandium.dtls.Connection] - Handshake with [/172.21.2.25:5684] has been completed
2018-06-18 20:02:22.898 [DEBUG] [rnium.scandium.dtls.ClientHandshaker] - Processed FINISHED (20) message with sequence no [3] from peer [/172.21.2.25:5684]
2018-06-18 20:02:22.902 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62818 for null:0]
2018-06-18 20:02:22.916 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62819 for null:0], KeyToken[fd21e5a24745]
2018-06-18 20:02:22.920 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62820 for null:0], KeyToken[0de76b4fea]
2018-06-18 20:02:22.925 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62821 for null:0], KeyToken[38e5e4eb21109e]
2018-06-18 20:02:22.931 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62822 for null:0], KeyToken[f6]
2018-06-18 20:02:22.938 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62823 for null:0], KeyToken[72ee01f7]
2018-06-18 20:02:22.946 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62824 for null:0], KeyToken[b0]
2018-06-18 20:02:22.952 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62819 for null:0]
2018-06-18 20:02:22.974 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62820 for null:0]
2018-06-18 20:02:22.987 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62821 for null:0]
2018-06-18 20:02:23.005 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62822 for null:0]
2018-06-18 20:02:23.016 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62823 for null:0]
2018-06-18 20:02:23.027 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62824 for null:0]
2018-06-18 20:02:23.463 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62817 for null:0], KeyToken[2f2133122505]
2018-06-18 20:02:23.512 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62817 for null:0]
2018-06-18 20:02:25.914 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62825 for null:0], KeyToken[1043]
2018-06-18 20:02:25.918 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62826 for null:0], KeyToken[ad5c24dd]
2018-06-18 20:02:25.920 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62825 for null:0]
2018-06-18 20:02:25.929 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62827 for null:0], KeyToken[93cc10f7]
2018-06-18 20:02:25.931 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62826 for null:0]
2018-06-18 20:02:25.955 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62828 for null:0], KeyToken[2198d646a1]
2018-06-18 20:02:25.959 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62827 for null:0]
2018-06-18 20:02:25.994 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62829 for null:0], KeyToken[7a99ee58]
2018-06-18 20:02:26.004 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62830 for null:0], KeyToken[73]
2018-06-18 20:02:26.009 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62828 for null:0]
2018-06-18 20:02:26.026 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62829 for null:0]
2018-06-18 20:02:26.092 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62830 for null:0]
2018-06-18 20:03:20.811 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62831 for null:0], KeyToken[5de576]
2018-06-18 20:03:20.814 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62832 for null:0], KeyToken[15fe1820a8f7]
2018-06-18 20:03:20.862 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62831 for null:0]
2018-06-18 20:03:20.864 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62832 for null:0]
2018-06-18 20:03:20.912 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62833 for null:0], KeyToken[bd8e771914]
2018-06-18 20:03:20.924 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62834 for null:0], KeyToken[66f42f7408277c]
2018-06-18 20:03:20.928 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62835 for null:0], KeyToken[be25903480]
2018-06-18 20:03:20.941 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62836 for null:0], KeyToken[330d81cfa08c2489]
2018-06-18 20:03:20.949 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62837 for null:0], KeyToken[80e8]
2018-06-18 20:03:20.956 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62838 for null:0], KeyToken[1871c1]
2018-06-18 20:03:20.965 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62833 for null:0]
2018-06-18 20:03:20.981 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62834 for null:0]
2018-06-18 20:03:20.988 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62835 for null:0]
2018-06-18 20:03:21.008 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62836 for null:0]
2018-06-18 20:03:21.019 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62837 for null:0]
2018-06-18 20:03:21.028 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62838 for null:0]
2018-06-18 20:03:23.880 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62839 for null:0], KeyToken[eefd5092f88e97]
2018-06-18 20:03:23.883 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62840 for null:0], KeyToken[2be9]
2018-06-18 20:03:23.885 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62841 for null:0], KeyToken[feee5c]
2018-06-18 20:03:23.887 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62842 for null:0], KeyToken[7b01]
2018-06-18 20:03:23.890 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62839 for null:0]
2018-06-18 20:03:23.901 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62840 for null:0]
2018-06-18 20:03:23.908 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62841 for null:0]
2018-06-18 20:03:23.925 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62842 for null:0]
2018-06-18 20:03:23.935 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62843 for null:0], KeyToken[94ddd9f3aaad]
2018-06-18 20:03:23.938 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62844 for null:0], KeyToken[e88f]
2018-06-18 20:03:23.945 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62843 for null:0]
2018-06-18 20:03:23.959 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62844 for null:0]
2018-06-18 20:04:20.812 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62845 for null:0], KeyToken[1bd1cc]
2018-06-18 20:04:20.815 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62846 for null:0], KeyToken[b537a6]
2018-06-18 20:04:20.864 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62845 for null:0]
2018-06-18 20:04:20.867 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62846 for null:0]
2018-06-18 20:04:20.873 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62847 for null:0], KeyToken[55cf7131526e]
2018-06-18 20:04:20.876 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62848 for null:0], KeyToken[bfdf10bade7287]
2018-06-18 20:04:20.891 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62849 for null:0], KeyToken[5b661f39e36cb812]
2018-06-18 20:04:20.899 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62850 for null:0], KeyToken[ef99]
2018-06-18 20:04:20.907 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62851 for null:0], KeyToken[535615ca47]
2018-06-18 20:04:20.913 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62852 for null:0], KeyToken[8c1fa787]
2018-06-18 20:04:20.919 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62847 for null:0]
2018-06-18 20:04:20.938 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62848 for null:0]
2018-06-18 20:04:20.954 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62849 for null:0]
2018-06-18 20:04:20.986 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62850 for null:0]
2018-06-18 20:04:21.061 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62851 for null:0]
2018-06-18 20:04:21.076 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62852 for null:0]
2018-06-18 20:05:20.814 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62853 for null:0], KeyToken[cb42f8]
2018-06-18 20:05:20.817 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62854 for null:0], KeyToken[59c371b471]
2018-06-18 20:05:20.864 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62853 for null:0]
2018-06-18 20:05:20.866 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62854 for null:0]
2018-06-18 20:05:20.870 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62855 for null:0], KeyToken[d6]
2018-06-18 20:05:20.875 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62856 for null:0], KeyToken[37d21a3482]
2018-06-18 20:05:20.878 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62857 for null:0], KeyToken[08b49b96c615]
2018-06-18 20:05:20.884 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62858 for null:0], KeyToken[c64301948a02]
2018-06-18 20:05:20.888 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62859 for null:0], KeyToken[5f06b960773821c3]
2018-06-18 20:05:20.890 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62860 for null:0], KeyToken[dc2c44981c38]
2018-06-18 20:05:20.895 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62855 for null:0]
2018-06-18 20:05:20.901 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62856 for null:0]
2018-06-18 20:05:20.907 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62857 for null:0]
2018-06-18 20:05:20.913 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62858 for null:0]
2018-06-18 20:05:20.919 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62859 for null:0]
2018-06-18 20:05:20.925 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62860 for null:0]
2018-06-18 20:06:20.816 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62861 for null:0], KeyToken[1ca1121d7d87e94f]
2018-06-18 20:06:20.818 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62862 for null:0], KeyToken[7b90902172b8]
2018-06-18 20:06:20.868 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62861 for null:0]
2018-06-18 20:06:20.871 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62862 for null:0]
2018-06-18 20:06:20.877 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62863 for null:0], KeyToken[7adc536c5d4b]
2018-06-18 20:06:20.891 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62864 for null:0], KeyToken[42ea]
2018-06-18 20:06:20.895 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62865 for null:0], KeyToken[efa13ca6]
2018-06-18 20:06:20.898 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62866 for null:0], KeyToken[d83e3d26e9ea]
2018-06-18 20:06:20.902 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62867 for null:0], KeyToken[c69c3cab38a6cb34]
2018-06-18 20:06:20.907 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62868 for null:0], KeyToken[85f6a4680b2a57c3]
2018-06-18 20:06:20.909 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62863 for null:0]
2018-06-18 20:06:20.930 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62864 for null:0]
2018-06-18 20:06:20.941 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62865 for null:0]
2018-06-18 20:06:20.951 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62866 for null:0]
2018-06-18 20:06:20.967 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62867 for null:0]
2018-06-18 20:06:20.978 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62868 for null:0]
2018-06-18 20:07:20.817 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62869 for null:0], KeyToken[b2]
2018-06-18 20:07:20.820 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62870 for null:0], KeyToken[88ad172f]
2018-06-18 20:07:20.867 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62869 for null:0]
2018-06-18 20:07:20.870 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62870 for null:0]
2018-06-18 20:07:20.876 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62871 for null:0], KeyToken[30523383e953f7]
2018-06-18 20:07:20.879 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62872 for null:0], KeyToken[a84aa92ccf0a300d]
2018-06-18 20:07:20.881 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62873 for null:0], KeyToken[34]
2018-06-18 20:07:20.884 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62874 for null:0], KeyToken[aba9d32c1b16]
2018-06-18 20:07:20.896 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62875 for null:0], KeyToken[8721]
2018-06-18 20:07:20.902 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62876 for null:0], KeyToken[f7732d5cd2]
2018-06-18 20:07:20.908 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62871 for null:0]
2018-06-18 20:07:20.918 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62872 for null:0]
2018-06-18 20:07:20.931 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62873 for null:0]
2018-06-18 20:07:20.938 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62874 for null:0]
2018-06-18 20:07:20.945 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62875 for null:0]
2018-06-18 20:07:20.953 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62876 for null:0]
2018-06-18 20:08:20.819 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62877 for null:0], KeyToken[35e4c812fa3efca2]
2018-06-18 20:08:20.822 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62878 for null:0], KeyToken[ed81]
2018-06-18 20:08:20.871 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62877 for null:0]
2018-06-18 20:08:20.874 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62878 for null:0]
2018-06-18 20:08:20.890 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62879 for null:0], KeyToken[b0f00d]
2018-06-18 20:08:20.893 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62880 for null:0], KeyToken[87c0dd45cb368b]
2018-06-18 20:08:20.898 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62881 for null:0], KeyToken[9812ab1abcfc82]
2018-06-18 20:08:20.903 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62882 for null:0], KeyToken[cf98dadb202f4b]
2018-06-18 20:08:20.908 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62883 for null:0], KeyToken[a21fa2db]
2018-06-18 20:08:20.913 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62884 for null:0], KeyToken[6bd8a3067ee9]
2018-06-18 20:08:20.918 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62879 for null:0]
2018-06-18 20:08:20.928 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62880 for null:0]
2018-06-18 20:08:20.936 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62881 for null:0]
2018-06-18 20:08:20.943 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62882 for null:0]
2018-06-18 20:08:20.951 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62883 for null:0]
2018-06-18 20:08:20.957 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62884 for null:0]

Sonni · June 18, 2018, 7:27pm

openhab.log part 2

2018-06-18 20:09:20.829 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62886 for null:0], KeyToken[1f3039]
2018-06-18 20:09:20.875 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62885 for null:0]
2018-06-18 20:09:20.879 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62886 for null:0]
2018-06-18 20:09:20.888 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62887 for null:0], KeyToken[18686dccaa96ab]
2018-06-18 20:09:20.892 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62888 for null:0], KeyToken[59535dab0f]
2018-06-18 20:09:20.897 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62889 for null:0], KeyToken[fc61]
2018-06-18 20:09:20.902 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62890 for null:0], KeyToken[afa21e863e]
2018-06-18 20:09:20.906 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62891 for null:0], KeyToken[dfd9]
2018-06-18 20:09:20.910 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62892 for null:0], KeyToken[8bf3b3]
2018-06-18 20:09:20.915 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62887 for null:0]
2018-06-18 20:09:20.926 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62888 for null:0]
2018-06-18 20:09:20.937 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62889 for null:0]
2018-06-18 20:09:20.948 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62890 for null:0]
2018-06-18 20:09:20.958 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62891 for null:0]
2018-06-18 20:09:20.967 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62892 for null:0]
2018-06-18 20:10:20.822 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62893 for null:0], KeyToken[b7]
2018-06-18 20:10:20.827 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62894 for null:0], KeyToken[ce233f]
2018-06-18 20:10:20.872 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62893 for null:0]
2018-06-18 20:10:20.876 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62894 for null:0]
2018-06-18 20:10:20.886 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62895 for null:0], KeyToken[16dea69f950a]
2018-06-18 20:10:20.891 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62896 for null:0], KeyToken[5e317c]
2018-06-18 20:10:20.900 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62897 for null:0], KeyToken[4e511cda]
2018-06-18 20:10:20.906 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62898 for null:0], KeyToken[c33cf732]
2018-06-18 20:10:20.911 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62899 for null:0], KeyToken[8402c2f7]
2018-06-18 20:10:20.915 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62900 for null:0], KeyToken[cf0cfd56124e]
2018-06-18 20:10:20.919 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62895 for null:0]
2018-06-18 20:10:20.943 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62896 for null:0]
2018-06-18 20:10:20.966 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62897 for null:0]
2018-06-18 20:10:20.976 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62898 for null:0]
2018-06-18 20:10:20.985 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62899 for null:0]
2018-06-18 20:10:20.994 [DEBUG] [pse.californium.core.network.Matcher] - Closed open request with KeyMID[62900 for null:0]
2018-06-18 20:11:20.828 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62901 for null:0], KeyToken[0e612d3c1b2abf]
2018-06-18 20:11:20.832 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62902 for null:0], KeyToken[0a55ec2503]
2018-06-18 20:11:22.961 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62901 for null:0], KeyToken[0e612d3c1b2abf]
2018-06-18 20:11:23.829 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62902 for null:0], KeyToken[0a55ec2503]
2018-06-18 20:11:27.225 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62901 for null:0], KeyToken[0e612d3c1b2abf]
2018-06-18 20:11:29.823 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62902 for null:0], KeyToken[0a55ec2503]
2018-06-18 20:11:35.753 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62901 for null:0], KeyToken[0e612d3c1b2abf]
2018-06-18 20:11:41.811 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62902 for null:0], KeyToken[0a55ec2503]
2018-06-18 20:11:52.809 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62901 for null:0], KeyToken[0e612d3c1b2abf]
2018-06-18 20:12:05.788 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62902 for null:0], KeyToken[0a55ec2503]
2018-06-18 20:12:20.829 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62903 for null:0], KeyToken[78221446]
2018-06-18 20:12:20.833 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62904 for null:0], KeyToken[3f690c6037]
2018-06-18 20:12:22.857 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62904 for null:0], KeyToken[3f690c6037]
2018-06-18 20:12:23.706 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62903 for null:0], KeyToken[78221446]
2018-06-18 20:12:26.905 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62904 for null:0], KeyToken[3f690c6037]
2018-06-18 20:12:29.461 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62903 for null:0], KeyToken[78221446]
2018-06-18 20:12:35.002 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62904 for null:0], KeyToken[3f690c6037]
2018-06-18 20:12:40.969 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62903 for null:0], KeyToken[78221446]
2018-06-18 20:12:51.194 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62904 for null:0], KeyToken[3f690c6037]
2018-06-18 20:13:03.986 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62903 for null:0], KeyToken[78221446]
2018-06-18 20:13:20.831 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62905 for null:0], KeyToken[09af39d8ab]
2018-06-18 20:13:20.836 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62906 for null:0], KeyToken[c8ffbd2a1cc8]
2018-06-18 20:13:23.643 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62905 for null:0], KeyToken[09af39d8ab]
2018-06-18 20:13:23.743 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62906 for null:0], KeyToken[c8ffbd2a1cc8]
2018-06-18 20:13:29.266 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62905 for null:0], KeyToken[09af39d8ab]
2018-06-18 20:13:29.556 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62906 for null:0], KeyToken[c8ffbd2a1cc8]
2018-06-18 20:13:40.509 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62905 for null:0], KeyToken[09af39d8ab]
2018-06-18 20:13:41.179 [DEBUG] [pse.californium.core.network.Matcher] - Stored open request by KeyMID[62906 for null:0], KeyToken[c8ffbd2a1cc8]

Sonni · June 18, 2018, 7:27pm

events.log
2018-06-18 20:02:20.269 [me.event.ThingUpdatedEvent] - Thing 'tradfri:gateway:gwdcefcabcf9df' has been updated.
2018-06-18 20:02:20.667 [me.event.ThingUpdatedEvent] - Thing 'tradfri:gateway:gwdcefcabcf9df' has been updated.
2018-06-18 20:02:20.753 [hingStatusInfoChangedEvent] - 'tradfri:gateway:gwdcefcabcf9df' changed from OFFLINE (COMMUNICATION_ERROR) to UNKNOWN
2018-06-18 20:02:22.910 [hingStatusInfoChangedEvent] - 'tradfri:gateway:gwdcefcabcf9df' changed from UNKNOWN to ONLINE
2018-06-18 20:02:22.928 [hingStatusInfoChangedEvent] - 'tradfri:0830:gwdcefcabcf9df:65536' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE
2018-06-18 20:02:22.936 [hingStatusInfoChangedEvent] - 'tradfri:0830:gwdcefcabcf9df:65536' changed from ONLINE to UNKNOWN
2018-06-18 20:02:22.951 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65540' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE
2018-06-18 20:02:22.963 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65540' changed from ONLINE to UNKNOWN
2018-06-18 20:02:22.979 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65537' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE
2018-06-18 20:02:22.985 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65537' changed from ONLINE to UNKNOWN
2018-06-18 20:02:22.997 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65539' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE
2018-06-18 20:02:23.006 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65538' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE
2018-06-18 20:02:23.018 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65538' changed from ONLINE to UNKNOWN
2018-06-18 20:02:23.028 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65541' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE
2018-06-18 20:02:23.036 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65539' changed from ONLINE to UNKNOWN
2018-06-18 20:02:23.047 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65541' changed from ONLINE to UNKNOWN
2018-06-18 20:02:23.059 [ome.event.ItemCommandEvent] - Item 'TradfriOnline' received command OFF
2018-06-18 20:02:23.069 [ome.event.ItemCommandEvent] - Item 'TradfriOnlineStatus' received command ON
2018-06-18 20:02:23.086 [vent.ItemStateChangedEvent] - TradfriOnlineStatus changed from OFF to ON
2018-06-18 20:02:25.926 [hingStatusInfoChangedEvent] - 'tradfri:0830:gwdcefcabcf9df:65536' changed from UNKNOWN to ONLINE
2018-06-18 20:02:25.940 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65540' changed from UNKNOWN to ONLINE
2018-06-18 20:02:25.982 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65537' changed from UNKNOWN to ONLINE
2018-06-18 20:02:26.019 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65538' changed from UNKNOWN to ONLINE
2018-06-18 20:02:26.038 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65539' changed from UNKNOWN to ONLINE
2018-06-18 20:02:26.109 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65541' changed from UNKNOWN to ONLINE
2018-06-18 20:02:41.924 [hingStatusInfoChangedEvent] - 'tradfri:gateway:gwdcefcabcf9df' changed from ONLINE to OFFLINE (COMMUNICATION_ERROR)
2018-06-18 20:02:41.933 [hingStatusInfoChangedEvent] - 'tradfri:0830:gwdcefcabcf9df:65536' changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-06-18 20:02:41.939 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65540' changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-06-18 20:02:41.942 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65539' changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-06-18 20:02:41.949 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65537' changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-06-18 20:02:41.953 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65541' changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-06-18 20:02:41.955 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65538' changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-06-18 20:02:41.958 [ome.event.ItemCommandEvent] - Item 'TradfriOnline' received command OFF
2018-06-18 20:02:41.962 [ome.event.ItemCommandEvent] - Item 'TradfriOnlineStatus' received command OFF
2018-06-18 20:02:41.982 [vent.ItemStateChangedEvent] - TradfriOnlineStatus changed from ON to OFF
2018-06-18 20:03:20.880 [hingStatusInfoChangedEvent] - 'tradfri:gateway:gwdcefcabcf9df' changed from OFFLINE (COMMUNICATION_ERROR) to ONLINE
2018-06-18 20:03:20.885 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65539' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE
2018-06-18 20:03:20.895 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65539' changed from ONLINE to UNKNOWN
2018-06-18 20:03:20.897 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65540' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE
2018-06-18 20:03:20.899 [hingStatusInfoChangedEvent] - 'tradfri:0830:gwdcefcabcf9df:65536' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE
2018-06-18 20:03:20.901 [hingStatusInfoChangedEvent] - 'tradfri:0830:gwdcefcabcf9df:65536' changed from ONLINE to UNKNOWN
2018-06-18 20:03:20.906 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65540' changed from ONLINE to UNKNOWN
2018-06-18 20:03:20.919 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65537' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE
2018-06-18 20:03:20.932 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65537' changed from ONLINE to UNKNOWN
2018-06-18 20:03:20.947 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65541' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE
2018-06-18 20:03:20.950 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65541' changed from ONLINE to UNKNOWN
2018-06-18 20:03:20.963 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65538' changed from OFFLINE (BRIDGE_OFFLINE) to ONLINE
2018-06-18 20:03:20.965 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65538' changed from ONLINE to UNKNOWN
2018-06-18 20:03:20.975 [ome.event.ItemCommandEvent] - Item 'TradfriOnline' received command OFF
2018-06-18 20:03:20.976 [ome.event.ItemCommandEvent] - Item 'TradfriOnlineStatus' received command ON
2018-06-18 20:03:20.989 [vent.ItemStateChangedEvent] - TradfriOnlineStatus changed from OFF to ON
2018-06-18 20:03:23.896 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65539' changed from UNKNOWN to ONLINE
2018-06-18 20:03:23.914 [hingStatusInfoChangedEvent] - 'tradfri:0830:gwdcefcabcf9df:65536' changed from UNKNOWN to ONLINE
2018-06-18 20:03:23.919 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65540' changed from UNKNOWN to ONLINE
2018-06-18 20:03:23.943 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65537' changed from UNKNOWN to ONLINE
2018-06-18 20:03:23.958 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65541' changed from UNKNOWN to ONLINE
2018-06-18 20:03:23.980 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65538' changed from UNKNOWN to ONLINE
2018-06-18 20:12:53.753 [hingStatusInfoChangedEvent] - 'tradfri:gateway:gwdcefcabcf9df' changed from ONLINE to OFFLINE (COMMUNICATION_ERROR)
2018-06-18 20:12:53.761 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65540' changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-06-18 20:12:53.777 [hingStatusInfoChangedEvent] - 'tradfri:0830:gwdcefcabcf9df:65536' changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-06-18 20:12:53.808 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65539' changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-06-18 20:12:53.814 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65541' changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-06-18 20:12:53.824 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65537' changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-06-18 20:12:53.835 [hingStatusInfoChangedEvent] - 'tradfri:0220:gwdcefcabcf9df:65538' changed from ONLINE to OFFLINE (BRIDGE_OFFLINE)
2018-06-18 20:12:53.848 [ome.event.ItemCommandEvent] - Item 'TradfriOnline' received command OFF
2018-06-18 20:12:53.866 [ome.event.ItemCommandEvent] - Item 'TradfriOnlineStatus' received command OFF
2018-06-18 20:12:53.886 [vent.ItemStateChangedEvent] - TradfriOnlineStatus changed from ON to OFF

OMR · June 18, 2018, 7:37pm

Have you tried with another patch cable?
The one that comes with the gateway has known defects. Search this forum for posts on that.

OMR · June 18, 2018, 7:39pm

You can also try changing the USB power supply…

Thedannymullen · June 19, 2018, 2:14am

I would look at your router as the possible issue. I have seen the router break many things.

Sonni · June 21, 2018, 1:40pm

Thanks for your suggestions.

It turned out to be the power supply that was causing the unstable behavior. I was not using the one which came with the gateway, but a different one which powers multiple usb devices.
Strange that it had been working for months…but thats hardware it sometime fails.

Thedannymullen · June 21, 2018, 5:19pm

Awesome! Glad you fixed it.

martinvw · June 28, 2018, 5:17pm

Unfortunately I faced the same problem with the standard power supply, I realized the problems yesterday, but there were some signals before. Like my openHAB motion rules not triggering the Tradfri panel.

I have a led panel and a remote and run firmware version 1.3.14

It seems to be fixed now that I removed the fixed ip address in my unifi controller, strange maybe a bug in my Unifi router?

Yoinkz · July 3, 2018, 1:34pm

Hi guys,

Same issue here, both my gateways are offline so are my LED’s.
I tried restarting the gateways, but no difference. The only fix seems to be restart of OH.

Currently running the latest OH Stable 2.3.0.
I don’t see any erros when looking at the log and the gateways + LED’s are responding perfectly with my IKEA app.

Any suggestions?

patoberli · July 3, 2018, 2:14pm

Hi

My Ikea gateway received new firmware yesterday, maybe it helps?

Running now 1.4.x

Yoinkz · July 3, 2018, 2:31pm

Maybe that could be it.

Let’s see what happens the next few days

Thedannymullen · July 3, 2018, 8:17pm

Really? I need to check that. Mine has not updated.

martinvw · July 4, 2018, 8:32pm

And it is OFFLINE again, unfortunately I don’t have the time to look into it right now.

@kai how is your tradfri behaving, is it fine?

I did btw also receive the 1.4.x update

EDIT: invested some time anyway

Network is fine this time and app is still working
After re-entering the security code a new connection is setup, could it be that it loses the pre-shared key / connection with a (some) firmware updates?

Kai · July 6, 2018, 8:23pm

@kai how is your tradfri behaving, is it fine?

It is feeling well in the drawer where it is stored
I don’t use it productively, so I cannot provide input here, sorry…

clempat · July 6, 2018, 10:01pm

I don’t know if it cans help you but in my case ([SOLVED] Tradfri binding is so unstable for me) it was the power plug making issue. I checked it make sure it is really good connected and actually let the gateway open in order to not disturb it.

And it is weird but since I did not face this issue again.

OliverT · November 23, 2018, 5:51am

My Tradfri Gateway thing requires re-entering of the security code in the binding after each OH 2.3 restart. Otherwise the gateway and all items went off-line…