Scheduled ON/OFF running rogue

[bkenobi]

I have a set of kitchen lights set to turn ON on weekdays at 5:30AM.  They are not set to turn ON on weekends in the morning.  They are set to turn ON in the evenings at dusk on all days.  AFAIK this has been working correctly for ages.  This morning I got up early and found my kitchen lights ON.  I checked my logs and found the following:

Code: [Select]

2016-01-16 05:30:10.3295 Debug 5A-02-00-65
2016-01-16 05:30:10.3705 Debug PLCRX: 5A-02-00-65
2016-01-16 05:30:10.3713 Debug FNMAP: 00
2016-01-16 05:30:10.3720 Debug DATA : 65
2016-01-16 05:30:10.3732 Debug       0) Address = A7
2016-01-16 05:30:10.7604 Debug 5A-02-01-62
2016-01-16 05:30:10.7611 Debug PLCRX: 5A-02-01-62
2016-01-16 05:30:10.7617 Debug FNMAP: 01
2016-01-16 05:30:10.7617 Debug DATA : 62
2016-01-16 05:30:10.7629 Debug       0) House code = A
2016-01-16 05:30:10.7636 Debug       0)    Command = On
2016-01-16 05:30:10.7663 Info HomeAutomation.X10 A7 - Status.Level 1
Yesterday when HG turned the lights ON in the morning, this is what it correctly did:

Code: [Select]

2016-01-15 05:30:01.2660 Info HomeAutomation.HomeGenie.Automation 35 Automation Program Program.Notification {"Title":"Scheduled Control","Message":"Cabinet lights ON"}
2016-01-15 05:30:01.2694 Debug 04-65
2016-01-15 05:30:01.9304 Info HomeAutomation.HomeGenie.Automation 1017 - Program.UiRefresh Data updated
2016-01-15 05:30:02.5886 Debug 55
2016-01-15 05:30:02.5886 Debug Command succesfull
2016-01-15 05:30:02.5906 Debug 06-62
2016-01-15 05:30:03.0207 Debug 55
2016-01-15 05:30:03.0207 Debug Command succesfull
2016-01-15 05:30:03.0231 Info HomeAutomation.X10 A7 - Status.Level 1
2016-01-15 05:30:10.8216 Debug 5A-02-00-65
2016-01-15 05:30:10.8216 Debug PLCRX: 5A-02-00-65
2016-01-15 05:30:10.8228 Debug FNMAP: 00
2016-01-15 05:30:10.8228 Debug DATA : 65
2016-01-15 05:30:10.8241 Debug       0) Address = A7
2016-01-15 05:30:11.2456 Debug 5A-02-01-62
2016-01-15 05:30:11.2456 Debug PLCRX: 5A-02-01-62
2016-01-15 05:30:11.2470 Debug FNMAP: 01
2016-01-15 05:30:11.2470 Debug DATA : 62
2016-01-15 05:30:11.2480 Debug       0) House code = A
2016-01-15 05:30:11.2488 Debug       0)    Command = On
2016-01-15 05:30:11.2505 Info HomeAutomation.X10 A7 - Status.Level 1
I checked my settings and found this as the scheduled ON event:

Code: [Select]

(30 5 * 1-4,8-12 *;@Weekdays;* * * 1-5,8-12 *):(@SolarAltitude.Evening.Sunset.Start;* * * 1-5,8-12 *)
I checked the Weekdays item in the Scheduler and found this:

Code: [Select]

* * * * 1-5
So, it appears that HG and the Scheduled ON/OFF APP are running on the wrong day but not reporting to the MIG interface.  When the APP correctly applies a scheduled event, it adds a statement about APP 35 and what it did.  In this case, there was no statement.  If it was an odd time, I'd look at other causes but clearly this triggered at 5:30 so it must be the Scheduled ON/OFF causing this.

[Gene]

Next update will fix this.

https://github.com/genielabs/HomeGenie/blob/master/HISTORY.TXT

g.

[bkenobi]

Wow, that was quick!

Thanks 

[bkenobi]

I found the source of the rogue command.  I have a second HG set up on a winxp machine that is simply used to track my RPi HG to try to trap a once a month type of error.  It appears that although I turned all APPs off on install, the Scheduled ON/OFF code was still enabled.  Combined with the date being set wrong with that, and the second HG thought it should turn the lights on.

Thanks for looking into this and apparently locating an unrelated bug.   

[Gene]

That's why hg needs a widget for "Scheduled On/Off" that show all configured events in one page

Cheers,
g.

[bkenobi]

Agreed!