May 31 19:15:00 reveil-parents volumio[1117]: info: Getting current volume May 31 19:15:00 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:15:00 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:00 reveil-parents volumio[1117]: info: Current volume is 34 May 31 19:15:00 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 35 May 31 19:15:00 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=35 May 31 19:15:00 reveil-parents volumio[1117]: info: May 31 19:15:00 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 35 May 31 19:15:00 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume35 May 31 19:15:00 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:00 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:00 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:15:00 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:00 reveil-parents volumio[1117]: info: Received response: {"time":1780247700870,"response":"volume Success"} May 31 19:15:00 reveil-parents volumio[1117]: info: Volume set to 35 May 31 19:15:02 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:15:02 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:05 reveil-parents volumio[1117]: info: CoreCommandRouter::getUIConfigOnPlugin May 31 19:15:05 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 31 19:15:05 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 19:15:05 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 31 19:15:05 reveil-parents volumio[1117]: info: Getting Alsa Cards List without I2S DAC May 31 19:15:05 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber May 31 19:15:05 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 19:15:05 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 31 19:15:05 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 31 19:15:05 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 31 19:15:05 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 31 19:15:05 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 31 19:15:05 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 31 19:15:05 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 31 19:15:05 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 31 19:15:05 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 31 19:15:06 reveil-parents volumio[1117]: info: Getting current volume May 31 19:15:06 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:15:06 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:06 reveil-parents volumio[1117]: info: Current volume is 35 May 31 19:15:06 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 36 May 31 19:15:06 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=36 May 31 19:15:06 reveil-parents volumio[1117]: info: May 31 19:15:06 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 36 May 31 19:15:06 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume36 May 31 19:15:06 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:06 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:06 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:15:06 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:06 reveil-parents volumio[1117]: info: Getting current volume May 31 19:15:06 reveil-parents volumio[1117]: info: Received response: {"time":1780247706955,"response":"volume Success"} May 31 19:15:06 reveil-parents volumio[1117]: info: Volume set to 36 May 31 19:15:06 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:15:07 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:07 reveil-parents volumio[1117]: info: Current volume is 36 May 31 19:15:07 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 37 May 31 19:15:07 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=37 May 31 19:15:07 reveil-parents volumio[1117]: info: May 31 19:15:07 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 37 May 31 19:15:07 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume37 May 31 19:15:07 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:07 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:07 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:15:07 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:07 reveil-parents volumio[1117]: info: Received response: {"time":1780247707010,"response":"volume Success"} May 31 19:15:07 reveil-parents volumio[1117]: info: Volume set to 37 May 31 19:15:08 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:15:08 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:10 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 31 19:15:10 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 31 19:15:12 reveil-parents volumio[1117]: info: CoreCommandRouter::getUIConfigOnPlugin May 31 19:15:12 reveil-parents volumio[1117]: info: SleepWakePlugin - getUIConfig May 31 19:15:12 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 31 19:15:12 reveil-parents volumio[1117]: info: CURURI: playlists May 31 19:15:12 reveil-parents volumio[1117]: info: Listing playlists May 31 19:15:15 reveil-parents volumio[1117]: info: Getting current volume May 31 19:15:15 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:15:15 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:15 reveil-parents volumio[1117]: info: Current volume is 37 May 31 19:15:15 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 38 May 31 19:15:15 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=38 May 31 19:15:15 reveil-parents volumio[1117]: info: May 31 19:15:15 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 38 May 31 19:15:15 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume38 May 31 19:15:15 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:15 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:15 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:15:15 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:15 reveil-parents volumio[1117]: info: Received response: {"time":1780247715924,"response":"volume Success"} May 31 19:15:15 reveil-parents volumio[1117]: info: Volume set to 38 May 31 19:15:17 reveil-parents volumio[1117]: info: CALLMETHOD: system_controller SleepWakePlugin saveOptions [object Object] May 31 19:15:17 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: SleepWakePlugin , saveOptions May 31 19:15:17 reveil-parents volumio[1117]: info: SleepWakePlugin - saveOptions May 31 19:15:17 reveil-parents volumio[1117]: info: SleepWakePlugin - Sleep scheduled in -2631617665 milliseconds May 31 19:15:17 reveil-parents volumio[1117]: info: SleepWakePlugin - Wake scheduled in -2635217667 milliseconds May 31 19:15:17 reveil-parents volumio[1117]: info: SleepWakePlugin - Sleep timer triggered May 31 19:15:17 reveil-parents volumio[1117]: info: SleepWakePlugin - Starting fade out volume May 31 19:15:17 reveil-parents volumio[1117]: info: Getting current volume May 31 19:15:17 reveil-parents volumio[1117]: info: SleepWakePlugin - Wake timer triggered May 31 19:15:17 reveil-parents volumio[1117]: info: SleepWakePlugin - Interrupting sleep to start wake-up. May 31 19:15:17 reveil-parents volumio[1117]: info: SleepWakePlugin - Starting playlist May 31 19:15:17 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=25 May 31 19:15:17 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:15:17 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:17 reveil-parents volumio[1117]: info: May 31 19:15:17 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 25 May 31 19:15:17 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume25 May 31 19:15:17 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:17 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:17 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:15:17 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:17 reveil-parents volumio[1117]: info: Current volume is 38 May 31 19:15:17 reveil-parents volumio[1117]: info: Decreasing volume by 1: setting volume to 37 May 31 19:15:17 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=37 May 31 19:15:17 reveil-parents volumio[1117]: info: Received response: {"time":1780247717691,"response":"volume Success"} May 31 19:15:17 reveil-parents volumio[1117]: info: Initial volume set to 25 May 31 19:15:17 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=playplaylist&name=Reveil%20France%20inter May 31 19:15:17 reveil-parents volumio[1117]: info: May 31 19:15:17 reveil-parents volumio[1117]: ---------------------------- Client requests Volumio Play Playlist Reveil France inter May 31 19:15:17 reveil-parents volumio[1117]: info: Play playlist Reveil France inter May 31 19:15:17 reveil-parents volumio[1117]: info: May 31 19:15:17 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 37 May 31 19:15:17 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume37 May 31 19:15:17 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:17 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:17 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:15:17 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:17 reveil-parents volumio[1117]: info: Received response: {"time":1780247717746,"response":"volume Success"} May 31 19:15:17 reveil-parents volumio[1117]: info: Volume set to 37 May 31 19:15:17 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioClearQueue May 31 19:15:17 reveil-parents volumio[1117]: info: CoreStateMachine::ClearQueue May 31 19:15:17 reveil-parents volumio[1117]: info: CoreStateMachine::stop May 31 19:15:17 reveil-parents volumio[1117]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 19:15:17 reveil-parents volumio[1117]: info: CorePlayQueue::clearPlayQueue May 31 19:15:17 reveil-parents volumio[1117]: info: CorePlayQueue::saveQueue May 31 19:15:17 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:17 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushQueue May 31 19:15:17 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioAddQueueItems May 31 19:15:17 reveil-parents volumio[1117]: info: CoreStateMachine::addQueueItems May 31 19:15:17 reveil-parents volumio[1117]: info: CorePlayQueue::addQueueItems May 31 19:15:17 reveil-parents volumio[1117]: info: Preload queue cleared May 31 19:15:17 reveil-parents volumio[1117]: info: Adding Item to queue: http://icecast.radiofrance.fr/franceinter-hifi.aac May 31 19:15:17 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 31 19:15:17 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushQueue May 31 19:15:17 reveil-parents volumio[1117]: info: CorePlayQueue::saveQueue May 31 19:15:17 reveil-parents volumio[1117]: info: CoreStateMachine::updateTrackBlock May 31 19:15:17 reveil-parents volumio[1117]: info: CorePlayQueue::getTrackBlock May 31 19:15:17 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPlay May 31 19:15:17 reveil-parents volumio[1117]: info: CoreStateMachine::play index 0 May 31 19:15:17 reveil-parents volumio[1117]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 19:15:17 reveil-parents volumio[1117]: info: CoreStateMachine::stop May 31 19:15:17 reveil-parents volumio[1117]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 19:15:17 reveil-parents volumio[1117]: info: CoreStateMachine::play index undefined May 31 19:15:17 reveil-parents volumio[1117]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 19:15:17 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:17 reveil-parents volumio[1117]: info: CoreStateMachine::startPlaybackTimer May 31 19:15:17 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:17 reveil-parents volumio[1117]: info: [1780247717804] ControllerWebradio::clearAddPlayTrack May 31 19:15:17 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand stop May 31 19:15:17 reveil-parents volumio[1117]: info: Received response: {"time":1780247717739,"response":"playplaylist Success"} May 31 19:15:17 reveil-parents volumio[1117]: info: Playlist "Reveil France inter" started. May 31 19:15:17 reveil-parents volumio[1117]: info: Getting current volume May 31 19:15:17 reveil-parents volumio[1117]: info: sendMpdCommand stop took 11 milliseconds May 31 19:15:17 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand clear May 31 19:15:17 reveil-parents volumio[1117]: info: May 31 19:15:17 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:15:17 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:15:17 reveil-parents volumio[1117]: info: sendMpdCommand clear took 4 milliseconds May 31 19:15:17 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand load "http://icecast.radiofrance.fr/franceinter-hifi.aac" May 31 19:15:17 reveil-parents volumio[1117]: info: May 31 19:15:17 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:15:17 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:15:17 reveil-parents volumio[1117]: info: May 31 19:15:17 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:15:17 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:15:17 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:15:17 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:17 reveil-parents volumio[1117]: error: updateQueue error: null May 31 19:15:17 reveil-parents volumio[1117]: info: ------------------------------ 11ms May 31 19:15:17 reveil-parents volumio[1117]: info: Current volume is 37 May 31 19:15:17 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 38 May 31 19:15:17 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=38 May 31 19:15:17 reveil-parents volumio[1117]: info: May 31 19:15:17 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 38 May 31 19:15:17 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume38 May 31 19:15:17 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:17 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:17 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:15:17 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:17 reveil-parents volumio[1117]: info: Received response: {"time":1780247717846,"response":"volume Success"} May 31 19:15:17 reveil-parents volumio[1117]: info: Volume set to 38 May 31 19:15:18 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand add "http://icecast.radiofrance.fr/franceinter-hifi.aac" May 31 19:15:18 reveil-parents volumio[1117]: error: updateQueue error: null May 31 19:15:18 reveil-parents volumio[1117]: error: updateQueue error: null May 31 19:15:18 reveil-parents volumio[1117]: info: May 31 19:15:18 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:15:18 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:15:18 reveil-parents volumio[1117]: info: ------------------------------ 570ms May 31 19:15:18 reveil-parents volumio[1117]: info: ------------------------------ 568ms May 31 19:15:18 reveil-parents volumio[1117]: info: sendMpdCommand add "http://icecast.radiofrance.fr/franceinter-hifi.aac" took 3 milliseconds May 31 19:15:18 reveil-parents volumio[1117]: info: CoreStateMachine::setConsumeUpdateService mpd May 31 19:15:18 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand play May 31 19:15:18 reveil-parents volumio[1117]: info: May 31 19:15:18 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:15:18 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:15:18 reveil-parents volumio[1117]: info: May 31 19:15:18 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:15:18 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:15:18 reveil-parents volumio[1117]: info: ------------------------------ 7ms May 31 19:15:18 reveil-parents volumio[1117]: info: sendMpdCommand play took 6 milliseconds May 31 19:15:18 reveil-parents volumio[1117]: info: ------------------------------ 5ms May 31 19:15:18 reveil-parents volumio[1117]: info: ------------------------------ 4ms May 31 19:15:18 reveil-parents volumio[1117]: info: May 31 19:15:18 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:15:18 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:15:18 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:15:18 reveil-parents volumio[1117]: info: May 31 19:15:18 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:15:18 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:15:18 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:15:18 reveil-parents volumio[1117]: info: May 31 19:15:18 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:15:18 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:15:18 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:15:18 reveil-parents volumio[1117]: info: May 31 19:15:18 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:15:18 reveil-parents volumio[1117]: info: sendMpdCommand status took 31 milliseconds May 31 19:15:18 reveil-parents volumio[1117]: info: sendMpdCommand status took 30 milliseconds May 31 19:15:18 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:15:18 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:15:18 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:15:18 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 19:15:18 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:15:18 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 19:15:18 reveil-parents volumio[1117]: info: May 31 19:15:18 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:15:18 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:15:18 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:15:18 reveil-parents volumio[1117]: info: May 31 19:15:18 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:15:18 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:15:18 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:15:18 reveil-parents volumio[1117]: info: May 31 19:15:18 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:15:18 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:15:18 reveil-parents volumio[1117]: info: sendMpdCommand status took 39 milliseconds May 31 19:15:18 reveil-parents volumio[1117]: info: sendMpdCommand status took 10 milliseconds May 31 19:15:18 reveil-parents volumio[1117]: info: sendMpdCommand playlistinfo took 10 milliseconds May 31 19:15:18 reveil-parents volumio[1117]: info: sendMpdCommand playlistinfo took 10 milliseconds May 31 19:15:18 reveil-parents volumio[1117]: info: sendMpdCommand status took 7 milliseconds May 31 19:15:18 reveil-parents volumio[1117]: info: sendMpdCommand status took 5 milliseconds May 31 19:15:18 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:15:18 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 19:15:18 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:15:18 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 19:15:18 reveil-parents volumio[1117]: verbose: ControllerMpd::parseTrackInfo May 31 19:15:18 reveil-parents volumio[1117]: verbose: ControllerMpd::parseTrackInfo May 31 19:15:18 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:15:18 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 19:15:18 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:15:18 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 19:15:18 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:15:18 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:15:18 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:18 reveil-parents volumio[1117]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"franceinter-hifi.aac","artist":"franceinter-hifi.aac","album":null,"uri":"http://icecast.radiofrance.fr/franceinter-hifi.aac","trackType":"aac"} May 31 19:15:18 reveil-parents volumio[1117]: verbose: CURRENT POSITION 0 May 31 19:15:18 reveil-parents volumio[1117]: info: CoreStateMachine::syncState stateService play May 31 19:15:18 reveil-parents volumio[1117]: info: CoreStateMachine::syncState currentStatus stop May 31 19:15:18 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:15:18 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:15:18 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:18 reveil-parents volumio[1117]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"191 Kbps","isStreaming":false,"title":"franceinter-hifi.aac","artist":"franceinter-hifi.aac","album":null,"uri":"http://icecast.radiofrance.fr/franceinter-hifi.aac","trackType":"aac"} May 31 19:15:18 reveil-parents volumio[1117]: verbose: CURRENT POSITION 0 May 31 19:15:18 reveil-parents volumio[1117]: info: CoreStateMachine::syncState stateService play May 31 19:15:18 reveil-parents volumio[1117]: info: CoreStateMachine::syncState currentStatus play May 31 19:15:18 reveil-parents volumio[1117]: info: Received an update from plugin. extracting info from payload May 31 19:15:18 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 31 19:15:18 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:18 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:18 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:15:18 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:18 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:18 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:18 reveil-parents volumio[1117]: info: ------------------------------ 58ms May 31 19:15:18 reveil-parents volumio[1117]: info: ------------------------------ 61ms May 31 19:15:18 reveil-parents volumio[1117]: info: May 31 19:15:18 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:15:18 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:15:18 reveil-parents volumio[1117]: info: May 31 19:15:18 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:15:18 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:15:18 reveil-parents volumio[1117]: info: ------------------------------ 27ms May 31 19:15:18 reveil-parents volumio[1117]: info: sendMpdCommand playlistinfo took 23 milliseconds May 31 19:15:18 reveil-parents volumio[1117]: info: sendMpdCommand playlistinfo took 22 milliseconds May 31 19:15:18 reveil-parents volumio[1117]: info: sendMpdCommand playlistinfo took 22 milliseconds May 31 19:15:18 reveil-parents volumio[1117]: info: sendMpdCommand playlistinfo took 22 milliseconds May 31 19:15:18 reveil-parents volumio[1117]: info: ------------------------------ 6ms May 31 19:15:18 reveil-parents volumio[1117]: info: ------------------------------ 4ms May 31 19:15:18 reveil-parents volumio[1117]: verbose: ControllerMpd::parseTrackInfo May 31 19:15:18 reveil-parents volumio[1117]: verbose: ControllerMpd::parseTrackInfo May 31 19:15:18 reveil-parents volumio[1117]: verbose: ControllerMpd::parseTrackInfo May 31 19:15:18 reveil-parents volumio[1117]: verbose: ControllerMpd::parseTrackInfo May 31 19:15:18 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:15:18 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:15:18 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:18 reveil-parents volumio[1117]: verbose: STATE SERVICE {"status":"play","position":0,"seek":10,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"191 Kbps","isStreaming":false,"title":"franceinter-hifi.aac","artist":"franceinter-hifi.aac","album":null,"uri":"http://icecast.radiofrance.fr/franceinter-hifi.aac","trackType":"aac"} May 31 19:15:18 reveil-parents volumio[1117]: verbose: CURRENT POSITION 0 May 31 19:15:18 reveil-parents volumio[1117]: info: CoreStateMachine::syncState stateService play May 31 19:15:18 reveil-parents volumio[1117]: info: CoreStateMachine::syncState currentStatus play May 31 19:15:18 reveil-parents volumio[1117]: info: Received an update from plugin. extracting info from payload May 31 19:15:18 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 31 19:15:18 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:18 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:18 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:18 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:18 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:18 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:15:18 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:15:18 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:18 reveil-parents volumio[1117]: verbose: STATE SERVICE {"status":"play","position":0,"seek":189,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"191 Kbps","isStreaming":false,"title":"franceinter-hifi.aac","artist":"franceinter-hifi.aac","album":null,"uri":"http://icecast.radiofrance.fr/franceinter-hifi.aac","trackType":"aac"} May 31 19:15:18 reveil-parents volumio[1117]: verbose: CURRENT POSITION 0 May 31 19:15:18 reveil-parents volumio[1117]: info: CoreStateMachine::syncState stateService play May 31 19:15:18 reveil-parents volumio[1117]: info: CoreStateMachine::syncState currentStatus play May 31 19:15:18 reveil-parents volumio[1117]: info: Received an update from plugin. extracting info from payload May 31 19:15:18 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 31 19:15:18 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:18 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:18 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:18 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:18 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:18 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:15:18 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:15:18 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:18 reveil-parents volumio[1117]: verbose: STATE SERVICE {"status":"play","position":0,"seek":610,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"191 Kbps","isStreaming":false,"title":"franceinter-hifi.aac","artist":"franceinter-hifi.aac","album":null,"uri":"http://icecast.radiofrance.fr/franceinter-hifi.aac","trackType":"aac"} May 31 19:15:18 reveil-parents volumio[1117]: verbose: CURRENT POSITION 0 May 31 19:15:18 reveil-parents volumio[1117]: info: CoreStateMachine::syncState stateService play May 31 19:15:18 reveil-parents volumio[1117]: info: CoreStateMachine::syncState currentStatus play May 31 19:15:18 reveil-parents volumio[1117]: info: Received an update from plugin. extracting info from payload May 31 19:15:18 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 31 19:15:18 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:18 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:18 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:18 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:18 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:18 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:15:18 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:15:18 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:18 reveil-parents volumio[1117]: verbose: STATE SERVICE {"status":"play","position":0,"seek":736,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"191 Kbps","isStreaming":false,"title":"franceinter-hifi.aac","artist":"franceinter-hifi.aac","album":null,"uri":"http://icecast.radiofrance.fr/franceinter-hifi.aac","trackType":"aac"} May 31 19:15:18 reveil-parents volumio[1117]: verbose: CURRENT POSITION 0 May 31 19:15:18 reveil-parents volumio[1117]: info: CoreStateMachine::syncState stateService play May 31 19:15:18 reveil-parents volumio[1117]: info: CoreStateMachine::syncState currentStatus play May 31 19:15:18 reveil-parents volumio[1117]: info: Received an update from plugin. extracting info from payload May 31 19:15:18 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 31 19:15:18 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:18 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:18 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:18 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:18 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:18 reveil-parents volumio[1117]: info: ------------------------------ 106ms May 31 19:15:18 reveil-parents volumio[1117]: info: ------------------------------ 79ms May 31 19:15:18 reveil-parents volumio[1117]: info: ------------------------------ 75ms May 31 19:15:18 reveil-parents volumio[1117]: info: ------------------------------ 73ms May 31 19:15:19 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioStop May 31 19:15:19 reveil-parents volumio[1117]: info: CoreStateMachine::stop May 31 19:15:19 reveil-parents volumio[1117]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 19:15:19 reveil-parents volumio[1117]: info: CoreStateMachine::stPlaybackTimer May 31 19:15:19 reveil-parents volumio[1117]: info: CoreStateMachine::updateTrackBlock May 31 19:15:19 reveil-parents volumio[1117]: info: CorePlayQueue::getTrackBlock May 31 19:15:19 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:19 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:19 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:15:19 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:19 reveil-parents volumio[1117]: info: CoreStateMachine::serviceStop May 31 19:15:19 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:19 reveil-parents volumio[1117]: info: CoreCommandRouter::serviceStop May 31 19:15:19 reveil-parents volumio[1117]: info: [1780247719962] ControllerWebradio::stop May 31 19:15:19 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand stop May 31 19:15:19 reveil-parents volumio[1117]: info: May 31 19:15:19 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:15:19 reveil-parents volumio[1117]: info: sendMpdCommand stop took 9 milliseconds May 31 19:15:19 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:15:19 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:15:19 reveil-parents volumio[1117]: info: sendMpdCommand status took 2 milliseconds May 31 19:15:19 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:15:19 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 19:15:19 reveil-parents volumio[1117]: info: May 31 19:15:19 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:15:19 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:15:19 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:15:19 reveil-parents volumio[1117]: info: May 31 19:15:19 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:15:19 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:15:19 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:15:19 reveil-parents volumio[1117]: info: sendMpdCommand playlistinfo took 5 milliseconds May 31 19:15:19 reveil-parents volumio[1117]: info: sendMpdCommand status took 3 milliseconds May 31 19:15:19 reveil-parents volumio[1117]: info: sendMpdCommand status took 2 milliseconds May 31 19:15:19 reveil-parents volumio[1117]: verbose: ControllerMpd::parseTrackInfo May 31 19:15:19 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:15:19 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 19:15:19 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:15:19 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 19:15:19 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:15:19 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:15:19 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:19 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:19 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:19 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:19 reveil-parents volumio[1117]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd May 31 19:15:19 reveil-parents volumio[1117]: info: ------------------------------ 17ms May 31 19:15:19 reveil-parents volumio[1117]: info: sendMpdCommand playlistinfo took 10 milliseconds May 31 19:15:19 reveil-parents volumio[1117]: info: sendMpdCommand playlistinfo took 9 milliseconds May 31 19:15:19 reveil-parents volumio[1117]: verbose: ControllerMpd::parseTrackInfo May 31 19:15:19 reveil-parents volumio[1117]: verbose: ControllerMpd::parseTrackInfo May 31 19:15:19 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:15:19 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:15:19 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:19 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:19 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:19 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:19 reveil-parents volumio[1117]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd May 31 19:15:19 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:15:19 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:15:19 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:19 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:19 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:19 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:19 reveil-parents volumio[1117]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd May 31 19:15:20 reveil-parents volumio[1117]: info: ------------------------------ 27ms May 31 19:15:20 reveil-parents volumio[1117]: info: ------------------------------ 26ms May 31 19:15:21 reveil-parents volumio[1117]: info: Getting current volume May 31 19:15:22 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:15:22 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:22 reveil-parents volumio[1117]: info: Current volume is 38 May 31 19:15:22 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 39 May 31 19:15:22 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=39 May 31 19:15:22 reveil-parents volumio[1117]: info: May 31 19:15:22 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 39 May 31 19:15:22 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume39 May 31 19:15:22 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:22 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:22 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:15:22 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:22 reveil-parents volumio[1117]: info: Received response: {"time":1780247722010,"response":"volume Success"} May 31 19:15:22 reveil-parents volumio[1117]: info: Volume set to 39 May 31 19:15:22 reveil-parents volumio[1117]: info: Getting current volume May 31 19:15:22 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:15:22 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:22 reveil-parents volumio[1117]: info: Current volume is 39 May 31 19:15:22 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 40 May 31 19:15:22 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=40 May 31 19:15:22 reveil-parents volumio[1117]: info: May 31 19:15:22 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 40 May 31 19:15:22 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume40 May 31 19:15:22 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:22 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:22 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:15:22 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:22 reveil-parents volumio[1117]: info: Received response: {"time":1780247722062,"response":"volume Success"} May 31 19:15:22 reveil-parents volumio[1117]: info: Volume set to 40 May 31 19:15:22 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume7 May 31 19:15:22 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:22 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:22 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:15:22 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:28 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:15:28 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:30 reveil-parents volumio[1117]: info: Getting current volume May 31 19:15:30 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:15:30 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:30 reveil-parents volumio[1117]: info: Current volume is 7 May 31 19:15:30 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 8 May 31 19:15:30 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=8 May 31 19:15:30 reveil-parents volumio[1117]: info: May 31 19:15:30 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 8 May 31 19:15:30 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume8 May 31 19:15:30 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:30 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:30 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:15:30 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:31 reveil-parents volumio[1117]: info: Received response: {"time":1780247730977,"response":"volume Success"} May 31 19:15:31 reveil-parents volumio[1117]: info: Volume set to 8 May 31 19:15:32 reveil-parents volumio[1117]: info: Getting current volume May 31 19:15:32 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:15:32 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:32 reveil-parents volumio[1117]: info: Current volume is 8 May 31 19:15:32 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 9 May 31 19:15:32 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=9 May 31 19:15:32 reveil-parents volumio[1117]: info: May 31 19:15:32 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 9 May 31 19:15:32 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume9 May 31 19:15:32 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:32 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:32 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:15:32 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:32 reveil-parents volumio[1117]: info: Received response: {"time":1780247732903,"response":"volume Success"} May 31 19:15:32 reveil-parents volumio[1117]: info: Volume set to 9 May 31 19:15:37 reveil-parents volumio[1117]: info: Getting current volume May 31 19:15:37 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:15:37 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:37 reveil-parents volumio[1117]: info: Current volume is 9 May 31 19:15:37 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 10 May 31 19:15:37 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=10 May 31 19:15:37 reveil-parents volumio[1117]: info: May 31 19:15:37 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 10 May 31 19:15:37 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume10 May 31 19:15:37 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:37 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:37 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:15:37 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:37 reveil-parents volumio[1117]: info: Received response: {"time":1780247737053,"response":"volume Success"} May 31 19:15:37 reveil-parents volumio[1117]: info: Volume set to 10 May 31 19:15:37 reveil-parents volumio[1117]: info: Getting current volume May 31 19:15:37 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:15:37 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:37 reveil-parents volumio[1117]: info: Current volume is 10 May 31 19:15:37 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 11 May 31 19:15:37 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=11 May 31 19:15:37 reveil-parents volumio[1117]: info: May 31 19:15:37 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 11 May 31 19:15:37 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume11 May 31 19:15:37 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:37 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:37 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:15:37 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:37 reveil-parents volumio[1117]: info: Received response: {"time":1780247737111,"response":"volume Success"} May 31 19:15:37 reveil-parents volumio[1117]: info: Volume set to 11 May 31 19:15:46 reveil-parents volumio[1117]: info: Getting current volume May 31 19:15:46 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:15:46 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:46 reveil-parents volumio[1117]: info: Current volume is 11 May 31 19:15:46 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 12 May 31 19:15:46 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=12 May 31 19:15:46 reveil-parents volumio[1117]: info: May 31 19:15:46 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 12 May 31 19:15:46 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume12 May 31 19:15:46 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:46 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:46 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:15:46 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:46 reveil-parents volumio[1117]: info: Received response: {"time":1780247746039,"response":"volume Success"} May 31 19:15:46 reveil-parents volumio[1117]: info: Volume set to 12 May 31 19:15:47 reveil-parents volumio[1117]: info: Getting current volume May 31 19:15:47 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:15:47 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:47 reveil-parents volumio[1117]: info: Current volume is 12 May 31 19:15:47 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 13 May 31 19:15:47 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=13 May 31 19:15:47 reveil-parents volumio[1117]: info: May 31 19:15:47 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 13 May 31 19:15:47 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume13 May 31 19:15:47 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:47 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:47 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:15:47 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:47 reveil-parents volumio[1117]: info: Received response: {"time":1780247747950,"response":"volume Success"} May 31 19:15:47 reveil-parents volumio[1117]: info: Volume set to 13 May 31 19:15:52 reveil-parents volumio[1117]: info: Getting current volume May 31 19:15:52 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:15:52 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:52 reveil-parents volumio[1117]: info: Current volume is 13 May 31 19:15:52 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 14 May 31 19:15:52 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=14 May 31 19:15:52 reveil-parents volumio[1117]: info: May 31 19:15:52 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 14 May 31 19:15:52 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume14 May 31 19:15:52 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:52 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:52 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:15:52 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:52 reveil-parents volumio[1117]: info: Received response: {"time":1780247752102,"response":"volume Success"} May 31 19:15:52 reveil-parents volumio[1117]: info: Volume set to 14 May 31 19:15:52 reveil-parents volumio[1117]: info: Getting current volume May 31 19:15:52 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:15:52 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:52 reveil-parents volumio[1117]: info: Current volume is 14 May 31 19:15:52 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 15 May 31 19:15:52 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=15 May 31 19:15:52 reveil-parents volumio[1117]: info: May 31 19:15:52 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 15 May 31 19:15:52 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume15 May 31 19:15:52 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:15:52 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:15:52 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:15:52 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:15:52 reveil-parents volumio[1117]: info: Received response: {"time":1780247752157,"response":"volume Success"} May 31 19:15:52 reveil-parents volumio[1117]: info: Volume set to 15 May 31 19:16:01 reveil-parents volumio[1117]: info: Getting current volume May 31 19:16:01 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:16:01 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:01 reveil-parents volumio[1117]: info: Current volume is 15 May 31 19:16:01 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 16 May 31 19:16:01 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=16 May 31 19:16:01 reveil-parents volumio[1117]: info: May 31 19:16:01 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 16 May 31 19:16:01 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume16 May 31 19:16:01 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:01 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:01 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:16:01 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:01 reveil-parents volumio[1117]: info: Received response: {"time":1780247761096,"response":"volume Success"} May 31 19:16:01 reveil-parents volumio[1117]: info: Volume set to 16 May 31 19:16:02 reveil-parents volumio[1117]: info: Getting current volume May 31 19:16:02 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:16:02 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:02 reveil-parents volumio[1117]: info: Current volume is 16 May 31 19:16:02 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 17 May 31 19:16:02 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=17 May 31 19:16:02 reveil-parents volumio[1117]: info: May 31 19:16:02 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 17 May 31 19:16:02 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume17 May 31 19:16:03 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:03 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:03 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:16:03 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:03 reveil-parents volumio[1117]: info: Received response: {"time":1780247762998,"response":"volume Success"} May 31 19:16:03 reveil-parents volumio[1117]: info: Volume set to 17 May 31 19:16:07 reveil-parents volumio[1117]: info: Getting current volume May 31 19:16:07 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:16:07 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:07 reveil-parents volumio[1117]: info: Current volume is 17 May 31 19:16:07 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 18 May 31 19:16:07 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=18 May 31 19:16:07 reveil-parents volumio[1117]: info: May 31 19:16:07 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 18 May 31 19:16:07 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume18 May 31 19:16:07 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:07 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:07 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:16:07 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:07 reveil-parents volumio[1117]: info: Received response: {"time":1780247767154,"response":"volume Success"} May 31 19:16:07 reveil-parents volumio[1117]: info: Volume set to 18 May 31 19:16:07 reveil-parents volumio[1117]: info: Getting current volume May 31 19:16:07 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:16:07 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:07 reveil-parents volumio[1117]: info: Current volume is 18 May 31 19:16:07 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 19 May 31 19:16:07 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=19 May 31 19:16:07 reveil-parents volumio[1117]: info: May 31 19:16:07 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 19 May 31 19:16:07 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume19 May 31 19:16:07 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:07 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:07 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:16:07 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:07 reveil-parents volumio[1117]: info: Received response: {"time":1780247767202,"response":"volume Success"} May 31 19:16:07 reveil-parents volumio[1117]: info: Volume set to 19 May 31 19:16:12 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 31 19:16:12 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 31 19:16:13 reveil-parents volumio[1117]: info: CoreCommandRouter::getUIConfigOnPlugin May 31 19:16:13 reveil-parents volumio[1117]: info: SleepWakePlugin - getUIConfig May 31 19:16:13 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 31 19:16:13 reveil-parents volumio[1117]: info: CURURI: playlists May 31 19:16:13 reveil-parents volumio[1117]: info: Listing playlists May 31 19:16:15 reveil-parents volumio[1117]: info: CALLMETHOD: system_controller SleepWakePlugin saveOptions [object Object] May 31 19:16:15 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: SleepWakePlugin , saveOptions May 31 19:16:15 reveil-parents volumio[1117]: info: SleepWakePlugin - saveOptions May 31 19:16:15 reveil-parents volumio[1117]: info: SleepWakePlugin - Sleep scheduled in -2631675235 milliseconds May 31 19:16:15 reveil-parents volumio[1117]: info: SleepWakePlugin - Wake scheduled in -2635275237 milliseconds May 31 19:16:15 reveil-parents volumio[1117]: info: SleepWakePlugin - Sleep timer triggered May 31 19:16:15 reveil-parents volumio[1117]: info: SleepWakePlugin - Starting fade out volume May 31 19:16:15 reveil-parents volumio[1117]: info: Getting current volume May 31 19:16:15 reveil-parents volumio[1117]: info: SleepWakePlugin - Wake timer triggered May 31 19:16:15 reveil-parents volumio[1117]: info: SleepWakePlugin - Interrupting sleep to start wake-up. May 31 19:16:15 reveil-parents volumio[1117]: info: SleepWakePlugin - Starting playlist May 31 19:16:15 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=25 May 31 19:16:15 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:16:15 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:15 reveil-parents volumio[1117]: info: Current volume is 19 May 31 19:16:15 reveil-parents volumio[1117]: info: Decreasing volume by 1: setting volume to 18 May 31 19:16:15 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=18 May 31 19:16:15 reveil-parents volumio[1117]: info: May 31 19:16:15 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 25 May 31 19:16:15 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume25 May 31 19:16:15 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:15 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:15 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:16:15 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:15 reveil-parents volumio[1117]: info: Received response: {"time":1780247775269,"response":"volume Success"} May 31 19:16:15 reveil-parents volumio[1117]: info: Initial volume set to 25 May 31 19:16:15 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=playplaylist&name=Reveil%20France%20inter May 31 19:16:15 reveil-parents volumio[1117]: info: May 31 19:16:15 reveil-parents volumio[1117]: ---------------------------- Client requests Volumio Play Playlist Reveil France inter May 31 19:16:15 reveil-parents volumio[1117]: info: Play playlist Reveil France inter May 31 19:16:15 reveil-parents volumio[1117]: info: May 31 19:16:15 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 18 May 31 19:16:15 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume18 May 31 19:16:15 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:15 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:15 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:16:15 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:15 reveil-parents volumio[1117]: info: Received response: {"time":1780247775313,"response":"volume Success"} May 31 19:16:15 reveil-parents volumio[1117]: info: Volume set to 18 May 31 19:16:15 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioClearQueue May 31 19:16:15 reveil-parents volumio[1117]: info: CoreStateMachine::ClearQueue May 31 19:16:15 reveil-parents volumio[1117]: info: CoreStateMachine::stop May 31 19:16:15 reveil-parents volumio[1117]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 19:16:15 reveil-parents volumio[1117]: info: CorePlayQueue::clearPlayQueue May 31 19:16:15 reveil-parents volumio[1117]: info: CorePlayQueue::saveQueue May 31 19:16:15 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:15 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushQueue May 31 19:16:15 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioAddQueueItems May 31 19:16:15 reveil-parents volumio[1117]: info: CoreStateMachine::addQueueItems May 31 19:16:15 reveil-parents volumio[1117]: info: CorePlayQueue::addQueueItems May 31 19:16:15 reveil-parents volumio[1117]: info: Preload queue cleared May 31 19:16:15 reveil-parents volumio[1117]: info: Adding Item to queue: http://icecast.radiofrance.fr/franceinter-hifi.aac May 31 19:16:15 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 31 19:16:15 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushQueue May 31 19:16:15 reveil-parents volumio[1117]: info: CorePlayQueue::saveQueue May 31 19:16:15 reveil-parents volumio[1117]: info: CoreStateMachine::updateTrackBlock May 31 19:16:15 reveil-parents volumio[1117]: info: CorePlayQueue::getTrackBlock May 31 19:16:15 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPlay May 31 19:16:15 reveil-parents volumio[1117]: info: CoreStateMachine::play index 0 May 31 19:16:15 reveil-parents volumio[1117]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 19:16:15 reveil-parents volumio[1117]: info: CoreStateMachine::stop May 31 19:16:15 reveil-parents volumio[1117]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 19:16:15 reveil-parents volumio[1117]: info: CoreStateMachine::play index undefined May 31 19:16:15 reveil-parents volumio[1117]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 19:16:15 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:15 reveil-parents volumio[1117]: info: CoreStateMachine::startPlaybackTimer May 31 19:16:15 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:15 reveil-parents volumio[1117]: info: [1780247775362] ControllerWebradio::clearAddPlayTrack May 31 19:16:15 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand stop May 31 19:16:15 reveil-parents volumio[1117]: info: Received response: {"time":1780247775308,"response":"playplaylist Success"} May 31 19:16:15 reveil-parents volumio[1117]: info: Playlist "Reveil France inter" started. May 31 19:16:15 reveil-parents volumio[1117]: info: Getting current volume May 31 19:16:15 reveil-parents volumio[1117]: info: sendMpdCommand stop took 16 milliseconds May 31 19:16:15 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand clear May 31 19:16:15 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:16:15 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:15 reveil-parents volumio[1117]: info: May 31 19:16:15 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:16:15 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:16:15 reveil-parents volumio[1117]: info: sendMpdCommand clear took 8 milliseconds May 31 19:16:15 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand load "http://icecast.radiofrance.fr/franceinter-hifi.aac" May 31 19:16:15 reveil-parents volumio[1117]: info: May 31 19:16:15 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:16:15 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:16:15 reveil-parents volumio[1117]: info: May 31 19:16:15 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:16:15 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:16:15 reveil-parents volumio[1117]: info: Current volume is 18 May 31 19:16:15 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 19 May 31 19:16:15 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=19 May 31 19:16:15 reveil-parents volumio[1117]: error: updateQueue error: null May 31 19:16:15 reveil-parents volumio[1117]: info: ------------------------------ 10ms May 31 19:16:15 reveil-parents volumio[1117]: info: May 31 19:16:15 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 19 May 31 19:16:15 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume19 May 31 19:16:15 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:15 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:15 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:16:15 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:15 reveil-parents volumio[1117]: info: Received response: {"time":1780247775400,"response":"volume Success"} May 31 19:16:15 reveil-parents volumio[1117]: info: Volume set to 19 May 31 19:16:15 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand add "http://icecast.radiofrance.fr/franceinter-hifi.aac" May 31 19:16:15 reveil-parents volumio[1117]: error: updateQueue error: null May 31 19:16:15 reveil-parents volumio[1117]: error: updateQueue error: null May 31 19:16:15 reveil-parents volumio[1117]: info: ------------------------------ 426ms May 31 19:16:15 reveil-parents volumio[1117]: info: ------------------------------ 425ms May 31 19:16:15 reveil-parents volumio[1117]: info: May 31 19:16:15 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:16:15 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:16:15 reveil-parents volumio[1117]: info: sendMpdCommand add "http://icecast.radiofrance.fr/franceinter-hifi.aac" took 3 milliseconds May 31 19:16:15 reveil-parents volumio[1117]: info: CoreStateMachine::setConsumeUpdateService mpd May 31 19:16:15 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand play May 31 19:16:15 reveil-parents volumio[1117]: info: May 31 19:16:15 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:16:15 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:16:15 reveil-parents volumio[1117]: info: May 31 19:16:15 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:16:15 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:16:15 reveil-parents volumio[1117]: info: ------------------------------ 12ms May 31 19:16:15 reveil-parents volumio[1117]: info: sendMpdCommand play took 11 milliseconds May 31 19:16:15 reveil-parents volumio[1117]: info: ------------------------------ 11ms May 31 19:16:15 reveil-parents volumio[1117]: info: ------------------------------ 10ms May 31 19:16:16 reveil-parents volumio[1117]: info: Getting current volume May 31 19:16:16 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:16:16 reveil-parents volumio[1117]: info: Current volume is 19 May 31 19:16:16 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 20 May 31 19:16:16 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=20 May 31 19:16:16 reveil-parents volumio[1117]: info: May 31 19:16:16 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 20 May 31 19:16:16 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume20 May 31 19:16:16 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:16 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:16:16 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:16 reveil-parents volumio[1117]: info: Received response: {"time":1780247776144,"response":"volume Success"} May 31 19:16:16 reveil-parents volumio[1117]: info: Volume set to 20 May 31 19:16:16 reveil-parents volumio[1117]: info: May 31 19:16:16 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:16:16 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:16:16 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:16:16 reveil-parents volumio[1117]: info: May 31 19:16:16 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:16:16 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:16:16 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:16:16 reveil-parents volumio[1117]: info: May 31 19:16:16 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:16:16 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:16:16 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:16:16 reveil-parents volumio[1117]: info: May 31 19:16:16 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:16:16 reveil-parents volumio[1117]: info: sendMpdCommand status took 25 milliseconds May 31 19:16:16 reveil-parents volumio[1117]: info: sendMpdCommand status took 24 milliseconds May 31 19:16:16 reveil-parents volumio[1117]: info: sendMpdCommand status took 23 milliseconds May 31 19:16:16 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:16:16 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:16:16 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:16:16 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 19:16:16 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:16:16 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 19:16:16 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:16:16 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 19:16:16 reveil-parents volumio[1117]: info: May 31 19:16:16 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:16:16 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:16:16 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:16:16 reveil-parents volumio[1117]: info: May 31 19:16:16 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:16:16 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:16:16 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:16:16 reveil-parents volumio[1117]: info: May 31 19:16:16 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:16:16 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:16:16 reveil-parents volumio[1117]: info: sendMpdCommand status took 8 milliseconds May 31 19:16:16 reveil-parents volumio[1117]: info: sendMpdCommand playlistinfo took 7 milliseconds May 31 19:16:16 reveil-parents volumio[1117]: info: sendMpdCommand playlistinfo took 8 milliseconds May 31 19:16:16 reveil-parents volumio[1117]: info: sendMpdCommand playlistinfo took 8 milliseconds May 31 19:16:16 reveil-parents volumio[1117]: info: sendMpdCommand status took 5 milliseconds May 31 19:16:16 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:16:16 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 19:16:16 reveil-parents volumio[1117]: verbose: ControllerMpd::parseTrackInfo May 31 19:16:16 reveil-parents volumio[1117]: verbose: ControllerMpd::parseTrackInfo May 31 19:16:16 reveil-parents volumio[1117]: verbose: ControllerMpd::parseTrackInfo May 31 19:16:16 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:16:16 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 19:16:16 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:16:16 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:16:16 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:16 reveil-parents volumio[1117]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"franceinter-hifi.aac","artist":"franceinter-hifi.aac","album":null,"uri":"http://icecast.radiofrance.fr/franceinter-hifi.aac","trackType":"aac"} May 31 19:16:16 reveil-parents volumio[1117]: verbose: CURRENT POSITION 0 May 31 19:16:16 reveil-parents volumio[1117]: info: CoreStateMachine::syncState stateService play May 31 19:16:16 reveil-parents volumio[1117]: info: CoreStateMachine::syncState currentStatus stop May 31 19:16:16 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:16:16 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:16:16 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:16 reveil-parents volumio[1117]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"franceinter-hifi.aac","artist":"franceinter-hifi.aac","album":null,"uri":"http://icecast.radiofrance.fr/franceinter-hifi.aac","trackType":"aac"} May 31 19:16:16 reveil-parents volumio[1117]: verbose: CURRENT POSITION 0 May 31 19:16:16 reveil-parents volumio[1117]: info: CoreStateMachine::syncState stateService play May 31 19:16:16 reveil-parents volumio[1117]: info: CoreStateMachine::syncState currentStatus play May 31 19:16:16 reveil-parents volumio[1117]: info: Received an update from plugin. extracting info from payload May 31 19:16:16 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 31 19:16:16 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:16 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:16 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:16:16 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:16 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:16 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:16 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:16:16 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:16:16 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:16 reveil-parents volumio[1117]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"franceinter-hifi.aac","artist":"franceinter-hifi.aac","album":null,"uri":"http://icecast.radiofrance.fr/franceinter-hifi.aac","trackType":"aac"} May 31 19:16:16 reveil-parents volumio[1117]: verbose: CURRENT POSITION 0 May 31 19:16:16 reveil-parents volumio[1117]: info: CoreStateMachine::syncState stateService play May 31 19:16:16 reveil-parents volumio[1117]: info: CoreStateMachine::syncState currentStatus play May 31 19:16:16 reveil-parents volumio[1117]: info: Received an update from plugin. extracting info from payload May 31 19:16:16 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 31 19:16:16 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:16 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:16 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:16 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:16 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:16 reveil-parents volumio[1117]: info: ------------------------------ 60ms May 31 19:16:16 reveil-parents volumio[1117]: info: ------------------------------ 65ms May 31 19:16:16 reveil-parents volumio[1117]: info: ------------------------------ 65ms May 31 19:16:16 reveil-parents volumio[1117]: info: May 31 19:16:16 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:16:16 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:16:16 reveil-parents volumio[1117]: info: May 31 19:16:16 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:16:16 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:16:16 reveil-parents volumio[1117]: info: sendMpdCommand status took 37 milliseconds May 31 19:16:16 reveil-parents volumio[1117]: info: ------------------------------ 36ms May 31 19:16:16 reveil-parents volumio[1117]: info: sendMpdCommand playlistinfo took 34 milliseconds May 31 19:16:16 reveil-parents volumio[1117]: info: sendMpdCommand playlistinfo took 33 milliseconds May 31 19:16:16 reveil-parents volumio[1117]: info: ------------------------------ 4ms May 31 19:16:16 reveil-parents volumio[1117]: info: ------------------------------ 3ms May 31 19:16:16 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:16:16 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 19:16:16 reveil-parents volumio[1117]: verbose: ControllerMpd::parseTrackInfo May 31 19:16:16 reveil-parents volumio[1117]: verbose: ControllerMpd::parseTrackInfo May 31 19:16:16 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:16:16 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:16:16 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:16 reveil-parents volumio[1117]: verbose: STATE SERVICE {"status":"play","position":0,"seek":715,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"franceinter-hifi.aac","artist":"franceinter-hifi.aac","album":null,"uri":"http://icecast.radiofrance.fr/franceinter-hifi.aac","trackType":"aac"} May 31 19:16:16 reveil-parents volumio[1117]: verbose: CURRENT POSITION 0 May 31 19:16:16 reveil-parents volumio[1117]: info: CoreStateMachine::syncState stateService play May 31 19:16:16 reveil-parents volumio[1117]: info: CoreStateMachine::syncState currentStatus play May 31 19:16:16 reveil-parents volumio[1117]: info: Received an update from plugin. extracting info from payload May 31 19:16:16 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 31 19:16:16 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:16 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:16 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:16 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:16 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:16 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:16:16 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:16:16 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:16 reveil-parents volumio[1117]: verbose: STATE SERVICE {"status":"play","position":0,"seek":862,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"franceinter-hifi.aac","artist":"franceinter-hifi.aac","album":null,"uri":"http://icecast.radiofrance.fr/franceinter-hifi.aac","trackType":"aac"} May 31 19:16:16 reveil-parents volumio[1117]: verbose: CURRENT POSITION 0 May 31 19:16:16 reveil-parents volumio[1117]: info: CoreStateMachine::syncState stateService play May 31 19:16:16 reveil-parents volumio[1117]: info: CoreStateMachine::syncState currentStatus play May 31 19:16:16 reveil-parents volumio[1117]: info: Received an update from plugin. extracting info from payload May 31 19:16:16 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 31 19:16:16 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:16 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:16 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:16 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:16 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:16 reveil-parents volumio[1117]: info: ------------------------------ 67ms May 31 19:16:16 reveil-parents volumio[1117]: info: ------------------------------ 60ms May 31 19:16:16 reveil-parents volumio[1117]: info: sendMpdCommand playlistinfo took 39 milliseconds May 31 19:16:16 reveil-parents volumio[1117]: verbose: ControllerMpd::parseTrackInfo May 31 19:16:16 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:16:16 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:16:16 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:16 reveil-parents volumio[1117]: verbose: STATE SERVICE {"status":"play","position":0,"seek":989,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"franceinter-hifi.aac","artist":"franceinter-hifi.aac","album":null,"uri":"http://icecast.radiofrance.fr/franceinter-hifi.aac","trackType":"aac"} May 31 19:16:16 reveil-parents volumio[1117]: verbose: CURRENT POSITION 0 May 31 19:16:16 reveil-parents volumio[1117]: info: CoreStateMachine::syncState stateService play May 31 19:16:16 reveil-parents volumio[1117]: info: CoreStateMachine::syncState currentStatus play May 31 19:16:16 reveil-parents volumio[1117]: info: Received an update from plugin. extracting info from payload May 31 19:16:16 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 31 19:16:16 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:16 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:16 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:16 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:16 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:16 reveil-parents volumio[1117]: info: ------------------------------ 90ms May 31 19:16:18 reveil-parents volumio[1117]: info: Getting current volume May 31 19:16:18 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:16:18 reveil-parents volumio[1117]: info: Current volume is 20 May 31 19:16:18 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 21 May 31 19:16:18 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=21 May 31 19:16:18 reveil-parents volumio[1117]: info: May 31 19:16:18 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 21 May 31 19:16:18 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume21 May 31 19:16:18 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:18 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:16:18 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:18 reveil-parents volumio[1117]: info: Received response: {"time":1780247778050,"response":"volume Success"} May 31 19:16:18 reveil-parents volumio[1117]: info: Volume set to 21 May 31 19:16:18 reveil-parents volumio[1117]: info: CALLMETHOD: system_controller SleepWakePlugin saveOptions [object Object] May 31 19:16:18 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: SleepWakePlugin , saveOptions May 31 19:16:18 reveil-parents volumio[1117]: info: SleepWakePlugin - saveOptions May 31 19:16:18 reveil-parents volumio[1117]: info: SleepWakePlugin - Sleep scheduled in -2631678103 milliseconds May 31 19:16:18 reveil-parents volumio[1117]: info: SleepWakePlugin - Wake scheduled in -2635278105 milliseconds May 31 19:16:18 reveil-parents volumio[1117]: info: SleepWakePlugin - Sleep timer triggered May 31 19:16:18 reveil-parents volumio[1117]: info: SleepWakePlugin - Starting fade out volume May 31 19:16:18 reveil-parents volumio[1117]: info: Getting current volume May 31 19:16:18 reveil-parents volumio[1117]: info: SleepWakePlugin - Wake timer triggered May 31 19:16:18 reveil-parents volumio[1117]: info: SleepWakePlugin - Interrupting sleep to start wake-up. May 31 19:16:18 reveil-parents volumio[1117]: info: SleepWakePlugin - Starting playlist May 31 19:16:18 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=25 May 31 19:16:18 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:16:18 reveil-parents volumio[1117]: info: May 31 19:16:18 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 25 May 31 19:16:18 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume25 May 31 19:16:18 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:18 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:16:18 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:18 reveil-parents volumio[1117]: info: Current volume is 21 May 31 19:16:18 reveil-parents volumio[1117]: info: Decreasing volume by 1: setting volume to 20 May 31 19:16:18 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=20 May 31 19:16:18 reveil-parents volumio[1117]: info: Received response: {"time":1780247778129,"response":"volume Success"} May 31 19:16:18 reveil-parents volumio[1117]: info: Initial volume set to 25 May 31 19:16:18 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=playplaylist&name=Reveil%20France%20inter May 31 19:16:18 reveil-parents volumio[1117]: info: May 31 19:16:18 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 20 May 31 19:16:18 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume20 May 31 19:16:18 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:18 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:16:18 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:18 reveil-parents volumio[1117]: info: May 31 19:16:18 reveil-parents volumio[1117]: ---------------------------- Client requests Volumio Play Playlist Reveil France inter May 31 19:16:18 reveil-parents volumio[1117]: info: Play playlist Reveil France inter May 31 19:16:18 reveil-parents volumio[1117]: info: Received response: {"time":1780247778174,"response":"volume Success"} May 31 19:16:18 reveil-parents volumio[1117]: info: Volume set to 20 May 31 19:16:18 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioClearQueue May 31 19:16:18 reveil-parents volumio[1117]: info: CoreStateMachine::ClearQueue May 31 19:16:18 reveil-parents volumio[1117]: info: CoreStateMachine::stop May 31 19:16:18 reveil-parents volumio[1117]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 19:16:18 reveil-parents volumio[1117]: info: CoreStateMachine::stPlaybackTimer May 31 19:16:18 reveil-parents volumio[1117]: info: CoreStateMachine::updateTrackBlock May 31 19:16:18 reveil-parents volumio[1117]: info: CorePlayQueue::getTrackBlock May 31 19:16:18 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:18 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:18 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:16:18 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:18 reveil-parents volumio[1117]: info: CoreStateMachine::serviceStop May 31 19:16:18 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:18 reveil-parents volumio[1117]: info: CoreCommandRouter::serviceStop May 31 19:16:18 reveil-parents volumio[1117]: info: [1780247778213] ControllerWebradio::stop May 31 19:16:18 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand stop May 31 19:16:18 reveil-parents volumio[1117]: info: CorePlayQueue::clearPlayQueue May 31 19:16:18 reveil-parents volumio[1117]: info: CorePlayQueue::saveQueue May 31 19:16:18 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:18 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushQueue May 31 19:16:18 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioAddQueueItems May 31 19:16:18 reveil-parents volumio[1117]: info: CoreStateMachine::addQueueItems May 31 19:16:18 reveil-parents volumio[1117]: info: CorePlayQueue::addQueueItems May 31 19:16:18 reveil-parents volumio[1117]: info: Preload queue cleared May 31 19:16:18 reveil-parents volumio[1117]: info: Adding Item to queue: http://icecast.radiofrance.fr/franceinter-hifi.aac May 31 19:16:18 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri May 31 19:16:18 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushQueue May 31 19:16:18 reveil-parents volumio[1117]: info: CorePlayQueue::saveQueue May 31 19:16:18 reveil-parents volumio[1117]: info: CoreStateMachine::updateTrackBlock May 31 19:16:18 reveil-parents volumio[1117]: info: CorePlayQueue::getTrackBlock May 31 19:16:18 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPlay May 31 19:16:18 reveil-parents volumio[1117]: info: CoreStateMachine::play index 0 May 31 19:16:18 reveil-parents volumio[1117]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 19:16:18 reveil-parents volumio[1117]: info: CoreStateMachine::stop May 31 19:16:18 reveil-parents volumio[1117]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 19:16:18 reveil-parents volumio[1117]: info: CoreStateMachine::play index undefined May 31 19:16:18 reveil-parents volumio[1117]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 19:16:18 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:18 reveil-parents volumio[1117]: info: CoreStateMachine::startPlaybackTimer May 31 19:16:18 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:18 reveil-parents volumio[1117]: info: [1780247778236] ControllerWebradio::clearAddPlayTrack May 31 19:16:18 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand stop May 31 19:16:18 reveil-parents volumio[1117]: info: May 31 19:16:18 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:16:18 reveil-parents volumio[1117]: info: sendMpdCommand stop took 30 milliseconds May 31 19:16:18 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:16:18 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:16:18 reveil-parents volumio[1117]: info: sendMpdCommand stop took 7 milliseconds May 31 19:16:18 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand clear May 31 19:16:18 reveil-parents volumio[1117]: info: May 31 19:16:18 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:16:18 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:16:18 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:16:18 reveil-parents volumio[1117]: info: May 31 19:16:18 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:16:18 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:16:18 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:16:18 reveil-parents volumio[1117]: info: Received response: {"time":1780247778196,"response":"playplaylist Success"} May 31 19:16:18 reveil-parents volumio[1117]: info: Playlist "Reveil France inter" started. May 31 19:16:18 reveil-parents volumio[1117]: info: Getting current volume May 31 19:16:18 reveil-parents volumio[1117]: info: May 31 19:16:18 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:16:18 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:16:18 reveil-parents volumio[1117]: info: sendMpdCommand status took 17 milliseconds May 31 19:16:18 reveil-parents volumio[1117]: info: sendMpdCommand clear took 17 milliseconds May 31 19:16:18 reveil-parents volumio[1117]: info: sendMpdCommand status took 16 milliseconds May 31 19:16:18 reveil-parents volumio[1117]: info: sendMpdCommand status took 15 milliseconds May 31 19:16:18 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:16:18 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 19:16:18 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand load "http://icecast.radiofrance.fr/franceinter-hifi.aac" May 31 19:16:18 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:16:18 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:16:18 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:16:18 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:16:18 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:18 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:18 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:18 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:18 reveil-parents volumio[1117]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd May 31 19:16:18 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:16:18 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:16:18 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:18 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:18 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:18 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:18 reveil-parents volumio[1117]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd May 31 19:16:18 reveil-parents volumio[1117]: info: ------------------------------ 30ms May 31 19:16:18 reveil-parents volumio[1117]: info: ------------------------------ 30ms May 31 19:16:18 reveil-parents volumio[1117]: info: May 31 19:16:18 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:16:18 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:16:18 reveil-parents volumio[1117]: info: May 31 19:16:18 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:16:18 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:16:18 reveil-parents volumio[1117]: error: updateQueue error: null May 31 19:16:18 reveil-parents volumio[1117]: info: ------------------------------ 30ms May 31 19:16:18 reveil-parents volumio[1117]: info: sendMpdCommand playlistinfo took 20 milliseconds May 31 19:16:18 reveil-parents volumio[1117]: verbose: ControllerMpd::parseTrackInfo May 31 19:16:18 reveil-parents volumio[1117]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') May 31 19:16:18 reveil-parents volumio[1117]: info: ------------------------------ 43ms May 31 19:16:18 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:16:18 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:18 reveil-parents volumio[1117]: info: Current volume is 20 May 31 19:16:18 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 21 May 31 19:16:18 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=21 May 31 19:16:18 reveil-parents volumio[1117]: info: May 31 19:16:18 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 21 May 31 19:16:18 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume21 May 31 19:16:18 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:18 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:18 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:16:18 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:18 reveil-parents volumio[1117]: info: Received response: {"time":1780247778302,"response":"volume Success"} May 31 19:16:18 reveil-parents volumio[1117]: info: Volume set to 21 May 31 19:16:18 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand add "http://icecast.radiofrance.fr/franceinter-hifi.aac" May 31 19:16:18 reveil-parents volumio[1117]: error: updateQueue error: null May 31 19:16:18 reveil-parents volumio[1117]: error: updateQueue error: null May 31 19:16:18 reveil-parents volumio[1117]: info: May 31 19:16:18 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:16:18 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:16:18 reveil-parents volumio[1117]: info: ------------------------------ 424ms May 31 19:16:18 reveil-parents volumio[1117]: info: ------------------------------ 422ms May 31 19:16:18 reveil-parents volumio[1117]: info: sendMpdCommand add "http://icecast.radiofrance.fr/franceinter-hifi.aac" took 3 milliseconds May 31 19:16:18 reveil-parents volumio[1117]: info: CoreStateMachine::setConsumeUpdateService mpd May 31 19:16:18 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand play May 31 19:16:18 reveil-parents volumio[1117]: info: May 31 19:16:18 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:16:18 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:16:18 reveil-parents volumio[1117]: info: May 31 19:16:18 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:16:18 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:16:18 reveil-parents volumio[1117]: info: ------------------------------ 6ms May 31 19:16:18 reveil-parents volumio[1117]: info: sendMpdCommand play took 6 milliseconds May 31 19:16:18 reveil-parents volumio[1117]: info: ------------------------------ 5ms May 31 19:16:18 reveil-parents volumio[1117]: info: ------------------------------ 3ms May 31 19:16:19 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPlay May 31 19:16:19 reveil-parents volumio[1117]: info: CoreStateMachine::play index undefined May 31 19:16:19 reveil-parents volumio[1117]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 19:16:19 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:19 reveil-parents volumio[1117]: info: CoreStateMachine::startPlaybackTimer May 31 19:16:19 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:19 reveil-parents volumio[1117]: info: [1780247779216] ControllerWebradio::clearAddPlayTrack May 31 19:16:19 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand stop May 31 19:16:19 reveil-parents volumio[1117]: info: May 31 19:16:19 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:16:19 reveil-parents volumio[1117]: info: sendMpdCommand stop took 2 milliseconds May 31 19:16:19 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:16:19 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:16:19 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand clear May 31 19:16:19 reveil-parents volumio[1117]: info: May 31 19:16:19 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:16:19 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:16:19 reveil-parents volumio[1117]: info: sendMpdCommand status took 1 milliseconds May 31 19:16:19 reveil-parents volumio[1117]: info: sendMpdCommand clear took 2 milliseconds May 31 19:16:19 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:16:19 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 19:16:19 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand load "http://icecast.radiofrance.fr/franceinter-hifi.aac" May 31 19:16:19 reveil-parents volumio[1117]: info: May 31 19:16:19 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:16:19 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:16:19 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:16:19 reveil-parents volumio[1117]: info: May 31 19:16:19 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:16:19 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:16:19 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:16:19 reveil-parents volumio[1117]: error: updateQueue error: null May 31 19:16:19 reveil-parents volumio[1117]: info: ------------------------------ 6ms May 31 19:16:19 reveil-parents volumio[1117]: info: sendMpdCommand playlistinfo took 5 milliseconds May 31 19:16:19 reveil-parents volumio[1117]: verbose: ControllerMpd::parseTrackInfo May 31 19:16:19 reveil-parents volumio[1117]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') May 31 19:16:19 reveil-parents volumio[1117]: info: ------------------------------ 10ms May 31 19:16:19 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand add "http://icecast.radiofrance.fr/franceinter-hifi.aac" May 31 19:16:19 reveil-parents volumio[1117]: info: May 31 19:16:19 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:16:19 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:16:19 reveil-parents volumio[1117]: info: sendMpdCommand status took 431 milliseconds May 31 19:16:19 reveil-parents volumio[1117]: info: sendMpdCommand status took 431 milliseconds May 31 19:16:19 reveil-parents volumio[1117]: info: sendMpdCommand add "http://icecast.radiofrance.fr/franceinter-hifi.aac" took 3 milliseconds May 31 19:16:19 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:16:19 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:16:19 reveil-parents volumio[1117]: info: CoreStateMachine::setConsumeUpdateService mpd May 31 19:16:19 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand play May 31 19:16:19 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:16:19 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:16:19 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:19 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:16:19 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:19 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:19 reveil-parents volumio[1117]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 31 19:16:19 reveil-parents volumio[1117]: verbose: CURRENT POSITION 0 May 31 19:16:19 reveil-parents volumio[1117]: info: CoreStateMachine::syncState stateService stop May 31 19:16:19 reveil-parents volumio[1117]: info: CoreStateMachine::syncState currentStatus stop May 31 19:16:19 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:19 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:19 reveil-parents volumio[1117]: info: No code May 31 19:16:19 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:19 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:19 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:16:19 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:16:19 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:19 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:19 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:19 reveil-parents volumio[1117]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 31 19:16:19 reveil-parents volumio[1117]: verbose: CURRENT POSITION 0 May 31 19:16:19 reveil-parents volumio[1117]: info: CoreStateMachine::syncState stateService stop May 31 19:16:19 reveil-parents volumio[1117]: info: CoreStateMachine::syncState currentStatus stop May 31 19:16:19 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:19 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:19 reveil-parents volumio[1117]: info: No code May 31 19:16:19 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:19 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:19 reveil-parents volumio[1117]: info: ------------------------------ 466ms May 31 19:16:19 reveil-parents volumio[1117]: info: ------------------------------ 465ms May 31 19:16:19 reveil-parents volumio[1117]: info: May 31 19:16:19 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:16:19 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:16:19 reveil-parents volumio[1117]: info: May 31 19:16:19 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:16:19 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:16:19 reveil-parents volumio[1117]: info: ------------------------------ 40ms May 31 19:16:19 reveil-parents volumio[1117]: info: sendMpdCommand play took 38 milliseconds May 31 19:16:19 reveil-parents volumio[1117]: info: ------------------------------ 4ms May 31 19:16:19 reveil-parents volumio[1117]: info: ------------------------------ 3ms May 31 19:16:19 reveil-parents volumio[1117]: info: May 31 19:16:19 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:16:19 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:16:19 reveil-parents volumio[1117]: info: May 31 19:16:19 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:16:19 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:16:19 reveil-parents volumio[1117]: info: ------------------------------ 10ms May 31 19:16:19 reveil-parents volumio[1117]: info: ------------------------------ 11ms May 31 19:16:20 reveil-parents volumio[1117]: info: May 31 19:16:20 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:16:20 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:16:20 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:16:20 reveil-parents volumio[1117]: info: May 31 19:16:20 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:16:20 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:16:20 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:16:20 reveil-parents volumio[1117]: info: May 31 19:16:20 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:16:20 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:16:20 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:16:20 reveil-parents volumio[1117]: info: sendMpdCommand status took 30 milliseconds May 31 19:16:20 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:16:20 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 19:16:20 reveil-parents volumio[1117]: info: May 31 19:16:20 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:16:20 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:16:20 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:16:20 reveil-parents volumio[1117]: info: May 31 19:16:20 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:16:20 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:16:20 reveil-parents volumio[1117]: info: May 31 19:16:20 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:16:20 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:16:20 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:16:20 reveil-parents volumio[1117]: info: sendMpdCommand status took 33 milliseconds May 31 19:16:20 reveil-parents volumio[1117]: info: sendMpdCommand status took 32 milliseconds May 31 19:16:20 reveil-parents volumio[1117]: info: sendMpdCommand playlistinfo took 4 milliseconds May 31 19:16:20 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:16:20 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 19:16:20 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:16:20 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 19:16:20 reveil-parents volumio[1117]: verbose: ControllerMpd::parseTrackInfo May 31 19:16:20 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:16:20 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:16:20 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:20 reveil-parents volumio[1117]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"franceinter-hifi.aac","artist":"franceinter-hifi.aac","album":null,"uri":"http://icecast.radiofrance.fr/franceinter-hifi.aac","trackType":"aac"} May 31 19:16:20 reveil-parents volumio[1117]: verbose: CURRENT POSITION 0 May 31 19:16:20 reveil-parents volumio[1117]: info: CoreStateMachine::syncState stateService play May 31 19:16:20 reveil-parents volumio[1117]: info: CoreStateMachine::syncState currentStatus stop May 31 19:16:20 reveil-parents volumio[1117]: info: ------------------------------ 39ms May 31 19:16:20 reveil-parents volumio[1117]: info: May 31 19:16:20 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:16:20 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:16:20 reveil-parents volumio[1117]: info: May 31 19:16:20 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:16:20 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:16:20 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:16:20 reveil-parents volumio[1117]: info: May 31 19:16:20 reveil-parents volumio[1117]: ---------------------------- MPD announces system playlist update May 31 19:16:20 reveil-parents volumio[1117]: info: Ignoring MPD Status Update May 31 19:16:20 reveil-parents volumio[1117]: info: sendMpdCommand status took 11 milliseconds May 31 19:16:20 reveil-parents volumio[1117]: info: ------------------------------ 10ms May 31 19:16:20 reveil-parents volumio[1117]: info: sendMpdCommand status took 9 milliseconds May 31 19:16:20 reveil-parents volumio[1117]: info: sendMpdCommand playlistinfo took 8 milliseconds May 31 19:16:20 reveil-parents volumio[1117]: info: sendMpdCommand playlistinfo took 7 milliseconds May 31 19:16:20 reveil-parents volumio[1117]: info: ------------------------------ 5ms May 31 19:16:20 reveil-parents volumio[1117]: info: sendMpdCommand status took 4 milliseconds May 31 19:16:20 reveil-parents volumio[1117]: info: ------------------------------ 3ms May 31 19:16:20 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:16:20 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 19:16:20 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:16:20 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 19:16:20 reveil-parents volumio[1117]: verbose: ControllerMpd::parseTrackInfo May 31 19:16:20 reveil-parents volumio[1117]: verbose: ControllerMpd::parseTrackInfo May 31 19:16:20 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:16:20 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 19:16:20 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:16:20 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:16:20 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:20 reveil-parents volumio[1117]: verbose: STATE SERVICE {"status":"play","position":0,"seek":252,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"franceinter-hifi.aac","artist":"franceinter-hifi.aac","album":null,"uri":"http://icecast.radiofrance.fr/franceinter-hifi.aac","trackType":"aac"} May 31 19:16:20 reveil-parents volumio[1117]: verbose: CURRENT POSITION 0 May 31 19:16:20 reveil-parents volumio[1117]: info: CoreStateMachine::syncState stateService play May 31 19:16:20 reveil-parents volumio[1117]: info: CoreStateMachine::syncState currentStatus play May 31 19:16:20 reveil-parents volumio[1117]: info: Received an update from plugin. extracting info from payload May 31 19:16:20 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 31 19:16:20 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:20 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:20 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:16:20 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:20 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:20 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:20 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:16:20 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:16:20 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:20 reveil-parents volumio[1117]: verbose: STATE SERVICE {"status":"play","position":0,"seek":336,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"franceinter-hifi.aac","artist":"franceinter-hifi.aac","album":null,"uri":"http://icecast.radiofrance.fr/franceinter-hifi.aac","trackType":"aac"} May 31 19:16:20 reveil-parents volumio[1117]: verbose: CURRENT POSITION 0 May 31 19:16:20 reveil-parents volumio[1117]: info: CoreStateMachine::syncState stateService play May 31 19:16:20 reveil-parents volumio[1117]: info: CoreStateMachine::syncState currentStatus play May 31 19:16:20 reveil-parents volumio[1117]: info: Received an update from plugin. extracting info from payload May 31 19:16:20 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 31 19:16:20 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:20 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:20 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:20 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:20 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:20 reveil-parents volumio[1117]: info: ------------------------------ 71ms May 31 19:16:20 reveil-parents volumio[1117]: info: ------------------------------ 70ms May 31 19:16:20 reveil-parents volumio[1117]: info: sendMpdCommand playlistinfo took 29 milliseconds May 31 19:16:20 reveil-parents volumio[1117]: info: sendMpdCommand playlistinfo took 30 milliseconds May 31 19:16:20 reveil-parents volumio[1117]: info: sendMpdCommand playlistinfo took 29 milliseconds May 31 19:16:20 reveil-parents volumio[1117]: verbose: ControllerMpd::parseTrackInfo May 31 19:16:20 reveil-parents volumio[1117]: verbose: ControllerMpd::parseTrackInfo May 31 19:16:20 reveil-parents volumio[1117]: verbose: ControllerMpd::parseTrackInfo May 31 19:16:20 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:16:20 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:16:20 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:20 reveil-parents volumio[1117]: verbose: STATE SERVICE {"status":"play","position":0,"seek":989,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"franceinter-hifi.aac","artist":"franceinter-hifi.aac","album":null,"uri":"http://icecast.radiofrance.fr/franceinter-hifi.aac","trackType":"aac"} May 31 19:16:20 reveil-parents volumio[1117]: verbose: CURRENT POSITION 0 May 31 19:16:20 reveil-parents volumio[1117]: info: CoreStateMachine::syncState stateService play May 31 19:16:20 reveil-parents volumio[1117]: info: CoreStateMachine::syncState currentStatus play May 31 19:16:20 reveil-parents volumio[1117]: info: Received an update from plugin. extracting info from payload May 31 19:16:20 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 31 19:16:20 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:20 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:20 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:20 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:20 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:20 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:16:20 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:16:20 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:20 reveil-parents volumio[1117]: verbose: STATE SERVICE {"status":"play","position":0,"seek":989,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"franceinter-hifi.aac","artist":"franceinter-hifi.aac","album":null,"uri":"http://icecast.radiofrance.fr/franceinter-hifi.aac","trackType":"aac"} May 31 19:16:20 reveil-parents volumio[1117]: verbose: CURRENT POSITION 0 May 31 19:16:20 reveil-parents volumio[1117]: info: CoreStateMachine::syncState stateService play May 31 19:16:20 reveil-parents volumio[1117]: info: CoreStateMachine::syncState currentStatus play May 31 19:16:20 reveil-parents volumio[1117]: info: Received an update from plugin. extracting info from payload May 31 19:16:20 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 31 19:16:20 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:20 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:20 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:20 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:20 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:20 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:16:20 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:16:20 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:20 reveil-parents volumio[1117]: verbose: STATE SERVICE {"status":"play","position":0,"seek":989,"duration":0,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"franceinter-hifi.aac","artist":"franceinter-hifi.aac","album":null,"uri":"http://icecast.radiofrance.fr/franceinter-hifi.aac","trackType":"aac"} May 31 19:16:20 reveil-parents volumio[1117]: verbose: CURRENT POSITION 0 May 31 19:16:20 reveil-parents volumio[1117]: info: CoreStateMachine::syncState stateService play May 31 19:16:20 reveil-parents volumio[1117]: info: CoreStateMachine::syncState currentStatus play May 31 19:16:20 reveil-parents volumio[1117]: info: Received an update from plugin. extracting info from payload May 31 19:16:20 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt May 31 19:16:20 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:20 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:20 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:20 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:20 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:20 reveil-parents volumio[1117]: info: ------------------------------ 80ms May 31 19:16:20 reveil-parents volumio[1117]: info: ------------------------------ 79ms May 31 19:16:20 reveil-parents volumio[1117]: info: ------------------------------ 75ms May 31 19:16:21 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioStop May 31 19:16:21 reveil-parents volumio[1117]: info: CoreStateMachine::stop May 31 19:16:21 reveil-parents volumio[1117]: info: CoreStateMachine::setConsumeUpdateService undefined May 31 19:16:21 reveil-parents volumio[1117]: info: CoreStateMachine::stPlaybackTimer May 31 19:16:21 reveil-parents volumio[1117]: info: CoreStateMachine::updateTrackBlock May 31 19:16:21 reveil-parents volumio[1117]: info: CorePlayQueue::getTrackBlock May 31 19:16:21 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:21 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:21 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:16:21 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:21 reveil-parents volumio[1117]: info: CoreStateMachine::serviceStop May 31 19:16:21 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:21 reveil-parents volumio[1117]: info: CoreCommandRouter::serviceStop May 31 19:16:21 reveil-parents volumio[1117]: info: [1780247781612] ControllerWebradio::stop May 31 19:16:21 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand stop May 31 19:16:21 reveil-parents volumio[1117]: info: May 31 19:16:21 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:16:21 reveil-parents volumio[1117]: info: sendMpdCommand stop took 11 milliseconds May 31 19:16:21 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:16:21 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:16:21 reveil-parents volumio[1117]: info: May 31 19:16:21 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:16:21 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:16:21 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:16:21 reveil-parents volumio[1117]: info: May 31 19:16:21 reveil-parents volumio[1117]: ---------------------------- MPD announces state update: player May 31 19:16:21 reveil-parents volumio[1117]: info: ControllerMpd::getState May 31 19:16:21 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand status May 31 19:16:21 reveil-parents volumio[1117]: info: sendMpdCommand status took 6 milliseconds May 31 19:16:21 reveil-parents volumio[1117]: info: sendMpdCommand status took 3 milliseconds May 31 19:16:21 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:16:21 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 19:16:21 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:16:21 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 19:16:21 reveil-parents volumio[1117]: info: sendMpdCommand status took 4 milliseconds May 31 19:16:21 reveil-parents volumio[1117]: info: sendMpdCommand playlistinfo took 2 milliseconds May 31 19:16:21 reveil-parents volumio[1117]: info: sendMpdCommand playlistinfo took 2 milliseconds May 31 19:16:21 reveil-parents volumio[1117]: verbose: ControllerMpd::parseState May 31 19:16:21 reveil-parents volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 31 19:16:21 reveil-parents volumio[1117]: verbose: ControllerMpd::parseTrackInfo May 31 19:16:21 reveil-parents volumio[1117]: verbose: ControllerMpd::parseTrackInfo May 31 19:16:21 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:16:21 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:16:21 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:21 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:21 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:16:21 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:21 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:21 reveil-parents volumio[1117]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd May 31 19:16:21 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:16:21 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:16:21 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:21 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:21 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:21 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:21 reveil-parents volumio[1117]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd May 31 19:16:21 reveil-parents volumio[1117]: info: ------------------------------ 22ms May 31 19:16:21 reveil-parents volumio[1117]: info: ------------------------------ 19ms May 31 19:16:21 reveil-parents volumio[1117]: info: sendMpdCommand playlistinfo took 13 milliseconds May 31 19:16:21 reveil-parents volumio[1117]: verbose: ControllerMpd::parseTrackInfo May 31 19:16:21 reveil-parents volumio[1117]: info: ControllerMpd::pushState May 31 19:16:21 reveil-parents volumio[1117]: info: CoreCommandRouter::servicePushState May 31 19:16:21 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:21 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:21 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:21 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:21 reveil-parents volumio[1117]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd May 31 19:16:21 reveil-parents volumio[1117]: info: ------------------------------ 27ms May 31 19:16:22 reveil-parents volumio[1117]: info: Getting current volume May 31 19:16:22 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:16:22 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:22 reveil-parents volumio[1117]: info: Current volume is 21 May 31 19:16:22 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 22 May 31 19:16:22 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=22 May 31 19:16:22 reveil-parents volumio[1117]: info: May 31 19:16:22 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 22 May 31 19:16:22 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume22 May 31 19:16:22 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:22 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:22 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:16:22 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:22 reveil-parents volumio[1117]: info: Received response: {"time":1780247782201,"response":"volume Success"} May 31 19:16:22 reveil-parents volumio[1117]: info: Volume set to 22 May 31 19:16:22 reveil-parents volumio[1117]: info: Getting current volume May 31 19:16:22 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:16:22 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:22 reveil-parents volumio[1117]: info: Current volume is 22 May 31 19:16:22 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 23 May 31 19:16:22 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=23 May 31 19:16:22 reveil-parents volumio[1117]: info: May 31 19:16:22 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 23 May 31 19:16:22 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume23 May 31 19:16:22 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:22 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:22 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:16:22 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:22 reveil-parents volumio[1117]: info: Received response: {"time":1780247782252,"response":"volume Success"} May 31 19:16:22 reveil-parents volumio[1117]: info: Volume set to 23 May 31 19:16:30 reveil-parents volumio[1117]: info: Getting current volume May 31 19:16:30 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:16:30 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:30 reveil-parents volumio[1117]: info: Current volume is 23 May 31 19:16:30 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 24 May 31 19:16:30 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=24 May 31 19:16:30 reveil-parents volumio[1117]: info: May 31 19:16:30 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 24 May 31 19:16:30 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume24 May 31 19:16:30 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:30 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:30 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:16:30 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:30 reveil-parents volumio[1117]: info: Received response: {"time":1780247790458,"response":"volume Success"} May 31 19:16:30 reveil-parents volumio[1117]: info: Volume set to 24 May 31 19:16:31 reveil-parents volumio[1117]: info: Getting current volume May 31 19:16:31 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:16:31 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:31 reveil-parents volumio[1117]: info: Current volume is 24 May 31 19:16:31 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 25 May 31 19:16:31 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=25 May 31 19:16:31 reveil-parents volumio[1117]: info: May 31 19:16:31 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 25 May 31 19:16:31 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume25 May 31 19:16:31 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:31 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:31 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:16:31 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:31 reveil-parents volumio[1117]: info: Received response: {"time":1780247791185,"response":"volume Success"} May 31 19:16:31 reveil-parents volumio[1117]: info: Volume set to 25 May 31 19:16:33 reveil-parents volumio[1117]: info: Getting current volume May 31 19:16:33 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:16:33 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:33 reveil-parents volumio[1117]: info: Current volume is 25 May 31 19:16:33 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 26 May 31 19:16:33 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=26 May 31 19:16:33 reveil-parents volumio[1117]: info: May 31 19:16:33 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 26 May 31 19:16:33 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume26 May 31 19:16:33 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:33 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:33 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:16:33 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:33 reveil-parents volumio[1117]: info: Received response: {"time":1780247793092,"response":"volume Success"} May 31 19:16:33 reveil-parents volumio[1117]: info: Volume set to 26 May 31 19:16:33 reveil-parents volumio[1117]: info: Getting current volume May 31 19:16:33 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:16:33 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:33 reveil-parents volumio[1117]: info: Current volume is 26 May 31 19:16:33 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 27 May 31 19:16:33 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=27 May 31 19:16:33 reveil-parents volumio[1117]: info: May 31 19:16:33 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 27 May 31 19:16:33 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume27 May 31 19:16:33 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:33 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:33 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:16:33 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:33 reveil-parents volumio[1117]: info: Received response: {"time":1780247793364,"response":"volume Success"} May 31 19:16:33 reveil-parents volumio[1117]: info: Volume set to 27 May 31 19:16:37 reveil-parents volumio[1117]: info: Getting current volume May 31 19:16:37 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:16:37 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:37 reveil-parents volumio[1117]: info: Current volume is 27 May 31 19:16:37 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 28 May 31 19:16:37 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=28 May 31 19:16:37 reveil-parents volumio[1117]: info: May 31 19:16:37 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 28 May 31 19:16:37 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume28 May 31 19:16:37 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:37 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:37 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:16:37 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:37 reveil-parents volumio[1117]: info: Received response: {"time":1780247797249,"response":"volume Success"} May 31 19:16:37 reveil-parents volumio[1117]: info: Volume set to 28 May 31 19:16:37 reveil-parents volumio[1117]: info: Getting current volume May 31 19:16:37 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioGetState May 31 19:16:37 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:37 reveil-parents volumio[1117]: info: Current volume is 28 May 31 19:16:37 reveil-parents volumio[1117]: info: Increasing volume by 1: setting volume to 29 May 31 19:16:37 reveil-parents volumio[1117]: info: Sending REST command to localhost:3000/api/v1/commands/?cmd=volume&volume=29 May 31 19:16:37 reveil-parents volumio[1117]: info: May 31 19:16:37 reveil-parents volumio[1117]: ---------------------------- Client requests Volume 29 May 31 19:16:37 reveil-parents volumio[1117]: info: VolumeController::SetAlsaVolume29 May 31 19:16:37 reveil-parents volumio[1117]: info: CoreStateMachine::pushState May 31 19:16:37 reveil-parents volumio[1117]: info: CorePlayQueue::getTrack 0 May 31 19:16:37 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 19:16:37 reveil-parents volumio[1117]: info: CoreCommandRouter::volumioPushState May 31 19:16:37 reveil-parents volumio[1117]: info: Received response: {"time":1780247797297,"response":"volume Success"} May 31 19:16:37 reveil-parents volumio[1117]: info: Volume set to 29 May 31 19:16:37 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 31 19:16:37 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 31 19:16:41 reveil-parents volumio[1117]: info: Starting Uninstall of plugin system_controller - SleepWakePlugin May 31 19:16:41 reveil-parents volumio[1117]: info: Uninstalling plugin SleepWakePlugin May 31 19:16:41 reveil-parents volumio[1117]: info: SleepWakePlugin - onStop May 31 19:16:41 reveil-parents volumio5-onboarding[1686]: time=2026-05-31T19:16:41.756+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 31 19:16:41 reveil-parents volumio[1117]: info: Disabling plugin SleepWakePlugin May 31 19:16:41 reveil-parents volumio5-onboarding[1686]: time=2026-05-31T19:16:41.762+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 31 19:16:41 reveil-parents volumio[1117]: info: Checking if uninstall.sh is present May 31 19:16:41 reveil-parents volumio[1117]: info: Executing uninstall.sh May 31 19:16:41 reveil-parents sudo[9820]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/system_controller/SleepWakePlugin/uninstall.sh May 31 19:16:41 reveil-parents sudo[9820]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 31 19:16:41 reveil-parents sudo[9820]: pam_unix(sudo:session): session closed for user root May 31 19:16:41 reveil-parents volumio[1117]: info: Uninstall script completed May 31 19:16:41 reveil-parents volumio5-onboarding[1686]: time=2026-05-31T19:16:41.920+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 31 19:16:41 reveil-parents volumio[1117]: info: Removing plugin SleepWakePlugin from configuration May 31 19:16:42 reveil-parents volumio[1117]: info: Successfully removed SleepWakePlugin configuration files May 31 19:16:42 reveil-parents volumio[1117]: info: Plugin folders cleanup May 31 19:16:42 reveil-parents volumio[1117]: info: Scanning into folder /volumio/app/plugins/ May 31 19:16:42 reveil-parents volumio5-onboarding[1686]: time=2026-05-31T19:16:42.062+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 31 19:16:42 reveil-parents volumio[1117]: info: Scanning category audio_interface May 31 19:16:42 reveil-parents volumio[1117]: info: Scanning category miscellanea May 31 19:16:42 reveil-parents volumio[1117]: info: Scanning category music_service May 31 19:16:42 reveil-parents volumio[1117]: info: Scanning category plugins.json May 31 19:16:42 reveil-parents volumio[1117]: info: Scanning category system_controller May 31 19:16:42 reveil-parents volumio[1117]: info: Scanning category user_interface May 31 19:16:42 reveil-parents volumio[1117]: info: Scanning into folder /data/plugins/ May 31 19:16:42 reveil-parents volumio[1117]: info: Scanning category system_controller May 31 19:16:42 reveil-parents volumio[1117]: info: Cleaning folder for SleepWakePlugin May 31 19:16:42 reveil-parents volumio[1117]: info: Scanning category system_hardware May 31 19:16:42 reveil-parents volumio[1117]: info: Scanning category user_interface May 31 19:16:42 reveil-parents volumio[1117]: info: Plugin folders cleanup completed May 31 19:16:42 reveil-parents volumio5-onboarding[1686]: time=2026-05-31T19:16:42.206+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 31 19:16:42 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 31 19:16:42 reveil-parents volumio[1117]: info: [{"prettyName":"ScheduledRestart","name":"scheduledrestart","category":"system_controller","version":"1.0.0","icon":"fa-clock-o","isManuallyInstalled":false,"enabled":false,"active":false},{"prettyName":"Audiophonics ON/OFF","name":"audiophonicsonoff","category":"system_hardware","version":"2.0.5","icon":"fa fa-cogs","isManuallyInstalled":false,"enabled":false,"active":false},{"prettyName":"GPIO Buttons","name":"gpio-buttons","category":"system_hardware","version":"1.8.4","icon":"fa-microchip","isManuallyInstalled":false,"enabled":false,"active":false},{"prettyName":"GPIO Control","name":"gpio_control","category":"system_hardware","version":"2.0.11","icon":"fa-microchip","isManuallyInstalled":false,"enabled":false,"active":false},{"prettyName":"Rotary Encoder II","name":"rotaryencoder2","category":"system_hardware","version":"2.2.0","icon":"fa-circle-o-notch","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"System information","name":"Systeminfo","category":"user_interface","version":"3.0.15","icon":"fa-info-circle","isManuallyInstalled":false,"enabled":false,"active":false}] May 31 19:16:42 reveil-parents volumio[1117]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 31 19:16:45 reveil-parents volumio[1117]: info: Getting current volume May 31 19:16:45 reveil-parents volumio[1117]: error: SleepWakePlugin - Error in increaseVolume: Error: ENOENT: no such file or directory, open '/data/plugins/system_controller/SleepWakePlugin/sleep-wake-plugin.log' May 31 19:16:45 reveil-parents volumio[1117]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 31 19:16:45 reveil-parents volumio[1117]: Error: ENOENT: no such file or directory, open '/data/plugins/system_controller/SleepWakePlugin/sleep-wake-plugin.log' May 31 19:16:45 reveil-parents volumio[1117]: at Object.openSync (node:fs:602:3) May 31 19:16:45 reveil-parents volumio[1117]: at Object.writeFileSync (node:fs:2334:35) May 31 19:16:45 reveil-parents volumio[1117]: at Object.appendFileSync (node:fs:2396:6) May 31 19:16:45 reveil-parents volumio[1117]: at SleepWakePlugin.writeLog (/data/plugins/system_controller/SleepWakePlugin/index.js:827:6) May 31 19:16:45 reveil-parents volumio[1117]: at Timeout.increaseVolume [as _onTimeout] (/data/plugins/system_controller/SleepWakePlugin/index.js:802:12) May 31 19:16:45 reveil-parents volumio[1117]: at listOnTimeout (node:internal/timers:573:17) May 31 19:16:45 reveil-parents volumio[1117]: at process.processTimers (node:internal/timers:514:7) { May 31 19:16:45 reveil-parents volumio[1117]: errno: -2, May 31 19:16:45 reveil-parents volumio[1117]: syscall: 'open', May 31 19:16:45 reveil-parents volumio[1117]: code: 'ENOENT', May 31 19:16:45 reveil-parents volumio[1117]: path: '/data/plugins/system_controller/SleepWakePlugin/sleep-wake-plugin.log' May 31 19:16:45 reveil-parents volumio[1117]: } May 31 19:16:45 reveil-parents volumio[1117]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 31 19:16:46 reveil-parents sudo[9845]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-05-31 19:15' May 31 19:16:46 reveil-parents sudo[9845]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"