1) Give a description of the problem
I am trying to get a basic light on, wait, turn off but it seems to be having issues. I previously had a similar piston working but managed to delete it. As I did having one working, im pretty sure i have done everything correct.
Some help or advice on this would be greatly appreciated and could you guy possibly explain any suggested changes in the piston to help a Noobie learn for next time.
2) What is the expected behaviour?
When motion is detected when the light level and loctation mode is correct I expect the selected lights to turn on. Then, after 5min the lights should turn off.
3) What is happening/not happening?
The piston is working up until the “wait” bit. When I “Trace” the piston, i see the timer count down to zero, it changes to say “pending” then the timer next to the wait function starts counting up and the lights stay on indefinitely. The other confusing issue is that sometimes the piston actually works! Looking at the log it seems as if the timer (that show next the the “wait” function when Trace is checked) counts up to 3-4min and then the piston restarts and the 5min/300sec countdown begins again.
.
**4) Post a Green Snapshot of the piston!
5) Attach logs after turning logging level to Full
5/30/2019, 7:00:46 PM +484ms
+0ms â•”Received event [Home].execute = recovery with a delay of 49ms
+89ms â•‘RunTime Analysis CS > 20ms > PS > 43ms > PE > 27ms > CE
+92ms â•‘Runtime (40113 bytes) successfully initialized in 43ms (v0.3.10c.20190522) (91ms)
+93ms â•‘â•”Execution stage started
+107ms â•‘â•‘Condition #5 evaluated false (8ms)
+109ms â•‘â•‘Condition group #3 evaluated false (state did not change) (9ms)
+112ms â•‘â•‘Cancelling statement #28's schedules...
+122ms â•‘â•‘Executed virtual command [Hue ambiance spot 1, Hue ambiance spot 2, Hue ambiance spot 3].wait (0ms)
+123ms â•‘â•‘Requesting a wake up for Thu, May 30 2019 @ 7:05:46 PM BST (in 300.0s)
+129ms ║╚Execution stage complete. (36ms)
+131ms â•‘Setting up scheduled job for Thu, May 30 2019 @ 7:05:46 PM BST (in 299.994s)
+144ms ╚Event processed successfully (143ms)
5/30/2019, 7:00:38 PM +526ms
+75ms â•”Received event [Home].time = 1559239189925 with a delay of 48595ms
+5267ms â•‘RunTime Analysis CS > 4001ms > PS > 774ms > PE > 498ms > CE
+5271ms â•‘Runtime (40126 bytes) successfully initialized in 774ms (v0.3.10c.20190522) (5179ms)
+5273ms â•‘â•”Execution stage started
+5322ms ║╚Execution stage complete. (50ms)
+6245ms â•‘Setting up scheduled job for Thu, May 30 2019 @ 6:59:49 PM BST (in 1s)
+6257ms ╚Event processed successfully (6257ms)
5/30/2019, 6:54:49 PM +799ms
+1ms â•”Received event [Home].execute = recovery with a delay of 67ms
+93ms â•‘RunTime Analysis CS > 21ms > PS > 46ms > PE > 26ms > CE
+96ms â•‘Runtime (40113 bytes) successfully initialized in 46ms (v0.3.10c.20190522) (93ms)
+97ms â•‘â•”Execution stage started
+111ms â•‘â•‘Condition #5 evaluated false (7ms)
+112ms â•‘â•‘Condition group #3 evaluated false (state did not change) (10ms)
+115ms â•‘â•‘Cancelling statement #28's schedules...
+124ms â•‘â•‘Executed virtual command [Hue ambiance spot 1, Hue ambiance spot 2, Hue ambiance spot 3].wait (1ms)
+126ms â•‘â•‘Requesting a wake up for Thu, May 30 2019 @ 6:59:49 PM BST (in 300.0s)
+137ms ║╚Execution stage complete. (41ms)
+139ms â•‘Setting up scheduled job for Thu, May 30 2019 @ 6:59:49 PM BST (in 299.988s)
+150ms ╚Event processed successfully (150ms)
5/30/2019, 6:47:06 PM +440ms
+1ms â•”Received event [Hue Motion Sensor (Hall)].motion = inactive with a delay of 58ms
+74ms â•‘RunTime Analysis CS > 15ms > PS > 34ms > PE > 26ms > CE
+77ms â•‘Runtime (40125 bytes) successfully initialized in 34ms (v0.3.10c.20190522) (74ms)
+78ms â•‘â•”Execution stage started
+96ms â•‘â•‘Comparison (enum) inactive changes_to (string) active = false (2ms)
+98ms â•‘â•‘Cancelling condition #5's schedules...
+99ms â•‘â•‘Condition #5 evaluated false (10ms)
+101ms â•‘â•‘Cancelling condition #3's schedules...
+102ms â•‘â•‘Condition group #3 evaluated false (state changed) (14ms)
+105ms â•‘â•‘Cancelling statement #28's schedules...
+116ms â•‘â•‘Executed virtual command [Hue ambiance spot 1, Hue ambiance spot 2, Hue ambiance spot 3].wait (1ms)
+118ms â•‘â•‘Requesting a wake up for Thu, May 30 2019 @ 6:52:06 PM BST (in 300.0s)
+124ms ║╚Execution stage complete. (46ms)
+126ms â•‘Setting up scheduled job for Thu, May 30 2019 @ 6:52:06 PM BST (in 299.993s)
+138ms ╚Event processed successfully (138ms)
5/30/2019, 6:46:36 PM +446ms
+1ms â•”Received event [Hue Motion Sensor (Hall)].motion = active with a delay of 66ms
+87ms â•‘RunTime Analysis CS > 18ms > PS > 45ms > PE > 24ms > CE
+89ms â•‘Runtime (40130 bytes) successfully initialized in 45ms (v0.3.10c.20190522) (87ms)
+90ms â•‘â•”Execution stage started
+101ms â•‘â•‘Comparison (enum) active changes_to (string) active = true (1ms)
+103ms â•‘â•‘Cancelling condition #5's schedules...
+104ms â•‘â•‘Condition #5 evaluated true (8ms)
+114ms â•‘â•‘Comparison (integer) 6 is_less_than_or_equal_to (integer) 10 = true (2ms)
+116ms â•‘â•‘Condition #4 evaluated true (10ms)
+122ms â•‘â•‘Comparison (string) :4741a60e498c1b32b57b46dfce8e2ee0: is_any_of (string) :302bcc01d8fc7d79826d917e0169f855:,:4741a60e498c1b32b57b46dfce8e2ee0: = true (3ms)
+124ms â•‘â•‘Condition #16 evaluated true (8ms)
+125ms â•‘â•‘Cancelling condition #3's schedules...
+127ms â•‘â•‘Condition group #3 evaluated true (state changed) (30ms)
+129ms â•‘â•‘Cancelling statement #6's schedules...
+146ms â•‘â•‘Skipped execution of physical command [Hue ambiance spot 1].on([]) because it would make no change to the device. (4ms)
+147ms â•‘â•‘Executed [Hue ambiance spot 1].on (6ms)
+152ms â•‘â•‘Skipped execution of physical command [Hue ambiance spot 2].on([]) because it would make no change to the device. (2ms)
+153ms â•‘â•‘Executed [Hue ambiance spot 2].on (4ms)
+159ms â•‘â•‘Skipped execution of physical command [Hue ambiance spot 3].on([]) because it would make no change to the device. (3ms)
+160ms â•‘â•‘Executed [Hue ambiance spot 3].on (5ms)
+180ms â•‘â•‘Executed physical command [Hue ambiance spot 1].setColorTemperature([5000]) (15ms)
+181ms â•‘â•‘Executed [Hue ambiance spot 1].setColorTemperature (17ms)
+195ms â•‘â•‘Executed physical command [Hue ambiance spot 2].setColorTemperature([5000]) (12ms)
+196ms â•‘â•‘Executed [Hue ambiance spot 2].setColorTemperature (14ms)
+211ms â•‘â•‘Executed physical command [Hue ambiance spot 3].setColorTemperature([5000]) (13ms)
+212ms â•‘â•‘Executed [Hue ambiance spot 3].setColorTemperature (15ms)
+222ms â•‘â•‘Skipped execution of physical command [Hue ambiance spot 1].setLevel([100]) because it would make no change to the device. (4ms)
+223ms â•‘â•‘Executed [Hue ambiance spot 1].setLevel (6ms)
+231ms â•‘â•‘Skipped execution of physical command [Hue ambiance spot 2].setLevel([100]) because it would make no change to the device. (6ms)
+232ms â•‘â•‘Executed [Hue ambiance spot 2].setLevel (7ms)
+239ms â•‘â•‘Skipped execution of physical command [Hue ambiance spot 3].setLevel([100]) because it would make no change to the device. (6ms)
+240ms â•‘â•‘Executed [Hue ambiance spot 3].setLevel (7ms)
+245ms ║╚Execution stage complete. (155ms)
+246ms ╚Event processed successfully (247ms)
5/30/2019, 6:46:06 PM +467ms
+1ms â•”Received event [Hue Motion Sensor (Hall)].motion = inactive with a delay of 87ms
+89ms â•‘RunTime Analysis CS > 20ms > PS > 45ms > PE > 25ms > CE
+92ms â•‘Runtime (40125 bytes) successfully initialized in 45ms (v0.3.10c.20190522) (89ms)
+93ms â•‘â•”Execution stage started
+104ms â•‘â•‘Comparison (enum) inactive changes_to (string) active = false (1ms)
+106ms â•‘â•‘Cancelling condition #5's schedules...
+107ms â•‘â•‘Condition #5 evaluated false (8ms)
+108ms â•‘â•‘Cancelling condition #3's schedules...
+110ms â•‘â•‘Condition group #3 evaluated false (state changed) (10ms)
+113ms â•‘â•‘Cancelling statement #28's schedules...
+123ms â•‘â•‘Executed virtual command [Hue ambiance spot 1, Hue ambiance spot 2, Hue ambiance spot 3].wait (1ms)
+124ms â•‘â•‘Requesting a wake up for Thu, May 30 2019 @ 6:51:06 PM BST (in 300.0s)
+130ms ║╚Execution stage complete. (38ms)
+133ms â•‘Setting up scheduled job for Thu, May 30 2019 @ 6:51:06 PM BST (in 299.994s)
+142ms ╚Event processed successfully (142ms)
5/30/2019, 6:45:36 PM +482ms
+2ms â•”Received event [Hue Motion Sensor (Hall)].motion = active with a delay of 89ms
+112ms â•‘RunTime Analysis CS > 25ms > PS > 50ms > PE > 36ms > CE
+116ms â•‘Runtime (40131 bytes) successfully initialized in 50ms (v0.3.10c.20190522) (113ms)
+118ms â•‘â•”Execution stage started
+128ms â•‘â•‘Comparison (enum) active changes_to (string) active = true (1ms)
+130ms â•‘â•‘Cancelling condition #5's schedules...
+132ms â•‘â•‘Condition #5 evaluated true (7ms)
+141ms â•‘â•‘Comparison (integer) 6 is_less_than_or_equal_to (integer) 10 = true (2ms)
+143ms â•‘â•‘Condition #4 evaluated true (11ms)
+149ms â•‘â•‘Comparison (string) :4741a60e498c1b32b57b46dfce8e2ee0: is_any_of (string) :302bcc01d8fc7d79826d917e0169f855:,:4741a60e498c1b32b57b46dfce8e2ee0: = true (3ms)
+151ms â•‘â•‘Condition #16 evaluated true (7ms)
+153ms â•‘â•‘Cancelling condition #3's schedules...
+154ms â•‘â•‘Condition group #3 evaluated true (state changed) (30ms)
+156ms â•‘â•‘Cancelling statement #6's schedules...
+240ms â•‘â•‘Executed physical command [Hue ambiance spot 1].on() (76ms)
+241ms â•‘â•‘Executed [Hue ambiance spot 1].on (78ms)
+263ms â•‘â•‘Executed physical command [Hue ambiance spot 2].on() (19ms)
+264ms â•‘â•‘Executed [Hue ambiance spot 2].on (21ms)
+286ms â•‘â•‘Executed physical command [Hue ambiance spot 3].on() (19ms)
+287ms â•‘â•‘Executed [Hue ambiance spot 3].on (21ms)
+306ms â•‘â•‘Executed physical command [Hue ambiance spot 1].setColorTemperature([5000]) (13ms)
+307ms â•‘â•‘Executed [Hue ambiance spot 1].setColorTemperature (16ms)
+320ms â•‘â•‘Executed physical command [Hue ambiance spot 2].setColorTemperature([5000]) (11ms)
+321ms â•‘â•‘Executed [Hue ambiance spot 2].setColorTemperature (13ms)
+336ms â•‘â•‘Executed physical command [Hue ambiance spot 3].setColorTemperature([5000]) (13ms)
+337ms â•‘â•‘Executed [Hue ambiance spot 3].setColorTemperature (15ms)
+347ms â•‘â•‘Skipped execution of physical command [Hue ambiance spot 1].setLevel([100]) because it would make no change to the device. (5ms)
+348ms â•‘â•‘Executed [Hue ambiance spot 1].setLevel (7ms)
+356ms â•‘â•‘Skipped execution of physical command [Hue ambiance spot 2].setLevel([100]) because it would make no change to the device. (5ms)
+357ms â•‘â•‘Executed [Hue ambiance spot 2].setLevel (7ms)
+376ms â•‘â•‘Executed physical command [Hue ambiance spot 3].setLevel([100]) (17ms)
+378ms â•‘â•‘Executed [Hue ambiance spot 3].setLevel (20ms)
+382ms ║╚Execution stage complete. (264ms)
+383ms ╚Event processed successfully (383ms)
5/30/2019, 6:45:22 PM +47ms
+2ms â•”Received event [Home].time = 1559238306673 with a delay of 15374ms
+707ms â•‘RunTime Analysis CS > 284ms > PS > 396ms > PE > 25ms > CE
+711ms â•‘Runtime (40122 bytes) successfully initialized in 396ms (v0.3.10c.20190522) (706ms)
+712ms â•‘â•”Execution stage started
+1685ms â•‘â•‘Executed physical command [Hue ambiance spot 1].off() (20ms)
+1687ms â•‘â•‘Executed [Hue ambiance spot 1].off (22ms)
+1704ms â•‘â•‘Executed physical command [Hue ambiance spot 2].off() (14ms)
+1705ms â•‘â•‘Executed [Hue ambiance spot 2].off (17ms)
+1722ms â•‘â•‘Executed physical command [Hue ambiance spot 3].off() (13ms)
+1723ms â•‘â•‘Executed [Hue ambiance spot 3].off (17ms)
+1727ms ║╚Execution stage complete. (1015ms)
+1729ms ╚Event processed successfully (1728ms)
5/30/2019, 6:40:06 PM +570ms
+1ms â•”Received event [Hue Motion Sensor (Hall)].motion = inactive with a delay of 66ms
+71ms â•‘RunTime Analysis CS > 16ms > PS > 34ms > PE > 21ms > CE
+74ms â•‘Runtime (40130 bytes) successfully initialized in 34ms (v0.3.10c.20190522) (72ms)
+75ms â•‘â•”Execution stage started
+85ms â•‘â•‘Comparison (enum) inactive changes_to (string) active = false (1ms)
+87ms â•‘â•‘Condition #5 evaluated false (6ms)
+88ms â•‘â•‘Condition group #3 evaluated false (state did not change) (8ms)
+91ms â•‘â•‘Cancelling statement #28's schedules...
+100ms â•‘â•‘Executed virtual command [Hue ambiance spot 1, Hue ambiance spot 2, Hue ambiance spot 3].wait (1ms)
+102ms â•‘â•‘Requesting a wake up for Thu, May 30 2019 @ 6:45:06 PM BST (in 300.0s)
+108ms ║╚Execution stage complete. (33ms)
+110ms â•‘Setting up scheduled job for Thu, May 30 2019 @ 6:45:06 PM BST (in 299.994s)
+126ms ╚Event processed successfully (126ms)
5/30/2019, 6:39:36 PM +764ms
+0ms â•”Received event [Home].execute = recovery with a delay of 50ms
+9853ms â•‘RunTime Analysis CS > 21ms > PS > 9810ms > PE > 23ms > CE
+9855ms â•‘Piston waited at a semaphore for 9771ms
+9857ms â•‘Runtime (40186 bytes) successfully initialized in 9810ms (v0.3.10c.20190522) (9856ms)
+9858ms â•‘â•”Execution stage started
+9872ms â•‘â•‘Condition #5 evaluated false (8ms)
+9873ms â•‘â•‘Condition group #3 evaluated false (state did not change) (9ms)
+9876ms â•‘â•‘Cancelling statement #28's schedules...
+9886ms â•‘â•‘Executed virtual command [Hue ambiance spot 1, Hue ambiance spot 2, Hue ambiance spot 3].wait (1ms)
+9888ms â•‘â•‘Requesting a wake up for Thu, May 30 2019 @ 6:44:46 PM BST (in 300.0s)
+9893ms ║╚Execution stage complete. (35ms)
+9895ms â•‘Setting up scheduled job for Thu, May 30 2019 @ 6:44:46 PM BST (in 299.995s)
+9907ms ╚Event processed successfully (9906ms)
5/30/2019, 6:39:37 PM +44ms
+1ms â•”Received event [Home].execute = recovery with a delay of 67ms
+97ms â•‘RunTime Analysis CS > 22ms > PS > 48ms > PE > 26ms > CE
+100ms â•‘Runtime (40106 bytes) successfully initialized in 48ms (v0.3.10c.20190522) (97ms)
+102ms â•‘â•”Execution stage started
+117ms â•‘â•‘Cancelling condition #5's schedules...
+119ms â•‘â•‘Condition #5 evaluated false (10ms)
+121ms â•‘â•‘Cancelling condition #3's schedules...
+122ms â•‘â•‘Condition group #3 evaluated false (state changed) (13ms)
+126ms â•‘â•‘Cancelling statement #28's schedules...
+138ms â•‘â•‘Executed virtual command [Hue ambiance spot 1, Hue ambiance spot 2, Hue ambiance spot 3].wait (0ms)
+140ms â•‘â•‘Requesting a wake up for Thu, May 30 2019 @ 6:44:37 PM BST (in 300.0s)
+146ms ║╚Execution stage complete. (44ms)
+148ms â•‘Setting up scheduled job for Thu, May 30 2019 @ 6:44:37 PM BST (in 299.994s)
+157ms ╚Event processed successfully (157ms)
5/30/2019, 6:39:36 PM +491ms
+1ms â•”Received event [Hue Motion Sensor (Hall)].motion = active with a delay of 78ms
+125ms â•‘RunTime Analysis CS > 26ms > PS > 64ms > PE > 35ms > CE
+128ms â•‘Runtime (40131 bytes) successfully initialized in 64ms (v0.3.10c.20190522) (125ms)
+129ms â•‘â•”Execution stage started
+140ms â•‘â•‘Comparison (enum) active changes_to (string) active = true (1ms)
+142ms â•‘â•‘Cancelling condition #5's schedules...
+143ms â•‘â•‘Condition #5 evaluated true (8ms)
+154ms â•‘â•‘Comparison (integer) 5 is_less_than_or_equal_to (integer) 10 = true (2ms)
+156ms â•‘â•‘Condition #4 evaluated true (11ms)
+162ms â•‘â•‘Comparison (string) :4741a60e498c1b32b57b46dfce8e2ee0: is_any_of (string) :302bcc01d8fc7d79826d917e0169f855:,:4741a60e498c1b32b57b46dfce8e2ee0: = true (3ms)
+165ms â•‘â•‘Condition #16 evaluated true (7ms)
+166ms â•‘â•‘Cancelling condition #3's schedules...
+167ms â•‘â•‘Condition group #3 evaluated true (state changed) (32ms)
+171ms â•‘â•‘Cancelling statement #6's schedules...
+210ms â•‘â•‘Executed physical command [Hue ambiance spot 1].on() (19ms)
+212ms â•‘â•‘Executed [Hue ambiance spot 1].on (22ms)
+236ms â•‘â•‘Executed physical command [Hue ambiance spot 2].on() (18ms)
+238ms â•‘â•‘Executed [Hue ambiance spot 2].on (22ms)
+262ms â•‘â•‘Executed physical command [Hue ambiance spot 3].on() (18ms)
+264ms â•‘â•‘Executed [Hue ambiance spot 3].on (22ms)
+285ms â•‘â•‘Executed physical command [Hue ambiance spot 1].setColorTemperature([5000]) (12ms)
+287ms â•‘â•‘Executed [Hue ambiance spot 1].setColorTemperature (16ms)
+303ms â•‘â•‘Executed physical command [Hue ambiance spot 2].setColorTemperature([5000]) (12ms)
+305ms â•‘â•‘Executed [Hue ambiance spot 2].setColorTemperature (16ms)
+412ms â•‘â•‘Executed physical command [Hue ambiance spot 3].setColorTemperature([5000]) (104ms)
+413ms â•‘â•‘Executed [Hue ambiance spot 3].setColorTemperature (107ms)
+424ms â•‘â•‘Skipped execution of physical command [Hue ambiance spot 1].setLevel([100]) because it would make no change to the device. (5ms)
+425ms â•‘â•‘Executed [Hue ambiance spot 1].setLevel (7ms)
+432ms â•‘â•‘Skipped execution of physical command [Hue ambiance spot 2].setLevel([100]) because it would make no change to the device. (5ms)
+433ms â•‘â•‘Executed [Hue ambiance spot 2].setLevel (7ms)
+440ms â•‘â•‘Skipped execution of physical command [Hue ambiance spot 3].setLevel([100]) because it would make no change to the device. (4ms)
+441ms â•‘â•‘Executed [Hue ambiance spot 3].setLevel (6ms)
+444ms ║╚Execution stage complete. (316ms)
+446ms ╚Event processed successfully (446ms)`Preformatted text`