Squeezebox: Can't get Audio Sink to work for notifications

Great, thank you!

FTR

I just had the same issue trying to use voiceRSS with my openhab stable 2.4 on a raspberry pi3 using docker

Your jar fixed my issue as well!

Many thanks @mhilbush and @Christoph_B for fixing and testing respectively !
Very much appreciated

Edit: To be honest I did not think this is going to fix it because my container is supposed to use the host ip address and not an internal one (not using the bridge network). Maybe I do not understand well how notifications are supposed to work

1 Like

Hi friends.
I have may be the same problem with notifications on OH2.5.0 m1.
In log i see this url generated by pollytts(amazon):

20:57:12.892 [DEBUG] [ernal.handler.SqueezeBoxServerHandler] - Sending command: 00:00:00:00:00:06 playlist add http://192.168.0.254:8090/audio/b36dc725-a122-402c-a317-02d48503ccd6.mp3 Notification

if i go to this url i got error 404 - not found.
But in cache folder \userdata\cache\org.openhab.voice.pollytts:
i see voice files correctly generated by Amazon with this name: Tatyana_4dca73ae6c8476b520d815e93785ee55.mp3 This file plays correctly. Please, @mhilbush help to resolve this problem with no sound on notifications.

This is normal. These URLs are one-time-use only. They disappear pretty quickly after being passed to the notification service. Therefore, this is unrelated to the issue you’ve described above.

The worrisome part is this. This doesn’t look like a valid MAC address.

Sending command: 00:00:00:00:00:06

Can you post a complete debug log showing the following.

  • stop org.openhab.binding.squeezebox (from the console)
  • start org.openhab.binding.squeezebox (from the console)
  • play a notification

Also, what are you using as a player (e.g. piCorePlayer)?

Thank you for reply, @mhilbush. I use a squeezelite 2 players with logitech mediaserver.


Squeezelite v1.9.2-1165, Copyright 2012-2015 Adrian Smith, 2015-2019 Ralph Irving. 

The mac address is correct. This is software players and i assign this mac address at startup script of player.


openhab> smarthome:audio sinks
  SqueezeLite-BathRoom (squeezebox:squeezeboxplayer:B910C26D-0CA0-48CE-9B4C-10F872EF1DD7:000000000005)
* SqueezeLite-NewKitchen (squeezebox:squeezeboxplayer:B910C26D-0CA0-48CE-9B4C-10F872EF1DD7:000000000006)
  System Speaker (javasound)
  System Speaker (with mp3 support) (enhancedjavasound)
  Web Audio (webaudio)

The smarthome:voice say some text command in console work correctly, but they speak only at one player (regardless Bathroom or Kitchen player set as default)

This is log smarthome voise say test command:

11:45:01.281 [DEBUG] [ice.pollytts.internal.PollyTTSService] - Synthesize '?????? ???????? ' in format AudioFormat [codec=MP3, container=NONE, bitDepth=16, bitRate=64000, frequency=22050]
11:45:01.290 [DEBUG] [ice.pollytts.internal.PollyTTSService] - voice UID: 'pollytts:Tatyana' voice label: 'Tatyana' voice Locale: ru_RU
11:45:01.310 [DEBUG] [rnal.cloudapi.CachedPollyTTSCloudImpl] - PollyTTS cache cleaner lastdelete 377914
11:45:01.335 [DEBUG] [ice.pollytts.internal.PollyTTSService] - Audio Stream for '?????? ????????' in format AudioFormat [codec=MP3, container=NONE, bitDepth=16, bitRate=64000, frequency=22050]
11:45:01.356 [DEBUG] [ueezebox.internal.SqueezeBoxAudioSink] - Processing audioStream http://192.168.0.254:8090/audio/eca84b26-efd8-49a5-871f-d72fdf58245d.mp3 of format AudioFormat [codec=MP3, container=NONE, bitDepth=16, bitRate=64000, frequency=22050]
11:45:01.364 [DEBUG] [ernal.handler.SqueezeBoxPlayerHandler] - Play notification sound on player 00:00:00:00:00:06 at URI http://192.168.0.254:8090/audio/eca84b26-efd8-49a5-871f-d72fdf58245d.mp3
11:45:01.372 [DEBUG] [nternal.handler.SqueezeBoxPlayerState] - Cur State: vol=34, mut=NOT MUTED, pwr=ON, stp=NOT STOPPED, ctl=PLAYING, shf=OFF, rpt=OFF, tix=0, tnm=1, tim=2
11:45:01.390 [DEBUG] [.handler.SqueezeBoxNotificationPlayer] - Setting up player for notification
11:45:01.397 [DEBUG] [ernal.handler.SqueezeBoxServerHandler] - Sending command: 00:00:00:00:00:06 stop
11:45:01.410 [DEBUG] [.handler.SqueezeBoxNotificationPlayer] - Adding notification message to playlist
11:45:01.432 [DEBUG] [ernal.handler.SqueezeBoxServerHandler] - Sending command: 00:00:00:00:00:06 playlist add http://192.168.0.254:8090/audio/eca84b26-efd8-49a5-871f-d72fdf58245d.mp3 Notification
11:45:01.468 [TRACE] [smarthome.event.ItemStateEvent       ] - Received event of type 'ItemStateEvent' under the topic 'smarthome/items/SqueezeLiteNewKitchen_Control/state' with payload: '{"type":"PlayPause","value":"PAUSE"}'
11:45:01.503 [INFO ] [smarthome.event.ItemStateEvent       ] - SqueezeLiteNewKitchen_Control updated to PAUSE
11:45:01.517 [TRACE] [smarthome.event.ItemStateChangedEvent] - Received event of type 'ItemStateChangedEvent' under the topic 'smarthome/items/SqueezeLiteNewKitchen_Control/statechanged' with payload: '{"type":"PlayPause","value":"PAUSE","oldType":"PlayPause","oldValue":"PLAY"}'
11:45:01.529 [INFO ] [smarthome.event.ItemStateChangedEvent] - SqueezeLiteNewKitchen_Control changed from PLAY to PAUSE
11:45:01.941 [DEBUG] [.handler.SqueezeBoxNotificationPlayer] - Playlist updated
11:45:01.949 [DEBUG] [.handler.SqueezeBoxNotificationPlayer] - Playing notification
11:45:01.962 [DEBUG] [ernal.handler.SqueezeBoxServerHandler] - Sending command: 00:00:00:00:00:06 playlist index 1
11:45:02.684 [TRACE] [smarthome.event.ItemStateEvent       ] - Received event of type 'ItemStateEvent' under the topic 'smarthome/items/SqueezeLiteNewKitchen_Control/state' with payload: '{"type":"PlayPause","value":"PLAY"}'
11:45:02.717 [INFO ] [smarthome.event.ItemStateEvent       ] - SqueezeLiteNewKitchen_Control updated to PLAY
11:45:02.733 [TRACE] [smarthome.event.ItemStateChangedEvent] - Received event of type 'ItemStateChangedEvent' under the topic 'smarthome/items/SqueezeLiteNewKitchen_Control/statechanged' with payload: '{"type":"PlayPause","value":"PLAY","oldType":"PlayPause","oldValue":"PAUSE"}'
11:45:02.745 [INFO ] [smarthome.event.ItemStateChangedEvent] - SqueezeLiteNewKitchen_Control changed from PAUSE to PLAY
11:45:03.043 [TRACE] [smarthome.event.ItemStateEvent       ] - Received event of type 'ItemStateEvent' under the topic 'smarthome/items/Kichen_Player_Artist/state' with payload: '{"type":"String","value":""}'
11:45:03.080 [INFO ] [smarthome.event.ItemStateEvent       ] - Kichen_Player_Artist updated to
11:45:03.103 [TRACE] [smarthome.event.ItemStateChangedEvent] - Received event of type 'ItemStateChangedEvent' under the topic 'smarthome/items/Kichen_Player_Artist/statechanged' with payload: '{"type":"String","value":"","oldType":"String","oldValue":"Showtek"}'
11:45:03.110 [INFO ] [smarthome.event.ItemStateChangedEvent] - Kichen_Player_Artist changed from Showtek to
11:45:03.117 [TRACE] [smarthome.event.ItemStateEvent       ] - Received event of type 'ItemStateEvent' under the topic 'smarthome/items/Player/state' with payload: '{"type":"String","value":"Notification"}'
11:45:03.124 [INFO ] [smarthome.event.ItemStateEvent       ] - Player updated to Notification
11:45:03.131 [TRACE] [smarthome.event.ItemStateChangedEvent] - Received event of type 'ItemStateChangedEvent' under the topic 'smarthome/items/Player/statechanged' with payload: '{"type":"String","value":"Notification","oldType":"String","oldValue":"Listen To Your Momma (feat. Leon Sherman)"}'
11:45:03.138 [INFO ] [smarthome.event.ItemStateChangedEvent] - Player changed from Listen To Your Momma (feat. Leon Sherman) to Notification
11:45:10.723 [DEBUG] [ernal.handler.SqueezeBoxServerHandler] - Sending command: players 0
11:45:22.212 [DEBUG] [.handler.SqueezeBoxNotificationPlayer] - Notification message timed out after 20 seconds
11:45:22.219 [DEBUG] [.handler.SqueezeBoxNotificationPlayer] - Restoring player state
11:45:22.233 [DEBUG] [ernal.handler.SqueezeBoxServerHandler] - Sending command: 00:00:00:00:00:06 mixer volume 0
11:45:22.258 [DEBUG] [.handler.SqueezeBoxNotificationPlayer] - Removing notification message from playlist
11:45:22.273 [DEBUG] [ernal.handler.SqueezeBoxServerHandler] - Sending command: 00:00:00:00:00:06 playlist delete 1
11:45:22.406 [TRACE] [smarthome.event.ItemStateEvent       ] - Received event of type 'ItemStateEvent' under the topic 'smarthome/items/SqueezeLiteNewKitchen_Control/state' with payload: '{"type":"PlayPause","value":"PAUSE"}'
11:45:22.415 [INFO ] [smarthome.event.ItemStateEvent       ] - SqueezeLiteNewKitchen_Control updated to PAUSE
11:45:22.422 [TRACE] [smarthome.event.ItemStateChangedEvent] - Received event of type 'ItemStateChangedEvent' under the topic 'smarthome/items/SqueezeLiteNewKitchen_Control/statechanged' with payload: '{"type":"PlayPause","value":"PAUSE","oldType":"PlayPause","oldValue":"PLAY"}'
11:45:22.429 [INFO ] [smarthome.event.ItemStateChangedEvent] - SqueezeLiteNewKitchen_Control changed from PLAY to PAUSE
11:45:24.702 [TRACE] [smarthome.event.ItemStateEvent       ] - Received event of type 'ItemStateEvent' under the topic 'smarthome/items/Player/state' with payload: '{"type":"String","value":"Listen To Your Momma (feat. Leon Sherman)"}'
11:45:24.730 [INFO ] [smarthome.event.ItemStateEvent       ] - Player updated to Listen To Your Momma (feat. Leon Sherman)
11:45:24.771 [TRACE] [smarthome.event.ItemStateChangedEvent] - Received event of type 'ItemStateChangedEvent' under the topic 'smarthome/items/Player/statechanged' with payload: '{"type":"String","value":"Listen To Your Momma (feat. Leon Sherman)","oldType":"String","oldValue":"Notification"}'
11:45:24.792 [DEBUG] [.handler.SqueezeBoxNotificationPlayer] - Playlist updated
11:45:24.826 [INFO ] [smarthome.event.ItemStateChangedEvent] - Player changed from Notification to Listen To Your Momma (feat. Leon Sherman)
11:45:24.829 [DEBUG] [ernal.handler.SqueezeBoxServerHandler] - Sending command: 00:00:00:00:00:06 playlist index 0
11:45:24.849 [TRACE] [smarthome.event.ItemStateEvent       ] - Received event of type 'ItemStateEvent' under the topic 'smarthome/items/SqueezeLiteNewKitchen_Control/state' with payload: '{"type":"PlayPause","value":"PLAY"}'
11:45:24.854 [DEBUG] [ernal.handler.SqueezeBoxServerHandler] - Sending command: 00:00:00:00:00:06 time 2
11:45:24.868 [INFO ] [smarthome.event.ItemStateEvent       ] - SqueezeLiteNewKitchen_Control updated to PLAY
11:45:24.894 [TRACE] [smarthome.event.ItemStateChangedEvent] - Received event of type 'ItemStateChangedEvent' under the topic 'smarthome/items/SqueezeLiteNewKitchen_Control/statechanged' with payload: '{"type":"PlayPause","value":"PLAY","oldType":"PlayPause","oldValue":"PAUSE"}'
11:45:24.880 [DEBUG] [.handler.SqueezeBoxNotificationPlayer] - Resuming last item playing
11:45:24.906 [INFO ] [smarthome.event.ItemStateChangedEvent] - SqueezeLiteNewKitchen_Control changed from PAUSE to PLAY
11:45:24.914 [DEBUG] [ernal.handler.SqueezeBoxServerHandler] - Sending command: 00:00:00:00:00:06 mixer volume 34
11:45:24.925 [TRACE] [smarthome.event.ItemStateEvent       ] - Received event of type 'ItemStateEvent' under the topic 'smarthome/items/Kichen_Player_Artist/state' with payload: '{"type":"String","value":"Showtek"}'
11:45:24.938 [DEBUG] [ernal.handler.SqueezeBoxPlayerHandler] - SqueezeBoxTimeoutException during notification: Notification message timed out
11:45:24.936 [INFO ] [smarthome.event.ItemStateEvent       ] - Kichen_Player_Artist updated to Showtek
11:45:24.965 [TRACE] [smarthome.event.ItemStateChangedEvent] - Received event of type 'ItemStateChangedEvent' under the topic 'smarthome/items/Kichen_Player_Artist/statechanged' with payload: '{"type":"String","value":"Showtek","oldType":"String","oldValue":""}'
11:45:24.983 [INFO ] [smarthome.event.ItemStateChangedEvent] - Kichen_Player_Artist changed from  to Showtek
11:45:25.122 [TRACE] [smarthome.event.ItemStateEvent       ] - Received event of type 'ItemStateEvent' under the topic 'smarthome/items/SqueezeLiteNewKitchen_Control/state' with payload: '{"type":"PlayPause","value":"PAUSE"}'
11:45:25.151 [INFO ] [smarthome.event.ItemStateEvent       ] - SqueezeLiteNewKitchen_Control updated to PAUSE
11:45:25.159 [TRACE] [smarthome.event.ItemStateChangedEvent] - Received event of type 'ItemStateChangedEvent' under the topic 'smarthome/items/SqueezeLiteNewKitchen_Control/statechanged' with payload: '{"type":"PlayPause","value":"PAUSE","oldType":"PlayPause","oldValue":"PLAY"}'
11:45:25.166 [INFO ] [smarthome.event.ItemStateChangedEvent] - SqueezeLiteNewKitchen_Control changed from PLAY to PAUSE
11:45:26.697 [TRACE] [smarthome.event.ItemStateEvent       ] - Received event of type 'ItemStateEvent' under the topic 'smarthome/items/SqueezeLiteNewKitchen_Control/state' with payload: '{"type":"PlayPause","value":"PLAY"}'
11:45:26.728 [INFO ] [smarthome.event.ItemStateEvent       ] - SqueezeLiteNewKitchen_Control updated to PLAY
11:45:26.744 [TRACE] [smarthome.event.ItemStateChangedEvent] - Received event of type 'ItemStateChangedEvent' under the topic 'smarthome/items/SqueezeLiteNewKitchen_Control/statechanged' with payload: '{"type":"PlayPause","value":"PLAY","oldType":"PlayPause","oldValue":"PAUSE"}'
11:45:26.751 [INFO ] [smarthome.event.ItemStateChangedEvent] - SqueezeLiteNewKitchen_Control changed from PAUSE to PLAY
11:45:29.396 [TRACE] [smarthome.event.ItemStateEvent       ] - Received event of type 'ItemStateEvent' under the topic 'smarthome/items/Player/state' with payload: '{"type":"String","value":"Slide (feat. Frank Ocean \u0026 Migos)"}'
11:45:29.441 [INFO ] [smarthome.event.ItemStateEvent       ] - Player updated to Slide (feat. Frank Ocean & Migos)
11:45:29.476 [TRACE] [smarthome.event.ItemStateChangedEvent] - Received event of type 'ItemStateChangedEvent' under the topic 'smarthome/items/Player/statechanged' with payload: '{"type":"String","value":"Slide (feat. Frank Ocean \u0026 Migos)","oldType":"String","oldValue":"Listen To Your Momma (feat. Leon Sherman)"}'
11:45:29.513 [INFO ] [smarthome.event.ItemStateChangedEvent] - Player changed from Listen To Your Momma (feat. Leon Sherman) to Slide (feat. Frank Ocean & Migos)
11:45:29.541 [TRACE] [smarthome.event.ItemStateEvent       ] - Received event of type 'ItemStateEvent' under the topic 'smarthome/items/Kichen_Player_Artist/state' with payload: '{"type":"String","value":"Calvin Harris"}'
11:45:29.554 [INFO ] [smarthome.event.ItemStateEvent       ] - Kichen_Player_Artist updated to Calvin Harris
11:45:29.588 [TRACE] [smarthome.event.ItemStateChangedEvent] - Received event of type 'ItemStateChangedEvent' under the topic 'smarthome/items/Kichen_Player_Artist/statechanged' with payload: '{"type":"String","value":"Calvin Harris","oldType":"String","oldValue":"Showtek"}'
11:45:29.620 [INFO ] [smarthome.event.ItemStateChangedEvent] - Kichen_Player_Artist changed from Showtek to Calvin Harris
11:45:34.499 [DEBUG] [ernal.handler.SqueezeBoxPlayerHandler] - Trying to download the content of URL http://cdn-albums.tunein.com/gn/P38LKM4QXVg.jpg
^C~                                                                                                                                                                                                  openhab>

This is log smarthome:voise say test command with another default set player:

11:49:10.791 [DEBUG] [ernal.handler.SqueezeBoxServerHandler] - Sending command: players 0
11:49:16.868 [DEBUG] [ice.pollytts.internal.PollyTTSService] - Synthesize '?????? ???????? ' in format AudioFormat [codec=MP3, container=NONE, bitDepth=16, bitRate=64000, frequency=22050]
11:49:16.877 [DEBUG] [ice.pollytts.internal.PollyTTSService] - voice UID: 'pollytts:Tatyana' voice label: 'Tatyana' voice Locale: ru_RU
11:49:16.894 [DEBUG] [rnal.cloudapi.CachedPollyTTSCloudImpl] - PollyTTS cache cleaner lastdelete 633499
11:49:16.910 [DEBUG] [ice.pollytts.internal.PollyTTSService] - Audio Stream for '?????? ????????' in format AudioFormat [codec=MP3, container=NONE, bitDepth=16, bitRate=64000, frequency=22050]
11:49:16.936 [DEBUG] [ueezebox.internal.SqueezeBoxAudioSink] - Processing audioStream http://192.168.0.254:8090/audio/b4e9f3c7-ebd5-4ead-a028-d9d050a31827.mp3 of format AudioFormat [codec=MP3, container=NONE, bitDepth=16, bitRate=64000, frequency=22050]
11:49:16.943 [DEBUG] [ernal.handler.SqueezeBoxPlayerHandler] - Play notification sound on player 00:00:00:00:00:05 at URI http://192.168.0.254:8090/audio/b4e9f3c7-ebd5-4ead-a028-d9d050a31827.mp3
11:49:16.951 [DEBUG] [nternal.handler.SqueezeBoxPlayerState] - Cur State: vol=27, mut=NOT MUTED, pwr=ON, stp=NOT STOPPED, ctl=PLAYING, shf=OFF, rpt=OFF, tix=0, tnm=1, tim=225
11:49:16.967 [DEBUG] [.handler.SqueezeBoxNotificationPlayer] - Setting up player for notification
11:49:16.981 [DEBUG] [ernal.handler.SqueezeBoxServerHandler] - Sending command: 00:00:00:00:00:05 stop
11:49:17.000 [DEBUG] [.handler.SqueezeBoxNotificationPlayer] - Adding notification message to playlist
11:49:17.015 [DEBUG] [ernal.handler.SqueezeBoxServerHandler] - Sending command: 00:00:00:00:00:05 playlist add http://192.168.0.254:8090/audio/b4e9f3c7-ebd5-4ead-a028-d9d050a31827.mp3 Notification
11:49:17.062 [TRACE] [smarthome.event.ItemStateEvent       ] - Received event of type 'ItemStateEvent' under the topic 'smarthome/items/SqueezeLiteNewKitchen_Control/state' with payload: '{"type":"PlayPause","value":"PAUSE"}'

As we can see the mac different but playing on the same player.

And this is the log from rule file with command:
say(“Кубик повернули влево”, “pollytts:Tatyana”, “SqueezeLite-NewKitchen”)

11:54:05.424 [DEBUG] [ice.pollytts.internal.PollyTTSService] - Synthesize '??????? ??????' in format AudioFormat [codec=MP3, container=NONE, bitDepth=16, bitRate=64000, frequency=22050]
11:54:05.435 [DEBUG] [ice.pollytts.internal.PollyTTSService] - voice UID: 'pollytts:Tatyana' voice label: 'Tatyana' voice Locale: ru_RU
11:54:05.451 [DEBUG] [rnal.cloudapi.CachedPollyTTSCloudImpl] - PollyTTS cache cleaner lastdelete 922053
11:54:05.461 [DEBUG] [ice.pollytts.internal.PollyTTSService] - Audio Stream for '??????? ??????' in format AudioFormat [codec=MP3, container=NONE, bitDepth=16, bitRate=64000, frequency=22050]
11:54:05.485 [DEBUG] [ueezebox.internal.SqueezeBoxAudioSink] - Processing audioStream http://192.168.0.254:8090/audio/43c9d984-a813-4218-90f0-f3254f0c39ef.mp3 of format AudioFormat [codec=MP3, container=NONE, bitDepth=16, bitRate=64000, frequency=22050]
11:54:05.494 [DEBUG] [ernal.handler.SqueezeBoxPlayerHandler] - Play notification sound on player 00:00:00:00:00:06 at URI http://192.168.0.254:8090/audio/43c9d984-a813-4218-90f0-f3254f0c39ef.mp3
11:54:05.513 [DEBUG] [nternal.handler.SqueezeBoxPlayerState] - Cur State: vol=34, mut=NOT MUTED, pwr=ON, stp=NOT STOPPED, ctl=PLAYING, shf=OFF, rpt=OFF, tix=0, tnm=1, tim=92
11:54:05.521 [DEBUG] [.handler.SqueezeBoxNotificationPlayer] - Setting up player for notification
11:54:05.529 [DEBUG] [ernal.handler.SqueezeBoxServerHandler] - Sending command: 00:00:00:00:00:06 stop
11:54:05.554 [DEBUG] [ernal.handler.SqueezeBoxServerHandler] - Sending command: 00:00:00:00:00:06 mixer volume 80
11:54:05.621 [TRACE] [smarthome.event.ItemStateEvent       ] - Received event of type 'ItemStateEvent' under the topic 'smarthome/items/SqueezeLiteNewKitchen_Control/state' with payload: '{"type":"PlayPause","value":"PAUSE"}'
11:54:05.664 [INFO ] [smarthome.event.ItemStateEvent       ] - SqueezeLiteNewKitchen_Control updated to PAUSE
11:54:05.683 [DEBUG] [.handler.SqueezeBoxNotificationPlayer] - Adding notification message to playlist
11:54:05.681 [TRACE] [smarthome.event.ItemStateChangedEvent] - Received event of type 'ItemStateChangedEvent' under the topic 'smarthome/items/SqueezeLiteNewKitchen_Control/statechanged' with payload: '{"type":"PlayPause","value":"PAUSE","oldType":"PlayPause","oldValue":"PLAY"}'
11:54:05.702 [DEBUG] [ernal.handler.SqueezeBoxServerHandler] - Sending command: 00:00:00:00:00:06 playlist add http://192.168.0.254:8090/audio/43c9d984-a813-4218-90f0-f3254f0c39ef.mp3 Notification
11:54:05.699 [INFO ] [smarthome.event.ItemStateChangedEvent] - SqueezeLiteNewKitchen_Control changed from PLAY to PAUSE
11:54:06.221 [DEBUG] [.handler.SqueezeBoxNotificationPlayer] - Playlist updated
11:54:06.229 [DEBUG] [.handler.SqueezeBoxNotificationPlayer] - Playing notification
11:54:06.245 [DEBUG] [ernal.handler.SqueezeBoxServerHandler] - Sending command: 00:00:00:00:00:06 playlist index 1
11:54:06.560 [TRACE] [smarthome.event.ItemStateEvent       ] - Received event of type 'ItemStateEvent' under the topic 'smarthome/items/SqueezeLiteNewKitchen_Control/state' with payload: '{"type":"PlayPause","value":"PLAY"}'
11:54:06.619 [INFO ] [smarthome.event.ItemStateEvent       ] - SqueezeLiteNewKitchen_Control updated to PLAY
11:54:06.644 [TRACE] [smarthome.event.ItemStateChangedEvent] - Received event of type 'ItemStateChangedEvent' under the topic 'smarthome/items/SqueezeLiteNewKitchen_Control/statechanged' with payload: '{"type":"PlayPause","value":"PLAY","oldType":"PlayPause","oldValue":"PAUSE"}'
11:54:06.663 [INFO ] [smarthome.event.ItemStateChangedEvent] - SqueezeLiteNewKitchen_Control changed from PAUSE to PLAY
11:54:06.923 [TRACE] [smarthome.event.ItemStateEvent       ] - Received event of type 'ItemStateEvent' under the topic 'smarthome/items/Player/state' with payload: '{"type":"String","value":"Notification"}'
11:54:06.933 [DEBUG] [ernal.handler.SqueezeBoxPlayerHandler] - Trying to download the content of URL http://192.168.0.77:9000/html/images/radio.png
11:54:06.984 [INFO ] [smarthome.event.ItemStateEvent       ] - Player updated to Notification
11:54:07.033 [TRACE] [smarthome.event.ItemStateChangedEvent] - Received event of type 'ItemStateChangedEvent' under the topic 'smarthome/items/Player/statechanged' with payload: '{"type":"String","value":"Notification","oldType":"String","oldValue":"Money On My Mind (Remix)"}'
11:54:07.047 [INFO ] [smarthome.event.ItemStateChangedEvent] - Player changed from Money On My Mind (Remix) to Notification
11:54:07.120 [TRACE] [smarthome.event.ItemStateEvent       ] - Received event of type 'ItemStateEvent' under the topic 'smarthome/items/Kichen_Player_Artist/state' with payload: '{"type":"String","value":""}'
11:54:07.153 [INFO ] [smarthome.event.ItemStateEvent       ] - Kichen_Player_Artist updated to
11:54:07.171 [TRACE] [smarthome.event.ItemStateChangedEvent] - Received event of type 'ItemStateChangedEvent' under the topic 'smarthome/items/Kichen_Player_Artist/statechanged' with payload: '{"type":"String","value":"","oldType":"String","oldValue":"Sam Smith"}'
11:54:07.182 [INFO ] [smarthome.event.ItemStateChangedEvent] - Kichen_Player_Artist changed from Sam Smith to
11:54:10.883 [DEBUG] [ernal.handler.SqueezeBoxServerHandler] - Sending command: players 0
11:54:26.501 [DEBUG] [.handler.SqueezeBoxNotificationPlayer] - Notification message timed out after 20 seconds
11:54:26.509 [DEBUG] [.handler.SqueezeBoxNotificationPlayer] - Restoring player state
11:54:26.516 [DEBUG] [ernal.handler.SqueezeBoxServerHandler] - Sending command: 00:00:00:00:00:06 mixer volume 0
11:54:26.527 [DEBUG] [.handler.SqueezeBoxNotificationPlayer] - Removing notification message from playlist
11:54:26.549 [DEBUG] [ernal.handler.SqueezeBoxServerHandler] - Sending command: 00:00:00:00:00:06 playlist delete 1
11:54:26.678 [TRACE] [smarthome.event.ItemStateEvent       ] - Received event of type 'ItemStateEvent' under the topic 'smarthome/items/SqueezeLiteNewKitchen_Control/state' with payload: '{"type":"PlayPause","value":"PAUSE"}'
11:54:26.713 [INFO ] [smarthome.event.ItemStateEvent       ] - SqueezeLiteNewKitchen_Control updated to PAUSE
11:54:26.729 [TRACE] [smarthome.event.ItemStateChangedEvent] - Received event of type 'ItemStateChangedEvent' under the topic 'smarthome/items/SqueezeLiteNewKitchen_Control/statechanged' with payload: '{"type":"PlayPause","value":"PAUSE","oldType":"PlayPause","oldValue":"PLAY"}'
11:54:26.745 [INFO ] [smarthome.event.ItemStateChangedEvent] - SqueezeLiteNewKitchen_Control changed from PLAY to PAUSE
11:54:27.377 [TRACE] [smarthome.event.ItemStateEvent       ] - Received event of type 'ItemStateEvent' under the topic 'smarthome/items/SqueezeLiteNewKitchen_Control/state' with payload: '{"type":"PlayPause","value":"PLAY"}'
11:54:27.414 [INFO ] [smarthome.event.ItemStateEvent       ] - SqueezeLiteNewKitchen_Control updated to PLAY
11:54:27.436 [TRACE] [smarthome.event.ItemStateChangedEvent] - Received event of type 'ItemStateChangedEvent' under the topic 'smarthome/items/SqueezeLiteNewKitchen_Control/statechanged' with payload: '{"type":"PlayPause","value":"PLAY","oldType":"PlayPause","oldValue":"PAUSE"}'
11:54:27.454 [INFO ] [smarthome.event.ItemStateChangedEvent] - SqueezeLiteNewKitchen_Control changed from PAUSE to PLAY
11:54:27.755 [TRACE] [smarthome.event.ItemStateEvent       ] - Received event of type 'ItemStateEvent' under the topic 'smarthome/items/Kichen_Player_Artist/state' with payload: '{"type":"String","value":"??????"}'
11:54:27.778 [DEBUG] [.handler.SqueezeBoxNotificationPlayer] - Playlist updated
11:54:27.814 [DEBUG] [ernal.handler.SqueezeBoxServerHandler] - Sending command: 00:00:00:00:00:06 playlist index 0
11:54:27.821 [INFO ] [smarthome.event.ItemStateEvent       ] - Kichen_Player_Artist updated to ??????
11:54:27.879 [DEBUG] [ernal.handler.SqueezeBoxServerHandler] - Sending command: 00:00:00:00:00:06 time 92
11:54:27.883 [TRACE] [smarthome.event.ItemStateChangedEvent] - Received event of type 'ItemStateChangedEvent' under the topic 'smarthome/items/Kichen_Player_Artist/statechanged' with payload: '{"type":"String","value":"??????","oldType":"String","oldValue":""}'
11:54:27.915 [DEBUG] [.handler.SqueezeBoxNotificationPlayer] - Resuming last item playing
11:54:27.927 [INFO ] [smarthome.event.ItemStateChangedEvent] - Kichen_Player_Artist changed from  to ??????
11:54:27.945 [DEBUG] [ernal.handler.SqueezeBoxServerHandler] - Sending command: 00:00:00:00:00:06 mixer volume 34
11:54:27.952 [TRACE] [smarthome.event.ItemStateEvent       ] - Received event of type 'ItemStateEvent' under the topic 'smarthome/items/Player/state' with payload: '{"type":"String","value":"??? (feat. ????? ?????)"}'
11:54:27.976 [INFO ] [smarthome.event.ItemStateEvent       ] - Player updated to ??? (feat. ????? ?????)
11:54:27.972 [DEBUG] [ernal.handler.SqueezeBoxPlayerHandler] - SqueezeBoxTimeoutException during notification: Notification message timed out
11:54:27.994 [TRACE] [smarthome.event.ItemStateChangedEvent] - Received event of type 'ItemStateChangedEvent' under the topic 'smarthome/items/Player/statechanged' with payload: '{"type":"String","value":"??? (feat. ????? ?????)","oldType":"String","oldValue":"Notification"}'
11:54:28.016 [INFO ] [smarthome.event.ItemStateChangedEvent] - Player changed from Notification to ??? (feat. ????? ?????)
11:54:28.078 [TRACE] [smarthome.event.ItemStateEvent       ] - Received event of type 'ItemStateEvent' under the topic 'smarthome/items/SqueezeLiteNewKitchen_Control/state' with payload: '{"type":"PlayPause","value":"PAUSE"}'
11:54:28.134 [INFO ] [smarthome.event.ItemStateEvent       ] - SqueezeLiteNewKitchen_Control updated to PAUSE
11:54:28.152 [TRACE] [smarthome.event.ItemStateChangedEvent] - Received event of type 'ItemStateChangedEvent' under the topic 'smarthome/items/SqueezeLiteNewKitchen_Control/statechanged' with payload: '{"type":"PlayPause","value":"PAUSE","oldType":"PlayPause","oldValue":"PLAY"}'
11:54:28.159 [INFO ] [smarthome.event.ItemStateChangedEvent] - SqueezeLiteNewKitchen_Control changed from PLAY to PAUSE
11:54:29.702 [TRACE] [smarthome.event.ItemStateEvent       ] - Received event of type 'ItemStateEvent' under the topic 'smarthome/items/SqueezeLiteNewKitchen_Control/state' with payload: '{"type":"PlayPause","value":"PLAY"}'
11:54:29.717 [DEBUG] [ernal.handler.SqueezeBoxPlayerHandler] - Trying to download the content of URL http://cdn-radiotime-logos.tunein.com/s136389q.png
11:54:29.741 [INFO ] [smarthome.event.ItemStateEvent       ] - SqueezeLiteNewKitchen_Control updated to PLAY
11:54:29.771 [TRACE] [smarthome.event.ItemStateChangedEvent] - Received event of type 'ItemStateChangedEvent' under the topic 'smarthome/items/SqueezeLiteNewKitchen_Control/statechanged' with payload: '{"type":"PlayPause","value":"PLAY","oldType":"PlayPause","oldValue":"PAUSE"}'
11:54:29.782 [INFO ] [smarthome.event.ItemStateChangedEvent] - SqueezeLiteNewKitchen_Control changed from PAUSE to PLAY

Now i realy hear the notification but only in one player with very low volume. Some note: players work in logitech media server in SYNC mode.

This is players processes in system:


[root@Archey ~]# ps -ax | grep sque
  373 ?        SLsl   2:44 /usr/bin/squeezelite -D -v -o front:CARD=DAC,DEV=0 -n NewKitchen -m 00 00 00 00 00 06
  374 ?        SLsl   2:24 /usr/bin/squeezelite -D -v -o default:CARD=sunxicodec -n Bathroom -m 00 00 00 00 00 05
 1626 pts/0    S+     0:00 grep sque


I’m not sure what’s going on. I’d suggest trying a few things.

  • unsync the players. This shouldn’t matter, but it will reduce the number of variables.

  • copy one of the mp3 files from the polyttts cache to your openHAB conf/html directory, then try to play that URL directly from the LMS. That will confirm that the LMS and players can successfully play the mp3 without openHAB in the loop. URL will look like this.

http://your.openhab.ip.address:port/static/name-of-file.mp3

Try this with each of your players.

I try to play tts sound using link and directly from LMS and i found very strange behavior on one of players(NewKitchen). This player atached to the usb device DAC. The sound played very fast and with low volume. Other sound (doorbel.mp3) plays fine on this player.
Another player (Bathroom) play all tested files fine withou any problems. This player use internal DAC.
If player synchrnized i listen all (say destination Bathroom or Kitchen) sound on Bathroom player, if players not sync i listen only sounds for Bathroom player.
Problem in kernel module for this dac or mp3 format? Or may be i need some extra option for starting this squuezelite player
Some info about USB DAC ( [PCM2704 USB DAC):


T:  Bus=02 Lev=01 Prnt=01 Port=00 Cnt=01 Dev#=  2 Spd=12  MxCh= 0
D:  Ver= 1.10 Cls=00(>ifc ) Sub=00 Prot=00 MxPS= 8 #Cfgs=  1
P:  Vendor=08bb ProdID=27c4 Rev=01.00
S:  Manufacturer=BurrBrown from Texas Instruments
S:  Product=USB AUDIO    DAC
C:  #Ifs= 3 Cfg#= 1 Atr=80 MxPwr=500mA
I:  If#= 0 Alt= 0 #EPs= 0 Cls=01(audio) Sub=01 Prot=00 Driver=snd-usb-audio
I:  If#= 1 Alt= 1 #EPs= 1 Cls=01(audio) Sub=02 Prot=00 Driver=snd-usb-audio
I:  If#= 2 Alt= 0 #EPs= 1 Cls=03(HID  ) Sub=00 Prot=00 Driver=usbhid

Good bit of analysis!

I’m no expert in DACs or MP3s. But, in the past I’ve had issues with squeezelite playing some MP3s (i.e. it wouldn’t play short MP3s). Tracking this down was difficult. I was very fortunate that the maintainer of squeezelite was able to make a fix.

I’m not sure what to suggest in your case. Sorry.

Thank you, @mhilbush for your advices. I suppouse i found problem, but i have no idea how to resolve it.
My dac PCM2704 support only 32 44.1 48 khz sample rates. But Pollytts make files with 22050 khz sample rate. Wheh i resample my polly tts file using this command:

ffmpeg -i /opt/openhab2/conf/html/Tatyana_5392486ccd5e7971cd0cba02acccb651.mp3 -ar 44100 tat_44100.mp3

the new file tat_44100.mp3 played fine on both players in synced mode.
Unfortunatelly amazon does not have opportunity to make files in 44.1 khz sample rate.
Does Javasound have this opportunity?
Recieve file than resample and play it.

UPD: i find resample option in squeezelite : -R -u [params] Resample, params = ::::<passband_end>:<stopband_start>:<phase_response>,
recipe = (v|h|m|l|q)(L|I|M)(s) [E|X], E = exception - resample only if native rate not supported, X = async - resample to max rate for device, otherwise to max sync rate
and i will try this later.

VoiceRSS creates 44.1 kHz files. Not sure if that service would work for you…

en-US_ff3700315ab36b20bf3a0efdc76e8ea0.mp3: Audio file with ID3 version 2.4.0, contains: MPEG ADTS, layer III, v1,  56 kbps, 44.1 kHz, Monaural