Yamahareceiver Binding problems

yamahareceiver
Tags: #<Tag:0x00007fd31f524dc0>

(Ganesh) #41

Glad to hear that!


(Ganesh) #42

Regarding this binding problems, Yamaha users please feel free to report bugs here. I know that older receivers and new ones may not work with either 2.1 or 2.2 bindings. Its not a binding problem, the company changed their API. We, the OH community will fix this soon.


(Yannick Schaus) #43

Hey there! :wave:
Wish I’d see this thread sooner :disappointed:
I have the following three regressions since upgrading to the binding that shipped with 2.2 stable:

  1. My receiver (RX-V479) accepts inputs like HDMI1 and NET RADIO, those with underscores (enforced by the binding) don’t work:
07:43:18.393 [INFO ] [smarthome.event.ItemCommandEvent     ] - Item 'Yamaha_Input' received command HDMI_1
07:43:18.446 [INFO ] [smarthome.event.ItemStateChangedEvent] - Yamaha_Input changed from NET_RADIO to HDMI_1
07:43:18.634 [INFO ] [smarthome.event.ItemStateChangedEvent] - Yamaha_Input changed from HDMI_1 to NET_RADIO
...
07:43:47.200 [INFO ] [smarthome.event.ItemCommandEvent     ] - Item 'Yamaha_Input' received command HDMI1
07:43:47.233 [INFO ] [smarthome.event.ItemStateChangedEvent] - Yamaha_Input changed from NET_RADIO to HDMI1
07:43:47.397 [INFO ] [smarthome.event.ItemStateChangedEvent] - Yamaha_Input changed from HDMI1 to HDMI_1
07:43:47.427 [INFO ] [smarthome.event.ItemStateChangedEvent] - Yamaha_Surround changed from 5ch Stereo to Standard
07:43:47.423 [DEBUG] [ceiver.handler.YamahaZoneThingHandler] - Input changed to HDMI_1
...
07:52:44.223 [INFO ] [smarthome.event.ItemCommandEvent     ] - Item 'Yamaha_Input' received command NET_RADIO
07:52:44.259 [INFO ] [smarthome.event.ItemStateChangedEvent] - Yamaha_Input changed from HDMI_1 to NET_RADIO
07:52:44.465 [INFO ] [smarthome.event.ItemStateChangedEvent] - Yamaha_Input changed from NET_RADIO to HDMI_1
...
07:53:01.352 [INFO ] [smarthome.event.ItemCommandEvent     ] - Item 'Yamaha_Input' received command NET RADIO
07:53:01.415 [INFO ] [smarthome.event.ItemStateChangedEvent] - Yamaha_Input changed from HDMI_1 to NET RADIO
07:53:01.564 [DEBUG] [ceiver.handler.YamahaZoneThingHandler] - Input changed to NET_RADIO
07:53:01.664 [INFO ] [smarthome.event.ItemStateChangedEvent] - Yamaha_Input changed from NET RADIO to NET_RADIO

It also reports inputs without underscores:

<?xml version="1.0" encoding="UTF-8"?>
<YAMAHA_AV rsp="GET" RC="0">
   <Main_Zone>
      <Basic_Status>
...
         <Input>
            <Input_Sel>HDMI1</Input_Sel>
            <Input_Sel_Item_Info>
               <Param>HDMI1</Param>
               <RW>RW</RW>
               <Title>Kodi</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon004.png</On>
                  <Off />
               </Icon>
               <Src_Name />
               <Src_Number>1</Src_Number>
            </Input_Sel_Item_Info>
         </Input>
...
      </Basic_Status>
   </Main_Zone>
</YAMAHA_AV>
<?xml version="1.0" encoding="UTF-8"?>
<YAMAHA_AV rsp="GET" RC="0">
   <Main_Zone>
...
         <Input>
            <Input_Sel>NET RADIO</Input_Sel>
            <Input_Sel_Item_Info>
               <Param>NET RADIO</Param>
               <RW>RW</RW>
               <Title>NET RADIO</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon005.png</On>
                  <Off />
               </Icon>
               <Src_Name>NET_RADIO</Src_Name>
               <Src_Number>1</Src_Number>
            </Input_Sel_Item_Info>
         </Input>
...
      </Basic_Status>
   </Main_Zone>
</YAMAHA_AV>

I’ve read the discussions above and understand the need for those shenanigans introduced by other models, but in any case the state of the item should remain stable and not changed from the value of the command. Otherwise this breaks selection controls and menus (mappings in sitemaps) etc. So it’s fine to use the underscore alternatives but switching to e.g. HDMI_1 should change the input to the correct value on all receivers (by checking the available inputs and removing the underscore if needed).

Here’s a proposal: maybe it isn’t the cleanest way but for simplicity’s sake, maybe the binding could send both versions of HDMIx / HDMI_x and NET RADIO / NET_RADIO input to the receiver when receiving the command. One of them is going to be ignored and the other will go through.

  1. I wonder if it’s just me, but when I flip the power switch on or off (on the receiver thing/bridge or the zone thing), it immediately reverts to the previous value and only gets the proper state on the next refresh:
08:11:10.707 [INFO ] [smarthome.event.ItemCommandEvent     ] - Item 'Yamaha_Power' received command ON
08:11:10.778 [INFO ] [smarthome.event.ItemStateChangedEvent] - Yamaha_Power changed from OFF to ON
08:11:10.936 [INFO ] [smarthome.event.ItemStateChangedEvent] - Yamaha_Power changed from ON to OFF
..
08:12:01.758 [INFO ] [smarthome.event.ItemStateChangedEvent] - Yamaha_Power changed from OFF to ON

Does anyone else have this problem?

  1. I used to be able to launch Spotify playlists I have saved as favourites with this technique:

Now the binding won’t allow me because:

08:19:21.655 [DEBUG] [ceiver.handler.YamahaZoneThingHandler] - preset control not supported by Spotify
08:19:29.780 [WARN ] [ceiver.handler.YamahaZoneThingHandler] - Channel preset not working with this input!

I might file a PR to add Spotify to the list of the inputs supporting preset controls - any objections?

Thanks!


(Tomasz Maruszak) #44

Hey, @ysc few comments from my end:

  1. Myself and other also have the issues with HDMI input naming inconsistencies. This was described in earlier posts, yet I have not heard nor tested NET RADIO.
    There is a verbal proposal to fix this input HDMI mapping (that could be expanded to handle NET RADIO too). In short, the root cause is command names required by AVR and state updates names reported by AVR vary per model. The proposed improvement would be to perform initial detection and perform mapping to adjust to a particular mode.
    I could contribute a PR for this after the holiday since I got my AVR back and ready to test this. Not sure if @ganesh.ingle made any progress here.
  2. Regarding addition of preset to Spotify, I am not sure how would this work? Few months back I contributed playback functionality for Spotify (next, prev, pause, play, stop) - wouldn’t that be sufficiet for your case? It’s hard for me to image what would preset do for Spotify.

(Yannick Schaus) #45

Sure, I understand, I can live with that and a few additional rules to cope with those issues. I mostly blame myself for only noticing the add-on was completely rewritten after upgrading my productive system… Somehow it missed the release notes too.

As a matter of fact I coded a remote app for the Pebble swartwatch a while ago, if this helps I can offer how I retrieved the input names:

The output of these <Scene><Scene_Sel_Item>GetParam</Scene_Sel_Item></Scene> requests is as follows and includes both scenes (the 4 buttons you have on the receiver and the remote, at least on mine) and inputs:

<?xml version="1.0" encoding="UTF-8"?>
<YAMAHA_AV rsp="GET" RC="0">
   <Main_Zone>
      <Scene>
         <Scene_Sel_Item>
            <Item_1>
               <Param>Scene 1</Param>
               <RW>W</RW>
               <Title>BD/DVD</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon040.png</On>
                  <Off />
               </Icon>
               <Src_Name />
               <Src_Number>1</Src_Number>
            </Item_1>
            <Item_2>
               <Param>Scene 2</Param>
               <RW>W</RW>
               <Title>TV</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon044.png</On>
                  <Off />
               </Icon>
               <Src_Name />
               <Src_Number />
            </Item_2>
            <Item_3>
               <Param>Scene 3</Param>
               <RW>W</RW>
               <Title>NET</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon069.png</On>
                  <Off />
               </Icon>
               <Src_Name>NET_RADIO</Src_Name>
               <Src_Number>1</Src_Number>
            </Item_3>
            <Item_4>
               <Param>Scene 4</Param>
               <RW>W</RW>
               <Title>RADIO</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon043.png</On>
                  <Off />
               </Icon>
               <Src_Name>Tuner</Src_Name>
               <Src_Number>1</Src_Number>
            </Item_4>
            <Item_5>
               <Param>Spotify</Param>
               <RW>R</RW>
               <Title>Spotify</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon102.png</On>
                  <Off />
               </Icon>
               <Src_Name>Spotify</Src_Name>
               <Src_Number>1</Src_Number>
            </Item_5>
            <Item_6>
               <Param>JUKE</Param>
               <RW>R</RW>
               <Title>JUKE</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon103.png</On>
                  <Off />
               </Icon>
               <Src_Name>JUKE</Src_Name>
               <Src_Number>1</Src_Number>
            </Item_6>
            <Item_7>
               <Param>AirPlay</Param>
               <RW>R</RW>
               <Title>AirPlay</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon067.png</On>
                  <Off />
               </Icon>
               <Src_Name>AirPlay</Src_Name>
               <Src_Number>1</Src_Number>
            </Item_7>
            <Item_8>
               <Param>MusicCast Link</Param>
               <RW>R</RW>
               <Title>MusicCast Link</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon107.png</On>
                  <Off />
               </Icon>
               <Src_Name />
               <Src_Number />
            </Item_8>
            <Item_9>
               <Param>SERVER</Param>
               <RW>R</RW>
               <Title>SERVER</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon006.png</On>
                  <Off />
               </Icon>
               <Src_Name>SERVER</Src_Name>
               <Src_Number>1</Src_Number>
            </Item_9>
            <Item_10>
               <Param>NET RADIO</Param>
               <RW>R</RW>
               <Title>NET RADIO</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon005.png</On>
                  <Off />
               </Icon>
               <Src_Name>NET_RADIO</Src_Name>
               <Src_Number>1</Src_Number>
            </Item_10>
            <Item_11>
               <Param>Bluetooth</Param>
               <RW>R</RW>
               <Title>Bluetooth</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon105.png</On>
                  <Off />
               </Icon>
               <Src_Name>Bluetooth</Src_Name>
               <Src_Number>1</Src_Number>
            </Item_11>
            <Item_12>
               <Param>USB</Param>
               <RW>R</RW>
               <Title>USB</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon009.png</On>
                  <Off />
               </Icon>
               <Src_Name>USB</Src_Name>
               <Src_Number>1</Src_Number>
            </Item_12>
            <Item_13>
               <Param>iPod (USB)</Param>
               <RW>R</RW>
               <Title>USB</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon011.png</On>
                  <Off />
               </Icon>
               <Src_Name>iPod_USB</Src_Name>
               <Src_Number>1</Src_Number>
            </Item_13>
            <Item_14>
               <Param>TUNER</Param>
               <RW>R</RW>
               <Title>TUNER</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon008.png</On>
                  <Off />
               </Icon>
               <Src_Name>Tuner</Src_Name>
               <Src_Number>1</Src_Number>
            </Item_14>
            <Item_15>
               <Param>HDMI1</Param>
               <RW>R</RW>
               <Title>Kodi</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon004.png</On>
                  <Off />
               </Icon>
               <Src_Name />
               <Src_Number>1</Src_Number>
            </Item_15>
            <Item_16>
               <Param>HDMI2</Param>
               <RW>R</RW>
               <Title>Xbox</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon004.png</On>
                  <Off />
               </Icon>
               <Src_Name />
               <Src_Number>1</Src_Number>
            </Item_16>
            <Item_17>
               <Param>HDMI3</Param>
               <RW>R</RW>
               <Title>Freebox</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon004.png</On>
                  <Off />
               </Icon>
               <Src_Name />
               <Src_Number>1</Src_Number>
            </Item_17>
            <Item_18>
               <Param>HDMI4</Param>
               <RW>R</RW>
               <Title>HDMI4</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon004.png</On>
                  <Off />
               </Icon>
               <Src_Name />
               <Src_Number>1</Src_Number>
            </Item_18>
            <Item_19>
               <Param>HDMI5</Param>
               <RW>R</RW>
               <Title>HDMI5</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon004.png</On>
                  <Off />
               </Icon>
               <Src_Name />
               <Src_Number>1</Src_Number>
            </Item_19>
            <Item_20>
               <Param>HDMI6</Param>
               <RW>R</RW>
               <Title>HDMI6</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon004.png</On>
                  <Off />
               </Icon>
               <Src_Name />
               <Src_Number>1</Src_Number>
            </Item_20>
            <Item_21>
               <Param>AV1</Param>
               <RW>R</RW>
               <Title>AV1</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon003.png</On>
                  <Off />
               </Icon>
               <Src_Name />
               <Src_Number />
            </Item_21>
            <Item_22>
               <Param>AV2</Param>
               <RW>R</RW>
               <Title>AV2</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon003.png</On>
                  <Off />
               </Icon>
               <Src_Name />
               <Src_Number />
            </Item_22>
            <Item_23>
               <Param>AV3</Param>
               <RW>R</RW>
               <Title>AV3</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon003.png</On>
                  <Off />
               </Icon>
               <Src_Name />
               <Src_Number />
            </Item_23>
            <Item_24>
               <Param>AV4</Param>
               <RW>R</RW>
               <Title>AV4</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon003.png</On>
                  <Off />
               </Icon>
               <Src_Name />
               <Src_Number />
            </Item_24>
            <Item_25>
               <Param>AUDIO1</Param>
               <RW>R</RW>
               <Title>AUDIO1</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon002.png</On>
                  <Off />
               </Icon>
               <Src_Name />
               <Src_Number />
            </Item_25>
            <Item_26>
               <Param>AUDIO2</Param>
               <RW>R</RW>
               <Title>AUDIO2</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon002.png</On>
                  <Off />
               </Icon>
               <Src_Name />
               <Src_Number />
            </Item_26>
            <Item_27>
               <Param>AUX</Param>
               <RW>R</RW>
               <Title>AUX</Title>
               <Icon>
                  <On>/YamahaRemoteControl/Icons/icon104.png</On>
                  <Off />
               </Icon>
               <Src_Name />
               <Src_Number />
            </Item_27>
         </Scene_Sel_Item>
      </Scene>
   </Main_Zone>
</YAMAHA_AV>

You can apparently distinguish between scenes and simple inputs with the <RW> element (W for scenes, R for inputs) and it includes the title, and what could a reliable identifier (<Param>, NOT <Src_Name>, for instance HDMI inputs don’t have a Src_Name). I don’t know if this operation is supported on all devices.

Simple: Spotify presets are on the same list as Net Radio presets (they’re called “Network favorites” in the MusicCast app, see my post here) and the receiver switches inputs if necessary, the binding simply doesn’t need to block the preset selection when on the Spotify input because this actually works the same. This used to work without problems with the old binding.


(Ganesh) #46

Thanks Yannick for joining the thread. I have temporarily reverted back to 2.1.0 binding.
Owners of older receivers, may try 2.1.0 binding compiled for 2.2.0. It works with OH 2.2.0 stable release and Yamaha RX475 receiver from 2012. Auto discovery somehow didn’t work for me, I had to manually add a thing with receiver’s IP address.

Going forward we should fix the 2.2.0 binding to accommodate all generations of Yamaha receivers. I am also planing to support development of Yamaha MusicCast binding myself, soon.
Meanwhile @zarusz and @David_Graeff try to give users some temporary solution for this naming issue. I will join you on this one soon, and maybe you can join me on MusicCast binding.


(Tomasz Maruszak) #47

Regarding the input fix, I made further improvements based on my initial changes (see earlier posts):

  1. Made the default user mapping setting empty. With 2) in place, this user mapping should only be needed in some edge cases and older AVR. The addon readme has been updated with explanations how to debug and customize this if anyone runs into input issues again. Any mapping here takes precedence over next points (the user knows better).
  2. Added discovery if input names are NET RADIO, HDMIx, AUDIOx (via same method proposed by @ysc), if so the mapping logic for old models will not be executed (it used to change HDMI1 to HDMI_1).
  3. The last step that fires is the existing logic (customized for older models?).

Regarding enabling preset for Spotify, I have included that as well.

Could you please verify on your AVRs please (@ysc, @ganesh.ingle)?
I tested on my Yamaha and all works fine now.

How to deploy the fix?

  • Make sure you are on OH 2.2.0 release.
  • Download JAR from DropBox
  • Drop the JAR into your addons folder.
  • If needed adjust the mapping setting in the thing configuration.
  • If you had yamaha addon before, you may need to uninstall it first and do some cleanup - check earlier posts.

Debugging
If you want to see some useful logs while debugging add something like this to userdata\etc\org.ops4j.pax.logging.cfg

log4j2.logger.yamaha.name = org.openhab.binding.yamahareceiver
log4j2.logger.yamaha.level = TRACE

After binding init you should see something like this:

2017-12-28 21:54:43.542 [TRACE] [ernal.protocol.xml.InputConverterXML] - User defined mapping: supa=212a
2017-12-28 21:54:43.628 [TRACE] [ernal.protocol.xml.InputConverterXML] - These inputs will not be mapped: [Bluetooth, AUDIO1, AUDIO2, AUDIO3, HDMI6, HDMI4, NET RADIO, HDMI5, Spotify, HDMI2, HDMI3, HDMI1]

2017-12-28 21:54:43.668 [TRACE] [ernal.protocol.xml.InputConverterXML] - Converting from state name Spotify to Spotify - as per no conversion rule
2017-12-28 21:54:43.676 [TRACE] [ernal.protocol.xml.InputConverterXML] - Converting from state name JUKE to JUKE - as per legacy mapping
2017-12-28 21:54:43.678 [TRACE] [ernal.protocol.xml.InputConverterXML] - Converting from state name AirPlay to AIRPLAY - as per legacy mapping
2017-12-28 21:54:43.679 [TRACE] [ernal.protocol.xml.InputConverterXML] - Converting from state name MusicCast Link to MUSICCAST_LINK - as per legacy mapping
2017-12-28 21:54:43.708 [TRACE] [ernal.protocol.xml.InputConverterXML] - Converting from state name SERVER to SERVER - as per legacy mapping
2017-12-28 21:54:43.710 [TRACE] [ernal.protocol.xml.InputConverterXML] - Converting from state name NET RADIO to NET RADIO - as per no conversion rule
2017-12-28 21:54:43.711 [TRACE] [ernal.protocol.xml.InputConverterXML] - Converting from state name Bluetooth to Bluetooth - as per no conversion rule
2017-12-28 21:54:43.712 [TRACE] [ernal.protocol.xml.InputConverterXML] - Converting from state name USB to USB - as per legacy mapping
2017-12-28 21:54:43.713 [TRACE] [ernal.protocol.xml.InputConverterXML] - Converting from state name TUNER to TUNER - as per legacy mapping
2017-12-28 21:54:43.717 [TRACE] [ernal.protocol.xml.InputConverterXML] - Converting from state name HDMI1 to HDMI1 - as per no conversion rule
2017-12-28 21:54:43.719 [TRACE] [ernal.protocol.xml.InputConverterXML] - Converting from state name HDMI2 to HDMI2 - as per no conversion rule
2017-12-28 21:54:43.720 [TRACE] [ernal.protocol.xml.InputConverterXML] - Converting from state name HDMI3 to HDMI3 - as per no conversion rule
2017-12-28 21:54:43.721 [TRACE] [ernal.protocol.xml.InputConverterXML] - Converting from state name HDMI4 to HDMI4 - as per no conversion rule
2017-12-28 21:54:43.723 [TRACE] [ernal.protocol.xml.InputConverterXML] - Converting from state name HDMI5 to HDMI5 - as per no conversion rule
2017-12-28 21:54:43.724 [TRACE] [ernal.protocol.xml.InputConverterXML] - Converting from state name HDMI6 to HDMI6 - as per no conversion rule
2017-12-28 21:54:43.736 [TRACE] [ernal.protocol.xml.InputConverterXML] - Converting from state name AV1 to AV1 - as per legacy mapping
2017-12-28 21:54:43.738 [TRACE] [ernal.protocol.xml.InputConverterXML] - Converting from state name AV2 to AV2 - as per legacy mapping
2017-12-28 21:54:43.739 [TRACE] [ernal.protocol.xml.InputConverterXML] - Converting from state name AV3 to AV3 - as per legacy mapping
2017-12-28 21:54:43.740 [TRACE] [ernal.protocol.xml.InputConverterXML] - Converting from state name AUDIO1 to AUDIO1 - as per no conversion rule
2017-12-28 21:54:43.742 [TRACE] [ernal.protocol.xml.InputConverterXML] - Converting from state name AUDIO2 to AUDIO2 - as per no conversion rule
2017-12-28 21:54:43.743 [TRACE] [ernal.protocol.xml.InputConverterXML] - Converting from state name AUDIO3 to AUDIO3 - as per no conversion rule
2017-12-28 21:54:43.755 [TRACE] [ernal.protocol.xml.InputConverterXML] - Converting from state name AUX to AUX - as per legacy mapping
2017-12-28 21:54:43.757 [TRACE] [.protocol.xml.ZoneAvailableInputsXML] - Zone Main_Zone - available inputs: AIRPLAY, AUDIO1, AUDIO2, AUDIO3, AUX, AV1, AV2, AV3, Bluetooth, HDMI1, HDMI2, HDMI3, HDMI4, HDMI5, HDMI6, JUKE, MUSICCAST_LINK, NET RADIO, SERVER, Spotify, TUNER, USB

Note: User defined mappings have as per user defined mapping and the rest comes is the existing addon mapping logic.

After switching to HDMI 1 you should see this:

2017-12-28 20:47:33.404 [TRACE] [ernal.protocol.xml.InputConverterXML] - Converting from HDMI1 to command name HDMI1
2017-12-28 20:47:33.548 [TRACE] [ernal.protocol.xml.InputConverterXML] - Converting from state name HDMI1 to HDMI1 - as per no conversion rule
2017-12-28 20:47:33.550 [TRACE] [internal.protocol.xml.ZoneControlXML] - Zone Main_Zone state - power: true, input: HDMI1, mute: false, surroundProgram: 5ch Stereo, volume: 35.869564

(Yannick Schaus) #48

@zarusz just tested it with my RX-V479 on a brand new openHAB install and it corrects my complaints 1. and 3. above, great job, thanks!

Here’s the log just in case:

12:46:28.373 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - 'yamahareceiver:yamahaAV:f0defe0a' changed from INITIALIZING to OFFLINE (CONFIGURATION_PENDING): Waiting for data
12:46:28.375 [TRACE] [areceiver.handler.YamahaBridgeHandler] - updateAllZoneInformation
12:46:28.375 [TRACE] [ternal.protocol.xml.InputConverterXML] - User defined mapping:
12:46:28.376 [WARN ] [ternal.protocol.xml.InputConverterXML] - Invalid setting:  entry:  - KEY=VALUE format was expected
12:46:28.395 [TRACE] [nal.protocol.xml.DeviceInformationXML] - Found feature Main_Zone
12:46:28.397 [TRACE] [nal.protocol.xml.DeviceInformationXML] - Adding zone: Main_Zone
12:46:28.399 [TRACE] [nal.protocol.xml.DeviceInformationXML] - Found feature Tuner
12:46:28.400 [TRACE] [nal.protocol.xml.DeviceInformationXML] - Found feature Spotify
12:46:28.403 [INFO ] [ig.discovery.internal.PersistentInbox] - Added new thing 'yamahareceiver:zone:f0defe0a:Main_Zone' to inbox.
12:46:28.403 [INFO ] [smarthome.event.InboxAddedEvent      ] - Discovery Result with UID 'yamahareceiver:zone:f0defe0a:Main_Zone' has been added.
12:46:28.409 [TRACE] [ernal.protocol.xml.XMLProtocolService] - Zone Main_Zone - inputs: InputDto{param='Spotify', writable=true}, InputDto{param='JUKE', writable=true}, InputDto{param='AirPlay', writable=true}, InputDto{param='MusicCast Link', writable=true}, InputDto{param='SERVER', writable=true}, InputDto{param='NET RADIO', writable=true}, InputDto{param='Bluetooth', writable=true}, InputDto{param='USB', writable=true}, InputDto{param='iPod (USB)', writable=false}, InputDto{param='TUNER', writable=true}, InputDto{param='HDMI1', writable=true}, InputDto{param='HDMI2', writable=true}, InputDto{param='HDMI3', writable=true}, InputDto{param='HDMI4', writable=true}, InputDto{param='HDMI5', writable=true}, InputDto{param='HDMI6', writable=true}, InputDto{param='AV1', writable=true}, InputDto{param='AV2', writable=true}, InputDto{param='AV3', writable=true}, InputDto{param='AV4', writable=true}, InputDto{param='AUDIO1', writable=true}, InputDto{param='AUDIO2', writable=true}, InputDto{param='AUX', writable=true}
12:46:28.412 [TRACE] [ternal.protocol.xml.InputConverterXML] - These inputs will not be mapped: [Bluetooth, AUDIO1, AUDIO2, HDMI6, HDMI4, NET RADIO, HDMI5, Spotify, HDMI2, HDMI3, HDMI1]
12:46:28.430 [INFO ] [smarthome.event.ThingUpdatedEvent    ] - Thing 'yamahareceiver:yamahaAV:f0defe0a' has been updated.
12:46:28.441 [INFO ] [smarthome.event.ThingUpdatedEvent    ] - Thing 'yamahareceiver:yamahaAV:f0defe0a' has been updated.
12:46:28.443 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - 'yamahareceiver:yamahaAV:f0defe0a' changed from OFFLINE (CONFIGURATION_PENDING): Waiting for data to ONLINE
12:47:28.441 [TRACE] [areceiver.handler.YamahaBridgeHandler] - updateAllZoneInformation
12:47:28.456 [TRACE] [nal.protocol.xml.DeviceInformationXML] - Found feature Main_Zone
12:47:28.458 [TRACE] [nal.protocol.xml.DeviceInformationXML] - Adding zone: Main_Zone
12:47:28.459 [TRACE] [nal.protocol.xml.DeviceInformationXML] - Found feature Tuner
12:47:28.460 [TRACE] [nal.protocol.xml.DeviceInformationXML] - Found feature Spotify
12:47:41.139 [INFO ] [thome.event.ItemChannelLinkAddedEvent] - Link 'YamahaReceiver_Power-yamahareceiver:yamahaAV:f0defe0a:power' has been added.
12:47:41.152 [INFO ] [smarthome.event.ItemStateChangedEvent] - YamahaReceiver_Power changed from NULL to OFF
12:47:56.293 [INFO ] [smarthome.event.InboxRemovedEvent    ] - Discovery Result with UID 'yamahareceiver:zone:f0defe0a:Main_Zone' has been removed.
12:47:56.310 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - 'yamahareceiver:zone:f0defe0a:Main_Zone' changed from UNINITIALIZED to INITIALIZING
12:47:56.315 [DEBUG] [org.openhab.binding.yamahareceiver   ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.thing.type.ChannelTypeProvider}={service.id=331, service.bundleid=207, service.scope=singleton} - org.openhab.binding.yamahareceiver
12:47:56.318 [DEBUG] [org.openhab.binding.yamahareceiver   ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.thing.type.ChannelTypeProvider}={service.id=332, service.bundleid=207, service.scope=singleton} - org.openhab.binding.yamahareceiver
12:47:56.324 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - 'yamahareceiver:zone:f0defe0a:Main_Zone' changed from INITIALIZING to ONLINE
12:47:56.340 [TRACE] [ernal.protocol.xml.XMLProtocolService] - Zone Main_Zone - inputs: InputDto{param='Spotify', writable=true}, InputDto{param='JUKE', writable=true}, InputDto{param='AirPlay', writable=true}, InputDto{param='MusicCast Link', writable=true}, InputDto{param='SERVER', writable=true}, InputDto{param='NET RADIO', writable=true}, InputDto{param='Bluetooth', writable=true}, InputDto{param='USB', writable=true}, InputDto{param='iPod (USB)', writable=false}, InputDto{param='TUNER', writable=true}, InputDto{param='HDMI1', writable=true}, InputDto{param='HDMI2', writable=true}, InputDto{param='HDMI3', writable=true}, InputDto{param='HDMI4', writable=true}, InputDto{param='HDMI5', writable=true}, InputDto{param='HDMI6', writable=true}, InputDto{param='AV1', writable=true}, InputDto{param='AV2', writable=true}, InputDto{param='AV3', writable=true}, InputDto{param='AV4', writable=true}, InputDto{param='AUDIO1', writable=true}, InputDto{param='AUDIO2', writable=true}, InputDto{param='AUX', writable=true}
12:47:56.343 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name Spotify to Spotify - as per no conversion rule
12:47:56.344 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name JUKE to JUKE - as per legacy mapping
12:47:56.347 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AirPlay to AIRPLAY - as per legacy mapping
12:47:56.348 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name MusicCast Link to MUSICCAST_LINK - as per legacy mapping
12:47:56.350 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name Spotify to Spotify - as per no conversion rule
12:47:56.349 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name SERVER to SERVER - as per legacy mapping
12:47:56.352 [TRACE] [.internal.protocol.xml.ZoneControlXML] - Zone Main_Zone state - power: false, input: Spotify, mute: false, surroundProgram: 5ch Stereo, volume: 40.217392
12:47:56.352 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name NET RADIO to NET RADIO - as per no conversion rule
12:47:56.355 [DEBUG] [ceiver.handler.YamahaZoneThingHandler] - Input changed to Spotify
12:47:56.357 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name Bluetooth to Bluetooth - as per no conversion rule
12:47:56.359 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name USB to USB - as per legacy mapping
12:47:56.360 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name TUNER to TUNER - as per legacy mapping
12:47:56.361 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name HDMI1 to HDMI1 - as per no conversion rule
12:47:56.362 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name HDMI2 to HDMI2 - as per no conversion rule
12:47:56.363 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name HDMI3 to HDMI3 - as per no conversion rule
12:47:56.364 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name HDMI4 to HDMI4 - as per no conversion rule
12:47:56.365 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name HDMI5 to HDMI5 - as per no conversion rule
12:47:56.368 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name HDMI6 to HDMI6 - as per no conversion rule
12:47:56.373 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AV1 to AV1 - as per legacy mapping
12:47:56.374 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AV2 to AV2 - as per legacy mapping
12:47:56.375 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AV3 to AV3 - as per legacy mapping
12:47:56.376 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AV4 to AV4 - as per legacy mapping
12:47:56.379 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AUDIO1 to AUDIO1 - as per no conversion rule
12:47:56.380 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AUDIO2 to AUDIO2 - as per no conversion rule
12:47:56.381 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AUX to AUX - as per legacy mapping
12:47:56.382 [TRACE] [l.protocol.xml.ZoneAvailableInputsXML] - Zone Main_Zone - available inputs: AIRPLAY, AUDIO1, AUDIO2, AUX, AV1, AV2, AV3, AV4, Bluetooth, HDMI1, HDMI2, HDMI3, HDMI4, HDMI5, HDMI6, JUKE, MUSICCAST_LINK, NET RADIO, SERVER, Spotify, TUNER, USB
12:47:56.409 [INFO ] [smarthome.event.ThingUpdatedEvent    ] - Thing 'yamahareceiver:zone:f0defe0a:Main_Zone' has been updated.
12:48:28.470 [TRACE] [areceiver.handler.YamahaBridgeHandler] - updateAllZoneInformation
12:48:28.483 [TRACE] [nal.protocol.xml.DeviceInformationXML] - Found feature Main_Zone
12:48:28.487 [TRACE] [nal.protocol.xml.DeviceInformationXML] - Adding zone: Main_Zone
12:48:28.488 [TRACE] [nal.protocol.xml.DeviceInformationXML] - Found feature Tuner
12:48:28.489 [TRACE] [nal.protocol.xml.DeviceInformationXML] - Found feature Spotify
12:48:28.522 [TRACE] [ernal.protocol.xml.XMLProtocolService] - Zone Main_Zone - inputs: InputDto{param='Spotify', writable=true}, InputDto{param='JUKE', writable=true}, InputDto{param='AirPlay', writable=true}, InputDto{param='MusicCast Link', writable=true}, InputDto{param='SERVER', writable=true}, InputDto{param='NET RADIO', writable=true}, InputDto{param='Bluetooth', writable=true}, InputDto{param='USB', writable=true}, InputDto{param='iPod (USB)', writable=false}, InputDto{param='TUNER', writable=true}, InputDto{param='HDMI1', writable=true}, InputDto{param='HDMI2', writable=true}, InputDto{param='HDMI3', writable=true}, InputDto{param='HDMI4', writable=true}, InputDto{param='HDMI5', writable=true}, InputDto{param='HDMI6', writable=true}, InputDto{param='AV1', writable=true}, InputDto{param='AV2', writable=true}, InputDto{param='AV3', writable=true}, InputDto{param='AV4', writable=true}, InputDto{param='AUDIO1', writable=true}, InputDto{param='AUDIO2', writable=true}, InputDto{param='AUX', writable=true}
12:48:28.525 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name Spotify to Spotify - as per no conversion rule
12:48:28.525 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name Spotify to Spotify - as per no conversion rule
12:48:28.526 [TRACE] [.internal.protocol.xml.ZoneControlXML] - Zone Main_Zone state - power: false, input: Spotify, mute: false, surroundProgram: 5ch Stereo, volume: 40.217392
12:48:28.527 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name JUKE to JUKE - as per legacy mapping
12:48:28.528 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AirPlay to AIRPLAY - as per legacy mapping
12:48:28.529 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name MusicCast Link to MUSICCAST_LINK - as per legacy mapping
12:48:28.530 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name SERVER to SERVER - as per legacy mapping
12:48:28.531 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name NET RADIO to NET RADIO - as per no conversion rule
12:48:28.532 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name Bluetooth to Bluetooth - as per no conversion rule
12:48:28.533 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name USB to USB - as per legacy mapping
12:48:28.536 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name TUNER to TUNER - as per legacy mapping
12:48:28.538 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name HDMI1 to HDMI1 - as per no conversion rule
12:48:28.539 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name HDMI2 to HDMI2 - as per no conversion rule
12:48:28.540 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name HDMI3 to HDMI3 - as per no conversion rule
12:48:28.543 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name HDMI4 to HDMI4 - as per no conversion rule
12:48:28.546 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name HDMI5 to HDMI5 - as per no conversion rule
12:48:28.547 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name HDMI6 to HDMI6 - as per no conversion rule
12:48:28.548 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AV1 to AV1 - as per legacy mapping
12:48:28.549 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AV2 to AV2 - as per legacy mapping
12:48:28.552 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AV3 to AV3 - as per legacy mapping
12:48:28.553 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AV4 to AV4 - as per legacy mapping
12:48:28.556 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AUDIO1 to AUDIO1 - as per no conversion rule
12:48:28.557 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AUDIO2 to AUDIO2 - as per no conversion rule
12:48:28.560 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AUX to AUX - as per legacy mapping
12:48:28.561 [TRACE] [l.protocol.xml.ZoneAvailableInputsXML] - Zone Main_Zone - available inputs: AIRPLAY, AUDIO1, AUDIO2, AUX, AV1, AV2, AV3, AV4, Bluetooth, HDMI1, HDMI2, HDMI3, HDMI4, HDMI5, HDMI6, JUKE, MUSICCAST_LINK, NET RADIO, SERVER, Spotify, TUNER, USB
12:48:28.567 [INFO ] [smarthome.event.ThingUpdatedEvent    ] - Thing 'yamahareceiver:zone:f0defe0a:Main_Zone' has been updated.
12:49:23.473 [INFO ] [thome.event.ItemChannelLinkAddedEvent] - Link 'RXV479Main_Zone_Playback_channels_Preset-yamahareceiver:zone:f0defe0a:Main_Zone:playback_channels#preset' has been added.
12:49:23.477 [INFO ] [smarthome.event.ItemStateChangedEvent] - RXV479Main_Zone_Playback_channels_Preset changed from NULL to 0
12:49:28.499 [TRACE] [areceiver.handler.YamahaBridgeHandler] - updateAllZoneInformation
12:49:28.513 [TRACE] [nal.protocol.xml.DeviceInformationXML] - Found feature Main_Zone
12:49:28.515 [TRACE] [nal.protocol.xml.DeviceInformationXML] - Adding zone: Main_Zone
12:49:28.516 [TRACE] [nal.protocol.xml.DeviceInformationXML] - Found feature Tuner
12:49:28.517 [TRACE] [nal.protocol.xml.DeviceInformationXML] - Found feature Spotify
12:49:28.551 [TRACE] [ernal.protocol.xml.XMLProtocolService] - Zone Main_Zone - inputs: InputDto{param='Spotify', writable=true}, InputDto{param='JUKE', writable=true}, InputDto{param='AirPlay', writable=true}, InputDto{param='MusicCast Link', writable=true}, InputDto{param='SERVER', writable=true}, InputDto{param='NET RADIO', writable=true}, InputDto{param='Bluetooth', writable=true}, InputDto{param='USB', writable=true}, InputDto{param='iPod (USB)', writable=false}, InputDto{param='TUNER', writable=true}, InputDto{param='HDMI1', writable=true}, InputDto{param='HDMI2', writable=true}, InputDto{param='HDMI3', writable=true}, InputDto{param='HDMI4', writable=true}, InputDto{param='HDMI5', writable=true}, InputDto{param='HDMI6', writable=true}, InputDto{param='AV1', writable=true}, InputDto{param='AV2', writable=true}, InputDto{param='AV3', writable=true}, InputDto{param='AV4', writable=true}, InputDto{param='AUDIO1', writable=true}, InputDto{param='AUDIO2', writable=true}, InputDto{param='AUX', writable=true}
12:49:28.554 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name Spotify to Spotify - as per no conversion rule
12:49:28.555 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name JUKE to JUKE - as per legacy mapping
12:49:28.557 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AirPlay to AIRPLAY - as per legacy mapping
12:49:28.558 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name MusicCast Link to MUSICCAST_LINK - as per legacy mapping
12:49:28.559 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name SERVER to SERVER - as per legacy mapping
12:49:28.560 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name NET RADIO to NET RADIO - as per no conversion rule
12:49:28.561 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name Bluetooth to Bluetooth - as per no conversion rule
12:49:28.561 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name Spotify to Spotify - as per no conversion rule
12:49:28.562 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name USB to USB - as per legacy mapping
12:49:28.564 [TRACE] [.internal.protocol.xml.ZoneControlXML] - Zone Main_Zone state - power: false, input: Spotify, mute: false, surroundProgram: 5ch Stereo, volume: 40.217392
12:49:28.565 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name TUNER to TUNER - as per legacy mapping
12:49:28.566 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name HDMI1 to HDMI1 - as per no conversion rule
12:49:28.567 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name HDMI2 to HDMI2 - as per no conversion rule
12:49:28.568 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name HDMI3 to HDMI3 - as per no conversion rule
12:49:28.569 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name HDMI4 to HDMI4 - as per no conversion rule
12:49:28.570 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name HDMI5 to HDMI5 - as per no conversion rule
12:49:28.571 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name HDMI6 to HDMI6 - as per no conversion rule
12:49:28.572 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AV1 to AV1 - as per legacy mapping
12:49:28.575 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AV2 to AV2 - as per legacy mapping
12:49:28.576 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AV3 to AV3 - as per legacy mapping
12:49:28.577 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AV4 to AV4 - as per legacy mapping
12:49:28.578 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AUDIO1 to AUDIO1 - as per no conversion rule
12:49:28.579 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AUDIO2 to AUDIO2 - as per no conversion rule
12:49:28.580 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AUX to AUX - as per legacy mapping
12:49:28.581 [TRACE] [l.protocol.xml.ZoneAvailableInputsXML] - Zone Main_Zone - available inputs: AIRPLAY, AUDIO1, AUDIO2, AUX, AV1, AV2, AV3, AV4, Bluetooth, HDMI1, HDMI2, HDMI3, HDMI4, HDMI5, HDMI6, JUKE, MUSICCAST_LINK, NET RADIO, SERVER, Spotify, TUNER, USB
12:49:28.586 [INFO ] [smarthome.event.ThingUpdatedEvent    ] - Thing 'yamahareceiver:zone:f0defe0a:Main_Zone' has been updated.
12:50:14.444 [INFO ] [thome.event.ItemChannelLinkAddedEvent] - Link 'RXV479Main_Zone_Zone_channels_InputSource-yamahareceiver:zone:f0defe0a:Main_Zone:zone_channels#input' has been added.
12:50:14.447 [INFO ] [smarthome.event.ItemStateChangedEvent] - RXV479Main_Zone_Zone_channels_InputSource changed from NULL to Spotify
12:50:28.527 [TRACE] [areceiver.handler.YamahaBridgeHandler] - updateAllZoneInformation
12:50:28.541 [TRACE] [nal.protocol.xml.DeviceInformationXML] - Found feature Main_Zone
12:50:28.542 [TRACE] [nal.protocol.xml.DeviceInformationXML] - Adding zone: Main_Zone
12:50:28.544 [TRACE] [nal.protocol.xml.DeviceInformationXML] - Found feature Tuner
12:50:28.545 [TRACE] [nal.protocol.xml.DeviceInformationXML] - Found feature Spotify
12:50:28.573 [TRACE] [ernal.protocol.xml.XMLProtocolService] - Zone Main_Zone - inputs: InputDto{param='Spotify', writable=true}, InputDto{param='JUKE', writable=true}, InputDto{param='AirPlay', writable=true}, InputDto{param='MusicCast Link', writable=true}, InputDto{param='SERVER', writable=true}, InputDto{param='NET RADIO', writable=true}, InputDto{param='Bluetooth', writable=true}, InputDto{param='USB', writable=true}, InputDto{param='iPod (USB)', writable=false}, InputDto{param='TUNER', writable=true}, InputDto{param='HDMI1', writable=true}, InputDto{param='HDMI2', writable=true}, InputDto{param='HDMI3', writable=true}, InputDto{param='HDMI4', writable=true}, InputDto{param='HDMI5', writable=true}, InputDto{param='HDMI6', writable=true}, InputDto{param='AV1', writable=true}, InputDto{param='AV2', writable=true}, InputDto{param='AV3', writable=true}, InputDto{param='AV4', writable=true}, InputDto{param='AUDIO1', writable=true}, InputDto{param='AUDIO2', writable=true}, InputDto{param='AUX', writable=true}
12:50:28.575 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name Spotify to Spotify - as per no conversion rule
12:50:28.577 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name JUKE to JUKE - as per legacy mapping
12:50:28.577 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AirPlay to AIRPLAY - as per legacy mapping
12:50:28.578 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name MusicCast Link to MUSICCAST_LINK - as per legacy mapping
12:50:28.580 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name Spotify to Spotify - as per no conversion rule
12:50:28.580 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name SERVER to SERVER - as per legacy mapping
12:50:28.581 [TRACE] [.internal.protocol.xml.ZoneControlXML] - Zone Main_Zone state - power: false, input: Spotify, mute: false, surroundProgram: 5ch Stereo, volume: 40.217392
12:50:28.582 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name NET RADIO to NET RADIO - as per no conversion rule
12:50:28.586 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name Bluetooth to Bluetooth - as per no conversion rule
12:50:28.587 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name USB to USB - as per legacy mapping
12:50:28.588 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name TUNER to TUNER - as per legacy mapping
12:50:28.589 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name HDMI1 to HDMI1 - as per no conversion rule
12:50:28.590 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name HDMI2 to HDMI2 - as per no conversion rule
12:50:28.591 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name HDMI3 to HDMI3 - as per no conversion rule
12:50:28.591 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name HDMI4 to HDMI4 - as per no conversion rule
12:50:28.592 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name HDMI5 to HDMI5 - as per no conversion rule
12:50:28.593 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name HDMI6 to HDMI6 - as per no conversion rule
12:50:28.594 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AV1 to AV1 - as per legacy mapping
12:50:28.597 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AV2 to AV2 - as per legacy mapping
12:50:28.598 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AV3 to AV3 - as per legacy mapping
12:50:28.598 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AV4 to AV4 - as per legacy mapping
12:50:28.599 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AUDIO1 to AUDIO1 - as per no conversion rule
12:50:28.600 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AUDIO2 to AUDIO2 - as per no conversion rule
12:50:28.601 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name AUX to AUX - as per legacy mapping
12:50:28.602 [TRACE] [l.protocol.xml.ZoneAvailableInputsXML] - Zone Main_Zone - available inputs: AIRPLAY, AUDIO1, AUDIO2, AUX, AV1, AV2, AV3, AV4, Bluetooth, HDMI1, HDMI2, HDMI3, HDMI4, HDMI5, HDMI6, JUKE, MUSICCAST_LINK, NET RADIO, SERVER, Spotify, TUNER, USB
12:50:28.609 [INFO ] [smarthome.event.ThingUpdatedEvent    ] - Thing 'yamahareceiver:zone:f0defe0a:Main_Zone' has been updated.
12:50:29.341 [INFO ] [smarthome.event.ItemCommandEvent     ] - Item 'RXV479Main_Zone_Zone_channels_InputSource' received command NET RADIO
12:50:29.344 [INFO ] [smarthome.event.ItemStateChangedEvent] - RXV479Main_Zone_Zone_channels_InputSource changed from Spotify to NET RADIO
12:50:29.345 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from NET RADIO to command name NET RADIO
12:50:29.465 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name NET RADIO to NET RADIO - as per no conversion rule
12:50:29.467 [TRACE] [.internal.protocol.xml.ZoneControlXML] - Zone Main_Zone state - power: false, input: NET RADIO, mute: false, surroundProgram: 5ch Stereo, volume: 40.217392
12:50:29.470 [DEBUG] [ceiver.handler.YamahaZoneThingHandler] - Input changed to NET RADIO
12:50:29.472 [TRACE] [ceiver.handler.YamahaZoneThingHandler] - navigation control requested by channel
12:50:29.473 [TRACE] [ceiver.handler.YamahaZoneThingHandler] - InputWithDabBandControl requested by channel
12:50:29.474 [TRACE] [ceiver.handler.YamahaZoneThingHandler] - playback control requested by channel
12:50:29.476 [TRACE] [ceiver.handler.YamahaZoneThingHandler] - preset control requested by channel
12:50:29.488 [INFO ] [smarthome.event.ItemStateChangedEvent] - RXV479Main_Zone_Playback_channels_Preset changed from 0 to -1
12:50:44.554 [INFO ] [smarthome.event.ItemCommandEvent     ] - Item 'RXV479Main_Zone_Zone_channels_InputSource' received command SERVER
12:50:44.554 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from SERVER to command name SERVER
12:50:44.557 [INFO ] [smarthome.event.ItemStateChangedEvent] - RXV479Main_Zone_Zone_channels_InputSource changed from NET RADIO to SERVER
12:50:44.678 [TRACE] [ternal.protocol.xml.InputConverterXML] - Converting from state name SERVER to SERVER - as per legacy mapping
12:50:44.680 [TRACE] [.internal.protocol.xml.ZoneControlXML] - Zone Main_Zone state - power: false, input: SERVER, mute: false, surroundProgram: Surround Decoder, volume: 40.217392
12:50:44.682 [DEBUG] [ceiver.handler.YamahaZoneThingHandler] - Input changed to SERVER
12:50:44.683 [TRACE] [ceiver.handler.YamahaZoneThingHandler] - navigation control requested by channel
12:50:44.684 [TRACE] [ceiver.handler.YamahaZoneThingHandler] - InputWithDabBandControl requested by channel
12:50:44.686 [TRACE] [ceiver.handler.YamahaZoneThingHandler] - playback control requested by channel
12:50:44.688 [TRACE] [ceiver.handler.YamahaZoneThingHandler] - preset control requested by channel
12:50:44.690 [DEBUG] [ceiver.handler.YamahaZoneThingHandler] - preset control not supported by SERVER
12:50:44.692 [INFO ] [smarthome.event.ItemStateChangedEvent] - RXV479Main_Zone_Playback_channels_Preset changed from -1 to 0

A few comments:

  • It seems to log a warning when there is no user mapping specified (I didn’t have to):
    [WARN ] [ternal.protocol.xml.InputConverterXML] - Invalid setting: entry: - KEY=VALUE format was expected

  • I have to double-check since I don’t use that, but I recall the SERVER input accepts presets too:
    preset control not supported by SERVER
    You can add e.g. an album as a network favorite and recall it, same as Spotify.

  • This wasn’t addressed by your latest changes, but the Power switches still won’t stay in their new state after receiving a command. It’s like it queries the state too early after it changes it, and it’s not updated yet so it changes it back to the previous position. Pretty annoying if you ask me :slight_smile: Or am I the only one with this problem?

13:10:34.105 [INFO ] [smarthome.event.ItemCommandEvent     ] - Item 'RXV479Main_Zone_Zone_channels_Power' received command OFF
13:10:34.109 [INFO ] [smarthome.event.ItemStateChangedEvent] - RXV479Main_Zone_Zone_channels_Power changed from ON to OFF
13:10:34.225 [INFO ] [smarthome.event.ItemStateChangedEvent] - RXV479Main_Zone_Zone_channels_Power changed from OFF to ON
13:10:45.387 [INFO ] [smarthome.event.ItemCommandEvent     ] - Item 'RXV479Main_Zone_Zone_channels_Power' received command OFF
13:10:45.392 [INFO ] [smarthome.event.ItemStateChangedEvent] - RXV479Main_Zone_Zone_channels_Power changed from ON to OFF
13:10:59.211 [INFO ] [smarthome.event.ItemCommandEvent     ] - Item 'RXV479Main_Zone_Zone_channels_Power' received command ON
13:10:59.216 [INFO ] [smarthome.event.ItemStateChangedEvent] - RXV479Main_Zone_Zone_channels_Power changed from OFF to ON
13:10:59.341 [INFO ] [smarthome.event.ItemStateChangedEvent] - RXV479Main_Zone_Zone_channels_Power changed from ON to OFF
  • Could there be a way to check whether there have actually been changes and not update the Thing every 60 seconds if it isn’t necessary? This line is flooding the logs:
    [INFO ] [smarthome.event.ThingUpdatedEvent ] - Thing 'yamahareceiver:yamahaAV:f0defe0a' has been updated.

Again, thanks!


(Tomasz Maruszak) #49

Thanks for testing @ysc. I just updated the JAR in DropBox to accomodate your comments 1-2:

  • SERVER is now supported input for preset and playback. As per the protocol descriptor is seem to be supported (although I have not tested that on my setup):
		<Cmd_List>
			<Define ID="P1">SERVER,Play_Control,Play_Mode,Repeat</Define>
			<Define ID="P2">SERVER,Play_Control,Play_Mode,Shuffle</Define>
			<Define ID="P3">SERVER,Play_Control,Playback</Define>
			<Define ID="P4">SERVER,Play_Control,Preset,Preset_Sel</Define>
			<Define ID="P5">SERVER,List_Control,Direct_Sel</Define>
			<Define ID="P6">SERVER,List_Control,Jump_Line</Define>
			<Define ID="P7">SERVER,List_Control,Cursor</Define>
			<Define ID="P8">SERVER,List_Control,Page</Define>
			<Define ID="P9">SERVER,Play_Control,Play_URI</Define>
			<Define ID="G1">SERVER,Play_Info</Define>
			<Define ID="G2">SERVER,List_Info</Define>
			<Define ID="G3">SERVER,Config</Define>
			<Define ID="G4">SERVER,Play_Control,Preset,Preset_Sel_Item</Define>
		</Cmd_List>
  • When no user mapping provided the WARN log should no longer get generated.

Regarding comment 3, I just noticed it also happens for me. Probably the new power state is not reflected immediately after the on/off commands. The state will be refreshed after 1 minute. When I find some time, I can look into this.

Regarding comment 4, I think this could be improved, yet I do not want to perform all these fixes/improvements all at once. I suggest you post an enhancement issue on github.

EDIT:
In the DropBox I also provided the binding compiled for OH 2.3.0-snapshot.


Yamaha NetRadio binding
Preparing the openHAB 2.2 release
Yamahareceiver Binding has issue with Zone 2
(Ganesh) #50

Will test on my avr tomorrow. Thanks for the fix!


(Jean) #51

Seems this behaviour stopped since I ran an update this week.
Thank you, to whoever has fixed it!

Jean


(Hans Van Damme) #52

I installed 2.3.0-snapshot today. I can confirm it is working well with the Yamaha HTR-4067.

When trying to control playback for Spotify, I see in the log

2018-02-20 14:14:38.526 [WARN ] [eiver.handler.YamahaZoneThingHandler] - Channel playback not working with Spotify input!

Are there plans for implementing Spotify playback control?


(Tomasz Maruszak) #53

Spotify playback (next, prev, play, stop, pause) will work from this PR: https://github.com/openhab/openhab2-addons/pull/3264. If you want to give it a try here is the latest JAR build as of now.

Unfortunately, this version introduces host/port/zone config naming changes, so it will require to remove the thing and add it again (via paperUI) or changing the .thing file.


(Scott Karns) #54

I am experiencing problems with this binding after upgrading to SNAPSHOT-2.3.0.201805091233. Prior to this, I was successfully using the binding with my Yamaha HTR-4065. It appears that discovery found my receiver, but in the YamahaZoneThingHandler method isCorrectlyInitialized(), the binding throws an NPE:

2018-05-13 14:37:57.468 [DEBUG] [.internal.protocol.xml.XMLConnection] - Making POST to http://192.168.1.201:80/YamahaRemoteControl/ctrl with payload: <?xml version="1.0" encoding="utf-8"?><YAMAHA_AV cmd="GET"><System><Config>GetParam</Config></System></YAMAHA_AV>
2018-05-13 14:37:57.614 [DEBUG] [.internal.protocol.xml.XMLConnection] - Making GET to http://192.168.1.201:80/YamahaRemoteControl/desc.xml
2018-05-13 14:37:57.952 [DEBUG] [nal.protocol.xml.DeviceDescriptorXML] - Retrieved descriptor from /YamahaRemoteControl/desc.xml
2018-05-13 14:37:58.222 [DEBUG] [nal.protocol.xml.DeviceDescriptorXML] - Found system 1, zones 1, features 4
2018-05-13 14:37:58.245 [DEBUG] [.internal.protocol.xml.XMLConnection] - Making POST to http://192.168.1.201:80/YamahaRemoteControl/ctrl with payload: <?xml version="1.0" encoding="utf-8"?><YAMAHA_AV cmd="GET"><Main_Zone><Basic_Status>GetParam</Basic_Status></Main_Zone></YAMAHA_AV>
2018-05-13 14:37:58.330 [INFO ] [al.protocol.xml.DeviceInformationXML] - Found zones: [Main_Zone], features: [AIRPLAY, NET_RADIO, TUNER, USB]
2018-05-13 14:37:58.388 [DEBUG] [.internal.protocol.xml.XMLConnection] - Making POST to http://192.168.1.201:80/YamahaRemoteControl/ctrl with payload: <?xml version="1.0" encoding="utf-8"?><YAMAHA_AV cmd="GET"><Main_Zone><Input><Input_Sel_Item>GetParam</Input_Sel_Item></Input></Main_Zone></YAMAHA_AV>
2018-05-13 14:38:00.075 [DEBUG] [.internal.protocol.xml.XMLConnection] - Making POST to http://192.168.1.201:80/YamahaRemoteControl/ctrl with payload: <?xml version="1.0" encoding="utf-8"?><YAMAHA_AV cmd="GET"><System><Power_Control>GetParam</Power_Control></System></YAMAHA_AV>
2018-05-13 14:38:00.132 [WARN ] [mmon.WrappedScheduledExecutorService] - Scheduled runnable ended with an exception
java.lang.NullPointerException: null
        at org.openhab.binding.yamahareceiver.handler.YamahaZoneThingHandler.isCorrectlyInitialized(YamahaZoneThingHandler.java:196) ~[?:?]
        at org.openhab.binding.yamahareceiver.handler.YamahaBridgeHandler.updateAllZoneInformation(YamahaBridgeHandler.java:166) ~[?:?]
        at org.openhab.binding.yamahareceiver.handler.YamahaBridgeHandler.lambda$0(YamahaBridgeHandler.java:142) ~[?:?]
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:?]
        at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308) [?:?]
        at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180) [?:?]
        at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294) [?:?]
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:?]
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:?]
        at java.lang.Thread.run(Thread.java:748) [?:?]

Any insights as to what I might do to further troubleshoot, or better, fix this issue?

Thanks for your help!

[Updated logs]
I set the log level for the Yamaha binding to TRACE and changed the logging configuration to store this binding’s log output to a dedicated log file.

yamaha.log:

2018-05-13 15:48:41.494 [DEBUG] [org.openhab.binding.yamahareceiver  ] - BundleEvent STARTING - org.openhab.binding.yamahareceiver
2018-05-13 15:48:41.541 [DEBUG] [org.openhab.binding.yamahareceiver  ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.core.thing.binding.ThingHandlerFactory}={service.id=426, service.bundleid=235, service.scope=bundle, component.name=org.openhab.binding.yamahareceiver.internal.YamahaReceiverHandlerFactory, component.id=273} - org.openhab.binding.yamahareceiver
2018-05-13 15:48:41.564 [DEBUG] [org.openhab.binding.yamahareceiver  ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.discovery.UpnpDiscoveryParticipant}={service.id=427, service.bundleid=235, service.scope=bundle, component.name=org.openhab.binding.yamahareceiver.internal.discovery.YamahaDiscoveryParticipant, component.id=274} - org.openhab.binding.yamahareceiver
2018-05-13 15:48:41.571 [DEBUG] [discovery.YamahaDiscoveryParticipant] - Discovered a Yamaha Receiver 'HTR-4065 916E27' model 'HTR-4065' thing with UDN '5f9ec1b3-ed59-1900-4530-00a0de1b0fff'
2018-05-13 15:48:41.583 [DEBUG] [org.openhab.binding.yamahareceiver  ] - BundleEvent STARTED - org.openhab.binding.yamahareceiver
2018-05-13 15:48:41.862 [DEBUG] [org.openhab.binding.yamahareceiver  ] - ServiceEvent REGISTERED - {org.eclipse.smarthome.config.discovery.DiscoveryService}={service.id=428, service.bundleid=235, service.scope=singleton} - org.openhab.binding.yamahareceiver
2018-05-13 15:48:41.870 [TRACE] [receiver.handler.YamahaBridgeHandler] - Initialize of Yamaha Receiver HTR-4065 with host '192.168.1.201' and port 80
2018-05-13 15:48:41.915 [WARN ] [internal.protocol.AbstractConnection] - Protocol sniffing for Yamaha Receiver Addon is enabled. Performance may suffer! Writing to /var/lib/openhab2/yamaha_trace.log
2018-05-13 15:48:41.928 [TRACE] [receiver.handler.YamahaBridgeHandler] - updateDeviceInformation
2018-05-13 15:48:41.933 [DEBUG] [.internal.protocol.xml.XMLConnection] - Making POST to http://192.168.1.201:80/YamahaRemoteControl/ctrl with payload: <?xml version="1.0" encoding="utf-8"?><YAMAHA_AV cmd="GET"><System><Config>GetParam</Config></System></YAMAHA_AV>
2018-05-13 15:48:41.947 [TRACE] [.internal.protocol.xml.XMLConnection] - The charset UTF-8 will be used to parse the response
2018-05-13 15:48:41.956 [DEBUG] [.internal.protocol.xml.XMLConnection] - Making GET to http://192.168.1.201:80/YamahaRemoteControl/desc.xml
2018-05-13 15:48:41.998 [TRACE] [.internal.protocol.xml.XMLConnection] - The charset UTF-8 will be used to parse the response
2018-05-13 15:48:42.083 [DEBUG] [nal.protocol.xml.DeviceDescriptorXML] - Retrieved descriptor from /YamahaRemoteControl/desc.xml
2018-05-13 15:48:42.095 [TRACE] [nal.protocol.xml.DeviceDescriptorXML] - Zone Main_Zone has commands: Main_Zone,Sound_Video,Dialogue_Adjust,Dialogue_Lift;Main_Zone,Config,Name,Zone;Main_Zone,Sound_Video,Tone,Bass;System,Sound_Video,HDMI,Video,Preset_Sel,Current;Main_Zone,Scene,Scene_Sel;Main_Zone,Power_Control,Sleep;Main_Zone,Power_Control,Power;Main_Zone,Surround,Program_Sel,Current,Sound_Program;Main_Zone,Sound_Video,Adaptive_DRC;Main_Zone,Surround,Program_Sel,Current,Straight;Main_Zone,Scene,Scene_Sel_Item;Main_Zone,Input,Input_Sel_Item;Main_Zone,Volume,Lvl;Main_Zone,Sound_Video,Tone,Treble;Main_Zone,List_Control,Menu_Control;Main_Zone,Play_Control,Playback;Main_Zone,Volume,Mute;Main_Zone,Input,Input_Sel;Main_Zone,Surround,Program_Sel,Current,Enhancer;Main_Zone,Surround,_3D_Cinema_DSP;Main_Zone,Basic_Status;Main_Zone,Config;Main_Zone,Sound_Video,Direct,Mode;Main_Zone,List_Control,Cursor
2018-05-13 15:48:42.101 [TRACE] [nal.protocol.xml.DeviceDescriptorXML] - Feature TUNER has commands: Tuner,Play_Control,Tuning,Band;Tuner,Play_Control,Tuning,Freq;Tuner,Play_Control,Preset,Preset_Sel_Item;Tuner,Play_Control,Auto_Freq;Tuner,Play_Control,Tuning,Freq,FM,Val;Tuner,Play_Control,Tuning,Freq,AM;Tuner,Play_Control,Tuning,Freq,AM,Val;Tuner,Play_Control,Tuning,Freq,FM;Tuner,Play_Info;Tuner,Config;Tuner,Play_Control,Search_Mode;Tuner,Play_Control,Preset,Preset_Sel
2018-05-13 15:48:42.106 [TRACE] [nal.protocol.xml.DeviceDescriptorXML] - Feature AIRPLAY has commands: AirPlay,Play_Info;AirPlay,Play_Control,Playback;AirPlay,Config
2018-05-13 15:48:42.116 [TRACE] [nal.protocol.xml.DeviceDescriptorXML] - Feature USB has commands: USB,Play_Control,Play_Mode,Repeat;USB,Play_Control,Preset,Preset_Sel;USB,List_Control,Page;USB,Play_Info;USB,Play_Control,Play_Mode,Shuffle;USB,Play_Control,Playback;USB,List_Control,Jump_Line;USB,Play_Control,Preset,Preset_Sel_Item;USB,Config;USB,List_Control,Direct_Sel;USB,List_Control,Cursor;USB,List_Info
2018-05-13 15:48:42.125 [TRACE] [nal.protocol.xml.DeviceDescriptorXML] - Feature NET_RADIO has commands: NET_RADIO,Play_Control,Preset,Preset_Sel_Item;NET_RADIO,Play_Control,Playback;NET_RADIO,List_Control,Direct_Sel;NET_RADIO,List_Control,Page;NET_RADIO,Play_Info;NET_RADIO,Play_Control,Preset,Preset_Sel;NET_RADIO,List_Control,Jump_Line;NET_RADIO,Config;NET_RADIO,List_Control,Bookmark;NET_RADIO,List_Control,Cursor;NET_RADIO,List_Info
2018-05-13 15:48:42.127 [DEBUG] [nal.protocol.xml.DeviceDescriptorXML] - Found system 1, zones 1, features 4
2018-05-13 15:48:42.130 [DEBUG] [.internal.protocol.xml.XMLConnection] - Making POST to http://192.168.1.201:80/YamahaRemoteControl/ctrl with payload: <?xml version="1.0" encoding="utf-8"?><YAMAHA_AV cmd="GET"><Main_Zone><Basic_Status>GetParam</Basic_Status></Main_Zone></YAMAHA_AV>
2018-05-13 15:48:42.156 [TRACE] [.internal.protocol.xml.XMLConnection] - The charset UTF-8 will be used to parse the response
2018-05-13 15:48:42.163 [INFO ] [al.protocol.xml.DeviceInformationXML] - Found zones: [Main_Zone], features: [AIRPLAY, NET_RADIO, TUNER, USB]
2018-05-13 15:48:42.168 [TRACE] [receiver.handler.YamahaBridgeHandler] - updateAllZoneInformation
2018-05-13 15:48:42.170 [TRACE] [ernal.protocol.xml.InputConverterXML] - User defined mapping: 
2018-05-13 15:48:42.170 [DEBUG] [.internal.protocol.xml.XMLConnection] - Making POST to http://192.168.1.201:80/YamahaRemoteControl/ctrl with payload: <?xml version="1.0" encoding="utf-8"?><YAMAHA_AV cmd="GET"><System><Power_Control>GetParam</Power_Control></System></YAMAHA_AV>
2018-05-13 15:48:42.180 [DEBUG] [.internal.protocol.xml.XMLConnection] - Making POST to http://192.168.1.201:80/YamahaRemoteControl/ctrl with payload: <?xml version="1.0" encoding="utf-8"?><YAMAHA_AV cmd="GET"><Main_Zone><Input><Input_Sel_Item>GetParam</Input_Sel_Item></Input></Main_Zone></YAMAHA_AV>
2018-05-13 15:48:42.204 [TRACE] [.internal.protocol.xml.XMLConnection] - The charset UTF-8 will be used to parse the response
2018-05-13 15:48:42.204 [TRACE] [.internal.protocol.xml.XMLConnection] - The charset UTF-8 will be used to parse the response
2018-05-13 15:48:42.220 [TRACE] [rnal.protocol.xml.XMLProtocolService] - Zone Main_Zone - inputs: NET RADIO:RW, SERVER:RW, AirPlay:RW, USB:RW, iPod (USB):R, TUNER:RW, HDMI1:RW, HDMI2:RW, HDMI3:RW, HDMI4:RW, AV1:RW, AV2:RW, AV3:RW, AV4:RW, AV5:RW, AV6:RW, AUDIO:RW, V-AUX:RW
2018-05-13 15:48:42.229 [TRACE] [ernal.protocol.xml.InputConverterXML] - These inputs will not be mapped: [Bluetooth, HDMI4, NET RADIO, Spotify, HDMI2, HDMI3, HDMI1]

Related openhab.log:

2018-05-13 15:48:42.218 [WARN ] [mmon.WrappedScheduledExecutorService] - Scheduled runnable ended with an exception
java.lang.NullPointerException: null
        at org.openhab.binding.yamahareceiver.handler.YamahaZoneThingHandler.isCorrectlyInitialized(YamahaZoneThingHandler.java:196) ~[?:?]
        at org.openhab.binding.yamahareceiver.handler.YamahaBridgeHandler.updateAllZoneInformation(YamahaBridgeHandler.java:166) ~[?:?]
        at org.openhab.binding.yamahareceiver.handler.YamahaBridgeHandler.lambda$0(YamahaBridgeHandler.java:142) ~[?:?]
        at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [?:?]
        at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308) [?:?]
        at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180) [?:?]
        at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294) [?:?]
        at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [?:?]
        at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [?:?]
        at java.lang.Thread.run(Thread.java:748) [?:?]

(namraccr) #55

Here’s the culprit:

return zoneConfiguration.getZone() != null && zoneAvailableInputs != null && zoneControl != null;

Now the question becomes, Why is zoneConfiguration null here?


(Tomasz Maruszak) #56

@namraccr and @scottk I run into this issue today myself after upgrading to latest OH 2.3.0-SNAPSHOT. Before that I was on an older OH build and this issue did not appear.

I have a fix for this now and will be looking to push another pull request for the scene, party mode and RX-V3900 surround compatibility fix. I will be releasing my own build in other yamaha topics for users to test the features mentioned. With that I can also drop a link here to the JAR that fixes this (should be soon).

EDIT:

Here is the addon with the fix. Just remove the stock addon and add this one to the addons folder.
Can you please verify if this fixes the issue for you as well?

EDIT 2:

I ought to mention that after the upgrade you also need to adjust your thing settings because they are are now stored under a different name (see more info here). Because of that you need to set the IP/host address of your Yamaha on the Yamaha thing and assign the zone setting on each of the zone things.

If you configued via PaperUI go to > Configuration > Things > Yamaha Receiver > edit (pencil) > Address, and also Configuration > Things > Yamaha Main Zone > edit > Zone (set to ‘Main_Zone’). If you configured via the .thing file see the updated documentation here - note the host and zone are now all lower case.

In case you still have issues enable detailed logging and get back to me please.