Power below level turn off

[Cbarth3]

1) Give a description of the problem
Can’t get piston to turn off device

2) What is the expected behaviour?
After 5 minutes and current below set level turn off device

3) What is happening/not happening?
Device not turning off

**4) Post a Green Snapshot of the piston

5) Attach logs after turning logging level to Full

5/19/2020, 11:48:50 PM +243ms
+10134ms ║Piston waited at a semaphore for 10014ms
5/19/2020, 11:48:00 PM +315ms
+10114ms ║Piston waited at a semaphore for 10015ms
5/19/2020, 11:47:06 PM +413ms
+1ms ╔Received event [Printer].voltage = 122.1 with a delay of 80ms
+131ms ║RunTime Analysis CS > 23ms > PS > 57ms > PE > 52ms > CE
+134ms ║Runtime (37978 bytes) successfully initialized in 57ms (v0.3.110.20191009) (132ms)
+135ms ║╔Execution stage started
+147ms ║║Comparison (string) 0.1 is_less_than (decimal) 0.15 = true (1ms)
+149ms ║║Condition #2 evaluated true (10ms)
+153ms ║║Comparison (decimal) 122.1 is_greater_than_or_equal_to (integer) 119 = true (1ms)
+154ms ║║Condition #7 evaluated true (4ms)
+155ms ║║Condition group #1 evaluated true (state did not change) (17ms)
+157ms ║║Cancelling statement #4's schedules...
+162ms ║║Executed virtual command [Printer].wait (0ms)
+163ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:52:06 PM CDT (in 300.0s)
+167ms ║╚Execution stage complete. (32ms)
+168ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:52:06 PM CDT (in 299.996s)
+188ms ╚Event processed successfully (188ms)
5/19/2020, 11:47:03 PM +719ms
+2ms ╔Received event [Printer].current = 0.1 with a delay of 63ms
+112ms ║RunTime Analysis CS > 20ms > PS > 45ms > PE > 47ms > CE
+114ms ║Runtime (37977 bytes) successfully initialized in 45ms (v0.3.110.20191009) (112ms)
+115ms ║╔Execution stage started
+122ms ║║Comparison (string) 0.1 is_less_than (decimal) 0.15 = true (1ms)
+123ms ║║Condition #2 evaluated true (4ms)
+130ms ║║Comparison (decimal) 122.0 is_greater_than_or_equal_to (integer) 119 = true (1ms)
+131ms ║║Condition #7 evaluated true (7ms)
+132ms ║║Condition group #1 evaluated true (state did not change) (14ms)
+134ms ║║Cancelling statement #4's schedules...
+138ms ║║Executed virtual command [Printer].wait (1ms)
+139ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:52:03 PM CDT (in 300.0s)
+143ms ║╚Execution stage complete. (28ms)
+144ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:52:03 PM CDT (in 299.997s)
+159ms ╚Event processed successfully (159ms)
5/19/2020, 11:46:52 PM +30ms
+2ms ╔Received event [Printer].current = 0.09 with a delay of 70ms
+10208ms ║RunTime Analysis CS > 23ms > PS > 10127ms > PE > 57ms > CE
+10209ms ║Piston waited at a semaphore for 10016ms
+10211ms ║Runtime (38058 bytes) successfully initialized in 10127ms (v0.3.110.20191009) (10209ms)
+10212ms ║╔Execution stage started
+10219ms ║║Comparison (string) 0.09 is_less_than (decimal) 0.15 = true (2ms)
+10220ms ║║Condition #2 evaluated true (5ms)
+10229ms ║║Comparison (decimal) 122.0 is_greater_than_or_equal_to (integer) 119 = true (1ms)
+10230ms ║║Condition #7 evaluated true (9ms)
+10231ms ║║Condition group #1 evaluated true (state did not change) (16ms)
+10233ms ║║Cancelling statement #4's schedules...
+10237ms ║║Executed virtual command [Printer].wait (0ms)
+10238ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:52:02 PM CDT (in 300.0s)
+10242ms ║╚Execution stage complete. (31ms)
+10243ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:52:02 PM CDT (in 299.996s)
+10262ms ╚Event processed successfully (10262ms)
5/19/2020, 11:47:00 PM +629ms
+2ms ╔Received event [Printer].voltage = 122 with a delay of 67ms
+114ms ║RunTime Analysis CS > 18ms > PS > 48ms > PE > 48ms > CE
+117ms ║Runtime (37976 bytes) successfully initialized in 48ms (v0.3.110.20191009) (115ms)
+118ms ║╔Execution stage started
+130ms ║║Comparison (string) 0.09 is_less_than (decimal) 0.15 = true (1ms)
+131ms ║║Condition #2 evaluated true (9ms)
+135ms ║║Comparison (decimal) 122.0 is_greater_than_or_equal_to (integer) 119 = true (1ms)
+137ms ║║Condition #7 evaluated true (5ms)
+138ms ║║Condition group #1 evaluated true (state did not change) (16ms)
+140ms ║║Cancelling statement #4's schedules...
+145ms ║║Executed virtual command [Printer].wait (0ms)
+146ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:52:00 PM CDT (in 300.0s)
+150ms ║╚Execution stage complete. (33ms)
+151ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:52:00 PM CDT (in 299.995s)
+165ms ╚Event processed successfully (165ms)
5/19/2020, 11:46:45 PM +343ms
+2ms ╔Received event [Printer].current = 0.1 with a delay of 73ms
+10148ms ║RunTime Analysis CS > 23ms > PS > 10071ms > PE > 54ms > CE
+10149ms ║Piston waited at a semaphore for 10014ms
+10152ms ║Runtime (38057 bytes) successfully initialized in 10071ms (v0.3.110.20191009) (10148ms)
+10152ms ║╔Execution stage started
+10160ms ║║Comparison (string) 0.1 is_less_than (decimal) 0.15 = true (1ms)
+10162ms ║║Condition #2 evaluated true (5ms)
+10169ms ║║Comparison (decimal) 124.2 is_greater_than_or_equal_to (integer) 119 = true (2ms)
+10170ms ║║Condition #7 evaluated true (8ms)
+10171ms ║║Condition group #1 evaluated true (state did not change) (15ms)
+10173ms ║║Cancelling statement #4's schedules...
+10178ms ║║Executed virtual command [Printer].wait (1ms)
+10179ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:51:55 PM CDT (in 300.0s)
+10183ms ║╚Execution stage complete. (30ms)
+10184ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:51:55 PM CDT (in 299.997s)
+10197ms ╚Event processed successfully (10197ms)
5/19/2020, 11:46:51 PM +829ms
+2ms ╔Received event [Printer].voltage = 124.2 with a delay of 67ms
+132ms ║RunTime Analysis CS > 21ms > PS > 52ms > PE > 58ms > CE
+134ms ║Runtime (37978 bytes) successfully initialized in 52ms (v0.3.110.20191009) (132ms)
+135ms ║╔Execution stage started
+147ms ║║Comparison (string) 0.09 is_less_than (decimal) 0.15 = true (1ms)
+148ms ║║Condition #2 evaluated true (9ms)
+153ms ║║Comparison (decimal) 124.2 is_greater_than_or_equal_to (integer) 119 = true (1ms)
+154ms ║║Condition #7 evaluated true (5ms)
+155ms ║║Condition group #1 evaluated true (state did not change) (16ms)
+157ms ║║Cancelling statement #4's schedules...
+161ms ║║Executed virtual command [Printer].wait (0ms)
+162ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:51:51 PM CDT (in 300.0s)
+166ms ║╚Execution stage complete. (31ms)
+168ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:51:51 PM CDT (in 299.996s)
+256ms ╚Event processed successfully (256ms)
5/19/2020, 11:46:45 PM +151ms
+1ms ╔Received event [Printer].voltage = 125.1 with a delay of 77ms
+145ms ║RunTime Analysis CS > 37ms > PS > 57ms > PE > 52ms > CE
+148ms ║Runtime (37979 bytes) successfully initialized in 57ms (v0.3.110.20191009) (145ms)
+148ms ║╔Execution stage started
+160ms ║║Comparison (string) 0.1 is_less_than (decimal) 0.15 = true (1ms)
+161ms ║║Condition #2 evaluated true (9ms)
+165ms ║║Comparison (decimal) 125.1 is_greater_than_or_equal_to (integer) 119 = true (1ms)
+166ms ║║Condition #7 evaluated true (4ms)
+167ms ║║Condition group #1 evaluated true (state did not change) (15ms)
+169ms ║║Cancelling statement #4's schedules...
+173ms ║║Executed virtual command [Printer].wait (0ms)
+175ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:51:45 PM CDT (in 300.0s)
+178ms ║╚Execution stage complete. (30ms)
+179ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:51:45 PM CDT (in 299.996s)
+202ms ╚Event processed successfully (202ms)
5/19/2020, 11:46:42 PM +254ms
+1ms ╔Received event [Printer].voltage = 122.1 with a delay of 69ms
+115ms ║RunTime Analysis CS > 19ms > PS > 47ms > PE > 49ms > CE
+118ms ║Runtime (37979 bytes) successfully initialized in 47ms (v0.3.110.20191009) (115ms)
+119ms ║╔Execution stage started
+129ms ║║Comparison (string) 0.09 is_less_than (decimal) 0.15 = true (1ms)
+131ms ║║Condition #2 evaluated true (9ms)
+135ms ║║Comparison (decimal) 122.1 is_greater_than_or_equal_to (integer) 119 = true (2ms)
+136ms ║║Condition #7 evaluated true (5ms)
+137ms ║║Condition group #1 evaluated true (state did not change) (15ms)
+139ms ║║Cancelling statement #4's schedules...
+143ms ║║Executed virtual command [Printer].wait (1ms)
+144ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:51:42 PM CDT (in 300.0s)
+148ms ║╚Execution stage complete. (29ms)
+149ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:51:42 PM CDT (in 299.997s)
+166ms ╚Event processed successfully (166ms)
5/19/2020, 11:46:41 PM +318ms
+0ms ╔Received event [Printer].voltage = 122 with a delay of 45ms
+92ms ║RunTime Analysis CS > 15ms > PS > 33ms > PE > 45ms > CE
+95ms ║Runtime (37976 bytes) successfully initialized in 33ms (v0.3.110.20191009) (93ms)
+95ms ║╔Execution stage started
+106ms ║║Comparison (string) 0.09 is_less_than (decimal) 0.15 = true (2ms)
+107ms ║║Condition #2 evaluated true (8ms)
+111ms ║║Comparison (decimal) 122.0 is_greater_than_or_equal_to (integer) 119 = true (1ms)
+113ms ║║Condition #7 evaluated true (4ms)
+114ms ║║Condition group #1 evaluated true (state did not change) (14ms)
+115ms ║║Cancelling statement #4's schedules...
+119ms ║║Executed virtual command [Printer].wait (1ms)
+120ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:51:41 PM CDT (in 300.0s)
+124ms ║╚Execution stage complete. (29ms)
+125ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:51:41 PM CDT (in 299.996s)
+141ms ╚Event processed successfully (141ms)
5/19/2020, 11:46:33 PM +634ms
+1ms ╔Received event [Printer].voltage = 124.2 with a delay of 54ms
+101ms ║RunTime Analysis CS > 17ms > PS > 36ms > PE > 47ms > CE
+103ms ║Runtime (37979 bytes) successfully initialized in 36ms (v0.3.110.20191009) (101ms)
+104ms ║╔Execution stage started
+114ms ║║Comparison (string) 0.09 is_less_than (decimal) 0.15 = true (2ms)
+115ms ║║Condition #2 evaluated true (7ms)
+119ms ║║Comparison (decimal) 124.2 is_greater_than_or_equal_to (integer) 119 = true (1ms)
+120ms ║║Condition #7 evaluated true (4ms)
+121ms ║║Condition group #1 evaluated true (state did not change) (14ms)
+123ms ║║Cancelling statement #4's schedules...
+127ms ║║Executed virtual command [Printer].wait (1ms)
+128ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:51:33 PM CDT (in 300.0s)
+132ms ║╚Execution stage complete. (28ms)
+133ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:51:33 PM CDT (in 299.997s)
+146ms ╚Event processed successfully (146ms)
5/19/2020, 11:46:31 PM +992ms
+0ms ╔Received event [Printer].current = 0.09 with a delay of 60ms
+103ms ║RunTime Analysis CS > 17ms > PS > 34ms > PE > 53ms > CE
+106ms ║Runtime (37977 bytes) successfully initialized in 34ms (v0.3.110.20191009) (105ms)
+107ms ║╔Execution stage started
+115ms ║║Comparison (string) 0.09 is_less_than (decimal) 0.15 = true (2ms)
+116ms ║║Condition #2 evaluated true (5ms)
+123ms ║║Comparison (decimal) 122.0 is_greater_than_or_equal_to (integer) 119 = true (1ms)
+125ms ║║Condition #7 evaluated true (7ms)
+126ms ║║Condition group #1 evaluated true (state did not change) (14ms)
+127ms ║║Cancelling statement #4's schedules...
+131ms ║║Executed virtual command [Printer].wait (0ms)
+132ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:51:32 PM CDT (in 300.0s)
+136ms ║╚Execution stage complete. (30ms)
+138ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:51:32 PM CDT (in 299.996s)
+152ms ╚Event processed successfully (152ms)
5/19/2020, 11:46:31 PM +732ms
+2ms ╔Received event [Printer].voltage = 122 with a delay of 64ms
+110ms ║RunTime Analysis CS > 18ms > PS > 47ms > PE > 45ms > CE
+112ms ║Runtime (37976 bytes) successfully initialized in 47ms (v0.3.110.20191009) (110ms)
+113ms ║╔Execution stage started
+124ms ║║Comparison (string) 0.1 is_less_than (decimal) 0.15 = true (1ms)
+125ms ║║Condition #2 evaluated true (8ms)
+129ms ║║Comparison (decimal) 122.0 is_greater_than_or_equal_to (integer) 119 = true (1ms)
+130ms ║║Condition #7 evaluated true (4ms)
+131ms ║║Condition group #1 evaluated true (state did not change) (15ms)
+133ms ║║Cancelling statement #4's schedules...
+137ms ║║Executed virtual command [Printer].wait (0ms)
+138ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:51:31 PM CDT (in 300.0s)
+142ms ║╚Execution stage complete. (29ms)
+143ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:51:31 PM CDT (in 299.997s)
+154ms ╚Event processed successfully (154ms)
5/19/2020, 11:46:24 PM +391ms
+1ms ╔Received event [Printer].current = 0.1 with a delay of 211ms
+133ms ║RunTime Analysis CS > 24ms > PS > 56ms > PE > 54ms > CE
+135ms ║Runtime (37978 bytes) successfully initialized in 56ms (v0.3.110.20191009) (133ms)
+136ms ║╔Execution stage started
+144ms ║║Comparison (string) 0.1 is_less_than (decimal) 0.15 = true (2ms)
+145ms ║║Condition #2 evaluated true (5ms)
+152ms ║║Comparison (decimal) 121.9 is_greater_than_or_equal_to (integer) 119 = true (1ms)
+154ms ║║Condition #7 evaluated true (8ms)
+155ms ║║Condition group #1 evaluated true (state did not change) (14ms)
+157ms ║║Cancelling statement #4's schedules...
+161ms ║║Executed virtual command [Printer].wait (0ms)
+162ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:51:24 PM CDT (in 300.0s)
+166ms ║╚Execution stage complete. (30ms)
+167ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:51:24 PM CDT (in 299.996s)
+206ms ╚Event processed successfully (206ms)
5/19/2020, 11:46:21 PM +117ms
+2ms ╔Received event [Printer].voltage = 121.9 with a delay of 66ms
+129ms ║RunTime Analysis CS > 22ms > PS > 57ms > PE > 50ms > CE
+131ms ║Runtime (37979 bytes) successfully initialized in 57ms (v0.3.110.20191009) (129ms)
+132ms ║╔Execution stage started
+143ms ║║Comparison (string) 0.09 is_less_than (decimal) 0.15 = true (1ms)
+144ms ║║Condition #2 evaluated true (8ms)
+148ms ║║Comparison (decimal) 121.9 is_greater_than_or_equal_to (integer) 119 = true (1ms)
+149ms ║║Condition #7 evaluated true (4ms)
+150ms ║║Condition group #1 evaluated true (state did not change) (15ms)
+152ms ║║Cancelling statement #4's schedules...
+156ms ║║Executed virtual command [Printer].wait (1ms)
+157ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:51:21 PM CDT (in 300.0s)
+161ms ║╚Execution stage complete. (29ms)
+162ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:51:21 PM CDT (in 299.996s)
+178ms ╚Event processed successfully (178ms)
5/19/2020, 11:46:19 PM +295ms
+1ms ╔Received event [Printer].voltage = 122 with a delay of 125ms
+95ms ║RunTime Analysis CS > 19ms > PS > 34ms > PE > 42ms > CE
+97ms ║Runtime (37977 bytes) successfully initialized in 34ms (v0.3.110.20191009) (95ms)
+98ms ║╔Execution stage started
+109ms ║║Comparison (string) 0.09 is_less_than (decimal) 0.15 = true (1ms)
+110ms ║║Condition #2 evaluated true (8ms)
+114ms ║║Comparison (decimal) 122.0 is_greater_than_or_equal_to (integer) 119 = true (1ms)
+115ms ║║Condition #7 evaluated true (5ms)
+116ms ║║Condition group #1 evaluated true (state did not change) (15ms)
+118ms ║║Cancelling statement #4's schedules...
+121ms ║║Executed virtual command [Printer].wait (1ms)
+122ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:51:19 PM CDT (in 300.0s)
+126ms ║╚Execution stage complete. (28ms)
+127ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:51:19 PM CDT (in 299.997s)
+146ms ╚Event processed successfully (146ms)
5/19/2020, 11:46:15 PM +551ms
+1ms ╔Received event [Printer].current = 0.09 with a delay of 74ms
+136ms ║RunTime Analysis CS > 25ms > PS > 54ms > PE > 58ms > CE
+139ms ║Runtime (37978 bytes) successfully initialized in 54ms (v0.3.110.20191009) (136ms)
+140ms ║╔Execution stage started
+147ms ║║Comparison (string) 0.09 is_less_than (decimal) 0.15 = true (1ms)
+149ms ║║Condition #2 evaluated true (4ms)
+157ms ║║Comparison (decimal) 121.8 is_greater_than_or_equal_to (integer) 119 = true (2ms)
+158ms ║║Condition #7 evaluated true (9ms)
+159ms ║║Condition group #1 evaluated true (state did not change) (16ms)
+161ms ║║Cancelling statement #4's schedules...
+166ms ║║Executed virtual command [Printer].wait (1ms)
+167ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:51:15 PM CDT (in 300.0s)
+171ms ║╚Execution stage complete. (32ms)
+172ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:51:15 PM CDT (in 299.996s)
+192ms ╚Event processed successfully (192ms)
5/19/2020, 11:46:15 PM +366ms
+1ms ╔Received event [Printer].voltage = 121.8 with a delay of 94ms
+112ms ║RunTime Analysis CS > 20ms > PS > 47ms > PE > 45ms > CE
+114ms ║Runtime (37978 bytes) successfully initialized in 47ms (v0.3.110.20191009) (112ms)
+115ms ║╔Execution stage started
+125ms ║║Comparison (string) 0.09 is_less_than (decimal) 0.15 = true (1ms)
+126ms ║║Condition #2 evaluated true (7ms)
+130ms ║║Comparison (decimal) 121.8 is_greater_than_or_equal_to (integer) 119 = true (1ms)
+131ms ║║Condition #7 evaluated true (4ms)
+132ms ║║Condition group #1 evaluated true (state did not change) (13ms)
+134ms ║║Cancelling statement #4's schedules...
+138ms ║║Executed virtual command [Printer].wait (1ms)
+139ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:51:15 PM CDT (in 300.0s)
+143ms ║╚Execution stage complete. (28ms)
+144ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:51:15 PM CDT (in 299.997s)
+159ms ╚Event processed successfully (159ms)
5/19/2020, 11:46:14 PM +652ms
+2ms ╔Received event [Printer].current = 0.1 with a delay of 64ms
+113ms ║RunTime Analysis CS > 19ms > PS > 45ms > PE > 49ms > CE
+116ms ║Runtime (37977 bytes) successfully initialized in 45ms (v0.3.110.20191009) (113ms)
+116ms ║╔Execution stage started
+124ms ║║Comparison (string) 0.1 is_less_than (decimal) 0.15 = true (1ms)
+125ms ║║Condition #2 evaluated true (5ms)
+132ms ║║Comparison (decimal) 122.0 is_greater_than_or_equal_to (integer) 119 = true (1ms)
+133ms ║║Condition #7 evaluated true (7ms)
+134ms ║║Condition group #1 evaluated true (state did not change) (14ms)
+136ms ║║Cancelling statement #4's schedules...
+140ms ║║Executed virtual command [Printer].wait (1ms)
+141ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:51:14 PM CDT (in 300.0s)
+145ms ║╚Execution stage complete. (28ms)
+146ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:51:14 PM CDT (in 299.996s)
+160ms ╚Event processed successfully (159ms)
5/19/2020, 11:46:10 PM +564ms
+1ms ╔Received event [Printer].voltage = 122 with a delay of 89ms
+106ms ║RunTime Analysis CS > 15ms > PS > 35ms > PE > 55ms > CE
+108ms ║Runtime (37977 bytes) successfully initialized in 35ms (v0.3.110.20191009) (106ms)
+109ms ║╔Execution stage started
+122ms ║║Comparison (string) 0.09 is_less_than (decimal) 0.15 = true (2ms)
+124ms ║║Condition #2 evaluated true (9ms)
+129ms ║║Comparison (decimal) 122.0 is_greater_than_or_equal_to (integer) 119 = true (1ms)
+130ms ║║Condition #7 evaluated true (6ms)
+131ms ║║Condition group #1 evaluated true (state did not change) (17ms)
+134ms ║║Cancelling statement #4's schedules...
+138ms ║║Executed virtual command [Printer].wait (1ms)
+140ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:51:10 PM CDT (in 300.0s)
+144ms ║╚Execution stage complete. (35ms)
+146ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:51:10 PM CDT (in 299.995s)
+169ms ╚Event processed successfully (169ms)
5/19/2020, 11:46:06 PM +777ms
+2ms ╔Received event [Printer].voltage = 120.4 with a delay of 90ms
+139ms ║RunTime Analysis CS > 25ms > PS > 57ms > PE > 56ms > CE
+141ms ║Runtime (37979 bytes) successfully initialized in 57ms (v0.3.110.20191009) (138ms)
+142ms ║╔Execution stage started
+156ms ║║Comparison (string) 0.09 is_less_than (decimal) 0.15 = true (2ms)
+158ms ║║Condition #2 evaluated true (12ms)
+163ms ║║Comparison (decimal) 120.4 is_greater_than_or_equal_to (integer) 119 = true (2ms)
+165ms ║║Condition #7 evaluated true (5ms)
+166ms ║║Condition group #1 evaluated true (state did not change) (20ms)
+168ms ║║Cancelling statement #4's schedules...
+173ms ║║Executed virtual command [Printer].wait (0ms)
+175ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:51:06 PM CDT (in 300.0s)
+180ms ║╚Execution stage complete. (37ms)
+181ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:51:06 PM CDT (in 299.995s)
+195ms ╚Event processed successfully (195ms)
5/19/2020, 11:46:04 PM +39ms
+2ms ╔Received event [Printer].current = 0.09 with a delay of 72ms
+208ms ║RunTime Analysis CS > 71ms > PS > 77ms > PE > 59ms > CE
+210ms ║Runtime (37977 bytes) successfully initialized in 77ms (v0.3.110.20191009) (208ms)
+211ms ║╔Execution stage started
+219ms ║║Comparison (string) 0.09 is_less_than (decimal) 0.15 = true (2ms)
+220ms ║║Condition #2 evaluated true (5ms)
+228ms ║║Comparison (decimal) 122.1 is_greater_than_or_equal_to (integer) 119 = true (2ms)
+229ms ║║Condition #7 evaluated true (8ms)
+230ms ║║Condition group #1 evaluated true (state did not change) (15ms)
+232ms ║║Cancelling statement #4's schedules...
+237ms ║║Executed virtual command [Printer].wait (1ms)
+238ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:51:04 PM CDT (in 300.0s)
+242ms ║╚Execution stage complete. (31ms)
+243ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:51:04 PM CDT (in 299.996s)
+259ms ╚Event processed successfully (259ms)
5/19/2020, 11:46:03 PM +834ms
+1ms ╔Received event [Printer].voltage = 122.1 with a delay of 64ms
+121ms ║RunTime Analysis CS > 17ms > PS > 56ms > PE > 48ms > CE
+123ms ║Runtime (37978 bytes) successfully initialized in 56ms (v0.3.110.20191009) (122ms)
+124ms ║╔Execution stage started
+135ms ║║Comparison (string) 0.1 is_less_than (decimal) 0.15 = true (1ms)
+136ms ║║Condition #2 evaluated true (8ms)
+140ms ║║Comparison (decimal) 122.1 is_greater_than_or_equal_to (integer) 119 = true (1ms)
+141ms ║║Condition #7 evaluated true (4ms)
+142ms ║║Condition group #1 evaluated true (state did not change) (14ms)
+144ms ║║Cancelling statement #4's schedules...
+148ms ║║Executed virtual command [Printer].wait (1ms)
+149ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:51:03 PM CDT (in 300.0s)
+153ms ║╚Execution stage complete. (29ms)
+154ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:51:03 PM CDT (in 299.996s)
+168ms ╚Event processed successfully (169ms)
5/19/2020, 11:45:57 PM +165ms
+1ms ╔Received event [Printer].voltage = 121 with a delay of 107ms
+117ms ║RunTime Analysis CS > 17ms > PS > 45ms > PE > 54ms > CE
+119ms ║Runtime (37977 bytes) successfully initialized in 45ms (v0.3.110.20191009) (117ms)
+120ms ║╔Execution stage started
+131ms ║║Comparison (string) 0.1 is_less_than (decimal) 0.15 = true (1ms)
+133ms ║║Condition #2 evaluated true (8ms)
+137ms ║║Comparison (decimal) 121.0 is_greater_than_or_equal_to (integer) 119 = true (1ms)
+139ms ║║Condition #7 evaluated true (5ms)
+140ms ║║Condition group #1 evaluated true (state did not change) (15ms)
+142ms ║║Cancelling statement #4's schedules...
+146ms ║║Executed virtual command [Printer].wait (1ms)
+147ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:50:57 PM CDT (in 300.0s)
+151ms ║╚Execution stage complete. (31ms)
+153ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:50:57 PM CDT (in 299.996s)
+171ms ╚Event processed successfully (171ms)
5/19/2020, 11:45:54 PM +441ms
+2ms ╔Received event [Printer].current = 0.1 with a delay of 70ms
+109ms ║RunTime Analysis CS > 19ms > PS > 44ms > PE > 46ms > CE
+111ms ║Runtime (37977 bytes) successfully initialized in 44ms (v0.3.110.20191009) (109ms)
+112ms ║╔Execution stage started
+119ms ║║Comparison (string) 0.1 is_less_than (decimal) 0.15 = true (1ms)
+121ms ║║Condition #2 evaluated true (4ms)
+127ms ║║Comparison (decimal) 122.0 is_greater_than_or_equal_to (integer) 119 = true (1ms)
+129ms ║║Condition #7 evaluated true (7ms)
+129ms ║║Condition group #1 evaluated true (state did not change) (13ms)
+131ms ║║Cancelling statement #4's schedules...
+135ms ║║Executed virtual command [Printer].wait (0ms)
+136ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:50:54 PM CDT (in 300.0s)
+140ms ║╚Execution stage complete. (28ms)
+141ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:50:54 PM CDT (in 299.996s)
+155ms ╚Event processed successfully (155ms)
5/19/2020, 11:45:48 PM +445ms
+1ms ╔Received event [Printer].voltage = 122 with a delay of 65ms
+114ms ║RunTime Analysis CS > 20ms > PS > 47ms > PE > 47ms > CE
+116ms ║Runtime (37977 bytes) successfully initialized in 47ms (v0.3.110.20191009) (114ms)
+117ms ║╔Execution stage started
+128ms ║║Comparison (string) 0.09 is_less_than (decimal) 0.15 = true (2ms)
+129ms ║║Condition #2 evaluated true (8ms)
+133ms ║║Comparison (decimal) 122.0 is_greater_than_or_equal_to (integer) 119 = true (1ms)
+134ms ║║Condition #7 evaluated true (4ms)
+135ms ║║Condition group #1 evaluated true (state did not change) (14ms)
+137ms ║║Cancelling statement #4's schedules...
+141ms ║║Executed virtual command [Printer].wait (0ms)
+142ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:50:48 PM CDT (in 300.0s)
+146ms ║╚Execution stage complete. (29ms)
+147ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:50:48 PM CDT (in 299.996s)
+159ms ╚Event processed successfully (159ms)
5/19/2020, 11:45:47 PM +675ms
+1ms ╔Received event [Printer].voltage = 122.1 with a delay of 210ms
+103ms ║RunTime Analysis CS > 16ms > PS > 44ms > PE > 43ms > CE
+105ms ║Runtime (37980 bytes) successfully initialized in 44ms (v0.3.110.20191009) (103ms)
+106ms ║╔Execution stage started
+117ms ║║Comparison (string) 0.09 is_less_than (decimal) 0.15 = true (1ms)
+118ms ║║Condition #2 evaluated true (8ms)
+122ms ║║Comparison (decimal) 122.1 is_greater_than_or_equal_to (integer) 119 = true (1ms)
+124ms ║║Condition #7 evaluated true (4ms)
+125ms ║║Condition group #1 evaluated true (state did not change) (15ms)
+126ms ║║Cancelling statement #4's schedules...
+131ms ║║Executed virtual command [Printer].wait (0ms)
+132ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:50:47 PM CDT (in 300.0s)
+135ms ║╚Execution stage complete. (29ms)
+136ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:50:47 PM CDT (in 299.996s)
+151ms ╚Event processed successfully (151ms)
5/19/2020, 11:45:42 PM +740ms
+1ms ╔Received event [Printer].voltage = 121.7 with a delay of 77ms
+137ms ║RunTime Analysis CS > 22ms > PS > 61ms > PE > 54ms > CE
+139ms ║Runtime (37978 bytes) successfully initialized in 61ms (v0.3.110.20191009) (137ms)
+140ms ║╔Execution stage started
+151ms ║║Comparison (string) 0.09 is_less_than (decimal) 0.15 = true (1ms)
+153ms ║║Condition #2 evaluated true (8ms)
+157ms ║║Comparison (decimal) 121.7 is_greater_than_or_equal_to (integer) 119 = true (2ms)
+158ms ║║Condition #7 evaluated true (5ms)
+159ms ║║Condition group #1 evaluated true (state did not change) (16ms)
+161ms ║║Cancelling statement #4's schedules...
+165ms ║║Executed virtual command [Printer].wait (0ms)
+166ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:50:42 PM CDT (in 300.0s)
+170ms ║╚Execution stage complete. (31ms)
+171ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:50:42 PM CDT (in 299.996s)
+188ms ╚Event processed successfully (188ms)
5/19/2020, 11:45:27 PM +525ms
+2ms ╔Received event [Printer].current = 0.1 with a delay of 64ms
+10124ms ║RunTime Analysis CS > 20ms > PS > 10060ms > PE > 44ms > CE
+10125ms ║Piston waited at a semaphore for 10015ms
+10127ms ║Runtime (38057 bytes) successfully initialized in 10060ms (v0.3.110.20191009) (10125ms)
+10128ms ║╔Execution stage started
+10135ms ║║Comparison (string) 0.1 is_less_than (decimal) 0.15 = true (1ms)
+10136ms ║║Condition #2 evaluated true (5ms)
+10143ms ║║Comparison (decimal) 122.0 is_greater_than_or_equal_to (integer) 119 = true (1ms)
+10144ms ║║Condition #7 evaluated true (7ms)
+10145ms ║║Condition group #1 evaluated true (state did not change) (13ms)
+10147ms ║║Cancelling statement #4's schedules...
+10151ms ║║Executed virtual command [Printer].wait (0ms)
+10152ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:50:37 PM CDT (in 300.0s)
+10155ms ║╚Execution stage complete. (28ms)
+10156ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:50:37 PM CDT (in 299.996s)
+10169ms ╚Event processed successfully (10169ms)
5/19/2020, 11:45:30 PM +430ms
+2ms ╔Received event [Printer].current = 0.09 with a delay of 71ms
+126ms ║RunTime Analysis CS > 23ms > PS > 56ms > PE > 46ms > CE
+128ms ║Runtime (37977 bytes) successfully initialized in 56ms (v0.3.110.20191009) (126ms)
+129ms ║╔Execution stage started
+136ms ║║Comparison (string) 0.09 is_less_than (decimal) 0.15 = true (1ms)
+138ms ║║Condition #2 evaluated true (4ms)
+145ms ║║Comparison (decimal) 122.0 is_greater_than_or_equal_to (integer) 119 = true (1ms)
+146ms ║║Condition #7 evaluated true (8ms)
+147ms ║║Condition group #1 evaluated true (state did not change) (15ms)
+149ms ║║Cancelling statement #4's schedules...
+153ms ║║Executed virtual command [Printer].wait (0ms)
+155ms ║║Requesting a wake up for Tue, May 19 2020 @ 11:50:30 PM CDT (in 300.0s)
+158ms ║╚Execution stage complete. (29ms)
+160ms ║Setting up scheduled job for Tue, May 19 2020 @ 11:50:30 PM CDT (in 299.996s)
+173ms ╚Event processed s

[WCmore]

The WAIT is cancelled anytime either condition is false.
(and power fluctuates so often, I suspect it is usually cancelled within seconds)

If you want Outlet2 to turn off regardless, you can set Task Cancellation Policy on the WITH to Never.

---

Note:

Power changes so often, I highly recommend studying how often your piston runs by turning your log level to Full while testing. (the logs above average about once every 3 seconds, or 1200 times per hour!)

With that in mind (I hate to be the bearer of bad news but), you should know that pistons like this can actually make your entire SmartHome more sluggish.

[Cbarth3]

So what would my best option be to turn this device off once the current or power drops below a certain value for 5 minutes?

[WCmore]

My preferred method to keep the spam out of the network is to not use power as a trigger at all.

(Maybe execute on a 5 minute timer, and two low events back to back can trigger your action?)

[milhouse]

Watts = volts x amps, so I assume you are really aiming for “if wattage stays below xxx for 5 minutes, then turn off”. Is there a wattage so you can use as a trigger instead of both volts and amps? 18W in this case. Or, assuming your voltage should generally be around 120v ignore the voltage drift and just use .15amps.

Then you can use “stays below”.
If Outlet 2 power stays below 18W for 5 minutes
then
turn off Outlet 2

This will work just fine. I use power triggers for a number of things.

But WCmore really knows this stuff. Keep any eye out for performance issues, and think about alternatives in case you need to.

[Cbarth3]

Yeah I was trying to think of a way for it to only consider the current when it is actually on. Otherwise don’t look at it or worry about it. I have it setup with just having the current as the trigger now.

Might look at using the watts instead it just seemed like that fluctuated more than the current.

[orangebucket]

I haven’t delved too much into the logs, but I suspect that the problem may not have been that the conditions were changing and cancelling the wait (effectively) because of the Task Cancellation Policy, but they were staying the same and continuously restarting the wait because of the Task Scheduling Policy.

You might be have been able to use the Task Execution Policy so things only happened the first time the conditions are true, but you probably want to think in terms of limiting the times the piston executes, as it is firing frequently enough to generate semaphore waits, and that seems to have been something you’ve done.

Just bear in mind that the conditions remaining true can be as significant as them changing. It isn’t something we necessarily consider because we are used to dealing with binary values that are toggling.