-- Logs begin at Fri 2020-12-11 14:53:56 UTC, end at Tue 2024-07-09 12:41:20 UTC. -- Jul 09 12:40:00 volumio volumio[4919]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 09 12:40:00 volumio volumio[4919]: info: CoreStateMachine::ClearQueue Jul 09 12:40:00 volumio volumio[4919]: info: CoreStateMachine::stop Jul 09 12:40:00 volumio volumio[4919]: info: CoreStateMachine::serviceStop Jul 09 12:40:00 volumio volumio[4919]: info: CoreCommandRouter::serviceStop Jul 09 12:40:00 volumio volumio[4919]: info: Airplay Stop Jul 09 12:40:00 volumio volumio[4919]: info: Stopping Airplay Playback and sending pause command to client via USR2 Jul 09 12:40:00 volumio volumio[4919]: info: CorePlayQueue::clearPlayQueue Jul 09 12:40:00 volumio volumio[4919]: info: CorePlayQueue::saveQueue Jul 09 12:40:00 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:00 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:00 volumio volumio[4919]: info: CoreCommandRouter::volumioPushQueue Jul 09 12:40:00 volumio volumio[4919]: info: CoreStateMachine::addQueueItems Jul 09 12:40:00 volumio volumio[4919]: info: CorePlayQueue::addQueueItems Jul 09 12:40:00 volumio volumio[4919]: info: Adding Item to queue: music-library/USB/02. 半 島 鐵 盒.mp3 Jul 09 12:40:00 volumio volumio[4919]: info: Exploding uri music-library/USB/02. 半 島 鐵 盒.mp3 in service mpd Jul 09 12:40:00 volumio volumio[4919]: info: ALBUMART /albumart?cacheid=507&web=%E5%91%A8%E6%9D%B0%E5%80%AB/%E5%85%AB%E5%BA%A6%E7%A9%BA%E9%96%93/mega&path=%2Fmnt%2FUSB%2F02.%20%E5%8D%8A%20%E5%B3%B6%20%E9%90%B5%20%E7%9B%92.mp3&metadata=false Jul 09 12:40:00 volumio volumio[4919]: info: URI /mnt/USB/02. 半 島 鐵 盒.mp3 Jul 09 12:40:00 volumio volumio[4919]: info: CorePlayQueue::saveQueue Jul 09 12:40:00 volumio volumio[4919]: info: CoreCommandRouter::volumioPushQueue Jul 09 12:40:00 volumio sudo[5418]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 5256 Jul 09 12:40:00 volumio sudo[5418]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 12:40:00 volumio volumio[4919]: info: CoreStateMachine::updateTrackBlock Jul 09 12:40:00 volumio volumio[4919]: info: CorePlayQueue::getTrackBlock Jul 09 12:40:00 volumio volumio[4919]: info: CoreCommandRouter::volumioPlay Jul 09 12:40:00 volumio volumio[4919]: UNSET VOLATILE Jul 09 12:40:00 volumio sudo[5418]: pam_unix(sudo:session): session closed for user root Jul 09 12:40:00 volumio shairport-sync[5256]: {"time":1720528791576,"response":"startAirplayPlayback Success"} Jul 09 12:40:00 volumio volumio[4919]: info: Stopping Airplay Playback and sending pause command to client via USR2 Jul 09 12:40:00 volumio kernel: aml_spdif_dai: aiu 958 playback disable Jul 09 12:40:00 volumio systemd[1]: shairport-sync.service: main process exited, code=killed, status=12/USR2 Jul 09 12:40:00 volumio systemd[1]: Unit shairport-sync.service entered failed state. Jul 09 12:40:00 volumio volumio[4919]: info: CoreStateMachine::play index 0 Jul 09 12:40:00 volumio volumio[4919]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 09 12:40:00 volumio volumio[4919]: info: CoreStateMachine::stop Jul 09 12:40:00 volumio volumio[4919]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 09 12:40:00 volumio volumio[4919]: UNSET VOLATILE Jul 09 12:40:00 volumio volumio[4919]: info: CoreStateMachine::stPlaybackTimer Jul 09 12:40:00 volumio volumio[4919]: info: CoreStateMachine::updateTrackBlock Jul 09 12:40:00 volumio volumio[4919]: info: CorePlayQueue::getTrackBlock Jul 09 12:40:00 volumio volumio[4919]: info: CoreStateMachine::pushState Jul 09 12:40:00 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:00 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:00 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:00 volumio volumio[4919]: info: CoreStateMachine::serviceStop Jul 09 12:40:00 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:00 volumio volumio[4919]: info: CoreCommandRouter::serviceStop Jul 09 12:40:00 volumio volumio[4919]: info: ControllerMpd::stop Jul 09 12:40:00 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand stop Jul 09 12:40:00 volumio volumio[4919]: info: CoreStateMachine::play index undefined Jul 09 12:40:00 volumio volumio[4919]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 09 12:40:00 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:00 volumio volumio[4919]: info: CoreStateMachine::startPlaybackTimer Jul 09 12:40:00 volumio sudo[5423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 Jul 09 12:40:00 volumio sudo[5423]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 12:40:00 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:00 volumio volumio[4919]: verbose: ControllerMpd::clearAddPlayTracks USB/02. 半 島 鐵 盒.mp3 Jul 09 12:40:00 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand stop Jul 09 12:40:00 volumio sudo[5423]: pam_unix(sudo:session): session closed for user root Jul 09 12:40:00 volumio volumio[4919]: info: Shairport-Sync paused with USR2 Jul 09 12:40:00 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand clear Jul 09 12:40:00 volumio volumio[4919]: info: Cannot execute Shairport-sync USR2 kill: Error: Command failed: /usr/bin/sudo /bin/kill -USR2 $(pidof shairport-sync) Jul 09 12:40:00 volumio volumio[4919]: kill: invalid argument U Jul 09 12:40:00 volumio volumio[4919]: Usage: Jul 09 12:40:00 volumio volumio[4919]: kill [options] [...] Jul 09 12:40:00 volumio volumio[4919]: Options: Jul 09 12:40:00 volumio volumio[4919]: [...] send signal to every listed Jul 09 12:40:00 volumio volumio[4919]: -, -s, --signal Jul 09 12:40:00 volumio volumio[4919]: specify the to be sent Jul 09 12:40:00 volumio volumio[4919]: -l, --list=[] list all signal names, or convert one to a name Jul 09 12:40:00 volumio volumio[4919]: -L, --table list all signal names in a nice table Jul 09 12:40:00 volumio volumio[4919]: -h, --help display this help and exit Jul 09 12:40:00 volumio volumio[4919]: -V, --version output version information and exit Jul 09 12:40:00 volumio volumio[4919]: For more details see kill(1). Jul 09 12:40:00 volumio volumio[4919]: info: Jul 09 12:40:00 volumio volumio[4919]: ---------------------------- MPD announces system playlist update Jul 09 12:40:00 volumio volumio[4919]: info: Ignoring MPD Status Update Jul 09 12:40:00 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand add "USB/02. 半 島 鐵 盒.mp3" Jul 09 12:40:00 volumio volumio[4919]: error: updateQueue error: null Jul 09 12:40:00 volumio volumio[4919]: info: Jul 09 12:40:00 volumio volumio[4919]: ---------------------------- MPD announces system playlist update Jul 09 12:40:00 volumio volumio[4919]: info: Ignoring MPD Status Update Jul 09 12:40:00 volumio volumio[4919]: info: ------------------------------ 10ms Jul 09 12:40:00 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand play Jul 09 12:40:00 volumio volumio[4919]: info: ------------------------------ 7ms Jul 09 12:40:00 volumio volumio[4919]: info: Jul 09 12:40:00 volumio volumio[4919]: ---------------------------- MPD announces state update: player Jul 09 12:40:00 volumio volumio[4919]: info: ControllerMpd::getState Jul 09 12:40:00 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand status Jul 09 12:40:00 volumio kernel: aml_spdif_dai: aml_hw_iec958_init,runtime->rate=192000, same source mode(0) Jul 09 12:40:00 volumio kernel: aml_spdif_dai: set normal 512 fs /4 fs Jul 09 12:40:00 volumio kernel: aml_spdif_dai: iec958 mode PCM32 Jul 09 12:40:00 volumio kernel: aml_audio_hw: IEC958 PCM32 Jul 09 12:40:00 volumio kernel: hdmitx: audio: aout notify rate 192000 Jul 09 12:40:00 volumio kernel: hdmitx: audio: aout notify size 32 Jul 09 12:40:00 volumio kernel: hdmtix: set audio Jul 09 12:40:00 volumio kernel: hdmitx tx_aud_src = 0 Jul 09 12:40:00 volumio kernel: hdmitx: fs = 7, cd = 4, tmds_clk = 74250 Jul 09 12:40:00 volumio volumio[4919]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%91%A8%E6%9D%B0%E5%80%AB/%E5%85%AB%E5%BA%A6%E7%A9%BA%E9%96%93/ff338865-dee6-446e-b14e-a010df729264.jpg' Jul 09 12:40:00 volumio kernel: hdmitx aud_n_para = 24576 Jul 09 12:40:00 volumio kernel: hdmitx set channel status Jul 09 12:40:00 volumio kernel: hdmitx: audio: Audio Type: PCM Jul 09 12:40:00 volumio kernel: hdmitx: audio: set audio param Jul 09 12:40:00 volumio volumio[4919]: info: Jul 09 12:40:00 volumio volumio[4919]: ---------------------------- MPD announces state update: player Jul 09 12:40:00 volumio volumio[4919]: info: ControllerMpd::getState Jul 09 12:40:00 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand status Jul 09 12:40:00 volumio volumio[4919]: verbose: ControllerMpd::parseState Jul 09 12:40:00 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 09 12:40:00 volumio volumio[4919]: verbose: ControllerMpd::parseState Jul 09 12:40:00 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 09 12:40:00 volumio volumio[4919]: verbose: ControllerMpd::parseTrackInfo Jul 09 12:40:00 volumio volumio[4919]: info: ControllerMpd::pushState Jul 09 12:40:00 volumio volumio[4919]: info: CoreCommandRouter::servicePushState Jul 09 12:40:00 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:00 volumio volumio[4919]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":319,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"半島鐵盒","artist":"周杰倫","album":"八度空間","uri":"USB/02. 半 島 鐵 盒.mp3","trackType":"mp3"} Jul 09 12:40:00 volumio volumio[4919]: verbose: CURRENT POSITION 0 Jul 09 12:40:00 volumio volumio[4919]: info: CoreStateMachine::syncState stateService play Jul 09 12:40:00 volumio volumio[4919]: info: CoreStateMachine::syncState currentStatus stop Jul 09 12:40:00 volumio volumio[4919]: info: CoreStateMachine::pushState Jul 09 12:40:00 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:00 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:00 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:00 volumio volumio[4919]: info: ------------------------------ 88ms Jul 09 12:40:00 volumio volumio[4919]: verbose: ControllerMpd::parseTrackInfo Jul 09 12:40:00 volumio volumio[4919]: info: ControllerMpd::pushState Jul 09 12:40:00 volumio volumio[4919]: info: CoreCommandRouter::servicePushState Jul 09 12:40:00 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:00 volumio volumio[4919]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11,"duration":319,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"半島鐵盒","artist":"周杰倫","album":"八度空間","uri":"USB/02. 半 島 鐵 盒.mp3","trackType":"mp3"} Jul 09 12:40:00 volumio volumio[4919]: verbose: CURRENT POSITION 0 Jul 09 12:40:00 volumio volumio[4919]: info: CoreStateMachine::syncState stateService play Jul 09 12:40:00 volumio volumio[4919]: info: CoreStateMachine::syncState currentStatus play Jul 09 12:40:00 volumio volumio[4919]: info: Received an update from plugin. extracting info from payload Jul 09 12:40:00 volumio volumio[4919]: info: CoreStateMachine::pushState Jul 09 12:40:00 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:00 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:00 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:00 volumio volumio[4919]: info: CoreStateMachine::pushState Jul 09 12:40:00 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:00 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:00 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:00 volumio volumio[4919]: info: ------------------------------ 77ms Jul 09 12:40:00 volumio kernel: aml_spdif_dai: aiu 958 playback enable Jul 09 12:40:01 volumio volumio[4919]: info: Restarting Shairport-Sync after stop Jul 09 12:40:01 volumio sudo[5429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 09 12:40:01 volumio sudo[5429]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 12:40:01 volumio systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jul 09 12:40:01 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 09 12:40:01 volumio sudo[5429]: pam_unix(sudo:session): session closed for user root Jul 09 12:40:01 volumio volumio[4919]: info: Shairport-Sync retarted Jul 09 12:40:13 volumio volumio[4919]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 09 12:40:13 volumio volumio[4919]: info: CoreStateMachine::ClearQueue Jul 09 12:40:13 volumio volumio[4919]: info: CoreStateMachine::stop Jul 09 12:40:13 volumio volumio[4919]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 09 12:40:13 volumio volumio[4919]: UNSET VOLATILE Jul 09 12:40:13 volumio volumio[4919]: info: CoreStateMachine::stPlaybackTimer Jul 09 12:40:13 volumio volumio[4919]: info: CoreStateMachine::updateTrackBlock Jul 09 12:40:13 volumio volumio[4919]: info: CorePlayQueue::getTrackBlock Jul 09 12:40:13 volumio volumio[4919]: info: CoreStateMachine::pushState Jul 09 12:40:13 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:13 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:13 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:13 volumio volumio[4919]: info: CoreStateMachine::serviceStop Jul 09 12:40:13 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:13 volumio volumio[4919]: info: CoreCommandRouter::serviceStop Jul 09 12:40:13 volumio volumio[4919]: info: ControllerMpd::stop Jul 09 12:40:13 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand stop Jul 09 12:40:13 volumio volumio[4919]: info: CorePlayQueue::clearPlayQueue Jul 09 12:40:13 volumio volumio[4919]: info: CorePlayQueue::saveQueue Jul 09 12:40:13 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:13 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:13 volumio volumio[4919]: info: CoreCommandRouter::volumioPushQueue Jul 09 12:40:13 volumio volumio[4919]: info: CoreStateMachine::addQueueItems Jul 09 12:40:13 volumio volumio[4919]: info: CorePlayQueue::addQueueItems Jul 09 12:40:13 volumio volumio[4919]: info: Adding Item to queue: albums://%E5%91%A8%E6%9D%B0%E5%80%AB/%E5%85%AB%E5%BA%A6%E7%A9%BA%E9%96%93 Jul 09 12:40:13 volumio volumio[4919]: info: Exploding uri albums://%E5%91%A8%E6%9D%B0%E5%80%AB/%E5%85%AB%E5%BA%A6%E7%A9%BA%E9%96%93 in service mpd Jul 09 12:40:13 volumio volumio[4919]: info: CorePlayQueue::saveQueue Jul 09 12:40:13 volumio volumio[4919]: info: CoreCommandRouter::volumioPushQueue Jul 09 12:40:13 volumio volumio[4919]: info: CoreStateMachine::updateTrackBlock Jul 09 12:40:13 volumio volumio[4919]: info: CorePlayQueue::getTrackBlock Jul 09 12:40:13 volumio volumio[4919]: info: CoreCommandRouter::volumioPlay Jul 09 12:40:13 volumio volumio[4919]: UNSET VOLATILE Jul 09 12:40:13 volumio volumio[4919]: info: CoreStateMachine::play index 0 Jul 09 12:40:13 volumio volumio[4919]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 09 12:40:13 volumio volumio[4919]: info: CoreStateMachine::stop Jul 09 12:40:13 volumio volumio[4919]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 09 12:40:13 volumio volumio[4919]: UNSET VOLATILE Jul 09 12:40:13 volumio volumio[4919]: info: CoreStateMachine::play index undefined Jul 09 12:40:13 volumio volumio[4919]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 09 12:40:13 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:13 volumio volumio[4919]: info: CoreStateMachine::startPlaybackTimer Jul 09 12:40:13 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:13 volumio volumio[4919]: verbose: ControllerMpd::clearAddPlayTracks USB/02. 半 島 鐵 盒.mp3 Jul 09 12:40:13 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand stop Jul 09 12:40:13 volumio kernel: aml_spdif_dai: aiu 958 playback disable Jul 09 12:40:13 volumio volumio[4919]: info: Jul 09 12:40:13 volumio volumio[4919]: ---------------------------- MPD announces state update: player Jul 09 12:40:13 volumio volumio[4919]: info: ControllerMpd::getState Jul 09 12:40:13 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand status Jul 09 12:40:13 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand clear Jul 09 12:40:13 volumio volumio[4919]: info: Jul 09 12:40:13 volumio volumio[4919]: ---------------------------- MPD announces system playlist update Jul 09 12:40:13 volumio volumio[4919]: info: Ignoring MPD Status Update Jul 09 12:40:13 volumio volumio[4919]: verbose: ControllerMpd::parseState Jul 09 12:40:13 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 09 12:40:13 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand add "USB/02. 半 島 鐵 盒.mp3" Jul 09 12:40:13 volumio volumio[4919]: error: updateQueue error: null Jul 09 12:40:13 volumio volumio[4919]: info: Jul 09 12:40:13 volumio volumio[4919]: ---------------------------- MPD announces system playlist update Jul 09 12:40:13 volumio volumio[4919]: info: Ignoring MPD Status Update Jul 09 12:40:13 volumio volumio[4919]: info: ------------------------------ 10ms Jul 09 12:40:13 volumio volumio[4919]: verbose: ControllerMpd::parseTrackInfo Jul 09 12:40:13 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand play Jul 09 12:40:13 volumio volumio[4919]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 09 12:40:13 volumio volumio[4919]: info: ------------------------------ 33ms Jul 09 12:40:13 volumio volumio[4919]: info: ------------------------------ 18ms Jul 09 12:40:13 volumio kernel: aml_spdif_dai: aml_hw_iec958_init,runtime->rate=192000, same source mode(0) Jul 09 12:40:13 volumio kernel: aml_spdif_dai: set normal 512 fs /4 fs Jul 09 12:40:13 volumio volumio[4919]: info: Jul 09 12:40:13 volumio volumio[4919]: ---------------------------- MPD announces state update: player Jul 09 12:40:13 volumio volumio[4919]: info: ControllerMpd::getState Jul 09 12:40:13 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand status Jul 09 12:40:13 volumio kernel: aml_spdif_dai: iec958 mode PCM32 Jul 09 12:40:13 volumio kernel: aml_audio_hw: IEC958 PCM32 Jul 09 12:40:13 volumio kernel: hdmitx: audio: aout notify rate 192000 Jul 09 12:40:13 volumio kernel: hdmitx: audio: aout notify size 32 Jul 09 12:40:13 volumio kernel: hdmitx: audio: no update Jul 09 12:40:13 volumio volumio[4919]: info: Jul 09 12:40:13 volumio volumio[4919]: ---------------------------- MPD announces state update: player Jul 09 12:40:13 volumio volumio[4919]: info: ControllerMpd::getState Jul 09 12:40:13 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand status Jul 09 12:40:13 volumio volumio[4919]: verbose: ControllerMpd::parseState Jul 09 12:40:13 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 09 12:40:13 volumio volumio[4919]: verbose: ControllerMpd::parseState Jul 09 12:40:13 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 09 12:40:13 volumio volumio[4919]: verbose: ControllerMpd::parseTrackInfo Jul 09 12:40:13 volumio volumio[4919]: info: ControllerMpd::pushState Jul 09 12:40:13 volumio volumio[4919]: info: CoreCommandRouter::servicePushState Jul 09 12:40:13 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:13 volumio volumio[4919]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":319,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"半島鐵盒","artist":"周杰倫","album":"八度空間","uri":"USB/02. 半 島 鐵 盒.mp3","trackType":"mp3"} Jul 09 12:40:13 volumio volumio[4919]: verbose: CURRENT POSITION 0 Jul 09 12:40:13 volumio volumio[4919]: info: CoreStateMachine::syncState stateService play Jul 09 12:40:13 volumio volumio[4919]: info: CoreStateMachine::syncState currentStatus stop Jul 09 12:40:13 volumio volumio[4919]: info: CoreStateMachine::pushState Jul 09 12:40:13 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:13 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:13 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:13 volumio volumio[4919]: info: ------------------------------ 85ms Jul 09 12:40:13 volumio volumio[4919]: verbose: ControllerMpd::parseTrackInfo Jul 09 12:40:13 volumio volumio[4919]: info: ControllerMpd::pushState Jul 09 12:40:13 volumio kernel: aml_spdif_dai: aiu 958 playback enable Jul 09 12:40:13 volumio volumio[4919]: info: CoreCommandRouter::servicePushState Jul 09 12:40:13 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:13 volumio volumio[4919]: verbose: STATE SERVICE {"status":"play","position":0,"seek":34,"duration":319,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"半島鐵盒","artist":"周杰倫","album":"八度空間","uri":"USB/02. 半 島 鐵 盒.mp3","trackType":"mp3"} Jul 09 12:40:13 volumio volumio[4919]: verbose: CURRENT POSITION 0 Jul 09 12:40:13 volumio volumio[4919]: info: CoreStateMachine::syncState stateService play Jul 09 12:40:13 volumio volumio[4919]: info: CoreStateMachine::syncState currentStatus play Jul 09 12:40:13 volumio volumio[4919]: info: Received an update from plugin. extracting info from payload Jul 09 12:40:13 volumio volumio[4919]: info: CoreStateMachine::pushState Jul 09 12:40:13 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:13 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:13 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:13 volumio volumio[4919]: info: CoreStateMachine::pushState Jul 09 12:40:13 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:13 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:13 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:13 volumio volumio[4919]: info: ------------------------------ 92ms Jul 09 12:40:13 volumio volumio[4919]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%91%A8%E6%9D%B0%E5%80%AB/%E5%85%AB%E5%BA%A6%E7%A9%BA%E9%96%93/ff338865-dee6-446e-b14e-a010df729264.jpg' Jul 09 12:40:14 volumio volumio[4919]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 09 12:40:14 volumio volumio[4919]: info: CoreStateMachine::ClearQueue Jul 09 12:40:14 volumio volumio[4919]: info: CoreStateMachine::stop Jul 09 12:40:14 volumio volumio[4919]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 09 12:40:14 volumio volumio[4919]: UNSET VOLATILE Jul 09 12:40:14 volumio volumio[4919]: info: CoreStateMachine::stPlaybackTimer Jul 09 12:40:14 volumio volumio[4919]: info: CoreStateMachine::updateTrackBlock Jul 09 12:40:14 volumio volumio[4919]: info: CorePlayQueue::getTrackBlock Jul 09 12:40:14 volumio volumio[4919]: info: CoreStateMachine::pushState Jul 09 12:40:14 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:14 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:14 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:14 volumio volumio[4919]: info: CoreStateMachine::serviceStop Jul 09 12:40:14 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:14 volumio volumio[4919]: info: CoreCommandRouter::serviceStop Jul 09 12:40:14 volumio volumio[4919]: info: ControllerMpd::stop Jul 09 12:40:14 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand stop Jul 09 12:40:14 volumio volumio[4919]: info: CorePlayQueue::clearPlayQueue Jul 09 12:40:14 volumio volumio[4919]: info: CorePlayQueue::saveQueue Jul 09 12:40:14 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:14 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:14 volumio volumio[4919]: info: CoreCommandRouter::volumioPushQueue Jul 09 12:40:14 volumio volumio[4919]: info: CoreStateMachine::addQueueItems Jul 09 12:40:14 volumio volumio[4919]: info: CorePlayQueue::addQueueItems Jul 09 12:40:14 volumio volumio[4919]: info: Adding Item to queue: music-library/USB/02. 半 島 鐵 盒.mp3 Jul 09 12:40:14 volumio volumio[4919]: info: Exploding uri music-library/USB/02. 半 島 鐵 盒.mp3 in service mpd Jul 09 12:40:14 volumio kernel: aml_spdif_dai: aiu 958 playback disable Jul 09 12:40:14 volumio volumio[4919]: info: Jul 09 12:40:14 volumio volumio[4919]: ---------------------------- MPD announces state update: player Jul 09 12:40:14 volumio volumio[4919]: info: ALBUMART /albumart?cacheid=507&web=%E5%91%A8%E6%9D%B0%E5%80%AB/%E5%85%AB%E5%BA%A6%E7%A9%BA%E9%96%93/mega&path=%2Fmnt%2FUSB%2F02.%20%E5%8D%8A%20%E5%B3%B6%20%E9%90%B5%20%E7%9B%92.mp3&metadata=false Jul 09 12:40:14 volumio volumio[4919]: info: URI /mnt/USB/02. 半 島 鐵 盒.mp3 Jul 09 12:40:14 volumio volumio[4919]: info: ControllerMpd::getState Jul 09 12:40:14 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand status Jul 09 12:40:14 volumio volumio[4919]: info: CorePlayQueue::saveQueue Jul 09 12:40:14 volumio volumio[4919]: info: CoreCommandRouter::volumioPushQueue Jul 09 12:40:14 volumio volumio[4919]: info: CoreStateMachine::updateTrackBlock Jul 09 12:40:14 volumio volumio[4919]: info: CorePlayQueue::getTrackBlock Jul 09 12:40:14 volumio volumio[4919]: info: CoreCommandRouter::volumioPlay Jul 09 12:40:14 volumio volumio[4919]: UNSET VOLATILE Jul 09 12:40:14 volumio volumio[4919]: info: CoreStateMachine::play index 0 Jul 09 12:40:14 volumio volumio[4919]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 09 12:40:14 volumio volumio[4919]: info: CoreStateMachine::stop Jul 09 12:40:14 volumio volumio[4919]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 09 12:40:14 volumio volumio[4919]: UNSET VOLATILE Jul 09 12:40:14 volumio volumio[4919]: info: CoreStateMachine::play index undefined Jul 09 12:40:14 volumio volumio[4919]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 09 12:40:14 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:14 volumio volumio[4919]: info: CoreStateMachine::startPlaybackTimer Jul 09 12:40:14 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:14 volumio volumio[4919]: verbose: ControllerMpd::clearAddPlayTracks USB/02. 半 島 鐵 盒.mp3 Jul 09 12:40:14 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand stop Jul 09 12:40:14 volumio volumio[4919]: verbose: ControllerMpd::parseState Jul 09 12:40:14 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 09 12:40:14 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand clear Jul 09 12:40:14 volumio volumio[4919]: info: Jul 09 12:40:14 volumio volumio[4919]: ---------------------------- MPD announces system playlist update Jul 09 12:40:14 volumio volumio[4919]: info: Ignoring MPD Status Update Jul 09 12:40:14 volumio volumio[4919]: verbose: ControllerMpd::parseTrackInfo Jul 09 12:40:14 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand add "USB/02. 半 島 鐵 盒.mp3" Jul 09 12:40:14 volumio volumio[4919]: info: ControllerMpd::pushState Jul 09 12:40:14 volumio volumio[4919]: info: CoreCommandRouter::servicePushState Jul 09 12:40:14 volumio volumio[4919]: info: CoreStateMachine::pushState Jul 09 12:40:14 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:14 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:14 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:14 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:14 volumio volumio[4919]: 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":"周杰倫","album":"八度空間","uri":"USB/02. 半 島 鐵 盒.mp3","trackType":"mp3"} Jul 09 12:40:14 volumio volumio[4919]: verbose: CURRENT POSITION 0 Jul 09 12:40:14 volumio volumio[4919]: info: CoreStateMachine::syncState stateService stop Jul 09 12:40:14 volumio volumio[4919]: info: CoreStateMachine::syncState currentStatus stop Jul 09 12:40:14 volumio volumio[4919]: info: CoreStateMachine::pushState Jul 09 12:40:14 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:14 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:14 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:14 volumio volumio[4919]: info: No code Jul 09 12:40:14 volumio volumio[4919]: info: CoreStateMachine::pushState Jul 09 12:40:14 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:14 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:14 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:14 volumio volumio[4919]: info: ------------------------------ 92ms Jul 09 12:40:14 volumio volumio[4919]: error: updateQueue error: null Jul 09 12:40:14 volumio volumio[4919]: info: Jul 09 12:40:14 volumio volumio[4919]: ---------------------------- MPD announces system playlist update Jul 09 12:40:14 volumio volumio[4919]: info: Ignoring MPD Status Update Jul 09 12:40:14 volumio volumio[4919]: info: ------------------------------ 49ms Jul 09 12:40:14 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand play Jul 09 12:40:14 volumio volumio[4919]: info: ------------------------------ 24ms Jul 09 12:40:14 volumio volumio[4919]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%91%A8%E6%9D%B0%E5%80%AB/%E5%85%AB%E5%BA%A6%E7%A9%BA%E9%96%93/ff338865-dee6-446e-b14e-a010df729264.jpg' Jul 09 12:40:14 volumio volumio[4919]: info: Jul 09 12:40:15 volumio volumio[4919]: ---------------------------- MPD announces state update: player Jul 09 12:40:15 volumio kernel: aml_spdif_dai: aml_hw_iec958_init,runtime->rate=192000, same source mode(0) Jul 09 12:40:15 volumio kernel: aml_spdif_dai: set normal 512 fs /4 fs Jul 09 12:40:15 volumio volumio[4919]: info: ControllerMpd::getState Jul 09 12:40:15 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand status Jul 09 12:40:15 volumio kernel: aml_spdif_dai: iec958 mode PCM32 Jul 09 12:40:15 volumio kernel: aml_audio_hw: IEC958 PCM32 Jul 09 12:40:15 volumio kernel: hdmitx: audio: aout notify rate 192000 Jul 09 12:40:15 volumio kernel: hdmitx: audio: aout notify size 32 Jul 09 12:40:15 volumio kernel: hdmitx: audio: no update Jul 09 12:40:15 volumio volumio[4919]: verbose: ControllerMpd::parseState Jul 09 12:40:15 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 09 12:40:15 volumio volumio[4919]: info: Jul 09 12:40:15 volumio volumio[4919]: ---------------------------- MPD announces state update: player Jul 09 12:40:15 volumio volumio[4919]: info: ControllerMpd::getState Jul 09 12:40:15 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand status Jul 09 12:40:15 volumio volumio[4919]: verbose: ControllerMpd::parseTrackInfo Jul 09 12:40:15 volumio volumio[4919]: info: ControllerMpd::pushState Jul 09 12:40:15 volumio volumio[4919]: info: CoreCommandRouter::servicePushState Jul 09 12:40:15 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:15 volumio volumio[4919]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":319,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"半島鐵盒","artist":"周杰倫","album":"八度空間","uri":"USB/02. 半 島 鐵 盒.mp3","trackType":"mp3"} Jul 09 12:40:15 volumio volumio[4919]: verbose: CURRENT POSITION 0 Jul 09 12:40:15 volumio volumio[4919]: info: CoreStateMachine::syncState stateService play Jul 09 12:40:15 volumio volumio[4919]: info: CoreStateMachine::syncState currentStatus stop Jul 09 12:40:15 volumio volumio[4919]: info: CoreStateMachine::pushState Jul 09 12:40:15 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:15 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:15 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:15 volumio volumio[4919]: info: ------------------------------ 56ms Jul 09 12:40:15 volumio volumio[4919]: verbose: ControllerMpd::parseState Jul 09 12:40:15 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 09 12:40:15 volumio volumio[4919]: verbose: ControllerMpd::parseTrackInfo Jul 09 12:40:15 volumio volumio[4919]: info: ControllerMpd::pushState Jul 09 12:40:15 volumio volumio[4919]: info: CoreCommandRouter::servicePushState Jul 09 12:40:15 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:15 volumio volumio[4919]: verbose: STATE SERVICE {"status":"play","position":0,"seek":11,"duration":319,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"半島鐵盒","artist":"周杰倫","album":"八度空間","uri":"USB/02. 半 島 鐵 盒.mp3","trackType":"mp3"} Jul 09 12:40:15 volumio volumio[4919]: verbose: CURRENT POSITION 0 Jul 09 12:40:15 volumio volumio[4919]: info: CoreStateMachine::syncState stateService play Jul 09 12:40:15 volumio volumio[4919]: info: CoreStateMachine::syncState currentStatus play Jul 09 12:40:15 volumio volumio[4919]: info: Received an update from plugin. extracting info from payload Jul 09 12:40:15 volumio volumio[4919]: info: CoreStateMachine::pushState Jul 09 12:40:15 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:15 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:15 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:15 volumio volumio[4919]: info: CoreStateMachine::pushState Jul 09 12:40:15 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:15 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:15 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:15 volumio kernel: aml_spdif_dai: aiu 958 playback enable Jul 09 12:40:15 volumio volumio[4919]: info: ------------------------------ 117ms Jul 09 12:40:15 volumio volumio[4919]: info: CoreCommandRouter::volumioPause Jul 09 12:40:15 volumio volumio[4919]: info: CoreStateMachine::pause Jul 09 12:40:15 volumio volumio[4919]: info: CoreStateMachine::stPlaybackTimer Jul 09 12:40:15 volumio volumio[4919]: info: CoreStateMachine::servicePause Jul 09 12:40:15 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:15 volumio volumio[4919]: info: CoreCommandRouter::servicePause Jul 09 12:40:15 volumio volumio[4919]: info: ControllerMpd::pause Jul 09 12:40:15 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand pause Jul 09 12:40:15 volumio volumio[4919]: info: Jul 09 12:40:15 volumio volumio[4919]: ---------------------------- MPD announces state update: player Jul 09 12:40:15 volumio kernel: aml_spdif_dai: aiu 958 playback disable Jul 09 12:40:15 volumio volumio[4919]: info: ControllerMpd::getState Jul 09 12:40:15 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand status Jul 09 12:40:15 volumio volumio[4919]: verbose: ControllerMpd::parseState Jul 09 12:40:15 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 09 12:40:15 volumio volumio[4919]: verbose: ControllerMpd::parseTrackInfo Jul 09 12:40:15 volumio volumio[4919]: info: ControllerMpd::pushState Jul 09 12:40:15 volumio volumio[4919]: info: CoreCommandRouter::servicePushState Jul 09 12:40:15 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:15 volumio volumio[4919]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":998,"duration":319,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"半島鐵盒","artist":"周杰倫","album":"八度空間","uri":"USB/02. 半 島 鐵 盒.mp3","trackType":"mp3"} Jul 09 12:40:15 volumio volumio[4919]: verbose: CURRENT POSITION 0 Jul 09 12:40:15 volumio volumio[4919]: info: CoreStateMachine::syncState stateService pause Jul 09 12:40:15 volumio volumio[4919]: info: CoreStateMachine::syncState currentStatus pause Jul 09 12:40:15 volumio volumio[4919]: info: CoreStateMachine::pushState Jul 09 12:40:15 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:15 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:15 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:15 volumio volumio[4919]: info: CoreStateMachine::stPlaybackTimer Jul 09 12:40:15 volumio volumio[4919]: info: ------------------------------ 26ms Jul 09 12:40:20 volumio volumio[4919]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 12:40:20 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 09 12:40:20 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 12:40:20 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 09 12:40:20 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 12:40:20 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 12:40:20 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 12:40:20 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 12:40:20 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 12:40:20 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 12:40:20 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 12:40:20 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 09 12:40:20 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 09 12:40:20 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 09 12:40:24 volumio volumio[4919]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Jul 09 12:40:24 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Jul 09 12:40:24 volumio sudo[5525]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 09 12:40:24 volumio sudo[5525]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 12:40:24 volumio sudo[5525]: pam_unix(sudo:session): session closed for user root Jul 09 12:40:24 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 12:40:24 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 12:40:24 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 12:40:24 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 12:40:24 volumio sudo[5527]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 09 12:40:24 volumio sudo[5527]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 12:40:24 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 12:40:24 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 12:40:24 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 12:40:24 volumio systemd[1]: Stopping Music Player Daemon... Jul 09 12:40:24 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 12:40:24 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 09 12:40:24 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 12:40:24 volumio volumio[4919]: info: MPD Permissions set Jul 09 12:40:24 volumio systemd[1]: Starting Music Player Daemon... Jul 09 12:40:25 volumio volumio[4919]: error: Upnp client error: Error: This socket has been ended by the other party Jul 09 12:40:25 volumio sudo[5527]: pam_unix(sudo:session): session closed for user root Jul 09 12:40:25 volumio systemd[1]: Started Music Player Daemon. Jul 09 12:40:25 volumio volumio[4919]: error: updateQueue error: null Jul 09 12:40:25 volumio volumio[4919]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Jul 09 12:40:25 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Jul 09 12:40:25 volumio sudo[5545]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 09 12:40:25 volumio sudo[5545]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 12:40:25 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 12:40:25 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 12:40:25 volumio sudo[5545]: pam_unix(sudo:session): session closed for user root Jul 09 12:40:25 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 12:40:25 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 12:40:25 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 12:40:25 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 12:40:25 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 12:40:25 volumio sudo[5547]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 09 12:40:25 volumio sudo[5547]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 12:40:25 volumio systemd[1]: Stopping Music Player Daemon... Jul 09 12:40:25 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 12:40:25 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 09 12:40:25 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 12:40:25 volumio volumio[4919]: info: MPD Permissions set Jul 09 12:40:26 volumio systemd[1]: Starting Music Player Daemon... Jul 09 12:40:26 volumio systemd[1]: Started Music Player Daemon. Jul 09 12:40:26 volumio sudo[5547]: pam_unix(sudo:session): session closed for user root Jul 09 12:40:26 volumio volumio[4919]: error: updateQueue error: null Jul 09 12:40:41 volumio volumio[4919]: info: CoreCommandRouter::volumioPlay Jul 09 12:40:41 volumio volumio[4919]: UNSET VOLATILE Jul 09 12:40:41 volumio volumio[4919]: info: CoreStateMachine::play index undefined Jul 09 12:40:41 volumio volumio[4919]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 09 12:40:41 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:41 volumio volumio[4919]: info: CoreStateMachine::startPlaybackTimer Jul 09 12:40:41 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:41 volumio volumio[4919]: info: ControllerMpd::resume Jul 09 12:40:41 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand play Jul 09 12:40:49 volumio volumio[4919]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 12:40:49 volumio volumio[4919]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 12:40:49 volumio volumio[4919]: info: Retrieving Cloud Streaming UI Jul 09 12:40:49 volumio volumio[4919]: info: Getting Tidal Cloud Configuration Jul 09 12:40:49 volumio volumio[4919]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 12:40:49 volumio volumio[4919]: info: Getting Qobuz Cloud Configuration Jul 09 12:40:49 volumio volumio[4919]: info: Asking plugin for UI Config Jul 09 12:40:49 volumio volumio[4919]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 12:40:49 volumio volumio[4919]: info: Getting Spotify Cloud Configuration Jul 09 12:40:49 volumio volumio[4919]: info: Asking plugin for UI Config Jul 09 12:40:49 volumio volumio[4919]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 12:40:49 volumio volumio[4919]: info: Saving Spotify Acccount Jul 09 12:40:49 volumio volumio[4919]: info: Got Tidal Cloud Configuration Jul 09 12:40:49 volumio volumio[4919]: info: Got it Jul 09 12:40:49 volumio volumio[4919]: info: Got it Jul 09 12:40:49 volumio volumio[4919]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 09 12:40:49 volumio volumio[4919]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 12:40:49 volumio volumio[4919]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jul 09 12:40:49 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 09 12:40:49 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 09 12:40:49 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 09 12:40:49 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 09 12:40:49 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 12:40:49 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 12:40:49 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 12:40:49 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 12:40:49 volumio volumio[4919]: info: CoreCommandRouter::volumioGetBrowseSources Jul 09 12:40:49 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 09 12:40:49 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 09 12:40:50 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Jul 09 12:40:50 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand rescan Jul 09 12:40:50 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand status Jul 09 12:40:50 volumio volumio[4919]: info: Jul 09 12:40:50 volumio volumio[4919]: ---------------------------- MPD announces state update: update Jul 09 12:40:50 volumio volumio[4919]: info: ControllerMpd::getState Jul 09 12:40:50 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand status Jul 09 12:40:50 volumio volumio[4919]: verbose: ControllerMpd::parseState Jul 09 12:40:50 volumio volumio[4919]: info: Command Router : Notfying DB Updatetrue Jul 09 12:40:50 volumio volumio[4919]: info: MPD Database updated - AlbumList cache refreshed Jul 09 12:40:50 volumio volumio[4919]: info: Jul 09 12:40:50 volumio volumio[4919]: ---------------------------- MPD announces state update: database Jul 09 12:40:50 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand status Jul 09 12:40:50 volumio volumio[4919]: info: Jul 09 12:40:50 volumio volumio[4919]: ---------------------------- MPD announces state update: update Jul 09 12:40:50 volumio volumio[4919]: info: ControllerMpd::getState Jul 09 12:40:50 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand status Jul 09 12:40:50 volumio volumio[4919]: info: ControllerMpd::getState Jul 09 12:40:50 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand status Jul 09 12:40:50 volumio volumio[4919]: verbose: ControllerMpd::parseState Jul 09 12:40:50 volumio volumio[4919]: info: ControllerMpd::pushState Jul 09 12:40:50 volumio volumio[4919]: info: CoreCommandRouter::servicePushState Jul 09 12:40:50 volumio volumio[4919]: info: CoreStateMachine::pushState Jul 09 12:40:50 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:50 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:50 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:50 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:50 volumio volumio[4919]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 09 12:40:50 volumio volumio[4919]: verbose: CURRENT POSITION 0 Jul 09 12:40:50 volumio volumio[4919]: info: CoreStateMachine::syncState stateService stop Jul 09 12:40:50 volumio volumio[4919]: info: CoreStateMachine::syncState currentStatus pause Jul 09 12:40:50 volumio volumio[4919]: info: CoreStateMachine::pushState Jul 09 12:40:50 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:50 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:50 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:50 volumio volumio[4919]: info: ------------------------------ 100ms Jul 09 12:40:50 volumio volumio[4919]: verbose: ControllerMpd::parseState Jul 09 12:40:50 volumio volumio[4919]: info: Command Router : Notfying DB Updatefalse Jul 09 12:40:50 volumio volumio[4919]: info: CoreCommandRouter::Close All Modals sent Jul 09 12:40:50 volumio volumio[4919]: verbose: ControllerMpd::parseState Jul 09 12:40:50 volumio volumio[4919]: verbose: ControllerMpd::parseState Jul 09 12:40:50 volumio volumio[4919]: info: ControllerMpd::pushState Jul 09 12:40:50 volumio volumio[4919]: info: CoreCommandRouter::servicePushState Jul 09 12:40:50 volumio volumio[4919]: info: CoreStateMachine::pushState Jul 09 12:40:50 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:50 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:50 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:50 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:50 volumio volumio[4919]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 09 12:40:50 volumio volumio[4919]: verbose: CURRENT POSITION 0 Jul 09 12:40:50 volumio volumio[4919]: info: CoreStateMachine::syncState stateService stop Jul 09 12:40:50 volumio volumio[4919]: info: CoreStateMachine::syncState currentStatus pause Jul 09 12:40:50 volumio volumio[4919]: info: CoreStateMachine::pushState Jul 09 12:40:50 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:50 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:50 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:50 volumio volumio[4919]: info: ControllerMpd::pushState Jul 09 12:40:50 volumio volumio[4919]: info: CoreCommandRouter::servicePushState Jul 09 12:40:50 volumio volumio[4919]: info: CoreStateMachine::pushState Jul 09 12:40:50 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:50 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:50 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:50 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:50 volumio volumio[4919]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 09 12:40:50 volumio volumio[4919]: verbose: CURRENT POSITION 0 Jul 09 12:40:50 volumio volumio[4919]: info: CoreStateMachine::syncState stateService stop Jul 09 12:40:50 volumio volumio[4919]: info: CoreStateMachine::syncState currentStatus pause Jul 09 12:40:50 volumio volumio[4919]: info: CoreStateMachine::pushState Jul 09 12:40:50 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:50 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:50 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:50 volumio volumio[4919]: info: ------------------------------ 140ms Jul 09 12:40:50 volumio volumio[4919]: info: ------------------------------ 143ms Jul 09 12:40:52 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Jul 09 12:40:52 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand update Jul 09 12:40:52 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand status Jul 09 12:40:52 volumio volumio[4919]: info: Jul 09 12:40:52 volumio volumio[4919]: ---------------------------- MPD announces state update: update Jul 09 12:40:52 volumio volumio[4919]: info: ControllerMpd::getState Jul 09 12:40:52 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand status Jul 09 12:40:52 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand status Jul 09 12:40:52 volumio volumio[4919]: info: Jul 09 12:40:52 volumio volumio[4919]: ---------------------------- MPD announces state update: update Jul 09 12:40:52 volumio volumio[4919]: info: ControllerMpd::getState Jul 09 12:40:52 volumio volumio[4919]: verbose: ControllerMpd::sendMpdCommand status Jul 09 12:40:52 volumio volumio[4919]: verbose: ControllerMpd::parseState Jul 09 12:40:52 volumio volumio[4919]: info: Command Router : Notfying DB Updatefalse Jul 09 12:40:52 volumio volumio[4919]: info: CoreCommandRouter::Close All Modals sent Jul 09 12:40:52 volumio volumio[4919]: verbose: ControllerMpd::parseState Jul 09 12:40:52 volumio volumio[4919]: info: ControllerMpd::pushState Jul 09 12:40:52 volumio volumio[4919]: info: CoreCommandRouter::servicePushState Jul 09 12:40:52 volumio volumio[4919]: info: CoreStateMachine::pushState Jul 09 12:40:52 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:52 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:52 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:52 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:52 volumio volumio[4919]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 09 12:40:52 volumio volumio[4919]: verbose: CURRENT POSITION 0 Jul 09 12:40:52 volumio volumio[4919]: info: CoreStateMachine::syncState stateService stop Jul 09 12:40:52 volumio volumio[4919]: info: CoreStateMachine::syncState currentStatus pause Jul 09 12:40:52 volumio volumio[4919]: info: CoreStateMachine::pushState Jul 09 12:40:52 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:52 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:52 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:52 volumio volumio[4919]: info: ------------------------------ 65ms Jul 09 12:40:52 volumio volumio[4919]: verbose: ControllerMpd::parseState Jul 09 12:40:52 volumio volumio[4919]: info: Command Router : Notfying DB Updatefalse Jul 09 12:40:52 volumio volumio[4919]: info: CoreCommandRouter::Close All Modals sent Jul 09 12:40:52 volumio volumio[4919]: verbose: ControllerMpd::parseState Jul 09 12:40:52 volumio volumio[4919]: info: ControllerMpd::pushState Jul 09 12:40:52 volumio volumio[4919]: info: CoreCommandRouter::servicePushState Jul 09 12:40:52 volumio volumio[4919]: info: CoreStateMachine::pushState Jul 09 12:40:52 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:52 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:52 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:52 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:52 volumio volumio[4919]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jul 09 12:40:52 volumio volumio[4919]: verbose: CURRENT POSITION 0 Jul 09 12:40:52 volumio volumio[4919]: info: CoreStateMachine::syncState stateService stop Jul 09 12:40:52 volumio volumio[4919]: info: CoreStateMachine::syncState currentStatus pause Jul 09 12:40:52 volumio volumio[4919]: info: CoreStateMachine::pushState Jul 09 12:40:52 volumio volumio[4919]: info: CorePlayQueue::getTrack 0 Jul 09 12:40:52 volumio volumio[4919]: info: CoreCommandRouter::volumioPushState Jul 09 12:40:52 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 09 12:40:52 volumio volumio[4919]: info: ------------------------------ 140ms Jul 09 12:40:53 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 09 12:40:57 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 09 12:41:02 volumio volumio[4919]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 09 12:41:02 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 09 12:41:02 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 12:41:02 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 09 12:41:02 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 12:41:02 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 12:41:02 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 12:41:02 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 12:41:02 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 12:41:02 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 12:41:02 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 09 12:41:02 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 09 12:41:02 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 09 12:41:10 volumio volumio[4919]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object] Jul 09 12:41:10 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions Jul 09 12:41:10 volumio sudo[5650]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 09 12:41:10 volumio sudo[5650]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 12:41:10 volumio sudo[5650]: pam_unix(sudo:session): session closed for user root Jul 09 12:41:10 volumio volumio[4919]: info: MPD Permissions set Jul 09 12:41:10 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 12:41:10 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 12:41:10 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 12:41:10 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 12:41:10 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 12:41:10 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 12:41:10 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 12:41:10 volumio sudo[5653]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 09 12:41:10 volumio sudo[5653]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 09 12:41:10 volumio systemd[1]: Stopping Music Player Daemon... Jul 09 12:41:10 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 09 12:41:10 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 09 12:41:10 volumio volumio[4919]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 09 12:41:10 volumio volumio[4919]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%91%A8%E6%9D%B0%E5%80%AB/%E5%85%AB%E5%BA%A6%E7%A9%BA%E9%96%93/ff338865-dee6-446e-b14e-a010df729264.jpg' Jul 09 12:41:10 volumio systemd[1]: Starting Music Player Daemon... Jul 09 12:41:11 volumio volumio[4919]: error: Upnp client error: Error: This socket has been ended by the other party Jul 09 12:41:11 volumio systemd[1]: Started Music Player Daemon. Jul 09 12:41:11 volumio sudo[5653]: pam_unix(sudo:session): session closed for user root Jul 09 12:41:11 volumio volumio[4919]: error: updateQueue error: null Jul 09 12:41:19 volumio volumio[4919]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 09 12:41:19 volumio volumio[4919]: { Error: connect ETIMEDOUT 157.240.13.8:443 Jul 09 12:41:19 volumio volumio[4919]: at Object._errnoException (util.js:1022:11) Jul 09 12:41:19 volumio volumio[4919]: at _exceptionWithHostPort (util.js:1044:20) Jul 09 12:41:19 volumio volumio[4919]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jul 09 12:41:19 volumio volumio[4919]: code: 'ETIMEDOUT', Jul 09 12:41:19 volumio volumio[4919]: errno: 'ETIMEDOUT', Jul 09 12:41:19 volumio volumio[4919]: syscall: 'connect', Jul 09 12:41:19 volumio volumio[4919]: address: '157.240.13.8', Jul 09 12:41:19 volumio volumio[4919]: port: 443 } Jul 09 12:41:19 volumio volumio[4919]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 09 12:41:20 volumio sudo[5698]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-09 12:40 Jul 09 12:41:20 volumio sudo[5698]: 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="168ba7444df98cd868db72f24faec0b6346489cc" VOLUMIO_FE_VERSION="847a48ecf32d35cc502a0053d585d1a69236e391" VOLUMIO_BE_VERSION="99dfb342fe07851f1e26bd1d8046d0234eda91dd" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 11 15:53:56 CET 2020" VOLUMIO_VERSION="2.857" VOLUMIO_HARDWARE="aml9xxxarmv7" VOLUMIO_HASH="5e595833ee6075a27fef1ba35f928abb"