-- Logs begin at Mon 2026-01-26 21:30:23 CST, end at Mon 2026-01-26 21:48:37 CST. -- Jan 26 21:47:10 volumio-x86-784 volumio[1190]: info: CALLMETHOD: user_interface peppy_screensaver savePeppyMeterConf [object Object] Jan 26 21:47:10 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , savePeppyMeterConf Jan 26 21:47:10 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 21:47:15 volumio-x86-784 volumio[1190]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jan 26 21:47:15 volumio-x86-784 volumio[1190]: info: Retrying Login Due to Network Error Jan 26 21:47:25 volumio-x86-784 volumio[1190]: info: MyVolumio login type: Token Jan 26 21:47:26 volumio-x86-784 volumio[1190]: info: CALLMETHOD: user_interface peppy_screensaver saveVUMeterConf [object Object] Jan 26 21:47:26 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , saveVUMeterConf Jan 26 21:47:26 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 21:47:26 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioNext Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreStateMachine::next Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreStateMachine::stop Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreStateMachine::stPlaybackTimer Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreStateMachine::updateTrackBlock Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrackBlock Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreStateMachine::pushState Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 23 Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioPushState Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreStateMachine::serviceStop Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 23 Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::serviceStop Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: ControllerMpd::stop Jan 26 21:47:29 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand stop Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: Jan 26 21:47:29 volumio-x86-784 volumio[1190]: ---------------------------- MPD announces state update: player Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: sendMpdCommand stop took 28 milliseconds Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: ControllerMpd::getState Jan 26 21:47:29 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand status Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreStateMachine::play index undefined Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 24 Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreStateMachine::startPlaybackTimer Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 24 Jan 26 21:47:29 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::clearAddPlayTracks NAS/local/20-BEYOND专辑 42首/BEYOND - 原谅我今天.mp3 Jan 26 21:47:29 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand stop Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreStateMachine::updateTrackBlock Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrackBlock Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: sendMpdCommand status took 4 milliseconds Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: sendMpdCommand stop took 3 milliseconds Jan 26 21:47:29 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::parseState Jan 26 21:47:29 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 26 21:47:29 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand clear Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 26 21:47:29 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::parseTrackInfo Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: ControllerMpd::pushState Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::servicePushState Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreStateMachine::pushState Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 24 Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioPushState Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 24 Jan 26 21:47:29 volumio-x86-784 volumio[1190]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"光辉岁月","artist":"BEYOND(深度音像店)","album":"BEYOND Deliberate犹豫(超越时代纪念版)(HiFi立体环绕音质)","uri":"NAS/local/20-BEYOND专辑 42首/024.光辉岁月 (国语)-BEYOND.mp3","trackType":"mp3"} Jan 26 21:47:29 volumio-x86-784 volumio[1190]: verbose: CURRENT POSITION 24 Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreStateMachine::syncState stateService stop Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreStateMachine::syncState currentStatus stop Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreStateMachine::pushState Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 24 Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioPushState Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: No code Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreStateMachine::pushState Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 24 Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioPushState Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: ------------------------------ 24ms Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: Jan 26 21:47:29 volumio-x86-784 volumio[1190]: ---------------------------- MPD announces system playlist update Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: Ignoring MPD Status Update Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: sendMpdCommand clear took 21 milliseconds Jan 26 21:47:29 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand add "NAS/local/20-BEYOND专辑 42首/BEYOND - 原谅我今天.mp3" Jan 26 21:47:29 volumio-x86-784 volumio[1190]: error: updateQueue error: null Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: Jan 26 21:47:29 volumio-x86-784 volumio[1190]: ---------------------------- MPD announces system playlist update Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: Ignoring MPD Status Update Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: ------------------------------ 12ms Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: sendMpdCommand add "NAS/local/20-BEYOND专辑 42首/BEYOND - 原谅我今天.mp3" took 12 milliseconds Jan 26 21:47:29 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand play Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: ------------------------------ 3ms Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: sendMpdCommand play took 2 milliseconds Jan 26 21:47:29 volumio-x86-784 volumio[1190]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/BEYOND/BEYOND%20IV/f2258372-6108-474f-8c54-30fbcc7f19f7.jpg' Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: Jan 26 21:47:29 volumio-x86-784 volumio[1190]: ---------------------------- MPD announces state update: player Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: ControllerMpd::getState Jan 26 21:47:29 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand status Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: Jan 26 21:47:29 volumio-x86-784 volumio[1190]: ---------------------------- MPD announces state update: player Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: ControllerMpd::getState Jan 26 21:47:29 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand status Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: sendMpdCommand status took 23 milliseconds Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: sendMpdCommand status took 21 milliseconds Jan 26 21:47:29 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::parseState Jan 26 21:47:29 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 26 21:47:29 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::parseState Jan 26 21:47:29 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 26 21:47:29 volumio-x86-784 volumio[1190]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/BEYOND/BEYOND%20IV/f2258372-6108-474f-8c54-30fbcc7f19f7.jpg' Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 26 21:47:29 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::parseTrackInfo Jan 26 21:47:29 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::parseTrackInfo Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: ControllerMpd::pushState Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::servicePushState Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 24 Jan 26 21:47:29 volumio-x86-784 volumio[1190]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":288,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"原谅我今天","artist":"BEYOND","album":"BEYOND IV","uri":"NAS/local/20-BEYOND专辑 42首/BEYOND - 原谅我今天.mp3","trackType":"mp3"} Jan 26 21:47:29 volumio-x86-784 volumio[1190]: verbose: CURRENT POSITION 24 Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreStateMachine::syncState stateService play Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreStateMachine::syncState currentStatus stop Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: ControllerMpd::pushState Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::servicePushState Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 24 Jan 26 21:47:29 volumio-x86-784 volumio[1190]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":288,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"原谅我今天","artist":"BEYOND","album":"BEYOND IV","uri":"NAS/local/20-BEYOND专辑 42首/BEYOND - 原谅我今天.mp3","trackType":"mp3"} Jan 26 21:47:29 volumio-x86-784 volumio[1190]: verbose: CURRENT POSITION 24 Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreStateMachine::syncState stateService play Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreStateMachine::syncState currentStatus play Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: Received an update from plugin. extracting info from payload Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreStateMachine::pushState Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 24 Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioPushState Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreStateMachine::pushState Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 24 Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioPushState Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: ------------------------------ 37ms Jan 26 21:47:29 volumio-x86-784 volumio[1190]: info: ------------------------------ 37ms Jan 26 21:47:44 volumio-x86-784 volumio[1190]: info: VolumeController::SetAlsaVolume100 Jan 26 21:47:44 volumio-x86-784 volumio[1190]: info: CoreStateMachine::pushState Jan 26 21:47:44 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 24 Jan 26 21:47:44 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 21:47:44 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioPushState Jan 26 21:47:50 volumio-x86-784 volumio[1190]: info: VolumeController::SetAlsaVolume89 Jan 26 21:47:50 volumio-x86-784 volumio[1190]: info: CoreStateMachine::pushState Jan 26 21:47:50 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 24 Jan 26 21:47:50 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 21:47:50 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioPushState Jan 26 21:47:53 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 21:47:53 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 26 21:47:53 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 21:47:53 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 26 21:47:53 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 21:47:53 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 21:47:53 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 21:47:53 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 21:47:53 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 21:47:53 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 21:47:53 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 21:47:53 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 26 21:47:53 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 26 21:47:55 volumio-x86-784 volumio[1190]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jan 26 21:47:55 volumio-x86-784 volumio[1190]: info: Retrying Login Due to Network Error Jan 26 21:48:05 volumio-x86-784 volumio[1190]: info: MyVolumio login type: Token Jan 26 21:48:07 volumio-x86-784 volumio[1190]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Jan 26 21:48:07 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Jan 26 21:48:07 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioGetState Jan 26 21:48:07 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 24 Jan 26 21:48:07 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: mpd , saveResampleOptions Jan 26 21:48:07 volumio-x86-784 sudo[5693]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 26 21:48:07 volumio-x86-784 sudo[5693]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 21:48:07 volumio-x86-784 sudo[5693]: pam_unix(sudo:session): session closed for user root Jan 26 21:48:07 volumio-x86-784 volumio[1190]: info: Restoring Previous Volume level: 89 false true Jan 26 21:48:07 volumio-x86-784 volumio[1190]: info: VolumeController::SetAlsaVolume100 Jan 26 21:48:07 volumio-x86-784 sudo[5697]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 26 21:48:07 volumio-x86-784 sudo[5697]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 21:48:07 volumio-x86-784 volumio[1190]: info: Volume configurations have been set Jan 26 21:48:07 volumio-x86-784 systemd[1]: Stopping Music Player Daemon... Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jan 26 21:48:08 volumio-x86-784 systemd[1]: mpd.service: Succeeded. Jan 26 21:48:08 volumio-x86-784 systemd[1]: Stopped Music Player Daemon. Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: Disabling external Volume Control Jan 26 21:48:08 volumio-x86-784 systemd[1]: Starting Music Player Daemon... Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreStateMachine::pushState Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 24 Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioPushState Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: MPD Permissions set Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 26 21:48:08 volumio-x86-784 sudo[5703]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 26 21:48:08 volumio-x86-784 sudo[5703]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 21:48:08 volumio-x86-784 sudo[5703]: pam_unix(sudo:session): session closed for user root Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreStateMachine::pushState Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 24 Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 21:48:08 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioPushState Jan 26 21:48:10 volumio-x86-784 mpd[5717]: Jan 26 21:48 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 26 21:48:10 volumio-x86-784 systemd[1]: Started Music Player Daemon. Jan 26 21:48:10 volumio-x86-784 sudo[5697]: pam_unix(sudo:session): session closed for user root Jan 26 21:48:10 volumio-x86-784 volumio[1190]: error: updateQueue error: null Jan 26 21:48:12 volumio-x86-784 volumio[1190]: info: VolumeController::SetAlsaVolume89 Jan 26 21:48:12 volumio-x86-784 volumio[1190]: info: CoreStateMachine::pushState Jan 26 21:48:12 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 24 Jan 26 21:48:12 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 21:48:12 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioPushState Jan 26 21:48:15 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioPause Jan 26 21:48:15 volumio-x86-784 volumio[1190]: info: CoreStateMachine::pause Jan 26 21:48:15 volumio-x86-784 volumio[1190]: info: CoreStateMachine::stPlaybackTimer Jan 26 21:48:15 volumio-x86-784 volumio[1190]: info: CoreStateMachine::servicePause Jan 26 21:48:15 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 24 Jan 26 21:48:15 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::servicePause Jan 26 21:48:15 volumio-x86-784 volumio[1190]: info: ControllerMpd::pause Jan 26 21:48:15 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand pause Jan 26 21:48:15 volumio-x86-784 volumio[1190]: info: sendMpdCommand pause took 2 milliseconds Jan 26 21:48:16 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioPause Jan 26 21:48:16 volumio-x86-784 volumio[1190]: info: CoreStateMachine::pause Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioNext Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CoreStateMachine::next Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CoreStateMachine::stop Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CoreStateMachine::updateTrackBlock Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrackBlock Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CoreStateMachine::stPlaybackTimer Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CoreStateMachine::pushState Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 24 Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioPushState Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CoreStateMachine::serviceStop Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 24 Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::serviceStop Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: ControllerMpd::stop Jan 26 21:48:17 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand stop Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: sendMpdCommand stop took 11 milliseconds Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CoreStateMachine::play index undefined Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 25 Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CoreStateMachine::startPlaybackTimer Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 25 Jan 26 21:48:17 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::clearAddPlayTracks NAS/local/20-BEYOND专辑 42首/020.旧日的足迹-BEYOND.mp3 Jan 26 21:48:17 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand stop Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CoreStateMachine::updateTrackBlock Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrackBlock Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: sendMpdCommand stop took 10 milliseconds Jan 26 21:48:17 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand clear Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: Jan 26 21:48:17 volumio-x86-784 volumio[1190]: ---------------------------- MPD announces system playlist update Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: Ignoring MPD Status Update Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: sendMpdCommand clear took 1 milliseconds Jan 26 21:48:17 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand add "NAS/local/20-BEYOND专辑 42首/020.旧日的足迹-BEYOND.mp3" Jan 26 21:48:17 volumio-x86-784 volumio[1190]: error: updateQueue error: null Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: Jan 26 21:48:17 volumio-x86-784 volumio[1190]: ---------------------------- MPD announces system playlist update Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: Ignoring MPD Status Update Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: ------------------------------ 4ms Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: sendMpdCommand add "NAS/local/20-BEYOND专辑 42首/020.旧日的足迹-BEYOND.mp3" took 4 milliseconds Jan 26 21:48:17 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand play Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: ------------------------------ 3ms Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: sendMpdCommand play took 3 milliseconds Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: Jan 26 21:48:17 volumio-x86-784 volumio[1190]: ---------------------------- MPD announces state update: player Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: ControllerMpd::getState Jan 26 21:48:17 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand status Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: Jan 26 21:48:17 volumio-x86-784 volumio[1190]: ---------------------------- MPD announces state update: player Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: sendMpdCommand status took 45 milliseconds Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: ControllerMpd::getState Jan 26 21:48:17 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand status Jan 26 21:48:17 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::parseState Jan 26 21:48:17 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: sendMpdCommand status took 18 milliseconds Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 26 21:48:17 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::parseState Jan 26 21:48:17 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 26 21:48:17 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::parseTrackInfo Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: ControllerMpd::pushState Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::servicePushState Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 25 Jan 26 21:48:17 volumio-x86-784 volumio[1190]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"旧日的足迹 (live)","artist":"BEYOND(深度音像店)","album":"Beyond Live 1991 生命接触演唱会(HiFi立体环绕音质)","uri":"NAS/local/20-BEYOND专辑 42首/020.旧日的足迹-BEYOND.mp3","trackType":"mp3"} Jan 26 21:48:17 volumio-x86-784 volumio[1190]: verbose: CURRENT POSITION 25 Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CoreStateMachine::syncState stateService play Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CoreStateMachine::syncState currentStatus stop Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: ------------------------------ 68ms Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 26 21:48:17 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::parseTrackInfo Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: ControllerMpd::pushState Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::servicePushState Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 25 Jan 26 21:48:17 volumio-x86-784 volumio[1190]: verbose: STATE SERVICE {"status":"play","position":0,"seek":535,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"旧日的足迹 (live)","artist":"BEYOND(深度音像店)","album":"Beyond Live 1991 生命接触演唱会(HiFi立体环绕音质)","uri":"NAS/local/20-BEYOND专辑 42首/020.旧日的足迹-BEYOND.mp3","trackType":"mp3"} Jan 26 21:48:17 volumio-x86-784 volumio[1190]: verbose: CURRENT POSITION 25 Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CoreStateMachine::syncState stateService play Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CoreStateMachine::syncState currentStatus play Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: Received an update from plugin. extracting info from payload Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CoreStateMachine::pushState Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 25 Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioPushState Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CoreStateMachine::pushState Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 25 Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioPushState Jan 26 21:48:17 volumio-x86-784 volumio[1190]: info: ------------------------------ 36ms Jan 26 21:48:21 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioPause Jan 26 21:48:21 volumio-x86-784 volumio[1190]: info: CoreStateMachine::pause Jan 26 21:48:21 volumio-x86-784 volumio[1190]: info: CoreStateMachine::stPlaybackTimer Jan 26 21:48:21 volumio-x86-784 volumio[1190]: info: CoreStateMachine::servicePause Jan 26 21:48:21 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 25 Jan 26 21:48:21 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::servicePause Jan 26 21:48:21 volumio-x86-784 volumio[1190]: info: ControllerMpd::pause Jan 26 21:48:21 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand pause Jan 26 21:48:21 volumio-x86-784 volumio[1190]: info: Jan 26 21:48:21 volumio-x86-784 volumio[1190]: ---------------------------- MPD announces state update: player Jan 26 21:48:21 volumio-x86-784 volumio[1190]: info: sendMpdCommand pause took 3 milliseconds Jan 26 21:48:21 volumio-x86-784 volumio[1190]: info: ControllerMpd::getState Jan 26 21:48:21 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand status Jan 26 21:48:21 volumio-x86-784 volumio[1190]: info: sendMpdCommand status took 1 milliseconds Jan 26 21:48:21 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::parseState Jan 26 21:48:21 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 26 21:48:21 volumio-x86-784 volumio[1190]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 26 21:48:21 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::parseTrackInfo Jan 26 21:48:21 volumio-x86-784 volumio[1190]: info: ControllerMpd::pushState Jan 26 21:48:21 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::servicePushState Jan 26 21:48:21 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 25 Jan 26 21:48:21 volumio-x86-784 volumio[1190]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":4997,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"旧日的足迹 (live)","artist":"BEYOND(深度音像店)","album":"Beyond Live 1991 生命接触演唱会(HiFi立体环绕音质)","uri":"NAS/local/20-BEYOND专辑 42首/020.旧日的足迹-BEYOND.mp3","trackType":"mp3"} Jan 26 21:48:21 volumio-x86-784 volumio[1190]: verbose: CURRENT POSITION 25 Jan 26 21:48:21 volumio-x86-784 volumio[1190]: info: CoreStateMachine::syncState stateService pause Jan 26 21:48:21 volumio-x86-784 volumio[1190]: info: CoreStateMachine::syncState currentStatus pause Jan 26 21:48:21 volumio-x86-784 volumio[1190]: info: CoreStateMachine::pushState Jan 26 21:48:21 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 25 Jan 26 21:48:21 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 21:48:21 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioPushState Jan 26 21:48:21 volumio-x86-784 volumio[1190]: info: CoreStateMachine::stPlaybackTimer Jan 26 21:48:21 volumio-x86-784 volumio[1190]: info: ------------------------------ 13ms Jan 26 21:48:22 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioPlay Jan 26 21:48:22 volumio-x86-784 volumio[1190]: info: CoreStateMachine::play index undefined Jan 26 21:48:22 volumio-x86-784 volumio[1190]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 26 21:48:22 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 25 Jan 26 21:48:22 volumio-x86-784 volumio[1190]: info: CoreStateMachine::startPlaybackTimer Jan 26 21:48:22 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 25 Jan 26 21:48:22 volumio-x86-784 volumio[1190]: info: ControllerMpd::resume Jan 26 21:48:22 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand play Jan 26 21:48:22 volumio-x86-784 volumio[1190]: info: Jan 26 21:48:22 volumio-x86-784 volumio[1190]: ---------------------------- MPD announces state update: player Jan 26 21:48:22 volumio-x86-784 volumio[1190]: info: sendMpdCommand play took 33 milliseconds Jan 26 21:48:22 volumio-x86-784 volumio[1190]: info: ControllerMpd::getState Jan 26 21:48:22 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand status Jan 26 21:48:22 volumio-x86-784 volumio[1190]: info: sendMpdCommand status took 6 milliseconds Jan 26 21:48:22 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::parseState Jan 26 21:48:22 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 26 21:48:22 volumio-x86-784 volumio[1190]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 26 21:48:22 volumio-x86-784 volumio[1190]: verbose: ControllerMpd::parseTrackInfo Jan 26 21:48:22 volumio-x86-784 volumio[1190]: info: ControllerMpd::pushState Jan 26 21:48:22 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::servicePushState Jan 26 21:48:22 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 25 Jan 26 21:48:22 volumio-x86-784 volumio[1190]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5611,"duration":262,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"旧日的足迹 (live)","artist":"BEYOND(深度音像店)","album":"Beyond Live 1991 生命接触演唱会(HiFi立体环绕音质)","uri":"NAS/local/20-BEYOND专辑 42首/020.旧日的足迹-BEYOND.mp3","trackType":"mp3"} Jan 26 21:48:22 volumio-x86-784 volumio[1190]: verbose: CURRENT POSITION 25 Jan 26 21:48:22 volumio-x86-784 volumio[1190]: info: CoreStateMachine::syncState stateService play Jan 26 21:48:22 volumio-x86-784 volumio[1190]: info: CoreStateMachine::syncState currentStatus pause Jan 26 21:48:22 volumio-x86-784 volumio[1190]: info: CoreStateMachine::pushState Jan 26 21:48:22 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 25 Jan 26 21:48:22 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 21:48:22 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioPushState Jan 26 21:48:22 volumio-x86-784 volumio[1190]: info: ------------------------------ 19ms Jan 26 21:48:24 volumio-x86-784 volumio[1190]: info: VolumeController::SetAlsaVolume65 Jan 26 21:48:24 volumio-x86-784 volumio[1190]: info: CoreStateMachine::pushState Jan 26 21:48:24 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 25 Jan 26 21:48:24 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 21:48:24 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioPushState Jan 26 21:48:25 volumio-x86-784 volumio[1190]: info: VolumeController::SetAlsaVolume69 Jan 26 21:48:25 volumio-x86-784 volumio[1190]: info: CoreStateMachine::pushState Jan 26 21:48:25 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 25 Jan 26 21:48:25 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 21:48:25 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioPushState Jan 26 21:48:26 volumio-x86-784 volumio[1190]: info: VolumeController::SetAlsaVolume88 Jan 26 21:48:26 volumio-x86-784 volumio[1190]: info: CoreStateMachine::pushState Jan 26 21:48:26 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 25 Jan 26 21:48:26 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 21:48:26 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioPushState Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CALLMETHOD: audio_interface alsa_controller saveVolumeOptions [object Object] Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveVolumeOptions Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioGetState Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 25 Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: mpd , saveResampleOptions Jan 26 21:48:33 volumio-x86-784 sudo[5836]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 26 21:48:33 volumio-x86-784 sudo[5836]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 21:48:33 volumio-x86-784 sudo[5836]: pam_unix(sudo:session): session closed for user root Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: Restoring Previous Volume level: 88 false true Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: VolumeController::SetAlsaVolume100 Jan 26 21:48:33 volumio-x86-784 sudo[5839]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 26 21:48:33 volumio-x86-784 sudo[5839]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: Volume configurations have been set Jan 26 21:48:33 volumio-x86-784 systemd[1]: Stopping Music Player Daemon... Jan 26 21:48:33 volumio-x86-784 systemd[1]: mpd.service: Succeeded. Jan 26 21:48:33 volumio-x86-784 systemd[1]: Stopped Music Player Daemon. Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jan 26 21:48:33 volumio-x86-784 systemd[1]: Starting Music Player Daemon... Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: Disabling external Volume Control Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreStateMachine::pushState Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 25 Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioPushState Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: MPD Permissions set Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 26 21:48:33 volumio-x86-784 sudo[5844]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 26 21:48:33 volumio-x86-784 sudo[5844]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 26 21:48:33 volumio-x86-784 sudo[5844]: pam_unix(sudo:session): session closed for user root Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreStateMachine::pushState Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CorePlayQueue::getTrack 25 Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 26 21:48:33 volumio-x86-784 volumio[1190]: info: CoreCommandRouter::volumioPushState Jan 26 21:48:34 volumio-x86-784 mpd[5858]: Jan 26 21:48 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 26 21:48:34 volumio-x86-784 systemd[1]: Started Music Player Daemon. Jan 26 21:48:34 volumio-x86-784 sudo[5839]: pam_unix(sudo:session): session closed for user root Jan 26 21:48:34 volumio-x86-784 volumio[1190]: error: updateQueue error: null Jan 26 21:48:35 volumio-x86-784 volumio[1190]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jan 26 21:48:35 volumio-x86-784 volumio[1190]: info: Retrying Login Due to Network Error Jan 26 21:48:37 volumio-x86-784 volumio[1190]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 26 21:48:37 volumio-x86-784 volumio[1190]: Error: connect ETIMEDOUT 173.252.105.21:443 Jan 26 21:48:37 volumio-x86-784 volumio[1190]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jan 26 21:48:37 volumio-x86-784 volumio[1190]: errno: -110, Jan 26 21:48:37 volumio-x86-784 volumio[1190]: code: 'ETIMEDOUT', Jan 26 21:48:37 volumio-x86-784 volumio[1190]: syscall: 'connect', Jan 26 21:48:37 volumio-x86-784 volumio[1190]: address: '173.252.105.21', Jan 26 21:48:37 volumio-x86-784 volumio[1190]: port: 443 Jan 26 21:48:37 volumio-x86-784 volumio[1190]: } Jan 26 21:48:37 volumio-x86-784 volumio[1190]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 26 21:48:37 volumio-x86-784 sudo[5878]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-26 21:47 Jan 26 21:48:37 volumio-x86-784 sudo[5878]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 10:07:11 AM CEST" VOLUMIO_VERSION="3.804" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="dc77d77f02ef88ea816c3d31de871e8f"