Tahoma Binding compatible with OH2

Ondrej_Pecta · December 9, 2019, 8:02pm

Thanks. Now it is obvious:
the request

https://www.tahomalink.com/enduser-mobile-web/externalAPI/json/refreshAllStates

is from the old version of Tahoma binding.
So either you are running both versions or there are some remains of the old binding in the OH2 cache.
Could you please check that you are running only the latest V2 binding and clear the caches?
(Clear the Cache)

thanks.
Ondrej

bartsnijder · December 9, 2019, 9:14pm

Clearing the cache did it for me. Thanks!

dafdegiraf · December 10, 2019, 11:27am

i am running 2.4 of openhab on windows machine
How do i update the somfy binding?

Ondrej_Pecta · December 10, 2019, 11:40am

please see post #324 and #329

dafdegiraf · December 10, 2019, 11:45am

how do i change the MANIFEST.MF file in META-INF dir in the provided jar?
Do i extract this jar file?

But in the mean while it is working !!! YES!

andreas.marti · December 14, 2019, 7:59am

Dear Ondrej, thank you for your very fast support! I’m running:
OH 2.4 on Docker (qnap)
downloaded your new .jar file into addons directory (nothing happend)
Now I’ve seen your hint about “com.google.gson”…seems to be mandatory, right?
Could you please share a explanation of about what exactly I have to do? Would be great!

Thank you, Andreas

Ondrej_Pecta · December 14, 2019, 7:08pm

Use for example Total Commander to

open the jar file (CRTL+PG DOWN)
find the MANIFEST.MF in META-INF subdirectory
edit the file with F4 as mentined in post #324
save the file
update the jar when asked

andreas.marti · December 15, 2019, 8:53am

Dear Ondej,
YES! This did it. I did not realize, there are subfolders since I only saw one file in my “normal” file exploer. Thank you very much!
Do you think, Somfy will change their access rules another time, so there is a risk the binding coult become obsolete? Would be a disaster…
Thanks again, Andreas

vossivossi · December 15, 2019, 9:34am

That is the general risk with all “cloud only” based solutions. There have already been several negative examples recently like Logitech Harmony or Nest.

janwilke · December 16, 2019, 4:14pm

Dear Ondrej, I still have an issue with the new binding.
I already cleaned up the cache, but still the Bridge is more often offline.
Do you have an idea? Current setup:

ii openhab2 2.4.0-1 all openhab2
ii openhab2-addons 2.4.0-1 all openhab2-addons

bundle:list
53 │ Active │ 80 │ 2.5.0.201908161758 │ openHAB Add-ons :: Bundles :: SomfyTahoma Binding

LogInfo:
https://pastebin.com/Cyk0HmC7

Ondrej_Pecta · December 16, 2019, 6:06pm

Hi,

unfortunately the log still shows a mixture of the old and the new binding.
Please delete the binding, stop OH2, clean caches, start OH2 and install the new jar into the addons directory.

I hope this helps…
thanks
Ondrej

janwilke · December 16, 2019, 8:38pm

Hey, I could solve it be deleting all Somfy Bindings, upgrading to Oh2.5, Cleaning the cache and reinstalling the new Somfy Binding. Thanks a lot… no errors till yet.

AldoHa · December 23, 2019, 9:30am

Openhab 2.5.0
openhab> bundle:list |grep Somfy
289 │ Active │ 80 │ 2.5.0 │ openHAB Add-ons :: Bundles :: SomfyTahoma Binding
Somfy connexoon
Current firmware version: 2019.5.4

Hi all,

I hope people can advise me or point me in the right direction to further investigate my issue.
As I am making my way through Openhab and the Tahoma binding.

The issue started after Somfy updated their app to the new API.
The timers within the app were used, and only when manual intervention was needed I use the Tahoma binding.

Now both timers within the app, and Openhab are struggling with the following what ends up in random functionality.
Binding/shutter are offline.

==========
Too many requests error, suspending activity for 120 seconds
==========**

==========
2019-12-23 08:50:10.669 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Cannot get login cookie!
java.util.concurrent.TimeoutException: Total timeout 5000 ms elapsed
** at org.eclipse.jetty.client.HttpDestination$TimeoutTask.onTimeoutExpired(HttpDestination.java:529) ~[?:?]**
** at org.eclipse.jetty.io.CyclicTimeout$Wakeup.run(CyclicTimeout.java:282) ~[?:?]**
** at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:1.8.0_212]**
** at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:1.8.0_212]**
** at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180) [?:1.8.0_212]**
** at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293) [?:1.8.0_212]**
** at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_212]**
** at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_212]**
** at java.lang.Thread.run(Thread.java:748) [?:1.8.0_212] **
==========

As people were speaking about too many requests, the “refresh” and “status time out” was brought back to 300.
As well as the debug logs, as network dump showing in my opinion that I connect every 5 min and still getting the above errors.

Any help from the audience is welcome.

Kind regards.
Aldo

**2019-12-23 09:20:22.371 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Refreshing Tahoma states...**

2019-12-23 09:20:22.372 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Doing relogin

2019-12-23 09:20:22.408 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Getting Tahoma Updates...

2019-12-23 09:20:22.409 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Doing relogin

2019-12-23 09:20:23.187 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Login response: {"success":true,"roles":[{"name":"ENDUSER"}]}

2019-12-23 09:20:23.189 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - SomfyTahoma version:

2019-12-23 09:20:23.190 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Sending POST to Tahoma to url: https://www.tahomalink.com/enduser-mobile-web/enduserAPI/events/register with data:

2019-12-23 09:20:23.233 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Response: {"id":"31dxxxxx-d9b6-xxxx-1304-85907c3xxxxx"}

2019-12-23 09:20:23.235 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Events id: 31dxxxxx-d9b6-xxxx-1304-85907c3xxxxx

2019-12-23 09:20:23.244 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Sending GET to Tahoma to url: https://www.tahomalink.com/enduser-mobile-web/enduserAPI/setup/gateways/xxxx-7588-xxxx

2019-12-23 09:20:23.285 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Response: {"partners":[{"activated":true,"status":"OWNER","name":"Somfy Netherlands","id":"somfy-nl"}],"functions":"INTERNET_AUTHORIZATION,SCENARIO_DOWNLOAD,SCENARIO_AUTO_LAUNCHING,SCENARIO_TELECO_LAUNCHING,INTERNET_UPLOAD,INTERNET_UPDATE,TRIGGERS_SENSORS","gatewayId":"xxxx-7588-xxxx","subType":3,"alive":true,"mode":"ACTIVE","placeOID":"xxxxxxxx-xxxx-xxxxx-xxxx-xxxxxxxxxxxx","upToDate":true,"updateStatus":"UP_TO_DATE","syncInProgress":false,"timeReliable":true,"connectivity":{"status":"OK","protocolVersion":"2019.5.4"},"type":34}

2019-12-23 09:20:23.287 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Tahoma status: OK

2019-12-23 09:20:23.288 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Tahoma protocol version: 2019.5.4

2019-12-23 09:20:23.289 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Sending PUT to Tahoma to url: https://www.tahomalink.com/enduser-mobile-web/enduserAPI/setup/devices/states/refresh

2019-12-23 09:20:23.330 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Too many requests error, suspending activity for 120 seconds

2019-12-23 09:20:23.419 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Response: {}

2019-12-23 09:25:23.331 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Getting Tahoma Updates...

2019-12-23 09:25:23.331 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Doing relogin

2019-12-23 09:25:23.420 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Refreshing Tahoma states...

2019-12-23 09:25:23.422 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Doing relogin

2019-12-23 09:25:24.083 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Login response: {"success":true,"roles":[{"name":"ENDUSER"}]}

2019-12-23 09:25:24.084 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - SomfyTahoma version:

2019-12-23 09:25:24.086 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Sending POST to Tahoma to url: https://www.tahomalink.com/enduser-mobile-web/enduserAPI/events/register with data:

2019-12-23 09:25:24.137 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Response: {"id":"xxxxxxxx-xxxx-xxxx-xxxxx-xxxxxxxxxxx"}

2019-12-23 09:25:24.139 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Events id: xxxxxxxx-xxxx-xxxx-xxxxx-xxxxxxxxxxx

2019-12-23 09:25:24.144 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Sending GET to Tahoma to url: https://www.tahomalink.com/enduser-mobile-web/enduserAPI/setup/gateways/xxxx-7588-xxxx

2019-12-23 09:25:24.186 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Response: {"partners":[{"activated":true,"status":"OWNER","name":"Somfy Netherlands","id":"somfy-nl"}],"functions":"INTERNET_AUTHORIZATION,SCENARIO_DOWNLOAD,SCENARIO_AUTO_LAUNCHING,SCENARIO_TELECO_LAUNCHING,INTERNET_UPLOAD,INTERNET_UPDATE,TRIGGERS_SENSORS","gatewayId":"xxxx-7588-xxxx","subType":3,"alive":true,"mode":"ACTIVE","placeOID":"xxxxxxxx-xxxx-xxxxx-xxxx-xxxxxxxxxxxx","upToDate":true,"updateStatus":"UP_TO_DATE","syncInProgress":false,"timeReliable":true,"connectivity":{"status":"OK","protocolVersion":"2019.5.4"},"type":34}

2019-12-23 09:25:24.188 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Tahoma status: OK

2019-12-23 09:25:24.189 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Tahoma protocol version: 2019.5.4

2019-12-23 09:25:24.191 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Sending POST to Tahoma to url: https://www.tahomalink.com/enduser-mobile-web/enduserAPI/events/xxxxxxxx-xxxx-xxxx-xxxxx-xxxxxxxxxxx/fetch with data:

2019-12-23 09:25:24.234 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Too many requests error, suspending activity for 120 seconds

2019-12-23 09:25:24.271 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Response: []

2019-12-23 09:25:24.273 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Got total of 0 events

2019-12-23 09:30:24.235 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Refreshing Tahoma states...

2019-12-23 09:30:24.237 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Doing relogin

2019-12-23 09:30:24.274 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Getting Tahoma Updates...

2019-12-23 09:30:24.276 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Doing relogin

2019-12-23 09:30:25.030 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Login response: {"success":true,"roles":[{"name":"ENDUSER"}]}

2019-12-23 09:30:25.032 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - SomfyTahoma version:

2019-12-23 09:30:25.033 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Sending POST to Tahoma to url: https://www.tahomalink.com/enduser-mobile-web/enduserAPI/events/register with data:

2019-12-23 09:30:25.076 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Response: {"id":"xxxxxxxx-xxxx-xxxxx-xxxx-xxxxxxxxxxxxxxxxx"}

2019-12-23 09:30:25.078 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Events id: xxxxxxxx-xxxx-xxxxx-xxxx-xxxxxxxxxxxxxxxxx

2019-12-23 09:30:25.085 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Sending GET to Tahoma to url: https://www.tahomalink.com/enduser-mobile-web/enduserAPI/setup/gateways/xxxx-7588-xxxx

2019-12-23 09:30:25.125 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Response: {"partners":[{"activated":true,"status":"OWNER","name":"Somfy Netherlands","id":"somfy-nl"}],"functions":"INTERNET_AUTHORIZATION,SCENARIO_DOWNLOAD,SCENARIO_AUTO_LAUNCHING,SCENARIO_TELECO_LAUNCHING,INTERNET_UPLOAD,INTERNET_UPDATE,TRIGGERS_SENSORS","gatewayId":"xxxx-7588-xxxx","subType":3,"alive":true,"mode":"ACTIVE","placeOID":"xxxxxxxx-xxxx-xxxxx-xxxx-xxxxxxxxxxxx","upToDate":true,"updateStatus":"UP_TO_DATE","syncInProgress":false,"timeReliable":true,"connectivity":{"status":"OK","protocolVersion":"2019.5.4"},"type":34}

2019-12-23 09:30:25.127 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Tahoma status: OK

2019-12-23 09:30:25.128 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Tahoma protocol version: 2019.5.4

2019-12-23 09:30:25.130 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Sending PUT to Tahoma to url: https://www.tahomalink.com/enduser-mobile-web/enduserAPI/setup/devices/states/refresh

2019-12-23 09:30:25.171 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Too many requests error, suspending activity for 120 seconds

2019-12-23 09:30:25.267 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Response: {}

2019-12-23 09:35:25.173 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Getting Tahoma Updates...

2019-12-23 09:35:25.175 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Doing relogin

2019-12-23 09:35:25.269 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Refreshing Tahoma states...

2019-12-23 09:35:25.270 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Doing relogin

2019-12-23 09:35:25.389 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Too many requests error, suspending activity for 120 seconds

2019-12-23 09:35:25.390 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Skipping login due to too many requests

2019-12-23 09:40:25.391 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Getting Tahoma Updates...

2019-12-23 09:40:25.392 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Refreshing Tahoma states...

2019-12-23 09:40:25.392 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Doing relogin

2019-12-23 09:40:25.392 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Doing relogin

2019-12-23 09:40:26.382 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Login response: {"success":true,"roles":[{"name":"ENDUSER"}]}

2019-12-23 09:40:26.384 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - SomfyTahoma version:

2019-12-23 09:40:26.385 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Sending POST to Tahoma to url: https://www.tahomalink.com/enduser-mobile-web/enduserAPI/events/register with data:

2019-12-23 09:40:26.429 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Response: {"id":"xxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxxxx"}

2019-12-23 09:40:26.431 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Events id: xxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxxxx

2019-12-23 09:40:26.437 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Sending GET to Tahoma to url: https://www.tahomalink.com/enduser-mobile-web/enduserAPI/setup/gateways/xxxx-7588-xxxx

2019-12-23 09:40:26.479 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Response: {"partners":[{"activated":true,"status":"OWNER","name":"Somfy Netherlands","id":"somfy-nl"}],"functions":"INTERNET_AUTHORIZATION,SCENARIO_DOWNLOAD,SCENARIO_AUTO_LAUNCHING,SCENARIO_TELECO_LAUNCHING,INTERNET_UPLOAD,INTERNET_UPDATE,TRIGGERS_SENSORS","gatewayId":"xxxx-7588-xxxx","subType":3,"alive":true,"mode":"ACTIVE","placeOID":"xxxxxxxx-xxxx-xxxxx-xxxx-xxxxxxxxxxxx","upToDate":true,"updateStatus":"UP_TO_DATE","syncInProgress":false,"timeReliable":true,"connectivity":{"status":"OK","protocolVersion":"2019.5.4"},"type":34}

2019-12-23 09:40:26.480 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Tahoma status: OK

2019-12-23 09:40:26.480 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Tahoma protocol version: 2019.5.4

2019-12-23 09:40:26.483 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Sending POST to Tahoma to url: https://www.tahomalink.com/enduser-mobile-web/enduserAPI/events/xxxxxxx-xxxx-xxxx-xxxx-xxxxxxxxxxxxx/fetch with data:

2019-12-23 09:40:26.522 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Too many requests error, suspending activity for 120 seconds

2019-12-23 09:40:26.609 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Response: []

2019-12-23 09:40:26.609 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Got total of 0 events

riederd · December 23, 2019, 10:41am

Hi,

I see the same issue here. I control about 25 Somfy devices using OH2.5 with the newest binding installed (caches emptied).

The tahoma bridge reports: OFFLINE - COMMUNICATION_ERROR Cannot get login cookie
Refresh time: 30 sec
Status timeout: 300 sec

Best

Ondrej_Pecta · December 23, 2019, 12:11pm

Hi, thanks for the log.
It seems that some timeout network problem occured which results in two login attempts in a queue and the second one causes the Too Many Requests error.
Can you please try this version and send the log?

https://www.dropbox.com/s/wxbc1zhdzvy8y4s/org.openhab.binding.somfytahoma-2.5.1-SNAPSHOT.jar?dl=1

the only change is an extra check for the bridge status - it does not reattempt to log in, if the status is already ONLINE.

Let’s see if it helps.
Ondrej

AldoHa · December 23, 2019, 2:01pm

Hi Ondrej,

Thanks from here,

Hereby the first entries from the log files which looks in the first view to prevent the double authentication to happen. I will further monitor it.

Can I make up that the following is more related to network issues, as well on my side as with Tahoma?

Cannot get Tahoma events!
Cannot get login cookie!

 2019-12-23 13:41:17.202 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Getting Tahoma Updates...
2019-12-23 13:41:17.205 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Sending POST to Tahoma to url: https://www.tahomalink.com/enduser-mobile-web/enduserAPI/events/xxxxxxxxx-xxxxxxxx-xxxxxxx-x-xxxxx/fetch with data: 
2019-12-23 13:41:17.529 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - No need to log in, because already logged in
2019-12-23 13:41:17.530 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Got total of 0 events
2019-12-23 13:42:07.452 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Refreshing Tahoma states...
2019-12-23 13:42:07.453 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Sending PUT to Tahoma to url: https://www.tahomalink.com/enduser-mobile-web/enduserAPI/setup/devices/states/refresh
2019-12-23 13:42:09.040 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - No need to log in, because already logged in
2019-12-23 13:46:17.531 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Getting Tahoma Updates...
2019-12-23 13:46:17.534 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Sending POST to Tahoma to url: https://www.tahomalink.com/enduser-mobile-web/enduserAPI/events/xxxxxxxxx-xxxxxxxx-xxxxxxx-x-xxxxx/fetch with data: 
2019-12-23 13:46:22.539 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Cannot get Tahoma events!
java.util.concurrent.TimeoutException: Total timeout 5000 ms elapsed
	at org.eclipse.jetty.client.HttpDestination$TimeoutTask.onTimeoutExpired(HttpDestination.java:529) ~[?:?]
	at org.eclipse.jetty.io.CyclicTimeout$Wakeup.run(CyclicTimeout.java:282) ~[?:?]
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:1.8.0_212]
	at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:1.8.0_212]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180) [?:1.8.0_212]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293) [?:1.8.0_212]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_212]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_212]
	at java.lang.Thread.run(Thread.java:748) [?:1.8.0_212]
2019-12-23 13:46:22.560 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Got total of 0 events
2019-12-23 13:47:09.041 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Refreshing Tahoma states...
2019-12-23 13:47:09.043 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Doing relogin
2019-12-23 13:47:11.734 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Login response: {"success":true,"roles":[{"name":"ENDUSER"}]}
2019-12-23 13:47:11.736 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - SomfyTahoma version: 
2019-12-23 13:47:11.738 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Sending POST to Tahoma to url: https://www.tahomalink.com/enduser-mobile-web/enduserAPI/events/register with data: 
2019-12-23 13:47:11.785 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Response: {"id":"xxxxx-xxxx-xxxx "}
2019-12-23 13:47:11.788 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Events id: xxxxx-xxxx-xxxx 
2019-12-23 13:47:11.792 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Sending GET to Tahoma to url: https://www.tahomalink.com/enduser-mobile-web/enduserAPI/setup/gateways/xxxxx-xxxx-xxxx 
2019-12-23 13:47:11.837 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Response: {"partners":[{"activated":true,"status":"OWNER","name":"Somfy Netherlands","id":"somfy-nl"}],"functions":"INTERNET_AUTHORIZATION,SCENARIO_DOWNLOAD,SCENARIO_AUTO_LAUNCHING,SCENARIO_TELECO_LAUNCHING,INTERNET_UPLOAD,INTERNET_UPDATE,TRIGGERS_SENSORS","gatewayId":"xxxxx-xxxx-xxxx ","subType":3,"alive":true,"mode":"ACTIVE","placeOID":"xxxxx-xxxx-xxxx ","upToDate":true,"updateStatus":"UP_TO_DATE","syncInProgress":false,"timeReliable":true,"connectivity":{"status":"OK","protocolVersion":"2019.5.4"},"type":34}
2019-12-23 13:47:11.839 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Tahoma status: OK
2019-12-23 13:47:11.840 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Tahoma protocol version: 2019.5.4
2019-12-23 13:47:11.841 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Updating all states
2019-12-23 13:47:11.842 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Sending GET to Tahoma to url: https://www.tahomalink.com/enduser-mobile-web/enduserAPI/setup


==SNIP==

2019-12-23 13:47:13.325 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Response: {}
^[^[2019-12-23 13:51:22.564 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Getting Tahoma Updates...
2019-12-23 13:51:22.566 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Sending POST to Tahoma to url: https://www.tahomalink.com/enduser-mobile-web/enduserAPI/events/xxxxx-xxxx-xxxx /fetch with data: 
2019-12-23 13:51:27.570 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Cannot get Tahoma events!
java.util.concurrent.TimeoutException: Total timeout 5000 ms elapsed
	at org.eclipse.jetty.client.HttpDestination$TimeoutTask.onTimeoutExpired(HttpDestination.java:529) ~[?:?]
	at org.eclipse.jetty.io.CyclicTimeout$Wakeup.run(CyclicTimeout.java:282) ~[?:?]
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:1.8.0_212]
	at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:1.8.0_212]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180) [?:1.8.0_212]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293) [?:1.8.0_212]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_212]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_212]
	at java.lang.Thread.run(Thread.java:748) [?:1.8.0_212]
2019-12-23 13:51:27.590 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Got total of 0 events
2019-12-23 13:52:13.326 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Refreshing Tahoma states...
2019-12-23 13:52:13.327 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Doing relogin
2019-12-23 13:52:15.581 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Login response: {"success":true,"roles":[{"name":"ENDUSER"}]}
2019-12-23 13:52:15.583 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - SomfyTahoma version: 
2019-12-23 13:52:15.585 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Sending POST to Tahoma to url: https://www.tahomalink.com/enduser-mobile-web/enduserAPI/events/register with data: 
2019-12-23 13:52:15.631 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Response: {"id":"xxxxx-xxxx-xxxx "}
2019-12-23 13:52:15.633 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Events id: xxxxx-xxxx-xxxx 
2019-12-23 13:52:15.635 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Sending GET to Tahoma to url: https://www.tahomalink.com/enduser-mobile-web/enduserAPI/setup/gateways/xxxxx-xxxx-xxxx 
2019-12-23 13:52:15.679 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Response: {"partners":[{"activated":true,"status":"OWNER","name":"Somfy Netherlands","id":"somfy-nl"}],"functions":"INTERNET_AUTHORIZATION,SCENARIO_DOWNLOAD,SCENARIO_AUTO_LAUNCHING,SCENARIO_TELECO_LAUNCHING,INTERNET_UPLOAD,INTERNET_UPDATE,TRIGGERS_SENSORS","gatewayId":"xxxxx-xxxx-xxxx ","subType":3,"alive":true,"mode":"ACTIVE","placeOID":"xxxxx-xxxx-xxxx ","upToDate":true,"updateStatus":"UP_TO_DATE","syncInProgress":false,"timeReliable":true,"connectivity":{"status":"OK","protocolVersion":"2019.5.4"},"type":34}
2019-12-23 13:52:15.681 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Tahoma status: OK
2019-12-23 13:52:15.682 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Tahoma protocol version: 2019.5.4
2019-12-23 13:52:15.683 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Updating all states
2019-12-23 13:52:15.684 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Sending GET to Tahoma to url: https://www.tahomalink.com/enduser-mobile-web/enduserAPI/setup


2019-12-23 14:32:00.762 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Cannot get Tahoma events!
java.util.concurrent.TimeoutException: Total timeout 5000 ms elapsed
	at org.eclipse.jetty.client.HttpDestination$TimeoutTask.onTimeoutExpired(HttpDestination.java:529) ~[?:?]
	at org.eclipse.jetty.io.CyclicTimeout$Wakeup.run(CyclicTimeout.java:282) ~[?:?]
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:1.8.0_212]
	at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:1.8.0_212]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180) [?:1.8.0_212]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293) [?:1.8.0_212]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_212]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_212]
	at java.lang.Thread.run(Thread.java:748) [?:1.8.0_212]
2019-12-23 14:32:00.778 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Got total of 0 events
2019-12-23 14:32:43.585 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Refreshing Tahoma states...
2019-12-23 14:32:43.586 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Doing relogin
2019-12-23 14:32:48.599 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Cannot get login cookie!
java.util.concurrent.TimeoutException: Total timeout 5000 ms elapsed
	at org.eclipse.jetty.client.TimeoutCompleteListener.onTimeoutExpired(TimeoutCompleteListener.java:51) ~[?:?]
	at org.eclipse.jetty.io.CyclicTimeout$Wakeup.run(CyclicTimeout.java:282) ~[?:?]
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:1.8.0_212]
	at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:1.8.0_212]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180) [?:1.8.0_212]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293) [?:1.8.0_212]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_212]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_212]
	at java.lang.Thread.run(Thread.java:748) [?:1.8.0_212]
2019-12-23 14:37:00.780 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Getting Tahoma Updates...
2019-12-23 14:37:00.782 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Doing relogin
2019-12-23 14:37:05.787 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Cannot get login cookie!
java.util.concurrent.TimeoutException: Total timeout 5000 ms elapsed
	at org.eclipse.jetty.client.TimeoutCompleteListener.onTimeoutExpired(TimeoutCompleteListener.java:51) ~[?:?]
	at org.eclipse.jetty.io.CyclicTimeout$Wakeup.run(CyclicTimeout.java:282) ~[?:?]
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:1.8.0_212]
	at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:1.8.0_212]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180) [?:1.8.0_212]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293) [?:1.8.0_212]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_212]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_212]
	at java.lang.Thread.run(Thread.java:748) [?:1.8.0_212]
2019-12-23 14:37:48.609 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Refreshing Tahoma states...
2019-12-23 14:37:48.610 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Doing relogin
2019-12-23 14:37:53.613 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Cannot get login cookie!
java.util.concurrent.TimeoutException: Total timeout 5000 ms elapsed
	at org.eclipse.jetty.client.HttpDestination$TimeoutTask.onTimeoutExpired(HttpDestination.java:529) ~[?:?]
	at org.eclipse.jetty.io.CyclicTimeout$Wakeup.run(CyclicTimeout.java:282) ~[?:?]
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:1.8.0_212]
	at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:1.8.0_212]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180) [?:1.8.0_212]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293) [?:1.8.0_212]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_212]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_212]
	at java.lang.Thread.run(Thread.java:748) [?:1.8.0_212]
2019-12-23 14:42:05.798 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Getting Tahoma Updates...
2019-12-23 14:42:05.799 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Doing relogin
2019-12-23 14:42:10.802 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Cannot get login cookie!
java.util.concurrent.TimeoutException: Total timeout 5000 ms elapsed
	at org.eclipse.jetty.client.HttpDestination$TimeoutTask.onTimeoutExpired(HttpDestination.java:529) ~[?:?]
	at org.eclipse.jetty.io.CyclicTimeout$Wakeup.run(CyclicTimeout.java:282) ~[?:?]
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:1.8.0_212]
	at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:1.8.0_212]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180) [?:1.8.0_212]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293) [?:1.8.0_212]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_212]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_212]
	at java.lang.Thread.run(Thread.java:748) [?:1.8.0_212]
2019-12-23 14:42:53.624 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Refreshing Tahoma states...
2019-12-23 14:42:53.626 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Doing relogin
2019-12-23 14:42:58.629 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Cannot get login cookie!
java.util.concurrent.TimeoutException: Total timeout 5000 ms elapsed
	at org.eclipse.jetty.client.TimeoutCompleteListener.onTimeoutExpired(TimeoutCompleteListener.java:51) ~[?:?]
	at org.eclipse.jetty.io.CyclicTimeout$Wakeup.run(CyclicTimeout.java:282) ~[?:?]
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:1.8.0_212]
	at java.util.concurrent.FutureTask.run(FutureTask.java:266) [?:1.8.0_212]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180) [?:1.8.0_212]
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293) [?:1.8.0_212]
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:1.8.0_212]
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:1.8.0_212]
	at java.lang.Thread.run(Thread.java:748) [?:1.8.0_212]
2019-12-23 14:47:10.815 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Getting Tahoma Updates...
2019-12-23 14:47:10.816 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Doing relogin
2019-12-23 14:47:11.750 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Login response: {"success":true,"roles":[{"name":"ENDUSER"}]}
2019-12-23 14:47:11.752 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - SomfyTahoma version: 
2019-12-23 14:47:11.753 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Sending POST to Tahoma to url: https://www.tahomalink.com/enduser-mobile-web/enduserAPI/events/register with data: 
2019-12-23 14:47:11.800 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Response: {"id":"xxxxx-xxxx-xxxx "}
2019-12-23 14:47:11.801 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Events id: xxxxx-xxxx-xxxx 
2019-12-23 14:47:11.815 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Sending GET to Tahoma to url: https://www.tahomalink.com/enduser-mobile-web/enduserAPI/setup/gateways/xxxxx-xxxx-xxxx 
2019-12-23 14:47:11.859 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Response: {"partners":[{"activated":true,"status":"OWNER","name":"Somfy Netherlands","id":"somfy-nl"}],"functions":"INTERNET_AUTHORIZATION,SCENARIO_DOWNLOAD,SCENARIO_AUTO_LAUNCHING,SCENARIO_TELECO_LAUNCHING,INTERNET_UPLOAD,INTERNET_UPDATE,TRIGGERS_SENSORS","gatewayId":"xxxxx-xxxx-xxxx ","subType":3,"alive":true,"mode":"ACTIVE","placeOID":"xxxxx-xxxx-xxxx ","upToDate":true,"updateStatus":"UP_TO_DATE","syncInProgress":false,"timeReliable":true,"connectivity":{"status":"OK","protocolVersion":"2019.5.4"},"type":34}
2019-12-23 14:47:11.860 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Tahoma status: OK
2019-12-23 14:47:11.861 [DEBUG] [nal.handler.SomfyTahomaBridgeHandler] - Tahoma protocol version: 2019.5.4
2019-12-23 14:47:11.862 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Sending POST to Tahoma to url: https://www.tahomalink.com/enduser-mobile-web/enduserAPI/events/xxxxx-xxxx-xxxx /fetch with data: 
2019-12-23 14:47:11.907 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Response: []
2019-12-23 14:47:11.908 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Got total of 0 events
2019-12-23 14:47:19.600 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Sending GET to Tahoma to url: https://www.tahomalink.com/enduser-mobile-web/enduserAPI/setup
2019-12-23 14:47:19.845 [TRACE] [nal.handler.SomfyTahomaBridgeHandler] - Response:

Ondrej_Pecta · December 23, 2019, 2:21pm

Hmm, the quick fix really recovers the binding from “Too many requests” error caused by more logins in a row, but the root cause of your problem seems to be some kind of network timeouts
The binding cannot get new events within 5 seconds…
Ondrej

luismauriz11 · December 26, 2019, 11:15am

Hello Guys, I have a Problem with the Tahoma Binding at OH 2.5. Since the recent changes to the API 2 at Tahoma, the MY Position at my Rollershutters isn’t working anymore. At the API V1 I allways used the command
sendCommand(Item, STOP) And that worked fine.
But at the new System with the new API and OH 2.5, the Command isnt`t working anymore.
Is there a different command to come to the MY Position?
Thanks for your help!

Ondrej_Pecta · December 26, 2019, 5:45pm

Hi,

you are right. There were some remains of the v1 API in the code related to handing of execution states. I have fixed it.
Please, could you try this version?
https://www.dropbox.com/s/wxbc1zhdzvy8y4s/org.openhab.binding.somfytahoma-2.5.1-SNAPSHOT.jar?dl=1
Thanks for testing…
Ondrej

Stylewarz3 · December 27, 2019, 8:56am

Hello Ondrej, I installed openHAB 2.5.0-1 and the tahoma binding somfytahoma-3.0.0-SNAPSHOT.jar.

Suddenly there are no more items for the Somfy Izymo devices. Only things. Can you help me here? I need the items for my sitemap.

Thank you very much