Curtains receiving second close command!


#1

1) Give a description of the problem
As title says, i have a simple piston, but 50% of the time, for some reason the piston sends a second close command, thereby stopping my curtains and leaving them partially open. i’m hoping someone clever can help, its possibly due to Task Execution Policy, but i have no idea.

2) What is the expected behavior?
Just send single close command

3) What is happening/not happening?
double close command sent!

**4) Post a Green Snapshot of the piston!

**5) Attach any logs

10/04/2018, 18:26:00 +288ms
+1ms ╔Received event [Curtains].windowShade = partially open with a delay of 631ms
+9195ms ║RunTime Analysis CS > 173ms > PS > 8894ms > PE > 128ms > CE
+9196ms ║Piston waited at a semaphore for 8851ms
+9199ms ║Runtime (41845 bytes) successfully initialized in 8894ms (v0.3.104.20180323) (9197ms)
+9200ms ║╔Execution stage started
+9211ms ║║Comparison (enum) partially open changes = true (1ms)
+9212ms ║║Condition #12 evaluated true (3ms)
+9213ms ║║Condition group #9 evaluated true (state did not change) (5ms)
+9215ms ║║Cancelling statement #10’s schedules…
+9228ms ║║Calculating (string) Curtains are + (string) partially open >> (string) Curtains are partially open
+9232ms ║║Calculating (string) Curtains are partially open + (string) at >> (string) Curtains are partially open at
+9235ms ║║Calculating (string) Curtains are partially open at + (string) 18:26 >> (string) Curtains are partially open at 18:26
+9239ms ║║Calculating (string) Curtains are partially open at 18:26 + (string) >> (string) Curtains are partially open at 18:26
+9242ms ║║Calculating (string) Curtains are partially open at 18:26 + (string) on >> (string) Curtains are partially open at 18:26 on
+9245ms ║║Calculating (string) Curtains are partially open at 18:26 on + (string) >> (string) Curtains are partially open at 18:26 on
+9248ms ║║Calculating (string) Curtains are partially open at 18:26 on + (string) 10 >> (string) Curtains are partially open at 18:26 on 10
+9251ms ║║Calculating (string) Curtains are partially open at 18:26 on 10 + (string) of >> (string) Curtains are partially open at 18:26 on 10 of
+9253ms ║║Calculating (string) Curtains are partially open at 18:26 on 10 of + (string) April >> (string) Curtains are partially open at 18:26 on 10 of April
+9255ms ║║Calculating (string) Curtains are partially open at 18:26 on 10 of April + (string) >> (string) Curtains are partially open at 18:26 on 10 of April
+9258ms ║║Executed virtual command setState (1ms)
+9260ms ║╚Execution stage complete. (61ms)
+9262ms ║Setting up scheduled job for Wed, Apr 11 2018 @ 10:45:00 AM CEST (in 58730.45s), with 1 more job pending
+9272ms ╚Event processed successfully (9272ms)
10/04/2018, 18:25:59 +252ms
+2ms ╔Received event [Curtains].windowShade = closing with a delay of 738ms
+212ms ║RunTime Analysis CS > 38ms > PS > 71ms > PE > 102ms > CE
+214ms ║Runtime (41754 bytes) successfully initialized in 71ms (v0.3.104.20180323) (211ms)
+215ms ║╔Execution stage started
+227ms ║║Comparison (enum) closing changes = true (0ms)
+228ms ║║Condition #12 evaluated true (4ms)
+229ms ║║Condition group #9 evaluated true (state did not change) (4ms)
+231ms ║║Cancelling statement #10’s schedules…
+244ms ║║Calculating (string) Curtains are + (string) closing >> (string) Curtains are closing
+248ms ║║Calculating (string) Curtains are closing + (string) at >> (string) Curtains are closing at
+252ms ║║Calculating (string) Curtains are closing at + (string) 18:25 >> (string) Curtains are closing at 18:25
+255ms ║║Calculating (string) Curtains are closing at 18:25 + (string) >> (string) Curtains are closing at 18:25
+259ms ║║Calculating (string) Curtains are closing at 18:25 + (string) on >> (string) Curtains are closing at 18:25 on
+262ms ║║Calculating (string) Curtains are closing at 18:25 on + (string) >> (string) Curtains are closing at 18:25 on
+265ms ║║Calculating (string) Curtains are closing at 18:25 on + (string) 10 >> (string) Curtains are closing at 18:25 on 10
+268ms ║║Calculating (string) Curtains are closing at 18:25 on 10 + (string) of >> (string) Curtains are closing at 18:25 on 10 of
+270ms ║║Calculating (string) Curtains are closing at 18:25 on 10 of + (string) April >> (string) Curtains are closing at 18:25 on 10 of April
+273ms ║║Calculating (string) Curtains are closing at 18:25 on 10 of April + (string) >> (string) Curtains are closing at 18:25 on 10 of April
+275ms ║║Executed virtual command setState (1ms)
+963ms ║║Executed physical command [Curtains].close() (671ms)
+964ms ║║Executed [Curtains].close (673ms)
+967ms ║╚Execution stage complete. (752ms)
+969ms ║Setting up scheduled job for Wed, Apr 11 2018 @ 10:45:00 AM CEST (in 58739.78s), with 1 more job pending
+1008ms ╚Event processed successfully (1008ms)


#2

My time based pistons are double triggering as well!! So odd. Just started happening the other day.