-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Tue 2026-06-02 10:55:21 CST. -- Jun 02 10:54:00 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:00 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 4 Jun 02 10:54:00 smsl-n100 volumio[2440]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:54:00 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:00 smsl-n100 volumio[2440]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:54:00 smsl-n100 volumio[2440]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:54:00 smsl-n100 volumio[2440]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:54:00 smsl-n100 volumio[2440]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:54:05 smsl-n100 volumio[2440]: info: Listing playlists Jun 02 10:54:06 smsl-n100 volumio[2440]: info: MyVolumio login type: Token Jun 02 10:54:06 smsl-n100 volumio[2440]: info: Saving local item Chi Jun 02 10:54:06 smsl-n100 volumio[2440]: info: Pushing Favourites {"uri":"/mnt/NAS/CD/Hewitt - Bach Arrangements/07 - Jesu, Joy Of Man's Desiring ('Jesu Bleibet Meine Freude' From Cantata No 147, BWV147).flac","favourite":false} Jun 02 10:54:06 smsl-n100 volumio[2440]: info: Listing playlists Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Preload queue cleared Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::ClearQueue Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::stop Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::stPlaybackTimer Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::updateTrackBlock Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrackBlock Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 4 Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::serviceStop Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 4 Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreCommandRouter::serviceStop Jun 02 10:54:12 smsl-n100 volumio[2440]: info: ControllerMpd::stop Jun 02 10:54:12 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CorePlayQueue::clearPlayQueue Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CorePlayQueue::saveQueue Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::addQueueItems Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CorePlayQueue::addQueueItems Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Preload queue cleared Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/01 - Sinfonia In D Major (From Cantata No 29, BWV29).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/01 - Sinfonia In D Major (From Cantata No 29, BWV29).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/02 - Siciliano In G Minor (From Flute Sonata In E Flat, BWV1031).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/02 - Siciliano In G Minor (From Flute Sonata In E Flat, BWV1031).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/03 - Nun Komm, Der Heiden Heiland BWV 659 (From Leipzig Chorales ('The Eighteen')).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/03 - Nun Komm, Der Heiden Heiland BWV 659 (From Leipzig Chorales ('The Eighteen')).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/04 - Wachet Auf, Ruft Uns Die Stimme BWV 639 (From Schübler Chorales).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/04 - Wachet Auf, Ruft Uns Die Stimme BWV 639 (From Schübler Chorales).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/05 - Ich Ruf' Zu Dir, Herr Jesu Christ (From Orgelbüchlein).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/05 - Ich Ruf' Zu Dir, Herr Jesu Christ (From Orgelbüchlein).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/06 - Sheep May Safely Graze ('Schäfe Können Sicher Weiden' From Cantata No 208, BWV208).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/06 - Sheep May Safely Graze ('Schäfe Können Sicher Weiden' From Cantata No 208, BWV208).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/07 - Jesu, Joy Of Man's Desiring ('Jesu Bleibet Meine Freude' From Cantata No 147, BWV147).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/07 - Jesu, Joy Of Man's Desiring ('Jesu Bleibet Meine Freude' From Cantata No 147, BWV147).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/08 - Wenn Wir In Höchsten Nöten Sein BWV 641 (From Orgelbüchlein).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/08 - Wenn Wir In Höchsten Nöten Sein BWV 641 (From Orgelbüchlein).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/09 - Das Alte Jahr Vergangen Ist BWV614 (From Orgelbüchlein).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/09 - Das Alte Jahr Vergangen Ist BWV614 (From Orgelbüchlein).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/10 - In Dulci Jubilo BWV729.flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/10 - In Dulci Jubilo BWV729.flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CorePlayQueue::saveQueue Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::updateTrackBlock Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrackBlock Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPlay Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::play index 9 Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::addQueueItems Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CorePlayQueue::addQueueItems Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Preload queue cleared Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/11 - Herzlich Tut Mich Verlangen BWV727.flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/11 - Herzlich Tut Mich Verlangen BWV727.flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/12 - Meine Seele Erhebt Den Herrn BWV648 (From Schübler Chorales).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/12 - Meine Seele Erhebt Den Herrn BWV648 (From Schübler Chorales).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/13 - O Mensch, Bewein Dein Sünde Gross BWV622 (From Orgelbüchlein).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/13 - O Mensch, Bewein Dein Sünde Gross BWV622 (From Orgelbüchlein).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/14 - Sanctify Us By Thy Goodness (From Cantata No 22, BWV22).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/14 - Sanctify Us By Thy Goodness (From Cantata No 22, BWV22).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/15 - Die Seele Ruht In Jesu Händen (From Cantata No 127, BWV127).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/15 - Die Seele Ruht In Jesu Händen (From Cantata No 127, BWV127).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/16 - Passacaglia In C Minor BWV582.flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/16 - Passacaglia In C Minor BWV582.flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/17 - Alle Menschen Müssen Sterben BWV643 (From Orgelbüchlein).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/17 - Alle Menschen Müssen Sterben BWV643 (From Orgelbüchlein).flac Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::stop Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CorePlayQueue::saveQueue Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::play index undefined Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::updateTrackBlock Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrackBlock Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::startPlaybackTimer Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:12 smsl-n100 volumio[2440]: verbose: ControllerMpd::clearAddPlayTracks NAS/CD/Hewitt - Bach Arrangements/10 - In Dulci Jubilo BWV729.flac Jun 02 10:54:12 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 10:54:12 smsl-n100 volumio[2440]: error: Failed request for metavolumio API Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Jun 02 10:54:12 smsl-n100 volumio[2440]: ---------------------------- MPD announces state update: player Jun 02 10:54:12 smsl-n100 volumio[2440]: info: sendMpdCommand stop took 183 milliseconds Jun 02 10:54:12 smsl-n100 volumio[2440]: info: ControllerMpd::getState Jun 02 10:54:12 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:54:12 smsl-n100 volumio[2440]: info: sendMpdCommand stop took 61 milliseconds Jun 02 10:54:12 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand clear Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Jun 02 10:54:12 smsl-n100 volumio[2440]: ---------------------------- MPD announces state update: player Jun 02 10:54:12 smsl-n100 volumio[2440]: info: ControllerMpd::getState Jun 02 10:54:12 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Jun 02 10:54:12 smsl-n100 volumio[2440]: ---------------------------- MPD announces state update: player Jun 02 10:54:12 smsl-n100 volumio[2440]: info: ControllerMpd::getState Jun 02 10:54:12 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Jun 02 10:54:12 smsl-n100 volumio[2440]: ---------------------------- MPD announces system playlist update Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Ignoring MPD Status Update Jun 02 10:54:12 smsl-n100 volumio[2440]: info: sendMpdCommand status took 24 milliseconds Jun 02 10:54:12 smsl-n100 volumio[2440]: info: sendMpdCommand clear took 22 milliseconds Jun 02 10:54:12 smsl-n100 volumio[2440]: info: sendMpdCommand status took 18 milliseconds Jun 02 10:54:12 smsl-n100 volumio[2440]: info: sendMpdCommand status took 14 milliseconds Jun 02 10:54:12 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseState Jun 02 10:54:12 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:54:12 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand add "NAS/CD/Hewitt - Bach Arrangements/10 - In Dulci Jubilo BWV729.flac" Jun 02 10:54:12 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseState Jun 02 10:54:12 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseState Jun 02 10:54:12 smsl-n100 volumio[2440]: info: ControllerMpd::pushState Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreCommandRouter::servicePushState Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:12 smsl-n100 volumio[2440]: 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:54:12 smsl-n100 volumio[2440]: verbose: CURRENT POSITION 9 Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState stateService stop Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:12 smsl-n100 volumio[2440]: info: No code Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:12 smsl-n100 volumio[2440]: info: ControllerMpd::pushState Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreCommandRouter::servicePushState Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:12 smsl-n100 volumio[2440]: 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:54:12 smsl-n100 volumio[2440]: verbose: CURRENT POSITION 9 Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState stateService stop Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:12 smsl-n100 volumio[2440]: info: No code Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:12 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:12 smsl-n100 volumio[2440]: info: ------------------------------ 134ms Jun 02 10:54:12 smsl-n100 volumio[2440]: info: ------------------------------ 132ms Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Jun 02 10:54:12 smsl-n100 volumio[2440]: ---------------------------- MPD announces system playlist update Jun 02 10:54:12 smsl-n100 volumio[2440]: info: Ignoring MPD Status Update Jun 02 10:54:13 smsl-n100 volumio[2440]: info: Jun 02 10:54:13 smsl-n100 volumio[2440]: ---------------------------- MPD announces system playlist update Jun 02 10:54:13 smsl-n100 volumio[2440]: info: Ignoring MPD Status Update Jun 02 10:54:13 smsl-n100 volumio[2440]: error: updateQueue error: null Jun 02 10:54:13 smsl-n100 volumio[2440]: info: Jun 02 10:54:13 smsl-n100 volumio[2440]: ---------------------------- MPD announces system playlist update Jun 02 10:54:13 smsl-n100 volumio[2440]: info: Ignoring MPD Status Update Jun 02 10:54:13 smsl-n100 volumio[2440]: info: ------------------------------ 148ms Jun 02 10:54:13 smsl-n100 volumio[2440]: info: sendMpdCommand playlistinfo took 140 milliseconds Jun 02 10:54:13 smsl-n100 volumio[2440]: info: sendMpdCommand add "NAS/CD/Hewitt - Bach Arrangements/10 - In Dulci Jubilo BWV729.flac" took 140 milliseconds Jun 02 10:54:13 smsl-n100 volumio[2440]: info: ------------------------------ 28ms Jun 02 10:54:13 smsl-n100 volumio[2440]: info: ------------------------------ 24ms Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand play Jun 02 10:54:13 smsl-n100 volumio[2440]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 02 10:54:13 smsl-n100 volumio[2440]: info: ------------------------------ 184ms Jun 02 10:54:13 smsl-n100 volumio[2440]: info: Jun 02 10:54:13 smsl-n100 volumio[2440]: ---------------------------- MPD announces system playlist update Jun 02 10:54:13 smsl-n100 volumio[2440]: info: Ignoring MPD Status Update Jun 02 10:54:13 smsl-n100 volumio[2440]: info: Jun 02 10:54:13 smsl-n100 volumio[2440]: ---------------------------- MPD announces system playlist update Jun 02 10:54:13 smsl-n100 volumio[2440]: info: Ignoring MPD Status Update Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:13 smsl-n100 volumio[2440]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:54:13 smsl-n100 volumio[2440]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:54:13 smsl-n100 volumio[2440]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:54:13 smsl-n100 volumio[2440]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:54:13 smsl-n100 volumio[2440]: info: Jun 02 10:54:13 smsl-n100 volumio[2440]: ---------------------------- MPD announces state update: player Jun 02 10:54:13 smsl-n100 volumio[2440]: info: ------------------------------ 122ms Jun 02 10:54:13 smsl-n100 volumio[2440]: info: sendMpdCommand play took 112 milliseconds Jun 02 10:54:13 smsl-n100 volumio[2440]: info: ------------------------------ 108ms Jun 02 10:54:13 smsl-n100 volumio[2440]: info: ------------------------------ 105ms Jun 02 10:54:13 smsl-n100 volumio[2440]: info: ControllerMpd::getState Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:54:13 smsl-n100 volumio[2440]: info: Jun 02 10:54:13 smsl-n100 volumio[2440]: ---------------------------- MPD announces state update: player Jun 02 10:54:13 smsl-n100 volumio[2440]: info: ControllerMpd::getState Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:54:13 smsl-n100 volumio[2440]: info: Jun 02 10:54:13 smsl-n100 volumio[2440]: ---------------------------- MPD announces state update: player Jun 02 10:54:13 smsl-n100 volumio[2440]: info: ControllerMpd::getState Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:54:13 smsl-n100 volumio[2440]: info: Jun 02 10:54:13 smsl-n100 volumio[2440]: ---------------------------- MPD announces state update: player Jun 02 10:54:13 smsl-n100 volumio[2440]: info: ControllerMpd::getState Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:54:13 smsl-n100 volumio[2440]: info: sendMpdCommand status took 29 milliseconds Jun 02 10:54:13 smsl-n100 volumio[2440]: info: sendMpdCommand status took 23 milliseconds Jun 02 10:54:13 smsl-n100 volumio[2440]: info: sendMpdCommand status took 16 milliseconds Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseState Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseState Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseState Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:54:13 smsl-n100 volumio[2440]: info: Jun 02 10:54:13 smsl-n100 volumio[2440]: ---------------------------- MPD announces state update: player Jun 02 10:54:13 smsl-n100 volumio[2440]: info: ControllerMpd::getState Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:54:13 smsl-n100 volumio[2440]: info: Jun 02 10:54:13 smsl-n100 volumio[2440]: ---------------------------- MPD announces state update: player Jun 02 10:54:13 smsl-n100 volumio[2440]: info: ControllerMpd::getState Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:54:13 smsl-n100 volumio[2440]: info: sendMpdCommand status took 68 milliseconds Jun 02 10:54:13 smsl-n100 volumio[2440]: info: sendMpdCommand playlistinfo took 58 milliseconds Jun 02 10:54:13 smsl-n100 volumio[2440]: info: sendMpdCommand playlistinfo took 57 milliseconds Jun 02 10:54:13 smsl-n100 volumio[2440]: info: sendMpdCommand playlistinfo took 56 milliseconds Jun 02 10:54:13 smsl-n100 volumio[2440]: info: sendMpdCommand status took 46 milliseconds Jun 02 10:54:13 smsl-n100 volumio[2440]: info: sendMpdCommand status took 39 milliseconds Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseState Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseState Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseState Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:54:13 smsl-n100 volumio[2440]: info: ControllerMpd::pushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreCommandRouter::servicePushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":121,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"459 Kbps","isStreaming":false,"title":"In Dulci Jubilo BWV729","artist":"Angela Hewitt , Bach Transcriptions By Myra Hess , Wilhelm Kempff , Harriet Cohen , Lord Berners , Herbert Howells , William Walton , John Ireland , Mary Howe , Eugen D'Albert , Harold Bauer","album":"Bach Arrangements","uri":"NAS/CD/Hewitt - Bach Arrangements/10 - In Dulci Jubilo BWV729.flac","trackType":"flac"} Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: CURRENT POSITION 9 Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState stateService play Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:54:13 smsl-n100 volumio[2440]: info: ControllerMpd::pushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreCommandRouter::servicePushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":121,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"437 Kbps","isStreaming":false,"title":"In Dulci Jubilo BWV729","artist":"Angela Hewitt , Bach Transcriptions By Myra Hess , Wilhelm Kempff , Harriet Cohen , Lord Berners , Herbert Howells , William Walton , John Ireland , Mary Howe , Eugen D'Albert , Harold Bauer","album":"Bach Arrangements","uri":"NAS/CD/Hewitt - Bach Arrangements/10 - In Dulci Jubilo BWV729.flac","trackType":"flac"} Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: CURRENT POSITION 9 Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState stateService play Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:54:13 smsl-n100 volumio[2440]: info: Received an update from plugin. extracting info from payload Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: ControllerMpd::pushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreCommandRouter::servicePushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":121,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"437 Kbps","isStreaming":false,"title":"In Dulci Jubilo BWV729","artist":"Angela Hewitt , Bach Transcriptions By Myra Hess , Wilhelm Kempff , Harriet Cohen , Lord Berners , Herbert Howells , William Walton , John Ireland , Mary Howe , Eugen D'Albert , Harold Bauer","album":"Bach Arrangements","uri":"NAS/CD/Hewitt - Bach Arrangements/10 - In Dulci Jubilo BWV729.flac","trackType":"flac"} Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: CURRENT POSITION 9 Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState stateService play Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:54:13 smsl-n100 volumio[2440]: info: Received an update from plugin. extracting info from payload Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: ------------------------------ 231ms Jun 02 10:54:13 smsl-n100 volumio[2440]: info: ------------------------------ 273ms Jun 02 10:54:13 smsl-n100 volumio[2440]: info: ------------------------------ 269ms Jun 02 10:54:13 smsl-n100 volumio[2440]: info: sendMpdCommand playlistinfo took 176 milliseconds Jun 02 10:54:13 smsl-n100 volumio[2440]: info: sendMpdCommand playlistinfo took 168 milliseconds Jun 02 10:54:13 smsl-n100 volumio[2440]: info: sendMpdCommand playlistinfo took 167 milliseconds Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:54:13 smsl-n100 volumio[2440]: info: ControllerMpd::pushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreCommandRouter::servicePushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":121,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"437 Kbps","isStreaming":false,"title":"In Dulci Jubilo BWV729","artist":"Angela Hewitt , Bach Transcriptions By Myra Hess , Wilhelm Kempff , Harriet Cohen , Lord Berners , Herbert Howells , William Walton , John Ireland , Mary Howe , Eugen D'Albert , Harold Bauer","album":"Bach Arrangements","uri":"NAS/CD/Hewitt - Bach Arrangements/10 - In Dulci Jubilo BWV729.flac","trackType":"flac"} Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: CURRENT POSITION 9 Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState stateService play Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:54:13 smsl-n100 volumio[2440]: info: Received an update from plugin. extracting info from payload Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: ControllerMpd::pushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreCommandRouter::servicePushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":121,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"437 Kbps","isStreaming":false,"title":"In Dulci Jubilo BWV729","artist":"Angela Hewitt , Bach Transcriptions By Myra Hess , Wilhelm Kempff , Harriet Cohen , Lord Berners , Herbert Howells , William Walton , John Ireland , Mary Howe , Eugen D'Albert , Harold Bauer","album":"Bach Arrangements","uri":"NAS/CD/Hewitt - Bach Arrangements/10 - In Dulci Jubilo BWV729.flac","trackType":"flac"} Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: CURRENT POSITION 9 Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState stateService play Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:54:13 smsl-n100 volumio[2440]: info: Received an update from plugin. extracting info from payload Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: ControllerMpd::pushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreCommandRouter::servicePushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":121,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"437 Kbps","isStreaming":false,"title":"In Dulci Jubilo BWV729","artist":"Angela Hewitt , Bach Transcriptions By Myra Hess , Wilhelm Kempff , Harriet Cohen , Lord Berners , Herbert Howells , William Walton , John Ireland , Mary Howe , Eugen D'Albert , Harold Bauer","album":"Bach Arrangements","uri":"NAS/CD/Hewitt - Bach Arrangements/10 - In Dulci Jubilo BWV729.flac","trackType":"flac"} Jun 02 10:54:13 smsl-n100 volumio[2440]: verbose: CURRENT POSITION 9 Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState stateService play Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:54:13 smsl-n100 volumio[2440]: info: Received an update from plugin. extracting info from payload Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: ------------------------------ 518ms Jun 02 10:54:13 smsl-n100 volumio[2440]: info: ------------------------------ 493ms Jun 02 10:54:13 smsl-n100 volumio[2440]: info: ------------------------------ 489ms Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:54:13 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:13 smsl-n100 volumio[2440]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:54:13 smsl-n100 volumio[2440]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:54:13 smsl-n100 volumio[2440]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:54:13 smsl-n100 volumio[2440]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Preload queue cleared Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::ClearQueue Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::stop Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::stPlaybackTimer Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::updateTrackBlock Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrackBlock Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::serviceStop Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 9 Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::serviceStop Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ControllerMpd::stop Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::clearPlayQueue Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::saveQueue Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::addQueueItems Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::addQueueItems Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Preload queue cleared Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/01 - Sinfonia In D Major (From Cantata No 29, BWV29).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/01 - Sinfonia In D Major (From Cantata No 29, BWV29).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/02 - Siciliano In G Minor (From Flute Sonata In E Flat, BWV1031).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/02 - Siciliano In G Minor (From Flute Sonata In E Flat, BWV1031).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/03 - Nun Komm, Der Heiden Heiland BWV 659 (From Leipzig Chorales ('The Eighteen')).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/03 - Nun Komm, Der Heiden Heiland BWV 659 (From Leipzig Chorales ('The Eighteen')).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/04 - Wachet Auf, Ruft Uns Die Stimme BWV 639 (From Schübler Chorales).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/04 - Wachet Auf, Ruft Uns Die Stimme BWV 639 (From Schübler Chorales).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/05 - Ich Ruf' Zu Dir, Herr Jesu Christ (From Orgelbüchlein).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/05 - Ich Ruf' Zu Dir, Herr Jesu Christ (From Orgelbüchlein).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/06 - Sheep May Safely Graze ('Schäfe Können Sicher Weiden' From Cantata No 208, BWV208).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/06 - Sheep May Safely Graze ('Schäfe Können Sicher Weiden' From Cantata No 208, BWV208).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::saveQueue Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::updateTrackBlock Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrackBlock Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPlay Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::play index 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::addQueueItems Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::addQueueItems Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Preload queue cleared Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/07 - Jesu, Joy Of Man's Desiring ('Jesu Bleibet Meine Freude' From Cantata No 147, BWV147).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/07 - Jesu, Joy Of Man's Desiring ('Jesu Bleibet Meine Freude' From Cantata No 147, BWV147).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/08 - Wenn Wir In Höchsten Nöten Sein BWV 641 (From Orgelbüchlein).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/08 - Wenn Wir In Höchsten Nöten Sein BWV 641 (From Orgelbüchlein).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/09 - Das Alte Jahr Vergangen Ist BWV614 (From Orgelbüchlein).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/09 - Das Alte Jahr Vergangen Ist BWV614 (From Orgelbüchlein).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/10 - In Dulci Jubilo BWV729.flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/10 - In Dulci Jubilo BWV729.flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/11 - Herzlich Tut Mich Verlangen BWV727.flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/11 - Herzlich Tut Mich Verlangen BWV727.flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/12 - Meine Seele Erhebt Den Herrn BWV648 (From Schübler Chorales).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/12 - Meine Seele Erhebt Den Herrn BWV648 (From Schübler Chorales).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/13 - O Mensch, Bewein Dein Sünde Gross BWV622 (From Orgelbüchlein).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/13 - O Mensch, Bewein Dein Sünde Gross BWV622 (From Orgelbüchlein).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/14 - Sanctify Us By Thy Goodness (From Cantata No 22, BWV22).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/14 - Sanctify Us By Thy Goodness (From Cantata No 22, BWV22).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/15 - Die Seele Ruht In Jesu Händen (From Cantata No 127, BWV127).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/15 - Die Seele Ruht In Jesu Händen (From Cantata No 127, BWV127).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/16 - Passacaglia In C Minor BWV582.flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/16 - Passacaglia In C Minor BWV582.flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Adding Item to queue: music-library/NAS/CD/Hewitt - Bach Arrangements/17 - Alle Menschen Müssen Sterben BWV643 (From Orgelbüchlein).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Using cached record of: music-library/NAS/CD/Hewitt - Bach Arrangements/17 - Alle Menschen Müssen Sterben BWV643 (From Orgelbüchlein).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::stop Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::saveQueue Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::play index undefined Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::updateTrackBlock Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrackBlock Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::startPlaybackTimer Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::clearAddPlayTracks NAS/CD/Hewitt - Bach Arrangements/06 - Sheep May Safely Graze ('Schäfe Können Sicher Weiden' From Cantata No 208, BWV208).flac Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand stop Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Jun 02 10:54:20 smsl-n100 volumio[2440]: ---------------------------- MPD announces state update: player Jun 02 10:54:20 smsl-n100 volumio[2440]: info: sendMpdCommand stop took 129 milliseconds Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ControllerMpd::getState Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:54:20 smsl-n100 volumio[2440]: info: sendMpdCommand stop took 33 milliseconds Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand clear Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Jun 02 10:54:20 smsl-n100 volumio[2440]: ---------------------------- MPD announces state update: player Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ControllerMpd::getState Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Jun 02 10:54:20 smsl-n100 volumio[2440]: ---------------------------- MPD announces state update: player Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ControllerMpd::getState Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Jun 02 10:54:20 smsl-n100 volumio[2440]: ---------------------------- MPD announces system playlist update Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Ignoring MPD Status Update Jun 02 10:54:20 smsl-n100 volumio[2440]: info: sendMpdCommand status took 21 milliseconds Jun 02 10:54:20 smsl-n100 volumio[2440]: info: sendMpdCommand clear took 19 milliseconds Jun 02 10:54:20 smsl-n100 volumio[2440]: info: sendMpdCommand status took 16 milliseconds Jun 02 10:54:20 smsl-n100 volumio[2440]: info: sendMpdCommand status took 12 milliseconds Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseState Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand add "NAS/CD/Hewitt - Bach Arrangements/06 - Sheep May Safely Graze ('Schäfe Können Sicher Weiden' From Cantata No 208, BWV208).flac" Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseState Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ControllerMpd::pushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::servicePushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: 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:54:20 smsl-n100 volumio[2440]: verbose: CURRENT POSITION 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState stateService stop Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: No code Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ControllerMpd::pushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::servicePushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: 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:54:20 smsl-n100 volumio[2440]: verbose: CURRENT POSITION 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState stateService stop Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: No code Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ------------------------------ 126ms Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ------------------------------ 124ms Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Jun 02 10:54:20 smsl-n100 volumio[2440]: ---------------------------- MPD announces system playlist update Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Ignoring MPD Status Update Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Jun 02 10:54:20 smsl-n100 volumio[2440]: ---------------------------- MPD announces system playlist update Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Ignoring MPD Status Update Jun 02 10:54:20 smsl-n100 volumio[2440]: error: updateQueue error: null Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Jun 02 10:54:20 smsl-n100 volumio[2440]: ---------------------------- MPD announces system playlist update Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Ignoring MPD Status Update Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ------------------------------ 141ms Jun 02 10:54:20 smsl-n100 volumio[2440]: info: sendMpdCommand playlistinfo took 134 milliseconds Jun 02 10:54:20 smsl-n100 volumio[2440]: info: sendMpdCommand add "NAS/CD/Hewitt - Bach Arrangements/06 - Sheep May Safely Graze ('Schäfe Können Sicher Weiden' From Cantata No 208, BWV208).flac" took 134 milliseconds Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ------------------------------ 27ms Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ------------------------------ 26ms Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand play Jun 02 10:54:20 smsl-n100 volumio[2440]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ------------------------------ 180ms Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Jun 02 10:54:20 smsl-n100 volumio[2440]: ---------------------------- MPD announces system playlist update Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Ignoring MPD Status Update Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Jun 02 10:54:20 smsl-n100 volumio[2440]: ---------------------------- MPD announces system playlist update Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Ignoring MPD Status Update Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Jun 02 10:54:20 smsl-n100 volumio[2440]: ---------------------------- MPD announces state update: player Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Jun 02 10:54:20 smsl-n100 volumio[2440]: ---------------------------- MPD announces state update: player Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ------------------------------ 131ms Jun 02 10:54:20 smsl-n100 volumio[2440]: info: sendMpdCommand play took 120 milliseconds Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ControllerMpd::getState Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ------------------------------ 115ms Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ControllerMpd::getState Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ------------------------------ 105ms Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Jun 02 10:54:20 smsl-n100 volumio[2440]: ---------------------------- MPD announces state update: player Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ControllerMpd::getState Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Jun 02 10:54:20 smsl-n100 volumio[2440]: ---------------------------- MPD announces state update: player Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ControllerMpd::getState Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:20 smsl-n100 volumio[2440]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:54:20 smsl-n100 volumio[2440]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:54:20 smsl-n100 volumio[2440]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:54:20 smsl-n100 volumio[2440]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:54:20 smsl-n100 volumio[2440]: info: sendMpdCommand status took 63 milliseconds Jun 02 10:54:20 smsl-n100 volumio[2440]: info: sendMpdCommand status took 60 milliseconds Jun 02 10:54:20 smsl-n100 volumio[2440]: info: sendMpdCommand status took 53 milliseconds Jun 02 10:54:20 smsl-n100 volumio[2440]: info: sendMpdCommand status took 47 milliseconds Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseState Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseState Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseState Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseState Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Jun 02 10:54:20 smsl-n100 volumio[2440]: ---------------------------- MPD announces state update: player Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ControllerMpd::getState Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand status Jun 02 10:54:20 smsl-n100 volumio[2440]: info: sendMpdCommand playlistinfo took 43 milliseconds Jun 02 10:54:20 smsl-n100 volumio[2440]: info: sendMpdCommand playlistinfo took 42 milliseconds Jun 02 10:54:20 smsl-n100 volumio[2440]: info: sendMpdCommand playlistinfo took 41 milliseconds Jun 02 10:54:20 smsl-n100 volumio[2440]: info: sendMpdCommand playlistinfo took 39 milliseconds Jun 02 10:54:20 smsl-n100 volumio[2440]: info: sendMpdCommand status took 31 milliseconds Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseState Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ControllerMpd::pushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::servicePushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":348,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"319 Kbps","isStreaming":false,"title":"Sheep May Safely Graze ('Schäfe Können Sicher Weiden' From Cantata No 208, BWV208)","artist":"Angela Hewitt , Bach Transcriptions By Myra Hess , Wilhelm Kempff , Harriet Cohen , Lord Berners , Herbert Howells , William Walton , John Ireland , Mary Howe , Eugen D'Albert , Harold Bauer","album":"Bach Arrangements","uri":"NAS/CD/Hewitt - Bach Arrangements/06 - Sheep May Safely Graze ('Schäfe Können Sicher Weiden' From Cantata No 208, BWV208).flac","trackType":"flac"} Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: CURRENT POSITION 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState stateService play Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState currentStatus stop Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ControllerMpd::pushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::servicePushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":348,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"319 Kbps","isStreaming":false,"title":"Sheep May Safely Graze ('Schäfe Können Sicher Weiden' From Cantata No 208, BWV208)","artist":"Angela Hewitt , Bach Transcriptions By Myra Hess , Wilhelm Kempff , Harriet Cohen , Lord Berners , Herbert Howells , William Walton , John Ireland , Mary Howe , Eugen D'Albert , Harold Bauer","album":"Bach Arrangements","uri":"NAS/CD/Hewitt - Bach Arrangements/06 - Sheep May Safely Graze ('Schäfe Können Sicher Weiden' From Cantata No 208, BWV208).flac","trackType":"flac"} Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: CURRENT POSITION 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState stateService play Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Received an update from plugin. extracting info from payload Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ControllerMpd::pushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::servicePushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":348,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"319 Kbps","isStreaming":false,"title":"Sheep May Safely Graze ('Schäfe Können Sicher Weiden' From Cantata No 208, BWV208)","artist":"Angela Hewitt , Bach Transcriptions By Myra Hess , Wilhelm Kempff , Harriet Cohen , Lord Berners , Herbert Howells , William Walton , John Ireland , Mary Howe , Eugen D'Albert , Harold Bauer","album":"Bach Arrangements","uri":"NAS/CD/Hewitt - Bach Arrangements/06 - Sheep May Safely Graze ('Schäfe Können Sicher Weiden' From Cantata No 208, BWV208).flac","trackType":"flac"} Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: CURRENT POSITION 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState stateService play Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Received an update from plugin. extracting info from payload Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ControllerMpd::pushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::servicePushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":348,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"319 Kbps","isStreaming":false,"title":"Sheep May Safely Graze ('Schäfe Können Sicher Weiden' From Cantata No 208, BWV208)","artist":"Angela Hewitt , Bach Transcriptions By Myra Hess , Wilhelm Kempff , Harriet Cohen , Lord Berners , Herbert Howells , William Walton , John Ireland , Mary Howe , Eugen D'Albert , Harold Bauer","album":"Bach Arrangements","uri":"NAS/CD/Hewitt - Bach Arrangements/06 - Sheep May Safely Graze ('Schäfe Können Sicher Weiden' From Cantata No 208, BWV208).flac","trackType":"flac"} Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: CURRENT POSITION 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState stateService play Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Received an update from plugin. extracting info from payload Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ------------------------------ 251ms Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ------------------------------ 325ms Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ------------------------------ 312ms Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ------------------------------ 308ms Jun 02 10:54:20 smsl-n100 volumio[2440]: info: sendMpdCommand playlistinfo took 205 milliseconds Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: ControllerMpd::parseTrackInfo Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ControllerMpd::pushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::servicePushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":348,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"363 Kbps","isStreaming":false,"title":"Sheep May Safely Graze ('Schäfe Können Sicher Weiden' From Cantata No 208, BWV208)","artist":"Angela Hewitt , Bach Transcriptions By Myra Hess , Wilhelm Kempff , Harriet Cohen , Lord Berners , Herbert Howells , William Walton , John Ireland , Mary Howe , Eugen D'Albert , Harold Bauer","album":"Bach Arrangements","uri":"NAS/CD/Hewitt - Bach Arrangements/06 - Sheep May Safely Graze ('Schäfe Können Sicher Weiden' From Cantata No 208, BWV208).flac","trackType":"flac"} Jun 02 10:54:20 smsl-n100 volumio[2440]: verbose: CURRENT POSITION 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState stateService play Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::syncState currentStatus play Jun 02 10:54:20 smsl-n100 volumio[2440]: info: Received an update from plugin. extracting info from payload Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 5 Jun 02 10:54:20 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:20 smsl-n100 volumio[2440]: info: ------------------------------ 308ms Jun 02 10:54:21 smsl-n100 volumio[2440]: info: CoreStateMachine::pushState Jun 02 10:54:21 smsl-n100 volumio[2440]: info: CorePlayQueue::getTrack 5 Jun 02 10:54:21 smsl-n100 volumio[2440]: info: CoreCommandRouter::volumioPushState Jun 02 10:54:21 smsl-n100 volumio[2440]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:54:21 smsl-n100 volumio[2440]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:54:21 smsl-n100 volumio[2440]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:54:21 smsl-n100 volumio[2440]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:54:36 smsl-n100 volumio[2440]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Jun 02 10:54:36 smsl-n100 volumio[2440]: info: Retrying Login Due to Network Error Jun 02 10:54:44 smsl-n100 volumio[2440]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 02 10:54:44 smsl-n100 volumio[2440]: info: CURURI: albums://Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preload queue cleared Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/01 - No.1 In C Major.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/02 - No.2 In C Minor.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/03 - No.3 In D Major.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/04 - No.4 In D Minor.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/05 - No.5 In E Flat Major.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/06 - No.6 In E Major.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/07 - No.7 In E Minor.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/08 - No.8 In F Major.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/09 - No.9 In F Minor.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/10 - No.10 In G Major.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/11 - No.11 In G Minor.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/12 - No.12 In A Major.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/13 - No.13 In A Minor.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/14 - No.14 In B Flat Major.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/15 - No.15 In B Minor.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/16 - I. Allemanda.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/17 - II. Corrente.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/18 - III. Sarabanda.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/19 - IV. Giga.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/20 - V. Ciaccona.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/21 - No.1 In C Major.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/22 - No.2 In C Minor.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/23 - No.3 In D Major.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/24 - No.4 In D Minor.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/25 - No.5 In E Flat Major.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/26 - No.6 In E Major.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/27 - No.7 In E Minor.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/28 - No.8 In F Major.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/29 - No.9 In F Minor.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/30 - No.10 In G Major.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/31 - No.11 In G Minor.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/32 - No.12 In A Major.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/33 - No.13 In A Minor.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/34 - No.14 In B Flat Major.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Preloading song: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/35 - No.15 In B Minor.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/01 - No.1 In C Major.flac in service mpd Jun 02 10:54:44 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F01%20-%20No.1%20In%20C%20Major.flac&metadata=false Jun 02 10:54:44 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/01 - No.1 In C Major.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Executing endpoint getSimilarAlbums Jun 02 10:54:44 smsl-n100 volumio[2440]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/02 - No.2 In C Minor.flac in service mpd Jun 02 10:54:44 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F02%20-%20No.2%20In%20C%20Minor.flac&metadata=false Jun 02 10:54:44 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/02 - No.2 In C Minor.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/03 - No.3 In D Major.flac in service mpd Jun 02 10:54:44 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F03%20-%20No.3%20In%20D%20Major.flac&metadata=false Jun 02 10:54:44 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/03 - No.3 In D Major.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Executing endpoint metavolumio Jun 02 10:54:44 smsl-n100 volumio[2440]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Executing endpoint metavolumio Jun 02 10:54:44 smsl-n100 volumio[2440]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/04 - No.4 In D Minor.flac in service mpd Jun 02 10:54:44 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F04%20-%20No.4%20In%20D%20Minor.flac&metadata=false Jun 02 10:54:44 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/04 - No.4 In D Minor.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/05 - No.5 In E Flat Major.flac in service mpd Jun 02 10:54:44 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F05%20-%20No.5%20In%20E%20Flat%20Major.flac&metadata=false Jun 02 10:54:44 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/05 - No.5 In E Flat Major.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/06 - No.6 In E Major.flac in service mpd Jun 02 10:54:44 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F06%20-%20No.6%20In%20E%20Major.flac&metadata=false Jun 02 10:54:44 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/06 - No.6 In E Major.flac Jun 02 10:54:44 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/07 - No.7 In E Minor.flac in service mpd Jun 02 10:54:44 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F07%20-%20No.7%20In%20E%20Minor.flac&metadata=false Jun 02 10:54:44 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/07 - No.7 In E Minor.flac Jun 02 10:54:45 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/08 - No.8 In F Major.flac in service mpd Jun 02 10:54:45 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F08%20-%20No.8%20In%20F%20Major.flac&metadata=false Jun 02 10:54:45 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/08 - No.8 In F Major.flac Jun 02 10:54:45 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/09 - No.9 In F Minor.flac in service mpd Jun 02 10:54:45 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F09%20-%20No.9%20In%20F%20Minor.flac&metadata=false Jun 02 10:54:45 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/09 - No.9 In F Minor.flac Jun 02 10:54:45 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/10 - No.10 In G Major.flac in service mpd Jun 02 10:54:45 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F10%20-%20No.10%20In%20G%20Major.flac&metadata=false Jun 02 10:54:45 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/10 - No.10 In G Major.flac Jun 02 10:54:45 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/11 - No.11 In G Minor.flac in service mpd Jun 02 10:54:45 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F11%20-%20No.11%20In%20G%20Minor.flac&metadata=false Jun 02 10:54:45 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/11 - No.11 In G Minor.flac Jun 02 10:54:45 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/12 - No.12 In A Major.flac in service mpd Jun 02 10:54:45 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F12%20-%20No.12%20In%20A%20Major.flac&metadata=false Jun 02 10:54:45 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/12 - No.12 In A Major.flac Jun 02 10:54:45 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/13 - No.13 In A Minor.flac in service mpd Jun 02 10:54:45 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F13%20-%20No.13%20In%20A%20Minor.flac&metadata=false Jun 02 10:54:45 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/13 - No.13 In A Minor.flac Jun 02 10:54:45 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/14 - No.14 In B Flat Major.flac in service mpd Jun 02 10:54:45 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F14%20-%20No.14%20In%20B%20Flat%20Major.flac&metadata=false Jun 02 10:54:45 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/14 - No.14 In B Flat Major.flac Jun 02 10:54:45 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/15 - No.15 In B Minor.flac in service mpd Jun 02 10:54:45 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F15%20-%20No.15%20In%20B%20Minor.flac&metadata=false Jun 02 10:54:45 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/15 - No.15 In B Minor.flac Jun 02 10:54:45 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/16 - I. Allemanda.flac in service mpd Jun 02 10:54:45 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F16%20-%20I.%20Allemanda.flac&metadata=false Jun 02 10:54:45 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/16 - I. Allemanda.flac Jun 02 10:54:45 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/17 - II. Corrente.flac in service mpd Jun 02 10:54:45 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F17%20-%20II.%20Corrente.flac&metadata=false Jun 02 10:54:45 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/17 - II. Corrente.flac Jun 02 10:54:45 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/18 - III. Sarabanda.flac in service mpd Jun 02 10:54:45 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F18%20-%20III.%20Sarabanda.flac&metadata=false Jun 02 10:54:45 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/18 - III. Sarabanda.flac Jun 02 10:54:45 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/19 - IV. Giga.flac in service mpd Jun 02 10:54:45 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F19%20-%20IV.%20Giga.flac&metadata=false Jun 02 10:54:45 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/19 - IV. Giga.flac Jun 02 10:54:45 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/20 - V. Ciaccona.flac in service mpd Jun 02 10:54:45 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F20%20-%20V.%20Ciaccona.flac&metadata=false Jun 02 10:54:45 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/20 - V. Ciaccona.flac Jun 02 10:54:45 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/21 - No.1 In C Major.flac in service mpd Jun 02 10:54:45 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F21%20-%20No.1%20In%20C%20Major.flac&metadata=false Jun 02 10:54:45 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/21 - No.1 In C Major.flac Jun 02 10:54:45 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/22 - No.2 In C Minor.flac in service mpd Jun 02 10:54:45 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F22%20-%20No.2%20In%20C%20Minor.flac&metadata=false Jun 02 10:54:45 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/22 - No.2 In C Minor.flac Jun 02 10:54:45 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/23 - No.3 In D Major.flac in service mpd Jun 02 10:54:45 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F23%20-%20No.3%20In%20D%20Major.flac&metadata=false Jun 02 10:54:45 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/23 - No.3 In D Major.flac Jun 02 10:54:45 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/24 - No.4 In D Minor.flac in service mpd Jun 02 10:54:45 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F24%20-%20No.4%20In%20D%20Minor.flac&metadata=false Jun 02 10:54:45 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/24 - No.4 In D Minor.flac Jun 02 10:54:45 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/25 - No.5 In E Flat Major.flac in service mpd Jun 02 10:54:45 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F25%20-%20No.5%20In%20E%20Flat%20Major.flac&metadata=false Jun 02 10:54:45 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/25 - No.5 In E Flat Major.flac Jun 02 10:54:45 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/26 - No.6 In E Major.flac in service mpd Jun 02 10:54:45 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F26%20-%20No.6%20In%20E%20Major.flac&metadata=false Jun 02 10:54:45 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/26 - No.6 In E Major.flac Jun 02 10:54:45 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/27 - No.7 In E Minor.flac in service mpd Jun 02 10:54:45 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F27%20-%20No.7%20In%20E%20Minor.flac&metadata=false Jun 02 10:54:45 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/27 - No.7 In E Minor.flac Jun 02 10:54:46 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/28 - No.8 In F Major.flac in service mpd Jun 02 10:54:46 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F28%20-%20No.8%20In%20F%20Major.flac&metadata=false Jun 02 10:54:46 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/28 - No.8 In F Major.flac Jun 02 10:54:46 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/29 - No.9 In F Minor.flac in service mpd Jun 02 10:54:46 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F29%20-%20No.9%20In%20F%20Minor.flac&metadata=false Jun 02 10:54:46 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/29 - No.9 In F Minor.flac Jun 02 10:54:46 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/30 - No.10 In G Major.flac in service mpd Jun 02 10:54:46 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F30%20-%20No.10%20In%20G%20Major.flac&metadata=false Jun 02 10:54:46 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/30 - No.10 In G Major.flac Jun 02 10:54:46 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/31 - No.11 In G Minor.flac in service mpd Jun 02 10:54:46 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F31%20-%20No.11%20In%20G%20Minor.flac&metadata=false Jun 02 10:54:46 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/31 - No.11 In G Minor.flac Jun 02 10:54:46 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/32 - No.12 In A Major.flac in service mpd Jun 02 10:54:46 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F32%20-%20No.12%20In%20A%20Major.flac&metadata=false Jun 02 10:54:46 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/32 - No.12 In A Major.flac Jun 02 10:54:46 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/33 - No.13 In A Minor.flac in service mpd Jun 02 10:54:46 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F33%20-%20No.13%20In%20A%20Minor.flac&metadata=false Jun 02 10:54:46 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/33 - No.13 In A Minor.flac Jun 02 10:54:46 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/34 - No.14 In B Flat Major.flac in service mpd Jun 02 10:54:46 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F34%20-%20No.14%20In%20B%20Flat%20Major.flac&metadata=false Jun 02 10:54:46 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/34 - No.14 In B Flat Major.flac Jun 02 10:54:46 smsl-n100 volumio[2440]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/35 - No.15 In B Minor.flac in service mpd Jun 02 10:54:46 smsl-n100 volumio[2440]: info: ALBUMART /albumart?cacheid=737&web=Janine%20Jansen/Janine%20Jansen%20-%20Inventions%20%26%20Partita/extralarge&path=%2Fmnt%2FNAS%2FCD%2FJanine%20Jansen%20-%20Bach-Inventions%20%26%20Partita%2F35%20-%20No.15%20In%20B%20Minor.flac&metadata=false Jun 02 10:54:46 smsl-n100 volumio[2440]: info: URI /mnt/NAS/CD/Janine Jansen - Bach-Inventions & Partita/35 - No.15 In B Minor.flac Jun 02 10:54:46 smsl-n100 volumio[2440]: info: MyVolumio login type: Token Jun 02 10:54:48 smsl-n100 volumio[2440]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 10:54:48 smsl-n100 volumio[2440]: Error: connect ECONNREFUSED 122.10.85.4:443 Jun 02 10:54:48 smsl-n100 volumio[2440]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jun 02 10:54:48 smsl-n100 volumio[2440]: errno: -111, Jun 02 10:54:48 smsl-n100 volumio[2440]: code: 'ECONNREFUSED', Jun 02 10:54:48 smsl-n100 volumio[2440]: syscall: 'connect', Jun 02 10:54:48 smsl-n100 volumio[2440]: address: '122.10.85.4', Jun 02 10:54:48 smsl-n100 volumio[2440]: port: 443 Jun 02 10:54:48 smsl-n100 volumio[2440]: } Jun 02 10:54:48 smsl-n100 volumio[2440]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 10:54:49 smsl-n100 sudo[3498]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-06-02 10:53 Jun 02 10:54:49 smsl-n100 sudo[3498]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 10:54:49 smsl-n100 sudo[3498]: pam_unix(sudo:session): session closed for user root Jun 02 10:54:51 smsl-n100 volumio-remote-updater[497]: [2026-06-02 10:54:51] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Jun 02 10:54:51 smsl-n100 volumio-remote-updater[497]: [2026-06-02 10:54:51] [error] handle_read_frame error: websocketpp.transport:2 (Underlying Transport Error) Jun 02 10:54:51 smsl-n100 volumio-remote-updater[497]: [2026-06-02 10:54:51] [disconnect] Disconnect close local:[1006,Underlying Transport Error] remote:[1006] Jun 02 10:54:51 smsl-n100 vtcs[2719]: [2026-06-02 10:54:51.290] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Jun 02 10:54:51 smsl-n100 systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jun 02 10:54:51 smsl-n100 systemd[1]: volumio.service: Failed with result 'exit-code'. Jun 02 10:54:51 smsl-n100 systemd[1]: Started dynamicswap service. Jun 02 10:54:51 smsl-n100 systemd[1]: dynamicswap.service: Succeeded. Jun 02 10:54:51 smsl-n100 systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jun 02 10:54:51 smsl-n100 systemd[1]: volumio.service: Scheduled restart job, restart counter is at 7. Jun 02 10:54:51 smsl-n100 systemd[1]: Stopped Volumio Backend Module. Jun 02 10:54:51 smsl-n100 systemd[1]: Started Volumio Backend Module. Jun 02 10:54:51 smsl-n100 systemd[1]: Started dynamicswap service. Jun 02 10:54:51 smsl-n100 systemd[1]: dynamicswap.service: Succeeded. Jun 02 10:54:54 smsl-n100 volumio[3511]: info: ------------------------------------------- Jun 02 10:54:54 smsl-n100 volumio[3511]: info: ----- Volumio3 ---- Jun 02 10:54:54 smsl-n100 volumio[3511]: info: ------------------------------------------- Jun 02 10:54:54 smsl-n100 volumio[3511]: info: ----- System startup ---- Jun 02 10:54:54 smsl-n100 volumio[3511]: info: ------------------------------------------- Jun 02 10:54:56 smsl-n100 volumio[3511]: info: MYVOLUMIO Environment detected Jun 02 10:54:56 smsl-n100 volumio[3511]: info: Plugin folders cleanup Jun 02 10:54:56 smsl-n100 volumio[3511]: info: Scanning into folder /volumio/app/plugins/ Jun 02 10:54:56 smsl-n100 volumio[3511]: info: Scanning category audio_interface Jun 02 10:54:56 smsl-n100 volumio[3511]: info: Scanning category miscellanea Jun 02 10:54:56 smsl-n100 volumio[3511]: info: Scanning category music_service Jun 02 10:54:56 smsl-n100 volumio[3511]: info: Scanning category plugins.json Jun 02 10:54:56 smsl-n100 volumio[3511]: info: Scanning category system_controller Jun 02 10:54:56 smsl-n100 volumio[3511]: info: Scanning category user_interface Jun 02 10:54:56 smsl-n100 volumio[3511]: info: Scanning into folder /data/plugins/ Jun 02 10:54:56 smsl-n100 volumio[3511]: info: Plugin folders cleanup completed Jun 02 10:54:56 smsl-n100 volumio[3511]: info: ------------------------------------------- Jun 02 10:54:56 smsl-n100 volumio[3511]: info: ----- Core plugins startup ---- Jun 02 10:54:56 smsl-n100 volumio[3511]: info: ------------------------------------------- Jun 02 10:54:56 smsl-n100 volumio[3511]: info: Loading plugins from folder /volumio/app/plugins/ Jun 02 10:54:56 smsl-n100 volumio-remote-updater[497]: [2026-06-02 10:54:56] [connect] Successful connection Jun 02 10:54:56 smsl-n100 volumio[3511]: info: Adding plugin bluetooth to MyMusic Plugins Jun 02 10:54:56 smsl-n100 volumio[3511]: info: Adding plugin multiroom to MyMusic Plugins Jun 02 10:54:56 smsl-n100 volumio[3511]: info: Adding plugin upnp to MyMusic Plugins Jun 02 10:54:56 smsl-n100 volumio[3511]: info: Adding plugin metavolumio to MyMusic Plugins Jun 02 10:54:56 smsl-n100 volumio[3511]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 02 10:54:56 smsl-n100 volumio[3511]: info: Adding plugin cd_controller to MyMusic Plugins Jun 02 10:54:56 smsl-n100 volumio[3511]: info: Adding plugin raat to MyMusic Plugins Jun 02 10:54:56 smsl-n100 volumio[3511]: info: Adding plugin smart_inputs to MyMusic Plugins Jun 02 10:54:56 smsl-n100 volumio[3511]: info: Adding plugin tidalconnect to MyMusic Plugins Jun 02 10:54:56 smsl-n100 volumio[3511]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 02 10:54:56 smsl-n100 volumio[3511]: info: Loading plugins from folder /data/plugins/ Jun 02 10:54:56 smsl-n100 volumio[3511]: info: Loading plugin "system"... Jun 02 10:54:56 smsl-n100 volumio[3511]: info: Loading plugin "appearance"... Jun 02 10:54:58 smsl-n100 volumio[3511]: info: Loading plugin "network"... Jun 02 10:54:58 smsl-n100 volumio[3511]: info: Refreshing Cached IP Addresses Jun 02 10:54:58 smsl-n100 sudo[3542]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 02 10:54:58 smsl-n100 sudo[3542]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 10:54:58 smsl-n100 volumio[3511]: info: Loading plugin "services"... Jun 02 10:54:58 smsl-n100 sudo[3544]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 02 10:54:58 smsl-n100 sudo[3544]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 10:54:58 smsl-n100 sudo[3542]: pam_unix(sudo:session): session closed for user root Jun 02 10:54:58 smsl-n100 volumio[3511]: info: Loading plugin "alsa_controller"... Jun 02 10:54:58 smsl-n100 sudo[3544]: pam_unix(sudo:session): session closed for user root Jun 02 10:54:58 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 02 10:54:58 smsl-n100 volumio[3511]: info: Loading plugin "wizard"... Jun 02 10:54:58 smsl-n100 volumio[3511]: info: Loading plugin "networkfs"... Jun 02 10:54:58 smsl-n100 volumio[3511]: info: Cannot mount NAS CD at system boot, trial number 1 ,retrying in 5 seconds Jun 02 10:54:58 smsl-n100 volumio[3511]: info: Cannot mount NAS HD at system boot, trial number 1 ,retrying in 5 seconds Jun 02 10:54:58 smsl-n100 volumio[3511]: info: Cannot mount NAS Collections at system boot, trial number 1 ,retrying in 5 seconds Jun 02 10:54:58 smsl-n100 volumio[3511]: info: Cannot mount NAS DSD at system boot, trial number 1 ,retrying in 5 seconds Jun 02 10:54:58 smsl-n100 volumio[3511]: info: Starting Udev Watcher for removable devices Jun 02 10:54:58 smsl-n100 volumio[3511]: info: Ignoring mount for partition: boot Jun 02 10:54:58 smsl-n100 volumio[3511]: info: Ignoring mount for partition: volumio Jun 02 10:54:58 smsl-n100 volumio[3511]: info: Ignoring mount for partition: volumio_data Jun 02 10:54:58 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 02 10:54:58 smsl-n100 volumio[3511]: info: Loading plugin "volumio_command_line_client"... Jun 02 10:54:58 smsl-n100 volumio[3511]: info: Plugin upnp is not enabled Jun 02 10:54:58 smsl-n100 volumio[3511]: info: Loading plugin "my_music"... Jun 02 10:54:58 smsl-n100 volumio[3511]: info: Loading plugin "mpd"... Jun 02 10:54:59 smsl-n100 volumio[3511]: info: Plugin upnp_browser is not enabled Jun 02 10:54:59 smsl-n100 volumio[3511]: info: Plugin bluetooth is not enabled Jun 02 10:54:59 smsl-n100 volumio[3511]: info: Loading plugin "alarm-clock"... Jun 02 10:54:59 smsl-n100 volumio[3511]: info: Loading plugin "manifestui"... Jun 02 10:54:59 smsl-n100 volumio[3511]: info: Loading plugin "metavolumio"... Jun 02 10:55:01 smsl-n100 volumio[3511]: info: Plugin airplay_emulation is not enabled Jun 02 10:55:01 smsl-n100 volumio[3511]: info: Plugin cd_controller is not enabled Jun 02 10:55:01 smsl-n100 volumio[3511]: info: Loading plugin "last_100"... Jun 02 10:55:01 smsl-n100 volumio[3511]: info: Loading plugin "raat"... Jun 02 10:55:02 smsl-n100 volumio[3511]: info: RAAT Plugin loaded Jun 02 10:55:02 smsl-n100 volumio[3511]: info: Adding restartRAATSocket REST API Endpoint Jun 02 10:55:02 smsl-n100 volumio[3511]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat Jun 02 10:55:02 smsl-n100 volumio[3511]: info: Loading plugin "streaming_services"... Jun 02 10:55:03 smsl-n100 volumio[3511]: info: Starting Streaming Service Transparent Proxy Jun 02 10:55:03 smsl-n100 volumio[3511]: info: Loading plugin "tidalconnect"... Jun 02 10:55:04 smsl-n100 volumio[3511]: info: Loading plugin "webradio"... Jun 02 10:55:04 smsl-n100 volumio[3511]: info: Loading plugin "i2s_dacs"... Jun 02 10:55:04 smsl-n100 volumio[3511]: info: I2S DAC not set, start Auto-detection Jun 02 10:55:04 smsl-n100 volumio[3511]: info: Loading plugin "volumiodiscovery"... Jun 02 10:55:04 smsl-n100 volumio[3511]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 02 10:55:04 smsl-n100 node[3511]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 02 10:55:04 smsl-n100 node[3511]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 02 10:55:04 smsl-n100 volumio[3511]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 02 10:55:04 smsl-n100 volumio[3511]: *** WARNING *** For more information see Jun 02 10:55:04 smsl-n100 volumio[3511]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 02 10:55:04 smsl-n100 volumio[3511]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 02 10:55:04 smsl-n100 volumio[3511]: *** WARNING *** For more information see Jun 02 10:55:04 smsl-n100 node[3511]: *** WARNING *** For more information see Jun 02 10:55:04 smsl-n100 node[3511]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 02 10:55:04 smsl-n100 node[3511]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 02 10:55:04 smsl-n100 node[3511]: *** WARNING *** For more information see Jun 02 10:55:04 smsl-n100 volumio[3511]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 02 10:55:04 smsl-n100 volumio[3511]: info: Discovery: Started advertising with name: SMSL N100 Jun 02 10:55:04 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 02 10:55:04 smsl-n100 volumio[3511]: info: Plugin multiroom is not enabled Jun 02 10:55:04 smsl-n100 volumio[3511]: info: Loading plugin "outputs"... Jun 02 10:55:04 smsl-n100 volumio[3511]: info: Loading plugin "albumart"... Jun 02 10:55:04 smsl-n100 volumio[3511]: info: Plugin example_plugin is not enabled Jun 02 10:55:04 smsl-n100 volumio[3511]: info: Loading plugin "hi_res_audio"... Jun 02 10:55:05 smsl-n100 volumio[3511]: Forking 3 albumart workers Jun 02 10:55:07 smsl-n100 volumio[3511]: STREAMING PROXY: Starting server on port 3245 Jun 02 10:55:07 smsl-n100 volumio[3511]: Node JS runtime: 14 Jun 02 10:55:08 smsl-n100 volumio[3511]: info: Applying required configuration parameters for plugin hi_res_audio Jun 02 10:55:08 smsl-n100 volumio[3511]: info: Loading plugin "inputs"... Jun 02 10:55:08 smsl-n100 volumio[3511]: Starting albumart workers Jun 02 10:55:08 smsl-n100 volumio[3511]: Starting albumart workers Jun 02 10:55:08 smsl-n100 volumio[3511]: Starting albumart workers Jun 02 10:55:08 smsl-n100 volumio-remote-updater[497]: [2026-06-02 10:55:08] [connect] Successful connection Jun 02 10:55:09 smsl-n100 volumio[3511]: info: Loading plugin "qobuz"... Jun 02 10:55:12 smsl-n100 volumio[3511]: info: Plugin smart_inputs is not enabled Jun 02 10:55:12 smsl-n100 volumio[3511]: info: Loading plugin "tidal"... Jun 02 10:55:13 smsl-n100 volumio[3511]: info: Loading plugin "oem_helper"... Jun 02 10:55:15 smsl-n100 volumio[3511]: info: Applying required configuration parameters for plugin oem_helper Jun 02 10:55:15 smsl-n100 volumio[3511]: info: Loading plugin "smslcontrol"... Jun 02 10:55:15 smsl-n100 volumio[3511]: info: Adding this device properties Jun 02 10:55:15 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Jun 02 10:55:15 smsl-n100 volumio[3511]: info: Setting Additional Device Volumio Properties: [object Object] Jun 02 10:55:15 smsl-n100 volumio[3511]: info: Loading plugin "updater_comm"... Jun 02 10:55:15 smsl-n100 volumio[3511]: info: Plugin mpdemulation is not enabled Jun 02 10:55:15 smsl-n100 volumio[3511]: info: Loading plugin "rest_api"... Jun 02 10:55:15 smsl-n100 volumio[3511]: info: Loading plugin "websocket"... Jun 02 10:55:15 smsl-n100 volumio[3511]: info: Starting Socket.io Server version 2.3.0 Jun 02 10:55:15 smsl-n100 volumio[3511]: info: Loading i18n strings for locale en Jun 02 10:55:15 smsl-n100 volumio[3511]: Updating browse sources language Jun 02 10:55:15 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 10:55:16 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 10:55:16 smsl-n100 volumio[3511]: info: CoreCommandRouter::initPlayerControls Jun 02 10:55:16 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:16 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:16 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:16 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:16 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:16 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:16 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:16 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:16 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 10:55:16 smsl-n100 volumio[3511]: Express server listening on port 3000 Jun 02 10:55:16 smsl-n100 volumio[3511]: [Metrics] WebUI: 22s 637.87ms Jun 02 10:55:16 smsl-n100 volumio[3511]: info: CoreStateMachine::resetVolumioState Jun 02 10:55:16 smsl-n100 volumio[3511]: info: CoreStateMachine::getcurrentVolume Jun 02 10:55:16 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioRetrievevolume Jun 02 10:55:16 smsl-n100 volumio[3511]: info: CoreStateMachine::pushState Jun 02 10:55:16 smsl-n100 volumio[3511]: info: CorePlayQueue::getTrack 0 Jun 02 10:55:16 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:55:16 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioPushState Jun 02 10:55:16 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 10:55:16 smsl-n100 volumio[3511]: info: Cannot mount NAS CD at system boot, trial number 2 ,retrying in 5 seconds Jun 02 10:55:16 smsl-n100 volumio[3511]: info: Cannot mount NAS HD at system boot, trial number 2 ,retrying in 5 seconds Jun 02 10:55:16 smsl-n100 volumio[3511]: info: Cannot mount NAS Collections at system boot, trial number 2 ,retrying in 5 seconds Jun 02 10:55:16 smsl-n100 volumio[3511]: info: Cannot mount NAS DSD at system boot, trial number 2 ,retrying in 5 seconds Jun 02 10:55:16 smsl-n100 volumio[3511]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jun 02 10:55:16 smsl-n100 volumio[3511]: info: Completed loading Core Plugins Jun 02 10:55:16 smsl-n100 volumio[3511]: info: Preparing to generate the ALSA configuration file Jun 02 10:55:16 smsl-n100 volumio[3511]: info: Volumio Network Manager: Network status updated: 1 Jun 02 10:55:16 smsl-n100 volumio[3511]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jun 02 10:55:16 smsl-n100 volumio[3511]: verbose: New Socket.io Connection to 10.113.100.102 from 10.113.100.101 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 1 Jun 02 10:55:16 smsl-n100 volumio[3511]: verbose: New Socket.io Connection to 10.113.100.102 from 10.113.100.101 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 2 Jun 02 10:55:16 smsl-n100 volumio[3511]: verbose: New Socket.io Connection to 10.113.100.102 from 10.113.100.101 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 3 Jun 02 10:55:16 smsl-n100 volumio[3511]: verbose: New Socket.io Connection to 10.113.100.102 from 10.113.100.101 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 4 Jun 02 10:55:16 smsl-n100 volumio[3511]: verbose: New Socket.io Connection to 10.113.100.102 from 10.113.100.101 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 5 Jun 02 10:55:16 smsl-n100 volumio[3511]: verbose: New Socket.io Connection to 10.113.100.102 from 10.113.100.101 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 6 Jun 02 10:55:16 smsl-n100 volumio[3511]: info: Asound.conf file unchanged, so no further update is needed Jun 02 10:55:16 smsl-n100 volumio[3511]: info: Output device has changed, restarting MPD Jun 02 10:55:17 smsl-n100 sudo[3656]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 02 10:55:17 smsl-n100 sudo[3656]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 10:55:17 smsl-n100 volumio[3511]: info: ___________ START PLUGINS ___________ Jun 02 10:55:17 smsl-n100 sudo[3656]: pam_unix(sudo:session): session closed for user root Jun 02 10:55:17 smsl-n100 volumio[3511]: info: ControllerMpd::onStart: Initializing MPD Jun 02 10:55:17 smsl-n100 volumio[3511]: info: Creating MPD Configuration file Jun 02 10:55:17 smsl-n100 sudo[3658]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 02 10:55:17 smsl-n100 sudo[3658]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 10:55:17 smsl-n100 systemd[1]: Stopping Music Player Daemon... Jun 02 10:55:17 smsl-n100 sudo[3662]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 02 10:55:17 smsl-n100 sudo[3662]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 10:55:17 smsl-n100 volumio[3511]: info: Adding METAVOLUMIO REST API Endpoints Jun 02 10:55:17 smsl-n100 volumio[3511]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Jun 02 10:55:17 smsl-n100 volumio[3511]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Jun 02 10:55:17 smsl-n100 volumio[3511]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Jun 02 10:55:17 smsl-n100 volumio[3511]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Jun 02 10:55:17 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 02 10:55:17 smsl-n100 systemd[1]: mpd.service: Succeeded. Jun 02 10:55:17 smsl-n100 volumio[3511]: info: [1780368917191] CoreMusicLibrary::Adding element Last_100 Jun 02 10:55:17 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 10:55:17 smsl-n100 systemd[1]: Stopped Music Player Daemon. Jun 02 10:55:17 smsl-n100 sudo[3662]: pam_unix(sudo:session): session closed for user root Jun 02 10:55:17 smsl-n100 volumio[3511]: info: Starting RAAT Plugin Jun 02 10:55:17 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Jun 02 10:55:17 smsl-n100 volumio[3511]: info: Additional UI Settings Added for plugin music_service/raat Jun 02 10:55:17 smsl-n100 volumio[3511]: info: Registering DSP Elements listener and retrieving current ones Jun 02 10:55:17 smsl-n100 volumio[3511]: info: Additional DSP elements updated Jun 02 10:55:17 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:17 smsl-n100 sudo[3664]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 02 10:55:17 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:17 smsl-n100 systemd[1]: Starting Music Player Daemon... Jun 02 10:55:17 smsl-n100 sudo[3664]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 10:55:17 smsl-n100 volumio[3511]: info: Updating RAAT Signal Path Jun 02 10:55:17 smsl-n100 volumio[3511]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jun 02 10:55:17 smsl-n100 volumio[3511]: info: Streaming services startup Jun 02 10:55:17 smsl-n100 volumio[3511]: info: Starting Streaming Daemon Jun 02 10:55:17 smsl-n100 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jun 02 10:55:17 smsl-n100 systemd[1]: mpd.service: Succeeded. Jun 02 10:55:17 smsl-n100 systemd[1]: Stopped Music Player Daemon. Jun 02 10:55:17 smsl-n100 systemd[1]: Starting Music Player Daemon... Jun 02 10:55:17 smsl-n100 sudo[3672]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 02 10:55:17 smsl-n100 sudo[3672]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 10:55:17 smsl-n100 sudo[3672]: pam_unix(sudo:session): session closed for user root Jun 02 10:55:17 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 02 10:55:17 smsl-n100 volumio[3511]: info: [1780368917451] CoreMusicLibrary::Adding element Webradio Jun 02 10:55:17 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 10:55:17 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 02 10:55:17 smsl-n100 sudo[3679]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 02 10:55:17 smsl-n100 volumio[3511]: info: Initializing BBC Radios Jun 02 10:55:17 smsl-n100 sudo[3679]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 10:55:17 smsl-n100 systemd[1]: Stopping Volumio Tidal Connect Service... Jun 02 10:55:17 smsl-n100 sudo[3671]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 02 10:55:17 smsl-n100 systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Jun 02 10:55:17 smsl-n100 sudo[3671]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 10:55:17 smsl-n100 systemd[1]: vtcs.service: Succeeded. Jun 02 10:55:17 smsl-n100 systemd[1]: Stopped Volumio Tidal Connect Service. Jun 02 10:55:17 smsl-n100 sudo[3671]: pam_unix(sudo:session): session closed for user root Jun 02 10:55:17 smsl-n100 sudo[3679]: pam_unix(sudo:session): session closed for user root Jun 02 10:55:17 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 02 10:55:17 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 10:55:17 smsl-n100 volumio[3511]: error: Hi Res Audio Failed Login: Missing Login Data Jun 02 10:55:17 smsl-n100 volumio[3511]: info: Adding HIGHRESAUDIO REST API Endpoints Jun 02 10:55:17 smsl-n100 volumio[3511]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Jun 02 10:55:17 smsl-n100 volumio[3511]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Jun 02 10:55:17 smsl-n100 volumio[3511]: info: Initializing Serial Communication on port /dev/ttyS1 Jun 02 10:55:17 smsl-n100 volumio[3511]: info: Touch Event Listener Process Starting Jun 02 10:55:17 smsl-n100 volumio[3511]: info: Refreshing TIDAL token Jun 02 10:55:17 smsl-n100 sudo[3697]: pam_unix(sudo:auth): conversation failed Jun 02 10:55:17 smsl-n100 sudo[3697]: pam_unix(sudo:auth): auth could not identify password for [volumio] Jun 02 10:55:17 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 02 10:55:17 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 10:55:17 smsl-n100 volumio[3511]: info: Initializing GPIOs Jun 02 10:55:17 smsl-n100 volumio[3511]: info: Starting Button Listener Jun 02 10:55:17 smsl-n100 volumio[3511]: info: Turning off Green LED Jun 02 10:55:17 smsl-n100 volumio[3511]: info: Tuning on Blue LED Jun 02 10:55:17 smsl-n100 volumio[3511]: info: Signaling System Ready Jun 02 10:55:17 smsl-n100 volumio[3511]: info: Volumio Calling Home Jun 02 10:55:18 smsl-n100 volumio[3511]: (node:3511) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Jun 02 10:55:18 smsl-n100 volumio[3511]: (Use `node --trace-deprecation ...` to show where the warning was created) Jun 02 10:55:18 smsl-n100 volumio[3511]: info: Stopping AccessToken refresher cron for QOBUZ Jun 02 10:55:18 smsl-n100 volumio[3511]: info: AccessToken refresher cron started for QOBUZ Jun 02 10:55:18 smsl-n100 volumio[3511]: info: Adding QOBUZ REST API Endpoints Jun 02 10:55:18 smsl-n100 volumio[3511]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CoreStateMachine::setRepeat false single undefined Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CoreStateMachine::pushState Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CorePlayQueue::getTrack 0 Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioPushState Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CoreStateMachine::setRandom true Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CoreStateMachine::pushState Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CorePlayQueue::getTrack 0 Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioPushState Jun 02 10:55:18 smsl-n100 volumio[3511]: info: Setting Device type: NanoPi NEO 3 Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 02 10:55:18 smsl-n100 volumio[3511]: info: Serial port opened successfully Jun 02 10:55:18 smsl-n100 volumio[3511]: info: Sending serial start messages Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:18 smsl-n100 volumio[3511]: info: Reporting MCU Network Status: 1 Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioGetVisibleSources Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioGetState Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CorePlayQueue::getTrack 0 Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioGetQueue Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CoreStateMachine::getQueue Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CorePlayQueue::getQueue Jun 02 10:55:18 smsl-n100 volumio[3511]: info: Listing playlists Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 02 10:55:18 smsl-n100 volumio[3511]: info: Received Get System Info Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 10:55:18 smsl-n100 volumio[3511]: info: Discovery: Getting this device information Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioGetState Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CorePlayQueue::getTrack 0 Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioGetState Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CorePlayQueue::getTrack 0 Jun 02 10:55:18 smsl-n100 volumio[3511]: info: Touch Event Listener Process Closed Jun 02 10:55:18 smsl-n100 volumio[3511]: error: Cannot start Volumio Streaming Daemon Jun 02 10:55:18 smsl-n100 volumio[3511]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 02 10:55:18 smsl-n100 volumio[3511]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 02 10:55:18 smsl-n100 volumio[3511]: info: MPD Permissions set Jun 02 10:55:18 smsl-n100 volumio[3511]: info: MPD Permissions set Jun 02 10:55:18 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Jun 02 10:55:18 smsl-n100 volumio[3511]: info: Setting Device Volume Override Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jun 02 10:55:19 smsl-n100 volumio[3511]: info: Updating Volume Controller Parameters: Device: 1 Name: SPDIF Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jun 02 10:55:19 smsl-n100 volumio[3511]: info: Disabling external Volume Control Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreStateMachine::pushState Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CorePlayQueue::getTrack 0 Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioPushState Jun 02 10:55:19 smsl-n100 volumio[3511]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:55:19 smsl-n100 volumio[3511]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:55:19 smsl-n100 volumio[3511]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:55:19 smsl-n100 volumio[3511]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreStateMachine::pushState Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CorePlayQueue::getTrack 0 Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioPushState Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreStateMachine::pushState Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CorePlayQueue::getTrack 0 Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioPushState Jun 02 10:55:19 smsl-n100 volumio[3511]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:55:19 smsl-n100 volumio[3511]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:55:19 smsl-n100 volumio[3511]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:55:19 smsl-n100 volumio[3511]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreStateMachine::pushState Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CorePlayQueue::getTrack 0 Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioPushState Jun 02 10:55:19 smsl-n100 volumio[3511]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:55:19 smsl-n100 volumio[3511]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:55:19 smsl-n100 volumio[3511]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:55:19 smsl-n100 volumio[3511]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreStateMachine::pushState Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CorePlayQueue::getTrack 0 Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioPushState Jun 02 10:55:19 smsl-n100 volumio[3511]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:55:19 smsl-n100 volumio[3511]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:55:19 smsl-n100 volumio[3511]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:55:19 smsl-n100 volumio[3511]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:55:19 smsl-n100 volumio[3511]: error: Serial API: Failed to decode command: 1, message: undefined Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreStateMachine::pushState Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CorePlayQueue::getTrack 0 Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioPushState Jun 02 10:55:19 smsl-n100 volumio[3511]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:55:19 smsl-n100 volumio[3511]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jun 02 10:55:19 smsl-n100 volumio[3511]: info: Volumio called home Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreStateMachine::pushState Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CorePlayQueue::getTrack 0 Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioPushState Jun 02 10:55:19 smsl-n100 volumio[3511]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:55:19 smsl-n100 volumio[3511]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:55:19 smsl-n100 volumio[3511]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:55:19 smsl-n100 volumio[3511]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:55:19 smsl-n100 volumio[3511]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jun 02 10:55:19 smsl-n100 volumio[3511]: info: Discovery: adding 1158988f-92fb-46eb-a45c-e1755046c17b Jun 02 10:55:19 smsl-n100 volumio[3511]: info: Discovery: Found device SMSL N100 Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioGetState Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CorePlayQueue::getTrack 0 Jun 02 10:55:19 smsl-n100 volumio[3511]: info: VolumeController::SetAlsaVolume0 Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreStateMachine::pushState Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CorePlayQueue::getTrack 0 Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioPushState Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreStateMachine::pushState Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CorePlayQueue::getTrack 0 Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioPushState Jun 02 10:55:19 smsl-n100 volumio[3511]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:55:19 smsl-n100 volumio[3511]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:55:19 smsl-n100 volumio[3511]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:55:19 smsl-n100 volumio[3511]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreStateMachine::pushState Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CorePlayQueue::getTrack 0 Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioPushState Jun 02 10:55:19 smsl-n100 volumio[3511]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:55:19 smsl-n100 volumio[3511]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:55:19 smsl-n100 volumio[3511]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:55:19 smsl-n100 volumio[3511]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioGetState Jun 02 10:55:19 smsl-n100 volumio[3511]: info: CorePlayQueue::getTrack 0 Jun 02 10:55:20 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioGetState Jun 02 10:55:20 smsl-n100 volumio[3511]: info: CorePlayQueue::getTrack 0 Jun 02 10:55:20 smsl-n100 volumio[3511]: info: CoreStateMachine::pushState Jun 02 10:55:20 smsl-n100 volumio[3511]: info: CorePlayQueue::getTrack 0 Jun 02 10:55:20 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioPushState Jun 02 10:55:20 smsl-n100 volumio[3511]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:55:20 smsl-n100 volumio[3511]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 02 10:55:20 smsl-n100 volumio[3511]: error: Serial API: Failed to decode command: 100, message: undefined Jun 02 10:55:20 smsl-n100 volumio[3511]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 10:55:20 smsl-n100 volumio[3511]: info: Access Token successfully retrieved Jun 02 10:55:20 smsl-n100 volumio[3511]: info: Preload queue cleared Jun 02 10:55:20 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 02 10:55:20 smsl-n100 volumio[3511]: info: CoreStateMachine::ClearQueue Jun 02 10:55:20 smsl-n100 volumio[3511]: info: CoreStateMachine::stop Jun 02 10:55:20 smsl-n100 volumio[3511]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 02 10:55:20 smsl-n100 volumio[3511]: info: CorePlayQueue::clearPlayQueue Jun 02 10:55:20 smsl-n100 volumio[3511]: info: CorePlayQueue::saveQueue Jun 02 10:55:20 smsl-n100 volumio[3511]: info: CoreCommandRouter::volumioPushQueue Jun 02 10:55:20 smsl-n100 volumio[3511]: info: CoreStateMachine::addQueueItems Jun 02 10:55:20 smsl-n100 volumio[3511]: info: CorePlayQueue::addQueueItems Jun 02 10:55:20 smsl-n100 volumio[3511]: info: Preload queue cleared Jun 02 10:55:20 smsl-n100 volumio[3511]: info: Adding Item to queue: music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/01 - No.1 In C Major.flac Jun 02 10:55:20 smsl-n100 volumio[3511]: info: Exploding uri music-library/NAS/CD/Janine Jansen - Bach-Inventions & Partita/01 - No.1 In C Major.flac in service mpd Jun 02 10:55:20 smsl-n100 volumio[3511]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 10:55:20 smsl-n100 volumio[3511]: TypeError: Cannot read property 'then' of undefined Jun 02 10:55:20 smsl-n100 volumio[3511]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2546:19) Jun 02 10:55:20 smsl-n100 volumio[3511]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2344:21) Jun 02 10:55:20 smsl-n100 volumio[3511]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1384:16) Jun 02 10:55:20 smsl-n100 volumio[3511]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Jun 02 10:55:20 smsl-n100 volumio[3511]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Jun 02 10:55:20 smsl-n100 volumio[3511]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Jun 02 10:55:20 smsl-n100 volumio[3511]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:251:25) Jun 02 10:55:20 smsl-n100 volumio[3511]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:511:25) Jun 02 10:55:20 smsl-n100 volumio[3511]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:484:17) Jun 02 10:55:20 smsl-n100 volumio[3511]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:142:33) Jun 02 10:55:20 smsl-n100 volumio[3511]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 10:55:21 smsl-n100 sudo[3749]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-06-02 10:54 Jun 02 10:55:21 smsl-n100 sudo[3749]: 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"