Dec 05 22:29:01 volumio volumio[519344]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Dec 05 22:29:01 volumio volumio[519344]: info: CURURI: music-library/INTERNAL/CD光盘
Dec 05 22:29:01 volumio volumio[519344]: info: Preload queue cleared
Dec 05 22:29:01 volumio volumio[519344]: info: Preloading song: music-library/INTERNAL/CD光盘/CD1宝丽金精选.wav
Dec 05 22:29:01 volumio volumio[519344]: info: Preloading song: music-library/INTERNAL/CD光盘/CD2邓丽君精选.wav
Dec 05 22:29:01 volumio volumio[519344]: info: Preloading song: music-library/INTERNAL/CD光盘/CD3高胜美.wav
Dec 05 22:29:01 volumio volumio[519344]: info: Preloading song: music-library/INTERNAL/CD光盘/CD4黑鸭子影视.wav
Dec 05 22:29:01 volumio volumio[519344]: info: Preloading song: music-library/INTERNAL/CD光盘/CD5惠威试音碟.wav
Dec 05 22:29:01 volumio volumio[519344]: info: Preloading song: music-library/INTERNAL/CD光盘/CD蔡琴精选德国版.wav
Dec 05 22:29:01 volumio volumio[519344]: info: Exploding uri music-library/INTERNAL/CD光盘/CD1宝丽金精选.wav in service mpd
Dec 05 22:29:01 volumio volumio[519344]: info: ALBUMART /albumart?cacheid=238&web=//large&path=%2Fmnt%2FINTERNAL%2FCD%E5%85%89%E7%9B%98%2FCD1%E5%AE%9D%E4%B8%BD%E9%87%91%E7%B2%BE%E9%80%89.wav&metadata=false
Dec 05 22:29:01 volumio volumio[519344]: info: URI /mnt/INTERNAL/CD光盘/CD1宝丽金精选.wav
Dec 05 22:29:01 volumio volumio[519344]: info: Exploding uri music-library/INTERNAL/CD光盘/CD2邓丽君精选.wav in service mpd
Dec 05 22:29:01 volumio volumio[519344]: info: ALBUMART /albumart?cacheid=238&web=//large&path=%2Fmnt%2FINTERNAL%2FCD%E5%85%89%E7%9B%98%2FCD2%E9%82%93%E4%B8%BD%E5%90%9B%E7%B2%BE%E9%80%89.wav&metadata=false
Dec 05 22:29:01 volumio volumio[519344]: info: URI /mnt/INTERNAL/CD光盘/CD2邓丽君精选.wav
Dec 05 22:29:01 volumio volumio[519344]: info: Exploding uri music-library/INTERNAL/CD光盘/CD3高胜美.wav in service mpd
Dec 05 22:29:01 volumio volumio[519344]: info: ALBUMART /albumart?cacheid=238&web=//large&path=%2Fmnt%2FINTERNAL%2FCD%E5%85%89%E7%9B%98%2FCD3%E9%AB%98%E8%83%9C%E7%BE%8E.wav&metadata=false
Dec 05 22:29:01 volumio volumio[519344]: info: URI /mnt/INTERNAL/CD光盘/CD3高胜美.wav
Dec 05 22:29:01 volumio volumio[519344]: info: Exploding uri music-library/INTERNAL/CD光盘/CD4黑鸭子影视.wav in service mpd
Dec 05 22:29:01 volumio volumio[519344]: info: ALBUMART /albumart?cacheid=238&web=//large&path=%2Fmnt%2FINTERNAL%2FCD%E5%85%89%E7%9B%98%2FCD4%E9%BB%91%E9%B8%AD%E5%AD%90%E5%BD%B1%E8%A7%86.wav&metadata=false
Dec 05 22:29:01 volumio volumio[519344]: info: URI /mnt/INTERNAL/CD光盘/CD4黑鸭子影视.wav
Dec 05 22:29:01 volumio volumio[519344]: info: Exploding uri music-library/INTERNAL/CD光盘/CD5惠威试音碟.wav in service mpd
Dec 05 22:29:01 volumio volumio[519344]: info: ALBUMART /albumart?cacheid=238&web=//large&path=%2Fmnt%2FINTERNAL%2FCD%E5%85%89%E7%9B%98%2FCD5%E6%83%A0%E5%A8%81%E8%AF%95%E9%9F%B3%E7%A2%9F.wav&metadata=false
Dec 05 22:29:01 volumio volumio[519344]: info: URI /mnt/INTERNAL/CD光盘/CD5惠威试音碟.wav
Dec 05 22:29:01 volumio volumio[519344]: info: Exploding uri music-library/INTERNAL/CD光盘/CD蔡琴精选德国版.wav in service mpd
Dec 05 22:29:01 volumio volumio[519344]: info: ALBUMART /albumart?cacheid=238&web=//large&path=%2Fmnt%2FINTERNAL%2FCD%E5%85%89%E7%9B%98%2FCD%E8%94%A1%E7%90%B4%E7%B2%BE%E9%80%89%E5%BE%B7%E5%9B%BD%E7%89%88.wav&metadata=false
Dec 05 22:29:01 volumio volumio[519344]: info: URI /mnt/INTERNAL/CD光盘/CD蔡琴精选德国版.wav
Dec 05 22:29:06 volumio volumio[519344]: info: Preload queue cleared
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::volumioReplaceandPlayItems
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::ClearQueue
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::stop
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::stPlaybackTimer
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::updateTrackBlock
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrackBlock
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::pushState
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 0
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::volumioPushState
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::serviceStop
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 0
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::serviceStop
Dec 05 22:29:06 volumio volumio[519344]: info: ControllerMpd::stop
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::sendMpdCommand stop
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::clearPlayQueue
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::saveQueue
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::volumioPushQueue
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::addQueueItems
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::addQueueItems
Dec 05 22:29:06 volumio volumio[519344]: info: Preload queue cleared
Dec 05 22:29:06 volumio volumio[519344]: info: Adding Item to queue: music-library/INTERNAL/CD光盘/CD1宝丽金精选.wav
Dec 05 22:29:06 volumio volumio[519344]: info: Using cached record of: music-library/INTERNAL/CD光盘/CD1宝丽金精选.wav
Dec 05 22:29:06 volumio volumio[519344]: info: Adding Item to queue: music-library/INTERNAL/CD光盘/CD2邓丽君精选.wav
Dec 05 22:29:06 volumio volumio[519344]: info: Using cached record of: music-library/INTERNAL/CD光盘/CD2邓丽君精选.wav
Dec 05 22:29:06 volumio volumio[519344]: info: Adding Item to queue: music-library/INTERNAL/CD光盘/CD3高胜美.wav
Dec 05 22:29:06 volumio volumio[519344]: info: Using cached record of: music-library/INTERNAL/CD光盘/CD3高胜美.wav
Dec 05 22:29:06 volumio volumio[519344]: info: Adding Item to queue: music-library/INTERNAL/CD光盘/CD4黑鸭子影视.wav
Dec 05 22:29:06 volumio volumio[519344]: info: Using cached record of: music-library/INTERNAL/CD光盘/CD4黑鸭子影视.wav
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::volumioPushQueue
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::saveQueue
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::updateTrackBlock
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrackBlock
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::volumioPlay
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::play index 3
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::addQueueItems
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::addQueueItems
Dec 05 22:29:06 volumio volumio[519344]: info: Preload queue cleared
Dec 05 22:29:06 volumio volumio[519344]: info: Adding Item to queue: music-library/INTERNAL/CD光盘/CD5惠威试音碟.wav
Dec 05 22:29:06 volumio volumio[519344]: info: Using cached record of: music-library/INTERNAL/CD光盘/CD5惠威试音碟.wav
Dec 05 22:29:06 volumio volumio[519344]: info: Adding Item to queue: music-library/INTERNAL/CD光盘/CD蔡琴精选德国版.wav
Dec 05 22:29:06 volumio volumio[519344]: info: Using cached record of: music-library/INTERNAL/CD光盘/CD蔡琴精选德国版.wav
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::stop
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::volumioPushQueue
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::saveQueue
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::play index undefined
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::updateTrackBlock
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrackBlock
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 3
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::startPlaybackTimer
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 3
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/CD光盘/CD4黑鸭子影视.wav
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::sendMpdCommand stop
Dec 05 22:29:06 volumio volumio[519344]: info:
Dec 05 22:29:06 volumio volumio[519344]: ---------------------------- MPD announces state update: player
Dec 05 22:29:06 volumio volumio[519344]: info: sendMpdCommand stop took 6 milliseconds
Dec 05 22:29:06 volumio volumio[519344]: info: ControllerMpd::getState
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::sendMpdCommand status
Dec 05 22:29:06 volumio volumio[519344]: info: sendMpdCommand stop took 2 milliseconds
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::sendMpdCommand clear
Dec 05 22:29:06 volumio volumio[519344]: info:
Dec 05 22:29:06 volumio volumio[519344]: ---------------------------- MPD announces state update: player
Dec 05 22:29:06 volumio volumio[519344]: info: ControllerMpd::getState
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::sendMpdCommand status
Dec 05 22:29:06 volumio volumio[519344]: info:
Dec 05 22:29:06 volumio volumio[519344]: ---------------------------- MPD announces state update: player
Dec 05 22:29:06 volumio volumio[519344]: info: ControllerMpd::getState
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::sendMpdCommand status
Dec 05 22:29:06 volumio volumio[519344]: info:
Dec 05 22:29:06 volumio volumio[519344]: ---------------------------- MPD announces system playlist update
Dec 05 22:29:06 volumio volumio[519344]: info: Ignoring MPD Status Update
Dec 05 22:29:06 volumio volumio[519344]: info: sendMpdCommand status took 1 milliseconds
Dec 05 22:29:06 volumio volumio[519344]: info: sendMpdCommand clear took 1 milliseconds
Dec 05 22:29:06 volumio volumio[519344]: info: sendMpdCommand status took 1 milliseconds
Dec 05 22:29:06 volumio volumio[519344]: info: sendMpdCommand status took 0 milliseconds
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::parseState
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/CD光盘/CD4黑鸭子影视.wav"
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::parseState
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::parseState
Dec 05 22:29:06 volumio volumio[519344]: info: ControllerMpd::pushState
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::servicePushState
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::pushState
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 3
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::volumioPushState
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 3
Dec 05 22:29:06 volumio volumio[519344]: 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}
Dec 05 22:29:06 volumio volumio[519344]: verbose: CURRENT POSITION 3
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::syncState stateService stop
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::syncState currentStatus stop
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::pushState
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 3
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::volumioPushState
Dec 05 22:29:06 volumio volumio[519344]: info: No code
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::pushState
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 3
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::volumioPushState
Dec 05 22:29:06 volumio volumio[519344]: info: ControllerMpd::pushState
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::servicePushState
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::pushState
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 3
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::volumioPushState
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 3
Dec 05 22:29:06 volumio volumio[519344]: 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}
Dec 05 22:29:06 volumio volumio[519344]: verbose: CURRENT POSITION 3
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::syncState stateService stop
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::syncState currentStatus stop
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::pushState
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 3
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::volumioPushState
Dec 05 22:29:06 volumio volumio[519344]: info: No code
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::pushState
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 3
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::volumioPushState
Dec 05 22:29:06 volumio volumio[519344]: info: ------------------------------ 8ms
Dec 05 22:29:06 volumio volumio[519344]: info: ------------------------------ 8ms
Dec 05 22:29:06 volumio volumio[519344]: info:
Dec 05 22:29:06 volumio volumio[519344]: ---------------------------- MPD announces system playlist update
Dec 05 22:29:06 volumio volumio[519344]: info: Ignoring MPD Status Update
Dec 05 22:29:06 volumio volumio[519344]: info:
Dec 05 22:29:06 volumio volumio[519344]: ---------------------------- MPD announces system playlist update
Dec 05 22:29:06 volumio volumio[519344]: info: Ignoring MPD Status Update
Dec 05 22:29:06 volumio volumio[519344]: error: updateQueue error: null
Dec 05 22:29:06 volumio volumio[519344]: info:
Dec 05 22:29:06 volumio volumio[519344]: ---------------------------- MPD announces system playlist update
Dec 05 22:29:06 volumio volumio[519344]: info: Ignoring MPD Status Update
Dec 05 22:29:06 volumio volumio[519344]: info: ------------------------------ 9ms
Dec 05 22:29:06 volumio volumio[519344]: info: sendMpdCommand playlistinfo took 9 milliseconds
Dec 05 22:29:06 volumio volumio[519344]: info: sendMpdCommand add "INTERNAL/CD光盘/CD4黑鸭子影视.wav" took 9 milliseconds
Dec 05 22:29:06 volumio volumio[519344]: info: ------------------------------ 2ms
Dec 05 22:29:06 volumio volumio[519344]: info: ------------------------------ 1ms
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::parseTrackInfo
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::sendMpdCommand play
Dec 05 22:29:06 volumio volumio[519344]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Dec 05 22:29:06 volumio volumio[519344]: info: ------------------------------ 10ms
Dec 05 22:29:06 volumio volumio[519344]: info:
Dec 05 22:29:06 volumio volumio[519344]: ---------------------------- MPD announces system playlist update
Dec 05 22:29:06 volumio volumio[519344]: info: Ignoring MPD Status Update
Dec 05 22:29:06 volumio volumio[519344]: info:
Dec 05 22:29:06 volumio volumio[519344]: ---------------------------- MPD announces system playlist update
Dec 05 22:29:06 volumio volumio[519344]: info: Ignoring MPD Status Update
Dec 05 22:29:06 volumio volumio[519344]: info: ------------------------------ 4ms
Dec 05 22:29:06 volumio volumio[519344]: info: sendMpdCommand play took 3 milliseconds
Dec 05 22:29:06 volumio volumio[519344]: info: ------------------------------ 3ms
Dec 05 22:29:06 volumio volumio[519344]: info: ------------------------------ 2ms
Dec 05 22:29:06 volumio volumio[519344]: info:
Dec 05 22:29:06 volumio volumio[519344]: ---------------------------- MPD announces state update: player
Dec 05 22:29:06 volumio volumio[519344]: info: ControllerMpd::getState
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::sendMpdCommand status
Dec 05 22:29:06 volumio volumio[519344]: info:
Dec 05 22:29:06 volumio volumio[519344]: ---------------------------- MPD announces state update: player
Dec 05 22:29:06 volumio volumio[519344]: info: ControllerMpd::getState
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::sendMpdCommand status
Dec 05 22:29:06 volumio volumio[519344]: info:
Dec 05 22:29:06 volumio volumio[519344]: ---------------------------- MPD announces state update: player
Dec 05 22:29:06 volumio volumio[519344]: info: ControllerMpd::getState
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::sendMpdCommand status
Dec 05 22:29:06 volumio volumio[519344]: info: sendMpdCommand status took 10 milliseconds
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::parseState
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 05 22:29:06 volumio volumio[519344]: info:
Dec 05 22:29:06 volumio volumio[519344]: ---------------------------- MPD announces state update: player
Dec 05 22:29:06 volumio volumio[519344]: info: ControllerMpd::getState
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::sendMpdCommand status
Dec 05 22:29:06 volumio volumio[519344]: info:
Dec 05 22:29:06 volumio volumio[519344]: ---------------------------- MPD announces state update: player
Dec 05 22:29:06 volumio volumio[519344]: info: ControllerMpd::getState
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::sendMpdCommand status
Dec 05 22:29:06 volumio volumio[519344]: info: sendMpdCommand status took 17 milliseconds
Dec 05 22:29:06 volumio volumio[519344]: info: sendMpdCommand status took 16 milliseconds
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::parseState
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::parseState
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 05 22:29:06 volumio volumio[519344]: info:
Dec 05 22:29:06 volumio volumio[519344]: ---------------------------- MPD announces state update: player
Dec 05 22:29:06 volumio volumio[519344]: info: ControllerMpd::getState
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::sendMpdCommand status
Dec 05 22:29:06 volumio volumio[519344]: info: sendMpdCommand playlistinfo took 8 milliseconds
Dec 05 22:29:06 volumio volumio[519344]: info: sendMpdCommand status took 8 milliseconds
Dec 05 22:29:06 volumio volumio[519344]: info: sendMpdCommand status took 4 milliseconds
Dec 05 22:29:06 volumio volumio[519344]: info: sendMpdCommand playlistinfo took 4 milliseconds
Dec 05 22:29:06 volumio volumio[519344]: info: sendMpdCommand playlistinfo took 3 milliseconds
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::parseTrackInfo
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::parseState
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::parseState
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::parseTrackInfo
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::parseTrackInfo
Dec 05 22:29:06 volumio volumio[519344]: info: ControllerMpd::pushState
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::servicePushState
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 3
Dec 05 22:29:06 volumio volumio[519344]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3163,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"CD4黑鸭子影视.wav","artist":null,"album":null,"uri":"INTERNAL/CD光盘/CD4黑鸭子影视.wav","trackType":"wav"}
Dec 05 22:29:06 volumio volumio[519344]: verbose: CURRENT POSITION 3
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::syncState stateService play
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::syncState currentStatus stop
Dec 05 22:29:06 volumio volumio[519344]: info: ControllerMpd::pushState
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::servicePushState
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 3
Dec 05 22:29:06 volumio volumio[519344]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3163,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"CD4黑鸭子影视.wav","artist":null,"album":null,"uri":"INTERNAL/CD光盘/CD4黑鸭子影视.wav","trackType":"wav"}
Dec 05 22:29:06 volumio volumio[519344]: verbose: CURRENT POSITION 3
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::syncState stateService play
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::syncState currentStatus play
Dec 05 22:29:06 volumio volumio[519344]: info: Received an update from plugin. extracting info from payload
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::pushState
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 3
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::volumioPushState
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::pushState
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 3
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::volumioPushState
Dec 05 22:29:06 volumio volumio[519344]: info: ControllerMpd::pushState
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::servicePushState
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 3
Dec 05 22:29:06 volumio volumio[519344]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3163,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"CD4黑鸭子影视.wav","artist":null,"album":null,"uri":"INTERNAL/CD光盘/CD4黑鸭子影视.wav","trackType":"wav"}
Dec 05 22:29:06 volumio volumio[519344]: verbose: CURRENT POSITION 3
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::syncState stateService play
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::syncState currentStatus play
Dec 05 22:29:06 volumio volumio[519344]: info: Received an update from plugin. extracting info from payload
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::pushState
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 3
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::volumioPushState
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::pushState
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 3
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::volumioPushState
Dec 05 22:29:06 volumio volumio[519344]: info: ------------------------------ 25ms
Dec 05 22:29:06 volumio volumio[519344]: info: ------------------------------ 34ms
Dec 05 22:29:06 volumio volumio[519344]: info: ------------------------------ 34ms
Dec 05 22:29:06 volumio volumio[519344]: info: sendMpdCommand status took 14 milliseconds
Dec 05 22:29:06 volumio volumio[519344]: info: sendMpdCommand playlistinfo took 14 milliseconds
Dec 05 22:29:06 volumio volumio[519344]: info: sendMpdCommand playlistinfo took 14 milliseconds
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::parseState
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::parseTrackInfo
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::parseTrackInfo
Dec 05 22:29:06 volumio volumio[519344]: info: ControllerMpd::pushState
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::servicePushState
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 3
Dec 05 22:29:06 volumio volumio[519344]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3163,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"CD4黑鸭子影视.wav","artist":null,"album":null,"uri":"INTERNAL/CD光盘/CD4黑鸭子影视.wav","trackType":"wav"}
Dec 05 22:29:06 volumio volumio[519344]: verbose: CURRENT POSITION 3
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::syncState stateService play
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::syncState currentStatus play
Dec 05 22:29:06 volumio volumio[519344]: info: Received an update from plugin. extracting info from payload
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::pushState
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 3
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::volumioPushState
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::pushState
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 3
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::volumioPushState
Dec 05 22:29:06 volumio volumio[519344]: info: ControllerMpd::pushState
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::servicePushState
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 3
Dec 05 22:29:06 volumio volumio[519344]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3163,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"CD4黑鸭子影视.wav","artist":null,"album":null,"uri":"INTERNAL/CD光盘/CD4黑鸭子影视.wav","trackType":"wav"}
Dec 05 22:29:06 volumio volumio[519344]: verbose: CURRENT POSITION 3
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::syncState stateService play
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::syncState currentStatus play
Dec 05 22:29:06 volumio volumio[519344]: info: Received an update from plugin. extracting info from payload
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::pushState
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 3
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::volumioPushState
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::pushState
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 3
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::volumioPushState
Dec 05 22:29:06 volumio volumio[519344]: info: ------------------------------ 31ms
Dec 05 22:29:06 volumio volumio[519344]: info: ------------------------------ 27ms
Dec 05 22:29:06 volumio volumio[519344]: info: sendMpdCommand playlistinfo took 16 milliseconds
Dec 05 22:29:06 volumio volumio[519344]: verbose: ControllerMpd::parseTrackInfo
Dec 05 22:29:06 volumio volumio[519344]: info: ControllerMpd::pushState
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::servicePushState
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 3
Dec 05 22:29:06 volumio volumio[519344]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":3163,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"CD4黑鸭子影视.wav","artist":null,"album":null,"uri":"INTERNAL/CD光盘/CD4黑鸭子影视.wav","trackType":"wav"}
Dec 05 22:29:06 volumio volumio[519344]: verbose: CURRENT POSITION 3
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::syncState stateService play
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::syncState currentStatus play
Dec 05 22:29:06 volumio volumio[519344]: info: Received an update from plugin. extracting info from payload
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::pushState
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 3
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::volumioPushState
Dec 05 22:29:06 volumio volumio[519344]: info: CoreStateMachine::pushState
Dec 05 22:29:06 volumio volumio[519344]: info: CorePlayQueue::getTrack 3
Dec 05 22:29:06 volumio volumio[519344]: info: CoreCommandRouter::volumioPushState
Dec 05 22:29:06 volumio volumio[519344]: info: ------------------------------ 36ms
Dec 05 22:30:37 volumio volumio[519344]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 05 22:30:37 volumio volumio[519344]: Error: connect ETIMEDOUT 103.252.115.169:443
Dec 05 22:30:37 volumio volumio[519344]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) {
Dec 05 22:30:37 volumio volumio[519344]: errno: -110,
Dec 05 22:30:37 volumio volumio[519344]: code: 'ETIMEDOUT',
Dec 05 22:30:37 volumio volumio[519344]: syscall: 'connect',
Dec 05 22:30:37 volumio volumio[519344]: address: '103.252.115.169',
Dec 05 22:30:37 volumio volumio[519344]: port: 443
Dec 05 22:30:37 volumio volumio[519344]: }
Dec 05 22:30:37 volumio volumio[519344]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 05 22:30:37 volumio sudo[519963]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-05 22:29'
Dec 05 22:30:37 volumio sudo[519963]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Debian GNU/Linux 12 (bookworm)"
NAME="Debian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="3a3cfe435f8bb2bc94a920662e91a4ef35bc8e7c"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="8bcc10c3dbcbcb349e9887dc0527d54876b32688"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue Dec 2 12:15:37 UTC 2025"
VOLUMIO_VERSION="4.072"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="3ca59a0b3ec3a926fd3274a2fb539106"