-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Tue 2026-06-02 10:59:43 CST. --
Jun 02 10:58:00 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 3
Jun 02 10:58:00 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:58:00 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:58:00 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:58:03 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:58:03 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 30.
Jun 02 10:58:03 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:58:03 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:58:03 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:58:03 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:58:03 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 3
Jun 02 10:58:03 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:58:03 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:58:03 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:58:06 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:58:06 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 31.
Jun 02 10:58:06 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:58:06 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:58:06 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:58:06 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:58:06 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 3
Jun 02 10:58:06 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:58:06 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:58:06 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:58:08 smsl-n100 volumio[3769]: info: MyVolumio login type: Token
Jun 02 10:58:09 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:58:09 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 32.
Jun 02 10:58:09 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:58:09 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:58:09 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:58:09 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:58:09 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 3
Jun 02 10:58:09 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:58:09 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:58:09 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:58:12 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:58:12 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 33.
Jun 02 10:58:12 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:58:12 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:58:12 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:58:12 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:58:13 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 3
Jun 02 10:58:13 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:58:13 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:58:13 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: CURURI: albums://Delibes/L%C3%A9o%20Delibes%20-%20Coppelia%20Hts
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Preload queue cleared
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Léo Delibes - Coppelia/01. Prelude.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Léo Delibes - Coppelia/02. Act 1 - Valse.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Léo Delibes - Coppelia/03. Act 1 - Mazurka.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Léo Delibes - Coppelia/04. Act 1 - Scene.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Léo Delibes - Coppelia/05. Act 1 - Ballade.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Léo Delibes - Coppelia/06. Act 1 - Theme Slave Varie.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Léo Delibes - Coppelia/07. Act 1 - Czardas.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Léo Delibes - Coppelia/08. Act 2 - Musique Des Automates.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Léo Delibes - Coppelia/09. Act 2 - Chanson A Boire.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Léo Delibes - Coppelia/10. Act 2 - Valse De La Poupee.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Léo Delibes - Coppelia/11. Act 2 - Bolero.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Léo Delibes - Coppelia/12. Act 2 - Gigue.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Léo Delibes - Coppelia/13. Act 3 - Fete De La Cloche.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Léo Delibes - Coppelia/14. Act 3 - Valse Des Heures.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Léo Delibes - Coppelia/15. Act 3 - L'Aurore.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Léo Delibes - Coppelia/16. Act 3 - La Priere.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Léo Delibes - Coppelia/17. Act 3 - Le Travail (La Fileuse).flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Léo Delibes - Coppelia/18. Act 3 - L'Hymen (Noce Villageois).flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Léo Delibes - Coppelia/19. Act 3 - La Discorde Et La Guerre (Marche Des Guerriers).flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Léo Delibes - Coppelia/20. Act 3 - La Paix.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Léo Delibes - Coppelia/21. Act 3 - Danse De Fete.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Léo Delibes - Coppelia/22. Act 3 - Galop Final.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Léo Delibes - Coppelia/01. Prelude.flac in service mpd
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=Delibes/L%C3%A9o%20Delibes%20-%20Coppelia%20Hts/extralarge&path=%2Fmnt%2FNAS%2FCD%2FL%C3%A9o%20Delibes%20-%20Coppelia%2F01.%20Prelude.flac&metadata=false
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Léo Delibes - Coppelia/01. Prelude.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Executing endpoint getSimilarAlbums
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Léo Delibes - Coppelia/02. Act 1 - Valse.flac in service mpd
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=Delibes/L%C3%A9o%20Delibes%20-%20Coppelia%20Hts/extralarge&path=%2Fmnt%2FNAS%2FCD%2FL%C3%A9o%20Delibes%20-%20Coppelia%2F02.%20Act%201%20-%20Valse.flac&metadata=false
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Léo Delibes - Coppelia/02. Act 1 - Valse.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Léo Delibes - Coppelia/03. Act 1 - Mazurka.flac in service mpd
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=Delibes/L%C3%A9o%20Delibes%20-%20Coppelia%20Hts/extralarge&path=%2Fmnt%2FNAS%2FCD%2FL%C3%A9o%20Delibes%20-%20Coppelia%2F03.%20Act%201%20-%20Mazurka.flac&metadata=false
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Léo Delibes - Coppelia/03. Act 1 - Mazurka.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Executing endpoint metavolumio
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Executing endpoint metavolumio
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Léo Delibes - Coppelia/04. Act 1 - Scene.flac in service mpd
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=Delibes/L%C3%A9o%20Delibes%20-%20Coppelia%20Hts/extralarge&path=%2Fmnt%2FNAS%2FCD%2FL%C3%A9o%20Delibes%20-%20Coppelia%2F04.%20Act%201%20-%20Scene.flac&metadata=false
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Léo Delibes - Coppelia/04. Act 1 - Scene.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Léo Delibes - Coppelia/05. Act 1 - Ballade.flac in service mpd
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=Delibes/L%C3%A9o%20Delibes%20-%20Coppelia%20Hts/extralarge&path=%2Fmnt%2FNAS%2FCD%2FL%C3%A9o%20Delibes%20-%20Coppelia%2F05.%20Act%201%20-%20Ballade.flac&metadata=false
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Léo Delibes - Coppelia/05. Act 1 - Ballade.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Léo Delibes - Coppelia/06. Act 1 - Theme Slave Varie.flac in service mpd
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=Delibes/L%C3%A9o%20Delibes%20-%20Coppelia%20Hts/extralarge&path=%2Fmnt%2FNAS%2FCD%2FL%C3%A9o%20Delibes%20-%20Coppelia%2F06.%20Act%201%20-%20Theme%20Slave%20Varie.flac&metadata=false
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Léo Delibes - Coppelia/06. Act 1 - Theme Slave Varie.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Léo Delibes - Coppelia/07. Act 1 - Czardas.flac in service mpd
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=Delibes/L%C3%A9o%20Delibes%20-%20Coppelia%20Hts/extralarge&path=%2Fmnt%2FNAS%2FCD%2FL%C3%A9o%20Delibes%20-%20Coppelia%2F07.%20Act%201%20-%20Czardas.flac&metadata=false
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Léo Delibes - Coppelia/07. Act 1 - Czardas.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Léo Delibes - Coppelia/08. Act 2 - Musique Des Automates.flac in service mpd
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=Delibes/L%C3%A9o%20Delibes%20-%20Coppelia%20Hts/extralarge&path=%2Fmnt%2FNAS%2FCD%2FL%C3%A9o%20Delibes%20-%20Coppelia%2F08.%20Act%202%20-%20Musique%20Des%20Automates.flac&metadata=false
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Léo Delibes - Coppelia/08. Act 2 - Musique Des Automates.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Léo Delibes - Coppelia/09. Act 2 - Chanson A Boire.flac in service mpd
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=Delibes/L%C3%A9o%20Delibes%20-%20Coppelia%20Hts/extralarge&path=%2Fmnt%2FNAS%2FCD%2FL%C3%A9o%20Delibes%20-%20Coppelia%2F09.%20Act%202%20-%20Chanson%20A%20Boire.flac&metadata=false
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Léo Delibes - Coppelia/09. Act 2 - Chanson A Boire.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Léo Delibes - Coppelia/10. Act 2 - Valse De La Poupee.flac in service mpd
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=Delibes/L%C3%A9o%20Delibes%20-%20Coppelia%20Hts/extralarge&path=%2Fmnt%2FNAS%2FCD%2FL%C3%A9o%20Delibes%20-%20Coppelia%2F10.%20Act%202%20-%20Valse%20De%20La%20Poupee.flac&metadata=false
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Léo Delibes - Coppelia/10. Act 2 - Valse De La Poupee.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Léo Delibes - Coppelia/11. Act 2 - Bolero.flac in service mpd
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=Delibes/L%C3%A9o%20Delibes%20-%20Coppelia%20Hts/extralarge&path=%2Fmnt%2FNAS%2FCD%2FL%C3%A9o%20Delibes%20-%20Coppelia%2F11.%20Act%202%20-%20Bolero.flac&metadata=false
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Léo Delibes - Coppelia/11. Act 2 - Bolero.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Léo Delibes - Coppelia/12. Act 2 - Gigue.flac in service mpd
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=Delibes/L%C3%A9o%20Delibes%20-%20Coppelia%20Hts/extralarge&path=%2Fmnt%2FNAS%2FCD%2FL%C3%A9o%20Delibes%20-%20Coppelia%2F12.%20Act%202%20-%20Gigue.flac&metadata=false
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Léo Delibes - Coppelia/12. Act 2 - Gigue.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Léo Delibes - Coppelia/13. Act 3 - Fete De La Cloche.flac in service mpd
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=Delibes/L%C3%A9o%20Delibes%20-%20Coppelia%20Hts/extralarge&path=%2Fmnt%2FNAS%2FCD%2FL%C3%A9o%20Delibes%20-%20Coppelia%2F13.%20Act%203%20-%20Fete%20De%20La%20Cloche.flac&metadata=false
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Léo Delibes - Coppelia/13. Act 3 - Fete De La Cloche.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Léo Delibes - Coppelia/14. Act 3 - Valse Des Heures.flac in service mpd
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=Delibes/L%C3%A9o%20Delibes%20-%20Coppelia%20Hts/extralarge&path=%2Fmnt%2FNAS%2FCD%2FL%C3%A9o%20Delibes%20-%20Coppelia%2F14.%20Act%203%20-%20Valse%20Des%20Heures.flac&metadata=false
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Léo Delibes - Coppelia/14. Act 3 - Valse Des Heures.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Léo Delibes - Coppelia/15. Act 3 - L'Aurore.flac in service mpd
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=Delibes/L%C3%A9o%20Delibes%20-%20Coppelia%20Hts/extralarge&path=%2Fmnt%2FNAS%2FCD%2FL%C3%A9o%20Delibes%20-%20Coppelia%2F15.%20Act%203%20-%20L'Aurore.flac&metadata=false
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Léo Delibes - Coppelia/15. Act 3 - L'Aurore.flac
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Léo Delibes - Coppelia/16. Act 3 - La Priere.flac in service mpd
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=Delibes/L%C3%A9o%20Delibes%20-%20Coppelia%20Hts/extralarge&path=%2Fmnt%2FNAS%2FCD%2FL%C3%A9o%20Delibes%20-%20Coppelia%2F16.%20Act%203%20-%20La%20Priere.flac&metadata=false
Jun 02 10:58:15 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Léo Delibes - Coppelia/16. Act 3 - La Priere.flac
Jun 02 10:58:16 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Léo Delibes - Coppelia/17. Act 3 - Le Travail (La Fileuse).flac in service mpd
Jun 02 10:58:16 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=Delibes/L%C3%A9o%20Delibes%20-%20Coppelia%20Hts/extralarge&path=%2Fmnt%2FNAS%2FCD%2FL%C3%A9o%20Delibes%20-%20Coppelia%2F17.%20Act%203%20-%20Le%20Travail%20(La%20Fileuse).flac&metadata=false
Jun 02 10:58:16 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Léo Delibes - Coppelia/17. Act 3 - Le Travail (La Fileuse).flac
Jun 02 10:58:16 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Léo Delibes - Coppelia/18. Act 3 - L'Hymen (Noce Villageois).flac in service mpd
Jun 02 10:58:16 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=Delibes/L%C3%A9o%20Delibes%20-%20Coppelia%20Hts/extralarge&path=%2Fmnt%2FNAS%2FCD%2FL%C3%A9o%20Delibes%20-%20Coppelia%2F18.%20Act%203%20-%20L'Hymen%20(Noce%20Villageois).flac&metadata=false
Jun 02 10:58:16 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Léo Delibes - Coppelia/18. Act 3 - L'Hymen (Noce Villageois).flac
Jun 02 10:58:16 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:58:16 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 34.
Jun 02 10:58:16 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:58:16 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:58:16 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Léo Delibes - Coppelia/19. Act 3 - La Discorde Et La Guerre (Marche Des Guerriers).flac in service mpd
Jun 02 10:58:16 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=Delibes/L%C3%A9o%20Delibes%20-%20Coppelia%20Hts/extralarge&path=%2Fmnt%2FNAS%2FCD%2FL%C3%A9o%20Delibes%20-%20Coppelia%2F19.%20Act%203%20-%20La%20Discorde%20Et%20La%20Guerre%20(Marche%20Des%20Guerriers).flac&metadata=false
Jun 02 10:58:16 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Léo Delibes - Coppelia/19. Act 3 - La Discorde Et La Guerre (Marche Des Guerriers).flac
Jun 02 10:58:16 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Léo Delibes - Coppelia/20. Act 3 - La Paix.flac in service mpd
Jun 02 10:58:16 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=Delibes/L%C3%A9o%20Delibes%20-%20Coppelia%20Hts/extralarge&path=%2Fmnt%2FNAS%2FCD%2FL%C3%A9o%20Delibes%20-%20Coppelia%2F20.%20Act%203%20-%20La%20Paix.flac&metadata=false
Jun 02 10:58:16 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Léo Delibes - Coppelia/20. Act 3 - La Paix.flac
Jun 02 10:58:16 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Léo Delibes - Coppelia/21. Act 3 - Danse De Fete.flac in service mpd
Jun 02 10:58:16 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=Delibes/L%C3%A9o%20Delibes%20-%20Coppelia%20Hts/extralarge&path=%2Fmnt%2FNAS%2FCD%2FL%C3%A9o%20Delibes%20-%20Coppelia%2F21.%20Act%203%20-%20Danse%20De%20Fete.flac&metadata=false
Jun 02 10:58:16 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Léo Delibes - Coppelia/21. Act 3 - Danse De Fete.flac
Jun 02 10:58:16 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:58:16 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:58:16 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Léo Delibes - Coppelia/22. Act 3 - Galop Final.flac in service mpd
Jun 02 10:58:16 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 3
Jun 02 10:58:16 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=Delibes/L%C3%A9o%20Delibes%20-%20Coppelia%20Hts/extralarge&path=%2Fmnt%2FNAS%2FCD%2FL%C3%A9o%20Delibes%20-%20Coppelia%2F22.%20Act%203%20-%20Galop%20Final.flac&metadata=false
Jun 02 10:58:16 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Léo Delibes - Coppelia/22. Act 3 - Galop Final.flac
Jun 02 10:58:16 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:58:16 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:58:16 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:58:19 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:58:19 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 35.
Jun 02 10:58:19 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:58:19 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:58:19 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:58:19 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:58:19 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 3
Jun 02 10:58:19 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:58:19 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:58:19 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:58:21 smsl-n100 volumio[3769]: info: Listing playlists
Jun 02 10:58:22 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:58:22 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 36.
Jun 02 10:58:22 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:58:22 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:58:22 smsl-n100 volumio[3769]: info: Saving local item Chi
Jun 02 10:58:22 smsl-n100 volumio[3769]: info: Pushing Favourites {"uri":"/mnt/NAS/CD/Léo Delibes - Coppelia/02. Act 1 - Valse.flac","favourite":false}
Jun 02 10:58:22 smsl-n100 volumio[3769]: info: Listing playlists
Jun 02 10:58:22 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:58:22 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:58:22 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 3
Jun 02 10:58:22 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:58:22 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:58:22 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:58:23 smsl-n100 volumio[3769]: error: Failed request for metavolumio API
Jun 02 10:58:25 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:58:25 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 37.
Jun 02 10:58:25 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:58:25 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:58:25 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:58:25 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:58:26 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 3
Jun 02 10:58:26 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:58:26 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:58:26 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:58:29 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:58:29 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 38.
Jun 02 10:58:29 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:58:29 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:58:29 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:58:29 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:58:29 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 3
Jun 02 10:58:29 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:58:29 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:58:29 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:58:32 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:58:32 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 39.
Jun 02 10:58:32 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:58:32 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:58:32 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:58:32 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:58:32 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 3
Jun 02 10:58:32 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:58:32 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:58:32 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:58:35 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:58:35 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 40.
Jun 02 10:58:35 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:58:35 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:58:35 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:58:35 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:58:35 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 3
Jun 02 10:58:35 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:58:35 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:58:35 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:58:36 smsl-n100 volumio[3769]: info: Preload queue cleared
Jun 02 10:58:36 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jun 02 10:58:36 smsl-n100 volumio[3769]: info: CoreStateMachine::ClearQueue
Jun 02 10:58:36 smsl-n100 volumio[3769]: info: CoreStateMachine::stop
Jun 02 10:58:36 smsl-n100 volumio[3769]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 02 10:58:36 smsl-n100 volumio[3769]: info: CoreStateMachine::stPlaybackTimer
Jun 02 10:58:36 smsl-n100 volumio[3769]: info: CoreStateMachine::updateTrackBlock
Jun 02 10:58:36 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrackBlock
Jun 02 10:58:36 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:36 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 3
Jun 02 10:58:36 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 02 10:58:36 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:36 smsl-n100 volumio[3769]: info: CoreStateMachine::serviceStop
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 3
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::serviceStop
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ControllerMpd::stop
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand stop
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::clearPlayQueue
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::saveQueue
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushQueue
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::addQueueItems
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::addQueueItems
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Preload queue cleared
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/01. Prelude.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/01. Prelude.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/02. Act 1 - Valse.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/02. Act 1 - Valse.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/03. Act 1 - Mazurka.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/03. Act 1 - Mazurka.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/04. Act 1 - Scene.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/04. Act 1 - Scene.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/05. Act 1 - Ballade.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/05. Act 1 - Ballade.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/06. Act 1 - Theme Slave Varie.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/06. Act 1 - Theme Slave Varie.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/07. Act 1 - Czardas.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/07. Act 1 - Czardas.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushQueue
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::saveQueue
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::updateTrackBlock
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrackBlock
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPlay
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::play index 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::addQueueItems
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::addQueueItems
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Preload queue cleared
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/08. Act 2 - Musique Des Automates.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/08. Act 2 - Musique Des Automates.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/09. Act 2 - Chanson A Boire.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/09. Act 2 - Chanson A Boire.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/10. Act 2 - Valse De La Poupee.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/10. Act 2 - Valse De La Poupee.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/11. Act 2 - Bolero.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/11. Act 2 - Bolero.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/12. Act 2 - Gigue.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/12. Act 2 - Gigue.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/13. Act 3 - Fete De La Cloche.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/13. Act 3 - Fete De La Cloche.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/14. Act 3 - Valse Des Heures.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/14. Act 3 - Valse Des Heures.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/15. Act 3 - L'Aurore.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/15. Act 3 - L'Aurore.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/16. Act 3 - La Priere.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/16. Act 3 - La Priere.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/17. Act 3 - Le Travail (La Fileuse).flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/17. Act 3 - Le Travail (La Fileuse).flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/18. Act 3 - L'Hymen (Noce Villageois).flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/18. Act 3 - L'Hymen (Noce Villageois).flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/19. Act 3 - La Discorde Et La Guerre (Marche Des Guerriers).flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/19. Act 3 - La Discorde Et La Guerre (Marche Des Guerriers).flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/20. Act 3 - La Paix.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/20. Act 3 - La Paix.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/21. Act 3 - Danse De Fete.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/21. Act 3 - Danse De Fete.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/22. Act 3 - Galop Final.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/22. Act 3 - Galop Final.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::stop
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushQueue
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::saveQueue
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::play index undefined
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::updateTrackBlock
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrackBlock
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::startPlaybackTimer
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::clearAddPlayTracks NAS/CD/Léo Delibes - Coppelia/07. Act 1 - Czardas.flac
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand stop
Jun 02 10:58:37 smsl-n100 volumio[3769]: info:
Jun 02 10:58:37 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: sendMpdCommand stop took 134 milliseconds
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: sendMpdCommand stop took 28 milliseconds
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand clear
Jun 02 10:58:37 smsl-n100 volumio[3769]: info:
Jun 02 10:58:37 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:58:37 smsl-n100 volumio[3769]: info:
Jun 02 10:58:37 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:58:37 smsl-n100 volumio[3769]: info:
Jun 02 10:58:37 smsl-n100 volumio[3769]: ---------------------------- MPD announces system playlist update
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Ignoring MPD Status Update
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: sendMpdCommand status took 31 milliseconds
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: sendMpdCommand clear took 29 milliseconds
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: sendMpdCommand status took 25 milliseconds
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: sendMpdCommand status took 23 milliseconds
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand add "NAS/CD/Léo Delibes - Coppelia/07. Act 1 - Czardas.flac"
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService stop
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus stop
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: No code
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService stop
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus stop
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: No code
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ------------------------------ 127ms
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ------------------------------ 125ms
Jun 02 10:58:37 smsl-n100 volumio[3769]: info:
Jun 02 10:58:37 smsl-n100 volumio[3769]: ---------------------------- MPD announces system playlist update
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Ignoring MPD Status Update
Jun 02 10:58:37 smsl-n100 volumio[3769]: info:
Jun 02 10:58:37 smsl-n100 volumio[3769]: ---------------------------- MPD announces system playlist update
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Ignoring MPD Status Update
Jun 02 10:58:37 smsl-n100 volumio[3769]: error: updateQueue error: null
Jun 02 10:58:37 smsl-n100 volumio[3769]: info:
Jun 02 10:58:37 smsl-n100 volumio[3769]: ---------------------------- MPD announces system playlist update
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Ignoring MPD Status Update
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ------------------------------ 122ms
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 114 milliseconds
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: sendMpdCommand add "NAS/CD/Léo Delibes - Coppelia/07. Act 1 - Czardas.flac" took 114 milliseconds
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ------------------------------ 16ms
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ------------------------------ 13ms
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand play
Jun 02 10:58:37 smsl-n100 volumio[3769]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ------------------------------ 163ms
Jun 02 10:58:37 smsl-n100 volumio[3769]: info:
Jun 02 10:58:37 smsl-n100 volumio[3769]: ---------------------------- MPD announces system playlist update
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Ignoring MPD Status Update
Jun 02 10:58:37 smsl-n100 volumio[3769]: info:
Jun 02 10:58:37 smsl-n100 volumio[3769]: ---------------------------- MPD announces system playlist update
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Ignoring MPD Status Update
Jun 02 10:58:37 smsl-n100 volumio[3769]: info:
Jun 02 10:58:37 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:58:37 smsl-n100 volumio[3769]: info:
Jun 02 10:58:37 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ------------------------------ 120ms
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: sendMpdCommand play took 110 milliseconds
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ------------------------------ 108ms
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ------------------------------ 108ms
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:58:37 smsl-n100 volumio[3769]: info:
Jun 02 10:58:37 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:58:37 smsl-n100 volumio[3769]: info:
Jun 02 10:58:37 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: error: Serial API: Failed to decode command: 100, message: undefined
Jun 02 10:58:37 smsl-n100 volumio[3769]: error: Serial API: Failed to decode command: MAXVOL, message:
Jun 02 10:58:37 smsl-n100 volumio[3769]: error: Serial API: Failed to decode command: 100, message: undefined
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: sendMpdCommand status took 69 milliseconds
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: sendMpdCommand status took 67 milliseconds
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: sendMpdCommand status took 60 milliseconds
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: sendMpdCommand status took 54 milliseconds
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:58:37 smsl-n100 volumio[3769]: info:
Jun 02 10:58:37 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:58:37 smsl-n100 volumio[3769]: info:
Jun 02 10:58:37 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 53 milliseconds
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 51 milliseconds
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 56 milliseconds
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 55 milliseconds
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: sendMpdCommand status took 45 milliseconds
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: sendMpdCommand status took 39 milliseconds
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"626 Kbps","isStreaming":false,"title":"Coppelia: Act 1 : Czardas","artist":"Delibes","album":"Léo Delibes - Coppelia Hts","uri":"NAS/CD/Léo Delibes - Coppelia/07. Act 1 - Czardas.flac","trackType":"flac"}
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService play
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus stop
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"626 Kbps","isStreaming":false,"title":"Coppelia: Act 1 : Czardas","artist":"Delibes","album":"Léo Delibes - Coppelia Hts","uri":"NAS/CD/Léo Delibes - Coppelia/07. Act 1 - Czardas.flac","trackType":"flac"}
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService play
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus play
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Received an update from plugin. extracting info from payload
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"626 Kbps","isStreaming":false,"title":"Coppelia: Act 1 : Czardas","artist":"Delibes","album":"Léo Delibes - Coppelia Hts","uri":"NAS/CD/Léo Delibes - Coppelia/07. Act 1 - Czardas.flac","trackType":"flac"}
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService play
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus play
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Received an update from plugin. extracting info from payload
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"534 Kbps","isStreaming":false,"title":"Coppelia: Act 1 : Czardas","artist":"Delibes","album":"Léo Delibes - Coppelia Hts","uri":"NAS/CD/Léo Delibes - Coppelia/07. Act 1 - Czardas.flac","trackType":"flac"}
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService play
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus play
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Received an update from plugin. extracting info from payload
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ------------------------------ 317ms
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ------------------------------ 399ms
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ------------------------------ 384ms
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ------------------------------ 380ms
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 241 milliseconds
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 241 milliseconds
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"534 Kbps","isStreaming":false,"title":"Coppelia: Act 1 : Czardas","artist":"Delibes","album":"Léo Delibes - Coppelia Hts","uri":"NAS/CD/Léo Delibes - Coppelia/07. Act 1 - Czardas.flac","trackType":"flac"}
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService play
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus play
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Received an update from plugin. extracting info from payload
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":204,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"534 Kbps","isStreaming":false,"title":"Coppelia: Act 1 : Czardas","artist":"Delibes","album":"Léo Delibes - Coppelia Hts","uri":"NAS/CD/Léo Delibes - Coppelia/07. Act 1 - Czardas.flac","trackType":"flac"}
Jun 02 10:58:37 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService play
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus play
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: Received an update from plugin. extracting info from payload
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ------------------------------ 439ms
Jun 02 10:58:37 smsl-n100 volumio[3769]: info: ------------------------------ 435ms
Jun 02 10:58:38 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:38 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:38 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 02 10:58:38 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:38 smsl-n100 volumio[3769]: error: Serial API: Failed to decode command: 100, message: undefined
Jun 02 10:58:38 smsl-n100 volumio[3769]: error: Serial API: Failed to decode command: MAXVOL, message:
Jun 02 10:58:38 smsl-n100 volumio[3769]: error: Serial API: Failed to decode command: 100, message: undefined
Jun 02 10:58:38 smsl-n100 volumio[3769]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff
Jun 02 10:58:38 smsl-n100 volumio[3769]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Jun 02 10:58:38 smsl-n100 volumio[3769]: info: Retrying Login Due to Network Error
Jun 02 10:58:38 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:58:38 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 41.
Jun 02 10:58:38 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:58:38 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:58:38 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:58:38 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:39 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:58:39 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:58:39 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Preload queue cleared
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CoreStateMachine::ClearQueue
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CoreStateMachine::stop
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CoreStateMachine::stPlaybackTimer
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CoreStateMachine::updateTrackBlock
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrackBlock
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CoreStateMachine::serviceStop
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 6
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CoreCommandRouter::serviceStop
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: ControllerMpd::stop
Jun 02 10:58:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand stop
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CorePlayQueue::clearPlayQueue
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CorePlayQueue::saveQueue
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushQueue
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CoreStateMachine::addQueueItems
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CorePlayQueue::addQueueItems
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Preload queue cleared
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/01. Prelude.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/01. Prelude.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/02. Act 1 - Valse.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/02. Act 1 - Valse.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/03. Act 1 - Mazurka.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/03. Act 1 - Mazurka.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/04. Act 1 - Scene.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/04. Act 1 - Scene.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/05. Act 1 - Ballade.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/05. Act 1 - Ballade.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/06. Act 1 - Theme Slave Varie.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/06. Act 1 - Theme Slave Varie.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushQueue
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CorePlayQueue::saveQueue
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CoreStateMachine::updateTrackBlock
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrackBlock
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPlay
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CoreStateMachine::play index 5
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CoreStateMachine::addQueueItems
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CorePlayQueue::addQueueItems
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Preload queue cleared
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/07. Act 1 - Czardas.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/07. Act 1 - Czardas.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/08. Act 2 - Musique Des Automates.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/08. Act 2 - Musique Des Automates.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/09. Act 2 - Chanson A Boire.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/09. Act 2 - Chanson A Boire.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/10. Act 2 - Valse De La Poupee.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/10. Act 2 - Valse De La Poupee.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/11. Act 2 - Bolero.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/11. Act 2 - Bolero.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/12. Act 2 - Gigue.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/12. Act 2 - Gigue.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/13. Act 3 - Fete De La Cloche.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/13. Act 3 - Fete De La Cloche.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/14. Act 3 - Valse Des Heures.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/14. Act 3 - Valse Des Heures.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/15. Act 3 - L'Aurore.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/15. Act 3 - L'Aurore.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/16. Act 3 - La Priere.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/16. Act 3 - La Priere.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/17. Act 3 - Le Travail (La Fileuse).flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/17. Act 3 - Le Travail (La Fileuse).flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/18. Act 3 - L'Hymen (Noce Villageois).flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/18. Act 3 - L'Hymen (Noce Villageois).flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/19. Act 3 - La Discorde Et La Guerre (Marche Des Guerriers).flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/19. Act 3 - La Discorde Et La Guerre (Marche Des Guerriers).flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/20. Act 3 - La Paix.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/20. Act 3 - La Paix.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/21. Act 3 - Danse De Fete.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/21. Act 3 - Danse De Fete.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/22. Act 3 - Galop Final.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/22. Act 3 - Galop Final.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CoreStateMachine::stop
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushQueue
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CorePlayQueue::saveQueue
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CoreStateMachine::play index undefined
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CoreStateMachine::updateTrackBlock
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrackBlock
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CoreStateMachine::startPlaybackTimer
Jun 02 10:58:39 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::clearAddPlayTracks NAS/CD/Léo Delibes - Coppelia/06. Act 1 - Theme Slave Varie.flac
Jun 02 10:58:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand stop
Jun 02 10:58:40 smsl-n100 volumio[3769]: info:
Jun 02 10:58:40 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: sendMpdCommand stop took 128 milliseconds
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: sendMpdCommand stop took 33 milliseconds
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand clear
Jun 02 10:58:40 smsl-n100 volumio[3769]: info:
Jun 02 10:58:40 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:58:40 smsl-n100 volumio[3769]: info:
Jun 02 10:58:40 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:58:40 smsl-n100 volumio[3769]: info:
Jun 02 10:58:40 smsl-n100 volumio[3769]: ---------------------------- MPD announces system playlist update
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: Ignoring MPD Status Update
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: sendMpdCommand status took 24 milliseconds
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: sendMpdCommand clear took 22 milliseconds
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: sendMpdCommand status took 19 milliseconds
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: sendMpdCommand status took 16 milliseconds
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand add "NAS/CD/Léo Delibes - Coppelia/06. Act 1 - Theme Slave Varie.flac"
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService stop
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus stop
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: No code
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService stop
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus stop
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: No code
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ------------------------------ 122ms
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ------------------------------ 120ms
Jun 02 10:58:40 smsl-n100 volumio[3769]: info:
Jun 02 10:58:40 smsl-n100 volumio[3769]: ---------------------------- MPD announces system playlist update
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: Ignoring MPD Status Update
Jun 02 10:58:40 smsl-n100 volumio[3769]: info:
Jun 02 10:58:40 smsl-n100 volumio[3769]: ---------------------------- MPD announces system playlist update
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: Ignoring MPD Status Update
Jun 02 10:58:40 smsl-n100 volumio[3769]: error: updateQueue error: null
Jun 02 10:58:40 smsl-n100 volumio[3769]: info:
Jun 02 10:58:40 smsl-n100 volumio[3769]: ---------------------------- MPD announces system playlist update
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: Ignoring MPD Status Update
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ------------------------------ 122ms
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 115 milliseconds
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: sendMpdCommand add "NAS/CD/Léo Delibes - Coppelia/06. Act 1 - Theme Slave Varie.flac" took 116 milliseconds
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ------------------------------ 16ms
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ------------------------------ 13ms
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand play
Jun 02 10:58:40 smsl-n100 volumio[3769]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ------------------------------ 158ms
Jun 02 10:58:40 smsl-n100 volumio[3769]: info:
Jun 02 10:58:40 smsl-n100 volumio[3769]: ---------------------------- MPD announces system playlist update
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: Ignoring MPD Status Update
Jun 02 10:58:40 smsl-n100 volumio[3769]: info:
Jun 02 10:58:40 smsl-n100 volumio[3769]: ---------------------------- MPD announces system playlist update
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: Ignoring MPD Status Update
Jun 02 10:58:40 smsl-n100 volumio[3769]: info:
Jun 02 10:58:40 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:58:40 smsl-n100 volumio[3769]: info:
Jun 02 10:58:40 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ------------------------------ 126ms
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: sendMpdCommand play took 118 milliseconds
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ------------------------------ 117ms
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ------------------------------ 114ms
Jun 02 10:58:40 smsl-n100 volumio[3769]: info:
Jun 02 10:58:40 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:58:40 smsl-n100 volumio[3769]: info:
Jun 02 10:58:40 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: error: Serial API: Failed to decode command: 100, message: undefined
Jun 02 10:58:40 smsl-n100 volumio[3769]: error: Serial API: Failed to decode command: MAXVOL, message:
Jun 02 10:58:40 smsl-n100 volumio[3769]: error: Serial API: Failed to decode command: 100, message: undefined
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: sendMpdCommand status took 67 milliseconds
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: sendMpdCommand status took 65 milliseconds
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: sendMpdCommand status took 56 milliseconds
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: sendMpdCommand status took 50 milliseconds
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:58:40 smsl-n100 volumio[3769]: info:
Jun 02 10:58:40 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 43 milliseconds
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 42 milliseconds
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 41 milliseconds
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 40 milliseconds
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: sendMpdCommand status took 30 milliseconds
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":440,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"394 Kbps","isStreaming":false,"title":"Coppelia: Act 1 : Theme slave varie","artist":"Delibes","album":"Léo Delibes - Coppelia Hts","uri":"NAS/CD/Léo Delibes - Coppelia/06. Act 1 - Theme Slave Varie.flac","trackType":"flac"}
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService play
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus stop
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":440,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"394 Kbps","isStreaming":false,"title":"Coppelia: Act 1 : Theme slave varie","artist":"Delibes","album":"Léo Delibes - Coppelia Hts","uri":"NAS/CD/Léo Delibes - Coppelia/06. Act 1 - Theme Slave Varie.flac","trackType":"flac"}
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService play
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus play
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: Received an update from plugin. extracting info from payload
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":440,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"384 Kbps","isStreaming":false,"title":"Coppelia: Act 1 : Theme slave varie","artist":"Delibes","album":"Léo Delibes - Coppelia Hts","uri":"NAS/CD/Léo Delibes - Coppelia/06. Act 1 - Theme Slave Varie.flac","trackType":"flac"}
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService play
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus play
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: Received an update from plugin. extracting info from payload
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":440,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"384 Kbps","isStreaming":false,"title":"Coppelia: Act 1 : Theme slave varie","artist":"Delibes","album":"Léo Delibes - Coppelia Hts","uri":"NAS/CD/Léo Delibes - Coppelia/06. Act 1 - Theme Slave Varie.flac","trackType":"flac"}
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService play
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus play
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: Received an update from plugin. extracting info from payload
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ------------------------------ 265ms
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ------------------------------ 344ms
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ------------------------------ 331ms
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ------------------------------ 326ms
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 211 milliseconds
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":440,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"384 Kbps","isStreaming":false,"title":"Coppelia: Act 1 : Theme slave varie","artist":"Delibes","album":"Léo Delibes - Coppelia Hts","uri":"NAS/CD/Léo Delibes - Coppelia/06. Act 1 - Theme Slave Varie.flac","trackType":"flac"}
Jun 02 10:58:40 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService play
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus play
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: Received an update from plugin. extracting info from payload
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: ------------------------------ 323ms
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:40 smsl-n100 volumio[3769]: error: Serial API: Failed to decode command: 100, message: undefined
Jun 02 10:58:40 smsl-n100 volumio[3769]: error: Serial API: Failed to decode command: MAXVOL, message:
Jun 02 10:58:40 smsl-n100 volumio[3769]: error: Serial API: Failed to decode command: 100, message: undefined
Jun 02 10:58:40 smsl-n100 volumio[3769]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff
Jun 02 10:58:42 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:58:42 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 42.
Jun 02 10:58:42 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:58:42 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:58:42 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:58:42 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:58:42 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:42 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:58:42 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:58:42 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:58:45 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:58:45 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 43.
Jun 02 10:58:45 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:58:45 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:58:45 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:58:45 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:58:45 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:45 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:58:45 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:58:45 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Preload queue cleared
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::ClearQueue
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::stop
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::stPlaybackTimer
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::updateTrackBlock
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrackBlock
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::serviceStop
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 5
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::serviceStop
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ControllerMpd::stop
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand stop
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::clearPlayQueue
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::saveQueue
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushQueue
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::addQueueItems
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::addQueueItems
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Preload queue cleared
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/01. Prelude.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/01. Prelude.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/02. Act 1 - Valse.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/02. Act 1 - Valse.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/03. Act 1 - Mazurka.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/03. Act 1 - Mazurka.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/04. Act 1 - Scene.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/04. Act 1 - Scene.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/05. Act 1 - Ballade.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/05. Act 1 - Ballade.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushQueue
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::saveQueue
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::updateTrackBlock
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrackBlock
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPlay
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::play index 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::addQueueItems
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::addQueueItems
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Preload queue cleared
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/06. Act 1 - Theme Slave Varie.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/06. Act 1 - Theme Slave Varie.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/07. Act 1 - Czardas.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/07. Act 1 - Czardas.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/08. Act 2 - Musique Des Automates.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/08. Act 2 - Musique Des Automates.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/09. Act 2 - Chanson A Boire.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/09. Act 2 - Chanson A Boire.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/10. Act 2 - Valse De La Poupee.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/10. Act 2 - Valse De La Poupee.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/11. Act 2 - Bolero.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/11. Act 2 - Bolero.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/12. Act 2 - Gigue.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/12. Act 2 - Gigue.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/13. Act 3 - Fete De La Cloche.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/13. Act 3 - Fete De La Cloche.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/14. Act 3 - Valse Des Heures.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/14. Act 3 - Valse Des Heures.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/15. Act 3 - L'Aurore.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/15. Act 3 - L'Aurore.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/16. Act 3 - La Priere.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/16. Act 3 - La Priere.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/17. Act 3 - Le Travail (La Fileuse).flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/17. Act 3 - Le Travail (La Fileuse).flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/18. Act 3 - L'Hymen (Noce Villageois).flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/18. Act 3 - L'Hymen (Noce Villageois).flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/19. Act 3 - La Discorde Et La Guerre (Marche Des Guerriers).flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/19. Act 3 - La Discorde Et La Guerre (Marche Des Guerriers).flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/20. Act 3 - La Paix.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/20. Act 3 - La Paix.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/21. Act 3 - Danse De Fete.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/21. Act 3 - Danse De Fete.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Léo Delibes - Coppelia/22. Act 3 - Galop Final.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Léo Delibes - Coppelia/22. Act 3 - Galop Final.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::stop
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushQueue
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::saveQueue
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::play index undefined
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::updateTrackBlock
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrackBlock
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::startPlaybackTimer
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::clearAddPlayTracks NAS/CD/Léo Delibes - Coppelia/05. Act 1 - Ballade.flac
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand stop
Jun 02 10:58:46 smsl-n100 volumio[3769]: info:
Jun 02 10:58:46 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: sendMpdCommand stop took 136 milliseconds
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: sendMpdCommand stop took 25 milliseconds
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand clear
Jun 02 10:58:46 smsl-n100 volumio[3769]: info:
Jun 02 10:58:46 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:58:46 smsl-n100 volumio[3769]: info:
Jun 02 10:58:46 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:58:46 smsl-n100 volumio[3769]: info:
Jun 02 10:58:46 smsl-n100 volumio[3769]: ---------------------------- MPD announces system playlist update
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Ignoring MPD Status Update
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: sendMpdCommand status took 18 milliseconds
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: sendMpdCommand clear took 17 milliseconds
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: sendMpdCommand status took 20 milliseconds
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: sendMpdCommand status took 17 milliseconds
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand add "NAS/CD/Léo Delibes - Coppelia/05. Act 1 - Ballade.flac"
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService stop
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus stop
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: No code
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService stop
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus stop
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: No code
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ------------------------------ 137ms
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ------------------------------ 136ms
Jun 02 10:58:46 smsl-n100 volumio[3769]: info:
Jun 02 10:58:46 smsl-n100 volumio[3769]: ---------------------------- MPD announces system playlist update
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Ignoring MPD Status Update
Jun 02 10:58:46 smsl-n100 volumio[3769]: info:
Jun 02 10:58:46 smsl-n100 volumio[3769]: ---------------------------- MPD announces system playlist update
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Ignoring MPD Status Update
Jun 02 10:58:46 smsl-n100 volumio[3769]: error: updateQueue error: null
Jun 02 10:58:46 smsl-n100 volumio[3769]: info:
Jun 02 10:58:46 smsl-n100 volumio[3769]: ---------------------------- MPD announces system playlist update
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Ignoring MPD Status Update
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ------------------------------ 147ms
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 133 milliseconds
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: sendMpdCommand add "NAS/CD/Léo Delibes - Coppelia/05. Act 1 - Ballade.flac" took 133 milliseconds
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ------------------------------ 20ms
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ------------------------------ 17ms
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand play
Jun 02 10:58:46 smsl-n100 volumio[3769]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ------------------------------ 176ms
Jun 02 10:58:46 smsl-n100 volumio[3769]: info:
Jun 02 10:58:46 smsl-n100 volumio[3769]: ---------------------------- MPD announces system playlist update
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Ignoring MPD Status Update
Jun 02 10:58:46 smsl-n100 volumio[3769]: info:
Jun 02 10:58:46 smsl-n100 volumio[3769]: ---------------------------- MPD announces system playlist update
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Ignoring MPD Status Update
Jun 02 10:58:46 smsl-n100 volumio[3769]: info:
Jun 02 10:58:46 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:58:46 smsl-n100 volumio[3769]: info:
Jun 02 10:58:46 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ------------------------------ 94ms
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: sendMpdCommand play took 85 milliseconds
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ------------------------------ 82ms
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ------------------------------ 81ms
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:58:46 smsl-n100 volumio[3769]: info:
Jun 02 10:58:46 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:58:46 smsl-n100 volumio[3769]: info:
Jun 02 10:58:46 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: error: Serial API: Failed to decode command: 100, message: undefined
Jun 02 10:58:46 smsl-n100 volumio[3769]: error: Serial API: Failed to decode command: MAXVOL, message:
Jun 02 10:58:46 smsl-n100 volumio[3769]: error: Serial API: Failed to decode command: 100, message: undefined
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: sendMpdCommand status took 53 milliseconds
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: sendMpdCommand status took 51 milliseconds
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: sendMpdCommand status took 47 milliseconds
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: sendMpdCommand status took 42 milliseconds
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:58:46 smsl-n100 volumio[3769]: info:
Jun 02 10:58:46 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:58:46 smsl-n100 volumio[3769]: info:
Jun 02 10:58:46 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 40 milliseconds
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 39 milliseconds
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 38 milliseconds
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 37 milliseconds
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: sendMpdCommand status took 30 milliseconds
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: sendMpdCommand status took 24 milliseconds
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"525 Kbps","isStreaming":false,"title":"Coppelia: Act 1 : Ballade","artist":"Delibes","album":"Léo Delibes - Coppelia Hts","uri":"NAS/CD/Léo Delibes - Coppelia/05. Act 1 - Ballade.flac","trackType":"flac"}
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService play
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus stop
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"525 Kbps","isStreaming":false,"title":"Coppelia: Act 1 : Ballade","artist":"Delibes","album":"Léo Delibes - Coppelia Hts","uri":"NAS/CD/Léo Delibes - Coppelia/05. Act 1 - Ballade.flac","trackType":"flac"}
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService play
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus play
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Received an update from plugin. extracting info from payload
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"525 Kbps","isStreaming":false,"title":"Coppelia: Act 1 : Ballade","artist":"Delibes","album":"Léo Delibes - Coppelia Hts","uri":"NAS/CD/Léo Delibes - Coppelia/05. Act 1 - Ballade.flac","trackType":"flac"}
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService play
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus play
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Received an update from plugin. extracting info from payload
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"525 Kbps","isStreaming":false,"title":"Coppelia: Act 1 : Ballade","artist":"Delibes","album":"Léo Delibes - Coppelia Hts","uri":"NAS/CD/Léo Delibes - Coppelia/05. Act 1 - Ballade.flac","trackType":"flac"}
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService play
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus play
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Received an update from plugin. extracting info from payload
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ------------------------------ 236ms
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ------------------------------ 296ms
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ------------------------------ 286ms
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ------------------------------ 284ms
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 185 milliseconds
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 184 milliseconds
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"545 Kbps","isStreaming":false,"title":"Coppelia: Act 1 : Ballade","artist":"Delibes","album":"Léo Delibes - Coppelia Hts","uri":"NAS/CD/Léo Delibes - Coppelia/05. Act 1 - Ballade.flac","trackType":"flac"}
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService play
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus play
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Received an update from plugin. extracting info from payload
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":212,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"545 Kbps","isStreaming":false,"title":"Coppelia: Act 1 : Ballade","artist":"Delibes","album":"Léo Delibes - Coppelia Hts","uri":"NAS/CD/Léo Delibes - Coppelia/05. Act 1 - Ballade.flac","trackType":"flac"}
Jun 02 10:58:46 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService play
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus play
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: Received an update from plugin. extracting info from payload
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ------------------------------ 325ms
Jun 02 10:58:46 smsl-n100 volumio[3769]: info: ------------------------------ 322ms
Jun 02 10:58:47 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:58:47 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:47 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:58:47 smsl-n100 volumio[3769]: error: Serial API: Failed to decode command: 100, message: undefined
Jun 02 10:58:47 smsl-n100 volumio[3769]: error: Serial API: Failed to decode command: MAXVOL, message:
Jun 02 10:58:47 smsl-n100 volumio[3769]: error: Serial API: Failed to decode command: 100, message: undefined
Jun 02 10:58:47 smsl-n100 volumio[3769]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff
Jun 02 10:58:48 smsl-n100 volumio[3769]: info: MyVolumio login type: Token
Jun 02 10:58:48 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:58:48 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 44.
Jun 02 10:58:48 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:58:48 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:58:48 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:58:48 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:58:48 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:48 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:58:48 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:58:48 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:58:51 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:58:51 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 45.
Jun 02 10:58:51 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:58:51 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:58:51 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:58:52 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:58:52 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:52 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:58:52 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:58:52 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:58:55 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:58:55 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 46.
Jun 02 10:58:55 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:58:55 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:58:55 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:58:55 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:58:55 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:55 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:58:55 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:58:55 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:58:58 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:58:58 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 47.
Jun 02 10:58:58 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:58:58 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:58:58 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:58:58 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:58:58 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:58:58 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:58:58 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:58:58 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:59:01 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:59:01 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 48.
Jun 02 10:59:01 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:59:01 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:59:01 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:59:01 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:59:01 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:59:01 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:59:01 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:59:01 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:59:04 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:59:04 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 49.
Jun 02 10:59:04 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:59:04 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:59:05 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:59:05 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:59:05 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:59:05 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:59:05 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:59:05 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:59:05 smsl-n100 volumio[3769]: info: Listing playlists
Jun 02 10:59:08 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:59:08 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 50.
Jun 02 10:59:08 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:59:08 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:59:08 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:59:08 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:59:08 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:59:08 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:59:08 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:59:08 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:59:11 smsl-n100 volumio[3769]: info: Saving local item Chi
Jun 02 10:59:11 smsl-n100 volumio[3769]: info: Pushing Favourites {"uri":"/mnt/NAS/CD/Léo Delibes - Coppelia/05. Act 1 - Ballade.flac","favourite":false}
Jun 02 10:59:11 smsl-n100 volumio[3769]: info: Listing playlists
Jun 02 10:59:11 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:59:11 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 51.
Jun 02 10:59:11 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:59:11 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:59:11 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:59:11 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:59:11 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:59:11 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:59:12 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:59:12 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:59:15 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:59:15 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 52.
Jun 02 10:59:15 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:59:15 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:59:15 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:59:15 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:59:16 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:59:16 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:59:16 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:59:16 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:59:18 smsl-n100 volumio[3769]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Jun 02 10:59:18 smsl-n100 volumio[3769]: info: Retrying Login Due to Network Error
Jun 02 10:59:19 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:59:19 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 53.
Jun 02 10:59:19 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:59:19 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:59:19 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:59:19 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:59:19 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:59:19 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:59:19 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:59:19 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6
Jun 02 10:59:22 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:59:22 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 54.
Jun 02 10:59:22 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:59:22 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:59:22 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:59:22 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:59:22 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:59:22 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:59:22 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:59:22 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:59:25 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:59:25 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 55.
Jun 02 10:59:25 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:59:25 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:59:25 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:59:25 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:59:26 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:59:26 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:59:26 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:59:26 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:59:28 smsl-n100 volumio[3769]: info: MyVolumio login type: Token
Jun 02 10:59:29 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:59:29 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 56.
Jun 02 10:59:29 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:59:29 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:59:29 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:59:29 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:59:29 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:59:29 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:59:29 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:59:29 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:59:32 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:59:32 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 57.
Jun 02 10:59:32 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:59:32 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:59:32 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:59:32 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:59:32 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:59:32 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:59:32 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:59:32 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:59:35 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:59:35 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 58.
Jun 02 10:59:35 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:59:35 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:59:35 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:59:35 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:59:35 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:59:35 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Jun 02 10:59:35 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:59:35 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:59:35 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jun 02 10:59:35 smsl-n100 volumio[3769]: info: CURURI: albums:///Mozart%3A%20Clarinet%20Concerto%3B%20Horn%20Concertos%20Nos.%201%20%26%204
Jun 02 10:59:35 smsl-n100 volumio[3769]: info: Preload queue cleared
Jun 02 10:59:35 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/01 Orpheus Chamber orchestra - Charles Neidich On Basset Clarinet With Orpheus Chamber Orchestra , Konzert für Klarinette und Orchester - Allegro.flac
Jun 02 10:59:35 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/02 Orpheus Chamber orchestra - Charles Neidich On Basset Clarinet With Orpheus Chamber Orchestra , Konzert für Klarinette und Orchester - Adagio.flac
Jun 02 10:59:35 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/03 Orpheus Chamber orchestra - Charles Neidich On Basset Clarinet With Orpheus Chamber Orchestra , Konzert für Klarinette und Orchester - Rondo. Allegro.flac
Jun 02 10:59:35 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/04 Orpheus Chamber orchestra - David Jolley On Horn With Orpheus Chamber Orchestra , Konzerte für Horn und Orchester Nr. 1 - Allegro.flac
Jun 02 10:59:35 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/05 Orpheus Chamber orchestra - David Jolley On Horn With Orpheus Chamber Orchestra , Konzerte für Horn und Orchester Nr. 1- Rondo. Allegro.flac
Jun 02 10:59:35 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/06 Orpheus Chamber orchestra - David Jolley On Horn With Orpheus Chamber Orchestra , Konzerte für Horn und Orchester Nr. 4- Allegro maestoso.flac
Jun 02 10:59:35 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/07 Orpheus Chamber orchestra - David Jolley On Horn With Orpheus Chamber Orchestra , Konzerte für Horn und Orchester Nr. 4- Romance. Andante cantabile.flac
Jun 02 10:59:35 smsl-n100 volumio[3769]: info: Preloading song: music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/08 Orpheus Chamber orchestra - David Jolley On Horn With Orpheus Chamber Orchestra , Konzerte für Horn und Orchester Nr. 4- Rondo. Allegro vivace.flac
Jun 02 10:59:35 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/01 Orpheus Chamber orchestra - Charles Neidich On Basset Clarinet With Orpheus Chamber Orchestra , Konzert für Klarinette und Orchester - Allegro.flac in service mpd
Jun 02 10:59:35 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=/Mozart%3A%20Clarinet%20Concerto%3B%20Horn%20Concertos%20Nos.%201%20%26%204/extralarge&path=%2Fmnt%2FNAS%2FCD%2FMozart%20-%20Clarinet%20Concerto%20Horn%20Concerto%2F01%20Orpheus%20Chamber%20orchestra%20-%20Charles%20Neidich%20On%20Basset%20Clarinet%20With%20Orpheus%20Chamber%20Orchestra%20%2C%20Konzert%20f%C3%BCr%20Klarinette%20und%20Orchester%20-%20Allegro.flac&metadata=false
Jun 02 10:59:35 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/01 Orpheus Chamber orchestra - Charles Neidich On Basset Clarinet With Orpheus Chamber Orchestra , Konzert für Klarinette und Orchester - Allegro.flac
Jun 02 10:59:36 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/02 Orpheus Chamber orchestra - Charles Neidich On Basset Clarinet With Orpheus Chamber Orchestra , Konzert für Klarinette und Orchester - Adagio.flac in service mpd
Jun 02 10:59:36 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=/Mozart%3A%20Clarinet%20Concerto%3B%20Horn%20Concertos%20Nos.%201%20%26%204/extralarge&path=%2Fmnt%2FNAS%2FCD%2FMozart%20-%20Clarinet%20Concerto%20Horn%20Concerto%2F02%20Orpheus%20Chamber%20orchestra%20-%20Charles%20Neidich%20On%20Basset%20Clarinet%20With%20Orpheus%20Chamber%20Orchestra%20%2C%20Konzert%20f%C3%BCr%20Klarinette%20und%20Orchester%20-%20Adagio.flac&metadata=false
Jun 02 10:59:36 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/02 Orpheus Chamber orchestra - Charles Neidich On Basset Clarinet With Orpheus Chamber Orchestra , Konzert für Klarinette und Orchester - Adagio.flac
Jun 02 10:59:36 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/03 Orpheus Chamber orchestra - Charles Neidich On Basset Clarinet With Orpheus Chamber Orchestra , Konzert für Klarinette und Orchester - Rondo. Allegro.flac in service mpd
Jun 02 10:59:36 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=/Mozart%3A%20Clarinet%20Concerto%3B%20Horn%20Concertos%20Nos.%201%20%26%204/extralarge&path=%2Fmnt%2FNAS%2FCD%2FMozart%20-%20Clarinet%20Concerto%20Horn%20Concerto%2F03%20Orpheus%20Chamber%20orchestra%20-%20Charles%20Neidich%20On%20Basset%20Clarinet%20With%20Orpheus%20Chamber%20Orchestra%20%2C%20Konzert%20f%C3%BCr%20Klarinette%20und%20Orchester%20-%20Rondo.%20Allegro.flac&metadata=false
Jun 02 10:59:36 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/03 Orpheus Chamber orchestra - Charles Neidich On Basset Clarinet With Orpheus Chamber Orchestra , Konzert für Klarinette und Orchester - Rondo. Allegro.flac
Jun 02 10:59:36 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/04 Orpheus Chamber orchestra - David Jolley On Horn With Orpheus Chamber Orchestra , Konzerte für Horn und Orchester Nr. 1 - Allegro.flac in service mpd
Jun 02 10:59:36 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=/Mozart%3A%20Clarinet%20Concerto%3B%20Horn%20Concertos%20Nos.%201%20%26%204/extralarge&path=%2Fmnt%2FNAS%2FCD%2FMozart%20-%20Clarinet%20Concerto%20Horn%20Concerto%2F04%20Orpheus%20Chamber%20orchestra%20-%20David%20Jolley%20On%20Horn%20With%20Orpheus%20Chamber%20Orchestra%20%2C%20Konzerte%20f%C3%BCr%20Horn%20und%20Orchester%20Nr.%201%20-%20Allegro.flac&metadata=false
Jun 02 10:59:36 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/04 Orpheus Chamber orchestra - David Jolley On Horn With Orpheus Chamber Orchestra , Konzerte für Horn und Orchester Nr. 1 - Allegro.flac
Jun 02 10:59:36 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/05 Orpheus Chamber orchestra - David Jolley On Horn With Orpheus Chamber Orchestra , Konzerte für Horn und Orchester Nr. 1- Rondo. Allegro.flac in service mpd
Jun 02 10:59:36 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=/Mozart%3A%20Clarinet%20Concerto%3B%20Horn%20Concertos%20Nos.%201%20%26%204/extralarge&path=%2Fmnt%2FNAS%2FCD%2FMozart%20-%20Clarinet%20Concerto%20Horn%20Concerto%2F05%20Orpheus%20Chamber%20orchestra%20-%20David%20Jolley%20On%20Horn%20With%20Orpheus%20Chamber%20Orchestra%20%2C%20Konzerte%20f%C3%BCr%20Horn%20und%20Orchester%20Nr.%201-%20Rondo.%20Allegro.flac&metadata=false
Jun 02 10:59:36 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/05 Orpheus Chamber orchestra - David Jolley On Horn With Orpheus Chamber Orchestra , Konzerte für Horn und Orchester Nr. 1- Rondo. Allegro.flac
Jun 02 10:59:36 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/06 Orpheus Chamber orchestra - David Jolley On Horn With Orpheus Chamber Orchestra , Konzerte für Horn und Orchester Nr. 4- Allegro maestoso.flac in service mpd
Jun 02 10:59:36 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=/Mozart%3A%20Clarinet%20Concerto%3B%20Horn%20Concertos%20Nos.%201%20%26%204/extralarge&path=%2Fmnt%2FNAS%2FCD%2FMozart%20-%20Clarinet%20Concerto%20Horn%20Concerto%2F06%20Orpheus%20Chamber%20orchestra%20-%20David%20Jolley%20On%20Horn%20With%20Orpheus%20Chamber%20Orchestra%20%2C%20Konzerte%20f%C3%BCr%20Horn%20und%20Orchester%20Nr.%204-%20Allegro%20maestoso.flac&metadata=false
Jun 02 10:59:36 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/06 Orpheus Chamber orchestra - David Jolley On Horn With Orpheus Chamber Orchestra , Konzerte für Horn und Orchester Nr. 4- Allegro maestoso.flac
Jun 02 10:59:36 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/07 Orpheus Chamber orchestra - David Jolley On Horn With Orpheus Chamber Orchestra , Konzerte für Horn und Orchester Nr. 4- Romance. Andante cantabile.flac in service mpd
Jun 02 10:59:36 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=/Mozart%3A%20Clarinet%20Concerto%3B%20Horn%20Concertos%20Nos.%201%20%26%204/extralarge&path=%2Fmnt%2FNAS%2FCD%2FMozart%20-%20Clarinet%20Concerto%20Horn%20Concerto%2F07%20Orpheus%20Chamber%20orchestra%20-%20David%20Jolley%20On%20Horn%20With%20Orpheus%20Chamber%20Orchestra%20%2C%20Konzerte%20f%C3%BCr%20Horn%20und%20Orchester%20Nr.%204-%20Romance.%20Andante%20cantabile.flac&metadata=false
Jun 02 10:59:36 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/07 Orpheus Chamber orchestra - David Jolley On Horn With Orpheus Chamber Orchestra , Konzerte für Horn und Orchester Nr. 4- Romance. Andante cantabile.flac
Jun 02 10:59:36 smsl-n100 volumio[3769]: info: Exploding uri music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/08 Orpheus Chamber orchestra - David Jolley On Horn With Orpheus Chamber Orchestra , Konzerte für Horn und Orchester Nr. 4- Rondo. Allegro vivace.flac in service mpd
Jun 02 10:59:36 smsl-n100 volumio[3769]: info: ALBUMART /albumart?cacheid=737&web=/Mozart%3A%20Clarinet%20Concerto%3B%20Horn%20Concertos%20Nos.%201%20%26%204/extralarge&path=%2Fmnt%2FNAS%2FCD%2FMozart%20-%20Clarinet%20Concerto%20Horn%20Concerto%2F08%20Orpheus%20Chamber%20orchestra%20-%20David%20Jolley%20On%20Horn%20With%20Orpheus%20Chamber%20Orchestra%20%2C%20Konzerte%20f%C3%BCr%20Horn%20und%20Orchester%20Nr.%204-%20Rondo.%20Allegro%20vivace.flac&metadata=false
Jun 02 10:59:36 smsl-n100 volumio[3769]: info: URI /mnt/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/08 Orpheus Chamber orchestra - David Jolley On Horn With Orpheus Chamber Orchestra , Konzerte für Horn und Orchester Nr. 4- Rondo. Allegro vivace.flac
Jun 02 10:59:38 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:59:38 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 59.
Jun 02 10:59:38 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:59:38 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:59:38 smsl-n100 volumio[3769]: info: Executing endpoint restartRAATSocket
Jun 02 10:59:38 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:59:39 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=6/ABRT
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6
Jun 02 10:59:39 smsl-n100 systemd[1]: raat-daemon.service: Failed with result 'signal'.
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: Preload queue cleared
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::ClearQueue
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::stop
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::stPlaybackTimer
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::updateTrackBlock
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrackBlock
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::serviceStop
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 4
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreCommandRouter::serviceStop
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: ControllerMpd::stop
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand stop
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CorePlayQueue::clearPlayQueue
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CorePlayQueue::saveQueue
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushQueue
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::addQueueItems
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CorePlayQueue::addQueueItems
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: Preload queue cleared
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/01 Orpheus Chamber orchestra - Charles Neidich On Basset Clarinet With Orpheus Chamber Orchestra , Konzert für Klarinette und Orchester - Allegro.flac
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/01 Orpheus Chamber orchestra - Charles Neidich On Basset Clarinet With Orpheus Chamber Orchestra , Konzert für Klarinette und Orchester - Allegro.flac
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/02 Orpheus Chamber orchestra - Charles Neidich On Basset Clarinet With Orpheus Chamber Orchestra , Konzert für Klarinette und Orchester - Adagio.flac
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/02 Orpheus Chamber orchestra - Charles Neidich On Basset Clarinet With Orpheus Chamber Orchestra , Konzert für Klarinette und Orchester - Adagio.flac
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushQueue
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CorePlayQueue::saveQueue
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::updateTrackBlock
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrackBlock
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPlay
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::play index 1
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::addQueueItems
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CorePlayQueue::addQueueItems
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: Preload queue cleared
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/03 Orpheus Chamber orchestra - Charles Neidich On Basset Clarinet With Orpheus Chamber Orchestra , Konzert für Klarinette und Orchester - Rondo. Allegro.flac
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/03 Orpheus Chamber orchestra - Charles Neidich On Basset Clarinet With Orpheus Chamber Orchestra , Konzert für Klarinette und Orchester - Rondo. Allegro.flac
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/04 Orpheus Chamber orchestra - David Jolley On Horn With Orpheus Chamber Orchestra , Konzerte für Horn und Orchester Nr. 1 - Allegro.flac
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/04 Orpheus Chamber orchestra - David Jolley On Horn With Orpheus Chamber Orchestra , Konzerte für Horn und Orchester Nr. 1 - Allegro.flac
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/05 Orpheus Chamber orchestra - David Jolley On Horn With Orpheus Chamber Orchestra , Konzerte für Horn und Orchester Nr. 1- Rondo. Allegro.flac
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/05 Orpheus Chamber orchestra - David Jolley On Horn With Orpheus Chamber Orchestra , Konzerte für Horn und Orchester Nr. 1- Rondo. Allegro.flac
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/06 Orpheus Chamber orchestra - David Jolley On Horn With Orpheus Chamber Orchestra , Konzerte für Horn und Orchester Nr. 4- Allegro maestoso.flac
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/06 Orpheus Chamber orchestra - David Jolley On Horn With Orpheus Chamber Orchestra , Konzerte für Horn und Orchester Nr. 4- Allegro maestoso.flac
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/07 Orpheus Chamber orchestra - David Jolley On Horn With Orpheus Chamber Orchestra , Konzerte für Horn und Orchester Nr. 4- Romance. Andante cantabile.flac
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/07 Orpheus Chamber orchestra - David Jolley On Horn With Orpheus Chamber Orchestra , Konzerte für Horn und Orchester Nr. 4- Romance. Andante cantabile.flac
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: Adding Item to queue: music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/08 Orpheus Chamber orchestra - David Jolley On Horn With Orpheus Chamber Orchestra , Konzerte für Horn und Orchester Nr. 4- Rondo. Allegro vivace.flac
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: Using cached record of: music-library/NAS/CD/Mozart - Clarinet Concerto Horn Concerto/08 Orpheus Chamber orchestra - David Jolley On Horn With Orpheus Chamber Orchestra , Konzerte für Horn und Orchester Nr. 4- Rondo. Allegro vivace.flac
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::stop
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushQueue
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CorePlayQueue::saveQueue
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::play index undefined
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::updateTrackBlock
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrackBlock
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::startPlaybackTimer
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::clearAddPlayTracks NAS/CD/Mozart - Clarinet Concerto Horn Concerto/02 Orpheus Chamber orchestra - Charles Neidich On Basset Clarinet With Orpheus Chamber Orchestra , Konzert für Klarinette und Orchester - Adagio.flac
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand stop
Jun 02 10:59:39 smsl-n100 volumio[3769]: info:
Jun 02 10:59:39 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: sendMpdCommand stop took 93 milliseconds
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: sendMpdCommand stop took 28 milliseconds
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand clear
Jun 02 10:59:39 smsl-n100 volumio[3769]: info:
Jun 02 10:59:39 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:59:39 smsl-n100 volumio[3769]: info:
Jun 02 10:59:39 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:59:39 smsl-n100 volumio[3769]: info:
Jun 02 10:59:39 smsl-n100 volumio[3769]: ---------------------------- MPD announces system playlist update
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: Ignoring MPD Status Update
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: sendMpdCommand status took 16 milliseconds
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: sendMpdCommand clear took 14 milliseconds
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: sendMpdCommand status took 11 milliseconds
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: sendMpdCommand status took 8 milliseconds
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand add "NAS/CD/Mozart - Clarinet Concerto Horn Concerto/02 Orpheus Chamber orchestra - Charles Neidich On Basset Clarinet With Orpheus Chamber Orchestra , Konzert für Klarinette und Orchester - Adagio.flac"
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 1
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService stop
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus stop
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: No code
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 1
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService stop
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus stop
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: No code
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: ------------------------------ 102ms
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: ------------------------------ 100ms
Jun 02 10:59:39 smsl-n100 volumio[3769]: info:
Jun 02 10:59:39 smsl-n100 volumio[3769]: ---------------------------- MPD announces system playlist update
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: Ignoring MPD Status Update
Jun 02 10:59:39 smsl-n100 volumio[3769]: info:
Jun 02 10:59:39 smsl-n100 volumio[3769]: ---------------------------- MPD announces system playlist update
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: Ignoring MPD Status Update
Jun 02 10:59:39 smsl-n100 volumio[3769]: error: updateQueue error: null
Jun 02 10:59:39 smsl-n100 volumio[3769]: info:
Jun 02 10:59:39 smsl-n100 volumio[3769]: ---------------------------- MPD announces system playlist update
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: Ignoring MPD Status Update
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: ------------------------------ 110ms
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 104 milliseconds
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: sendMpdCommand add "NAS/CD/Mozart - Clarinet Concerto Horn Concerto/02 Orpheus Chamber orchestra - Charles Neidich On Basset Clarinet With Orpheus Chamber Orchestra , Konzert für Klarinette und Orchester - Adagio.flac" took 104 milliseconds
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: ------------------------------ 16ms
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: ------------------------------ 13ms
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand play
Jun 02 10:59:39 smsl-n100 volumio[3769]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: ------------------------------ 136ms
Jun 02 10:59:39 smsl-n100 volumio[3769]: info:
Jun 02 10:59:39 smsl-n100 volumio[3769]: ---------------------------- MPD announces system playlist update
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: Ignoring MPD Status Update
Jun 02 10:59:39 smsl-n100 volumio[3769]: info:
Jun 02 10:59:39 smsl-n100 volumio[3769]: ---------------------------- MPD announces system playlist update
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: Ignoring MPD Status Update
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: ------------------------------ 69ms
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: sendMpdCommand play took 60 milliseconds
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: ------------------------------ 57ms
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: ------------------------------ 54ms
Jun 02 10:59:39 smsl-n100 volumio[3769]: info:
Jun 02 10:59:39 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:59:39 smsl-n100 volumio[3769]: error: Serial API: Failed to decode command: 100, message: undefined
Jun 02 10:59:39 smsl-n100 volumio[3769]: error: Serial API: Failed to decode command: MAXVOL, message:
Jun 02 10:59:39 smsl-n100 volumio[3769]: error: Serial API: Failed to decode command: 100, message: undefined
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff
Jun 02 10:59:39 smsl-n100 volumio[3769]: info:
Jun 02 10:59:39 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:59:39 smsl-n100 volumio[3769]: info:
Jun 02 10:59:39 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:59:39 smsl-n100 volumio[3769]: info:
Jun 02 10:59:39 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: sendMpdCommand status took 59 milliseconds
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: sendMpdCommand status took 19 milliseconds
Jun 02 10:59:39 smsl-n100 volumio[3769]: info: sendMpdCommand status took 16 milliseconds
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:59:39 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:59:40 smsl-n100 volumio[3769]: info:
Jun 02 10:59:40 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:59:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:59:40 smsl-n100 volumio[3769]: info:
Jun 02 10:59:40 smsl-n100 volumio[3769]: ---------------------------- MPD announces state update: player
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: ControllerMpd::getState
Jun 02 10:59:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand status
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: sendMpdCommand status took 51 milliseconds
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 45 milliseconds
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 44 milliseconds
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 43 milliseconds
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: sendMpdCommand status took 32 milliseconds
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: sendMpdCommand status took 28 milliseconds
Jun 02 10:59:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:59:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:59:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:59:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:59:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:59:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:59:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:59:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseState
Jun 02 10:59:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:40 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":517,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Concerto For Clarinet & Orchestra In A Major, K. 622: 2. Adagio","artist":null,"album":"Mozart: Clarinet Concerto; Horn Concertos Nos. 1 & 4","uri":"NAS/CD/Mozart - Clarinet Concerto Horn Concerto/02 Orpheus Chamber orchestra - Charles Neidich On Basset Clarinet With Orpheus Chamber Orchestra , Konzert für Klarinette und Orchester - Adagio.flac","trackType":"flac"}
Jun 02 10:59:40 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 1
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService play
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus stop
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:40 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":517,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"405 Kbps","isStreaming":false,"title":"Concerto For Clarinet & Orchestra In A Major, K. 622: 2. Adagio","artist":null,"album":"Mozart: Clarinet Concerto; Horn Concertos Nos. 1 & 4","uri":"NAS/CD/Mozart - Clarinet Concerto Horn Concerto/02 Orpheus Chamber orchestra - Charles Neidich On Basset Clarinet With Orpheus Chamber Orchestra , Konzert für Klarinette und Orchester - Adagio.flac","trackType":"flac"}
Jun 02 10:59:40 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 1
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService play
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus play
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: Received an update from plugin. extracting info from payload
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:40 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":517,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"428 Kbps","isStreaming":false,"title":"Concerto For Clarinet & Orchestra In A Major, K. 622: 2. Adagio","artist":null,"album":"Mozart: Clarinet Concerto; Horn Concertos Nos. 1 & 4","uri":"NAS/CD/Mozart - Clarinet Concerto Horn Concerto/02 Orpheus Chamber orchestra - Charles Neidich On Basset Clarinet With Orpheus Chamber Orchestra , Konzert für Klarinette und Orchester - Adagio.flac","trackType":"flac"}
Jun 02 10:59:40 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 1
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService play
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus play
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: Received an update from plugin. extracting info from payload
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: ------------------------------ 198ms
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: ------------------------------ 200ms
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: ------------------------------ 196ms
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 124 milliseconds
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 120 milliseconds
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: sendMpdCommand playlistinfo took 119 milliseconds
Jun 02 10:59:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:59:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:59:40 smsl-n100 volumio[3769]: verbose: ControllerMpd::parseTrackInfo
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:40 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":517,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"436 Kbps","isStreaming":false,"title":"Concerto For Clarinet & Orchestra In A Major, K. 622: 2. Adagio","artist":null,"album":"Mozart: Clarinet Concerto; Horn Concertos Nos. 1 & 4","uri":"NAS/CD/Mozart - Clarinet Concerto Horn Concerto/02 Orpheus Chamber orchestra - Charles Neidich On Basset Clarinet With Orpheus Chamber Orchestra , Konzert für Klarinette und Orchester - Adagio.flac","trackType":"flac"}
Jun 02 10:59:40 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 1
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService play
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus play
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: Received an update from plugin. extracting info from payload
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:40 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":517,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"436 Kbps","isStreaming":false,"title":"Concerto For Clarinet & Orchestra In A Major, K. 622: 2. Adagio","artist":null,"album":"Mozart: Clarinet Concerto; Horn Concertos Nos. 1 & 4","uri":"NAS/CD/Mozart - Clarinet Concerto Horn Concerto/02 Orpheus Chamber orchestra - Charles Neidich On Basset Clarinet With Orpheus Chamber Orchestra , Konzert für Klarinette und Orchester - Adagio.flac","trackType":"flac"}
Jun 02 10:59:40 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 1
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService play
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus play
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: Received an update from plugin. extracting info from payload
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: ControllerMpd::pushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::servicePushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:40 smsl-n100 volumio[3769]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":517,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"436 Kbps","isStreaming":false,"title":"Concerto For Clarinet & Orchestra In A Major, K. 622: 2. Adagio","artist":null,"album":"Mozart: Clarinet Concerto; Horn Concertos Nos. 1 & 4","uri":"NAS/CD/Mozart - Clarinet Concerto Horn Concerto/02 Orpheus Chamber orchestra - Charles Neidich On Basset Clarinet With Orpheus Chamber Orchestra , Konzert für Klarinette und Orchester - Adagio.flac","trackType":"flac"}
Jun 02 10:59:40 smsl-n100 volumio[3769]: verbose: CURRENT POSITION 1
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState stateService play
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreStateMachine::syncState currentStatus play
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: Received an update from plugin. extracting info from payload
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: ------------------------------ 332ms
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: ------------------------------ 311ms
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: ------------------------------ 307ms
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreStateMachine::pushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CorePlayQueue::getTrack 1
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: CoreCommandRouter::volumioPushState
Jun 02 10:59:40 smsl-n100 volumio[3769]: error: Serial API: Failed to decode command: 100, message: undefined
Jun 02 10:59:40 smsl-n100 volumio[3769]: error: Serial API: Failed to decode command: MAXVOL, message:
Jun 02 10:59:40 smsl-n100 volumio[3769]: error: Serial API: Failed to decode command: 100, message: undefined
Jun 02 10:59:40 smsl-n100 volumio[3769]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff
Jun 02 10:59:42 smsl-n100 volumio[3769]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 02 10:59:42 smsl-n100 volumio[3769]: Error: connect ETIMEDOUT 31.13.95.18:443
Jun 02 10:59:42 smsl-n100 volumio[3769]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Jun 02 10:59:42 smsl-n100 volumio[3769]: errno: -110,
Jun 02 10:59:42 smsl-n100 volumio[3769]: code: 'ETIMEDOUT',
Jun 02 10:59:42 smsl-n100 volumio[3769]: syscall: 'connect',
Jun 02 10:59:42 smsl-n100 volumio[3769]: address: '31.13.95.18',
Jun 02 10:59:42 smsl-n100 volumio[3769]: port: 443
Jun 02 10:59:42 smsl-n100 volumio[3769]: }
Jun 02 10:59:42 smsl-n100 volumio[3769]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 02 10:59:42 smsl-n100 systemd[1]: raat-daemon.service: Service RestartSec=3s expired, scheduling restart.
Jun 02 10:59:42 smsl-n100 systemd[1]: raat-daemon.service: Scheduled restart job, restart counter is at 60.
Jun 02 10:59:42 smsl-n100 systemd[1]: Stopped RAAT DAEMON.
Jun 02 10:59:42 smsl-n100 systemd[1]: Started RAAT DAEMON.
Jun 02 10:59:43 smsl-n100 sudo[5303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-06-02 10:58
Jun 02 10:59:43 smsl-n100 sudo[5303]: 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"