-- Logs begin at Tue 2025-03-18 18:48:58 CET, end at Wed 2025-03-19 19:56:56 CET. -- Mar 19 19:55:08 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 19 19:55:08 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 19 19:55:12 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 19 19:55:12 volumio volumio[958]: info: CorePlayQueue::getTrack 0 Mar 19 19:55:15 volumio volumio[958]: info: CoreCommandRouter::volumioGetQueue Mar 19 19:55:15 volumio volumio[958]: info: CoreStateMachine::getQueue Mar 19 19:55:15 volumio volumio[958]: info: CorePlayQueue::getQueue Mar 19 19:55:25 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 19 19:55:25 volumio volumio[958]: info: CURURI: music-library/USB/A554-B5A7/2004 - Travis Singles Mar 19 19:55:25 volumio volumio[958]: info: Preload queue cleared Mar 19 19:55:25 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/2004 - Travis Singles/01 - Sing.flac Mar 19 19:55:25 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/2004 - Travis Singles/02 - Driftwood.flac Mar 19 19:55:25 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/2004 - Travis Singles/03 - Writing To Reach You.flac Mar 19 19:55:25 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/2004 - Travis Singles/04 - Why Does It Always Rain On Me.flac Mar 19 19:55:25 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/2004 - Travis Singles/05 - Re-Offender.flac Mar 19 19:55:25 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/2004 - Travis Singles/06 - Walking In The Sun.flac Mar 19 19:55:25 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/2004 - Travis Singles/07 - Tied To The 90's.flac Mar 19 19:55:25 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/2004 - Travis Singles/08 - Coming Around.flac Mar 19 19:55:25 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/2004 - Travis Singles/09 - Flowers In The Window.flac Mar 19 19:55:25 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/2004 - Travis Singles/10 - Love Will Come Through.flac Mar 19 19:55:25 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/2004 - Travis Singles/11 - More Than Us.flac Mar 19 19:55:25 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/2004 - Travis Singles/12 - Side.flac Mar 19 19:55:25 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/2004 - Travis Singles/13 - U16 Girls.flac Mar 19 19:55:25 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/2004 - Travis Singles/14 - Happy.flac Mar 19 19:55:25 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/2004 - Travis Singles/15 - All I Want To Do Is Rock.flac Mar 19 19:55:25 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/2004 - Travis Singles/16 - The Beautiful Occupation.flac Mar 19 19:55:25 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/2004 - Travis Singles/17 - Turn.flac Mar 19 19:55:25 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/2004 - Travis Singles/18 - The Distance.flac Mar 19 19:55:25 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/2004 - Travis Singles/01 - Sing.flac in service mpd Mar 19 19:55:25 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Travis/The%20Singles/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2F2004%20-%20Travis%20Singles%2F01%20-%20Sing.flac&metadata=false Mar 19 19:55:25 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/2004 - Travis Singles/01 - Sing.flac Mar 19 19:55:25 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/2004 - Travis Singles/02 - Driftwood.flac in service mpd Mar 19 19:55:25 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Travis/The%20Singles/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2F2004%20-%20Travis%20Singles%2F02%20-%20Driftwood.flac&metadata=false Mar 19 19:55:25 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/2004 - Travis Singles/02 - Driftwood.flac Mar 19 19:55:25 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/2004 - Travis Singles/03 - Writing To Reach You.flac in service mpd Mar 19 19:55:25 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Travis/The%20Singles/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2F2004%20-%20Travis%20Singles%2F03%20-%20Writing%20To%20Reach%20You.flac&metadata=false Mar 19 19:55:25 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/2004 - Travis Singles/03 - Writing To Reach You.flac Mar 19 19:55:25 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/2004 - Travis Singles/04 - Why Does It Always Rain On Me.flac in service mpd Mar 19 19:55:25 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Travis/The%20Singles/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2F2004%20-%20Travis%20Singles%2F04%20-%20Why%20Does%20It%20Always%20Rain%20On%20Me.flac&metadata=false Mar 19 19:55:25 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/2004 - Travis Singles/04 - Why Does It Always Rain On Me.flac Mar 19 19:55:26 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/2004 - Travis Singles/05 - Re-Offender.flac in service mpd Mar 19 19:55:26 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Travis/The%20Singles/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2F2004%20-%20Travis%20Singles%2F05%20-%20Re-Offender.flac&metadata=false Mar 19 19:55:26 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/2004 - Travis Singles/05 - Re-Offender.flac Mar 19 19:55:26 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/2004 - Travis Singles/06 - Walking In The Sun.flac in service mpd Mar 19 19:55:26 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Travis/The%20Singles/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2F2004%20-%20Travis%20Singles%2F06%20-%20Walking%20In%20The%20Sun.flac&metadata=false Mar 19 19:55:26 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/2004 - Travis Singles/06 - Walking In The Sun.flac Mar 19 19:55:26 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/2004 - Travis Singles/07 - Tied To The 90's.flac in service mpd Mar 19 19:55:26 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Travis/The%20Singles/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2F2004%20-%20Travis%20Singles%2F07%20-%20Tied%20To%20The%2090's.flac&metadata=false Mar 19 19:55:26 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/2004 - Travis Singles/07 - Tied To The 90's.flac Mar 19 19:55:26 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/2004 - Travis Singles/08 - Coming Around.flac in service mpd Mar 19 19:55:26 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Travis/The%20Singles/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2F2004%20-%20Travis%20Singles%2F08%20-%20Coming%20Around.flac&metadata=false Mar 19 19:55:26 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/2004 - Travis Singles/08 - Coming Around.flac Mar 19 19:55:26 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/2004 - Travis Singles/09 - Flowers In The Window.flac in service mpd Mar 19 19:55:26 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Travis/The%20Singles/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2F2004%20-%20Travis%20Singles%2F09%20-%20Flowers%20In%20The%20Window.flac&metadata=false Mar 19 19:55:26 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/2004 - Travis Singles/09 - Flowers In The Window.flac Mar 19 19:55:26 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/2004 - Travis Singles/10 - Love Will Come Through.flac in service mpd Mar 19 19:55:26 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Travis/The%20Singles/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2F2004%20-%20Travis%20Singles%2F10%20-%20Love%20Will%20Come%20Through.flac&metadata=false Mar 19 19:55:26 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/2004 - Travis Singles/10 - Love Will Come Through.flac Mar 19 19:55:26 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/2004 - Travis Singles/11 - More Than Us.flac in service mpd Mar 19 19:55:26 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Travis/The%20Singles/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2F2004%20-%20Travis%20Singles%2F11%20-%20More%20Than%20Us.flac&metadata=false Mar 19 19:55:26 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/2004 - Travis Singles/11 - More Than Us.flac Mar 19 19:55:26 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/2004 - Travis Singles/12 - Side.flac in service mpd Mar 19 19:55:26 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Travis/The%20Singles/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2F2004%20-%20Travis%20Singles%2F12%20-%20Side.flac&metadata=false Mar 19 19:55:26 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/2004 - Travis Singles/12 - Side.flac Mar 19 19:55:26 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/2004 - Travis Singles/13 - U16 Girls.flac in service mpd Mar 19 19:55:26 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Travis/The%20Singles/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2F2004%20-%20Travis%20Singles%2F13%20-%20U16%20Girls.flac&metadata=false Mar 19 19:55:26 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/2004 - Travis Singles/13 - U16 Girls.flac Mar 19 19:55:26 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/2004 - Travis Singles/14 - Happy.flac in service mpd Mar 19 19:55:26 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Travis/The%20Singles/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2F2004%20-%20Travis%20Singles%2F14%20-%20Happy.flac&metadata=false Mar 19 19:55:26 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/2004 - Travis Singles/14 - Happy.flac Mar 19 19:55:26 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/2004 - Travis Singles/15 - All I Want To Do Is Rock.flac in service mpd Mar 19 19:55:26 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Travis/The%20Singles/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2F2004%20-%20Travis%20Singles%2F15%20-%20All%20I%20Want%20To%20Do%20Is%20Rock.flac&metadata=false Mar 19 19:55:26 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/2004 - Travis Singles/15 - All I Want To Do Is Rock.flac Mar 19 19:55:26 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/2004 - Travis Singles/16 - The Beautiful Occupation.flac in service mpd Mar 19 19:55:26 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Travis/The%20Singles/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2F2004%20-%20Travis%20Singles%2F16%20-%20The%20Beautiful%20Occupation.flac&metadata=false Mar 19 19:55:26 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/2004 - Travis Singles/16 - The Beautiful Occupation.flac Mar 19 19:55:26 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/2004 - Travis Singles/17 - Turn.flac in service mpd Mar 19 19:55:26 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Travis/The%20Singles/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2F2004%20-%20Travis%20Singles%2F17%20-%20Turn.flac&metadata=false Mar 19 19:55:26 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/2004 - Travis Singles/17 - Turn.flac Mar 19 19:55:26 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/2004 - Travis Singles/18 - The Distance.flac in service mpd Mar 19 19:55:26 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Travis/The%20Singles/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2F2004%20-%20Travis%20Singles%2F18%20-%20The%20Distance.flac&metadata=false Mar 19 19:55:26 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/2004 - Travis Singles/18 - The Distance.flac Mar 19 19:55:27 volumio volumio[958]: info: Preload queue cleared Mar 19 19:55:27 volumio volumio[958]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 19 19:55:27 volumio volumio[958]: info: CoreStateMachine::ClearQueue Mar 19 19:55:27 volumio volumio[958]: info: CoreStateMachine::stop Mar 19 19:55:27 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 19:55:27 volumio volumio[958]: info: CorePlayQueue::clearPlayQueue Mar 19 19:55:27 volumio volumio[958]: info: CorePlayQueue::saveQueue Mar 19 19:55:27 volumio volumio[958]: info: CoreCommandRouter::volumioPushQueue Mar 19 19:55:27 volumio volumio[958]: info: CoreStateMachine::addQueueItems Mar 19 19:55:27 volumio volumio[958]: info: CorePlayQueue::addQueueItems Mar 19 19:55:27 volumio volumio[958]: info: Preload queue cleared Mar 19 19:55:27 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/01 - Sing.flac Mar 19 19:55:27 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/01 - Sing.flac Mar 19 19:55:27 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/02 - Driftwood.flac Mar 19 19:55:27 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/02 - Driftwood.flac Mar 19 19:55:27 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/03 - Writing To Reach You.flac Mar 19 19:55:27 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/03 - Writing To Reach You.flac Mar 19 19:55:27 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/04 - Why Does It Always Rain On Me.flac Mar 19 19:55:27 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/04 - Why Does It Always Rain On Me.flac Mar 19 19:55:27 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/05 - Re-Offender.flac Mar 19 19:55:27 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/05 - Re-Offender.flac Mar 19 19:55:27 volumio volumio[958]: info: CoreCommandRouter::volumioPushQueue Mar 19 19:55:27 volumio volumio[958]: info: CorePlayQueue::saveQueue Mar 19 19:55:27 volumio volumio[958]: info: CoreStateMachine::updateTrackBlock Mar 19 19:55:27 volumio volumio[958]: info: CorePlayQueue::getTrackBlock Mar 19 19:55:27 volumio volumio[958]: info: CoreCommandRouter::volumioPlay Mar 19 19:55:27 volumio volumio[958]: info: CoreStateMachine::play index 4 Mar 19 19:55:27 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 19:55:27 volumio volumio[958]: info: CoreStateMachine::addQueueItems Mar 19 19:55:27 volumio volumio[958]: info: CorePlayQueue::addQueueItems Mar 19 19:55:27 volumio volumio[958]: info: Preload queue cleared Mar 19 19:55:27 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/06 - Walking In The Sun.flac Mar 19 19:55:27 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/06 - Walking In The Sun.flac Mar 19 19:55:27 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/07 - Tied To The 90's.flac Mar 19 19:55:27 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/07 - Tied To The 90's.flac Mar 19 19:55:27 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/08 - Coming Around.flac Mar 19 19:55:27 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/08 - Coming Around.flac Mar 19 19:55:27 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/09 - Flowers In The Window.flac Mar 19 19:55:27 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/09 - Flowers In The Window.flac Mar 19 19:55:27 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/10 - Love Will Come Through.flac Mar 19 19:55:27 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/10 - Love Will Come Through.flac Mar 19 19:55:27 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/11 - More Than Us.flac Mar 19 19:55:27 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/11 - More Than Us.flac Mar 19 19:55:27 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/12 - Side.flac Mar 19 19:55:27 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/12 - Side.flac Mar 19 19:55:27 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/13 - U16 Girls.flac Mar 19 19:55:27 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/13 - U16 Girls.flac Mar 19 19:55:27 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/14 - Happy.flac Mar 19 19:55:27 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/14 - Happy.flac Mar 19 19:55:27 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/15 - All I Want To Do Is Rock.flac Mar 19 19:55:27 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/15 - All I Want To Do Is Rock.flac Mar 19 19:55:27 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/16 - The Beautiful Occupation.flac Mar 19 19:55:27 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/16 - The Beautiful Occupation.flac Mar 19 19:55:27 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/17 - Turn.flac Mar 19 19:55:27 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/17 - Turn.flac Mar 19 19:55:27 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/18 - The Distance.flac Mar 19 19:55:27 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/18 - The Distance.flac Mar 19 19:55:27 volumio volumio[958]: info: CoreStateMachine::stop Mar 19 19:55:27 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 19:55:27 volumio volumio[958]: info: CoreCommandRouter::volumioPushQueue Mar 19 19:55:27 volumio volumio[958]: info: CorePlayQueue::saveQueue Mar 19 19:55:27 volumio volumio[958]: info: CoreStateMachine::play index undefined Mar 19 19:55:27 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 19:55:27 volumio volumio[958]: info: CoreStateMachine::updateTrackBlock Mar 19 19:55:27 volumio volumio[958]: info: CorePlayQueue::getTrackBlock Mar 19 19:55:27 volumio volumio[958]: info: CorePlayQueue::getTrack 4 Mar 19 19:55:27 volumio volumio[958]: info: CoreStateMachine::startPlaybackTimer Mar 19 19:55:27 volumio volumio[958]: info: CorePlayQueue::getTrack 4 Mar 19 19:55:27 volumio volumio[958]: verbose: ControllerMpd::clearAddPlayTracks USB/A554-B5A7/2004 - Travis Singles/05 - Re-Offender.flac Mar 19 19:55:27 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand stop Mar 19 19:55:28 volumio volumio[958]: info: sendMpdCommand stop took 13 milliseconds Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand clear Mar 19 19:55:28 volumio volumio[958]: info: Mar 19 19:55:28 volumio volumio[958]: ---------------------------- MPD announces system playlist update Mar 19 19:55:28 volumio volumio[958]: info: Ignoring MPD Status Update Mar 19 19:55:28 volumio volumio[958]: info: sendMpdCommand clear took 5 milliseconds Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand add "USB/A554-B5A7/2004 - Travis Singles/05 - Re-Offender.flac" Mar 19 19:55:28 volumio volumio[958]: info: Mar 19 19:55:28 volumio volumio[958]: ---------------------------- MPD announces system playlist update Mar 19 19:55:28 volumio volumio[958]: info: Ignoring MPD Status Update Mar 19 19:55:28 volumio volumio[958]: info: Mar 19 19:55:28 volumio volumio[958]: ---------------------------- MPD announces system playlist update Mar 19 19:55:28 volumio volumio[958]: info: Ignoring MPD Status Update Mar 19 19:55:28 volumio volumio[958]: error: updateQueue error: null Mar 19 19:55:28 volumio volumio[958]: info: Mar 19 19:55:28 volumio volumio[958]: ---------------------------- MPD announces system playlist update Mar 19 19:55:28 volumio volumio[958]: info: Ignoring MPD Status Update Mar 19 19:55:28 volumio volumio[958]: info: ------------------------------ 13ms Mar 19 19:55:28 volumio volumio[958]: info: sendMpdCommand add "USB/A554-B5A7/2004 - Travis Singles/05 - Re-Offender.flac" took 10 milliseconds Mar 19 19:55:28 volumio volumio[958]: info: ------------------------------ 9ms Mar 19 19:55:28 volumio volumio[958]: info: ------------------------------ 7ms Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand play Mar 19 19:55:28 volumio volumio[958]: info: Mar 19 19:55:28 volumio volumio[958]: ---------------------------- MPD announces system playlist update Mar 19 19:55:28 volumio volumio[958]: info: Ignoring MPD Status Update Mar 19 19:55:28 volumio volumio[958]: info: Mar 19 19:55:28 volumio volumio[958]: ---------------------------- MPD announces system playlist update Mar 19 19:55:28 volumio volumio[958]: info: Ignoring MPD Status Update Mar 19 19:55:28 volumio volumio[958]: error: Upnp client error: Error: This socket has been ended by the other party Mar 19 19:55:28 volumio volumio[958]: info: Mar 19 19:55:28 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:28 volumio volumio[958]: info: ------------------------------ 12ms Mar 19 19:55:28 volumio volumio[958]: info: sendMpdCommand play took 8 milliseconds Mar 19 19:55:28 volumio volumio[958]: info: ------------------------------ 7ms Mar 19 19:55:28 volumio volumio[958]: info: ------------------------------ 5ms Mar 19 19:55:28 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:28 volumio volumio[958]: info: Mar 19 19:55:28 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:28 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:28 volumio volumio[958]: info: Mar 19 19:55:28 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:28 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:28 volumio volumio[958]: info: Mar 19 19:55:28 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:28 volumio volumio[958]: info: sendMpdCommand status took 17 milliseconds Mar 19 19:55:28 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 19:55:28 volumio volumio[958]: info: sendMpdCommand status took 21 milliseconds Mar 19 19:55:28 volumio volumio[958]: info: sendMpdCommand status took 19 milliseconds Mar 19 19:55:28 volumio volumio[958]: info: sendMpdCommand status took 7 milliseconds Mar 19 19:55:28 volumio volumio[958]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Mar 19 19:55:28 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:28 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:28 volumio volumio[958]: info: CorePlayQueue::getTrack 4 Mar 19 19:55:28 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"854 Kbps","isStreaming":false,"title":"Re-Offender","artist":"Travis","album":"The Singles","uri":"USB/A554-B5A7/2004 - Travis Singles/05 - Re-Offender.flac","trackType":"flac"} Mar 19 19:55:28 volumio volumio[958]: verbose: CURRENT POSITION 4 Mar 19 19:55:28 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Mar 19 19:55:28 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus stop Mar 19 19:55:28 volumio volumio[958]: info: ------------------------------ 42ms Mar 19 19:55:28 volumio volumio[958]: info: Mar 19 19:55:28 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:28 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:28 volumio volumio[958]: info: Mar 19 19:55:28 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:28 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:28 volumio volumio[958]: info: sendMpdCommand playlistinfo took 19 milliseconds Mar 19 19:55:28 volumio volumio[958]: info: sendMpdCommand playlistinfo took 18 milliseconds Mar 19 19:55:28 volumio volumio[958]: info: sendMpdCommand playlistinfo took 18 milliseconds Mar 19 19:55:28 volumio volumio[958]: info: sendMpdCommand status took 6 milliseconds Mar 19 19:55:28 volumio volumio[958]: info: sendMpdCommand status took 4 milliseconds Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 19:55:28 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:28 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:28 volumio volumio[958]: info: CorePlayQueue::getTrack 4 Mar 19 19:55:28 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"881 Kbps","isStreaming":false,"title":"Re-Offender","artist":"Travis","album":"The Singles","uri":"USB/A554-B5A7/2004 - Travis Singles/05 - Re-Offender.flac","trackType":"flac"} Mar 19 19:55:28 volumio volumio[958]: verbose: CURRENT POSITION 4 Mar 19 19:55:28 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Mar 19 19:55:28 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Mar 19 19:55:28 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Mar 19 19:55:28 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:28 volumio volumio[958]: info: CorePlayQueue::getTrack 4 Mar 19 19:55:28 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 19:55:28 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:28 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:28 volumio volumio[958]: info: CorePlayQueue::getTrack 4 Mar 19 19:55:28 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:28 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:28 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:28 volumio volumio[958]: info: CorePlayQueue::getTrack 4 Mar 19 19:55:28 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"881 Kbps","isStreaming":false,"title":"Re-Offender","artist":"Travis","album":"The Singles","uri":"USB/A554-B5A7/2004 - Travis Singles/05 - Re-Offender.flac","trackType":"flac"} Mar 19 19:55:28 volumio volumio[958]: verbose: CURRENT POSITION 4 Mar 19 19:55:28 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Mar 19 19:55:28 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Mar 19 19:55:28 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Mar 19 19:55:28 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:28 volumio volumio[958]: info: CorePlayQueue::getTrack 4 Mar 19 19:55:28 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:28 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:28 volumio volumio[958]: info: CorePlayQueue::getTrack 4 Mar 19 19:55:28 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:28 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:28 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:28 volumio volumio[958]: info: CorePlayQueue::getTrack 4 Mar 19 19:55:28 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"537 Kbps","isStreaming":false,"title":"Re-Offender","artist":"Travis","album":"The Singles","uri":"USB/A554-B5A7/2004 - Travis Singles/05 - Re-Offender.flac","trackType":"flac"} Mar 19 19:55:28 volumio volumio[958]: verbose: CURRENT POSITION 4 Mar 19 19:55:28 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Mar 19 19:55:28 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Mar 19 19:55:28 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Mar 19 19:55:28 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:28 volumio volumio[958]: info: CorePlayQueue::getTrack 4 Mar 19 19:55:28 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:28 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:28 volumio volumio[958]: info: CorePlayQueue::getTrack 4 Mar 19 19:55:28 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:28 volumio volumio[958]: info: ------------------------------ 127ms Mar 19 19:55:28 volumio volumio[958]: info: ------------------------------ 126ms Mar 19 19:55:28 volumio volumio[958]: info: ------------------------------ 116ms Mar 19 19:55:28 volumio volumio[958]: info: sendMpdCommand playlistinfo took 82 milliseconds Mar 19 19:55:28 volumio volumio[958]: info: sendMpdCommand playlistinfo took 82 milliseconds Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Mar 19 19:55:28 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Mar 19 19:55:28 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:28 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:28 volumio volumio[958]: info: CorePlayQueue::getTrack 4 Mar 19 19:55:28 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"537 Kbps","isStreaming":false,"title":"Re-Offender","artist":"Travis","album":"The Singles","uri":"USB/A554-B5A7/2004 - Travis Singles/05 - Re-Offender.flac","trackType":"flac"} Mar 19 19:55:28 volumio volumio[958]: verbose: CURRENT POSITION 4 Mar 19 19:55:28 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Mar 19 19:55:28 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Mar 19 19:55:28 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Mar 19 19:55:28 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:28 volumio volumio[958]: info: CorePlayQueue::getTrack 4 Mar 19 19:55:28 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:28 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:28 volumio volumio[958]: info: CorePlayQueue::getTrack 4 Mar 19 19:55:28 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:28 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:28 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:28 volumio volumio[958]: info: CorePlayQueue::getTrack 4 Mar 19 19:55:28 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"537 Kbps","isStreaming":false,"title":"Re-Offender","artist":"Travis","album":"The Singles","uri":"USB/A554-B5A7/2004 - Travis Singles/05 - Re-Offender.flac","trackType":"flac"} Mar 19 19:55:28 volumio volumio[958]: verbose: CURRENT POSITION 4 Mar 19 19:55:28 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Mar 19 19:55:28 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Mar 19 19:55:28 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Mar 19 19:55:28 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:28 volumio volumio[958]: info: CorePlayQueue::getTrack 4 Mar 19 19:55:28 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:28 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:28 volumio volumio[958]: info: CorePlayQueue::getTrack 4 Mar 19 19:55:28 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:28 volumio volumio[958]: info: ------------------------------ 135ms Mar 19 19:55:28 volumio volumio[958]: info: ------------------------------ 134ms Mar 19 19:55:28 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:28 volumio volumio[958]: info: [GPIO_Control] Handling event: musicPlay Mar 19 19:55:28 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:28 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:28 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:28 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:28 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:28 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:28 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:28 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:28 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:31 volumio volumio[958]: info: Preload queue cleared Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::ClearQueue Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::stop Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::stPlaybackTimer Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::updateTrackBlock Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrackBlock Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 4 Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::serviceStop Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 4 Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::serviceStop Mar 19 19:55:31 volumio volumio[958]: info: ControllerMpd::stop Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand stop Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::clearPlayQueue Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::saveQueue Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::volumioPushQueue Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::addQueueItems Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::addQueueItems Mar 19 19:55:31 volumio volumio[958]: info: Preload queue cleared Mar 19 19:55:31 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/01 - Sing.flac Mar 19 19:55:31 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/01 - Sing.flac Mar 19 19:55:31 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/02 - Driftwood.flac Mar 19 19:55:31 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/02 - Driftwood.flac Mar 19 19:55:31 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/03 - Writing To Reach You.flac Mar 19 19:55:31 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/03 - Writing To Reach You.flac Mar 19 19:55:31 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/04 - Why Does It Always Rain On Me.flac Mar 19 19:55:31 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/04 - Why Does It Always Rain On Me.flac Mar 19 19:55:31 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/05 - Re-Offender.flac Mar 19 19:55:31 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/05 - Re-Offender.flac Mar 19 19:55:31 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/06 - Walking In The Sun.flac Mar 19 19:55:31 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/06 - Walking In The Sun.flac Mar 19 19:55:31 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/07 - Tied To The 90's.flac Mar 19 19:55:31 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/07 - Tied To The 90's.flac Mar 19 19:55:31 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/08 - Coming Around.flac Mar 19 19:55:31 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/08 - Coming Around.flac Mar 19 19:55:31 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/09 - Flowers In The Window.flac Mar 19 19:55:31 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/09 - Flowers In The Window.flac Mar 19 19:55:31 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/10 - Love Will Come Through.flac Mar 19 19:55:31 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/10 - Love Will Come Through.flac Mar 19 19:55:31 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/11 - More Than Us.flac Mar 19 19:55:31 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/11 - More Than Us.flac Mar 19 19:55:31 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/12 - Side.flac Mar 19 19:55:31 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/12 - Side.flac Mar 19 19:55:31 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/13 - U16 Girls.flac Mar 19 19:55:31 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/13 - U16 Girls.flac Mar 19 19:55:31 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/14 - Happy.flac Mar 19 19:55:31 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/14 - Happy.flac Mar 19 19:55:31 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/15 - All I Want To Do Is Rock.flac Mar 19 19:55:31 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/15 - All I Want To Do Is Rock.flac Mar 19 19:55:31 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/16 - The Beautiful Occupation.flac Mar 19 19:55:31 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/16 - The Beautiful Occupation.flac Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::volumioPushQueue Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::saveQueue Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::updateTrackBlock Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrackBlock Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::volumioPlay Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::play index 15 Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::addQueueItems Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::addQueueItems Mar 19 19:55:31 volumio volumio[958]: info: Preload queue cleared Mar 19 19:55:31 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/17 - Turn.flac Mar 19 19:55:31 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/17 - Turn.flac Mar 19 19:55:31 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/2004 - Travis Singles/18 - The Distance.flac Mar 19 19:55:31 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/2004 - Travis Singles/18 - The Distance.flac Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::stop Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::volumioPushQueue Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::saveQueue Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::play index undefined Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::updateTrackBlock Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrackBlock Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::startPlaybackTimer Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::clearAddPlayTracks USB/A554-B5A7/2004 - Travis Singles/16 - The Beautiful Occupation.flac Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand stop Mar 19 19:55:31 volumio volumio[958]: info: [GPIO_Control] Status changed: stop Mar 19 19:55:31 volumio volumio[958]: info: [GPIO_Control] Handling event: musicStop Mar 19 19:55:31 volumio volumio[958]: info: Mar 19 19:55:31 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:31 volumio volumio[958]: info: sendMpdCommand stop took 61 milliseconds Mar 19 19:55:31 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:31 volumio volumio[958]: info: sendMpdCommand stop took 16 milliseconds Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand clear Mar 19 19:55:31 volumio volumio[958]: info: Mar 19 19:55:31 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:31 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:31 volumio volumio[958]: info: Mar 19 19:55:31 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:31 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:31 volumio volumio[958]: info: Mar 19 19:55:31 volumio volumio[958]: ---------------------------- MPD announces system playlist update Mar 19 19:55:31 volumio volumio[958]: info: Ignoring MPD Status Update Mar 19 19:55:31 volumio volumio[958]: info: sendMpdCommand status took 8 milliseconds Mar 19 19:55:31 volumio volumio[958]: info: sendMpdCommand clear took 6 milliseconds Mar 19 19:55:31 volumio volumio[958]: info: sendMpdCommand status took 6 milliseconds Mar 19 19:55:31 volumio volumio[958]: info: sendMpdCommand status took 4 milliseconds Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand add "USB/A554-B5A7/2004 - Travis Singles/16 - The Beautiful Occupation.flac" Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:31 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:31 volumio volumio[958]: 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} Mar 19 19:55:31 volumio volumio[958]: verbose: CURRENT POSITION 15 Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::syncState stateService stop Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus stop Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:31 volumio volumio[958]: info: No code Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:31 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:31 volumio volumio[958]: 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} Mar 19 19:55:31 volumio volumio[958]: verbose: CURRENT POSITION 15 Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::syncState stateService stop Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus stop Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:31 volumio volumio[958]: info: No code Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:31 volumio volumio[958]: info: ------------------------------ 82ms Mar 19 19:55:31 volumio volumio[958]: info: ------------------------------ 82ms Mar 19 19:55:31 volumio volumio[958]: info: Mar 19 19:55:31 volumio volumio[958]: ---------------------------- MPD announces system playlist update Mar 19 19:55:31 volumio volumio[958]: info: Ignoring MPD Status Update Mar 19 19:55:31 volumio volumio[958]: info: Mar 19 19:55:31 volumio volumio[958]: ---------------------------- MPD announces system playlist update Mar 19 19:55:31 volumio volumio[958]: info: Ignoring MPD Status Update Mar 19 19:55:31 volumio volumio[958]: error: updateQueue error: null Mar 19 19:55:31 volumio volumio[958]: info: Mar 19 19:55:31 volumio volumio[958]: ---------------------------- MPD announces system playlist update Mar 19 19:55:31 volumio volumio[958]: info: Ignoring MPD Status Update Mar 19 19:55:31 volumio volumio[958]: info: ------------------------------ 91ms Mar 19 19:55:31 volumio volumio[958]: info: sendMpdCommand playlistinfo took 88 milliseconds Mar 19 19:55:31 volumio volumio[958]: info: sendMpdCommand add "USB/A554-B5A7/2004 - Travis Singles/16 - The Beautiful Occupation.flac" took 89 milliseconds Mar 19 19:55:31 volumio volumio[958]: info: ------------------------------ 12ms Mar 19 19:55:31 volumio volumio[958]: info: ------------------------------ 9ms Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand play Mar 19 19:55:31 volumio volumio[958]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 19 19:55:31 volumio volumio[958]: info: ------------------------------ 107ms Mar 19 19:55:31 volumio volumio[958]: info: Mar 19 19:55:31 volumio volumio[958]: ---------------------------- MPD announces system playlist update Mar 19 19:55:31 volumio volumio[958]: info: Ignoring MPD Status Update Mar 19 19:55:31 volumio volumio[958]: info: Mar 19 19:55:31 volumio volumio[958]: ---------------------------- MPD announces system playlist update Mar 19 19:55:31 volumio volumio[958]: info: Ignoring MPD Status Update Mar 19 19:55:31 volumio volumio[958]: info: [GPIO_Control] Status changed: stop Mar 19 19:55:31 volumio volumio[958]: info: [GPIO_Control] Status changed: stop Mar 19 19:55:31 volumio volumio[958]: info: [GPIO_Control] Status changed: stop Mar 19 19:55:31 volumio volumio[958]: info: [GPIO_Control] Status changed: stop Mar 19 19:55:31 volumio volumio[958]: info: [GPIO_Control] Status changed: stop Mar 19 19:55:31 volumio volumio[958]: info: Mar 19 19:55:31 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:31 volumio volumio[958]: info: Mar 19 19:55:31 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:31 volumio volumio[958]: info: ------------------------------ 52ms Mar 19 19:55:31 volumio volumio[958]: info: sendMpdCommand play took 44 milliseconds Mar 19 19:55:31 volumio volumio[958]: info: ------------------------------ 42ms Mar 19 19:55:31 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:31 volumio volumio[958]: info: ------------------------------ 42ms Mar 19 19:55:31 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:31 volumio volumio[958]: info: Mar 19 19:55:31 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:31 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:31 volumio volumio[958]: info: Mar 19 19:55:31 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:31 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:31 volumio volumio[958]: info: sendMpdCommand status took 11 milliseconds Mar 19 19:55:31 volumio volumio[958]: info: sendMpdCommand status took 10 milliseconds Mar 19 19:55:31 volumio volumio[958]: info: sendMpdCommand status took 8 milliseconds Mar 19 19:55:31 volumio volumio[958]: info: sendMpdCommand status took 6 milliseconds Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 19:55:31 volumio volumio[958]: info: Mar 19 19:55:31 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:31 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:31 volumio volumio[958]: info: Mar 19 19:55:31 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:31 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:31 volumio volumio[958]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 19 19:55:31 volumio volumio[958]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 19 19:55:31 volumio volumio[958]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 19 19:55:31 volumio volumio[958]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 19 19:55:31 volumio volumio[958]: info: sendMpdCommand status took 6 milliseconds Mar 19 19:55:31 volumio volumio[958]: info: sendMpdCommand status took 4 milliseconds Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 19:55:31 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:31 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":226,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"856 Kbps","isStreaming":false,"title":"The Beautiful Occupation","artist":"Travis","album":"The Singles","uri":"USB/A554-B5A7/2004 - Travis Singles/16 - The Beautiful Occupation.flac","trackType":"flac"} Mar 19 19:55:31 volumio volumio[958]: verbose: CURRENT POSITION 15 Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus stop Mar 19 19:55:31 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:31 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":226,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"856 Kbps","isStreaming":false,"title":"The Beautiful Occupation","artist":"Travis","album":"The Singles","uri":"USB/A554-B5A7/2004 - Travis Singles/16 - The Beautiful Occupation.flac","trackType":"flac"} Mar 19 19:55:31 volumio volumio[958]: verbose: CURRENT POSITION 15 Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Mar 19 19:55:31 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:31 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:31 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":226,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"856 Kbps","isStreaming":false,"title":"The Beautiful Occupation","artist":"Travis","album":"The Singles","uri":"USB/A554-B5A7/2004 - Travis Singles/16 - The Beautiful Occupation.flac","trackType":"flac"} Mar 19 19:55:31 volumio volumio[958]: verbose: CURRENT POSITION 15 Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Mar 19 19:55:31 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:31 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:31 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":226,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"856 Kbps","isStreaming":false,"title":"The Beautiful Occupation","artist":"Travis","album":"The Singles","uri":"USB/A554-B5A7/2004 - Travis Singles/16 - The Beautiful Occupation.flac","trackType":"flac"} Mar 19 19:55:31 volumio volumio[958]: verbose: CURRENT POSITION 15 Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Mar 19 19:55:31 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:31 volumio volumio[958]: info: ------------------------------ 64ms Mar 19 19:55:31 volumio volumio[958]: info: ------------------------------ 105ms Mar 19 19:55:31 volumio volumio[958]: info: ------------------------------ 101ms Mar 19 19:55:31 volumio volumio[958]: info: ------------------------------ 100ms Mar 19 19:55:31 volumio volumio[958]: info: sendMpdCommand playlistinfo took 80 milliseconds Mar 19 19:55:31 volumio volumio[958]: info: sendMpdCommand playlistinfo took 80 milliseconds Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Mar 19 19:55:31 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Mar 19 19:55:31 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:31 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":226,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"856 Kbps","isStreaming":false,"title":"The Beautiful Occupation","artist":"Travis","album":"The Singles","uri":"USB/A554-B5A7/2004 - Travis Singles/16 - The Beautiful Occupation.flac","trackType":"flac"} Mar 19 19:55:31 volumio volumio[958]: verbose: CURRENT POSITION 15 Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Mar 19 19:55:31 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:31 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:31 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":226,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"856 Kbps","isStreaming":false,"title":"The Beautiful Occupation","artist":"Travis","album":"The Singles","uri":"USB/A554-B5A7/2004 - Travis Singles/16 - The Beautiful Occupation.flac","trackType":"flac"} Mar 19 19:55:31 volumio volumio[958]: verbose: CURRENT POSITION 15 Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Mar 19 19:55:31 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:31 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:31 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:31 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:31 volumio volumio[958]: info: ------------------------------ 135ms Mar 19 19:55:31 volumio volumio[958]: info: ------------------------------ 134ms Mar 19 19:55:31 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:31 volumio volumio[958]: info: [GPIO_Control] Handling event: musicPlay Mar 19 19:55:31 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:31 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:31 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:31 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:31 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:31 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:31 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:31 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:31 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:32 volumio volumio[958]: info: CoreCommandRouter::volumioSeek Mar 19 19:55:32 volumio volumio[958]: info: CoreStateMachine::seek Mar 19 19:55:32 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:32 volumio volumio[958]: info: TRACKBLOCK {"uri":"mnt/USB/A554-B5A7/2004 - Travis Singles/16 - The Beautiful Occupation.flac","service":"mpd","name":"The Beautiful Occupation","artist":"Travis","album":"The Singles","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=61&web=Travis/The%20Singles/extralarge&path=%2FUSB%2FA554-B5A7%2F2004%20-%20Travis%20Singles&metadata=false","duration":226,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"flac","channels":2} Mar 19 19:55:32 volumio volumio[958]: info: CoreStateMachine::startPlaybackTimer Mar 19 19:55:32 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:32 volumio volumio[958]: info: ControllerMpd::seek Mar 19 19:55:32 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:32 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:32 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 19:55:32 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:32 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:32 volumio volumio[958]: error: null Mar 19 19:55:32 volumio volumio[958]: info: Mar 19 19:55:32 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:32 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:32 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:32 volumio volumio[958]: info: Mar 19 19:55:32 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:32 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:32 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:32 volumio volumio[958]: info: Mar 19 19:55:32 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:32 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:32 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:32 volumio volumio[958]: info: sendMpdCommand status took 6 milliseconds Mar 19 19:55:32 volumio volumio[958]: info: sendMpdCommand status took 4 milliseconds Mar 19 19:55:32 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:32 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 19:55:32 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:32 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 19:55:32 volumio volumio[958]: info: sendMpdCommand status took 7 milliseconds Mar 19 19:55:32 volumio volumio[958]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 19 19:55:32 volumio volumio[958]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 19 19:55:32 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:32 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 19:55:32 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Mar 19 19:55:32 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Mar 19 19:55:32 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:32 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:32 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:32 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42000,"duration":226,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1042 Kbps","isStreaming":false,"title":"The Beautiful Occupation","artist":"Travis","album":"The Singles","uri":"USB/A554-B5A7/2004 - Travis Singles/16 - The Beautiful Occupation.flac","trackType":"flac"} Mar 19 19:55:32 volumio volumio[958]: verbose: CURRENT POSITION 15 Mar 19 19:55:32 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Mar 19 19:55:32 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Mar 19 19:55:32 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Mar 19 19:55:32 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:32 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:32 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:32 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:32 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:32 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:32 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:32 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:32 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:32 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42000,"duration":226,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1042 Kbps","isStreaming":false,"title":"The Beautiful Occupation","artist":"Travis","album":"The Singles","uri":"USB/A554-B5A7/2004 - Travis Singles/16 - The Beautiful Occupation.flac","trackType":"flac"} Mar 19 19:55:32 volumio volumio[958]: verbose: CURRENT POSITION 15 Mar 19 19:55:32 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Mar 19 19:55:32 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Mar 19 19:55:32 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Mar 19 19:55:32 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:32 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:32 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:32 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:32 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:32 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:32 volumio volumio[958]: info: ------------------------------ 67ms Mar 19 19:55:32 volumio volumio[958]: info: ------------------------------ 67ms Mar 19 19:55:32 volumio volumio[958]: info: sendMpdCommand playlistinfo took 57 milliseconds Mar 19 19:55:32 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Mar 19 19:55:32 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:32 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:32 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:32 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42114,"duration":226,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"882 Kbps","isStreaming":false,"title":"The Beautiful Occupation","artist":"Travis","album":"The Singles","uri":"USB/A554-B5A7/2004 - Travis Singles/16 - The Beautiful Occupation.flac","trackType":"flac"} Mar 19 19:55:32 volumio volumio[958]: verbose: CURRENT POSITION 15 Mar 19 19:55:32 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Mar 19 19:55:32 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Mar 19 19:55:32 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Mar 19 19:55:32 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:32 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:32 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 19:55:32 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:32 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:32 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:32 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:32 volumio volumio[958]: info: ------------------------------ 96ms Mar 19 19:55:32 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:32 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:32 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:32 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:32 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:32 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:33 volumio volumio[958]: info: CoreCommandRouter::volumioSeek Mar 19 19:55:33 volumio volumio[958]: info: CoreStateMachine::seek Mar 19 19:55:33 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:33 volumio volumio[958]: info: TRACKBLOCK {"uri":"mnt/USB/A554-B5A7/2004 - Travis Singles/16 - The Beautiful Occupation.flac","service":"mpd","name":"The Beautiful Occupation","artist":"Travis","album":"The Singles","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=61&web=Travis/The%20Singles/extralarge&path=%2FUSB%2FA554-B5A7%2F2004%20-%20Travis%20Singles&metadata=false","duration":226,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"flac","channels":2} Mar 19 19:55:33 volumio volumio[958]: info: CoreStateMachine::startPlaybackTimer Mar 19 19:55:33 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:33 volumio volumio[958]: info: ControllerMpd::seek Mar 19 19:55:33 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:33 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:33 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 19:55:33 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:33 volumio volumio[958]: error: null Mar 19 19:55:33 volumio volumio[958]: info: Mar 19 19:55:33 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:33 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:33 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:33 volumio volumio[958]: info: Mar 19 19:55:33 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:33 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:33 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:33 volumio volumio[958]: info: Mar 19 19:55:33 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:33 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:33 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:33 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:33 volumio volumio[958]: info: sendMpdCommand status took 11 milliseconds Mar 19 19:55:33 volumio volumio[958]: info: sendMpdCommand status took 10 milliseconds Mar 19 19:55:33 volumio volumio[958]: info: sendMpdCommand status took 7 milliseconds Mar 19 19:55:33 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:33 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 19:55:33 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:33 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 19:55:33 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:33 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 19:55:33 volumio volumio[958]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 19 19:55:33 volumio volumio[958]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 19 19:55:33 volumio volumio[958]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 19 19:55:33 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Mar 19 19:55:33 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Mar 19 19:55:33 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Mar 19 19:55:33 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:33 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:33 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:33 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":51869,"duration":226,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1076 Kbps","isStreaming":false,"title":"The Beautiful Occupation","artist":"Travis","album":"The Singles","uri":"USB/A554-B5A7/2004 - Travis Singles/16 - The Beautiful Occupation.flac","trackType":"flac"} Mar 19 19:55:33 volumio volumio[958]: verbose: CURRENT POSITION 15 Mar 19 19:55:33 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Mar 19 19:55:33 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Mar 19 19:55:33 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Mar 19 19:55:33 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:33 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:33 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 19:55:33 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:33 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:33 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:33 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:33 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:33 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:33 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:33 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":51869,"duration":226,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1097 Kbps","isStreaming":false,"title":"The Beautiful Occupation","artist":"Travis","album":"The Singles","uri":"USB/A554-B5A7/2004 - Travis Singles/16 - The Beautiful Occupation.flac","trackType":"flac"} Mar 19 19:55:33 volumio volumio[958]: verbose: CURRENT POSITION 15 Mar 19 19:55:33 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Mar 19 19:55:33 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Mar 19 19:55:33 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Mar 19 19:55:33 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:33 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:33 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:33 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:33 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:33 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:33 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:33 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:33 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:33 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":51869,"duration":226,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1097 Kbps","isStreaming":false,"title":"The Beautiful Occupation","artist":"Travis","album":"The Singles","uri":"USB/A554-B5A7/2004 - Travis Singles/16 - The Beautiful Occupation.flac","trackType":"flac"} Mar 19 19:55:33 volumio volumio[958]: verbose: CURRENT POSITION 15 Mar 19 19:55:33 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Mar 19 19:55:33 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Mar 19 19:55:33 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Mar 19 19:55:33 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:33 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:33 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:33 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:33 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:33 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:33 volumio volumio[958]: info: ------------------------------ 98ms Mar 19 19:55:33 volumio volumio[958]: info: ------------------------------ 97ms Mar 19 19:55:33 volumio volumio[958]: info: ------------------------------ 96ms Mar 19 19:55:33 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:33 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:33 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:33 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:33 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:33 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:38 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 19 19:55:38 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:55 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 19 19:55:55 volumio volumio[958]: info: CURURI: music-library/USB/A554-B5A7/Calogero - Amour FLAC Mar 19 19:55:55 volumio volumio[958]: info: Preload queue cleared Mar 19 19:55:55 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/Calogero - Amour FLAC/01 - A.M.O.U.R.flac Mar 19 19:55:55 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/Calogero - Amour FLAC/02 - Donne.flac Mar 19 19:55:55 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/Calogero - Amour FLAC/03 - Juste une chanson.flac Mar 19 19:55:55 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/Calogero - Amour FLAC/04 - La nuit n'est jamais noire.flac Mar 19 19:55:55 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/Calogero - Amour FLAC/05 - Dénouement heureux.flac Mar 19 19:55:55 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/Calogero - Amour FLAC/06 - Derrière ma fenêtre.flac Mar 19 19:55:55 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/Calogero - Amour FLAC/07 - Le hall des départs.flac Mar 19 19:55:55 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/Calogero - Amour FLAC/08 - Rien comme les autres.flac Mar 19 19:55:55 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/Calogero - Amour FLAC/09 - Cache cache.flac Mar 19 19:55:55 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/Calogero - Amour FLAC/10 - Si tu passes par là.flac Mar 19 19:55:55 volumio volumio[958]: info: Preloading song: music-library/USB/A554-B5A7/Calogero - Amour FLAC/11 - Marie.flac Mar 19 19:55:55 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/Calogero - Amour FLAC/01 - A.M.O.U.R.flac in service mpd Mar 19 19:55:55 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Calogero/A.M.O.U.R/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2FCalogero%20-%20Amour%20FLAC%2F01%20-%20A.M.O.U.R.flac&metadata=false Mar 19 19:55:55 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/Calogero - Amour FLAC/01 - A.M.O.U.R.flac Mar 19 19:55:55 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/Calogero - Amour FLAC/02 - Donne.flac in service mpd Mar 19 19:55:55 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Calogero/A.M.O.U.R/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2FCalogero%20-%20Amour%20FLAC%2F02%20-%20Donne.flac&metadata=false Mar 19 19:55:55 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/Calogero - Amour FLAC/02 - Donne.flac Mar 19 19:55:55 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/Calogero - Amour FLAC/03 - Juste une chanson.flac in service mpd Mar 19 19:55:55 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Calogero/A.M.O.U.R/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2FCalogero%20-%20Amour%20FLAC%2F03%20-%20Juste%20une%20chanson.flac&metadata=false Mar 19 19:55:55 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/Calogero - Amour FLAC/03 - Juste une chanson.flac Mar 19 19:55:56 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/Calogero - Amour FLAC/04 - La nuit n'est jamais noire.flac in service mpd Mar 19 19:55:56 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Ga%C3%ABtan%20Roussel/A.M.O.U.R/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2FCalogero%20-%20Amour%20FLAC%2F04%20-%20La%20nuit%20n'est%20jamais%20noire.flac&metadata=false Mar 19 19:55:56 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/Calogero - Amour FLAC/04 - La nuit n'est jamais noire.flac Mar 19 19:55:56 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/Calogero - Amour FLAC/05 - Dénouement heureux.flac in service mpd Mar 19 19:55:56 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Calogero/A.M.O.U.R/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2FCalogero%20-%20Amour%20FLAC%2F05%20-%20D%C3%A9nouement%20heureux.flac&metadata=false Mar 19 19:55:56 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/Calogero - Amour FLAC/05 - Dénouement heureux.flac Mar 19 19:55:56 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/Calogero - Amour FLAC/06 - Derrière ma fenêtre.flac in service mpd Mar 19 19:55:56 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Calogero/A.M.O.U.R/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2FCalogero%20-%20Amour%20FLAC%2F06%20-%20Derri%C3%A8re%20ma%20fen%C3%AAtre.flac&metadata=false Mar 19 19:55:56 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/Calogero - Amour FLAC/06 - Derrière ma fenêtre.flac Mar 19 19:55:56 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/Calogero - Amour FLAC/07 - Le hall des départs.flac in service mpd Mar 19 19:55:56 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Marie%20Poulain/A.M.O.U.R/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2FCalogero%20-%20Amour%20FLAC%2F07%20-%20Le%20hall%20des%20d%C3%A9parts.flac&metadata=false Mar 19 19:55:56 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/Calogero - Amour FLAC/07 - Le hall des départs.flac Mar 19 19:55:56 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/Calogero - Amour FLAC/08 - Rien comme les autres.flac in service mpd Mar 19 19:55:56 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Calogero/A.M.O.U.R/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2FCalogero%20-%20Amour%20FLAC%2F08%20-%20Rien%20comme%20les%20autres.flac&metadata=false Mar 19 19:55:56 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/Calogero - Amour FLAC/08 - Rien comme les autres.flac Mar 19 19:55:56 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/Calogero - Amour FLAC/09 - Cache cache.flac in service mpd Mar 19 19:55:56 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Calogero/A.M.O.U.R/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2FCalogero%20-%20Amour%20FLAC%2F09%20-%20Cache%20cache.flac&metadata=false Mar 19 19:55:56 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/Calogero - Amour FLAC/09 - Cache cache.flac Mar 19 19:55:56 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/Calogero - Amour FLAC/10 - Si tu passes par là.flac in service mpd Mar 19 19:55:56 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Calogero/A.M.O.U.R/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2FCalogero%20-%20Amour%20FLAC%2F10%20-%20Si%20tu%20passes%20par%20l%C3%A0.flac&metadata=false Mar 19 19:55:56 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/Calogero - Amour FLAC/10 - Si tu passes par là.flac Mar 19 19:55:56 volumio volumio[958]: info: Exploding uri music-library/USB/A554-B5A7/Calogero - Amour FLAC/11 - Marie.flac in service mpd Mar 19 19:55:56 volumio volumio[958]: info: ALBUMART /albumart?cacheid=61&web=Calogero/A.M.O.U.R/extralarge&path=%2Fmnt%2FUSB%2FA554-B5A7%2FCalogero%20-%20Amour%20FLAC%2F11%20-%20Marie.flac&metadata=false Mar 19 19:55:56 volumio volumio[958]: info: URI /mnt/USB/A554-B5A7/Calogero - Amour FLAC/11 - Marie.flac Mar 19 19:55:57 volumio volumio[958]: info: Preload queue cleared Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::ClearQueue Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::stop Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::stPlaybackTimer Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::updateTrackBlock Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrackBlock Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::serviceStop Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 15 Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::serviceStop Mar 19 19:55:57 volumio volumio[958]: info: ControllerMpd::stop Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand stop Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::clearPlayQueue Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::saveQueue Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::volumioPushQueue Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::addQueueItems Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::addQueueItems Mar 19 19:55:57 volumio volumio[958]: info: Preload queue cleared Mar 19 19:55:57 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/Calogero - Amour FLAC/01 - A.M.O.U.R.flac Mar 19 19:55:57 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/Calogero - Amour FLAC/01 - A.M.O.U.R.flac Mar 19 19:55:57 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/Calogero - Amour FLAC/02 - Donne.flac Mar 19 19:55:57 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/Calogero - Amour FLAC/02 - Donne.flac Mar 19 19:55:57 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/Calogero - Amour FLAC/03 - Juste une chanson.flac Mar 19 19:55:57 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/Calogero - Amour FLAC/03 - Juste une chanson.flac Mar 19 19:55:57 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/Calogero - Amour FLAC/04 - La nuit n'est jamais noire.flac Mar 19 19:55:57 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/Calogero - Amour FLAC/04 - La nuit n'est jamais noire.flac Mar 19 19:55:57 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/Calogero - Amour FLAC/05 - Dénouement heureux.flac Mar 19 19:55:57 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/Calogero - Amour FLAC/05 - Dénouement heureux.flac Mar 19 19:55:57 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/Calogero - Amour FLAC/06 - Derrière ma fenêtre.flac Mar 19 19:55:57 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/Calogero - Amour FLAC/06 - Derrière ma fenêtre.flac Mar 19 19:55:57 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/Calogero - Amour FLAC/07 - Le hall des départs.flac Mar 19 19:55:57 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/Calogero - Amour FLAC/07 - Le hall des départs.flac Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::volumioPushQueue Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::saveQueue Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::updateTrackBlock Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrackBlock Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::volumioPlay Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::play index 6 Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::addQueueItems Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::addQueueItems Mar 19 19:55:57 volumio volumio[958]: info: Preload queue cleared Mar 19 19:55:57 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/Calogero - Amour FLAC/08 - Rien comme les autres.flac Mar 19 19:55:57 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/Calogero - Amour FLAC/08 - Rien comme les autres.flac Mar 19 19:55:57 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/Calogero - Amour FLAC/09 - Cache cache.flac Mar 19 19:55:57 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/Calogero - Amour FLAC/09 - Cache cache.flac Mar 19 19:55:57 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/Calogero - Amour FLAC/10 - Si tu passes par là.flac Mar 19 19:55:57 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/Calogero - Amour FLAC/10 - Si tu passes par là.flac Mar 19 19:55:57 volumio volumio[958]: info: Adding Item to queue: music-library/USB/A554-B5A7/Calogero - Amour FLAC/11 - Marie.flac Mar 19 19:55:57 volumio volumio[958]: info: Using cached record of: music-library/USB/A554-B5A7/Calogero - Amour FLAC/11 - Marie.flac Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::stop Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::volumioPushQueue Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::saveQueue Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::play index undefined Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::updateTrackBlock Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrackBlock Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::startPlaybackTimer Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::clearAddPlayTracks USB/A554-B5A7/Calogero - Amour FLAC/07 - Le hall des départs.flac Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand stop Mar 19 19:55:57 volumio volumio[958]: info: [GPIO_Control] Status changed: stop Mar 19 19:55:57 volumio volumio[958]: info: [GPIO_Control] Handling event: musicStop Mar 19 19:55:57 volumio volumio[958]: info: Mar 19 19:55:57 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:57 volumio volumio[958]: info: sendMpdCommand stop took 55 milliseconds Mar 19 19:55:57 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:57 volumio volumio[958]: info: sendMpdCommand stop took 12 milliseconds Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand clear Mar 19 19:55:57 volumio volumio[958]: info: Mar 19 19:55:57 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:57 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:57 volumio volumio[958]: info: Mar 19 19:55:57 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:57 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:57 volumio volumio[958]: info: Mar 19 19:55:57 volumio volumio[958]: ---------------------------- MPD announces system playlist update Mar 19 19:55:57 volumio volumio[958]: info: Ignoring MPD Status Update Mar 19 19:55:57 volumio volumio[958]: info: sendMpdCommand status took 10 milliseconds Mar 19 19:55:57 volumio volumio[958]: info: sendMpdCommand clear took 9 milliseconds Mar 19 19:55:57 volumio volumio[958]: info: sendMpdCommand status took 8 milliseconds Mar 19 19:55:57 volumio volumio[958]: info: sendMpdCommand status took 6 milliseconds Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand add "USB/A554-B5A7/Calogero - Amour FLAC/07 - Le hall des départs.flac" Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:57 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:55:57 volumio volumio[958]: 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} Mar 19 19:55:57 volumio volumio[958]: verbose: CURRENT POSITION 6 Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::syncState stateService stop Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus stop Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:57 volumio volumio[958]: info: No code Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:57 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:55:57 volumio volumio[958]: 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} Mar 19 19:55:57 volumio volumio[958]: verbose: CURRENT POSITION 6 Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::syncState stateService stop Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus stop Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:57 volumio volumio[958]: info: No code Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:57 volumio volumio[958]: info: ------------------------------ 79ms Mar 19 19:55:57 volumio volumio[958]: info: ------------------------------ 79ms Mar 19 19:55:57 volumio volumio[958]: info: Mar 19 19:55:57 volumio volumio[958]: ---------------------------- MPD announces system playlist update Mar 19 19:55:57 volumio volumio[958]: info: Ignoring MPD Status Update Mar 19 19:55:57 volumio volumio[958]: info: Mar 19 19:55:57 volumio volumio[958]: ---------------------------- MPD announces system playlist update Mar 19 19:55:57 volumio volumio[958]: info: Ignoring MPD Status Update Mar 19 19:55:57 volumio volumio[958]: error: updateQueue error: null Mar 19 19:55:57 volumio volumio[958]: info: Mar 19 19:55:57 volumio volumio[958]: ---------------------------- MPD announces system playlist update Mar 19 19:55:57 volumio volumio[958]: info: Ignoring MPD Status Update Mar 19 19:55:57 volumio volumio[958]: info: ------------------------------ 82ms Mar 19 19:55:57 volumio volumio[958]: info: sendMpdCommand playlistinfo took 80 milliseconds Mar 19 19:55:57 volumio volumio[958]: info: sendMpdCommand add "USB/A554-B5A7/Calogero - Amour FLAC/07 - Le hall des départs.flac" took 80 milliseconds Mar 19 19:55:57 volumio volumio[958]: info: ------------------------------ 9ms Mar 19 19:55:57 volumio volumio[958]: info: ------------------------------ 8ms Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand play Mar 19 19:55:57 volumio volumio[958]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 19 19:55:57 volumio volumio[958]: info: ------------------------------ 97ms Mar 19 19:55:57 volumio volumio[958]: info: Mar 19 19:55:57 volumio volumio[958]: ---------------------------- MPD announces system playlist update Mar 19 19:55:57 volumio volumio[958]: info: Ignoring MPD Status Update Mar 19 19:55:57 volumio volumio[958]: info: Mar 19 19:55:57 volumio volumio[958]: ---------------------------- MPD announces system playlist update Mar 19 19:55:57 volumio volumio[958]: info: Ignoring MPD Status Update Mar 19 19:55:57 volumio volumio[958]: info: [GPIO_Control] Status changed: stop Mar 19 19:55:57 volumio volumio[958]: info: [GPIO_Control] Status changed: stop Mar 19 19:55:57 volumio volumio[958]: info: [GPIO_Control] Status changed: stop Mar 19 19:55:57 volumio volumio[958]: info: [GPIO_Control] Status changed: stop Mar 19 19:55:57 volumio volumio[958]: info: [GPIO_Control] Status changed: stop Mar 19 19:55:57 volumio volumio[958]: info: [GPIO_Control] Status changed: stop Mar 19 19:55:57 volumio volumio[958]: info: Mar 19 19:55:57 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:57 volumio volumio[958]: info: ------------------------------ 37ms Mar 19 19:55:57 volumio volumio[958]: info: sendMpdCommand play took 33 milliseconds Mar 19 19:55:57 volumio volumio[958]: info: ------------------------------ 32ms Mar 19 19:55:57 volumio volumio[958]: info: ------------------------------ 30ms Mar 19 19:55:57 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:57 volumio volumio[958]: info: Mar 19 19:55:57 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:57 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:57 volumio volumio[958]: info: Mar 19 19:55:57 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:57 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:57 volumio volumio[958]: info: Mar 19 19:55:57 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:57 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:57 volumio volumio[958]: info: sendMpdCommand status took 15 milliseconds Mar 19 19:55:57 volumio volumio[958]: info: sendMpdCommand status took 12 milliseconds Mar 19 19:55:57 volumio volumio[958]: info: sendMpdCommand status took 10 milliseconds Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 19:55:57 volumio volumio[958]: info: Mar 19 19:55:57 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:57 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:57 volumio volumio[958]: info: Mar 19 19:55:57 volumio volumio[958]: ---------------------------- MPD announces state update: player Mar 19 19:55:57 volumio volumio[958]: info: ControllerMpd::getState Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand status Mar 19 19:55:57 volumio volumio[958]: info: sendMpdCommand status took 10 milliseconds Mar 19 19:55:57 volumio volumio[958]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 19 19:55:57 volumio volumio[958]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 19 19:55:57 volumio volumio[958]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 19 19:55:57 volumio volumio[958]: info: sendMpdCommand status took 7 milliseconds Mar 19 19:55:57 volumio volumio[958]: info: sendMpdCommand status took 6 milliseconds Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::parseState Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 19 19:55:57 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:55:57 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":251,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Le hall des départs","artist":"Marie Poulain","album":"A.M.O.U.R","uri":"USB/A554-B5A7/Calogero - Amour FLAC/07 - Le hall des départs.flac","trackType":"flac"} Mar 19 19:55:57 volumio volumio[958]: verbose: CURRENT POSITION 6 Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus stop Mar 19 19:55:57 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:55:57 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":251,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Le hall des départs","artist":"Marie Poulain","album":"A.M.O.U.R","uri":"USB/A554-B5A7/Calogero - Amour FLAC/07 - Le hall des départs.flac","trackType":"flac"} Mar 19 19:55:57 volumio volumio[958]: verbose: CURRENT POSITION 6 Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Mar 19 19:55:57 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:57 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:55:57 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":251,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Le hall des départs","artist":"Marie Poulain","album":"A.M.O.U.R","uri":"USB/A554-B5A7/Calogero - Amour FLAC/07 - Le hall des départs.flac","trackType":"flac"} Mar 19 19:55:57 volumio volumio[958]: verbose: CURRENT POSITION 6 Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Mar 19 19:55:57 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:57 volumio volumio[958]: info: ------------------------------ 69ms Mar 19 19:55:57 volumio volumio[958]: info: ------------------------------ 100ms Mar 19 19:55:57 volumio volumio[958]: info: ------------------------------ 98ms Mar 19 19:55:57 volumio volumio[958]: info: sendMpdCommand playlistinfo took 75 milliseconds Mar 19 19:55:57 volumio volumio[958]: info: sendMpdCommand playlistinfo took 73 milliseconds Mar 19 19:55:57 volumio volumio[958]: info: sendMpdCommand playlistinfo took 73 milliseconds Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Mar 19 19:55:57 volumio volumio[958]: verbose: ControllerMpd::parseTrackInfo Mar 19 19:55:57 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:55:57 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":251,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1367 Kbps","isStreaming":false,"title":"Le hall des départs","artist":"Marie Poulain","album":"A.M.O.U.R","uri":"USB/A554-B5A7/Calogero - Amour FLAC/07 - Le hall des départs.flac","trackType":"flac"} Mar 19 19:55:57 volumio volumio[958]: verbose: CURRENT POSITION 6 Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Mar 19 19:55:57 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:57 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:55:57 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":251,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1517 Kbps","isStreaming":false,"title":"Le hall des départs","artist":"Marie Poulain","album":"A.M.O.U.R","uri":"USB/A554-B5A7/Calogero - Amour FLAC/07 - Le hall des départs.flac","trackType":"flac"} Mar 19 19:55:57 volumio volumio[958]: verbose: CURRENT POSITION 6 Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Mar 19 19:55:57 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:57 volumio volumio[958]: info: ControllerMpd::pushState Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::servicePushState Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:55:57 volumio volumio[958]: verbose: STATE SERVICE {"status":"play","position":0,"seek":986,"duration":251,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1517 Kbps","isStreaming":false,"title":"Le hall des départs","artist":"Marie Poulain","album":"A.M.O.U.R","uri":"USB/A554-B5A7/Calogero - Amour FLAC/07 - Le hall des départs.flac","trackType":"flac"} Mar 19 19:55:57 volumio volumio[958]: verbose: CURRENT POSITION 6 Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::syncState stateService play Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::syncState currentStatus play Mar 19 19:55:57 volumio volumio[958]: info: Received an update from plugin. extracting info from payload Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:57 volumio volumio[958]: info: CoreStateMachine::pushState Mar 19 19:55:57 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:55:57 volumio volumio[958]: info: CoreCommandRouter::volumioPushState Mar 19 19:55:57 volumio volumio[958]: info: ------------------------------ 153ms Mar 19 19:55:57 volumio volumio[958]: info: ------------------------------ 147ms Mar 19 19:55:57 volumio volumio[958]: info: ------------------------------ 147ms Mar 19 19:55:57 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:57 volumio volumio[958]: info: [GPIO_Control] Handling event: musicPlay Mar 19 19:55:57 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:57 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:57 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:57 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:57 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:57 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:57 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:57 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:55:57 volumio volumio[958]: info: [GPIO_Control] Status changed: play Mar 19 19:56:00 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 19 19:56:00 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:56:20 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 19 19:56:20 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 19 19:56:23 volumio volumio[958]: info: CoreCommandRouter::volumioGetState Mar 19 19:56:23 volumio volumio[958]: info: CorePlayQueue::getTrack 6 Mar 19 19:56:35 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: jellyfin , handleBrowseUri Mar 19 19:56:35 volumio volumio[958]: info: [jellyfin-browse] browseUri: jellyfin Mar 19 19:56:35 volumio volumio[958]: info: Preload queue cleared Mar 19 19:56:49 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Mar 19 19:56:49 volumio volumio[958]: info: Preload queue cleared Mar 19 19:56:51 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Mar 19 19:56:51 volumio volumio[958]: info: Preload queue cleared Mar 19 19:56:53 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Mar 19 19:56:53 volumio volumio[958]: info: Preload queue cleared Mar 19 19:56:55 volumio volumio[958]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Mar 19 19:56:55 volumio volumio[958]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 19 19:56:55 volumio volumio[958]: TypeError: Cannot read property 'length' of undefined Mar 19 19:56:55 volumio volumio[958]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Mar 19 19:56:55 volumio volumio[958]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Mar 19 19:56:55 volumio volumio[958]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Mar 19 19:56:55 volumio volumio[958]: at Parser.emit (events.js:315:20) Mar 19 19:56:55 volumio volumio[958]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Mar 19 19:56:55 volumio volumio[958]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Mar 19 19:56:55 volumio volumio[958]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Mar 19 19:56:55 volumio volumio[958]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Mar 19 19:56:55 volumio volumio[958]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Mar 19 19:56:55 volumio volumio[958]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Mar 19 19:56:55 volumio volumio[958]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Mar 19 19:56:55 volumio volumio[958]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Mar 19 19:56:55 volumio volumio[958]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Mar 19 19:56:55 volumio volumio[958]: at IncomingMessage.emit (events.js:327:22) Mar 19 19:56:55 volumio volumio[958]: at endReadableNT (internal/streams/readable.js:1327:12) Mar 19 19:56:55 volumio volumio[958]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Mar 19 19:56:55 volumio volumio[958]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 19 19:56:56 volumio sudo[2295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-19 19:55 Mar 19 19:56:56 volumio sudo[2295]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 11:42:54 AM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4049a67f1c09d4a94e033ba35a80a144"