Announcement

Collapse
No announcement yet.

HS3 Sonoscontroller beta testing forum

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

    #31
    Show Failing Pings was not switched on. I've switched it on now so I'll report back tomorrow to let you know what the count says.

    Streaming works fine, hardly ever have a drop and the list of zones in the iPad/PC apps always show all zones - could be luck, but ...
    Nicolai L

    Comment


      #32
      Originally posted by NicolaiL View Post
      Show Failing Pings was not switched on. I've switched it on now so I'll report back tomorrow to let you know what the count says.

      Streaming works fine, hardly ever have a drop and the list of zones in the iPad/PC apps always show all zones - could be luck, but ...
      If you open the device table (in HS3 version) on the Sonos Plugin config page, you should see the counters, no need to turn on "show failing pings". The latter will add log entries.

      Even if the players play fine, your problem could be between players and your PC and/or buffering on the players could mask network congestion issues. Do you power down players?

      Dirk

      Comment


        #33
        Originally posted by dcorsus View Post
        If you open the device table (in HS3 version) on the Sonos Plugin config page, you should see the counters, no need to turn on "show failing pings". The latter will add log entries.

        Even if the players play fine, your problem could be between players and your PC and/or buffering on the players could mask network congestion issues. Do you power down players?

        Dirk
        Nope, never power down the players. Did it a long time back but it caused more hassle than it was worth. Here's the missing Pings, from the HS3 box:

        Office RINCON_000E58551BA801400 Online S5 10
        Bedroom/Ensuite RINCON_000E58A2947E01400 Online ZP90 4
        Jasmine RINCON_000E58713C2601400 Online S3 192.168.1.33 00:0E:58:71:3C:26 67
        Kiani RINCON_000E587A2B0801400 Online S3 18
        Den RINCON_000E5888D39601400 Online S5 87
        Bathroom RINCON_000E583BF06601400 Online ZP120 3
        Kitchen/Lounge RINCON_000E58A06C2801400 Online ZP90 3



        Which was running since: 14/10/2013 19:52:12 (according the startup log).

        The three devices with the highest count are all connected via Wireless (using one of the wired zones as the bridge).
        Nicolai L

        Comment


          #34
          Not to change track from the support you are providing on the above issue, but I noticed that when I click the "Reset Ping Counters" on the Config screen the ping count stays the same (I would have expected them all to reset to zero).
          Nicolai L

          Comment


            #35
            Originally posted by NicolaiL View Post
            Not to change track from the support you are providing on the above issue, but I noticed that when I click the "Reset Ping Counters" on the Config screen the ping count stays the same (I would have expected them all to reset to zero).
            might not have coded up a dynamic update for that part. If you refresh the page, does it go to zero? if not, it clearly is a bug
            Dirk

            Comment


              #36
              Originally posted by dcorsus View Post
              might not have coded up a dynamic update for that part. If you refresh the page, does it go to zero? if not, it clearly is a bug
              Dirk
              Nope, counters remain at original value.
              Nicolai L

              Comment


                #37
                Originally posted by NicolaiL View Post
                Nope, never power down the players. Did it a long time back but it caused more hassle than it was worth. Here's the missing Pings, from the HS3 box:

                Office RINCON_000E58551BA801400 Online S5 10
                Bedroom/Ensuite RINCON_000E58A2947E01400 Online ZP90 4
                Jasmine RINCON_000E58713C2601400 Online S3 192.168.1.33 00:0E:58:71:3C:26 67
                Kiani RINCON_000E587A2B0801400 Online S3 18
                Den RINCON_000E5888D39601400 Online S5 87
                Bathroom RINCON_000E583BF06601400 Online ZP120 3
                Kitchen/Lounge RINCON_000E58A06C2801400 Online ZP90 3



                Which was running since: 14/10/2013 19:52:12 (according the startup log).

                The three devices with the highest count are all connected via Wireless (using one of the wired zones as the bridge).

                well this is telling us something, where there is smoke there is .....

                Comment


                  #38
                  Originally posted by NicolaiL View Post
                  Nope, counters remain at original value.
                  Oops ... will have a look at it, might have broken it ... or not coded it up

                  Comment


                    #39
                    Originally posted by dcorsus View Post
                    Oops ... will have a look at it, might have broken it ... or not coded it up
                    Well, that's what a beta is for
                    Nicolai L

                    Comment


                      #40
                      Originally posted by NicolaiL View Post
                      Nope, counters remain at original value.
                      Found issue, fix will be part of next beta. Thanks for catching this.

                      Changed implementation a little: currently count will continue to go up when player is off-line, changed that to only count missing pings, when the PI assumed the player to be on-line and before set to off-line.

                      Dirk

                      Comment


                        #41
                        Originally posted by dcorsus View Post
                        Found issue, fix will be part of next beta. Thanks for catching this.

                        Changed implementation a little: currently count will continue to go up when player is off-line, changed that to only count missing pings, when the PI assumed the player to be on-line and before set to off-line.

                        Dirk
                        Sounds great! I like the new logic for the count.

                        Re my issues above I eventually found a very interesting issue with the Spanning Tree protocol. Once I fixed that my general ping times to all of my Sonos zons (wired or wireless) dropped right down and seem more stable. Thanks for pointing out the network issue.

                        Re the original log entries. Network issue or not, the one below here, is this a "valid" log entry or a piece of failing code?


                        15/10/2013 14:19:06 ~!~Sonos Error~!~ERROR in GetTimeNow for zoneplayer = Den with UPNP Error = -2147012194: Unknown error type. OrgError=-2147012894. Error = Exception from HRESULT: 0x80072EE2

                        Cheers
                        Nicolai
                        Nicolai L

                        Comment


                          #42
                          Originally posted by NicolaiL View Post
                          15/10/2013 14:19:06 ~!~Sonos Error~!~ERROR in GetTimeNow for zoneplayer = Den with UPNP Error = -2147012194: Unknown error type. OrgError=-2147012894. Error = Exception from HRESULT: 0x80072EE2
                          Obviously, you shouldn't have this error. Do you still have now that you fixed the network? If so, how frequent? Which kind of player is this? Do you see the same error on your HS2 version? Can you turn the PI's debug flag on and capture everything that happens just before and right after this error.

                          Dirk

                          Comment


                            #43
                            Originally posted by dcorsus View Post
                            Obviously, you shouldn't have this error. Do you still have now that you fixed the network? If so, how frequent? Which kind of player is this? Do you see the same error on your HS2 version? Can you turn the PI's debug flag on and capture everything that happens just before and right after this error.

                            Dirk
                            Hi,

                            Pings are now acceptable, but yes, still getting errors. HS2 also gives errors. They looks like this:

                            PHP Code:
                            22/10/2013 20:12:47     SonosController     ERROR in myDeviceFinderCallback_DeviceFound for KianiCall back wwrong Device pointerExpected 654197448 530099880
                            22
                            /10/2013 20:12:47     SonosController     ERROR in myDeviceFinderCallback_DeviceFound for JasmineCall back wwrong Device pointerExpected 532005080 653623672 
                            On HS3 I get the following when starting:

                            PHP Code:
                            22/10/2013 20:16:15           Sonos     GetPagePlugin for SonosControl called with pageName SonosConfig and user = default and userRights and queryString =
                            22/10/2013 20:16:15           Sonos     hspi.GetPagePlugin called for instance = and pageName SonosConfig and user = default and userRights and queryString =
                            22/10/2013 20:15:24           Sonos     GetPagePlugin for SonosControl called with pageName SonosConfig and user = default and userRights and queryString =
                            22/10/2013 20:15:24           Sonos     hspi.GetPagePlugin called for instance = and pageName SonosConfig and user = default and userRights and queryString =
                            22/10/2013 20:15:17           Web Server     Web Server authorized local login successful from192.168.1.51 User: default
                            22/10/2013 20:15:14           Sonos     InitializeSonosDevicesDone Initializing Sonos Devices
                            22
                            /10/2013 20:15:14           Sonos     [Log Entry Contains Chars Converted to Hex in Brackets{}]WriteSonosNamesToIniFile wrote new string Office{3B}:{3B}S5:|:Bedroom/Ensuite{3B}:{3B}ZP90:|:Jasmine{3B}:{3B}S3:|:Kiani{3B}:{3B}S3:|:Den{3B}:{3B}S5:|:Bathroom{3B}:{3B}ZP120:|:Kitchen/Lounge{3B}:{3B}ZP90
                            22
                            /10/2013 20:15:14           Sonos     CreateSonosControllersCreated instance of ZonePlayerController for Zoneplayer Kitchen/Lounge with index 2
                            22
                            /10/2013 20:15:14           Sonos     GetPagePlugin for Zoneplayer Kitchen/Lounge set ZoneUDN RINCON_000E58A06C2801400
                            22
                            /10/2013 20:15:14           Sonos     CreateWebLink called with ZoneUDN RINCON_000E58A06C2801400 and PageName PlayerControl000E58A06C2801400
                            22
                            /10/2013 20:15:14           Sonos     SetAdministrativeState called for device Kitchen/Lounge and Active True
                            22
                            /10/2013 20:15:14           Sonos     SetHSDeviceRefPlayer called for zone Kitchen/Lounge with HS Ref 8732
                            22
                            /10/2013 20:15:13           Sonos     InitIO Called for Instance RINCON_000E58A06C2801400
                            22
                            /10/2013 20:15:13           Info     Plug-in SONOSCONTROLLER with instance RINCON_000E58A06C2801400 has connected successfully
                            22
                            /10/2013 20:15:13           Info     Remote application or plugin has connected127.0.0.1:53033
                            22
                            /10/2013 20:15:13           Info     Remote application or plugin has connected127.0.0.1:53032
                            22
                            /10/2013 20:15:13           Sonos     AddInstance called with InstanceName RINCON_000E58A06C2801400
                            22
                            /10/2013 20:15:13           Sonos     CreateSonosControllersCreated instance of ZonePlayerController for Zoneplayer Bathroom with index 7
                            22
                            /10/2013 20:15:13           Sonos     GetPagePlugin for Zoneplayer Bathroom set ZoneUDN RINCON_000E583BF06601400
                            22
                            /10/2013 20:15:13           Sonos     CreateWebLink called with ZoneUDN RINCON_000E583BF06601400 and PageName PlayerControl000E583BF06601400
                            22
                            /10/2013 20:15:13           Sonos     SetAdministrativeState called for device Bathroom and Active True
                            22
                            /10/2013 20:15:13           Sonos     SetHSDeviceRefPlayer called for zone Bathroom with HS Ref 7969
                            22
                            /10/2013 20:15:12           Sonos     InitIO Called for Instance RINCON_000E583BF06601400
                            22
                            /10/2013 20:15:12           Info     Plug-in SONOSCONTROLLER with instance RINCON_000E583BF06601400 has connected successfully
                            22
                            /10/2013 20:15:12           Info     Remote application or plugin has connected127.0.0.1:53031
                            22
                            /10/2013 20:15:12           Info     Remote application or plugin has connected127.0.0.1:53030
                            22
                            /10/2013 20:15:12           Sonos     AddInstance called with InstanceName RINCON_000E583BF06601400
                            22
                            /10/2013 20:15:11           Sonos     CreateSonosControllersCreated instance of ZonePlayerController for Zoneplayer Den with index 1
                            22
                            /10/2013 20:15:11           Sonos     GetPagePlugin for Zoneplayer Den set ZoneUDN RINCON_000E5888D39601400
                            22
                            /10/2013 20:15:11           Sonos     CreateWebLink called with ZoneUDN RINCON_000E5888D39601400 and PageName PlayerControl000E5888D39601400
                            22
                            /10/2013 20:15:11           Sonos     [Log Entry Contains Chars Converted to Hex in Brackets{}]HS updated in UpdateHSHS Code 7841 Info = {3C}table{3E}{3C}tr{3E}{3C}td{3E}{3C}img src=/Sonos/images/noart.png height="150" width="150" {3E}{3C}/td{3E}{3C}td{3E}{3C}p{3E}Stop{3C}/p{3E}{3C}p{3E}Lastfm{3C}/p{3E}{3C}p{3E}pop Tag Radio{3C}/p{3E}{3C}p{3E}{3C}/p{3E}{3C}p{3E}{3C}/p{3E}{3C}/td{3E}{3C}/tr{3E}{3C}/table{3E}
                            22/10/2013 20:15:11           Sonos     ArtworkURL Set for ZoneName DenAlbum http://192.168.1.26:80/Sonos/images/noart.png
                            22/10/2013 20:15:11           Sonos     ArtworkURL is setting HS Status for ZoneName Den with Value http://192.168.1.26:80/Sonos/images/noart.png and HSRef = 1484
                            22/10/2013 20:15:11           Sonos     Album Set for ZoneName DenAlbum =
                            22/10/2013 20:15:11           Sonos     Artist Set for ZoneName DenArtist =
                            22/10/2013 20:15:11           Sonos     Track Set for ZoneName DenTrack pop Tag Radio
                            22
                            /10/2013 20:15:11           Sonos     PlayChangeNotifyCallback called for Zone Den with ChangeType PlayStatusChanged and Changevalue stopped
                            22
                            /10/2013 20:15:11           Sonos     PlayChangeNotifyCallback called for Zone Den with ChangeType SongChanged and Changevalue stopped
                            22
                            /10/2013 20:15:11           Sonos     CurrentPlayerState Set for ZoneName DenValue stopped
                            22
                            /10/2013 20:15:11           Sonos     Den TrackInfo(Source) = Lastfm
                            22
                            /10/2013 20:15:11           Sonos     UpdateRadioStationsInfo updated RadioStation LastFM pop Tag Radio for Zone Den
                            22
                            /10/2013 20:15:11           Sonos     [Log Entry Contains Chars Converted to Hex in Brackets{}]CreateRadioStationDatabase called with C:\Program Files (x86)\HomeSeer HS3\html\Sonos\MusicDb\SonosRadioStationsDB.mdb and Provider=Microsoft.Jet.OLEDB.4.0{3B}Data Source=C:\Program Files (x86)\HomeSeer HS3\html\Sonos\MusicDb\SonosRadioStationsDB.mdb for zoneplayer Den
                            22
                            /10/2013 20:15:11           Sonos     [Log Entry Contains Chars Converted to Hex in Brackets{}]UpdateRadioStationsInfo called for Zone Den with CurrentURI lastfm://globaltags/pop and CurrentURIMetaData = {3C}DIDL-Lite xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:r="urn:schemas-rinconnetworks-com:metadata-1-0/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/"{3E}{3C}item id="RP:SA_RINCON11_LegolasHaifisch:0:LFM%3aTAG%3apop" parentID="RECENT" restricted="true"{3E}{3C}dc:title{3E}pop Tag Radio{3C}/dc:title{3E}{3C}upnp:class{3E}object.item.audioItem.audioBroadcast{3C}/upnp:class{3E}{3C}desc id="cdudn" nameSpace="urn:schemas-rinconnetworks-com:metadata-1-0/"{3E}SA_RINCON11_LegolasHaifisch{3C}/desc{3E}{3C}/item{3E}{3C}/DIDL-Lite{3E}
                            22/10/2013 20:15:11           Sonos     Den TrackInfo (title) = pop Tag Radio
                            22
                            /10/2013 20:15:11           Sonos     Den TrackInfo (MediaInfo/Title) = pop Tag Radio
                            22
                            /10/2013 20:15:11           Sonos     [Log Entry Contains Chars Converted to Hex in Brackets{}]Den TrackInfo (CurrentURI) = lastfm://globaltags/pop and TrackInfo (CurrentURIMetaData) = {3C}DIDL-Lite xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:r="urn:schemas-rinconnetworks-com:metadata-1-0/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/"{3E}{3C}item id="RP:SA_RINCON11_LegolasHaifisch:0:LFM%3aTAG%3apop" parentID="RECENT" restricted="true"{3E}{3C}dc:title{3E}pop Tag Radio{3C}/dc:title{3E}{3C}upnp:class{3E}object.item.audioItem.audioBroadcast{3C}/upnp:class{3E}{3C}desc id="cdudn" nameSpace="urn:schemas-rinconnetworks-com:metadata-1-0/"{3E}SA_RINCON11_LegolasHaifisch{3C}/desc{3E}{3C}/item{3E}{3C}/DIDL-Lite{3E}
                            22/10/2013 20:15:11           Sonos     GetcurrentTrackInfo called for zoneplayer Den
                            22
                            /10/2013 20:15:11           Sonos     MPAdd added IPAddress 192.168.1.34 and ClientName RINCON_000E5888D39601400 to its ping list. IPAddress list count 3
                            22
                            /10/2013 20:15:11           Sonos     CheckDeviceIsOnLine pinged IPAddress 192.168.1.34 successfully
                            22
                            /10/2013 20:15:11           Sonos     IPAddress for zoneplayer Den192.168.1.34
                            22
                            /10/2013 20:15:11           Sonos     PlayChangeNotifyCallback called for Zone Den with ChangeType DeviceStatusChanged and Changevalue AudioInTrue
                            22
                            /10/2013 20:15:11           Sonos     DirectConnect for zoneplayer Den found AudioInputName Audio Component
                            22
                            /10/2013 20:15:11           Sonos     GetLoudnessState called for ZonePlayer Den with values Channel=Master and DeviceStatus =Online
                            22
                            /10/2013 20:15:11           Sonos     SetMuteState is setting HS Status Mute for ZoneName Den with Value False and HSRef 3506
                            22
                            /10/2013 20:15:11           Sonos     GetMuteState calledDeviceStatus =Online
                            22
                            /10/2013 20:15:11           Sonos     UpdateBalance is setting HS Status for ZoneName Den with Value and HSRef 6781
                            22
                            /10/2013 20:15:11           Sonos     GetVolumeLevel called for ZonePlayer Den with values Channel=RF and DeviceStatus =Online
                            22
                            /10/2013 20:15:11           Sonos     GetVolumeLevel called for ZonePlayer Den with values Channel=LF and DeviceStatus =Online
                            22
                            /10/2013 20:15:11           Sonos     SetVolume is setting HS Status Volume for ZoneName Den with Value 74 and HSRef 7463
                            22
                            /10/2013 20:15:11           Sonos     GetVolumeLevel called for ZonePlayer Den with values Channel=Master and DeviceStatus =Online
                            22
                            /10/2013 20:15:11           Sonos     DevicePropertiesCallback added for zoneplayer Den
                            22
                            /10/2013 20:15:11           Sonos     AudioInCallback added for zoneplayer Den
                            22
                            /10/2013 20:15:11           Sonos     ConnectionManagerCallback added for zoneplayer Den
                            22
                            /10/2013 20:15:11           Sonos     SystemProperties ControlCallback added for zoneplayer Den
                            22
                            /10/2013 20:15:11           Sonos     MusicServices ControlCallback added for zoneplayer Den
                            22
                            /10/2013 20:15:11           Sonos     AlarmClock ControlCallback added for zoneplayer Den
                            22
                            /10/2013 20:15:11           Sonos     GroupManagement ControlCallback added for zoneplayer Den
                            22
                            /10/2013 20:15:11           Sonos     ZoneGroupTopology ControlCallback added for zoneplayer Den
                            22
                            /10/2013 20:15:11           Sonos     ContentDirectory ControlCallback added for zoneplayer Den
                            22
                            /10/2013 20:15:11           Sonos     RenderingControlCallback added for zoneplayer Den
                            22
                            /10/2013 20:15:11           Sonos     AvTransportCallback added for zoneplayer Den
                            22
                            /10/2013 20:15:11           Sonos     ConnectionManager service added for zoneplayer Den
                            22
                            /10/2013 20:15:11           Sonos     ContentDirectory service added for zoneplayer Den
                            22
                            /10/2013 20:15:11           Sonos Error     Error in MediaRenderer.Services for zoneplayer Den with UPNP Error = -2147219524Unknown error typeOrgError=-2147220224. Error Exception from HRESULT0x80040500
                            22
                            /10/2013 20:15:11           Sonos     AVTransport service added for zoneplayer Den
                            22
                            /10/2013 20:15:11           Sonos     ConnectionManager service added for zoneplayer Den
                            22
                            /10/2013 20:15:11           Sonos     RenderingControl service added for zoneplayer Den
                            22
                            /10/2013 20:15:11           Sonos     Additional services found for Den with ID urn:tencent-com:serviceId:QPlay
                            22
                            /10/2013 20:15:11           Sonos     GroupManagement service added for zoneplayer Den
                            22
                            /10/2013 20:15:11           Sonos     ZoneGroupTopology service added for zoneplayer Den
                            22
                            /10/2013 20:15:11           Sonos     SystemProperties service added for zoneplayer Den
                            22
                            /10/2013 20:15:11           Sonos     DeviceProperties service added for zoneplayer Den
                            22
                            /10/2013 20:15:11           Sonos     AudioIN service added for zoneplayer Den
                            22
                            /10/2013 20:15:11           Sonos     MusicServices service added for zoneplayer Den
                            22
                            /10/2013 20:15:11           Sonos     AlarmClock service added for zoneplayer Den
                            22
                            /10/2013 20:15:11           Sonos     Den MediaRenderer Friendly Name Den Sonos PLAY:5 Media Renderer
                            22
                            /10/2013 20:15:11           Sonos     Den MediaServer Friendly Name uuid:RINCON_000E5888D39601400_MS
                            22
                            /10/2013 20:15:10           Sonos     DirectConnect for zoneplayer Den added Image = /images/Sonos/PlayerIcon_S5.png for HSRef 7841
                            22
                            /10/2013 20:15:10           Sonos     DirectConnect for zoneplayer Den found Icon already stored at /images/Sonos/PlayerIcon_S5.png
                            22
                            /10/2013 20:15:10           Sonos     DirectConnect for zoneplayer Den checking for file C:\Program Files (x86)\HomeSeer HS3\html/images/Sonos/PlayerIcon_S5.png
                            22
                            /10/2013 20:15:10           Sonos     DirectConnect for zoneplayer Den found IconURL http://192.168.1.34:1400/img/icon-S5.png
                            22/10/2013 20:15:10           Sonos     DirectConnect called for Zone Den with device name uuid:RINCON_000E5888D39601400 and Model S5
                            22
                            /10/2013 20:15:10           Sonos     SetAdministrativeState called for device Den and Active True
                            22
                            /10/2013 20:15:10           Sonos     SetHSDeviceRefPlayer called for zone Den with HS Ref 7841
                            22
                            /10/2013 20:15:09           Sonos     InitIO Called for Instance RINCON_000E5888D39601400
                            22
                            /10/2013 20:15:09           Info     Plug-in SONOSCONTROLLER with instance RINCON_000E5888D39601400 has connected successfully
                            22
                            /10/2013 20:15:09           Info     Remote application or plugin has connected127.0.0.1:52990
                            22
                            /10/2013 20:15:09           Info     Remote application or plugin has connected127.0.0.1:52989
                            22
                            /10/2013 20:15:09           Sonos     AddInstance called with InstanceName RINCON_000E5888D39601400
                            22
                            /10/2013 20:15:09           Sonos     CreateSonosControllersCreated instance of ZonePlayerController for Zoneplayer Kiani with index 6
                            22
                            /10/2013 20:15:09           Sonos     GetPagePlugin for Zoneplayer Kiani set ZoneUDN RINCON_000E587A2B0801400
                            22
                            /10/2013 20:15:09           Sonos     CreateWebLink called with ZoneUDN RINCON_000E587A2B0801400 and PageName PlayerControl000E587A2B0801400
                            22
                            /10/2013 20:15:09           Sonos     [Log Entry Contains Chars Converted to Hex in Brackets{}]HS updated in UpdateHSHS Code 5817 Info = {3C}table{3E}{3C}tr{3E}{3C}td{3E}{3C}img src=/Sonos/images/noart.png height="150" width="150" {3E}{3C}/td{3E}{3C}td{3E}{3C}p{3E}Stop{3C}/p{3E}{3C}p{3E}Unknown{3C}/p{3E}{3C}p{3E}{3C}/p{3E}{3C}p{3E}{3C}/p{3E}{3C}p{3E}{3C}/p{3E}{3C}/td{3E}{3C}/tr{3E}{3C}/table{3E}
                            22/10/2013 20:15:09           Sonos     ArtworkURL Set for ZoneName KianiAlbum http://192.168.1.26:80/Sonos/images/noart.png
                            22/10/2013 20:15:09           Sonos     ArtworkURL is setting HS Status for ZoneName Kiani with Value http://192.168.1.26:80/Sonos/images/noart.png and HSRef = 4350
                            22/10/2013 20:15:09           Sonos     Album Set for ZoneName KianiAlbum =
                            22/10/2013 20:15:09           Sonos     Artist Set for ZoneName KianiArtist =
                            22/10/2013 20:15:09           Sonos     Track Set for ZoneName KianiTrack =
                            22/10/2013 20:15:09           Sonos     PlayChangeNotifyCallback called for Zone Kiani with ChangeType PlayStatusChanged and Changevalue stopped
                            22
                            /10/2013 20:15:09           Sonos     PlayChangeNotifyCallback called for Zone Kiani with ChangeType SongChanged and Changevalue stopped
                            22
                            /10/2013 20:15:09           Sonos     CurrentPlayerState Set for ZoneName KianiValue stopped
                            22
                            /10/2013 20:15:09           Sonos     Kiani TrackInfo(Source) = Unknown
                            22
                            /10/2013 20:15:09           Sonos     Kiani TrackInfo (CurrentURI) = and TrackInfo (CurrentURIMetaData) =
                            22/10/2013 20:15:09           Sonos     GetcurrentTrackInfo called for zoneplayer Kiani
                            22
                            /10/2013 20:15:09           Sonos     MPAdd added IPAddress 192.168.1.37 and ClientName RINCON_000E587A2B0801400 to its ping list. IPAddress list count 2
                            22
                            /10/2013 20:15:08           Sonos     CheckDeviceIsOnLine pinged IPAddress 192.168.1.37 successfully
                            22
                            /10/2013 20:15:08           Sonos     IPAddress for zoneplayer Kiani192.168.1.37
                            22
                            /10/2013 20:15:08           Sonos     GetLoudnessState called for ZonePlayer Kiani with values Channel=Master and DeviceStatus =Online
                            22
                            /10/2013 20:15:08           Sonos     SetMuteState is setting HS Status Mute for ZoneName Kiani with Value False and HSRef 1941
                            22
                            /10/2013 20:15:08           Sonos     GetMuteState calledDeviceStatus =Online
                            22
                            /10/2013 20:15:08           Sonos     UpdateBalance is setting HS Status for ZoneName Kiani with Value and HSRef 7895
                            22
                            /10/2013 20:15:08           Sonos     GetVolumeLevel called for ZonePlayer Kiani with values Channel=RF and DeviceStatus =Online
                            22
                            /10/2013 20:15:08           Sonos     GetVolumeLevel called for ZonePlayer Kiani with values Channel=LF and DeviceStatus =Online
                            22
                            /10/2013 20:15:08           Sonos     SetVolume is setting HS Status Volume for ZoneName Kiani with Value 44 and HSRef 5054
                            22
                            /10/2013 20:15:08           Sonos     GetVolumeLevel called for ZonePlayer Kiani with values Channel=Master and DeviceStatus =Online
                            22
                            /10/2013 20:15:08           Sonos     DevicePropertiesCallback added for zoneplayer Kiani
                            22
                            /10/2013 20:15:08           Sonos     ConnectionManagerCallback added for zoneplayer Kiani
                            22
                            /10/2013 20:15:08           Sonos     SystemProperties ControlCallback added for zoneplayer Kiani
                            22
                            /10/2013 20:15:08           Sonos     MusicServices ControlCallback added for zoneplayer Kiani
                            22
                            /10/2013 20:15:08           Sonos     AlarmClock ControlCallback added for zoneplayer Kiani
                            22
                            /10/2013 20:15:08           Sonos     GroupManagement ControlCallback added for zoneplayer Kiani
                            22
                            /10/2013 20:15:08           Sonos     ZoneGroupTopology ControlCallback added for zoneplayer Kiani
                            22
                            /10/2013 20:15:08           Sonos     ContentDirectory ControlCallback added for zoneplayer Kiani
                            22
                            /10/2013 20:15:08           Sonos     RenderingControlCallback added for zoneplayer Kiani
                            22
                            /10/2013 20:15:08           Sonos     AvTransportCallback added for zoneplayer Kiani
                            22
                            /10/2013 20:15:08           Sonos     ConnectionManager service added for zoneplayer Kiani
                            22
                            /10/2013 20:15:08           Sonos     ContentDirectory service added for zoneplayer Kiani
                            22
                            /10/2013 20:15:08           Sonos Error     Error in MediaRenderer.Services for zoneplayer Kiani with UPNP Error = -2147219524Unknown error typeOrgError=-2147220224. Error Exception from HRESULT0x80040500
                            22
                            /10/2013 20:15:08           Sonos     AVTransport service added for zoneplayer Kiani
                            22
                            /10/2013 20:15:08           Sonos     ConnectionManager service added for zoneplayer Kiani
                            22
                            /10/2013 20:15:08           Sonos     RenderingControl service added for zoneplayer Kiani
                            22
                            /10/2013 20:15:08           Sonos     Additional services found for Kiani with ID urn:tencent-com:serviceId:QPlay
                            22
                            /10/2013 20:15:08           Sonos     GroupManagement service added for zoneplayer Kiani
                            22
                            /10/2013 20:15:08           Sonos     ZoneGroupTopology service added for zoneplayer Kiani
                            22
                            /10/2013 20:15:08           Sonos     SystemProperties service added for zoneplayer Kiani
                            22
                            /10/2013 20:15:08           Sonos     DeviceProperties service added for zoneplayer Kiani
                            22
                            /10/2013 20:15:08           Sonos     MusicServices service added for zoneplayer Kiani
                            22
                            /10/2013 20:15:08           Sonos     AlarmClock service added for zoneplayer Kiani
                            22
                            /10/2013 20:15:08           Sonos     Kiani MediaRenderer Friendly Name Kiani Sonos PLAY:3 Media Renderer
                            22
                            /10/2013 20:15:08           Sonos     Kiani MediaServer Friendly Name uuid:RINCON_000E587A2B0801400_MS
                            22
                            /10/2013 20:15:08           Sonos     DirectConnect for zoneplayer Kiani added Image = /images/Sonos/PlayerIcon_S3.png for HSRef 5817
                            22
                            /10/2013 20:15:08           Sonos     DirectConnect for zoneplayer Kiani found Icon already stored at /images/Sonos/PlayerIcon_S3.png
                            22
                            /10/2013 20:15:08           Sonos     DirectConnect for zoneplayer Kiani checking for file C:\Program Files (x86)\HomeSeer HS3\html/images/Sonos/PlayerIcon_S3.png
                            22
                            /10/2013 20:15:08           Sonos     DirectConnect for zoneplayer Kiani found IconURL http://192.168.1.37:1400/img/icon-S3.png
                            22/10/2013 20:15:08           Sonos     DirectConnect called for Zone Kiani with device name uuid:RINCON_000E587A2B0801400 and Model S3
                            22
                            /10/2013 20:15:08           Sonos     SetAdministrativeState called for device Kiani and Active True
                            22
                            /10/2013 20:15:08           Sonos     SetHSDeviceRefPlayer called for zone Kiani with HS Ref 5817
                            22
                            /10/2013 20:15:07           Sonos     InitIO Called for Instance RINCON_000E587A2B0801400
                            22
                            /10/2013 20:15:07           Info     Plug-in SONOSCONTROLLER with instance RINCON_000E587A2B0801400 has connected successfully
                            22
                            /10/2013 20:15:07           Info     Remote application or plugin has connected127.0.0.1:52953
                            22
                            /10/2013 20:15:07           Info     Remote application or plugin has connected127.0.0.1:52952
                            22
                            /10/2013 20:15:07           Sonos     AddInstance called with InstanceName RINCON_000E587A2B0801400
                            22
                            /10/2013 20:15:07           Sonos     CreateSonosControllersCreated instance of ZonePlayerController for Zoneplayer Jasmine with index 5
                            22
                            /10/2013 20:15:06           Sonos     GetPagePlugin for Zoneplayer Jasmine set ZoneUDN RINCON_000E58713C2601400
                            22
                            /10/2013 20:15:06           Sonos     CreateWebLink called with ZoneUDN RINCON_000E58713C2601400 and PageName PlayerControl000E58713C2601400
                            22
                            /10/2013 20:15:06           Sonos     [Log Entry Contains Chars Converted to Hex in Brackets{}]HS updated in UpdateHSHS Code 5640 Info = {3C}table{3E}{3C}tr{3E}{3C}td{3E}{3C}img src=/Sonos/Artwork/Cover5_1.jpg height="150" width="150" {3E}{3C}/td{3E}{3C}td{3E}{3C}p{3E}Stop{3C}/p{3E}{3C}p{3E}Tracks{3C}/p{3E}{3C}p{3E}Counting Stars{3C}/p{3E}{3C}p{3E}OneRepublic{3C}/p{3E}{3C}p{3E}Native{3C}/p{3E}{3C}/td{3E}{3C}/tr{3E}{3C}/table{3E}
                            22/10/2013 20:15:06           Sonos     ArtworkURL Set for ZoneName JasmineAlbum http://192.168.1.26:80/Sonos/Artwork/Cover5_1.jpg
                            22/10/2013 20:15:06           Sonos     ArtworkURL is setting HS Status for ZoneName Jasmine with Value http://192.168.1.26:80/Sonos/Artwork/Cover5_1.jpg and HSRef = 4683
                            22/10/2013 20:15:06           Sonos     Album Set for ZoneName JasmineAlbum Native
                            22
                            /10/2013 20:15:06           Sonos     Artist Set for ZoneName JasmineArtist OneRepublic
                            22
                            /10/2013 20:15:06           Sonos     Track Set for ZoneName JasmineTrack Counting Stars
                            22
                            /10/2013 20:15:06           Sonos     PlayChangeNotifyCallback called for Zone Jasmine with ChangeType PlayStatusChanged and Changevalue stopped
                            22
                            /10/2013 20:15:06           Sonos     PlayChangeNotifyCallback called for Zone Jasmine with ChangeType SongChanged and Changevalue stopped
                            22
                            /10/2013 20:15:06           Sonos     CurrentPlayerState Set for ZoneName JasmineValue stopped
                            22
                            /10/2013 20:15:06           Sonos     Jasmine TrackInfo PositionInfo (% played) = 0
                            22
                            /10/2013 20:15:06           Sonos     Jasmine TrackInfo PositionInfo (Queue Position) = 1
                            22
                            /10/2013 20:15:06           Sonos     SetTrackLength set Pair for ZoneName Jasmine Old Max Range 257 New Max Range 257
                            22
                            /10/2013 20:15:06           Sonos     SetTrackLength is setting HS Status Max Position TrackPosition for ZoneName Jasmine and HSRef 1735
                            22
                            /10/2013 20:15:06           Sonos     SetTrackLength is setting HS Device TrackLength for ZoneName Jasmine with Value 257 and HSRef 8082
                            22
                            /10/2013 20:15:06           Sonos     Jasmine TrackInfo PositionInfo (Track Duration) = 0:04:17
                            22
                            /10/2013 20:15:06           Sonos     Jasmine TrackInfo PositionInfo (Track Position Seconds) = 0
                            22
                            /10/2013 20:15:06           Sonos     Jasmine TrackInfo PositionInfo (Track Position) = 0:00:00
                            22
                            /10/2013 20:15:06           Sonos     GetAlbumArtPath returned for Zone Jasmine with AlbumURI http://192.168.1.33:1400/getaa?r=1&u=npsdy:Tra.98547055.mp3 and returned path= /Sonos/Artwork/Cover5_1.jpg
                            22/10/2013 20:15:06           Sonos     GetAlbumArtPath called for zone Jasmine with AlbumURI http://192.168.1.33:1400/getaa?r=1&u=npsdy:Tra.98547055.mp3 and NextTrack = False
                            22/10/2013 20:15:06           Sonos     Jasmine TrackInfo PositionInfo (albumArtURI) = http://192.168.1.33:1400/getaa?r=1&u=npsdy:Tra.98547055.mp3
                            22/10/2013 20:15:06           Sonos     Jasmine TrackInfo PositionInfo (title) = Counting Stars
                            22
                            /10/2013 20:15:06           Sonos     Jasmine TrackInfo PositionInfo (album) = Native
                            22
                            /10/2013 20:15:06           Sonos     Jasmine TrackInfo PositionInfo (creator) = OneRepublic
                            22
                            /10/2013 20:15:06           Sonos     Jasmine TrackInfo PositionInfo (Streamcontent/Title) =
                            22/10/2013 20:15:06           Sonos     [Log Entry Contains Chars Converted to Hex in Brackets{}]GetcurrentTrackInfo called GetPositionInfo for zoneplayer Jasmine and MetaData {3C}DIDL-Lite xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:r="urn:schemas-rinconnetworks-com:metadata-1-0/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/"{3E}{3C}item id="-1" parentID="-1" restricted="true"{3E}{3C}res protocolInfo="real.com-rhapsody-direct:*:audio/mp3:*" duration="0:04:17"{3E}npsdy:Tra.98547055.mp3{3C}/res{3E}{3C}r:streamContent{3E}{3C}/r:streamContent{3E}{3C}upnp:albumArtURI{3E}/getaa?r=1&u=npsdy%3aTra.98547055.mp3{3C}/upnp:albumArtURI{3E}{3C}dc:title{3E}Counting Stars{3C}/dc:title{3E}{3C}upnp:class{3E}object.item.audioItem.musicTrack{3C}/upnp:class{3E}{3C}dc:creator{3E}OneRepublic{3C}/dc:creator{3E}{3C}upnp:album{3E}Native{3C}/upnp:album{3E}{3C}/item{3E}{3C}/DIDL-Lite{3E}
                            22/10/2013 20:15:06           Sonos     Jasmine TrackInfo(Source) = Tracks
                            22
                            /10/2013 20:15:06           Sonos     Jasmine TrackInfo (CurrentURI) = x-rincon-queue:RINCON_000E58713C2601400#0
                            22/10/2013 20:15:06           Sonos     Jasmine TrackInfo (CurrentURI) = x-rincon-queue:RINCON_000E58713C2601400#0 and TrackInfo (CurrentURIMetaData) =
                            22/10/2013 20:15:06           Sonos     GetcurrentTrackInfo called for zoneplayer Jasmine
                            22
                            /10/2013 20:15:06           Sonos     MPAdd added IPAddress 192.168.1.33 and ClientName RINCON_000E58713C2601400 to its ping list. IPAddress list count 1
                            22
                            /10/2013 20:15:06           Sonos     CheckDeviceIsOnLine pinged IPAddress 192.168.1.33 successfully
                            22
                            /10/2013 20:15:06           Sonos     IPAddress for zoneplayer Jasmine192.168.1.33
                            22
                            /10/2013 20:15:06           Sonos     GetLoudnessState called for ZonePlayer Jasmine with values Channel=Master and DeviceStatus =Online
                            22
                            /10/2013 20:15:06           Sonos     SetMuteState is setting HS Status Mute for ZoneName Jasmine with Value False and HSRef 6545
                            22
                            /10/2013 20:15:05           Sonos     GetMuteState calledDeviceStatus =Online
                            22
                            /10/2013 20:15:05           Sonos     UpdateBalance is setting HS Status for ZoneName Jasmine with Value and HSRef 9912
                            22
                            /10/2013 20:15:05           Sonos     GetVolumeLevel called for ZonePlayer Jasmine with values Channel=RF and DeviceStatus =Online
                            22
                            /10/2013 20:15:05           Sonos     GetVolumeLevel called for ZonePlayer Jasmine with values Channel=LF and DeviceStatus =Online
                            22
                            /10/2013 20:15:05           Sonos     SetVolume is setting HS Status Volume for ZoneName Jasmine with Value and HSRef 930
                            22
                            /10/2013 20:15:05           Sonos     GetVolumeLevel called for ZonePlayer Jasmine with values Channel=Master and DeviceStatus =Online
                            22
                            /10/2013 20:15:05           Sonos     DevicePropertiesCallback added for zoneplayer Jasmine
                            22
                            /10/2013 20:15:05           Sonos     ConnectionManagerCallback added for zoneplayer Jasmine
                            22
                            /10/2013 20:15:05           Sonos     SystemProperties ControlCallback added for zoneplayer Jasmine
                            22
                            /10/2013 20:15:05           Sonos     MusicServices ControlCallback added for zoneplayer Jasmine
                            22
                            /10/2013 20:15:05           Sonos     AlarmClock ControlCallback added for zoneplayer Jasmine
                            22
                            /10/2013 20:15:05           Sonos     GroupManagement ControlCallback added for zoneplayer Jasmine
                            22
                            /10/2013 20:15:05           Sonos     ZoneGroupTopology ControlCallback added for zoneplayer Jasmine
                            22
                            /10/2013 20:15:05           Sonos     ContentDirectory ControlCallback added for zoneplayer Jasmine
                            22
                            /10/2013 20:15:05           Sonos     RenderingControlCallback added for zoneplayer Jasmine
                            22
                            /10/2013 20:15:05           Sonos     AvTransportCallback added for zoneplayer Jasmine
                            22
                            /10/2013 20:15:05           Sonos     ConnectionManager service added for zoneplayer Jasmine
                            22
                            /10/2013 20:15:05           Sonos     ContentDirectory service added for zoneplayer Jasmine
                            22
                            /10/2013 20:15:05           Sonos Error     Error in MediaRenderer.Services for zoneplayer Jasmine with UPNP Error = -2147219524Unknown error typeOrgError=-2147220224. Error Exception from HRESULT0x80040500
                            22
                            /10/2013 20:15:05           Sonos     AVTransport service added for zoneplayer Jasmine
                            22
                            /10/2013 20:15:05           Sonos     ConnectionManager service added for zoneplayer Jasmine
                            22
                            /10/2013 20:15:05           Sonos     RenderingControl service added for zoneplayer Jasmine
                            22
                            /10/2013 20:15:05           Sonos     Additional services found for Jasmine with ID urn:tencent-com:serviceId:QPlay
                            22
                            /10/2013 20:15:05           Sonos     GroupManagement service added for zoneplayer Jasmine
                            22
                            /10/2013 20:15:05           Sonos     ZoneGroupTopology service added for zoneplayer Jasmine
                            22
                            /10/2013 20:15:05           Sonos     SystemProperties service added for zoneplayer Jasmine
                            22
                            /10/2013 20:15:05           Sonos     DeviceProperties service added for zoneplayer Jasmine
                            22
                            /10/2013 20:15:05           Sonos     MusicServices service added for zoneplayer Jasmine
                            22
                            /10/2013 20:15:05           Sonos     AlarmClock service added for zoneplayer Jasmine
                            22
                            /10/2013 20:15:05           Sonos     Jasmine MediaRenderer Friendly Name Jasmine Sonos PLAY:3 Media Renderer
                            22
                            /10/2013 20:15:05           Sonos     Jasmine MediaServer Friendly Name uuid:RINCON_000E58713C2601400_MS
                            22
                            /10/2013 20:15:05           Sonos     DirectConnect for zoneplayer Jasmine added Image = /images/Sonos/PlayerIcon_S3.png for HSRef 5640
                            22
                            /10/2013 20:15:05           Sonos     DirectConnect for zoneplayer Jasmine found Icon already stored at /images/Sonos/PlayerIcon_S3.png
                            22
                            /10/2013 20:15:05           Sonos     DirectConnect for zoneplayer Jasmine checking for file C:\Program Files (x86)\HomeSeer HS3\html/images/Sonos/PlayerIcon_S3.png
                            22
                            /10/2013 20:15:05           Sonos     DirectConnect for zoneplayer Jasmine found IconURL http://192.168.1.33:1400/img/icon-S3.png
                            22/10/2013 20:15:05           Sonos     DirectConnect called for Zone Jasmine with device name uuid:RINCON_000E58713C2601400 and Model S3
                            22
                            /10/2013 20:15:05           Sonos     SetAdministrativeState called for device Jasmine and Active True
                            22
                            /10/2013 20:15:05           Sonos     SetHSDeviceRefPlayer called for zone Jasmine with HS Ref 5640
                            22
                            /10/2013 20:15:04           Sonos     InitIO Called for Instance RINCON_000E58713C2601400
                            22
                            /10/2013 20:15:04           Info     Plug-in SONOSCONTROLLER with instance RINCON_000E58713C2601400 has connected successfully
                            22
                            /10/2013 20:15:04           Info     Remote application or plugin has connected127.0.0.1:52913
                            22
                            /10/2013 20:15:04           Info     Remote application or plugin has connected127.0.0.1:52912
                            22
                            /10/2013 20:15:04           Sonos     AddInstance called with InstanceName RINCON_000E58713C2601400
                            22
                            /10/2013 20:15:04           Sonos     CreateSonosControllersCreated instance of ZonePlayerController for Zoneplayer Bedroom/Ensuite with index 4
                            22
                            /10/2013 20:15:04           Sonos     GetPagePlugin for Zoneplayer Bedroom/Ensuite set ZoneUDN RINCON_000E58A2947E01400
                            22
                            /10/2013 20:15:04           Sonos     CreateWebLink called with ZoneUDN RINCON_000E58A2947E01400 and PageName PlayerControl000E58A2947E01400
                            22
                            /10/2013 20:15:04           Sonos     SetAdministrativeState called for device Bedroom/Ensuite and Active True
                            22
                            /10/2013 20:15:04           Sonos     SetHSDeviceRefPlayer called for zone Bedroom/Ensuite with HS Ref 2564
                            22
                            /10/2013 20:15:03           Sonos     InitIO Called for Instance RINCON_000E58A2947E01400
                            22
                            /10/2013 20:15:03           Info     Plug-in SONOSCONTROLLER with instance RINCON_000E58A2947E01400 has connected successfully
                            22
                            /10/2013 20:15:03           Info     Remote application or plugin has connected127.0.0.1:52911
                            22
                            /10/2013 20:15:03           Info     Remote application or plugin has connected127.0.0.1:52910
                            22
                            /10/2013 20:15:03           Sonos     AddInstance called with InstanceName RINCON_000E58A2947E01400
                            22
                            /10/2013 20:15:03           Sonos     CreateSonosControllersCreated instance of ZonePlayerController for Zoneplayer Office with index 3
                            22
                            /10/2013 20:15:03           Sonos     GetPagePlugin for Zoneplayer Office set ZoneUDN RINCON_000E58551BA801400
                            22
                            /10/2013 20:15:03           Sonos     CreateWebLink called with ZoneUDN RINCON_000E58551BA801400 and PageName PlayerControl000E58551BA801400
                            22
                            /10/2013 20:15:03           Sonos     SetAdministrativeState called for device Office and Active True
                            22
                            /10/2013 20:15:03           Sonos     SetHSDeviceRefPlayer called for zone Office with HS Ref 2225
                            22
                            /10/2013 20:15:02           Sonos     InitIO Called for Instance RINCON_000E58551BA801400
                            22
                            /10/2013 20:15:02           Info     Plug-in SONOSCONTROLLER with instance RINCON_000E58551BA801400 has connected successfully
                            22
                            /10/2013 20:15:02           Info     Remote application or plugin has connected127.0.0.1:52901
                            22
                            /10/2013 20:15:02           Info     Remote application or plugin has connected127.0.0.1:52900
                            22
                            /10/2013 20:15:02           Sonos     AddInstance called with InstanceName RINCON_000E58551BA801400
                            22
                            /10/2013 20:15:02           Sonos     CreateSonosControllersZonePlayer in HS DB not found on-lineZoneHSRef 8732. ZoneUDN RINCON_000E58A06C2801400
                            22
                            /10/2013 20:15:02           Sonos     CreateSonosControllersZonePlayer in HS DB not found on-lineZoneHSRef 7969. ZoneUDN RINCON_000E583BF06601400
                            22
                            /10/2013 20:15:02           Sonos     CreateSonosControllersZonePlayer in HS DB not found on-lineZoneHSRef 2564. ZoneUDN RINCON_000E58A2947E01400
                            22
                            /10/2013 20:15:02           Sonos     CreateSonosControllersZonePlayer in HS DB not found on-lineZoneHSRef 2225. ZoneUDN RINCON_000E58551BA801400
                            22
                            /10/2013 20:15:02           Sonos     CreateSonosControllersfound 7 Device Codes
                            22
                            /10/2013 20:15:02           Sonos     SetDeviceStringConnected called
                            22
                            /10/2013 20:15:02           Sonos     BuildHSSonosDevicesFound Zone Name for TransportZonename Kiani
                            22
                            /10/2013 20:15:02           Sonos     BuildHSSonosDeviceslooking for Kiani in ZoneInfo and Refresh False
                            22
                            /10/2013 20:15:02           Sonos     BuildHSSonosDevicesFound Zone Name for TransportZonename Jasmine
                            22
                            /10/2013 20:15:02           Sonos     BuildHSSonosDeviceslooking for Jasmine in ZoneInfo and Refresh False
                            22
                            /10/2013 20:15:02           Sonos     BuildHSSonosDevicesFound Zone Name for TransportZonename Den
                            22
                            /10/2013 20:15:02           Sonos     BuildHSSonosDeviceslooking for Den in ZoneInfo and Refresh False
                            22
                            /10/2013 20:15:02           Sonos     FindZonePlayers Discovery succeeded3 ZonePlayer(sfound.
                            22/10/2013 20:15:02           Sonos     FindZonePlayers for zoneplayer Kiani found IconURL http://192.168.1.37:1400/img/icon-S3.png
                            22/10/2013 20:15:02           Sonos     FindZonePlayers found Zone Name Kiani and Stored in ZoneInfo at Index 2 with UDN uuid:RINCON_000E587A2B0801400 Friendly Name 192.168.1.37 Sonos PLAY:and Icon living
                            22
                            /10/2013 20:15:02           Sonos     FindZonePlayers for zoneplayer Jasmine found IconURL http://192.168.1.33:1400/img/icon-S3.png
                            22/10/2013 20:15:02           Sonos     FindZonePlayers found Zone Name Jasmine and Stored in ZoneInfo at Index 1 with UDN uuid:RINCON_000E58713C2601400 Friendly Name 192.168.1.33 Sonos PLAY:and Icon masterbedroom
                            22
                            /10/2013 20:15:02           Sonos     FindZonePlayers for zoneplayer Den found IconURL http://192.168.1.34:1400/img/icon-S5.png
                            22/10/2013 20:15:02           Sonos     FindZonePlayers found Zone Name Den and Stored in ZoneInfo at Index 0 with UDN uuid:RINCON_000E5888D39601400 Friendly Name 192.168.1.34 Sonos PLAY:and Icon den
                            22
                            /10/2013 20:15:02           Sonos     FindZonePlayers Discovery succeeded3 ZonePlayer(sfound.
                            22/10/2013 20:15:01           Warning     A database 'save' was called less than 5 minutes after the system was started this is being ignored or re-queued to promote database integrity.
                            22/10/2013 20:14:59           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'1' Key being added'1'
                            22/10/2013 20:14:59           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'0' Key being added'0'
                            22/10/2013 20:14:59           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-1' Key being added'-1'
                            22/10/2013 20:14:59           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-2' Key being added'-2'
                            22/10/2013 20:14:59           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-3' Key being added'-3'
                            22/10/2013 20:14:59           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'1' Key being added'1'
                            22/10/2013 20:14:59           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'0' Key being added'0'
                            22/10/2013 20:14:59           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-1' Key being added'-1'
                            22/10/2013 20:14:59           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-2' Key being added'-2'
                            22/10/2013 20:14:59           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-3' Key being added'-3'
                            22/10/2013 20:14:57           Startup     Start up complete.
                            22/10/2013 20:14:57           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'1' Key being added'1'
                            22/10/2013 20:14:57           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'0' Key being added'0'
                            22/10/2013 20:14:57           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-1' Key being added'-1'
                            22/10/2013 20:14:57           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-2' Key being added'-2'
                            22/10/2013 20:14:57           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-3' Key being added'-3'
                            22/10/2013 20:14:57           TTS     Speak: ():Welcome to Home-Seer
                            22
                            /10/2013 20:14:57           Sonos     GetIniSection called with section NewTTSSpeakDevice and # Result = -1
                            22/10/2013 20:14:57           Sonos     SpeakIn called for Device 100Text Welcome to Home-SeerWait=TrueHost =
                            22/10/2013 20:14:57           Startup     Scripting is OK and is now running Startup.vb
                            22
                            /10/2013 20:14:57           Startup     Running the startup script Startup.vb
                            22
                            /10/2013 20:14:57           HSTouch Server     Server started on port 10200
                            22
                            /10/2013 20:14:56           Startup     Starting DDNS service...
                            22/10/2013 20:14:56           Startup     Updater services starting...
                            22/10/2013 20:14:56           Database     Opening Energy (Mode=Read Onlydatabase C:\Program Files (x86)\HomeSeer HS3\Data\Energy\Energy.hsd
                            22
                            /10/2013 20:14:56           Startup     Starting Event Scheduler...
                            22/10/2013 20:14:56           Startup     Starting the HS3 Sentry EXE
                            22
                            /10/2013 20:14:56           Speech     Listening for remote speaker connections on port 10401
                            22
                            /10/2013 20:14:56           Startup     Initializing Speaker Client Interface
                            22/10/2013 20:14:56           Startup     Start automation engine...
                            22/10/2013 20:14:55           Web Server     SSL Web Server started on port 443
                            22
                            /10/2013 20:14:55           Startup     Creating ASP.NET application host...
                            22/10/2013 20:14:55           Web Server     Web Server started on port 80
                            22
                            /10/2013 20:14:55           Web Server     UPNP Discovery started
                            22
                            /10/2013 20:14:55           Web Server     Local IP address (subnetis192.168.1.26 (255.255.255.0)
                            22/10/2013 20:14:55           Plug-In     Finished initializing plug-in Current Cost
                            22
                            /10/2013 20:14:55           Current Cost     Updating ALL projected values
                            22
                            /10/2013 20:14:55           Current Cost     Opening COM port at 57600 for newer Envi units
                            22
                            /10/2013 20:14:55           Current Cost     Current Cost Startup Complete.
                            22/10/2013 20:14:55           Current Cost     Initializing Current Cost on COM port COM1
                            22
                            /10/2013 20:14:54           Info     Plug-in Current Cost has connected successfully
                            22
                            /10/2013 20:14:54           Info     Remote application or plugin has connected127.0.0.1:52843
                            22
                            /10/2013 20:14:54           Info     Remote application or plugin has connected127.0.0.1:52842
                            22
                            /10/2013 20:14:54           Plug-In     Finished initializing plug-in DSC Security
                            22
                            /10/2013 20:14:54           DSC Security     InitIO Successful
                            22
                            /10/2013 20:14:54           DSC Security     COM Port COM3 open OK
                            22
                            /10/2013 20:14:54           DSC Security     Polling timer is disabledthe panel will not be polled.
                            22/10/2013 20:14:54           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'1' Key being added'1'
                            22/10/2013 20:14:54           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'0' Key being added'0'
                            22/10/2013 20:14:54           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-1' Key being added'-1'
                            22/10/2013 20:14:54           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-2' Key being added'-2'
                            22/10/2013 20:14:54           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-3' Key being added'-3'
                            22/10/2013 20:14:53           Info     Plug-in DSC Security has connected successfully
                            22
                            /10/2013 20:14:53           Info     Remote application or plugin has connected127.0.0.1:52836
                            22
                            /10/2013 20:14:53           Info     Remote application or plugin has connected127.0.0.1:52835
                            22
                            /10/2013 20:14:53           Plug-In     Finished initializing plug-in BLRadar
                            22
                            /10/2013 20:14:53           BLRadar start     BLRadar plug-in has been initialized
                            22
                            /10/2013 20:14:53           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'1' Key being added'1'
                            22/10/2013 20:14:53           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'0' Key being added'0'
                            22/10/2013 20:14:53           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-1' Key being added'-1'
                            22/10/2013 20:14:53           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-2' Key being added'-2'
                            22/10/2013 20:14:53           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-3' Key being added'-3'
                            22/10/2013 20:14:53           Sonos     FindZonePlayersAttempting to locate all connected ZonePlayersThis may take up to 9 seconds.
                            22/10/2013 20:14:52           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'1' Key being added'1'
                            22/10/2013 20:14:52           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'0' Key being added'0'
                            22/10/2013 20:14:52           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-1' Key being added'-1'
                            22/10/2013 20:14:52           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-2' Key being added'-2'
                            22/10/2013 20:14:52           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-3' Key being added'-3'
                            22/10/2013 20:14:52           Sonos     BuildButtonStringRef Found LinkgroupZoneSource =
                            22/10/2013 20:14:52           Sonos     InitializeSonosDevices added image /images/Sonos/sonos.jpg
                            22
                            /10/2013 20:14:52           Sonos     InitializeSonosDevices found MasterHSDeviceRef in the inifileMasterHSDeviceRef 8302
                            22
                            /10/2013 20:14:52           Sonos     Initializing Sonos Devices 
                            So basically the below error comes up in the log for each of my 7 zones:

                            PHP Code:
                            22/10/2013 20:20:12           Sonos Error     Error in MediaRenderer.Services for zoneplayer Office with UPNP Error = -2147219524Unknown error typeOrgError=-2147220224. Error=Exception from HRESULT0x80040500 
                            These are a mixture of different devices: Play:3, Play:5, Connect and Connnect:Amp. All running latest Sonos SW.

                            Also, not sure if it matters, but I am running HS2 and HS3 simultaneously (although on two different machines).

                            Hope this helps. Let me know if you need anything else.
                            Nicolai L

                            Comment


                              #44
                              Originally posted by NicolaiL View Post
                              Hi,

                              Pings are now acceptable, but yes, still getting errors. HS2 also gives errors. They looks like this:

                              PHP Code:
                              22/10/2013 20:12:47     SonosController     ERROR in myDeviceFinderCallback_DeviceFound for KianiCall back wwrong Device pointerExpected 654197448 530099880
                              22
                              /10/2013 20:12:47     SonosController     ERROR in myDeviceFinderCallback_DeviceFound for JasmineCall back wwrong Device pointerExpected 532005080 653623672 
                              On HS3 I get the following when starting:

                              PHP Code:
                              22/10/2013 20:16:15           Sonos     GetPagePlugin for SonosControl called with pageName SonosConfig and user = default and userRights and queryString =
                              22/10/2013 20:16:15           Sonos     hspi.GetPagePlugin called for instance = and pageName SonosConfig and user = default and userRights and queryString =
                              22/10/2013 20:15:24           Sonos     GetPagePlugin for SonosControl called with pageName SonosConfig and user = default and userRights and queryString =
                              22/10/2013 20:15:24           Sonos     hspi.GetPagePlugin called for instance = and pageName SonosConfig and user = default and userRights and queryString =
                              22/10/2013 20:15:17           Web Server     Web Server authorized local login successful from192.168.1.51 User: default
                              22/10/2013 20:15:14           Sonos     InitializeSonosDevicesDone Initializing Sonos Devices
                              22
                              /10/2013 20:15:14           Sonos     [Log Entry Contains Chars Converted to Hex in Brackets{}]WriteSonosNamesToIniFile wrote new string Office{3B}:{3B}S5:|:Bedroom/Ensuite{3B}:{3B}ZP90:|:Jasmine{3B}:{3B}S3:|:Kiani{3B}:{3B}S3:|:Den{3B}:{3B}S5:|:Bathroom{3B}:{3B}ZP120:|:Kitchen/Lounge{3B}:{3B}ZP90
                              22
                              /10/2013 20:15:14           Sonos     CreateSonosControllersCreated instance of ZonePlayerController for Zoneplayer Kitchen/Lounge with index 2
                              22
                              /10/2013 20:15:14           Sonos     GetPagePlugin for Zoneplayer Kitchen/Lounge set ZoneUDN RINCON_000E58A06C2801400
                              22
                              /10/2013 20:15:14           Sonos     CreateWebLink called with ZoneUDN RINCON_000E58A06C2801400 and PageName PlayerControl000E58A06C2801400
                              22
                              /10/2013 20:15:14           Sonos     SetAdministrativeState called for device Kitchen/Lounge and Active True
                              22
                              /10/2013 20:15:14           Sonos     SetHSDeviceRefPlayer called for zone Kitchen/Lounge with HS Ref 8732
                              22
                              /10/2013 20:15:13           Sonos     InitIO Called for Instance RINCON_000E58A06C2801400
                              22
                              /10/2013 20:15:13           Info     Plug-in SONOSCONTROLLER with instance RINCON_000E58A06C2801400 has connected successfully
                              22
                              /10/2013 20:15:13           Info     Remote application or plugin has connected127.0.0.1:53033
                              22
                              /10/2013 20:15:13           Info     Remote application or plugin has connected127.0.0.1:53032
                              22
                              /10/2013 20:15:13           Sonos     AddInstance called with InstanceName RINCON_000E58A06C2801400
                              22
                              /10/2013 20:15:13           Sonos     CreateSonosControllersCreated instance of ZonePlayerController for Zoneplayer Bathroom with index 7
                              22
                              /10/2013 20:15:13           Sonos     GetPagePlugin for Zoneplayer Bathroom set ZoneUDN RINCON_000E583BF06601400
                              22
                              /10/2013 20:15:13           Sonos     CreateWebLink called with ZoneUDN RINCON_000E583BF06601400 and PageName PlayerControl000E583BF06601400
                              22
                              /10/2013 20:15:13           Sonos     SetAdministrativeState called for device Bathroom and Active True
                              22
                              /10/2013 20:15:13           Sonos     SetHSDeviceRefPlayer called for zone Bathroom with HS Ref 7969
                              22
                              /10/2013 20:15:12           Sonos     InitIO Called for Instance RINCON_000E583BF06601400
                              22
                              /10/2013 20:15:12           Info     Plug-in SONOSCONTROLLER with instance RINCON_000E583BF06601400 has connected successfully
                              22
                              /10/2013 20:15:12           Info     Remote application or plugin has connected127.0.0.1:53031
                              22
                              /10/2013 20:15:12           Info     Remote application or plugin has connected127.0.0.1:53030
                              22
                              /10/2013 20:15:12           Sonos     AddInstance called with InstanceName RINCON_000E583BF06601400
                              22
                              /10/2013 20:15:11           Sonos     CreateSonosControllersCreated instance of ZonePlayerController for Zoneplayer Den with index 1
                              22
                              /10/2013 20:15:11           Sonos     GetPagePlugin for Zoneplayer Den set ZoneUDN RINCON_000E5888D39601400
                              22
                              /10/2013 20:15:11           Sonos     CreateWebLink called with ZoneUDN RINCON_000E5888D39601400 and PageName PlayerControl000E5888D39601400
                              22
                              /10/2013 20:15:11           Sonos     [Log Entry Contains Chars Converted to Hex in Brackets{}]HS updated in UpdateHSHS Code 7841 Info = {3C}table{3E}{3C}tr{3E}{3C}td{3E}{3C}img src=/Sonos/images/noart.png height="150" width="150" {3E}{3C}/td{3E}{3C}td{3E}{3C}p{3E}Stop{3C}/p{3E}{3C}p{3E}Lastfm{3C}/p{3E}{3C}p{3E}pop Tag Radio{3C}/p{3E}{3C}p{3E}{3C}/p{3E}{3C}p{3E}{3C}/p{3E}{3C}/td{3E}{3C}/tr{3E}{3C}/table{3E}
                              22/10/2013 20:15:11           Sonos     ArtworkURL Set for ZoneName DenAlbum http://192.168.1.26:80/Sonos/images/noart.png
                              22/10/2013 20:15:11           Sonos     ArtworkURL is setting HS Status for ZoneName Den with Value http://192.168.1.26:80/Sonos/images/noart.png and HSRef = 1484
                              22/10/2013 20:15:11           Sonos     Album Set for ZoneName DenAlbum =
                              22/10/2013 20:15:11           Sonos     Artist Set for ZoneName DenArtist =
                              22/10/2013 20:15:11           Sonos     Track Set for ZoneName DenTrack pop Tag Radio
                              22
                              /10/2013 20:15:11           Sonos     PlayChangeNotifyCallback called for Zone Den with ChangeType PlayStatusChanged and Changevalue stopped
                              22
                              /10/2013 20:15:11           Sonos     PlayChangeNotifyCallback called for Zone Den with ChangeType SongChanged and Changevalue stopped
                              22
                              /10/2013 20:15:11           Sonos     CurrentPlayerState Set for ZoneName DenValue stopped
                              22
                              /10/2013 20:15:11           Sonos     Den TrackInfo(Source) = Lastfm
                              22
                              /10/2013 20:15:11           Sonos     UpdateRadioStationsInfo updated RadioStation LastFM pop Tag Radio for Zone Den
                              22
                              /10/2013 20:15:11           Sonos     [Log Entry Contains Chars Converted to Hex in Brackets{}]CreateRadioStationDatabase called with C:\Program Files (x86)\HomeSeer HS3\html\Sonos\MusicDb\SonosRadioStationsDB.mdb and Provider=Microsoft.Jet.OLEDB.4.0{3B}Data Source=C:\Program Files (x86)\HomeSeer HS3\html\Sonos\MusicDb\SonosRadioStationsDB.mdb for zoneplayer Den
                              22
                              /10/2013 20:15:11           Sonos     [Log Entry Contains Chars Converted to Hex in Brackets{}]UpdateRadioStationsInfo called for Zone Den with CurrentURI lastfm://globaltags/pop and CurrentURIMetaData = {3C}DIDL-Lite xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:r="urn:schemas-rinconnetworks-com:metadata-1-0/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/"{3E}{3C}item id="RP:SA_RINCON11_LegolasHaifisch:0:LFM%3aTAG%3apop" parentID="RECENT" restricted="true"{3E}{3C}dc:title{3E}pop Tag Radio{3C}/dc:title{3E}{3C}upnp:class{3E}object.item.audioItem.audioBroadcast{3C}/upnp:class{3E}{3C}desc id="cdudn" nameSpace="urn:schemas-rinconnetworks-com:metadata-1-0/"{3E}SA_RINCON11_LegolasHaifisch{3C}/desc{3E}{3C}/item{3E}{3C}/DIDL-Lite{3E}
                              22/10/2013 20:15:11           Sonos     Den TrackInfo (title) = pop Tag Radio
                              22
                              /10/2013 20:15:11           Sonos     Den TrackInfo (MediaInfo/Title) = pop Tag Radio
                              22
                              /10/2013 20:15:11           Sonos     [Log Entry Contains Chars Converted to Hex in Brackets{}]Den TrackInfo (CurrentURI) = lastfm://globaltags/pop and TrackInfo (CurrentURIMetaData) = {3C}DIDL-Lite xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:r="urn:schemas-rinconnetworks-com:metadata-1-0/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/"{3E}{3C}item id="RP:SA_RINCON11_LegolasHaifisch:0:LFM%3aTAG%3apop" parentID="RECENT" restricted="true"{3E}{3C}dc:title{3E}pop Tag Radio{3C}/dc:title{3E}{3C}upnp:class{3E}object.item.audioItem.audioBroadcast{3C}/upnp:class{3E}{3C}desc id="cdudn" nameSpace="urn:schemas-rinconnetworks-com:metadata-1-0/"{3E}SA_RINCON11_LegolasHaifisch{3C}/desc{3E}{3C}/item{3E}{3C}/DIDL-Lite{3E}
                              22/10/2013 20:15:11           Sonos     GetcurrentTrackInfo called for zoneplayer Den
                              22
                              /10/2013 20:15:11           Sonos     MPAdd added IPAddress 192.168.1.34 and ClientName RINCON_000E5888D39601400 to its ping list. IPAddress list count 3
                              22
                              /10/2013 20:15:11           Sonos     CheckDeviceIsOnLine pinged IPAddress 192.168.1.34 successfully
                              22
                              /10/2013 20:15:11           Sonos     IPAddress for zoneplayer Den192.168.1.34
                              22
                              /10/2013 20:15:11           Sonos     PlayChangeNotifyCallback called for Zone Den with ChangeType DeviceStatusChanged and Changevalue AudioInTrue
                              22
                              /10/2013 20:15:11           Sonos     DirectConnect for zoneplayer Den found AudioInputName Audio Component
                              22
                              /10/2013 20:15:11           Sonos     GetLoudnessState called for ZonePlayer Den with values Channel=Master and DeviceStatus =Online
                              22
                              /10/2013 20:15:11           Sonos     SetMuteState is setting HS Status Mute for ZoneName Den with Value False and HSRef 3506
                              22
                              /10/2013 20:15:11           Sonos     GetMuteState calledDeviceStatus =Online
                              22
                              /10/2013 20:15:11           Sonos     UpdateBalance is setting HS Status for ZoneName Den with Value and HSRef 6781
                              22
                              /10/2013 20:15:11           Sonos     GetVolumeLevel called for ZonePlayer Den with values Channel=RF and DeviceStatus =Online
                              22
                              /10/2013 20:15:11           Sonos     GetVolumeLevel called for ZonePlayer Den with values Channel=LF and DeviceStatus =Online
                              22
                              /10/2013 20:15:11           Sonos     SetVolume is setting HS Status Volume for ZoneName Den with Value 74 and HSRef 7463
                              22
                              /10/2013 20:15:11           Sonos     GetVolumeLevel called for ZonePlayer Den with values Channel=Master and DeviceStatus =Online
                              22
                              /10/2013 20:15:11           Sonos     DevicePropertiesCallback added for zoneplayer Den
                              22
                              /10/2013 20:15:11           Sonos     AudioInCallback added for zoneplayer Den
                              22
                              /10/2013 20:15:11           Sonos     ConnectionManagerCallback added for zoneplayer Den
                              22
                              /10/2013 20:15:11           Sonos     SystemProperties ControlCallback added for zoneplayer Den
                              22
                              /10/2013 20:15:11           Sonos     MusicServices ControlCallback added for zoneplayer Den
                              22
                              /10/2013 20:15:11           Sonos     AlarmClock ControlCallback added for zoneplayer Den
                              22
                              /10/2013 20:15:11           Sonos     GroupManagement ControlCallback added for zoneplayer Den
                              22
                              /10/2013 20:15:11           Sonos     ZoneGroupTopology ControlCallback added for zoneplayer Den
                              22
                              /10/2013 20:15:11           Sonos     ContentDirectory ControlCallback added for zoneplayer Den
                              22
                              /10/2013 20:15:11           Sonos     RenderingControlCallback added for zoneplayer Den
                              22
                              /10/2013 20:15:11           Sonos     AvTransportCallback added for zoneplayer Den
                              22
                              /10/2013 20:15:11           Sonos     ConnectionManager service added for zoneplayer Den
                              22
                              /10/2013 20:15:11           Sonos     ContentDirectory service added for zoneplayer Den
                              22
                              /10/2013 20:15:11           Sonos Error     Error in MediaRenderer.Services for zoneplayer Den with UPNP Error = -2147219524Unknown error typeOrgError=-2147220224. Error Exception from HRESULT0x80040500
                              22
                              /10/2013 20:15:11           Sonos     AVTransport service added for zoneplayer Den
                              22
                              /10/2013 20:15:11           Sonos     ConnectionManager service added for zoneplayer Den
                              22
                              /10/2013 20:15:11           Sonos     RenderingControl service added for zoneplayer Den
                              22
                              /10/2013 20:15:11           Sonos     Additional services found for Den with ID urn:tencent-com:serviceId:QPlay
                              22
                              /10/2013 20:15:11           Sonos     GroupManagement service added for zoneplayer Den
                              22
                              /10/2013 20:15:11           Sonos     ZoneGroupTopology service added for zoneplayer Den
                              22
                              /10/2013 20:15:11           Sonos     SystemProperties service added for zoneplayer Den
                              22
                              /10/2013 20:15:11           Sonos     DeviceProperties service added for zoneplayer Den
                              22
                              /10/2013 20:15:11           Sonos     AudioIN service added for zoneplayer Den
                              22
                              /10/2013 20:15:11           Sonos     MusicServices service added for zoneplayer Den
                              22
                              /10/2013 20:15:11           Sonos     AlarmClock service added for zoneplayer Den
                              22
                              /10/2013 20:15:11           Sonos     Den MediaRenderer Friendly Name Den Sonos PLAY:5 Media Renderer
                              22
                              /10/2013 20:15:11           Sonos     Den MediaServer Friendly Name uuid:RINCON_000E5888D39601400_MS
                              22
                              /10/2013 20:15:10           Sonos     DirectConnect for zoneplayer Den added Image = /images/Sonos/PlayerIcon_S5.png for HSRef 7841
                              22
                              /10/2013 20:15:10           Sonos     DirectConnect for zoneplayer Den found Icon already stored at /images/Sonos/PlayerIcon_S5.png
                              22
                              /10/2013 20:15:10           Sonos     DirectConnect for zoneplayer Den checking for file C:\Program Files (x86)\HomeSeer HS3\html/images/Sonos/PlayerIcon_S5.png
                              22
                              /10/2013 20:15:10           Sonos     DirectConnect for zoneplayer Den found IconURL http://192.168.1.34:1400/img/icon-S5.png
                              22/10/2013 20:15:10           Sonos     DirectConnect called for Zone Den with device name uuid:RINCON_000E5888D39601400 and Model S5
                              22
                              /10/2013 20:15:10           Sonos     SetAdministrativeState called for device Den and Active True
                              22
                              /10/2013 20:15:10           Sonos     SetHSDeviceRefPlayer called for zone Den with HS Ref 7841
                              22
                              /10/2013 20:15:09           Sonos     InitIO Called for Instance RINCON_000E5888D39601400
                              22
                              /10/2013 20:15:09           Info     Plug-in SONOSCONTROLLER with instance RINCON_000E5888D39601400 has connected successfully
                              22
                              /10/2013 20:15:09           Info     Remote application or plugin has connected127.0.0.1:52990
                              22
                              /10/2013 20:15:09           Info     Remote application or plugin has connected127.0.0.1:52989
                              22
                              /10/2013 20:15:09           Sonos     AddInstance called with InstanceName RINCON_000E5888D39601400
                              22
                              /10/2013 20:15:09           Sonos     CreateSonosControllersCreated instance of ZonePlayerController for Zoneplayer Kiani with index 6
                              22
                              /10/2013 20:15:09           Sonos     GetPagePlugin for Zoneplayer Kiani set ZoneUDN RINCON_000E587A2B0801400
                              22
                              /10/2013 20:15:09           Sonos     CreateWebLink called with ZoneUDN RINCON_000E587A2B0801400 and PageName PlayerControl000E587A2B0801400
                              22
                              /10/2013 20:15:09           Sonos     [Log Entry Contains Chars Converted to Hex in Brackets{}]HS updated in UpdateHSHS Code 5817 Info = {3C}table{3E}{3C}tr{3E}{3C}td{3E}{3C}img src=/Sonos/images/noart.png height="150" width="150" {3E}{3C}/td{3E}{3C}td{3E}{3C}p{3E}Stop{3C}/p{3E}{3C}p{3E}Unknown{3C}/p{3E}{3C}p{3E}{3C}/p{3E}{3C}p{3E}{3C}/p{3E}{3C}p{3E}{3C}/p{3E}{3C}/td{3E}{3C}/tr{3E}{3C}/table{3E}
                              22/10/2013 20:15:09           Sonos     ArtworkURL Set for ZoneName KianiAlbum http://192.168.1.26:80/Sonos/images/noart.png
                              22/10/2013 20:15:09           Sonos     ArtworkURL is setting HS Status for ZoneName Kiani with Value http://192.168.1.26:80/Sonos/images/noart.png and HSRef = 4350
                              22/10/2013 20:15:09           Sonos     Album Set for ZoneName KianiAlbum =
                              22/10/2013 20:15:09           Sonos     Artist Set for ZoneName KianiArtist =
                              22/10/2013 20:15:09           Sonos     Track Set for ZoneName KianiTrack =
                              22/10/2013 20:15:09           Sonos     PlayChangeNotifyCallback called for Zone Kiani with ChangeType PlayStatusChanged and Changevalue stopped
                              22
                              /10/2013 20:15:09           Sonos     PlayChangeNotifyCallback called for Zone Kiani with ChangeType SongChanged and Changevalue stopped
                              22
                              /10/2013 20:15:09           Sonos     CurrentPlayerState Set for ZoneName KianiValue stopped
                              22
                              /10/2013 20:15:09           Sonos     Kiani TrackInfo(Source) = Unknown
                              22
                              /10/2013 20:15:09           Sonos     Kiani TrackInfo (CurrentURI) = and TrackInfo (CurrentURIMetaData) =
                              22/10/2013 20:15:09           Sonos     GetcurrentTrackInfo called for zoneplayer Kiani
                              22
                              /10/2013 20:15:09           Sonos     MPAdd added IPAddress 192.168.1.37 and ClientName RINCON_000E587A2B0801400 to its ping list. IPAddress list count 2
                              22
                              /10/2013 20:15:08           Sonos     CheckDeviceIsOnLine pinged IPAddress 192.168.1.37 successfully
                              22
                              /10/2013 20:15:08           Sonos     IPAddress for zoneplayer Kiani192.168.1.37
                              22
                              /10/2013 20:15:08           Sonos     GetLoudnessState called for ZonePlayer Kiani with values Channel=Master and DeviceStatus =Online
                              22
                              /10/2013 20:15:08           Sonos     SetMuteState is setting HS Status Mute for ZoneName Kiani with Value False and HSRef 1941
                              22
                              /10/2013 20:15:08           Sonos     GetMuteState calledDeviceStatus =Online
                              22
                              /10/2013 20:15:08           Sonos     UpdateBalance is setting HS Status for ZoneName Kiani with Value and HSRef 7895
                              22
                              /10/2013 20:15:08           Sonos     GetVolumeLevel called for ZonePlayer Kiani with values Channel=RF and DeviceStatus =Online
                              22
                              /10/2013 20:15:08           Sonos     GetVolumeLevel called for ZonePlayer Kiani with values Channel=LF and DeviceStatus =Online
                              22
                              /10/2013 20:15:08           Sonos     SetVolume is setting HS Status Volume for ZoneName Kiani with Value 44 and HSRef 5054
                              22
                              /10/2013 20:15:08           Sonos     GetVolumeLevel called for ZonePlayer Kiani with values Channel=Master and DeviceStatus =Online
                              22
                              /10/2013 20:15:08           Sonos     DevicePropertiesCallback added for zoneplayer Kiani
                              22
                              /10/2013 20:15:08           Sonos     ConnectionManagerCallback added for zoneplayer Kiani
                              22
                              /10/2013 20:15:08           Sonos     SystemProperties ControlCallback added for zoneplayer Kiani
                              22
                              /10/2013 20:15:08           Sonos     MusicServices ControlCallback added for zoneplayer Kiani
                              22
                              /10/2013 20:15:08           Sonos     AlarmClock ControlCallback added for zoneplayer Kiani
                              22
                              /10/2013 20:15:08           Sonos     GroupManagement ControlCallback added for zoneplayer Kiani
                              22
                              /10/2013 20:15:08           Sonos     ZoneGroupTopology ControlCallback added for zoneplayer Kiani
                              22
                              /10/2013 20:15:08           Sonos     ContentDirectory ControlCallback added for zoneplayer Kiani
                              22
                              /10/2013 20:15:08           Sonos     RenderingControlCallback added for zoneplayer Kiani
                              22
                              /10/2013 20:15:08           Sonos     AvTransportCallback added for zoneplayer Kiani
                              22
                              /10/2013 20:15:08           Sonos     ConnectionManager service added for zoneplayer Kiani
                              22
                              /10/2013 20:15:08           Sonos     ContentDirectory service added for zoneplayer Kiani
                              22
                              /10/2013 20:15:08           Sonos Error     Error in MediaRenderer.Services for zoneplayer Kiani with UPNP Error = -2147219524Unknown error typeOrgError=-2147220224. Error Exception from HRESULT0x80040500
                              22
                              /10/2013 20:15:08           Sonos     AVTransport service added for zoneplayer Kiani
                              22
                              /10/2013 20:15:08           Sonos     ConnectionManager service added for zoneplayer Kiani
                              22
                              /10/2013 20:15:08           Sonos     RenderingControl service added for zoneplayer Kiani
                              22
                              /10/2013 20:15:08           Sonos     Additional services found for Kiani with ID urn:tencent-com:serviceId:QPlay
                              22
                              /10/2013 20:15:08           Sonos     GroupManagement service added for zoneplayer Kiani
                              22
                              /10/2013 20:15:08           Sonos     ZoneGroupTopology service added for zoneplayer Kiani
                              22
                              /10/2013 20:15:08           Sonos     SystemProperties service added for zoneplayer Kiani
                              22
                              /10/2013 20:15:08           Sonos     DeviceProperties service added for zoneplayer Kiani
                              22
                              /10/2013 20:15:08           Sonos     MusicServices service added for zoneplayer Kiani
                              22
                              /10/2013 20:15:08           Sonos     AlarmClock service added for zoneplayer Kiani
                              22
                              /10/2013 20:15:08           Sonos     Kiani MediaRenderer Friendly Name Kiani Sonos PLAY:3 Media Renderer
                              22
                              /10/2013 20:15:08           Sonos     Kiani MediaServer Friendly Name uuid:RINCON_000E587A2B0801400_MS
                              22
                              /10/2013 20:15:08           Sonos     DirectConnect for zoneplayer Kiani added Image = /images/Sonos/PlayerIcon_S3.png for HSRef 5817
                              22
                              /10/2013 20:15:08           Sonos     DirectConnect for zoneplayer Kiani found Icon already stored at /images/Sonos/PlayerIcon_S3.png
                              22
                              /10/2013 20:15:08           Sonos     DirectConnect for zoneplayer Kiani checking for file C:\Program Files (x86)\HomeSeer HS3\html/images/Sonos/PlayerIcon_S3.png
                              22
                              /10/2013 20:15:08           Sonos     DirectConnect for zoneplayer Kiani found IconURL http://192.168.1.37:1400/img/icon-S3.png
                              22/10/2013 20:15:08           Sonos     DirectConnect called for Zone Kiani with device name uuid:RINCON_000E587A2B0801400 and Model S3
                              22
                              /10/2013 20:15:08           Sonos     SetAdministrativeState called for device Kiani and Active True
                              22
                              /10/2013 20:15:08           Sonos     SetHSDeviceRefPlayer called for zone Kiani with HS Ref 5817
                              22
                              /10/2013 20:15:07           Sonos     InitIO Called for Instance RINCON_000E587A2B0801400
                              22
                              /10/2013 20:15:07           Info     Plug-in SONOSCONTROLLER with instance RINCON_000E587A2B0801400 has connected successfully
                              22
                              /10/2013 20:15:07           Info     Remote application or plugin has connected127.0.0.1:52953
                              22
                              /10/2013 20:15:07           Info     Remote application or plugin has connected127.0.0.1:52952
                              22
                              /10/2013 20:15:07           Sonos     AddInstance called with InstanceName RINCON_000E587A2B0801400
                              22
                              /10/2013 20:15:07           Sonos     CreateSonosControllersCreated instance of ZonePlayerController for Zoneplayer Jasmine with index 5
                              22
                              /10/2013 20:15:06           Sonos     GetPagePlugin for Zoneplayer Jasmine set ZoneUDN RINCON_000E58713C2601400
                              22
                              /10/2013 20:15:06           Sonos     CreateWebLink called with ZoneUDN RINCON_000E58713C2601400 and PageName PlayerControl000E58713C2601400
                              22
                              /10/2013 20:15:06           Sonos     [Log Entry Contains Chars Converted to Hex in Brackets{}]HS updated in UpdateHSHS Code 5640 Info = {3C}table{3E}{3C}tr{3E}{3C}td{3E}{3C}img src=/Sonos/Artwork/Cover5_1.jpg height="150" width="150" {3E}{3C}/td{3E}{3C}td{3E}{3C}p{3E}Stop{3C}/p{3E}{3C}p{3E}Tracks{3C}/p{3E}{3C}p{3E}Counting Stars{3C}/p{3E}{3C}p{3E}OneRepublic{3C}/p{3E}{3C}p{3E}Native{3C}/p{3E}{3C}/td{3E}{3C}/tr{3E}{3C}/table{3E}
                              22/10/2013 20:15:06           Sonos     ArtworkURL Set for ZoneName JasmineAlbum http://192.168.1.26:80/Sonos/Artwork/Cover5_1.jpg
                              22/10/2013 20:15:06           Sonos     ArtworkURL is setting HS Status for ZoneName Jasmine with Value http://192.168.1.26:80/Sonos/Artwork/Cover5_1.jpg and HSRef = 4683
                              22/10/2013 20:15:06           Sonos     Album Set for ZoneName JasmineAlbum Native
                              22
                              /10/2013 20:15:06           Sonos     Artist Set for ZoneName JasmineArtist OneRepublic
                              22
                              /10/2013 20:15:06           Sonos     Track Set for ZoneName JasmineTrack Counting Stars
                              22
                              /10/2013 20:15:06           Sonos     PlayChangeNotifyCallback called for Zone Jasmine with ChangeType PlayStatusChanged and Changevalue stopped
                              22
                              /10/2013 20:15:06           Sonos     PlayChangeNotifyCallback called for Zone Jasmine with ChangeType SongChanged and Changevalue stopped
                              22
                              /10/2013 20:15:06           Sonos     CurrentPlayerState Set for ZoneName JasmineValue stopped
                              22
                              /10/2013 20:15:06           Sonos     Jasmine TrackInfo PositionInfo (% played) = 0
                              22
                              /10/2013 20:15:06           Sonos     Jasmine TrackInfo PositionInfo (Queue Position) = 1
                              22
                              /10/2013 20:15:06           Sonos     SetTrackLength set Pair for ZoneName Jasmine Old Max Range 257 New Max Range 257
                              22
                              /10/2013 20:15:06           Sonos     SetTrackLength is setting HS Status Max Position TrackPosition for ZoneName Jasmine and HSRef 1735
                              22
                              /10/2013 20:15:06           Sonos     SetTrackLength is setting HS Device TrackLength for ZoneName Jasmine with Value 257 and HSRef 8082
                              22
                              /10/2013 20:15:06           Sonos     Jasmine TrackInfo PositionInfo (Track Duration) = 0:04:17
                              22
                              /10/2013 20:15:06           Sonos     Jasmine TrackInfo PositionInfo (Track Position Seconds) = 0
                              22
                              /10/2013 20:15:06           Sonos     Jasmine TrackInfo PositionInfo (Track Position) = 0:00:00
                              22
                              /10/2013 20:15:06           Sonos     GetAlbumArtPath returned for Zone Jasmine with AlbumURI http://192.168.1.33:1400/getaa?r=1&u=npsdy:Tra.98547055.mp3 and returned path= /Sonos/Artwork/Cover5_1.jpg
                              22/10/2013 20:15:06           Sonos     GetAlbumArtPath called for zone Jasmine with AlbumURI http://192.168.1.33:1400/getaa?r=1&u=npsdy:Tra.98547055.mp3 and NextTrack = False
                              22/10/2013 20:15:06           Sonos     Jasmine TrackInfo PositionInfo (albumArtURI) = http://192.168.1.33:1400/getaa?r=1&u=npsdy:Tra.98547055.mp3
                              22/10/2013 20:15:06           Sonos     Jasmine TrackInfo PositionInfo (title) = Counting Stars
                              22
                              /10/2013 20:15:06           Sonos     Jasmine TrackInfo PositionInfo (album) = Native
                              22
                              /10/2013 20:15:06           Sonos     Jasmine TrackInfo PositionInfo (creator) = OneRepublic
                              22
                              /10/2013 20:15:06           Sonos     Jasmine TrackInfo PositionInfo (Streamcontent/Title) =
                              22/10/2013 20:15:06           Sonos     [Log Entry Contains Chars Converted to Hex in Brackets{}]GetcurrentTrackInfo called GetPositionInfo for zoneplayer Jasmine and MetaData {3C}DIDL-Lite xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:upnp="urn:schemas-upnp-org:metadata-1-0/upnp/" xmlns:r="urn:schemas-rinconnetworks-com:metadata-1-0/" xmlns="urn:schemas-upnp-org:metadata-1-0/DIDL-Lite/"{3E}{3C}item id="-1" parentID="-1" restricted="true"{3E}{3C}res protocolInfo="real.com-rhapsody-direct:*:audio/mp3:*" duration="0:04:17"{3E}npsdy:Tra.98547055.mp3{3C}/res{3E}{3C}r:streamContent{3E}{3C}/r:streamContent{3E}{3C}upnp:albumArtURI{3E}/getaa?r=1&u=npsdy%3aTra.98547055.mp3{3C}/upnp:albumArtURI{3E}{3C}dc:title{3E}Counting Stars{3C}/dc:title{3E}{3C}upnp:class{3E}object.item.audioItem.musicTrack{3C}/upnp:class{3E}{3C}dc:creator{3E}OneRepublic{3C}/dc:creator{3E}{3C}upnp:album{3E}Native{3C}/upnp:album{3E}{3C}/item{3E}{3C}/DIDL-Lite{3E}
                              22/10/2013 20:15:06           Sonos     Jasmine TrackInfo(Source) = Tracks
                              22
                              /10/2013 20:15:06           Sonos     Jasmine TrackInfo (CurrentURI) = x-rincon-queue:RINCON_000E58713C2601400#0
                              22/10/2013 20:15:06           Sonos     Jasmine TrackInfo (CurrentURI) = x-rincon-queue:RINCON_000E58713C2601400#0 and TrackInfo (CurrentURIMetaData) =
                              22/10/2013 20:15:06           Sonos     GetcurrentTrackInfo called for zoneplayer Jasmine
                              22
                              /10/2013 20:15:06           Sonos     MPAdd added IPAddress 192.168.1.33 and ClientName RINCON_000E58713C2601400 to its ping list. IPAddress list count 1
                              22
                              /10/2013 20:15:06           Sonos     CheckDeviceIsOnLine pinged IPAddress 192.168.1.33 successfully
                              22
                              /10/2013 20:15:06           Sonos     IPAddress for zoneplayer Jasmine192.168.1.33
                              22
                              /10/2013 20:15:06           Sonos     GetLoudnessState called for ZonePlayer Jasmine with values Channel=Master and DeviceStatus =Online
                              22
                              /10/2013 20:15:06           Sonos     SetMuteState is setting HS Status Mute for ZoneName Jasmine with Value False and HSRef 6545
                              22
                              /10/2013 20:15:05           Sonos     GetMuteState calledDeviceStatus =Online
                              22
                              /10/2013 20:15:05           Sonos     UpdateBalance is setting HS Status for ZoneName Jasmine with Value and HSRef 9912
                              22
                              /10/2013 20:15:05           Sonos     GetVolumeLevel called for ZonePlayer Jasmine with values Channel=RF and DeviceStatus =Online
                              22
                              /10/2013 20:15:05           Sonos     GetVolumeLevel called for ZonePlayer Jasmine with values Channel=LF and DeviceStatus =Online
                              22
                              /10/2013 20:15:05           Sonos     SetVolume is setting HS Status Volume for ZoneName Jasmine with Value and HSRef 930
                              22
                              /10/2013 20:15:05           Sonos     GetVolumeLevel called for ZonePlayer Jasmine with values Channel=Master and DeviceStatus =Online
                              22
                              /10/2013 20:15:05           Sonos     DevicePropertiesCallback added for zoneplayer Jasmine
                              22
                              /10/2013 20:15:05           Sonos     ConnectionManagerCallback added for zoneplayer Jasmine
                              22
                              /10/2013 20:15:05           Sonos     SystemProperties ControlCallback added for zoneplayer Jasmine
                              22
                              /10/2013 20:15:05           Sonos     MusicServices ControlCallback added for zoneplayer Jasmine
                              22
                              /10/2013 20:15:05           Sonos     AlarmClock ControlCallback added for zoneplayer Jasmine
                              22
                              /10/2013 20:15:05           Sonos     GroupManagement ControlCallback added for zoneplayer Jasmine
                              22
                              /10/2013 20:15:05           Sonos     ZoneGroupTopology ControlCallback added for zoneplayer Jasmine
                              22
                              /10/2013 20:15:05           Sonos     ContentDirectory ControlCallback added for zoneplayer Jasmine
                              22
                              /10/2013 20:15:05           Sonos     RenderingControlCallback added for zoneplayer Jasmine
                              22
                              /10/2013 20:15:05           Sonos     AvTransportCallback added for zoneplayer Jasmine
                              22
                              /10/2013 20:15:05           Sonos     ConnectionManager service added for zoneplayer Jasmine
                              22
                              /10/2013 20:15:05           Sonos     ContentDirectory service added for zoneplayer Jasmine
                              22
                              /10/2013 20:15:05           Sonos Error     Error in MediaRenderer.Services for zoneplayer Jasmine with UPNP Error = -2147219524Unknown error typeOrgError=-2147220224. Error Exception from HRESULT0x80040500
                              22
                              /10/2013 20:15:05           Sonos     AVTransport service added for zoneplayer Jasmine
                              22
                              /10/2013 20:15:05           Sonos     ConnectionManager service added for zoneplayer Jasmine
                              22
                              /10/2013 20:15:05           Sonos     RenderingControl service added for zoneplayer Jasmine
                              22
                              /10/2013 20:15:05           Sonos     Additional services found for Jasmine with ID urn:tencent-com:serviceId:QPlay
                              22
                              /10/2013 20:15:05           Sonos     GroupManagement service added for zoneplayer Jasmine
                              22
                              /10/2013 20:15:05           Sonos     ZoneGroupTopology service added for zoneplayer Jasmine
                              22
                              /10/2013 20:15:05           Sonos     SystemProperties service added for zoneplayer Jasmine
                              22
                              /10/2013 20:15:05           Sonos     DeviceProperties service added for zoneplayer Jasmine
                              22
                              /10/2013 20:15:05           Sonos     MusicServices service added for zoneplayer Jasmine
                              22
                              /10/2013 20:15:05           Sonos     AlarmClock service added for zoneplayer Jasmine
                              22
                              /10/2013 20:15:05           Sonos     Jasmine MediaRenderer Friendly Name Jasmine Sonos PLAY:3 Media Renderer
                              22
                              /10/2013 20:15:05           Sonos     Jasmine MediaServer Friendly Name uuid:RINCON_000E58713C2601400_MS
                              22
                              /10/2013 20:15:05           Sonos     DirectConnect for zoneplayer Jasmine added Image = /images/Sonos/PlayerIcon_S3.png for HSRef 5640
                              22
                              /10/2013 20:15:05           Sonos     DirectConnect for zoneplayer Jasmine found Icon already stored at /images/Sonos/PlayerIcon_S3.png
                              22
                              /10/2013 20:15:05           Sonos     DirectConnect for zoneplayer Jasmine checking for file C:\Program Files (x86)\HomeSeer HS3\html/images/Sonos/PlayerIcon_S3.png
                              22
                              /10/2013 20:15:05           Sonos     DirectConnect for zoneplayer Jasmine found IconURL http://192.168.1.33:1400/img/icon-S3.png
                              22/10/2013 20:15:05           Sonos     DirectConnect called for Zone Jasmine with device name uuid:RINCON_000E58713C2601400 and Model S3
                              22
                              /10/2013 20:15:05           Sonos     SetAdministrativeState called for device Jasmine and Active True
                              22
                              /10/2013 20:15:05           Sonos     SetHSDeviceRefPlayer called for zone Jasmine with HS Ref 5640
                              22
                              /10/2013 20:15:04           Sonos     InitIO Called for Instance RINCON_000E58713C2601400
                              22
                              /10/2013 20:15:04           Info     Plug-in SONOSCONTROLLER with instance RINCON_000E58713C2601400 has connected successfully
                              22
                              /10/2013 20:15:04           Info     Remote application or plugin has connected127.0.0.1:52913
                              22
                              /10/2013 20:15:04           Info     Remote application or plugin has connected127.0.0.1:52912
                              22
                              /10/2013 20:15:04           Sonos     AddInstance called with InstanceName RINCON_000E58713C2601400
                              22
                              /10/2013 20:15:04           Sonos     CreateSonosControllersCreated instance of ZonePlayerController for Zoneplayer Bedroom/Ensuite with index 4
                              22
                              /10/2013 20:15:04           Sonos     GetPagePlugin for Zoneplayer Bedroom/Ensuite set ZoneUDN RINCON_000E58A2947E01400
                              22
                              /10/2013 20:15:04           Sonos     CreateWebLink called with ZoneUDN RINCON_000E58A2947E01400 and PageName PlayerControl000E58A2947E01400
                              22
                              /10/2013 20:15:04           Sonos     SetAdministrativeState called for device Bedroom/Ensuite and Active True
                              22
                              /10/2013 20:15:04           Sonos     SetHSDeviceRefPlayer called for zone Bedroom/Ensuite with HS Ref 2564
                              22
                              /10/2013 20:15:03           Sonos     InitIO Called for Instance RINCON_000E58A2947E01400
                              22
                              /10/2013 20:15:03           Info     Plug-in SONOSCONTROLLER with instance RINCON_000E58A2947E01400 has connected successfully
                              22
                              /10/2013 20:15:03           Info     Remote application or plugin has connected127.0.0.1:52911
                              22
                              /10/2013 20:15:03           Info     Remote application or plugin has connected127.0.0.1:52910
                              22
                              /10/2013 20:15:03           Sonos     AddInstance called with InstanceName RINCON_000E58A2947E01400
                              22
                              /10/2013 20:15:03           Sonos     CreateSonosControllersCreated instance of ZonePlayerController for Zoneplayer Office with index 3
                              22
                              /10/2013 20:15:03           Sonos     GetPagePlugin for Zoneplayer Office set ZoneUDN RINCON_000E58551BA801400
                              22
                              /10/2013 20:15:03           Sonos     CreateWebLink called with ZoneUDN RINCON_000E58551BA801400 and PageName PlayerControl000E58551BA801400
                              22
                              /10/2013 20:15:03           Sonos     SetAdministrativeState called for device Office and Active True
                              22
                              /10/2013 20:15:03           Sonos     SetHSDeviceRefPlayer called for zone Office with HS Ref 2225
                              22
                              /10/2013 20:15:02           Sonos     InitIO Called for Instance RINCON_000E58551BA801400
                              22
                              /10/2013 20:15:02           Info     Plug-in SONOSCONTROLLER with instance RINCON_000E58551BA801400 has connected successfully
                              22
                              /10/2013 20:15:02           Info     Remote application or plugin has connected127.0.0.1:52901
                              22
                              /10/2013 20:15:02           Info     Remote application or plugin has connected127.0.0.1:52900
                              22
                              /10/2013 20:15:02           Sonos     AddInstance called with InstanceName RINCON_000E58551BA801400
                              22
                              /10/2013 20:15:02           Sonos     CreateSonosControllersZonePlayer in HS DB not found on-lineZoneHSRef 8732. ZoneUDN RINCON_000E58A06C2801400
                              22
                              /10/2013 20:15:02           Sonos     CreateSonosControllersZonePlayer in HS DB not found on-lineZoneHSRef 7969. ZoneUDN RINCON_000E583BF06601400
                              22
                              /10/2013 20:15:02           Sonos     CreateSonosControllersZonePlayer in HS DB not found on-lineZoneHSRef 2564. ZoneUDN RINCON_000E58A2947E01400
                              22
                              /10/2013 20:15:02           Sonos     CreateSonosControllersZonePlayer in HS DB not found on-lineZoneHSRef 2225. ZoneUDN RINCON_000E58551BA801400
                              22
                              /10/2013 20:15:02           Sonos     CreateSonosControllersfound 7 Device Codes
                              22
                              /10/2013 20:15:02           Sonos     SetDeviceStringConnected called
                              22
                              /10/2013 20:15:02           Sonos     BuildHSSonosDevicesFound Zone Name for TransportZonename Kiani
                              22
                              /10/2013 20:15:02           Sonos     BuildHSSonosDeviceslooking for Kiani in ZoneInfo and Refresh False
                              22
                              /10/2013 20:15:02           Sonos     BuildHSSonosDevicesFound Zone Name for TransportZonename Jasmine
                              22
                              /10/2013 20:15:02           Sonos     BuildHSSonosDeviceslooking for Jasmine in ZoneInfo and Refresh False
                              22
                              /10/2013 20:15:02           Sonos     BuildHSSonosDevicesFound Zone Name for TransportZonename Den
                              22
                              /10/2013 20:15:02           Sonos     BuildHSSonosDeviceslooking for Den in ZoneInfo and Refresh False
                              22
                              /10/2013 20:15:02           Sonos     FindZonePlayers Discovery succeeded3 ZonePlayer(sfound.
                              22/10/2013 20:15:02           Sonos     FindZonePlayers for zoneplayer Kiani found IconURL http://192.168.1.37:1400/img/icon-S3.png
                              22/10/2013 20:15:02           Sonos     FindZonePlayers found Zone Name Kiani and Stored in ZoneInfo at Index 2 with UDN uuid:RINCON_000E587A2B0801400 Friendly Name 192.168.1.37 Sonos PLAY:and Icon living
                              22
                              /10/2013 20:15:02           Sonos     FindZonePlayers for zoneplayer Jasmine found IconURL http://192.168.1.33:1400/img/icon-S3.png
                              22/10/2013 20:15:02           Sonos     FindZonePlayers found Zone Name Jasmine and Stored in ZoneInfo at Index 1 with UDN uuid:RINCON_000E58713C2601400 Friendly Name 192.168.1.33 Sonos PLAY:and Icon masterbedroom
                              22
                              /10/2013 20:15:02           Sonos     FindZonePlayers for zoneplayer Den found IconURL http://192.168.1.34:1400/img/icon-S5.png
                              22/10/2013 20:15:02           Sonos     FindZonePlayers found Zone Name Den and Stored in ZoneInfo at Index 0 with UDN uuid:RINCON_000E5888D39601400 Friendly Name 192.168.1.34 Sonos PLAY:and Icon den
                              22
                              /10/2013 20:15:02           Sonos     FindZonePlayers Discovery succeeded3 ZonePlayer(sfound.
                              22/10/2013 20:15:01           Warning     A database 'save' was called less than 5 minutes after the system was started this is being ignored or re-queued to promote database integrity.
                              22/10/2013 20:14:59           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'1' Key being added'1'
                              22/10/2013 20:14:59           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'0' Key being added'0'
                              22/10/2013 20:14:59           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-1' Key being added'-1'
                              22/10/2013 20:14:59           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-2' Key being added'-2'
                              22/10/2013 20:14:59           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-3' Key being added'-3'
                              22/10/2013 20:14:59           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'1' Key being added'1'
                              22/10/2013 20:14:59           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'0' Key being added'0'
                              22/10/2013 20:14:59           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-1' Key being added'-1'
                              22/10/2013 20:14:59           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-2' Key being added'-2'
                              22/10/2013 20:14:59           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-3' Key being added'-3'
                              22/10/2013 20:14:57           Startup     Start up complete.
                              22/10/2013 20:14:57           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'1' Key being added'1'
                              22/10/2013 20:14:57           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'0' Key being added'0'
                              22/10/2013 20:14:57           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-1' Key being added'-1'
                              22/10/2013 20:14:57           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-2' Key being added'-2'
                              22/10/2013 20:14:57           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-3' Key being added'-3'
                              22/10/2013 20:14:57           TTS     Speak: ():Welcome to Home-Seer
                              22
                              /10/2013 20:14:57           Sonos     GetIniSection called with section NewTTSSpeakDevice and # Result = -1
                              22/10/2013 20:14:57           Sonos     SpeakIn called for Device 100Text Welcome to Home-SeerWait=TrueHost =
                              22/10/2013 20:14:57           Startup     Scripting is OK and is now running Startup.vb
                              22
                              /10/2013 20:14:57           Startup     Running the startup script Startup.vb
                              22
                              /10/2013 20:14:57           HSTouch Server     Server started on port 10200
                              22
                              /10/2013 20:14:56           Startup     Starting DDNS service...
                              22/10/2013 20:14:56           Startup     Updater services starting...
                              22/10/2013 20:14:56           Database     Opening Energy (Mode=Read Onlydatabase C:\Program Files (x86)\HomeSeer HS3\Data\Energy\Energy.hsd
                              22
                              /10/2013 20:14:56           Startup     Starting Event Scheduler...
                              22/10/2013 20:14:56           Startup     Starting the HS3 Sentry EXE
                              22
                              /10/2013 20:14:56           Speech     Listening for remote speaker connections on port 10401
                              22
                              /10/2013 20:14:56           Startup     Initializing Speaker Client Interface
                              22/10/2013 20:14:56           Startup     Start automation engine...
                              22/10/2013 20:14:55           Web Server     SSL Web Server started on port 443
                              22
                              /10/2013 20:14:55           Startup     Creating ASP.NET application host...
                              22/10/2013 20:14:55           Web Server     Web Server started on port 80
                              22
                              /10/2013 20:14:55           Web Server     UPNP Discovery started
                              22
                              /10/2013 20:14:55           Web Server     Local IP address (subnetis192.168.1.26 (255.255.255.0)
                              22/10/2013 20:14:55           Plug-In     Finished initializing plug-in Current Cost
                              22
                              /10/2013 20:14:55           Current Cost     Updating ALL projected values
                              22
                              /10/2013 20:14:55           Current Cost     Opening COM port at 57600 for newer Envi units
                              22
                              /10/2013 20:14:55           Current Cost     Current Cost Startup Complete.
                              22/10/2013 20:14:55           Current Cost     Initializing Current Cost on COM port COM1
                              22
                              /10/2013 20:14:54           Info     Plug-in Current Cost has connected successfully
                              22
                              /10/2013 20:14:54           Info     Remote application or plugin has connected127.0.0.1:52843
                              22
                              /10/2013 20:14:54           Info     Remote application or plugin has connected127.0.0.1:52842
                              22
                              /10/2013 20:14:54           Plug-In     Finished initializing plug-in DSC Security
                              22
                              /10/2013 20:14:54           DSC Security     InitIO Successful
                              22
                              /10/2013 20:14:54           DSC Security     COM Port COM3 open OK
                              22
                              /10/2013 20:14:54           DSC Security     Polling timer is disabledthe panel will not be polled.
                              22/10/2013 20:14:54           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'1' Key being added'1'
                              22/10/2013 20:14:54           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'0' Key being added'0'
                              22/10/2013 20:14:54           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-1' Key being added'-1'
                              22/10/2013 20:14:54           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-2' Key being added'-2'
                              22/10/2013 20:14:54           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-3' Key being added'-3'
                              22/10/2013 20:14:53           Info     Plug-in DSC Security has connected successfully
                              22
                              /10/2013 20:14:53           Info     Remote application or plugin has connected127.0.0.1:52836
                              22
                              /10/2013 20:14:53           Info     Remote application or plugin has connected127.0.0.1:52835
                              22
                              /10/2013 20:14:53           Plug-In     Finished initializing plug-in BLRadar
                              22
                              /10/2013 20:14:53           BLRadar start     BLRadar plug-in has been initialized
                              22
                              /10/2013 20:14:53           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'1' Key being added'1'
                              22/10/2013 20:14:53           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'0' Key being added'0'
                              22/10/2013 20:14:53           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-1' Key being added'-1'
                              22/10/2013 20:14:53           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-2' Key being added'-2'
                              22/10/2013 20:14:53           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-3' Key being added'-3'
                              22/10/2013 20:14:53           Sonos     FindZonePlayersAttempting to locate all connected ZonePlayersThis may take up to 9 seconds.
                              22/10/2013 20:14:52           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'1' Key being added'1'
                              22/10/2013 20:14:52           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'0' Key being added'0'
                              22/10/2013 20:14:52           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-1' Key being added'-1'
                              22/10/2013 20:14:52           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-2' Key being added'-2'
                              22/10/2013 20:14:52           Warning     Exception adding a (singlepair to the collectionItem has already been addedKey in dictionary'-3' Key being added'-3'
                              22/10/2013 20:14:52           Sonos     BuildButtonStringRef Found LinkgroupZoneSource =
                              22/10/2013 20:14:52           Sonos     InitializeSonosDevices added image /images/Sonos/sonos.jpg
                              22
                              /10/2013 20:14:52           Sonos     InitializeSonosDevices found MasterHSDeviceRef in the inifileMasterHSDeviceRef 8302
                              22
                              /10/2013 20:14:52           Sonos     Initializing Sonos Devices 
                              So basically the below error comes up in the log for each of my 7 zones:

                              PHP Code:
                              22/10/2013 20:20:12           Sonos Error     Error in MediaRenderer.Services for zoneplayer Office with UPNP Error = -2147219524Unknown error typeOrgError=-2147220224. Error=Exception from HRESULT0x80040500 
                              These are a mixture of different devices: Play:3, Play:5, Connect and Connnect:Amp. All running latest Sonos SW.

                              Also, not sure if it matters, but I am running HS2 and HS3 simultaneously (although on two different machines).

                              Hope this helps. Let me know if you need anything else.
                              All benign errors, the one on mediaservices is a problem in Sonos itself, I have few postings on this, they won't show if you turn debug off because they have no negative side effect. The HS2 error on DeviceFinder is some side effect of players coming and going so your network might be better but not 100% either. Have you tried calling Sonos support? Apparently they can log in and see where you may have some stp issues. Running HS2 and HS3 simultaneously should have no negative effect.

                              Dirk.

                              Comment


                                #45
                                Originally posted by dcorsus View Post
                                All benign errors, the one on mediaservices is a problem in Sonos itself, I have few postings on this, they won't show if you turn debug off because they have no negative side effect. The HS2 error on DeviceFinder is some side effect of players coming and going so your network might be better but not 100% either. Have you tried calling Sonos support? Apparently they can log in and see where you may have some stp issues. Running HS2 and HS3 simultaneously should have no negative effect.

                                Dirk.
                                Thanks, Dirk. I've logged a ticket with Sonos now. Looks like I was only losing ping on one zone. I've also changed the layout a bit now so I only have one wireless zone left on and all other hardwires. Looks like it may remove the lost pings altogether.

                                I love Sonos, but I hate the way they insist on creating their own network and giving you zero control over it.
                                Nicolai L

                                Comment

                                Working...
                                X