Page 1 of 1

Plugin restart

PostPosted: Thu Feb 01, 2018 9:30 am
by Umtauscher
Hi,

I have a problem with the Harmony Hub plugin not updating after a day or so.
The plugin is running for some time and suddenly it doesn't report changes in the activities any more.
Then I have to restart the plugin and after a few seconds, the activity state is ok again.

I assume there is some sort of timeout when the hub doesn't report changes to the plugin any more.
Is there a way to set some sort of action that could refresh the hubs client list?

TIA for any hint.
Wilhelm

Re: Plugin restart

PostPosted: Thu Feb 01, 2018 3:10 pm
by FlyingDiver
I'll have to see if there's any way to detect that, so I can do an automatic reconnect. Otherwise an action you could put on a schedule might be best.

Can you create an issue ticket here? https://github.com/FlyingDiver/Indigo-Harmony/issues

Re: Plugin restart

PostPosted: Fri Feb 02, 2018 1:22 am
by Umtauscher
Thanks , I also thought about a scheduled action. unfortunately I can't think of any action that I could start without disturbing the active action, if there is any.
I wouldn't mind being able to trigger a reload but I think at the moment this isn't possible, right?

This morning I found the plugin unaware of the current actin btw.
i will enter the issue at Github.
cheers
wilhelm

Re: Plugin restart

PostPosted: Fri Feb 02, 2018 1:42 am
by Umtauscher
Just some additional information.
I have 2 hubs, I last restarted the plugin yesterday afternoon.
This morning both devices showed the wrong state in Indigo which means the connection must have been broken yesterday evening already.

Re: Plugin restart

PostPosted: Fri Feb 02, 2018 5:43 am
by FlyingDiver
Anything in the log about this?

Re: Plugin restart

PostPosted: Fri Feb 02, 2018 5:52 am
by Umtauscher
No, sorry,
I can see the restart yesterday 16:21
and the restart today 08:09
nothing in between.
Eventlogging is set to "informational messages"

Re: Plugin restart

PostPosted: Fri Feb 02, 2018 6:06 am
by Umtauscher
I just checked setting the level to "debug"
i get
Code: Select all
   Harmony Hub Debug               logLevel = 10
   Harmony Hub Debug               updateFrequency = 86400.0

02.02.2018 12:59:41
   Harmony Hub                     Checking for updates...
   Harmony Hub Debug               Plugin version detected: 7.2.2
   Harmony Hub Debug               Current version is: 7.2.2
   Harmony Hub Debug               Getting latest release from FlyingDiver/Indigo-Harmony...
   Harmony Hub Debug               GET /repos/FlyingDiver/Indigo-Harmony/releases/latest
   Harmony Hub Debug               HTTP 200 OK
   Harmony Hub Debug               Latest release is: 7.2.2
   Harmony Hub                     No updates are available
   Harmony Hub Debug               Harmony Hub Wohnzimmer: messageHandler: Event state notify, activityId = 15546603, activityStatus = 3
   Harmony Hub Debug               Harmony Hub Wohnzimmer: messageHandler: Event state notify, activityId = -1, activityStatus = 0
   Harmony Hub Debug               Harmony Hub Wohnzimmer: messageHandler: Event startActivityFinished, activityId = -1, errorCode = 200, errorString = OK
   Harmony Hub Debug               Harmony Hub Wohnzimmer: messageHandler: Event state notify, activityId = -1, activityStatus = 0


Then I switched off

Code: Select all
   Harmony Hub Debug               Harmony Hub Wohnzimmer: messageHandler: Event state notify, activityId = 15546603, activityStatus = 3
   Harmony Hub Debug               Harmony Hub Wohnzimmer: messageHandler: Event state notify, activityId = -1, activityStatus = 0
   Harmony Hub Debug               Harmony Hub Wohnzimmer: messageHandler: Event startActivityFinished, activityId = -1, errorCode = 200, errorString = OK
   Harmony Hub Debug               Harmony Hub Wohnzimmer: messageHandler: Event state notify, activityId = -1, activityStatus = 0
 

and that seems to be the last thing I see.
switching On doesn't do anything any more.

Re: Plugin restart

PostPosted: Fri Feb 02, 2018 6:27 am
by Umtauscher
... and a second try produces this
Code: Select all
02.02.2018 13:21:57
   Harmony Hub Debug               Harmony Hub Wohnzimmer: messageHandler: Event state notify, activityId = 15546603, activityStatus = 3
   Harmony Hub Debug               Harmony Hub Wohnzimmer: messageHandler: Event state notify, activityId = -1, activityStatus = 0
   Harmony Hub Debug               Harmony Hub Wohnzimmer: messageHandler: Event startActivityFinished, activityId = -1, errorCode = 200, errorString = OK
   Harmony Hub Debug               Harmony Hub Wohnzimmer: messageHandler: Event state notify, activityId = -1, activityStatus = 0
   Trigger                         RX-A3070 standby

02.02.2018 13:22:19
   Harmony Hub Debug               Harmony Hub Wohnzimmer: messageHandler: Event state notify, activityId = 15546603, activityStatus = 1
   Trigger                         RX-A3070 on
   Harmony Hub Debug               Harmony Hub Wohnzimmer: messageHandler: Event state notify, activityId = 15546603, activityStatus = 2
   Harmony Hub Debug               Harmony Hub Wohnzimmer: messageHandler: Event startActivityFinished, activityId = 15546603, errorCode = 200, errorString = OK
   Harmony Hub Debug               Harmony Hub Wohnzimmer: messageHandler: Event state notify, activityId = 15546603, activityStatus = 2


BTW the Trigger for the Receiver Standby and On are created with the GhostXML plugin..
So it seems, sometimes it works sometimes the messages are lost or not sent,

Re: Plugin restart

PostPosted: Fri Feb 02, 2018 10:00 am
by Woetjes
I have the same 'issue' but it's quite rare, once or twice every two weeks or so. I also noticed when I execute a command from Indigo, there is sometimes a delay of 4-5 seconds before the Harmony executes the action. That's happening more often, couple of times per week. I'll turn on debugging to see if I can spot something.

Re: Plugin restart

PostPosted: Sun Feb 04, 2018 7:20 am
by Woetjes
Hi Joe,

Below you can find the log when the delay happened. Do you see anything strange?
I took around 30 seconds to start the activity.

Code: Select all
2018-02-03 19:28:30.612   Harmony Hub Debug   Living: Harmony Hub: Start Activity - 18968386
2018-02-03 19:29:01.173   Harmony Hub Threaddebug   Living: Harmony Hub: messageHandler: Event connect.stateDigest, child.text = {"sleepTimerId":-1,"runningZoneList":[],"configVersion":168,"activityId":"18968386","errorCode":"200","syncStatus":0,"time":1517613228,"stateVersion":1033,"tzOffset":"3600","mode":3,"hubSwVersion":"4.14.123","deviceSetupState":[],"tzoffset":"3600","isSetupComplete":true,"contentVersion":82,"discoveryServer":"https:\/\/svcs.myharmony.com\/Discovery\/Discovery.svc","wifiStatus":1,"activityStatus":1,"runningActivityList":"24822932","tz":"CET-1CEST,M3.4.0,M10.4.0\/3","activitySetupState":false,"updates":{"97":"4.14.112","100":"4.14.112"},"hubUpdate":false,"sequence":false,"accountId":"7827841"}
2018-02-03 19:29:01.174   Harmony Hub Debug   Living: Harmony Hub: messageHandler: Event state notify, activityId = 18968386, activityStatus = 1
2018-02-03 19:29:05.502   Harmony Hub Threaddebug   Living: Harmony Hub: messageHandler: Event connect.stateDigest, child.text = {"sleepTimerId":-1,"runningZoneList":[],"configVersion":168,"activityId":"18968386","errorCode":"200","syncStatus":0,"time":1517613228,"stateVersion":1034,"tzOffset":"3600","mode":3,"hubSwVersion":"4.14.123","deviceSetupState":[],"tzoffset":"3600","isSetupComplete":true,"contentVersion":82,"discoveryServer":"https:\/\/svcs.myharmony.com\/Discovery\/Discovery.svc","wifiStatus":1,"activityStatus":2,"runningActivityList":"24822932","tz":"CET-1CEST,M3.4.0,M10.4.0\/3","activitySetupState":false,"updates":{"97":"4.14.112","100":"4.14.112"},"hubUpdate":false,"sequence":false,"accountId":"7827841"}
2018-02-03 19:29:05.503   Harmony Hub Debug   Living: Harmony Hub: messageHandler: Event state notify, activityId = 18968386, activityStatus = 2
2018-02-03 19:29:05.518   Harmony Hub Threaddebug   Living: Harmony Hub: messageHandler: Event startActivityFinished, child.text = errorCode=200:errorString=OK:activityId=18968386
2018-02-03 19:29:05.519   Harmony Hub Debug   Living: Harmony Hub: messageHandler: Event startActivityFinished, activityId = 18968386, errorCode = 200, errorString = OK