Speak Text sounds twice

Foggy · 2017-09-03 16:52:17 UTC

Hello,

More assistance please.

Why does it speak text twice?
Dimmer 1 is an IR toggle that mutes the television
Music Player 1 is a Sonos

c1arkbar · 2017-09-03 16:53:54 UTC

Please attach some logs

Foggy · 2017-09-03 17:26:04 UTC

03/09/2017, 18:24:01 +325ms
+2ms ╔Received event [Home].time = 1504459442437 with a delay of -1113ms
+271ms ║RunTime Analysis CS > 22ms > PS > 52ms > PE > 197ms > CE
+283ms ║Runtime (37770 bytes) successfully initialized in 52ms (v0.2.0e6.20170830) (280ms)
+285ms ║╔Execution stage started
+378ms ║║Executed physical command [Family Room Sonos].setLevel([25]) (40ms)
+379ms ║║Executed [Family Room Sonos].setLevel (42ms)
+382ms ║║Skipping execution for statement #19 because condition state did not change
+386ms ║╚Execution stage complete. (102ms)
+395ms ╚Event processed successfully (395ms)
03/09/2017, 18:23:51 +13ms
+2ms ╔Received event [Lamp].power = 0.0 with a delay of 264ms
+5690ms ║RunTime Analysis CS > 18ms > PS > 5391ms > PE > 280ms > CE
+5697ms ║Piston waited at a semaphore for 5343ms
+5699ms ║Runtime (37838 bytes) successfully initialized in 5391ms (v0.2.0e6.20170830) (5697ms)
+5700ms ║╔Execution stage started
+5716ms ║║Comparison (decimal) 0.0 rises_above (integer) 500 = false (1ms)
+5718ms ║║Condition #4 evaluated false (9ms)
+5720ms ║║Condition group #1 evaluated false (state did not change) (11ms)
+5728ms ║║Comparison (decimal) 0.0 drops_below (integer) 99 = true (1ms)
+5730ms ║║Cancelling condition #12’s schedules…
+5731ms ║║Condition #12 evaluated true (10ms)
+5732ms ║║Cancelling condition #6’s schedules…
+5733ms ║║Condition group #6 evaluated true (state changed) (13ms)
+5737ms ║║Cancelling statement #15’s schedules…
+5890ms ║║Executed physical command [Mute].off() (145ms)
+5891ms ║║Executed virtual command [Mute].toggle (150ms)
+5895ms ║║Cancelling statement #10’s schedules…
+5957ms ║║Executed physical command [Family Room Sonos].setLevel([60]) (55ms)
+5958ms ║║Executed [Family Room Sonos].setLevel (56ms)
+5963ms ║║Executed virtual command [Family Room Sonos].wait (0ms)
+5964ms ║║Waiting for 2000ms
+8417ms ║║Executed physical command [Family Room Sonos].playText([James. The dryer has finished]) (447ms)
+8417ms ║║Executed [Family Room Sonos].playText (449ms)
+8422ms ║║Executed virtual command [Family Room Sonos].wait (1ms)
+8423ms ║║Requesting a wake up for Sun, Sep 3 2017 @ 6:24:02 PM BST (in 3.0s)
+8430ms ║╚Execution stage complete. (2731ms)
+8432ms ║Setting up scheduled job for Sun, Sep 3 2017 @ 6:24:02 PM BST (in 2.993s)
+8449ms ╚Event processed successfully (8449ms)
03/09/2017, 18:23:49 +845ms
+2ms ╔Received event [Lamp].power = -327.0 with a delay of 340ms
+309ms ║RunTime Analysis CS > 33ms > PS > 56ms > PE > 220ms > CE
+321ms ║Runtime (37767 bytes) successfully initialized in 56ms (v0.2.0e6.20170830) (318ms)
+323ms ║╔Execution stage started
+348ms ║║Comparison (decimal) -327.0 rises_above (integer) 500 = false (2ms)
+352ms ║║Condition #4 evaluated false (14ms)
+354ms ║║Condition group #1 evaluated false (state did not change) (18ms)
+369ms ║║Comparison (decimal) -327.0 drops_below (integer) 99 = true (2ms)
+371ms ║║Cancelling condition #12’s schedules…
+372ms ║║Condition #12 evaluated true (15ms)
+373ms ║║Cancelling condition #6’s schedules…
+374ms ║║Condition group #6 evaluated true (state changed) (18ms)
+379ms ║║Cancelling statement #15’s schedules…
+712ms ║║Executed physical command [Mute].off() (325ms)
+713ms ║║Executed virtual command [Mute].toggle (330ms)
+718ms ║║Cancelling statement #10’s schedules…
+768ms ║║Executed physical command [Family Room Sonos].setLevel([60]) (42ms)
+769ms ║║Executed [Family Room Sonos].setLevel (44ms)
+775ms ║║Executed virtual command [Family Room Sonos].wait (1ms)
+775ms ║║Waiting for 2000ms
+3217ms ║║Executed physical command [Family Room Sonos].playText([James. The dryer has finished]) (435ms)
+3218ms ║║Executed [Family Room Sonos].playText (437ms)
+3223ms ║║Executed virtual command [Family Room Sonos].wait (0ms)
+3224ms ║║Waiting for 3000ms
+6263ms ║║Executed physical command [Family Room Sonos].setLevel([25]) (33ms)
+6264ms ║║Executed [Family Room Sonos].setLevel (35ms)
+6269ms ║║Cancelling statement #19’s schedules…
+6316ms ║║Executed physical command [Mute].on() (40ms)
+6317ms ║║Executed virtual command [Mute].toggle (45ms)
+6323ms ║╚Execution stage complete. (6001ms)
+6333ms ╚Event processed successfully (6332ms)
03/09/2017, 18:23:48 +597ms
+2ms ╔Received event [Lamp].power = 1642.0 with a delay of 309ms
+234ms ║RunTime Analysis CS > 22ms > PS > 44ms > PE > 167ms > CE
+244ms ║Runtime (37767 bytes) successfully initialized in 44ms (v0.2.0e6.20170830) (241ms)
+245ms ║╔Execution stage started
+260ms ║║Comparison (decimal) 1642.0 rises_above (integer) 500 = false (1ms)
+262ms ║║Condition #4 evaluated false (9ms)
+264ms ║║Condition group #1 evaluated false (state did not change) (10ms)
+272ms ║║Comparison (decimal) 1642.0 drops_below (integer) 99 = false (1ms)
+274ms ║║Condition #12 evaluated false (8ms)
+275ms ║║Condition group #6 evaluated false (state did not change) (11ms)
+278ms ║╚Execution stage complete. (33ms)
+286ms ╚Event processed successfully (286ms)
03/09/2017, 18:23:47 +335ms
+2ms ╔Received event [Lamp].power = 1642.7 with a delay of 268ms
+271ms ║RunTime Analysis CS > 24ms > PS > 56ms > PE > 190ms > CE
+282ms ║Runtime (37767 bytes) successfully initialized in 56ms (v0.2.0e6.20170830) (276ms)
+283ms ║╔Execution stage started
+299ms ║║Comparison (decimal) 1642.7 rises_above (integer) 500 = false (1ms)
+301ms ║║Condition #4 evaluated false (8ms)
+302ms ║║Condition group #1 evaluated false (state did not change) (11ms)
+311ms ║║Comparison (decimal) 1642.7 drops_below (integer) 99 = false (2ms)
+313ms ║║Condition #12 evaluated false (10ms)
+315ms ║║Condition group #6 evaluated false (state did not change) (11ms)
+318ms ║╚Execution stage complete. (35ms)
+327ms ╚Event processed successfully (326ms)
03/09/2017, 18:23:46 +91ms
+2ms ╔Received event [Lamp].power = 1641.2 with a delay of 261ms
+546ms ║RunTime Analysis CS > 31ms > PS > 302ms > PE > 212ms > CE
+553ms ║Piston waited at a semaphore for 260ms
+556ms ║Runtime (37835 bytes) successfully initialized in 302ms (v0.2.0e6.20170830) (553ms)
+557ms ║╔Execution stage started
+572ms ║║Comparison (decimal) 1641.2 rises_above (integer) 500 = false (1ms)
+574ms ║║Condition #4 evaluated false (9ms)
+576ms ║║Condition group #1 evaluated false (state did not change) (10ms)
+584ms ║║Comparison (decimal) 1641.2 drops_below (integer) 99 = false (1ms)
+586ms ║║Condition #12 evaluated false (8ms)
+587ms ║║Condition group #6 evaluated false (state did not change) (10ms)
+590ms ║╚Execution stage complete. (33ms)
+597ms ╚Event processed successfully (597ms)
03/09/2017, 18:23:41 +205ms
+2ms ╔Received event [Lamp].power = 1641.9 with a delay of 296ms
+4900ms ║RunTime Analysis CS > 19ms > PS > 4680ms > PE > 202ms > CE
+4907ms ║Piston waited at a semaphore for 4625ms
+4910ms ║Runtime (37841 bytes) successfully initialized in 4680ms (v0.2.0e6.20170830) (4908ms)
+4911ms ║╔Execution stage started
+4928ms ║║Comparison (decimal) 1641.9 rises_above (integer) 500 = false (2ms)
+4930ms ║║Condition #4 evaluated false (10ms)
+4931ms ║║Condition group #1 evaluated false (state did not change) (11ms)
+4940ms ║║Comparison (decimal) 1641.9 drops_below (integer) 99 = false (2ms)
+4942ms ║║Condition #12 evaluated false (9ms)
+4944ms ║║Condition group #6 evaluated false (state did not change) (11ms)
+4947ms ║╚Execution stage complete. (36ms)
+4955ms ╚Event processed successfully (4954ms)
03/09/2017, 18:23:45 +4ms
+2ms ╔Received event [Lamp].power = 1639.6 with a delay of 387ms
+518ms ║RunTime Analysis CS > 16ms > PS > 294ms > PE > 208ms > CE
+526ms ║Piston waited at a semaphore for 259ms
+529ms ║Runtime (37832 bytes) successfully initialized in 294ms (v0.2.0e6.20170830) (526ms)
+530ms ║╔Execution stage started
+544ms ║║Comparison (decimal) 1639.6 rises_above (integer) 500 = false (1ms)
+546ms ║║Condition #4 evaluated false (8ms)
+548ms ║║Condition group #1 evaluated false (state did not change) (9ms)
+555ms ║║Comparison (decimal) 1639.6 drops_below (integer) 99 = false (1ms)
+557ms ║║Condition #12 evaluated false (8ms)
+558ms ║║Condition group #6 evaluated false (state did not change) (10ms)
+562ms ║╚Execution stage complete. (32ms)
+569ms ╚Event processed successfully (569ms)
03/09/2017, 18:23:38 +739ms
+2ms ╔Received event [Lamp].power = 1643.1 with a delay of 267ms
+6085ms ║RunTime Analysis CS > 21ms > PS > 5676ms > PE > 389ms > CE
+6275ms ║Piston waited at a semaphore for 5628ms
+6277ms ║Runtime (37836 bytes) successfully initialized in 5676ms (v0.2.0e6.20170830) (6274ms)
+6279ms ║╔Execution stage started
+6296ms ║║Comparison (decimal) 1643.1 rises_above (integer) 500 = false (1ms)
+6298ms ║║Cancelling condition #4’s schedules…
+6299ms ║║Condition #4 evaluated false (10ms)
+6301ms ║║Cancelling condition #1’s schedules…
+6302ms ║║Condition group #1 evaluated false (state changed) (13ms)
+6311ms ║║Comparison (decimal) 1643.1 drops_below (integer) 99 = false (1ms)
+6313ms ║║Condition #12 evaluated false (10ms)
+6314ms ║║Condition group #6 evaluated false (state did not change) (11ms)
+6318ms ║╚Execution stage complete. (39ms)
+6331ms ╚Event processed successfully (6330ms)
03/09/2017, 18:23:42 +423ms
+1ms ╔Received event [Lamp].power = 1640.6 with a delay of 263ms
+1934ms ║RunTime Analysis CS > 18ms > PS > 1564ms > PE > 353ms > CE
+1942ms ║Piston waited at a semaphore for 1522ms
+1945ms ║Runtime (37836 bytes) successfully initialized in 1564ms (v0.2.0e6.20170830) (1943ms)
+1947ms ║╔Execution stage started
+1966ms ║║Comparison (decimal) 1640.6 rises_above (integer) 500 = false (1ms)
+1968ms ║║Cancelling condition #4’s schedules…
+1969ms ║║Condition #4 evaluated false (11ms)
+1971ms ║║Cancelling condition #1’s schedules…
+1972ms ║║Condition group #1 evaluated false (state changed) (13ms)
+1980ms ║║Comparison (decimal) 1640.6 drops_below (integer) 99 = false (1ms)
+1982ms ║║Condition #12 evaluated false (9ms)
+1984ms ║║Condition group #6 evaluated false (state did not change) (10ms)
+1987ms ║╚Execution stage complete. (41ms)
+1996ms ╚Event processed successfully (1997ms)
03/09/2017, 18:23:36 +594ms
+1ms ╔Received event [Lamp].power = 1644.4 with a delay of 576ms
+7644ms ║RunTime Analysis CS > 24ms > PS > 7402ms > PE > 218ms > CE
+7653ms ║Piston waited at a semaphore for 7355ms
+7655ms ║Runtime (37836 bytes) successfully initialized in 7402ms (v0.2.0e6.20170830) (7653ms)
+7656ms ║╔Execution stage started
+7674ms ║║Comparison (decimal) 1644.4 rises_above (integer) 500 = false (1ms)
+7676ms ║║Cancelling condition #4’s schedules…
+7677ms ║║Condition #4 evaluated false (11ms)
+7678ms ║║Cancelling condition #1’s schedules…
+7679ms ║║Condition group #1 evaluated false (state changed) (14ms)
+7689ms ║║Comparison (decimal) 1644.4 drops_below (integer) 99 = false (1ms)
+7691ms ║║Condition #12 evaluated false (10ms)
+7692ms ║║Condition group #6 evaluated false (state did not change) (12ms)
+7696ms ║╚Execution stage complete. (39ms)
+7705ms ╚Event processed successfully (7706ms)
03/09/2017, 18:23:35 +47ms
+2ms ╔Received event [Lamp].power = 1647.5 with a delay of 259ms
+4031ms ║RunTime Analysis CS > 17ms > PS > 3841ms > PE > 172ms > CE
+4044ms ║Piston waited at a semaphore for 3794ms
+4047ms ║Runtime (37838 bytes) successfully initialized in 3841ms (v0.2.0e6.20170830) (4045ms)
+4048ms ║╔Execution stage started
+4065ms ║║Comparison (decimal) 1647.5 rises_above (integer) 500 = true (1ms)
+4067ms ║║Cancelling condition #4’s schedules…
+4068ms ║║Condition #4 evaluated true (10ms)
+4069ms ║║Cancelling condition #1’s schedules…
+4070ms ║║Condition group #1 evaluated true (state changed) (13ms)
+4073ms ║║Cancelling statement #13’s schedules…
+4125ms ║║Executed physical command [Mute].on() (44ms)
+4126ms ║║Executed virtual command [Mute].toggle (50ms)
+4130ms ║║Cancelling statement #2’s schedules…
+4177ms ║║Executed physical command [Family Room Sonos].setLevel([60]) (39ms)
+4177ms ║║Executed [Family Room Sonos].setLevel (40ms)
+4182ms ║║Executed virtual command [Family Room Sonos].wait (1ms)
+4185ms ║║Waiting for 1000ms
+5729ms ║║Executed physical command [Family Room Sonos].playText([James. The dryer has started]) (539ms)
+5730ms ║║Executed [Family Room Sonos].playText (541ms)
+5735ms ║║Executed virtual command [Family Room Sonos].wait (1ms)
+5737ms ║║Waiting for 3000ms
+8774ms ║║Executed physical command [Family Room Sonos].setLevel([25]) (32ms)
+8775ms ║║Executed [Family Room Sonos].setLevel (33ms)
+8779ms ║║Cancelling statement #17’s schedules…
+8824ms ║║Executed physical command [Mute].off() (39ms)
+8825ms ║║Executed virtual command [Mute].toggle (43ms)
+8828ms ║╚Execution stage complete. (4780ms)
+8838ms ╚Event processed successfully (8838ms)
03/09/2017, 18:23:33 +882ms
+1ms ╔Received event [Lamp].power = 1675.3 with a delay of 267ms
+231ms ║RunTime Analysis CS > 19ms > PS > 50ms > PE > 162ms > CE
+241ms ║Runtime (37764 bytes) successfully initialized in 50ms (v0.2.0e6.20170830) (239ms)
+242ms ║╔Execution stage started
+260ms ║║Comparison (decimal) 1675.3 rises_above (integer) 500 = true (2ms)
+263ms ║║Cancelling condition #4’s schedules…
+264ms ║║Condition #4 evaluated true (11ms)
+265ms ║║Cancelling condition #1’s schedules…
+266ms ║║Condition group #1 evaluated true (state changed) (14ms)
+270ms ║║Cancelling statement #13’s schedules…
+321ms ║║Executed physical command [Mute].on() (45ms)
+322ms ║║Executed virtual command [Mute].toggle (49ms)
+327ms ║║Cancelling statement #2’s schedules…
+374ms ║║Executed physical command [Family Room Sonos].setLevel([60]) (39ms)
+375ms ║║Executed [Family Room Sonos].setLevel (41ms)
+380ms ║║Executed virtual command [Family Room Sonos].wait (1ms)
+381ms ║║Waiting for 1000ms
+1785ms ║║Executed physical command [Family Room Sonos].playText([James. The dryer has started]) (395ms)
+1786ms ║║Executed [Family Room Sonos].playText (399ms)
+1795ms ║║Executed virtual command [Family Room Sonos].wait (1ms)
+1796ms ║║Waiting for 3000ms
+4836ms ║║Executed physical command [Family Room Sonos].setLevel([25]) (32ms)
+4837ms ║║Executed [Family Room Sonos].setLevel (34ms)
+4841ms ║║Cancelling statement #17’s schedules…
+4886ms ║║Executed physical command [Mute].off() (39ms)
+4886ms ║║Executed virtual command [Mute].toggle (43ms)
+4891ms ║╚Execution stage complete. (4648ms)
+4899ms ╚Event processed successfully (4899ms)

Foggy · 2017-09-05 10:49:28 UTC

Any thoughts?

Best wishes.

jsulliweb · 2018-02-28 04:33:51 UTC

I’m getting a similar result from a piston that I use to play a welcome home message. @Foggy Any updates? Ever get it working properly?

Foggy · 2018-02-28 22:04:06 UTC

No I did not and didn’t get back to it.

Best wishes…

WCmore · 2018-04-15 17:36:35 UTC

I haven’t started monitoring power usage yet, but from what I know about electricity, it fluxuates. I would venture to guess that your dryer actually went over 500W, then briefly dropped, then rose above 500W again. Something like this:

Maybe try tweaking 500W to another number? If that won’t work, you may have to use variables and/or duration checks.