Problem or issues reports

Hi,

No sorry. I do not understand the error message that comes back. It should be numbers in used for HTTP errors (400 or 500 range). What you can try is in the L_Harmony.lua file uncomment the debug lines 1100 and 1127 in the low level wait_response and send_request functions so it shows what goes over the wire to and from the hub.

Cheers Rene

[quote=“reneboer, post:121, topic:191192”]Hi,

No sorry. I do not understand the error message that comes back. It should be numbers in used for HTTP errors (400 or 500 range). What you can try is in the L_Harmony.lua file uncomment the debug lines 1100 and 1127 in the low level wait_response and send_request functions so it shows what goes over the wire to and from the hub.

Cheers Rene[/quote]

Hi Rene,

Sorry for the late reply. I have uncommented the debug lines and this is the result:

2019-01-28 09:13:44.875 luup_log:69: Harmony Control_debug: StartActivity, newActivityID : -1 2019-01-28 09:13:44.875 luup_log:69: Harmony Control_debug: StartActivity, ActivityID : -1 2019-01-28 09:13:44.875 luup_log:69: Harmony Control_debug: Sending command cmd=start_activity 2019-01-28 09:13:44.927 luup_log:69: Harmony Control_debug: Sending command : {"hubId":11770187,"timeout":30,"hbus":{"cmd":"vnd.logitech.connect/vnd.logitech.statedigest?get","id":3,"params":{"verb":"get","format":"json"}}} 2019-01-28 09:13:44.971 luup_log:69: Harmony Control_debug: Received response: {"cmd":"vnd.logitech.connect\/vnd.logitech.statedigest?get","code":200,"id":3,"msg":"OK","data":{"sleepTimerId":-1,"runningZoneList":[],"contentVersion":66,"activityId":"30219462","syncStatus":0,"time":1548663209,"stateVersion":224,"tzOffset":"3600","mode":3,"hubSwVersion":"4.15.206","deviceSetupState":[],"tzoffset":"3600","isSetupComplete":true,"discoveryServer":"http:\/\/svcs.myharmony.com\/Discovery\/Discovery.svc","sequence":false,"discoveryServerCF":"https:\/\/cf-svcs.myharmony.com\/Discovery\/Discovery.svc","updates":[],"activityStatus":2,"wifiStatus":1,"tz":"CET-1CEST,M3.5.0,M10.4.0\/3","activitySetupState":false,"runningActivityList":"30219462","hubUpdate":false,"configVersion":129,"accountId":"10543920"}} 2019-01-28 09:13:44.971 luup_log:69: Harmony Control_debug: Sending command : {"hubId":11770187,"timeout":30,"hbus":{"cmd":"harmony.activityengine?runactivity","id":4,"params":{"async": "true","timestamp": 0,"args":{"rule":"start"},"activityId":"-1"}}} 2019-01-28 09:13:45.299 luup_log:69: Harmony Control_debug: Received response: {"cmd":"harmony.activityengine?runactivity","code":200,"id":4,"msg":"OK"} 2019-01-28 09:13:45.318 luup_log:69: Harmony Control_debug: Received response: {"type":"connect.stateDigest?notify","data":{"sleepTimerId":-1,"runningZoneList":[],"contentVersion":66,"activityId":"30219462","syncStatus":0,"time":1548663209,"stateVersion":225,"tzOffset":"3600","mode":3,"hubSwVersion":"4.15.206","deviceSetupState":[],"tzoffset":"3600","isSetupComplete":true,"discoveryServer":"http:\/\/svcs.myharmony.com\/Discovery\/Discovery.svc","sequence":false,"discoveryServerCF":"https:\/\/cf-svcs.myharmony.com\/Discovery\/Discovery.svc","updates":[],"activityStatus":3,"wifiStatus":1,"tz":"CET-1CEST,M3.5.0,M10.4.0\/3","activitySetupState":false,"runningActivityList":"30219462","hubUpdate":false,"configVersion":129,"accountId":"10543920"}} 2019-01-28 09:13:45.318 luup_log:69: Harmony Control: response is for other message id : 2019-01-28 09:13:45.599 luup_log:69: Harmony Control_debug: Received response: {"cmd":"harmony.engine?startActivity","code":100,"id":4,"msg":"Continue","data":{"done":"1","total":"2","deviceId":"50073836"}} 2019-01-28 09:13:47.523 luup_log:69: Harmony Control_debug: Received response: {"cmd":"harmony.engine?startActivity","code":50073837,"id":4,"data":{"done":"2","total":"2","deviceId":"50073837"}} 2019-01-28 09:13:47.547 luup.variable_set:: 69.urn:rboer-com:serviceId:Harmony1.LinkStatus was: Ok now: Error #hooks:0 2019-01-28 09:13:47.547 luup_log:69: Harmony Control: CMD: errcode=50073837, errmsg=Unknown Harmony response 2019-01-28 09:13:47.548 luup_log:69: Harmony Control: task: CMD: Failed sending command start_activity to Harmony Hub - errorcode=5007 2019-01-28 09:13:47.548 luup.task:: status=2 Harmony Control : CMD: Failed sending command start_activity to Harmony Hub - errorcode=50073837, errormessage=Unknown Harmony response 2019-01-28 09:13:47.548 luup_log:69: Harmony Control: StartActivity, ERROR failed to start Activity... errorcode=50073837, errormessag 2019-01-28 09:13:47.548 luup.variable_set:: 69.urn:rboer-com:serviceId:Harmony1.IconSet was: 2 now: 1 #hooks:0 2019-01-28 09:13:47.548 openLuup.io.server:: HTTP connection from 192.168.1.100 tcp{client}: 0x1f4d178 2019-01-28 09:13:47.552 openLuup.http:: request completed (10897 bytes, 1 chunks, 4083 ms) tcp{client}: 0x2a6ff28 2019-01-28 09:13:47.552 openLuup.http:: GET /data_request?id=action&output_format=json&serviceId=urn:upnp-org:serviceId:SwitchPower1&action=SetTarget&newTargetValue=0&DeviceNum=34 HTTP/1.1 tcp{client}: 0x1f4d178 2019-01-28 09:13:47.552 luup.call_action:: 34.urn:upnp-org:serviceId:SwitchPower1.SetTarget 2019-01-28 09:13:47.552 luup.call_action:: action will be handled by parent: 31 2019-01-28 09:13:47.554 openLuup.http:: request completed (61 bytes, 1 chunks, 1 ms) tcp{client}: 0x1f4d178 2019-01-28 09:13:47.554 luup.io.write:: message length: 37, bytes sent: 37, status: OK tcp{client}: 0x26ec528 2019-01-28 09:13:47.557 luup.io.incoming:: bytes received: 37, status: OK tcp{client}: 0x26ec528 2019-01-28 09:13:47.557 luup.variable_set:: 34.urn:upnp-org:serviceId:SwitchPower1.Status was: 1 now: 0 #hooks:0 2019-01-28 09:13:47.558 luup.io.incoming:: bytes received: 88, status: OK tcp{client}: 0x26ec528 2019-01-28 09:13:47.558 luup.io.incoming:: bytes received: 88, status: OK tcp{client}: 0x26ec528 2019-01-28 09:13:47.558 luup.io.incoming:: bytes received: 63, status: OK tcp{client}: 0x26ec528 2019-01-28 09:13:47.559 luup.io.incoming:: bytes received: 51, status: OK tcp{client}: 0x26ec528 2019-01-28 09:13:47.559 luup.io.incoming:: bytes received: 88, status: OK tcp{client}: 0x26e

I do not really know how to interpret this, but it seems that Harmony Hub is giving me a strange code?

BTW Your custom xml you uploaded is probably overwritten by the new base version, because now the action setTarget doesn’t work again. Can I replace it without problems again with the new base version?

Hi

This is the offending response.

luup_log:69: Harmony Control_debug: Received response: {"cmd":"harmony.engine?startActivity","code":50073837,"id":4,"data":{"done":"2","total":"2","deviceId":"50073837"}}

The code value should be 200 that the activity is started. It is odd your Hub reports this value, as mine has the same firmware version 4.15.206, and I’m not seeing this. You can try the new plugin 3.1 version that is availble on the Mios App market as of today. There I changed some of this logic and this return code should not cause issues (lucky coincidence).

Keep me posted.

Cheers Rene

As of today - 2/18/2018 - it looks like Logitech/Harmony has screwed the pooch again!
I am using your special l_harmony.lua - it has worked fine until today when authentication fails.
An update remote software message also appeared today.

Hi,

Can you look in the Harmony mobile app about the software version?

There is a much newer version of the plugin (V3.5) so you can also try to upgrade to that.

Cheers Rene

Just updated the harmony app to v3.5 manually - it was on v2.29 and did not autoupdate even though the box was checked.
Can connect to a hub running firmware v4.15.206
Will NOT connect to hub running firmware version 4.15.250 (the new one released today).

Hi,

I posted a temporary fix in the topic on this Harmony 4.15.250 software version. Should help for all existing installs.

[Update]: V3.6 is a permanent fix at least till the next Hub software release.

Cheers Rene

Will look for this. Thanks so much.

Hi All,

The V3.6 release will work with Harmony’s latest Hub version. See the Version log topic on how to install.

Cheers Rene

Rene,

I recently ran into an issue with the plugin that I felt was important to raise to your attention. The updated plugin was consuming all available resources on my controller. As a result, none of my other systems, (zwave, etc.) were responding forcing the controller to assume that those devices were no longer online - error from controller was “Can’t detect device.”

Vera Support looked into the issue and found the following:

"The plugin “Harmony” was doing some requests to each device connected to it and those requests were going through Vera, were keeping the engine busy. Based on the logs we found, the Plugin would request each device for status every 1-3 seconds interval, since you have a bunch of them, the engine could not process all the information at the same time with other z-wave requests.

Those requests should not stay always on, basically the request should free the port after each time it did it, but in your case the request would not free the port that the engine uses and since each device did this, the engine was never free to deal with other requests."

For background, this happened recently as I began adding my remaining Harmony remotes/hubs to Vera. Total number of hubs that were configured when the problem occurred was 10.

As of right now, the plugin has been uninstalled. Please advise if you are aware of the issue and if there is a potential fix as I would like to get it working once again.

Thanks,

-Kaz

Hi Kaz,

Is this for the latest 3.8 release? Since a few releases the plugin does not poll any more, but listens for any new data from the Hub on a websocket connection. Although this runs once per second, it is a very light process and my VeraLight does not even shows an increase in CPU usage from it.

However, you say you have 10 hubs, and that is not a load I have ever heard of and I think is beyond what a Vera can handle. With that many I would advise to get a raspberry PI 3 and install openLuup on it. That should be able to handle more, but if ten or more works? It is the first time I hear any one trying with this many.

Success.

Cheers Rene

It was with the 3.8 release. I will give openLuup a try. Thanks.

I updated the f/w on my Asus router and then Harmony Hub is not connecting to Vera. I get an “Hub connection failed. Remote ID could not be retrieved, check IP” error. I checked the IP and it was changed for whatever reason in the Control>Advanced Page to 10.0.0.117 but correct in the Settings Page at 10.0.0.224. I tried adding in the port number to no avail. Removing the port number didn’t change anything either. Not sure how to fix this. Any help would be great. TIA

Apparently my changes back to an ip with no port number didn’t “stick”. After re-doing the change and hitting CNTRL F5 all is well. Sorry to bug.

No problem Sammy2. Just glad there is no real issue.

Cheers Rene

im getting Hub connection failed. Remote ID could not be retrieved, check IP” error, with plugin version of 3.9 and harmony 4.15.250, could you please help me?, I pretty sure the ip is correct

Thx

Hi, Please make sure you have a fixed IP address for the Hub. You can configure this in your WiFi router. Also make sure they are on the same subnet. If in doubt, try a ping from your Vera to the Hub.

Cheers Rene

yup that was it. Sorry to bother I didnt know the vera was connected to other network.

No problem Ernesto. Always worried Harmony made changes to their API again creating a mess. Just glad it is not that.