-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Fri 2024-07-26 13:58:41 CEST. -- Jul 26 13:57:00 volumio volumio[1037]: info: CoreCommandRouter::volumioGetState Jul 26 13:57:00 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:57:18 volumio volumio[1037]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 26 13:57:18 volumio volumio[1037]: info: CURURI: music-library/USB/Elements/Estera/Kiss Jul 26 13:57:19 volumio volumio[1037]: info: Preload queue cleared Jul 26 13:57:20 volumio volumio[1037]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 26 13:57:20 volumio volumio[1037]: info: CURURI: music-library/USB/Elements/Estera/Kiss/Gold CD 1 Jul 26 13:57:20 volumio volumio[1037]: info: Preload queue cleared Jul 26 13:57:20 volumio volumio[1037]: info: Preloading song: music-library/USB/Elements/Estera/Kiss/Gold CD 1/01 Strutter.flac Jul 26 13:57:20 volumio volumio[1037]: info: Preloading song: music-library/USB/Elements/Estera/Kiss/Gold CD 1/02 Nothin' To Lose.flac Jul 26 13:57:20 volumio volumio[1037]: info: Preloading song: music-library/USB/Elements/Estera/Kiss/Gold CD 1/03 Firehouse.flac Jul 26 13:57:20 volumio volumio[1037]: info: Preloading song: music-library/USB/Elements/Estera/Kiss/Gold CD 1/04 Deuce.flac Jul 26 13:57:20 volumio volumio[1037]: info: Preloading song: music-library/USB/Elements/Estera/Kiss/Gold CD 1/05 Black Diamond.flac Jul 26 13:57:20 volumio volumio[1037]: info: Preloading song: music-library/USB/Elements/Estera/Kiss/Gold CD 1/06 Got To Choose.flac Jul 26 13:57:20 volumio volumio[1037]: info: Preloading song: music-library/USB/Elements/Estera/Kiss/Gold CD 1/07 Parasite.flac Jul 26 13:57:20 volumio volumio[1037]: info: Preloading song: music-library/USB/Elements/Estera/Kiss/Gold CD 1/08 Hotter Than Hell.flac Jul 26 13:57:20 volumio volumio[1037]: info: Preloading song: music-library/USB/Elements/Estera/Kiss/Gold CD 1/09 C'Mon And Love Me.flac Jul 26 13:57:20 volumio volumio[1037]: info: Preloading song: music-library/USB/Elements/Estera/Kiss/Gold CD 1/10 She.flac Jul 26 13:57:20 volumio volumio[1037]: info: Preloading song: music-library/USB/Elements/Estera/Kiss/Gold CD 1/11 Anything For My Baby.flac Jul 26 13:57:20 volumio volumio[1037]: info: Preloading song: music-library/USB/Elements/Estera/Kiss/Gold CD 1/12 Rock Bottom (Live).flac Jul 26 13:57:20 volumio volumio[1037]: info: Preloading song: music-library/USB/Elements/Estera/Kiss/Gold CD 1/13 Cold Gin (Live).flac Jul 26 13:57:20 volumio volumio[1037]: info: Preloading song: music-library/USB/Elements/Estera/Kiss/Gold CD 1/14 Rock And Roll All Nite (Live).flac Jul 26 13:57:20 volumio volumio[1037]: info: Preloading song: music-library/USB/Elements/Estera/Kiss/Gold CD 1/15 Let Me Go, Rock 'N Roll (Live).flac Jul 26 13:57:20 volumio volumio[1037]: info: Preloading song: music-library/USB/Elements/Estera/Kiss/Gold CD 1/16 Detroit Rock City.flac Jul 26 13:57:20 volumio volumio[1037]: info: Preloading song: music-library/USB/Elements/Estera/Kiss/Gold CD 1/17 King Of The Night Time World.flac Jul 26 13:57:20 volumio volumio[1037]: info: Preloading song: music-library/USB/Elements/Estera/Kiss/Gold CD 1/18 Shout It Out Loud.flac Jul 26 13:57:20 volumio volumio[1037]: info: Preloading song: music-library/USB/Elements/Estera/Kiss/Gold CD 1/19 Beth.flac Jul 26 13:57:20 volumio volumio[1037]: info: Preloading song: music-library/USB/Elements/Estera/Kiss/Gold CD 1/20 Do You Love Me.flac Jul 26 13:57:20 volumio volumio[1037]: info: Preloading song: music-library/USB/Elements/Estera/Kiss/Gold CD 1/Kiss - 2005 - Gold (Disc 1).m3u Jul 26 13:57:20 volumio volumio[1037]: info: Exploding uri music-library/USB/Elements/Estera/Kiss/Gold CD 1/01 Strutter.flac in service mpd Jul 26 13:57:20 volumio volumio[1037]: info: ALBUMART /albumart?cacheid=264&web=Kiss/2005%20-%20Gold%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FElements%2FEstera%2FKiss%2FGold%20CD%201%2F01%20Strutter.flac&metadata=false Jul 26 13:57:20 volumio volumio[1037]: info: URI /mnt/USB/Elements/Estera/Kiss/Gold CD 1/01 Strutter.flac Jul 26 13:57:20 volumio volumio[1037]: info: Exploding uri music-library/USB/Elements/Estera/Kiss/Gold CD 1/02 Nothin' To Lose.flac in service mpd Jul 26 13:57:20 volumio volumio[1037]: info: ALBUMART /albumart?cacheid=264&web=Kiss/2005%20-%20Gold%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FElements%2FEstera%2FKiss%2FGold%20CD%201%2F02%20Nothin'%20To%20Lose.flac&metadata=false Jul 26 13:57:20 volumio volumio[1037]: info: URI /mnt/USB/Elements/Estera/Kiss/Gold CD 1/02 Nothin' To Lose.flac Jul 26 13:57:20 volumio volumio[1037]: info: Exploding uri music-library/USB/Elements/Estera/Kiss/Gold CD 1/03 Firehouse.flac in service mpd Jul 26 13:57:20 volumio volumio[1037]: info: ALBUMART /albumart?cacheid=264&web=Kiss/2005%20-%20Gold%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FElements%2FEstera%2FKiss%2FGold%20CD%201%2F03%20Firehouse.flac&metadata=false Jul 26 13:57:20 volumio volumio[1037]: info: URI /mnt/USB/Elements/Estera/Kiss/Gold CD 1/03 Firehouse.flac Jul 26 13:57:20 volumio volumio[1037]: info: Exploding uri music-library/USB/Elements/Estera/Kiss/Gold CD 1/04 Deuce.flac in service mpd Jul 26 13:57:20 volumio volumio[1037]: info: ALBUMART /albumart?cacheid=264&web=Kiss/2005%20-%20Gold%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FElements%2FEstera%2FKiss%2FGold%20CD%201%2F04%20Deuce.flac&metadata=false Jul 26 13:57:20 volumio volumio[1037]: info: URI /mnt/USB/Elements/Estera/Kiss/Gold CD 1/04 Deuce.flac Jul 26 13:57:20 volumio volumio[1037]: info: Exploding uri music-library/USB/Elements/Estera/Kiss/Gold CD 1/05 Black Diamond.flac in service mpd Jul 26 13:57:20 volumio volumio[1037]: info: ALBUMART /albumart?cacheid=264&web=Kiss/2005%20-%20Gold%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FElements%2FEstera%2FKiss%2FGold%20CD%201%2F05%20Black%20Diamond.flac&metadata=false Jul 26 13:57:20 volumio volumio[1037]: info: URI /mnt/USB/Elements/Estera/Kiss/Gold CD 1/05 Black Diamond.flac Jul 26 13:57:21 volumio volumio[1037]: info: Exploding uri music-library/USB/Elements/Estera/Kiss/Gold CD 1/06 Got To Choose.flac in service mpd Jul 26 13:57:21 volumio volumio[1037]: info: ALBUMART /albumart?cacheid=264&web=Kiss/2005%20-%20Gold%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FElements%2FEstera%2FKiss%2FGold%20CD%201%2F06%20Got%20To%20Choose.flac&metadata=false Jul 26 13:57:21 volumio volumio[1037]: info: URI /mnt/USB/Elements/Estera/Kiss/Gold CD 1/06 Got To Choose.flac Jul 26 13:57:21 volumio volumio[1037]: info: Exploding uri music-library/USB/Elements/Estera/Kiss/Gold CD 1/07 Parasite.flac in service mpd Jul 26 13:57:21 volumio volumio[1037]: info: ALBUMART /albumart?cacheid=264&web=Kiss/2005%20-%20Gold%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FElements%2FEstera%2FKiss%2FGold%20CD%201%2F07%20Parasite.flac&metadata=false Jul 26 13:57:21 volumio volumio[1037]: info: URI /mnt/USB/Elements/Estera/Kiss/Gold CD 1/07 Parasite.flac Jul 26 13:57:21 volumio volumio[1037]: info: Exploding uri music-library/USB/Elements/Estera/Kiss/Gold CD 1/08 Hotter Than Hell.flac in service mpd Jul 26 13:57:21 volumio volumio[1037]: info: ALBUMART /albumart?cacheid=264&web=Kiss/2005%20-%20Gold%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FElements%2FEstera%2FKiss%2FGold%20CD%201%2F08%20Hotter%20Than%20Hell.flac&metadata=false Jul 26 13:57:21 volumio volumio[1037]: info: URI /mnt/USB/Elements/Estera/Kiss/Gold CD 1/08 Hotter Than Hell.flac Jul 26 13:57:21 volumio volumio[1037]: info: Exploding uri music-library/USB/Elements/Estera/Kiss/Gold CD 1/09 C'Mon And Love Me.flac in service mpd Jul 26 13:57:21 volumio volumio[1037]: info: ALBUMART /albumart?cacheid=264&web=Kiss/2005%20-%20Gold%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FElements%2FEstera%2FKiss%2FGold%20CD%201%2F09%20C'Mon%20And%20Love%20Me.flac&metadata=false Jul 26 13:57:21 volumio volumio[1037]: info: URI /mnt/USB/Elements/Estera/Kiss/Gold CD 1/09 C'Mon And Love Me.flac Jul 26 13:57:21 volumio volumio[1037]: info: Exploding uri music-library/USB/Elements/Estera/Kiss/Gold CD 1/10 She.flac in service mpd Jul 26 13:57:21 volumio volumio[1037]: info: ALBUMART /albumart?cacheid=264&web=Kiss/2005%20-%20Gold%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FElements%2FEstera%2FKiss%2FGold%20CD%201%2F10%20She.flac&metadata=false Jul 26 13:57:21 volumio volumio[1037]: info: URI /mnt/USB/Elements/Estera/Kiss/Gold CD 1/10 She.flac Jul 26 13:57:21 volumio volumio[1037]: info: Exploding uri music-library/USB/Elements/Estera/Kiss/Gold CD 1/11 Anything For My Baby.flac in service mpd Jul 26 13:57:21 volumio volumio[1037]: info: ALBUMART /albumart?cacheid=264&web=Kiss/2005%20-%20Gold%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FElements%2FEstera%2FKiss%2FGold%20CD%201%2F11%20Anything%20For%20My%20Baby.flac&metadata=false Jul 26 13:57:21 volumio volumio[1037]: info: URI /mnt/USB/Elements/Estera/Kiss/Gold CD 1/11 Anything For My Baby.flac Jul 26 13:57:21 volumio volumio[1037]: info: Exploding uri music-library/USB/Elements/Estera/Kiss/Gold CD 1/12 Rock Bottom (Live).flac in service mpd Jul 26 13:57:21 volumio volumio[1037]: info: ALBUMART /albumart?cacheid=264&web=Kiss/2005%20-%20Gold%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FElements%2FEstera%2FKiss%2FGold%20CD%201%2F12%20Rock%20Bottom%20(Live).flac&metadata=false Jul 26 13:57:21 volumio volumio[1037]: info: URI /mnt/USB/Elements/Estera/Kiss/Gold CD 1/12 Rock Bottom (Live).flac Jul 26 13:57:21 volumio volumio[1037]: info: Exploding uri music-library/USB/Elements/Estera/Kiss/Gold CD 1/13 Cold Gin (Live).flac in service mpd Jul 26 13:57:21 volumio volumio[1037]: info: ALBUMART /albumart?cacheid=264&web=Kiss/2005%20-%20Gold%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FElements%2FEstera%2FKiss%2FGold%20CD%201%2F13%20Cold%20Gin%20(Live).flac&metadata=false Jul 26 13:57:21 volumio volumio[1037]: info: URI /mnt/USB/Elements/Estera/Kiss/Gold CD 1/13 Cold Gin (Live).flac Jul 26 13:57:21 volumio volumio[1037]: info: Exploding uri music-library/USB/Elements/Estera/Kiss/Gold CD 1/14 Rock And Roll All Nite (Live).flac in service mpd Jul 26 13:57:21 volumio volumio[1037]: info: ALBUMART /albumart?cacheid=264&web=Kiss/2005%20-%20Gold%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FElements%2FEstera%2FKiss%2FGold%20CD%201%2F14%20Rock%20And%20Roll%20All%20Nite%20(Live).flac&metadata=false Jul 26 13:57:21 volumio volumio[1037]: info: URI /mnt/USB/Elements/Estera/Kiss/Gold CD 1/14 Rock And Roll All Nite (Live).flac Jul 26 13:57:21 volumio volumio[1037]: info: Exploding uri music-library/USB/Elements/Estera/Kiss/Gold CD 1/15 Let Me Go, Rock 'N Roll (Live).flac in service mpd Jul 26 13:57:21 volumio volumio[1037]: info: ALBUMART /albumart?cacheid=264&web=Kiss/2005%20-%20Gold%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FElements%2FEstera%2FKiss%2FGold%20CD%201%2F15%20Let%20Me%20Go%2C%20Rock%20'N%20Roll%20(Live).flac&metadata=false Jul 26 13:57:21 volumio volumio[1037]: info: URI /mnt/USB/Elements/Estera/Kiss/Gold CD 1/15 Let Me Go, Rock 'N Roll (Live).flac Jul 26 13:57:21 volumio volumio[1037]: info: Exploding uri music-library/USB/Elements/Estera/Kiss/Gold CD 1/16 Detroit Rock City.flac in service mpd Jul 26 13:57:21 volumio volumio[1037]: info: ALBUMART /albumart?cacheid=264&web=Kiss/2005%20-%20Gold%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FElements%2FEstera%2FKiss%2FGold%20CD%201%2F16%20Detroit%20Rock%20City.flac&metadata=false Jul 26 13:57:21 volumio volumio[1037]: info: URI /mnt/USB/Elements/Estera/Kiss/Gold CD 1/16 Detroit Rock City.flac Jul 26 13:57:21 volumio volumio[1037]: info: Exploding uri music-library/USB/Elements/Estera/Kiss/Gold CD 1/17 King Of The Night Time World.flac in service mpd Jul 26 13:57:21 volumio volumio[1037]: info: ALBUMART /albumart?cacheid=264&web=Kiss/2005%20-%20Gold%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FElements%2FEstera%2FKiss%2FGold%20CD%201%2F17%20King%20Of%20The%20Night%20Time%20World.flac&metadata=false Jul 26 13:57:21 volumio volumio[1037]: info: URI /mnt/USB/Elements/Estera/Kiss/Gold CD 1/17 King Of The Night Time World.flac Jul 26 13:57:21 volumio volumio[1037]: info: Exploding uri music-library/USB/Elements/Estera/Kiss/Gold CD 1/18 Shout It Out Loud.flac in service mpd Jul 26 13:57:21 volumio volumio[1037]: info: ALBUMART /albumart?cacheid=264&web=Kiss/2005%20-%20Gold%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FElements%2FEstera%2FKiss%2FGold%20CD%201%2F18%20Shout%20It%20Out%20Loud.flac&metadata=false Jul 26 13:57:21 volumio volumio[1037]: info: URI /mnt/USB/Elements/Estera/Kiss/Gold CD 1/18 Shout It Out Loud.flac Jul 26 13:57:21 volumio volumio[1037]: info: Exploding uri music-library/USB/Elements/Estera/Kiss/Gold CD 1/19 Beth.flac in service mpd Jul 26 13:57:21 volumio volumio[1037]: info: ALBUMART /albumart?cacheid=264&web=Kiss/2005%20-%20Gold%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FElements%2FEstera%2FKiss%2FGold%20CD%201%2F19%20Beth.flac&metadata=false Jul 26 13:57:21 volumio volumio[1037]: info: URI /mnt/USB/Elements/Estera/Kiss/Gold CD 1/19 Beth.flac Jul 26 13:57:21 volumio volumio[1037]: info: Exploding uri music-library/USB/Elements/Estera/Kiss/Gold CD 1/20 Do You Love Me.flac in service mpd Jul 26 13:57:21 volumio volumio[1037]: info: ALBUMART /albumart?cacheid=264&web=Kiss/2005%20-%20Gold%20(Disc%201)/extralarge&path=%2Fmnt%2FUSB%2FElements%2FEstera%2FKiss%2FGold%20CD%201%2F20%20Do%20You%20Love%20Me.flac&metadata=false Jul 26 13:57:21 volumio volumio[1037]: info: URI /mnt/USB/Elements/Estera/Kiss/Gold CD 1/20 Do You Love Me.flac Jul 26 13:57:21 volumio volumio[1037]: info: Exploding uri music-library/USB/Elements/Estera/Kiss/Gold CD 1/Kiss - 2005 - Gold (Disc 1).m3u in service mpd Jul 26 13:57:24 volumio volumio[1037]: info: Preload queue cleared Jul 26 13:57:24 volumio volumio[1037]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::ClearQueue Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::stop Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 13:57:24 volumio volumio[1037]: info: CorePlayQueue::clearPlayQueue Jul 26 13:57:24 volumio volumio[1037]: info: CorePlayQueue::saveQueue Jul 26 13:57:24 volumio volumio[1037]: info: CoreCommandRouter::volumioPushQueue Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::addQueueItems Jul 26 13:57:24 volumio volumio[1037]: info: CorePlayQueue::addQueueItems Jul 26 13:57:24 volumio volumio[1037]: info: Preload queue cleared Jul 26 13:57:24 volumio volumio[1037]: info: Adding Item to queue: music-library/USB/Elements/Estera/Kiss/Gold CD 1/01 Strutter.flac Jul 26 13:57:24 volumio volumio[1037]: info: Using cached record of: music-library/USB/Elements/Estera/Kiss/Gold CD 1/01 Strutter.flac Jul 26 13:57:24 volumio volumio[1037]: info: CoreCommandRouter::volumioPushQueue Jul 26 13:57:24 volumio volumio[1037]: info: CorePlayQueue::saveQueue Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::updateTrackBlock Jul 26 13:57:24 volumio volumio[1037]: info: CorePlayQueue::getTrackBlock Jul 26 13:57:24 volumio volumio[1037]: info: CoreCommandRouter::volumioPlay Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::play index 0 Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::stop Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::play index undefined Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 13:57:24 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::startPlaybackTimer Jul 26 13:57:24 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::clearAddPlayTracks USB/Elements/Estera/Kiss/Gold CD 1/01 Strutter.flac Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::sendMpdCommand stop Jul 26 13:57:24 volumio volumio[1037]: info: sendMpdCommand stop took 3 milliseconds Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::sendMpdCommand clear Jul 26 13:57:24 volumio volumio[1037]: info: Jul 26 13:57:24 volumio volumio[1037]: ---------------------------- MPD announces system playlist update Jul 26 13:57:24 volumio volumio[1037]: info: Ignoring MPD Status Update Jul 26 13:57:24 volumio volumio[1037]: info: sendMpdCommand clear took 2 milliseconds Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::sendMpdCommand add "USB/Elements/Estera/Kiss/Gold CD 1/01 Strutter.flac" Jul 26 13:57:24 volumio volumio[1037]: info: Jul 26 13:57:24 volumio volumio[1037]: ---------------------------- MPD announces system playlist update Jul 26 13:57:24 volumio volumio[1037]: info: Ignoring MPD Status Update Jul 26 13:57:24 volumio volumio[1037]: info: Jul 26 13:57:24 volumio volumio[1037]: ---------------------------- MPD announces system playlist update Jul 26 13:57:24 volumio volumio[1037]: info: Ignoring MPD Status Update Jul 26 13:57:24 volumio volumio[1037]: error: updateQueue error: null Jul 26 13:57:24 volumio volumio[1037]: info: Jul 26 13:57:24 volumio volumio[1037]: ---------------------------- MPD announces system playlist update Jul 26 13:57:24 volumio volumio[1037]: info: Ignoring MPD Status Update Jul 26 13:57:24 volumio volumio[1037]: info: ------------------------------ 7ms Jul 26 13:57:24 volumio volumio[1037]: info: sendMpdCommand add "USB/Elements/Estera/Kiss/Gold CD 1/01 Strutter.flac" took 7 milliseconds Jul 26 13:57:24 volumio volumio[1037]: info: ------------------------------ 5ms Jul 26 13:57:24 volumio volumio[1037]: info: ------------------------------ 4ms Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::sendMpdCommand play Jul 26 13:57:24 volumio volumio[1037]: info: Jul 26 13:57:24 volumio volumio[1037]: ---------------------------- MPD announces system playlist update Jul 26 13:57:24 volumio volumio[1037]: info: Ignoring MPD Status Update Jul 26 13:57:24 volumio volumio[1037]: info: Jul 26 13:57:24 volumio volumio[1037]: ---------------------------- MPD announces system playlist update Jul 26 13:57:24 volumio volumio[1037]: info: Ignoring MPD Status Update Jul 26 13:57:24 volumio volumio[1037]: info: ------------------------------ 8ms Jul 26 13:57:24 volumio volumio[1037]: info: sendMpdCommand play took 6 milliseconds Jul 26 13:57:24 volumio volumio[1037]: info: ------------------------------ 5ms Jul 26 13:57:24 volumio volumio[1037]: info: ------------------------------ 3ms Jul 26 13:57:24 volumio volumio[1037]: info: Jul 26 13:57:24 volumio volumio[1037]: ---------------------------- MPD announces state update: player Jul 26 13:57:24 volumio volumio[1037]: info: ControllerMpd::getState Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::sendMpdCommand status Jul 26 13:57:24 volumio volumio[1037]: info: Jul 26 13:57:24 volumio volumio[1037]: ---------------------------- MPD announces state update: player Jul 26 13:57:24 volumio volumio[1037]: info: ControllerMpd::getState Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::sendMpdCommand status Jul 26 13:57:24 volumio volumio[1037]: info: Jul 26 13:57:24 volumio volumio[1037]: ---------------------------- MPD announces state update: player Jul 26 13:57:24 volumio volumio[1037]: info: ControllerMpd::getState Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::sendMpdCommand status Jul 26 13:57:24 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Jul 26 13:57:24 volumio volumio[1037]: info: sendMpdCommand status took 18 milliseconds Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::parseState Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 13:57:24 volumio volumio[1037]: info: Jul 26 13:57:24 volumio volumio[1037]: ---------------------------- MPD announces state update: player Jul 26 13:57:24 volumio volumio[1037]: info: ControllerMpd::getState Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::sendMpdCommand status Jul 26 13:57:24 volumio volumio[1037]: info: sendMpdCommand status took 20 milliseconds Jul 26 13:57:24 volumio volumio[1037]: info: sendMpdCommand status took 18 milliseconds Jul 26 13:57:24 volumio volumio[1037]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::parseState Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::parseState Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::parseTrackInfo Jul 26 13:57:24 volumio volumio[1037]: info: ControllerMpd::pushState Jul 26 13:57:24 volumio volumio[1037]: info: CoreCommandRouter::servicePushState Jul 26 13:57:24 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:57:24 volumio volumio[1037]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Strutter","artist":"Kiss","album":"2005 - Gold (Disc 1)","uri":"USB/Elements/Estera/Kiss/Gold CD 1/01 Strutter.flac","trackType":"flac"} Jul 26 13:57:24 volumio volumio[1037]: verbose: CURRENT POSITION 0 Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::syncState stateService play Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::syncState currentStatus stop Jul 26 13:57:24 volumio volumio[1037]: info: ------------------------------ 34ms Jul 26 13:57:24 volumio volumio[1037]: info: Jul 26 13:57:24 volumio volumio[1037]: ---------------------------- MPD announces state update: player Jul 26 13:57:24 volumio volumio[1037]: info: ControllerMpd::getState Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::sendMpdCommand status Jul 26 13:57:24 volumio volumio[1037]: info: Jul 26 13:57:24 volumio volumio[1037]: ---------------------------- MPD announces state update: player Jul 26 13:57:24 volumio volumio[1037]: info: ControllerMpd::getState Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::sendMpdCommand status Jul 26 13:57:24 volumio volumio[1037]: info: sendMpdCommand status took 18 milliseconds Jul 26 13:57:24 volumio volumio[1037]: info: sendMpdCommand playlistinfo took 14 milliseconds Jul 26 13:57:24 volumio volumio[1037]: info: sendMpdCommand playlistinfo took 14 milliseconds Jul 26 13:57:24 volumio volumio[1037]: info: sendMpdCommand status took 7 milliseconds Jul 26 13:57:24 volumio volumio[1037]: info: sendMpdCommand status took 4 milliseconds Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::parseState Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::parseTrackInfo Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::parseTrackInfo Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::parseState Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::parseState Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 13:57:24 volumio volumio[1037]: info: ControllerMpd::pushState Jul 26 13:57:24 volumio volumio[1037]: info: CoreCommandRouter::servicePushState Jul 26 13:57:24 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:57:24 volumio volumio[1037]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1029 Kbps","isStreaming":false,"title":"Strutter","artist":"Kiss","album":"2005 - Gold (Disc 1)","uri":"USB/Elements/Estera/Kiss/Gold CD 1/01 Strutter.flac","trackType":"flac"} Jul 26 13:57:24 volumio volumio[1037]: verbose: CURRENT POSITION 0 Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::syncState stateService play Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::syncState currentStatus play Jul 26 13:57:24 volumio volumio[1037]: info: Received an update from plugin. extracting info from payload Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::pushState Jul 26 13:57:24 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:57:24 volumio volumio[1037]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 13:57:24 volumio volumio[1037]: info: CoreCommandRouter::volumioPushState Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::pushState Jul 26 13:57:24 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:57:24 volumio volumio[1037]: info: CoreCommandRouter::volumioPushState Jul 26 13:57:24 volumio volumio[1037]: info: ControllerMpd::pushState Jul 26 13:57:24 volumio volumio[1037]: info: CoreCommandRouter::servicePushState Jul 26 13:57:24 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:57:24 volumio volumio[1037]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1055 Kbps","isStreaming":false,"title":"Strutter","artist":"Kiss","album":"2005 - Gold (Disc 1)","uri":"USB/Elements/Estera/Kiss/Gold CD 1/01 Strutter.flac","trackType":"flac"} Jul 26 13:57:24 volumio volumio[1037]: verbose: CURRENT POSITION 0 Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::syncState stateService play Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::syncState currentStatus play Jul 26 13:57:24 volumio volumio[1037]: info: Received an update from plugin. extracting info from payload Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::pushState Jul 26 13:57:24 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:57:24 volumio volumio[1037]: info: CoreCommandRouter::volumioPushState Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::pushState Jul 26 13:57:24 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:57:24 volumio volumio[1037]: info: CoreCommandRouter::volumioPushState Jul 26 13:57:24 volumio volumio[1037]: info: ------------------------------ 102ms Jul 26 13:57:24 volumio volumio[1037]: info: ------------------------------ 100ms Jul 26 13:57:24 volumio volumio[1037]: info: sendMpdCommand playlistinfo took 63 milliseconds Jul 26 13:57:24 volumio volumio[1037]: info: sendMpdCommand playlistinfo took 61 milliseconds Jul 26 13:57:24 volumio volumio[1037]: info: sendMpdCommand playlistinfo took 61 milliseconds Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::parseTrackInfo Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::parseTrackInfo Jul 26 13:57:24 volumio volumio[1037]: verbose: ControllerMpd::parseTrackInfo Jul 26 13:57:24 volumio volumio[1037]: info: ControllerMpd::pushState Jul 26 13:57:24 volumio volumio[1037]: info: CoreCommandRouter::servicePushState Jul 26 13:57:24 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:57:24 volumio volumio[1037]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1055 Kbps","isStreaming":false,"title":"Strutter","artist":"Kiss","album":"2005 - Gold (Disc 1)","uri":"USB/Elements/Estera/Kiss/Gold CD 1/01 Strutter.flac","trackType":"flac"} Jul 26 13:57:24 volumio volumio[1037]: verbose: CURRENT POSITION 0 Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::syncState stateService play Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::syncState currentStatus play Jul 26 13:57:24 volumio volumio[1037]: info: Received an update from plugin. extracting info from payload Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::pushState Jul 26 13:57:24 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:57:24 volumio volumio[1037]: info: CoreCommandRouter::volumioPushState Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::pushState Jul 26 13:57:24 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:57:24 volumio volumio[1037]: info: CoreCommandRouter::volumioPushState Jul 26 13:57:24 volumio volumio[1037]: info: ControllerMpd::pushState Jul 26 13:57:24 volumio volumio[1037]: info: CoreCommandRouter::servicePushState Jul 26 13:57:24 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:57:24 volumio volumio[1037]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1055 Kbps","isStreaming":false,"title":"Strutter","artist":"Kiss","album":"2005 - Gold (Disc 1)","uri":"USB/Elements/Estera/Kiss/Gold CD 1/01 Strutter.flac","trackType":"flac"} Jul 26 13:57:24 volumio volumio[1037]: verbose: CURRENT POSITION 0 Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::syncState stateService play Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::syncState currentStatus play Jul 26 13:57:24 volumio volumio[1037]: info: Received an update from plugin. extracting info from payload Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::pushState Jul 26 13:57:24 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:57:24 volumio volumio[1037]: info: CoreCommandRouter::volumioPushState Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::pushState Jul 26 13:57:24 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:57:24 volumio volumio[1037]: info: CoreCommandRouter::volumioPushState Jul 26 13:57:24 volumio volumio[1037]: info: ControllerMpd::pushState Jul 26 13:57:24 volumio volumio[1037]: info: CoreCommandRouter::servicePushState Jul 26 13:57:24 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:57:24 volumio volumio[1037]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":192,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1055 Kbps","isStreaming":false,"title":"Strutter","artist":"Kiss","album":"2005 - Gold (Disc 1)","uri":"USB/Elements/Estera/Kiss/Gold CD 1/01 Strutter.flac","trackType":"flac"} Jul 26 13:57:24 volumio volumio[1037]: verbose: CURRENT POSITION 0 Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::syncState stateService play Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::syncState currentStatus play Jul 26 13:57:24 volumio volumio[1037]: info: Received an update from plugin. extracting info from payload Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::pushState Jul 26 13:57:24 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:57:24 volumio volumio[1037]: info: CoreCommandRouter::volumioPushState Jul 26 13:57:24 volumio volumio[1037]: info: CoreStateMachine::pushState Jul 26 13:57:24 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:57:24 volumio volumio[1037]: info: CoreCommandRouter::volumioPushState Jul 26 13:57:24 volumio volumio[1037]: info: ------------------------------ 143ms Jul 26 13:57:24 volumio volumio[1037]: info: ------------------------------ 132ms Jul 26 13:57:24 volumio volumio[1037]: info: ------------------------------ 130ms Jul 26 13:57:29 volumio volumio[1037]: info: CoreCommandRouter::volumioGetState Jul 26 13:57:29 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:57:46 volumio volumio[1037]: info: VolumeController::SetAlsaVolume78 Jul 26 13:57:46 volumio volumio[1037]: info: CoreStateMachine::pushState Jul 26 13:57:46 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:57:46 volumio volumio[1037]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 13:57:46 volumio volumio[1037]: info: CoreCommandRouter::volumioPushState Jul 26 13:57:48 volumio volumio[1037]: info: VolumeController::SetAlsaVolume12 Jul 26 13:57:48 volumio volumio[1037]: info: CoreStateMachine::pushState Jul 26 13:57:48 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:57:48 volumio volumio[1037]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 13:57:48 volumio volumio[1037]: info: CoreCommandRouter::volumioPushState Jul 26 13:57:50 volumio volumio[1037]: info: VolumeController::SetAlsaVolume100 Jul 26 13:57:50 volumio volumio[1037]: info: CoreStateMachine::pushState Jul 26 13:57:50 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:57:50 volumio volumio[1037]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 13:57:50 volumio volumio[1037]: info: CoreCommandRouter::volumioPushState Jul 26 13:58:28 volumio volumio[1037]: info: CoreCommandRouter::volumioClearQueue Jul 26 13:58:28 volumio volumio[1037]: info: CoreStateMachine::ClearQueue Jul 26 13:58:28 volumio volumio[1037]: info: CoreStateMachine::stop Jul 26 13:58:28 volumio volumio[1037]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 13:58:28 volumio volumio[1037]: info: CoreStateMachine::stPlaybackTimer Jul 26 13:58:28 volumio volumio[1037]: info: CoreStateMachine::updateTrackBlock Jul 26 13:58:28 volumio volumio[1037]: info: CorePlayQueue::getTrackBlock Jul 26 13:58:28 volumio volumio[1037]: info: CoreStateMachine::pushState Jul 26 13:58:28 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:58:28 volumio volumio[1037]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 13:58:28 volumio volumio[1037]: info: CoreCommandRouter::volumioPushState Jul 26 13:58:28 volumio volumio[1037]: info: CoreStateMachine::serviceStop Jul 26 13:58:28 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:58:28 volumio volumio[1037]: info: CoreCommandRouter::serviceStop Jul 26 13:58:28 volumio volumio[1037]: info: ControllerMpd::stop Jul 26 13:58:28 volumio volumio[1037]: verbose: ControllerMpd::sendMpdCommand stop Jul 26 13:58:28 volumio volumio[1037]: info: CorePlayQueue::clearPlayQueue Jul 26 13:58:28 volumio volumio[1037]: info: CorePlayQueue::saveQueue Jul 26 13:58:28 volumio volumio[1037]: info: CoreCommandRouter::volumioPushState Jul 26 13:58:28 volumio volumio[1037]: info: CoreCommandRouter::volumioPushQueue Jul 26 13:58:28 volumio volumio[1037]: info: sendMpdCommand stop took 21 milliseconds Jul 26 13:58:28 volumio volumio[1037]: info: Jul 26 13:58:28 volumio volumio[1037]: ---------------------------- MPD announces state update: player Jul 26 13:58:28 volumio volumio[1037]: info: ControllerMpd::getState Jul 26 13:58:28 volumio volumio[1037]: verbose: ControllerMpd::sendMpdCommand status Jul 26 13:58:28 volumio volumio[1037]: info: Jul 26 13:58:28 volumio volumio[1037]: ---------------------------- MPD announces state update: player Jul 26 13:58:28 volumio volumio[1037]: info: ControllerMpd::getState Jul 26 13:58:28 volumio volumio[1037]: verbose: ControllerMpd::sendMpdCommand status Jul 26 13:58:28 volumio volumio[1037]: info: Jul 26 13:58:28 volumio volumio[1037]: ---------------------------- MPD announces state update: player Jul 26 13:58:28 volumio volumio[1037]: info: ControllerMpd::getState Jul 26 13:58:28 volumio volumio[1037]: verbose: ControllerMpd::sendMpdCommand status Jul 26 13:58:28 volumio volumio[1037]: info: sendMpdCommand status took 5 milliseconds Jul 26 13:58:28 volumio volumio[1037]: info: sendMpdCommand status took 3 milliseconds Jul 26 13:58:28 volumio volumio[1037]: info: sendMpdCommand status took 2 milliseconds Jul 26 13:58:28 volumio volumio[1037]: verbose: ControllerMpd::parseState Jul 26 13:58:28 volumio volumio[1037]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 13:58:28 volumio volumio[1037]: verbose: ControllerMpd::parseState Jul 26 13:58:28 volumio volumio[1037]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 13:58:28 volumio volumio[1037]: verbose: ControllerMpd::parseState Jul 26 13:58:28 volumio volumio[1037]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 13:58:28 volumio volumio[1037]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 26 13:58:28 volumio volumio[1037]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 26 13:58:28 volumio volumio[1037]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 26 13:58:28 volumio volumio[1037]: verbose: ControllerMpd::parseTrackInfo Jul 26 13:58:28 volumio volumio[1037]: verbose: ControllerMpd::parseTrackInfo Jul 26 13:58:28 volumio volumio[1037]: verbose: ControllerMpd::parseTrackInfo Jul 26 13:58:28 volumio volumio[1037]: info: ControllerMpd::pushState Jul 26 13:58:28 volumio volumio[1037]: info: CoreCommandRouter::servicePushState Jul 26 13:58:28 volumio volumio[1037]: info: CoreStateMachine::pushState Jul 26 13:58:28 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:58:28 volumio volumio[1037]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 13:58:28 volumio volumio[1037]: info: CoreCommandRouter::volumioPushState Jul 26 13:58:28 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:58:28 volumio volumio[1037]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Strutter","artist":"Kiss","album":"2005 - Gold (Disc 1)","uri":"USB/Elements/Estera/Kiss/Gold CD 1/01 Strutter.flac","trackType":"flac"} Jul 26 13:58:28 volumio volumio[1037]: verbose: CURRENT POSITION 0 Jul 26 13:58:28 volumio volumio[1037]: info: CoreStateMachine::syncState stateService stop Jul 26 13:58:28 volumio volumio[1037]: info: CoreStateMachine::syncState currentStatus stop Jul 26 13:58:28 volumio volumio[1037]: info: CoreStateMachine::pushState Jul 26 13:58:28 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:58:28 volumio volumio[1037]: info: CoreCommandRouter::volumioPushState Jul 26 13:58:28 volumio volumio[1037]: info: No code Jul 26 13:58:28 volumio volumio[1037]: info: CoreStateMachine::pushState Jul 26 13:58:28 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:58:28 volumio volumio[1037]: info: CoreCommandRouter::volumioPushState Jul 26 13:58:28 volumio volumio[1037]: info: ControllerMpd::pushState Jul 26 13:58:28 volumio volumio[1037]: info: CoreCommandRouter::servicePushState Jul 26 13:58:28 volumio volumio[1037]: info: CoreStateMachine::pushState Jul 26 13:58:28 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:58:28 volumio volumio[1037]: info: CoreCommandRouter::volumioPushState Jul 26 13:58:28 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:58:28 volumio volumio[1037]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Strutter","artist":"Kiss","album":"2005 - Gold (Disc 1)","uri":"USB/Elements/Estera/Kiss/Gold CD 1/01 Strutter.flac","trackType":"flac"} Jul 26 13:58:28 volumio volumio[1037]: verbose: CURRENT POSITION 0 Jul 26 13:58:28 volumio volumio[1037]: info: CoreStateMachine::syncState stateService stop Jul 26 13:58:28 volumio volumio[1037]: info: CoreStateMachine::syncState currentStatus stop Jul 26 13:58:28 volumio volumio[1037]: info: CoreStateMachine::pushState Jul 26 13:58:28 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:58:28 volumio volumio[1037]: info: CoreCommandRouter::volumioPushState Jul 26 13:58:28 volumio volumio[1037]: info: No code Jul 26 13:58:28 volumio volumio[1037]: info: CoreStateMachine::pushState Jul 26 13:58:28 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:58:28 volumio volumio[1037]: info: CoreCommandRouter::volumioPushState Jul 26 13:58:28 volumio volumio[1037]: info: ControllerMpd::pushState Jul 26 13:58:28 volumio volumio[1037]: info: CoreCommandRouter::servicePushState Jul 26 13:58:28 volumio volumio[1037]: info: CoreStateMachine::pushState Jul 26 13:58:28 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:58:28 volumio volumio[1037]: info: CoreCommandRouter::volumioPushState Jul 26 13:58:28 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:58:28 volumio volumio[1037]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Strutter","artist":"Kiss","album":"2005 - Gold (Disc 1)","uri":"USB/Elements/Estera/Kiss/Gold CD 1/01 Strutter.flac","trackType":"flac"} Jul 26 13:58:28 volumio volumio[1037]: verbose: CURRENT POSITION 0 Jul 26 13:58:28 volumio volumio[1037]: info: CoreStateMachine::syncState stateService stop Jul 26 13:58:28 volumio volumio[1037]: info: CoreStateMachine::syncState currentStatus stop Jul 26 13:58:28 volumio volumio[1037]: info: CoreStateMachine::pushState Jul 26 13:58:28 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:58:28 volumio volumio[1037]: info: CoreCommandRouter::volumioPushState Jul 26 13:58:28 volumio volumio[1037]: info: No code Jul 26 13:58:28 volumio volumio[1037]: info: CoreStateMachine::pushState Jul 26 13:58:28 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:58:28 volumio volumio[1037]: info: CoreCommandRouter::volumioPushState Jul 26 13:58:28 volumio volumio[1037]: info: ------------------------------ 109ms Jul 26 13:58:28 volumio volumio[1037]: info: ------------------------------ 107ms Jul 26 13:58:28 volumio volumio[1037]: info: ------------------------------ 107ms Jul 26 13:58:31 volumio volumio[1037]: info: CoreCommandRouter::volumioGetState Jul 26 13:58:31 volumio volumio[1037]: info: CorePlayQueue::getTrack 0 Jul 26 13:58:38 volumio volumio[1037]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 26 13:58:38 volumio volumio[1037]: info: CURURI: music-library/USB/Elements/Estera/Genesis Jul 26 13:58:38 volumio volumio[1037]: info: Preload queue cleared Jul 26 13:58:40 volumio volumio[1037]: info: Preload queue cleared Jul 26 13:58:40 volumio volumio[1037]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 26 13:58:40 volumio volumio[1037]: info: CoreStateMachine::ClearQueue Jul 26 13:58:40 volumio volumio[1037]: info: CoreStateMachine::stop Jul 26 13:58:40 volumio volumio[1037]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 13:58:40 volumio volumio[1037]: info: CorePlayQueue::clearPlayQueue Jul 26 13:58:40 volumio volumio[1037]: info: CorePlayQueue::saveQueue Jul 26 13:58:40 volumio volumio[1037]: info: CoreCommandRouter::volumioPushQueue Jul 26 13:58:40 volumio volumio[1037]: info: CoreStateMachine::addQueueItems Jul 26 13:58:40 volumio volumio[1037]: info: CorePlayQueue::addQueueItems Jul 26 13:58:40 volumio volumio[1037]: info: Preload queue cleared Jul 26 13:58:40 volumio volumio[1037]: info: Adding Item to queue: music-library/USB/Elements/Estera/Genesis/A Trick Of The Tail (1976) Jul 26 13:58:40 volumio volumio[1037]: info: Exploding uri music-library/USB/Elements/Estera/Genesis/A Trick Of The Tail (1976) in service mpd Jul 26 13:58:41 volumio volumio[1037]: info: ALBUMART /albumart?cacheid=264&web=/A%20Trick%20of%20The%20Tail/extralarge&path=%2Fmnt%2FUSB%2FElements%2FEstera%2FGenesis%2FA%20Trick%20Of%20The%20Tail%20(1976)%2FGenesis%20-%20A%20Trick%20of%20The%20Tail.cue&metadata=false Jul 26 13:58:41 volumio volumio[1037]: info: URI /mnt/USB/Elements/Estera/Genesis/A Trick Of The Tail (1976)/Genesis - A Trick of The Tail.cue Jul 26 13:58:41 volumio volumio[1037]: info: ALBUMART /albumart?cacheid=264&web=/A%20Trick%20of%20The%20Tail/extralarge&path=%2Fmnt%2FUSB%2FElements%2FEstera%2FGenesis%2FA%20Trick%20Of%20The%20Tail%20(1976)%2FGenesis%20-%20A%20Trick%20of%20The%20Tail.cue&metadata=false Jul 26 13:58:41 volumio volumio[1037]: info: URI /mnt/USB/Elements/Estera/Genesis/A Trick Of The Tail (1976)/Genesis - A Trick of The Tail.cue Jul 26 13:58:41 volumio volumio[1037]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 26 13:58:41 volumio volumio[1037]: Error: Unable to resolve or reject the same promise twice Jul 26 13:58:41 volumio volumio[1037]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jul 26 13:58:41 volumio volumio[1037]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Jul 26 13:58:41 volumio volumio[1037]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Jul 26 13:58:41 volumio volumio[1037]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Jul 26 13:58:41 volumio volumio[1037]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Jul 26 13:58:41 volumio volumio[1037]: at Socket.emit (events.js:315:20) Jul 26 13:58:41 volumio volumio[1037]: at addChunk (internal/streams/readable.js:309:12) Jul 26 13:58:41 volumio volumio[1037]: at readableAddChunk (internal/streams/readable.js:280:11) Jul 26 13:58:41 volumio volumio[1037]: at Socket.Readable.push (internal/streams/readable.js:223:10) Jul 26 13:58:41 volumio volumio[1037]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Jul 26 13:58:41 volumio volumio[1037]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 26 13:58:41 volumio sudo[1970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-26 13:57 Jul 26 13:58:41 volumio sudo[1970]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"