-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Sat 2025-02-22 11:57:35 CST. -- Feb 22 11:56:00 volumio volumio[994]: info: Preload queue cleared Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::ClearQueue Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::stop Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::stPlaybackTimer Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::updateTrackBlock Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrackBlock Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::serviceStop Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::serviceStop Feb 22 11:56:00 volumio volumio[994]: info: ControllerMpd::stop Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand stop Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::clearPlayQueue Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::saveQueue Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::addQueueItems Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::addQueueItems Feb 22 11:56:00 volumio volumio[994]: info: Preload queue cleared Feb 22 11:56:00 volumio volumio[994]: info: Adding Item to queue: albums://Quartetto%20Italiano/Brahms%20Piano%20Quintet%20CD%2037 Feb 22 11:56:00 volumio volumio[994]: info: Exploding uri albums://Quartetto%20Italiano/Brahms%20Piano%20Quintet%20CD%2037 in service mpd Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::saveQueue Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::updateTrackBlock Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrackBlock Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::volumioPlay Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::play index 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::stop Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::play index undefined Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::startPlaybackTimer Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::clearAddPlayTracks USB/LEXAR256/Quartetto Italiano Complete Recordings合集/CD37/CD37 Quartetto Italiano - Brahms Piano Quintet CD 37.flac Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand stop Feb 22 11:56:00 volumio volumio[994]: info: sendMpdCommand stop took 24 milliseconds Feb 22 11:56:00 volumio volumio[994]: info: Feb 22 11:56:00 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:00 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:00 volumio volumio[994]: info: sendMpdCommand stop took 8 milliseconds Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand clear Feb 22 11:56:00 volumio volumio[994]: info: Feb 22 11:56:00 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:00 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:00 volumio volumio[994]: info: Feb 22 11:56:00 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:00 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:00 volumio volumio[994]: info: Feb 22 11:56:00 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:00 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:00 volumio volumio[994]: info: sendMpdCommand status took 3 milliseconds Feb 22 11:56:00 volumio volumio[994]: info: sendMpdCommand clear took 2 milliseconds Feb 22 11:56:00 volumio volumio[994]: info: sendMpdCommand status took 2 milliseconds Feb 22 11:56:00 volumio volumio[994]: info: sendMpdCommand status took 2 milliseconds Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand add "USB/LEXAR256/Quartetto Italiano Complete Recordings合集/CD37/CD37 Quartetto Italiano - Brahms Piano Quintet CD 37.flac" Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:00 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 22 11:56:00 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::syncState stateService stop Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus stop Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:00 volumio volumio[994]: info: No code Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:00 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 22 11:56:00 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::syncState stateService stop Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus stop Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:00 volumio volumio[994]: info: No code Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:00 volumio volumio[994]: info: ------------------------------ 28ms Feb 22 11:56:00 volumio volumio[994]: info: ------------------------------ 27ms Feb 22 11:56:00 volumio volumio[994]: info: Feb 22 11:56:00 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:00 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:00 volumio volumio[994]: info: Feb 22 11:56:00 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:00 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:00 volumio volumio[994]: error: updateQueue error: null Feb 22 11:56:00 volumio volumio[994]: info: Feb 22 11:56:00 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:00 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:00 volumio volumio[994]: info: ------------------------------ 34ms Feb 22 11:56:00 volumio volumio[994]: info: sendMpdCommand playlistinfo took 33 milliseconds Feb 22 11:56:00 volumio volumio[994]: info: sendMpdCommand add "USB/LEXAR256/Quartetto Italiano Complete Recordings合集/CD37/CD37 Quartetto Italiano - Brahms Piano Quintet CD 37.flac" took 33 milliseconds Feb 22 11:56:00 volumio volumio[994]: info: ------------------------------ 7ms Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand play Feb 22 11:56:00 volumio volumio[994]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 22 11:56:00 volumio volumio[994]: info: ------------------------------ 39ms Feb 22 11:56:00 volumio volumio[994]: info: Feb 22 11:56:00 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:00 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:00 volumio volumio[994]: info: Feb 22 11:56:00 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:00 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:00 volumio volumio[994]: info: Feb 22 11:56:00 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:00 volumio volumio[994]: info: ------------------------------ 9ms Feb 22 11:56:00 volumio volumio[994]: info: sendMpdCommand play took 7 milliseconds Feb 22 11:56:00 volumio volumio[994]: info: ------------------------------ 7ms Feb 22 11:56:00 volumio volumio[994]: info: ------------------------------ 6ms Feb 22 11:56:00 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:00 volumio volumio[994]: info: Feb 22 11:56:00 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:00 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:00 volumio volumio[994]: info: Feb 22 11:56:00 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:00 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:00 volumio volumio[994]: info: Feb 22 11:56:00 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:00 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:00 volumio volumio[994]: info: sendMpdCommand status took 5 milliseconds Feb 22 11:56:00 volumio volumio[994]: info: sendMpdCommand status took 3 milliseconds Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:00 volumio volumio[994]: info: Feb 22 11:56:00 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:00 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:00 volumio volumio[994]: info: Feb 22 11:56:00 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:00 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:00 volumio volumio[994]: info: sendMpdCommand status took 6 milliseconds Feb 22 11:56:00 volumio volumio[994]: info: sendMpdCommand playlistinfo took 5 milliseconds Feb 22 11:56:00 volumio volumio[994]: info: sendMpdCommand playlistinfo took 5 milliseconds Feb 22 11:56:00 volumio volumio[994]: info: sendMpdCommand playlistinfo took 5 milliseconds Feb 22 11:56:00 volumio volumio[994]: info: sendMpdCommand status took 4 milliseconds Feb 22 11:56:00 volumio volumio[994]: info: sendMpdCommand status took 3 milliseconds Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:00 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":2629,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Brahms: Piano Quintet In F Minor, Op. 34A - 2. Andante, Un Poco Adagio","artist":"Quartetto Italiano","album":"Brahms Piano Quintet CD 37","uri":"USB/LEXAR256/Quartetto Italiano Complete Recordings合集/CD37/CD37 Quartetto Italiano - Brahms Piano Quintet CD 37.flac","trackType":"flac"} Feb 22 11:56:00 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus stop Feb 22 11:56:00 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":2629,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Brahms: Piano Quintet In F Minor, Op. 34A - 2. Andante, Un Poco Adagio","artist":"Quartetto Italiano","album":"Brahms Piano Quintet CD 37","uri":"USB/LEXAR256/Quartetto Italiano Complete Recordings合集/CD37/CD37 Quartetto Italiano - Brahms Piano Quintet CD 37.flac","trackType":"flac"} Feb 22 11:56:00 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Feb 22 11:56:00 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:00 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":2629,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Brahms: Piano Quintet In F Minor, Op. 34A - 2. Andante, Un Poco Adagio","artist":"Quartetto Italiano","album":"Brahms Piano Quintet CD 37","uri":"USB/LEXAR256/Quartetto Italiano Complete Recordings合集/CD37/CD37 Quartetto Italiano - Brahms Piano Quintet CD 37.flac","trackType":"flac"} Feb 22 11:56:00 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Feb 22 11:56:00 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:00 volumio volumio[994]: info: ------------------------------ 30ms Feb 22 11:56:00 volumio volumio[994]: info: ------------------------------ 41ms Feb 22 11:56:00 volumio volumio[994]: info: ------------------------------ 39ms Feb 22 11:56:00 volumio volumio[994]: info: sendMpdCommand playlistinfo took 29 milliseconds Feb 22 11:56:00 volumio volumio[994]: info: sendMpdCommand playlistinfo took 28 milliseconds Feb 22 11:56:00 volumio volumio[994]: info: sendMpdCommand playlistinfo took 28 milliseconds Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:00 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:00 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":2629,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Brahms: Piano Quintet In F Minor, Op. 34A - 2. Andante, Un Poco Adagio","artist":"Quartetto Italiano","album":"Brahms Piano Quintet CD 37","uri":"USB/LEXAR256/Quartetto Italiano Complete Recordings合集/CD37/CD37 Quartetto Italiano - Brahms Piano Quintet CD 37.flac","trackType":"flac"} Feb 22 11:56:00 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Feb 22 11:56:00 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:00 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":2629,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Brahms: Piano Quintet In F Minor, Op. 34A - 2. Andante, Un Poco Adagio","artist":"Quartetto Italiano","album":"Brahms Piano Quintet CD 37","uri":"USB/LEXAR256/Quartetto Italiano Complete Recordings合集/CD37/CD37 Quartetto Italiano - Brahms Piano Quintet CD 37.flac","trackType":"flac"} Feb 22 11:56:00 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Feb 22 11:56:00 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:00 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":2629,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Brahms: Piano Quintet In F Minor, Op. 34A - 2. Andante, Un Poco Adagio","artist":"Quartetto Italiano","album":"Brahms Piano Quintet CD 37","uri":"USB/LEXAR256/Quartetto Italiano Complete Recordings合集/CD37/CD37 Quartetto Italiano - Brahms Piano Quintet CD 37.flac","trackType":"flac"} Feb 22 11:56:00 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Feb 22 11:56:00 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:00 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:00 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:00 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:00 volumio volumio[994]: info: ------------------------------ 77ms Feb 22 11:56:00 volumio volumio[994]: info: ------------------------------ 74ms Feb 22 11:56:00 volumio volumio[994]: info: ------------------------------ 73ms Feb 22 11:56:04 volumio volumio[994]: info: Preload queue cleared Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::ClearQueue Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::stop Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::stPlaybackTimer Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::updateTrackBlock Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrackBlock Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::serviceStop Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::serviceStop Feb 22 11:56:04 volumio volumio[994]: info: ControllerMpd::stop Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand stop Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::clearPlayQueue Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::saveQueue Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::addQueueItems Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::addQueueItems Feb 22 11:56:04 volumio volumio[994]: info: Preload queue cleared Feb 22 11:56:04 volumio volumio[994]: info: Adding Item to queue: albums://Dallas%20Wind%20Symphony%20(feat.%20conductor%3A%20Jerry%20Junkin)/Garden%20of%20Dreams%20-%20Music%20by%20David%20Maslanka Feb 22 11:56:04 volumio volumio[994]: info: Exploding uri albums://Dallas%20Wind%20Symphony%20(feat.%20conductor%3A%20Jerry%20Junkin)/Garden%20of%20Dreams%20-%20Music%20by%20David%20Maslanka in service mpd Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::saveQueue Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::updateTrackBlock Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrackBlock Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::volumioPlay Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::play index 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::stop Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::play index undefined Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::startPlaybackTimer Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::clearAddPlayTracks USB/LEXAR256/RR-108 Garden of Dreams/RR-108 Garden of Dreams/01 - A Child's Garden Of Dreams - I..flac Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand stop Feb 22 11:56:04 volumio volumio[994]: info: sendMpdCommand stop took 19 milliseconds Feb 22 11:56:04 volumio volumio[994]: info: Feb 22 11:56:04 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:04 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:04 volumio volumio[994]: info: sendMpdCommand stop took 7 milliseconds Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand clear Feb 22 11:56:04 volumio volumio[994]: info: Feb 22 11:56:04 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:04 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:04 volumio volumio[994]: info: Feb 22 11:56:04 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:04 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:04 volumio volumio[994]: info: Feb 22 11:56:04 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:04 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:04 volumio volumio[994]: info: sendMpdCommand status took 3 milliseconds Feb 22 11:56:04 volumio volumio[994]: info: sendMpdCommand clear took 3 milliseconds Feb 22 11:56:04 volumio volumio[994]: info: sendMpdCommand status took 3 milliseconds Feb 22 11:56:04 volumio volumio[994]: info: sendMpdCommand status took 2 milliseconds Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand add "USB/LEXAR256/RR-108 Garden of Dreams/RR-108 Garden of Dreams/01 - A Child's Garden Of Dreams - I..flac" Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:04 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 22 11:56:04 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::syncState stateService stop Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus stop Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:04 volumio volumio[994]: info: No code Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:04 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 22 11:56:04 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::syncState stateService stop Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus stop Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:04 volumio volumio[994]: info: No code Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:04 volumio volumio[994]: info: ------------------------------ 32ms Feb 22 11:56:04 volumio volumio[994]: info: ------------------------------ 32ms Feb 22 11:56:04 volumio volumio[994]: info: Feb 22 11:56:04 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:04 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:04 volumio volumio[994]: info: Feb 22 11:56:04 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:04 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:04 volumio volumio[994]: error: updateQueue error: null Feb 22 11:56:04 volumio volumio[994]: info: Feb 22 11:56:04 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:04 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:04 volumio volumio[994]: info: ------------------------------ 37ms Feb 22 11:56:04 volumio volumio[994]: info: sendMpdCommand playlistinfo took 36 milliseconds Feb 22 11:56:04 volumio volumio[994]: info: sendMpdCommand add "USB/LEXAR256/RR-108 Garden of Dreams/RR-108 Garden of Dreams/01 - A Child's Garden Of Dreams - I..flac" took 36 milliseconds Feb 22 11:56:04 volumio volumio[994]: info: ------------------------------ 6ms Feb 22 11:56:04 volumio volumio[994]: info: ------------------------------ 5ms Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand play Feb 22 11:56:04 volumio volumio[994]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 22 11:56:04 volumio volumio[994]: info: ------------------------------ 43ms Feb 22 11:56:04 volumio volumio[994]: info: Feb 22 11:56:04 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:04 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:04 volumio volumio[994]: info: Feb 22 11:56:04 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:04 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:04 volumio volumio[994]: info: Feb 22 11:56:04 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:04 volumio volumio[994]: info: ------------------------------ 10ms Feb 22 11:56:04 volumio volumio[994]: info: sendMpdCommand play took 8 milliseconds Feb 22 11:56:04 volumio volumio[994]: info: ------------------------------ 7ms Feb 22 11:56:04 volumio volumio[994]: info: ------------------------------ 6ms Feb 22 11:56:04 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:04 volumio volumio[994]: info: Feb 22 11:56:04 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:04 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:04 volumio volumio[994]: info: Feb 22 11:56:04 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:04 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:04 volumio volumio[994]: info: Feb 22 11:56:04 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:04 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:04 volumio volumio[994]: info: sendMpdCommand status took 6 milliseconds Feb 22 11:56:04 volumio volumio[994]: info: sendMpdCommand status took 6 milliseconds Feb 22 11:56:04 volumio volumio[994]: info: sendMpdCommand status took 4 milliseconds Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:04 volumio volumio[994]: info: Feb 22 11:56:04 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:04 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:04 volumio volumio[994]: info: Feb 22 11:56:04 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:04 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:04 volumio volumio[994]: info: sendMpdCommand status took 6 milliseconds Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:04 volumio volumio[994]: info: sendMpdCommand playlistinfo took 6 milliseconds Feb 22 11:56:04 volumio volumio[994]: info: sendMpdCommand playlistinfo took 6 milliseconds Feb 22 11:56:04 volumio volumio[994]: info: sendMpdCommand playlistinfo took 6 milliseconds Feb 22 11:56:04 volumio volumio[994]: info: sendMpdCommand status took 4 milliseconds Feb 22 11:56:04 volumio volumio[994]: info: sendMpdCommand status took 3 milliseconds Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:04 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":301,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"282 Kbps","isStreaming":false,"title":"A Child's Garden Of Dreams - I.","artist":"Dallas Wind Symphony (feat. conductor: Jerry Junkin)","album":"Garden of Dreams - Music by David Maslanka","uri":"USB/LEXAR256/RR-108 Garden of Dreams/RR-108 Garden of Dreams/01 - A Child's Garden Of Dreams - I..flac","trackType":"flac"} Feb 22 11:56:04 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus stop Feb 22 11:56:04 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":301,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"282 Kbps","isStreaming":false,"title":"A Child's Garden Of Dreams - I.","artist":"Dallas Wind Symphony (feat. conductor: Jerry Junkin)","album":"Garden of Dreams - Music by David Maslanka","uri":"USB/LEXAR256/RR-108 Garden of Dreams/RR-108 Garden of Dreams/01 - A Child's Garden Of Dreams - I..flac","trackType":"flac"} Feb 22 11:56:04 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Feb 22 11:56:04 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:04 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":301,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"282 Kbps","isStreaming":false,"title":"A Child's Garden Of Dreams - I.","artist":"Dallas Wind Symphony (feat. conductor: Jerry Junkin)","album":"Garden of Dreams - Music by David Maslanka","uri":"USB/LEXAR256/RR-108 Garden of Dreams/RR-108 Garden of Dreams/01 - A Child's Garden Of Dreams - I..flac","trackType":"flac"} Feb 22 11:56:04 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Feb 22 11:56:04 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:04 volumio volumio[994]: info: ------------------------------ 31ms Feb 22 11:56:04 volumio volumio[994]: info: ------------------------------ 40ms Feb 22 11:56:04 volumio volumio[994]: info: ------------------------------ 39ms Feb 22 11:56:04 volumio volumio[994]: info: sendMpdCommand playlistinfo took 32 milliseconds Feb 22 11:56:04 volumio volumio[994]: info: sendMpdCommand playlistinfo took 28 milliseconds Feb 22 11:56:04 volumio volumio[994]: info: sendMpdCommand playlistinfo took 28 milliseconds Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:04 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:04 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":301,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"282 Kbps","isStreaming":false,"title":"A Child's Garden Of Dreams - I.","artist":"Dallas Wind Symphony (feat. conductor: Jerry Junkin)","album":"Garden of Dreams - Music by David Maslanka","uri":"USB/LEXAR256/RR-108 Garden of Dreams/RR-108 Garden of Dreams/01 - A Child's Garden Of Dreams - I..flac","trackType":"flac"} Feb 22 11:56:04 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Feb 22 11:56:04 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:04 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":301,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"282 Kbps","isStreaming":false,"title":"A Child's Garden Of Dreams - I.","artist":"Dallas Wind Symphony (feat. conductor: Jerry Junkin)","album":"Garden of Dreams - Music by David Maslanka","uri":"USB/LEXAR256/RR-108 Garden of Dreams/RR-108 Garden of Dreams/01 - A Child's Garden Of Dreams - I..flac","trackType":"flac"} Feb 22 11:56:04 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Feb 22 11:56:04 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:04 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":301,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"282 Kbps","isStreaming":false,"title":"A Child's Garden Of Dreams - I.","artist":"Dallas Wind Symphony (feat. conductor: Jerry Junkin)","album":"Garden of Dreams - Music by David Maslanka","uri":"USB/LEXAR256/RR-108 Garden of Dreams/RR-108 Garden of Dreams/01 - A Child's Garden Of Dreams - I..flac","trackType":"flac"} Feb 22 11:56:04 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Feb 22 11:56:04 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:04 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:04 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:04 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:04 volumio volumio[994]: info: ------------------------------ 83ms Feb 22 11:56:04 volumio volumio[994]: info: ------------------------------ 78ms Feb 22 11:56:04 volumio volumio[994]: info: ------------------------------ 78ms Feb 22 11:56:18 volumio volumio[994]: info: Preload queue cleared Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::ClearQueue Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::stop Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::stPlaybackTimer Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::updateTrackBlock Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrackBlock Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::serviceStop Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::serviceStop Feb 22 11:56:18 volumio volumio[994]: info: ControllerMpd::stop Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand stop Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::clearPlayQueue Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::saveQueue Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::addQueueItems Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::addQueueItems Feb 22 11:56:18 volumio volumio[994]: info: Preload queue cleared Feb 22 11:56:18 volumio volumio[994]: info: Adding Item to queue: albums://%E3%83%86%E3%82%A4%E3%83%A9%E3%83%BC%E3%83%BB%E3%82%B9%E3%82%A6%E3%82%A3%E3%83%95%E3%83%88/THE%20TORTURED%20POETS%20DEPARTMENT Feb 22 11:56:18 volumio volumio[994]: info: Exploding uri albums://%E3%83%86%E3%82%A4%E3%83%A9%E3%83%BC%E3%83%BB%E3%82%B9%E3%82%A6%E3%82%A3%E3%83%95%E3%83%88/THE%20TORTURED%20POETS%20DEPARTMENT in service mpd Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::saveQueue Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::updateTrackBlock Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrackBlock Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::volumioPlay Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::play index 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::stop Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::play index undefined Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::startPlaybackTimer Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::clearAddPlayTracks USB/LEXAR256/Taylor Swift - THE TORTURED POETS DEPARTMENT [E] [M] (2024)/テイラー・スウィフト-All’s.fair.in.love.and.poetry....2024.480p.AM.WEB-DL.AAC.2.0.H.264-WASITWORTHIT.mp4 Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand stop Feb 22 11:56:18 volumio volumio[994]: info: sendMpdCommand stop took 20 milliseconds Feb 22 11:56:18 volumio volumio[994]: info: Feb 22 11:56:18 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:18 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:18 volumio volumio[994]: info: sendMpdCommand stop took 6 milliseconds Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand clear Feb 22 11:56:18 volumio volumio[994]: info: Feb 22 11:56:18 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:18 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:18 volumio volumio[994]: info: Feb 22 11:56:18 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:18 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:18 volumio volumio[994]: info: Feb 22 11:56:18 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:18 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:18 volumio volumio[994]: info: sendMpdCommand status took 3 milliseconds Feb 22 11:56:18 volumio volumio[994]: info: sendMpdCommand clear took 3 milliseconds Feb 22 11:56:18 volumio volumio[994]: info: sendMpdCommand status took 2 milliseconds Feb 22 11:56:18 volumio volumio[994]: info: sendMpdCommand status took 2 milliseconds Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand add "USB/LEXAR256/Taylor Swift - THE TORTURED POETS DEPARTMENT [E] [M] (2024)/テイラー・スウィフト-All’s.fair.in.love.and.poetry....2024.480p.AM.WEB-DL.AAC.2.0.H.264-WASITWORTHIT.mp4" Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:18 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 22 11:56:18 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::syncState stateService stop Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus stop Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:18 volumio volumio[994]: info: No code Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:18 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 22 11:56:18 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::syncState stateService stop Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus stop Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:18 volumio volumio[994]: info: No code Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:18 volumio volumio[994]: info: ------------------------------ 27ms Feb 22 11:56:18 volumio volumio[994]: info: ------------------------------ 26ms Feb 22 11:56:18 volumio volumio[994]: info: Feb 22 11:56:18 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:18 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:18 volumio volumio[994]: info: Feb 22 11:56:18 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:18 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:18 volumio volumio[994]: error: updateQueue error: null Feb 22 11:56:18 volumio volumio[994]: info: Feb 22 11:56:18 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:18 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:18 volumio volumio[994]: info: ------------------------------ 33ms Feb 22 11:56:18 volumio volumio[994]: info: sendMpdCommand playlistinfo took 32 milliseconds Feb 22 11:56:18 volumio volumio[994]: info: sendMpdCommand add "USB/LEXAR256/Taylor Swift - THE TORTURED POETS DEPARTMENT [E] [M] (2024)/テイラー・スウィフト-All’s.fair.in.love.and.poetry....2024.480p.AM.WEB-DL.AAC.2.0.H.264-WASITWORTHIT.mp4" took 32 milliseconds Feb 22 11:56:18 volumio volumio[994]: info: ------------------------------ 7ms Feb 22 11:56:18 volumio volumio[994]: info: ------------------------------ 7ms Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand play Feb 22 11:56:18 volumio volumio[994]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 22 11:56:18 volumio volumio[994]: info: ------------------------------ 39ms Feb 22 11:56:18 volumio volumio[994]: info: Feb 22 11:56:18 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:18 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:18 volumio volumio[994]: info: Feb 22 11:56:18 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:18 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:18 volumio volumio[994]: info: ------------------------------ 9ms Feb 22 11:56:18 volumio volumio[994]: info: sendMpdCommand play took 7 milliseconds Feb 22 11:56:18 volumio volumio[994]: info: ------------------------------ 6ms Feb 22 11:56:18 volumio volumio[994]: info: ------------------------------ 5ms Feb 22 11:56:18 volumio volumio[994]: info: Feb 22 11:56:18 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:18 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:18 volumio volumio[994]: info: Feb 22 11:56:18 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:18 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:18 volumio volumio[994]: info: Feb 22 11:56:18 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:18 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:18 volumio volumio[994]: info: Feb 22 11:56:18 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:18 volumio volumio[994]: info: sendMpdCommand status took 25 milliseconds Feb 22 11:56:18 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:18 volumio volumio[994]: info: sendMpdCommand status took 24 milliseconds Feb 22 11:56:18 volumio volumio[994]: info: sendMpdCommand status took 23 milliseconds Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:18 volumio volumio[994]: info: Feb 22 11:56:18 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:18 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:18 volumio volumio[994]: info: Feb 22 11:56:18 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:18 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:18 volumio volumio[994]: info: sendMpdCommand status took 5 milliseconds Feb 22 11:56:18 volumio volumio[994]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 22 11:56:18 volumio volumio[994]: info: sendMpdCommand playlistinfo took 5 milliseconds Feb 22 11:56:18 volumio volumio[994]: info: sendMpdCommand playlistinfo took 5 milliseconds Feb 22 11:56:18 volumio volumio[994]: info: sendMpdCommand status took 3 milliseconds Feb 22 11:56:18 volumio volumio[994]: info: sendMpdCommand status took 2 milliseconds Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:18 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":8,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2 Kbps","isStreaming":false,"title":"All’s fair in love and poetry...","artist":null,"album":"THE TORTURED POETS DEPARTMENT","uri":"USB/LEXAR256/Taylor Swift - THE TORTURED POETS DEPARTMENT [E] [M] (2024)/テイラー・スウィフト-All’s.fair.in.love.and.poetry....2024.480p.AM.WEB-DL.AAC.2.0.H.264-WASITWORTHIT.mp4","trackType":"mp4"} Feb 22 11:56:18 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus stop Feb 22 11:56:18 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":609,"duration":8,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2 Kbps","isStreaming":false,"title":"All’s fair in love and poetry...","artist":null,"album":"THE TORTURED POETS DEPARTMENT","uri":"USB/LEXAR256/Taylor Swift - THE TORTURED POETS DEPARTMENT [E] [M] (2024)/テイラー・スウィフト-All’s.fair.in.love.and.poetry....2024.480p.AM.WEB-DL.AAC.2.0.H.264-WASITWORTHIT.mp4","trackType":"mp4"} Feb 22 11:56:18 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Feb 22 11:56:18 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:18 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":609,"duration":8,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2 Kbps","isStreaming":false,"title":"All’s fair in love and poetry...","artist":null,"album":"THE TORTURED POETS DEPARTMENT","uri":"USB/LEXAR256/Taylor Swift - THE TORTURED POETS DEPARTMENT [E] [M] (2024)/テイラー・スウィフト-All’s.fair.in.love.and.poetry....2024.480p.AM.WEB-DL.AAC.2.0.H.264-WASITWORTHIT.mp4","trackType":"mp4"} Feb 22 11:56:18 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Feb 22 11:56:18 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:18 volumio volumio[994]: info: ------------------------------ 43ms Feb 22 11:56:18 volumio volumio[994]: info: ------------------------------ 53ms Feb 22 11:56:18 volumio volumio[994]: info: ------------------------------ 53ms Feb 22 11:56:18 volumio volumio[994]: info: sendMpdCommand playlistinfo took 23 milliseconds Feb 22 11:56:18 volumio volumio[994]: info: sendMpdCommand playlistinfo took 23 milliseconds Feb 22 11:56:18 volumio volumio[994]: info: sendMpdCommand playlistinfo took 23 milliseconds Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:18 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:18 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":987,"duration":8,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2 Kbps","isStreaming":false,"title":"All’s fair in love and poetry...","artist":null,"album":"THE TORTURED POETS DEPARTMENT","uri":"USB/LEXAR256/Taylor Swift - THE TORTURED POETS DEPARTMENT [E] [M] (2024)/テイラー・スウィフト-All’s.fair.in.love.and.poetry....2024.480p.AM.WEB-DL.AAC.2.0.H.264-WASITWORTHIT.mp4","trackType":"mp4"} Feb 22 11:56:18 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Feb 22 11:56:18 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:18 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":987,"duration":8,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2 Kbps","isStreaming":false,"title":"All’s fair in love and poetry...","artist":null,"album":"THE TORTURED POETS DEPARTMENT","uri":"USB/LEXAR256/Taylor Swift - THE TORTURED POETS DEPARTMENT [E] [M] (2024)/テイラー・スウィフト-All’s.fair.in.love.and.poetry....2024.480p.AM.WEB-DL.AAC.2.0.H.264-WASITWORTHIT.mp4","trackType":"mp4"} Feb 22 11:56:18 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Feb 22 11:56:18 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:18 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":987,"duration":8,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2 Kbps","isStreaming":false,"title":"All’s fair in love and poetry...","artist":null,"album":"THE TORTURED POETS DEPARTMENT","uri":"USB/LEXAR256/Taylor Swift - THE TORTURED POETS DEPARTMENT [E] [M] (2024)/テイラー・スウィフト-All’s.fair.in.love.and.poetry....2024.480p.AM.WEB-DL.AAC.2.0.H.264-WASITWORTHIT.mp4","trackType":"mp4"} Feb 22 11:56:18 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Feb 22 11:56:18 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:18 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:18 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:18 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:18 volumio volumio[994]: info: ------------------------------ 64ms Feb 22 11:56:18 volumio volumio[994]: info: ------------------------------ 61ms Feb 22 11:56:18 volumio volumio[994]: info: ------------------------------ 60ms Feb 22 11:56:20 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:20 volumio volumio[994]: info: CorePlayQueue::getTrack 1 Feb 22 11:56:20 volumio volumio[994]: info: Prefetching next song Feb 22 11:56:20 volumio volumio[994]: info: DOING PREFETCH IN MPD Feb 22 11:56:20 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand add "USB/LEXAR256/Taylor Swift - THE TORTURED POETS DEPARTMENT [E] [M] (2024)/01. テイラー・スウィフト - Fortnight (feat. Post Malone) [E] [M].m4a" Feb 22 11:56:20 volumio volumio[994]: info: sendMpdCommand add "USB/LEXAR256/Taylor Swift - THE TORTURED POETS DEPARTMENT [E] [M] (2024)/01. テイラー・スウィフト - Fortnight (feat. Post Malone) [E] [M].m4a" took 1 milliseconds Feb 22 11:56:20 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand consume 1 Feb 22 11:56:20 volumio volumio[994]: info: Feb 22 11:56:20 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:20 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:20 volumio volumio[994]: info: sendMpdCommand consume 1 took 1 milliseconds Feb 22 11:56:20 volumio volumio[994]: info: Feb 22 11:56:20 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:20 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:20 volumio volumio[994]: info: Feb 22 11:56:20 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:20 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:20 volumio volumio[994]: info: ------------------------------ 3ms Feb 22 11:56:20 volumio volumio[994]: info: ------------------------------ 2ms Feb 22 11:56:20 volumio volumio[994]: info: ------------------------------ 2ms Feb 22 11:56:24 volumio volumio[994]: info: CoreStateMachine::startPlaybackTimer Feb 22 11:56:24 volumio volumio[994]: info: CorePlayQueue::getTrack 1 Feb 22 11:56:25 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:25 volumio volumio[994]: info: CorePlayQueue::getTrack 1 Feb 22 11:56:25 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 11:56:25 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:25 volumio volumio[994]: info: Feb 22 11:56:25 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:25 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:25 volumio volumio[994]: info: Feb 22 11:56:25 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:25 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:25 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:25 volumio volumio[994]: info: Feb 22 11:56:25 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:25 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:25 volumio volumio[994]: info: Feb 22 11:56:25 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:25 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:25 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:25 volumio volumio[994]: info: Feb 22 11:56:25 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:25 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:25 volumio volumio[994]: info: Feb 22 11:56:25 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:25 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:25 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:25 volumio volumio[994]: info: ------------------------------ 4ms Feb 22 11:56:26 volumio kernel: xhci_hcd 0000:01:00.0: ERROR Transfer event for disabled endpoint slot 2 ep 1 Feb 22 11:56:26 volumio kernel: xhci_hcd 0000:01:00.0: @0000000429522c10 00000000 00000000 0e000000 02028000 Feb 22 11:56:26 volumio volumio[994]: info: sendMpdCommand status took 1024 milliseconds Feb 22 11:56:26 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:26 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:26 volumio volumio[994]: info: Feb 22 11:56:26 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:26 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:26 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:26 volumio volumio[994]: info: ------------------------------ 1027ms Feb 22 11:56:26 volumio volumio[994]: info: sendMpdCommand status took 1026 milliseconds Feb 22 11:56:26 volumio volumio[994]: info: ------------------------------ 1026ms Feb 22 11:56:26 volumio volumio[994]: info: sendMpdCommand status took 1025 milliseconds Feb 22 11:56:26 volumio volumio[994]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 22 11:56:26 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:26 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:26 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:26 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:26 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:26 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:26 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:26 volumio volumio[994]: info: CorePlayQueue::getTrack 1 Feb 22 11:56:26 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":"48 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1716 Kbps","isStreaming":false,"title":"Fortnight (feat. Post Malone)","artist":"テイラー・スウィフト","album":"THE TORTURED POETS DEPARTMENT","uri":"USB/LEXAR256/Taylor Swift - THE TORTURED POETS DEPARTMENT [E] [M] (2024)/01. テイラー・スウィフト - Fortnight (feat. Post Malone) [E] [M].m4a","trackType":"m4a"} Feb 22 11:56:26 volumio volumio[994]: verbose: CURRENT POSITION 1 Feb 22 11:56:26 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:26 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Feb 22 11:56:26 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Feb 22 11:56:26 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:26 volumio volumio[994]: info: CorePlayQueue::getTrack 1 Feb 22 11:56:26 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 11:56:26 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:26 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:26 volumio volumio[994]: info: CorePlayQueue::getTrack 1 Feb 22 11:56:26 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:26 volumio volumio[994]: info: ------------------------------ 1040ms Feb 22 11:56:26 volumio volumio[994]: info: Feb 22 11:56:26 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:26 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:26 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:26 volumio volumio[994]: info: Feb 22 11:56:26 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:26 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:26 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:26 volumio volumio[994]: info: sendMpdCommand status took 15 milliseconds Feb 22 11:56:26 volumio volumio[994]: info: sendMpdCommand playlistinfo took 14 milliseconds Feb 22 11:56:26 volumio volumio[994]: info: sendMpdCommand playlistinfo took 15 milliseconds Feb 22 11:56:26 volumio volumio[994]: info: sendMpdCommand status took 3 milliseconds Feb 22 11:56:26 volumio volumio[994]: info: sendMpdCommand status took 2 milliseconds Feb 22 11:56:26 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:26 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:26 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:26 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:26 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:26 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:26 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:26 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:26 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:26 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:26 volumio volumio[994]: info: CorePlayQueue::getTrack 1 Feb 22 11:56:26 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":"48 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1716 Kbps","isStreaming":false,"title":"Fortnight (feat. Post Malone)","artist":"テイラー・スウィフト","album":"THE TORTURED POETS DEPARTMENT","uri":"USB/LEXAR256/Taylor Swift - THE TORTURED POETS DEPARTMENT [E] [M] (2024)/01. テイラー・スウィフト - Fortnight (feat. Post Malone) [E] [M].m4a","trackType":"m4a"} Feb 22 11:56:26 volumio volumio[994]: verbose: CURRENT POSITION 1 Feb 22 11:56:26 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:26 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Feb 22 11:56:26 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Feb 22 11:56:26 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:26 volumio volumio[994]: info: CorePlayQueue::getTrack 1 Feb 22 11:56:26 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:26 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:26 volumio volumio[994]: info: CorePlayQueue::getTrack 1 Feb 22 11:56:26 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:26 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:26 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:26 volumio volumio[994]: info: CorePlayQueue::getTrack 1 Feb 22 11:56:26 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":115,"duration":229,"samplerate":"48 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1716 Kbps","isStreaming":false,"title":"Fortnight (feat. Post Malone)","artist":"テイラー・スウィフト","album":"THE TORTURED POETS DEPARTMENT","uri":"USB/LEXAR256/Taylor Swift - THE TORTURED POETS DEPARTMENT [E] [M] (2024)/01. テイラー・スウィフト - Fortnight (feat. Post Malone) [E] [M].m4a","trackType":"m4a"} Feb 22 11:56:26 volumio volumio[994]: verbose: CURRENT POSITION 1 Feb 22 11:56:26 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:26 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Feb 22 11:56:26 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Feb 22 11:56:26 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:26 volumio volumio[994]: info: CorePlayQueue::getTrack 1 Feb 22 11:56:26 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 11:56:26 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:26 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:26 volumio volumio[994]: info: CorePlayQueue::getTrack 1 Feb 22 11:56:26 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:26 volumio volumio[994]: info: ------------------------------ 1064ms Feb 22 11:56:26 volumio volumio[994]: info: ------------------------------ 1063ms Feb 22 11:56:26 volumio volumio[994]: info: sendMpdCommand playlistinfo took 24 milliseconds Feb 22 11:56:26 volumio volumio[994]: info: sendMpdCommand playlistinfo took 25 milliseconds Feb 22 11:56:26 volumio volumio[994]: info: sendMpdCommand playlistinfo took 24 milliseconds Feb 22 11:56:26 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:26 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:26 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:26 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:26 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:26 volumio volumio[994]: info: CorePlayQueue::getTrack 1 Feb 22 11:56:26 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":229,"samplerate":"48 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1716 Kbps","isStreaming":false,"title":"Fortnight (feat. Post Malone)","artist":"テイラー・スウィフト","album":"THE TORTURED POETS DEPARTMENT","uri":"USB/LEXAR256/Taylor Swift - THE TORTURED POETS DEPARTMENT [E] [M] (2024)/01. テイラー・スウィフト - Fortnight (feat. Post Malone) [E] [M].m4a","trackType":"m4a"} Feb 22 11:56:26 volumio volumio[994]: verbose: CURRENT POSITION 1 Feb 22 11:56:26 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:26 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Feb 22 11:56:26 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Feb 22 11:56:26 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:26 volumio volumio[994]: info: CorePlayQueue::getTrack 1 Feb 22 11:56:26 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 11:56:26 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:26 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:26 volumio volumio[994]: info: CorePlayQueue::getTrack 1 Feb 22 11:56:26 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:26 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:26 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:26 volumio volumio[994]: info: CorePlayQueue::getTrack 1 Feb 22 11:56:26 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":229,"samplerate":"48 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1716 Kbps","isStreaming":false,"title":"Fortnight (feat. Post Malone)","artist":"テイラー・スウィフト","album":"THE TORTURED POETS DEPARTMENT","uri":"USB/LEXAR256/Taylor Swift - THE TORTURED POETS DEPARTMENT [E] [M] (2024)/01. テイラー・スウィフト - Fortnight (feat. Post Malone) [E] [M].m4a","trackType":"m4a"} Feb 22 11:56:26 volumio volumio[994]: verbose: CURRENT POSITION 1 Feb 22 11:56:26 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:26 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Feb 22 11:56:26 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Feb 22 11:56:26 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:26 volumio volumio[994]: info: CorePlayQueue::getTrack 1 Feb 22 11:56:26 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:26 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:26 volumio volumio[994]: info: CorePlayQueue::getTrack 1 Feb 22 11:56:26 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:26 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:26 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:26 volumio volumio[994]: info: CorePlayQueue::getTrack 1 Feb 22 11:56:26 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":229,"samplerate":"48 kHz","bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1716 Kbps","isStreaming":false,"title":"Fortnight (feat. Post Malone)","artist":"テイラー・スウィフト","album":"THE TORTURED POETS DEPARTMENT","uri":"USB/LEXAR256/Taylor Swift - THE TORTURED POETS DEPARTMENT [E] [M] (2024)/01. テイラー・スウィフト - Fortnight (feat. Post Malone) [E] [M].m4a","trackType":"m4a"} Feb 22 11:56:26 volumio volumio[994]: verbose: CURRENT POSITION 1 Feb 22 11:56:26 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:26 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Feb 22 11:56:26 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Feb 22 11:56:26 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:26 volumio volumio[994]: info: CorePlayQueue::getTrack 1 Feb 22 11:56:26 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:26 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:26 volumio volumio[994]: info: CorePlayQueue::getTrack 1 Feb 22 11:56:26 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:26 volumio volumio[994]: info: ------------------------------ 71ms Feb 22 11:56:26 volumio volumio[994]: info: ------------------------------ 56ms Feb 22 11:56:26 volumio volumio[994]: info: ------------------------------ 56ms Feb 22 11:56:54 volumio volumio[994]: info: Preload queue cleared Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::ClearQueue Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::stop Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::stPlaybackTimer Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::updateTrackBlock Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrackBlock Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 1 Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::serviceStop Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 1 Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::serviceStop Feb 22 11:56:54 volumio volumio[994]: info: ControllerMpd::stop Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand stop Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::clearPlayQueue Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::saveQueue Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::addQueueItems Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::addQueueItems Feb 22 11:56:54 volumio volumio[994]: info: Preload queue cleared Feb 22 11:56:54 volumio volumio[994]: info: Adding Item to queue: albums://%E5%AE%AB%E8%B0%B7%E7%90%86%E9%A6%99/%E5%AE%AB%E8%B0%B7%E7%90%86%E9%A6%99%E6%BC%94%E7%BB%8E%E5%B9%BB%E6%83%B3%E7%B3%BB%E5%88%97%E2%80%9C%E5%89%8D%E5%A5%8F%E6%9B%B2%E2%80%9D Feb 22 11:56:54 volumio volumio[994]: info: Exploding uri albums://%E5%AE%AB%E8%B0%B7%E7%90%86%E9%A6%99/%E5%AE%AB%E8%B0%B7%E7%90%86%E9%A6%99%E6%BC%94%E7%BB%8E%E5%B9%BB%E6%83%B3%E7%B3%BB%E5%88%97%E2%80%9C%E5%89%8D%E5%A5%8F%E6%9B%B2%E2%80%9D in service mpd Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushQueue Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::saveQueue Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::updateTrackBlock Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrackBlock Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::volumioPlay Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::play index 0 Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::stop Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::play index undefined Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::startPlaybackTimer Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::clearAddPlayTracks USB/LEXAR256/宫谷理香演绎幻想系列“前奏曲”(24192)/01 - The Well-Tempered Clavier, Book I_ No. 1 in C Major Prelude I.flac Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand stop Feb 22 11:56:54 volumio volumio[994]: info: sendMpdCommand stop took 22 milliseconds Feb 22 11:56:54 volumio volumio[994]: info: Feb 22 11:56:54 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:54 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:54 volumio volumio[994]: info: sendMpdCommand stop took 7 milliseconds Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand clear Feb 22 11:56:54 volumio volumio[994]: info: Feb 22 11:56:54 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:54 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:54 volumio volumio[994]: info: Feb 22 11:56:54 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:54 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:54 volumio volumio[994]: info: Feb 22 11:56:54 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:54 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:54 volumio volumio[994]: info: sendMpdCommand status took 3 milliseconds Feb 22 11:56:54 volumio volumio[994]: info: sendMpdCommand clear took 3 milliseconds Feb 22 11:56:54 volumio volumio[994]: info: sendMpdCommand status took 2 milliseconds Feb 22 11:56:54 volumio volumio[994]: info: sendMpdCommand status took 2 milliseconds Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand add "USB/LEXAR256/宫谷理香演绎幻想系列“前奏曲”(24192)/01 - The Well-Tempered Clavier, Book I_ No. 1 in C Major Prelude I.flac" Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:54 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:54 volumio volumio[994]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 22 11:56:54 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::syncState stateService stop Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus stop Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:54 volumio volumio[994]: info: No code Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:54 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:54 volumio volumio[994]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 22 11:56:54 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::syncState stateService stop Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus stop Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:54 volumio volumio[994]: info: No code Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:54 volumio volumio[994]: info: ------------------------------ 31ms Feb 22 11:56:54 volumio volumio[994]: info: ------------------------------ 31ms Feb 22 11:56:54 volumio volumio[994]: info: Feb 22 11:56:54 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:54 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:54 volumio volumio[994]: info: Feb 22 11:56:54 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:54 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:54 volumio volumio[994]: error: updateQueue error: null Feb 22 11:56:54 volumio volumio[994]: info: Feb 22 11:56:54 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:54 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:54 volumio volumio[994]: info: ------------------------------ 33ms Feb 22 11:56:54 volumio volumio[994]: info: sendMpdCommand playlistinfo took 30 milliseconds Feb 22 11:56:54 volumio volumio[994]: info: sendMpdCommand add "USB/LEXAR256/宫谷理香演绎幻想系列“前奏曲”(24192)/01 - The Well-Tempered Clavier, Book I_ No. 1 in C Major Prelude I.flac" took 31 milliseconds Feb 22 11:56:54 volumio volumio[994]: info: ------------------------------ 4ms Feb 22 11:56:54 volumio volumio[994]: info: ------------------------------ 3ms Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand play Feb 22 11:56:54 volumio volumio[994]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 22 11:56:54 volumio volumio[994]: info: ------------------------------ 38ms Feb 22 11:56:54 volumio volumio[994]: info: Feb 22 11:56:54 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:54 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:54 volumio volumio[994]: info: Feb 22 11:56:54 volumio volumio[994]: ---------------------------- MPD announces system playlist update Feb 22 11:56:54 volumio volumio[994]: info: Ignoring MPD Status Update Feb 22 11:56:54 volumio volumio[994]: info: Feb 22 11:56:54 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:54 volumio volumio[994]: info: ------------------------------ 11ms Feb 22 11:56:54 volumio volumio[994]: info: sendMpdCommand play took 10 milliseconds Feb 22 11:56:54 volumio volumio[994]: info: ------------------------------ 10ms Feb 22 11:56:54 volumio volumio[994]: info: ------------------------------ 9ms Feb 22 11:56:54 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:54 volumio volumio[994]: info: Feb 22 11:56:54 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:54 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:54 volumio volumio[994]: info: Feb 22 11:56:54 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:54 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:54 volumio volumio[994]: info: sendMpdCommand status took 15 milliseconds Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:54 volumio volumio[994]: info: Feb 22 11:56:54 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:54 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:54 volumio volumio[994]: info: sendMpdCommand status took 16 milliseconds Feb 22 11:56:54 volumio volumio[994]: info: sendMpdCommand status took 15 milliseconds Feb 22 11:56:54 volumio volumio[994]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:54 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:54 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":145,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Well-Tempered Clavier, Book I: No. 1 in C Major Prelude I","artist":"宫谷理香","album":"宫谷理香演绎幻想系列“前奏曲”","uri":"USB/LEXAR256/宫谷理香演绎幻想系列“前奏曲”(24192)/01 - The Well-Tempered Clavier, Book I_ No. 1 in C Major Prelude I.flac","trackType":"flac"} Feb 22 11:56:54 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus stop Feb 22 11:56:54 volumio volumio[994]: info: ------------------------------ 22ms Feb 22 11:56:54 volumio volumio[994]: info: Feb 22 11:56:54 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:54 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:54 volumio volumio[994]: info: Feb 22 11:56:54 volumio volumio[994]: ---------------------------- MPD announces state update: player Feb 22 11:56:54 volumio volumio[994]: info: ControllerMpd::getState Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand status Feb 22 11:56:54 volumio volumio[994]: info: sendMpdCommand status took 6 milliseconds Feb 22 11:56:54 volumio volumio[994]: info: sendMpdCommand playlistinfo took 5 milliseconds Feb 22 11:56:54 volumio volumio[994]: info: sendMpdCommand playlistinfo took 5 milliseconds Feb 22 11:56:54 volumio volumio[994]: info: sendMpdCommand status took 3 milliseconds Feb 22 11:56:54 volumio volumio[994]: info: sendMpdCommand status took 2 milliseconds Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::parseState Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 22 11:56:54 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:54 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":145,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Well-Tempered Clavier, Book I: No. 1 in C Major Prelude I","artist":"宫谷理香","album":"宫谷理香演绎幻想系列“前奏曲”","uri":"USB/LEXAR256/宫谷理香演绎幻想系列“前奏曲”(24192)/01 - The Well-Tempered Clavier, Book I_ No. 1 in C Major Prelude I.flac","trackType":"flac"} Feb 22 11:56:54 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Feb 22 11:56:54 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:54 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:54 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":145,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Well-Tempered Clavier, Book I: No. 1 in C Major Prelude I","artist":"宫谷理香","album":"宫谷理香演绎幻想系列“前奏曲”","uri":"USB/LEXAR256/宫谷理香演绎幻想系列“前奏曲”(24192)/01 - The Well-Tempered Clavier, Book I_ No. 1 in C Major Prelude I.flac","trackType":"flac"} Feb 22 11:56:54 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Feb 22 11:56:54 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:54 volumio volumio[994]: info: ------------------------------ 51ms Feb 22 11:56:54 volumio volumio[994]: info: ------------------------------ 51ms Feb 22 11:56:54 volumio volumio[994]: info: sendMpdCommand playlistinfo took 28 milliseconds Feb 22 11:56:54 volumio volumio[994]: info: sendMpdCommand playlistinfo took 28 milliseconds Feb 22 11:56:54 volumio volumio[994]: info: sendMpdCommand playlistinfo took 28 milliseconds Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:54 volumio volumio[994]: verbose: ControllerMpd::parseTrackInfo Feb 22 11:56:54 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:54 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":145,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Well-Tempered Clavier, Book I: No. 1 in C Major Prelude I","artist":"宫谷理香","album":"宫谷理香演绎幻想系列“前奏曲”","uri":"USB/LEXAR256/宫谷理香演绎幻想系列“前奏曲”(24192)/01 - The Well-Tempered Clavier, Book I_ No. 1 in C Major Prelude I.flac","trackType":"flac"} Feb 22 11:56:54 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Feb 22 11:56:54 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:54 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:54 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":145,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Well-Tempered Clavier, Book I: No. 1 in C Major Prelude I","artist":"宫谷理香","album":"宫谷理香演绎幻想系列“前奏曲”","uri":"USB/LEXAR256/宫谷理香演绎幻想系列“前奏曲”(24192)/01 - The Well-Tempered Clavier, Book I_ No. 1 in C Major Prelude I.flac","trackType":"flac"} Feb 22 11:56:54 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Feb 22 11:56:54 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:54 volumio volumio[994]: info: ControllerMpd::pushState Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::servicePushState Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:54 volumio volumio[994]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":145,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Well-Tempered Clavier, Book I: No. 1 in C Major Prelude I","artist":"宫谷理香","album":"宫谷理香演绎幻想系列“前奏曲”","uri":"USB/LEXAR256/宫谷理香演绎幻想系列“前奏曲”(24192)/01 - The Well-Tempered Clavier, Book I_ No. 1 in C Major Prelude I.flac","trackType":"flac"} Feb 22 11:56:54 volumio volumio[994]: verbose: CURRENT POSITION 0 Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::syncState stateService play Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::syncState currentStatus play Feb 22 11:56:54 volumio volumio[994]: info: Received an update from plugin. extracting info from payload Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:54 volumio volumio[994]: info: CoreStateMachine::pushState Feb 22 11:56:54 volumio volumio[994]: info: CorePlayQueue::getTrack 0 Feb 22 11:56:54 volumio volumio[994]: info: CoreCommandRouter::volumioPushState Feb 22 11:56:54 volumio volumio[994]: info: ------------------------------ 71ms Feb 22 11:56:54 volumio volumio[994]: info: ------------------------------ 66ms Feb 22 11:56:54 volumio volumio[994]: info: ------------------------------ 66ms Feb 22 11:57:35 volumio volumio[994]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 11:57:35 volumio volumio[994]: Error: connect ETIMEDOUT 108.160.165.62:443 Feb 22 11:57:35 volumio volumio[994]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Feb 22 11:57:35 volumio volumio[994]: errno: -110, Feb 22 11:57:35 volumio volumio[994]: code: 'ETIMEDOUT', Feb 22 11:57:35 volumio volumio[994]: syscall: 'connect', Feb 22 11:57:35 volumio volumio[994]: address: '108.160.165.62', Feb 22 11:57:35 volumio volumio[994]: port: 443 Feb 22 11:57:35 volumio volumio[994]: } Feb 22 11:57:35 volumio volumio[994]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 11:57:35 volumio sudo[8220]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-22 11:56 Feb 22 11:57:35 volumio sudo[8220]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"