1) Give a description of the problem
The below piston is set to turn lights on at a certain time in the morning, then off at sunrise. More often than not (if not always), the lights are still on after sunrise, and I suspect it is because the door that is being monitored has been opened, but the TCP is set to never so I’m not sure what I’m doing wrong.
2) What is the expected behavior?
Lights turn on at X time in the morning, then turn off at sunrise.
3) What is happening/not happening?
Lights turn on at X time in the morning, but do not turn off at sunrise.
**4) Post a Green Snapshot of the piston!
5) Attach any logs (From ST IDE and by turning logging level to Full)
11/16/2017, 7:12:59 AM +185ms +0ms ╔Received event [Home].time = 1510834380000 with a delay of -816ms +400ms ║RunTime Analysis CS > 23ms > PS > 63ms > PE > 315ms > CE +413ms ║Runtime (53319 bytes) successfully initialized in 63ms (v0.2.0fe.20171109) (412ms) +414ms ║╔Execution stage started +480ms ║║Comparison (time) 25979606 happens_daily_at (datetime) 1510869060000 = false (0ms) +481ms ║║Condition #2 evaluated false (60ms) +482ms ║║Cancelling statement #2's schedules... +486ms ║║Requesting time schedule wake up at Thu, Nov 16 2017 @ 4:52:00 PM EST +489ms ║║Condition group #1 evaluated false (state did not change) (68ms) +495ms ║║Comparison (time) 25979677 happens_daily_at (time) 81000000 = false (0ms) +497ms ║║Condition #4 evaluated false (4ms) +498ms ║║Cancelling statement #4's schedules... +502ms ║║Requesting time schedule wake up at Thu, Nov 16 2017 @ 10:30:00 PM EST +505ms ║║Condition group #3 evaluated false (state did not change) (14ms) +511ms ║║Comparison (time) 25979693 happens_daily_at (time) 22200000 = false (0ms) +513ms ║║Condition #19 evaluated false (4ms) +514ms ║║Cancelling statement #19's schedules... +518ms ║║Requesting time schedule wake up at Fri, Nov 17 2017 @ 6:10:00 AM EST +521ms ║║Condition group #15 evaluated false (state did not change) (14ms) +527ms ║║Comparison (time) 25979709 happens_daily_at (datetime) 1510834320000 = true (0ms) +529ms ║║Time restriction check passed +530ms ║║Cancelling condition #24's schedules... +531ms ║║Condition #24 evaluated true (7ms) +532ms ║║Cancelling statement #24's schedules... +536ms ║║Requesting time schedule wake up at Fri, Nov 17 2017 @ 7:13:00 AM EST +546ms ║║Comparison (enum) off is (string) on = false (2ms) +547ms ║║Condition #73 evaluated false (9ms) +548ms ║║Condition group #20 evaluated false (state did not change) (24ms) +560ms ║║Condition #43 evaluated false (6ms) +568ms ║║Condition #44 evaluated false (7ms) +576ms ║║Condition #49 evaluated false (7ms) +583ms ║║Condition #50 evaluated false (6ms) +584ms ║║Condition group #48 evaluated false (state did not change) (32ms) +585ms ║║Condition group #42 evaluated false (state did not change) (33ms) +586ms ║║Condition group #25 evaluated false (state did not change) (35ms) +591ms ║╚Execution stage complete. (177ms) +594ms ║Setting up scheduled job for Thu, Nov 16 2017 @ 7:33:24 AM EST (in 1224.903s), with 4 more jobs pending +606ms ╚Event processed successfully (606ms) 11/16/2017, 6:24:17 AM +341ms +1ms ╔Received event [Front Doorbell].button = Ready with a delay of 123ms +202ms ║RunTime Analysis CS > 20ms > PS > 46ms > PE > 137ms > CE +250ms ║Runtime (53322 bytes) successfully initialized in 46ms (v0.2.0fe.20171109) (248ms) +251ms ║╔Execution stage started +304ms ║║Comparison (time) 23057597 happens_daily_at (datetime) 1510869060000 = false (0ms) +305ms ║║Condition #2 evaluated false (49ms) +306ms ║║Cancelling statement #2's schedules... +309ms ║║Requesting time schedule wake up at Thu, Nov 16 2017 @ 4:52:00 PM EST +311ms ║║Condition group #1 evaluated false (state did not change) (55ms) +316ms ║║Comparison (time) 23057655 happens_daily_at (time) 81000000 = false (0ms) +317ms ║║Condition #4 evaluated false (4ms) +318ms ║║Cancelling statement #4's schedules... +321ms ║║Requesting time schedule wake up at Thu, Nov 16 2017 @ 10:30:00 PM EST +324ms ║║Condition group #3 evaluated false (state did not change) (10ms) +328ms ║║Comparison (time) 23057667 happens_daily_at (time) 22200000 = false (0ms) +330ms ║║Condition #19 evaluated false (3ms) +330ms ║║Cancelling statement #19's schedules... +334ms ║║Requesting time schedule wake up at Fri, Nov 17 2017 @ 6:10:00 AM EST +336ms ║║Condition group #15 evaluated false (state did not change) (10ms) +341ms ║║Comparison (time) 23057679 happens_daily_at (datetime) 1510834320000 = false (1ms) +342ms ║║Condition #24 evaluated false (4ms) +343ms ║║Cancelling statement #24's schedules... +346ms ║║Requesting time schedule wake up at Thu, Nov 16 2017 @ 7:13:00 AM EST +348ms ║║Condition group #20 evaluated false (state did not change) (9ms) +357ms ║║Condition #43 evaluated false (6ms) +362ms ║║Comparison (enum) Ready gets (string) pushed = false (1ms) +363ms ║║Condition #44 evaluated false (5ms) +369ms ║║Condition #49 evaluated false (5ms) +376ms ║║Condition #50 evaluated false (6ms) +377ms ║║Condition group #48 evaluated false (state did not change) (27ms) +378ms ║║Condition group #42 evaluated false (state did not change) (27ms) +378ms ║║Condition group #25 evaluated false (state did not change) (28ms) +383ms ║╚Execution stage complete. (132ms) +385ms ║Setting up scheduled job for Thu, Nov 16 2017 @ 7:13:00 AM EST (in 2922.275s), with 4 more jobs pending +401ms ╚Event processed successfully (401ms) 11/16/2017, 6:23:51 AM +377ms +2ms ╔Received event [Front Door].contact = closed with a delay of 345ms +551ms ║RunTime Analysis CS > 22ms > PS > 329ms > PE > 199ms > CE +559ms ║Piston waited at a semaphore for 264ms +562ms ║Runtime (53384 bytes) successfully initialized in 329ms (v0.2.0fe.20171109) (560ms) +563ms ║╔Execution stage started +620ms ║║Comparison (time) 23031946 happens_daily_at (datetime) 1510869060000 = false (1ms) +621ms ║║Condition #2 evaluated false (52ms) +622ms ║║Cancelling statement #2's schedules... +626ms ║║Requesting time schedule wake up at Thu, Nov 16 2017 @ 4:52:00 PM EST +628ms ║║Condition group #1 evaluated false (state did not change) (60ms) +634ms ║║Comparison (time) 23032008 happens_daily_at (time) 81000000 = false (0ms) +635ms ║║Condition #4 evaluated false (4ms) +636ms ║║Cancelling statement #4's schedules... +640ms ║║Requesting time schedule wake up at Thu, Nov 16 2017 @ 10:30:00 PM EST +642ms ║║Condition group #3 evaluated false (state did not change) (12ms) +648ms ║║Comparison (time) 23032022 happens_daily_at (time) 22200000 = false (1ms) +649ms ║║Condition #19 evaluated false (4ms) +650ms ║║Cancelling statement #19's schedules... +654ms ║║Requesting time schedule wake up at Fri, Nov 17 2017 @ 6:10:00 AM EST +657ms ║║Condition group #15 evaluated false (state did not change) (11ms) +662ms ║║Comparison (time) 23032036 happens_daily_at (datetime) 1510834320000 = false (0ms) +663ms ║║Condition #24 evaluated false (4ms) +664ms ║║Cancelling statement #24's schedules... +668ms ║║Requesting time schedule wake up at Thu, Nov 16 2017 @ 7:13:00 AM EST +670ms ║║Condition group #20 evaluated false (state did not change) (11ms) +679ms ║║Comparison (enum) closed changes_to (string) open = false (1ms) +680ms ║║Cancelling condition #43's schedules... +681ms ║║Condition #43 evaluated false (7ms) +689ms ║║Condition #44 evaluated false (7ms) +698ms ║║Condition #49 evaluated false (8ms) +706ms ║║Condition #50 evaluated false (7ms) +707ms ║║Cancelling condition #48's schedules... +708ms ║║Condition group #48 evaluated false (state changed) (34ms) +708ms ║║Condition group #42 evaluated false (state did not change) (35ms) +709ms ║║Condition group #25 evaluated false (state did not change) (37ms) +714ms ║╚Execution stage complete. (151ms) +717ms ║Setting up scheduled job for Thu, Nov 16 2017 @ 7:13:00 AM EST (in 2947.907s), with 4 more jobs pending +751ms ╚Event processed successfully (751ms) 11/16/2017, 6:23:51 AM +141ms +1ms ╔Received event [Front Door].contact = open with a delay of 351ms +188ms ║RunTime Analysis CS > 14ms > PS > 38ms > PE > 136ms > CE +200ms ║Runtime (53318 bytes) successfully initialized in 38ms (v0.2.0fe.20171109) (199ms) +201ms ║╔Execution stage started +245ms ║║Comparison (time) 23031346 happens_daily_at (datetime) 1510869060000 = false (0ms) +247ms ║║Condition #2 evaluated false (41ms) +247ms ║║Cancelling statement #2's schedules... +250ms ║║Requesting time schedule wake up at Thu, Nov 16 2017 @ 4:52:00 PM EST +252ms ║║Condition group #1 evaluated false (state did not change) (47ms) +257ms ║║Comparison (time) 23031396 happens_daily_at (time) 81000000 = false (1ms) +258ms ║║Condition #4 evaluated false (4ms) +259ms ║║Cancelling statement #4's schedules... +262ms ║║Requesting time schedule wake up at Thu, Nov 16 2017 @ 10:30:00 PM EST +264ms ║║Condition group #3 evaluated false (state did not change) (10ms) +269ms ║║Comparison (time) 23031407 happens_daily_at (time) 22200000 = false (0ms) +270ms ║║Condition #19 evaluated false (4ms) +271ms ║║Cancelling statement #19's schedules... +274ms ║║Requesting time schedule wake up at Fri, Nov 17 2017 @ 6:10:00 AM EST +276ms ║║Condition group #15 evaluated false (state did not change) (10ms) +281ms ║║Comparison (time) 23031419 happens_daily_at (datetime) 1510834320000 = false (0ms) +282ms ║║Condition #24 evaluated false (3ms) +283ms ║║Cancelling statement #24's schedules... +285ms ║║Requesting time schedule wake up at Thu, Nov 16 2017 @ 7:13:00 AM EST +287ms ║║Condition group #20 evaluated false (state did not change) (9ms) +294ms ║║Comparison (enum) open changes_to (string) open = true (1ms) +295ms ║║Cancelling condition #43's schedules... +296ms ║║Condition #43 evaluated true (4ms) +296ms ║║Cancelling condition #48's schedules... +297ms ║║Condition group #48 evaluated true (state changed) (7ms) +304ms ║║Comparison (time) 23031439 is_before (time) 22200000 = false (4ms) +305ms ║║Condition #52 evaluated false (7ms) +311ms ║║Comparison (time) 23031447 is_after (time) 81000000 = false (3ms) +312ms ║║Condition #53 evaluated false (6ms) +313ms ║║Condition group #51 evaluated false (state did not change) (15ms) +314ms ║║Condition group #42 evaluated false (state did not change) (24ms) +315ms ║║Condition group #25 evaluated false (state did not change) (26ms) +319ms ║╚Execution stage complete. (119ms) +321ms ║Setting up scheduled job for Thu, Nov 16 2017 @ 7:13:00 AM EST (in 2948.539s), with 4 more jobs pending +339ms ╚Event processed successfully (338ms) 11/16/2017, 6:23:48 AM +42ms +1ms ╔Received event [Front Door].contact = closed with a delay of 436ms +211ms ║RunTime Analysis CS > 16ms > PS > 56ms > PE > 139ms > CE +220ms ║Runtime (53316 bytes) successfully initialized in 56ms (v0.2.0fe.20171109) (218ms) +221ms ║╔Execution stage started +274ms ║║Comparison (time) 23028269 happens_daily_at (datetime) 1510869060000 = false (0ms) +276ms ║║Condition #2 evaluated false (49ms) +276ms ║║Cancelling statement #2's schedules... +279ms ║║Requesting time schedule wake up at Thu, Nov 16 2017 @ 4:52:00 PM EST +281ms ║║Condition group #1 evaluated false (state did not change) (55ms) +286ms ║║Comparison (time) 23028325 happens_daily_at (time) 81000000 = false (1ms) +287ms ║║Condition #4 evaluated false (4ms) +288ms ║║Cancelling statement #4's schedules... +291ms ║║Requesting time schedule wake up at Thu, Nov 16 2017 @ 10:30:00 PM EST +293ms ║║Condition group #3 evaluated false (state did not change) (10ms) +297ms ║║Comparison (time) 23028337 happens_daily_at (time) 22200000 = false (0ms) +299ms ║║Condition #19 evaluated false (3ms) +299ms ║║Cancelling statement #19's schedules... +303ms ║║Requesting time schedule wake up at Fri, Nov 17 2017 @ 6:10:00 AM EST +305ms ║║Condition group #15 evaluated false (state did not change) (9ms) +309ms ║║Comparison (time) 23028349 happens_daily_at (datetime) 1510834320000 = false (0ms) +310ms ║║Condition #24 evaluated false (3ms) +311ms ║║Cancelling statement #24's schedules... +314ms ║║Requesting time schedule wake up at Thu, Nov 16 2017 @ 7:13:00 AM EST +316ms ║║Condition group #20 evaluated false (state did not change) (10ms) +324ms ║║Comparison (enum) closed changes_to (string) open = false (1ms) +325ms ║║Cancelling condition #43's schedules... +326ms ║║Condition #43 evaluated false (7ms) +335ms ║║Condition #44 evaluated false (8ms) +342ms ║║Condition #49 evaluated false (7ms) +350ms ║║Condition #50 evaluated false (8ms) +351ms ║║Cancelling condition #48's schedules... +352ms ║║Condition group #48 evaluated false (state changed) (32ms) +352ms ║║Condition group #42 evaluated false (state did not change) (34ms) +353ms ║║Condition group #25 evaluated false (state did not change) (35ms) +357ms ║╚Execution stage complete. (136ms) +360ms ║Setting up scheduled job for Thu, Nov 16 2017 @ 7:13:00 AM EST (in 2951.599s), with 4 more jobs pending +377ms ╚Event processed successfully (377ms) 11/16/2017, 6:23:43 AM +0ms +1ms ╔Received event [Front Door].contact = open with a delay of 355ms +178ms ║RunTime Analysis CS > 13ms > PS > 33ms > PE > 132ms > CE +190ms ║Runtime (53313 bytes) successfully initialized in 33ms (v0.2.0fe.20171109) (189ms) +191ms ║╔Execution stage started +236ms ║║Comparison (time) 23023196 happens_daily_at (datetime) 1510869060000 = false (1ms) +237ms ║║Condition #2 evaluated false (42ms) +238ms ║║Cancelling statement #2's schedules... +241ms ║║Requesting time schedule wake up at Thu, Nov 16 2017 @ 4:52:00 PM EST +242ms ║║Condition group #1 evaluated false (state did not change) (47ms) +247ms ║║Comparison (time) 23023245 happens_daily_at (time) 81000000 = false (0ms) +248ms ║║Condition #4 evaluated false (4ms) +249ms ║║Cancelling statement #4's schedules... +252ms ║║Requesting time schedule wake up at Thu, Nov 16 2017 @ 10:30:00 PM EST +254ms ║║Condition group #3 evaluated false (state did not change) (10ms) +259ms ║║Comparison (time) 23023256 happens_daily_at (time) 22200000 = false (0ms) +260ms ║║Cancelling condition #19's schedules... +260ms ║║Condition #19 evaluated false (4ms) +261ms ║║Cancelling statement #19's schedules... +264ms ║║Requesting time schedule wake up at Fri, Nov 17 2017 @ 6:10:00 AM EST +266ms ║║Cancelling condition #15's schedules... +267ms ║║Condition group #15 evaluated false (state changed) (11ms) +272ms ║║Comparison (time) 23023269 happens_daily_at (datetime) 1510834320000 = false (0ms) +273ms ║║Condition #24 evaluated false (4ms) +274ms ║║Cancelling statement #24's schedules... +276ms ║║Requesting time schedule wake up at Thu, Nov 16 2017 @ 7:13:00 AM EST +278ms ║║Condition group #20 evaluated false (state did not change) (9ms) +284ms ║║Comparison (enum) open changes_to (string) open = true (1ms) +285ms ║║Cancelling condition #43's schedules... +286ms ║║Condition #43 evaluated true (5ms) +287ms ║║Cancelling condition #48's schedules... +287ms ║║Condition group #48 evaluated true (state changed) (6ms) +294ms ║║Comparison (time) 23023289 is_before (time) 22200000 = false (4ms) +295ms ║║Condition #52 evaluated false (7ms) +301ms ║║Comparison (time) 23023296 is_after (time) 81000000 = false (4ms) +302ms ║║Condition #53 evaluated false (6ms) +303ms ║║Condition group #51 evaluated false (state did not change) (15ms) +304ms ║║Condition group #42 evaluated false (state did not change) (24ms) +304ms ║║Condition group #25 evaluated false (state did not change) (24ms) +309ms ║╚Execution stage complete. (118ms) +311ms ║Setting up scheduled job for Thu, Nov 16 2017 @ 7:13:00 AM EST (in 2956.69s), with 4 more jobs pending +348ms ╚Event processed successfully (348ms) 11/16/2017, 6:09:59 AM +166ms +0ms ╔Received event [Home].time = 1510830600000 with a delay of -835ms +349ms ║RunTime Analysis CS > 24ms > PS > 64ms > PE > 262ms > CE +362ms ║Runtime (53317 bytes) successfully initialized in 64ms (v0.2.0fe.20171109) (360ms) +362ms ║╔Execution stage started +426ms ║║Comparison (time) 22199535 happens_daily_at (datetime) 1510869060000 = false (0ms) +428ms ║║Condition #2 evaluated false (59ms) +429ms ║║Cancelling statement #2's schedules... +432ms ║║Requesting time schedule wake up at Thu, Nov 16 2017 @ 4:52:00 PM EST +434ms ║║Condition group #1 evaluated false (state did not change) (66ms) +440ms ║║Comparison (time) 22199603 happens_daily_at (time) 81000000 = false (1ms) +441ms ║║Cancelling condition #4's schedules... +442ms ║║Condition #4 evaluated false (5ms) +443ms ║║Cancelling statement #4's schedules... +447ms ║║Requesting time schedule wake up at Thu, Nov 16 2017 @ 10:30:00 PM EST +449ms ║║Cancelling condition #3's schedules... +450ms ║║Condition group #3 evaluated false (state changed) (13ms) +456ms ║║Comparison (time) 22199619 happens_daily_at (time) 22200000 = true (0ms) +457ms ║║Time restriction check passed +458ms ║║Cancelling condition #19's schedules... +459ms ║║Condition #19 evaluated true (6ms) +460ms ║║Cancelling statement #19's schedules... +464ms ║║Requesting time schedule wake up at Fri, Nov 17 2017 @ 6:10:00 AM EST +473ms ║║Comparison (enum) off is (string) off = true (1ms) +474ms ║║Cancelling condition #75's schedules... +475ms ║║Condition #75 evaluated true (9ms) +476ms ║║Cancelling condition #15's schedules... +477ms ║║Condition group #15 evaluated true (state changed) (25ms) +479ms ║║Cancelling statement #16's schedules... +505ms ║║Executed virtual command [Front Pot Lights].sendPushNotification (22ms) +513ms ║║Executed virtual command [Front Pot Lights].wait (0ms) +514ms ║║Requesting a wake up for Thu, Nov 16 2017 @ 7:33:24 AM EST (in 5005.0s) +521ms ║╚Execution stage complete. (159ms) +523ms ║Setting up scheduled job for Thu, Nov 16 2017 @ 7:12:00 AM EST (in 3720.312s), with 4 more jobs pending +540ms ╚Event processed successfully (540ms)
