-- Logs begin at Thu 2019-02-14 08:11:59 -02, end at Thu 2025-05-15 13:49:36 -03. -- May 15 13:48:24 volumio volumio[2697]: info: Get:30 http://mirror.ufam.edu.br/raspbian/raspbian buster/main armhf libpython3.7-dev armhf 3.7.3-2+deb10u7 [47.2 MB] May 15 13:49:03 volumio volumio[2697]: info: MPD Database updated - AlbumList cache refreshed May 15 13:49:03 volumio volumio[2697]: info: May 15 13:49:03 volumio volumio[2697]: ---------------------------- MPD announces state update: database May 15 13:49:03 volumio volumio[2697]: verbose: ControllerMpd::sendMpdCommand status May 15 13:49:03 volumio volumio[2697]: info: May 15 13:49:03 volumio volumio[2697]: ---------------------------- MPD announces state update: update May 15 13:49:03 volumio volumio[2697]: info: ControllerMpd::getState May 15 13:49:03 volumio volumio[2697]: verbose: ControllerMpd::sendMpdCommand status May 15 13:49:03 volumio volumio[2697]: info: ControllerMpd::getState May 15 13:49:03 volumio volumio[2697]: verbose: ControllerMpd::sendMpdCommand status May 15 13:49:03 volumio volumio[2697]: info: MPD Database updated - AlbumList cache refreshed May 15 13:49:03 volumio volumio[2697]: info: May 15 13:49:03 volumio volumio[2697]: ---------------------------- MPD announces state update: database May 15 13:49:03 volumio volumio[2697]: verbose: ControllerMpd::sendMpdCommand status May 15 13:49:03 volumio volumio[2697]: info: May 15 13:49:03 volumio volumio[2697]: ---------------------------- MPD announces state update: update May 15 13:49:03 volumio volumio[2697]: info: ControllerMpd::getState May 15 13:49:03 volumio volumio[2697]: verbose: ControllerMpd::sendMpdCommand status May 15 13:49:03 volumio volumio[2697]: info: ControllerMpd::getState May 15 13:49:03 volumio volumio[2697]: verbose: ControllerMpd::sendMpdCommand status May 15 13:49:03 volumio volumio[2697]: info: MPD Database updated - AlbumList cache refreshed May 15 13:49:03 volumio volumio[2697]: info: May 15 13:49:03 volumio volumio[2697]: ---------------------------- MPD announces state update: database May 15 13:49:03 volumio volumio[2697]: verbose: ControllerMpd::sendMpdCommand status May 15 13:49:03 volumio volumio[2697]: info: May 15 13:49:03 volumio volumio[2697]: ---------------------------- MPD announces state update: update May 15 13:49:03 volumio volumio[2697]: info: ControllerMpd::getState May 15 13:49:03 volumio volumio[2697]: verbose: ControllerMpd::sendMpdCommand status May 15 13:49:03 volumio volumio[2697]: info: ControllerMpd::getState May 15 13:49:03 volumio volumio[2697]: verbose: ControllerMpd::sendMpdCommand status May 15 13:49:05 volumio volumio[2697]: Cannot compose Albumart path May 15 13:49:05 volumio volumio[2697]: Cannot compose Albumart path May 15 13:49:05 volumio volumio[2697]: info: sendMpdCommand status took 1722 milliseconds May 15 13:49:05 volumio volumio[2697]: info: sendMpdCommand status took 1721 milliseconds May 15 13:49:05 volumio volumio[2697]: info: sendMpdCommand status took 1720 milliseconds May 15 13:49:05 volumio volumio[2697]: verbose: ControllerMpd::parseState May 15 13:49:05 volumio volumio[2697]: info: Command Router : Notfying DB Updatefalse May 15 13:49:05 volumio volumio[2697]: info: CoreCommandRouter::Close All Modals sent May 15 13:49:05 volumio volumio[2697]: verbose: ControllerMpd::parseState May 15 13:49:05 volumio volumio[2697]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 15 13:49:05 volumio volumio[2697]: verbose: ControllerMpd::parseState May 15 13:49:05 volumio volumio[2697]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 15 13:49:06 volumio volumio[2697]: Cannot compose Albumart path May 15 13:49:06 volumio volumio[2697]: Cannot compose Albumart path May 15 13:49:06 volumio volumio[2697]: info: sendMpdCommand status took 2853 milliseconds May 15 13:49:06 volumio volumio[2697]: info: sendMpdCommand status took 2852 milliseconds May 15 13:49:06 volumio volumio[2697]: info: sendMpdCommand status took 2852 milliseconds May 15 13:49:06 volumio volumio[2697]: verbose: ControllerMpd::parseState May 15 13:49:06 volumio volumio[2697]: info: Command Router : Notfying DB Updatefalse May 15 13:49:06 volumio volumio[2697]: info: CoreCommandRouter::Close All Modals sent May 15 13:49:06 volumio volumio[2697]: verbose: ControllerMpd::parseState May 15 13:49:06 volumio volumio[2697]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 15 13:49:06 volumio volumio[2697]: verbose: ControllerMpd::parseState May 15 13:49:06 volumio volumio[2697]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 15 13:49:07 volumio volumio[2697]: Cannot compose Albumart path May 15 13:49:07 volumio volumio[2697]: Cannot compose Albumart path May 15 13:49:07 volumio volumio[2697]: info: sendMpdCommand status took 3937 milliseconds May 15 13:49:07 volumio volumio[2697]: info: sendMpdCommand status took 3937 milliseconds May 15 13:49:07 volumio volumio[2697]: info: sendMpdCommand status took 3937 milliseconds May 15 13:49:07 volumio volumio[2697]: verbose: ControllerMpd::parseState May 15 13:49:07 volumio volumio[2697]: info: Command Router : Notfying DB Updatefalse May 15 13:49:07 volumio volumio[2697]: info: CoreCommandRouter::Close All Modals sent May 15 13:49:07 volumio volumio[2697]: verbose: ControllerMpd::parseState May 15 13:49:07 volumio volumio[2697]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 15 13:49:07 volumio volumio[2697]: verbose: ControllerMpd::parseState May 15 13:49:07 volumio volumio[2697]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 15 13:49:07 volumio volumio[2697]: info: sendMpdCommand playlistinfo took 2242 milliseconds May 15 13:49:07 volumio volumio[2697]: info: sendMpdCommand playlistinfo took 2242 milliseconds May 15 13:49:07 volumio volumio[2697]: verbose: ControllerMpd::parseTrackInfo May 15 13:49:07 volumio volumio[2697]: verbose: ControllerMpd::parseTrackInfo May 15 13:49:07 volumio volumio[2697]: info: ControllerMpd::pushState May 15 13:49:07 volumio volumio[2697]: info: CoreCommandRouter::servicePushState May 15 13:49:07 volumio volumio[2697]: info: CorePlayQueue::getTrack 0 May 15 13:49:07 volumio volumio[2697]: verbose: STATE SERVICE {"status":"play","position":0,"seek":253714,"duration":301,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"It's a Long Way to the Top (If You Wanna Rock 'N' Roll)","artist":"AC/DC","album":"High Voltage","uri":"NAS/External/Rock/AC_DC - It's a Long Way to the Top (If You Wanna Rock 'N' Roll).mp3","trackType":"mp3"} May 15 13:49:07 volumio volumio[2697]: verbose: CURRENT POSITION 0 May 15 13:49:07 volumio volumio[2697]: info: CoreStateMachine::syncState stateService play May 15 13:49:07 volumio volumio[2697]: info: CoreStateMachine::syncState currentStatus play May 15 13:49:07 volumio volumio[2697]: info: Received an update from plugin. extracting info from payload May 15 13:49:07 volumio volumio[2697]: info: CoreStateMachine::pushState May 15 13:49:07 volumio volumio[2697]: info: CorePlayQueue::getTrack 0 May 15 13:49:07 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 13:49:07 volumio volumio[2697]: info: CoreCommandRouter::volumioPushState May 15 13:49:07 volumio volumio[2697]: info: CoreStateMachine::pushState May 15 13:49:07 volumio volumio[2697]: info: CorePlayQueue::getTrack 0 May 15 13:49:07 volumio volumio[2697]: info: CoreCommandRouter::volumioPushState May 15 13:49:07 volumio volumio[2697]: info: ControllerMpd::pushState May 15 13:49:08 volumio volumio[2697]: info: CoreCommandRouter::servicePushState May 15 13:49:08 volumio volumio[2697]: info: CorePlayQueue::getTrack 0 May 15 13:49:08 volumio volumio[2697]: verbose: STATE SERVICE {"status":"play","position":0,"seek":253725,"duration":301,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"It's a Long Way to the Top (If You Wanna Rock 'N' Roll)","artist":"AC/DC","album":"High Voltage","uri":"NAS/External/Rock/AC_DC - It's a Long Way to the Top (If You Wanna Rock 'N' Roll).mp3","trackType":"mp3"} May 15 13:49:08 volumio volumio[2697]: verbose: CURRENT POSITION 0 May 15 13:49:08 volumio volumio[2697]: info: CoreStateMachine::syncState stateService play May 15 13:49:08 volumio volumio[2697]: info: CoreStateMachine::syncState currentStatus play May 15 13:49:08 volumio volumio[2697]: info: Received an update from plugin. extracting info from payload May 15 13:49:08 volumio volumio[2697]: info: CoreStateMachine::pushState May 15 13:49:08 volumio volumio[2697]: info: CorePlayQueue::getTrack 0 May 15 13:49:08 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 13:49:08 volumio volumio[2697]: info: CoreCommandRouter::volumioPushState May 15 13:49:08 volumio volumio[2697]: info: CoreStateMachine::pushState May 15 13:49:08 volumio volumio[2697]: info: CorePlayQueue::getTrack 0 May 15 13:49:08 volumio volumio[2697]: info: CoreCommandRouter::volumioPushState May 15 13:49:08 volumio volumio[2697]: info: ------------------------------ 4069ms May 15 13:49:08 volumio volumio[2697]: info: ------------------------------ 4070ms May 15 13:49:08 volumio volumio[2697]: info: sendMpdCommand playlistinfo took 1195 milliseconds May 15 13:49:08 volumio volumio[2697]: info: sendMpdCommand playlistinfo took 1196 milliseconds May 15 13:49:08 volumio volumio[2697]: verbose: ControllerMpd::parseTrackInfo May 15 13:49:08 volumio volumio[2697]: verbose: ControllerMpd::parseTrackInfo May 15 13:49:08 volumio volumio[2697]: info: ControllerMpd::pushState May 15 13:49:08 volumio volumio[2697]: info: CoreCommandRouter::servicePushState May 15 13:49:08 volumio volumio[2697]: info: CorePlayQueue::getTrack 0 May 15 13:49:08 volumio volumio[2697]: verbose: STATE SERVICE {"status":"play","position":0,"seek":253954,"duration":301,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"It's a Long Way to the Top (If You Wanna Rock 'N' Roll)","artist":"AC/DC","album":"High Voltage","uri":"NAS/External/Rock/AC_DC - It's a Long Way to the Top (If You Wanna Rock 'N' Roll).mp3","trackType":"mp3"} May 15 13:49:08 volumio volumio[2697]: verbose: CURRENT POSITION 0 May 15 13:49:08 volumio volumio[2697]: info: CoreStateMachine::syncState stateService play May 15 13:49:08 volumio volumio[2697]: info: CoreStateMachine::syncState currentStatus play May 15 13:49:08 volumio volumio[2697]: info: Received an update from plugin. extracting info from payload May 15 13:49:08 volumio volumio[2697]: info: CoreStateMachine::pushState May 15 13:49:08 volumio volumio[2697]: info: CorePlayQueue::getTrack 0 May 15 13:49:08 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 13:49:08 volumio volumio[2697]: info: CoreCommandRouter::volumioPushState May 15 13:49:08 volumio volumio[2697]: info: CoreStateMachine::pushState May 15 13:49:08 volumio volumio[2697]: info: CorePlayQueue::getTrack 0 May 15 13:49:08 volumio volumio[2697]: info: CoreCommandRouter::volumioPushState May 15 13:49:08 volumio volumio[2697]: info: ControllerMpd::pushState May 15 13:49:08 volumio volumio[2697]: info: CoreCommandRouter::servicePushState May 15 13:49:08 volumio volumio[2697]: info: CorePlayQueue::getTrack 0 May 15 13:49:08 volumio volumio[2697]: verbose: STATE SERVICE {"status":"play","position":0,"seek":253954,"duration":301,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"It's a Long Way to the Top (If You Wanna Rock 'N' Roll)","artist":"AC/DC","album":"High Voltage","uri":"NAS/External/Rock/AC_DC - It's a Long Way to the Top (If You Wanna Rock 'N' Roll).mp3","trackType":"mp3"} May 15 13:49:08 volumio volumio[2697]: verbose: CURRENT POSITION 0 May 15 13:49:08 volumio volumio[2697]: info: CoreStateMachine::syncState stateService play May 15 13:49:08 volumio volumio[2697]: info: CoreStateMachine::syncState currentStatus play May 15 13:49:08 volumio volumio[2697]: info: Received an update from plugin. extracting info from payload May 15 13:49:08 volumio volumio[2697]: info: CoreStateMachine::pushState May 15 13:49:08 volumio volumio[2697]: info: CorePlayQueue::getTrack 0 May 15 13:49:08 volumio volumio[2697]: info: CoreCommandRouter::volumioPushState May 15 13:49:08 volumio volumio[2697]: info: CoreStateMachine::pushState May 15 13:49:08 volumio volumio[2697]: info: CorePlayQueue::getTrack 0 May 15 13:49:08 volumio volumio[2697]: info: CoreCommandRouter::volumioPushState May 15 13:49:08 volumio volumio[2697]: info: ------------------------------ 4129ms May 15 13:49:08 volumio volumio[2697]: info: ------------------------------ 4130ms May 15 13:49:08 volumio volumio[2697]: info: sendMpdCommand playlistinfo took 159 milliseconds May 15 13:49:08 volumio volumio[2697]: info: sendMpdCommand playlistinfo took 159 milliseconds May 15 13:49:08 volumio volumio[2697]: verbose: ControllerMpd::parseTrackInfo May 15 13:49:08 volumio volumio[2697]: verbose: ControllerMpd::parseTrackInfo May 15 13:49:08 volumio volumio[2697]: info: ControllerMpd::pushState May 15 13:49:08 volumio volumio[2697]: info: CoreCommandRouter::servicePushState May 15 13:49:08 volumio volumio[2697]: info: CorePlayQueue::getTrack 0 May 15 13:49:08 volumio volumio[2697]: verbose: STATE SERVICE {"status":"play","position":0,"seek":254080,"duration":301,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"It's a Long Way to the Top (If You Wanna Rock 'N' Roll)","artist":"AC/DC","album":"High Voltage","uri":"NAS/External/Rock/AC_DC - It's a Long Way to the Top (If You Wanna Rock 'N' Roll).mp3","trackType":"mp3"} May 15 13:49:08 volumio volumio[2697]: verbose: CURRENT POSITION 0 May 15 13:49:08 volumio volumio[2697]: info: CoreStateMachine::syncState stateService play May 15 13:49:08 volumio volumio[2697]: info: CoreStateMachine::syncState currentStatus play May 15 13:49:08 volumio volumio[2697]: info: Received an update from plugin. extracting info from payload May 15 13:49:08 volumio volumio[2697]: info: CoreStateMachine::pushState May 15 13:49:08 volumio volumio[2697]: info: CorePlayQueue::getTrack 0 May 15 13:49:08 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 13:49:08 volumio volumio[2697]: info: CoreCommandRouter::volumioPushState May 15 13:49:08 volumio volumio[2697]: info: CoreStateMachine::pushState May 15 13:49:08 volumio volumio[2697]: info: CorePlayQueue::getTrack 0 May 15 13:49:08 volumio volumio[2697]: info: CoreCommandRouter::volumioPushState May 15 13:49:08 volumio volumio[2697]: info: ControllerMpd::pushState May 15 13:49:08 volumio volumio[2697]: info: CoreCommandRouter::servicePushState May 15 13:49:08 volumio volumio[2697]: info: CorePlayQueue::getTrack 0 May 15 13:49:08 volumio volumio[2697]: verbose: STATE SERVICE {"status":"play","position":0,"seek":254080,"duration":301,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"It's a Long Way to the Top (If You Wanna Rock 'N' Roll)","artist":"AC/DC","album":"High Voltage","uri":"NAS/External/Rock/AC_DC - It's a Long Way to the Top (If You Wanna Rock 'N' Roll).mp3","trackType":"mp3"} May 15 13:49:08 volumio volumio[2697]: verbose: CURRENT POSITION 0 May 15 13:49:08 volumio volumio[2697]: info: CoreStateMachine::syncState stateService play May 15 13:49:08 volumio volumio[2697]: info: CoreStateMachine::syncState currentStatus play May 15 13:49:08 volumio volumio[2697]: info: Received an update from plugin. extracting info from payload May 15 13:49:08 volumio volumio[2697]: info: CoreStateMachine::pushState May 15 13:49:08 volumio volumio[2697]: info: CorePlayQueue::getTrack 0 May 15 13:49:08 volumio volumio[2697]: info: CoreCommandRouter::volumioPushState May 15 13:49:08 volumio volumio[2697]: info: CoreStateMachine::pushState May 15 13:49:08 volumio volumio[2697]: info: CorePlayQueue::getTrack 0 May 15 13:49:08 volumio volumio[2697]: info: CoreCommandRouter::volumioPushState May 15 13:49:08 volumio volumio[2697]: info: ------------------------------ 4174ms May 15 13:49:08 volumio volumio[2697]: info: ------------------------------ 4174ms May 15 13:49:09 volumio volumio[2697]: info: VolumeController::SetAlsaVolume38 May 15 13:49:09 volumio volumio[2697]: info: CoreStateMachine::pushState May 15 13:49:09 volumio volumio[2697]: info: CorePlayQueue::getTrack 0 May 15 13:49:09 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 13:49:09 volumio volumio[2697]: info: CoreCommandRouter::volumioPushState May 15 13:49:11 volumio volumio[2697]: info: VolumeController::SetAlsaVolume43 May 15 13:49:11 volumio volumio[2697]: info: CoreStateMachine::pushState May 15 13:49:11 volumio volumio[2697]: info: CorePlayQueue::getTrack 0 May 15 13:49:11 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 13:49:11 volumio volumio[2697]: info: CoreCommandRouter::volumioPushState May 15 13:49:12 volumio volumio[2697]: info: VolumeController::SetAlsaVolume44 May 15 13:49:12 volumio volumio[2697]: info: CoreStateMachine::pushState May 15 13:49:12 volumio volumio[2697]: info: CorePlayQueue::getTrack 0 May 15 13:49:12 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 15 13:49:12 volumio volumio[2697]: info: CoreCommandRouter::volumioPushState May 15 13:49:21 volumio volumio[2697]: info: CoreCommandRouter::getUIConfigOnPlugin May 15 13:49:21 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 15 13:49:21 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 15 13:49:21 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 15 13:49:21 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 15 13:49:21 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 15 13:49:21 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 15 13:49:21 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 15 13:49:21 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 15 13:49:21 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 15 13:49:21 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 15 13:49:21 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 15 13:49:21 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 15 13:49:21 volumio volumio[2697]: info: Get:30 http://mirror.ufam.edu.br/raspbian/raspbian buster/main armhf libpython3.7-dev armhf 3.7.3-2+deb10u7 [47.2 MB] May 15 13:49:26 volumio volumio[2697]: info: CoreCommandRouter::volumioGetState May 15 13:49:26 volumio volumio[2697]: info: CorePlayQueue::getTrack 0 May 15 13:49:28 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 15 13:49:28 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 15 13:49:32 volumio volumio[2697]: info: Enabling plugin fusiondsp May 15 13:49:32 volumio volumio[2697]: info: Loading plugin "fusiondsp"... May 15 13:49:33 volumio volumio[2697]: info: Applying required configuration parameters for plugin fusiondsp May 15 13:49:33 volumio volumio[2697]: info: Preparing to generate the ALSA configuration file May 15 13:49:33 volumio volumio[2697]: info: Asound.conf file unchanged, so no further update is needed May 15 13:49:33 volumio volumio[2697]: info: Output device has changed, restarting MPD May 15 13:49:33 volumio sudo[7109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 15 13:49:33 volumio sudo[7109]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 13:49:33 volumio sudo[7109]: pam_unix(sudo:session): session closed for user root May 15 13:49:33 volumio volumio[2697]: info: Output device has changed, restarting Shairport Sync May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 15 13:49:33 volumio sudo[7112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 15 13:49:33 volumio sudo[7112]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 13:49:33 volumio systemd[1]: Stopping Music Player Daemon... May 15 13:49:33 volumio volumio[2697]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 15 13:49:33 volumio volumio[2697]: info: PLUGIN START: fusiondsp May 15 13:49:33 volumio volumio[2697]: info: Loading i18n strings for locale en May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 15 13:49:33 volumio volumio[2697]: info: FusionDsp - mixtype--------------------- Hardware May 15 13:49:33 volumio systemd[1]: mpd.service: Succeeded. May 15 13:49:33 volumio systemd[1]: Stopped Music Player Daemon. May 15 13:49:33 volumio volumio[2697]: info: Preparing to generate the ALSA configuration file May 15 13:49:33 volumio volumio[2697]: info: Done. May 15 13:49:33 volumio volumio[2697]: info: MPD Permissions set May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 15 13:49:33 volumio systemd[1]: Starting Music Player Daemon... May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 15 13:49:33 volumio volumio[2697]: info: Asound.conf file unchanged, so no further update is needed May 15 13:49:33 volumio volumio[2697]: info: Output device has changed, restarting MPD May 15 13:49:33 volumio sudo[7123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 15 13:49:33 volumio sudo[7123]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 13:49:33 volumio volumio[2697]: info: Output device has changed, restarting Shairport Sync May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 15 13:49:33 volumio sudo[7123]: pam_unix(sudo:session): session closed for user root May 15 13:49:33 volumio sudo[7126]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 15 13:49:33 volumio sudo[7126]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 13:49:33 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM May 15 13:49:33 volumio systemd[1]: mpd.service: Succeeded. May 15 13:49:33 volumio systemd[1]: Stopped Music Player Daemon. May 15 13:49:33 volumio systemd[1]: Starting Music Player Daemon... May 15 13:49:33 volumio volumio[2697]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::getUIConfigOnPlugin May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::getUIConfigOnPlugin May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::getUIConfigOnPlugin May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::getUIConfigOnPlugin May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::getUIConfigOnPlugin May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::getUIConfigOnPlugin May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::getUIConfigOnPlugin May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::getUIConfigOnPlugin May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::getUIConfigOnPlugin May 15 13:49:33 volumio volumio[2697]: error: Upnp client error: Error: This socket has been ended by the other party May 15 13:49:33 volumio volumio[2697]: info: MPD Permissions set May 15 13:49:33 volumio volumio[2697]: info: Starting Shairport Sync May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 15 13:49:33 volumio sudo[7133]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 15 13:49:33 volumio sudo[7133]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 15 13:49:33 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 15 13:49:33 volumio sudo[7131]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 15 13:49:33 volumio sudo[7131]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 13:49:33 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 15 13:49:33 volumio sudo[7131]: pam_unix(sudo:session): session closed for user root May 15 13:49:33 volumio systemd[1]: shairport-sync.service: Succeeded. May 15 13:49:33 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 15 13:49:33 volumio volumio[2697]: info: FusionDsp - Rock-FusionDsp May 15 13:49:34 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 15 13:49:34 volumio sudo[7133]: pam_unix(sudo:session): session closed for user root May 15 13:49:34 volumio volumio[2697]: info: FusionDsp - Rock-FusionDsp May 15 13:49:34 volumio volumio[2697]: info: FusionDsp - Rock-FusionDsp May 15 13:49:34 volumio volumio[2697]: info: FusionDsp - Rock-FusionDsp May 15 13:49:34 volumio volumio[2697]: info: FusionDsp - Rock-FusionDsp May 15 13:49:35 volumio volumio[2697]: info: FusionDsp - Rock-FusionDsp May 15 13:49:35 volumio volumio[2697]: info: FusionDsp - Rock-FusionDsp May 15 13:49:35 volumio volumio[2697]: info: FusionDsp - Rock-FusionDsp May 15 13:49:35 volumio mpd[7140]: May 15 13:49 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 15 13:49:35 volumio volumio[2697]: info: FusionDsp - Rock-FusionDsp May 15 13:49:35 volumio systemd[1]: Started Music Player Daemon. May 15 13:49:35 volumio sudo[7126]: pam_unix(sudo:session): session closed for user root May 15 13:49:35 volumio sudo[7112]: pam_unix(sudo:session): session closed for user root May 15 13:49:36 volumio volumio[2697]: info: camilladsp service started and running in background, instance 1 May 15 13:49:36 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 15 13:49:36 volumio volumio[2697]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found May 15 13:49:36 volumio volumio[2697]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json May 15 13:49:36 volumio volumio[2697]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found May 15 13:49:36 volumio volumio[2697]: info: FusionDsp loaded May 15 13:49:36 volumio volumio[2697]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 15 13:49:36 volumio sudo[7156]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service May 15 13:49:36 volumio sudo[7156]: pam_unix(sudo:session): session opened for user root by (uid=0) May 15 13:49:36 volumio volumio[2697]: info: FusionDsp - Reporting Fusion DSP Enabled May 15 13:49:36 volumio volumio[2697]: info: Adding Signal Path Element [object Object] May 15 13:49:36 volumio volumio[2697]: info: Adding fusiondspeq DSP Signal Path Element May 15 13:49:36 volumio volumio[2697]: info: FusionDsp - ---- installed callbackRead May 15 13:49:36 volumio sudo[7156]: pam_unix(sudo:session): session closed for user root May 15 13:49:36 volumio volumio[2697]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 15 13:49:36 volumio volumio[2697]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT May 15 13:49:36 volumio volumio[2697]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) May 15 13:49:36 volumio volumio[2697]: at onErrorNT (internal/child_process.js:465:16) May 15 13:49:36 volumio volumio[2697]: at processTicksAndRejections (internal/process/task_queues.js:80:21) May 15 13:49:36 volumio volumio[2697]: at runNextTicks (internal/process/task_queues.js:62:3) May 15 13:49:36 volumio volumio[2697]: at listOnTimeout (internal/timers.js:523:9) May 15 13:49:36 volumio volumio[2697]: at processTimers (internal/timers.js:497:7) { May 15 13:49:36 volumio volumio[2697]: errno: -2, May 15 13:49:36 volumio volumio[2697]: code: 'ENOENT', May 15 13:49:36 volumio volumio[2697]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', May 15 13:49:36 volumio volumio[2697]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', May 15 13:49:36 volumio volumio[2697]: spawnargs: [ May 15 13:49:36 volumio volumio[2697]: '-p', May 15 13:49:36 volumio volumio[2697]: 9876, May 15 13:49:36 volumio volumio[2697]: '-o', May 15 13:49:36 volumio volumio[2697]: '/tmp/camilladsp.log', May 15 13:49:36 volumio volumio[2697]: '-l', May 15 13:49:36 volumio volumio[2697]: 'warn', May 15 13:49:36 volumio volumio[2697]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' May 15 13:49:36 volumio volumio[2697]: ] May 15 13:49:36 volumio volumio[2697]: } May 15 13:49:36 volumio volumio[2697]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 15 13:49:36 volumio sudo[7167]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-15 13:48 May 15 13:49:36 volumio sudo[7167]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 11:42:54 AM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4049a67f1c09d4a94e033ba35a80a144"