-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Sun 2024-08-18 12:07:33 CST. --
Aug 18 12:06:06 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Aug 18 12:06:06 volumio-pi5 volumio[1245]: info: CURURI: albums:///%E5%8D%81%E4%BA%8C%E5%A5%B3%E5%A3%B0%E2%85%A2
Aug 18 12:06:06 volumio-pi5 volumio[1245]: info: Preload queue cleared
Aug 18 12:06:06 volumio-pi5 volumio[1245]: info: Preloading song: music-library/NAS/192.168.1.218/104张音乐原盘+820个ape无损音乐大礼包(将近90G文件)/无损3/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/CDImage.wav
Aug 18 12:06:07 volumio-pi5 volumio[1245]: info: Exploding uri music-library/NAS/192.168.1.218/104张音乐原盘+820个ape无损音乐大礼包(将近90G文件)/无损3/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/CDImage.wav in service mpd
Aug 18 12:06:07 volumio-pi5 volumio[1245]: info: ALBUMART /albumart?cacheid=633&web=/%E5%8D%81%E4%BA%8C%E5%A5%B3%E5%A3%B0%E2%85%A2/extralarge&path=%2Fmnt%2FNAS%2F192.168.1.218%2F104%E5%BC%A0%E9%9F%B3%E4%B9%90%E5%8E%9F%E7%9B%98%2B820%E4%B8%AAape%E6%97%A0%E6%8D%9F%E9%9F%B3%E4%B9%90%E5%A4%A7%E7%A4%BC%E5%8C%85%EF%BC%88%E5%B0%86%E8%BF%9190G%E6%96%87%E4%BB%B6%EF%BC%89%2F%E6%97%A0%E6%8D%9F3%2F%E5%A6%99%E9%9F%B3%E5%94%B1%E7%89%87%20-%20%E5%8D%81%E4%BA%8C%E5%A5%B3%E5%A3%B0%E2%85%A2%20%5BWAV%2BCUE%5D%2F%E5%A6%99%E9%9F%B3%E5%94%B1%E7%89%87%20-%20%E5%8D%81%E4%BA%8C%E5%A5%B3%E5%A3%B0%E2%85%A2%20%5BWAV%2BCUE%5D%2FCDImage.wav&metadata=false
Aug 18 12:06:07 volumio-pi5 volumio[1245]: info: URI /mnt/NAS/192.168.1.218/104张音乐原盘+820个ape无损音乐大礼包(将近90G文件)/无损3/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/CDImage.wav
Aug 18 12:06:16 volumio-pi5 volumio[1245]: info: Listing playlists
Aug 18 12:06:20 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioAddQueueItems
Aug 18 12:06:20 volumio-pi5 volumio[1245]: info: CoreStateMachine::addQueueItems
Aug 18 12:06:20 volumio-pi5 volumio[1245]: info: CorePlayQueue::addQueueItems
Aug 18 12:06:20 volumio-pi5 volumio[1245]: info: Preload queue cleared
Aug 18 12:06:20 volumio-pi5 volumio[1245]: info: Adding Item to queue: albums:///%E5%8D%81%E4%BA%8C%E5%A5%B3%E5%A3%B0%E2%85%A2
Aug 18 12:06:20 volumio-pi5 volumio[1245]: info: Exploding uri albums:///%E5%8D%81%E4%BA%8C%E5%A5%B3%E5%A3%B0%E2%85%A2 in service mpd
Aug 18 12:06:20 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushQueue
Aug 18 12:06:20 volumio-pi5 volumio[1245]: info: CorePlayQueue::saveQueue
Aug 18 12:06:20 volumio-pi5 volumio[1245]: info: CoreStateMachine::updateTrackBlock
Aug 18 12:06:20 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrackBlock
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: Preload queue cleared
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioReplaceandPlayItems
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CoreStateMachine::ClearQueue
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CoreStateMachine::stop
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CoreStateMachine::stPlaybackTimer
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CoreStateMachine::updateTrackBlock
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrackBlock
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CoreStateMachine::serviceStop
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CoreCommandRouter::serviceStop
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: ControllerMpd::stop
Aug 18 12:06:23 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand stop
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CorePlayQueue::clearPlayQueue
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CorePlayQueue::saveQueue
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushQueue
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CoreStateMachine::addQueueItems
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CorePlayQueue::addQueueItems
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: Preload queue cleared
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: Adding Item to queue: music-library/NAS/192.168.1.218/104张音乐原盘+820个ape无损音乐大礼包(将近90G文件)/无损3/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/CDImage.wav
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: Using cached record of: music-library/NAS/192.168.1.218/104张音乐原盘+820个ape无损音乐大礼包(将近90G文件)/无损3/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/CDImage.wav
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushQueue
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CorePlayQueue::saveQueue
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CoreStateMachine::updateTrackBlock
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrackBlock
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPlay
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CoreStateMachine::play index 0
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CoreStateMachine::stop
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CoreStateMachine::play index undefined
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CoreStateMachine::setConsumeUpdateService undefined
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CoreStateMachine::startPlaybackTimer
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:23 volumio-pi5 volumio[1245]: verbose: ControllerMpd::clearAddPlayTracks NAS/192.168.1.218/104张音乐原盘+820个ape无损音乐大礼包(将近90G文件)/无损3/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/CDImage.wav
Aug 18 12:06:23 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand stop
Aug 18 12:06:23 volumio-pi5 volumio[1245]: info: touch_display: Setting screensaver timeout to 60 seconds.
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: sendMpdCommand stop took 411 milliseconds
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:24 volumio-pi5 volumio[1245]: ---------------------------- MPD announces state update: player
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ControllerMpd::getState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand status
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: sendMpdCommand stop took 402 milliseconds
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand clear
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:24 volumio-pi5 volumio[1245]: ---------------------------- MPD announces state update: player
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ControllerMpd::getState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand status
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:24 volumio-pi5 volumio[1245]: ---------------------------- MPD announces state update: player
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ControllerMpd::getState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand status
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:24 volumio-pi5 volumio[1245]: ---------------------------- MPD announces state update: player
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ControllerMpd::getState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand status
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:24 volumio-pi5 volumio[1245]: ---------------------------- MPD announces system playlist update
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: Ignoring MPD Status Update
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: sendMpdCommand status took 2 milliseconds
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: sendMpdCommand clear took 2 milliseconds
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: sendMpdCommand status took 3 milliseconds
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: sendMpdCommand status took 2 milliseconds
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: sendMpdCommand status took 1 milliseconds
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand add "NAS/192.168.1.218/104张音乐原盘+820个ape无损音乐大礼包(将近90G文件)/无损3/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/CDImage.wav"
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ControllerMpd::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::servicePushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: CURRENT POSITION 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState stateService stop
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState currentStatus stop
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: No code
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ControllerMpd::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::servicePushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: CURRENT POSITION 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState stateService stop
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState currentStatus stop
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: No code
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ControllerMpd::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::servicePushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: CURRENT POSITION 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState stateService stop
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState currentStatus stop
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: No code
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ------------------------------ 25ms
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ------------------------------ 25ms
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ------------------------------ 24ms
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:24 volumio-pi5 volumio[1245]: ---------------------------- MPD announces system playlist update
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: Ignoring MPD Status Update
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:24 volumio-pi5 volumio[1245]: ---------------------------- MPD announces system playlist update
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: Ignoring MPD Status Update
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:24 volumio-pi5 volumio[1245]: ---------------------------- MPD announces system playlist update
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: Ignoring MPD Status Update
Aug 18 12:06:24 volumio-pi5 volumio[1245]: error: updateQueue error: null
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:24 volumio-pi5 volumio[1245]: ---------------------------- MPD announces system playlist update
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: Ignoring MPD Status Update
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ------------------------------ 25ms
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: sendMpdCommand playlistinfo took 24 milliseconds
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: sendMpdCommand add "NAS/192.168.1.218/104张音乐原盘+820个ape无损音乐大礼包(将近90G文件)/无损3/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/CDImage.wav" took 24 milliseconds
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ------------------------------ 1ms
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ------------------------------ 1ms
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ------------------------------ 1ms
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseTrackInfo
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand play
Aug 18 12:06:24 volumio-pi5 volumio[1245]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ------------------------------ 29ms
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:24 volumio-pi5 volumio[1245]: ---------------------------- MPD announces system playlist update
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: Ignoring MPD Status Update
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:24 volumio-pi5 volumio[1245]: ---------------------------- MPD announces system playlist update
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: Ignoring MPD Status Update
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:24 volumio-pi5 volumio[1245]: ---------------------------- MPD announces system playlist update
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: Ignoring MPD Status Update
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ------------------------------ 4ms
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: sendMpdCommand play took 4 milliseconds
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ------------------------------ 4ms
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ------------------------------ 3ms
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:24 volumio-pi5 volumio[1245]: ---------------------------- MPD announces state update: player
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ControllerMpd::getState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand status
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:24 volumio-pi5 volumio[1245]: ---------------------------- MPD announces state update: player
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ControllerMpd::getState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand status
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:24 volumio-pi5 volumio[1245]: ---------------------------- MPD announces state update: player
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ControllerMpd::getState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand status
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:24 volumio-pi5 volumio[1245]: ---------------------------- MPD announces state update: player
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ControllerMpd::getState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand status
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: sendMpdCommand status took 67 milliseconds
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:24 volumio-pi5 volumio[1245]: ---------------------------- MPD announces state update: player
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ControllerMpd::getState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand status
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: sendMpdCommand status took 67 milliseconds
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: sendMpdCommand status took 67 milliseconds
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: sendMpdCommand status took 66 milliseconds
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: sendMpdCommand playlistinfo took 1 milliseconds
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseTrackInfo
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ControllerMpd::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::servicePushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3722,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.wav","artist":null,"album":"十二女声Ⅲ","uri":"NAS/192.168.1.218/104张音乐原盘+820个ape无损音乐大礼包(将近90G文件)/无损3/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/CDImage.wav","trackType":"wav"}
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: CURRENT POSITION 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState stateService play
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState currentStatus stop
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ------------------------------ 74ms
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:24 volumio-pi5 volumio[1245]: ---------------------------- MPD announces state update: player
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ControllerMpd::getState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand status
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:24 volumio-pi5 volumio[1245]: ---------------------------- MPD announces state update: player
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ControllerMpd::getState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand status
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:24 volumio-pi5 volumio[1245]: ---------------------------- MPD announces state update: player
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ControllerMpd::getState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand status
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: sendMpdCommand status took 5 milliseconds
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: sendMpdCommand playlistinfo took 4 milliseconds
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: sendMpdCommand playlistinfo took 4 milliseconds
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: sendMpdCommand playlistinfo took 4 milliseconds
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: sendMpdCommand status took 2 milliseconds
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: sendMpdCommand status took 1 milliseconds
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: sendMpdCommand status took 1 milliseconds
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseTrackInfo
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseTrackInfo
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseTrackInfo
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ControllerMpd::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::servicePushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":137,"duration":3722,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.wav","artist":null,"album":"十二女声Ⅲ","uri":"NAS/192.168.1.218/104张音乐原盘+820个ape无损音乐大礼包(将近90G文件)/无损3/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/CDImage.wav","trackType":"wav"}
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: CURRENT POSITION 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState stateService play
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState currentStatus play
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: Received an update from plugin. extracting info from payload
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ControllerMpd::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::servicePushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":205,"duration":3722,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.wav","artist":null,"album":"十二女声Ⅲ","uri":"NAS/192.168.1.218/104张音乐原盘+820个ape无损音乐大礼包(将近90G文件)/无损3/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/CDImage.wav","trackType":"wav"}
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: CURRENT POSITION 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState stateService play
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState currentStatus play
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: Received an update from plugin. extracting info from payload
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ControllerMpd::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::servicePushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":251,"duration":3722,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.wav","artist":null,"album":"十二女声Ⅲ","uri":"NAS/192.168.1.218/104张音乐原盘+820个ape无损音乐大礼包(将近90G文件)/无损3/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/CDImage.wav","trackType":"wav"}
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: CURRENT POSITION 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState stateService play
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState currentStatus play
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: Received an update from plugin. extracting info from payload
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ------------------------------ 93ms
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ------------------------------ 92ms
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ------------------------------ 92ms
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: sendMpdCommand playlistinfo took 21 milliseconds
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: sendMpdCommand playlistinfo took 20 milliseconds
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: sendMpdCommand playlistinfo took 20 milliseconds
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: sendMpdCommand playlistinfo took 20 milliseconds
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseTrackInfo
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseTrackInfo
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseTrackInfo
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseTrackInfo
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ControllerMpd::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::servicePushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":3722,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.wav","artist":null,"album":"十二女声Ⅲ","uri":"NAS/192.168.1.218/104张音乐原盘+820个ape无损音乐大礼包(将近90G文件)/无损3/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/CDImage.wav","trackType":"wav"}
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: CURRENT POSITION 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState stateService play
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState currentStatus play
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: Received an update from plugin. extracting info from payload
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ControllerMpd::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::servicePushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":3722,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.wav","artist":null,"album":"十二女声Ⅲ","uri":"NAS/192.168.1.218/104张音乐原盘+820个ape无损音乐大礼包(将近90G文件)/无损3/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/CDImage.wav","trackType":"wav"}
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: CURRENT POSITION 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState stateService play
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState currentStatus play
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: Received an update from plugin. extracting info from payload
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ControllerMpd::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::servicePushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":3722,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.wav","artist":null,"album":"十二女声Ⅲ","uri":"NAS/192.168.1.218/104张音乐原盘+820个ape无损音乐大礼包(将近90G文件)/无损3/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/CDImage.wav","trackType":"wav"}
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: CURRENT POSITION 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState stateService play
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState currentStatus play
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: Received an update from plugin. extracting info from payload
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ControllerMpd::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::servicePushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":3722,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.wav","artist":null,"album":"十二女声Ⅲ","uri":"NAS/192.168.1.218/104张音乐原盘+820个ape无损音乐大礼包(将近90G文件)/无损3/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/CDImage.wav","trackType":"wav"}
Aug 18 12:06:24 volumio-pi5 volumio[1245]: verbose: CURRENT POSITION 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState stateService play
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState currentStatus play
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: Received an update from plugin. extracting info from payload
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ------------------------------ 37ms
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ------------------------------ 34ms
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ------------------------------ 34ms
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: ------------------------------ 34ms
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: touch_display: Setting screensaver timeout to 0 seconds.
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: Discovery: Getting this device information
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioGetState
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 18 12:06:25 volumio-pi5 volumio[1245]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 10
Aug 18 12:06:25 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioGetState
Aug 18 12:06:25 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:29 volumio-pi5 volumio[1245]: info: VolumeController::SetAlsaVolume100
Aug 18 12:06:29 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:29 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:29 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 18 12:06:29 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:31 volumio-pi5 volumio[1245]: info: MPD Database updated - AlbumList cache refreshed
Aug 18 12:06:31 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:31 volumio-pi5 volumio[1245]: ---------------------------- MPD announces state update: database
Aug 18 12:06:31 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand status
Aug 18 12:06:31 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:31 volumio-pi5 volumio[1245]: ---------------------------- MPD announces state update: update
Aug 18 12:06:31 volumio-pi5 volumio[1245]: info: ControllerMpd::getState
Aug 18 12:06:31 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand status
Aug 18 12:06:31 volumio-pi5 volumio[1245]: info: ControllerMpd::getState
Aug 18 12:06:31 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand status
Aug 18 12:06:31 volumio-pi5 volumio[1245]: info: MPD Database updated - AlbumList cache refreshed
Aug 18 12:06:31 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:31 volumio-pi5 volumio[1245]: ---------------------------- MPD announces state update: database
Aug 18 12:06:31 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand status
Aug 18 12:06:31 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:31 volumio-pi5 volumio[1245]: ---------------------------- MPD announces state update: update
Aug 18 12:06:31 volumio-pi5 volumio[1245]: info: ControllerMpd::getState
Aug 18 12:06:31 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand status
Aug 18 12:06:31 volumio-pi5 volumio[1245]: info: ControllerMpd::getState
Aug 18 12:06:31 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand status
Aug 18 12:06:31 volumio-pi5 volumio[1245]: info: MPD Database updated - AlbumList cache refreshed
Aug 18 12:06:31 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:31 volumio-pi5 volumio[1245]: ---------------------------- MPD announces state update: database
Aug 18 12:06:31 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand status
Aug 18 12:06:31 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:31 volumio-pi5 volumio[1245]: ---------------------------- MPD announces state update: update
Aug 18 12:06:31 volumio-pi5 volumio[1245]: info: ControllerMpd::getState
Aug 18 12:06:31 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand status
Aug 18 12:06:31 volumio-pi5 volumio[1245]: info: ControllerMpd::getState
Aug 18 12:06:31 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand status
Aug 18 12:06:31 volumio-pi5 volumio[1245]: info: MPD Database updated - AlbumList cache refreshed
Aug 18 12:06:31 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:31 volumio-pi5 volumio[1245]: ---------------------------- MPD announces state update: database
Aug 18 12:06:31 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand status
Aug 18 12:06:31 volumio-pi5 volumio[1245]: info:
Aug 18 12:06:31 volumio-pi5 volumio[1245]: ---------------------------- MPD announces state update: update
Aug 18 12:06:31 volumio-pi5 volumio[1245]: info: ControllerMpd::getState
Aug 18 12:06:31 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand status
Aug 18 12:06:31 volumio-pi5 volumio[1245]: info: ControllerMpd::getState
Aug 18 12:06:31 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand status
Aug 18 12:06:32 volumio-pi5 volumio[1245]: info: sendMpdCommand status took 1175 milliseconds
Aug 18 12:06:32 volumio-pi5 volumio[1245]: info: sendMpdCommand status took 1175 milliseconds
Aug 18 12:06:32 volumio-pi5 volumio[1245]: info: sendMpdCommand status took 1175 milliseconds
Aug 18 12:06:32 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseState
Aug 18 12:06:32 volumio-pi5 volumio[1245]: info: Command Router : Notfying DB Updatetrue
Aug 18 12:06:32 volumio-pi5 volumio[1245]: info: CoreCommandRouter::Close All Modals sent
Aug 18 12:06:32 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseState
Aug 18 12:06:32 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 18 12:06:32 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseState
Aug 18 12:06:32 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 18 12:06:33 volumio-pi5 volumio[1245]: info: sendMpdCommand status took 2075 milliseconds
Aug 18 12:06:33 volumio-pi5 volumio[1245]: info: sendMpdCommand status took 2075 milliseconds
Aug 18 12:06:33 volumio-pi5 volumio[1245]: info: sendMpdCommand status took 2075 milliseconds
Aug 18 12:06:33 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseState
Aug 18 12:06:33 volumio-pi5 volumio[1245]: info: Command Router : Notfying DB Updatetrue
Aug 18 12:06:33 volumio-pi5 volumio[1245]: info: CoreCommandRouter::Close All Modals sent
Aug 18 12:06:33 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseState
Aug 18 12:06:33 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 18 12:06:33 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseState
Aug 18 12:06:33 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 18 12:06:33 volumio-pi5 volumio[1245]: info: sendMpdCommand status took 2850 milliseconds
Aug 18 12:06:33 volumio-pi5 volumio[1245]: info: sendMpdCommand status took 2850 milliseconds
Aug 18 12:06:33 volumio-pi5 volumio[1245]: info: sendMpdCommand status took 2851 milliseconds
Aug 18 12:06:33 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseState
Aug 18 12:06:33 volumio-pi5 volumio[1245]: info: Command Router : Notfying DB Updatetrue
Aug 18 12:06:33 volumio-pi5 volumio[1245]: info: CoreCommandRouter::Close All Modals sent
Aug 18 12:06:33 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseState
Aug 18 12:06:33 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 18 12:06:33 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseState
Aug 18 12:06:33 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: sendMpdCommand status took 3624 milliseconds
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: sendMpdCommand status took 3623 milliseconds
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: sendMpdCommand status took 3622 milliseconds
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: Command Router : Notfying DB Updatetrue
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::Close All Modals sent
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: sendMpdCommand playlistinfo took 2326 milliseconds
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: sendMpdCommand playlistinfo took 2325 milliseconds
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseTrackInfo
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseTrackInfo
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: ControllerMpd::pushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::servicePushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7298,"duration":3722,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.wav","artist":null,"album":"十二女声Ⅲ","uri":"NAS/192.168.1.218/104张音乐原盘+820个ape无损音乐大礼包(将近90G文件)/无损3/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/CDImage.wav","trackType":"wav"}
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: CURRENT POSITION 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState stateService play
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState currentStatus play
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: Received an update from plugin. extracting info from payload
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: ControllerMpd::pushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::servicePushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7298,"duration":3722,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.wav","artist":null,"album":"十二女声Ⅲ","uri":"NAS/192.168.1.218/104张音乐原盘+820个ape无损音乐大礼包(将近90G文件)/无损3/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/CDImage.wav","trackType":"wav"}
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: CURRENT POSITION 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState stateService play
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState currentStatus play
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: Received an update from plugin. extracting info from payload
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: ------------------------------ 3684ms
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: ------------------------------ 3684ms
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: sendMpdCommand playlistinfo took 1576 milliseconds
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: sendMpdCommand playlistinfo took 1576 milliseconds
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseTrackInfo
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseTrackInfo
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: ControllerMpd::pushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::servicePushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7390,"duration":3722,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.wav","artist":null,"album":"十二女声Ⅲ","uri":"NAS/192.168.1.218/104张音乐原盘+820个ape无损音乐大礼包(将近90G文件)/无损3/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/CDImage.wav","trackType":"wav"}
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: CURRENT POSITION 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState stateService play
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState currentStatus play
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: Received an update from plugin. extracting info from payload
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: ControllerMpd::pushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::servicePushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7390,"duration":3722,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.wav","artist":null,"album":"十二女声Ⅲ","uri":"NAS/192.168.1.218/104张音乐原盘+820个ape无损音乐大礼包(将近90G文件)/无损3/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/CDImage.wav","trackType":"wav"}
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: CURRENT POSITION 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState stateService play
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState currentStatus play
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: Received an update from plugin. extracting info from payload
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: ------------------------------ 3690ms
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: ------------------------------ 3690ms
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: sendMpdCommand playlistinfo took 824 milliseconds
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: sendMpdCommand playlistinfo took 825 milliseconds
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseTrackInfo
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseTrackInfo
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: ControllerMpd::pushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::servicePushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7481,"duration":3722,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.wav","artist":null,"album":"十二女声Ⅲ","uri":"NAS/192.168.1.218/104张音乐原盘+820个ape无损音乐大礼包(将近90G文件)/无损3/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/CDImage.wav","trackType":"wav"}
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: CURRENT POSITION 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState stateService play
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState currentStatus play
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: Received an update from plugin. extracting info from payload
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: ControllerMpd::pushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::servicePushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7481,"duration":3722,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.wav","artist":null,"album":"十二女声Ⅲ","uri":"NAS/192.168.1.218/104张音乐原盘+820个ape无损音乐大礼包(将近90G文件)/无损3/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/CDImage.wav","trackType":"wav"}
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: CURRENT POSITION 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState stateService play
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState currentStatus play
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: Received an update from plugin. extracting info from payload
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: ------------------------------ 3701ms
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: ------------------------------ 3701ms
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: sendMpdCommand playlistinfo took 38 milliseconds
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: sendMpdCommand playlistinfo took 38 milliseconds
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseTrackInfo
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: ControllerMpd::parseTrackInfo
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: ControllerMpd::pushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::servicePushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7573,"duration":3722,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.wav","artist":null,"album":"十二女声Ⅲ","uri":"NAS/192.168.1.218/104张音乐原盘+820个ape无损音乐大礼包(将近90G文件)/无损3/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/CDImage.wav","trackType":"wav"}
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: CURRENT POSITION 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState stateService play
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState currentStatus play
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: Received an update from plugin. extracting info from payload
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: ControllerMpd::pushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::servicePushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7573,"duration":3722,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.wav","artist":null,"album":"十二女声Ⅲ","uri":"NAS/192.168.1.218/104张音乐原盘+820个ape无损音乐大礼包(将近90G文件)/无损3/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/妙音唱片 - 十二女声Ⅲ [WAV+CUE]/CDImage.wav","trackType":"wav"}
Aug 18 12:06:34 volumio-pi5 volumio[1245]: verbose: CURRENT POSITION 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState stateService play
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::syncState currentStatus play
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: Received an update from plugin. extracting info from payload
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: ------------------------------ 3708ms
Aug 18 12:06:34 volumio-pi5 volumio[1245]: info: ------------------------------ 3708ms
Aug 18 12:06:35 volumio-pi5 volumiologrotate[805]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory
Aug 18 12:06:35 volumio-pi5 volumiologrotate[805]: ls: cannot access 'PI5': No such file or directory
Aug 18 12:06:36 volumio-pi5 volumio[1245]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 11
Aug 18 12:06:36 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioGetState
Aug 18 12:06:36 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:38 volumio-pi5 volumio[1245]: info: VolumeController::SetAlsaVolume95
Aug 18 12:06:38 volumio-pi5 volumio[1245]: info: CoreStateMachine::pushState
Aug 18 12:06:38 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:38 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Aug 18 12:06:38 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioPushState
Aug 18 12:06:54 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 18 12:06:54 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 18 12:06:54 volumio-pi5 volumio[1245]: info: Discovery: Getting this device information
Aug 18 12:06:54 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioGetState
Aug 18 12:06:54 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:06:54 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 18 12:07:19 volumio-pi5 sudo[20002]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 18 12:07:19 volumio-pi5 sudo[20002]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 18 12:07:19 volumio-pi5 sudo[20002]: pam_unix(sudo:session): session closed for user root
Aug 18 12:07:19 volumio-pi5 sudo[20005]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 18 12:07:19 volumio-pi5 sudo[20005]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 18 12:07:19 volumio-pi5 sudo[20005]: pam_unix(sudo:session): session closed for user root
Aug 18 12:07:19 volumio-pi5 volumio[1245]: verbose: New Socket.io Connection to 192.168.1.148 from 192.168.1.179 UA: Mozilla/5.0 (Linux; Android 14; 23127PN0CC Build/UKQ1.230804.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/120.0.6099.230 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Aug 18 12:07:19 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Aug 18 12:07:19 volumio-pi5 sudo[20008]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 18 12:07:19 volumio-pi5 sudo[20008]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 18 12:07:19 volumio-pi5 sudo[20008]: pam_unix(sudo:session): session closed for user root
Aug 18 12:07:19 volumio-pi5 sudo[20011]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 18 12:07:19 volumio-pi5 sudo[20011]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 18 12:07:19 volumio-pi5 sudo[20011]: pam_unix(sudo:session): session closed for user root
Aug 18 12:07:20 volumio-pi5 volumio[1245]: verbose: New Socket.io Connection to 192.168.1.148 from 192.168.1.179 UA: Mozilla/5.0 (Linux; Android 14; 23127PN0CC Build/UKQ1.230804.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/120.0.6099.230 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10
Aug 18 12:07:20 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Aug 18 12:07:20 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Aug 18 12:07:20 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioGetVisibleSources
Aug 18 12:07:20 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 18 12:07:20 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioGetState
Aug 18 12:07:20 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:07:20 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Aug 18 12:07:20 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioGetQueue
Aug 18 12:07:20 volumio-pi5 volumio[1245]: info: CoreStateMachine::getQueue
Aug 18 12:07:20 volumio-pi5 volumio[1245]: info: CorePlayQueue::getQueue
Aug 18 12:07:20 volumio-pi5 volumio[1245]: info: Listing playlists
Aug 18 12:07:20 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Aug 18 12:07:20 volumio-pi5 volumio[1245]: info: Received Get System Info
Aug 18 12:07:20 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 18 12:07:20 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 18 12:07:20 volumio-pi5 volumio[1245]: info: Discovery: Getting this device information
Aug 18 12:07:20 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioGetState
Aug 18 12:07:20 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:07:20 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 18 12:07:20 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioGetState
Aug 18 12:07:20 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:07:20 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Aug 18 12:07:20 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 18 12:07:20 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Aug 18 12:07:21 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Aug 18 12:07:21 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 18 12:07:21 volumio-pi5 volumio[1245]: info: Received Get System Info
Aug 18 12:07:21 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 18 12:07:21 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 18 12:07:21 volumio-pi5 volumio[1245]: info: Discovery: Getting this device information
Aug 18 12:07:21 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioGetState
Aug 18 12:07:21 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:07:21 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 18 12:07:23 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 18 12:07:23 volumio-pi5 volumio[1245]: info: Received Get System Info
Aug 18 12:07:23 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 18 12:07:23 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 18 12:07:23 volumio-pi5 volumio[1245]: info: Discovery: Getting this device information
Aug 18 12:07:23 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioGetState
Aug 18 12:07:23 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:07:23 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 18 12:07:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 18 12:07:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 18 12:07:24 volumio-pi5 volumio[1245]: info: Discovery: Getting this device information
Aug 18 12:07:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::volumioGetState
Aug 18 12:07:24 volumio-pi5 volumio[1245]: info: CorePlayQueue::getTrack 0
Aug 18 12:07:24 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 18 12:07:26 volumio-pi5 volumio[1245]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/*/5c19c092-d3ac-474a-b6ce-9793cb365c55.jpg'
Aug 18 12:07:27 volumio-pi5 volumio[1245]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%B0%B4%E6%9C%A8%E5%B9%B4%E5%8D%8E/70.80/ec9b5340-1ba5-4d45-a489-83a0086a93cd.jpg'
Aug 18 12:07:27 volumio-pi5 volumio[1245]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%8D%89%E8%9C%A2/Grasshopper%20The%20Best/9747d858-dbb0-46f0-9e4f-a1ceb935c956.jpg'
Aug 18 12:07:27 volumio-pi5 volumio[1245]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%9F%A9%E7%BA%A2/%E6%84%9F%E5%8A%A8/11dd6144-e3cc-46c6-b655-d0bbfeb9b04c.jpg'
Aug 18 12:07:27 volumio-pi5 volumio[1245]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9D%A8%E4%B8%9E%E7%90%B3/%E6%9B%96%E6%98%A7/72d11439-8158-47ee-9f0c-23acae56bb21.jpg'
Aug 18 12:07:27 volumio-pi5 volumio[1245]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%94%A1%E7%90%B4/%E6%B0%91%E6%AD%8C%E8%94%A1%E7%90%B4/f6bc2485-b324-4ebe-9b52-bf3629bf8f0e.jpg'
Aug 18 12:07:30 volumio-pi5 volumio[1245]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Aug 18 12:07:33 volumio-pi5 volumio[1245]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 18 12:07:33 volumio-pi5 volumio[1245]: Error: connect ETIMEDOUT 199.16.158.190:443
Aug 18 12:07:33 volumio-pi5 volumio[1245]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) {
Aug 18 12:07:33 volumio-pi5 volumio[1245]: errno: -110,
Aug 18 12:07:33 volumio-pi5 volumio[1245]: code: 'ETIMEDOUT',
Aug 18 12:07:33 volumio-pi5 volumio[1245]: syscall: 'connect',
Aug 18 12:07:33 volumio-pi5 volumio[1245]: address: '199.16.158.190',
Aug 18 12:07:33 volumio-pi5 volumio[1245]: port: 443
Aug 18 12:07:33 volumio-pi5 volumio[1245]: }
Aug 18 12:07:33 volumio-pi5 volumio[1245]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 18 12:07:33 volumio-pi5 sudo[20054]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-18 12:06
Aug 18 12:07:33 volumio-pi5 sudo[20054]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="4b122b2365bb8c09786cd63b50d1ea6db780eb4e"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST"
VOLUMIO_VERSION="3.703"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"