Serious issues with Webcore. Commands disappearing into the ether

[Mebejedi]

1) Give a description of the problem
To be clear, I’m not sure if the problem is exclusive to Webcore, so I’m trying different things to nail down the problem. I have a larger piston that makes comments based on triggers. It fires successfully about 50% of the time. I took this smaller part out, and made a new, smaller piston. I can fire it twice, but on the third try, it doesn’t even run the first command (turn virtual switch off). These are commands used to change the voice of Alexa through ES. Normally, the messages would be sent as dynamic strings, but the voices aspect requires them sent as a value (as far as I have been able to ascertain).

I use the setAlarmVolume to let my central speaking piston know which Echoes to speak from. Many times, I will see the ring turn blue, indicating the Volume change, but no speech is made.

In another (and larger) piston, I was unable to add any more Condition statements or Actions. I thought the issue was with my piston. However, when I imported someone else’s to make some changes. Webcore still wouldn’t let me make changes. When I tried to drag-and-drop the lines instead, the lines would disappear when I dropped them. I’ve tried clearing the Webcore cache, but I’m still having issues. It feels like Webcore is slowly breaking down on me. Am I being throttled? Should I reinstall WC?

Any suggestions would be helpful.

P.S. on an interesting note, when I use regular speaking commands, they show up in my Alexa history. when I do these new voice commands with ssml, they don’t show up in my Alexa history.

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

5) Attach logs after turning logging level to Full
02/01/2020, 10:36:59 +344ms
+2ms ╔Received event [An Unused Switch].switch = on with a delay of 308ms
+122ms ║RunTime Analysis CS > 25ms > PS > 62ms > PE > 35ms > CE
+125ms ║Runtime (53481 bytes) successfully initialized in 62ms (v0.3.110.20191009) (123ms)
+126ms ║╔Execution stage started
+132ms ║║Comparison (enum) on changes_to (string) on = false (0ms)
+134ms ║║Cancelling condition #99’s schedules…
+135ms ║║Condition #99 evaluated false (5ms)
+136ms ║║Cancelling condition #98’s schedules…
+136ms ║║Condition group #98 evaluated false (state changed) (7ms)
+138ms ║╚Execution stage complete. (13ms)
+139ms ╚Event processed successfully (139ms)
02/01/2020, 10:36:49 +360ms
+2ms ╔Received event [An Unused Switch].switch = on with a delay of 334ms
+117ms ║RunTime Analysis CS > 23ms > PS > 63ms > PE > 31ms > CE
+120ms ║Runtime (53497 bytes) successfully initialized in 63ms (v0.3.110.20191009) (117ms)
+121ms ║╔Execution stage started
+128ms ║║Comparison (enum) on changes_to (string) on = true (0ms)
+129ms ║║Cancelling condition #99’s schedules…
+130ms ║║Condition #99 evaluated true (5ms)
+131ms ║║Cancelling condition #98’s schedules…
+132ms ║║Condition group #98 evaluated true (state changed) (7ms)
+134ms ║║Cancelling statement #322’s schedules…
+148ms ║║Executed physical command [An Unused Switch].off() (11ms)
+149ms ║║Executed [An Unused Switch].off (13ms)
+151ms ║║Cancelling statement #76’s schedules…
+160ms ║║Executed virtual command setVariable (3ms)
+165ms ║║Executed virtual command setVariable (3ms)
+170ms ║║Calculating (string) <voice name=" + (string) Salli >> (string) <voice name=“Salli
+173ms ║║Calculating (string) Who the hell unlocked the back door? >> (string) Who the hell unlocked the back door?
+176ms ║║Executed virtual command setVariable (0ms)
+179ms ║║Executed virtual command setVariable (1ms)
+181ms ║║Cancelling statement #100’s schedules…
+228ms ║║Executed physical command [Front Door Light].setStatusLed([6, 3, 0]) (38ms)
+229ms ║║Executed [Front Door Light].setStatusLed (40ms)
+250ms ║║Executed physical command [Master Patio Switch].setStatusLed([6, 3, 0]) (18ms)
+251ms ║║Executed [Master Patio Switch].setStatusLed (20ms)
+254ms ║║Cancelling statement #313’s schedules…
+534ms ║║Executed physical command [Echo - Computer Echo].setAlarmVolume([99]) (273ms)
+535ms ║║Executed [Echo - Computer Echo].setAlarmVolume (275ms)
+801ms ║║Executed physical command [Echo - Living Room Echo].setAlarmVolume([99]) (261ms)
+802ms ║║Executed [Echo - Living Room Echo].setAlarmVolume (263ms)
+939ms ║║Comparison (dynamic) 61 is_less_than (integer) 70 = true (2ms)
+942ms ║║Cancelling statement #284’s schedules…
+947ms ║║Executed virtual command setVariable (3ms)
+953ms ║║Calculating (string) The back door is closed and locked + (string) , I hope you wore a jacket >> (string) The back door is closed and locked, I hope you wore a jacket
+959ms ║║Executed virtual command setVariable (4ms)
+966ms ║║Calculating (string) <voice name=” + (string) Salli >> (string) <voice name=“Salli
+970ms ║║Calculating (string) >> (string)
+973ms ║║Calculating (string) + (string) The back door is closed and locked, I hope you wore a jacket >> (string) The back door is closed and locked, I hope you wore a jacket
+975ms ║║Calculating (string) The back door is closed and locked, I hope you wore a jacket + (string) >> (string) The back door is closed and locked, I hope you wore a jacket
+978ms ║║Executed virtual command setVariable (1ms)
+982ms ║║Executed virtual command setVariable (1ms)
+983ms ║║Condition #283 evaluated true (178ms)
+984ms ║║Condition group #281 evaluated true (state did not change) (180ms)
+986ms ║╚Execution stage complete. (866ms)
+987ms ╚Event processed successfully (987ms)
02/01/2020, 10:36:36 +737ms
+1ms ╔Received event [An Unused Switch].switch = off with a delay of 165ms
+9859ms ║RunTime Analysis CS > 28ms > PS > 9805ms > PE > 27ms > CE
+9860ms ║Piston waited at a semaphore for 9766ms
+9863ms ║Runtime (53549 bytes) successfully initialized in 9805ms (v0.3.110.20191009) (9862ms)
+9864ms ║╔Execution stage started
+9870ms ║║Comparison (enum) off changes_to (string) on = false (0ms)
+9872ms ║║Cancelling condition #99’s schedules…
+9873ms ║║Condition #99 evaluated false (4ms)
+9874ms ║║Cancelling condition #98’s schedules…
+9874ms ║║Condition group #98 evaluated false (state changed) (7ms)
+9876ms ║╚Execution stage complete. (13ms)
+9877ms ╚Event processed successfully (9877ms)
02/01/2020, 10:36:36 +398ms
+1ms ╔Received event [An Unused Switch].switch = on with a delay of 218ms
+84ms ║RunTime Analysis CS > 17ms > PS > 41ms > PE > 26ms > CE
+87ms ║Runtime (53471 bytes) successfully initialized in 41ms (v0.3.110.20191009) (86ms)
+88ms ║╔Execution stage started
+95ms ║║Comparison (enum) on changes_to (string) on = true (0ms)
+96ms ║║Cancelling condition #99’s schedules…
+97ms ║║Condition #99 evaluated true (5ms)
+98ms ║║Cancelling condition #98’s schedules…
+99ms ║║Condition group #98 evaluated true (state changed) (7ms)
+101ms ║║Cancelling statement #322’s schedules…
+109ms ║║Executed physical command [An Unused Switch].off() (6ms)
+110ms ║║Executed [An Unused Switch].off (7ms)
+112ms ║║Cancelling statement #76’s schedules…
+120ms ║║Executed virtual command setVariable (2ms)
+125ms ║║Executed virtual command setVariable (2ms)
+131ms ║║Calculating (string) <voice name=” + (string) Liv >> (string) <voice name=“Liv
+133ms ║║Calculating (string) Who the hell unlocked the back door? >> (string) Who the hell unlocked the back door?
+136ms ║║Executed virtual command setVariable (1ms)
+139ms ║║Executed virtual command setVariable (1ms)
+142ms ║║Cancelling statement #100’s schedules…
+363ms ║║Executed physical command [Front Door Light].setStatusLed([6, 3, 0]) (215ms)
+364ms ║║Executed [Front Door Light].setStatusLed (216ms)
+379ms ║║Executed physical command [Master Patio Switch].setStatusLed([6, 3, 0]) (13ms)
+380ms ║║Executed [Master Patio Switch].setStatusLed (13ms)
+382ms ║║Cancelling statement #313’s schedules…
+730ms ║║Executed physical command [Echo - Computer Echo].setAlarmVolume([99]) (342ms)
+731ms ║║Executed [Echo - Computer Echo].setAlarmVolume (344ms)
+995ms ║║Executed physical command [Echo - Living Room Echo].setAlarmVolume([99]) (259ms)
+996ms ║║Executed [Echo - Living Room Echo].setAlarmVolume (261ms)
+1130ms ║║Comparison (dynamic) 61 is_less_than (integer) 70 = true (1ms)
+1132ms ║║Cancelling statement #284’s schedules…
+1138ms ║║Executed virtual command setVariable (3ms)
+1149ms ║║Calculating (string) Did you know it’s + (string) 61 >> (string) Did you know it’s 61
+1152ms ║║Calculating (string) Did you know it’s 61 + (string) degrees outside? >> (string) Did you know it’s 61 degrees outside?
+1153ms ║║Calculating (string) The back door is closed and locked + (string) Did you know it’s 61 degrees outside? >> (string) The back door is closed and locked Did you know it’s 61 degrees outside?
+1158ms ║║Executed virtual command setVariable (3ms)
+1166ms ║║Calculating (string) <voice name=” + (string) Liv >> (string) <voice name="Liv
+1169ms ║║Calculating (string) >> (string)
+1172ms ║║Calculating (string) + (string) The back door is closed and locked Did you know it’s 61 degrees outside? >> (string) The back door is closed and locked Did you know it’s 61 degrees outside?
+1175ms ║║Calculating (string) The back door is closed and locked Did you know it’s 61 degrees outside? + (string) >> (string) The back door is closed and locked Did you know it’s 61 degrees outside?
+1178ms ║║Executed virtual command setVariable (1ms)
+1182ms ║║Executed virtual command setVariable (1ms)
+1183ms ║║Condition #283 evaluated true (185ms)
+1184ms ║║Condition group #281 evaluated true (state did not change) (186ms)
+1186ms ║╚Execution stage complete. (1099ms)
+1187ms ╚Event processed successfully (1187ms)

[jkp]

There appear to be multiple reports of users having issues…

Missed motion events; outage?

Hi Guys, Recently, I’ve noticed some of my motion events are delayed or missed completely. It looks like I can see the events in ST’s logs, but they either aren’t making it webcore, or something else is wrong. I thought it was something I was doing wrong, but then I saw a post on the ST community forum. Are there any issues impacting the performance of webcore over the past few days? Possibly unrelated: It did seem that there was a complete ST outage about a week ago, and I think that’s whe…

Pistons requiring two runs

Just as the title says Pistons are requiring that I run them twice before they will work. Any idea what might be causing this?

Webcore Missing Motion.inactive Messages

Interesting. It sounds like this Dec 19 outage and whatever fix was applied my be a cause. Has anyone tried resetting and reading sensors? Any idea if these problems occur with Z wave motion sensors?

[ian_boje]

@Mebejedi Are you on na04-useast2?

I setup a test with two pistons; One flipped the status of a motion sensor, and the second counted the number of times that motion events were detected. At times, I was seeing as much as 22% loss.

I’ve got a ticket open with smartthings, as does Daniel (see post that @jkp linked to). I’d take a look at Daniel’s thread over on the smartthings forum also.

Perhaps if enough people report issues to smartthings, they might acknowledge an issue. The support rep denied any system issues on their side.

[Mebejedi]

Wasn’t aware there was a bug reports forum. Thank you for that.

I’m also glad to see I’m not the only one having this problem. Thought I broke something with these huge pistons. Need to be less ambitious, lol

@ian_boje, yes. Always thought that was weird, since I’m on the west coast.

[ian_boje]

Perhaps they don’t have any on the west coast. I’ve got a buddy on US1, he says he isn’t having these issues. Another poster says he is having the issues on US1.

It wouldn’t surprise me if one user has a loop going that is effectively DOSing this for the rest of us.

[Mebejedi]

Yeah, I’ve been going through all my other pistons trying to make sure it wasn’t something on my end. Very frustrating.

Hey, where do I go to send a ticket? Never done that before.

[russellm]

check my other reply in the motion sensor thread. I too started getting issues with my lights not turning on after a motion trigger. I went into the smarthings (classic) app directly and made a trigger there. Even though the log says my light was turned on, it actually was not turned on 2 out of 3 tries.

[jkp]

Not sure if this is related…

Unable to fetch a connection