-- Logs begin at Sun 2004-10-03 23:58:01 UTC, end at Sun 2026-10-11 22:39:22 UTC. -- Oct 11 22:38:01 volumio volumio[942]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Oct 11 22:38:01 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Oct 11 22:38:01 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:01 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:01 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:01 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:01 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:01 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:01 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:01 volumio volumio[942]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Oct 11 22:38:01 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Oct 11 22:38:01 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:01 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:01 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:01 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:01 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:01 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:01 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:01 volumio sudo[7176]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 11 22:38:01 volumio sudo[7172]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 11 22:38:01 volumio sudo[7178]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 11 22:38:01 volumio sudo[7174]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 11 22:38:01 volumio sudo[7178]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 22:38:01 volumio sudo[7174]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 22:38:01 volumio sudo[7172]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 22:38:01 volumio sudo[7176]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 22:38:01 volumio sudo[7176]: pam_unix(sudo:session): session closed for user root Oct 11 22:38:01 volumio sudo[7172]: pam_unix(sudo:session): session closed for user root Oct 11 22:38:01 volumio volumio[942]: info: MPD Permissions set Oct 11 22:38:01 volumio volumio[942]: info: MPD Permissions set Oct 11 22:38:02 volumio systemd[1]: Stopping Music Player Daemon... Oct 11 22:38:02 volumio volumio[942]: error: Upnp client error: Error: This socket has been ended by the other party Oct 11 22:38:03 volumio systemd[1]: Starting Music Player Daemon... Oct 11 22:38:05 volumio systemd[1]: Started Music Player Daemon. Oct 11 22:38:05 volumio sudo[7178]: pam_unix(sudo:session): session closed for user root Oct 11 22:38:05 volumio sudo[7174]: pam_unix(sudo:session): session closed for user root Oct 11 22:38:05 volumio volumio[942]: info: Oct 11 22:38:08 volumio volumio[942]: info: CoreCommandRouter::volumioGetState Oct 11 22:38:08 volumio volumio[942]: info: CoreStateMachine::getState Oct 11 22:38:08 volumio volumio[942]: info: CorePlayQueue::getTrack 11 Oct 11 22:38:08 volumio volumio[942]: info: CoreCommandRouter::volumioGetBrowseSources Oct 11 22:38:08 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 11 22:38:08 volumio volumio[942]: Plugin multiroom or method getMultiroom not found Oct 11 22:38:08 volumio volumio[942]: info: Listing playlists Oct 11 22:38:08 volumio volumio[942]: info: CoreCommandRouter::volumioGetQueue Oct 11 22:38:08 volumio volumio[942]: info: CoreStateMachine::getQueue Oct 11 22:38:08 volumio volumio[942]: info: CorePlayQueue::getQueue Oct 11 22:38:11 volumio volumio[942]: info: CoreCommandRouter::volumioSeek Oct 11 22:38:11 volumio volumio[942]: info: CoreStateMachine::seek Oct 11 22:38:11 volumio volumio[942]: info: CorePlayQueue::getTrack 11 Oct 11 22:38:11 volumio volumio[942]: info: TRACKBLOCK {"uri":"mnt/NAS/Nasyoo/ABBA/ABBA - The Winner Takes It All.flac","service":"mpd","name":"The Winner Takes It All","artist":"ABBA","album":"ABBA Gold","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=257&web=ABBA/ABBA%20Gold/extralarge&path=%2FNAS%2FNasyoo%2FABBA&metadata=false","duration":295,"samplerate":"44.1 KHz","bitdepth":"16 bit","trackType":"flac","channels":2} Oct 11 22:38:11 volumio volumio[942]: info: CoreStateMachine::startPlaybackTimer Oct 11 22:38:11 volumio volumio[942]: info: CorePlayQueue::getTrack 11 Oct 11 22:38:11 volumio volumio[942]: info: ControllerMpd::seek Oct 11 22:38:11 volumio volumio[942]: info: CoreStateMachine::pushState Oct 11 22:38:11 volumio volumio[942]: info: CoreStateMachine::getState Oct 11 22:38:11 volumio volumio[942]: info: CorePlayQueue::getTrack 11 Oct 11 22:38:11 volumio volumio[942]: info: CoreCommandRouter::volumioPushState Oct 11 22:38:11 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 22:38:11 volumio volumio[942]: info: interfaceApi::pushState Oct 11 22:38:11 volumio volumio[942]: info: Pushing Favourites {"service":"mpd","uri":"mnt/NAS/Nasyoo/ABBA/ABBA - The Winner Takes It All.flac","favourite":false} Oct 11 22:38:11 volumio volumio[942]: info: message= [2@0] {} Bad song index, stack=Error: [2@0] {} Bad song index Oct 11 22:38:11 volumio volumio[942]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:63:14) Oct 11 22:38:11 volumio volumio[942]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:10) Oct 11 22:38:11 volumio volumio[942]: at emitOne (events.js:116:13) Oct 11 22:38:11 volumio volumio[942]: at Socket.emit (events.js:211:7) Oct 11 22:38:11 volumio volumio[942]: at addChunk (_stream_readable.js:263:12) Oct 11 22:38:11 volumio volumio[942]: at readableAddChunk (_stream_readable.js:246:13) Oct 11 22:38:11 volumio volumio[942]: at Socket.Readable.push (_stream_readable.js:208:10) Oct 11 22:38:11 volumio volumio[942]: at Pipe.onread (net.js:607:20) Oct 11 22:38:14 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 11 22:38:14 volumio volumio[942]: info: CURURI: artists:// Oct 11 22:38:16 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 11 22:38:16 volumio volumio[942]: info: CURURI: artists://Scorpions Oct 11 22:38:19 volumio volumio[942]: info: CoreCommandRouter::volumioAddQueueItems Oct 11 22:38:19 volumio volumio[942]: info: CoreStateMachine::addQueueItems Oct 11 22:38:19 volumio volumio[942]: info: CorePlayQueue::addQueueItems Oct 11 22:38:19 volumio volumio[942]: info: Adding Item to queue: music-library/NAS/Nasyoo/Scorpions/Moment Of Glory (DSD 64 )/03 - Scorpions - Send Me An Angel.dsf Oct 11 22:38:19 volumio volumio[942]: info: Exploding uri music-library/NAS/Nasyoo/Scorpions/Moment Of Glory (DSD 64 )/03 - Scorpions - Send Me An Angel.dsf in service mpd Oct 11 22:38:19 volumio volumio[942]: info: ALBUMART /albumart?cacheid=257&web=Scorpions/Moment%20Of%20Glory/extralarge&path=%2Fmnt%2FNAS%2FNasyoo%2FScorpions%2FMoment%20Of%20Glory%20%20(DSD%2064%20)%2F03%20-%20Scorpions%20-%20Send%20Me%20An%20Angel.dsf&metadata=false Oct 11 22:38:19 volumio volumio[942]: info: URI /mnt/NAS/Nasyoo/Scorpions/Moment Of Glory (DSD 64 )/03 - Scorpions - Send Me An Angel.dsf Oct 11 22:38:19 volumio volumio[942]: info: CorePlayQueue::saveQueue Oct 11 22:38:19 volumio volumio[942]: info: CoreCommandRouter::volumioPushQueue Oct 11 22:38:19 volumio volumio[942]: info: interfaceApi::pushQueue Oct 11 22:38:19 volumio volumio[942]: info: CoreStateMachine::updateTrackBlock Oct 11 22:38:19 volumio volumio[942]: info: CorePlayQueue::getTrackBlock Oct 11 22:38:19 volumio volumio[942]: info: CoreCommandRouter::volumioPlay Oct 11 22:38:19 volumio volumio[942]: UNSET VOLATILE Oct 11 22:38:19 volumio volumio[942]: info: CoreStateMachine::play index 12 Oct 11 22:38:19 volumio volumio[942]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 22:38:19 volumio volumio[942]: info: CoreStateMachine::stop Oct 11 22:38:19 volumio volumio[942]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 22:38:19 volumio volumio[942]: UNSET VOLATILE Oct 11 22:38:19 volumio volumio[942]: info: CoreStateMachine::stPlaybackTimer Oct 11 22:38:19 volumio volumio[942]: info: CoreStateMachine::updateTrackBlock Oct 11 22:38:19 volumio volumio[942]: info: CorePlayQueue::getTrackBlock Oct 11 22:38:19 volumio volumio[942]: info: CoreStateMachine::pushState Oct 11 22:38:19 volumio volumio[942]: info: CoreStateMachine::getState Oct 11 22:38:19 volumio volumio[942]: info: CorePlayQueue::getTrack 11 Oct 11 22:38:19 volumio volumio[942]: info: CoreCommandRouter::volumioPushState Oct 11 22:38:19 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 22:38:19 volumio volumio[942]: info: interfaceApi::pushState Oct 11 22:38:19 volumio volumio[942]: info: CoreStateMachine::serviceStop Oct 11 22:38:19 volumio volumio[942]: info: CorePlayQueue::getTrack 11 Oct 11 22:38:19 volumio volumio[942]: info: CoreCommandRouter::serviceStop Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::stop Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::sendMpdCommand stop Oct 11 22:38:19 volumio volumio[942]: info: sending command... Oct 11 22:38:19 volumio volumio[942]: info: Pushing Favourites {"service":"mpd","uri":"mnt/NAS/Nasyoo/ABBA/ABBA - The Winner Takes It All.flac","favourite":false} Oct 11 22:38:19 volumio volumio[942]: info: parsing response... Oct 11 22:38:19 volumio volumio[942]: info: CoreStateMachine::play index undefined Oct 11 22:38:19 volumio volumio[942]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 22:38:19 volumio volumio[942]: info: CorePlayQueue::getTrack 12 Oct 11 22:38:19 volumio volumio[942]: info: CoreStateMachine::startPlaybackTimer Oct 11 22:38:19 volumio volumio[942]: info: CorePlayQueue::getTrack 12 Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::clearAddPlayTracks NAS/Nasyoo/Scorpions/Moment Of Glory (DSD 64 )/03 - Scorpions - Send Me An Angel.dsf Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::sendMpdCommand stop Oct 11 22:38:19 volumio volumio[942]: info: sending command... Oct 11 22:38:19 volumio volumio[942]: info: parsing response... Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::sendMpdCommand clear Oct 11 22:38:19 volumio volumio[942]: info: sending command... Oct 11 22:38:19 volumio volumio[942]: info: Oct 11 22:38:19 volumio volumio[942]: ---------------------------- MPD announces system playlist update Oct 11 22:38:19 volumio volumio[942]: info: Ignoring MPD Status Update Oct 11 22:38:19 volumio volumio[942]: info: parsing response... Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::sendMpdCommand add "NAS/Nasyoo/Scorpions/Moment Of Glory (DSD 64 )/03 - Scorpions - Send Me An Angel.dsf" Oct 11 22:38:19 volumio volumio[942]: info: sending command... Oct 11 22:38:19 volumio volumio[942]: info: Oct 11 22:38:19 volumio volumio[942]: ---------------------------- MPD announces system playlist update Oct 11 22:38:19 volumio volumio[942]: info: Ignoring MPD Status Update Oct 11 22:38:19 volumio volumio[942]: info: Oct 11 22:38:19 volumio volumio[942]: info: Oct 11 22:38:19 volumio volumio[942]: ---------------------------- MPD announces system playlist update Oct 11 22:38:19 volumio volumio[942]: info: Ignoring MPD Status Update Oct 11 22:38:19 volumio volumio[942]: info: ------------------------------ 12ms Oct 11 22:38:19 volumio volumio[942]: info: parsing response... Oct 11 22:38:19 volumio volumio[942]: info: ------------------------------ 5ms Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::sendMpdCommand play Oct 11 22:38:19 volumio volumio[942]: info: sending command... Oct 11 22:38:19 volumio volumio[942]: info: Oct 11 22:38:19 volumio volumio[942]: ---------------------------- MPD announces system playlist update Oct 11 22:38:19 volumio volumio[942]: info: Ignoring MPD Status Update Oct 11 22:38:19 volumio volumio[942]: info: ------------------------------ 7ms Oct 11 22:38:19 volumio volumio[942]: info: parsing response... Oct 11 22:38:19 volumio volumio[942]: info: ------------------------------ 3ms Oct 11 22:38:19 volumio volumio[942]: info: Oct 11 22:38:19 volumio volumio[942]: ---------------------------- MPD announces state update: player Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::getState Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::sendMpdCommand status Oct 11 22:38:19 volumio volumio[942]: info: sending command... Oct 11 22:38:19 volumio volumio[942]: info: Oct 11 22:38:19 volumio volumio[942]: ---------------------------- MPD announces state update: player Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::getState Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::sendMpdCommand status Oct 11 22:38:19 volumio volumio[942]: info: sending command... Oct 11 22:38:19 volumio volumio[942]: info: parsing response... Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::parseState Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::sendMpdCommand playlistinfo Oct 11 22:38:19 volumio volumio[942]: info: sending command... Oct 11 22:38:19 volumio volumio[942]: info: Oct 11 22:38:19 volumio volumio[942]: ---------------------------- MPD announces state update: player Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::getState Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::sendMpdCommand status Oct 11 22:38:19 volumio volumio[942]: info: parsing response... Oct 11 22:38:19 volumio volumio[942]: info: parsing response... Oct 11 22:38:19 volumio volumio[942]: info: sending command... Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::parseState Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::sendMpdCommand playlistinfo Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::parseTrackInfo Oct 11 22:38:19 volumio volumio[942]: info: sending command... Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::pushState Oct 11 22:38:19 volumio volumio[942]: info: CoreCommandRouter::servicePushState Oct 11 22:38:19 volumio volumio[942]: info: CoreStateMachine::syncState Oct 11 22:38:19 volumio volumio[942]: info: CorePlayQueue::getTrack 12 Oct 11 22:38:19 volumio volumio[942]: info: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":379,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Send Me An Angel","artist":"Scorpions","album":"Moment Of Glory","uri":"NAS/Nasyoo/Scorpions/Moment Of Glory (DSD 64 )/03 - Scorpions - Send Me An Angel.dsf","trackType":"dsf"} Oct 11 22:38:19 volumio volumio[942]: info: CURRENT POSITION 12 Oct 11 22:38:19 volumio volumio[942]: info: CoreStateMachine::syncState stateService play Oct 11 22:38:19 volumio volumio[942]: info: CoreStateMachine::syncState currentStatus stop Oct 11 22:38:19 volumio volumio[942]: info: CoreStateMachine::pushState Oct 11 22:38:19 volumio volumio[942]: info: CoreStateMachine::getState Oct 11 22:38:19 volumio volumio[942]: info: CorePlayQueue::getTrack 12 Oct 11 22:38:19 volumio volumio[942]: info: CoreCommandRouter::volumioPushState Oct 11 22:38:19 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 22:38:19 volumio volumio[942]: info: interfaceApi::pushState Oct 11 22:38:19 volumio volumio[942]: info: ------------------------------ 354ms Oct 11 22:38:19 volumio volumio[942]: info: Pushing Favourites {"service":"mpd","uri":"mnt/NAS/Nasyoo/Scorpions/Moment Of Glory (DSD 64 )/03 - Scorpions - Send Me An Angel.dsf","favourite":false} Oct 11 22:38:19 volumio volumio[942]: info: Oct 11 22:38:19 volumio volumio[942]: ---------------------------- MPD announces state update: player Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::getState Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::sendMpdCommand status Oct 11 22:38:19 volumio volumio[942]: info: sending command... Oct 11 22:38:19 volumio volumio[942]: info: parsing response... Oct 11 22:38:19 volumio volumio[942]: info: parsing response... Oct 11 22:38:19 volumio volumio[942]: info: parsing response... Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::parseState Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::sendMpdCommand playlistinfo Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::parseTrackInfo Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::parseState Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::sendMpdCommand playlistinfo Oct 11 22:38:19 volumio volumio[942]: info: sending command... Oct 11 22:38:19 volumio volumio[942]: info: ControllerMpd::pushState Oct 11 22:38:19 volumio volumio[942]: info: CoreCommandRouter::servicePushState Oct 11 22:38:19 volumio volumio[942]: info: CoreStateMachine::syncState Oct 11 22:38:19 volumio volumio[942]: info: CorePlayQueue::getTrack 12 Oct 11 22:38:19 volumio volumio[942]: info: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":379,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Send Me An Angel","artist":"Scorpions","album":"Moment Of Glory","uri":"NAS/Nasyoo/Scorpions/Moment Of Glory (DSD 64 )/03 - Scorpions - Send Me An Angel.dsf","trackType":"dsf"} Oct 11 22:38:19 volumio volumio[942]: info: CURRENT POSITION 12 Oct 11 22:38:19 volumio volumio[942]: info: CoreStateMachine::syncState stateService play Oct 11 22:38:19 volumio volumio[942]: info: CoreStateMachine::syncState currentStatus play Oct 11 22:38:19 volumio volumio[942]: info: Received an update from plaugin. extracting info from payload Oct 11 22:38:19 volumio volumio[942]: info: CoreStateMachine::pushState Oct 11 22:38:19 volumio volumio[942]: info: CoreStateMachine::getState Oct 11 22:38:19 volumio volumio[942]: info: CorePlayQueue::getTrack 12 Oct 11 22:38:19 volumio volumio[942]: info: CoreCommandRouter::volumioPushState Oct 11 22:38:19 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 22:38:19 volumio volumio[942]: info: interfaceApi::pushState Oct 11 22:38:20 volumio volumio[942]: info: CoreStateMachine::pushState Oct 11 22:38:20 volumio volumio[942]: info: CoreStateMachine::getState Oct 11 22:38:20 volumio volumio[942]: info: CorePlayQueue::getTrack 12 Oct 11 22:38:20 volumio volumio[942]: info: CoreCommandRouter::volumioPushState Oct 11 22:38:20 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 22:38:20 volumio volumio[942]: info: interfaceApi::pushState Oct 11 22:38:20 volumio volumio[942]: info: sending command... Oct 11 22:38:20 volumio volumio[942]: info: ------------------------------ 881ms Oct 11 22:38:20 volumio volumio[942]: info: Pushing Favourites {"service":"mpd","uri":"mnt/NAS/Nasyoo/Scorpions/Moment Of Glory (DSD 64 )/03 - Scorpions - Send Me An Angel.dsf","favourite":false} Oct 11 22:38:20 volumio volumio[942]: info: Pushing Favourites {"service":"mpd","uri":"mnt/NAS/Nasyoo/Scorpions/Moment Of Glory (DSD 64 )/03 - Scorpions - Send Me An Angel.dsf","favourite":false} Oct 11 22:38:20 volumio volumio[942]: info: parsing response... Oct 11 22:38:20 volumio volumio[942]: info: parsing response... Oct 11 22:38:20 volumio volumio[942]: info: ControllerMpd::parseTrackInfo Oct 11 22:38:20 volumio volumio[942]: info: ControllerMpd::parseTrackInfo Oct 11 22:38:20 volumio volumio[942]: info: ControllerMpd::pushState Oct 11 22:38:20 volumio volumio[942]: info: CoreCommandRouter::servicePushState Oct 11 22:38:20 volumio volumio[942]: info: CoreStateMachine::syncState Oct 11 22:38:20 volumio volumio[942]: info: CorePlayQueue::getTrack 12 Oct 11 22:38:20 volumio volumio[942]: info: STATE SERVICE {"status":"play","position":0,"seek":92,"duration":379,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Send Me An Angel","artist":"Scorpions","album":"Moment Of Glory","uri":"NAS/Nasyoo/Scorpions/Moment Of Glory (DSD 64 )/03 - Scorpions - Send Me An Angel.dsf","trackType":"dsf"} Oct 11 22:38:20 volumio volumio[942]: info: CURRENT POSITION 12 Oct 11 22:38:20 volumio volumio[942]: info: CoreStateMachine::syncState stateService play Oct 11 22:38:20 volumio volumio[942]: info: CoreStateMachine::syncState currentStatus play Oct 11 22:38:20 volumio volumio[942]: info: Received an update from plaugin. extracting info from payload Oct 11 22:38:20 volumio volumio[942]: info: CoreStateMachine::pushState Oct 11 22:38:20 volumio volumio[942]: info: CoreStateMachine::getState Oct 11 22:38:20 volumio volumio[942]: info: CorePlayQueue::getTrack 12 Oct 11 22:38:20 volumio volumio[942]: info: CoreCommandRouter::volumioPushState Oct 11 22:38:20 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 22:38:20 volumio volumio[942]: info: interfaceApi::pushState Oct 11 22:38:20 volumio volumio[942]: info: CoreStateMachine::pushState Oct 11 22:38:20 volumio volumio[942]: info: CoreStateMachine::getState Oct 11 22:38:20 volumio volumio[942]: info: CorePlayQueue::getTrack 12 Oct 11 22:38:20 volumio volumio[942]: info: CoreCommandRouter::volumioPushState Oct 11 22:38:20 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 22:38:20 volumio volumio[942]: info: interfaceApi::pushState Oct 11 22:38:20 volumio volumio[942]: info: ControllerMpd::pushState Oct 11 22:38:20 volumio volumio[942]: info: CoreCommandRouter::servicePushState Oct 11 22:38:20 volumio volumio[942]: info: CoreStateMachine::syncState Oct 11 22:38:20 volumio volumio[942]: info: CorePlayQueue::getTrack 12 Oct 11 22:38:20 volumio volumio[942]: info: STATE SERVICE {"status":"play","position":0,"seek":319,"duration":379,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Send Me An Angel","artist":"Scorpions","album":"Moment Of Glory","uri":"NAS/Nasyoo/Scorpions/Moment Of Glory (DSD 64 )/03 - Scorpions - Send Me An Angel.dsf","trackType":"dsf"} Oct 11 22:38:20 volumio volumio[942]: info: CURRENT POSITION 12 Oct 11 22:38:20 volumio volumio[942]: info: CoreStateMachine::syncState stateService play Oct 11 22:38:20 volumio volumio[942]: info: CoreStateMachine::syncState currentStatus play Oct 11 22:38:20 volumio volumio[942]: info: Received an update from plaugin. extracting info from payload Oct 11 22:38:20 volumio volumio[942]: info: CoreStateMachine::pushState Oct 11 22:38:20 volumio volumio[942]: info: CoreStateMachine::getState Oct 11 22:38:20 volumio volumio[942]: info: CorePlayQueue::getTrack 12 Oct 11 22:38:20 volumio volumio[942]: info: CoreCommandRouter::volumioPushState Oct 11 22:38:20 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 22:38:20 volumio volumio[942]: info: interfaceApi::pushState Oct 11 22:38:20 volumio volumio[942]: info: CoreStateMachine::pushState Oct 11 22:38:20 volumio volumio[942]: info: CoreStateMachine::getState Oct 11 22:38:20 volumio volumio[942]: info: CorePlayQueue::getTrack 12 Oct 11 22:38:20 volumio volumio[942]: info: CoreCommandRouter::volumioPushState Oct 11 22:38:20 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 22:38:20 volumio volumio[942]: info: interfaceApi::pushState Oct 11 22:38:20 volumio volumio[942]: info: ------------------------------ 984ms Oct 11 22:38:20 volumio volumio[942]: info: ------------------------------ 753ms Oct 11 22:38:20 volumio volumio[942]: info: Pushing Favourites {"service":"mpd","uri":"mnt/NAS/Nasyoo/Scorpions/Moment Of Glory (DSD 64 )/03 - Scorpions - Send Me An Angel.dsf","favourite":false} Oct 11 22:38:20 volumio volumio[942]: info: Pushing Favourites {"service":"mpd","uri":"mnt/NAS/Nasyoo/Scorpions/Moment Of Glory (DSD 64 )/03 - Scorpions - Send Me An Angel.dsf","favourite":false} Oct 11 22:38:20 volumio volumio[942]: info: Pushing Favourites {"service":"mpd","uri":"mnt/NAS/Nasyoo/Scorpions/Moment Of Glory (DSD 64 )/03 - Scorpions - Send Me An Angel.dsf","favourite":false} Oct 11 22:38:20 volumio volumio[942]: info: Pushing Favourites {"service":"mpd","uri":"mnt/NAS/Nasyoo/Scorpions/Moment Of Glory (DSD 64 )/03 - Scorpions - Send Me An Angel.dsf","favourite":false} Oct 11 22:38:57 volumio volumio[942]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Oct 11 22:38:57 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Oct 11 22:38:57 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:57 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:57 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:57 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:57 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:57 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:57 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:57 volumio sudo[7383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 11 22:38:57 volumio sudo[7383]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 22:38:57 volumio sudo[7382]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 11 22:38:57 volumio sudo[7382]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 22:38:57 volumio sudo[7382]: pam_unix(sudo:session): session closed for user root Oct 11 22:38:57 volumio volumio[942]: info: MPD Permissions set Oct 11 22:38:57 volumio systemd[1]: Stopping Music Player Daemon... Oct 11 22:38:57 volumio volumio[942]: error: Upnp client error: Error: read ECONNRESET Oct 11 22:38:58 volumio systemd[1]: Starting Music Player Daemon... Oct 11 22:38:59 volumio volumio[942]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Oct 11 22:38:59 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Oct 11 22:38:59 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:59 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:59 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:59 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:59 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:59 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:59 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:38:59 volumio sudo[7397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 11 22:38:59 volumio sudo[7397]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 22:38:59 volumio sudo[7399]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 11 22:38:59 volumio sudo[7397]: pam_unix(sudo:session): session closed for user root Oct 11 22:38:59 volumio volumio[942]: info: MPD Permissions set Oct 11 22:38:59 volumio sudo[7399]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 22:38:59 volumio systemd[1]: Stopping Music Player Daemon... Oct 11 22:38:59 volumio systemd[1]: Starting Music Player Daemon... Oct 11 22:39:00 volumio volumio[942]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Oct 11 22:39:00 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Oct 11 22:39:00 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:00 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:00 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:00 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:00 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:00 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:00 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:00 volumio sudo[7406]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 11 22:39:00 volumio sudo[7406]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 22:39:00 volumio sudo[7407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 11 22:39:00 volumio sudo[7407]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 22:39:00 volumio sudo[7406]: pam_unix(sudo:session): session closed for user root Oct 11 22:39:00 volumio volumio[942]: info: MPD Permissions set Oct 11 22:39:00 volumio systemd[1]: Stopping Music Player Daemon... Oct 11 22:39:01 volumio systemd[1]: Starting Music Player Daemon... Oct 11 22:39:01 volumio volumio[942]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Oct 11 22:39:01 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Oct 11 22:39:01 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:01 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:01 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:01 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:01 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:01 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:01 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:02 volumio sudo[7414]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 11 22:39:02 volumio sudo[7415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 11 22:39:02 volumio sudo[7414]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 22:39:02 volumio sudo[7415]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 22:39:02 volumio sudo[7414]: pam_unix(sudo:session): session closed for user root Oct 11 22:39:02 volumio volumio[942]: info: MPD Permissions set Oct 11 22:39:02 volumio systemd[1]: Stopping Music Player Daemon... Oct 11 22:39:02 volumio systemd[1]: Starting Music Player Daemon... Oct 11 22:39:02 volumio volumio[942]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Oct 11 22:39:02 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Oct 11 22:39:02 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:02 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:02 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:02 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:02 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:02 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:02 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:02 volumio sudo[7425]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 11 22:39:02 volumio sudo[7425]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 22:39:02 volumio sudo[7426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 11 22:39:02 volumio sudo[7426]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 22:39:02 volumio sudo[7425]: pam_unix(sudo:session): session closed for user root Oct 11 22:39:02 volumio volumio[942]: info: MPD Permissions set Oct 11 22:39:02 volumio systemd[1]: Stopping Music Player Daemon... Oct 11 22:39:03 volumio systemd[1]: Starting Music Player Daemon... Oct 11 22:39:04 volumio volumio[942]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Oct 11 22:39:04 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Oct 11 22:39:04 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:04 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:04 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:04 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:04 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:04 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:04 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:04 volumio systemd[1]: Started Music Player Daemon. Oct 11 22:39:04 volumio sudo[7399]: pam_unix(sudo:session): session closed for user root Oct 11 22:39:04 volumio sudo[7407]: pam_unix(sudo:session): session closed for user root Oct 11 22:39:04 volumio sudo[7426]: pam_unix(sudo:session): session closed for user root Oct 11 22:39:04 volumio sudo[7415]: pam_unix(sudo:session): session closed for user root Oct 11 22:39:04 volumio sudo[7383]: pam_unix(sudo:session): session closed for user root Oct 11 22:39:04 volumio sudo[7439]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 11 22:39:04 volumio sudo[7436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 11 22:39:04 volumio sudo[7439]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 22:39:04 volumio sudo[7436]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 22:39:04 volumio sudo[7436]: pam_unix(sudo:session): session closed for user root Oct 11 22:39:04 volumio systemd[1]: Stopping Music Player Daemon... Oct 11 22:39:04 volumio systemd[1]: Starting Music Player Daemon... Oct 11 22:39:04 volumio systemd[1]: mpd.service start request repeated too quickly, refusing to start. Oct 11 22:39:04 volumio systemd[1]: Failed to start Music Player Daemon. Oct 11 22:39:04 volumio sudo[7439]: pam_unix(sudo:session): session closed for user root Oct 11 22:39:04 volumio systemd[1]: Unit mpd.service entered failed state. Oct 11 22:39:04 volumio systemd[1]: Starting Music Player Daemon... Oct 11 22:39:04 volumio systemd[1]: mpd.service start request repeated too quickly, refusing to start. Oct 11 22:39:04 volumio systemd[1]: Failed to start Music Player Daemon. Oct 11 22:39:04 volumio systemd[1]: Unit mpd.socket entered failed state. Oct 11 22:39:04 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:04 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:04 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:04 volumio volumio[942]: error: MPD error: Error: connect ECONNRESET /run/mpd/socket Oct 11 22:39:04 volumio volumio[942]: error: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Oct 11 22:39:04 volumio volumio[942]: Job for mpd.service failed. See 'systemctl status mpd.service' and 'journalctl -xn' for details. Oct 11 22:39:04 volumio volumio[942]: info: MPD Permissions set Oct 11 22:39:04 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:04 volumio volumio[942]: error: MPD error: Error: write EPIPE Oct 11 22:39:04 volumio volumio[942]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Oct 11 22:39:04 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Oct 11 22:39:04 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:04 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:04 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:04 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:04 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:04 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:04 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:04 volumio sudo[7446]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 11 22:39:04 volumio sudo[7446]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 22:39:04 volumio sudo[7445]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 11 22:39:04 volumio sudo[7445]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 22:39:04 volumio sudo[7445]: pam_unix(sudo:session): session closed for user root Oct 11 22:39:04 volumio volumio[942]: info: MPD Permissions set Oct 11 22:39:04 volumio systemd[1]: Starting Music Player Daemon... Oct 11 22:39:04 volumio systemd[1]: mpd.service start request repeated too quickly, refusing to start. Oct 11 22:39:04 volumio systemd[1]: Failed to start Music Player Daemon. Oct 11 22:39:04 volumio sudo[7446]: pam_unix(sudo:session): session closed for user root Oct 11 22:39:04 volumio volumio[942]: error: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Oct 11 22:39:04 volumio volumio[942]: Job for mpd.service failed. See 'systemctl status mpd.service' and 'journalctl -xn' for details. Oct 11 22:39:05 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:08 volumio volumio[942]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Oct 11 22:39:08 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Oct 11 22:39:08 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:08 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:08 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:08 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:08 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:08 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:08 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 22:39:08 volumio sudo[7451]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 11 22:39:08 volumio sudo[7451]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 22:39:08 volumio sudo[7452]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 11 22:39:08 volumio sudo[7451]: pam_unix(sudo:session): session closed for user root Oct 11 22:39:08 volumio volumio[942]: info: MPD Permissions set Oct 11 22:39:08 volumio sudo[7452]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 22:39:08 volumio systemd[1]: Starting Music Player Daemon... Oct 11 22:39:09 volumio mpd[7455]: exception: bind to '0.0.0.0:6600' failed (continuing anyway, because binding to '[::]:6600' succeeded): Failed to bind socket: Address already in use Oct 11 22:39:09 volumio systemd[1]: Started Music Player Daemon. Oct 11 22:39:09 volumio sudo[7452]: pam_unix(sudo:session): session closed for user root Oct 11 22:39:09 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:09 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:09 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:09 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:09 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:09 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:09 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:10 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:12 volumio volumio[942]: info: CoreCommandRouter::volumioPause Oct 11 22:39:12 volumio volumio[942]: info: CoreStateMachine::pause Oct 11 22:39:12 volumio volumio[942]: info: CoreStateMachine::stPlaybackTimer Oct 11 22:39:12 volumio volumio[942]: info: CoreStateMachine::servicePause Oct 11 22:39:12 volumio volumio[942]: info: CorePlayQueue::getTrack 12 Oct 11 22:39:12 volumio volumio[942]: info: CoreCommandRouter::servicePause Oct 11 22:39:12 volumio volumio[942]: info: ControllerMpd::pause Oct 11 22:39:12 volumio volumio[942]: info: ControllerMpd::sendMpdCommand pause Oct 11 22:39:14 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:14 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:14 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:14 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:14 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:14 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:14 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:15 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:16 volumio volumio[942]: info: CoreCommandRouter::volumioPrevious Oct 11 22:39:16 volumio volumio[942]: info: CoreStateMachine::previous Oct 11 22:39:16 volumio volumio[942]: info: CoreStateMachine::updateTrackBlock Oct 11 22:39:16 volumio volumio[942]: info: CorePlayQueue::getTrackBlock Oct 11 22:39:16 volumio volumio[942]: info: CoreStateMachine::serviceClearAddPlay Oct 11 22:39:16 volumio volumio[942]: info: CoreCommandRouter::serviceClearAddPlayTracks Oct 11 22:39:16 volumio volumio[942]: error: WARNING: No clearAddPlayTracks method for service mpd Oct 11 22:39:19 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:19 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:19 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:19 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:19 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:19 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:19 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:20 volumio volumio[942]: error: MPD error: Error: connect ECONNREFUSED /run/mpd/socket Oct 11 22:39:20 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 11 22:39:20 volumio volumio[942]: info: CURURI: artists://Scorpions/Moment%20Of%20Glory Oct 11 22:39:20 volumio volumio[942]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 11 22:39:20 volumio volumio[942]: { AssertionError [ERR_ASSERTION]: false == true Oct 11 22:39:20 volumio volumio[942]: at MpdClient.sendCommand (/volumio/app/plugins/music_service/mpd/lib/mpd.js:92:9) Oct 11 22:39:20 volumio volumio[942]: at ControllerMpd.listAlbumSongs (/volumio/app/plugins/music_service/mpd/index.js:3124:17) Oct 11 22:39:20 volumio volumio[942]: at ControllerMpd.handleBrowseUri (/volumio/app/plugins/music_service/mpd/index.js:2917:21) Oct 11 22:39:20 volumio volumio[942]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1000:29) Oct 11 22:39:20 volumio volumio[942]: at CoreMusicLibrary.executeBrowseSource (/volumio/app/musiclibrary.js:318:39) Oct 11 22:39:20 volumio volumio[942]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:354:32) Oct 11 22:39:20 volumio volumio[942]: at emitTwo (events.js:126:13) Oct 11 22:39:20 volumio volumio[942]: at Socket.emit (events.js:214:7) Oct 11 22:39:20 volumio volumio[942]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Oct 11 22:39:20 volumio volumio[942]: at _combinedTickCallback (internal/process/next_tick.js:131:7) Oct 11 22:39:20 volumio volumio[942]: at process._tickCallback (internal/process/next_tick.js:180:9) Oct 11 22:39:20 volumio volumio[942]: generatedMessage: true, Oct 11 22:39:20 volumio volumio[942]: name: 'AssertionError [ERR_ASSERTION]', Oct 11 22:39:20 volumio volumio[942]: code: 'ERR_ASSERTION', Oct 11 22:39:20 volumio volumio[942]: actual: false, Oct 11 22:39:20 volumio volumio[942]: expected: true, Oct 11 22:39:20 volumio volumio[942]: operator: '==' } Oct 11 22:39:20 volumio volumio[942]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 11 22:39:22 volumio sudo[7469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-11 22:38 Oct 11 22:39:22 volumio sudo[7469]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="2f09878fca434492a3a1c8d64c992c38a304bdcb" VOLUMIO_FE_VERSION="81c7100e9c7342b16fc9e0ca5908a26771e08c4f" VOLUMIO_BE_VERSION="9ddaa4edade219b4424aaf553d8a153e2d73143a" VOLUMIO_ARCH="x86" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Jun 15 20:45:03 CEST 2018" VOLUMIO_VERSION="2.411" VOLUMIO_HARDWARE="x86"