-- Logs begin at Sat 2025-05-24 12:12:50 UTC, end at Sat 2025-05-24 16:36:56 UTC. --
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::volumioNext
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::next
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::stop
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::stPlaybackTimer
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::updateTrackBlock
May 24 16:35:01 volumio volumio[874]: info: CorePlayQueue::getTrackBlock
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:01 volumio volumio[874]: info: CorePlayQueue::getTrack 2954
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::serviceStop
May 24 16:35:01 volumio volumio[874]: info: CorePlayQueue::getTrack 2954
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::serviceStop
May 24 16:35:01 volumio volumio[874]: info: ControllerMpd::stop
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand stop
May 24 16:35:01 volumio volumio[874]: info:
May 24 16:35:01 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:01 volumio volumio[874]: info: sendMpdCommand stop took 21 milliseconds
May 24 16:35:01 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::play index undefined
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined
May 24 16:35:01 volumio volumio[874]: info: CorePlayQueue::getTrack 2127
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::startPlaybackTimer
May 24 16:35:01 volumio volumio[874]: info: CorePlayQueue::getTrack 2127
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::clearAddPlayTracks NAS/音乐/MQA/MQA - HK&CH&TW/Danny Chan/[M] The Most Greatest Hits [23616341] [2013]/03 - Danny Chan - Cheers.flac
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand stop
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::updateTrackBlock
May 24 16:35:01 volumio volumio[874]: info: CorePlayQueue::getTrackBlock
May 24 16:35:01 volumio volumio[874]: info:
May 24 16:35:01 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:01 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:01 volumio volumio[874]: info:
May 24 16:35:01 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:01 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:01 volumio volumio[874]: info: sendMpdCommand status took 5 milliseconds
May 24 16:35:01 volumio volumio[874]: info: sendMpdCommand stop took 4 milliseconds
May 24 16:35:01 volumio volumio[874]: info: sendMpdCommand status took 1 milliseconds
May 24 16:35:01 volumio volumio[874]: info: sendMpdCommand status took 0 milliseconds
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand clear
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:01 volumio volumio[874]: info:
May 24 16:35:01 volumio volumio[874]: ---------------------------- MPD announces system playlist update
May 24 16:35:01 volumio volumio[874]: info: Ignoring MPD Status Update
May 24 16:35:01 volumio volumio[874]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 24 16:35:01 volumio volumio[874]: info: sendMpdCommand clear took 1 milliseconds
May 24 16:35:01 volumio volumio[874]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 24 16:35:01 volumio volumio[874]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand add "NAS/音乐/MQA/MQA - HK&CH&TW/Danny Chan/[M] The Most Greatest Hits [23616341] [2013]/03 - Danny Chan - Cheers.flac"
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:01 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:01 volumio volumio[874]: info: CorePlayQueue::getTrack 2127
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:01 volumio volumio[874]: info: CorePlayQueue::getTrack 2127
May 24 16:35:01 volumio volumio[874]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Er Ren Shi Jie","artist":"George Lam","album":"Love Story","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/George Lam/[M] Love Story [79036835] [2005]/03 - George Lam - Er Ren Shi Jie.flac","trackType":"flac"}
May 24 16:35:01 volumio volumio[874]: verbose: CURRENT POSITION 2127
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::syncState stateService stop
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus stop
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:01 volumio volumio[874]: info: CorePlayQueue::getTrack 2127
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:01 volumio volumio[874]: info: No code
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:01 volumio volumio[874]: info: CorePlayQueue::getTrack 2127
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:01 volumio volumio[874]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 24 16:35:01 volumio volumio[874]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 24 16:35:01 volumio volumio[874]: info: ------------------------------ 16ms
May 24 16:35:01 volumio volumio[874]: info: ------------------------------ 11ms
May 24 16:35:01 volumio volumio[874]: info: ------------------------------ 11ms
May 24 16:35:01 volumio volumio[874]: info:
May 24 16:35:01 volumio volumio[874]: ---------------------------- MPD announces system playlist update
May 24 16:35:01 volumio volumio[874]: info: Ignoring MPD Status Update
May 24 16:35:01 volumio volumio[874]: info:
May 24 16:35:01 volumio volumio[874]: ---------------------------- MPD announces system playlist update
May 24 16:35:01 volumio volumio[874]: info: Ignoring MPD Status Update
May 24 16:35:01 volumio volumio[874]: error: updateQueue error: null
May 24 16:35:01 volumio volumio[874]: info:
May 24 16:35:01 volumio volumio[874]: ---------------------------- MPD announces system playlist update
May 24 16:35:01 volumio volumio[874]: info: Ignoring MPD Status Update
May 24 16:35:01 volumio volumio[874]: info: ------------------------------ 10ms
May 24 16:35:01 volumio volumio[874]: info: sendMpdCommand add "NAS/音乐/MQA/MQA - HK&CH&TW/Danny Chan/[M] The Most Greatest Hits [23616341] [2013]/03 - Danny Chan - Cheers.flac" took 10 milliseconds
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand play
May 24 16:35:01 volumio volumio[874]: info: ------------------------------ 5ms
May 24 16:35:01 volumio volumio[874]: info: ------------------------------ 4ms
May 24 16:35:01 volumio volumio[874]: info: ------------------------------ 5ms
May 24 16:35:01 volumio volumio[874]: info: sendMpdCommand play took 4 milliseconds
May 24 16:35:01 volumio volumio[874]: info:
May 24 16:35:01 volumio volumio[874]: ---------------------------- MPD announces system playlist update
May 24 16:35:01 volumio volumio[874]: info: Ignoring MPD Status Update
May 24 16:35:01 volumio volumio[874]: info:
May 24 16:35:01 volumio volumio[874]: ---------------------------- MPD announces system playlist update
May 24 16:35:01 volumio volumio[874]: info: Ignoring MPD Status Update
May 24 16:35:01 volumio volumio[874]: info: ------------------------------ 2ms
May 24 16:35:01 volumio volumio[874]: info: ------------------------------ 2ms
May 24 16:35:01 volumio volumio[874]: info:
May 24 16:35:01 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:01 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:01 volumio volumio[874]: info:
May 24 16:35:01 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:01 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:01 volumio volumio[874]: info:
May 24 16:35:01 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:01 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:01 volumio volumio[874]: info:
May 24 16:35:01 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:01 volumio volumio[874]: info: sendMpdCommand status took 49 milliseconds
May 24 16:35:01 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:01 volumio volumio[874]: info:
May 24 16:35:01 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:01 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:01 volumio volumio[874]: info:
May 24 16:35:01 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:01 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:01 volumio volumio[874]: info: sendMpdCommand status took 51 milliseconds
May 24 16:35:01 volumio volumio[874]: info: sendMpdCommand status took 50 milliseconds
May 24 16:35:01 volumio volumio[874]: info: sendMpdCommand status took 3 milliseconds
May 24 16:35:01 volumio volumio[874]: info: sendMpdCommand playlistinfo took 3 milliseconds
May 24 16:35:01 volumio volumio[874]: info: sendMpdCommand status took 2 milliseconds
May 24 16:35:01 volumio volumio[874]: info: sendMpdCommand status took 1 milliseconds
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:01 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:01 volumio volumio[874]: info: CorePlayQueue::getTrack 2127
May 24 16:35:01 volumio volumio[874]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":215,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"882 Kbps","isStreaming":false,"title":"Cheers","artist":"Danny Chan","album":"The Most Greatest Hits","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/Danny Chan/[M] The Most Greatest Hits [23616341] [2013]/03 - Danny Chan - Cheers.flac","trackType":"flac"}
May 24 16:35:01 volumio volumio[874]: verbose: CURRENT POSITION 2127
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::syncState stateService play
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus stop
May 24 16:35:01 volumio volumio[874]: info: ------------------------------ 57ms
May 24 16:35:01 volumio volumio[874]: info: sendMpdCommand playlistinfo took 6 milliseconds
May 24 16:35:01 volumio volumio[874]: info: sendMpdCommand playlistinfo took 6 milliseconds
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:01 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:01 volumio volumio[874]: info: CorePlayQueue::getTrack 2127
May 24 16:35:01 volumio volumio[874]: verbose: STATE SERVICE {"status":"play","position":0,"seek":682,"duration":215,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"846 Kbps","isStreaming":false,"title":"Cheers","artist":"Danny Chan","album":"The Most Greatest Hits","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/Danny Chan/[M] The Most Greatest Hits [23616341] [2013]/03 - Danny Chan - Cheers.flac","trackType":"flac"}
May 24 16:35:01 volumio volumio[874]: verbose: CURRENT POSITION 2127
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::syncState stateService play
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus play
May 24 16:35:01 volumio volumio[874]: info: Received an update from plugin. extracting info from payload
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:01 volumio volumio[874]: info: CorePlayQueue::getTrack 2127
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:01 volumio volumio[874]: info: CorePlayQueue::getTrack 2127
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:01 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:01 volumio volumio[874]: info: CorePlayQueue::getTrack 2127
May 24 16:35:01 volumio volumio[874]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":215,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"846 Kbps","isStreaming":false,"title":"Cheers","artist":"Danny Chan","album":"The Most Greatest Hits","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/Danny Chan/[M] The Most Greatest Hits [23616341] [2013]/03 - Danny Chan - Cheers.flac","trackType":"flac"}
May 24 16:35:01 volumio volumio[874]: verbose: CURRENT POSITION 2127
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::syncState stateService play
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus play
May 24 16:35:01 volumio volumio[874]: info: Received an update from plugin. extracting info from payload
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:01 volumio volumio[874]: info: CorePlayQueue::getTrack 2127
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:01 volumio volumio[874]: info: CorePlayQueue::getTrack 2127
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:01 volumio volumio[874]: info: ------------------------------ 76ms
May 24 16:35:01 volumio volumio[874]: info: ------------------------------ 76ms
May 24 16:35:01 volumio volumio[874]: info: sendMpdCommand playlistinfo took 24 milliseconds
May 24 16:35:01 volumio volumio[874]: info: sendMpdCommand playlistinfo took 24 milliseconds
May 24 16:35:01 volumio volumio[874]: info: sendMpdCommand playlistinfo took 24 milliseconds
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:01 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:01 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:01 volumio volumio[874]: info: CorePlayQueue::getTrack 2127
May 24 16:35:01 volumio volumio[874]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":215,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"846 Kbps","isStreaming":false,"title":"Cheers","artist":"Danny Chan","album":"The Most Greatest Hits","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/Danny Chan/[M] The Most Greatest Hits [23616341] [2013]/03 - Danny Chan - Cheers.flac","trackType":"flac"}
May 24 16:35:01 volumio volumio[874]: verbose: CURRENT POSITION 2127
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::syncState stateService play
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus play
May 24 16:35:01 volumio volumio[874]: info: Received an update from plugin. extracting info from payload
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:01 volumio volumio[874]: info: CorePlayQueue::getTrack 2127
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:01 volumio volumio[874]: info: CorePlayQueue::getTrack 2127
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:01 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:01 volumio volumio[874]: info: CorePlayQueue::getTrack 2127
May 24 16:35:01 volumio volumio[874]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":215,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"846 Kbps","isStreaming":false,"title":"Cheers","artist":"Danny Chan","album":"The Most Greatest Hits","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/Danny Chan/[M] The Most Greatest Hits [23616341] [2013]/03 - Danny Chan - Cheers.flac","trackType":"flac"}
May 24 16:35:01 volumio volumio[874]: verbose: CURRENT POSITION 2127
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::syncState stateService play
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus play
May 24 16:35:01 volumio volumio[874]: info: Received an update from plugin. extracting info from payload
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:01 volumio volumio[874]: info: CorePlayQueue::getTrack 2127
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:01 volumio volumio[874]: info: CorePlayQueue::getTrack 2127
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:01 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:01 volumio volumio[874]: info: CorePlayQueue::getTrack 2127
May 24 16:35:01 volumio volumio[874]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":215,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"846 Kbps","isStreaming":false,"title":"Cheers","artist":"Danny Chan","album":"The Most Greatest Hits","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/Danny Chan/[M] The Most Greatest Hits [23616341] [2013]/03 - Danny Chan - Cheers.flac","trackType":"flac"}
May 24 16:35:01 volumio volumio[874]: verbose: CURRENT POSITION 2127
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::syncState stateService play
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus play
May 24 16:35:01 volumio volumio[874]: info: Received an update from plugin. extracting info from payload
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:01 volumio volumio[874]: info: CorePlayQueue::getTrack 2127
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:01 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:01 volumio volumio[874]: info: CorePlayQueue::getTrack 2127
May 24 16:35:01 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:01 volumio volumio[874]: info: ------------------------------ 61ms
May 24 16:35:01 volumio volumio[874]: info: ------------------------------ 59ms
May 24 16:35:01 volumio volumio[874]: info: ------------------------------ 60ms
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::volumioNext
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::next
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::stop
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::stPlaybackTimer
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::updateTrackBlock
May 24 16:35:05 volumio volumio[874]: info: CorePlayQueue::getTrackBlock
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:05 volumio volumio[874]: info: CorePlayQueue::getTrack 2127
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::serviceStop
May 24 16:35:05 volumio volumio[874]: info: CorePlayQueue::getTrack 2127
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::serviceStop
May 24 16:35:05 volumio volumio[874]: info: ControllerMpd::stop
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand stop
May 24 16:35:05 volumio volumio[874]: info:
May 24 16:35:05 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:05 volumio volumio[874]: info: sendMpdCommand stop took 20 milliseconds
May 24 16:35:05 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::play index undefined
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined
May 24 16:35:05 volumio volumio[874]: info: CorePlayQueue::getTrack 2713
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::startPlaybackTimer
May 24 16:35:05 volumio volumio[874]: info: CorePlayQueue::getTrack 2713
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::clearAddPlayTracks NAS/音乐/MQA/MQA - HK&CH&TW/George Lam/[M] Creative Album Vol.2 93' [196412] [2015]/12 - George Lam - Yi Tuan He Qi.flac
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand stop
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::updateTrackBlock
May 24 16:35:05 volumio volumio[874]: info: CorePlayQueue::getTrackBlock
May 24 16:35:05 volumio volumio[874]: info:
May 24 16:35:05 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:05 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:05 volumio volumio[874]: info:
May 24 16:35:05 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:05 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:05 volumio volumio[874]: info: sendMpdCommand status took 5 milliseconds
May 24 16:35:05 volumio volumio[874]: info: sendMpdCommand stop took 2 milliseconds
May 24 16:35:05 volumio volumio[874]: info: sendMpdCommand status took 1 milliseconds
May 24 16:35:05 volumio volumio[874]: info: sendMpdCommand status took 1 milliseconds
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand clear
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:05 volumio volumio[874]: info:
May 24 16:35:05 volumio volumio[874]: ---------------------------- MPD announces system playlist update
May 24 16:35:05 volumio volumio[874]: info: Ignoring MPD Status Update
May 24 16:35:05 volumio volumio[874]: info: sendMpdCommand playlistinfo took 2 milliseconds
May 24 16:35:05 volumio volumio[874]: info: sendMpdCommand clear took 1 milliseconds
May 24 16:35:05 volumio volumio[874]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 24 16:35:05 volumio volumio[874]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand add "NAS/音乐/MQA/MQA - HK&CH&TW/George Lam/[M] Creative Album Vol.2 93' [196412] [2015]/12 - George Lam - Yi Tuan He Qi.flac"
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:05 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:05 volumio volumio[874]: info: CorePlayQueue::getTrack 2713
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:05 volumio volumio[874]: info: CorePlayQueue::getTrack 2713
May 24 16:35:05 volumio volumio[874]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Cheers","artist":"Danny Chan","album":"The Most Greatest Hits","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/Danny Chan/[M] The Most Greatest Hits [23616341] [2013]/03 - Danny Chan - Cheers.flac","trackType":"flac"}
May 24 16:35:05 volumio volumio[874]: verbose: CURRENT POSITION 2713
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::syncState stateService stop
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus stop
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:05 volumio volumio[874]: info: CorePlayQueue::getTrack 2713
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:05 volumio volumio[874]: info: No code
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:05 volumio volumio[874]: info: CorePlayQueue::getTrack 2713
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:05 volumio volumio[874]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 24 16:35:05 volumio volumio[874]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 24 16:35:05 volumio volumio[874]: info: ------------------------------ 16ms
May 24 16:35:05 volumio volumio[874]: info: ------------------------------ 11ms
May 24 16:35:05 volumio volumio[874]: info: ------------------------------ 12ms
May 24 16:35:05 volumio volumio[874]: info:
May 24 16:35:05 volumio volumio[874]: ---------------------------- MPD announces system playlist update
May 24 16:35:05 volumio volumio[874]: info: Ignoring MPD Status Update
May 24 16:35:05 volumio volumio[874]: info:
May 24 16:35:05 volumio volumio[874]: ---------------------------- MPD announces system playlist update
May 24 16:35:05 volumio volumio[874]: info: Ignoring MPD Status Update
May 24 16:35:05 volumio volumio[874]: error: updateQueue error: null
May 24 16:35:05 volumio volumio[874]: info:
May 24 16:35:05 volumio volumio[874]: ---------------------------- MPD announces system playlist update
May 24 16:35:05 volumio volumio[874]: info: Ignoring MPD Status Update
May 24 16:35:05 volumio volumio[874]: info: ------------------------------ 11ms
May 24 16:35:05 volumio volumio[874]: info: sendMpdCommand add "NAS/音乐/MQA/MQA - HK&CH&TW/George Lam/[M] Creative Album Vol.2 93' [196412] [2015]/12 - George Lam - Yi Tuan He Qi.flac" took 10 milliseconds
May 24 16:35:05 volumio volumio[874]: info: ------------------------------ 2ms
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand play
May 24 16:35:05 volumio volumio[874]: info:
May 24 16:35:05 volumio volumio[874]: ---------------------------- MPD announces system playlist update
May 24 16:35:05 volumio volumio[874]: info: Ignoring MPD Status Update
May 24 16:35:05 volumio volumio[874]: info:
May 24 16:35:05 volumio volumio[874]: ---------------------------- MPD announces system playlist update
May 24 16:35:05 volumio volumio[874]: info: Ignoring MPD Status Update
May 24 16:35:05 volumio volumio[874]: info: ------------------------------ 3ms
May 24 16:35:05 volumio volumio[874]: info: sendMpdCommand play took 2 milliseconds
May 24 16:35:05 volumio volumio[874]: info: ------------------------------ 3ms
May 24 16:35:05 volumio volumio[874]: info: ------------------------------ 3ms
May 24 16:35:05 volumio volumio[874]: info:
May 24 16:35:05 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:05 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:05 volumio volumio[874]: info:
May 24 16:35:05 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:05 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:05 volumio volumio[874]: info:
May 24 16:35:05 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:05 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:05 volumio volumio[874]: info:
May 24 16:35:05 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:05 volumio volumio[874]: info: sendMpdCommand status took 57 milliseconds
May 24 16:35:05 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:05 volumio volumio[874]: info:
May 24 16:35:05 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:05 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:05 volumio volumio[874]: info:
May 24 16:35:05 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:05 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:05 volumio volumio[874]: info: sendMpdCommand status took 62 milliseconds
May 24 16:35:05 volumio volumio[874]: info: sendMpdCommand status took 61 milliseconds
May 24 16:35:05 volumio volumio[874]: info: sendMpdCommand status took 4 milliseconds
May 24 16:35:05 volumio volumio[874]: info: sendMpdCommand playlistinfo took 4 milliseconds
May 24 16:35:05 volumio volumio[874]: info: sendMpdCommand status took 2 milliseconds
May 24 16:35:05 volumio volumio[874]: info: sendMpdCommand status took 1 milliseconds
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:05 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:05 volumio volumio[874]: info: CorePlayQueue::getTrack 2713
May 24 16:35:05 volumio volumio[874]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Yi Tuan He Qi","artist":"George Lam","album":"Creative Album Vol.2 93'","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/George Lam/[M] Creative Album Vol.2 93' [196412] [2015]/12 - George Lam - Yi Tuan He Qi.flac","trackType":"flac"}
May 24 16:35:05 volumio volumio[874]: verbose: CURRENT POSITION 2713
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::syncState stateService play
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus stop
May 24 16:35:05 volumio volumio[874]: info: ------------------------------ 69ms
May 24 16:35:05 volumio volumio[874]: info: sendMpdCommand playlistinfo took 8 milliseconds
May 24 16:35:05 volumio volumio[874]: info: sendMpdCommand playlistinfo took 9 milliseconds
May 24 16:35:05 volumio volumio[874]: info: sendMpdCommand playlistinfo took 10 milliseconds
May 24 16:35:05 volumio volumio[874]: info: sendMpdCommand playlistinfo took 6 milliseconds
May 24 16:35:05 volumio volumio[874]: info: sendMpdCommand playlistinfo took 6 milliseconds
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:05 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:05 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:05 volumio volumio[874]: info: CorePlayQueue::getTrack 2713
May 24 16:35:05 volumio volumio[874]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"305 Kbps","isStreaming":false,"title":"Yi Tuan He Qi","artist":"George Lam","album":"Creative Album Vol.2 93'","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/George Lam/[M] Creative Album Vol.2 93' [196412] [2015]/12 - George Lam - Yi Tuan He Qi.flac","trackType":"flac"}
May 24 16:35:05 volumio volumio[874]: verbose: CURRENT POSITION 2713
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::syncState stateService play
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus play
May 24 16:35:05 volumio volumio[874]: info: Received an update from plugin. extracting info from payload
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:05 volumio volumio[874]: info: CorePlayQueue::getTrack 2713
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:05 volumio volumio[874]: info: CorePlayQueue::getTrack 2713
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:05 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:05 volumio volumio[874]: info: CorePlayQueue::getTrack 2713
May 24 16:35:05 volumio volumio[874]: verbose: STATE SERVICE {"status":"play","position":0,"seek":182,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"301 Kbps","isStreaming":false,"title":"Yi Tuan He Qi","artist":"George Lam","album":"Creative Album Vol.2 93'","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/George Lam/[M] Creative Album Vol.2 93' [196412] [2015]/12 - George Lam - Yi Tuan He Qi.flac","trackType":"flac"}
May 24 16:35:05 volumio volumio[874]: verbose: CURRENT POSITION 2713
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::syncState stateService play
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus play
May 24 16:35:05 volumio volumio[874]: info: Received an update from plugin. extracting info from payload
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:05 volumio volumio[874]: info: CorePlayQueue::getTrack 2713
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:05 volumio volumio[874]: info: CorePlayQueue::getTrack 2713
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:05 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:05 volumio volumio[874]: info: CorePlayQueue::getTrack 2713
May 24 16:35:05 volumio volumio[874]: verbose: STATE SERVICE {"status":"play","position":0,"seek":295,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"949 Kbps","isStreaming":false,"title":"Yi Tuan He Qi","artist":"George Lam","album":"Creative Album Vol.2 93'","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/George Lam/[M] Creative Album Vol.2 93' [196412] [2015]/12 - George Lam - Yi Tuan He Qi.flac","trackType":"flac"}
May 24 16:35:05 volumio volumio[874]: verbose: CURRENT POSITION 2713
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::syncState stateService play
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus play
May 24 16:35:05 volumio volumio[874]: info: Received an update from plugin. extracting info from payload
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:05 volumio volumio[874]: info: CorePlayQueue::getTrack 2713
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:05 volumio volumio[874]: info: CorePlayQueue::getTrack 2713
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:05 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:05 volumio volumio[874]: info: CorePlayQueue::getTrack 2713
May 24 16:35:05 volumio volumio[874]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1031 Kbps","isStreaming":false,"title":"Yi Tuan He Qi","artist":"George Lam","album":"Creative Album Vol.2 93'","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/George Lam/[M] Creative Album Vol.2 93' [196412] [2015]/12 - George Lam - Yi Tuan He Qi.flac","trackType":"flac"}
May 24 16:35:05 volumio volumio[874]: verbose: CURRENT POSITION 2713
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::syncState stateService play
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus play
May 24 16:35:05 volumio volumio[874]: info: Received an update from plugin. extracting info from payload
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:05 volumio volumio[874]: info: CorePlayQueue::getTrack 2713
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:05 volumio volumio[874]: info: CorePlayQueue::getTrack 2713
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:05 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:05 volumio volumio[874]: info: CorePlayQueue::getTrack 2713
May 24 16:35:05 volumio volumio[874]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1031 Kbps","isStreaming":false,"title":"Yi Tuan He Qi","artist":"George Lam","album":"Creative Album Vol.2 93'","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/George Lam/[M] Creative Album Vol.2 93' [196412] [2015]/12 - George Lam - Yi Tuan He Qi.flac","trackType":"flac"}
May 24 16:35:05 volumio volumio[874]: verbose: CURRENT POSITION 2713
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::syncState stateService play
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus play
May 24 16:35:05 volumio volumio[874]: info: Received an update from plugin. extracting info from payload
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:05 volumio volumio[874]: info: CorePlayQueue::getTrack 2713
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:05 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:05 volumio volumio[874]: info: CorePlayQueue::getTrack 2713
May 24 16:35:05 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:05 volumio volumio[874]: info: ------------------------------ 106ms
May 24 16:35:05 volumio volumio[874]: info: ------------------------------ 52ms
May 24 16:35:05 volumio volumio[874]: info: ------------------------------ 51ms
May 24 16:35:05 volumio volumio[874]: info: ------------------------------ 50ms
May 24 16:35:08 volumio volumio[874]: info: CoreCommandRouter::volumioNext
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::next
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::stop
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::stPlaybackTimer
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::updateTrackBlock
May 24 16:35:08 volumio volumio[874]: info: CorePlayQueue::getTrackBlock
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:08 volumio volumio[874]: info: CorePlayQueue::getTrack 2713
May 24 16:35:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 24 16:35:08 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::serviceStop
May 24 16:35:08 volumio volumio[874]: info: CorePlayQueue::getTrack 2713
May 24 16:35:08 volumio volumio[874]: info: CoreCommandRouter::serviceStop
May 24 16:35:08 volumio volumio[874]: info: ControllerMpd::stop
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand stop
May 24 16:35:08 volumio volumio[874]: info:
May 24 16:35:08 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:08 volumio volumio[874]: info: sendMpdCommand stop took 21 milliseconds
May 24 16:35:08 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::play index undefined
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined
May 24 16:35:08 volumio volumio[874]: info: CorePlayQueue::getTrack 1169
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::startPlaybackTimer
May 24 16:35:08 volumio volumio[874]: info: CorePlayQueue::getTrack 1169
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::clearAddPlayTracks NAS/音乐/MQA/MQA - HK&CH&TW/C AllStar/[M] C AllStar Live Concert 2017 [82593850] [2017]/23 - C AllStar - In Memory Of You (Live).flac
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand stop
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::updateTrackBlock
May 24 16:35:08 volumio volumio[874]: info: CorePlayQueue::getTrackBlock
May 24 16:35:08 volumio volumio[874]: info:
May 24 16:35:08 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:08 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:08 volumio volumio[874]: info:
May 24 16:35:08 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:08 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:08 volumio volumio[874]: info: sendMpdCommand status took 4 milliseconds
May 24 16:35:08 volumio volumio[874]: info: sendMpdCommand stop took 4 milliseconds
May 24 16:35:08 volumio volumio[874]: info: sendMpdCommand status took 1 milliseconds
May 24 16:35:08 volumio volumio[874]: info: sendMpdCommand status took 1 milliseconds
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand clear
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:08 volumio volumio[874]: info:
May 24 16:35:08 volumio volumio[874]: ---------------------------- MPD announces system playlist update
May 24 16:35:08 volumio volumio[874]: info: Ignoring MPD Status Update
May 24 16:35:08 volumio volumio[874]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 24 16:35:08 volumio volumio[874]: info: sendMpdCommand clear took 1 milliseconds
May 24 16:35:08 volumio volumio[874]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 24 16:35:08 volumio volumio[874]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand add "NAS/音乐/MQA/MQA - HK&CH&TW/C AllStar/[M] C AllStar Live Concert 2017 [82593850] [2017]/23 - C AllStar - In Memory Of You (Live).flac"
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:08 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:08 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:08 volumio volumio[874]: info: CorePlayQueue::getTrack 1169
May 24 16:35:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 24 16:35:08 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:08 volumio volumio[874]: info: CorePlayQueue::getTrack 1169
May 24 16:35:08 volumio volumio[874]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Yi Tuan He Qi","artist":"George Lam","album":"Creative Album Vol.2 93'","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/George Lam/[M] Creative Album Vol.2 93' [196412] [2015]/12 - George Lam - Yi Tuan He Qi.flac","trackType":"flac"}
May 24 16:35:08 volumio volumio[874]: verbose: CURRENT POSITION 1169
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::syncState stateService stop
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus stop
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:08 volumio volumio[874]: info: CorePlayQueue::getTrack 1169
May 24 16:35:08 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:08 volumio volumio[874]: info: No code
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:08 volumio volumio[874]: info: CorePlayQueue::getTrack 1169
May 24 16:35:08 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:08 volumio volumio[874]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 24 16:35:08 volumio volumio[874]: info: ------------------------------ 19ms
May 24 16:35:08 volumio volumio[874]: info: ------------------------------ 15ms
May 24 16:35:08 volumio volumio[874]: info: ------------------------------ 14ms
May 24 16:35:08 volumio volumio[874]: info:
May 24 16:35:08 volumio volumio[874]: ---------------------------- MPD announces system playlist update
May 24 16:35:08 volumio volumio[874]: info: Ignoring MPD Status Update
May 24 16:35:08 volumio volumio[874]: info:
May 24 16:35:08 volumio volumio[874]: ---------------------------- MPD announces system playlist update
May 24 16:35:08 volumio volumio[874]: info: Ignoring MPD Status Update
May 24 16:35:08 volumio volumio[874]: error: updateQueue error: null
May 24 16:35:08 volumio volumio[874]: info:
May 24 16:35:08 volumio volumio[874]: ---------------------------- MPD announces system playlist update
May 24 16:35:08 volumio volumio[874]: info: Ignoring MPD Status Update
May 24 16:35:08 volumio volumio[874]: info: ------------------------------ 14ms
May 24 16:35:08 volumio volumio[874]: info: sendMpdCommand add "NAS/音乐/MQA/MQA - HK&CH&TW/C AllStar/[M] C AllStar Live Concert 2017 [82593850] [2017]/23 - C AllStar - In Memory Of You (Live).flac" took 14 milliseconds
May 24 16:35:08 volumio volumio[874]: info: ------------------------------ 2ms
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand play
May 24 16:35:08 volumio volumio[874]: info:
May 24 16:35:08 volumio volumio[874]: ---------------------------- MPD announces system playlist update
May 24 16:35:08 volumio volumio[874]: info: Ignoring MPD Status Update
May 24 16:35:08 volumio volumio[874]: info:
May 24 16:35:08 volumio volumio[874]: ---------------------------- MPD announces system playlist update
May 24 16:35:08 volumio volumio[874]: info: Ignoring MPD Status Update
May 24 16:35:08 volumio volumio[874]: info: ------------------------------ 10ms
May 24 16:35:08 volumio volumio[874]: info: sendMpdCommand play took 9 milliseconds
May 24 16:35:08 volumio volumio[874]: info: ------------------------------ 9ms
May 24 16:35:08 volumio volumio[874]: info: ------------------------------ 9ms
May 24 16:35:08 volumio volumio[874]: info:
May 24 16:35:08 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:08 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:08 volumio volumio[874]: info:
May 24 16:35:08 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:08 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:08 volumio volumio[874]: info:
May 24 16:35:08 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:08 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:08 volumio volumio[874]: info: sendMpdCommand status took 58 milliseconds
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:08 volumio volumio[874]: info:
May 24 16:35:08 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:08 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:08 volumio volumio[874]: info:
May 24 16:35:08 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:08 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:08 volumio volumio[874]: info:
May 24 16:35:08 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:08 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:08 volumio volumio[874]: info: sendMpdCommand status took 62 milliseconds
May 24 16:35:08 volumio volumio[874]: info: sendMpdCommand status took 61 milliseconds
May 24 16:35:08 volumio volumio[874]: info: sendMpdCommand playlistinfo took 3 milliseconds
May 24 16:35:08 volumio volumio[874]: info: sendMpdCommand status took 2 milliseconds
May 24 16:35:08 volumio volumio[874]: info: sendMpdCommand status took 1 milliseconds
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:08 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:08 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:08 volumio volumio[874]: info: CorePlayQueue::getTrack 1169
May 24 16:35:08 volumio volumio[874]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"833 Kbps","isStreaming":false,"title":"In Memory Of You (Live)","artist":"C AllStar","album":"C AllStar Live Concert 2017","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/C AllStar/[M] C AllStar Live Concert 2017 [82593850] [2017]/23 - C AllStar - In Memory Of You (Live).flac","trackType":"flac"}
May 24 16:35:08 volumio volumio[874]: verbose: CURRENT POSITION 1169
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::syncState stateService play
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus stop
May 24 16:35:08 volumio volumio[874]: info: ------------------------------ 68ms
May 24 16:35:08 volumio volumio[874]: info: sendMpdCommand status took 5 milliseconds
May 24 16:35:08 volumio volumio[874]: info: sendMpdCommand playlistinfo took 4 milliseconds
May 24 16:35:08 volumio volumio[874]: info: sendMpdCommand playlistinfo took 5 milliseconds
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:08 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:08 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:08 volumio volumio[874]: info: CorePlayQueue::getTrack 1169
May 24 16:35:08 volumio volumio[874]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"833 Kbps","isStreaming":false,"title":"In Memory Of You (Live)","artist":"C AllStar","album":"C AllStar Live Concert 2017","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/C AllStar/[M] C AllStar Live Concert 2017 [82593850] [2017]/23 - C AllStar - In Memory Of You (Live).flac","trackType":"flac"}
May 24 16:35:08 volumio volumio[874]: verbose: CURRENT POSITION 1169
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::syncState stateService play
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus play
May 24 16:35:08 volumio volumio[874]: info: Received an update from plugin. extracting info from payload
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:08 volumio volumio[874]: info: CorePlayQueue::getTrack 1169
May 24 16:35:08 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 24 16:35:08 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:08 volumio volumio[874]: info: CorePlayQueue::getTrack 1169
May 24 16:35:08 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:08 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:08 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:08 volumio volumio[874]: info: CorePlayQueue::getTrack 1169
May 24 16:35:08 volumio volumio[874]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"833 Kbps","isStreaming":false,"title":"In Memory Of You (Live)","artist":"C AllStar","album":"C AllStar Live Concert 2017","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/C AllStar/[M] C AllStar Live Concert 2017 [82593850] [2017]/23 - C AllStar - In Memory Of You (Live).flac","trackType":"flac"}
May 24 16:35:08 volumio volumio[874]: verbose: CURRENT POSITION 1169
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::syncState stateService play
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus play
May 24 16:35:08 volumio volumio[874]: info: Received an update from plugin. extracting info from payload
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:08 volumio volumio[874]: info: CorePlayQueue::getTrack 1169
May 24 16:35:08 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:08 volumio volumio[874]: info: CorePlayQueue::getTrack 1169
May 24 16:35:08 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:08 volumio volumio[874]: info: ------------------------------ 81ms
May 24 16:35:08 volumio volumio[874]: info: ------------------------------ 80ms
May 24 16:35:08 volumio volumio[874]: info: sendMpdCommand playlistinfo took 17 milliseconds
May 24 16:35:08 volumio volumio[874]: info: sendMpdCommand playlistinfo took 17 milliseconds
May 24 16:35:08 volumio volumio[874]: info: sendMpdCommand playlistinfo took 15 milliseconds
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:08 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:08 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:08 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:08 volumio volumio[874]: info: CorePlayQueue::getTrack 1169
May 24 16:35:08 volumio volumio[874]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"833 Kbps","isStreaming":false,"title":"In Memory Of You (Live)","artist":"C AllStar","album":"C AllStar Live Concert 2017","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/C AllStar/[M] C AllStar Live Concert 2017 [82593850] [2017]/23 - C AllStar - In Memory Of You (Live).flac","trackType":"flac"}
May 24 16:35:08 volumio volumio[874]: verbose: CURRENT POSITION 1169
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::syncState stateService play
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus play
May 24 16:35:08 volumio volumio[874]: info: Received an update from plugin. extracting info from payload
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:08 volumio volumio[874]: info: CorePlayQueue::getTrack 1169
May 24 16:35:08 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:08 volumio volumio[874]: info: CorePlayQueue::getTrack 1169
May 24 16:35:08 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:08 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:08 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:08 volumio volumio[874]: info: CorePlayQueue::getTrack 1169
May 24 16:35:08 volumio volumio[874]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"833 Kbps","isStreaming":false,"title":"In Memory Of You (Live)","artist":"C AllStar","album":"C AllStar Live Concert 2017","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/C AllStar/[M] C AllStar Live Concert 2017 [82593850] [2017]/23 - C AllStar - In Memory Of You (Live).flac","trackType":"flac"}
May 24 16:35:08 volumio volumio[874]: verbose: CURRENT POSITION 1169
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::syncState stateService play
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus play
May 24 16:35:08 volumio volumio[874]: info: Received an update from plugin. extracting info from payload
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:08 volumio volumio[874]: info: CorePlayQueue::getTrack 1169
May 24 16:35:08 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:08 volumio volumio[874]: info: CorePlayQueue::getTrack 1169
May 24 16:35:08 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:08 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:08 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:08 volumio volumio[874]: info: CorePlayQueue::getTrack 1169
May 24 16:35:08 volumio volumio[874]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"833 Kbps","isStreaming":false,"title":"In Memory Of You (Live)","artist":"C AllStar","album":"C AllStar Live Concert 2017","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/C AllStar/[M] C AllStar Live Concert 2017 [82593850] [2017]/23 - C AllStar - In Memory Of You (Live).flac","trackType":"flac"}
May 24 16:35:08 volumio volumio[874]: verbose: CURRENT POSITION 1169
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::syncState stateService play
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus play
May 24 16:35:08 volumio volumio[874]: info: Received an update from plugin. extracting info from payload
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:08 volumio volumio[874]: info: CorePlayQueue::getTrack 1169
May 24 16:35:08 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:08 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:08 volumio volumio[874]: info: CorePlayQueue::getTrack 1169
May 24 16:35:08 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:08 volumio volumio[874]: info: ------------------------------ 63ms
May 24 16:35:08 volumio volumio[874]: info: ------------------------------ 62ms
May 24 16:35:08 volumio volumio[874]: info: ------------------------------ 62ms
May 24 16:35:43 volumio volumio[874]: info: CoreCommandRouter::volumioNext
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::next
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::stop
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::stPlaybackTimer
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::updateTrackBlock
May 24 16:35:43 volumio volumio[874]: info: CorePlayQueue::getTrackBlock
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:43 volumio volumio[874]: info: CorePlayQueue::getTrack 1169
May 24 16:35:43 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 24 16:35:43 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::serviceStop
May 24 16:35:43 volumio volumio[874]: info: CorePlayQueue::getTrack 1169
May 24 16:35:43 volumio volumio[874]: info: CoreCommandRouter::serviceStop
May 24 16:35:43 volumio volumio[874]: info: ControllerMpd::stop
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand stop
May 24 16:35:43 volumio volumio[874]: info:
May 24 16:35:43 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:43 volumio volumio[874]: info: sendMpdCommand stop took 22 milliseconds
May 24 16:35:43 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::play index undefined
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::setConsumeUpdateService undefined
May 24 16:35:43 volumio volumio[874]: info: CorePlayQueue::getTrack 8944
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::startPlaybackTimer
May 24 16:35:43 volumio volumio[874]: info: CorePlayQueue::getTrack 8944
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::clearAddPlayTracks NAS/音乐/MQA/MQA - HK&CH&TW/蔡依林(Jolin Tsai)(1)/[M] Dancing Diva [41005927] [2015]/07 - Jolin Tsai - Heart-Breaking Day.flac
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand stop
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::updateTrackBlock
May 24 16:35:43 volumio volumio[874]: info: CorePlayQueue::getTrackBlock
May 24 16:35:43 volumio volumio[874]: info:
May 24 16:35:43 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:43 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:43 volumio volumio[874]: info:
May 24 16:35:43 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:43 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:43 volumio volumio[874]: info: sendMpdCommand status took 6 milliseconds
May 24 16:35:43 volumio volumio[874]: info: sendMpdCommand stop took 3 milliseconds
May 24 16:35:43 volumio volumio[874]: info: sendMpdCommand status took 3 milliseconds
May 24 16:35:43 volumio volumio[874]: info: sendMpdCommand status took 1 milliseconds
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand clear
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:43 volumio volumio[874]: info:
May 24 16:35:43 volumio volumio[874]: ---------------------------- MPD announces system playlist update
May 24 16:35:43 volumio volumio[874]: info: Ignoring MPD Status Update
May 24 16:35:43 volumio volumio[874]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 24 16:35:43 volumio volumio[874]: info: sendMpdCommand clear took 1 milliseconds
May 24 16:35:43 volumio volumio[874]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 24 16:35:43 volumio volumio[874]: info: sendMpdCommand playlistinfo took 1 milliseconds
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand add "NAS/音乐/MQA/MQA - HK&CH&TW/蔡依林(Jolin Tsai)(1)/[M] Dancing Diva [41005927] [2015]/07 - Jolin Tsai - Heart-Breaking Day.flac"
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:43 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:43 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:43 volumio volumio[874]: info: CorePlayQueue::getTrack 8944
May 24 16:35:43 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 24 16:35:43 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:43 volumio volumio[874]: info: CorePlayQueue::getTrack 8944
May 24 16:35:43 volumio volumio[874]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"In Memory Of You (Live)","artist":"C AllStar","album":"C AllStar Live Concert 2017","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/C AllStar/[M] C AllStar Live Concert 2017 [82593850] [2017]/23 - C AllStar - In Memory Of You (Live).flac","trackType":"flac"}
May 24 16:35:43 volumio volumio[874]: verbose: CURRENT POSITION 8944
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::syncState stateService stop
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus stop
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:43 volumio volumio[874]: info: CorePlayQueue::getTrack 8944
May 24 16:35:43 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:43 volumio volumio[874]: info: No code
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:43 volumio volumio[874]: info: CorePlayQueue::getTrack 8944
May 24 16:35:43 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:43 volumio volumio[874]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 24 16:35:43 volumio volumio[874]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
May 24 16:35:43 volumio volumio[874]: info: ------------------------------ 19ms
May 24 16:35:43 volumio volumio[874]: info: ------------------------------ 15ms
May 24 16:35:43 volumio volumio[874]: info: ------------------------------ 15ms
May 24 16:35:43 volumio volumio[874]: info:
May 24 16:35:43 volumio volumio[874]: ---------------------------- MPD announces system playlist update
May 24 16:35:43 volumio volumio[874]: info: Ignoring MPD Status Update
May 24 16:35:43 volumio volumio[874]: info:
May 24 16:35:43 volumio volumio[874]: ---------------------------- MPD announces system playlist update
May 24 16:35:43 volumio volumio[874]: info: Ignoring MPD Status Update
May 24 16:35:43 volumio volumio[874]: error: updateQueue error: null
May 24 16:35:43 volumio volumio[874]: info:
May 24 16:35:43 volumio volumio[874]: ---------------------------- MPD announces system playlist update
May 24 16:35:43 volumio volumio[874]: info: Ignoring MPD Status Update
May 24 16:35:43 volumio volumio[874]: info: ------------------------------ 13ms
May 24 16:35:43 volumio volumio[874]: info: sendMpdCommand add "NAS/音乐/MQA/MQA - HK&CH&TW/蔡依林(Jolin Tsai)(1)/[M] Dancing Diva [41005927] [2015]/07 - Jolin Tsai - Heart-Breaking Day.flac" took 12 milliseconds
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand play
May 24 16:35:43 volumio volumio[874]: info:
May 24 16:35:43 volumio volumio[874]: ---------------------------- MPD announces system playlist update
May 24 16:35:43 volumio volumio[874]: info: Ignoring MPD Status Update
May 24 16:35:43 volumio volumio[874]: info: ------------------------------ 8ms
May 24 16:35:43 volumio volumio[874]: info: ------------------------------ 7ms
May 24 16:35:43 volumio volumio[874]: info: ------------------------------ 7ms
May 24 16:35:43 volumio volumio[874]: info: sendMpdCommand play took 6 milliseconds
May 24 16:35:43 volumio volumio[874]: info:
May 24 16:35:43 volumio volumio[874]: ---------------------------- MPD announces system playlist update
May 24 16:35:43 volumio volumio[874]: info: Ignoring MPD Status Update
May 24 16:35:43 volumio volumio[874]: info: ------------------------------ 2ms
May 24 16:35:43 volumio volumio[874]: info: ------------------------------ 0ms
May 24 16:35:43 volumio volumio[874]: info:
May 24 16:35:43 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:43 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:43 volumio volumio[874]: info:
May 24 16:35:43 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:43 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:43 volumio volumio[874]: info:
May 24 16:35:43 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:43 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:43 volumio volumio[874]: info:
May 24 16:35:43 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:43 volumio volumio[874]: info: sendMpdCommand status took 146 milliseconds
May 24 16:35:43 volumio volumio[874]: info: sendMpdCommand status took 145 milliseconds
May 24 16:35:43 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:43 volumio volumio[874]: info:
May 24 16:35:43 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:43 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:43 volumio volumio[874]: info:
May 24 16:35:43 volumio volumio[874]: ---------------------------- MPD announces state update: player
May 24 16:35:43 volumio volumio[874]: info: ControllerMpd::getState
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand status
May 24 16:35:43 volumio volumio[874]: info: sendMpdCommand status took 8 milliseconds
May 24 16:35:43 volumio volumio[874]: info: sendMpdCommand playlistinfo took 8 milliseconds
May 24 16:35:43 volumio volumio[874]: info: sendMpdCommand playlistinfo took 8 milliseconds
May 24 16:35:43 volumio volumio[874]: info: sendMpdCommand playlistinfo took 8 milliseconds
May 24 16:35:43 volumio volumio[874]: info: sendMpdCommand status took 6 milliseconds
May 24 16:35:43 volumio volumio[874]: info: sendMpdCommand status took 5 milliseconds
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::parseState
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::sendMpdCommand playlistinfo
May 24 16:35:43 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:43 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:43 volumio volumio[874]: info: CorePlayQueue::getTrack 8944
May 24 16:35:43 volumio volumio[874]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":252,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"462 Kbps","isStreaming":false,"title":"Heart-Breaking Day","artist":"Jolin Tsai","album":"Dancing Diva","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/蔡依林(Jolin Tsai)(1)/[M] Dancing Diva [41005927] [2015]/07 - Jolin Tsai - Heart-Breaking Day.flac","trackType":"flac"}
May 24 16:35:43 volumio volumio[874]: verbose: CURRENT POSITION 8944
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::syncState stateService play
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus stop
May 24 16:35:43 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:43 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:43 volumio volumio[874]: info: CorePlayQueue::getTrack 8944
May 24 16:35:43 volumio volumio[874]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":252,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"462 Kbps","isStreaming":false,"title":"Heart-Breaking Day","artist":"Jolin Tsai","album":"Dancing Diva","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/蔡依林(Jolin Tsai)(1)/[M] Dancing Diva [41005927] [2015]/07 - Jolin Tsai - Heart-Breaking Day.flac","trackType":"flac"}
May 24 16:35:43 volumio volumio[874]: verbose: CURRENT POSITION 8944
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::syncState stateService play
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus play
May 24 16:35:43 volumio volumio[874]: info: Received an update from plugin. extracting info from payload
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:43 volumio volumio[874]: info: CorePlayQueue::getTrack 8944
May 24 16:35:43 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 24 16:35:43 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:43 volumio volumio[874]: info: CorePlayQueue::getTrack 8944
May 24 16:35:43 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:43 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:43 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:43 volumio volumio[874]: info: CorePlayQueue::getTrack 8944
May 24 16:35:43 volumio volumio[874]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":252,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"462 Kbps","isStreaming":false,"title":"Heart-Breaking Day","artist":"Jolin Tsai","album":"Dancing Diva","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/蔡依林(Jolin Tsai)(1)/[M] Dancing Diva [41005927] [2015]/07 - Jolin Tsai - Heart-Breaking Day.flac","trackType":"flac"}
May 24 16:35:43 volumio volumio[874]: verbose: CURRENT POSITION 8944
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::syncState stateService play
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus play
May 24 16:35:43 volumio volumio[874]: info: Received an update from plugin. extracting info from payload
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:43 volumio volumio[874]: info: CorePlayQueue::getTrack 8944
May 24 16:35:43 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:43 volumio volumio[874]: info: CorePlayQueue::getTrack 8944
May 24 16:35:43 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:43 volumio volumio[874]: info: ------------------------------ 167ms
May 24 16:35:43 volumio volumio[874]: info: ------------------------------ 177ms
May 24 16:35:43 volumio volumio[874]: info: ------------------------------ 177ms
May 24 16:35:43 volumio volumio[874]: info: sendMpdCommand playlistinfo took 22 milliseconds
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:43 volumio volumio[874]: verbose: ControllerMpd::parseTrackInfo
May 24 16:35:43 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:43 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:43 volumio volumio[874]: info: CorePlayQueue::getTrack 8944
May 24 16:35:43 volumio volumio[874]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":252,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"495 Kbps","isStreaming":false,"title":"Heart-Breaking Day","artist":"Jolin Tsai","album":"Dancing Diva","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/蔡依林(Jolin Tsai)(1)/[M] Dancing Diva [41005927] [2015]/07 - Jolin Tsai - Heart-Breaking Day.flac","trackType":"flac"}
May 24 16:35:43 volumio volumio[874]: verbose: CURRENT POSITION 8944
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::syncState stateService play
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus play
May 24 16:35:43 volumio volumio[874]: info: Received an update from plugin. extracting info from payload
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:43 volumio volumio[874]: info: CorePlayQueue::getTrack 8944
May 24 16:35:43 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:43 volumio volumio[874]: info: CorePlayQueue::getTrack 8944
May 24 16:35:43 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:43 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:43 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:43 volumio volumio[874]: info: CorePlayQueue::getTrack 8944
May 24 16:35:43 volumio volumio[874]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":252,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"495 Kbps","isStreaming":false,"title":"Heart-Breaking Day","artist":"Jolin Tsai","album":"Dancing Diva","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/蔡依林(Jolin Tsai)(1)/[M] Dancing Diva [41005927] [2015]/07 - Jolin Tsai - Heart-Breaking Day.flac","trackType":"flac"}
May 24 16:35:43 volumio volumio[874]: verbose: CURRENT POSITION 8944
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::syncState stateService play
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus play
May 24 16:35:43 volumio volumio[874]: info: Received an update from plugin. extracting info from payload
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:43 volumio volumio[874]: info: CorePlayQueue::getTrack 8944
May 24 16:35:43 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:43 volumio volumio[874]: info: CorePlayQueue::getTrack 8944
May 24 16:35:43 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:43 volumio volumio[874]: info: ControllerMpd::pushState
May 24 16:35:43 volumio volumio[874]: info: CoreCommandRouter::servicePushState
May 24 16:35:43 volumio volumio[874]: info: CorePlayQueue::getTrack 8944
May 24 16:35:43 volumio volumio[874]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":252,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"495 Kbps","isStreaming":false,"title":"Heart-Breaking Day","artist":"Jolin Tsai","album":"Dancing Diva","uri":"NAS/音乐/MQA/MQA - HK&CH&TW/蔡依林(Jolin Tsai)(1)/[M] Dancing Diva [41005927] [2015]/07 - Jolin Tsai - Heart-Breaking Day.flac","trackType":"flac"}
May 24 16:35:43 volumio volumio[874]: verbose: CURRENT POSITION 8944
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::syncState stateService play
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::syncState currentStatus play
May 24 16:35:43 volumio volumio[874]: info: Received an update from plugin. extracting info from payload
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:43 volumio volumio[874]: info: CorePlayQueue::getTrack 8944
May 24 16:35:43 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:43 volumio volumio[874]: info: CoreStateMachine::pushState
May 24 16:35:43 volumio volumio[874]: info: CorePlayQueue::getTrack 8944
May 24 16:35:43 volumio volumio[874]: info: CoreCommandRouter::volumioPushState
May 24 16:35:43 volumio volumio[874]: info: ------------------------------ 47ms
May 24 16:35:43 volumio volumio[874]: info: ------------------------------ 43ms
May 24 16:35:43 volumio volumio[874]: info: ------------------------------ 42ms
May 24 16:35:45 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 24 16:35:45 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 24 16:35:45 volumio volumio[874]: info: Discovery: Getting this device information
May 24 16:35:45 volumio volumio[874]: info: CoreCommandRouter::volumioGetState
May 24 16:35:45 volumio volumio[874]: info: CorePlayQueue::getTrack 8944
May 24 16:35:45 volumio volumio[874]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 24 16:36:55 volumio volumio[874]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 24 16:36:55 volumio volumio[874]: Error: connect ETIMEDOUT 108.160.163.112:443
May 24 16:36:55 volumio volumio[874]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
May 24 16:36:55 volumio volumio[874]: errno: -110,
May 24 16:36:55 volumio volumio[874]: code: 'ETIMEDOUT',
May 24 16:36:55 volumio volumio[874]: syscall: 'connect',
May 24 16:36:55 volumio volumio[874]: address: '108.160.163.112',
May 24 16:36:55 volumio volumio[874]: port: 443
May 24 16:36:55 volumio volumio[874]: }
May 24 16:36:55 volumio volumio[874]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 24 16:36:56 volumio sudo[3295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-24 16:35
May 24 16:36:56 volumio sudo[3295]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
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="570c5791513f5bac7da274aba6690c1a961705de"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:50:12 PM CEST"
VOLUMIO_VERSION="3.812"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="39b0f8c200b2dcadf117e189b4b3632d"