How do I concatenate For each device loops?

babbahotep · 2020-05-10 08:06:55 UTC

1) Give a description of the problem
I have an array of 9 RGB lights. I want them to run multiple for each device.
I want eachof them turn on, change to random color individually from 1 trhough 9.
Then I want to change each of them in sequence to a different color.
Then I want each of them in sequence to change to daylight.

2) What is the expected behaviour?
Have multiple for each device loops run after one another 1-9 going through all lights.

3) What is happening/not happening?
1st for each device loop runs until a random number 1-5 and stops. loop 2-n are not run.

**4) Post a Green Snapshot of the piston![image|45x37]

5) Attach logs after turning logging level to Full

5/10/2020, 1:05:55 AM +441ms
        +0ms	╔Received event [Home].execute = recovery with a delay of 64ms
        +10145ms	║RunTime Analysis CS > 19ms > PS > 10070ms > PE > 55ms > CE
        +10146ms	║Piston waited at a semaphore for 10025ms
        +10148ms	║Runtime (46012 bytes) successfully initialized in 10070ms (v0.3.110.20191009) (10147ms)
        +10149ms	║╔Execution stage started
        +10163ms	║║Condition #2 evaluated false (9ms)
        +10164ms	║║Condition group #1 evaluated false (state did not change) (10ms)
        +10174ms	║║Condition #10 evaluated false (6ms)
        +10175ms	║║Condition group #9 evaluated false (state did not change) (8ms)
        +10176ms	║╚Execution stage complete. (27ms)
        +10177ms	╚Event processed successfully (10177ms)
        5/10/2020, 1:05:52 AM +457ms
        +0ms	╔Received event [Home].execute = recovery with a delay of 68ms
        +10130ms	║RunTime Analysis CS > 19ms > PS > 10065ms > PE > 45ms > CE
        +10131ms	║Piston waited at a semaphore for 10016ms
        +10133ms	║Runtime (46012 bytes) successfully initialized in 10065ms (v0.3.110.20191009) (10132ms)
        +10134ms	║╔Execution stage started
        +10147ms	║║Condition #2 evaluated false (9ms)
        +10148ms	║║Condition group #1 evaluated false (state did not change) (10ms)
        +10158ms	║║Condition #10 evaluated false (8ms)
        +10159ms	║║Condition group #9 evaluated false (state did not change) (9ms)
        +10161ms	║╚Execution stage complete. (26ms)
        +10162ms	╚Event processed successfully (10162ms)
        5/10/2020, 1:05:52 AM +297ms
        +0ms	╔Received event [Home].execute = recovery with a delay of 53ms
        +10133ms	║RunTime Analysis CS > 15ms > PS > 10059ms > PE > 59ms > CE
        +10134ms	║Piston waited at a semaphore for 10018ms
        +10136ms	║Runtime (46012 bytes) successfully initialized in 10059ms (v0.3.110.20191009) (10135ms)
        +10137ms	║╔Execution stage started
        +10150ms	║║Condition #2 evaluated false (9ms)
        +10151ms	║║Condition group #1 evaluated false (state did not change) (10ms)
        +10259ms	║║Condition #10 evaluated false (105ms)
        +10260ms	║║Condition group #9 evaluated false (state did not change) (107ms)
        +10263ms	║╚Execution stage complete. (125ms)
        +10264ms	╚Event processed successfully (10265ms)
        5/10/2020, 1:05:50 AM +768ms
        +1ms	╔Received event [Home].execute = recovery with a delay of 56ms
        +10115ms	║RunTime Analysis CS > 15ms > PS > 10052ms > PE > 47ms > CE
        +10116ms	║Piston waited at a semaphore for 10012ms
        +10118ms	║Runtime (46012 bytes) successfully initialized in 10052ms (v0.3.110.20191009) (10117ms)
        +10119ms	║╔Execution stage started
        +10132ms	║║Condition #2 evaluated false (9ms)
        +10133ms	║║Condition group #1 evaluated false (state did not change) (10ms)
        +10143ms	║║Condition #10 evaluated false (7ms)
        +10144ms	║║Condition group #9 evaluated false (state did not change) (8ms)
        +10145ms	║╚Execution stage complete. (26ms)
        +10146ms	╚Event processed successfully (10146ms)
        5/10/2020, 1:05:47 AM +369ms
        +0ms	╔Received event [Home].execute = recovery with a delay of 54ms
        +10144ms	║RunTime Analysis CS > 14ms > PS > 10078ms > PE > 52ms > CE
        +10145ms	║Piston waited at a semaphore for 10040ms
        +10148ms	║Runtime (46012 bytes) successfully initialized in 10078ms (v0.3.110.20191009) (10146ms)
        +10148ms	║╔Execution stage started
        +10161ms	║║Condition #2 evaluated false (9ms)
        +10162ms	║║Condition group #1 evaluated false (state did not change) (9ms)
        +10171ms	║║Condition #10 evaluated false (6ms)
        +10171ms	║║Condition group #9 evaluated false (state did not change) (7ms)
        +10173ms	║╚Execution stage complete. (25ms)
        +10174ms	╚Event processed successfully (10174ms)
        5/10/2020, 1:05:45 AM +176ms
        +1ms	╔Received event [Home].execute = recovery with a delay of 72ms
        +10229ms	║RunTime Analysis CS > 19ms > PS > 10149ms > PE > 61ms > CE
        +10230ms	║Piston waited at a semaphore for 10102ms
        +10233ms	║Runtime (46012 bytes) successfully initialized in 10149ms (v0.3.110.20191009) (10231ms)
        +10234ms	║╔Execution stage started
        +10492ms	║║Condition #2 evaluated false (253ms)
        +10493ms	║║Condition group #1 evaluated false (state did not change) (255ms)
        +10504ms	║║Condition #10 evaluated false (8ms)
        +10505ms	║║Condition group #9 evaluated false (state did not change) (9ms)
        +10506ms	║╚Execution stage complete. (273ms)
        +10508ms	╚Event processed successfully (10507ms)
        5/10/2020, 1:05:54 AM +237ms
        +1ms	╔Received event [Home].execute = recovery with a delay of 78ms
        +119ms	║RunTime Analysis CS > 19ms > PS > 47ms > PE > 53ms > CE
        +122ms	║Runtime (45932 bytes) successfully initialized in 47ms (v0.3.110.20191009) (121ms)
        +123ms	║╔Execution stage started
        +138ms	║║Condition #2 evaluated false (10ms)
        +139ms	║║Condition group #1 evaluated false (state did not change) (11ms)
        +150ms	║║Condition #10 evaluated false (8ms)
        +152ms	║║Condition group #9 evaluated false (state did not change) (9ms)
        +154ms	║╚Execution stage complete. (31ms)
        +155ms	╚Event processed successfully (155ms)
        5/10/2020, 1:05:54 AM +38ms
        +0ms	╔Received event [Home].execute = recovery with a delay of 71ms
        +110ms	║RunTime Analysis CS > 16ms > PS > 48ms > PE > 46ms > CE
        +113ms	║Runtime (45932 bytes) successfully initialized in 48ms (v0.3.110.20191009) (111ms)
        +113ms	║╔Execution stage started
        +127ms	║║Condition #2 evaluated false (10ms)
        +128ms	║║Condition group #1 evaluated false (state did not change) (11ms)
        +138ms	║║Condition #10 evaluated false (7ms)
        +139ms	║║Condition group #9 evaluated false (state did not change) (8ms)
        +140ms	║╚Execution stage complete. (27ms)
        +141ms	╚Event processed successfully (141ms)
        5/10/2020, 1:05:52 AM +524ms
        +0ms	╔Received event [Home].execute = recovery with a delay of 59ms
        +102ms	║RunTime Analysis CS > 14ms > PS > 43ms > PE > 45ms > CE
        +105ms	║Runtime (45932 bytes) successfully initialized in 43ms (v0.3.110.20191009) (104ms)
        +106ms	║╔Execution stage started
        +120ms	║║Condition #2 evaluated false (9ms)
        +121ms	║║Condition group #1 evaluated false (state did not change) (11ms)
        +130ms	║║Condition #10 evaluated false (7ms)
        +131ms	║║Condition group #9 evaluated false (state did not change) (8ms)
        +133ms	║╚Execution stage complete. (28ms)
        +134ms	╚Event processed successfully (134ms)
        5/10/2020, 1:05:52 AM +288ms
        +0ms	╔Received event [Home].execute = recovery with a delay of 71ms
        +113ms	║RunTime Analysis CS > 20ms > PS > 50ms > PE > 43ms > CE
        +116ms	║Runtime (45932 bytes) successfully initialized in 50ms (v0.3.110.20191009) (114ms)
        +117ms	║╔Execution stage started
        +130ms	║║Condition #2 evaluated false (10ms)
        +131ms	║║Condition group #1 evaluated false (state did not change) (11ms)
        +141ms	║║Condition #10 evaluated false (7ms)
        +142ms	║║Condition group #9 evaluated false (state did not change) (9ms)
        +144ms	║╚Execution stage complete. (28ms)
        +145ms	╚Event processed successfully (145ms)
        5/10/2020, 1:05:50 AM +706ms
        +0ms	╔Received event [Home].execute = recovery with a delay of 64ms
        +115ms	║RunTime Analysis CS > 19ms > PS > 49ms > PE > 47ms > CE
        +117ms	║Runtime (45932 bytes) successfully initialized in 49ms (v0.3.110.20191009) (116ms)
        +118ms	║╔Execution stage started
        +131ms	║║Condition #2 evaluated false (9ms)
        +132ms	║║Condition group #1 evaluated false (state did not change) (10ms)
        +142ms	║║Condition #10 evaluated false (7ms)
        +143ms	║║Condition group #9 evaluated false (state did not change) (8ms)
        +145ms	║╚Execution stage complete. (27ms)
        +146ms	╚Event processed successfully (146ms)
        5/10/2020, 1:05:49 AM +549ms
        +0ms	╔Received event [Home].execute = recovery with a delay of 75ms
        +108ms	║RunTime Analysis CS > 19ms > PS > 47ms > PE > 43ms > CE
        +111ms	║Runtime (45932 bytes) successfully initialized in 47ms (v0.3.110.20191009) (110ms)
        +112ms	║╔Execution stage started
        +126ms	║║Condition #2 evaluated false (10ms)
        +127ms	║║Condition group #1 evaluated false (state did not change) (11ms)
        +137ms	║║Condition #10 evaluated false (8ms)
        +138ms	║║Condition group #9 evaluated false (state did not change) (9ms)
        +139ms	║╚Execution stage complete. (27ms)
        +141ms	╚Event processed successfully (140ms)
        5/10/2020, 1:05:47 AM +364ms
        +0ms	╔Received event [Home].execute = recovery with a delay of 53ms
        +101ms	║RunTime Analysis CS > 14ms > PS > 42ms > PE > 45ms > CE
        +104ms	║Runtime (45932 bytes) successfully initialized in 42ms (v0.3.110.20191009) (102ms)
        +105ms	║╔Execution stage started
        +123ms	║║Condition #2 evaluated false (13ms)
        +123ms	║║Condition group #1 evaluated false (state did not change) (15ms)
        +133ms	║║Condition #10 evaluated false (7ms)
        +134ms	║║Condition group #9 evaluated false (state did not change) (8ms)
        +136ms	║╚Execution stage complete. (32ms)
        +137ms	╚Event processed successfully (137ms)
        5/10/2020, 1:05:45 AM +363ms
        +0ms	╔Received event [Home].execute = recovery with a delay of 63ms
        +101ms	║RunTime Analysis CS > 18ms > PS > 40ms > PE > 43ms > CE
        +103ms	║Runtime (45925 bytes) successfully initialized in 40ms (v0.3.110.20191009) (102ms)
        +104ms	║╔Execution stage started
        +118ms	║║Cancelling condition #2's schedules...
        +119ms	║║Condition #2 evaluated false (11ms)
        +120ms	║║Cancelling condition #1's schedules...
        +121ms	║║Condition group #1 evaluated false (state changed) (13ms)
        +132ms	║║Cancelling condition #10's schedules...
        +133ms	║║Condition #10 evaluated false (10ms)
        +134ms	║║Cancelling condition #9's schedules...
        +135ms	║║Condition group #9 evaluated false (state changed) (12ms)
        +137ms	║╚Execution stage complete. (33ms)
        +138ms	╚Event processed successfully (138ms)
        5/10/2020, 1:05:45 AM +154ms
        +0ms	╔Received event [Home].execute = recovery with a delay of 86ms
        +100ms	║RunTime Analysis CS > 18ms > PS > 40ms > PE > 42ms > CE
        +103ms	║Runtime (45925 bytes) successfully initialized in 40ms (v0.3.110.20191009) (101ms)
        +103ms	║╔Execution stage started
        +118ms	║║Cancelling condition #2's schedules...
        +119ms	║║Condition #2 evaluated false (11ms)
        +120ms	║║Cancelling condition #1's schedules...
        +120ms	║║Condition group #1 evaluated false (state changed) (13ms)
        +131ms	║║Cancelling condition #10's schedules...
        +131ms	║║Condition #10 evaluated false (8ms)
        +132ms	║║Cancelling condition #9's schedules...
        +133ms	║║Condition group #9 evaluated false (state changed) (11ms)
        +135ms	║╚Execution stage complete. (32ms)
        +136ms	╚Event processed successfully (136ms)
        5/10/2020, 1:05:07 AM +91ms
        +1ms	╔Received event [Home].time = 1589097907288 with a delay of -197ms
        +104ms	║RunTime Analysis CS > 19ms > PS > 42ms > PE > 42ms > CE
        +106ms	║Runtime (45929 bytes) successfully initialized in 42ms (v0.3.110.20191009) (104ms)
        +107ms	║╔Execution stage started
        +147ms	║║Executed physical command [LB GAR RGB SY14].setLevel([100]) (15ms)
        +148ms	║║Executed virtual command [LB GAR RGB SY14].fadeLevel (20ms)
        +200ms	║║Executed virtual command [LB GAR RGB SY14].sendPushNotification (48ms)
        +209ms	║║Cancelling statement #33's schedules...
        +225ms	║║Executed physical command [LB GAR RGB SY15].on() (13ms)
        +226ms	║║Executed [LB GAR RGB SY15].on (15ms)
        +258ms	║║Executed physical command [LB GAR RGB SY15].setHue([18]) (26ms)
        +258ms	║║Executed [LB GAR RGB SY15].setHue (28ms)
        +262ms	║║Executed virtual command [LB GAR RGB SY15].wait (0ms)
        +262ms	║║Waiting for 2000ms
        +2300ms	║║Executed physical command [LB GAR RGB SY15].setHue([65]) (26ms)
        +2307ms	║║Executed physical command [LB GAR RGB SY15].setHue([66], [delay: 1000]) (5ms)
        +2314ms	║║Executed physical command [LB GAR RGB SY15].setHue([67], [delay: 2000]) (6ms)
        +2321ms	║║Executed physical command [LB GAR RGB SY15].setHue([68], [delay: 3000]) (6ms)
        +2328ms	║║Executed physical command [LB GAR RGB SY15].setHue([68], [delay: 3099]) (6ms)
        +2329ms	║║Executed virtual command [LB GAR RGB SY15].fadeHue (61ms)
        +2330ms	║║Waiting for 3100ms
        +5450ms	║║Executed physical command [LB GAR RGB SY15].setLevel([100]) (13ms)
        +5451ms	║║Executed virtual command [LB GAR RGB SY15].fadeLevel (17ms)
        +5471ms	║║Executed virtual command [LB GAR RGB SY15].sendPushNotification (16ms)
        +5480ms	║║Cancelling statement #33's schedules...
        +5496ms	║║Executed physical command [LB GAR RGB SY16].on() (13ms)
        +5497ms	║║Executed [LB GAR RGB SY16].on (15ms)
        +5526ms	║║Executed physical command [LB GAR RGB SY16].setHue([18]) (25ms)
        +5527ms	║║Executed [LB GAR RGB SY16].setHue (26ms)
        +5530ms	║║Executed virtual command [LB GAR RGB SY16].wait (1ms)
        +5531ms	║║Waiting for 2000ms
        +7565ms	║║Executed physical command [LB GAR RGB SY16].setHue([6]) (26ms)
        +7571ms	║║Executed physical command [LB GAR RGB SY16].setHue([16], [delay: 500]) (5ms)
        +7579ms	║║Executed physical command [LB GAR RGB SY16].setHue([27], [delay: 1000]) (7ms)
        +7586ms	║║Executed physical command [LB GAR RGB SY16].setHue([37], [delay: 1500]) (6ms)
        +7592ms	║║Executed physical command [LB GAR RGB SY16].setHue([47], [delay: 2000]) (5ms)
        +7600ms	║║Executed physical command [LB GAR RGB SY16].setHue([58], [delay: 2500]) (6ms)
        +7607ms	║║Executed physical command [LB GAR RGB SY16].setHue([68], [delay: 3000]) (5ms)
        +7613ms	║║Executed physical command [LB GAR RGB SY16].setHue([68], [delay: 3099]) (6ms)
        +7614ms	║║Executed virtual command [LB GAR RGB SY16].fadeHue (78ms)
        +7615ms	║║Requesting a wake up for Sun, May 10 2020 @ 1:05:17 AM PDT (in 3.1s)
        +7619ms	║╚Execution stage complete. (7512ms)
        +7621ms	║Setting up scheduled job for Sun, May 10 2020 @ 1:05:17 AM PDT (in 3.096s)
        +7629ms	╚Event processed successfully (7629ms)
        5/10/2020, 1:04:56 AM +491ms
        +1ms	╔Received event [BU GAR Track Light Sengled].switch = on with a delay of 83ms
        +105ms	║RunTime Analysis CS > 20ms > PS > 45ms > PE > 40ms > CE
        +108ms	║Runtime (45944 bytes) successfully initialized in 45ms (v0.3.110.20191009) (106ms)
        +109ms	║╔Execution stage started
        +120ms	║║Comparison (enum) on changes_to (string) on = true (0ms)
        +121ms	║║Cancelling condition #2's schedules...
        +122ms	║║Condition #2 evaluated true (9ms)
        +123ms	║║Cancelling condition #1's schedules...
        +124ms	║║Condition group #1 evaluated true (state changed) (12ms)
        +133ms	║║Cancelling statement #33's schedules...
        +279ms	║║Executed physical command [LB GAR RGB SY13].on() (141ms)
        +280ms	║║Executed [LB GAR RGB SY13].on (143ms)
        +312ms	║║Executed physical command [LB GAR RGB SY13].setHue([0]) (28ms)
        +313ms	║║Executed [LB GAR RGB SY13].setHue (29ms)
        +316ms	║║Executed virtual command [LB GAR RGB SY13].wait (1ms)
        +317ms	║║Waiting for 2000ms
        +2356ms	║║Executed physical command [LB GAR RGB SY13].setHue([31]) (30ms)
        +2364ms	║║Executed physical command [LB GAR RGB SY13].setHue([26], [delay: 500]) (6ms)
        +2370ms	║║Executed physical command [LB GAR RGB SY13].setHue([21], [delay: 1000]) (5ms)
        +2377ms	║║Executed physical command [LB GAR RGB SY13].setHue([16], [delay: 1500]) (6ms)
        +2384ms	║║Executed physical command [LB GAR RGB SY13].setHue([10], [delay: 2000]) (6ms)
        +2390ms	║║Executed physical command [LB GAR RGB SY13].setHue([5], [delay: 2500]) (5ms)
        +2397ms	║║Executed physical command [LB GAR RGB SY13].setHue([0], [delay: 3000]) (5ms)
        +2403ms	║║Executed physical command [LB GAR RGB SY13].setHue([0], [delay: 3099]) (6ms)
        +2404ms	║║Executed virtual command [LB GAR RGB SY13].fadeHue (82ms)
        +2405ms	║║Waiting for 3100ms
        +5525ms	║║Executed physical command [LB GAR RGB SY13].setLevel([100]) (13ms)
        +5526ms	║║Executed virtual command [LB GAR RGB SY13].fadeLevel (17ms)
        +5552ms	║║Executed virtual command [LB GAR RGB SY13].sendPushNotification (22ms)
        +5561ms	║║Cancelling statement #33's schedules...
        +5578ms	║║Executed physical command [LB GAR RGB SY14].on() (14ms)
        +5579ms	║║Executed [LB GAR RGB SY14].on (16ms)
        +5608ms	║║Executed physical command [LB GAR RGB SY14].setHue([0]) (24ms)
        +5609ms	║║Executed [LB GAR RGB SY14].setHue (25ms)
        +5612ms	║║Executed virtual command [LB GAR RGB SY14].wait (0ms)
        +5612ms	║║Waiting for 2000ms
        +7648ms	║║Executed physical command [LB GAR RGB SY14].setHue([100]) (26ms)
        +7655ms	║║Executed physical command [LB GAR RGB SY14].setHue([83], [delay: 500]) (6ms)
        +7662ms	║║Executed physical command [LB GAR RGB SY14].setHue([67], [delay: 1000]) (6ms)
        +7668ms	║║Executed physical command [LB GAR RGB SY14].setHue([50], [delay: 1500]) (4ms)
        +7674ms	║║Executed physical command [LB GAR RGB SY14].setHue([33], [delay: 2000]) (5ms)
        +7681ms	║║Executed physical command [LB GAR RGB SY14].setHue([17], [delay: 2500]) (5ms)
        +7687ms	║║Executed physical command [LB GAR RGB SY14].setHue([0], [delay: 3000]) (5ms)
        +7694ms	║║Executed physical command [LB GAR RGB SY14].setHue([0], [delay: 3099]) (6ms)
        +7695ms	║║Executed virtual command [LB GAR RGB SY14].fadeHue (77ms)
        +7696ms	║║Requesting a wake up for Sun, May 10 2020 @ 1:05:07 AM PDT (in 3.1s)
        +7701ms	║╚Execution stage complete. (7593ms)
        +7702ms	║Setting up scheduled job for Sun, May 10 2020 @ 1:05:07 AM PDT (in 3.095s)
        +7711ms	╚Event processed successfully (7711ms)
        5/10/2020, 1:04:49 AM +797ms
        +1ms	╔Received event [BU GAR Track Light Sengled].switch = off with a delay of 68ms
        +10140ms	║RunTime Analysis CS > 21ms > PS > 10060ms > PE > 59ms > CE
        +10141ms	║Piston waited at a semaphore for 10015ms
        +10143ms	║Runtime (46025 bytes) successfully initialized in 10060ms (v0.3.110.20191009) (10142ms)
        +10144ms	║╔Execution stage started
        +10155ms	║║Comparison (enum) off changes_to (string) on = false (0ms)
        +10157ms	║║Condition #2 evaluated false (9ms)
        +10158ms	║║Condition group #1 evaluated false (state did not change) (10ms)
        +10166ms	║║Comparison (enum) off changes_to (string) off = false (1ms)
        +10168ms	║║Cancelling condition #10's schedules...
        +10168ms	║║Condition #10 evaluated false (8ms)
        +10169ms	║║Cancelling condition #9's schedules...
        +10170ms	║║Condition group #9 evaluated false (state changed) (10ms)
        +10172ms	║╚Execution stage complete. (28ms)
        +10173ms	╚Event processed successfully (10173ms)
        5/10/2020, 1:04:49 AM +700ms
        +1ms	╔Received event [BU GAR Virtual Switch Office Lights].switch = off with a delay of 75ms
        +125ms	║RunTime Analysis CS > 19ms > PS > 49ms > PE > 58ms > CE
        +128ms	║Runtime (45955 bytes) successfully initialized in 49ms (v0.3.110.20191009) (126ms)
        +129ms	║╔Execution stage started
        +140ms	║║Comparison (enum) off changes_to (string) on = false (0ms)
        +141ms	║║Condition #2 evaluated false (8ms)
        +142ms	║║Condition group #1 evaluated false (state did not change) (10ms)
        +150ms	║║Comparison (enum) off changes_to (string) off = true (1ms)
        +152ms	║║Cancelling condition #10's schedules...
        +152ms	║║Condition #10 evaluated true (8ms)
        +153ms	║║Cancelling condition #9's schedules...
        +154ms	║║Condition group #9 evaluated true (state changed) (10ms)
        +156ms	║║Cancelling statement #11's schedules...
        +956ms	║║Executed physical command [LB GAR RGB SY13].off() (794ms)
        +957ms	║║Executed [LB GAR RGB SY13].off (795ms)
        +991ms	║║Executed physical command [LB GAR RGB SY14].off() (30ms)
        +992ms	║║Executed [LB GAR RGB SY14].off (32ms)
        +1024ms	║║Executed physical command [LB GAR RGB SY15].off() (30ms)
        +1025ms	║║Executed [LB GAR RGB SY15].off (31ms)
        +1057ms	║║Executed physical command [LB GAR RGB SY16].off() (29ms)
        +1058ms	║║Executed [LB GAR RGB SY16].off (31ms)
        +1089ms	║║Executed physical command [LB GAR RGB SY17].off() (28ms)
        +1090ms	║║Executed [LB GAR RGB SY17].off (30ms)
        +1121ms	║║Executed physical command [LB GAR RGB SY18].off() (28ms)
        +1122ms	║║Executed [LB GAR RGB SY18].off (30ms)
        +1152ms	║║Executed physical command [LB GAR RGB SY19].off() (27ms)
        +1153ms	║║Executed [LB GAR RGB SY19].off (29ms)
        +1184ms	║║Executed physical command [LB GAR RGB SY20].off() (28ms)
        +1184ms	║║Executed [LB GAR RGB SY20].off (29ms)
        +1219ms	║║Executed physical command [LB GAR RGB SY21].off() (32ms)
        +1220ms	║║Executed [LB GAR RGB SY21].off (34ms)
        +1222ms	║╚Execution stage complete. (1094ms)
        +1223ms	╚Event processed successfully (1223ms)
        5/10/2020, 1:04:08 AM +106ms
        +1ms	╔Starting piston... (v0.3.110.20191009)
        +1162ms	║╔Subscribing to devices...
        +1205ms	║║Subscribing to BU GAR Track Light Sengled.switch...
        +1218ms	║║Subscribing to BU GAR Virtual Switch Office Lights.switch...
        +1326ms	║║Subscribing to LB GAR RGB SY13...
        +1327ms	║║Subscribing to LB GAR RGB SY14...
        +1328ms	║║Subscribing to LB GAR RGB SY15...
        +1329ms	║║Subscribing to LB GAR RGB SY16...
        +1330ms	║║Subscribing to LB GAR RGB SY17...
        +1331ms	║║Subscribing to LB GAR RGB SY18...
        +1332ms	║║Subscribing to LB GAR RGB SY19...
        +1333ms	║║Subscribing to LB GAR RGB SY20...
        +1334ms	║║Subscribing to LB GAR RGB SY21...
        +1335ms	║╚Finished subscribing (183ms)
        +1450ms	╚Piston successfully started (1449ms)
        5/10/2020, 1:02:44 AM +67ms
        +1ms	╔Received event [Home].execute = recovery with a delay of 59ms
        +10132ms	║RunTime Analysis CS > 15ms > PS > 10076ms > PE > 41ms > CE
        +10133ms	║Piston waited at a semaphore for 10031ms
        +10136ms	║Runtime (46015 bytes) successfully initialized in 10076ms (v0.3.110.20191009) (10134ms)
        +10137ms	║╔Execution stage started
        +10150ms	║║Condition #2 evaluated false (8ms)
        +10151ms	║║Condition group #1 evaluated false (state did not change) (11ms)
        +10161ms	║║Condition #10 evaluated false (8ms)
        +10162ms	║║Condition group #9 evaluated false (state did not change) (9ms)
        +10164ms	║╚Execution stage complete. (27ms)
        +10165ms	╚Event processed successfully (10165ms)
        5/10/2020, 1:02:44 AM +86ms
        +0ms	╔Received event [Home].time = 1589097765800 with a delay of -1715ms
        +10117ms	║RunTime Analysis CS > 18ms > PS > 10062ms > PE > 38ms > CE
        +10118ms	║Piston waited at a semaphore for 10019ms
        +10120ms	║Runtime (46020 bytes) successfully initialized in 10062ms (v0.3.110.20191009) (10119ms)
        +10121ms	║╔Execution stage started
        +10122ms	║╚Execution stage complete. (1ms)
        +10123ms	╚Event processed successfully (10123ms)
        5/10/2020, 1:02:43 AM +966ms
        +0ms	╔Received event [Home].execute = recovery with a delay of 62ms
        +10120ms	║RunTime Analysis CS > 17ms > PS > 10063ms > PE > 41ms > CE
        +10121ms	║Piston waited at a semaphore for 10017ms
        +10124ms	║Runtime (46015 bytes) successfully initialized in 10063ms (v0.3.110.20191009) (10123ms)
        +10125ms	║╔Execution stage started
        +10138ms	║║Condition #2 evaluated false (9ms)
        +10139ms	║║Condition group #1 evaluated false (state did not change) (10ms)
        +10150ms	║║Condition #10 evaluated false (8ms)
        +10151ms	║║Condition group #9 evaluated false (state did not change) (10ms)
        +10153ms	║╚Execution stage complete. (29ms)
        +10154ms	╚Event processed successfully (10154ms)
        5/10/2020, 1:02:43 AM +951ms
        +1ms	╔Received event [Home].execute = recovery with a delay of 60ms
        +103ms	║RunTime Analysis CS > 19ms > PS > 44ms > PE > 40ms > CE
        +106ms	║Runtime (45928 bytes) successfully initialized in 44ms (v0.3.110.20191009) (105ms)
        +107ms	║╔Execution stage started
        +120ms	║║Cancelling condition #2's schedules...
        +121ms	║║Condition #2 evaluated false (10ms)
        +122ms	║║Cancelling condition #1's schedules...
        +123ms	║║Condition group #1 evaluated false (state changed) (12ms)
        +134ms	║║Cancelling condition #10's schedules...
        +135ms	║║Condition #10 evaluated false (8ms)
        +136ms	║║Cancelling condition #9's schedules...
        +137ms	║║Condition group #9 evaluated false (state changed) (10ms)
        +142ms	║╚Execution stage complete. (35ms)
        +143ms	╚Event processed successfully (143ms)
        5/10/2020, 1:02:39 AM +723ms
        +1ms	╔Received event [BU GAR Track Light Sengled].switch = on with a delay of 120ms
        +105ms	║RunTime Analysis CS > 21ms > PS > 49ms > PE > 35ms > CE
        +108ms	║Runtime (45949 bytes) successfully initialized in 49ms (v0.3.110.20191009) (106ms)
        +109ms	║╔Execution stage started
        +120ms	║║Comparison (enum) on changes_to (string) on = true (0ms)
        +121ms	║║Cancelling condition #2's schedules...
        +122ms	║║Condition #2 evaluated true (9ms)
        +123ms	║║Cancelling condition #1's schedules...
        +124ms	║║Condition group #1 evaluated true (state changed) (11ms)
        +133ms	║║Cancelling statement #33's schedules...
        +1034ms	║║Executed physical command [LB GAR RGB SY13].on() (897ms)
        +1035ms	║║Executed [LB GAR RGB SY13].on (899ms)
        +1071ms	║║Executed physical command [LB GAR RGB SY13].setHue([18]) (30ms)
        +1072ms	║║Executed [LB GAR RGB SY13].setHue (32ms)
        +1075ms	║║Executed virtual command [LB GAR RGB SY13].wait (0ms)
        +1076ms	║║Requesting a wake up for Sun, May 10 2020 @ 1:02:45 AM PDT (in 5.0s)
        +1081ms	║╚Execution stage complete. (971ms)
        +1082ms	║Setting up scheduled job for Sun, May 10 2020 @ 1:02:45 AM PDT (in 4.996s)
        +1090ms	╚Event processed successfully (1090ms)
        5/10/2020, 1:02:35 AM +55ms
        +1ms	╔Received event [BU GAR Track Light Sengled].switch = off with a delay of 84ms
        +99ms	║RunTime Analysis CS > 17ms > PS > 46ms > PE > 35ms > CE
        +101ms	║Runtime (45945 bytes) successfully initialized in 46ms (v0.3.110.20191009) (99ms)
        +102ms	║╔Execution stage started
        +113ms	║║Comparison (enum) off changes_to (string) on = false (0ms)
        +114ms	║║Cancelling condition #2's schedules...
        +115ms	║║Condition #2 evaluated false (9ms)
        +116ms	║║Cancelling condition #1's schedules...
        +117ms	║║Condition group #1 evaluated false (state changed) (11ms)
        +125ms	║║Comparison (enum) off changes_to (string) off = true (1ms)
        +127ms	║║Cancelling condition #10's schedules...
        +128ms	║║Condition #10 evaluated true (8ms)
        +129ms	║║Cancelling condition #9's schedules...
        +130ms	║║Condition group #9 evaluated true (state changed) (10ms)
        +132ms	║║Cancelling statement #11's schedules...
        +291ms	║║Executed physical command [LB GAR RGB SY13].off() (154ms)
        +292ms	║║Executed [LB GAR RGB SY13].off (156ms)
        +324ms	║║Executed physical command [LB GAR RGB SY14].off() (29ms)
        +325ms	║║Executed [LB GAR RGB SY14].off (31ms)
        +354ms	║║Executed physical command [LB GAR RGB SY15].off() (26ms)
        +355ms	║║Executed [LB GAR RGB SY15].off (28ms)
        +385ms	║║Executed physical command [LB GAR RGB SY16].off() (27ms)
        +386ms	║║Executed [LB GAR RGB SY16].off (29ms)
        +418ms	║║Executed physical command [LB GAR RGB SY17].off() (29ms)
        +419ms	║║Executed [LB GAR RGB SY17].off (31ms)
        +450ms	║║Executed physical command [LB GAR RGB SY18].off() (29ms)
        +451ms	║║Executed [LB GAR RGB SY18].off (29ms)
        +482ms	║║Executed physical command [LB GAR RGB SY19].off() (28ms)
        +482ms	║║Executed [LB GAR RGB SY19].off (29ms)
        +513ms	║║Executed physical command [LB GAR RGB SY20].off() (28ms)
        +514ms	║║Executed [LB GAR RGB SY20].off (30ms)
        +544ms	║║Executed physical command [LB GAR RGB SY21].off() (27ms)
        +545ms	║║Executed [LB GAR RGB SY21].off (29ms)
        +548ms	║╚Execution stage complete. (446ms)
        +549ms	╚Event processed successfully (549ms)
        5/10/2020, 1:02:09 AM +77ms
        +0ms	╔Received event [Home].time = 1589097729575 with a delay of -498ms
        +95ms	║RunTime Analysis CS > 17ms > PS > 45ms > PE > 33ms > CE
        +98ms	║Runtime (45933 bytes) successfully initialized in 45ms (v0.3.110.20191009) (97ms)
        +99ms	║╔Execution stage started
        +1060ms	║║Executed physical command [LB GAR RGB SY14].setLevel([100]) (927ms)
        +1061ms	║║Executed virtual command [LB GAR RGB SY14].fadeLevel (932ms)
        +1115ms	║║Executed virtual command [LB GAR RGB SY14].sendPushNotification (51ms)
        +1124ms	║║Cancelling statement #33's schedules...
        +1144ms	║║Executed physical command [LB GAR RGB SY15].on() (16ms)
        +1145ms	║║Executed [LB GAR RGB SY15].on (18ms)
        +1177ms	║║Executed physical command [LB GAR RGB SY15].setHue([0]) (28ms)
        +1178ms	║║Executed [LB GAR RGB SY15].setHue (29ms)
        +1181ms	║║Executed virtual command [LB GAR RGB SY15].wait (0ms)
        +1182ms	║║Requesting a wake up for Sun, May 10 2020 @ 1:02:15 AM PDT (in 5.0s)
        +1187ms	║╚Execution stage complete. (1087ms)
        +1188ms	║Setting up scheduled job for Sun, May 10 2020 @ 1:02:15 AM PDT (in 4.996s)
        +1196ms	╚Event processed successfully (1196ms)
        5/10/2020, 1:02:04 AM +80ms
        +0ms	╔Received event [Home].time = 1589097725899 with a delay of -1819ms
        +104ms	║RunTime Analysis CS > 17ms > PS > 45ms > PE > 41ms > CE
        +106ms	║Runtime (45935 bytes) successfully initialized in 45ms (v0.3.110.20191009) (105ms)
        +107ms	║╔Execution stage started
        +360ms	║║Executed physical command [LB GAR RGB SY14].setHue([65]) (225ms)
        +367ms	║║Executed physical command [LB GAR RGB SY14].setHue([66], [delay: 1667]) (6ms)
        +378ms	║║Executed physical command [LB GAR RGB SY14].setHue([67], [delay: 3334]) (9ms)
        +385ms	║║Executed physical command [LB GAR RGB SY14].setHue([68], [delay: 5001]) (6ms)
        +392ms	║║Executed physical command [LB GAR RGB SY14].setHue([68], [delay: 5099]) (5ms)
        +393ms	║║Executed virtual command [LB GAR RGB SY14].fadeHue (261ms)
        +394ms	║║Requesting a wake up for Sun, May 10 2020 @ 1:02:09 AM PDT (in 5.1s)
        +398ms	║╚Execution stage complete. (291ms)
        +399ms	║Setting up scheduled job for Sun, May 10 2020 @ 1:02:09 AM PDT (in 5.096s)
        +407ms	╚Event processed successfully (406ms)
        5/10/2020, 1:02:00 AM +212ms
        +0ms	╔Received event [Home].time = 1589097720459 with a delay of -248ms
        +93ms	║RunTime Analysis CS > 17ms > PS > 50ms > PE > 27ms > CE
        +97ms	║Runtime (45933 bytes) successfully initialized in 50ms (v0.3.110.20191009) (95ms)
        +98ms	║╔Execution stage started
        +438ms	║║Executed physical command [LB GAR RGB SY13].setLevel([100]) (305ms)
        +439ms	║║Executed virtual command [LB GAR RGB SY13].fadeLevel (309ms)
        +605ms	║║Executed virtual command [LB GAR RGB SY13].sendPushNotification (162ms)
        +615ms	║║Cancelling statement #33's schedules...
        +634ms	║║Executed physical command [LB GAR RGB SY14].on() (16ms)
        +635ms	║║Executed [LB GAR RGB SY14].on (18ms)
        +681ms	║║Executed physical command [LB GAR RGB SY14].setHue([18]) (41ms)
        +682ms	║║Executed [LB GAR RGB SY14].setHue (43ms)
        +685ms	║║Executed virtual command [LB GAR RGB SY14].wait (1ms)
        +686ms	║║Requesting a wake up for Sun, May 10 2020 @ 1:02:05 AM PDT (in 5.0s)
        +691ms	║╚Execution stage complete. (593ms)
        +692ms	║Setting up scheduled job for Sun, May 10 2020 @ 1:02:05 AM PDT (in 4.996s)
        +699ms	╚Event processed successfully (699ms)
        5/10/2020, 1:01:55 AM +78ms
        +0ms	╔Received event [Home].time = 1589097716906 with a delay of -1828ms
        +101ms	║RunTime Analysis CS > 18ms > PS > 54ms > PE > 29ms > CE
        +104ms	║Runtime (45935 bytes) successfully initialized in 54ms (v0.3.110.20191009) (103ms)
        +105ms	║╔Execution stage started
        +193ms	║║Executed physical command [LB GAR RGB SY13].setHue([65]) (63ms)
        +201ms	║║Executed physical command [LB GAR RGB SY13].setHue([59], [delay: 500]) (6ms)
        +208ms	║║Executed physical command [LB GAR RGB SY13].setHue([52], [delay: 1000]) (6ms)
        +215ms	║║Executed physical command [LB GAR RGB SY13].setHue([46], [delay: 1500]) (5ms)
        +221ms	║║Executed physical command [LB GAR RGB SY13].setHue([39], [delay: 2000]) (6ms)
        +227ms	║║Executed physical command [LB GAR RGB SY13].setHue([33], [delay: 2500]) (5ms)
        +238ms	║║Executed physical command [LB GAR RGB SY13].setHue([26], [delay: 3000]) (10ms)
        +246ms	║║Executed physical command [LB GAR RGB SY13].setHue([20], [delay: 3500]) (7ms)
        +259ms	║║Executed physical command [LB GAR RGB SY13].setHue([13], [delay: 4000]) (12ms)
        +264ms	║║Executed physical command [LB GAR RGB SY13].setHue([7], [delay: 4500]) (4ms)
        +271ms	║║Executed physical command [LB GAR RGB SY13].setHue([0], [delay: 5000]) (6ms)
        +278ms	║║Executed physical command [LB GAR RGB SY13].setHue([0], [delay: 5099]) (6ms)
        +279ms	║║Executed virtual command [LB GAR RGB SY13].fadeHue (152ms)
        +280ms	║║Requesting a wake up for Sun, May 10 2020 @ 1:02:00 AM PDT (in 5.1s)
        +285ms	║╚Execution stage complete. (181ms)
        +286ms	║Setting up scheduled job for Sun, May 10 2020 @ 1:02:00 AM PDT (in 5.095s)
        +295ms	╚Event processed successfully (294ms)
        5/10/2020, 1:01:51 AM +612ms
        +1ms	╔Received event [BU GAR Track Light Sengled].switch = on with a delay of 79ms
        +101ms	║RunTime Analysis CS > 15ms > PS > 39ms > PE > 47ms > CE
        +104ms	║Runtime (45952 bytes) successfully initialized in 39ms (v0.3.110.20191009) (102ms)
        +105ms	║╔Execution stage started
        +114ms	║║Comparison (enum) on changes_to (string) on = true (1ms)
        +116ms	║║Cancelling condition #2's schedules...
        +117ms	║║Condition #2 evaluated true (8ms)
        +118ms	║║Cancelling condition #1's schedules...
        +118ms	║║Condition group #1 evaluated true (state changed) (10ms)
        +127ms	║║Cancelling statement #33's schedules...
        +250ms	║║Executed physical command [LB GAR RGB SY13].on() (119ms)
        +251ms	║║Executed [LB GAR RGB SY13].on (121ms)
        +288ms	║║Executed physical command [LB GAR RGB SY13].setHue([18]) (31ms)
        +288ms	║║Executed [LB GAR RGB SY13].setHue (33ms)
        +292ms	║║Executed virtual command [LB GAR RGB SY13].wait (0ms)
        +293ms	║║Requesting a wake up for Sun, May 10 2020 @ 1:01:56 AM PDT (in 5.0s)
        +297ms	║╚Execution stage complete. (193ms)
        +299ms	║Setting up scheduled job for Sun, May 10 2020 @ 1:01:56 AM PDT (in 4.996s)
        +307ms	╚Event processed successfully (307ms)
        5/10/2020, 1:01:37 AM +625ms
        +1ms	╔Starting piston... (v0.3.110.20191009)
        +1232ms	║╔Subscribing to devices...
        +1274ms	║║Subscribing to BU GAR Track Light Sengled.switch...
        +1286ms	║║Subscribing to BU GAR Virtual Switch Office Lights.switch...
        +1419ms	║║Subscribing to LB GAR RGB SY13...
        +1420ms	║║Subscribing to LB GAR RGB SY14...
        +1421ms	║║Subscribing to LB GAR RGB SY15...
        +1422ms	║║Subscribing to LB GAR RGB SY16...
        +1423ms	║║Subscribing to LB GAR RGB SY17...
        +1424ms	║║Subscribing to LB GAR RGB SY18...
        +1425ms	║║Subscribing to LB GAR RGB SY19...
        +1426ms	║║Subscribing to LB GAR RGB SY20...
        +1427ms	║║Subscribing to LB GAR RGB SY21...
        +1428ms	║╚Finished subscribing (207ms)

guxdude · 2020-05-10 08:36:02 UTC

Looks like you have somewhere between 5-15 seconds of activity for each of your lights in the first loop. It can’t get through many before the ‘changes to on’ trigger is no longer valid and then the piston stops executing. That would be my guess for what you are seeing. Not sure what you are really trying to accomplish.

The logs are not formatted properly so difficult to decipher. Suggest you use </> button next time you post logs.

Terminal · 2020-05-11 11:26:12 UTC

It looks to me like everything is going okay until at 1:02:35 AM, Then the switch changes to off and triggers the piston again. Basically what guxdude said.

Received event [BU GAR Track Light Sengled].switch = off with a delay of 84ms

orangebucket · 2020-05-11 16:44:39 UTC

I am sure I’ve answered this one once already, perhaps elsewhere. Your logs are showing a ridiculous number of recovery events. So many that I can’t begin to work out which timer events have gone missing. It could just be a massive ST brain fart at the time your piston was running.

When a piston schedules a timed execution (as it does to wake up from a wait of five seconds or more) the timer event sometimes never happens for whatever reason. As pistons schedule their own next timed execution, this could mean a piston could “stop”, so webCoRE uses every running piston, as well as a regularly scheduled routine, to look out for pistons that missed a timer and sends them a ‘recovery’ event which might help them sort themselves out.

babbahotep · 2020-05-11 19:18:56 UTC

How long does the changes to trigger stay valid and is there a way to prevent or extend that interval?

WCmore · 2020-05-11 19:22:18 UTC

From what I have seen, it is until something else triggers the piston…
(Then the original is no longer “changing to” anything)

In this case, it is valid until either:

White Bulb 1’s switch changes to on… or
White Bulb 1’s switch changes to off… or
Switch 1’s switch changes to on… or
Switch 1’s switch changes to off

babbahotep · 2020-05-11 19:58:50 UTC

Version 2…
All lights turn on in sequence (loop 1), changes color (loop 2). then it stops… How could I trigger loop 3?

PS I selected the log and clicked </>. Is this right ? looks confusing below.

5/11/2020, 12:54:59 PM +784ms
       +0ms	+Received event [BU GAR Virtual Switch Office Lights].switch = on with a delay of 54ms
       +87ms	¦RunTime Analysis CS > 19ms > PS > 41ms > PE > 28ms > CE
       +90ms	¦Runtime (43788 bytes) successfully initialized in 41ms (v0.3.110.20191009) (88ms)
       +91ms	¦+Execution stage started
       +98ms	¦¦Comparison (enum) on is (string) on = true (1ms)
       +99ms	¦¦Cancelling condition #2's schedules...
       +100ms	¦¦Condition #2 evaluated true (6ms)
       +101ms	¦¦Cancelling condition #1's schedules...
       +102ms	¦¦Condition group #1 evaluated true (state changed) (8ms)
       +118ms	¦¦Comparison (enum) off is (string) off = true (1ms)
       +120ms	¦¦Cancelling condition #5's schedules...
       +121ms	¦¦Condition #5 evaluated true (9ms)
       +122ms	¦¦Cancelling condition #4's schedules...
       +123ms	¦¦Condition group #4 evaluated true (state changed) (11ms)
       +125ms	¦¦Cancelling statement #6's schedules...
       +158ms	¦¦Executed physical command [LB GAR RGB SY13].on() (31ms)
       +159ms	¦¦Executed [LB GAR RGB SY13].on (32ms)
       +181ms	¦¦Executed physical command [LB GAR RGB SY13].setLevel([100]) (17ms)
       +182ms	¦¦Executed virtual command [LB GAR RGB SY13].adjustLevel (20ms)
       +198ms	¦¦Comparison (enum) off is (string) off = true (1ms)
       +200ms	¦¦Condition #5 evaluated true (8ms)
       +201ms	¦¦Condition group #4 evaluated true (state did not change) (10ms)
       +203ms	¦¦Cancelling statement #6's schedules...
       +222ms	¦¦Executed physical command [LB GAR RGB SY14].on() (15ms)
       +222ms	¦¦Executed [LB GAR RGB SY14].on (17ms)
       +243ms	¦¦Executed physical command [LB GAR RGB SY14].setLevel([100]) (15ms)
       +244ms	¦¦Executed virtual command [LB GAR RGB SY14].adjustLevel (19ms)
       +261ms	¦¦Comparison (enum) off is (string) off = true (2ms)
       +262ms	¦¦Condition #5 evaluated true (8ms)
       +263ms	¦¦Condition group #4 evaluated true (state did not change) (10ms)
       +266ms	¦¦Cancelling statement #6's schedules...
       +285ms	¦¦Executed physical command [LB GAR RGB SY15].on() (16ms)
       +286ms	¦¦Executed [LB GAR RGB SY15].on (17ms)
       +308ms	¦¦Executed physical command [LB GAR RGB SY15].setLevel([100]) (16ms)
       +309ms	¦¦Executed virtual command [LB GAR RGB SY15].adjustLevel (20ms)
       +325ms	¦¦Comparison (enum) off is (string) off = true (1ms)
       +327ms	¦¦Condition #5 evaluated true (8ms)
       +328ms	¦¦Condition group #4 evaluated true (state did not change) (10ms)
       +330ms	¦¦Cancelling statement #6's schedules...
       +349ms	¦¦Executed physical command [LB GAR RGB SY16].on() (15ms)
       +350ms	¦¦Executed [LB GAR RGB SY16].on (17ms)
       +372ms	¦¦Executed physical command [LB GAR RGB SY16].setLevel([100]) (16ms)
       +373ms	¦¦Executed virtual command [LB GAR RGB SY16].adjustLevel (20ms)
       +389ms	¦¦Comparison (enum) off is (string) off = true (2ms)
       +390ms	¦¦Condition #5 evaluated true (8ms)
       +391ms	¦¦Condition group #4 evaluated true (state did not change) (9ms)
       +393ms	¦¦Cancelling statement #6's schedules...
       +413ms	¦¦Executed physical command [LB GAR RGB SY17].on() (17ms)
       +414ms	¦¦Executed [LB GAR RGB SY17].on (19ms)
       +435ms	¦¦Executed physical command [LB GAR RGB SY17].setLevel([100]) (15ms)
       +436ms	¦¦Executed virtual command [LB GAR RGB SY17].adjustLevel (20ms)
       +453ms	¦¦Comparison (enum) off is (string) off = true (2ms)
       +454ms	¦¦Condition #5 evaluated true (8ms)
       +455ms	¦¦Condition group #4 evaluated true (state did not change) (10ms)
       +458ms	¦¦Cancelling statement #6's schedules...
       +478ms	¦¦Executed physical command [LB GAR RGB SY18].on() (17ms)
       +479ms	¦¦Executed [LB GAR RGB SY18].on (19ms)
       +501ms	¦¦Executed physical command [LB GAR RGB SY18].setLevel([100]) (17ms)
       +502ms	¦¦Executed virtual command [LB GAR RGB SY18].adjustLevel (21ms)
       +518ms	¦¦Comparison (enum) off is (string) off = true (1ms)
       +520ms	¦¦Condition #5 evaluated true (8ms)
       +521ms	¦¦Condition group #4 evaluated true (state did not change) (10ms)
       +523ms	¦¦Cancelling statement #6's schedules...
       +543ms	¦¦Executed physical command [LB GAR RGB SY19].on() (16ms)
       +544ms	¦¦Executed [LB GAR RGB SY19].on (18ms)
       +565ms	¦¦Executed physical command [LB GAR RGB SY19].setLevel([100]) (17ms)
       +566ms	¦¦Executed virtual command [LB GAR RGB SY19].adjustLevel (20ms)
       +582ms	¦¦Comparison (enum) off is (string) off = true (1ms)
       +584ms	¦¦Condition #5 evaluated true (9ms)
       +585ms	¦¦Condition group #4 evaluated true (state did not change) (10ms)
       +587ms	¦¦Cancelling statement #6's schedules...
       +609ms	¦¦Executed physical command [LB GAR RGB SY20].on() (18ms)
       +609ms	¦¦Executed [LB GAR RGB SY20].on (20ms)
       +631ms	¦¦Executed physical command [LB GAR RGB SY20].setLevel([100]) (16ms)
       +632ms	¦¦Executed virtual command [LB GAR RGB SY20].adjustLevel (20ms)
       +649ms	¦¦Comparison (enum) off is (string) off = true (2ms)
       +650ms	¦¦Condition #5 evaluated true (8ms)
       +651ms	¦¦Condition group #4 evaluated true (state did not change) (10ms)
       +654ms	¦¦Cancelling statement #6's schedules...
       +672ms	¦¦Executed physical command [LB GAR RGB SY21].on() (15ms)
       +673ms	¦¦Executed [LB GAR RGB SY21].on (18ms)
       +695ms	¦¦Executed physical command [LB GAR RGB SY21].setLevel([100]) (16ms)
       +696ms	¦¦Executed virtual command [LB GAR RGB SY21].adjustLevel (20ms)
       +711ms	¦¦Comparison (enum) on is (string) on = true (1ms)
       +713ms	¦¦Cancelling condition #10's schedules...
       +714ms	¦¦Condition #10 evaluated true (7ms)
       +715ms	¦¦Cancelling condition #9's schedules...
       +716ms	¦¦Condition group #9 evaluated true (state changed) (9ms)
       +718ms	¦¦Cancelling statement #11's schedules...
       +768ms	¦¦Executed physical command [LB GAR RGB SY13].setHue([100]) (41ms)
       +769ms	¦¦Executed virtual command [LB GAR RGB SY13].fadeHue (46ms)
       +814ms	¦¦Executed physical command [LB GAR RGB SY13].setColor([[hex:    #4169E1, hue:63, saturation:73, level:57]]) (42ms)
       +815ms	¦¦Executed [LB GAR RGB SY13].setColor (44ms)
       +828ms	¦¦Comparison (enum) on is (string) on = true (1ms)
       +829ms	¦¦Condition #10 evaluated true (5ms)
       +830ms	¦¦Condition group #9 evaluated true (state did not change) (6ms)
       +833ms	¦¦Cancelling statement #11's schedules...
       +866ms	¦¦Executed physical command [LB GAR RGB SY14].setHue([100]) (25ms)
       +867ms	¦¦Executed virtual command [LB GAR RGB SY14].fadeHue (30ms)
       +908ms	¦¦Executed physical command [LB GAR RGB SY14].setColor([[hex:    #FF6347, hue:3, saturation:100, level:64]]) (38ms)
       +909ms	¦¦Executed [LB GAR RGB SY14].setColor (40ms)
       +922ms	¦¦Comparison (enum) on is (string) on = true (1ms)
       +924ms	¦¦Condition #10 evaluated true (5ms)
       +925ms	¦¦Condition group #9 evaluated true (state did not change) (6ms)
       +927ms	¦¦Cancelling statement #11's schedules...
       +1067ms	¦¦Executed physical command [LB GAR RGB SY15].setHue([100]) (132ms)
       +1068ms	¦¦Executed virtual command [LB GAR RGB SY15].fadeHue (136ms)
       +1112ms	¦¦Executed physical command [LB GAR RGB SY15].setColor([[hex:    #66CDAA, hue:44, saturation:51, level:60]]) (41ms)
       +1113ms	¦¦Executed [LB GAR RGB SY15].setColor (43ms)
       +1126ms	¦¦Comparison (enum) on is (string) on = true (2ms)
       +1127ms	¦¦Condition #10 evaluated true (5ms)
       +1128ms	¦¦Condition group #9 evaluated true (state did not change) (6ms)
       +1131ms	¦¦Cancelling statement #11's schedules...
       +1164ms	¦¦Executed physical command [LB GAR RGB SY16].setHue([100]) (25ms)
       +1165ms	¦¦Executed virtual command [LB GAR RGB SY16].fadeHue (30ms)
       +1207ms	¦¦Executed physical command [LB GAR RGB SY16].setColor([[hex:    #D2B48C, hue:9, saturation:44, level:69]]) (39ms)
       +1208ms	¦¦Executed [LB GAR RGB SY16].setColor (41ms)
       +1220ms	¦¦Comparison (enum) on is (string) on = true (1ms)
       +1222ms	¦¦Condition #10 evaluated true (5ms)
       +1223ms	¦¦Condition group #9 evaluated true (state did not change) (7ms)
       +1225ms	¦¦Cancelling statement #11's schedules...
       +1257ms	¦¦Executed physical command [LB GAR RGB SY17].setHue([100]) (25ms)
       +1258ms	¦¦Executed virtual command [LB GAR RGB SY17].fadeHue (29ms)
       +1717ms	¦¦Executed physical command [LB GAR RGB SY17].setColor([[hex:    #FF69B4, hue:92, saturation:100, level:71]]) (455ms)
       +1718ms	¦¦Executed [LB GAR RGB SY17].setColor (457ms)
       +1730ms	¦¦Comparison (enum) on is (string) on = true (1ms)
       +1732ms	¦¦Condition #10 evaluated true (4ms)
       +1733ms	¦¦Condition group #9 evaluated true (state did not change) (6ms)
       +1735ms	¦¦Cancelling statement #11's schedules...
       +1849ms	¦¦Executed physical command [LB GAR RGB SY18].setHue([100]) (107ms)
       +1850ms	¦¦Executed virtual command [LB GAR RGB SY18].fadeHue (111ms)
       +1920ms	¦¦Executed physical command [LB GAR RGB SY18].setColor([[hex:    #7B68EE, hue:69, saturation:80, level:67]]) (67ms)
       +1921ms	¦¦Executed [LB GAR RGB SY18].setColor (69ms)
       +1934ms	¦¦Comparison (enum) on is (string) on = true (1ms)
       +1936ms	¦¦Condition #10 evaluated true (5ms)
       +1937ms	¦¦Condition group #9 evaluated true (state did not change) (6ms)
       +1939ms	¦¦Cancelling statement #11's schedules...
       +1984ms	¦¦Executed physical command [LB GAR RGB SY19].setHue([100]) (35ms)
       +1985ms	¦¦Executed virtual command [LB GAR RGB SY19].fadeHue (42ms)
       +2036ms	¦¦Executed physical command [LB GAR RGB SY19].setColor([[hex:    #DB7093, hue:94, saturation:60, level:65]]) (48ms)
       +2037ms	¦¦Executed [LB GAR RGB SY19].setColor (50ms)
       +2050ms	¦¦Comparison (enum) on is (string) on = true (1ms)
       +2052ms	¦¦Condition #10 evaluated true (5ms)
       +2053ms	¦¦Condition group #9 evaluated true (state did not change) (6ms)
       +2055ms	¦¦Cancelling statement #11's schedules...
       +2090ms	¦¦Executed physical command [LB GAR RGB SY20].setHue([100]) (27ms)
       +2092ms	¦¦Executed virtual command [LB GAR RGB SY20].fadeHue (32ms)
       +2140ms	¦¦Executed physical command [LB GAR RGB SY20].setColor([[hex:    #FDF5E6, hue:11, saturation:85, level:95]]) (44ms)
       +2141ms	¦¦Executed [LB GAR RGB SY20].setColor (46ms)
       +2154ms	¦¦Comparison (enum) on is (string) on = true (1ms)
       +2155ms	¦¦Condition #10 evaluated true (5ms)
       +2156ms	¦¦Condition group #9 evaluated true (state did not change) (6ms)
       +2158ms	¦¦Cancelling statement #11's schedules...
       +2192ms	¦¦Executed physical command [LB GAR RGB SY21].setHue([100]) (26ms)
       +2193ms	¦¦Executed virtual command [LB GAR RGB SY21].fadeHue (30ms)
       +2241ms	¦¦Executed physical command [LB GAR RGB SY21].setColor([[hex:    #FF6347, hue:3, saturation:100, level:64]]) (45ms)
       +2242ms	¦¦Executed [LB GAR RGB SY21].setColor (47ms)
       +2256ms	¦¦Comparison (enum) on is (string) on = true (1ms)
       +2258ms	¦¦Cancelling condition #18's schedules...
       +2259ms	¦¦Condition #18 evaluated true (6ms)
       +2260ms	¦¦Cancelling condition #17's schedules...
       +2261ms	¦¦Condition group #17 evaluated true (state changed) (9ms)
       +2264ms	¦¦Cancelling statement #19's schedules...
       +2308ms	¦¦Executed physical command [LB GAR RGB SY13].setColor([[hex:    #FF00FF, hue:83, saturation:100, level:50]]) (41ms)
       +2309ms	¦¦Executed [LB GAR RGB SY13].setColor (43ms)
       +2322ms	¦¦Comparison (enum) on is (string) on = true (1ms)
       +2324ms	¦¦Condition #18 evaluated true (5ms)
       +2325ms	¦¦Condition group #17 evaluated true (state did not change) (7ms)
       +2327ms	¦¦Cancelling statement #19's schedules...
       +2371ms	¦¦Executed physical command [LB GAR RGB SY14].setColor([[hex:    #FF00FF, hue:83, saturation:100, level:50]]) (40ms)
       +2372ms	¦¦Executed [LB GAR RGB SY14].setColor (42ms)
       +2385ms	¦¦Comparison (enum) on is (string) on = true (1ms)
       +2386ms	¦¦Condition #18 evaluated true (5ms)
       +2387ms	¦¦Condition group #17 evaluated true (state did not change) (6ms)
       +2389ms	¦¦Cancelling statement #19's schedules...
       +2433ms	¦¦Executed physical command [LB GAR RGB SY15].setColor([[hex:    #FF00FF, hue:83, saturation:100, level:50]]) (39ms)
       +2434ms	¦¦Executed [LB GAR RGB SY15].setColor (41ms)
       +2446ms	¦¦Comparison (enum) on is (string) on = true (2ms)
       +2447ms	¦¦Condition #18 evaluated true (5ms)
       +2448ms	¦¦Condition group #17 evaluated true (state did not change) (6ms)
       +2450ms	¦¦Cancelling statement #19's schedules...
       +2531ms	¦¦Executed physical command [LB GAR RGB SY16].setColor([[hex:    #FF00FF, hue:83, saturation:100, level:50]]) (77ms)
       +2532ms	¦¦Executed [LB GAR RGB SY16].setColor (79ms)
       +2545ms	¦¦Comparison (enum) on is (string) on = true (1ms)
       +2546ms	¦¦Condition #18 evaluated true (5ms)
       +2547ms	¦¦Condition group #17 evaluated true (state did not change) (6ms)
       +2549ms	¦¦Cancelling statement #19's schedules...
       +2594ms	¦¦Executed physical command [LB GAR RGB SY17].setColor([[hex:    #FF00FF, hue:83, saturation:100, level:50]]) (41ms)
       +2595ms	¦¦Executed [LB GAR RGB SY17].setColor (43ms)
       +2608ms	¦¦Comparison (enum) on is (string) on = true (1ms)
       +2609ms	¦¦Condition #18 evaluated true (5ms)
       +2610ms	¦¦Condition group #17 evaluated true (state did not change) (6ms)
       +2613ms	¦¦Cancelling statement #19's schedules...
       +2656ms	¦¦Executed physical command [LB GAR RGB SY18].setColor([[hex:    #FF00FF, hue:83, saturation:100, level:50]]) (40ms)
       +2657ms	¦¦Executed [LB GAR RGB SY18].setColor (41ms)
       +2669ms	¦¦Comparison (enum) on is (string) on = true (1ms)
       +2671ms	¦¦Condition #18 evaluated true (4ms)
       +2671ms	¦¦Condition group #17 evaluated true (state did not change) (6ms)
       +2674ms	¦¦Cancelling statement #19's schedules...
       +2716ms	¦¦Executed physical command [LB GAR RGB SY19].setColor([[hex:    #FF00FF, hue:83, saturation:100, level:50]]) (39ms)
       +2717ms	¦¦Executed [LB GAR RGB SY19].setColor (41ms)
       +2730ms	¦¦Comparison (enum) on is (string) on = true (1ms)
       +2731ms	¦¦Condition #18 evaluated true (5ms)
       +2732ms	¦¦Condition group #17 evaluated true (state did not change) (6ms)
       +2734ms	¦¦Cancelling statement #19's schedules...
       +2777ms	¦¦Executed physical command [LB GAR RGB SY20].setColor([[hex:    #FF00FF, hue:83, saturation:100, level:50]]) (40ms)
       +2778ms	¦¦Executed [LB GAR RGB SY20].setColor (41ms)
       +2791ms	¦¦Comparison (enum) on is (string) on = true (1ms)
       +2792ms	¦¦Condition #18 evaluated true (5ms)
       +2793ms	¦¦Condition group #17 evaluated true (state did not change) (6ms)
       +2795ms	¦¦Cancelling statement #19's schedules...
       +2837ms	¦¦Executed physical command [LB GAR RGB SY21].setColor([[hex:    #FF00FF, hue:83, saturation:100, level:50]]) (39ms)
       +2838ms	¦¦Executed [LB GAR RGB SY21].setColor (40ms)
       +2845ms	¦¦Comparison (enum) on changes_to (string) off = false (0ms)
       +2847ms	¦¦Cancelling condition #29's schedules...
       +2848ms	¦¦Condition #29 evaluated false (6ms)
       +2849ms	¦¦Cancelling condition #28's schedules...
       +2850ms	¦¦Condition group #28 evaluated false (state changed) (8ms)
       +2853ms	¦+Execution stage complete. (2763ms)
       +2854ms	+Event processed successfully (2854ms)
       5/11/2020, 12:54:50 PM +666ms
       +0ms	+Received event [BU GAR Virtual Switch Office Lights].switch = off with a delay of 53ms
       +96ms	¦RunTime Analysis CS > 14ms > PS > 39ms > PE > 43ms > CE
       +98ms	¦Runtime (43787 bytes) successfully initialized in 39ms (v0.3.110.20191009) (97ms)
       +99ms	¦+Execution stage started
       +106ms	¦¦Comparison (enum) off is (string) on = false (1ms)
       +107ms	¦¦Cancelling condition #2's schedules...
       +108ms	¦¦Condition #2 evaluated false (5ms)
       +109ms	¦¦Cancelling condition #1's schedules...
       +110ms	¦¦Condition group #1 evaluated false (state changed) (8ms)
       +122ms	¦¦Comparison (enum) off is (string) on = false (1ms)
       +123ms	¦¦Cancelling condition #10's schedules...
       +124ms	¦¦Condition #10 evaluated false (6ms)
       +125ms	¦¦Cancelling condition #9's schedules...
       +126ms	¦¦Condition group #9 evaluated false (state changed) (8ms)
       +137ms	¦¦Comparison (enum) off is (string) on = false (1ms)
       +139ms	¦¦Condition #10 evaluated false (4ms)
       +139ms	¦¦Condition group #9 evaluated false (state did not change) (5ms)
       +151ms	¦¦Comparison (enum) off is (string) on = false (1ms)
       +152ms	¦¦Condition #10 evaluated false (5ms)
       +153ms	¦¦Condition group #9 evaluated false (state did not change) (6ms)
       +164ms	¦¦Comparison (enum) off is (string) on = false (1ms)
       +165ms	¦¦Condition #10 evaluated false (4ms)
       +166ms	¦¦Condition group #9 evaluated false (state did not change) (6ms)
       +178ms	¦¦Comparison (enum) off is (string) on = false (1ms)
       +179ms	¦¦Condition #10 evaluated false (5ms)
       +180ms	¦¦Condition group #9 evaluated false (state did not change) (5ms)
       +191ms	¦¦Comparison (enum) off is (string) on = false (1ms)
       +192ms	¦¦Condition #10 evaluated false (4ms)
       +193ms	¦¦Condition group #9 evaluated false (state did not change) (6ms)
       +204ms	¦¦Comparison (enum) off is (string) on = false (1ms)
       +206ms	¦¦Condition #10 evaluated false (4ms)
       +206ms	¦¦Condition group #9 evaluated false (state did not change) (5ms)
       +218ms	¦¦Comparison (enum) off is (string) on = false (2ms)
       +219ms	¦¦Condition #10 evaluated false (5ms)
       +220ms	¦¦Condition group #9 evaluated false (state did not change) (6ms)
       +232ms	¦¦Comparison (enum) off is (string) on = false (1ms)
       +233ms	¦¦Condition #10 evaluated false (5ms)
       +234ms	¦¦Condition group #9 evaluated false (state did not change) (6ms)
       +246ms	¦¦Comparison (enum) off is (string) on = false (1ms)
       +248ms	¦¦Cancelling condition #18's schedules...
       +249ms	¦¦Condition #18 evaluated false (5ms)
       +249ms	¦¦Cancelling condition #17's schedules...
       +250ms	¦¦Condition group #17 evaluated false (state changed) (7ms)
       +262ms	¦¦Comparison (enum) off is (string) on = false (1ms)
       +263ms	¦¦Condition #18 evaluated false (4ms)
       +264ms	¦¦Condition group #17 evaluated false (state did not change) (6ms)
       +276ms	¦¦Comparison (enum) off is (string) on = false (1ms)
       +277ms	¦¦Condition #18 evaluated false (5ms)
       +278ms	¦¦Condition group #17 evaluated false (state did not change) (6ms)
       +289ms	¦¦Comparison (enum) off is (string) on = false (1ms)
       +291ms	¦¦Condition #18 evaluated false (4ms)
       +292ms	¦¦Condition group #17 evaluated false (state did not change) (5ms)
       +304ms	¦¦Comparison (enum) off is (string) on = false (1ms)
       +305ms	¦¦Condition #18 evaluated false (5ms)
       +306ms	¦¦Condition group #17 evaluated false (state did not change) (6ms)
       +318ms	¦¦Comparison (enum) off is (string) on = false (1ms)
       +319ms	¦¦Condition #18 evaluated false (5ms)
       +320ms	¦¦Condition group #17 evaluated false (state did not change) (6ms)
       +332ms	¦¦Comparison (enum) off is (string) on = false (1ms)
       +334ms	¦¦Condition #18 evaluated false (5ms)
       +335ms	¦¦Condition group #17 evaluated false (state did not change) (5ms)
       +346ms	¦¦Comparison (enum) off is (string) on = false (1ms)
       +348ms	¦¦Condition #18 evaluated false (4ms)
       +349ms	¦¦Condition group #17 evaluated false (state did not change) (6ms)
       +360ms	¦¦Comparison (enum) off is (string) on = false (1ms)
       +361ms	¦¦Condition #18 evaluated false (4ms)
       +362ms	¦¦Condition group #17 evaluated false (state did not change) (6ms)
       +368ms	¦¦Comparison (enum) off changes_to (string) off = true (1ms)
       +369ms	¦¦Cancelling condition #29's schedules...
       +370ms	¦¦Condition #29 evaluated true (5ms)
       +371ms	¦¦Cancelling condition #28's schedules...
       +372ms	¦¦Condition group #28 evaluated true (state changed) (6ms)
       +374ms	¦¦Cancelling statement #30's schedules...
       +522ms	¦¦Executed physical command [LB GAR RGB SY13].off() (141ms)
       +523ms	¦¦Executed [LB GAR RGB SY13].off (142ms)
       +554ms	¦¦Executed physical command [LB GAR RGB SY14].off() (28ms)
       +555ms	¦¦Executed [LB GAR RGB SY14].off (30ms)
       +585ms	¦¦Executed physical command [LB GAR RGB SY15].off() (27ms)
       +586ms	¦¦Executed [LB GAR RGB SY15].off (29ms)
       +615ms	¦¦Executed physical command [LB GAR RGB SY16].off() (27ms)
       +616ms	¦¦Executed [LB GAR RGB SY16].off (28ms)
       +646ms	¦¦Executed physical command [LB GAR RGB SY17].off() (28ms)
       +647ms	¦¦Executed [LB GAR RGB SY17].off (28ms)
       +677ms	¦¦Executed physical command [LB GAR RGB SY18].off() (28ms)
       +678ms	¦¦Executed [LB GAR RGB SY18].off (29ms)
       +707ms	¦¦Executed physical command [LB GAR RGB SY19].off() (27ms)
       +708ms	¦¦Executed [LB GAR RGB SY19].off (28ms)
       +738ms	¦¦Executed physical command [LB GAR RGB SY20].off() (28ms)
       +739ms	¦¦Executed [LB GAR RGB SY20].off (30ms)
       +768ms	¦¦Executed physical command [LB GAR RGB SY21].off() (26ms)
       +769ms	¦¦Executed [LB GAR RGB SY21].off (28ms)
       +772ms	¦+Execution stage complete. (672ms)
       +773ms	+Event processed successfully (774ms)

WCmore · 2020-05-11 20:10:14 UTC

I think there needs to be an empty line before the code you select.
(I fixed your post)

Edit, for some reason, your logs jumped back out of preformatting, so I just went thru the process again.

guxdude · 2020-05-26 18:11:35 UTC

Right now you only have one trigger which is the switch turning off. Do you execute the piston from somewhere else? Now that you have simplified your activities, I would suggest simplifying the logic with:

If switch changes to on
   or
   switch is on               <-- this will keep things going if the 'changes to' times out
then
  for loop
     do stuff
  end for
  for loop
     do second stuff
  end for
  for loop
     do third stuff
  end for
end if