-- Logs begin at Sat 2025-12-20 11:38:11 MSK, end at Sat 2025-12-20 12:49:15 MSK. -- Dec 20 12:48:00 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 20 12:48:00 smsl-n100 volumio[965]: info: CURURI: music-library/USB/Aune_SD Dec 20 12:48:00 smsl-n100 volumio[965]: info: Preload queue cleared Dec 20 12:48:01 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 20 12:48:01 smsl-n100 volumio[965]: info: CURURI: music-library/USB/Aune_SD/ENG Dec 20 12:48:01 smsl-n100 volumio[965]: info: Preload queue cleared Dec 20 12:48:02 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 20 12:48:02 smsl-n100 volumio[965]: info: CURURI: music-library/USB/Aune_SD/ENG/Сollection Dec 20 12:48:03 smsl-n100 volumio[965]: info: Preload queue cleared Dec 20 12:48:21 smsl-n100 volumio[965]: info: Listing playlists Dec 20 12:48:23 smsl-n100 volumio[965]: info: Saving local item Play max Dec 20 12:48:23 smsl-n100 volumio[965]: info: Pushing Favourites {"uri":"/mnt/USB/Aune_SD/ENG/Сollection/Volbeat","favourite":false} Dec 20 12:48:23 smsl-n100 volumio[965]: info: Listing playlists Dec 20 12:48:26 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 20 12:48:26 smsl-n100 volumio[965]: info: CURURI: music-library/USB/Aune_SD/ENG/Сollection/Volbeat Dec 20 12:48:26 smsl-n100 volumio[965]: info: Preload queue cleared Dec 20 12:48:27 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 20 12:48:27 smsl-n100 volumio[965]: info: CURURI: music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021 Dec 20 12:48:27 smsl-n100 volumio[965]: info: Preload queue cleared Dec 20 12:48:29 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 20 12:48:29 smsl-n100 volumio[965]: info: CURURI: music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind Dec 20 12:48:29 smsl-n100 volumio[965]: info: Preload queue cleared Dec 20 12:48:29 smsl-n100 volumio[965]: info: Preloading song: music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/01. Temple Of Ekur.flac Dec 20 12:48:29 smsl-n100 volumio[965]: info: Preloading song: music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/02. Wait A Minute My Girl.flac Dec 20 12:48:29 smsl-n100 volumio[965]: info: Preloading song: music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/03. The Sacred Stones.flac Dec 20 12:48:29 smsl-n100 volumio[965]: info: Preloading song: music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/04. Shotgun Blues.flac Dec 20 12:48:29 smsl-n100 volumio[965]: info: Preloading song: music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/05. The Devil Rages On.flac Dec 20 12:48:29 smsl-n100 volumio[965]: info: Preloading song: music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/06. Say No More.flac Dec 20 12:48:29 smsl-n100 volumio[965]: info: Preloading song: music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/07. Heaven's Descent.flac Dec 20 12:48:29 smsl-n100 volumio[965]: info: Preloading song: music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/08. Dagen For.flac Dec 20 12:48:29 smsl-n100 volumio[965]: info: Preloading song: music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/09. The Passenger.flac Dec 20 12:48:29 smsl-n100 volumio[965]: info: Preloading song: music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/10. Step Into Light.flac Dec 20 12:48:29 smsl-n100 volumio[965]: info: Preloading song: music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/11. Becoming.flac Dec 20 12:48:29 smsl-n100 volumio[965]: info: Preloading song: music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/12. Mindlock.flac Dec 20 12:48:29 smsl-n100 volumio[965]: info: Preloading song: music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/13. Lasse's Birgitta.flac Dec 20 12:48:29 smsl-n100 volumio[965]: info: Preloading song: music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/14. Return To None.flac Dec 20 12:48:29 smsl-n100 volumio[965]: info: Preloading song: music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/15. Domino.flac Dec 20 12:48:29 smsl-n100 volumio[965]: info: Preloading song: music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/16. Shotgun Blues.flac Dec 20 12:48:29 smsl-n100 volumio[965]: info: Preloading song: music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/17. Dagen For (Michael Vox Version).flac Dec 20 12:48:29 smsl-n100 volumio[965]: info: Preloading song: music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/18. Don’t Tread On Me.flac Dec 20 12:48:29 smsl-n100 volumio[965]: info: Exploding uri music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/01. Temple Of Ekur.flac in service mpd Dec 20 12:48:29 smsl-n100 volumio[965]: info: ALBUMART /albumart?cacheid=202&web=Volbeat/Servant%20Of%20The%20Mind/extralarge&path=%2Fmnt%2FUSB%2FAune_SD%2FENG%2F%D0%A1ollection%2FVolbeat%2FStudio%20Albums%202005%20-%202021%2F2021%20-%20Servant%20Of%20The%20Mind%2F01.%20Temple%20Of%20Ekur.flac&metadata=false Dec 20 12:48:29 smsl-n100 volumio[965]: info: URI /mnt/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/01. Temple Of Ekur.flac Dec 20 12:48:29 smsl-n100 volumio[965]: info: Exploding uri music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/02. Wait A Minute My Girl.flac in service mpd Dec 20 12:48:29 smsl-n100 volumio[965]: info: ALBUMART /albumart?cacheid=202&web=Volbeat/Servant%20Of%20The%20Mind/extralarge&path=%2Fmnt%2FUSB%2FAune_SD%2FENG%2F%D0%A1ollection%2FVolbeat%2FStudio%20Albums%202005%20-%202021%2F2021%20-%20Servant%20Of%20The%20Mind%2F02.%20Wait%20A%20Minute%20My%20Girl.flac&metadata=false Dec 20 12:48:29 smsl-n100 volumio[965]: info: URI /mnt/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/02. Wait A Minute My Girl.flac Dec 20 12:48:29 smsl-n100 volumio[965]: info: Exploding uri music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/03. The Sacred Stones.flac in service mpd Dec 20 12:48:29 smsl-n100 volumio[965]: info: ALBUMART /albumart?cacheid=202&web=Volbeat/Servant%20Of%20The%20Mind/extralarge&path=%2Fmnt%2FUSB%2FAune_SD%2FENG%2F%D0%A1ollection%2FVolbeat%2FStudio%20Albums%202005%20-%202021%2F2021%20-%20Servant%20Of%20The%20Mind%2F03.%20The%20Sacred%20Stones.flac&metadata=false Dec 20 12:48:29 smsl-n100 volumio[965]: info: URI /mnt/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/03. The Sacred Stones.flac Dec 20 12:48:29 smsl-n100 volumio[965]: info: Exploding uri music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/04. Shotgun Blues.flac in service mpd Dec 20 12:48:29 smsl-n100 volumio[965]: info: ALBUMART /albumart?cacheid=202&web=Volbeat/Servant%20Of%20The%20Mind/extralarge&path=%2Fmnt%2FUSB%2FAune_SD%2FENG%2F%D0%A1ollection%2FVolbeat%2FStudio%20Albums%202005%20-%202021%2F2021%20-%20Servant%20Of%20The%20Mind%2F04.%20Shotgun%20Blues.flac&metadata=false Dec 20 12:48:29 smsl-n100 volumio[965]: info: URI /mnt/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/04. Shotgun Blues.flac Dec 20 12:48:29 smsl-n100 volumio[965]: info: Exploding uri music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/05. The Devil Rages On.flac in service mpd Dec 20 12:48:29 smsl-n100 volumio[965]: info: ALBUMART /albumart?cacheid=202&web=Volbeat/Servant%20Of%20The%20Mind/extralarge&path=%2Fmnt%2FUSB%2FAune_SD%2FENG%2F%D0%A1ollection%2FVolbeat%2FStudio%20Albums%202005%20-%202021%2F2021%20-%20Servant%20Of%20The%20Mind%2F05.%20The%20Devil%20Rages%20On.flac&metadata=false Dec 20 12:48:29 smsl-n100 volumio[965]: info: URI /mnt/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/05. The Devil Rages On.flac Dec 20 12:48:29 smsl-n100 volumio[965]: info: Exploding uri music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/06. Say No More.flac in service mpd Dec 20 12:48:29 smsl-n100 volumio[965]: info: ALBUMART /albumart?cacheid=202&web=Volbeat/Servant%20Of%20The%20Mind/extralarge&path=%2Fmnt%2FUSB%2FAune_SD%2FENG%2F%D0%A1ollection%2FVolbeat%2FStudio%20Albums%202005%20-%202021%2F2021%20-%20Servant%20Of%20The%20Mind%2F06.%20Say%20No%20More.flac&metadata=false Dec 20 12:48:29 smsl-n100 volumio[965]: info: URI /mnt/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/06. Say No More.flac Dec 20 12:48:30 smsl-n100 volumio[965]: info: Exploding uri music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/07. Heaven's Descent.flac in service mpd Dec 20 12:48:30 smsl-n100 volumio[965]: info: ALBUMART /albumart?cacheid=202&web=Volbeat/Servant%20Of%20The%20Mind/extralarge&path=%2Fmnt%2FUSB%2FAune_SD%2FENG%2F%D0%A1ollection%2FVolbeat%2FStudio%20Albums%202005%20-%202021%2F2021%20-%20Servant%20Of%20The%20Mind%2F07.%20Heaven's%20Descent.flac&metadata=false Dec 20 12:48:30 smsl-n100 volumio[965]: info: URI /mnt/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/07. Heaven's Descent.flac Dec 20 12:48:30 smsl-n100 volumio[965]: info: Exploding uri music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/08. Dagen For.flac in service mpd Dec 20 12:48:30 smsl-n100 volumio[965]: info: ALBUMART /albumart?cacheid=202&web=Volbeat/Servant%20Of%20The%20Mind/extralarge&path=%2Fmnt%2FUSB%2FAune_SD%2FENG%2F%D0%A1ollection%2FVolbeat%2FStudio%20Albums%202005%20-%202021%2F2021%20-%20Servant%20Of%20The%20Mind%2F08.%20Dagen%20For.flac&metadata=false Dec 20 12:48:30 smsl-n100 volumio[965]: info: URI /mnt/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/08. Dagen For.flac Dec 20 12:48:30 smsl-n100 volumio[965]: info: Exploding uri music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/09. The Passenger.flac in service mpd Dec 20 12:48:30 smsl-n100 volumio[965]: info: ALBUMART /albumart?cacheid=202&web=Volbeat/Servant%20Of%20The%20Mind/extralarge&path=%2Fmnt%2FUSB%2FAune_SD%2FENG%2F%D0%A1ollection%2FVolbeat%2FStudio%20Albums%202005%20-%202021%2F2021%20-%20Servant%20Of%20The%20Mind%2F09.%20The%20Passenger.flac&metadata=false Dec 20 12:48:30 smsl-n100 volumio[965]: info: URI /mnt/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/09. The Passenger.flac Dec 20 12:48:30 smsl-n100 volumio[965]: info: Exploding uri music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/10. Step Into Light.flac in service mpd Dec 20 12:48:30 smsl-n100 volumio[965]: info: ALBUMART /albumart?cacheid=202&web=Volbeat/Servant%20Of%20The%20Mind/extralarge&path=%2Fmnt%2FUSB%2FAune_SD%2FENG%2F%D0%A1ollection%2FVolbeat%2FStudio%20Albums%202005%20-%202021%2F2021%20-%20Servant%20Of%20The%20Mind%2F10.%20Step%20Into%20Light.flac&metadata=false Dec 20 12:48:30 smsl-n100 volumio[965]: info: URI /mnt/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/10. Step Into Light.flac Dec 20 12:48:30 smsl-n100 volumio[965]: info: Exploding uri music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/11. Becoming.flac in service mpd Dec 20 12:48:30 smsl-n100 volumio[965]: info: ALBUMART /albumart?cacheid=202&web=Volbeat/Servant%20Of%20The%20Mind/extralarge&path=%2Fmnt%2FUSB%2FAune_SD%2FENG%2F%D0%A1ollection%2FVolbeat%2FStudio%20Albums%202005%20-%202021%2F2021%20-%20Servant%20Of%20The%20Mind%2F11.%20Becoming.flac&metadata=false Dec 20 12:48:30 smsl-n100 volumio[965]: info: URI /mnt/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/11. Becoming.flac Dec 20 12:48:30 smsl-n100 volumio[965]: info: Exploding uri music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/12. Mindlock.flac in service mpd Dec 20 12:48:30 smsl-n100 volumio[965]: info: ALBUMART /albumart?cacheid=202&web=Volbeat/Servant%20Of%20The%20Mind/extralarge&path=%2Fmnt%2FUSB%2FAune_SD%2FENG%2F%D0%A1ollection%2FVolbeat%2FStudio%20Albums%202005%20-%202021%2F2021%20-%20Servant%20Of%20The%20Mind%2F12.%20Mindlock.flac&metadata=false Dec 20 12:48:30 smsl-n100 volumio[965]: info: URI /mnt/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/12. Mindlock.flac Dec 20 12:48:30 smsl-n100 volumio[965]: info: Exploding uri music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/13. Lasse's Birgitta.flac in service mpd Dec 20 12:48:30 smsl-n100 volumio[965]: info: ALBUMART /albumart?cacheid=202&web=Volbeat/Servant%20Of%20The%20Mind/extralarge&path=%2Fmnt%2FUSB%2FAune_SD%2FENG%2F%D0%A1ollection%2FVolbeat%2FStudio%20Albums%202005%20-%202021%2F2021%20-%20Servant%20Of%20The%20Mind%2F13.%20Lasse's%20Birgitta.flac&metadata=false Dec 20 12:48:30 smsl-n100 volumio[965]: info: URI /mnt/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/13. Lasse's Birgitta.flac Dec 20 12:48:30 smsl-n100 volumio[965]: info: Exploding uri music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/14. Return To None.flac in service mpd Dec 20 12:48:30 smsl-n100 volumio[965]: info: ALBUMART /albumart?cacheid=202&web=Volbeat/Servant%20Of%20The%20Mind/extralarge&path=%2Fmnt%2FUSB%2FAune_SD%2FENG%2F%D0%A1ollection%2FVolbeat%2FStudio%20Albums%202005%20-%202021%2F2021%20-%20Servant%20Of%20The%20Mind%2F14.%20Return%20To%20None.flac&metadata=false Dec 20 12:48:30 smsl-n100 volumio[965]: info: URI /mnt/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/14. Return To None.flac Dec 20 12:48:30 smsl-n100 volumio[965]: info: Exploding uri music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/15. Domino.flac in service mpd Dec 20 12:48:30 smsl-n100 volumio[965]: info: ALBUMART /albumart?cacheid=202&web=Volbeat/Servant%20Of%20The%20Mind/extralarge&path=%2Fmnt%2FUSB%2FAune_SD%2FENG%2F%D0%A1ollection%2FVolbeat%2FStudio%20Albums%202005%20-%202021%2F2021%20-%20Servant%20Of%20The%20Mind%2F15.%20Domino.flac&metadata=false Dec 20 12:48:30 smsl-n100 volumio[965]: info: URI /mnt/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/15. Domino.flac Dec 20 12:48:30 smsl-n100 volumio[965]: info: Exploding uri music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/16. Shotgun Blues.flac in service mpd Dec 20 12:48:30 smsl-n100 volumio[965]: info: ALBUMART /albumart?cacheid=202&web=Volbeat/Servant%20Of%20The%20Mind/extralarge&path=%2Fmnt%2FUSB%2FAune_SD%2FENG%2F%D0%A1ollection%2FVolbeat%2FStudio%20Albums%202005%20-%202021%2F2021%20-%20Servant%20Of%20The%20Mind%2F16.%20Shotgun%20Blues.flac&metadata=false Dec 20 12:48:30 smsl-n100 volumio[965]: info: URI /mnt/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/16. Shotgun Blues.flac Dec 20 12:48:30 smsl-n100 volumio[965]: info: Exploding uri music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/17. Dagen For (Michael Vox Version).flac in service mpd Dec 20 12:48:30 smsl-n100 volumio[965]: info: ALBUMART /albumart?cacheid=202&web=Volbeat/Servant%20Of%20The%20Mind/extralarge&path=%2Fmnt%2FUSB%2FAune_SD%2FENG%2F%D0%A1ollection%2FVolbeat%2FStudio%20Albums%202005%20-%202021%2F2021%20-%20Servant%20Of%20The%20Mind%2F17.%20Dagen%20For%20(Michael%20Vox%20Version).flac&metadata=false Dec 20 12:48:30 smsl-n100 volumio[965]: info: URI /mnt/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/17. Dagen For (Michael Vox Version).flac Dec 20 12:48:30 smsl-n100 volumio[965]: info: Exploding uri music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/18. Don’t Tread On Me.flac in service mpd Dec 20 12:48:30 smsl-n100 volumio[965]: info: ALBUMART /albumart?cacheid=202&web=Volbeat/Servant%20Of%20The%20Mind/extralarge&path=%2Fmnt%2FUSB%2FAune_SD%2FENG%2F%D0%A1ollection%2FVolbeat%2FStudio%20Albums%202005%20-%202021%2F2021%20-%20Servant%20Of%20The%20Mind%2F18.%20Don%E2%80%99t%20Tread%20On%20Me.flac&metadata=false Dec 20 12:48:30 smsl-n100 volumio[965]: info: URI /mnt/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/18. Don’t Tread On Me.flac Dec 20 12:48:41 smsl-n100 volumio[965]: info: Preload queue cleared Dec 20 12:48:41 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioAddQueueItems Dec 20 12:48:41 smsl-n100 volumio[965]: info: CoreStateMachine::addQueueItems Dec 20 12:48:41 smsl-n100 volumio[965]: info: CorePlayQueue::addQueueItems Dec 20 12:48:41 smsl-n100 volumio[965]: info: Preload queue cleared Dec 20 12:48:41 smsl-n100 volumio[965]: info: Adding Item to queue: music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/05. The Devil Rages On.flac Dec 20 12:48:41 smsl-n100 volumio[965]: info: Using cached record of: music-library/USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/05. The Devil Rages On.flac Dec 20 12:48:41 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushQueue Dec 20 12:48:41 smsl-n100 volumio[965]: info: CorePlayQueue::saveQueue Dec 20 12:48:41 smsl-n100 volumio[965]: info: CoreStateMachine::updateTrackBlock Dec 20 12:48:41 smsl-n100 volumio[965]: info: CorePlayQueue::getTrackBlock Dec 20 12:48:41 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPlay Dec 20 12:48:41 smsl-n100 volumio[965]: info: CoreStateMachine::play index 2508 Dec 20 12:48:41 smsl-n100 volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 12:48:41 smsl-n100 volumio[965]: info: CoreStateMachine::stop Dec 20 12:48:41 smsl-n100 volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 12:48:41 smsl-n100 volumio[965]: info: CoreStateMachine::stPlaybackTimer Dec 20 12:48:41 smsl-n100 volumio[965]: info: CoreStateMachine::updateTrackBlock Dec 20 12:48:41 smsl-n100 volumio[965]: info: CorePlayQueue::getTrackBlock Dec 20 12:48:41 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:41 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 684 Dec 20 12:48:41 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 12:48:41 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:41 smsl-n100 volumio[965]: info: CoreStateMachine::serviceStop Dec 20 12:48:41 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 684 Dec 20 12:48:41 smsl-n100 volumio[965]: info: CoreCommandRouter::serviceStop Dec 20 12:48:41 smsl-n100 volumio[965]: info: ControllerMpd::stop Dec 20 12:48:41 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand stop Dec 20 12:48:42 smsl-n100 volumio[965]: info: Dec 20 12:48:42 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:48:42 smsl-n100 volumio[965]: info: sendMpdCommand stop took 615 milliseconds Dec 20 12:48:42 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:48:42 smsl-n100 volumio[965]: info: CoreStateMachine::play index undefined Dec 20 12:48:42 smsl-n100 volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 12:48:42 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:42 smsl-n100 volumio[965]: info: CoreStateMachine::startPlaybackTimer Dec 20 12:48:42 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::clearAddPlayTracks USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/05. The Devil Rages On.flac Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand stop Dec 20 12:48:42 smsl-n100 volumio[965]: info: Dec 20 12:48:42 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:48:42 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:48:42 smsl-n100 volumio[965]: info: Dec 20 12:48:42 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:48:42 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:48:42 smsl-n100 volumio[965]: info: Dec 20 12:48:42 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:48:42 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:48:42 smsl-n100 volumio[965]: info: sendMpdCommand status took 38 milliseconds Dec 20 12:48:42 smsl-n100 volumio[965]: info: sendMpdCommand stop took 26 milliseconds Dec 20 12:48:42 smsl-n100 volumio[965]: info: sendMpdCommand status took 23 milliseconds Dec 20 12:48:42 smsl-n100 volumio[965]: info: sendMpdCommand status took 19 milliseconds Dec 20 12:48:42 smsl-n100 volumio[965]: info: sendMpdCommand status took 17 milliseconds Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand clear Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:48:42 smsl-n100 volumio[965]: info: Dec 20 12:48:42 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:48:42 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:48:42 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 21 milliseconds Dec 20 12:48:42 smsl-n100 volumio[965]: info: sendMpdCommand clear took 21 milliseconds Dec 20 12:48:42 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 21 milliseconds Dec 20 12:48:42 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 20 milliseconds Dec 20 12:48:42 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 19 milliseconds Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand add "USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/05. The Devil Rages On.flac" Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:48:42 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:48:42 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:48:42 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:42 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:42 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 12:48:42 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:42 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Harder The Heart (The Harder It Breaks)","artist":"Bullet For My Valentine","album":"Venom","uri":"USB/Aune_SD/ENG/Сollection/Bullet For My Valentine/Studio Albums 2006 - 2021/2015 - Venom/08. The Harder The Heart (The Harder It Breaks).flac","trackType":"flac"} Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: CURRENT POSITION 2508 Dec 20 12:48:42 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService stop Dec 20 12:48:42 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus stop Dec 20 12:48:42 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:42 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:42 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:42 smsl-n100 volumio[965]: info: No code Dec 20 12:48:42 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:42 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:42 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:42 smsl-n100 volumio[965]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 20 12:48:42 smsl-n100 volumio[965]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 20 12:48:42 smsl-n100 volumio[965]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 20 12:48:42 smsl-n100 volumio[965]: info: ------------------------------ 164ms Dec 20 12:48:42 smsl-n100 volumio[965]: info: ------------------------------ 140ms Dec 20 12:48:42 smsl-n100 volumio[965]: info: ------------------------------ 136ms Dec 20 12:48:42 smsl-n100 volumio[965]: info: ------------------------------ 133ms Dec 20 12:48:42 smsl-n100 volumio[965]: info: Dec 20 12:48:42 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:48:42 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:48:42 smsl-n100 volumio[965]: info: Dec 20 12:48:42 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:48:42 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:48:42 smsl-n100 volumio[965]: info: Dec 20 12:48:42 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:48:42 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:48:42 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:42 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:42 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:42 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: 100, message: undefined Dec 20 12:48:42 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: MAXVOL, message: Dec 20 12:48:42 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: 100, message: undefined Dec 20 12:48:42 smsl-n100 volumio[965]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Dec 20 12:48:42 smsl-n100 volumio[965]: error: updateQueue error: null Dec 20 12:48:42 smsl-n100 volumio[965]: info: Dec 20 12:48:42 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:48:42 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:48:42 smsl-n100 volumio[965]: info: ------------------------------ 143ms Dec 20 12:48:42 smsl-n100 volumio[965]: info: sendMpdCommand add "USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/05. The Devil Rages On.flac" took 127 milliseconds Dec 20 12:48:42 smsl-n100 volumio[965]: info: ------------------------------ 52ms Dec 20 12:48:42 smsl-n100 volumio[965]: info: ------------------------------ 49ms Dec 20 12:48:42 smsl-n100 volumio[965]: info: ------------------------------ 47ms Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand play Dec 20 12:48:42 smsl-n100 volumio[965]: info: Dec 20 12:48:42 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:48:42 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:48:42 smsl-n100 volumio[965]: info: Dec 20 12:48:42 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:48:42 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:48:42 smsl-n100 volumio[965]: info: Dec 20 12:48:42 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:48:42 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:48:42 smsl-n100 volumio[965]: info: Dec 20 12:48:42 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:48:42 smsl-n100 volumio[965]: info: Dec 20 12:48:42 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:48:42 smsl-n100 volumio[965]: info: ------------------------------ 83ms Dec 20 12:48:42 smsl-n100 volumio[965]: info: sendMpdCommand play took 76 milliseconds Dec 20 12:48:42 smsl-n100 volumio[965]: info: ------------------------------ 78ms Dec 20 12:48:42 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:48:42 smsl-n100 volumio[965]: info: ------------------------------ 78ms Dec 20 12:48:42 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:48:42 smsl-n100 volumio[965]: info: ------------------------------ 76ms Dec 20 12:48:42 smsl-n100 volumio[965]: info: Dec 20 12:48:42 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:48:42 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:48:42 smsl-n100 volumio[965]: info: Dec 20 12:48:42 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:48:42 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:48:42 smsl-n100 volumio[965]: info: Dec 20 12:48:42 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:48:42 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:48:42 smsl-n100 volumio[965]: info: sendMpdCommand status took 61 milliseconds Dec 20 12:48:42 smsl-n100 volumio[965]: info: sendMpdCommand status took 59 milliseconds Dec 20 12:48:42 smsl-n100 volumio[965]: info: sendMpdCommand status took 53 milliseconds Dec 20 12:48:42 smsl-n100 volumio[965]: info: sendMpdCommand status took 47 milliseconds Dec 20 12:48:42 smsl-n100 volumio[965]: info: sendMpdCommand status took 40 milliseconds Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:48:42 smsl-n100 volumio[965]: info: Dec 20 12:48:42 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:48:42 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:48:42 smsl-n100 volumio[965]: info: Dec 20 12:48:42 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:48:42 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:48:42 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 68 milliseconds Dec 20 12:48:42 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 63 milliseconds Dec 20 12:48:42 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 62 milliseconds Dec 20 12:48:42 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 61 milliseconds Dec 20 12:48:42 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 59 milliseconds Dec 20 12:48:42 smsl-n100 volumio[965]: info: sendMpdCommand status took 47 milliseconds Dec 20 12:48:42 smsl-n100 volumio[965]: info: sendMpdCommand status took 39 milliseconds Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:48:42 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:48:42 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:48:42 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":310,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"579 Kbps","isStreaming":false,"title":"The Devil Rages On","artist":"Volbeat","album":"Servant Of The Mind","uri":"USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/05. The Devil Rages On.flac","trackType":"flac"} Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: CURRENT POSITION 2508 Dec 20 12:48:42 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:48:42 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus stop Dec 20 12:48:42 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:48:42 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:48:42 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":310,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"579 Kbps","isStreaming":false,"title":"The Devil Rages On","artist":"Volbeat","album":"Servant Of The Mind","uri":"USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/05. The Devil Rages On.flac","trackType":"flac"} Dec 20 12:48:42 smsl-n100 volumio[965]: verbose: CURRENT POSITION 2508 Dec 20 12:48:42 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:48:42 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:48:42 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:48:42 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:42 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:42 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 12:48:42 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:42 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:42 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:43 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":310,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"579 Kbps","isStreaming":false,"title":"The Devil Rages On","artist":"Volbeat","album":"Servant Of The Mind","uri":"USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/05. The Devil Rages On.flac","trackType":"flac"} Dec 20 12:48:43 smsl-n100 volumio[965]: verbose: CURRENT POSITION 2508 Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:48:43 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:43 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":310,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"579 Kbps","isStreaming":false,"title":"The Devil Rages On","artist":"Volbeat","album":"Servant Of The Mind","uri":"USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/05. The Devil Rages On.flac","trackType":"flac"} Dec 20 12:48:43 smsl-n100 volumio[965]: verbose: CURRENT POSITION 2508 Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:48:43 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:43 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":310,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"579 Kbps","isStreaming":false,"title":"The Devil Rages On","artist":"Volbeat","album":"Servant Of The Mind","uri":"USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/05. The Devil Rages On.flac","trackType":"flac"} Dec 20 12:48:43 smsl-n100 volumio[965]: verbose: CURRENT POSITION 2508 Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:48:43 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: ------------------------------ 255ms Dec 20 12:48:43 smsl-n100 volumio[965]: info: ------------------------------ 310ms Dec 20 12:48:43 smsl-n100 volumio[965]: info: ------------------------------ 292ms Dec 20 12:48:43 smsl-n100 volumio[965]: info: ------------------------------ 286ms Dec 20 12:48:43 smsl-n100 volumio[965]: info: ------------------------------ 281ms Dec 20 12:48:43 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 148 milliseconds Dec 20 12:48:43 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 147 milliseconds Dec 20 12:48:43 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:48:43 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:48:43 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:43 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":310,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"602 Kbps","isStreaming":false,"title":"The Devil Rages On","artist":"Volbeat","album":"Servant Of The Mind","uri":"USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/05. The Devil Rages On.flac","trackType":"flac"} Dec 20 12:48:43 smsl-n100 volumio[965]: verbose: CURRENT POSITION 2508 Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:48:43 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:43 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":310,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"602 Kbps","isStreaming":false,"title":"The Devil Rages On","artist":"Volbeat","album":"Servant Of The Mind","uri":"USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/05. The Devil Rages On.flac","trackType":"flac"} Dec 20 12:48:43 smsl-n100 volumio[965]: verbose: CURRENT POSITION 2508 Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:48:43 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: ------------------------------ 281ms Dec 20 12:48:43 smsl-n100 volumio[965]: info: ------------------------------ 275ms Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:43 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:43 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:43 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: 100, message: undefined Dec 20 12:48:43 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: MAXVOL, message: Dec 20 12:48:43 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: 100, message: undefined Dec 20 12:48:43 smsl-n100 volumio[965]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Dec 20 12:48:46 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioRandom Dec 20 12:48:46 smsl-n100 volumio[965]: info: CoreCommandRouter::writePlayerControls Dec 20 12:48:46 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:46 smsl-n100 volumio[965]: info: CoreStateMachine::setRandom false Dec 20 12:48:46 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:46 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:46 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 12:48:46 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioNext Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::next Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::stop Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::stPlaybackTimer Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::updateTrackBlock Dec 20 12:48:54 smsl-n100 volumio[965]: info: CorePlayQueue::getTrackBlock Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::serviceStop Dec 20 12:48:54 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2508 Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreCommandRouter::serviceStop Dec 20 12:48:54 smsl-n100 volumio[965]: info: ControllerMpd::stop Dec 20 12:48:54 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand stop Dec 20 12:48:54 smsl-n100 volumio[965]: info: Dec 20 12:48:54 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:48:54 smsl-n100 volumio[965]: info: sendMpdCommand stop took 19 milliseconds Dec 20 12:48:54 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:48:54 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::play index undefined Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 12:48:54 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2509 Dec 20 12:48:54 smsl-n100 volumio[965]: info: sendMpdCommand status took 7 milliseconds Dec 20 12:48:54 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:48:54 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:48:54 smsl-n100 volumio[965]: info: Dec 20 12:48:54 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:48:54 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:48:54 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:48:54 smsl-n100 volumio[965]: info: Dec 20 12:48:54 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:48:54 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:48:54 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:48:54 smsl-n100 volumio[965]: info: Dec 20 12:48:54 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:48:54 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:48:54 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:48:54 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 17 milliseconds Dec 20 12:48:54 smsl-n100 volumio[965]: info: sendMpdCommand status took 14 milliseconds Dec 20 12:48:54 smsl-n100 volumio[965]: info: sendMpdCommand status took 10 milliseconds Dec 20 12:48:54 smsl-n100 volumio[965]: info: sendMpdCommand status took 7 milliseconds Dec 20 12:48:54 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:48:54 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:48:54 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:48:54 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:48:54 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:48:54 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:48:54 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:48:54 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 0 Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 0 Dec 20 12:48:54 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Devil Rages On","artist":"Volbeat","album":"Servant Of The Mind","uri":"USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/05. The Devil Rages On.flac","trackType":"flac"} Dec 20 12:48:54 smsl-n100 volumio[965]: verbose: CURRENT POSITION 0 Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService stop Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus stop Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 0 Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: No code Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 0 Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: ------------------------------ 93ms Dec 20 12:48:54 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 58 milliseconds Dec 20 12:48:54 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 58 milliseconds Dec 20 12:48:54 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 58 milliseconds Dec 20 12:48:54 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:48:54 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:48:54 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 0 Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 0 Dec 20 12:48:54 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Devil Rages On","artist":"Volbeat","album":"Servant Of The Mind","uri":"USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/05. The Devil Rages On.flac","trackType":"flac"} Dec 20 12:48:54 smsl-n100 volumio[965]: verbose: CURRENT POSITION 0 Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService stop Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus stop Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 0 Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: No code Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 0 Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 0 Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 0 Dec 20 12:48:54 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Devil Rages On","artist":"Volbeat","album":"Servant Of The Mind","uri":"USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/05. The Devil Rages On.flac","trackType":"flac"} Dec 20 12:48:54 smsl-n100 volumio[965]: verbose: CURRENT POSITION 0 Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService stop Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus stop Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 0 Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: No code Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 0 Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 0 Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 0 Dec 20 12:48:54 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Devil Rages On","artist":"Volbeat","album":"Servant Of The Mind","uri":"USB/Aune_SD/ENG/Сollection/Volbeat/Studio Albums 2005 - 2021/2021 - Servant Of The Mind/05. The Devil Rages On.flac","trackType":"flac"} Dec 20 12:48:54 smsl-n100 volumio[965]: verbose: CURRENT POSITION 0 Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService stop Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus stop Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 0 Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: No code Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 0 Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: ------------------------------ 219ms Dec 20 12:48:54 smsl-n100 volumio[965]: info: ------------------------------ 217ms Dec 20 12:48:54 smsl-n100 volumio[965]: info: ------------------------------ 215ms Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:48:54 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 0 Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 12:48:54 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:48:54 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: 100, message: undefined Dec 20 12:48:54 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: MAXVOL, message: Dec 20 12:48:54 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: 100, message: undefined Dec 20 12:48:54 smsl-n100 volumio[965]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Dec 20 12:49:00 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioNext Dec 20 12:49:00 smsl-n100 volumio[965]: info: CoreStateMachine::next Dec 20 12:49:00 smsl-n100 volumio[965]: info: CoreStateMachine::stop Dec 20 12:49:00 smsl-n100 volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 12:49:00 smsl-n100 volumio[965]: info: CoreStateMachine::play index undefined Dec 20 12:49:00 smsl-n100 volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 12:49:00 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 1 Dec 20 12:49:00 smsl-n100 volumio[965]: info: CoreStateMachine::startPlaybackTimer Dec 20 12:49:00 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 1 Dec 20 12:49:00 smsl-n100 volumio[965]: verbose: ControllerMpd::clearAddPlayTracks USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/02. Venus And Mars.flac Dec 20 12:49:00 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand stop Dec 20 12:49:00 smsl-n100 volumio[965]: info: CoreStateMachine::updateTrackBlock Dec 20 12:49:00 smsl-n100 volumio[965]: info: CorePlayQueue::getTrackBlock Dec 20 12:49:00 smsl-n100 volumio[965]: info: sendMpdCommand stop took 9 milliseconds Dec 20 12:49:00 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand clear Dec 20 12:49:00 smsl-n100 volumio[965]: info: Dec 20 12:49:00 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:00 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:00 smsl-n100 volumio[965]: info: sendMpdCommand clear took 5 milliseconds Dec 20 12:49:00 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand add "USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/02. Venus And Mars.flac" Dec 20 12:49:00 smsl-n100 volumio[965]: info: Dec 20 12:49:00 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:00 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:00 smsl-n100 volumio[965]: info: Dec 20 12:49:00 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:00 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:00 smsl-n100 volumio[965]: info: Dec 20 12:49:00 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:00 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:00 smsl-n100 volumio[965]: error: updateQueue error: null Dec 20 12:49:00 smsl-n100 volumio[965]: info: Dec 20 12:49:00 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:00 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:00 smsl-n100 volumio[965]: info: ------------------------------ 28ms Dec 20 12:49:00 smsl-n100 volumio[965]: info: sendMpdCommand add "USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/02. Venus And Mars.flac" took 24 milliseconds Dec 20 12:49:00 smsl-n100 volumio[965]: info: ------------------------------ 22ms Dec 20 12:49:00 smsl-n100 volumio[965]: info: ------------------------------ 19ms Dec 20 12:49:00 smsl-n100 volumio[965]: info: ------------------------------ 12ms Dec 20 12:49:00 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand play Dec 20 12:49:00 smsl-n100 volumio[965]: info: Dec 20 12:49:00 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:00 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:00 smsl-n100 volumio[965]: info: Dec 20 12:49:00 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:00 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:01 smsl-n100 volumio[965]: info: Dec 20 12:49:01 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:01 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:01 smsl-n100 volumio[965]: info: Dec 20 12:49:01 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:01 smsl-n100 volumio[965]: info: Dec 20 12:49:01 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:01 smsl-n100 volumio[965]: info: ------------------------------ 27ms Dec 20 12:49:01 smsl-n100 volumio[965]: info: sendMpdCommand play took 20 milliseconds Dec 20 12:49:01 smsl-n100 volumio[965]: info: ------------------------------ 20ms Dec 20 12:49:01 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:01 smsl-n100 volumio[965]: info: ------------------------------ 20ms Dec 20 12:49:01 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:01 smsl-n100 volumio[965]: info: ------------------------------ 20ms Dec 20 12:49:01 smsl-n100 volumio[965]: info: Dec 20 12:49:01 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:01 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:01 smsl-n100 volumio[965]: info: Dec 20 12:49:01 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:01 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:01 smsl-n100 volumio[965]: info: Dec 20 12:49:01 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:01 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:01 smsl-n100 volumio[965]: info: sendMpdCommand status took 36 milliseconds Dec 20 12:49:01 smsl-n100 volumio[965]: info: sendMpdCommand status took 33 milliseconds Dec 20 12:49:01 smsl-n100 volumio[965]: info: sendMpdCommand status took 24 milliseconds Dec 20 12:49:01 smsl-n100 volumio[965]: info: sendMpdCommand status took 18 milliseconds Dec 20 12:49:01 smsl-n100 volumio[965]: info: sendMpdCommand status took 13 milliseconds Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:01 smsl-n100 volumio[965]: info: Dec 20 12:49:01 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:01 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:01 smsl-n100 volumio[965]: info: Dec 20 12:49:01 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:01 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:01 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 32 milliseconds Dec 20 12:49:01 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 32 milliseconds Dec 20 12:49:01 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 31 milliseconds Dec 20 12:49:01 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 30 milliseconds Dec 20 12:49:01 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 29 milliseconds Dec 20 12:49:01 smsl-n100 volumio[965]: info: sendMpdCommand status took 20 milliseconds Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:01 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 1 Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"823 Kbps","isStreaming":false,"title":"Venus And Mars","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/02. Venus And Mars.flac","trackType":"flac"} Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: CURRENT POSITION 1 Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus stop Dec 20 12:49:01 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 1 Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"888 Kbps","isStreaming":false,"title":"Venus And Mars","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/02. Venus And Mars.flac","trackType":"flac"} Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: CURRENT POSITION 1 Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:01 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 1 Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 1 Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 1 Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"952 Kbps","isStreaming":false,"title":"Venus And Mars","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/02. Venus And Mars.flac","trackType":"flac"} Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: CURRENT POSITION 1 Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:01 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 1 Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 1 Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 1 Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"825 Kbps","isStreaming":false,"title":"Venus And Mars","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/02. Venus And Mars.flac","trackType":"flac"} Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: CURRENT POSITION 1 Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:01 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 1 Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 1 Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 1 Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"784 Kbps","isStreaming":false,"title":"Venus And Mars","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/02. Venus And Mars.flac","trackType":"flac"} Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: CURRENT POSITION 1 Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:01 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 1 Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 1 Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: ------------------------------ 202ms Dec 20 12:49:01 smsl-n100 volumio[965]: info: ------------------------------ 266ms Dec 20 12:49:01 smsl-n100 volumio[965]: info: ------------------------------ 251ms Dec 20 12:49:01 smsl-n100 volumio[965]: info: ------------------------------ 245ms Dec 20 12:49:01 smsl-n100 volumio[965]: info: ------------------------------ 240ms Dec 20 12:49:01 smsl-n100 volumio[965]: info: sendMpdCommand status took 196 milliseconds Dec 20 12:49:01 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 167 milliseconds Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:01 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 1 Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"784 Kbps","isStreaming":false,"title":"Venus And Mars","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/02. Venus And Mars.flac","trackType":"flac"} Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: CURRENT POSITION 1 Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:01 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 1 Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 1 Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: ------------------------------ 248ms Dec 20 12:49:01 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 88 milliseconds Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:01 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 1 Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"784 Kbps","isStreaming":false,"title":"Venus And Mars","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/02. Venus And Mars.flac","trackType":"flac"} Dec 20 12:49:01 smsl-n100 volumio[965]: verbose: CURRENT POSITION 1 Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:01 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 1 Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 1 Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: ------------------------------ 330ms Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:01 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 1 Dec 20 12:49:01 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:01 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: 100, message: undefined Dec 20 12:49:01 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: MAXVOL, message: Dec 20 12:49:01 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: 100, message: undefined Dec 20 12:49:01 smsl-n100 volumio[965]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioNext Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::next Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::stop Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::stPlaybackTimer Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::updateTrackBlock Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrackBlock Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 1 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::serviceStop Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 1 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::serviceStop Dec 20 12:49:03 smsl-n100 volumio[965]: info: ControllerMpd::stop Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand stop Dec 20 12:49:03 smsl-n100 volumio[965]: info: Dec 20 12:49:03 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:03 smsl-n100 volumio[965]: info: sendMpdCommand stop took 19 milliseconds Dec 20 12:49:03 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::play index undefined Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::startPlaybackTimer Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::clearAddPlayTracks USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/03. My Army Of Lovers.flac Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand stop Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::updateTrackBlock Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrackBlock Dec 20 12:49:03 smsl-n100 volumio[965]: info: sendMpdCommand status took 18 milliseconds Dec 20 12:49:03 smsl-n100 volumio[965]: info: sendMpdCommand stop took 9 milliseconds Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand clear Dec 20 12:49:03 smsl-n100 volumio[965]: info: Dec 20 12:49:03 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:03 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:03 smsl-n100 volumio[965]: info: Dec 20 12:49:03 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:03 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:03 smsl-n100 volumio[965]: info: Dec 20 12:49:03 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:03 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:03 smsl-n100 volumio[965]: info: Dec 20 12:49:03 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:03 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:03 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 21 milliseconds Dec 20 12:49:03 smsl-n100 volumio[965]: info: sendMpdCommand clear took 21 milliseconds Dec 20 12:49:03 smsl-n100 volumio[965]: info: sendMpdCommand status took 16 milliseconds Dec 20 12:49:03 smsl-n100 volumio[965]: info: sendMpdCommand status took 13 milliseconds Dec 20 12:49:03 smsl-n100 volumio[965]: info: sendMpdCommand status took 10 milliseconds Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand add "USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/03. My Army Of Lovers.flac" Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:03 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Venus And Mars","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/02. Venus And Mars.flac","trackType":"flac"} Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: CURRENT POSITION 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService stop Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus stop Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: No code Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: 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} Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: CURRENT POSITION 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService stop Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus stop Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: No code Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: 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} Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: CURRENT POSITION 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService stop Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus stop Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: No code Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: 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} Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: CURRENT POSITION 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService stop Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus stop Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: No code Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: ------------------------------ 249ms Dec 20 12:49:03 smsl-n100 volumio[965]: info: ------------------------------ 222ms Dec 20 12:49:03 smsl-n100 volumio[965]: info: ------------------------------ 221ms Dec 20 12:49:03 smsl-n100 volumio[965]: info: ------------------------------ 218ms Dec 20 12:49:03 smsl-n100 volumio[965]: info: Dec 20 12:49:03 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:03 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:03 smsl-n100 volumio[965]: info: Dec 20 12:49:03 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:03 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:03 smsl-n100 volumio[965]: info: Dec 20 12:49:03 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:03 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:03 smsl-n100 volumio[965]: error: updateQueue error: null Dec 20 12:49:03 smsl-n100 volumio[965]: info: Dec 20 12:49:03 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:03 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:03 smsl-n100 volumio[965]: info: ------------------------------ 231ms Dec 20 12:49:03 smsl-n100 volumio[965]: info: sendMpdCommand add "USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/03. My Army Of Lovers.flac" took 222 milliseconds Dec 20 12:49:03 smsl-n100 volumio[965]: info: ------------------------------ 17ms Dec 20 12:49:03 smsl-n100 volumio[965]: info: ------------------------------ 14ms Dec 20 12:49:03 smsl-n100 volumio[965]: info: ------------------------------ 12ms Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand play Dec 20 12:49:03 smsl-n100 volumio[965]: info: Dec 20 12:49:03 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:03 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:03 smsl-n100 volumio[965]: info: Dec 20 12:49:03 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:03 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:03 smsl-n100 volumio[965]: info: Dec 20 12:49:03 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:03 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:03 smsl-n100 volumio[965]: info: Dec 20 12:49:03 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:03 smsl-n100 volumio[965]: info: Dec 20 12:49:03 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:03 smsl-n100 volumio[965]: info: ------------------------------ 126ms Dec 20 12:49:03 smsl-n100 volumio[965]: info: sendMpdCommand play took 120 milliseconds Dec 20 12:49:03 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:03 smsl-n100 volumio[965]: info: ------------------------------ 122ms Dec 20 12:49:03 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:03 smsl-n100 volumio[965]: info: ------------------------------ 119ms Dec 20 12:49:03 smsl-n100 volumio[965]: info: ------------------------------ 114ms Dec 20 12:49:03 smsl-n100 volumio[965]: info: Dec 20 12:49:03 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:03 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:03 smsl-n100 volumio[965]: info: Dec 20 12:49:03 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:03 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:03 smsl-n100 volumio[965]: info: Dec 20 12:49:03 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:03 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:03 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: 100, message: undefined Dec 20 12:49:03 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: MAXVOL, message: Dec 20 12:49:03 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: 100, message: undefined Dec 20 12:49:03 smsl-n100 volumio[965]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Dec 20 12:49:03 smsl-n100 volumio[965]: info: sendMpdCommand status took 63 milliseconds Dec 20 12:49:03 smsl-n100 volumio[965]: info: sendMpdCommand status took 60 milliseconds Dec 20 12:49:03 smsl-n100 volumio[965]: info: sendMpdCommand status took 49 milliseconds Dec 20 12:49:03 smsl-n100 volumio[965]: info: sendMpdCommand status took 43 milliseconds Dec 20 12:49:03 smsl-n100 volumio[965]: info: sendMpdCommand status took 39 milliseconds Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:03 smsl-n100 volumio[965]: info: Dec 20 12:49:03 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:03 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:03 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 27 milliseconds Dec 20 12:49:03 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 26 milliseconds Dec 20 12:49:03 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 25 milliseconds Dec 20 12:49:03 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 24 milliseconds Dec 20 12:49:03 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 25 milliseconds Dec 20 12:49:03 smsl-n100 volumio[965]: info: sendMpdCommand status took 19 milliseconds Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:03 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":209,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"851 Kbps","isStreaming":false,"title":"My Army Of Lovers","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/03. My Army Of Lovers.flac","trackType":"flac"} Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: CURRENT POSITION 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus stop Dec 20 12:49:03 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":209,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"851 Kbps","isStreaming":false,"title":"My Army Of Lovers","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/03. My Army Of Lovers.flac","trackType":"flac"} Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: CURRENT POSITION 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:03 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":209,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"851 Kbps","isStreaming":false,"title":"My Army Of Lovers","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/03. My Army Of Lovers.flac","trackType":"flac"} Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: CURRENT POSITION 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:03 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":209,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"851 Kbps","isStreaming":false,"title":"My Army Of Lovers","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/03. My Army Of Lovers.flac","trackType":"flac"} Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: CURRENT POSITION 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:03 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":209,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"851 Kbps","isStreaming":false,"title":"My Army Of Lovers","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/03. My Army Of Lovers.flac","trackType":"flac"} Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: CURRENT POSITION 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:03 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: ------------------------------ 197ms Dec 20 12:49:03 smsl-n100 volumio[965]: info: ------------------------------ 291ms Dec 20 12:49:03 smsl-n100 volumio[965]: info: ------------------------------ 277ms Dec 20 12:49:03 smsl-n100 volumio[965]: info: ------------------------------ 271ms Dec 20 12:49:03 smsl-n100 volumio[965]: info: ------------------------------ 268ms Dec 20 12:49:03 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 192 milliseconds Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:03 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":209,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"851 Kbps","isStreaming":false,"title":"My Army Of Lovers","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/03. My Army Of Lovers.flac","trackType":"flac"} Dec 20 12:49:03 smsl-n100 volumio[965]: verbose: CURRENT POSITION 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:03 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:03 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:03 smsl-n100 volumio[965]: info: ------------------------------ 259ms Dec 20 12:49:04 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:04 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:04 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:04 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: 100, message: undefined Dec 20 12:49:04 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: MAXVOL, message: Dec 20 12:49:04 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: 100, message: undefined Dec 20 12:49:04 smsl-n100 volumio[965]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioNext Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::next Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::stop Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::stPlaybackTimer Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::updateTrackBlock Dec 20 12:49:07 smsl-n100 volumio[965]: info: CorePlayQueue::getTrackBlock Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::serviceStop Dec 20 12:49:07 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2 Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreCommandRouter::serviceStop Dec 20 12:49:07 smsl-n100 volumio[965]: info: ControllerMpd::stop Dec 20 12:49:07 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand stop Dec 20 12:49:07 smsl-n100 volumio[965]: info: Dec 20 12:49:07 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:07 smsl-n100 volumio[965]: info: sendMpdCommand stop took 19 milliseconds Dec 20 12:49:07 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:07 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::play index undefined Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 12:49:07 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::startPlaybackTimer Dec 20 12:49:07 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:07 smsl-n100 volumio[965]: verbose: ControllerMpd::clearAddPlayTracks USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/04. Ride The Bullet.flac Dec 20 12:49:07 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand stop Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::updateTrackBlock Dec 20 12:49:07 smsl-n100 volumio[965]: info: CorePlayQueue::getTrackBlock Dec 20 12:49:07 smsl-n100 volumio[965]: info: sendMpdCommand status took 24 milliseconds Dec 20 12:49:07 smsl-n100 volumio[965]: info: sendMpdCommand stop took 18 milliseconds Dec 20 12:49:07 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:07 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:07 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand clear Dec 20 12:49:07 smsl-n100 volumio[965]: info: Dec 20 12:49:07 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:07 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:07 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:07 smsl-n100 volumio[965]: info: Dec 20 12:49:07 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:07 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:07 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:07 smsl-n100 volumio[965]: info: Dec 20 12:49:07 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:07 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:07 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:07 smsl-n100 volumio[965]: info: Dec 20 12:49:07 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:07 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:07 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 25 milliseconds Dec 20 12:49:07 smsl-n100 volumio[965]: info: sendMpdCommand clear took 26 milliseconds Dec 20 12:49:07 smsl-n100 volumio[965]: info: sendMpdCommand status took 21 milliseconds Dec 20 12:49:07 smsl-n100 volumio[965]: info: sendMpdCommand status took 17 milliseconds Dec 20 12:49:07 smsl-n100 volumio[965]: info: sendMpdCommand status took 12 milliseconds Dec 20 12:49:07 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:07 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand add "USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/04. Ride The Bullet.flac" Dec 20 12:49:07 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:07 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:07 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:07 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:07 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"My Army Of Lovers","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/03. My Army Of Lovers.flac","trackType":"flac"} Dec 20 12:49:07 smsl-n100 volumio[965]: verbose: CURRENT POSITION 3 Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService stop Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus stop Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: No code Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:07 smsl-n100 volumio[965]: 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} Dec 20 12:49:07 smsl-n100 volumio[965]: verbose: CURRENT POSITION 3 Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService stop Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus stop Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: No code Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:07 smsl-n100 volumio[965]: 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} Dec 20 12:49:07 smsl-n100 volumio[965]: verbose: CURRENT POSITION 3 Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService stop Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus stop Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: No code Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:07 smsl-n100 volumio[965]: 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} Dec 20 12:49:07 smsl-n100 volumio[965]: verbose: CURRENT POSITION 3 Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService stop Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus stop Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: No code Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: ------------------------------ 235ms Dec 20 12:49:07 smsl-n100 volumio[965]: info: ------------------------------ 203ms Dec 20 12:49:07 smsl-n100 volumio[965]: info: ------------------------------ 199ms Dec 20 12:49:07 smsl-n100 volumio[965]: info: ------------------------------ 197ms Dec 20 12:49:07 smsl-n100 volumio[965]: info: Dec 20 12:49:07 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:07 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:07 smsl-n100 volumio[965]: info: Dec 20 12:49:07 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:07 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:07 smsl-n100 volumio[965]: info: Dec 20 12:49:07 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:07 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:07 smsl-n100 volumio[965]: error: updateQueue error: null Dec 20 12:49:07 smsl-n100 volumio[965]: info: Dec 20 12:49:07 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:07 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:07 smsl-n100 volumio[965]: info: ------------------------------ 206ms Dec 20 12:49:07 smsl-n100 volumio[965]: info: sendMpdCommand add "USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/04. Ride The Bullet.flac" took 195 milliseconds Dec 20 12:49:07 smsl-n100 volumio[965]: info: ------------------------------ 17ms Dec 20 12:49:07 smsl-n100 volumio[965]: info: ------------------------------ 14ms Dec 20 12:49:07 smsl-n100 volumio[965]: info: ------------------------------ 12ms Dec 20 12:49:07 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand play Dec 20 12:49:07 smsl-n100 volumio[965]: info: Dec 20 12:49:07 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:07 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:07 smsl-n100 volumio[965]: info: Dec 20 12:49:07 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:07 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:07 smsl-n100 volumio[965]: info: Dec 20 12:49:07 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:07 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:07 smsl-n100 volumio[965]: info: Dec 20 12:49:07 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:07 smsl-n100 volumio[965]: info: Dec 20 12:49:07 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:07 smsl-n100 volumio[965]: info: ------------------------------ 109ms Dec 20 12:49:07 smsl-n100 volumio[965]: info: sendMpdCommand play took 103 milliseconds Dec 20 12:49:07 smsl-n100 volumio[965]: info: ------------------------------ 103ms Dec 20 12:49:07 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:07 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:07 smsl-n100 volumio[965]: info: ------------------------------ 102ms Dec 20 12:49:07 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:07 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:07 smsl-n100 volumio[965]: info: ------------------------------ 101ms Dec 20 12:49:07 smsl-n100 volumio[965]: info: Dec 20 12:49:07 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:07 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:07 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:07 smsl-n100 volumio[965]: info: Dec 20 12:49:07 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:07 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:07 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:07 smsl-n100 volumio[965]: info: Dec 20 12:49:07 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:07 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:07 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:07 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 12:49:07 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:07 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: 100, message: undefined Dec 20 12:49:07 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: MAXVOL, message: Dec 20 12:49:07 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: 100, message: undefined Dec 20 12:49:07 smsl-n100 volumio[965]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Dec 20 12:49:08 smsl-n100 volumio[965]: info: sendMpdCommand status took 62 milliseconds Dec 20 12:49:08 smsl-n100 volumio[965]: info: sendMpdCommand status took 59 milliseconds Dec 20 12:49:08 smsl-n100 volumio[965]: info: sendMpdCommand status took 53 milliseconds Dec 20 12:49:08 smsl-n100 volumio[965]: info: sendMpdCommand status took 47 milliseconds Dec 20 12:49:08 smsl-n100 volumio[965]: info: sendMpdCommand status took 41 milliseconds Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:08 smsl-n100 volumio[965]: info: Dec 20 12:49:08 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:08 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:08 smsl-n100 volumio[965]: info: Dec 20 12:49:08 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:08 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:08 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 29 milliseconds Dec 20 12:49:08 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 28 milliseconds Dec 20 12:49:08 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 27 milliseconds Dec 20 12:49:08 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 26 milliseconds Dec 20 12:49:08 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 26 milliseconds Dec 20 12:49:08 smsl-n100 volumio[965]: info: sendMpdCommand status took 20 milliseconds Dec 20 12:49:08 smsl-n100 volumio[965]: info: sendMpdCommand status took 17 milliseconds Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:08 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"941 Kbps","isStreaming":false,"title":"Ride The Bullet","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/04. Ride The Bullet.flac","trackType":"flac"} Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: CURRENT POSITION 3 Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus stop Dec 20 12:49:08 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"941 Kbps","isStreaming":false,"title":"Ride The Bullet","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/04. Ride The Bullet.flac","trackType":"flac"} Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: CURRENT POSITION 3 Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:08 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"941 Kbps","isStreaming":false,"title":"Ride The Bullet","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/04. Ride The Bullet.flac","trackType":"flac"} Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: CURRENT POSITION 3 Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:08 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1095 Kbps","isStreaming":false,"title":"Ride The Bullet","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/04. Ride The Bullet.flac","trackType":"flac"} Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: CURRENT POSITION 3 Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:08 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1095 Kbps","isStreaming":false,"title":"Ride The Bullet","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/04. Ride The Bullet.flac","trackType":"flac"} Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: CURRENT POSITION 3 Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:08 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: ------------------------------ 215ms Dec 20 12:49:08 smsl-n100 volumio[965]: info: ------------------------------ 259ms Dec 20 12:49:08 smsl-n100 volumio[965]: info: ------------------------------ 244ms Dec 20 12:49:08 smsl-n100 volumio[965]: info: ------------------------------ 242ms Dec 20 12:49:08 smsl-n100 volumio[965]: info: ------------------------------ 236ms Dec 20 12:49:08 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 150 milliseconds Dec 20 12:49:08 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 149 milliseconds Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:08 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1095 Kbps","isStreaming":false,"title":"Ride The Bullet","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/04. Ride The Bullet.flac","trackType":"flac"} Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: CURRENT POSITION 3 Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:08 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1095 Kbps","isStreaming":false,"title":"Ride The Bullet","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/04. Ride The Bullet.flac","trackType":"flac"} Dec 20 12:49:08 smsl-n100 volumio[965]: verbose: CURRENT POSITION 3 Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:08 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: ------------------------------ 263ms Dec 20 12:49:08 smsl-n100 volumio[965]: info: ------------------------------ 261ms Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:08 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:08 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:08 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: 100, message: undefined Dec 20 12:49:08 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: MAXVOL, message: Dec 20 12:49:08 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: 100, message: undefined Dec 20 12:49:08 smsl-n100 volumio[965]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Dec 20 12:49:09 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioRandom Dec 20 12:49:09 smsl-n100 volumio[965]: info: CoreCommandRouter::writePlayerControls Dec 20 12:49:09 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:09 smsl-n100 volumio[965]: info: CoreStateMachine::setRandom true Dec 20 12:49:09 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:09 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:09 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 12:49:09 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPrevious Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreStateMachine::previous Dec 20 12:49:10 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:10 smsl-n100 volumio[965]: info: ControllerMpd::seek Dec 20 12:49:10 smsl-n100 volumio[965]: error: null Dec 20 12:49:10 smsl-n100 volumio[965]: info: Dec 20 12:49:10 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:10 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:10 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:10 smsl-n100 volumio[965]: info: sendMpdCommand status took 4 milliseconds Dec 20 12:49:10 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:10 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:10 smsl-n100 volumio[965]: info: Dec 20 12:49:10 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:10 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:10 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:10 smsl-n100 volumio[965]: info: Dec 20 12:49:10 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:10 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:10 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:10 smsl-n100 volumio[965]: info: Dec 20 12:49:10 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:10 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:10 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:10 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 19 milliseconds Dec 20 12:49:10 smsl-n100 volumio[965]: info: sendMpdCommand status took 16 milliseconds Dec 20 12:49:10 smsl-n100 volumio[965]: info: sendMpdCommand status took 11 milliseconds Dec 20 12:49:10 smsl-n100 volumio[965]: info: sendMpdCommand status took 7 milliseconds Dec 20 12:49:10 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:10 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:10 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:10 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:10 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:10 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:10 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:10 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:10 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:10 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1010 Kbps","isStreaming":false,"title":"Ride The Bullet","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/04. Ride The Bullet.flac","trackType":"flac"} Dec 20 12:49:10 smsl-n100 volumio[965]: verbose: CURRENT POSITION 3 Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:10 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:10 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:10 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:10 smsl-n100 volumio[965]: info: ------------------------------ 102ms Dec 20 12:49:10 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 66 milliseconds Dec 20 12:49:10 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 66 milliseconds Dec 20 12:49:10 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 65 milliseconds Dec 20 12:49:10 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:10 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:10 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:10 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:10 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:10 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1073 Kbps","isStreaming":false,"title":"Ride The Bullet","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/04. Ride The Bullet.flac","trackType":"flac"} Dec 20 12:49:10 smsl-n100 volumio[965]: verbose: CURRENT POSITION 3 Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:10 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:10 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:10 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:10 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:10 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:10 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"941 Kbps","isStreaming":false,"title":"Ride The Bullet","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/04. Ride The Bullet.flac","trackType":"flac"} Dec 20 12:49:10 smsl-n100 volumio[965]: verbose: CURRENT POSITION 3 Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:10 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:10 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:10 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:10 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:10 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:10 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":208,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"941 Kbps","isStreaming":false,"title":"Ride The Bullet","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/04. Ride The Bullet.flac","trackType":"flac"} Dec 20 12:49:10 smsl-n100 volumio[965]: verbose: CURRENT POSITION 3 Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:10 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:10 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:10 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:10 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: ------------------------------ 210ms Dec 20 12:49:11 smsl-n100 volumio[965]: info: ------------------------------ 208ms Dec 20 12:49:11 smsl-n100 volumio[965]: info: ------------------------------ 204ms Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPrevious Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::previous Dec 20 12:49:11 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::stop Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::stPlaybackTimer Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::updateTrackBlock Dec 20 12:49:11 smsl-n100 volumio[965]: info: CorePlayQueue::getTrackBlock Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::serviceStop Dec 20 12:49:11 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreCommandRouter::serviceStop Dec 20 12:49:11 smsl-n100 volumio[965]: info: ControllerMpd::stop Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand stop Dec 20 12:49:11 smsl-n100 volumio[965]: info: Dec 20 12:49:11 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:11 smsl-n100 volumio[965]: info: sendMpdCommand stop took 18 milliseconds Dec 20 12:49:11 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:11 smsl-n100 volumio[965]: info: sendMpdCommand status took 2 milliseconds Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:11 smsl-n100 volumio[965]: info: Dec 20 12:49:11 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:11 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:11 smsl-n100 volumio[965]: info: Dec 20 12:49:11 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:11 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:11 smsl-n100 volumio[965]: info: Dec 20 12:49:11 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:11 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:11 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 18 milliseconds Dec 20 12:49:11 smsl-n100 volumio[965]: info: sendMpdCommand status took 15 milliseconds Dec 20 12:49:11 smsl-n100 volumio[965]: info: sendMpdCommand status took 11 milliseconds Dec 20 12:49:11 smsl-n100 volumio[965]: info: sendMpdCommand status took 9 milliseconds Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:11 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ride The Bullet","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/04. Ride The Bullet.flac","trackType":"flac"} Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: CURRENT POSITION 3 Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService stop Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus stop Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: No code Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: ------------------------------ 83ms Dec 20 12:49:11 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 55 milliseconds Dec 20 12:49:11 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 54 milliseconds Dec 20 12:49:11 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 54 milliseconds Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:11 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ride The Bullet","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/04. Ride The Bullet.flac","trackType":"flac"} Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: CURRENT POSITION 3 Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService stop Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus stop Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: No code Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ride The Bullet","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/04. Ride The Bullet.flac","trackType":"flac"} Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: CURRENT POSITION 3 Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService stop Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus stop Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: No code Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Ride The Bullet","artist":"Army Of Lovers","album":"Les Greatest Hits","uri":"USB/Aune_SD/ENG/Greatest Hits/Army Of Lovers/1996 - Greatest Hits/04. Ride The Bullet.flac","trackType":"flac"} Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: CURRENT POSITION 3 Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService stop Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus stop Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: No code Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: ------------------------------ 201ms Dec 20 12:49:11 smsl-n100 volumio[965]: info: ------------------------------ 200ms Dec 20 12:49:11 smsl-n100 volumio[965]: info: ------------------------------ 198ms Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:11 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 3 Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:11 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: 100, message: undefined Dec 20 12:49:11 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: MAXVOL, message: Dec 20 12:49:11 smsl-n100 volumio[965]: error: Serial API: Failed to decode command: 100, message: undefined Dec 20 12:49:11 smsl-n100 volumio[965]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::play index undefined Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 12:49:11 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2123 Dec 20 12:49:11 smsl-n100 volumio[965]: info: CoreStateMachine::startPlaybackTimer Dec 20 12:49:11 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2123 Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::clearAddPlayTracks USB/Aune_SD/ENG/Сollection/Sabaton/Studio Albums 2005 - 2023/2007 - Metalizer (Re-Armed Edition)/CD2/12. Birds Of War.flac Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand stop Dec 20 12:49:11 smsl-n100 volumio[965]: info: sendMpdCommand stop took 1 milliseconds Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand clear Dec 20 12:49:11 smsl-n100 volumio[965]: info: Dec 20 12:49:11 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:11 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:11 smsl-n100 volumio[965]: info: sendMpdCommand clear took 4 milliseconds Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand add "USB/Aune_SD/ENG/Сollection/Sabaton/Studio Albums 2005 - 2023/2007 - Metalizer (Re-Armed Edition)/CD2/12. Birds Of War.flac" Dec 20 12:49:11 smsl-n100 volumio[965]: info: Dec 20 12:49:11 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:11 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:11 smsl-n100 volumio[965]: info: Dec 20 12:49:11 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:11 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:11 smsl-n100 volumio[965]: info: Dec 20 12:49:11 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:11 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:11 smsl-n100 volumio[965]: error: updateQueue error: null Dec 20 12:49:11 smsl-n100 volumio[965]: info: Dec 20 12:49:11 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:11 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:11 smsl-n100 volumio[965]: info: ------------------------------ 18ms Dec 20 12:49:11 smsl-n100 volumio[965]: info: sendMpdCommand add "USB/Aune_SD/ENG/Сollection/Sabaton/Studio Albums 2005 - 2023/2007 - Metalizer (Re-Armed Edition)/CD2/12. Birds Of War.flac" took 15 milliseconds Dec 20 12:49:11 smsl-n100 volumio[965]: info: ------------------------------ 14ms Dec 20 12:49:11 smsl-n100 volumio[965]: info: ------------------------------ 12ms Dec 20 12:49:11 smsl-n100 volumio[965]: info: ------------------------------ 10ms Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand play Dec 20 12:49:11 smsl-n100 volumio[965]: info: Dec 20 12:49:11 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:11 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:11 smsl-n100 volumio[965]: info: Dec 20 12:49:11 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:11 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:11 smsl-n100 volumio[965]: info: Dec 20 12:49:11 smsl-n100 volumio[965]: ---------------------------- MPD announces system playlist update Dec 20 12:49:11 smsl-n100 volumio[965]: info: Ignoring MPD Status Update Dec 20 12:49:11 smsl-n100 volumio[965]: info: Dec 20 12:49:11 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:11 smsl-n100 volumio[965]: info: Dec 20 12:49:11 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:11 smsl-n100 volumio[965]: info: ------------------------------ 25ms Dec 20 12:49:11 smsl-n100 volumio[965]: info: sendMpdCommand play took 20 milliseconds Dec 20 12:49:11 smsl-n100 volumio[965]: info: ------------------------------ 19ms Dec 20 12:49:11 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:11 smsl-n100 volumio[965]: info: ------------------------------ 19ms Dec 20 12:49:11 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:11 smsl-n100 volumio[965]: info: ------------------------------ 18ms Dec 20 12:49:11 smsl-n100 volumio[965]: info: Dec 20 12:49:11 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:11 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:11 smsl-n100 volumio[965]: info: Dec 20 12:49:11 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:11 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:11 smsl-n100 volumio[965]: info: Dec 20 12:49:11 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:11 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:11 smsl-n100 volumio[965]: info: sendMpdCommand status took 25 milliseconds Dec 20 12:49:11 smsl-n100 volumio[965]: info: sendMpdCommand status took 25 milliseconds Dec 20 12:49:11 smsl-n100 volumio[965]: info: sendMpdCommand status took 23 milliseconds Dec 20 12:49:11 smsl-n100 volumio[965]: info: sendMpdCommand status took 20 milliseconds Dec 20 12:49:11 smsl-n100 volumio[965]: info: sendMpdCommand status took 17 milliseconds Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:11 smsl-n100 volumio[965]: info: Dec 20 12:49:11 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:11 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:11 smsl-n100 volumio[965]: info: Dec 20 12:49:11 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:11 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:11 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:11 smsl-n100 volumio[965]: info: Dec 20 12:49:11 smsl-n100 volumio[965]: ---------------------------- MPD announces state update: player Dec 20 12:49:12 smsl-n100 volumio[965]: info: ControllerMpd::getState Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand status Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPrevious Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::previous Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::updateTrackBlock Dec 20 12:49:12 smsl-n100 volumio[965]: info: CorePlayQueue::getTrackBlock Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::serviceClearAddPlay Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreCommandRouter::serviceClearAddPlayTracks Dec 20 12:49:12 smsl-n100 volumio[965]: error: WARNING: No clearAddPlayTracks method for service mpd Dec 20 12:49:12 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 55 milliseconds Dec 20 12:49:12 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 54 milliseconds Dec 20 12:49:12 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 51 milliseconds Dec 20 12:49:12 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 51 milliseconds Dec 20 12:49:12 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 50 milliseconds Dec 20 12:49:12 smsl-n100 volumio[965]: info: sendMpdCommand status took 38 milliseconds Dec 20 12:49:12 smsl-n100 volumio[965]: info: sendMpdCommand status took 35 milliseconds Dec 20 12:49:12 smsl-n100 volumio[965]: info: sendMpdCommand status took 31 milliseconds Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: ControllerMpd::parseState Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 12:49:12 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":293,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Birds Of War","artist":"Sabaton","album":"Metalizer (Re-Armed Edition) (CD2)","uri":"USB/Aune_SD/ENG/Сollection/Sabaton/Studio Albums 2005 - 2023/2007 - Metalizer (Re-Armed Edition)/CD2/12. Birds Of War.flac","trackType":"flac"} Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: CURRENT POSITION 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus stop Dec 20 12:49:12 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":293,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Birds Of War","artist":"Sabaton","album":"Metalizer (Re-Armed Edition) (CD2)","uri":"USB/Aune_SD/ENG/Сollection/Sabaton/Studio Albums 2005 - 2023/2007 - Metalizer (Re-Armed Edition)/CD2/12. Birds Of War.flac","trackType":"flac"} Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: CURRENT POSITION 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:12 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":293,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Birds Of War","artist":"Sabaton","album":"Metalizer (Re-Armed Edition) (CD2)","uri":"USB/Aune_SD/ENG/Сollection/Sabaton/Studio Albums 2005 - 2023/2007 - Metalizer (Re-Armed Edition)/CD2/12. Birds Of War.flac","trackType":"flac"} Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: CURRENT POSITION 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:12 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":293,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Birds Of War","artist":"Sabaton","album":"Metalizer (Re-Armed Edition) (CD2)","uri":"USB/Aune_SD/ENG/Сollection/Sabaton/Studio Albums 2005 - 2023/2007 - Metalizer (Re-Armed Edition)/CD2/12. Birds Of War.flac","trackType":"flac"} Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: CURRENT POSITION 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:12 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":293,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Birds Of War","artist":"Sabaton","album":"Metalizer (Re-Armed Edition) (CD2)","uri":"USB/Aune_SD/ENG/Сollection/Sabaton/Studio Albums 2005 - 2023/2007 - Metalizer (Re-Armed Edition)/CD2/12. Birds Of War.flac","trackType":"flac"} Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: CURRENT POSITION 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:12 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: ------------------------------ 241ms Dec 20 12:49:12 smsl-n100 volumio[965]: info: ------------------------------ 291ms Dec 20 12:49:12 smsl-n100 volumio[965]: info: ------------------------------ 280ms Dec 20 12:49:12 smsl-n100 volumio[965]: info: ------------------------------ 277ms Dec 20 12:49:12 smsl-n100 volumio[965]: info: ------------------------------ 274ms Dec 20 12:49:12 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 175 milliseconds Dec 20 12:49:12 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 174 milliseconds Dec 20 12:49:12 smsl-n100 volumio[965]: info: sendMpdCommand playlistinfo took 173 milliseconds Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: ControllerMpd::parseTrackInfo Dec 20 12:49:12 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":293,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"744 Kbps","isStreaming":false,"title":"Birds Of War","artist":"Sabaton","album":"Metalizer (Re-Armed Edition) (CD2)","uri":"USB/Aune_SD/ENG/Сollection/Sabaton/Studio Albums 2005 - 2023/2007 - Metalizer (Re-Armed Edition)/CD2/12. Birds Of War.flac","trackType":"flac"} Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: CURRENT POSITION 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:12 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":293,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"744 Kbps","isStreaming":false,"title":"Birds Of War","artist":"Sabaton","album":"Metalizer (Re-Armed Edition) (CD2)","uri":"USB/Aune_SD/ENG/Сollection/Sabaton/Studio Albums 2005 - 2023/2007 - Metalizer (Re-Armed Edition)/CD2/12. Birds Of War.flac","trackType":"flac"} Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: CURRENT POSITION 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:12 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: ControllerMpd::pushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreCommandRouter::servicePushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":293,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"744 Kbps","isStreaming":false,"title":"Birds Of War","artist":"Sabaton","album":"Metalizer (Re-Armed Edition) (CD2)","uri":"USB/Aune_SD/ENG/Сollection/Sabaton/Studio Albums 2005 - 2023/2007 - Metalizer (Re-Armed Edition)/CD2/12. Birds Of War.flac","trackType":"flac"} Dec 20 12:49:12 smsl-n100 volumio[965]: verbose: CURRENT POSITION 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::syncState stateService play Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::syncState currentStatus play Dec 20 12:49:12 smsl-n100 volumio[965]: info: Received an update from plugin. extracting info from payload Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreStateMachine::pushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2509 Dec 20 12:49:12 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPushState Dec 20 12:49:12 smsl-n100 volumio[965]: info: ------------------------------ 309ms Dec 20 12:49:12 smsl-n100 volumio[965]: info: ------------------------------ 305ms Dec 20 12:49:12 smsl-n100 volumio[965]: info: ------------------------------ 301ms Dec 20 12:49:13 smsl-n100 volumio[965]: info: CoreCommandRouter::volumioPrevious Dec 20 12:49:13 smsl-n100 volumio[965]: info: CoreStateMachine::previous Dec 20 12:49:13 smsl-n100 volumio[965]: info: CorePlayQueue::getTrack 2509 Dec 20 12:49:13 smsl-n100 volumio[965]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 20 12:49:13 smsl-n100 volumio[965]: TypeError: Cannot read property 'service' of undefined Dec 20 12:49:13 smsl-n100 volumio[965]: at CoreStateMachine.previous (/volumio/app/statemachine.js:1329:97) Dec 20 12:49:13 smsl-n100 volumio[965]: at CoreCommandRouter.volumioPrevious (/volumio/app/index.js:97:28) Dec 20 12:49:13 smsl-n100 volumio[965]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:270:33) Dec 20 12:49:13 smsl-n100 volumio[965]: at Socket.emit (events.js:400:28) Dec 20 12:49:13 smsl-n100 volumio[965]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Dec 20 12:49:13 smsl-n100 volumio[965]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Dec 20 12:49:13 smsl-n100 volumio[965]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 20 12:49:15 smsl-n100 sudo[28793]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-20 12:48 Dec 20 12:49:15 smsl-n100 sudo[28793]: 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"