Minor piston problem but bothers me


#1

1) Give a description of the problem
Is there something that should be done differently and better in my piston?

2) What is the expected behaviour?
Piston works but I’m getting weird ST app history lines from the switch that I’m using in piston.

3) What is happening/not happening?
There should be basically one action: on…and after 2 hours off. Now I’m getting off/on/off and it bothers me.

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

5) Attach logs after turning logging level to Full

22.6.2020 klo 5.59.58 +94ms
+0ms ╔Received event [Koti].time = 1592794799644 with a delay of -1550ms
+97ms ║RunTime Analysis CS > 22ms > PS > 22ms > PE > 53ms > CE
+100ms ║Runtime (38981 bytes) successfully initialized in 22ms (v0.3.110.20191009) (99ms)
+101ms ║╔Execution stage started
+193ms ║║Executed physical command [Cool down upstairs [Harmony Activity]].off() (76ms)
+194ms ║║Executed [Cool down upstairs [Harmony Activity]].off (78ms)
+198ms ║╚Execution stage complete. (97ms)
+200ms ║Setting up scheduled job for Mon, Jun 22 2020 @ 10:00:00 PM EEST (in 57601.707s), with 2 more jobs pending
+214ms ╚Event processed successfully (214ms)

22.6.2020 klo 3.59.59 +75ms
+0ms ╔Received event [Koti].time = 1592787600000 with a delay of -926ms
+411ms ║RunTime Analysis CS > 29ms > PS > 28ms > PE > 354ms > CE
+414ms ║Runtime (38979 bytes) successfully initialized in 28ms (v0.3.110.20191009) (412ms)
+415ms ║╔Execution stage started
+426ms ║║Comparison (time) 14399498 happens_daily_at (time) 79200000 = false (1ms)
+428ms ║║Condition #2 evaluated false (5ms)
+430ms ║║Cancelling statement #2's schedules...
+434ms ║║Requesting time schedule wake up at Mon, Jun 22 2020 @ 10:00:00 PM EEST
+441ms ║║Comparison (time) 14399513 happens_daily_at (time) 3600000 = false (1ms)
+443ms ║║Cancelling condition #3's schedules...
+445ms ║║Condition #3 evaluated false (7ms)
+446ms ║║Cancelling statement #3's schedules...
+451ms ║║Requesting time schedule wake up at Tue, Jun 23 2020 @ 1:00:00 AM EEST
+459ms ║║Comparison (time) 14399530 happens_daily_at (time) 14400000 = true (0ms)
+461ms ║║Time restriction check passed
+462ms ║║Condition #13 evaluated true (7ms)
+465ms ║║Cancelling statement #13's schedules...
+469ms ║║Requesting time schedule wake up at Tue, Jun 23 2020 @ 4:00:00 AM EEST
+473ms ║║Condition group #1 evaluated true (state did not change) (50ms)
+482ms ║║Comparison (string) :aabc2d5940f153bb4da108afcefed12f: is_any_of (string) :aabc2d5940f153bb4da108afcefed12f:,:7140ca3e403eddab385088d93d601f83: = true (2ms)
+484ms ║║Condition #5 evaluated true (8ms)
+500ms ║║Comparison (decimal) 24.6 is_greater_than_or_equal_to (decimal) 23.5 = true (3ms)
+502ms ║║Condition #6 evaluated true (16ms)
+503ms ║║Condition group #4 evaluated true (state did not change) (28ms)
+505ms ║║Cancelling statement #7's schedules...
+562ms ║║Executed physical command [Cool down upstairs [Harmony Activity]].on() (53ms)
+563ms ║║Executed [Cool down upstairs [Harmony Activity]].on (55ms)
+567ms ║║Executed virtual command [Cool down upstairs [Harmony Activity]].wait (1ms)
+569ms ║║Requesting a wake up for Mon, Jun 22 2020 @ 5:59:59 AM EEST (in 7200.0s)
+575ms ║╚Execution stage complete. (160ms)
+577ms ║Setting up scheduled job for Mon, Jun 22 2020 @ 5:59:59 AM EEST (in 7199.992s), with 3 more jobs pending
+585ms ╚Event processed successfully (585ms)

22.6.2020 klo 2.59.58 +87ms
+0ms ╔Received event [Koti].time = 1592783999892 with a delay of -1806ms
+98ms ║RunTime Analysis CS > 18ms > PS > 29ms > PE > 51ms > CE
+100ms ║Runtime (38978 bytes) successfully initialized in 29ms (v0.3.110.20191009) (99ms)
+101ms ║╔Execution stage started
+171ms ║║Executed physical command [Cool down upstairs [Harmony Activity]].off() (56ms)
+172ms ║║Executed [Cool down upstairs [Harmony Activity]].off (58ms)
+175ms ║╚Execution stage complete. (74ms)
+177ms ║Setting up scheduled job for Mon, Jun 22 2020 @ 4:00:00 AM EEST (in 3601.737s), with 2 more jobs pending
+185ms ╚Event processed successfully (186ms)

22.6.2020 klo 0.59.59 +123ms
+1ms ╔Received event [Koti].time = 1592776800000 with a delay of -878ms
+613ms ║RunTime Analysis CS > 49ms > PS > 48ms > PE > 516ms > CE
+617ms ║Runtime (38980 bytes) successfully initialized in 48ms (v0.3.110.20191009) (614ms)
+618ms ║╔Execution stage started
+630ms ║║Comparison (time) 3599750 happens_daily_at (time) 79200000 = false (1ms)
+632ms ║║Cancelling condition #2's schedules...
+634ms ║║Condition #2 evaluated false (6ms)
+637ms ║║Cancelling statement #2's schedules...
+641ms ║║Requesting time schedule wake up at Mon, Jun 22 2020 @ 10:00:00 PM EEST
+648ms ║║Comparison (time) 3599768 happens_daily_at (time) 3600000 = true (1ms)
+651ms ║║Time restriction check passed
+652ms ║║Cancelling condition #3's schedules...
+654ms ║║Condition #3 evaluated true (9ms)
+655ms ║║Cancelling statement #3's schedules...
+659ms ║║Requesting time schedule wake up at Tue, Jun 23 2020 @ 1:00:00 AM EEST
+663ms ║║Condition group #1 evaluated true (state did not change) (36ms)
+672ms ║║Comparison (string) :aabc2d5940f153bb4da108afcefed12f: is_any_of (string) :aabc2d5940f153bb4da108afcefed12f:,:7140ca3e403eddab385088d93d601f83: = true (2ms)
+675ms ║║Condition #5 evaluated true (7ms)
+687ms ║║Comparison (decimal) 25.0 is_greater_than_or_equal_to (decimal) 23.5 = true (2ms)
+690ms ║║Condition #6 evaluated true (13ms)
+692ms ║║Condition group #4 evaluated true (state did not change) (26ms)
+696ms ║║Cancelling statement #7's schedules...
+759ms ║║Executed physical command [Cool down upstairs [Harmony Activity]].on() (57ms)
+761ms ║║Executed [Cool down upstairs [Harmony Activity]].on (60ms)
+766ms ║║Executed virtual command [Cool down upstairs [Harmony Activity]].wait (0ms)
+768ms ║║Requesting a wake up for Mon, Jun 22 2020 @ 2:59:59 AM EEST (in 7200.0s)
+777ms ║╚Execution stage complete. (158ms)
+780ms ║Setting up scheduled job for Mon, Jun 22 2020 @ 2:59:59 AM EEST (in 7199.99s), with 3 more jobs pending
+788ms ╚Event processed successfully (788ms)

21.6.2020 klo 23.59.58 +221ms
+0ms ╔Received event [Koti].time = 1592773199537 with a delay of -1317ms
+102ms ║RunTime Analysis CS > 24ms > PS > 23ms > PE > 56ms > CE
+105ms ║Runtime (38980 bytes) successfully initialized in 23ms (v0.3.110.20191009) (104ms)
+106ms ║╔Execution stage started
+170ms ║║Executed physical command [Cool down upstairs [Harmony Activity]].off() (50ms)
+171ms ║║Executed [Cool down upstairs [Harmony Activity]].off (52ms)
+175ms ║╚Execution stage complete. (69ms)
+177ms ║Setting up scheduled job for Mon, Jun 22 2020 @ 1:00:00 AM EEST (in 3601.603s), with 2 more jobs pending
+184ms ╚Event processed successfully (184ms)

21.6.2020 klo 21.59.59 +100ms
+1ms ╔Received event [Koti].time = 1592766000000 with a delay of -900ms
+270ms ║RunTime Analysis CS > 26ms > PS > 31ms > PE > 212ms > CE
+273ms ║Runtime (38983 bytes) successfully initialized in 31ms (v0.3.110.20191009) (270ms)
+274ms ║╔Execution stage started
+284ms ║║Comparison (time) 79199381 happens_daily_at (time) 79200000 = true (1ms)
+286ms ║║Time restriction check passed
+287ms ║║Cancelling condition #2's schedules...
+289ms ║║Condition #2 evaluated true (7ms)
+290ms ║║Cancelling statement #2's schedules...
+294ms ║║Requesting time schedule wake up at Mon, Jun 22 2020 @ 10:00:00 PM EEST
+297ms ║║Condition group #1 evaluated true (state did not change) (17ms)
+305ms ║║Comparison (string) :7140ca3e403eddab385088d93d601f83: is_any_of (string) :aabc2d5940f153bb4da108afcefed12f:,:7140ca3e403eddab385088d93d601f83: = true (2ms)
+307ms ║║Cancelling condition #5's schedules...
+308ms ║║Condition #5 evaluated true (8ms)
+319ms ║║Comparison (decimal) 25.4 is_greater_than_or_equal_to (decimal) 23.5 = true (2ms)
+321ms ║║Condition #6 evaluated true (12ms)
+322ms ║║Cancelling condition #4's schedules...
+323ms ║║Condition group #4 evaluated true (state changed) (23ms)
+326ms ║║Cancelling statement #7's schedules...
+428ms ║║Executed physical command [Cool down upstairs [Harmony Activity]].on() (98ms)
+429ms ║║Executed [Cool down upstairs [Harmony Activity]].on (101ms)
+434ms ║║Executed virtual command [Cool down upstairs [Harmony Activity]].wait (1ms)
+436ms ║║Requesting a wake up for Sun, Jun 21 2020 @ 11:59:59 PM EEST (in 7200.0s)
+621ms ║╚Execution stage complete. (347ms)
+623ms ║Setting up scheduled job for Sun, Jun 21 2020 @ 11:59:59 PM EEST (in 7199.814s), with 3 more jobs pending
+633ms ╚Event processed successfully (632ms)

Don’t mind about the first line from app history. That was manual press by me. Basically “cooling” started at 10pm (which is 22:00 where I live). As you can see first off is minute before 00.00, then there’s another “on”…and after one minute it really goes off. This does not seem to happen in every on or off but like I said it bothers me for some reason. Any ideas if it has something to do with the piston design (by me)? :slight_smile:


#2

If you ignore the fact that the piston usually fired a sec early, it looks like it did exactly what you told it to:

----------------------------------
21.59.59 = [Harmony Activity]].on
23.59.58 = [Harmony Activity]].off
0.59.59 = [Harmony Activity]].on
2.59.58 = [Harmony Activity]].off
3.59.59 = [Harmony Activity]].on
5.59.58 = [Harmony Activity]].off
----------------------------------

Side Note:

Harmony is not known for it’s lightning fast reflexes, and even less for it’s response times…


#3

Yep it really does what it is supposed to but is Harmony’s slowness reason for ST app to report:
02:59 off
02:59 on
03:00 off

So for some reason it reports that it first goes off then back on and finally off. Or then it is just some sorf of reporting issue that I shouldn’t care :slight_smile:


#4

I don’t see any issues with your piston, so I guess, if the end results are good, just roll with it. :sunglasses:


#5

I think ST sometimes reports whatever command was sent before it knows whether it was successful. I suspect, that is what is happening with the first off. Tzhen it gets a status that says, no, still on. Then it finally goes off.