genielabs / HomeGenie

HomeGenie, the programmable automation intelligence
https://homegenie.it
GNU General Public License v3.0
392 stars 155 forks source link

Scheduled ON/OFF running at the wrong time #252

Closed bkenobi closed 8 years ago

bkenobi commented 8 years ago
http://www.homegenie.it/forum/index.php?topic=1387.0 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]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[/code] Yesterday when HG turned the lights ON in the morning, this is what it correctly did: [code]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[/code] I checked my settings and found this as the scheduled ON event: [code](30 5 * 1-4,8-12 *;@Weekdays;* * * 1-5,8-12 *):(@SolarAltitude.Evening.Sunset.Start;\* \* \* 1-5,8-12 *)[/code] I checked the Weekdays item in the Scheduler and found this: [code]\* \* \* \* 1-5[/code] 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. I checked my logs which go back to Sunday January 3 in the afternoon and did not find another incident but that's only 1 other weekend of data. It appears this has only happened once to me so I can't yet say this is a common issue. I'm running HG 1.1 r509a currently.
genemars commented 8 years ago

fix is coming with r513