Haiku HaikuHelper causing OP2 System Resets

sjht

Active Member
After struggling to find out what is causing random system restarts of my OP2, I finally discovered that HaikuHelper seems to be causing this.  The event log of my OP2, shows 6-7 systems resets every few days always happening at around 1:40 a.m.  This also causes my OT7 to loose connectivity to the panel.  In reviewing the HaikuHelper log, it is when the application is syncing to the system.  The event listing and HaikuHelper log corresponds exactly when this issue is happening.  I really only use HaikuHelper for notifications and therefore have turned it off.  Any feedback on why this is happening?  Can I turn off syncing as not sure why I need to do this unless I've made changes to the system.    Thanks.  SJ
 
Do you have clock sync enabled? Any other options such as climate, etc enabled in HaikuHelper?

Could you possibly paste or PM me the last portion of the log when this occurs? You can blank out private info from it.
 
I just checked and there is nothing special programmed into HaikuHelper at 1:40 AM. There are just regular syncs scheduled as such:

Hourly - Update Rain Advisory flag (if enabled)
Every 30 minutes on the hour and 5 minutes after - Update energy cost (if enabled)
Every 10 minutes - thermostat frost protection routines (if enabled)
3:17 AM - Update controller configuration
3:06 AM - optimize and trim database
4:06 AM - Sync controller clock (if enabled)

So based on this schedule, its likely the sync being performed is the frost protection sync, which happens every 10 minutes.

Also check if you have any scripts perhaps in HaikuHelper that are based on time? I know you said you don't use it for anything but push notifications, but its a good idea to verify these things when troubleshooting.
 
I have none of the flags on (rain, energy, frost, clock sync, etc.).  I did try a manual sync and it worked without issues (did it several times).  I'm now starting to wonder whether shutting down HaikuHelper and restarting has helped as I probably haven't done that in a while.  The mac runs 24x7 with various things running all the time.   The log file seems to have been cleared (maybe with a restart), so I can't send that information to you.  Let me run this for the next few days to see if the issue pops up again.  Thanks.  SJ
 
Well, did it again last night.  Had four System Reset events in the OP2 log.  First one at 1:38 a.m. and the next three at 1:49 a.m.  Log file from HaikuHelper (Xed out name):
 
2015-05-27 23:06:16 Notification » XXXXXXXXXXX: Area 1 Armed Night
2015-05-27 23:06:16 Notification » Push » XXXXXXXXXXX: Sending push notification: Area 1 Armed Night
2015-05-28 1:40:00 Notification » XXXXXXXXXXX: Connection to controller interrupted
2015-05-28 1:40:00 Notification » Push » XXXXXXXXXXX: Sending push notification: Connection to controller interrupted
2015-05-28 1:40:15 Notification » XXXXXXXXXXX: Connection to controller established
2015-05-28 1:40:15 Notification » Push » XXXXXXXXXXX: Sending push notification: Connection to controller established
2015-05-28 1:40:15 Sync » XXXXXXXXXXX: Syncing stage 2 of 5: Controller Configuration (Reading Configuration)…
2015-05-28 1:40:38 Sync » XXXXXXXXXXX: Syncing stage 3 of 5: Controller Configuration (Loading Objects)…
2015-05-28 1:40:39 Sync » XXXXXXXXXXX: Syncing stage 4 of 5: Controller Configuration (Saving)…
2015-05-28 1:50:39 Notification » XXXXXXXXXXX: Connection to controller interrupted
2015-05-28 1:50:39 Notification » Push » XXXXXXXXXXX: Sending push notification: Connection to controller interrupted
2015-05-28 1:50:49 Notification » XXXXXXXXXXX: Connection to controller established
2015-05-28 1:50:49 Notification » Push » XXXXXXXXXXX: Sending push notification: Connection to controller established
2015-05-28 1:50:49 Sync » XXXXXXXXXXX: Syncing stage 2 of 5: Controller Configuration (Reading Configuration)…
2015-05-28 1:51:15 Sync » XXXXXXXXXXX: Syncing stage 3 of 5: Controller Configuration (Loading Objects)…
2015-05-28 1:51:15 Sync » XXXXXXXXXXX: Syncing stage 4 of 5: Controller Configuration (Saving)…
2015-05-28 3:06:01 Database » Trimming statistics data to 2 years…
2015-05-28 3:06:01 Database » Statistics trim completed successfully.
2015-05-28 6:12:16 Notification » XXXXXXXXXXX: Area 1 Disarmed
2015-05-28 6:12:16 Notification » Push » XXXXXXXXXXX: Sending push notification: Area 1 Disarmed
 
Unless this is HaikuHelpers response when the system resets which means its another problem.... Going to try and isolate the system this weekend given some instructions from another member as I think it must be network related.  ALWAYS happens at the same time at night for some strange reason which makes me doubt it is an OP2 internal problem but just the fact that the OP2 network interface can't handle something....  SJ
 
The sync is happening only after the connection is interrupted, which is probably after the controller restarts. I would try removing all the automation logic from the controller temporarily if possible or at least inspecting it for any suspicious logic.

Here's another idea: make the controller time off by an hour or two and see when it happens then. This will give you more of an idea on the cause (controller reacting to time vs an actual event at 1:40 am).
 
Well the same thing happened in HaikuHelper at around the same time (for the last two nights).  Here is last nights HaikuHelper log:
 
2015-05-30 23:16:08 Notification » Push » XXXXXXXXXXXXX: Sending push notification: Area 1 Armed Night
2015-05-31 1:34:41 Notification » XXXXXXXXXXXXX: Connection to controller interrupted
2015-05-31 1:34:41 Notification » Push » XXXXXXXXXXXXX: Sending push notification: Connection to controller interrupted
2015-05-31 1:34:45 Notification » XXXXXXXXXXXXX: Connection to controller established
2015-05-31 1:34:45 Notification » Push » XXXXXXXXXXXXX: Sending push notification: Connection to controller established
2015-05-31 1:34:46 Sync » XXXXXXXXXXXXX: Syncing stage 2 of 5: Controller Configuration (Reading Configuration)…
2015-05-31 1:35:08 Sync » XXXXXXXXXXXXX: Syncing stage 3 of 5: Controller Configuration (Loading Objects)…
2015-05-31 1:35:08 Sync » XXXXXXXXXXXXX: Syncing stage 4 of 5: Controller Configuration (Saving)…
2015-05-31 3:06:00 Database » Trimming statistics data to 2 years…
2015-05-31 3:06:00 Database » Statistics trim completed successfully.
2015-05-31 6:51:26 Notification » XXXXXXXXXXXXX: Area 1 Disarmed
2015-05-31 6:51:26 Notification » Push » XXXXXXXXXXXXX: Sending push notification: Area 1 Disarmed
 
However, based on your feedback, I changed the controller time to an hour ahead over the last couple of nights.  So, it is more around the time at night which is triggering the interuption (vs. controller time).  HAI support also validated that there is nothing special around this time unless I have something in my automation code (which I don't)..  I recently put my OP2 controller behind a secondary firewall because I have a lot of network activity in my setup which has caused some other forum members to get resets.  It hasn't done a system reset (at least from the OP2 log) since I installed this new setup.  Not sure what is going on, but maybe something else is causing the issue of HaikuHelper disconnecting at this time (usually between 1:30 a.m. and 1:40 a.m.).  Maybe something else is running (e.g. MAC time machine backup, etc.).     SJ
 
I just looked and my IP camera recorder (also running on the same mac) and it also disconnected at about the same time (within like 30 seconds) across all my IP cameras!  Strange....   SJ
 
Do you mean on the mac? It is a fixed IP address outside the range of what my router provides. Never had an issue. Maybe something is happening that makes the connection drop. The same incident was causing my OP2 to restart, but now the new secondary router in front of it is shielding it in some way. What a mystery.....
 
Back
Top