Announcement

Collapse
No announcement yet.

Playbar not resuming after announcement

Collapse
X
 
  • Filter
  • Time
  • Show
Clear All
new posts

    Playbar not resuming after announcement

    First of all, I would like to say I love the Sonos PI. It is awesome being able to integrate all of the functionality of the Sonos players throughout the house into HS3.

    I recently added two Playbars to our Sonos system. One of them is a solo Playbar, the other is paired with two Play:1s. The Playbars are named 'Kitchen' and 'Family Room'.

    In the plugin config, I have a linkgroup that groups the two Playbars together for announcements.



    When I run an event that speaks audio that targets this linkgroup, the Playbars do not resume what they were playing previously. So, if we are watching TV and an announcement plays, the TV audio does not resume when the announcement completes. The Sonos app shows the current input for the Playbar as 'HomeSeer Announcement'. We have to manually set the Playbar to TV by using the Sonos app. The same behavior happens when playing music as well.

    I turned on Debug and Super Debug flags and have included the log entries below if you'd like to take a look. I am running PI v3.1.0.22 and HS3 v3.0.0.368 on Windows.

    Thanks in advance for any help.

    Code:
    Nov-16 20:36:14	 	Sonos	GetIniSection called with section = TTSSpeakDevice, FileName = Sonos.ini and # Result = -1
    Nov-16 20:36:14	 	Sonos	postBackProc for SonosControl found Value = DebugChkBox
    Nov-16 20:36:14	 	Sonos	postBackProc for SonosControl found Key = id
    Nov-16 20:36:14	 	Sonos	postBackProc for SonosControl found Value = unchecked
    Nov-16 20:36:14	 	Sonos	postBackProc for SonosControl found Key = DebugChkBox
    Nov-16 20:36:14	 	Sonos	PostBackProc for SonosControl called with page = SonosConfig and data = DebugChkBox=unchecked&id=DebugChkBox and user = default and userRights = 6
    Nov-16 20:36:11	 	Sonos	GetPagePlugin for SonosControl called with pageName = SonosConfig and user = default and userRights = 6 and queryString =
    Nov-16 20:36:11	 	Sonos	hspi.GetPagePlugin called for instance = and pageName = SonosConfig and user = default and userRights = 6 and queryString =
    Nov-16 20:36:10	 	Sonos	DoCheckAnnouncementQueue is ending and all announcements were processed
    Nov-16 20:36:10	 	Sonos	DeleteHeadOfAnnouncementQueue called
    Nov-16 20:36:10	 	Sonos	DeviceTrigger called for Zone - with Trigger = Sonos Announcement Stop
    Nov-16 20:36:10	 	Sonos	PlayChangeNotifyCallback called for Zone - with ChangeType = AnnouncementChange and Changevalue = AnnouncementStop and SendDeviceTrigger = True
    Nov-16 20:36:10	 	Sonos	DoCheckAnnouncementQueue is done unlinking
    Nov-16 20:36:10	 	Sonos	HandleLinkingOff done with LinkgroupName = SOFTANNOUNCE and # players = 2
    Nov-16 20:36:09	 	Sonos	Finished DeletePreviousSavedQueues for zoneplayer = Family Room
    Nov-16 20:36:09	 	Sonos	DeletePreviousSavedQueues found 7 playlists for ZonePlayer - Family Room
    Nov-16 20:36:09	 	Sonos	DeletePreviousSavedQueues called for ZonePlayer = Family Room with QueueName = SCQueue-Family Room-SOFTANNOUNCE
    Nov-16 20:36:08	 	Sonos	SavedPlayerList.GetLastIndex called and MyLinkListIndex = 0
    Nov-16 20:36:08	 	Sonos	RestoreCurrentTrackInfo is done for zonePlayer Kitchen
    Nov-16 20:36:08	 	Sonos	RestoreCurrentTrackInfo updated HS DeviceValue for zonePlayer Kitchen. HSRef = 672 and value = Stopped
    Nov-16 20:36:08	 	Sonos	DeviceTrigger called for Zone - Kitchen with Trigger = Sonos Player Stop
    Nov-16 20:36:08	 	Sonos	PlayChangeNotifyCallback called for Zone - Kitchen with ChangeType = PlayStatusChanged and Changevalue = Stopped and SendDeviceTrigger = True
    Nov-16 20:36:08	 	Sonos	SetTransportState called for zoneplayer - Kitchen with value = STOPPED
    Nov-16 20:36:08	 	Sonos	SetPlayMode called for ZoneName Kitchen with value = NORMAL
    Nov-16 20:36:08	 	Sonos	SetMute called for zoneplayer = Kitchen with Channel = Master and NewState = False and DeviceStatus =Online
    Nov-16 20:36:08	 	Sonos	SetVolumeLevel called for ZonePlayer = Kitchen with values Channel=Master Value=50
    Nov-16 20:36:07	 	Sonos	PlayURI called for zoneplayer Kitchen with strURI = http://192.168.86.116:80/Sonos/Announcements/Ann_SOFTANNOUNCE_0.mp3 and MetaData = http://192.168.86.116:80/Sonos/Announcements/Ann_SOFTANNOUNCE_0.mp3http://192.168.86.116:80/images/Sonos/Announcement.jpgHomeSeer Announcementobject.item.audioItem.musicTrackDirk CorsusSonosControllerDirk Corsus and isObjectID = False
    Nov-16 20:36:07	 	Sonos	RestoreCurrentTrackInfo for Zonename = Kitchen and MySavedTrackinfo = http://192.168.86.116:80/Sonos/Announcements/Ann_SOFTANNOUNCE_0.mp3
    Nov-16 20:36:07	 	Sonos	SavedPlayerList.GetLastIndex called and returned UDN = RINCON_949F3E66DB9001400
    Nov-16 20:36:07	 	Sonos	SavedPlayerList.GetLastIndex called and MyLinkListIndex = 1
    Nov-16 20:36:07	 	Sonos	RestoreCurrentTrackInfo is done for zonePlayer Family Room
    Nov-16 20:36:07	 	Sonos	RestoreCurrentTrackInfo updated HS DeviceValue for zonePlayer Family Room. HSRef = 675 and value = Stopped
    Nov-16 20:36:07	 	Sonos	DeviceTrigger called for Zone - Family Room with Trigger = Sonos Player Stop
    Nov-16 20:36:07	 	Sonos	PlayChangeNotifyCallback called for Zone - Family Room with ChangeType = PlayStatusChanged and Changevalue = Stopped and SendDeviceTrigger = True
    Nov-16 20:36:07	 	Sonos	SetTransportState called for zoneplayer - Family Room with value =
    Nov-16 20:36:07	 	Sonos	SetPlayMode called for ZoneName Family Room with value = NORMAL
    Nov-16 20:36:07	 	Sonos	SetMute called for zoneplayer = Family Room with Channel = Master and NewState = False and DeviceStatus =Online
    Nov-16 20:36:07	 	Sonos	SetVolumeLevel called for ZonePlayer = Family Room with values Channel=Master Value=28
    Nov-16 20:36:07	 	Sonos	PlayURI called for zoneplayer Family Room with strURI = and MetaData = and isObjectID = False
    Nov-16 20:36:07	 	Sonos	RestoreCurrentTrackInfo for Zonename = Family Room and MySavedTrackinfo =
    Nov-16 20:36:07	 	Sonos	SavedPlayerList.GetLastIndex called and returned UDN = RINCON_949F3E684FD201400
    Nov-16 20:36:07	 	Sonos	SavedPlayerList.GetLastIndex called and MyLinkListIndex = 2
    Nov-16 20:36:07	 	Sonos	PlayURI called for zoneplayer Family Room with strURI = x-rincon-queue:RINCON_949F3E684FD201400#0 and MetaData = and isObjectID = False
    Nov-16 20:36:06	 	Sonos	PlayURI called for zoneplayer Kitchen with strURI = x-rincon-queue:RINCON_949F3E66DB9001400#0 and MetaData = and isObjectID = False
    Nov-16 20:36:06	 	Sonos	GetLinkGroupInfo called with LinkgroupName = SOFTANNOUNCE
    Nov-16 20:36:06	 	Sonos	HandleLinkingOff called with LinkgroupName = SOFTANNOUNCE
    Nov-16 20:36:06	 	Sonos	DoCheckAnnouncementQueue is starting to unlink
    Nov-16 20:36:06	 	Sonos	DoCheckAnnouncementQueue called for linkgroup SOFTANNOUNCE and State = asFilePlayed and isFile = True
    Nov-16 20:36:06	 	Sonos	DoCheckAnnouncementQueue called AnnouncementinQueue = True and AnnouncementInProgress = True and AnnouncementCountdown = 96 AnnouncementReEntry = False
    Nov-16 20:36:06	 	Sonos	CheckAnnouncementHasStarted called for Zoneplayer = Kitchen has trackposition = 0
    Nov-16 20:36:06	 	Sonos	CheckAnnouncementHasStarted called for Zoneplayer = Kitchen and New CurrentplayerState = Stopped
    Nov-16 20:36:06	 	Sonos	HS updated in UpdateHS. HS Code = 676 Info =
    Nov-16 20:36:06	 	Sonos	SetHSPlayerInfo updated HS ZonePlayer Kitchen_LR. HS Code = 676. Info =
    	
    Stopped
    
    Paired to Kitchen
    
    HomeSeer Announcement
    
    Dirk Corsus
    
    SonosController
    
    Nov-16 20:36:06	 	Sonos	GetHSDeviceReference called with Name: and Found DeviceReference = 676
    Nov-16 20:36:06	 	Sonos	GetHSDeviceReference was called with inUDN : RINCON_949F3E8D945801400
    Nov-16 20:36:06	 	Sonos	DeviceTrigger called for Zone - Kitchen_LR with Trigger = Sonos Player Stop
    Nov-16 20:36:06	 	Sonos	PlayChangeNotifyCallback called for Zone - Kitchen_LR with ChangeType = PlayStatusChanged and Changevalue = Stopped and SendDeviceTrigger = True
    Nov-16 20:36:06	 	Sonos	DeviceTrigger called for Zone - Kitchen_LR with Trigger = Sonos Track Change
    Nov-16 20:36:06	 	Sonos	PlayChangeNotifyCallback called for Zone - Kitchen_LR with ChangeType = SongChanged and Changevalue = Stopped and SendDeviceTrigger = True
    Nov-16 20:36:06	 	Sonos	UpdateHS is updating other linked zones. SourceZone=Kitchen. TargetZone=RINCON_949F3E8D945801400
    Nov-16 20:36:06	 	Sonos	CurrentPlayerState Set for ZoneName = Kitchen_LR. Value = Stopped
    Nov-16 20:36:06	 	Sonos	CurrentPlayerState is setting HS Status for ZoneName - Kitchen_LR with Value = Stopped and HSRef = 757
    Nov-16 20:36:06	 	Sonos	SetTrackNbr called for Zone - Kitchen_LR with TrackNbr = 0
    Nov-16 20:36:06	 	Sonos	SetNbrOfTracks called for Zone - Kitchen_LR with NbrOfTracks = 0
    Nov-16 20:36:06	 	Sonos	NextArtworkURL Set for ZoneName = Kitchen_LR. URL = /images/Sonos/NoArt.png
    Nov-16 20:36:06	 	Sonos	ArtworkURL Set for ZoneName = Kitchen_LR. Album = /images/Sonos/NoArt.png
    Nov-16 20:36:06	 	Sonos	RadiostationName Set for ZoneName = Kitchen_LR. RadiostationName =
    Nov-16 20:36:06	 	Sonos	NextArtist Set for ZoneName = Kitchen_LR. NextArtist =
    Nov-16 20:36:06	 	Sonos	NextAlbum Set for ZoneName = Kitchen_LR. NextAlbum =
    Nov-16 20:36:06	 	Sonos	NextTrack Set for ZoneName = Kitchen_LR. NextTrack =
    Nov-16 20:36:06	 	Sonos	Album Set for ZoneName = Kitchen_LR. Album = SonosController
    Nov-16 20:36:06	 	Sonos	Artist Set for ZoneName = Kitchen_LR. Artist = Dirk Corsus
    Nov-16 20:36:06	 	Sonos	Track Set for ZoneName = Kitchen_LR. Track = HomeSeer Announcement
    Nov-16 20:36:06	 	Sonos	HS updated in UpdateHS. HS Code = 674 Info =
    Nov-16 20:36:06	 	Sonos	SetHSPlayerInfo updated HS ZonePlayer Kitchen_RR. HS Code = 674. Info =
    	
    Stopped
    
    Paired to Kitchen
    
    HomeSeer Announcement
    
    Dirk Corsus
    
    SonosController
    
    Nov-16 20:36:06	 	Sonos	GetHSDeviceReference called with Name: and Found DeviceReference = 674
    Nov-16 20:36:06	 	Sonos	GetHSDeviceReference was called with inUDN : RINCON_B8E9378AD2CC01400
    Nov-16 20:36:06	 	Sonos	DeviceTrigger called for Zone - Kitchen_RR with Trigger = Sonos Player Stop
    Nov-16 20:36:06	 	Sonos	PlayChangeNotifyCallback called for Zone - Kitchen_RR with ChangeType = PlayStatusChanged and Changevalue = Stopped and SendDeviceTrigger = True
    Nov-16 20:36:06	 	Sonos	DeviceTrigger called for Zone - Kitchen_RR with Trigger = Sonos Track Change
    Nov-16 20:36:06	 	Sonos	PlayChangeNotifyCallback called for Zone - Kitchen_RR with ChangeType = SongChanged and Changevalue = Stopped and SendDeviceTrigger = True
    Nov-16 20:36:06	 	Sonos	UpdateHS is updating other linked zones. SourceZone=Kitchen. TargetZone=RINCON_B8E9378AD2CC01400
    Nov-16 20:36:06	 	Sonos	CurrentPlayerState Set for ZoneName = Kitchen_RR. Value = Stopped
    Nov-16 20:36:06	 	Sonos	CurrentPlayerState is setting HS Status for ZoneName - Kitchen_RR with Value = Stopped and HSRef = 721
    Nov-16 20:36:06	 	Sonos	SetTrackNbr called for Zone - Kitchen_RR with TrackNbr = 0
    Nov-16 20:36:06	 	Sonos	SetNbrOfTracks called for Zone - Kitchen_RR with NbrOfTracks = 0
    Nov-16 20:36:06	 	Sonos	NextArtworkURL Set for ZoneName = Kitchen_RR. URL = /images/Sonos/NoArt.png
    Nov-16 20:36:06	 	Sonos	ArtworkURL Set for ZoneName = Kitchen_RR. Album = /images/Sonos/NoArt.png
    Nov-16 20:36:06	 	Sonos	RadiostationName Set for ZoneName = Kitchen_RR. RadiostationName =
    Nov-16 20:36:06	 	Sonos	NextArtist Set for ZoneName = Kitchen_RR. NextArtist =
    Nov-16 20:36:06	 	Sonos	NextAlbum Set for ZoneName = Kitchen_RR. NextAlbum =
    Nov-16 20:36:06	 	Sonos	NextTrack Set for ZoneName = Kitchen_RR. NextTrack =
    Nov-16 20:36:06	 	Sonos	Album Set for ZoneName = Kitchen_RR. Album = SonosController
    Nov-16 20:36:06	 	Sonos	Artist Set for ZoneName = Kitchen_RR. Artist = Dirk Corsus
    Nov-16 20:36:06	 	Sonos	Track Set for ZoneName = Kitchen_RR. Track = HomeSeer Announcement
    Nov-16 20:36:06	 	Sonos	HS updated in UpdateHS. HSRef = 672
    Nov-16 20:36:06	 	Sonos	SetHSPlayerInfo updated HS ZonePlayer Kitchen. HS Code = 672. Info =
    	
    Stopped
    
    Tracks
    
    HomeSeer Announcement
    
    Dirk Corsus
    
    SonosController
    
    Nov-16 20:36:06	 	Sonos	ArtworkURL Set for ZoneName = Kitchen. Album = /images/Sonos/NoArt.png
    Nov-16 20:36:06	 	Sonos	Album Set for ZoneName = Kitchen. Album = SonosController
    Nov-16 20:36:06	 	Sonos	Artist Set for ZoneName = Kitchen. Artist = Dirk Corsus
    Nov-16 20:36:06	 	Sonos	Track Set for ZoneName = Kitchen. Track = HomeSeer Announcement
    Nov-16 20:36:06	 	Sonos	DeviceTrigger called for Zone - Kitchen with Trigger = Sonos Player Stop
    Nov-16 20:36:06	 	Sonos	PlayChangeNotifyCallback called for Zone - Kitchen with ChangeType = PlayStatusChanged and Changevalue = Stopped and SendDeviceTrigger = True
    Nov-16 20:36:06	 	Sonos	DeviceTrigger called for Zone - Kitchen with Trigger = Sonos Track Change
    Nov-16 20:36:06	 	Sonos	PlayChangeNotifyCallback called for Zone - Kitchen with ChangeType = SongChanged and Changevalue = Stopped and SendDeviceTrigger = True
    Nov-16 20:36:06	 	Sonos	Kitchen TrackInfo PositionInfo (% played) = 100
    Nov-16 20:36:06	 	Sonos	Kitchen TrackInfo PositionInfo (Queue Position) = 1
    Nov-16 20:36:06	 	Sonos	Kitchen TrackInfo PositionInfo (Track Duration) = 0:00:00
    Nov-16 20:36:06	 	Sonos	Kitchen TrackInfo PositionInfo (Track Position Seconds) = 0
    Nov-16 20:36:06	 	Sonos	Kitchen TrackInfo PositionInfo (Track Position) = 0:00:00
    Nov-16 20:36:06	 	Sonos	GetAlbumArtPath called for zone Kitchen with AlbumURI = and NextTrack = False
    Nov-16 20:36:06	 	Sonos	Kitchen TrackInfo PositionInfo (albumArtURI) =
    Nov-16 20:36:06	 	Sonos	Kitchen TrackInfo PositionInfo (title) = HomeSeer Announcement
    Nov-16 20:36:06	 	Sonos	Kitchen TrackInfo PositionInfo (album) = SonosController
    Nov-16 20:36:06	 	Sonos	Kitchen TrackInfo PositionInfo (creator) = Dirk Corsus
    Nov-16 20:36:06	 	Sonos	Kitchen TrackInfo PositionInfo (Streamcontent/Title) =
    Nov-16 20:36:06	 	Sonos	GetcurrentTrackInfo called GetPositionInfo for zoneplayer - Kitchen and MetaData http://192.168.86.116:80/Sonos/Announcements/Ann_SOFTANNOUNCE_0.mp3http://192.168.86.116:80/images/Sonos/Announcement.jpgHomeSeer Announcementobject.item.audioItem.musicTrackDirk CorsusSonosControllerDirk Corsus
    Nov-16 20:36:06	 	Sonos	Kitchen TrackInfo(Source) = Tracks
    Nov-16 20:36:06	 	Sonos	Kitchen TrackInfo (CurrentURI) = http://192.168.86.116:80/Sonos/Announcements/Ann_SOFTANNOUNCE_0.mp3
    Nov-16 20:36:06	 	Sonos	Kitchen TrackInfo (albumArtURI) =
    Nov-16 20:36:06	 	Sonos	Kitchen TrackInfo (album) = SonosController
    Nov-16 20:36:06	 	Sonos	Kitchen TrackInfo (creator) = Dirk Corsus
    Nov-16 20:36:06	 	Sonos	Kitchen TrackInfo (title) = HomeSeer Announcement
    Nov-16 20:36:06	 	Sonos	Kitchen TrackInfo (MediaInfo/Title) = HomeSeer Announcement
    Nov-16 20:36:06	 	Sonos	Kitchen TrackInfo (CurrentURI) = http://192.168.86.116:80/Sonos/Announcements/Ann_SOFTANNOUNCE_0.mp3 and TrackInfo (CurrentURIMetaData) = http://192.168.86.116:80/Sonos/Announcements/Ann_SOFTANNOUNCE_0.mp3http://192.168.86.116:80/images/Sonos/Announcement.jpgHomeSeer Announcementobject.item.audioItem.musicTrackDirk CorsusSonosControllerDirk Corsus
    Nov-16 20:36:06	 	Sonos	GetcurrentTrackInfo called for zoneplayer - Kitchen
    Nov-16 20:36:06	 	Sonos	CurrentPlayerState Set for ZoneName = Kitchen. Value = Stopped
    Nov-16 20:36:06	 	Sonos	CurrentPlayerState is setting HS Status for ZoneName - Kitchen with Value = Stopped and HSRef = 685
    Nov-16 20:36:06	 	Sonos	CheckAnnouncementHasStarted called for Zoneplayer = Kitchen and CurrentplayerState = Playing
    Nov-16 20:36:06	 	Sonos	DoCheckAnnouncementQueue called AnnouncementinQueue = True and AnnouncementInProgress = True and AnnouncementCountdown = 97 AnnouncementReEntry = False
    Nov-16 20:36:05	 	Sonos	CheckAnnouncementHasStarted called for Zoneplayer = Kitchen and New CurrentplayerState = Playing
    Nov-16 20:36:05	 	Sonos	CurrentPlayerState Set for ZoneName = Kitchen. Value = Playing
    Nov-16 20:36:05	 	Sonos	CheckAnnouncementHasStarted called for Zoneplayer = Kitchen and CurrentplayerState = Playing
    Nov-16 20:36:05	 	Sonos	DoCheckAnnouncementQueue called AnnouncementinQueue = True and AnnouncementInProgress = True and AnnouncementCountdown = 98 AnnouncementReEntry = False
    Nov-16 20:36:05	 	Sonos	CheckAnnouncementHasStarted called for Zoneplayer = Kitchen and New CurrentplayerState = Playing
    Nov-16 20:36:05	 	Sonos	CurrentPlayerState Set for ZoneName = Kitchen. Value = Playing
    Nov-16 20:36:05	 	Sonos	CheckAnnouncementHasStarted called for Zoneplayer = Kitchen and CurrentplayerState = Playing
    Nov-16 20:36:05	 	Sonos	DoCheckAnnouncementQueue called AnnouncementinQueue = True and AnnouncementInProgress = True and AnnouncementCountdown = 99 AnnouncementReEntry = False
    Nov-16 20:36:04	 	Sonos	CheckAnnouncementHasStarted called for Zoneplayer = Kitchen has trackposition = 0
    Nov-16 20:36:04	 	Sonos	CheckAnnouncementHasStarted called for Zoneplayer = Kitchen and New CurrentplayerState = Playing
    Nov-16 20:36:04	 	Sonos	HS updated in UpdateHS. HS Code = 676 Info =
    Nov-16 20:36:04	 	Sonos	SetHSPlayerInfo updated HS ZonePlayer Kitchen_LR. HS Code = 676. Info =
    	
    Playing
    
    Paired to Kitchen
    
    HomeSeer Announcement
    
    Dirk Corsus
    
    SonosController
    
    Nov-16 20:36:04	 	Sonos	GetHSDeviceReference called with Name: and Found DeviceReference = 676
    Nov-16 20:36:04	 	Sonos	GetHSDeviceReference was called with inUDN : RINCON_949F3E8D945801400
    Nov-16 20:36:04	 	Sonos	DeviceTrigger called for Zone - Kitchen_LR with Trigger = Sonos Player Start Playing
    Nov-16 20:36:04	 	Sonos	PlayChangeNotifyCallback called for Zone - Kitchen_LR with ChangeType = PlayStatusChanged and Changevalue = Playing and SendDeviceTrigger = True
    Nov-16 20:36:04	 	Sonos	DeviceTrigger called for Zone - Kitchen_LR with Trigger = Sonos Track Change
    Nov-16 20:36:04	 	Sonos	PlayChangeNotifyCallback called for Zone - Kitchen_LR with ChangeType = SongChanged and Changevalue = Playing and SendDeviceTrigger = True
    Nov-16 20:36:04	 	Sonos	UpdateHS is updating other linked zones. SourceZone=Kitchen. TargetZone=RINCON_949F3E8D945801400
    Nov-16 20:36:04	 	Sonos	CurrentPlayerState Set for ZoneName = Kitchen_LR. Value = Playing
    Nov-16 20:36:04	 	Sonos	CurrentPlayerState is setting HS Status for ZoneName - Kitchen_LR with Value = Playing and HSRef = 757
    Nov-16 20:36:04	 	Sonos	SetTrackNbr called for Zone - Kitchen_LR with TrackNbr = 0
    Nov-16 20:36:04	 	Sonos	SetNbrOfTracks called for Zone - Kitchen_LR with NbrOfTracks = 0
    Nov-16 20:36:04	 	Sonos	NextArtworkURL Set for ZoneName = Kitchen_LR. URL = /images/Sonos/NoArt.png
    Nov-16 20:36:04	 	Sonos	ArtworkURL Set for ZoneName = Kitchen_LR. Album = /images/Sonos/NoArt.png
    Nov-16 20:36:04	 	Sonos	RadiostationName Set for ZoneName = Kitchen_LR. RadiostationName =
    Nov-16 20:36:04	 	Sonos	NextArtist Set for ZoneName = Kitchen_LR. NextArtist =
    Nov-16 20:36:04	 	Sonos	NextAlbum Set for ZoneName = Kitchen_LR. NextAlbum =
    Nov-16 20:36:04	 	Sonos	NextTrack Set for ZoneName = Kitchen_LR. NextTrack =
    Nov-16 20:36:04	 	Sonos	Album Set for ZoneName = Kitchen_LR. Album = SonosController
    Nov-16 20:36:04	 	Sonos	Artist Set for ZoneName = Kitchen_LR. Artist = Dirk Corsus
    Nov-16 20:36:04	 	Sonos	Track Set for ZoneName = Kitchen_LR. Track = HomeSeer Announcement
    Nov-16 20:36:04	 	Sonos	HS updated in UpdateHS. HS Code = 674 Info =
    Nov-16 20:36:04	 	Sonos	SetHSPlayerInfo updated HS ZonePlayer Kitchen_RR. HS Code = 674. Info =
    	
    Playing
    
    Paired to Kitchen
    
    HomeSeer Announcement
    
    Dirk Corsus
    
    SonosController
    
    Nov-16 20:36:04	 	Sonos	GetHSDeviceReference called with Name: and Found DeviceReference = 674
    Nov-16 20:36:04	 	Sonos	GetHSDeviceReference was called with inUDN : RINCON_B8E9378AD2CC01400
    Nov-16 20:36:04	 	Sonos	DeviceTrigger called for Zone - Kitchen_RR with Trigger = Sonos Player Start Playing
    Nov-16 20:36:04	 	Sonos	PlayChangeNotifyCallback called for Zone - Kitchen_RR with ChangeType = PlayStatusChanged and Changevalue = Playing and SendDeviceTrigger = True
    Nov-16 20:36:04	 	Sonos	DeviceTrigger called for Zone - Kitchen_RR with Trigger = Sonos Track Change
    Nov-16 20:36:04	 	Sonos	PlayChangeNotifyCallback called for Zone - Kitchen_RR with ChangeType = SongChanged and Changevalue = Playing and SendDeviceTrigger = True
    Nov-16 20:36:04	 	Sonos	UpdateHS is updating other linked zones. SourceZone=Kitchen. TargetZone=RINCON_B8E9378AD2CC01400
    Nov-16 20:36:04	 	Sonos	CurrentPlayerState Set for ZoneName = Kitchen_RR. Value = Playing
    Nov-16 20:36:04	 	Sonos	CurrentPlayerState is setting HS Status for ZoneName - Kitchen_RR with Value = Playing and HSRef = 721
    Nov-16 20:36:04	 	Sonos	SetTrackNbr called for Zone - Kitchen_RR with TrackNbr = 0
    Nov-16 20:36:04	 	Sonos	SetNbrOfTracks called for Zone - Kitchen_RR with NbrOfTracks = 0
    Nov-16 20:36:04	 	Sonos	NextArtworkURL Set for ZoneName = Kitchen_RR. URL = /images/Sonos/NoArt.png
    Nov-16 20:36:04	 	Sonos	ArtworkURL Set for ZoneName = Kitchen_RR. Album = /images/Sonos/NoArt.png
    Nov-16 20:36:04	 	Sonos	RadiostationName Set for ZoneName = Kitchen_RR. RadiostationName =
    Nov-16 20:36:04	 	Sonos	NextArtist Set for ZoneName = Kitchen_RR. NextArtist =
    Nov-16 20:36:04	 	Sonos	NextAlbum Set for ZoneName = Kitchen_RR. NextAlbum =
    Nov-16 20:36:04	 	Sonos	NextTrack Set for ZoneName = Kitchen_RR. NextTrack =
    Nov-16 20:36:04	 	Sonos	Album Set for ZoneName = Kitchen_RR. Album = SonosController
    Nov-16 20:36:04	 	Sonos	Artist Set for ZoneName = Kitchen_RR. Artist = Dirk Corsus
    Nov-16 20:36:04	 	Sonos	Track Set for ZoneName = Kitchen_RR. Track = HomeSeer Announcement
    Nov-16 20:36:04	 	Sonos	HS updated in UpdateHS. HSRef = 672
    Nov-16 20:36:04	 	Sonos	SetHSPlayerInfo updated HS ZonePlayer Kitchen. HS Code = 672. Info =
    	
    Playing
    
    Tracks
    
    HomeSeer Announcement
    
    Dirk Corsus
    
    SonosController
    
    Nov-16 20:36:04	 	Sonos	ArtworkURL Set for ZoneName = Kitchen. Album = /images/Sonos/NoArt.png
    Nov-16 20:36:04	 	Sonos	Album Set for ZoneName = Kitchen. Album = SonosController
    Nov-16 20:36:04	 	Sonos	Artist Set for ZoneName = Kitchen. Artist = Dirk Corsus
    Nov-16 20:36:04	 	Sonos	Track Set for ZoneName = Kitchen. Track = HomeSeer Announcement
    Nov-16 20:36:04	 	Sonos	DeviceTrigger called for Zone - Kitchen with Trigger = Sonos Player Start Playing
    Nov-16 20:36:04	 	Sonos	PlayChangeNotifyCallback called for Zone - Kitchen with ChangeType = PlayStatusChanged and Changevalue = Playing and SendDeviceTrigger = True
    Nov-16 20:36:04	 	Sonos	DeviceTrigger called for Zone - Kitchen with Trigger = Sonos Track Change
    Nov-16 20:36:04	 	Sonos	PlayChangeNotifyCallback called for Zone - Kitchen with ChangeType = SongChanged and Changevalue = Playing and SendDeviceTrigger = True
    Nov-16 20:36:04	 	Sonos	Kitchen TrackInfo PositionInfo (% played) = 100
    Nov-16 20:36:04	 	Sonos	Kitchen TrackInfo PositionInfo (Queue Position) = 1
    Nov-16 20:36:04	 	Sonos	Kitchen TrackInfo PositionInfo (Track Duration) = 0:00:00
    Nov-16 20:36:04	 	Sonos	Kitchen TrackInfo PositionInfo (Track Position Seconds) = 0
    Nov-16 20:36:04	 	Sonos	Kitchen TrackInfo PositionInfo (Track Position) = 0:00:00
    Nov-16 20:36:04	 	Sonos	GetAlbumArtPath called for zone Kitchen with AlbumURI = and NextTrack = False
    Nov-16 20:36:04	 	Sonos	Kitchen TrackInfo PositionInfo (albumArtURI) =
    Nov-16 20:36:04	 	Sonos	Kitchen TrackInfo PositionInfo (title) = HomeSeer Announcement
    Nov-16 20:36:04	 	Sonos	Kitchen TrackInfo PositionInfo (album) = SonosController
    Nov-16 20:36:04	 	Sonos	Kitchen TrackInfo PositionInfo (creator) = Dirk Corsus
    Nov-16 20:36:04	 	Sonos	Kitchen TrackInfo PositionInfo (Streamcontent/Title) =
    Nov-16 20:36:04	 	Sonos	GetcurrentTrackInfo called GetPositionInfo for zoneplayer - Kitchen and MetaData http://192.168.86.116:80/Sonos/Announcements/Ann_SOFTANNOUNCE_0.mp3http://192.168.86.116:80/images/Sonos/Announcement.jpgHomeSeer Announcementobject.item.audioItem.musicTrackDirk CorsusSonosControllerDirk Corsus
    Nov-16 20:36:04	 	Sonos	Kitchen TrackInfo(Source) = Tracks
    Nov-16 20:36:04	 	Sonos	Kitchen TrackInfo (CurrentURI) = http://192.168.86.116:80/Sonos/Announcements/Ann_SOFTANNOUNCE_0.mp3
    Nov-16 20:36:04	 	Sonos	Kitchen TrackInfo (albumArtURI) =
    Nov-16 20:36:04	 	Sonos	Kitchen TrackInfo (album) = SonosController
    Nov-16 20:36:04	 	Sonos	Kitchen TrackInfo (creator) = Dirk Corsus
    Nov-16 20:36:04	 	Sonos	Kitchen TrackInfo (title) = HomeSeer Announcement
    Nov-16 20:36:04	 	Sonos	Kitchen TrackInfo (MediaInfo/Title) = HomeSeer Announcement
    Nov-16 20:36:04	 	Sonos	Kitchen TrackInfo (CurrentURI) = http://192.168.86.116:80/Sonos/Announcements/Ann_SOFTANNOUNCE_0.mp3 and TrackInfo (CurrentURIMetaData) = http://192.168.86.116:80/Sonos/Announcements/Ann_SOFTANNOUNCE_0.mp3http://192.168.86.116:80/images/Sonos/Announcement.jpgHomeSeer Announcementobject.item.audioItem.musicTrackDirk CorsusSonosControllerDirk Corsus
    Nov-16 20:36:04	 	Sonos	GetcurrentTrackInfo called for zoneplayer - Kitchen
    Nov-16 20:36:04	 	Sonos	CurrentPlayerState Set for ZoneName = Kitchen. Value = Playing
    Nov-16 20:36:04	 	Sonos	CurrentPlayerState is setting HS Status for ZoneName - Kitchen with Value = Playing and HSRef = 685
    Nov-16 20:36:04	 	Sonos	CheckAnnouncementHasStarted called for Zoneplayer = Kitchen and CurrentplayerState = Stopped
    Nov-16 20:36:04	 	Sonos	DoCheckAnnouncementQueue called AnnouncementinQueue = True and AnnouncementInProgress = True and AnnouncementCountdown = 100 AnnouncementReEntry = False
    Nov-16 20:36:03	 	Sonos	DoCheckAnnouncementQueue is waiting in for player to start playing w/ single announcement and existing procedure
    Nov-16 20:36:03	 	Sonos Warning	DoCheckAnnouncementQueue called and cause re-entry. Announcement state = asSpeaking
    Nov-16 20:36:03	 	Sonos	SetTransportState called for zoneplayer - Kitchen with value = Play
    Nov-16 20:36:03	 	Sonos	DoCheckAnnouncementQueue called AnnouncementinQueue = True and AnnouncementInProgress = True and AnnouncementCountdown = 100 AnnouncementReEntry = True
    Nov-16 20:36:03	 	Sonos	DoCheckAnnouncementQueue is calling PlayURI with http://192.168.86.116:80/Sonos/Announcements/Ann_SOFTANNOUNCE_0.mp3
    Nov-16 20:36:03	 	Sonos	PlayURI called for zoneplayer Kitchen with strURI = http://192.168.86.116:80/Sonos/Announcements/Ann_SOFTANNOUNCE_0.mp3 and MetaData = http://192.168.86.116:80/Sonos/Announcements/Ann_SOFTANNOUNCE_0.mp3http://192.168.86.116:80/images/Sonos/Announcement.jpgHomeSeer Announcementobject.item.audioItem.musicTrackDirk CorsusSonosControllerDirk Corsus and isObjectID = False
    Nov-16 20:36:03	 	Sonos	DoCheckAnnouncementQueue adds file = C:\Program Files (x86)\HomeSeer HS3\html\Sonos\Announcements\Ann_SOFTANNOUNCE_0 to Queue
    Nov-16 20:36:03	 	Sonos	DoCheckAnnouncementQueue is Linked and activated with HostName = *:* Text = C:\Program Files (x86)\HomeSeer HS3\Media\driveway.mp3 and LinkgroupName = SOFTANNOUNCE
    Nov-16 20:36:03	 	Sonos	PlayModeNormal called for ZoneName Kitchen
    Nov-16 20:36:03	 	Sonos	PlayURI called for zoneplayer Kitchen with strURI = x-rincon-queue:RINCON_949F3E66DB9001400#0 and MetaData = and isObjectID = False
    Nov-16 20:36:03	 	Sonos	ClearQueue called for zoneplayer Kitchen
    Nov-16 20:36:03	 	Sonos	DoCheckAnnouncementQueue done calling HandleLinking
    Nov-16 20:36:03	 	Sonos	HandleLinkingOn done with LinkgroupName = SOFTANNOUNCE and Delay = 0
    Nov-16 20:36:03	 	Sonos	HandleLinkingOn: Done LinkgroupZoneDestination = Family Room
    Nov-16 20:36:03	 	Sonos	SetVolumeLevel called for ZonePlayer = Family Room with values Channel=Master Value=40
    Nov-16 20:36:03	 	Sonos	PlayURI called for zoneplayer Family Room with strURI = x-rincon:RINCON_949F3E66DB9001400 and MetaData = http://192.168.86.116:80/images/Sonos/Announcement.jpgHomeSeer Announcementobject.item.audioItem.musicTrackDirk CorsusSonosControllerDirk Corsus and isObjectID = False
    Nov-16 20:36:03	 	Sonos	HandleLinkingOn: Start LinkgroupZoneDestination = RINCON_949F3E684FD201400
    Nov-16 20:36:03	 	Sonos	HandleLinkingOn: Done LinkgroupZoneDestination = Kitchen
    Nov-16 20:36:03	 	Sonos	SetVolumeLevel called for ZonePlayer = Kitchen with values Channel=Master Value=40
    Nov-16 20:36:03	 	Sonos	HandleLinkingOn: Start LinkgroupZoneDestination = RINCON_949F3E66DB9001400
    Nov-16 20:36:03	 	Sonos Error	ERROR in SetTransportState for zoneplayer = Kitchen with UPNP Error = Read only tag / Transport is locked / Access denied. Error = MyUPnPService.InvokeAction for ServiceID = http://192.168.86.111:1400/xml/AVTransport1.xml while sending Action = Stop for URI = http://192.168.86.111:1400/MediaRenderer/AVTransport/Control and Request = 0 UPNP Error = faultcode = s:Client, faultstring = UPnPError, detail = 701 with error = The remote server returned an error: (500) Internal Server Error.
    Nov-16 20:36:03	 	Sonos Warning	DoCheckAnnouncementQueue called and cause re-entry. Announcement state = asLinking
    Nov-16 20:36:03	 	Sonos	DoCheckAnnouncementQueue called AnnouncementinQueue = True and AnnouncementInProgress = True and AnnouncementCountdown = 100 AnnouncementReEntry = True
    Nov-16 20:36:03	 	Sonos	SetTransportState called for zoneplayer - Kitchen with value = Stop
    Nov-16 20:36:03	 	Sonos	HandleLinkingOn: Done Saving LinkgroupZoneDestination = Family Room
    Nov-16 20:36:03	 	Sonos	HandleLinkingOn: End Save Current Track Info for player = Family Room
    Nov-16 20:36:03	 	Sonos	SavedPlayerList.add called with PlayerUDN = RINCON_949F3E684FD201400 and MyLinkListIndex = 1
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Family Room saved ChannelMapSet =
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Family Room saved MyTargetZoneLinkedList =
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Family Room saved PlayMode State = NORMAL
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Family Room saved Mute State = False
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Family Room saved Master Volume = 28
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Family Room saved Player State =
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Family Room saved Queue position = 0
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Family Room with Track(12) =
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Family Room with Track(11) =
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Family Room with Track(10) = True
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Family Room with Track(9) = Unknown
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Family Room with Track(8) =
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Family Room with Track(7) = 0
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Family Room with Track(6) =
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Family Room with Track(5) = 00:00:00
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Family Room with Track(4) = /images/Sonos/NoArt.png
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Family Room with Track(3) =
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Family Room with Track(2) =
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Family Room with Track(1) =
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Family Room with Track(0) =
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Family Room saved SourceLinkedZone =
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Family Room saved ZoneIsLinked = False
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo called for zoneplayer - Family Room for Linkgroup = SOFTANNOUNCE and SaveQueueFlag = False and DeleteSavedQueue = False
    Nov-16 20:36:03	 	Sonos	HandleLinkingOn: Start Save Current Track Info for player = Family Room
    Nov-16 20:36:03	 	Sonos	SavedPlayerList.IsAlreadyStored for PlayerUDN = RINCON_949F3E684FD201400 didn't find anything stored
    Nov-16 20:36:03	 	Sonos	SavedPlayerList.IsAlreadyStored called with PlayerUDN = RINCON_949F3E684FD201400 and MyLinkListIndex = 1
    Nov-16 20:36:03	 	Sonos	GetLinkGroupInfo called with LinkgroupName = SOFTANNOUNCE
    Nov-16 20:36:03	 	Sonos	SaveLinkedPlayers called with SearchZoneUDN = RINCON_949F3E684FD201400 and SourceZoneUDN = RINCON_949F3E66DB9001400 and LinkGroupName = SOFTANNOUNCE
    Nov-16 20:36:03	 	Sonos	HandleLinkingOn: Done Saving LinkgroupZoneDestination = Kitchen
    Nov-16 20:36:03	 	Sonos	SaveLinkedPlayers called with SearchZoneUDN = RINCON_949F3E66DB9001400 and SourceZoneUDN = RINCON_949F3E66DB9001400 and LinkGroupName = SOFTANNOUNCE
    Nov-16 20:36:03	 	Sonos	SavedPlayerList.add called with PlayerUDN = RINCON_949F3E66DB9001400 and MyLinkListIndex = 0
    Nov-16 20:36:03	 	Sonos	SaveLinkedPlayers called with SearchZoneUDN = RINCON_949F3E66DB9001400 and SourceZoneUDN = RINCON_949F3E66DB9001400 and LinkGroupName = SOFTANNOUNCE
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Kitchen saved ChannelMapSet =
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Kitchen saved MyTargetZoneLinkedList = RINCON_B8E9378AD2CC01400;RINCON_949F3E8D945801400
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Kitchen saved PlayMode State = NORMAL
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Kitchen saved Mute State = False
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Kitchen saved Master Volume = 50
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Kitchen saved Player State = STOPPED
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Kitchen saved Queue position = 0
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Kitchen with Track(12) = http://192.168.86.116:80/Sonos/Announcements/Ann_SOFTANNOUNCE_0.mp3http://192.168.86.116:80/images/Sonos/Announcement.jpgHomeSeer Announcementobject.item.audioItem.musicTrackDirk CorsusSonosControllerDirk Corsus
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Kitchen with Track(11) =
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Kitchen with Track(10) = False
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Kitchen with Track(9) = Tracks
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Kitchen with Track(8) = 100
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Kitchen with Track(7) = 1
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Kitchen with Track(6) = 0:00:00
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Kitchen with Track(5) = 00:00:00
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Kitchen with Track(4) = /images/Sonos/NoArt.png
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Kitchen with Track(3) = http://192.168.86.116:80/Sonos/Announcements/Ann_SOFTANNOUNCE_0.mp3
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Kitchen with Track(2) = HomeSeer Announcement
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Kitchen with Track(1) = SonosController
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Kitchen with Track(0) = Dirk Corsus
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Kitchen saved SourceLinkedZone =
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo for zoneplayer Kitchen saved ZoneIsLinked = False
    Nov-16 20:36:03	 	Sonos	SaveCurrentTrackInfo called for zoneplayer - Kitchen for Linkgroup = SOFTANNOUNCE and SaveQueueFlag = True and DeleteSavedQueue = False
    Nov-16 20:36:03	 	Sonos	HandleLinkingOn found RINCON_949F3E66DB9001400 as source and Audio Input = False and Save Source = True
    Nov-16 20:36:03	 	Sonos	GetLinkGroupInfo called with LinkgroupName = SOFTANNOUNCE
    Nov-16 20:36:03	 	Sonos	HandleLinkingOn called with LinkgroupName = SOFTANNOUNCE
    Nov-16 20:36:03	 	Sonos	DoCheckAnnouncementQueue called HandleLinking
    Nov-16 20:36:03	 	Sonos	DeviceTrigger called for Zone - with Trigger = Sonos Announcement Start
    Nov-16 20:36:03	 	Sonos	PlayChangeNotifyCallback called for Zone - with ChangeType = AnnouncementChange and Changevalue = AnnouncementStart and SendDeviceTrigger = True
    Nov-16 20:36:03	 	Sonos	DoCheckAnnouncementQueue called for linkgroup SOFTANNOUNCE and State = asIdle and isFile = True
    Nov-16 20:36:03	 	Sonos	DoCheckAnnouncementQueue called AnnouncementinQueue = True and AnnouncementInProgress = False and AnnouncementCountdown = 100 AnnouncementReEntry = False
    Nov-16 20:36:03	 	Sonos	GetTailOfAnnouncementQueue called
    Nov-16 20:36:03	 	Sonos	GetLinkgroupSourceZone called with LinkgroupName = SOFTANNOUNCE
    Nov-16 20:36:03	 	Sonos	GetLinkgroupSourceZoneAudioInputFlag called with LinkgroupName = SOFTANNOUNCE
    Nov-16 20:36:03	 	Sonos	AddAnnouncementToQueue called for LinkGroupName = SOFTANNOUNCE and Text = C:\Program Files (x86)\HomeSeer HS3\Media\driveway.mp3
    Nov-16 20:36:03	 	Sonos	SpeakIn called for Device = 0, Text = C:\Program Files (x86)\HomeSeer HS3\Media\driveway.mp3, Wait=True, Host = $SONOS$SOFTANNOUNCE$:*, PIInitialized = True
    Nov-16 20:36:03	 	Pushover 3P	Pushover Notification Sent - Message Title Driveway Alert
    Nov-16 20:36:02	 	Event	Event Trigger "Driveway Driveway motion - day"
    Nov-16 20:36:02	 	Event	Event Driveway Driveway motion - day triggered by the event page 'Run' button.
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo found UDN = RINCON_000E5859386A01400. Array Size = 6
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo did not find UDN = RINCON_000E5859386A01400 but found = RINCON_949F3E66DB9001400
    Nov-16 20:35:58	 	Sonos	DoRediscover found UDN = uuid:RINCON_000E5859386A01400, with location = http://192.168.86.106:1400/xml/device_description.xml and Alive = True
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo found UDN = RINCON_949F3E45FFA801400. Array Size = 6
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo did not find UDN = RINCON_949F3E45FFA801400 but found = RINCON_949F3E8D945801400
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo did not find UDN = RINCON_949F3E45FFA801400 but found = RINCON_949F3E684FD201400
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo did not find UDN = RINCON_949F3E45FFA801400 but found = RINCON_B8E9378AD2CC01400
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo did not find UDN = RINCON_949F3E45FFA801400 but found = RINCON_000E5859386A01400
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo did not find UDN = RINCON_949F3E45FFA801400 but found = RINCON_949F3E66DB9001400
    Nov-16 20:35:58	 	Sonos	DoRediscover found UDN = uuid:RINCON_949F3E45FFA801400, with location = http://192.168.86.208:1400/xml/device_description.xml and Alive = True
    Nov-16 20:35:58	 	Sonos Warning	Warning in FindUPnPDeviceInfo did not find UDN = RINCON_000E5845991001400. Array Size = 6
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo did not find UDN = RINCON_000E5845991001400 but found = RINCON_949F3E45FFA801400
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo did not find UDN = RINCON_000E5845991001400 but found = RINCON_949F3E8D945801400
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo did not find UDN = RINCON_000E5845991001400 but found = RINCON_949F3E684FD201400
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo did not find UDN = RINCON_000E5845991001400 but found = RINCON_B8E9378AD2CC01400
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo did not find UDN = RINCON_000E5845991001400 but found = RINCON_000E5859386A01400
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo did not find UDN = RINCON_000E5845991001400 but found = RINCON_949F3E66DB9001400
    Nov-16 20:35:58	 	Sonos	DoRediscover found UDN = uuid:RINCON_000E5845991001400, with location = http://192.168.86.105:1400/xml/device_description.xml and Alive = True
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo found UDN = RINCON_B8E9378AD2CC01400. Array Size = 6
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo did not find UDN = RINCON_B8E9378AD2CC01400 but found = RINCON_000E5859386A01400
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo did not find UDN = RINCON_B8E9378AD2CC01400 but found = RINCON_949F3E66DB9001400
    Nov-16 20:35:58	 	Sonos	DoRediscover found UDN = uuid:RINCON_B8E9378AD2CC01400, with location = http://192.168.86.125:1400/xml/device_description.xml and Alive = True
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo found UDN = RINCON_949F3E8D945801400. Array Size = 6
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo did not find UDN = RINCON_949F3E8D945801400 but found = RINCON_949F3E684FD201400
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo did not find UDN = RINCON_949F3E8D945801400 but found = RINCON_B8E9378AD2CC01400
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo did not find UDN = RINCON_949F3E8D945801400 but found = RINCON_000E5859386A01400
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo did not find UDN = RINCON_949F3E8D945801400 but found = RINCON_949F3E66DB9001400
    Nov-16 20:35:58	 	Sonos	DoRediscover found UDN = uuid:RINCON_949F3E8D945801400, with location = http://192.168.86.110:1400/xml/device_description.xml and Alive = True
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo found UDN = RINCON_949F3E684FD201400. Array Size = 6
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo did not find UDN = RINCON_949F3E684FD201400 but found = RINCON_B8E9378AD2CC01400
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo did not find UDN = RINCON_949F3E684FD201400 but found = RINCON_000E5859386A01400
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo did not find UDN = RINCON_949F3E684FD201400 but found = RINCON_949F3E66DB9001400
    Nov-16 20:35:58	 	Sonos	DoRediscover found UDN = uuid:RINCON_949F3E684FD201400, with location = http://192.168.86.119:1400/xml/device_description.xml and Alive = True
    Nov-16 20:35:58	 	Sonos	FindUPnPDeviceInfo found UDN = RINCON_949F3E66DB9001400. Array Size = 6
    Nov-16 20:35:58	 	Sonos	DoRediscover found UDN = uuid:RINCON_949F3E66DB9001400, with location = http://192.168.86.111:1400/xml/device_description.xml and Alive = True
    Nov-16 20:35:58	 	Sonos	DoRediscover called
    Nov-16 20:35:41	 	Sonos	BuildButtonStringRef Found LinkgroupZoneSource = SOFTANNOUNCE
    Nov-16 20:35:41	 	Sonos	BuildButtonStringRef Found LinkgroupZoneSource = LOUDANNOUNCE
    Nov-16 20:35:41	 	Sonos	DeleteIniSection called with section = TTSSpeakDevice and FileName = Sonos.ini
    Nov-16 20:35:41	 	Sonos	GetIniSection called with section = TTSSpeakDevice, FileName = Sonos.ini and # Result = -1
    Nov-16 20:35:41	 	Sonos	INIT: MaxNbrOfUPNPObjects set to 400
    Nov-16 20:35:41	 	Sonos	ReadIniFile called
    Nov-16 20:35:41	 	Sonos	postBackProc for SonosControl found Value = SuperDebugChkBox
    Nov-16 20:35:41	 	Sonos	postBackProc for SonosControl found Key = id
    Nov-16 20:35:41	 	Sonos	postBackProc for SonosControl found Value = checked
    Nov-16 20:35:41	 	Sonos	postBackProc for SonosControl found Key = SuperDebugChkBox
    Nov-16 20:35:41	 	Sonos	PostBackProc for SonosControl called with page = SonosConfig and data = SuperDebugChkBox=checked&id=SuperDebugChkBox and user = default and userRights = 6
    Nov-16 20:35:39	 	Sonos	BuildButtonStringRef Found LinkgroupZoneSource = SOFTANNOUNCE
    Nov-16 20:35:39	 	Sonos	BuildButtonStringRef Found LinkgroupZoneSource = LOUDANNOUNCE
    Nov-16 20:35:39	 	Sonos	DeleteIniSection called with section = TTSSpeakDevice and FileName = Sonos.ini
    Nov-16 20:35:39	 	Sonos	INIT: MaxNbrOfUPNPObjects set to 400
    Nov-16 20:35:39	 	Sonos	ReadIniFile called
    Nov-16 20:35:26	 	Sonos Error	GetArtists unable to open DB for zoneplayer = Kitchen with error- SQL logic error or missing database no such table: Tracks

    #2
    Originally posted by pkdotnet View Post
    First of all, I would like to say I love the Sonos PI. It is awesome being able to integrate all of the functionality of the Sonos players throughout the house into HS3.

    I recently added two Playbars to our Sonos system. One of them is a solo Playbar, the other is paired with two Play:1s. The Playbars are named 'Kitchen' and 'Family Room'.

    In the plugin config, I have a linkgroup that groups the two Playbars together for announcements.



    When I run an event that speaks audio that targets this linkgroup, the Playbars do not resume what they were playing previously. So, if we are watching TV and an announcement plays, the TV audio does not resume when the announcement completes. The Sonos app shows the current input for the Playbar as 'HomeSeer Announcement'. We have to manually set the Playbar to TV by using the Sonos app. The same behavior happens when playing music as well.

    I turned on Debug and Super Debug flags and have included the log entries below if you'd like to take a look. I am running PI v3.1.0.22 and HS3 v3.0.0.368 on Windows.

    Thanks in advance for any help.
    Have to admit, never tried to use the playbar itself as a source (kitchen), but I think you are saying that the second playbar, which is marked as destination (Family Room), that it is not returning back to TV? I'm sure I tested that. I do see some errors and warnings in your log, don't think they are related but of concern. Unfortunately, the trace seems to indicate that prior to the announcement the player Kitchen already was "left over" from an aborted (previous) announcement and not playing TV and player Family room was idle.

    Moreover, I see zero autonomous events from any player so I suspect your firewall is NOT allowing the PI (not HS3!!) the proper access rights and autonomous events, such as updates what players are doing are being blocked. Which means that the PI thinks all these players are idle or the info is stale.

    Try again with Firewall disabled or check settings. HSPI_SONOS.EXE is what you are looking for and should have proper incoming and outgoing allowance.

    Dirk

    Comment


      #3
      Thanks Dirk. I added HSPI_SONOS.EXE to the firewall exceptions; I'll see how it does and report back.

      Comment


        #4
        Looks like the firewall exceptions fixed the issue. Thanks for the help!

        Comment


          #5
          I am having the same issue. PI works fine for awhile maybe a month and then all of a sudden the playbar will not restart after an announcement. Firewall for me didnt fix anything. A reboot of my HS server fixes mine. Windows 10 pro

          Comment


            #6
            Originally posted by jms72499 View Post
            I am having the same issue. PI works fine for awhile maybe a month and then all of a sudden the playbar will not restart after an announcement. Firewall for me didnt fix anything. A reboot of my HS server fixes mine. Windows 10 pro
            Next time it happens, turn on debug flag, do the announcement, take trace, post log. Also before you restart HS, display all system resources such as memory, cpu, handles etc (see other posting how).
            Which version of the PI?

            Dirk

            Comment

            Working...
            X