BUG: Sonos Notifications Not Working with Rule Machine

ksgnow2010 · November 1, 2021, 4:19pm

I ported my rules from Rule Machine Legacy to Rule Machine, and I am not getting notifications through my Sonos speakers. Here is one of the rules from Rule Machine (same as in Legacy) that is not working:

I know the logic is correct, as this same logic worked in Rule Machine Legacy. The Inovelli Dimmer Switch LEDs change to Red, and the Mode is being set to away. But no TTS.

This particular rule is supposed to say "Security System is Armed" when the alarm is armed. Here is the event log from (A2->H2) ADT Armed Away:

switch on (A2->H2) ADT Armed Away: switch is on DEVICE physical 2021-11-01 06:49:36.017 AM EDT

The corresponding event log from one of the speakers is:

trackData {"audioSource":"Unknown","station":null,"name":"Front Door is Locked","artist":"Hubitat","album":"TTS","trackNumber":"1","status":"stopped","level":"50","mute":"unmuted","uri":"http://192.168.1.200/tts/19dec768fcdc41c9f86842172b47a5a8.mp3","trackUri":"http://192.168.1.200/tts/19dec768fcdc41c9f86842172b47a5a8.mp3","transportUri":"http://192.168.1.200/tts/19dec768fcdc41c9f86842172b47a5a8.mp3","enqueuedUri":"http://192.168.1.200/tts/19dec768fcdc41c9f86842172b47a5a8.mp3","metaData":"http://192.168.1.200/tts/19dec768fcdc41c9f86842172b47a5a8.mp3Front Door is LockedHubitatTTSobject.item.audioItem.musicTrack","trackMetaData":"http://192.168.1.200/tts/19dec768fcdc41c9f86842172b47a5a8.mp3Front Door is LockedHubitatTTSobject.item.audioItem.musicTrack"} DEVICE 2021-11-01 06:55:44.627 AM EDT
trackData {"audioSource":"Unknown","station":null,"name":"Front Door is Locked","artist":"Hubitat","album":"TTS","trackNumber":"1","status":"stopped","level":"50","mute":"unmuted","uri":"http://192.168.1.200/tts/19dec768fcdc41c9f86842172b47a5a8.mp3","trackUri":"http://192.168.1.200/tts/19dec768fcdc41c9f86842172b47a5a8.mp3","transportUri":"http://192.168.1.200/tts/19dec768fcdc41c9f86842172b47a5a8.mp3","enqueuedUri":"http://192.168.1.200/tts/19dec768fcdc41c9f86842172b47a5a8.mp3","metaData":"http:\/\/192.168.1.200\/tts\/19dec768fcdc41c9f86842172b47a5a8.mp3<\/res><\/r:streamContent><\/r:radioShowMd>Front Door is Locked<\/dc:title>Hubitat<\/dc:creator>TTS<\/upnp:album>object.item.audioItem.musicTrack<\/upnp:class><\/item><\/DIDL-Lite>","trackMetaData":"http:\/\/192.168.1.200\/tts\/19dec768fcdc41c9f86842172b47a5a8.mp3<\/res><\/r:streamContent><\/r:radioShowMd>Front Door is Locked<\/dc:title>Hubitat<\/dc:creator>TTS<\/upnp:album>object.item.audioItem.musicTrack<\/upnp:class><\/item><\/DIDL-Lite>"} DEVICE 2021-11-01 06:55:44.271 AM EDT

Two things:

I hear nothing
The tracking is showing "Front Door is Locked"...this actually plays (properly) through a WebCore piston that is running...and only plays this when the front door changes between locked and unlocked

So - strange behavior, no sound, and wrong track.

Additionally, when I look into the logs for these Sonos speakers, they are being spammed with this same this about every 20 minutes after. It's too large to post.

mike.maxwell · November 1, 2021, 4:25pm

can you enable logging in the rule, then post those when you arm?

ksgnow2010 · November 1, 2021, 4:28pm

Which logging boxes should I check:

Events
Triggers
Actions
App Events

mike.maxwell · November 1, 2021, 4:43pm

all of them

mike.maxwell · November 1, 2021, 4:44pm

disable trackData in the preferences....

ksgnow2010 · November 1, 2021, 4:46pm

I cleared and armed the alarm remotely, here are the logs:

[dev:111]2021-11-01 12:38:55.188 pm [info]Living Room Sonos audio level is 50%

[dev:113]2021-11-01 12:38:54.955 pm [info]Living Room Sonos audio level is 50%

[dev:110]2021-11-01 12:38:54.712 pm [info]Yoga Room Sonos audio level is 50%

[dev:111]2021-11-01 12:38:54.649 pm [error]java.lang.NullPointerException: Cannot invoke method toInteger() on null object on line 650 (method speak)

[dev:113]2021-11-01 12:38:54.616 pm [info]Living Room Sonos audio level is 50%

[dev:110]2021-11-01 12:38:54.557 pm [error]java.lang.NullPointerException: Cannot invoke method toInteger() on null object on line 650 (method speak)

[dev:113]2021-11-01 12:38:54.495 pm [error]java.lang.NullPointerException: Cannot invoke method toInteger() on null object on line 650 (method speak)

[app:482]2021-11-01 12:38:54.454 pm [info]Action: Speak on Living Room Sonos, Yoga Room Sonos, Living Room Sonos: 'Security System is Armed Away'

[app:482]2021-11-01 12:38:54.374 pm [info]Action: Set Volume on Living Room Sonos, Yoga Room Sonos, Living Room Sonos to 50

[app:482]2021-11-01 12:38:54.359 pm [info]Action: Mode: Away

[dev:1045]2021-11-01 12:38:54.354 pm [info]Z-Wave: Inovelli Dimmer Switch LEDs - Red switch was turned on

[dev:1039]2021-11-01 12:38:54.187 pm [debug]on()

[dev:1037]2021-11-01 12:38:54.057 pm [debug]on()

[dev:1035]2021-11-01 12:38:53.932 pm [debug]on()

[dev:1033]2021-11-01 12:38:53.810 pm [debug]on()

[dev:1043]2021-11-01 12:38:53.686 pm [debug]on()

[dev:1041]2021-11-01 12:38:53.553 pm [debug]on()

[app:482]2021-11-01 12:38:53.528 pm [info]Action: On: Z-Wave: Inovelli Dimmer Switch LEDs - Red

[app:482]2021-11-01 12:38:53.504 pm [info]ADT Pulse - Alarm Panel Interface - 2 Away Triggered

[app:482]2021-11-01 12:38:53.497 pm [info]ADT Pulse - Alarm Panel Interface - 2 Away: (A2->H2) ADT Armed Away switch on

[dev:211]2021-11-01 12:38:53.431 pm [info] (A2->H2) ADT Armed Away: switch is on

[dev:209]2021-11-01 12:38:53.364 pm [info]ADT Interface: switch is on

[dev:254]2021-11-01 12:38:50.798 pm [info]Garage Flood Motion is active

[dev:258]2021-11-01 12:38:17.359 pm [info]Master Bedroom A/C Leak Sensor temperature is 79.38°F

[dev:111]2021-11-01 12:38:06.501 pm [info]Living Room Sonos audio level is 50%

[dev:113]2021-11-01 12:38:06.208 pm [info]Living Room Sonos audio level is 50%

[app:483]2021-11-01 12:38:06.071 pm [info]Action: END-IF

[dev:111]2021-11-01 12:38:06.066 pm [error]java.lang.NullPointerException: Cannot invoke method toInteger() on null object on line 650 (method speak)

[dev:110]2021-11-01 12:38:06.017 pm [error]java.lang.NullPointerException: Cannot invoke method toInteger() on null object on line 650 (method speak)

[dev:113]2021-11-01 12:38:05.999 pm [error]java.lang.NullPointerException: Cannot invoke method toInteger() on null object on line 650 (method speak)

[dev:110]2021-11-01 12:38:05.829 pm [info]Yoga Room Sonos audio level is 50%

[app:483]2021-11-01 12:38:05.791 pm [info]Action: Speak on Living Room Sonos, Yoga Room Sonos, Living Room Sonos: 'Security System is Disarmed'

[dev:113]2021-11-01 12:38:05.714 pm [info]Living Room Sonos audio level is 50%

[app:483]2021-11-01 12:38:05.410 pm [info]Action: Set Volume on Living Room Sonos, Yoga Room Sonos, Living Room Sonos to 50

[app:483]2021-11-01 12:38:05.387 pm [info]Action: Mode: Home

[dev:1045]2021-11-01 12:38:05.381 pm [info]Z-Wave: Inovelli Dimmer Switch LEDs - Red switch was turned off

[dev:1039]2021-11-01 12:38:05.259 pm [debug]off()

[dev:1037]2021-11-01 12:38:05.137 pm [debug]off()

[dev:1035]2021-11-01 12:38:05.016 pm [debug]off()

[dev:1033]2021-11-01 12:38:04.896 pm [debug]off()

[dev:1043]2021-11-01 12:38:04.773 pm [debug]off()

[dev:1041]2021-11-01 12:38:04.539 pm [debug]off()

[app:483]2021-11-01 12:38:04.475 pm [info]Action: Off: Z-Wave: Inovelli Dimmer Switch LEDs - Red

[app:483]2021-11-01 12:38:04.469 pm [info]Action: IF ((A1->H3) ADT Armed Stay, (A2->H2) ADT Armed Away(off, off) all off(T) [TRUE]) THEN

[app:483]2021-11-01 12:38:04.355 pm [info]ADT Pulse - Alarm Panel Interface - 3 Stay or Away Off Triggered

[app:483]2021-11-01 12:38:04.343 pm [info]ADT Pulse - Alarm Panel Interface - 3 Stay or Away Off: (A2->H2) ADT Armed Away switch off

[dev:211]2021-11-01 12:38:04.256 pm [info] (A2->H2) ADT Armed Away: switch is off

[dev:209]2021-11-01 12:38:04.187 pm [info]ADT Interface: switch is on

ksgnow2010 · November 1, 2021, 4:49pm

It was from the beginning:

mike.maxwell · November 1, 2021, 4:52pm

right, to disable it, the preference must be turned on...
so right now it's enabled (not disabled)