Mar 09 09:13:00 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , alsavolume Mar 09 09:13:00 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "58" [object Object] Mar 09 09:13:00 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: set volume to integer value 58 Mar 09 09:13:00 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volValue,58 Mar 09 09:13:00 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: volume_58! Mar 09 09:13:00 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: volume_58! Mar 09 09:13:00 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , alsavolume Mar 09 09:13:00 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "71" [object Object] Mar 09 09:13:00 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: set volume to integer value 71 Mar 09 09:13:00 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volValue,71 Mar 09 09:13:00 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: volume_71! Mar 09 09:13:00 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: volume_71! Mar 09 09:13:01 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , alsavolume Mar 09 09:13:01 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "75" [object Object] Mar 09 09:13:01 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: set volume to integer value 75 Mar 09 09:13:01 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volValue,75 Mar 09 09:13:01 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: volume_75! Mar 09 09:13:01 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: volume_75! Mar 09 09:13:02 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Mar 09 09:13:02 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:03 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , alsavolume Mar 09 09:13:03 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "24" [object Object] Mar 09 09:13:03 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: set volume to integer value 24 Mar 09 09:13:03 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volValue,24 Mar 09 09:13:03 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: volume_24! Mar 09 09:13:03 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: volume_24! Mar 09 09:13:04 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , alsavolume Mar 09 09:13:04 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "26" [object Object] Mar 09 09:13:04 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: set volume to integer value 26 Mar 09 09:13:04 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volValue,26 Mar 09 09:13:04 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: volume_26! Mar 09 09:13:04 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: volume_26! Mar 09 09:13:05 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , alsavolume Mar 09 09:13:05 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "73" [object Object] Mar 09 09:13:05 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: set volume to integer value 73 Mar 09 09:13:05 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volValue,73 Mar 09 09:13:05 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: volume_73! Mar 09 09:13:05 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: volume_73! Mar 09 09:13:09 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , alsavolume Mar 09 09:13:09 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "-" [object Object] Mar 09 09:13:09 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: decrease volume by single step. Mar 09 09:13:09 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volDown Mar 09 09:13:09 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: vol_dwn! Mar 09 09:13:09 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: vol_dwn! Mar 09 09:13:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] [parser:data]: Listener received: volume=23 Mar 09 09:13:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] parser:data: call processResponse with: respVolume Mar 09 09:13:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp signaled volume is 23 Mar 09 09:13:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":23} Mar 09 09:13:10 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:10 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:10 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:10 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":23} Mar 09 09:13:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":23} Mar 09 09:13:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":23} Mar 09 09:13:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":23} Mar 09 09:13:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":23} Mar 09 09:13:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":23} Mar 09 09:13:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":23} Mar 09 09:13:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":23} Mar 09 09:13:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp Status is now {"volume":23,"mute":false,"power":"on","source":"pc_usb"} Mar 09 09:13:10 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:10 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:10 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:10 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:10 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:10 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:10 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:10 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:10 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:10 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:10 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:10 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:10 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:10 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:10 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:10 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:10 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:10 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:10 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:10 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:10 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:10 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:10 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:10 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:10 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:10 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:10 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:10 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:12 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , alsavolume Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "+" [object Object] Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: increase volume by single step. Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volUp Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: vol_up! Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: vol_up! Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] [parser:data]: Listener received: volume=24 Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] parser:data: call processResponse with: respVolume Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp signaled volume is 24 Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":24} Mar 09 09:13:12 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:12 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:12 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:12 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":24} Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp Status is now {"volume":24,"mute":false,"power":"on","source":"pc_usb"} Mar 09 09:13:12 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:12 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:12 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:12 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:12 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:12 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:12 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:12 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Mar 09 09:13:12 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:12 volumio volumio[1102]: info: Listing playlists Mar 09 09:13:12 volumio volumio[1102]: info: Listing playlists Mar 09 09:13:12 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , alsavolume Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "+" [object Object] Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: increase volume by single step. Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volUp Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: vol_up! Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: vol_up! Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] [parser:data]: Listener received: volume=25 Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] parser:data: call processResponse with: respVolume Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp signaled volume is 25 Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":25} Mar 09 09:13:12 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:12 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:12 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:12 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":25} Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp Status is now {"volume":25,"mute":false,"power":"on","source":"pc_usb"} Mar 09 09:13:12 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:12 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:12 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:12 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:12 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:12 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:12 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:12 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:13 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , alsavolume Mar 09 09:13:13 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "+" [object Object] Mar 09 09:13:13 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: increase volume by single step. Mar 09 09:13:13 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volUp Mar 09 09:13:13 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: vol_up! Mar 09 09:13:13 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: vol_up! Mar 09 09:13:13 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] [parser:data]: Listener received: volume=26 Mar 09 09:13:13 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] parser:data: call processResponse with: respVolume Mar 09 09:13:13 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp signaled volume is 26 Mar 09 09:13:13 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":26} Mar 09 09:13:13 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:13 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:13 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:13 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:13 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":26} Mar 09 09:13:13 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp Status is now {"volume":26,"mute":false,"power":"on","source":"pc_usb"} Mar 09 09:13:13 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:13 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:13 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:13 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:13 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:13 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:13 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:13 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:13 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:13 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:14 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , alsavolume Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "+" [object Object] Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: increase volume by single step. Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volUp Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: vol_up! Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: vol_up! Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] [parser:data]: Listener received: volume=27 Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] parser:data: call processResponse with: respVolume Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp signaled volume is 27 Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":27} Mar 09 09:13:14 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:14 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:14 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:14 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":27} Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp Status is now {"volume":27,"mute":false,"power":"on","source":"pc_usb"} Mar 09 09:13:14 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:14 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:14 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:14 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:14 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:14 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:14 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:14 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , alsavolume Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "+" [object Object] Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: increase volume by single step. Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volUp Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: vol_up! Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: vol_up! Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] [parser:data]: Listener received: volume=28 Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] parser:data: call processResponse with: respVolume Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp signaled volume is 28 Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":28} Mar 09 09:13:14 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:14 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:14 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:14 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":28} Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp Status is now {"volume":28,"mute":false,"power":"on","source":"pc_usb"} Mar 09 09:13:14 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:14 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:14 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:14 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:14 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:14 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:14 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:14 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , alsavolume Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "+" [object Object] Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: increase volume by single step. Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volUp Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: vol_up! Mar 09 09:13:14 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: vol_up! Mar 09 09:13:15 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , alsavolume Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "+" [object Object] Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: increase volume by single step. Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volUp Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: vol_up! Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: vol_up! Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] [parser:data]: Listener received: volume=29 Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] parser:data: call processResponse with: respVolume Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp signaled volume is 29 Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":29} Mar 09 09:13:15 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:15 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:15 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:15 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":29} Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":29} Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp Status is now {"volume":29,"mute":false,"power":"on","source":"pc_usb"} Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] [parser:data]: Listener received: volume=30 Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] parser:data: call processResponse with: respVolume Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp signaled volume is 30 Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":30} Mar 09 09:13:15 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:15 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:15 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp Status is now {"volume":30,"mute":false,"power":"on","source":"pc_usb"} Mar 09 09:13:15 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:15 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:15 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:15 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:15 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:15 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:15 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:15 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:15 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:15 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:15 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:15 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:15 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:15 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:15 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , alsavolume Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "+" [object Object] Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: increase volume by single step. Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volUp Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: vol_up! Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: vol_up! Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] [parser:data]: Listener received: volume=31 Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] parser:data: call processResponse with: respVolume Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp signaled volume is 31 Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":31} Mar 09 09:13:15 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:15 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:15 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:15 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":31} Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp Status is now {"volume":31,"mute":false,"power":"on","source":"pc_usb"} Mar 09 09:13:15 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:15 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:15 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:15 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:15 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:15 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:15 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:15 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:16 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , alsavolume Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "-" [object Object] Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: decrease volume by single step. Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volDown Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: vol_dwn! Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: vol_dwn! Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] [parser:data]: Listener received: volume=30 Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] parser:data: call processResponse with: respVolume Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp signaled volume is 30 Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":30} Mar 09 09:13:16 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:16 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:16 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:16 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":30} Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp Status is now {"volume":30,"mute":false,"power":"on","source":"pc_usb"} Mar 09 09:13:16 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:16 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:16 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:16 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:16 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:16 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:16 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:16 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , alsavolume Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "-" [object Object] Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: decrease volume by single step. Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volDown Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: vol_dwn! Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: vol_dwn! Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] [parser:data]: Listener received: volume=29 Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] parser:data: call processResponse with: respVolume Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp signaled volume is 29 Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":29} Mar 09 09:13:16 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:16 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:16 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:16 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":29} Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp Status is now {"volume":29,"mute":false,"power":"on","source":"pc_usb"} Mar 09 09:13:16 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:16 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:16 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:16 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:16 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:16 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:16 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:16 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , alsavolume Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "-" [object Object] Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: decrease volume by single step. Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volDown Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: vol_dwn! Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: vol_dwn! Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] [parser:data]: Listener received: volume=28 Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] parser:data: call processResponse with: respVolume Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp signaled volume is 28 Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":28} Mar 09 09:13:16 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:16 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:16 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:16 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":28} Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp Status is now {"volume":28,"mute":false,"power":"on","source":"pc_usb"} Mar 09 09:13:16 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:16 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:16 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:16 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:16 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:16 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:16 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:16 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , alsavolume Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "-" [object Object] Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: decrease volume by single step. Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volDown Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: vol_dwn! Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: vol_dwn! Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] [parser:data]: Listener received: volume=27 Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] parser:data: call processResponse with: respVolume Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp signaled volume is 27 Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":27} Mar 09 09:13:17 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:17 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":27} Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp Status is now {"volume":27,"mute":false,"power":"on","source":"pc_usb"} Mar 09 09:13:17 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:17 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:17 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:17 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , alsavolume Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "-" [object Object] Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: decrease volume by single step. Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volDown Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: vol_dwn! Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: vol_dwn! Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] [parser:data]: Listener received: volume=26 Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] parser:data: call processResponse with: respVolume Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp signaled volume is 26 Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":26} Mar 09 09:13:17 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:17 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":26} Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp Status is now {"volume":26,"mute":false,"power":"on","source":"pc_usb"} Mar 09 09:13:17 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:17 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:17 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:17 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , alsavolume Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "-" [object Object] Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: decrease volume by single step. Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volDown Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: vol_dwn! Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: vol_dwn! Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] [parser:data]: Listener received: volume=25 Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] parser:data: call processResponse with: respVolume Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp signaled volume is 25 Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":25} Mar 09 09:13:17 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:17 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":25} Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp Status is now {"volume":25,"mute":false,"power":"on","source":"pc_usb"} Mar 09 09:13:17 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:17 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:17 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:17 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , alsavolume Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "-" [object Object] Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: decrease volume by single step. Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volDown Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: vol_dwn! Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: vol_dwn! Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] [parser:data]: Listener received: volume=24 Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] parser:data: call processResponse with: respVolume Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp signaled volume is 24 Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":24} Mar 09 09:13:17 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:17 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":24} Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp Status is now {"volume":24,"mute":false,"power":"on","source":"pc_usb"} Mar 09 09:13:17 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:17 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:17 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:17 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , alsavolume Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "-" [object Object] Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: decrease volume by single step. Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volDown Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: vol_dwn! Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: vol_dwn! Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] [parser:data]: Listener received: volume=23 Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] parser:data: call processResponse with: respVolume Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp signaled volume is 23 Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":23} Mar 09 09:13:17 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:17 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":23} Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp Status is now {"volume":23,"mute":false,"power":"on","source":"pc_usb"} Mar 09 09:13:17 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:17 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:17 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:17 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:17 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , alsavolume Mar 09 09:13:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "-" [object Object] Mar 09 09:13:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: decrease volume by single step. Mar 09 09:13:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volDown Mar 09 09:13:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: vol_dwn! Mar 09 09:13:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: vol_dwn! Mar 09 09:13:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] [parser:data]: Listener received: volume=22 Mar 09 09:13:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] parser:data: call processResponse with: respVolume Mar 09 09:13:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp signaled volume is 22 Mar 09 09:13:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":22} Mar 09 09:13:18 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:18 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:18 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":22} Mar 09 09:13:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp Status is now {"volume":22,"mute":false,"power":"on","source":"pc_usb"} Mar 09 09:13:18 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:18 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:13:18 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:18 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:13:18 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:18 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:13:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:13:22 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Mar 09 09:13:22 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:32 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Mar 09 09:13:32 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:32 volumio volumio[1102]: info: Listing playlists Mar 09 09:13:32 volumio volumio[1102]: info: Listing playlists Mar 09 09:13:32 volumio volumio[1102]: info: CALLMETHOD: system_hardware serialampcontroller updateSerialSettings [object Object] Mar 09 09:13:32 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , updateSerialSettings Mar 09 09:13:32 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] updateSerialSettings: Saving Interface Settings:{"tcp_ip":true,"serial_interface_dev":{"value":0,"label":"..."},"ip_address":"192.168.0.100"} Mar 09 09:13:32 volumio volumio[1102]: error: [SERIALAMPCONTROLLER] updateSerialSettings: nothing changed - do nothing Mar 09 09:13:42 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Mar 09 09:13:42 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:48 volumio volumio[1102]: info: CALLMETHOD: system_hardware serialampcontroller updateAmpSettings [object Object] Mar 09 09:13:48 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , updateAmpSettings Mar 09 09:13:48 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] updateAmpSettings: Saving Amplifier Settings:{"volumio_input":{"value":14,"label":"PC-USB"},"min_volume":0,"max_volume":96,"startup_volume":10,"volume_steps":1,"map_to_100":false,"pause_when_muted":true,"pause_when_input_changed":true,"switch_input_at_play":true,"start_at_powerup":true,"powerup_on_boot":true,"powerup_on_play":false} Mar 09 09:13:48 volumio volumio[1102]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 09 09:13:48 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getUIConfig: interface: TCP/IP; amps: ["Rotel - RC-1592 >=V1.53","Rotel - RSP-1582 SW V5.xx","Rotel - RA-1592 SW >=V1.52"]selected: Rotel - RA-1592 SW >=V1.52 Mar 09 09:13:48 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "10" [object Object] Mar 09 09:13:48 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: set volume to integer value 10 Mar 09 09:13:48 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volValue,10 Mar 09 09:13:48 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: volume_10! Mar 09 09:13:48 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: volume_10! Mar 09 09:13:52 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Mar 09 09:13:52 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:13:52 volumio volumio[1102]: info: Listing playlists Mar 09 09:13:52 volumio volumio[1102]: info: Listing playlists Mar 09 09:13:52 volumio volumio[1102]: info: CALLMETHOD: system_hardware serialampcontroller updateAmpSettings [object Object] Mar 09 09:13:52 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , updateAmpSettings Mar 09 09:13:52 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] updateAmpSettings: Saving Amplifier Settings:{"volumio_input":{"value":14,"label":"PC-USB"},"min_volume":0,"max_volume":96,"startup_volume":10,"volume_steps":1,"map_to_100":false,"pause_when_muted":true,"pause_when_input_changed":true,"switch_input_at_play":true,"start_at_powerup":true,"powerup_on_boot":false,"powerup_on_play":false} Mar 09 09:13:52 volumio volumio[1102]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 09 09:13:52 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getUIConfig: interface: TCP/IP; amps: ["Rotel - RC-1592 >=V1.53","Rotel - RSP-1582 SW V5.xx","Rotel - RA-1592 SW >=V1.52"]selected: Rotel - RA-1592 SW >=V1.52 Mar 09 09:13:52 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "10" [object Object] Mar 09 09:13:52 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: set volume to integer value 10 Mar 09 09:13:52 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volValue,10 Mar 09 09:13:52 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: volume_10! Mar 09 09:13:52 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: volume_10! Mar 09 09:13:53 volumio volumio[1102]: info: CALLMETHOD: system_hardware serialampcontroller updateAmpSettings [object Object] Mar 09 09:13:53 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , updateAmpSettings Mar 09 09:13:53 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] updateAmpSettings: Saving Amplifier Settings:{"volumio_input":{"value":14,"label":"PC-USB"},"min_volume":0,"max_volume":96,"startup_volume":10,"volume_steps":1,"map_to_100":false,"pause_when_muted":true,"pause_when_input_changed":true,"switch_input_at_play":true,"start_at_powerup":true,"powerup_on_boot":false,"powerup_on_play":false} Mar 09 09:13:53 volumio volumio[1102]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 09 09:13:53 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getUIConfig: interface: TCP/IP; amps: ["Rotel - RC-1592 >=V1.53","Rotel - RSP-1582 SW V5.xx","Rotel - RA-1592 SW >=V1.52"]selected: Rotel - RA-1592 SW >=V1.52 Mar 09 09:13:53 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "10" [object Object] Mar 09 09:13:53 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: set volume to integer value 10 Mar 09 09:13:53 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volValue,10 Mar 09 09:13:53 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: volume_10! Mar 09 09:13:53 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: volume_10! Mar 09 09:14:02 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Mar 09 09:14:02 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:10 volumio volumio[1102]: info: CALLMETHOD: system_hardware serialampcontroller updateAmpSettings [object Object] Mar 09 09:14:10 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , updateAmpSettings Mar 09 09:14:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] updateAmpSettings: Saving Amplifier Settings:{"volumio_input":{"value":14,"label":"PC-USB"},"min_volume":0,"max_volume":96,"startup_volume":10,"volume_steps":1,"map_to_100":false,"pause_when_muted":true,"pause_when_input_changed":true,"switch_input_at_play":true,"start_at_powerup":true,"powerup_on_boot":false,"powerup_on_play":false} Mar 09 09:14:10 volumio volumio[1102]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 09 09:14:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getUIConfig: interface: TCP/IP; amps: ["Rotel - RC-1592 >=V1.53","Rotel - RSP-1582 SW V5.xx","Rotel - RA-1592 SW >=V1.52"]selected: Rotel - RA-1592 SW >=V1.52 Mar 09 09:14:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "10" [object Object] Mar 09 09:14:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: set volume to integer value 10 Mar 09 09:14:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volValue,10 Mar 09 09:14:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: volume_10! Mar 09 09:14:10 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: volume_10! Mar 09 09:14:12 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Mar 09 09:14:12 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:12 volumio volumio[1102]: info: Listing playlists Mar 09 09:14:12 volumio volumio[1102]: info: Listing playlists Mar 09 09:14:17 volumio volumio[1102]: info: CALLMETHOD: system_hardware serialampcontroller updateAmpType [object Object] Mar 09 09:14:17 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , updateAmpType Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] updateAmpType: Saving Amplifier Settings:{"amp_type":{"value":3,"label":"Rotel - RA-1592 SW >=V1.52"}} Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] closePorts: closing TCP/IP Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] resetVolumeSettings: Volume settings have been reset. Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] setActiveAmp: {"vendor":"Rotel","model":"RA-1592 SW >=V1.52","interfaces":["RS232","TCP/IP"],"tcpport":9590,"baudRate":115200,"parity":"none","dataBits":8,"stopBits":1,"rtscts":false,"xon":false,"xoff":false,"xany":false,"sources":["CD","Coax1","Coax2","Coax3","Opt1","Opt2","Opt3","Aux","Tuner","Phono","USB","Bluetooth","Bal XLR","PC-USB"],"sourceCmd":["cd!","coax1!","coax2!","coax3!","opt1!","opt2!","opt3!","aux!","tuner!","phono!","usb!","bluetooth!","bal_xlr!","pcusb!"],"sourceRespPostfix":["cd","coax1","coax2","coax3","opt1","opt2","opt3","aux","tuner","phono","usb","bluetooth","bal_xlr","pc_usb"],"delimiter":"$","commands":{"powerOn":"power_on!","powerToggle":"power_toggle!","volUp":"vol_up!","volDown":"vol_dwn!","volValue":"volume_#!","mute":"mute!","muteOn":"mute_on!","muteOff":"mute_off!"},"responses":[{"rx":"power=on","cmd":["respPowerOn"]},{"rx":"power=standby","cmd":["respPowerOff"]},{"rx":"volume=([0-9]{1,2})","cmd":["respVolume"]},{"rx":"mute=on","cmd":["respMuteOn"]},{"rx":"mute=off","cmd":["respMuteOff"]},{"rx":"source=([a-z_12]*)","cmd":["respSource"]}],"statusRequests":{"reqPower":"power?","reqSource":"source?","reqVolume":"volume?","reqMute":"mute?","reqModel":"model?"}} Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] setActiveAmp: can send these responses: respPowerOn,respPowerOff,respVolume,respMuteOn,respMuteOff,respSource Mar 09 09:14:17 volumio volumio[1102]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] closePorts: closed TCP/IP socket Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getUIConfig: interface: TCP/IP; amps: ["Rotel - RC-1592 >=V1.53","Rotel - RSP-1582 SW V5.xx","Rotel - RA-1592 SW >=V1.52"]selected: Rotel - RA-1592 SW >=V1.52 Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] selectedInterfaceExists: TCP/IP selected. Expect network connection to exist. Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] selectedAmpSupportsInterface: TCP/IP in ["RS232","TCP/IP"] Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] openTcpIp: starting Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] openTcpIp: connect to 192.168.0.100 on port: 9590 Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getI18nString("TOAST_SAVE_SUCCESS"):Successfully saved Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getI18nString("TOAST_AMP_TYPE_SAVE"):Amplifier Type Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] openTcpIp: Connected to: 192.168.0.100:9590 Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] attachParser: Port is now open. Connecting Parser with delimiter: $ Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getAmpStatus: sending status requests to Amp Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqModel": model? Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqPower": power? Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqVolume": volume? Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqMute": mute? Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendStatusRequest: Sent command for "reqSource": source? Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: Set volume "10" [object Object] Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] alsavolume: set volume to integer value 10 Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send volValue,10 Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: now sending cmdString: volume_10! Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: sent cmdString: volume_10! Mar 09 09:14:17 volumio volumio[1102]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] [parser:data]: Listener received: model=RA-1592 Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] parser:data: no matching regex for: model=RA-1592 Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] [parser:data]: Listener received: power=on Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] parser:data: call processResponse with: respPowerOn Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp signaled PowerOn. Previous state is: on Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp Status is now {"volume":22,"mute":false,"power":"on","source":"pc_usb"} Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] [parser:data]: Listener received: volume=22 Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] parser:data: call processResponse with: respVolume Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp signaled volume is 22 Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":22} Mar 09 09:14:17 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:14:17 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:17 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:14:17 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":22} Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":22} Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":22} Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":22} Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":22} Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp Status is now {"volume":22,"mute":false,"power":"on","source":"pc_usb"} Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] [parser:data]: Listener received: mute=off Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] parser:data: call processResponse with: respMuteOff Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp signaled MuteOff Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":22} Mar 09 09:14:17 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:14:17 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:17 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp Status is now {"volume":22,"mute":false,"power":"on","source":"pc_usb"} Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] [parser:data]: Listener received: source=pc_usb Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] parser:data: call processResponse with: respSource Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp signaled source is pc_usb Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] processResponse: Amp Status is now {"volume":22,"mute":false,"power":"on","source":"pc_usb"} Mar 09 09:14:17 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:14:17 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:17 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:14:17 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:14:17 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:14:17 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:17 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:14:17 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:14:17 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:17 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:14:17 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:14:17 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:17 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:14:17 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:14:17 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:17 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:14:17 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:14:17 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:17 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:14:17 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:14:17 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:17 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:14:17 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] initVolumeSettings: getAlsaCards "5" Mar 09 09:14:17 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] initVolumeSettings: getAlsaCards [{"id":"0","alsacard":"b1","name":"HDMI Out"},{"id":"1","alsacard":"Headphones","name":"Headphones"},{"id":"5","alsacard":"R20","name":"Rotel USB Audio 2.0"}] Mar 09 09:14:17 volumio volumio[1102]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 09 09:14:17 volumio volumio[1102]: info: Updating Volume Controller Parameters: Device: 5 Name: Rotel USB Audio 2.0 Mixer: Max Vol: 96 Vol Curve; Vol Steps: 1 Mar 09 09:14:17 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 09 09:14:17 volumio volumio[1102]: info: Enabling external Volume Control Mar 09 09:14:17 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , updateVolumeSettings Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] updateVolumeSettings: received {"pluginType":"system_hardware","pluginName":"serialampcontroller","volumeOverride":true,"device":"5","name":"Rotel USB Audio 2.0","devicename":"Rotel - RA-1592 SW >=V1.52","mixer":"","mixertype":"None","maxvolume":96,"volumecurve":"","volumesteps":1} Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] retrieveVolume: Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":22} Mar 09 09:14:17 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , retrievevolume Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] retrieveVolume: Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":22} Mar 09 09:14:17 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 09 09:14:17 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] initVolumeSettings: getAlsaCards "5" Mar 09 09:14:17 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] initVolumeSettings: getAlsaCards [{"id":"0","alsacard":"b1","name":"HDMI Out"},{"id":"1","alsacard":"Headphones","name":"Headphones"},{"id":"5","alsacard":"R20","name":"Rotel USB Audio 2.0"}] Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 09 09:14:18 volumio volumio[1102]: info: Updating Volume Controller Parameters: Device: 5 Name: Rotel USB Audio 2.0 Mixer: Max Vol: 96 Vol Curve; Vol Steps: 1 Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 09 09:14:18 volumio volumio[1102]: info: Enabling external Volume Control Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , updateVolumeSettings Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] updateVolumeSettings: received {"pluginType":"system_hardware","pluginName":"serialampcontroller","volumeOverride":true,"device":"5","name":"Rotel USB Audio 2.0","devicename":"Rotel - RA-1592 SW >=V1.52","mixer":"","mixertype":"None","maxvolume":96,"volumecurve":"","volumesteps":1} Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] retrieveVolume: Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":22} Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , retrievevolume Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] retrieveVolume: Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":22} Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] initVolumeSettings: getAlsaCards "5" Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] initVolumeSettings: getAlsaCards [{"id":"0","alsacard":"b1","name":"HDMI Out"},{"id":"1","alsacard":"Headphones","name":"Headphones"},{"id":"5","alsacard":"R20","name":"Rotel USB Audio 2.0"}] Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 09 09:14:18 volumio volumio[1102]: info: Updating Volume Controller Parameters: Device: 5 Name: Rotel USB Audio 2.0 Mixer: Max Vol: 96 Vol Curve; Vol Steps: 1 Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 09 09:14:18 volumio volumio[1102]: info: Enabling external Volume Control Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , updateVolumeSettings Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] updateVolumeSettings: received {"pluginType":"system_hardware","pluginName":"serialampcontroller","volumeOverride":true,"device":"5","name":"Rotel USB Audio 2.0","devicename":"Rotel - RA-1592 SW >=V1.52","mixer":"","mixertype":"None","maxvolume":96,"volumecurve":"","volumesteps":1} Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] retrieveVolume: Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":22} Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , retrievevolume Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] retrieveVolume: Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":22} Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] initVolumeSettings: getAlsaCards "5" Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] initVolumeSettings: getAlsaCards [{"id":"0","alsacard":"b1","name":"HDMI Out"},{"id":"1","alsacard":"Headphones","name":"Headphones"},{"id":"5","alsacard":"R20","name":"Rotel USB Audio 2.0"}] Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 09 09:14:18 volumio volumio[1102]: info: Updating Volume Controller Parameters: Device: 5 Name: Rotel USB Audio 2.0 Mixer: Max Vol: 96 Vol Curve; Vol Steps: 1 Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 09 09:14:18 volumio volumio[1102]: info: Enabling external Volume Control Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , updateVolumeSettings Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] updateVolumeSettings: received {"pluginType":"system_hardware","pluginName":"serialampcontroller","volumeOverride":true,"device":"5","name":"Rotel USB Audio 2.0","devicename":"Rotel - RA-1592 SW >=V1.52","mixer":"","mixertype":"None","maxvolume":96,"volumecurve":"","volumesteps":1} Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] retrieveVolume: Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":22} Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , retrievevolume Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] retrieveVolume: Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":22} Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] initVolumeSettings: getAlsaCards "5" Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] initVolumeSettings: getAlsaCards [{"id":"0","alsacard":"b1","name":"HDMI Out"},{"id":"1","alsacard":"Headphones","name":"Headphones"},{"id":"5","alsacard":"R20","name":"Rotel USB Audio 2.0"}] Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 09 09:14:18 volumio volumio[1102]: info: Updating Volume Controller Parameters: Device: 5 Name: Rotel USB Audio 2.0 Mixer: Max Vol: 96 Vol Curve; Vol Steps: 1 Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 09 09:14:18 volumio volumio[1102]: info: Enabling external Volume Control Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , updateVolumeSettings Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] updateVolumeSettings: received {"pluginType":"system_hardware","pluginName":"serialampcontroller","volumeOverride":true,"device":"5","name":"Rotel USB Audio 2.0","devicename":"Rotel - RA-1592 SW >=V1.52","mixer":"","mixertype":"None","maxvolume":96,"volumecurve":"","volumesteps":1} Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] retrieveVolume: Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":22} Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , retrievevolume Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] retrieveVolume: Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":22} Mar 09 09:14:18 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:14:18 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:14:18 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:14:18 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:14:18 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:14:18 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:14:18 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:14:18 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:14:18 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:14:18 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:14:18 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:14:18 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:14:18 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:14:18 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:14:18 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:14:18 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:14:18 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:14:18 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:14:18 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:14:18 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getI18nString("TOAST_SAVE_SUCCESS"):Successfully saved Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getI18nString("TOAST_AMP_SAVE"):Amplifier Settings Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getI18nString("TOAST_SAVE_SUCCESS"):Successfully saved Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getI18nString("TOAST_AMP_SAVE"):Amplifier Settings Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getI18nString("TOAST_SAVE_SUCCESS"):Successfully saved Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getI18nString("TOAST_AMP_SAVE"):Amplifier Settings Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getI18nString("TOAST_SAVE_SUCCESS"):Successfully saved Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getI18nString("TOAST_AMP_SAVE"):Amplifier Settings Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Mar 09 09:14:18 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:18 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::volumioPlay Mar 09 09:14:18 volumio volumio[1102]: info: CoreStateMachine::play index undefined Mar 09 09:14:18 volumio volumio[1102]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 09:14:18 volumio volumio[1102]: info: CoreCommandRouter::volumioPause Mar 09 09:14:18 volumio volumio[1102]: info: CoreStateMachine::pause Mar 09 09:14:18 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:18 volumio volumio[1102]: info: CoreStateMachine::startPlaybackTimer Mar 09 09:14:18 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:18 volumio volumio[1102]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/!Lossless/Pet Shop Boys/1987 - Actually/01. One More Chance.flac Mar 09 09:14:18 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand stop Mar 09 09:14:18 volumio volumio[1102]: info: sendMpdCommand stop took 0 milliseconds Mar 09 09:14:18 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand clear Mar 09 09:14:18 volumio volumio[1102]: info: Mar 09 09:14:18 volumio volumio[1102]: ---------------------------- MPD announces system playlist update Mar 09 09:14:18 volumio volumio[1102]: info: Ignoring MPD Status Update Mar 09 09:14:18 volumio volumio[1102]: info: sendMpdCommand clear took 1 milliseconds Mar 09 09:14:18 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/!Lossless/Pet Shop Boys/1987 - Actually/01. One More Chance.flac" Mar 09 09:14:18 volumio mpd[1329]: exception: No database Mar 09 09:14:18 volumio volumio[1102]: info: Mar 09 09:14:18 volumio volumio[1102]: ---------------------------- MPD announces system playlist update Mar 09 09:14:18 volumio volumio[1102]: info: Ignoring MPD Status Update Mar 09 09:14:18 volumio volumio[1102]: info: Mar 09 09:14:18 volumio volumio[1102]: ---------------------------- MPD announces system playlist update Mar 09 09:14:18 volumio volumio[1102]: info: Ignoring MPD Status Update Mar 09 09:14:18 volumio volumio[1102]: error: updateQueue error: null Mar 09 09:14:18 volumio volumio[1102]: error: updateQueue error: null Mar 09 09:14:18 volumio volumio[1102]: error: updateQueue error: null Mar 09 09:14:18 volumio volumio[1102]: info: ------------------------------ 2ms Mar 09 09:14:18 volumio volumio[1102]: info: ------------------------------ 2ms Mar 09 09:14:18 volumio volumio[1102]: info: ------------------------------ 2ms Mar 09 09:14:20 volumio volumio[1102]: info: CALLMETHOD: system_hardware serialampcontroller updateSerialSettings [object Object] Mar 09 09:14:20 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , updateSerialSettings Mar 09 09:14:20 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] updateSerialSettings: Saving Interface Settings:{"tcp_ip":true,"serial_interface_dev":{"value":0,"label":"..."},"ip_address":"192.168.0.100"} Mar 09 09:14:20 volumio volumio[1102]: error: [SERIALAMPCONTROLLER] updateSerialSettings: nothing changed - do nothing Mar 09 09:14:21 volumio volumio[1102]: info: CALLMETHOD: system_hardware serialampcontroller updateSerialSettings [object Object] Mar 09 09:14:21 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , updateSerialSettings Mar 09 09:14:21 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] updateSerialSettings: Saving Interface Settings:{"tcp_ip":true,"serial_interface_dev":{"value":0,"label":"..."},"ip_address":"192.168.0.100"} Mar 09 09:14:21 volumio volumio[1102]: error: [SERIALAMPCONTROLLER] updateSerialSettings: nothing changed - do nothing Mar 09 09:14:22 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Mar 09 09:14:22 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:27 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Mar 09 09:14:27 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:27 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 09 09:14:27 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] initVolumeSettings: getAlsaCards "5" Mar 09 09:14:27 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Mar 09 09:14:27 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] initVolumeSettings: getAlsaCards [{"id":"0","alsacard":"b1","name":"HDMI Out"},{"id":"1","alsacard":"Headphones","name":"Headphones"},{"id":"5","alsacard":"R20","name":"Rotel USB Audio 2.0"}] Mar 09 09:14:27 volumio volumio[1102]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 09 09:14:27 volumio volumio[1102]: info: Updating Volume Controller Parameters: Device: 5 Name: Rotel USB Audio 2.0 Mixer: Max Vol: 96 Vol Curve; Vol Steps: 1 Mar 09 09:14:27 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 09 09:14:27 volumio volumio[1102]: info: Enabling external Volume Control Mar 09 09:14:27 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , updateVolumeSettings Mar 09 09:14:27 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] updateVolumeSettings: received {"pluginType":"system_hardware","pluginName":"serialampcontroller","volumeOverride":true,"device":"5","name":"Rotel USB Audio 2.0","devicename":"Rotel - RA-1592 SW >=V1.52","mixer":"","mixertype":"None","maxvolume":96,"volumecurve":"","volumesteps":1} Mar 09 09:14:27 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] retrieveVolume: Mar 09 09:14:27 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":22} Mar 09 09:14:27 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , retrievevolume Mar 09 09:14:27 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] retrieveVolume: Mar 09 09:14:27 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] getVolumeObject: {"mute":false,"currentDisableVolumeControl":false,"vol":22} Mar 09 09:14:27 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:14:27 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:27 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 09:14:27 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:14:27 volumio volumio[1102]: info: CoreStateMachine::pushState Mar 09 09:14:27 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:27 volumio volumio[1102]: info: CoreCommandRouter::volumioPushState Mar 09 09:14:27 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] sendCommand: send source,... Mar 09 09:14:27 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:14:27 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] on:pushState: undefined - stop Mar 09 09:14:27 volumio volumio[1102]: info: CoreCommandRouter::volumioPlay Mar 09 09:14:27 volumio volumio[1102]: info: CoreStateMachine::play index undefined Mar 09 09:14:27 volumio volumio[1102]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 09:14:27 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:27 volumio volumio[1102]: info: CoreStateMachine::startPlaybackTimer Mar 09 09:14:27 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:27 volumio volumio[1102]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/!Lossless/Pet Shop Boys/1987 - Actually/01. One More Chance.flac Mar 09 09:14:27 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand stop Mar 09 09:14:27 volumio volumio[1102]: info: sendMpdCommand stop took 1 milliseconds Mar 09 09:14:27 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand clear Mar 09 09:14:27 volumio volumio[1102]: info: Mar 09 09:14:27 volumio volumio[1102]: ---------------------------- MPD announces system playlist update Mar 09 09:14:27 volumio volumio[1102]: info: Ignoring MPD Status Update Mar 09 09:14:27 volumio volumio[1102]: info: sendMpdCommand clear took 1 milliseconds Mar 09 09:14:27 volumio volumio[1102]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/!Lossless/Pet Shop Boys/1987 - Actually/01. One More Chance.flac" Mar 09 09:14:27 volumio volumio[1102]: info: Mar 09 09:14:27 volumio volumio[1102]: ---------------------------- MPD announces system playlist update Mar 09 09:14:27 volumio volumio[1102]: info: Ignoring MPD Status Update Mar 09 09:14:27 volumio volumio[1102]: info: Mar 09 09:14:27 volumio volumio[1102]: ---------------------------- MPD announces system playlist update Mar 09 09:14:27 volumio volumio[1102]: info: Ignoring MPD Status Update Mar 09 09:14:27 volumio volumio[1102]: error: updateQueue error: null Mar 09 09:14:27 volumio volumio[1102]: info: ------------------------------ 2ms Mar 09 09:14:27 volumio volumio[1102]: error: updateQueue error: null Mar 09 09:14:27 volumio volumio[1102]: error: updateQueue error: null Mar 09 09:14:27 volumio volumio[1102]: info: ------------------------------ 3ms Mar 09 09:14:27 volumio mpd[1329]: exception: No database Mar 09 09:14:27 volumio volumio[1102]: info: ------------------------------ 3ms Mar 09 09:14:28 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 09 09:14:28 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 09 09:14:30 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] closePorts: closing TCP/IP Mar 09 09:14:30 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] resetVolumeSettings: Volume settings have been reset. Mar 09 09:14:30 volumio volumio[1102]: error: Plugin serialampcontroller does not return adequate promise from onStop: please update! Mar 09 09:14:30 volumio volumio[1102]: info: Disabling plugin serialampcontroller Mar 09 09:14:30 volumio volumio[1102]: info: Done. Mar 09 09:14:30 volumio volumio[1102]: info: [SERIALAMPCONTROLLER] closePorts: closed TCP/IP socket Mar 09 09:14:32 volumio volumio[1102]: info: CoreCommandRouter::volumioGetState Mar 09 09:14:32 volumio volumio[1102]: info: CorePlayQueue::getTrack 0 Mar 09 09:14:32 volumio volumio[1102]: info: Listing playlists Mar 09 09:14:32 volumio volumio[1102]: info: Listing playlists Mar 09 09:14:36 volumio volumio[1102]: info: CoreCommandRouter::executeOnPlugin: serialampcontroller , alsavolume Mar 09 09:14:36 volumio volumio[1102]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 09 09:14:36 volumio volumio[1102]: TypeError: Cannot read properties of undefined (reading 'then') Mar 09 09:14:36 volumio volumio[1102]: at CoreCommandRouter.volumiosetvolume (/volumio/app/index.js:136:10) Mar 09 09:14:36 volumio volumio[1102]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:304:33) Mar 09 09:14:36 volumio volumio[1102]: at Socket.emit (node:events:514:28) Mar 09 09:14:36 volumio volumio[1102]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Mar 09 09:14:36 volumio volumio[1102]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Mar 09 09:14:36 volumio volumio[1102]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 09 09:14:37 volumio sudo[2503]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-03-09 09:13' Mar 09 09:14:37 volumio sudo[2503]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="c4e184d4f6f6bde0af8ddd9d7eadaa6e3b46e745" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a7a6e4ee756971d9f8dea25279344ff5d3ab03d8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Feb 12 11:20:36 UTC 2025" VOLUMIO_VERSION="0.035" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="263951139c9246e32bb1521174a0ca82"