-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Tue 2026-06-02 10:48:55 CST. -- Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Preload queue cleared Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::ClearQueue Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::stop Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::stPlaybackTimer Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::updateTrackBlock Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrackBlock Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::serviceStop Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreCommandRouter::serviceStop Jun 02 10:47:01 smsl-n100 volumio[1436]: info: ControllerMpd::stop Jun 02 10:47:01 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CorePlayQueue::clearPlayQueue Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CorePlayQueue::saveQueue Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::addQueueItems Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CorePlayQueue::addQueueItems Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Preload queue cleared Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/01 La Risata del Diavolo (tema).flac Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/01 La Risata del Diavolo (tema).flac Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/02 La Campanella - Rondo dal Concerto per violino e orchestra n.2 in si minore.flac Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/02 La Campanella - Rondo dal Concerto per violino e orchestra n.2 in si minore.flac Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/03 Capriccio per violino solo n.5 in la minore - Agitato.flac Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/03 Capriccio per violino solo n.5 in la minore - Agitato.flac Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/04 Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore.flac Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/04 Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore.flac Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/05 Introduzione e variazioni su [[God Save the King]] op.9.flac Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/05 Introduzione e variazioni su [[God Save the King]] op.9.flac Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/06 Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale.flac Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/06 Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale.flac Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CorePlayQueue::saveQueue Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::updateTrackBlock Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrackBlock Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPlay Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::play index 5 Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::addQueueItems Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CorePlayQueue::addQueueItems Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Preload queue cleared Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/07 Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore.flac Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/07 Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore.flac Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/08 Capriccio per violino solo n.1 in mi maggiore - Andante.flac Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/08 Capriccio per violino solo n.1 in mi maggiore - Andante.flac Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/10 Sonata Moto Perpetuo - Allegro Vivace.flac Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/10 Sonata Moto Perpetuo - Allegro Vivace.flac Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::stop Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CorePlayQueue::saveQueue Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::play index undefined Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::updateTrackBlock Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrackBlock Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::startPlaybackTimer Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:01 smsl-n100 volumio[1436]: verbose: ControllerMpd::clearAddPlayTracks NAS/CD/Diabolus in Musica/06 Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale.flac Jun 02 10:47:01 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Jun 02 10:47:01 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:01 smsl-n100 volumio[1436]: info: sendMpdCommand stop took 115 milliseconds Jun 02 10:47:01 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:01 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:01 smsl-n100 volumio[1436]: info: sendMpdCommand stop took 27 milliseconds Jun 02 10:47:01 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand clear Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Jun 02 10:47:01 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:01 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:01 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Jun 02 10:47:01 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:01 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:01 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Jun 02 10:47:01 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:01 smsl-n100 volumio[1436]: info: sendMpdCommand status took 31 milliseconds Jun 02 10:47:01 smsl-n100 volumio[1436]: info: sendMpdCommand clear took 29 milliseconds Jun 02 10:47:01 smsl-n100 volumio[1436]: info: sendMpdCommand status took 26 milliseconds Jun 02 10:47:01 smsl-n100 volumio[1436]: info: sendMpdCommand status took 21 milliseconds Jun 02 10:47:01 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:01 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:01 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand add "NAS/CD/Diabolus in Musica/06 Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale.flac" Jun 02 10:47:01 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:01 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:01 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:01 smsl-n100 volumio[1436]: 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} Jun 02 10:47:01 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 5 Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService stop Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:01 smsl-n100 volumio[1436]: info: No code Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:01 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:01 smsl-n100 volumio[1436]: 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} Jun 02 10:47:01 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 5 Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService stop Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:01 smsl-n100 volumio[1436]: info: No code Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:01 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:01 smsl-n100 volumio[1436]: info: ------------------------------ 144ms Jun 02 10:47:01 smsl-n100 volumio[1436]: info: ------------------------------ 142ms Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Jun 02 10:47:01 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Jun 02 10:47:01 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:01 smsl-n100 volumio[1436]: error: updateQueue error: null Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Jun 02 10:47:01 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:01 smsl-n100 volumio[1436]: info: ------------------------------ 142ms Jun 02 10:47:01 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 133 milliseconds Jun 02 10:47:01 smsl-n100 volumio[1436]: info: sendMpdCommand add "NAS/CD/Diabolus in Musica/06 Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale.flac" took 133 milliseconds Jun 02 10:47:01 smsl-n100 volumio[1436]: info: ------------------------------ 18ms Jun 02 10:47:01 smsl-n100 volumio[1436]: info: ------------------------------ 15ms Jun 02 10:47:01 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:01 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand play Jun 02 10:47:01 smsl-n100 volumio[1436]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 02 10:47:01 smsl-n100 volumio[1436]: info: ------------------------------ 186ms Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Jun 02 10:47:01 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:01 smsl-n100 volumio[1436]: info: Jun 02 10:47:01 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:02 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:02 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:02 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:47:02 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:02 smsl-n100 volumio[1436]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:47:02 smsl-n100 volumio[1436]: info: Jun 02 10:47:02 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:02 smsl-n100 volumio[1436]: info: ------------------------------ 97ms Jun 02 10:47:02 smsl-n100 volumio[1436]: info: sendMpdCommand play took 88 milliseconds Jun 02 10:47:02 smsl-n100 volumio[1436]: info: ------------------------------ 83ms Jun 02 10:47:02 smsl-n100 volumio[1436]: info: ------------------------------ 79ms Jun 02 10:47:02 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:02 smsl-n100 volumio[1436]: info: Jun 02 10:47:02 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:02 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:02 smsl-n100 volumio[1436]: info: sendMpdCommand status took 11 milliseconds Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:02 smsl-n100 volumio[1436]: info: Jun 02 10:47:02 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:02 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:02 smsl-n100 volumio[1436]: info: Jun 02 10:47:02 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:02 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:02 smsl-n100 volumio[1436]: info: sendMpdCommand status took 39 milliseconds Jun 02 10:47:02 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 33 milliseconds Jun 02 10:47:02 smsl-n100 volumio[1436]: info: sendMpdCommand status took 15 milliseconds Jun 02 10:47:02 smsl-n100 volumio[1436]: info: sendMpdCommand status took 10 milliseconds Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:02 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":269,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/06 Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale.flac","trackType":"flac"} Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 5 Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:47:02 smsl-n100 volumio[1436]: info: ------------------------------ 87ms Jun 02 10:47:02 smsl-n100 volumio[1436]: info: Jun 02 10:47:02 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:02 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:02 smsl-n100 volumio[1436]: info: Jun 02 10:47:02 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:02 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:02 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 38 milliseconds Jun 02 10:47:02 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 36 milliseconds Jun 02 10:47:02 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 34 milliseconds Jun 02 10:47:02 smsl-n100 volumio[1436]: info: sendMpdCommand status took 21 milliseconds Jun 02 10:47:02 smsl-n100 volumio[1436]: info: sendMpdCommand status took 16 milliseconds Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:02 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":269,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"670 Kbps","isStreaming":false,"title":"Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/06 Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale.flac","trackType":"flac"} Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 5 Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:02 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":269,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"670 Kbps","isStreaming":false,"title":"Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/06 Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale.flac","trackType":"flac"} Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 5 Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:02 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":269,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"670 Kbps","isStreaming":false,"title":"Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/06 Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale.flac","trackType":"flac"} Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 5 Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:02 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: ------------------------------ 274ms Jun 02 10:47:02 smsl-n100 volumio[1436]: info: ------------------------------ 250ms Jun 02 10:47:02 smsl-n100 volumio[1436]: info: ------------------------------ 246ms Jun 02 10:47:02 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 173 milliseconds Jun 02 10:47:02 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 173 milliseconds Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:02 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":269,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"670 Kbps","isStreaming":false,"title":"Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/06 Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale.flac","trackType":"flac"} Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 5 Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:02 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":269,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"670 Kbps","isStreaming":false,"title":"Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/06 Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale.flac","trackType":"flac"} Jun 02 10:47:02 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 5 Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:02 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: ------------------------------ 328ms Jun 02 10:47:02 smsl-n100 volumio[1436]: info: ------------------------------ 325ms Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:02 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:02 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:02 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:47:02 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:02 smsl-n100 volumio[1436]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:47:04 smsl-n100 volumio[1436]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jun 02 10:47:04 smsl-n100 volumio[1436]: info: Retrying Login Due to Network Error Jun 02 10:47:10 smsl-n100 volumio[1436]: info: Listing playlists Jun 02 10:47:12 smsl-n100 volumio[1436]: info: Saving local item Chi Jun 02 10:47:12 smsl-n100 volumio[1436]: info: Pushing Favourites {"uri":"/mnt/NAS/CD/Diabolus in Musica/06 Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale.flac","favourite":false} Jun 02 10:47:12 smsl-n100 volumio[1436]: info: Listing playlists Jun 02 10:47:14 smsl-n100 volumio[1436]: info: MyVolumio login type: Token Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Preload queue cleared Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::ClearQueue Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::stop Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::stPlaybackTimer Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::updateTrackBlock Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrackBlock Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::serviceStop Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 5 Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreCommandRouter::serviceStop Jun 02 10:47:16 smsl-n100 volumio[1436]: info: ControllerMpd::stop Jun 02 10:47:16 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CorePlayQueue::clearPlayQueue Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CorePlayQueue::saveQueue Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::addQueueItems Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CorePlayQueue::addQueueItems Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Preload queue cleared Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/01 La Risata del Diavolo (tema).flac Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/01 La Risata del Diavolo (tema).flac Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/02 La Campanella - Rondo dal Concerto per violino e orchestra n.2 in si minore.flac Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/02 La Campanella - Rondo dal Concerto per violino e orchestra n.2 in si minore.flac Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/03 Capriccio per violino solo n.5 in la minore - Agitato.flac Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/03 Capriccio per violino solo n.5 in la minore - Agitato.flac Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/04 Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore.flac Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/04 Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore.flac Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/05 Introduzione e variazioni su [[God Save the King]] op.9.flac Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/05 Introduzione e variazioni su [[God Save the King]] op.9.flac Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/06 Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale.flac Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/06 Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale.flac Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/07 Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore.flac Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/07 Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore.flac Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/08 Capriccio per violino solo n.1 in mi maggiore - Andante.flac Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/08 Capriccio per violino solo n.1 in mi maggiore - Andante.flac Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CorePlayQueue::saveQueue Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::updateTrackBlock Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrackBlock Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPlay Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::play index 8 Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::addQueueItems Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CorePlayQueue::addQueueItems Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Preload queue cleared Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/10 Sonata Moto Perpetuo - Allegro Vivace.flac Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/10 Sonata Moto Perpetuo - Allegro Vivace.flac Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::stop Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CorePlayQueue::saveQueue Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::play index undefined Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::updateTrackBlock Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrackBlock Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::startPlaybackTimer Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:16 smsl-n100 volumio[1436]: verbose: ControllerMpd::clearAddPlayTracks NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac Jun 02 10:47:16 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Jun 02 10:47:16 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:16 smsl-n100 volumio[1436]: info: sendMpdCommand stop took 113 milliseconds Jun 02 10:47:16 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:16 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:16 smsl-n100 volumio[1436]: info: sendMpdCommand stop took 30 milliseconds Jun 02 10:47:16 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand clear Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Jun 02 10:47:16 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:16 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:16 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Jun 02 10:47:16 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:16 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:16 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Jun 02 10:47:16 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:16 smsl-n100 volumio[1436]: info: sendMpdCommand status took 23 milliseconds Jun 02 10:47:16 smsl-n100 volumio[1436]: info: sendMpdCommand clear took 21 milliseconds Jun 02 10:47:16 smsl-n100 volumio[1436]: info: sendMpdCommand status took 17 milliseconds Jun 02 10:47:16 smsl-n100 volumio[1436]: info: sendMpdCommand status took 13 milliseconds Jun 02 10:47:16 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:16 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:16 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand add "NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac" Jun 02 10:47:16 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:16 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:16 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:16 smsl-n100 volumio[1436]: 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} Jun 02 10:47:16 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 8 Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService stop Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:16 smsl-n100 volumio[1436]: info: No code Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:16 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:16 smsl-n100 volumio[1436]: 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} Jun 02 10:47:16 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 8 Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService stop Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:16 smsl-n100 volumio[1436]: info: No code Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:16 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:16 smsl-n100 volumio[1436]: info: ------------------------------ 137ms Jun 02 10:47:16 smsl-n100 volumio[1436]: info: ------------------------------ 135ms Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Jun 02 10:47:16 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Jun 02 10:47:16 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:16 smsl-n100 volumio[1436]: error: updateQueue error: null Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Jun 02 10:47:16 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:16 smsl-n100 volumio[1436]: info: ------------------------------ 153ms Jun 02 10:47:16 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 145 milliseconds Jun 02 10:47:16 smsl-n100 volumio[1436]: info: sendMpdCommand add "NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac" took 145 milliseconds Jun 02 10:47:16 smsl-n100 volumio[1436]: info: ------------------------------ 27ms Jun 02 10:47:16 smsl-n100 volumio[1436]: info: ------------------------------ 18ms Jun 02 10:47:16 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:16 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand play Jun 02 10:47:16 smsl-n100 volumio[1436]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 02 10:47:16 smsl-n100 volumio[1436]: info: ------------------------------ 188ms Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Jun 02 10:47:16 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Jun 02 10:47:16 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:16 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:17 smsl-n100 volumio[1436]: info: Jun 02 10:47:17 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:17 smsl-n100 volumio[1436]: info: ------------------------------ 94ms Jun 02 10:47:17 smsl-n100 volumio[1436]: info: sendMpdCommand play took 84 milliseconds Jun 02 10:47:17 smsl-n100 volumio[1436]: info: ------------------------------ 81ms Jun 02 10:47:17 smsl-n100 volumio[1436]: info: ------------------------------ 77ms Jun 02 10:47:17 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:17 smsl-n100 volumio[1436]: info: Jun 02 10:47:17 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:17 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:17 smsl-n100 volumio[1436]: info: Jun 02 10:47:17 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:17 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:17 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:17 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:47:17 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:17 smsl-n100 volumio[1436]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:47:17 smsl-n100 volumio[1436]: info: Jun 02 10:47:17 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:17 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:17 smsl-n100 volumio[1436]: info: sendMpdCommand status took 59 milliseconds Jun 02 10:47:17 smsl-n100 volumio[1436]: info: sendMpdCommand status took 54 milliseconds Jun 02 10:47:17 smsl-n100 volumio[1436]: info: sendMpdCommand status took 49 milliseconds Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:17 smsl-n100 volumio[1436]: info: Jun 02 10:47:17 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:17 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:17 smsl-n100 volumio[1436]: info: Jun 02 10:47:17 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:17 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:17 smsl-n100 volumio[1436]: info: sendMpdCommand status took 55 milliseconds Jun 02 10:47:17 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 42 milliseconds Jun 02 10:47:17 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 40 milliseconds Jun 02 10:47:17 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 40 milliseconds Jun 02 10:47:17 smsl-n100 volumio[1436]: info: sendMpdCommand status took 32 milliseconds Jun 02 10:47:17 smsl-n100 volumio[1436]: info: sendMpdCommand status took 27 milliseconds Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:17 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":587,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"403 Kbps","isStreaming":false,"title":"Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac","trackType":"flac"} Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 8 Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:47:17 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":587,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"403 Kbps","isStreaming":false,"title":"Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac","trackType":"flac"} Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 8 Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:17 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":587,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"403 Kbps","isStreaming":false,"title":"Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac","trackType":"flac"} Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 8 Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:17 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: ------------------------------ 219ms Jun 02 10:47:17 smsl-n100 volumio[1436]: info: ------------------------------ 252ms Jun 02 10:47:17 smsl-n100 volumio[1436]: info: ------------------------------ 249ms Jun 02 10:47:17 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 139 milliseconds Jun 02 10:47:17 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 134 milliseconds Jun 02 10:47:17 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 132 milliseconds Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:17 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":587,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"414 Kbps","isStreaming":false,"title":"Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac","trackType":"flac"} Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 8 Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:17 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":587,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"414 Kbps","isStreaming":false,"title":"Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac","trackType":"flac"} Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 8 Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:17 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":587,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"414 Kbps","isStreaming":false,"title":"Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac","trackType":"flac"} Jun 02 10:47:17 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 8 Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:17 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: ------------------------------ 378ms Jun 02 10:47:17 smsl-n100 volumio[1436]: info: ------------------------------ 351ms Jun 02 10:47:17 smsl-n100 volumio[1436]: info: ------------------------------ 348ms Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:17 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:17 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:17 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:47:17 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:17 smsl-n100 volumio[1436]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Preload queue cleared Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreStateMachine::ClearQueue Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreStateMachine::stop Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreStateMachine::stPlaybackTimer Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreStateMachine::updateTrackBlock Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrackBlock Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreStateMachine::serviceStop Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreCommandRouter::serviceStop Jun 02 10:47:22 smsl-n100 volumio[1436]: info: ControllerMpd::stop Jun 02 10:47:22 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CorePlayQueue::clearPlayQueue Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CorePlayQueue::saveQueue Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreStateMachine::addQueueItems Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CorePlayQueue::addQueueItems Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Preload queue cleared Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/01 La Risata del Diavolo (tema).flac Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/01 La Risata del Diavolo (tema).flac Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/02 La Campanella - Rondo dal Concerto per violino e orchestra n.2 in si minore.flac Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/02 La Campanella - Rondo dal Concerto per violino e orchestra n.2 in si minore.flac Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/03 Capriccio per violino solo n.5 in la minore - Agitato.flac Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/03 Capriccio per violino solo n.5 in la minore - Agitato.flac Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/04 Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore.flac Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/04 Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore.flac Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/05 Introduzione e variazioni su [[God Save the King]] op.9.flac Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/05 Introduzione e variazioni su [[God Save the King]] op.9.flac Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/06 Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale.flac Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/06 Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale.flac Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/07 Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore.flac Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/07 Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore.flac Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/08 Capriccio per violino solo n.1 in mi maggiore - Andante.flac Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/08 Capriccio per violino solo n.1 in mi maggiore - Andante.flac Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/10 Sonata Moto Perpetuo - Allegro Vivace.flac Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/10 Sonata Moto Perpetuo - Allegro Vivace.flac Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CorePlayQueue::saveQueue Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreStateMachine::updateTrackBlock Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrackBlock Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPlay Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreStateMachine::play index 9 Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreStateMachine::stop Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreStateMachine::play index undefined Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreStateMachine::startPlaybackTimer Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioGetVisibleSources Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jun 02 10:47:22 smsl-n100 volumio[1436]: verbose: ControllerMpd::clearAddPlayTracks NAS/CD/Diabolus in Musica/10 Sonata Moto Perpetuo - Allegro Vivace.flac Jun 02 10:47:22 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Jun 02 10:47:22 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:22 smsl-n100 volumio[1436]: info: sendMpdCommand stop took 99 milliseconds Jun 02 10:47:22 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:22 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:22 smsl-n100 volumio[1436]: info: sendMpdCommand stop took 23 milliseconds Jun 02 10:47:22 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand clear Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Jun 02 10:47:22 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:22 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:22 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Jun 02 10:47:22 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:22 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:22 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Jun 02 10:47:22 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:22 smsl-n100 volumio[1436]: info: sendMpdCommand status took 20 milliseconds Jun 02 10:47:22 smsl-n100 volumio[1436]: info: sendMpdCommand clear took 18 milliseconds Jun 02 10:47:22 smsl-n100 volumio[1436]: info: sendMpdCommand status took 14 milliseconds Jun 02 10:47:22 smsl-n100 volumio[1436]: info: sendMpdCommand status took 10 milliseconds Jun 02 10:47:22 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:22 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:22 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand add "NAS/CD/Diabolus in Musica/10 Sonata Moto Perpetuo - Allegro Vivace.flac" Jun 02 10:47:22 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:22 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:22 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:22 smsl-n100 volumio[1436]: 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} Jun 02 10:47:22 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 9 Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService stop Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:22 smsl-n100 volumio[1436]: info: No code Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:22 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:22 smsl-n100 volumio[1436]: 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} Jun 02 10:47:22 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 9 Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService stop Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:22 smsl-n100 volumio[1436]: info: No code Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:22 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:22 smsl-n100 volumio[1436]: info: ------------------------------ 146ms Jun 02 10:47:22 smsl-n100 volumio[1436]: info: ------------------------------ 145ms Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Jun 02 10:47:22 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Jun 02 10:47:22 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:22 smsl-n100 volumio[1436]: error: updateQueue error: null Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Jun 02 10:47:22 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:22 smsl-n100 volumio[1436]: info: ------------------------------ 157ms Jun 02 10:47:22 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 149 milliseconds Jun 02 10:47:22 smsl-n100 volumio[1436]: info: sendMpdCommand add "NAS/CD/Diabolus in Musica/10 Sonata Moto Perpetuo - Allegro Vivace.flac" took 149 milliseconds Jun 02 10:47:22 smsl-n100 volumio[1436]: info: ------------------------------ 29ms Jun 02 10:47:22 smsl-n100 volumio[1436]: info: ------------------------------ 27ms Jun 02 10:47:22 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:22 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand play Jun 02 10:47:22 smsl-n100 volumio[1436]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 02 10:47:22 smsl-n100 volumio[1436]: info: ------------------------------ 199ms Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Jun 02 10:47:22 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Jun 02 10:47:22 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:22 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:23 smsl-n100 volumio[1436]: info: Jun 02 10:47:23 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:23 smsl-n100 volumio[1436]: info: ------------------------------ 110ms Jun 02 10:47:23 smsl-n100 volumio[1436]: info: sendMpdCommand play took 91 milliseconds Jun 02 10:47:23 smsl-n100 volumio[1436]: info: ------------------------------ 87ms Jun 02 10:47:23 smsl-n100 volumio[1436]: info: ------------------------------ 82ms Jun 02 10:47:23 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:23 smsl-n100 volumio[1436]: info: Jun 02 10:47:23 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:23 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:23 smsl-n100 volumio[1436]: info: Jun 02 10:47:23 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:23 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:23 smsl-n100 volumio[1436]: info: Jun 02 10:47:23 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:23 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:23 smsl-n100 volumio[1436]: info: sendMpdCommand status took 21 milliseconds Jun 02 10:47:23 smsl-n100 volumio[1436]: info: sendMpdCommand status took 17 milliseconds Jun 02 10:47:23 smsl-n100 volumio[1436]: info: sendMpdCommand status took 11 milliseconds Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:23 smsl-n100 volumio[1436]: info: Jun 02 10:47:23 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:23 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:23 smsl-n100 volumio[1436]: info: Jun 02 10:47:23 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:23 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:23 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:23 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:47:23 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:23 smsl-n100 volumio[1436]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:47:23 smsl-n100 volumio[1436]: info: sendMpdCommand status took 95 milliseconds Jun 02 10:47:23 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 88 milliseconds Jun 02 10:47:23 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 87 milliseconds Jun 02 10:47:23 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 86 milliseconds Jun 02 10:47:23 smsl-n100 volumio[1436]: info: sendMpdCommand status took 59 milliseconds Jun 02 10:47:23 smsl-n100 volumio[1436]: info: sendMpdCommand status took 52 milliseconds Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:23 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":189,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"750 Kbps","isStreaming":false,"title":"Sonata Moto Perpetuo - Allegro Vivace","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/10 Sonata Moto Perpetuo - Allegro Vivace.flac","trackType":"flac"} Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 9 Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:47:23 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":189,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"750 Kbps","isStreaming":false,"title":"Sonata Moto Perpetuo - Allegro Vivace","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/10 Sonata Moto Perpetuo - Allegro Vivace.flac","trackType":"flac"} Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 9 Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:23 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":189,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"750 Kbps","isStreaming":false,"title":"Sonata Moto Perpetuo - Allegro Vivace","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/10 Sonata Moto Perpetuo - Allegro Vivace.flac","trackType":"flac"} Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 9 Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:23 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: ------------------------------ 218ms Jun 02 10:47:23 smsl-n100 volumio[1436]: info: ------------------------------ 259ms Jun 02 10:47:23 smsl-n100 volumio[1436]: info: ------------------------------ 255ms Jun 02 10:47:23 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 208 milliseconds Jun 02 10:47:23 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 204 milliseconds Jun 02 10:47:23 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 202 milliseconds Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:23 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":189,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"750 Kbps","isStreaming":false,"title":"Sonata Moto Perpetuo - Allegro Vivace","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/10 Sonata Moto Perpetuo - Allegro Vivace.flac","trackType":"flac"} Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 9 Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:23 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":189,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"853 Kbps","isStreaming":false,"title":"Sonata Moto Perpetuo - Allegro Vivace","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/10 Sonata Moto Perpetuo - Allegro Vivace.flac","trackType":"flac"} Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 9 Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:23 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":189,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"750 Kbps","isStreaming":false,"title":"Sonata Moto Perpetuo - Allegro Vivace","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/10 Sonata Moto Perpetuo - Allegro Vivace.flac","trackType":"flac"} Jun 02 10:47:23 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 9 Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:23 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: ------------------------------ 470ms Jun 02 10:47:23 smsl-n100 volumio[1436]: info: ------------------------------ 431ms Jun 02 10:47:23 smsl-n100 volumio[1436]: info: ------------------------------ 427ms Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:23 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:23 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:23 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:47:23 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:23 smsl-n100 volumio[1436]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Preload queue cleared Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::ClearQueue Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::stop Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::stPlaybackTimer Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::updateTrackBlock Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrackBlock Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::serviceStop Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 9 Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreCommandRouter::serviceStop Jun 02 10:47:27 smsl-n100 volumio[1436]: info: ControllerMpd::stop Jun 02 10:47:27 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CorePlayQueue::clearPlayQueue Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CorePlayQueue::saveQueue Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::addQueueItems Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CorePlayQueue::addQueueItems Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Preload queue cleared Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/01 La Risata del Diavolo (tema).flac Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/01 La Risata del Diavolo (tema).flac Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/02 La Campanella - Rondo dal Concerto per violino e orchestra n.2 in si minore.flac Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/02 La Campanella - Rondo dal Concerto per violino e orchestra n.2 in si minore.flac Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/03 Capriccio per violino solo n.5 in la minore - Agitato.flac Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/03 Capriccio per violino solo n.5 in la minore - Agitato.flac Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/04 Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore.flac Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/04 Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore.flac Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CorePlayQueue::saveQueue Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::updateTrackBlock Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrackBlock Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPlay Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::play index 3 Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::addQueueItems Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CorePlayQueue::addQueueItems Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Preload queue cleared Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/05 Introduzione e variazioni su [[God Save the King]] op.9.flac Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/05 Introduzione e variazioni su [[God Save the King]] op.9.flac Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/06 Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale.flac Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/06 Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale.flac Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/07 Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore.flac Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/07 Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore.flac Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/08 Capriccio per violino solo n.1 in mi maggiore - Andante.flac Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/08 Capriccio per violino solo n.1 in mi maggiore - Andante.flac Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/10 Sonata Moto Perpetuo - Allegro Vivace.flac Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/10 Sonata Moto Perpetuo - Allegro Vivace.flac Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::stop Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CorePlayQueue::saveQueue Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::play index undefined Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::updateTrackBlock Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrackBlock Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::startPlaybackTimer Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:27 smsl-n100 volumio[1436]: verbose: ControllerMpd::clearAddPlayTracks NAS/CD/Diabolus in Musica/04 Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore.flac Jun 02 10:47:27 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Jun 02 10:47:27 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:27 smsl-n100 volumio[1436]: info: sendMpdCommand stop took 104 milliseconds Jun 02 10:47:27 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:27 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:27 smsl-n100 volumio[1436]: info: sendMpdCommand stop took 28 milliseconds Jun 02 10:47:27 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand clear Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Jun 02 10:47:27 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:27 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:27 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Jun 02 10:47:27 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:27 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:27 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Jun 02 10:47:27 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:27 smsl-n100 volumio[1436]: info: sendMpdCommand status took 39 milliseconds Jun 02 10:47:27 smsl-n100 volumio[1436]: info: sendMpdCommand clear took 38 milliseconds Jun 02 10:47:27 smsl-n100 volumio[1436]: info: sendMpdCommand status took 34 milliseconds Jun 02 10:47:27 smsl-n100 volumio[1436]: info: sendMpdCommand status took 32 milliseconds Jun 02 10:47:27 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:27 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:27 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand add "NAS/CD/Diabolus in Musica/04 Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore.flac" Jun 02 10:47:27 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:27 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:27 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:27 smsl-n100 volumio[1436]: 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} Jun 02 10:47:27 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 3 Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService stop Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:27 smsl-n100 volumio[1436]: info: No code Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:27 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:27 smsl-n100 volumio[1436]: 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} Jun 02 10:47:27 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 3 Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService stop Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:27 smsl-n100 volumio[1436]: info: No code Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:27 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:27 smsl-n100 volumio[1436]: info: ------------------------------ 166ms Jun 02 10:47:27 smsl-n100 volumio[1436]: info: ------------------------------ 166ms Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Jun 02 10:47:27 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Jun 02 10:47:27 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:27 smsl-n100 volumio[1436]: error: updateQueue error: null Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Jun 02 10:47:27 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:27 smsl-n100 volumio[1436]: info: ------------------------------ 158ms Jun 02 10:47:27 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 148 milliseconds Jun 02 10:47:27 smsl-n100 volumio[1436]: info: sendMpdCommand add "NAS/CD/Diabolus in Musica/04 Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore.flac" took 147 milliseconds Jun 02 10:47:27 smsl-n100 volumio[1436]: info: ------------------------------ 18ms Jun 02 10:47:27 smsl-n100 volumio[1436]: info: ------------------------------ 14ms Jun 02 10:47:27 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:27 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand play Jun 02 10:47:27 smsl-n100 volumio[1436]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 02 10:47:27 smsl-n100 volumio[1436]: info: ------------------------------ 209ms Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Jun 02 10:47:27 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Jun 02 10:47:27 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:27 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:28 smsl-n100 volumio[1436]: info: Jun 02 10:47:28 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:28 smsl-n100 volumio[1436]: info: ------------------------------ 119ms Jun 02 10:47:28 smsl-n100 volumio[1436]: info: sendMpdCommand play took 111 milliseconds Jun 02 10:47:28 smsl-n100 volumio[1436]: info: ------------------------------ 105ms Jun 02 10:47:28 smsl-n100 volumio[1436]: info: ------------------------------ 101ms Jun 02 10:47:28 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:28 smsl-n100 volumio[1436]: info: Jun 02 10:47:28 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:28 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:28 smsl-n100 volumio[1436]: info: Jun 02 10:47:28 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:28 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:28 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:28 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:47:28 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:28 smsl-n100 volumio[1436]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:47:28 smsl-n100 volumio[1436]: info: Jun 02 10:47:28 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:28 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:28 smsl-n100 volumio[1436]: info: sendMpdCommand status took 77 milliseconds Jun 02 10:47:28 smsl-n100 volumio[1436]: info: sendMpdCommand status took 65 milliseconds Jun 02 10:47:28 smsl-n100 volumio[1436]: info: sendMpdCommand status took 58 milliseconds Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:28 smsl-n100 volumio[1436]: info: Jun 02 10:47:28 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:28 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:28 smsl-n100 volumio[1436]: info: Jun 02 10:47:28 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:28 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:28 smsl-n100 volumio[1436]: info: sendMpdCommand status took 57 milliseconds Jun 02 10:47:28 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 47 milliseconds Jun 02 10:47:28 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 46 milliseconds Jun 02 10:47:28 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 45 milliseconds Jun 02 10:47:28 smsl-n100 volumio[1436]: info: sendMpdCommand status took 38 milliseconds Jun 02 10:47:28 smsl-n100 volumio[1436]: info: sendMpdCommand status took 32 milliseconds Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:28 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":672,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"583 Kbps","isStreaming":false,"title":"Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/04 Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore.flac","trackType":"flac"} Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 3 Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:47:28 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":672,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"583 Kbps","isStreaming":false,"title":"Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/04 Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore.flac","trackType":"flac"} Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 3 Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:28 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":672,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"583 Kbps","isStreaming":false,"title":"Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/04 Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore.flac","trackType":"flac"} Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 3 Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:28 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: ------------------------------ 257ms Jun 02 10:47:28 smsl-n100 volumio[1436]: info: ------------------------------ 299ms Jun 02 10:47:28 smsl-n100 volumio[1436]: info: ------------------------------ 289ms Jun 02 10:47:28 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 174 milliseconds Jun 02 10:47:28 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 166 milliseconds Jun 02 10:47:28 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 165 milliseconds Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:28 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":672,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"859 Kbps","isStreaming":false,"title":"Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/04 Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore.flac","trackType":"flac"} Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 3 Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:28 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":672,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"859 Kbps","isStreaming":false,"title":"Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/04 Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore.flac","trackType":"flac"} Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 3 Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:28 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":672,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"859 Kbps","isStreaming":false,"title":"Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/04 Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore.flac","trackType":"flac"} Jun 02 10:47:28 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 3 Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:28 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: ------------------------------ 483ms Jun 02 10:47:28 smsl-n100 volumio[1436]: info: ------------------------------ 460ms Jun 02 10:47:28 smsl-n100 volumio[1436]: info: ------------------------------ 458ms Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:28 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:28 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:28 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:47:28 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:28 smsl-n100 volumio[1436]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Preload queue cleared Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::ClearQueue Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::stop Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::stPlaybackTimer Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::updateTrackBlock Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrackBlock Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::serviceStop Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 3 Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreCommandRouter::serviceStop Jun 02 10:47:31 smsl-n100 volumio[1436]: info: ControllerMpd::stop Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CorePlayQueue::clearPlayQueue Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CorePlayQueue::saveQueue Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::addQueueItems Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CorePlayQueue::addQueueItems Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Preload queue cleared Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/01 La Risata del Diavolo (tema).flac Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/01 La Risata del Diavolo (tema).flac Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/02 La Campanella - Rondo dal Concerto per violino e orchestra n.2 in si minore.flac Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/02 La Campanella - Rondo dal Concerto per violino e orchestra n.2 in si minore.flac Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/03 Capriccio per violino solo n.5 in la minore - Agitato.flac Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/03 Capriccio per violino solo n.5 in la minore - Agitato.flac Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/04 Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore.flac Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/04 Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore.flac Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/05 Introduzione e variazioni su [[God Save the King]] op.9.flac Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/05 Introduzione e variazioni su [[God Save the King]] op.9.flac Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CorePlayQueue::saveQueue Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::updateTrackBlock Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrackBlock Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPlay Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::play index 4 Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::addQueueItems Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CorePlayQueue::addQueueItems Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Preload queue cleared Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/06 Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale.flac Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/06 Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale.flac Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/07 Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore.flac Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/07 Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore.flac Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/08 Capriccio per violino solo n.1 in mi maggiore - Andante.flac Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/08 Capriccio per violino solo n.1 in mi maggiore - Andante.flac Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/10 Sonata Moto Perpetuo - Allegro Vivace.flac Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/10 Sonata Moto Perpetuo - Allegro Vivace.flac Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::stop Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CorePlayQueue::saveQueue Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::play index undefined Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::updateTrackBlock Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrackBlock Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::startPlaybackTimer Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::clearAddPlayTracks NAS/CD/Diabolus in Musica/05 Introduzione e variazioni su [[God Save the King]] op.9.flac Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Jun 02 10:47:31 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:31 smsl-n100 volumio[1436]: info: sendMpdCommand stop took 97 milliseconds Jun 02 10:47:31 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:31 smsl-n100 volumio[1436]: info: sendMpdCommand stop took 24 milliseconds Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand clear Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Jun 02 10:47:31 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:31 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Jun 02 10:47:31 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:31 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Jun 02 10:47:31 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:31 smsl-n100 volumio[1436]: info: sendMpdCommand status took 27 milliseconds Jun 02 10:47:31 smsl-n100 volumio[1436]: info: sendMpdCommand clear took 25 milliseconds Jun 02 10:47:31 smsl-n100 volumio[1436]: info: sendMpdCommand status took 22 milliseconds Jun 02 10:47:31 smsl-n100 volumio[1436]: info: sendMpdCommand status took 19 milliseconds Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand add "NAS/CD/Diabolus in Musica/05 Introduzione e variazioni su [[God Save the King]] op.9.flac" Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:31 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:31 smsl-n100 volumio[1436]: 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} Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 4 Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService stop Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:31 smsl-n100 volumio[1436]: info: No code Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:31 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:31 smsl-n100 volumio[1436]: 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} Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 4 Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService stop Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:31 smsl-n100 volumio[1436]: info: No code Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:31 smsl-n100 volumio[1436]: info: ------------------------------ 112ms Jun 02 10:47:31 smsl-n100 volumio[1436]: info: ------------------------------ 109ms Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Jun 02 10:47:31 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Jun 02 10:47:31 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:31 smsl-n100 volumio[1436]: error: updateQueue error: null Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Jun 02 10:47:31 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:31 smsl-n100 volumio[1436]: info: ------------------------------ 116ms Jun 02 10:47:31 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 109 milliseconds Jun 02 10:47:31 smsl-n100 volumio[1436]: info: sendMpdCommand add "NAS/CD/Diabolus in Musica/05 Introduzione e variazioni su [[God Save the King]] op.9.flac" took 110 milliseconds Jun 02 10:47:31 smsl-n100 volumio[1436]: info: ------------------------------ 24ms Jun 02 10:47:31 smsl-n100 volumio[1436]: info: ------------------------------ 22ms Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand play Jun 02 10:47:31 smsl-n100 volumio[1436]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 02 10:47:31 smsl-n100 volumio[1436]: info: ------------------------------ 158ms Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Jun 02 10:47:31 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Jun 02 10:47:31 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:31 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:31 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:31 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:47:31 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:31 smsl-n100 volumio[1436]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Jun 02 10:47:31 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Jun 02 10:47:31 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:31 smsl-n100 volumio[1436]: info: ------------------------------ 126ms Jun 02 10:47:31 smsl-n100 volumio[1436]: info: sendMpdCommand play took 115 milliseconds Jun 02 10:47:31 smsl-n100 volumio[1436]: info: ------------------------------ 110ms Jun 02 10:47:31 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:31 smsl-n100 volumio[1436]: info: ------------------------------ 120ms Jun 02 10:47:31 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Jun 02 10:47:31 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:31 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Jun 02 10:47:31 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:31 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:31 smsl-n100 volumio[1436]: info: sendMpdCommand status took 23 milliseconds Jun 02 10:47:31 smsl-n100 volumio[1436]: info: sendMpdCommand status took 21 milliseconds Jun 02 10:47:31 smsl-n100 volumio[1436]: info: sendMpdCommand status took 16 milliseconds Jun 02 10:47:31 smsl-n100 volumio[1436]: info: sendMpdCommand status took 10 milliseconds Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Jun 02 10:47:31 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:31 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:31 smsl-n100 volumio[1436]: info: Jun 02 10:47:31 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:31 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:31 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 44 milliseconds Jun 02 10:47:31 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 43 milliseconds Jun 02 10:47:31 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 41 milliseconds Jun 02 10:47:31 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 41 milliseconds Jun 02 10:47:31 smsl-n100 volumio[1436]: info: sendMpdCommand status took 31 milliseconds Jun 02 10:47:31 smsl-n100 volumio[1436]: info: sendMpdCommand status took 26 milliseconds Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:31 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:32 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:32 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:32 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:32 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:32 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":409,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"726 Kbps","isStreaming":false,"title":"Introduzione e variazioni su [[God Save the King]] op.9","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/05 Introduzione e variazioni su [[God Save the King]] op.9.flac","trackType":"flac"} Jun 02 10:47:32 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 4 Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:47:32 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:32 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":409,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"726 Kbps","isStreaming":false,"title":"Introduzione e variazioni su [[God Save the King]] op.9","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/05 Introduzione e variazioni su [[God Save the King]] op.9.flac","trackType":"flac"} Jun 02 10:47:32 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 4 Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:32 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:32 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":409,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"785 Kbps","isStreaming":false,"title":"Introduzione e variazioni su [[God Save the King]] op.9","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/05 Introduzione e variazioni su [[God Save the King]] op.9.flac","trackType":"flac"} Jun 02 10:47:32 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 4 Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:32 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:32 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":409,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"785 Kbps","isStreaming":false,"title":"Introduzione e variazioni su [[God Save the King]] op.9","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/05 Introduzione e variazioni su [[God Save the King]] op.9.flac","trackType":"flac"} Jun 02 10:47:32 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 4 Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:32 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: ------------------------------ 199ms Jun 02 10:47:32 smsl-n100 volumio[1436]: info: ------------------------------ 253ms Jun 02 10:47:32 smsl-n100 volumio[1436]: info: ------------------------------ 231ms Jun 02 10:47:32 smsl-n100 volumio[1436]: info: ------------------------------ 227ms Jun 02 10:47:32 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 155 milliseconds Jun 02 10:47:32 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 155 milliseconds Jun 02 10:47:32 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:32 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:32 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:32 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":409,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"785 Kbps","isStreaming":false,"title":"Introduzione e variazioni su [[God Save the King]] op.9","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/05 Introduzione e variazioni su [[God Save the King]] op.9.flac","trackType":"flac"} Jun 02 10:47:32 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 4 Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:32 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:32 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":409,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"785 Kbps","isStreaming":false,"title":"Introduzione e variazioni su [[God Save the King]] op.9","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/05 Introduzione e variazioni su [[God Save the King]] op.9.flac","trackType":"flac"} Jun 02 10:47:32 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 4 Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:32 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: ------------------------------ 298ms Jun 02 10:47:32 smsl-n100 volumio[1436]: info: ------------------------------ 294ms Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:32 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:32 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:32 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:47:32 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:32 smsl-n100 volumio[1436]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Preload queue cleared Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::ClearQueue Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::stop Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::stPlaybackTimer Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::updateTrackBlock Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrackBlock Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::serviceStop Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 4 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::serviceStop Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ControllerMpd::stop Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::clearPlayQueue Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::saveQueue Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::addQueueItems Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::addQueueItems Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Preload queue cleared Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/01 La Risata del Diavolo (tema).flac Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/01 La Risata del Diavolo (tema).flac Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/02 La Campanella - Rondo dal Concerto per violino e orchestra n.2 in si minore.flac Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/02 La Campanella - Rondo dal Concerto per violino e orchestra n.2 in si minore.flac Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/03 Capriccio per violino solo n.5 in la minore - Agitato.flac Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/03 Capriccio per violino solo n.5 in la minore - Agitato.flac Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/04 Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore.flac Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/04 Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore.flac Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/05 Introduzione e variazioni su [[God Save the King]] op.9.flac Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/05 Introduzione e variazioni su [[God Save the King]] op.9.flac Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/06 Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale.flac Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/06 Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale.flac Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/07 Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore.flac Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/07 Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore.flac Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::saveQueue Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::updateTrackBlock Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrackBlock Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPlay Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::play index 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::addQueueItems Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::addQueueItems Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Preload queue cleared Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/08 Capriccio per violino solo n.1 in mi maggiore - Andante.flac Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/08 Capriccio per violino solo n.1 in mi maggiore - Andante.flac Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/10 Sonata Moto Perpetuo - Allegro Vivace.flac Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/10 Sonata Moto Perpetuo - Allegro Vivace.flac Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::stop Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::saveQueue Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::play index undefined Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::updateTrackBlock Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrackBlock Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::startPlaybackTimer Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::clearAddPlayTracks NAS/CD/Diabolus in Musica/07 Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore.flac Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Jun 02 10:47:34 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:34 smsl-n100 volumio[1436]: info: sendMpdCommand stop took 129 milliseconds Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:34 smsl-n100 volumio[1436]: info: sendMpdCommand stop took 37 milliseconds Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand clear Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Jun 02 10:47:34 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Jun 02 10:47:34 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Jun 02 10:47:34 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:34 smsl-n100 volumio[1436]: info: sendMpdCommand status took 27 milliseconds Jun 02 10:47:34 smsl-n100 volumio[1436]: info: sendMpdCommand clear took 24 milliseconds Jun 02 10:47:34 smsl-n100 volumio[1436]: info: sendMpdCommand status took 16 milliseconds Jun 02 10:47:34 smsl-n100 volumio[1436]: info: sendMpdCommand status took 12 milliseconds Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand add "NAS/CD/Diabolus in Musica/07 Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore.flac" Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: 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} Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService stop Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: No code Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: 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} Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService stop Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: No code Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ------------------------------ 101ms Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ------------------------------ 98ms Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Jun 02 10:47:34 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Jun 02 10:47:34 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:34 smsl-n100 volumio[1436]: error: updateQueue error: null Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Jun 02 10:47:34 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ------------------------------ 102ms Jun 02 10:47:34 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 96 milliseconds Jun 02 10:47:34 smsl-n100 volumio[1436]: info: sendMpdCommand add "NAS/CD/Diabolus in Musica/07 Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore.flac" took 96 milliseconds Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ------------------------------ 15ms Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ------------------------------ 12ms Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand play Jun 02 10:47:34 smsl-n100 volumio[1436]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ------------------------------ 142ms Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Jun 02 10:47:34 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Jun 02 10:47:34 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ------------------------------ 57ms Jun 02 10:47:34 smsl-n100 volumio[1436]: info: sendMpdCommand play took 49 milliseconds Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ------------------------------ 46ms Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ------------------------------ 43ms Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:34 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:34 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:47:34 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:34 smsl-n100 volumio[1436]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Jun 02 10:47:34 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Jun 02 10:47:34 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Jun 02 10:47:34 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Jun 02 10:47:34 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:34 smsl-n100 volumio[1436]: info: sendMpdCommand status took 34 milliseconds Jun 02 10:47:34 smsl-n100 volumio[1436]: info: sendMpdCommand status took 29 milliseconds Jun 02 10:47:34 smsl-n100 volumio[1436]: info: sendMpdCommand status took 23 milliseconds Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Jun 02 10:47:34 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Jun 02 10:47:34 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:34 smsl-n100 volumio[1436]: info: sendMpdCommand status took 28 milliseconds Jun 02 10:47:34 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 23 milliseconds Jun 02 10:47:34 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 22 milliseconds Jun 02 10:47:34 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 21 milliseconds Jun 02 10:47:34 smsl-n100 volumio[1436]: info: sendMpdCommand status took 15 milliseconds Jun 02 10:47:34 smsl-n100 volumio[1436]: info: sendMpdCommand status took 10 milliseconds Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":698,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/07 Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore.flac","trackType":"flac"} Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":698,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/07 Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore.flac","trackType":"flac"} Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":698,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/07 Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore.flac","trackType":"flac"} Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ------------------------------ 147ms Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ------------------------------ 177ms Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ------------------------------ 172ms Jun 02 10:47:34 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 115 milliseconds Jun 02 10:47:34 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 111 milliseconds Jun 02 10:47:34 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 110 milliseconds Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":698,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"483 Kbps","isStreaming":false,"title":"Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/07 Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore.flac","trackType":"flac"} Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":698,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"457 Kbps","isStreaming":false,"title":"Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/07 Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore.flac","trackType":"flac"} Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":698,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"457 Kbps","isStreaming":false,"title":"Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/07 Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore.flac","trackType":"flac"} Jun 02 10:47:34 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:34 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:34 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ------------------------------ 313ms Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ------------------------------ 296ms Jun 02 10:47:34 smsl-n100 volumio[1436]: info: ------------------------------ 294ms Jun 02 10:47:35 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:35 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:35 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:35 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:35 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:35 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:47:35 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:35 smsl-n100 volumio[1436]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:47:44 smsl-n100 volumio[1436]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jun 02 10:47:44 smsl-n100 volumio[1436]: info: Retrying Login Due to Network Error Jun 02 10:47:54 smsl-n100 volumio[1436]: info: MyVolumio login type: Token Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Preload queue cleared Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::ClearQueue Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::stop Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::stPlaybackTimer Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::updateTrackBlock Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrackBlock Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::serviceStop Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 6 Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreCommandRouter::serviceStop Jun 02 10:47:55 smsl-n100 volumio[1436]: info: ControllerMpd::stop Jun 02 10:47:55 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CorePlayQueue::clearPlayQueue Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CorePlayQueue::saveQueue Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::addQueueItems Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CorePlayQueue::addQueueItems Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Preload queue cleared Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/01 La Risata del Diavolo (tema).flac Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/01 La Risata del Diavolo (tema).flac Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/02 La Campanella - Rondo dal Concerto per violino e orchestra n.2 in si minore.flac Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/02 La Campanella - Rondo dal Concerto per violino e orchestra n.2 in si minore.flac Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/03 Capriccio per violino solo n.5 in la minore - Agitato.flac Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/03 Capriccio per violino solo n.5 in la minore - Agitato.flac Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/04 Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore.flac Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/04 Accardo interpreta Paganini - Rondo galante. Andantino gaio - dal Concerto per violino e orchestra n.4 in re minore.flac Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/05 Introduzione e variazioni su [[God Save the King]] op.9.flac Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/05 Introduzione e variazioni su [[God Save the King]] op.9.flac Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/06 Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale.flac Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/06 Capriccio per violino solo n.24 in la minore - Tema. Quasi Presto - Variazioni - Finale.flac Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/07 Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore.flac Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/07 Polacca. Andantio vivace - dal Concerto per violino e orchestra n.3 in mi maggiore.flac Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/08 Capriccio per violino solo n.1 in mi maggiore - Andante.flac Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/08 Capriccio per violino solo n.1 in mi maggiore - Andante.flac Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CorePlayQueue::saveQueue Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::updateTrackBlock Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrackBlock Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPlay Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::play index 8 Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::addQueueItems Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CorePlayQueue::addQueueItems Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Preload queue cleared Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Adding Item to queue: music-library/NAS/CD/Diabolus in Musica/10 Sonata Moto Perpetuo - Allegro Vivace.flac Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Using cached record of: music-library/NAS/CD/Diabolus in Musica/10 Sonata Moto Perpetuo - Allegro Vivace.flac Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::stop Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CorePlayQueue::saveQueue Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::play index undefined Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::updateTrackBlock Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrackBlock Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::startPlaybackTimer Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:55 smsl-n100 volumio[1436]: verbose: ControllerMpd::clearAddPlayTracks NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac Jun 02 10:47:55 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Jun 02 10:47:55 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:55 smsl-n100 volumio[1436]: info: sendMpdCommand stop took 93 milliseconds Jun 02 10:47:55 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:55 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:55 smsl-n100 volumio[1436]: info: sendMpdCommand stop took 23 milliseconds Jun 02 10:47:55 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand clear Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Jun 02 10:47:55 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:55 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:55 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Jun 02 10:47:55 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:55 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:55 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Jun 02 10:47:55 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:55 smsl-n100 volumio[1436]: info: sendMpdCommand status took 16 milliseconds Jun 02 10:47:55 smsl-n100 volumio[1436]: info: sendMpdCommand clear took 15 milliseconds Jun 02 10:47:55 smsl-n100 volumio[1436]: info: sendMpdCommand status took 12 milliseconds Jun 02 10:47:55 smsl-n100 volumio[1436]: info: sendMpdCommand status took 9 milliseconds Jun 02 10:47:55 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:55 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:55 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand add "NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac" Jun 02 10:47:55 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:55 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:55 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:55 smsl-n100 volumio[1436]: 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} Jun 02 10:47:55 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 8 Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService stop Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:55 smsl-n100 volumio[1436]: info: No code Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:55 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:55 smsl-n100 volumio[1436]: 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} Jun 02 10:47:55 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 8 Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService stop Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:55 smsl-n100 volumio[1436]: info: No code Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:55 smsl-n100 volumio[1436]: info: ------------------------------ 98ms Jun 02 10:47:55 smsl-n100 volumio[1436]: info: ------------------------------ 97ms Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Jun 02 10:47:55 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Jun 02 10:47:55 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:55 smsl-n100 volumio[1436]: error: updateQueue error: null Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Jun 02 10:47:55 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:55 smsl-n100 volumio[1436]: info: ------------------------------ 106ms Jun 02 10:47:55 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 100 milliseconds Jun 02 10:47:55 smsl-n100 volumio[1436]: info: sendMpdCommand add "NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac" took 100 milliseconds Jun 02 10:47:55 smsl-n100 volumio[1436]: info: ------------------------------ 16ms Jun 02 10:47:55 smsl-n100 volumio[1436]: info: ------------------------------ 13ms Jun 02 10:47:55 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:55 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand play Jun 02 10:47:55 smsl-n100 volumio[1436]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 02 10:47:55 smsl-n100 volumio[1436]: info: ------------------------------ 132ms Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Jun 02 10:47:55 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Jun 02 10:47:55 smsl-n100 volumio[1436]: ---------------------------- MPD announces system playlist update Jun 02 10:47:55 smsl-n100 volumio[1436]: info: Ignoring MPD Status Update Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:55 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:56 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:56 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:47:56 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:56 smsl-n100 volumio[1436]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:47:56 smsl-n100 volumio[1436]: info: Jun 02 10:47:56 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:56 smsl-n100 volumio[1436]: info: Jun 02 10:47:56 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:56 smsl-n100 volumio[1436]: info: ------------------------------ 115ms Jun 02 10:47:56 smsl-n100 volumio[1436]: info: sendMpdCommand play took 107 milliseconds Jun 02 10:47:56 smsl-n100 volumio[1436]: info: ------------------------------ 104ms Jun 02 10:47:56 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:56 smsl-n100 volumio[1436]: info: ------------------------------ 104ms Jun 02 10:47:56 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:56 smsl-n100 volumio[1436]: info: Jun 02 10:47:56 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:56 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:56 smsl-n100 volumio[1436]: info: Jun 02 10:47:56 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:56 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:56 smsl-n100 volumio[1436]: info: sendMpdCommand status took 49 milliseconds Jun 02 10:47:56 smsl-n100 volumio[1436]: info: sendMpdCommand status took 47 milliseconds Jun 02 10:47:56 smsl-n100 volumio[1436]: info: sendMpdCommand status took 42 milliseconds Jun 02 10:47:56 smsl-n100 volumio[1436]: info: sendMpdCommand status took 38 milliseconds Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:56 smsl-n100 volumio[1436]: info: Jun 02 10:47:56 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:56 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:56 smsl-n100 volumio[1436]: info: Jun 02 10:47:56 smsl-n100 volumio[1436]: ---------------------------- MPD announces state update: player Jun 02 10:47:56 smsl-n100 volumio[1436]: info: ControllerMpd::getState Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:47:56 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 50 milliseconds Jun 02 10:47:56 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 50 milliseconds Jun 02 10:47:56 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 49 milliseconds Jun 02 10:47:56 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 49 milliseconds Jun 02 10:47:56 smsl-n100 volumio[1436]: info: sendMpdCommand status took 41 milliseconds Jun 02 10:47:56 smsl-n100 volumio[1436]: info: sendMpdCommand status took 37 milliseconds Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseState Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:47:56 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":587,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"403 Kbps","isStreaming":false,"title":"Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac","trackType":"flac"} Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 8 Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:47:56 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":587,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"403 Kbps","isStreaming":false,"title":"Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac","trackType":"flac"} Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 8 Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:56 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":587,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"403 Kbps","isStreaming":false,"title":"Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac","trackType":"flac"} Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 8 Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:56 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":587,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"403 Kbps","isStreaming":false,"title":"Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac","trackType":"flac"} Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 8 Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:56 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: ------------------------------ 228ms Jun 02 10:47:56 smsl-n100 volumio[1436]: info: ------------------------------ 287ms Jun 02 10:47:56 smsl-n100 volumio[1436]: info: ------------------------------ 277ms Jun 02 10:47:56 smsl-n100 volumio[1436]: info: ------------------------------ 274ms Jun 02 10:47:56 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 171 milliseconds Jun 02 10:47:56 smsl-n100 volumio[1436]: info: sendMpdCommand playlistinfo took 171 milliseconds Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:47:56 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":587,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"414 Kbps","isStreaming":false,"title":"Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac","trackType":"flac"} Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 8 Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:56 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: ControllerMpd::pushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreCommandRouter::servicePushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":587,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"414 Kbps","isStreaming":false,"title":"Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore","artist":"Paganini","album":"Diabolus in Musica","uri":"NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac","trackType":"flac"} Jun 02 10:47:56 smsl-n100 volumio[1436]: verbose: CURRENT POSITION 8 Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState stateService play Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:47:56 smsl-n100 volumio[1436]: info: Received an update from plugin. extracting info from payload Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: ------------------------------ 314ms Jun 02 10:47:56 smsl-n100 volumio[1436]: info: ------------------------------ 310ms Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreStateMachine::pushState Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CorePlayQueue::getTrack 8 Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:47:56 smsl-n100 volumio[1436]: info: CoreCommandRouter::volumioPushState Jun 02 10:47:56 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:56 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:47:56 smsl-n100 volumio[1436]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:47:56 smsl-n100 volumio[1436]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:48:10 smsl-n100 volumio[1436]: info: Listing playlists Jun 02 10:48:12 smsl-n100 volumio[1436]: info: Saving local item Chi Jun 02 10:48:12 smsl-n100 volumio[1436]: info: Pushing Favourites {"uri":"/mnt/NAS/CD/Diabolus in Musica/09 Rondo. Allegro spirituoso - dal Concerto per violino e orchestra n. 1 , op. 6 in re maggiore.flac","favourite":false} Jun 02 10:48:12 smsl-n100 volumio[1436]: info: Listing playlists Jun 02 10:48:20 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 02 10:48:20 smsl-n100 volumio[1436]: info: CURURI: albums:///111%20Years%20of%20Deutsche%20Grammophon Jun 02 10:48:20 smsl-n100 volumio[1436]: info: Preload queue cleared Jun 02 10:48:20 smsl-n100 volumio[1436]: info: Preloading song: music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(01) MAURICE RAVEL Pavane pour une infante defunte.flac Jun 02 10:48:20 smsl-n100 volumio[1436]: info: Preloading song: music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(02) BACH Cello Solo No.1 in G major BWV 1007 - 1. Prelude.flac Jun 02 10:48:20 smsl-n100 volumio[1436]: info: Preloading song: music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(03) FREDERIC CHOPIN Preludes in G major Op.28 No.3.flac Jun 02 10:48:20 smsl-n100 volumio[1436]: info: Preloading song: music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(04) GABRIEL FAURE Pie Jesu, from Requiem Op.48.flac Jun 02 10:48:20 smsl-n100 volumio[1436]: info: Preloading song: music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(05) BACH Prelude in C major BWV 846, from The Well-Tempered Clavier I.flac Jun 02 10:48:20 smsl-n100 volumio[1436]: info: Preloading song: music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(06) CAMILLE SAINT-SAENS Le cygne, from Le Carnaval des Animaux (arr. by Paul Vidal).flac Jun 02 10:48:20 smsl-n100 volumio[1436]: info: Preloading song: music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(07) CHARLES GOUNOD Ave Maria.flac Jun 02 10:48:20 smsl-n100 volumio[1436]: info: Preloading song: music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(08) JOHANN PACHELBEL Canon in D major.flac Jun 02 10:48:20 smsl-n100 volumio[1436]: info: Preloading song: music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(09) LUDWIG VAN BEETHOVEN Bagatelle in A minor WoO 59 - Fur Elise.flac Jun 02 10:48:20 smsl-n100 volumio[1436]: info: Preloading song: music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(10) FELIX MENDELSSOHN Symphony No.5 in D minor 'Reformation' Op.107 - 2. Allegro vivace.flac Jun 02 10:48:20 smsl-n100 volumio[1436]: info: Preloading song: music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(11) BRAHMS Double Concerto in A minor Op.102 - 2. Andante.flac Jun 02 10:48:20 smsl-n100 volumio[1436]: info: Preloading song: music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(12) WIENIAWSKI Etude-Caprice in E major Op.18 No.5.flac Jun 02 10:48:20 smsl-n100 volumio[1436]: info: Preloading song: music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(13) STANLEY MYERS Cavatina (arr. by John Williams).flac Jun 02 10:48:20 smsl-n100 volumio[1436]: info: Preloading song: music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(14) SCHUMANN Traumerei, from Kinderszenen Op.15.flac Jun 02 10:48:20 smsl-n100 volumio[1436]: info: Preloading song: music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(15) DOMENICO SCARLATTI Sonata in E major K.135.flac Jun 02 10:48:20 smsl-n100 volumio[1436]: info: Exploding uri music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(01) MAURICE RAVEL Pavane pour une infante defunte.flac in service mpd Jun 02 10:48:20 smsl-n100 volumio[1436]: info: ALBUMART /albumart?cacheid=737&web=/111%20Years%20of%20Deutsche%20Grammophon/extralarge&path=%2Fmnt%2FNAS%2FCD%2FDG%20111%20Years%20of%20Deutsche%20Grammophon%2F(01)%20MAURICE%20RAVEL%20Pavane%20pour%20une%20infante%20defunte.flac&metadata=false Jun 02 10:48:20 smsl-n100 volumio[1436]: info: URI /mnt/NAS/CD/DG 111 Years of Deutsche Grammophon/(01) MAURICE RAVEL Pavane pour une infante defunte.flac Jun 02 10:48:20 smsl-n100 volumio[1436]: info: Exploding uri music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(02) BACH Cello Solo No.1 in G major BWV 1007 - 1. Prelude.flac in service mpd Jun 02 10:48:20 smsl-n100 volumio[1436]: info: ALBUMART /albumart?cacheid=737&web=/111%20Years%20of%20Deutsche%20Grammophon/extralarge&path=%2Fmnt%2FNAS%2FCD%2FDG%20111%20Years%20of%20Deutsche%20Grammophon%2F(02)%20BACH%20Cello%20Solo%20No.1%20in%20G%20major%20BWV%201007%20-%201.%20Prelude.flac&metadata=false Jun 02 10:48:20 smsl-n100 volumio[1436]: info: URI /mnt/NAS/CD/DG 111 Years of Deutsche Grammophon/(02) BACH Cello Solo No.1 in G major BWV 1007 - 1. Prelude.flac Jun 02 10:48:20 smsl-n100 volumio[1436]: info: Exploding uri music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(03) FREDERIC CHOPIN Preludes in G major Op.28 No.3.flac in service mpd Jun 02 10:48:20 smsl-n100 volumio[1436]: info: ALBUMART /albumart?cacheid=737&web=/111%20Years%20of%20Deutsche%20Grammophon/extralarge&path=%2Fmnt%2FNAS%2FCD%2FDG%20111%20Years%20of%20Deutsche%20Grammophon%2F(03)%20FREDERIC%20CHOPIN%20Preludes%20in%20G%20major%20Op.28%20No.3.flac&metadata=false Jun 02 10:48:20 smsl-n100 volumio[1436]: info: URI /mnt/NAS/CD/DG 111 Years of Deutsche Grammophon/(03) FREDERIC CHOPIN Preludes in G major Op.28 No.3.flac Jun 02 10:48:20 smsl-n100 volumio[1436]: info: Exploding uri music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(04) GABRIEL FAURE Pie Jesu, from Requiem Op.48.flac in service mpd Jun 02 10:48:20 smsl-n100 volumio[1436]: info: ALBUMART /albumart?cacheid=737&web=/111%20Years%20of%20Deutsche%20Grammophon/extralarge&path=%2Fmnt%2FNAS%2FCD%2FDG%20111%20Years%20of%20Deutsche%20Grammophon%2F(04)%20GABRIEL%20FAURE%20Pie%20Jesu%2C%20from%20Requiem%20Op.48.flac&metadata=false Jun 02 10:48:20 smsl-n100 volumio[1436]: info: URI /mnt/NAS/CD/DG 111 Years of Deutsche Grammophon/(04) GABRIEL FAURE Pie Jesu, from Requiem Op.48.flac Jun 02 10:48:21 smsl-n100 volumio[1436]: info: Exploding uri music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(05) BACH Prelude in C major BWV 846, from The Well-Tempered Clavier I.flac in service mpd Jun 02 10:48:21 smsl-n100 volumio[1436]: info: ALBUMART /albumart?cacheid=737&web=/111%20Years%20of%20Deutsche%20Grammophon/extralarge&path=%2Fmnt%2FNAS%2FCD%2FDG%20111%20Years%20of%20Deutsche%20Grammophon%2F(05)%20BACH%20Prelude%20in%20C%20major%20BWV%20846%2C%20from%20The%20Well-Tempered%20Clavier%20I.flac&metadata=false Jun 02 10:48:21 smsl-n100 volumio[1436]: info: URI /mnt/NAS/CD/DG 111 Years of Deutsche Grammophon/(05) BACH Prelude in C major BWV 846, from The Well-Tempered Clavier I.flac Jun 02 10:48:21 smsl-n100 volumio[1436]: info: Exploding uri music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(06) CAMILLE SAINT-SAENS Le cygne, from Le Carnaval des Animaux (arr. by Paul Vidal).flac in service mpd Jun 02 10:48:21 smsl-n100 volumio[1436]: info: ALBUMART /albumart?cacheid=737&web=/111%20Years%20of%20Deutsche%20Grammophon/extralarge&path=%2Fmnt%2FNAS%2FCD%2FDG%20111%20Years%20of%20Deutsche%20Grammophon%2F(06)%20CAMILLE%20SAINT-SAENS%20Le%20cygne%2C%20from%20Le%20Carnaval%20des%20Animaux%20(arr.%20by%20Paul%20Vidal).flac&metadata=false Jun 02 10:48:21 smsl-n100 volumio[1436]: info: URI /mnt/NAS/CD/DG 111 Years of Deutsche Grammophon/(06) CAMILLE SAINT-SAENS Le cygne, from Le Carnaval des Animaux (arr. by Paul Vidal).flac Jun 02 10:48:21 smsl-n100 volumio[1436]: info: Exploding uri music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(07) CHARLES GOUNOD Ave Maria.flac in service mpd Jun 02 10:48:21 smsl-n100 volumio[1436]: info: ALBUMART /albumart?cacheid=737&web=/111%20Years%20of%20Deutsche%20Grammophon/extralarge&path=%2Fmnt%2FNAS%2FCD%2FDG%20111%20Years%20of%20Deutsche%20Grammophon%2F(07)%20CHARLES%20GOUNOD%20Ave%20Maria.flac&metadata=false Jun 02 10:48:21 smsl-n100 volumio[1436]: info: URI /mnt/NAS/CD/DG 111 Years of Deutsche Grammophon/(07) CHARLES GOUNOD Ave Maria.flac Jun 02 10:48:21 smsl-n100 volumio[1436]: info: Exploding uri music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(08) JOHANN PACHELBEL Canon in D major.flac in service mpd Jun 02 10:48:21 smsl-n100 volumio[1436]: info: ALBUMART /albumart?cacheid=737&web=/111%20Years%20of%20Deutsche%20Grammophon/extralarge&path=%2Fmnt%2FNAS%2FCD%2FDG%20111%20Years%20of%20Deutsche%20Grammophon%2F(08)%20JOHANN%20PACHELBEL%20Canon%20in%20D%20major.flac&metadata=false Jun 02 10:48:21 smsl-n100 volumio[1436]: info: URI /mnt/NAS/CD/DG 111 Years of Deutsche Grammophon/(08) JOHANN PACHELBEL Canon in D major.flac Jun 02 10:48:21 smsl-n100 volumio[1436]: info: Exploding uri music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(09) LUDWIG VAN BEETHOVEN Bagatelle in A minor WoO 59 - Fur Elise.flac in service mpd Jun 02 10:48:21 smsl-n100 volumio[1436]: info: ALBUMART /albumart?cacheid=737&web=/111%20Years%20of%20Deutsche%20Grammophon/extralarge&path=%2Fmnt%2FNAS%2FCD%2FDG%20111%20Years%20of%20Deutsche%20Grammophon%2F(09)%20LUDWIG%20VAN%20BEETHOVEN%20Bagatelle%20in%20A%20minor%20WoO%2059%20-%20Fur%20Elise.flac&metadata=false Jun 02 10:48:21 smsl-n100 volumio[1436]: info: URI /mnt/NAS/CD/DG 111 Years of Deutsche Grammophon/(09) LUDWIG VAN BEETHOVEN Bagatelle in A minor WoO 59 - Fur Elise.flac Jun 02 10:48:21 smsl-n100 volumio[1436]: info: Exploding uri music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(10) FELIX MENDELSSOHN Symphony No.5 in D minor 'Reformation' Op.107 - 2. Allegro vivace.flac in service mpd Jun 02 10:48:21 smsl-n100 volumio[1436]: info: ALBUMART /albumart?cacheid=737&web=/111%20Years%20of%20Deutsche%20Grammophon/extralarge&path=%2Fmnt%2FNAS%2FCD%2FDG%20111%20Years%20of%20Deutsche%20Grammophon%2F(10)%20FELIX%20MENDELSSOHN%20Symphony%20No.5%20in%20D%20minor%20'Reformation'%20Op.107%20-%202.%20Allegro%20vivace.flac&metadata=false Jun 02 10:48:21 smsl-n100 volumio[1436]: info: URI /mnt/NAS/CD/DG 111 Years of Deutsche Grammophon/(10) FELIX MENDELSSOHN Symphony No.5 in D minor 'Reformation' Op.107 - 2. Allegro vivace.flac Jun 02 10:48:21 smsl-n100 volumio[1436]: info: Exploding uri music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(11) BRAHMS Double Concerto in A minor Op.102 - 2. Andante.flac in service mpd Jun 02 10:48:21 smsl-n100 volumio[1436]: info: ALBUMART /albumart?cacheid=737&web=/111%20Years%20of%20Deutsche%20Grammophon/extralarge&path=%2Fmnt%2FNAS%2FCD%2FDG%20111%20Years%20of%20Deutsche%20Grammophon%2F(11)%20BRAHMS%20Double%20Concerto%20in%20A%20minor%20Op.102%20-%202.%20Andante.flac&metadata=false Jun 02 10:48:21 smsl-n100 volumio[1436]: info: URI /mnt/NAS/CD/DG 111 Years of Deutsche Grammophon/(11) BRAHMS Double Concerto in A minor Op.102 - 2. Andante.flac Jun 02 10:48:21 smsl-n100 volumio[1436]: info: Exploding uri music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(12) WIENIAWSKI Etude-Caprice in E major Op.18 No.5.flac in service mpd Jun 02 10:48:21 smsl-n100 volumio[1436]: info: ALBUMART /albumart?cacheid=737&web=/111%20Years%20of%20Deutsche%20Grammophon/extralarge&path=%2Fmnt%2FNAS%2FCD%2FDG%20111%20Years%20of%20Deutsche%20Grammophon%2F(12)%20WIENIAWSKI%20Etude-Caprice%20in%20E%20major%20Op.18%20No.5.flac&metadata=false Jun 02 10:48:21 smsl-n100 volumio[1436]: info: URI /mnt/NAS/CD/DG 111 Years of Deutsche Grammophon/(12) WIENIAWSKI Etude-Caprice in E major Op.18 No.5.flac Jun 02 10:48:21 smsl-n100 volumio[1436]: info: Exploding uri music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(13) STANLEY MYERS Cavatina (arr. by John Williams).flac in service mpd Jun 02 10:48:21 smsl-n100 volumio[1436]: info: ALBUMART /albumart?cacheid=737&web=/111%20Years%20of%20Deutsche%20Grammophon/extralarge&path=%2Fmnt%2FNAS%2FCD%2FDG%20111%20Years%20of%20Deutsche%20Grammophon%2F(13)%20STANLEY%20MYERS%20Cavatina%20(arr.%20by%20John%20Williams).flac&metadata=false Jun 02 10:48:21 smsl-n100 volumio[1436]: info: URI /mnt/NAS/CD/DG 111 Years of Deutsche Grammophon/(13) STANLEY MYERS Cavatina (arr. by John Williams).flac Jun 02 10:48:21 smsl-n100 volumio[1436]: info: Exploding uri music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(14) SCHUMANN Traumerei, from Kinderszenen Op.15.flac in service mpd Jun 02 10:48:21 smsl-n100 volumio[1436]: info: ALBUMART /albumart?cacheid=737&web=/111%20Years%20of%20Deutsche%20Grammophon/extralarge&path=%2Fmnt%2FNAS%2FCD%2FDG%20111%20Years%20of%20Deutsche%20Grammophon%2F(14)%20SCHUMANN%20Traumerei%2C%20from%20Kinderszenen%20Op.15.flac&metadata=false Jun 02 10:48:21 smsl-n100 volumio[1436]: info: URI /mnt/NAS/CD/DG 111 Years of Deutsche Grammophon/(14) SCHUMANN Traumerei, from Kinderszenen Op.15.flac Jun 02 10:48:21 smsl-n100 volumio[1436]: info: Exploding uri music-library/NAS/CD/DG 111 Years of Deutsche Grammophon/(15) DOMENICO SCARLATTI Sonata in E major K.135.flac in service mpd Jun 02 10:48:21 smsl-n100 volumio[1436]: info: ALBUMART /albumart?cacheid=737&web=/111%20Years%20of%20Deutsche%20Grammophon/extralarge&path=%2Fmnt%2FNAS%2FCD%2FDG%20111%20Years%20of%20Deutsche%20Grammophon%2F(15)%20DOMENICO%20SCARLATTI%20Sonata%20in%20E%20major%20K.135.flac&metadata=false Jun 02 10:48:21 smsl-n100 volumio[1436]: info: URI /mnt/NAS/CD/DG 111 Years of Deutsche Grammophon/(15) DOMENICO SCARLATTI Sonata in E major K.135.flac Jun 02 10:48:24 smsl-n100 volumio[1436]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jun 02 10:48:24 smsl-n100 volumio[1436]: info: Retrying Login Due to Network Error Jun 02 10:48:30 smsl-n100 volumio[1436]: info: Listing playlists Jun 02 10:48:31 smsl-n100 volumio[1436]: info: Saving local item Chi Jun 02 10:48:31 smsl-n100 volumio[1436]: info: Pushing Favourites {"uri":"/mnt/NAS/CD/DG 111 Years of Deutsche Grammophon/(07) CHARLES GOUNOD Ave Maria.flac","favourite":false} Jun 02 10:48:31 smsl-n100 volumio[1436]: info: Listing playlists Jun 02 10:48:34 smsl-n100 volumio[1436]: info: MyVolumio login type: Token Jun 02 10:48:50 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 02 10:48:50 smsl-n100 volumio[1436]: info: CURURI: albums://Ludwig%20van%20Beethoven/Gil%20Shaham%3A%20Violin%20Romances%20-%20(Orpheus%20Chamber%20Orchestra) Jun 02 10:48:50 smsl-n100 volumio[1436]: info: Preload queue cleared Jun 02 10:48:50 smsl-n100 volumio[1436]: info: Preloading song: music-library/NAS/CD/Gil Shaham - Romances/01 Gil Shaham (violin); Orpheus Chamber Orchestra - ELGAR- Salut D'amour.flac Jun 02 10:48:50 smsl-n100 volumio[1436]: info: Preloading song: music-library/NAS/CD/Gil Shaham - Romances/02 Gil Shaham (violin); Orpheus Chamber Orchestra - KREISLER- Schon Rosmarin.flac Jun 02 10:48:50 smsl-n100 volumio[1436]: info: Preloading song: music-library/NAS/CD/Gil Shaham - Romances/03 Gil Shaham (violin); Orpheus Chamber Orchestra - SVENDSEN- Romance In G Major.flac Jun 02 10:48:50 smsl-n100 volumio[1436]: info: Preloading song: music-library/NAS/CD/Gil Shaham - Romances/04 Gil Shaham (violin); Orpheus Chamber Orchestra - KREISLER- Liebesfreud.flac Jun 02 10:48:50 smsl-n100 volumio[1436]: info: Preloading song: music-library/NAS/CD/Gil Shaham - Romances/05 Gil Shaham (violin); Orpheus Chamber Orchestra - BEETHOVEN- Romance No. 1 In G Major.flac Jun 02 10:48:50 smsl-n100 volumio[1436]: info: Preloading song: music-library/NAS/CD/Gil Shaham - Romances/06 Gil Shaham (violin); Orpheus Chamber Orchestra - BEETHOVEN- Romance No. 2 In F Major.flac Jun 02 10:48:50 smsl-n100 volumio[1436]: info: Preloading song: music-library/NAS/CD/Gil Shaham - Romances/07 Gil Shaham (violin); Orpheus Chamber Orchestra - KREISLER- Liebesleid.flac Jun 02 10:48:50 smsl-n100 volumio[1436]: info: Preloading song: music-library/NAS/CD/Gil Shaham - Romances/08 Gil Shaham (violin); Orpheus Chamber Orchestra - TCHAIKOVSKY- Serenade Melancolique In B Minor.flac Jun 02 10:48:50 smsl-n100 volumio[1436]: info: Preloading song: music-library/NAS/CD/Gil Shaham - Romances/09 Gil Shaham (violin); Orpheus Chamber Orchestra - SARASATE- Romanza Andaluza.flac Jun 02 10:48:50 smsl-n100 volumio[1436]: info: Preloading song: music-library/NAS/CD/Gil Shaham - Romances/10 Gil Shaham (violin); Orpheus Chamber Orchestra - DVORAK- Romance In F Minor.flac Jun 02 10:48:50 smsl-n100 volumio[1436]: info: Exploding uri music-library/NAS/CD/Gil Shaham - Romances/01 Gil Shaham (violin); Orpheus Chamber Orchestra - ELGAR- Salut D'amour.flac in service mpd Jun 02 10:48:50 smsl-n100 volumio[1436]: info: ALBUMART /albumart?cacheid=737&web=Ludwig%20van%20Beethoven/Gil%20Shaham%3A%20Violin%20Romances%20-%20(Orpheus%20Chamber%20Orchestra)/extralarge&path=%2Fmnt%2FNAS%2FCD%2FGil%20Shaham%20-%20Romances%2F01%20Gil%20Shaham%20(violin)%3B%20Orpheus%20Chamber%20Orchestra%20-%20ELGAR-%20Salut%20D'amour.flac&metadata=false Jun 02 10:48:50 smsl-n100 volumio[1436]: info: URI /mnt/NAS/CD/Gil Shaham - Romances/01 Gil Shaham (violin); Orpheus Chamber Orchestra - ELGAR- Salut D'amour.flac Jun 02 10:48:50 smsl-n100 volumio[1436]: info: Exploding uri music-library/NAS/CD/Gil Shaham - Romances/02 Gil Shaham (violin); Orpheus Chamber Orchestra - KREISLER- Schon Rosmarin.flac in service mpd Jun 02 10:48:50 smsl-n100 volumio[1436]: info: ALBUMART /albumart?cacheid=737&web=Ludwig%20van%20Beethoven/Gil%20Shaham%3A%20Violin%20Romances%20-%20(Orpheus%20Chamber%20Orchestra)/extralarge&path=%2Fmnt%2FNAS%2FCD%2FGil%20Shaham%20-%20Romances%2F02%20Gil%20Shaham%20(violin)%3B%20Orpheus%20Chamber%20Orchestra%20-%20KREISLER-%20Schon%20Rosmarin.flac&metadata=false Jun 02 10:48:50 smsl-n100 volumio[1436]: info: URI /mnt/NAS/CD/Gil Shaham - Romances/02 Gil Shaham (violin); Orpheus Chamber Orchestra - KREISLER- Schon Rosmarin.flac Jun 02 10:48:50 smsl-n100 volumio[1436]: info: Executing endpoint getSimilarAlbums Jun 02 10:48:50 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Jun 02 10:48:50 smsl-n100 volumio[1436]: info: Exploding uri music-library/NAS/CD/Gil Shaham - Romances/03 Gil Shaham (violin); Orpheus Chamber Orchestra - SVENDSEN- Romance In G Major.flac in service mpd Jun 02 10:48:50 smsl-n100 volumio[1436]: info: ALBUMART /albumart?cacheid=737&web=Ludwig%20van%20Beethoven/Gil%20Shaham%3A%20Violin%20Romances%20-%20(Orpheus%20Chamber%20Orchestra)/extralarge&path=%2Fmnt%2FNAS%2FCD%2FGil%20Shaham%20-%20Romances%2F03%20Gil%20Shaham%20(violin)%3B%20Orpheus%20Chamber%20Orchestra%20-%20SVENDSEN-%20Romance%20In%20G%20Major.flac&metadata=false Jun 02 10:48:50 smsl-n100 volumio[1436]: info: URI /mnt/NAS/CD/Gil Shaham - Romances/03 Gil Shaham (violin); Orpheus Chamber Orchestra - SVENDSEN- Romance In G Major.flac Jun 02 10:48:51 smsl-n100 volumio[1436]: info: Exploding uri music-library/NAS/CD/Gil Shaham - Romances/04 Gil Shaham (violin); Orpheus Chamber Orchestra - KREISLER- Liebesfreud.flac in service mpd Jun 02 10:48:51 smsl-n100 volumio[1436]: info: ALBUMART /albumart?cacheid=737&web=Ludwig%20van%20Beethoven/Gil%20Shaham%3A%20Violin%20Romances%20-%20(Orpheus%20Chamber%20Orchestra)/extralarge&path=%2Fmnt%2FNAS%2FCD%2FGil%20Shaham%20-%20Romances%2F04%20Gil%20Shaham%20(violin)%3B%20Orpheus%20Chamber%20Orchestra%20-%20KREISLER-%20Liebesfreud.flac&metadata=false Jun 02 10:48:51 smsl-n100 volumio[1436]: info: URI /mnt/NAS/CD/Gil Shaham - Romances/04 Gil Shaham (violin); Orpheus Chamber Orchestra - KREISLER- Liebesfreud.flac Jun 02 10:48:51 smsl-n100 volumio[1436]: info: Executing endpoint metavolumio Jun 02 10:48:51 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 02 10:48:51 smsl-n100 volumio[1436]: info: Executing endpoint metavolumio Jun 02 10:48:51 smsl-n100 volumio[1436]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 02 10:48:51 smsl-n100 volumio[1436]: info: Exploding uri music-library/NAS/CD/Gil Shaham - Romances/05 Gil Shaham (violin); Orpheus Chamber Orchestra - BEETHOVEN- Romance No. 1 In G Major.flac in service mpd Jun 02 10:48:51 smsl-n100 volumio[1436]: info: ALBUMART /albumart?cacheid=737&web=Ludwig%20van%20Beethoven/Gil%20Shaham%3A%20Violin%20Romances%20-%20(Orpheus%20Chamber%20Orchestra)/extralarge&path=%2Fmnt%2FNAS%2FCD%2FGil%20Shaham%20-%20Romances%2F05%20Gil%20Shaham%20(violin)%3B%20Orpheus%20Chamber%20Orchestra%20-%20BEETHOVEN-%20Romance%20No.%201%20In%20G%20Major.flac&metadata=false Jun 02 10:48:51 smsl-n100 volumio[1436]: info: URI /mnt/NAS/CD/Gil Shaham - Romances/05 Gil Shaham (violin); Orpheus Chamber Orchestra - BEETHOVEN- Romance No. 1 In G Major.flac Jun 02 10:48:51 smsl-n100 volumio[1436]: info: Exploding uri music-library/NAS/CD/Gil Shaham - Romances/06 Gil Shaham (violin); Orpheus Chamber Orchestra - BEETHOVEN- Romance No. 2 In F Major.flac in service mpd Jun 02 10:48:51 smsl-n100 volumio[1436]: info: ALBUMART /albumart?cacheid=737&web=Ludwig%20van%20Beethoven/Gil%20Shaham%3A%20Violin%20Romances%20-%20(Orpheus%20Chamber%20Orchestra)/extralarge&path=%2Fmnt%2FNAS%2FCD%2FGil%20Shaham%20-%20Romances%2F06%20Gil%20Shaham%20(violin)%3B%20Orpheus%20Chamber%20Orchestra%20-%20BEETHOVEN-%20Romance%20No.%202%20In%20F%20Major.flac&metadata=false Jun 02 10:48:51 smsl-n100 volumio[1436]: info: URI /mnt/NAS/CD/Gil Shaham - Romances/06 Gil Shaham (violin); Orpheus Chamber Orchestra - BEETHOVEN- Romance No. 2 In F Major.flac Jun 02 10:48:51 smsl-n100 volumio[1436]: info: Exploding uri music-library/NAS/CD/Gil Shaham - Romances/07 Gil Shaham (violin); Orpheus Chamber Orchestra - KREISLER- Liebesleid.flac in service mpd Jun 02 10:48:51 smsl-n100 volumio[1436]: info: ALBUMART /albumart?cacheid=737&web=Ludwig%20van%20Beethoven/Gil%20Shaham%3A%20Violin%20Romances%20-%20(Orpheus%20Chamber%20Orchestra)/extralarge&path=%2Fmnt%2FNAS%2FCD%2FGil%20Shaham%20-%20Romances%2F07%20Gil%20Shaham%20(violin)%3B%20Orpheus%20Chamber%20Orchestra%20-%20KREISLER-%20Liebesleid.flac&metadata=false Jun 02 10:48:51 smsl-n100 volumio[1436]: info: URI /mnt/NAS/CD/Gil Shaham - Romances/07 Gil Shaham (violin); Orpheus Chamber Orchestra - KREISLER- Liebesleid.flac Jun 02 10:48:51 smsl-n100 volumio[1436]: info: Exploding uri music-library/NAS/CD/Gil Shaham - Romances/08 Gil Shaham (violin); Orpheus Chamber Orchestra - TCHAIKOVSKY- Serenade Melancolique In B Minor.flac in service mpd Jun 02 10:48:51 smsl-n100 volumio[1436]: info: ALBUMART /albumart?cacheid=737&web=Ludwig%20van%20Beethoven/Gil%20Shaham%3A%20Violin%20Romances%20-%20(Orpheus%20Chamber%20Orchestra)/extralarge&path=%2Fmnt%2FNAS%2FCD%2FGil%20Shaham%20-%20Romances%2F08%20Gil%20Shaham%20(violin)%3B%20Orpheus%20Chamber%20Orchestra%20-%20TCHAIKOVSKY-%20Serenade%20Melancolique%20In%20B%20Minor.flac&metadata=false Jun 02 10:48:51 smsl-n100 volumio[1436]: info: URI /mnt/NAS/CD/Gil Shaham - Romances/08 Gil Shaham (violin); Orpheus Chamber Orchestra - TCHAIKOVSKY- Serenade Melancolique In B Minor.flac Jun 02 10:48:51 smsl-n100 volumio[1436]: info: Exploding uri music-library/NAS/CD/Gil Shaham - Romances/09 Gil Shaham (violin); Orpheus Chamber Orchestra - SARASATE- Romanza Andaluza.flac in service mpd Jun 02 10:48:51 smsl-n100 volumio[1436]: info: ALBUMART /albumart?cacheid=737&web=Ludwig%20van%20Beethoven/Gil%20Shaham%3A%20Violin%20Romances%20-%20(Orpheus%20Chamber%20Orchestra)/extralarge&path=%2Fmnt%2FNAS%2FCD%2FGil%20Shaham%20-%20Romances%2F09%20Gil%20Shaham%20(violin)%3B%20Orpheus%20Chamber%20Orchestra%20-%20SARASATE-%20Romanza%20Andaluza.flac&metadata=false Jun 02 10:48:51 smsl-n100 volumio[1436]: info: URI /mnt/NAS/CD/Gil Shaham - Romances/09 Gil Shaham (violin); Orpheus Chamber Orchestra - SARASATE- Romanza Andaluza.flac Jun 02 10:48:51 smsl-n100 volumio[1436]: info: Exploding uri music-library/NAS/CD/Gil Shaham - Romances/10 Gil Shaham (violin); Orpheus Chamber Orchestra - DVORAK- Romance In F Minor.flac in service mpd Jun 02 10:48:51 smsl-n100 volumio[1436]: info: ALBUMART /albumart?cacheid=737&web=Ludwig%20van%20Beethoven/Gil%20Shaham%3A%20Violin%20Romances%20-%20(Orpheus%20Chamber%20Orchestra)/extralarge&path=%2Fmnt%2FNAS%2FCD%2FGil%20Shaham%20-%20Romances%2F10%20Gil%20Shaham%20(violin)%3B%20Orpheus%20Chamber%20Orchestra%20-%20DVORAK-%20Romance%20In%20F%20Minor.flac&metadata=false Jun 02 10:48:51 smsl-n100 volumio[1436]: info: URI /mnt/NAS/CD/Gil Shaham - Romances/10 Gil Shaham (violin); Orpheus Chamber Orchestra - DVORAK- Romance In F Minor.flac Jun 02 10:48:54 smsl-n100 volumio[1436]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 10:48:54 smsl-n100 volumio[1436]: Error: connect ETIMEDOUT 154.85.102.30:443 Jun 02 10:48:54 smsl-n100 volumio[1436]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jun 02 10:48:54 smsl-n100 volumio[1436]: errno: -110, Jun 02 10:48:54 smsl-n100 volumio[1436]: code: 'ETIMEDOUT', Jun 02 10:48:54 smsl-n100 volumio[1436]: syscall: 'connect', Jun 02 10:48:54 smsl-n100 volumio[1436]: address: '154.85.102.30', Jun 02 10:48:54 smsl-n100 volumio[1436]: port: 443 Jun 02 10:48:54 smsl-n100 volumio[1436]: } Jun 02 10:48:54 smsl-n100 volumio[1436]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 10:48:55 smsl-n100 sudo[2378]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-06-02 10:47 Jun 02 10:48:55 smsl-n100 sudo[2378]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="cc50ad4a2058d01de272214eb33827883bd2b7d8" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="3441cddd43405c36fe444484553f10f2f5bc830b" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="smsl" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 13 Nov 2025 12:39:08 PM CET" VOLUMIO_VERSION="3.874" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR_MODEL="SMSL S100" VOLUMIO_VENDOR="SMSL" VOLUMIO_MODEL="S100" VOLUMIO_HASH="7a92d73f7a04bc7854b1812143743fd4"