Dec 21 19:05:00 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:00 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:00 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:01 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:01 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:01 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:01 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:02 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:02 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:02 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:02 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:03 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:03 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:03 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:03 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:04 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:04 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:04 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:04 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:05 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:05 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:05 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:05 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:06 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:06 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:06 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:06 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:07 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:07 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:08 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:08 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:09 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:09 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:09 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:09 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:10 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:10 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:10 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:10 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:11 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:11 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:11 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:12 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:12 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:12 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:13 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:13 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:13 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:14 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:14 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:14 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:15 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:15 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:15 volumio volumio[1103]: info: VolumeController::SetAlsaVolume21 Dec 21 19:05:15 volumio volumio[1103]: info: CoreStateMachine::pushState Dec 21 19:05:15 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 21 19:05:15 volumio volumio[1103]: info: CoreCommandRouter::volumioPushState Dec 21 19:05:15 volumio volumio[1103]: info: CoreCommandRouter::volumioGetQueue Dec 21 19:05:15 volumio volumio[1103]: info: CoreStateMachine::getQueue Dec 21 19:05:15 volumio volumio[1103]: info: CorePlayQueue::getQueue Dec 21 19:05:15 volumio volumio[1103]: info: VolumeController::SetAlsaVolume26 Dec 21 19:05:15 volumio volumio[1103]: info: CoreStateMachine::pushState Dec 21 19:05:15 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 21 19:05:15 volumio volumio[1103]: info: CoreCommandRouter::volumioPushState Dec 21 19:05:15 volumio volumio[1103]: info: CoreCommandRouter::volumioGetQueue Dec 21 19:05:15 volumio volumio[1103]: info: CoreStateMachine::getQueue Dec 21 19:05:15 volumio volumio[1103]: info: CorePlayQueue::getQueue Dec 21 19:05:15 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:16 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:16 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:16 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:16 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:17 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:17 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:17 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:18 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:18 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:18 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:18 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:19 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:19 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:19 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:19 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:20 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:20 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:21 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:21 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:21 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:21 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:22 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:22 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:22 volumio volumio[1103]: info: CoreCommandRouter::volumioPlay Dec 21 19:05:22 volumio volumio[1103]: info: CoreStateMachine::play index undefined Dec 21 19:05:22 volumio volumio[1103]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 21 19:05:22 volumio volumio[1103]: info: CorePlayQueue::getTrack 1 Dec 21 19:05:22 volumio volumio[1103]: info: CoreStateMachine::startPlaybackTimer Dec 21 19:05:22 volumio volumio[1103]: info: CorePlayQueue::getTrack 1 Dec 21 19:05:22 volumio volumio[1103]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 21 19:05:22 volumio volumio[1103]: info: ControllerMpd::resume Dec 21 19:05:22 volumio volumio[1103]: verbose: ControllerMpd::sendMpdCommand play Dec 21 19:05:22 volumio volumio[1103]: info: Dec 21 19:05:22 volumio volumio[1103]: ---------------------------- MPD announces state update: player Dec 21 19:05:22 volumio volumio[1103]: info: sendMpdCommand play took 215 milliseconds Dec 21 19:05:22 volumio volumio[1103]: info: ControllerMpd::getState Dec 21 19:05:22 volumio volumio[1103]: verbose: ControllerMpd::sendMpdCommand status Dec 21 19:05:22 volumio volumio[1103]: info: Dec 21 19:05:22 volumio volumio[1103]: ---------------------------- MPD announces state update: player Dec 21 19:05:22 volumio volumio[1103]: info: ControllerMpd::getState Dec 21 19:05:22 volumio volumio[1103]: verbose: ControllerMpd::sendMpdCommand status Dec 21 19:05:22 volumio volumio[1103]: info: sendMpdCommand status took 8 milliseconds Dec 21 19:05:22 volumio volumio[1103]: info: sendMpdCommand status took 6 milliseconds Dec 21 19:05:22 volumio volumio[1103]: verbose: ControllerMpd::parseState Dec 21 19:05:22 volumio volumio[1103]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 21 19:05:22 volumio volumio[1103]: verbose: ControllerMpd::parseState Dec 21 19:05:22 volumio volumio[1103]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 21 19:05:22 volumio volumio[1103]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 21 19:05:22 volumio volumio[1103]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 21 19:05:22 volumio volumio[1103]: verbose: ControllerMpd::parseTrackInfo Dec 21 19:05:22 volumio volumio[1103]: verbose: ControllerMpd::parseTrackInfo Dec 21 19:05:22 volumio volumio[1103]: info: ControllerMpd::pushState Dec 21 19:05:22 volumio volumio[1103]: info: CoreCommandRouter::servicePushState Dec 21 19:05:22 volumio volumio[1103]: info: CorePlayQueue::getTrack 1 Dec 21 19:05:22 volumio volumio[1103]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7687,"duration":184,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1118 Kbps","isStreaming":false,"title":"Мимо меня","artist":"Filatov & Karas","album":"Мимо меня","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-77.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Daf7aa94adc18423bfee5bd89fd04840b618f29d92923b8affb0b8e82bf34049e%2Clid%3D78%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6955e25c%2F0%2F22381%2F1670fb3c.183989658.20.111095879%2Fflac-mp4&ext=.flac","trackType":"flac"} Dec 21 19:05:22 volumio volumio[1103]: verbose: CURRENT POSITION 1 Dec 21 19:05:22 volumio volumio[1103]: info: CoreStateMachine::syncState stateService play Dec 21 19:05:22 volumio volumio[1103]: info: CoreStateMachine::syncState currentStatus pause Dec 21 19:05:22 volumio volumio[1103]: info: CoreStateMachine::pushState Dec 21 19:05:22 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 21 19:05:22 volumio volumio[1103]: info: CoreCommandRouter::volumioPushState Dec 21 19:05:22 volumio volumio[1103]: info: ControllerMpd::pushState Dec 21 19:05:22 volumio volumio[1103]: info: CoreCommandRouter::servicePushState Dec 21 19:05:22 volumio volumio[1103]: info: CorePlayQueue::getTrack 1 Dec 21 19:05:22 volumio volumio[1103]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7687,"duration":184,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1118 Kbps","isStreaming":false,"title":"Мимо меня","artist":"Filatov & Karas","album":"Мимо меня","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-77.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Daf7aa94adc18423bfee5bd89fd04840b618f29d92923b8affb0b8e82bf34049e%2Clid%3D78%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6955e25c%2F0%2F22381%2F1670fb3c.183989658.20.111095879%2Fflac-mp4&ext=.flac","trackType":"flac"} Dec 21 19:05:22 volumio volumio[1103]: verbose: CURRENT POSITION 1 Dec 21 19:05:22 volumio volumio[1103]: info: CoreStateMachine::syncState stateService play Dec 21 19:05:22 volumio volumio[1103]: info: CoreStateMachine::syncState currentStatus play Dec 21 19:05:22 volumio volumio[1103]: info: Received an update from plugin. extracting info from payload Dec 21 19:05:22 volumio volumio[1103]: info: CoreStateMachine::pushState Dec 21 19:05:22 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 21 19:05:22 volumio volumio[1103]: info: CoreCommandRouter::volumioPushState Dec 21 19:05:22 volumio volumio[1103]: info: CoreStateMachine::pushState Dec 21 19:05:22 volumio volumio[1103]: info: CoreCommandRouter::volumioPushState Dec 21 19:05:22 volumio volumio[1103]: info: ------------------------------ 58ms Dec 21 19:05:22 volumio volumio[1103]: info: ------------------------------ 56ms Dec 21 19:05:22 volumio volumio[1103]: info: CoreCommandRouter::volumioGetQueue Dec 21 19:05:22 volumio volumio[1103]: info: CoreStateMachine::getQueue Dec 21 19:05:22 volumio volumio[1103]: info: CorePlayQueue::getQueue Dec 21 19:05:22 volumio volumio[1103]: info: CoreCommandRouter::volumioGetQueue Dec 21 19:05:22 volumio volumio[1103]: info: CoreStateMachine::getQueue Dec 21 19:05:22 volumio volumio[1103]: info: CorePlayQueue::getQueue Dec 21 19:05:22 volumio volumio[1103]: info: CoreCommandRouter::volumioGetQueue Dec 21 19:05:22 volumio volumio[1103]: info: CoreStateMachine::getQueue Dec 21 19:05:22 volumio volumio[1103]: info: CorePlayQueue::getQueue Dec 21 19:05:22 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:22 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:23 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:23 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:23 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:23 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:24 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:24 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:25 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:25 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:25 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:25 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:26 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:26 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:26 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:26 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:27 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:27 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:28 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:28 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:28 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:28 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:29 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:29 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:29 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:29 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:30 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:30 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:30 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:30 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:31 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:31 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:31 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:31 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:32 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:32 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:33 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:33 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:33 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:33 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:34 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:34 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:34 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:34 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:35 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:35 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:35 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:35 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:36 volumio volumio[1103]: info: CoreCommandRouter::volumioGetQueue Dec 21 19:05:36 volumio volumio[1103]: info: CoreStateMachine::getQueue Dec 21 19:05:36 volumio volumio[1103]: info: CorePlayQueue::getQueue Dec 21 19:05:36 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:36 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:37 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:37 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:37 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:37 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:38 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:38 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:38 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:38 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:39 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:39 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:39 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:39 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:40 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:40 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:41 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:41 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:41 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:41 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:42 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:42 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:43 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:43 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:43 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:43 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:44 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:44 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:44 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:44 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:44 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:45 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:45 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:46 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:46 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:47 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:47 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:47 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:47 volumio volumio[1103]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 21 19:05:47 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:48 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Dec 21 19:05:48 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 19:05:48 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 21 19:05:48 volumio volumio[1103]: info: Getting Alsa Cards List without I2S DAC Dec 21 19:05:48 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Dec 21 19:05:48 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 19:05:48 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 19:05:48 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 19:05:48 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 19:05:48 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 19:05:48 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 19:05:48 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 19:05:48 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 21 19:05:48 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Dec 21 19:05:48 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 21 19:05:49 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:49 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:49 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:49 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:50 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:50 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:51 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:51 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:51 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:51 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:52 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:52 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:52 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:52 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:53 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:53 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:53 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:53 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:54 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:54 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:54 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:54 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:55 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:55 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:55 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:55 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:56 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:56 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:57 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:57 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:57 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:57 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:57 volumio mpd_oled_plugin.sh[1635]: Failed to write to the i2c bus. Dec 21 19:05:58 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:58 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:58 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:58 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:59 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:59 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:59 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:05:59 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:06:00 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:06:00 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:06:01 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:06:01 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:06:01 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:06:01 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:06:02 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:06:02 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:06:02 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:06:02 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:06:03 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:06:03 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:06:03 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:06:03 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:06:04 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:06:04 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:06:04 volumio volumio[1103]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Dec 21 19:06:04 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Dec 21 19:06:04 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 19:06:04 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 19:06:04 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 19:06:04 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 19:06:04 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 19:06:04 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 19:06:04 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 19:06:04 volumio sudo[3736]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 21 19:06:04 volumio sudo[3736]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 19:06:04 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 19:06:04 volumio sudo[3736]: pam_unix(sudo:session): session closed for user root Dec 21 19:06:04 volumio sudo[3737]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 21 19:06:04 volumio sudo[3737]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 21 19:06:04 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 21 19:06:05 volumio volumio[1103]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 21 19:06:05 volumio systemd[1]: Stopping mpd_oled_plugin.service - MPD OLED Plugin... Dec 21 19:06:05 volumio volumio[1103]: info: MPD Permissions set Dec 21 19:06:05 volumio volumio[1103]: info: CoreCommandRouter::volumioGetState Dec 21 19:06:05 volumio systemd[1]: mpd_oled_plugin.service: Deactivated successfully. Dec 21 19:06:05 volumio systemd[1]: Stopped mpd_oled_plugin.service - MPD OLED Plugin. Dec 21 19:06:05 volumio systemd[1]: mpd_oled_plugin.service: Consumed 15.433s CPU time. Dec 21 19:06:05 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 21 19:06:05 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 21 19:06:05 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 21 19:06:05 volumio systemd[1]: mpd.service: Consumed 8.543s CPU time. Dec 21 19:06:05 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 21 19:06:05 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 21 19:06:05 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 21 19:06:05 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 21 19:06:05 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 21 19:06:06 volumio sudo[3748]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 21 19:06:06 volumio sudo[3748]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 21 19:06:06 volumio sudo[3748]: pam_unix(sudo:session): session closed for user root Dec 21 19:06:08 volumio volumio[1103]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 21 19:06:08 volumio volumio[1103]: Error: read ECONNRESET Dec 21 19:06:08 volumio volumio[1103]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:217:20) { Dec 21 19:06:08 volumio volumio[1103]: errno: -104, Dec 21 19:06:08 volumio volumio[1103]: code: 'ECONNRESET', Dec 21 19:06:08 volumio volumio[1103]: syscall: 'read' Dec 21 19:06:08 volumio volumio[1103]: } Dec 21 19:06:08 volumio volumio[1103]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 21 19:06:17 volumio mpd[3750]: 2025-12-21T19:06:17 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 21 19:06:17 volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 21 19:06:17 volumio sudo[3737]: pam_unix(sudo:session): session closed for user root Dec 21 19:06:17 volumio systemd[1]: Started mpd_oled_plugin.service - MPD OLED Plugin. Dec 21 19:06:23 volumio sudo[3802]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-21 19:05' Dec 21 19:06:23 volumio sudo[3802]: 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"