Tradfri Binding: Slow reaction and communication error with gateway

openhab2
binding
Tags: #<Tag:0x00007fe06019c588> #<Tag:0x00007fe06019c088>

(Philipp Marschall) #1

Hi there,
since a few weeks I have problems with the IKEA tradri binding.
The reaction of the binding is VERY poor (takes a minute sometimes) and I noticed that the gateway seems to be not online sometimes because of an communication error.
I set the log level to DEBUG now for the binding, maybe anybody can help?

I have openhabian installed, openhab version 2.2 and configured the things / items with files. Everything went very smooth for months, but the last week the problems have been arising.

I have been wondering why the thins are added to the inbox ("Adding device …to inbox…) although the thing is configured within the things file and is online already…?

The payload seems to be sent immediately but there are always two responses including all tradfri things and adding each again to the inbox… Sounds weired to me.
The action is finished after the second COAP response, not earlier.


Update:
I found the following line in the logs after setting up one more time the tradfri things…

“2018-05-10 11:58:00.554 [WARN ] [radfri.handler.TradfriGatewayHandler] - Gateway with old firmware - please consider upgrading to the latest version.”

I´ve installed the latest version on the gateway (1.3.14) so I´m wondering about this warning…

Logs:

2018-05-05 20:25:08.723 [ome.event.ItemCommandEvent] - Item ‘Stehlampe_Wohnzimmer’ received command OFF
2018-05-05 20:25:08.745 [vent.ItemStateChangedEvent] - Stehlampe_Wohnzimmer changed from ON to OFF

2018-05-05 20:25:08.725 [DEBUG] [.tradfri.handler.TradfriThingHandler] - Sending payload: {“3311”:[{“5850”:0}],“3”:{}}

2018-05-05 20:27:43.739 [DEBUG] [g.tradfri.internal.TradfriCoapClient] - Proccessing payload: {“3311”:[{“5850”:0}],“3”:{}}
2018-05-05 20:27:58.843 [DEBUG] [.tradfri.internal.TradfriCoapHandler] - CoAP response
options: {“Content-Format”:“application/json”, “Max-Age”:604800}
payload: [65543,65540,65538,65541,65537,65544,65539]
2018-05-05 20:27:58.849 [DEBUG] [radfri.handler.TradfriGatewayHandler] - onUpdate response: [65543,65540,65538,65541,65537,65544,65539]
2018-05-05 20:27:58.955 [DEBUG] [.tradfri.internal.TradfriCoapHandler] - CoAP response
options: {“Content-Format”:“application/json”, “Max-Age”:604800}
payload: {“9001”:“Fernbedienung Eingang”,“9002”:1516261718,“9020”:1519043205,“9003”:65543,“9054”:0,“5750”:0,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“TRADFRI remote control”,“2”:"",“3”:“1.2.214”,“6”:3,“9”:34},“15009”:[{“9003”:0}]}
2018-05-05 20:27:58.971 [DEBUG] [radfri.handler.TradfriGatewayHandler] - requestDeviceDetails response: {“9001”:“Fernbedienung Eingang”,“9002”:1516261718,“9020”:1519043205,“9003”:65543,“9054”:0,“5750”:0,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“TRADFRI remote control”,“2”:"",“3”:“1.2.214”,“6”:3,“9”:34},“15009”:[{“9003”:0}]}
2018-05-05 20:27:58.980 [DEBUG] [al.discovery.TradfriDiscoveryService] - Adding device tradfri:0830:gwb072bf27b557:65543 to inbox
2018-05-05 20:27:58.988 [DEBUG] [.tradfri.internal.TradfriCoapHandler] - CoAP response
options: {“Content-Format”:“application/json”, “Max-Age”:604800}
payload: {“9001”:“TRADFRI motion sensor”,“9002”:1497810026,“9020”:1519053350,“9003”:65540,“9054”:0,“5750”:4,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“TRADFRI motion sensor”,“2”:"",“3”:“1.2.214”,“6”:3,“9”:60},“3300”:[{“9003”:0}]}
2018-05-05 20:27:58.995 [DEBUG] [radfri.handler.TradfriGatewayHandler] - requestDeviceDetails response: {“9001”:“TRADFRI motion sensor”,“9002”:1497810026,“9020”:1519053350,“9003”:65540,“9054”:0,“5750”:4,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“TRADFRI motion sensor”,“2”:"",“3”:“1.2.214”,“6”:3,“9”:60},“3300”:[{“9003”:0}]}
2018-05-05 20:27:59.002 [DEBUG] [al.discovery.TradfriDiscoveryService] - Adding device tradfri:0107:gwb072bf27b557:65540 to inbox
2018-05-05 20:27:59.010 [DEBUG] [.tradfri.internal.TradfriCoapHandler] - CoAP response
options: {“Content-Format”:“application/json”, “Max-Age”:604800}
payload: {“9001”:“Fernbedienung Küche”,“9002”:1497809575,“9020”:1525134882,“9003”:65538,“9054”:0,“5750”:0,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“TRADFRI remote control”,“2”:"",“3”:“1.2.214”,“6”:3,“9”:34},“15009”:[{“9003”:0}]}
2018-05-05 20:27:59.017 [DEBUG] [radfri.handler.TradfriGatewayHandler] - requestDeviceDetails response: {“9001”:“Fernbedienung Küche”,“9002”:1497809575,“9020”:1525134882,“9003”:65538,“9054”:0,“5750”:0,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“TRADFRI remote control”,“2”:"",“3”:“1.2.214”,“6”:3,“9”:34},“15009”:[{“9003”:0}]}
2018-05-05 20:27:59.024 [DEBUG] [al.discovery.TradfriDiscoveryService] - Adding device tradfri:0830:gwb072bf27b557:65538 to inbox
2018-05-05 20:27:59.032 [DEBUG] [.tradfri.internal.TradfriCoapHandler] - CoAP response
options: {“Content-Format”:“application/json”, “Max-Age”:604800}
payload: {“9001”:“Toilette”,“9002”:1497810103,“9020”:1525540674,“9003”:65541,“9054”:0,“5750”:2,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“TRADFRI bulb E27 W opal 1000lm”,“2”:"",“3”:“1.2.214”,“6”:1},“3311”:[{“5850”:0,“5851”:254,“9003”:0}]}
2018-05-05 20:27:59.038 [DEBUG] [radfri.handler.TradfriGatewayHandler] - requestDeviceDetails response: {“9001”:“Toilette”,“9002”:1497810103,“9020”:1525540674,“9003”:65541,“9054”:0,“5750”:2,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“TRADFRI bulb E27 W opal 1000lm”,“2”:"",“3”:“1.2.214”,“6”:1},“3311”:[{“5850”:0,“5851”:254,“9003”:0}]}
2018-05-05 20:27:59.046 [DEBUG] [al.discovery.TradfriDiscoveryService] - Adding device tradfri:0100:gwb072bf27b557:65541 to inbox
2018-05-05 20:27:59.054 [DEBUG] [.tradfri.internal.TradfriCoapHandler] - CoAP response
options: {“Content-Format”:“application/json”, “Max-Age”:604800}
payload: {“9001”:“Stehlampe Wohnzimmer”,“9002”:1497808804,“9020”:1525543030,“9003”:65537,“9054”:0,“5750”:2,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“TRADFRI bulb E27 WS opal 980lm”,“2”:"",“3”:“1.2.217”,“6”:1},“3311”:[{“5850”:1,“5851”:254,“5717”:0,“5710”:27205,“5711”:454,“5709”:33077,“5706”:“efd275”,“9003”:0}]}
2018-05-05 20:27:59.058 [DEBUG] [radfri.handler.TradfriGatewayHandler] - requestDeviceDetails response: {“9001”:“Stehlampe Wohnzimmer”,“9002”:1497808804,“9020”:1525543030,“9003”:65537,“9054”:0,“5750”:2,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“TRADFRI bulb E27 WS opal 980lm”,“2”:"",“3”:“1.2.217”,“6”:1},“3311”:[{“5850”:1,“5851”:254,“5717”:0,“5710”:27205,“5711”:454,“5709”:33077,“5706”:“efd275”,“9003”:0}]}
2018-05-05 20:27:59.061 [DEBUG] [al.discovery.TradfriDiscoveryService] - Adding device tradfri:0220:gwb072bf27b557:65537 to inbox
2018-05-05 20:27:59.066 [DEBUG] [.tradfri.internal.TradfriCoapHandler] - CoAP response
options: {“Content-Format”:“application/json”, “Max-Age”:604800}
payload: {“9001”:“Eingang”,“9002”:1516261759,“9020”:1525518066,“9003”:65544,“9054”:0,“5750”:2,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“TRADFRI bulb E27 W opal 1000lm”,“2”:"",“3”:“1.2.214”,“6”:1},“3311”:[{“5850”:0,“5851”:254,“9003”:0}]}
2018-05-05 20:27:59.069 [DEBUG] [radfri.handler.TradfriGatewayHandler] - requestDeviceDetails response: {“9001”:“Eingang”,“9002”:1516261759,“9020”:1525518066,“9003”:65544,“9054”:0,“5750”:2,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“TRADFRI bulb E27 W opal 1000lm”,“2”:"",“3”:“1.2.214”,“6”:1},“3311”:[{“5850”:0,“5851”:254,“9003”:0}]}
2018-05-05 20:27:59.072 [DEBUG] [al.discovery.TradfriDiscoveryService] - Adding device tradfri:0100:gwb072bf27b557:65544 to inbox
2018-05-05 20:27:59.076 [DEBUG] [.tradfri.internal.TradfriCoapHandler] - CoAP response
options: {“Content-Format”:“application/json”, “Max-Age”:604800}
payload: {“9001”:“Küche”,“9002”:1497809665,“9020”:1525518068,“9003”:65539,“9054”:0,“5750”:2,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“FLOALT panel WS 60x60”,“2”:"",“3”:“1.2.217”,“6”:1},“3311”:[{“5850”:0,“5851”:254,“5717”:0,“5710”:24691,“5711”:250,“5709”:24933,“5706”:“f5faf6”,“9003”:0}]}
2018-05-05 20:27:59.079 [DEBUG] [radfri.handler.TradfriGatewayHandler] - requestDeviceDetails response: {“9001”:“Küche”,“9002”:1497809665,“9020”:1525518068,“9003”:65539,“9054”:0,“5750”:2,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“FLOALT panel WS 60x60”,“2”:"",“3”:“1.2.217”,“6”:1},“3311”:[{“5850”:0,“5851”:254,“5717”:0,“5710”:24691,“5711”:250,“5709”:24933,“5706”:“f5faf6”,“9003”:0}]}
2018-05-05 20:27:59.083 [DEBUG] [al.discovery.TradfriDiscoveryService] - Adding device tradfri:0220:gwb072bf27b557:65539 to inbox
2018-05-05 20:27:59.389 [DEBUG] [.tradfri.internal.TradfriCoapHandler] - CoAP response
options: {“Content-Format”:“application/json”, “Max-Age”:604800}
payload: {“9023”:“3.tradfri.pool.ntp.org”,“9079”:0,“9076”:10,“9059”:1525544882,“9060”:“2018-05-05T18:28:02.030000Z”,“9055”:0,“9062”:0,“9061”:0,“9080”:60,“9029”:“1.3.14”,“9081”:“7e13455204400029”,“9082”:true,“9083”:“992-23-020”,“9054”:0,“9066”:5,“9069”:1515431674,“9071”:1,“9072”:3,“9073”:25,“9074”:0,“9075”:59,“9077”:28,“9078”:1,“9092”:1,“9093”:1,“9106”:1,“9105”:0}
2018-05-05 20:28:00.790 [DEBUG] [.tradfri.internal.TradfriCoapHandler] - CoAP response
options: {}
payload:
2018-05-05 20:28:40.479 [DEBUG] [.tradfri.internal.TradfriCoapHandler] - CoAP response
options: {“Content-Format”:“application/json”, “Max-Age”:604800}
payload: {“9023”:“3.tradfri.pool.ntp.org”,“9079”:0,“9076”:10,“9059”:1525544923,“9060”:“2018-05-05T18:28:43.058464Z”,“9055”:0,“9062”:0,“9061”:0,“9080”:60,“9029”:“1.3.14”,“9081”:“7e13455204400029”,“9082”:true,“9083”:“992-23-020”,“9054”:0,“9066”:5,“9069”:1515431674,“9071”:1,“9072”:3,“9073”:25,“9074”:0,“9075”:59,“9077”:28,“9078”:1,“9092”:1,“9093”:1,“9106”:1,“9105”:0}
2018-05-05 20:28:40.482 [DEBUG] [.tradfri.internal.TradfriCoapHandler] - CoAP response
options: {“Content-Format”:“application/json”, “Max-Age”:604800}
payload: [65543,65540,65538,65541,65537,65544,65539]
2018-05-05 20:28:40.484 [DEBUG] [radfri.handler.TradfriGatewayHandler] - onUpdate response: [65543,65540,65538,65541,65537,65544,65539]
2018-05-05 20:28:40.525 [DEBUG] [.tradfri.internal.TradfriCoapHandler] - CoAP response
options: {“Content-Format”:“application/json”, “Max-Age”:604800}
payload: {“9001”:“Fernbedienung Eingang”,“9002”:1516261718,“9020”:1519043205,“9003”:65543,“9054”:0,“5750”:0,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“TRADFRI remote control”,“2”:"",“3”:“1.2.214”,“6”:3,“9”:34},“15009”:[{“9003”:0}]}
2018-05-05 20:28:40.532 [DEBUG] [radfri.handler.TradfriGatewayHandler] - requestDeviceDetails response: {“9001”:“Fernbedienung Eingang”,“9002”:1516261718,“9020”:1519043205,“9003”:65543,“9054”:0,“5750”:0,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“TRADFRI remote control”,“2”:"",“3”:“1.2.214”,“6”:3,“9”:34},“15009”:[{“9003”:0}]}
2018-05-05 20:28:40.536 [DEBUG] [al.discovery.TradfriDiscoveryService] - Adding device tradfri:0830:gwb072bf27b557:65543 to inbox
2018-05-05 20:28:40.539 [DEBUG] [.tradfri.internal.TradfriCoapHandler] - CoAP response
options: {“Content-Format”:“application/json”, “Max-Age”:604800}
payload: {“9001”:“TRADFRI motion sensor”,“9002”:1497810026,“9020”:1519053350,“9003”:65540,“9054”:0,“5750”:4,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“TRADFRI motion sensor”,“2”:"",“3”:“1.2.214”,“6”:3,“9”:60},“3300”:[{“9003”:0}]}
2018-05-05 20:28:40.543 [DEBUG] [radfri.handler.TradfriGatewayHandler] - requestDeviceDetails response: {“9001”:“TRADFRI motion sensor”,“9002”:1497810026,“9020”:1519053350,“9003”:65540,“9054”:0,“5750”:4,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“TRADFRI motion sensor”,“2”:"",“3”:“1.2.214”,“6”:3,“9”:60},“3300”:[{“9003”:0}]}
2018-05-05 20:28:40.546 [DEBUG] [al.discovery.TradfriDiscoveryService] - Adding device tradfri:0107:gwb072bf27b557:65540 to inbox
2018-05-05 20:28:40.549 [DEBUG] [.tradfri.internal.TradfriCoapHandler] - CoAP response
options: {“Content-Format”:“application/json”, “Max-Age”:604800}
payload: {“9001”:“Fernbedienung Küche”,“9002”:1497809575,“9020”:1525134882,“9003”:65538,“9054”:0,“5750”:0,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“TRADFRI remote control”,“2”:"",“3”:“1.2.214”,“6”:3,“9”:34},“15009”:[{“9003”:0}]}
2018-05-05 20:28:40.553 [DEBUG] [radfri.handler.TradfriGatewayHandler] - requestDeviceDetails response: {“9001”:“Fernbedienung Küche”,“9002”:1497809575,“9020”:1525134882,“9003”:65538,“9054”:0,“5750”:0,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“TRADFRI remote control”,“2”:"",“3”:“1.2.214”,“6”:3,“9”:34},“15009”:[{“9003”:0}]}
2018-05-05 20:28:40.556 [DEBUG] [al.discovery.TradfriDiscoveryService] - Adding device tradfri:0830:gwb072bf27b557:65538 to inbox
2018-05-05 20:28:40.559 [DEBUG] [.tradfri.internal.TradfriCoapHandler] - CoAP response
options: {“Content-Format”:“application/json”, “Max-Age”:604800}
payload: {“9001”:“Toilette”,“9002”:1497810103,“9020”:1525540674,“9003”:65541,“9054”:0,“5750”:2,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“TRADFRI bulb E27 W opal 1000lm”,“2”:"",“3”:“1.2.214”,“6”:1},“3311”:[{“5850”:0,“5851”:254,“9003”:0}]}
2018-05-05 20:28:40.560 [DEBUG] [radfri.handler.TradfriGatewayHandler] - requestDeviceDetails response: {“9001”:“Toilette”,“9002”:1497810103,“9020”:1525540674,“9003”:65541,“9054”:0,“5750”:2,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“TRADFRI bulb E27 W opal 1000lm”,“2”:"",“3”:“1.2.214”,“6”:1},“3311”:[{“5850”:0,“5851”:254,“9003”:0}]}
2018-05-05 20:28:40.563 [DEBUG] [al.discovery.TradfriDiscoveryService] - Adding device tradfri:0100:gwb072bf27b557:65541 to inbox
2018-05-05 20:28:40.566 [DEBUG] [.tradfri.internal.TradfriCoapHandler] - CoAP response
options: {“Content-Format”:“application/json”, “Max-Age”:604800}
payload: {“9001”:“Stehlampe Wohnzimmer”,“9002”:1497808804,“9020”:1525543030,“9003”:65537,“9054”:0,“5750”:2,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“TRADFRI bulb E27 WS opal 980lm”,“2”:"",“3”:“1.2.217”,“6”:1},“3311”:[{“5850”:0,“5851”:254,“5717”:0,“5710”:27205,“5711”:454,“5709”:33077,“5706”:“efd275”,“9003”:0}]}
2018-05-05 20:28:40.568 [DEBUG] [radfri.handler.TradfriGatewayHandler] - requestDeviceDetails response: {“9001”:“Stehlampe Wohnzimmer”,“9002”:1497808804,“9020”:1525543030,“9003”:65537,“9054”:0,“5750”:2,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“TRADFRI bulb E27 WS opal 980lm”,“2”:"",“3”:“1.2.217”,“6”:1},“3311”:[{“5850”:0,“5851”:254,“5717”:0,“5710”:27205,“5711”:454,“5709”:33077,“5706”:“efd275”,“9003”:0}]}
2018-05-05 20:28:40.570 [DEBUG] [al.discovery.TradfriDiscoveryService] - Adding device tradfri:0220:gwb072bf27b557:65537 to inbox
2018-05-05 20:28:40.574 [DEBUG] [.tradfri.internal.TradfriCoapHandler] - CoAP response
options: {“Content-Format”:“application/json”, “Max-Age”:604800}
payload: {“9001”:“Eingang”,“9002”:1516261759,“9020”:1525518066,“9003”:65544,“9054”:0,“5750”:2,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“TRADFRI bulb E27 W opal 1000lm”,“2”:"",“3”:“1.2.214”,“6”:1},“3311”:[{“5850”:0,“5851”:254,“9003”:0}]}
2018-05-05 20:28:40.576 [DEBUG] [radfri.handler.TradfriGatewayHandler] - requestDeviceDetails response: {“9001”:“Eingang”,“9002”:1516261759,“9020”:1525518066,“9003”:65544,“9054”:0,“5750”:2,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“TRADFRI bulb E27 W opal 1000lm”,“2”:"",“3”:“1.2.214”,“6”:1},“3311”:[{“5850”:0,“5851”:254,“9003”:0}]}
2018-05-05 20:28:40.578 [DEBUG] [al.discovery.TradfriDiscoveryService] - Adding device tradfri:0100:gwb072bf27b557:65544 to inbox
2018-05-05 20:28:40.581 [DEBUG] [.tradfri.internal.TradfriCoapHandler] - CoAP response
options: {“Content-Format”:“application/json”, “Max-Age”:604800}
payload: {“9001”:“Küche”,“9002”:1497809665,“9020”:1525518068,“9003”:65539,“9054”:0,“5750”:2,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“FLOALT panel WS 60x60”,“2”:"",“3”:“1.2.217”,“6”:1},“3311”:[{“5850”:0,“5851”:254,“5717”:0,“5710”:24691,“5711”:250,“5709”:24933,“5706”:“f5faf6”,“9003”:0}]}
2018-05-05 20:28:40.583 [DEBUG] [radfri.handler.TradfriGatewayHandler] - requestDeviceDetails response: {“9001”:“Küche”,“9002”:1497809665,“9020”:1525518068,“9003”:65539,“9054”:0,“5750”:2,“9019”:1,“3”:{“0”:“IKEA of Sweden”,“1”:“FLOALT panel WS 60x60”,“2”:"",“3”:“1.2.217”,“6”:1},“3311”:[{“5850”:0,“5851”:254,“5717”:0,“5710”:24691,“5711”:250,“5709”:24933,“5706”:“f5faf6”,“9003”:0}]}
2018-05-05 20:28:40.585 [DEBUG] [al.discovery.TradfriDiscoveryService] - Adding device tradfri:0220:gwb072bf27b557:65539 to inbox


(Vincent Regaud) #2

There are no [WARNING] there
Please use the code fences when publishing code and logs.