Apr 14 13:09:14 vrrpi4b volumio[1291]: info: Preload queue cleared Apr 14 13:09:21 vrrpi4b volumio[1291]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 14 13:09:21 vrrpi4b volumio[1291]: info: CURURI: albums:// Apr 14 13:09:21 vrrpi4b volumio[1291]: info: listAlbums - loading Albums from cache Apr 14 13:09:22 vrrpi4b volumio[1291]: info: Preload queue cleared Apr 14 13:09:32 vrrpi4b volumio[1291]: Searching plugin music_service/mpd Apr 14 13:09:32 vrrpi4b volumio[1291]: info: CoreCommandRouter::executeOnPlugin: mpd , search Apr 14 13:09:33 vrrpi4b volumio[1291]: info: All search sources collected, pushing search results Apr 14 13:09:34 vrrpi4b volumio[1291]: Searching plugin music_service/mpd Apr 14 13:09:34 vrrpi4b volumio[1291]: info: CoreCommandRouter::executeOnPlugin: mpd , search Apr 14 13:09:35 vrrpi4b volumio[1291]: info: All search sources collected, pushing search results Apr 14 13:09:38 vrrpi4b volumio[1291]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 14 13:09:38 vrrpi4b volumio[1291]: info: CURURI: artists://Ludwig%20van%20Beethoven%3B%20Arturo%20Toscanini Apr 14 13:09:38 vrrpi4b volumio[1291]: error: Parse List Albums error:null Apr 14 13:09:38 vrrpi4b volumio[1291]: error: Failed to execute browseSource: Error Apr 14 13:09:42 vrrpi4b volumio[1291]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 14 13:09:42 vrrpi4b volumio[1291]: info: CURURI: artists://Ludwig%20van%20Beethoven%20Artur%20Rubinstein%20Arturo%20Toscanini%20NBC%20Symphony%20Orchestra Apr 14 13:09:42 vrrpi4b volumio[1291]: error: Parse List Albums error:null Apr 14 13:09:42 vrrpi4b volumio[1291]: error: Failed to execute browseSource: Error Apr 14 13:09:46 vrrpi4b volumio[1291]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 14 13:09:46 vrrpi4b volumio[1291]: info: CURURI: artists://Ludwig%20van%20Beethoven%20Artur%20Rubinstein%20Arturo%20Toscanini%20NBC%20Symphony%20Orchestra Apr 14 13:09:46 vrrpi4b volumio[1291]: error: Parse List Albums error:null Apr 14 13:09:46 vrrpi4b volumio[1291]: error: Failed to execute browseSource: Error Apr 14 13:09:54 vrrpi4b volumio[1291]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Apr 14 13:09:54 vrrpi4b volumio[1291]: verbose: ControllerMpd::sendMpdCommand update Apr 14 13:10:00 vrrpi4b volumio[1291]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 14 13:10:00 vrrpi4b volumio[1291]: info: CURURI: artists://Ludwig%20van%20Beethoven%20Alfred%20Cortot Apr 14 13:10:00 vrrpi4b volumio[1291]: error: Parse List Albums error:null Apr 14 13:10:00 vrrpi4b volumio[1291]: error: Failed to execute browseSource: Error Apr 14 13:10:03 vrrpi4b volumio[1291]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Apr 14 13:10:03 vrrpi4b volumio[1291]: verbose: ControllerMpd::sendMpdCommand update Apr 14 13:10:10 vrrpi4b volumio[1291]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 14 13:10:10 vrrpi4b volumio[1291]: info: CURURI: artists://Ludwig%20van%20Beethoven%20Alfred%20Cortot Apr 14 13:10:10 vrrpi4b volumio[1291]: error: Parse List Albums error:null Apr 14 13:10:10 vrrpi4b volumio[1291]: error: Failed to execute browseSource: Error Apr 14 13:10:20 vrrpi4b volumio[1291]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 14 13:10:20 vrrpi4b volumio[1291]: info: CURURI: albums://Alfred%20Cortot/Grand%20Piano%3A%20Alfred%20Cortot Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Preload queue cleared Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Preloading song: music-library/NAS/OMV/Alfred Cortot/Grand Piano/01 Liszt- Hungarian Rhapsody No 2.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Preloading song: music-library/NAS/OMV/Alfred Cortot/Grand Piano/02 Chopin- Andante Spianato and Grande Polonaise, Op 22.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Preloading song: music-library/NAS/OMV/Alfred Cortot/Grand Piano/03 Chopin- Impromptu, Op 51, No 3.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Preloading song: music-library/NAS/OMV/Alfred Cortot/Grand Piano/04 Chopin- Nocturne, Op 55, No 2.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Preloading song: music-library/NAS/OMV/Alfred Cortot/Grand Piano/05 Chopin- Etude, Op 25, No 8.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Preloading song: music-library/NAS/OMV/Alfred Cortot/Grand Piano/06 Chopin- Etude, Op 25, No 9, Butterfly.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Preloading song: music-library/NAS/OMV/Alfred Cortot/Grand Piano/07 Chopin- Etude, Op 10, No 5, Black Key.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Preloading song: music-library/NAS/OMV/Alfred Cortot/Grand Piano/08 Chopin- Etude, Op 25, No 11, Winter Wind.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Preloading song: music-library/NAS/OMV/Alfred Cortot/Grand Piano/09 Chopin- Etude, Op 25, No 12.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Preloading song: music-library/NAS/OMV/Alfred Cortot/Grand Piano/10 Liszt- Au bord d'un source, No 4.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Preloading song: music-library/NAS/OMV/Alfred Cortot/Grand Piano/11 Liszt- Hungarian Rhapsody, No 11.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Preloading song: music-library/NAS/OMV/Alfred Cortot/Grand Piano/12 Beethoven- Sonata No 30 - 1. Vivace, ma non troppo.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Preloading song: music-library/NAS/OMV/Alfred Cortot/Grand Piano/13 Beethoven- Sonata No 30 - 2. Prestissimo.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Preloading song: music-library/NAS/OMV/Alfred Cortot/Grand Piano/14 Beethoven- Sonata No 30 - 3. Andante molto cantabile.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Preloading song: music-library/NAS/OMV/Alfred Cortot/Grand Piano/15 Saint‐Saëns- Etude en forme de valse, Op 52, No 6.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Preloading song: music-library/NAS/OMV/Alfred Cortot/Grand Piano/16 Chabrier- Idylle, No 6.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Preloading song: music-library/NAS/OMV/Alfred Cortot/Grand Piano/17 Scriabin- Etude, Op 8, No 12.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Exploding uri music-library/NAS/OMV/Alfred Cortot/Grand Piano/01 Liszt- Hungarian Rhapsody No 2.flac in service mpd Apr 14 13:10:20 vrrpi4b volumio[1291]: info: ALBUMART /albumart?cacheid=334&web=Franz%20Liszt%20Alfred%20Cortot/Grand%20Piano%3A%20Alfred%20Cortot/extralarge&path=%2Fmnt%2FNAS%2FOMV%2FAlfred%20Cortot%2FGrand%20Piano%2F01%20Liszt-%20Hungarian%20Rhapsody%20No%202.flac&metadata=false Apr 14 13:10:20 vrrpi4b volumio[1291]: info: URI /mnt/NAS/OMV/Alfred Cortot/Grand Piano/01 Liszt- Hungarian Rhapsody No 2.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Exploding uri music-library/NAS/OMV/Alfred Cortot/Grand Piano/02 Chopin- Andante Spianato and Grande Polonaise, Op 22.flac in service mpd Apr 14 13:10:20 vrrpi4b volumio[1291]: info: ALBUMART /albumart?cacheid=334&web=Frederic%20Chopin%20Alfred%20Cortot/Grand%20Piano%3A%20Alfred%20Cortot/extralarge&path=%2Fmnt%2FNAS%2FOMV%2FAlfred%20Cortot%2FGrand%20Piano%2F02%20Chopin-%20Andante%20Spianato%20and%20Grande%20Polonaise%2C%20Op%2022.flac&metadata=false Apr 14 13:10:20 vrrpi4b volumio[1291]: info: URI /mnt/NAS/OMV/Alfred Cortot/Grand Piano/02 Chopin- Andante Spianato and Grande Polonaise, Op 22.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Exploding uri music-library/NAS/OMV/Alfred Cortot/Grand Piano/03 Chopin- Impromptu, Op 51, No 3.flac in service mpd Apr 14 13:10:20 vrrpi4b volumio[1291]: info: ALBUMART /albumart?cacheid=334&web=Frederic%20Chopin%20Alfred%20Cortot/Grand%20Piano%3A%20Alfred%20Cortot/extralarge&path=%2Fmnt%2FNAS%2FOMV%2FAlfred%20Cortot%2FGrand%20Piano%2F03%20Chopin-%20Impromptu%2C%20Op%2051%2C%20No%203.flac&metadata=false Apr 14 13:10:20 vrrpi4b volumio[1291]: info: URI /mnt/NAS/OMV/Alfred Cortot/Grand Piano/03 Chopin- Impromptu, Op 51, No 3.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: No valid Plugin REST Endpoint: getSimilarAlbums Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Exploding uri music-library/NAS/OMV/Alfred Cortot/Grand Piano/04 Chopin- Nocturne, Op 55, No 2.flac in service mpd Apr 14 13:10:20 vrrpi4b volumio[1291]: info: ALBUMART /albumart?cacheid=334&web=Frederic%20Chopin%20Alfred%20Cortot/Grand%20Piano%3A%20Alfred%20Cortot/extralarge&path=%2Fmnt%2FNAS%2FOMV%2FAlfred%20Cortot%2FGrand%20Piano%2F04%20Chopin-%20Nocturne%2C%20Op%2055%2C%20No%202.flac&metadata=false Apr 14 13:10:20 vrrpi4b volumio[1291]: info: URI /mnt/NAS/OMV/Alfred Cortot/Grand Piano/04 Chopin- Nocturne, Op 55, No 2.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Exploding uri music-library/NAS/OMV/Alfred Cortot/Grand Piano/05 Chopin- Etude, Op 25, No 8.flac in service mpd Apr 14 13:10:20 vrrpi4b volumio[1291]: info: ALBUMART /albumart?cacheid=334&web=Frederic%20Chopin%20Alfred%20Cortot/Grand%20Piano%3A%20Alfred%20Cortot/extralarge&path=%2Fmnt%2FNAS%2FOMV%2FAlfred%20Cortot%2FGrand%20Piano%2F05%20Chopin-%20Etude%2C%20Op%2025%2C%20No%208.flac&metadata=false Apr 14 13:10:20 vrrpi4b volumio[1291]: info: URI /mnt/NAS/OMV/Alfred Cortot/Grand Piano/05 Chopin- Etude, Op 25, No 8.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Exploding uri music-library/NAS/OMV/Alfred Cortot/Grand Piano/06 Chopin- Etude, Op 25, No 9, Butterfly.flac in service mpd Apr 14 13:10:20 vrrpi4b volumio[1291]: info: ALBUMART /albumart?cacheid=334&web=Frederic%20Chopin%20Alfred%20Cortot/Grand%20Piano%3A%20Alfred%20Cortot/extralarge&path=%2Fmnt%2FNAS%2FOMV%2FAlfred%20Cortot%2FGrand%20Piano%2F06%20Chopin-%20Etude%2C%20Op%2025%2C%20No%209%2C%20Butterfly.flac&metadata=false Apr 14 13:10:20 vrrpi4b volumio[1291]: info: URI /mnt/NAS/OMV/Alfred Cortot/Grand Piano/06 Chopin- Etude, Op 25, No 9, Butterfly.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Exploding uri music-library/NAS/OMV/Alfred Cortot/Grand Piano/07 Chopin- Etude, Op 10, No 5, Black Key.flac in service mpd Apr 14 13:10:20 vrrpi4b volumio[1291]: info: ALBUMART /albumart?cacheid=334&web=Frederic%20Chopin%20Alfred%20Cortot/Grand%20Piano%3A%20Alfred%20Cortot/extralarge&path=%2Fmnt%2FNAS%2FOMV%2FAlfred%20Cortot%2FGrand%20Piano%2F07%20Chopin-%20Etude%2C%20Op%2010%2C%20No%205%2C%20Black%20Key.flac&metadata=false Apr 14 13:10:20 vrrpi4b volumio[1291]: info: URI /mnt/NAS/OMV/Alfred Cortot/Grand Piano/07 Chopin- Etude, Op 10, No 5, Black Key.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Exploding uri music-library/NAS/OMV/Alfred Cortot/Grand Piano/08 Chopin- Etude, Op 25, No 11, Winter Wind.flac in service mpd Apr 14 13:10:20 vrrpi4b volumio[1291]: info: ALBUMART /albumart?cacheid=334&web=Frederic%20Chopin%20Alfred%20Cortot/Grand%20Piano%3A%20Alfred%20Cortot/extralarge&path=%2Fmnt%2FNAS%2FOMV%2FAlfred%20Cortot%2FGrand%20Piano%2F08%20Chopin-%20Etude%2C%20Op%2025%2C%20No%2011%2C%20Winter%20Wind.flac&metadata=false Apr 14 13:10:20 vrrpi4b volumio[1291]: info: URI /mnt/NAS/OMV/Alfred Cortot/Grand Piano/08 Chopin- Etude, Op 25, No 11, Winter Wind.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Exploding uri music-library/NAS/OMV/Alfred Cortot/Grand Piano/09 Chopin- Etude, Op 25, No 12.flac in service mpd Apr 14 13:10:20 vrrpi4b volumio[1291]: info: ALBUMART /albumart?cacheid=334&web=Frederic%20Chopin%20Alfred%20Cortot/Grand%20Piano%3A%20Alfred%20Cortot/extralarge&path=%2Fmnt%2FNAS%2FOMV%2FAlfred%20Cortot%2FGrand%20Piano%2F09%20Chopin-%20Etude%2C%20Op%2025%2C%20No%2012.flac&metadata=false Apr 14 13:10:20 vrrpi4b volumio[1291]: info: URI /mnt/NAS/OMV/Alfred Cortot/Grand Piano/09 Chopin- Etude, Op 25, No 12.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Exploding uri music-library/NAS/OMV/Alfred Cortot/Grand Piano/10 Liszt- Au bord d'un source, No 4.flac in service mpd Apr 14 13:10:20 vrrpi4b volumio[1291]: info: ALBUMART /albumart?cacheid=334&web=Franz%20Liszt%20Alfred%20Cortot/Grand%20Piano%3A%20Alfred%20Cortot/extralarge&path=%2Fmnt%2FNAS%2FOMV%2FAlfred%20Cortot%2FGrand%20Piano%2F10%20Liszt-%20Au%20bord%20d'un%20source%2C%20No%204.flac&metadata=false Apr 14 13:10:20 vrrpi4b volumio[1291]: info: URI /mnt/NAS/OMV/Alfred Cortot/Grand Piano/10 Liszt- Au bord d'un source, No 4.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Exploding uri music-library/NAS/OMV/Alfred Cortot/Grand Piano/11 Liszt- Hungarian Rhapsody, No 11.flac in service mpd Apr 14 13:10:20 vrrpi4b volumio[1291]: info: ALBUMART /albumart?cacheid=334&web=Franz%20Liszt%20Alfred%20Cortot/Grand%20Piano%3A%20Alfred%20Cortot/extralarge&path=%2Fmnt%2FNAS%2FOMV%2FAlfred%20Cortot%2FGrand%20Piano%2F11%20Liszt-%20Hungarian%20Rhapsody%2C%20No%2011.flac&metadata=false Apr 14 13:10:20 vrrpi4b volumio[1291]: info: URI /mnt/NAS/OMV/Alfred Cortot/Grand Piano/11 Liszt- Hungarian Rhapsody, No 11.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Exploding uri music-library/NAS/OMV/Alfred Cortot/Grand Piano/12 Beethoven- Sonata No 30 - 1. Vivace, ma non troppo.flac in service mpd Apr 14 13:10:20 vrrpi4b volumio[1291]: info: ALBUMART /albumart?cacheid=334&web=Ludwig%20van%20Beethoven%20Alfred%20Cortot/Grand%20Piano%3A%20Alfred%20Cortot/extralarge&path=%2Fmnt%2FNAS%2FOMV%2FAlfred%20Cortot%2FGrand%20Piano%2F12%20Beethoven-%20Sonata%20No%2030%20-%201.%20Vivace%2C%20ma%20non%20troppo.flac&metadata=false Apr 14 13:10:20 vrrpi4b volumio[1291]: info: URI /mnt/NAS/OMV/Alfred Cortot/Grand Piano/12 Beethoven- Sonata No 30 - 1. Vivace, ma non troppo.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Exploding uri music-library/NAS/OMV/Alfred Cortot/Grand Piano/13 Beethoven- Sonata No 30 - 2. Prestissimo.flac in service mpd Apr 14 13:10:20 vrrpi4b volumio[1291]: info: ALBUMART /albumart?cacheid=334&web=Ludwig%20van%20Beethoven%20Alfred%20Cortot/Grand%20Piano%3A%20Alfred%20Cortot/extralarge&path=%2Fmnt%2FNAS%2FOMV%2FAlfred%20Cortot%2FGrand%20Piano%2F13%20Beethoven-%20Sonata%20No%2030%20-%202.%20Prestissimo.flac&metadata=false Apr 14 13:10:20 vrrpi4b volumio[1291]: info: URI /mnt/NAS/OMV/Alfred Cortot/Grand Piano/13 Beethoven- Sonata No 30 - 2. Prestissimo.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Exploding uri music-library/NAS/OMV/Alfred Cortot/Grand Piano/14 Beethoven- Sonata No 30 - 3. Andante molto cantabile.flac in service mpd Apr 14 13:10:20 vrrpi4b volumio[1291]: info: ALBUMART /albumart?cacheid=334&web=Ludwig%20van%20Beethoven%20Alfred%20Cortot/Grand%20Piano%3A%20Alfred%20Cortot/extralarge&path=%2Fmnt%2FNAS%2FOMV%2FAlfred%20Cortot%2FGrand%20Piano%2F14%20Beethoven-%20Sonata%20No%2030%20-%203.%20Andante%20molto%20cantabile.flac&metadata=false Apr 14 13:10:20 vrrpi4b volumio[1291]: info: URI /mnt/NAS/OMV/Alfred Cortot/Grand Piano/14 Beethoven- Sonata No 30 - 3. Andante molto cantabile.flac Apr 14 13:10:20 vrrpi4b volumio[1291]: info: Exploding uri music-library/NAS/OMV/Alfred Cortot/Grand Piano/15 Saint‐Saëns- Etude en forme de valse, Op 52, No 6.flac in service mpd Apr 14 13:10:20 vrrpi4b volumio[1291]: info: ALBUMART /albumart?cacheid=334&web=Camille%20Saint-Saens%20Alfred%20Cortot/Grand%20Piano%3A%20Alfred%20Cortot/extralarge&path=%2Fmnt%2FNAS%2FOMV%2FAlfred%20Cortot%2FGrand%20Piano%2F15%20Saint%E2%80%90Sa%C3%ABns-%20Etude%20en%20forme%20de%20valse%2C%20Op%2052%2C%20No%206.flac&metadata=false Apr 14 13:10:20 vrrpi4b volumio[1291]: info: URI /mnt/NAS/OMV/Alfred Cortot/Grand Piano/15 Saint‐Saëns- Etude en forme de valse, Op 52, No 6.flac Apr 14 13:10:21 vrrpi4b volumio[1291]: info: Exploding uri music-library/NAS/OMV/Alfred Cortot/Grand Piano/16 Chabrier- Idylle, No 6.flac in service mpd Apr 14 13:10:21 vrrpi4b volumio[1291]: info: ALBUMART /albumart?cacheid=334&web=Emmanuel%20Chabrier%20Alfred%20Cortot/Grand%20Piano%3A%20Alfred%20Cortot/extralarge&path=%2Fmnt%2FNAS%2FOMV%2FAlfred%20Cortot%2FGrand%20Piano%2F16%20Chabrier-%20Idylle%2C%20No%206.flac&metadata=false Apr 14 13:10:21 vrrpi4b volumio[1291]: info: URI /mnt/NAS/OMV/Alfred Cortot/Grand Piano/16 Chabrier- Idylle, No 6.flac Apr 14 13:10:21 vrrpi4b volumio[1291]: info: Exploding uri music-library/NAS/OMV/Alfred Cortot/Grand Piano/17 Scriabin- Etude, Op 8, No 12.flac in service mpd Apr 14 13:10:21 vrrpi4b volumio[1291]: info: ALBUMART /albumart?cacheid=334&web=Alexander%20Scriabin%20Alfred%20Cortot/Grand%20Piano%3A%20Alfred%20Cortot/extralarge&path=%2Fmnt%2FNAS%2FOMV%2FAlfred%20Cortot%2FGrand%20Piano%2F17%20Scriabin-%20Etude%2C%20Op%208%2C%20No%2012.flac&metadata=false Apr 14 13:10:21 vrrpi4b volumio[1291]: info: URI /mnt/NAS/OMV/Alfred Cortot/Grand Piano/17 Scriabin- Etude, Op 8, No 12.flac Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Preload queue cleared Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::ClearQueue Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::stop Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CorePlayQueue::clearPlayQueue Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CorePlayQueue::saveQueue Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreCommandRouter::volumioPushQueue Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::addQueueItems Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CorePlayQueue::addQueueItems Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Preload queue cleared Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Adding Item to queue: albums://Alfred%20Cortot/Grand%20Piano%3A%20Alfred%20Cortot Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Exploding uri albums://Alfred%20Cortot/Grand%20Piano%3A%20Alfred%20Cortot in service mpd Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreCommandRouter::volumioPushQueue Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CorePlayQueue::saveQueue Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::updateTrackBlock Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CorePlayQueue::getTrackBlock Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreCommandRouter::volumioPlay Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::play index 0 Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::stop Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::play index undefined Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CorePlayQueue::getTrack 0 Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::startPlaybackTimer Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CorePlayQueue::getTrack 0 Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::clearAddPlayTracks NAS/OMV/Alfred Cortot/Grand Piano/01 Liszt- Hungarian Rhapsody No 2.flac Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::sendMpdCommand stop Apr 14 13:10:23 vrrpi4b volumio[1291]: info: sendMpdCommand stop took 3 milliseconds Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::sendMpdCommand clear Apr 14 13:10:23 vrrpi4b volumio[1291]: info: sendMpdCommand clear took 0 milliseconds Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::sendMpdCommand add "NAS/OMV/Alfred Cortot/Grand Piano/01 Liszt- Hungarian Rhapsody No 2.flac" Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Apr 14 13:10:23 vrrpi4b volumio[1291]: ---------------------------- MPD announces system playlist update Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Ignoring MPD Status Update Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Apr 14 13:10:23 vrrpi4b volumio[1291]: ---------------------------- MPD announces system playlist update Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Ignoring MPD Status Update Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Apr 14 13:10:23 vrrpi4b volumio[1291]: ---------------------------- MPD announces system playlist update Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Ignoring MPD Status Update Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Apr 14 13:10:23 vrrpi4b volumio[1291]: ---------------------------- MPD announces system playlist update Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Ignoring MPD Status Update Apr 14 13:10:23 vrrpi4b volumio[1291]: info: sendMpdCommand add "NAS/OMV/Alfred Cortot/Grand Piano/01 Liszt- Hungarian Rhapsody No 2.flac" took 4 milliseconds Apr 14 13:10:23 vrrpi4b volumio[1291]: info: ------------------------------ 4ms Apr 14 13:10:23 vrrpi4b volumio[1291]: info: ------------------------------ 2ms Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::sendMpdCommand play Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Apr 14 13:10:23 vrrpi4b volumio[1291]: ---------------------------- MPD announces system playlist update Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Ignoring MPD Status Update Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Apr 14 13:10:23 vrrpi4b volumio[1291]: ---------------------------- MPD announces system playlist update Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Ignoring MPD Status Update Apr 14 13:10:23 vrrpi4b volumio[1291]: info: ------------------------------ 5ms Apr 14 13:10:23 vrrpi4b volumio[1291]: info: ------------------------------ 5ms Apr 14 13:10:23 vrrpi4b volumio[1291]: info: sendMpdCommand play took 3 milliseconds Apr 14 13:10:23 vrrpi4b volumio[1291]: info: ------------------------------ 3ms Apr 14 13:10:23 vrrpi4b volumio[1291]: info: ------------------------------ 2ms Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Apr 14 13:10:23 vrrpi4b volumio[1291]: ---------------------------- MPD announces state update: player Apr 14 13:10:23 vrrpi4b volumio[1291]: info: ControllerMpd::getState Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Apr 14 13:10:23 vrrpi4b volumio[1291]: ---------------------------- MPD announces state update: player Apr 14 13:10:23 vrrpi4b volumio[1291]: info: ControllerMpd::getState Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Apr 14 13:10:23 vrrpi4b volumio[1291]: ---------------------------- MPD announces state update: player Apr 14 13:10:23 vrrpi4b volumio[1291]: info: ControllerMpd::getState Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Apr 14 13:10:23 vrrpi4b volumio[1291]: ---------------------------- MPD announces state update: player Apr 14 13:10:23 vrrpi4b volumio[1291]: info: sendMpdCommand status took 10 milliseconds Apr 14 13:10:23 vrrpi4b volumio[1291]: info: sendMpdCommand status took 9 milliseconds Apr 14 13:10:23 vrrpi4b volumio[1291]: info: ControllerMpd::getState Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Apr 14 13:10:23 vrrpi4b volumio[1291]: info: sendMpdCommand status took 9 milliseconds Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::parseState Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::parseState Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::parseState Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Apr 14 13:10:23 vrrpi4b volumio[1291]: ---------------------------- MPD announces state update: player Apr 14 13:10:23 vrrpi4b volumio[1291]: info: ControllerMpd::getState Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Apr 14 13:10:23 vrrpi4b volumio[1291]: ---------------------------- MPD announces state update: player Apr 14 13:10:23 vrrpi4b volumio[1291]: info: ControllerMpd::getState Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Apr 14 13:10:23 vrrpi4b volumio[1291]: info: sendMpdCommand status took 8 milliseconds Apr 14 13:10:23 vrrpi4b volumio[1291]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 14 13:10:23 vrrpi4b volumio[1291]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 14 13:10:23 vrrpi4b volumio[1291]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 14 13:10:23 vrrpi4b volumio[1291]: info: sendMpdCommand status took 5 milliseconds Apr 14 13:10:23 vrrpi4b volumio[1291]: info: sendMpdCommand status took 4 milliseconds Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::parseState Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::parseTrackInfo Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::parseTrackInfo Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::parseTrackInfo Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::parseState Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::parseState Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 13:10:23 vrrpi4b volumio[1291]: info: ControllerMpd::pushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreCommandRouter::servicePushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CorePlayQueue::getTrack 0 Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":578,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"254 Kbps","isStreaming":false,"title":"Liszt: Hungarian Rhapsody No 2","artist":"Franz Liszt Alfred Cortot","album":"Grand Piano: Alfred Cortot","uri":"NAS/OMV/Alfred Cortot/Grand Piano/01 Liszt- Hungarian Rhapsody No 2.flac","trackType":"flac"} Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: CURRENT POSITION 0 Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::syncState stateService play Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::syncState currentStatus stop Apr 14 13:10:23 vrrpi4b volumio[1291]: info: ControllerMpd::pushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreCommandRouter::servicePushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CorePlayQueue::getTrack 0 Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: STATE SERVICE {"status":"play","position":0,"seek":458,"duration":578,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"279 Kbps","isStreaming":false,"title":"Liszt: Hungarian Rhapsody No 2","artist":"Franz Liszt Alfred Cortot","album":"Grand Piano: Alfred Cortot","uri":"NAS/OMV/Alfred Cortot/Grand Piano/01 Liszt- Hungarian Rhapsody No 2.flac","trackType":"flac"} Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: CURRENT POSITION 0 Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::syncState stateService play Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::syncState currentStatus play Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Received an update from plugin. extracting info from payload Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::pushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CorePlayQueue::getTrack 0 Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreCommandRouter::volumioPushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::pushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CorePlayQueue::getTrack 0 Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreCommandRouter::volumioPushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: ControllerMpd::pushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreCommandRouter::servicePushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CorePlayQueue::getTrack 0 Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: STATE SERVICE {"status":"play","position":0,"seek":710,"duration":578,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"294 Kbps","isStreaming":false,"title":"Liszt: Hungarian Rhapsody No 2","artist":"Franz Liszt Alfred Cortot","album":"Grand Piano: Alfred Cortot","uri":"NAS/OMV/Alfred Cortot/Grand Piano/01 Liszt- Hungarian Rhapsody No 2.flac","trackType":"flac"} Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: CURRENT POSITION 0 Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::syncState stateService play Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::syncState currentStatus play Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Received an update from plugin. extracting info from payload Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::pushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CorePlayQueue::getTrack 0 Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreCommandRouter::volumioPushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::pushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CorePlayQueue::getTrack 0 Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreCommandRouter::volumioPushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: ------------------------------ 50ms Apr 14 13:10:23 vrrpi4b volumio[1291]: info: ------------------------------ 70ms Apr 14 13:10:23 vrrpi4b volumio[1291]: info: ------------------------------ 70ms Apr 14 13:10:23 vrrpi4b volumio[1291]: info: sendMpdCommand playlistinfo took 49 milliseconds Apr 14 13:10:23 vrrpi4b volumio[1291]: info: sendMpdCommand playlistinfo took 47 milliseconds Apr 14 13:10:23 vrrpi4b volumio[1291]: info: sendMpdCommand playlistinfo took 47 milliseconds Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::parseTrackInfo Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::parseTrackInfo Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: ControllerMpd::parseTrackInfo Apr 14 13:10:23 vrrpi4b volumio[1291]: info: ControllerMpd::pushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreCommandRouter::servicePushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CorePlayQueue::getTrack 0 Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848,"duration":578,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"295 Kbps","isStreaming":false,"title":"Liszt: Hungarian Rhapsody No 2","artist":"Franz Liszt Alfred Cortot","album":"Grand Piano: Alfred Cortot","uri":"NAS/OMV/Alfred Cortot/Grand Piano/01 Liszt- Hungarian Rhapsody No 2.flac","trackType":"flac"} Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: CURRENT POSITION 0 Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::syncState stateService play Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::syncState currentStatus play Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Received an update from plugin. extracting info from payload Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::pushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CorePlayQueue::getTrack 0 Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreCommandRouter::volumioPushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::pushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CorePlayQueue::getTrack 0 Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreCommandRouter::volumioPushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: ControllerMpd::pushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreCommandRouter::servicePushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CorePlayQueue::getTrack 0 Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848,"duration":578,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"295 Kbps","isStreaming":false,"title":"Liszt: Hungarian Rhapsody No 2","artist":"Franz Liszt Alfred Cortot","album":"Grand Piano: Alfred Cortot","uri":"NAS/OMV/Alfred Cortot/Grand Piano/01 Liszt- Hungarian Rhapsody No 2.flac","trackType":"flac"} Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: CURRENT POSITION 0 Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::syncState stateService play Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::syncState currentStatus play Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Received an update from plugin. extracting info from payload Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::pushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CorePlayQueue::getTrack 0 Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreCommandRouter::volumioPushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::pushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CorePlayQueue::getTrack 0 Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreCommandRouter::volumioPushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: ControllerMpd::pushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreCommandRouter::servicePushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CorePlayQueue::getTrack 0 Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: STATE SERVICE {"status":"play","position":0,"seek":848,"duration":578,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"295 Kbps","isStreaming":false,"title":"Liszt: Hungarian Rhapsody No 2","artist":"Franz Liszt Alfred Cortot","album":"Grand Piano: Alfred Cortot","uri":"NAS/OMV/Alfred Cortot/Grand Piano/01 Liszt- Hungarian Rhapsody No 2.flac","trackType":"flac"} Apr 14 13:10:23 vrrpi4b volumio[1291]: verbose: CURRENT POSITION 0 Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::syncState stateService play Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::syncState currentStatus play Apr 14 13:10:23 vrrpi4b volumio[1291]: info: Received an update from plugin. extracting info from payload Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::pushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CorePlayQueue::getTrack 0 Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreCommandRouter::volumioPushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreStateMachine::pushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CorePlayQueue::getTrack 0 Apr 14 13:10:23 vrrpi4b volumio[1291]: info: CoreCommandRouter::volumioPushState Apr 14 13:10:23 vrrpi4b volumio[1291]: info: ------------------------------ 125ms Apr 14 13:10:23 vrrpi4b volumio[1291]: info: ------------------------------ 121ms Apr 14 13:10:23 vrrpi4b volumio[1291]: info: ------------------------------ 120ms Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CoreCommandRouter::volumioPause Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CoreStateMachine::pause Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CoreStateMachine::stPlaybackTimer Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CoreStateMachine::servicePause Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CorePlayQueue::getTrack 0 Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CoreCommandRouter::servicePause Apr 14 13:10:27 vrrpi4b volumio[1291]: info: ControllerMpd::pause Apr 14 13:10:27 vrrpi4b volumio[1291]: verbose: ControllerMpd::sendMpdCommand pause Apr 14 13:10:27 vrrpi4b volumio[1291]: info: sendMpdCommand pause took 2 milliseconds Apr 14 13:10:27 vrrpi4b volumio[1291]: info: Apr 14 13:10:27 vrrpi4b volumio[1291]: ---------------------------- MPD announces state update: player Apr 14 13:10:27 vrrpi4b volumio[1291]: info: ControllerMpd::getState Apr 14 13:10:27 vrrpi4b volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Apr 14 13:10:27 vrrpi4b volumio[1291]: info: Apr 14 13:10:27 vrrpi4b volumio[1291]: ---------------------------- MPD announces state update: player Apr 14 13:10:27 vrrpi4b volumio[1291]: info: ControllerMpd::getState Apr 14 13:10:27 vrrpi4b volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Apr 14 13:10:27 vrrpi4b volumio[1291]: info: Apr 14 13:10:27 vrrpi4b volumio[1291]: ---------------------------- MPD announces state update: player Apr 14 13:10:27 vrrpi4b volumio[1291]: info: ControllerMpd::getState Apr 14 13:10:27 vrrpi4b volumio[1291]: verbose: ControllerMpd::sendMpdCommand status Apr 14 13:10:27 vrrpi4b volumio[1291]: info: sendMpdCommand status took 3 milliseconds Apr 14 13:10:27 vrrpi4b volumio[1291]: info: sendMpdCommand status took 2 milliseconds Apr 14 13:10:27 vrrpi4b volumio[1291]: info: sendMpdCommand status took 1 milliseconds Apr 14 13:10:27 vrrpi4b volumio[1291]: verbose: ControllerMpd::parseState Apr 14 13:10:27 vrrpi4b volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 13:10:27 vrrpi4b volumio[1291]: verbose: ControllerMpd::parseState Apr 14 13:10:27 vrrpi4b volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 13:10:27 vrrpi4b volumio[1291]: verbose: ControllerMpd::parseState Apr 14 13:10:27 vrrpi4b volumio[1291]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 14 13:10:27 vrrpi4b volumio[1291]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 14 13:10:27 vrrpi4b volumio[1291]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 14 13:10:27 vrrpi4b volumio[1291]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 14 13:10:27 vrrpi4b volumio[1291]: verbose: ControllerMpd::parseTrackInfo Apr 14 13:10:27 vrrpi4b volumio[1291]: verbose: ControllerMpd::parseTrackInfo Apr 14 13:10:27 vrrpi4b volumio[1291]: verbose: ControllerMpd::parseTrackInfo Apr 14 13:10:27 vrrpi4b volumio[1291]: info: ControllerMpd::pushState Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CoreCommandRouter::servicePushState Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CorePlayQueue::getTrack 0 Apr 14 13:10:27 vrrpi4b volumio[1291]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":4722,"duration":578,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"418 Kbps","isStreaming":false,"title":"Liszt: Hungarian Rhapsody No 2","artist":"Franz Liszt Alfred Cortot","album":"Grand Piano: Alfred Cortot","uri":"NAS/OMV/Alfred Cortot/Grand Piano/01 Liszt- Hungarian Rhapsody No 2.flac","trackType":"flac"} Apr 14 13:10:27 vrrpi4b volumio[1291]: verbose: CURRENT POSITION 0 Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CoreStateMachine::syncState stateService pause Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CoreStateMachine::syncState currentStatus pause Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CoreStateMachine::pushState Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CorePlayQueue::getTrack 0 Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CoreCommandRouter::volumioPushState Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CoreStateMachine::stPlaybackTimer Apr 14 13:10:27 vrrpi4b volumio[1291]: info: ControllerMpd::pushState Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CoreCommandRouter::servicePushState Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CorePlayQueue::getTrack 0 Apr 14 13:10:27 vrrpi4b volumio[1291]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":4722,"duration":578,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"418 Kbps","isStreaming":false,"title":"Liszt: Hungarian Rhapsody No 2","artist":"Franz Liszt Alfred Cortot","album":"Grand Piano: Alfred Cortot","uri":"NAS/OMV/Alfred Cortot/Grand Piano/01 Liszt- Hungarian Rhapsody No 2.flac","trackType":"flac"} Apr 14 13:10:27 vrrpi4b volumio[1291]: verbose: CURRENT POSITION 0 Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CoreStateMachine::syncState stateService pause Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CoreStateMachine::syncState currentStatus pause Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CoreStateMachine::pushState Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CorePlayQueue::getTrack 0 Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CoreCommandRouter::volumioPushState Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CoreStateMachine::stPlaybackTimer Apr 14 13:10:27 vrrpi4b volumio[1291]: info: ControllerMpd::pushState Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CoreCommandRouter::servicePushState Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CorePlayQueue::getTrack 0 Apr 14 13:10:27 vrrpi4b volumio[1291]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":4722,"duration":578,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"418 Kbps","isStreaming":false,"title":"Liszt: Hungarian Rhapsody No 2","artist":"Franz Liszt Alfred Cortot","album":"Grand Piano: Alfred Cortot","uri":"NAS/OMV/Alfred Cortot/Grand Piano/01 Liszt- Hungarian Rhapsody No 2.flac","trackType":"flac"} Apr 14 13:10:27 vrrpi4b volumio[1291]: verbose: CURRENT POSITION 0 Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CoreStateMachine::syncState stateService pause Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CoreStateMachine::syncState currentStatus pause Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CoreStateMachine::pushState Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CorePlayQueue::getTrack 0 Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CoreCommandRouter::volumioPushState Apr 14 13:10:27 vrrpi4b volumio[1291]: info: CoreStateMachine::stPlaybackTimer Apr 14 13:10:27 vrrpi4b volumio[1291]: info: ------------------------------ 36ms Apr 14 13:10:27 vrrpi4b volumio[1291]: info: ------------------------------ 36ms Apr 14 13:10:27 vrrpi4b volumio[1291]: info: ------------------------------ 35ms Apr 14 13:10:33 vrrpi4b volumio[1291]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 14 13:10:33 vrrpi4b volumio[1291]: info: CURURI: artists:// Apr 14 13:10:33 vrrpi4b volumio[1291]: info: Preload queue cleared Apr 14 13:10:55 vrrpi4b volumio[1291]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 14 13:10:55 vrrpi4b volumio[1291]: info: CURURI: music-library Apr 14 13:10:55 vrrpi4b volumio[1291]: info: Preload queue cleared Apr 14 13:10:56 vrrpi4b volumio[1291]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 14 13:10:56 vrrpi4b volumio[1291]: info: CURURI: music-library/NAS Apr 14 13:10:56 vrrpi4b volumio[1291]: info: Preload queue cleared Apr 14 13:10:57 vrrpi4b volumio[1291]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 14 13:10:57 vrrpi4b volumio[1291]: info: CURURI: music-library/NAS/OMV Apr 14 13:10:57 vrrpi4b volumio[1291]: info: Preload queue cleared Apr 14 13:10:58 vrrpi4b volumio[1291]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 14 13:10:58 vrrpi4b volumio[1291]: TypeError: Cannot read properties of null (reading 'slice') Apr 14 13:10:58 vrrpi4b volumio[1291]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Apr 14 13:10:58 vrrpi4b volumio[1291]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Apr 14 13:10:58 vrrpi4b volumio[1291]: at Object.onceWrapper (node:events:629:26) Apr 14 13:10:58 vrrpi4b volumio[1291]: at ClientRequest.emit (node:events:514:28) Apr 14 13:10:58 vrrpi4b volumio[1291]: at HTTPParser.parserOnIncomingClient [as onIncoming] (node:_http_client:693:27) Apr 14 13:10:58 vrrpi4b volumio[1291]: at HTTPParser.parserOnHeadersComplete (node:_http_common:119:17) Apr 14 13:10:58 vrrpi4b volumio[1291]: at TLSSocket.socketOnData (node:_http_client:535:22) Apr 14 13:10:58 vrrpi4b volumio[1291]: at TLSSocket.emit (node:events:514:28) Apr 14 13:10:58 vrrpi4b volumio[1291]: at addChunk (node:internal/streams/readable:343:12) Apr 14 13:10:58 vrrpi4b volumio[1291]: at readableAddChunk (node:internal/streams/readable:316:9) Apr 14 13:10:58 vrrpi4b volumio[1291]: at Readable.push (node:internal/streams/readable:253:10) Apr 14 13:10:58 vrrpi4b volumio[1291]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:190:23) Apr 14 13:10:58 vrrpi4b volumio[1291]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 14 13:10:59 vrrpi4b sudo[4214]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-14 13:09' Apr 14 13:10:59 vrrpi4b sudo[4214]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"