-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Sat 2024-07-20 03:52:11 UTC. -- Jul 20 03:51:01 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 20 03:51:01 volumio volumio[922]: info: CURURI: music-library/USB/0E93-C36B/NAVERMUSIC_20200823 Jul 20 03:51:01 volumio volumio[922]: info: Preload queue cleared Jul 20 03:51:01 volumio volumio[922]: info: Preloading song: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/나윤선-1-In My Heart.mp3 Jul 20 03:51:01 volumio volumio[922]: info: Preloading song: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Leona Lewis, LeAnn Rimes, Ashanti, Rihanna, Mar-1-Just Stand Up.mp3 Jul 20 03:51:01 volumio volumio[922]: info: Preloading song: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Imelda May-1-Call Me.mp3 Jul 20 03:51:01 volumio volumio[922]: info: Preloading song: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Joan Baez-8-Donna Donna.mp3 Jul 20 03:51:01 volumio volumio[922]: info: Preloading song: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Malibu.mp3 Jul 20 03:51:01 volumio volumio[922]: info: Preloading song: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Maroon 5-1-Memories.mp3 Jul 20 03:51:01 volumio volumio[922]: info: Preloading song: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Party In The U.S.A..mp3 Jul 20 03:51:01 volumio volumio[922]: info: Preloading song: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/John Denver-3-Take Me Home, Country Roads (Remastered).mp3 Jul 20 03:51:01 volumio volumio[922]: info: Preloading song: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Wrecking Ball.mp3 Jul 20 03:51:01 volumio volumio[922]: info: Preloading song: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/김태현-1-눈물이 펑펑.mp3 Jul 20 03:51:01 volumio volumio[922]: info: Exploding uri music-library/USB/0E93-C36B/NAVERMUSIC_20200823/나윤선-1-In My Heart.mp3 in service mpd Jul 20 03:51:01 volumio volumio[922]: info: ALBUMART /albumart?cacheid=513&web=//extralarge&path=%2Fmnt%2FUSB%2F0E93-C36B%2FNAVERMUSIC_20200823%2F%EB%82%98%EC%9C%A4%EC%84%A0-1-In%20My%20Heart.mp3&metadata=false Jul 20 03:51:01 volumio volumio[922]: info: URI /mnt/USB/0E93-C36B/NAVERMUSIC_20200823/나윤선-1-In My Heart.mp3 Jul 20 03:51:01 volumio volumio[922]: info: Exploding uri music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Leona Lewis, LeAnn Rimes, Ashanti, Rihanna, Mar-1-Just Stand Up.mp3 in service mpd Jul 20 03:51:01 volumio volumio[922]: info: ALBUMART /albumart?cacheid=513&web=Leona%20Lewis%2CLeAnn%20Rimes%2CAshanti%2CRihanna%2CMariah%20Carey%2CMelissa%20Etheridge%2CBeyonce%2CKeyshia%20Cole%2CFergie%2CNatasha%20Bedingfield%2CCarrie%20Underwood%2CMary%20J.%20Blige%2CSheryl%20Crow%2CCiara%2CMiley%20Cyrus/JUST%20STAND%20UP!/extralarge&path=%2Fmnt%2FUSB%2F0E93-C36B%2FNAVERMUSIC_20200823%2FLeona%20Lewis%2C%20LeAnn%20Rimes%2C%20Ashanti%2C%20Rihanna%2C%20Mar-1-Just%20Stand%20Up.mp3&metadata=false Jul 20 03:51:01 volumio volumio[922]: info: URI /mnt/USB/0E93-C36B/NAVERMUSIC_20200823/Leona Lewis, LeAnn Rimes, Ashanti, Rihanna, Mar-1-Just Stand Up.mp3 Jul 20 03:51:01 volumio volumio[922]: info: Exploding uri music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Imelda May-1-Call Me.mp3 in service mpd Jul 20 03:51:01 volumio volumio[922]: info: ALBUMART /albumart?cacheid=513&web=Imelda%20May/Life%20Love%20Flesh%20Blood%20(Deluxe)/extralarge&path=%2Fmnt%2FUSB%2F0E93-C36B%2FNAVERMUSIC_20200823%2FImelda%20May-1-Call%20Me.mp3&metadata=false Jul 20 03:51:01 volumio volumio[922]: info: URI /mnt/USB/0E93-C36B/NAVERMUSIC_20200823/Imelda May-1-Call Me.mp3 Jul 20 03:51:01 volumio volumio[922]: info: Exploding uri music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Joan Baez-8-Donna Donna.mp3 in service mpd Jul 20 03:51:01 volumio volumio[922]: info: ALBUMART /albumart?cacheid=513&web=Joan%20Baez/LP%EC%8B%9C%EC%A0%88%20%EC%B6%94%EC%96%B5%EC%9D%98%20%ED%9E%88%ED%8A%B8%20%ED%8C%9D%EC%86%A1/extralarge&path=%2Fmnt%2FUSB%2F0E93-C36B%2FNAVERMUSIC_20200823%2FJoan%20Baez-8-Donna%20Donna.mp3&metadata=false Jul 20 03:51:01 volumio volumio[922]: info: URI /mnt/USB/0E93-C36B/NAVERMUSIC_20200823/Joan Baez-8-Donna Donna.mp3 Jul 20 03:51:01 volumio volumio[922]: info: Exploding uri music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Malibu.mp3 in service mpd Jul 20 03:51:01 volumio volumio[922]: info: ALBUMART /albumart?cacheid=513&web=Miley%20Cyrus/Malibu/extralarge&path=%2Fmnt%2FUSB%2F0E93-C36B%2FNAVERMUSIC_20200823%2FMiley%20Cyrus-1-Malibu.mp3&metadata=false Jul 20 03:51:01 volumio volumio[922]: info: URI /mnt/USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Malibu.mp3 Jul 20 03:51:01 volumio volumio[922]: info: Exploding uri music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Maroon 5-1-Memories.mp3 in service mpd Jul 20 03:51:01 volumio volumio[922]: info: ALBUMART /albumart?cacheid=513&web=Maroon%205/Memories/extralarge&path=%2Fmnt%2FUSB%2F0E93-C36B%2FNAVERMUSIC_20200823%2FMaroon%205-1-Memories.mp3&metadata=false Jul 20 03:51:01 volumio volumio[922]: info: URI /mnt/USB/0E93-C36B/NAVERMUSIC_20200823/Maroon 5-1-Memories.mp3 Jul 20 03:51:01 volumio volumio[922]: info: Exploding uri music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Party In The U.S.A..mp3 in service mpd Jul 20 03:51:01 volumio volumio[922]: info: ALBUMART /albumart?cacheid=513&web=Miley%20Cyrus/Party%20In%20The%20U.S.A./extralarge&path=%2Fmnt%2FUSB%2F0E93-C36B%2FNAVERMUSIC_20200823%2FMiley%20Cyrus-1-Party%20In%20The%20U.S.A..mp3&metadata=false Jul 20 03:51:01 volumio volumio[922]: info: URI /mnt/USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Party In The U.S.A..mp3 Jul 20 03:51:01 volumio volumio[922]: info: Exploding uri music-library/USB/0E93-C36B/NAVERMUSIC_20200823/John Denver-3-Take Me Home, Country Roads (Remastered).mp3 in service mpd Jul 20 03:51:01 volumio volumio[922]: info: ALBUMART /albumart?cacheid=513&web=John%20Denver/The%20Essential%20John%20Denver/extralarge&path=%2Fmnt%2FUSB%2F0E93-C36B%2FNAVERMUSIC_20200823%2FJohn%20Denver-3-Take%20Me%20Home%2C%20Country%20Roads%20(Remastered).mp3&metadata=false Jul 20 03:51:01 volumio volumio[922]: info: URI /mnt/USB/0E93-C36B/NAVERMUSIC_20200823/John Denver-3-Take Me Home, Country Roads (Remastered).mp3 Jul 20 03:51:02 volumio volumio[922]: info: Exploding uri music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Wrecking Ball.mp3 in service mpd Jul 20 03:51:02 volumio volumio[922]: info: ALBUMART /albumart?cacheid=513&web=Miley%20Cyrus/Wrecking%20Ball/extralarge&path=%2Fmnt%2FUSB%2F0E93-C36B%2FNAVERMUSIC_20200823%2FMiley%20Cyrus-1-Wrecking%20Ball.mp3&metadata=false Jul 20 03:51:02 volumio volumio[922]: info: URI /mnt/USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Wrecking Ball.mp3 Jul 20 03:51:02 volumio volumio[922]: info: Exploding uri music-library/USB/0E93-C36B/NAVERMUSIC_20200823/김태현-1-눈물이 펑펑.mp3 in service mpd Jul 20 03:51:02 volumio volumio[922]: info: ALBUMART /albumart?cacheid=513&web=%EA%B9%80%ED%83%9C%ED%98%84/%EC%97%94%EC%A0%A4%EC%95%84%EC%9D%B4%EC%A6%88%20OST%20Part%202/extralarge&path=%2Fmnt%2FUSB%2F0E93-C36B%2FNAVERMUSIC_20200823%2F%EA%B9%80%ED%83%9C%ED%98%84-1-%EB%88%88%EB%AC%BC%EC%9D%B4%20%ED%8E%91%ED%8E%91.mp3&metadata=false Jul 20 03:51:02 volumio volumio[922]: info: URI /mnt/USB/0E93-C36B/NAVERMUSIC_20200823/김태현-1-눈물이 펑펑.mp3 Jul 20 03:51:02 volumio volumio[922]: info: Preload queue cleared Jul 20 03:51:02 volumio volumio[922]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 20 03:51:02 volumio volumio[922]: info: CoreStateMachine::ClearQueue Jul 20 03:51:02 volumio volumio[922]: info: CoreStateMachine::stop Jul 20 03:51:02 volumio volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 20 03:51:02 volumio volumio[922]: info: CorePlayQueue::clearPlayQueue Jul 20 03:51:02 volumio volumio[922]: info: CorePlayQueue::saveQueue Jul 20 03:51:02 volumio volumio[922]: info: CoreCommandRouter::volumioPushQueue Jul 20 03:51:02 volumio volumio[922]: info: CoreStateMachine::addQueueItems Jul 20 03:51:02 volumio volumio[922]: info: CorePlayQueue::addQueueItems Jul 20 03:51:02 volumio volumio[922]: info: Preload queue cleared Jul 20 03:51:02 volumio volumio[922]: info: Adding Item to queue: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/나윤선-1-In My Heart.mp3 Jul 20 03:51:02 volumio volumio[922]: info: Using cached record of: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/나윤선-1-In My Heart.mp3 Jul 20 03:51:02 volumio volumio[922]: info: Adding Item to queue: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Leona Lewis, LeAnn Rimes, Ashanti, Rihanna, Mar-1-Just Stand Up.mp3 Jul 20 03:51:02 volumio volumio[922]: info: Using cached record of: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Leona Lewis, LeAnn Rimes, Ashanti, Rihanna, Mar-1-Just Stand Up.mp3 Jul 20 03:51:02 volumio volumio[922]: info: Adding Item to queue: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Imelda May-1-Call Me.mp3 Jul 20 03:51:02 volumio volumio[922]: info: Using cached record of: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Imelda May-1-Call Me.mp3 Jul 20 03:51:02 volumio volumio[922]: info: Adding Item to queue: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Joan Baez-8-Donna Donna.mp3 Jul 20 03:51:02 volumio volumio[922]: info: Using cached record of: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Joan Baez-8-Donna Donna.mp3 Jul 20 03:51:02 volumio volumio[922]: info: Adding Item to queue: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Malibu.mp3 Jul 20 03:51:02 volumio volumio[922]: info: Using cached record of: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Malibu.mp3 Jul 20 03:51:02 volumio volumio[922]: info: Adding Item to queue: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Maroon 5-1-Memories.mp3 Jul 20 03:51:02 volumio volumio[922]: info: Using cached record of: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Maroon 5-1-Memories.mp3 Jul 20 03:51:02 volumio volumio[922]: info: Adding Item to queue: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Party In The U.S.A..mp3 Jul 20 03:51:02 volumio volumio[922]: info: Using cached record of: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Party In The U.S.A..mp3 Jul 20 03:51:02 volumio volumio[922]: info: Adding Item to queue: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/John Denver-3-Take Me Home, Country Roads (Remastered).mp3 Jul 20 03:51:02 volumio volumio[922]: info: Using cached record of: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/John Denver-3-Take Me Home, Country Roads (Remastered).mp3 Jul 20 03:51:02 volumio volumio[922]: info: Adding Item to queue: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Wrecking Ball.mp3 Jul 20 03:51:02 volumio volumio[922]: info: Using cached record of: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Wrecking Ball.mp3 Jul 20 03:51:02 volumio volumio[922]: info: Adding Item to queue: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/김태현-1-눈물이 펑펑.mp3 Jul 20 03:51:02 volumio volumio[922]: info: Using cached record of: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/김태현-1-눈물이 펑펑.mp3 Jul 20 03:51:02 volumio volumio[922]: info: CoreCommandRouter::volumioPushQueue Jul 20 03:51:02 volumio volumio[922]: info: CorePlayQueue::saveQueue Jul 20 03:51:02 volumio volumio[922]: info: CoreStateMachine::updateTrackBlock Jul 20 03:51:02 volumio volumio[922]: info: CorePlayQueue::getTrackBlock Jul 20 03:51:02 volumio volumio[922]: info: CoreCommandRouter::volumioPlay Jul 20 03:51:02 volumio volumio[922]: info: CoreStateMachine::play index 0 Jul 20 03:51:02 volumio volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 20 03:51:02 volumio volumio[922]: info: CoreStateMachine::stop Jul 20 03:51:02 volumio volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 20 03:51:02 volumio volumio[922]: info: CoreStateMachine::play index undefined Jul 20 03:51:02 volumio volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 20 03:51:02 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:02 volumio volumio[922]: info: CoreStateMachine::startPlaybackTimer Jul 20 03:51:02 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:02 volumio volumio[922]: verbose: ControllerMpd::clearAddPlayTracks USB/0E93-C36B/NAVERMUSIC_20200823/나윤선-1-In My Heart.mp3 Jul 20 03:51:02 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand stop Jul 20 03:51:02 volumio volumio[922]: info: sendMpdCommand stop took 3 milliseconds Jul 20 03:51:02 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand clear Jul 20 03:51:02 volumio volumio[922]: info: Jul 20 03:51:02 volumio volumio[922]: ---------------------------- MPD announces system playlist update Jul 20 03:51:02 volumio volumio[922]: info: Ignoring MPD Status Update Jul 20 03:51:02 volumio volumio[922]: info: sendMpdCommand clear took 4 milliseconds Jul 20 03:51:02 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand add "USB/0E93-C36B/NAVERMUSIC_20200823/나윤선-1-In My Heart.mp3" Jul 20 03:51:02 volumio volumio[922]: info: Jul 20 03:51:02 volumio volumio[922]: ---------------------------- MPD announces system playlist update Jul 20 03:51:02 volumio volumio[922]: info: Ignoring MPD Status Update Jul 20 03:51:02 volumio volumio[922]: error: updateQueue error: null Jul 20 03:51:02 volumio volumio[922]: info: Jul 20 03:51:02 volumio volumio[922]: ---------------------------- MPD announces system playlist update Jul 20 03:51:02 volumio volumio[922]: info: Ignoring MPD Status Update Jul 20 03:51:02 volumio volumio[922]: info: ------------------------------ 5ms Jul 20 03:51:02 volumio volumio[922]: info: sendMpdCommand add "USB/0E93-C36B/NAVERMUSIC_20200823/나윤선-1-In My Heart.mp3" took 3 milliseconds Jul 20 03:51:02 volumio volumio[922]: info: ------------------------------ 3ms Jul 20 03:51:02 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand play Jul 20 03:51:02 volumio volumio[922]: info: Jul 20 03:51:02 volumio volumio[922]: ---------------------------- MPD announces system playlist update Jul 20 03:51:02 volumio volumio[922]: info: Ignoring MPD Status Update Jul 20 03:51:02 volumio volumio[922]: info: ------------------------------ 6ms Jul 20 03:51:02 volumio volumio[922]: info: sendMpdCommand play took 5 milliseconds Jul 20 03:51:02 volumio volumio[922]: info: ------------------------------ 4ms Jul 20 03:51:02 volumio volumio[922]: info: Jul 20 03:51:02 volumio volumio[922]: ---------------------------- MPD announces state update: player Jul 20 03:51:02 volumio volumio[922]: info: ControllerMpd::getState Jul 20 03:51:02 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand status Jul 20 03:51:02 volumio volumio[922]: info: Jul 20 03:51:02 volumio volumio[922]: ---------------------------- MPD announces state update: player Jul 20 03:51:02 volumio volumio[922]: info: ControllerMpd::getState Jul 20 03:51:02 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand status Jul 20 03:51:02 volumio volumio[922]: info: Jul 20 03:51:02 volumio volumio[922]: ---------------------------- MPD announces state update: player Jul 20 03:51:02 volumio volumio[922]: info: sendMpdCommand status took 95 milliseconds Jul 20 03:51:02 volumio volumio[922]: info: sendMpdCommand status took 95 milliseconds Jul 20 03:51:02 volumio volumio[922]: info: ControllerMpd::getState Jul 20 03:51:02 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand status Jul 20 03:51:02 volumio volumio[922]: verbose: ControllerMpd::parseState Jul 20 03:51:02 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 20 03:51:02 volumio volumio[922]: verbose: ControllerMpd::parseState Jul 20 03:51:02 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 20 03:51:02 volumio volumio[922]: info: Jul 20 03:51:02 volumio volumio[922]: ---------------------------- MPD announces state update: player Jul 20 03:51:02 volumio volumio[922]: info: ControllerMpd::getState Jul 20 03:51:02 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand status Jul 20 03:51:02 volumio volumio[922]: info: sendMpdCommand status took 8 milliseconds Jul 20 03:51:02 volumio volumio[922]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 20 03:51:02 volumio volumio[922]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 20 03:51:02 volumio volumio[922]: info: sendMpdCommand status took 3 milliseconds Jul 20 03:51:02 volumio volumio[922]: verbose: ControllerMpd::parseState Jul 20 03:51:02 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 20 03:51:02 volumio volumio[922]: verbose: ControllerMpd::parseTrackInfo Jul 20 03:51:02 volumio volumio[922]: verbose: ControllerMpd::parseTrackInfo Jul 20 03:51:02 volumio volumio[922]: verbose: ControllerMpd::parseState Jul 20 03:51:02 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 20 03:51:02 volumio volumio[922]: info: ControllerMpd::pushState Jul 20 03:51:02 volumio volumio[922]: info: CoreCommandRouter::servicePushState Jul 20 03:51:02 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:02 volumio volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":145,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"나윤선-1-In My Heart.mp3","artist":null,"album":null,"uri":"USB/0E93-C36B/NAVERMUSIC_20200823/나윤선-1-In My Heart.mp3","trackType":"mp3"} Jul 20 03:51:02 volumio volumio[922]: verbose: CURRENT POSITION 0 Jul 20 03:51:02 volumio volumio[922]: info: CoreStateMachine::syncState stateService play Jul 20 03:51:02 volumio volumio[922]: info: CoreStateMachine::syncState currentStatus stop Jul 20 03:51:02 volumio volumio[922]: info: ControllerMpd::pushState Jul 20 03:51:02 volumio volumio[922]: info: CoreCommandRouter::servicePushState Jul 20 03:51:02 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:02 volumio volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":145,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"나윤선-1-In My Heart.mp3","artist":null,"album":null,"uri":"USB/0E93-C36B/NAVERMUSIC_20200823/나윤선-1-In My Heart.mp3","trackType":"mp3"} Jul 20 03:51:02 volumio volumio[922]: verbose: CURRENT POSITION 0 Jul 20 03:51:02 volumio volumio[922]: info: CoreStateMachine::syncState stateService play Jul 20 03:51:02 volumio volumio[922]: info: CoreStateMachine::syncState currentStatus play Jul 20 03:51:02 volumio volumio[922]: info: Received an update from plugin. extracting info from payload Jul 20 03:51:02 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:02 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:02 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 03:51:02 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:02 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:02 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:02 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:03 volumio volumio[922]: info: ------------------------------ 140ms Jul 20 03:51:03 volumio volumio[922]: info: ------------------------------ 145ms Jul 20 03:51:03 volumio volumio[922]: info: sendMpdCommand playlistinfo took 37 milliseconds Jul 20 03:51:03 volumio volumio[922]: info: sendMpdCommand playlistinfo took 27 milliseconds Jul 20 03:51:03 volumio volumio[922]: verbose: ControllerMpd::parseTrackInfo Jul 20 03:51:03 volumio volumio[922]: verbose: ControllerMpd::parseTrackInfo Jul 20 03:51:03 volumio volumio[922]: info: ControllerMpd::pushState Jul 20 03:51:03 volumio volumio[922]: info: CoreCommandRouter::servicePushState Jul 20 03:51:03 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:03 volumio volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":220,"duration":145,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"나윤선-1-In My Heart.mp3","artist":null,"album":null,"uri":"USB/0E93-C36B/NAVERMUSIC_20200823/나윤선-1-In My Heart.mp3","trackType":"mp3"} Jul 20 03:51:03 volumio volumio[922]: verbose: CURRENT POSITION 0 Jul 20 03:51:03 volumio volumio[922]: info: CoreStateMachine::syncState stateService play Jul 20 03:51:03 volumio volumio[922]: info: CoreStateMachine::syncState currentStatus play Jul 20 03:51:03 volumio volumio[922]: info: Received an update from plugin. extracting info from payload Jul 20 03:51:03 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:03 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:03 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 03:51:03 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:03 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:03 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:03 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:03 volumio volumio[922]: info: ControllerMpd::pushState Jul 20 03:51:03 volumio volumio[922]: info: CoreCommandRouter::servicePushState Jul 20 03:51:03 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:03 volumio volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":336,"duration":145,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"나윤선-1-In My Heart.mp3","artist":null,"album":null,"uri":"USB/0E93-C36B/NAVERMUSIC_20200823/나윤선-1-In My Heart.mp3","trackType":"mp3"} Jul 20 03:51:03 volumio volumio[922]: verbose: CURRENT POSITION 0 Jul 20 03:51:03 volumio volumio[922]: info: CoreStateMachine::syncState stateService play Jul 20 03:51:03 volumio volumio[922]: info: CoreStateMachine::syncState currentStatus play Jul 20 03:51:03 volumio volumio[922]: info: Received an update from plugin. extracting info from payload Jul 20 03:51:03 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:03 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:03 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 03:51:03 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:03 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:03 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:03 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:03 volumio volumio[922]: info: ------------------------------ 97ms Jul 20 03:51:03 volumio volumio[922]: info: ------------------------------ 89ms Jul 20 03:51:07 volumio volumio[922]: info: Jul 20 03:51:07 volumio volumio[922]: ---------------------------- MPD announces state update: player Jul 20 03:51:07 volumio volumio[922]: info: ControllerMpd::getState Jul 20 03:51:07 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand status Jul 20 03:51:07 volumio volumio[922]: info: Jul 20 03:51:07 volumio volumio[922]: ---------------------------- MPD announces state update: player Jul 20 03:51:07 volumio volumio[922]: info: ControllerMpd::getState Jul 20 03:51:07 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand status Jul 20 03:51:07 volumio volumio[922]: info: sendMpdCommand status took 3 milliseconds Jul 20 03:51:07 volumio volumio[922]: info: sendMpdCommand status took 2 milliseconds Jul 20 03:51:07 volumio volumio[922]: verbose: ControllerMpd::parseState Jul 20 03:51:07 volumio volumio[922]: verbose: ControllerMpd::parseState Jul 20 03:51:07 volumio volumio[922]: info: ControllerMpd::pushState Jul 20 03:51:07 volumio volumio[922]: info: CoreCommandRouter::servicePushState Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:07 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:07 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 03:51:07 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:07 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:07 volumio volumio[922]: 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} Jul 20 03:51:07 volumio volumio[922]: verbose: CURRENT POSITION 0 Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::syncState stateService stop Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::syncState currentStatus play Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::play index undefined Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:07 volumio volumio[922]: info: CorePlayQueue::getTrack 9 Jul 20 03:51:07 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 03:51:07 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:07 volumio volumio[922]: info: ControllerMpd::pushState Jul 20 03:51:07 volumio volumio[922]: info: CoreCommandRouter::servicePushState Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:07 volumio volumio[922]: info: CorePlayQueue::getTrack 9 Jul 20 03:51:07 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:07 volumio volumio[922]: info: CorePlayQueue::getTrack 9 Jul 20 03:51:07 volumio volumio[922]: 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} Jul 20 03:51:07 volumio volumio[922]: verbose: CURRENT POSITION 9 Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::syncState stateService stop Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::syncState currentStatus stop Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:07 volumio volumio[922]: info: CorePlayQueue::getTrack 9 Jul 20 03:51:07 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:07 volumio volumio[922]: info: No code Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:07 volumio volumio[922]: info: CorePlayQueue::getTrack 9 Jul 20 03:51:07 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:07 volumio volumio[922]: info: CorePlayQueue::getTrack 9 Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::startPlaybackTimer Jul 20 03:51:07 volumio volumio[922]: info: CorePlayQueue::getTrack 9 Jul 20 03:51:07 volumio volumio[922]: verbose: ControllerMpd::clearAddPlayTracks USB/0E93-C36B/NAVERMUSIC_20200823/김태현-1-눈물이 펑펑.mp3 Jul 20 03:51:07 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand stop Jul 20 03:51:07 volumio volumio[922]: info: ------------------------------ 51ms Jul 20 03:51:07 volumio volumio[922]: info: ------------------------------ 49ms Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:07 volumio volumio[922]: info: CorePlayQueue::getTrack 9 Jul 20 03:51:07 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 03:51:07 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:07 volumio volumio[922]: info: sendMpdCommand stop took 10 milliseconds Jul 20 03:51:07 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand clear Jul 20 03:51:07 volumio volumio[922]: info: Jul 20 03:51:07 volumio volumio[922]: ---------------------------- MPD announces system playlist update Jul 20 03:51:07 volumio volumio[922]: info: Ignoring MPD Status Update Jul 20 03:51:07 volumio volumio[922]: info: sendMpdCommand clear took 14 milliseconds Jul 20 03:51:07 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand add "USB/0E93-C36B/NAVERMUSIC_20200823/김태현-1-눈물이 펑펑.mp3" Jul 20 03:51:07 volumio volumio[922]: info: Jul 20 03:51:07 volumio volumio[922]: ---------------------------- MPD announces system playlist update Jul 20 03:51:07 volumio volumio[922]: info: Ignoring MPD Status Update Jul 20 03:51:07 volumio volumio[922]: error: updateQueue error: null Jul 20 03:51:07 volumio volumio[922]: info: Jul 20 03:51:07 volumio volumio[922]: ---------------------------- MPD announces system playlist update Jul 20 03:51:07 volumio volumio[922]: info: Ignoring MPD Status Update Jul 20 03:51:07 volumio volumio[922]: info: ------------------------------ 6ms Jul 20 03:51:07 volumio volumio[922]: info: sendMpdCommand add "USB/0E93-C36B/NAVERMUSIC_20200823/김태현-1-눈물이 펑펑.mp3" took 5 milliseconds Jul 20 03:51:07 volumio volumio[922]: info: ------------------------------ 4ms Jul 20 03:51:07 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand play Jul 20 03:51:07 volumio volumio[922]: info: Jul 20 03:51:07 volumio volumio[922]: ---------------------------- MPD announces system playlist update Jul 20 03:51:07 volumio volumio[922]: info: Ignoring MPD Status Update Jul 20 03:51:07 volumio volumio[922]: info: Jul 20 03:51:07 volumio volumio[922]: ---------------------------- MPD announces state update: player Jul 20 03:51:07 volumio volumio[922]: info: ------------------------------ 7ms Jul 20 03:51:07 volumio volumio[922]: info: sendMpdCommand play took 4 milliseconds Jul 20 03:51:07 volumio volumio[922]: info: ControllerMpd::getState Jul 20 03:51:07 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand status Jul 20 03:51:07 volumio volumio[922]: info: ------------------------------ 5ms Jul 20 03:51:07 volumio volumio[922]: info: Jul 20 03:51:07 volumio volumio[922]: ---------------------------- MPD announces state update: player Jul 20 03:51:07 volumio volumio[922]: info: ControllerMpd::getState Jul 20 03:51:07 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand status Jul 20 03:51:07 volumio volumio[922]: info: sendMpdCommand status took 23 milliseconds Jul 20 03:51:07 volumio volumio[922]: verbose: ControllerMpd::parseState Jul 20 03:51:07 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 20 03:51:07 volumio volumio[922]: info: Jul 20 03:51:07 volumio volumio[922]: ---------------------------- MPD announces state update: player Jul 20 03:51:07 volumio volumio[922]: info: ControllerMpd::getState Jul 20 03:51:07 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand status Jul 20 03:51:07 volumio volumio[922]: info: sendMpdCommand status took 22 milliseconds Jul 20 03:51:07 volumio volumio[922]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 20 03:51:07 volumio volumio[922]: verbose: ControllerMpd::parseState Jul 20 03:51:07 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 20 03:51:07 volumio volumio[922]: verbose: ControllerMpd::parseTrackInfo Jul 20 03:51:07 volumio volumio[922]: info: ControllerMpd::pushState Jul 20 03:51:07 volumio volumio[922]: info: CoreCommandRouter::servicePushState Jul 20 03:51:07 volumio volumio[922]: info: CorePlayQueue::getTrack 9 Jul 20 03:51:07 volumio volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"눈물이 펑펑","artist":"김태현","album":"엔젤아이즈 OST Part 2","uri":"USB/0E93-C36B/NAVERMUSIC_20200823/김태현-1-눈물이 펑펑.mp3","trackType":"mp3"} Jul 20 03:51:07 volumio volumio[922]: verbose: CURRENT POSITION 9 Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::syncState stateService play Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::syncState currentStatus stop Jul 20 03:51:07 volumio volumio[922]: info: ------------------------------ 31ms Jul 20 03:51:07 volumio volumio[922]: info: Jul 20 03:51:07 volumio volumio[922]: ---------------------------- MPD announces state update: player Jul 20 03:51:07 volumio volumio[922]: info: ControllerMpd::getState Jul 20 03:51:07 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand status Jul 20 03:51:07 volumio volumio[922]: info: sendMpdCommand status took 7 milliseconds Jul 20 03:51:07 volumio volumio[922]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 20 03:51:07 volumio volumio[922]: info: sendMpdCommand status took 2 milliseconds Jul 20 03:51:07 volumio volumio[922]: verbose: ControllerMpd::parseState Jul 20 03:51:07 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 20 03:51:07 volumio volumio[922]: verbose: ControllerMpd::parseTrackInfo Jul 20 03:51:07 volumio volumio[922]: verbose: ControllerMpd::parseState Jul 20 03:51:07 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 20 03:51:07 volumio volumio[922]: info: ControllerMpd::pushState Jul 20 03:51:07 volumio volumio[922]: info: CoreCommandRouter::servicePushState Jul 20 03:51:07 volumio volumio[922]: info: CorePlayQueue::getTrack 9 Jul 20 03:51:07 volumio volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"눈물이 펑펑","artist":"김태현","album":"엔젤아이즈 OST Part 2","uri":"USB/0E93-C36B/NAVERMUSIC_20200823/김태현-1-눈물이 펑펑.mp3","trackType":"mp3"} Jul 20 03:51:07 volumio volumio[922]: verbose: CURRENT POSITION 9 Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::syncState stateService play Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::syncState currentStatus play Jul 20 03:51:07 volumio volumio[922]: info: Received an update from plugin. extracting info from payload Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:07 volumio volumio[922]: info: CorePlayQueue::getTrack 9 Jul 20 03:51:07 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 03:51:07 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:07 volumio volumio[922]: info: CorePlayQueue::getTrack 9 Jul 20 03:51:07 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:07 volumio volumio[922]: info: ------------------------------ 56ms Jul 20 03:51:07 volumio volumio[922]: info: sendMpdCommand playlistinfo took 26 milliseconds Jul 20 03:51:07 volumio volumio[922]: info: sendMpdCommand playlistinfo took 25 milliseconds Jul 20 03:51:07 volumio volumio[922]: verbose: ControllerMpd::parseTrackInfo Jul 20 03:51:07 volumio volumio[922]: verbose: ControllerMpd::parseTrackInfo Jul 20 03:51:07 volumio volumio[922]: info: ControllerMpd::pushState Jul 20 03:51:07 volumio volumio[922]: info: CoreCommandRouter::servicePushState Jul 20 03:51:07 volumio volumio[922]: info: CorePlayQueue::getTrack 9 Jul 20 03:51:07 volumio volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":229,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"눈물이 펑펑","artist":"김태현","album":"엔젤아이즈 OST Part 2","uri":"USB/0E93-C36B/NAVERMUSIC_20200823/김태현-1-눈물이 펑펑.mp3","trackType":"mp3"} Jul 20 03:51:07 volumio volumio[922]: verbose: CURRENT POSITION 9 Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::syncState stateService play Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::syncState currentStatus play Jul 20 03:51:07 volumio volumio[922]: info: Received an update from plugin. extracting info from payload Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:07 volumio volumio[922]: info: CorePlayQueue::getTrack 9 Jul 20 03:51:07 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 03:51:07 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:07 volumio volumio[922]: info: CorePlayQueue::getTrack 9 Jul 20 03:51:07 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:07 volumio volumio[922]: info: ControllerMpd::pushState Jul 20 03:51:07 volumio volumio[922]: info: CoreCommandRouter::servicePushState Jul 20 03:51:07 volumio volumio[922]: info: CorePlayQueue::getTrack 9 Jul 20 03:51:07 volumio volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":148,"duration":229,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"눈물이 펑펑","artist":"김태현","album":"엔젤아이즈 OST Part 2","uri":"USB/0E93-C36B/NAVERMUSIC_20200823/김태현-1-눈물이 펑펑.mp3","trackType":"mp3"} Jul 20 03:51:07 volumio volumio[922]: verbose: CURRENT POSITION 9 Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::syncState stateService play Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::syncState currentStatus play Jul 20 03:51:07 volumio volumio[922]: info: Received an update from plugin. extracting info from payload Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:07 volumio volumio[922]: info: CorePlayQueue::getTrack 9 Jul 20 03:51:07 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 03:51:07 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:07 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:07 volumio volumio[922]: info: CorePlayQueue::getTrack 9 Jul 20 03:51:07 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:07 volumio volumio[922]: info: ------------------------------ 70ms Jul 20 03:51:07 volumio volumio[922]: info: ------------------------------ 64ms Jul 20 03:51:24 volumio volumio[922]: info: [jellyfin-poller-worker] _doPoll(): All servers polled. Will poll again in 30000ms. Jul 20 03:51:32 volumio volumio[922]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 20 03:51:32 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 20 03:51:32 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 20 03:51:32 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 20 03:51:33 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 20 03:51:33 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 20 03:51:33 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 20 03:51:33 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 20 03:51:33 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 20 03:51:33 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 20 03:51:33 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 20 03:51:33 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 20 03:51:33 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 20 03:51:42 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 20 03:51:42 volumio volumio[922]: info: CURURI: music-library Jul 20 03:51:42 volumio volumio[922]: info: Preload queue cleared Jul 20 03:51:42 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 20 03:51:42 volumio volumio[922]: info: CURURI: music-library/USB Jul 20 03:51:42 volumio volumio[922]: info: Preload queue cleared Jul 20 03:51:43 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 20 03:51:43 volumio volumio[922]: info: CURURI: music-library/USB/0E93-C36B Jul 20 03:51:43 volumio volumio[922]: info: Preload queue cleared Jul 20 03:51:44 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 20 03:51:44 volumio volumio[922]: info: CURURI: music-library/USB/0E93-C36B/NAVERMUSIC_20200823 Jul 20 03:51:44 volumio volumio[922]: info: Preload queue cleared Jul 20 03:51:45 volumio volumio[922]: info: Preload queue cleared Jul 20 03:51:45 volumio volumio[922]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::ClearQueue Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::stop Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::stPlaybackTimer Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::updateTrackBlock Jul 20 03:51:45 volumio volumio[922]: info: CorePlayQueue::getTrackBlock Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:45 volumio volumio[922]: info: CorePlayQueue::getTrack 9 Jul 20 03:51:45 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 03:51:45 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::serviceStop Jul 20 03:51:45 volumio volumio[922]: info: CorePlayQueue::getTrack 9 Jul 20 03:51:45 volumio volumio[922]: info: CoreCommandRouter::serviceStop Jul 20 03:51:45 volumio volumio[922]: info: ControllerMpd::stop Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand stop Jul 20 03:51:45 volumio volumio[922]: info: CorePlayQueue::clearPlayQueue Jul 20 03:51:45 volumio volumio[922]: info: CorePlayQueue::saveQueue Jul 20 03:51:45 volumio volumio[922]: info: CoreCommandRouter::volumioPushQueue Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::addQueueItems Jul 20 03:51:45 volumio volumio[922]: info: CorePlayQueue::addQueueItems Jul 20 03:51:45 volumio volumio[922]: info: Preload queue cleared Jul 20 03:51:45 volumio volumio[922]: info: Adding Item to queue: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/나윤선-1-In My Heart.mp3 Jul 20 03:51:45 volumio volumio[922]: info: Using cached record of: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/나윤선-1-In My Heart.mp3 Jul 20 03:51:45 volumio volumio[922]: info: Adding Item to queue: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Leona Lewis, LeAnn Rimes, Ashanti, Rihanna, Mar-1-Just Stand Up.mp3 Jul 20 03:51:45 volumio volumio[922]: info: Using cached record of: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Leona Lewis, LeAnn Rimes, Ashanti, Rihanna, Mar-1-Just Stand Up.mp3 Jul 20 03:51:45 volumio volumio[922]: info: Adding Item to queue: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Imelda May-1-Call Me.mp3 Jul 20 03:51:45 volumio volumio[922]: info: Using cached record of: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Imelda May-1-Call Me.mp3 Jul 20 03:51:45 volumio volumio[922]: info: Adding Item to queue: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Joan Baez-8-Donna Donna.mp3 Jul 20 03:51:45 volumio volumio[922]: info: Using cached record of: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Joan Baez-8-Donna Donna.mp3 Jul 20 03:51:45 volumio volumio[922]: info: Adding Item to queue: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Malibu.mp3 Jul 20 03:51:45 volumio volumio[922]: info: Using cached record of: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Malibu.mp3 Jul 20 03:51:45 volumio volumio[922]: info: Adding Item to queue: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Maroon 5-1-Memories.mp3 Jul 20 03:51:45 volumio volumio[922]: info: Using cached record of: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Maroon 5-1-Memories.mp3 Jul 20 03:51:45 volumio volumio[922]: info: Adding Item to queue: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Party In The U.S.A..mp3 Jul 20 03:51:45 volumio volumio[922]: info: Using cached record of: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Party In The U.S.A..mp3 Jul 20 03:51:45 volumio volumio[922]: info: Adding Item to queue: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/John Denver-3-Take Me Home, Country Roads (Remastered).mp3 Jul 20 03:51:45 volumio volumio[922]: info: Using cached record of: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/John Denver-3-Take Me Home, Country Roads (Remastered).mp3 Jul 20 03:51:45 volumio volumio[922]: info: Adding Item to queue: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Wrecking Ball.mp3 Jul 20 03:51:45 volumio volumio[922]: info: Using cached record of: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Wrecking Ball.mp3 Jul 20 03:51:45 volumio volumio[922]: info: Adding Item to queue: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/김태현-1-눈물이 펑펑.mp3 Jul 20 03:51:45 volumio volumio[922]: info: Using cached record of: music-library/USB/0E93-C36B/NAVERMUSIC_20200823/김태현-1-눈물이 펑펑.mp3 Jul 20 03:51:45 volumio volumio[922]: info: CoreCommandRouter::volumioPushQueue Jul 20 03:51:45 volumio volumio[922]: info: CorePlayQueue::saveQueue Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::updateTrackBlock Jul 20 03:51:45 volumio volumio[922]: info: CorePlayQueue::getTrackBlock Jul 20 03:51:45 volumio volumio[922]: info: CoreCommandRouter::volumioPlay Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::play index 0 Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::stop Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::play index undefined Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 20 03:51:45 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::startPlaybackTimer Jul 20 03:51:45 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::clearAddPlayTracks USB/0E93-C36B/NAVERMUSIC_20200823/나윤선-1-In My Heart.mp3 Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand stop Jul 20 03:51:45 volumio volumio[922]: info: Jul 20 03:51:45 volumio volumio[922]: ---------------------------- MPD announces state update: player Jul 20 03:51:45 volumio volumio[922]: info: sendMpdCommand stop took 57 milliseconds Jul 20 03:51:45 volumio volumio[922]: info: ControllerMpd::getState Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand status Jul 20 03:51:45 volumio volumio[922]: info: sendMpdCommand stop took 35 milliseconds Jul 20 03:51:45 volumio volumio[922]: info: sendMpdCommand status took 1 milliseconds Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand clear Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::parseState Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 20 03:51:45 volumio volumio[922]: info: Jul 20 03:51:45 volumio volumio[922]: ---------------------------- MPD announces state update: player Jul 20 03:51:45 volumio volumio[922]: info: ControllerMpd::getState Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand status Jul 20 03:51:45 volumio volumio[922]: info: Jul 20 03:51:45 volumio volumio[922]: ---------------------------- MPD announces system playlist update Jul 20 03:51:45 volumio volumio[922]: info: Ignoring MPD Status Update Jul 20 03:51:45 volumio volumio[922]: info: sendMpdCommand clear took 3 milliseconds Jul 20 03:51:45 volumio volumio[922]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 20 03:51:45 volumio volumio[922]: info: sendMpdCommand status took 1 milliseconds Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand add "USB/0E93-C36B/NAVERMUSIC_20200823/나윤선-1-In My Heart.mp3" Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::parseTrackInfo Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::parseState Jul 20 03:51:45 volumio volumio[922]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 20 03:51:45 volumio volumio[922]: info: ControllerMpd::pushState Jul 20 03:51:45 volumio volumio[922]: info: CoreCommandRouter::servicePushState Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:45 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:45 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 03:51:45 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:45 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:45 volumio volumio[922]: 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} Jul 20 03:51:45 volumio volumio[922]: verbose: CURRENT POSITION 0 Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::syncState stateService stop Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::syncState currentStatus stop Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:45 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:45 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:45 volumio volumio[922]: info: No code Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:45 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:45 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:45 volumio volumio[922]: info: ------------------------------ 16ms Jul 20 03:51:45 volumio volumio[922]: info: ------------------------------ 25ms Jul 20 03:51:45 volumio volumio[922]: info: Jul 20 03:51:45 volumio volumio[922]: ---------------------------- MPD announces system playlist update Jul 20 03:51:45 volumio volumio[922]: info: Ignoring MPD Status Update Jul 20 03:51:45 volumio volumio[922]: error: updateQueue error: null Jul 20 03:51:45 volumio volumio[922]: info: Jul 20 03:51:45 volumio volumio[922]: ---------------------------- MPD announces system playlist update Jul 20 03:51:45 volumio volumio[922]: info: Ignoring MPD Status Update Jul 20 03:51:45 volumio volumio[922]: info: ------------------------------ 29ms Jul 20 03:51:45 volumio volumio[922]: info: sendMpdCommand add "USB/0E93-C36B/NAVERMUSIC_20200823/나윤선-1-In My Heart.mp3" took 28 milliseconds Jul 20 03:51:45 volumio volumio[922]: info: ------------------------------ 5ms Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand play Jul 20 03:51:45 volumio volumio[922]: info: Jul 20 03:51:45 volumio volumio[922]: ---------------------------- MPD announces system playlist update Jul 20 03:51:45 volumio volumio[922]: info: Ignoring MPD Status Update Jul 20 03:51:45 volumio volumio[922]: info: ------------------------------ 9ms Jul 20 03:51:45 volumio volumio[922]: info: sendMpdCommand play took 8 milliseconds Jul 20 03:51:45 volumio volumio[922]: info: ------------------------------ 8ms Jul 20 03:51:45 volumio volumio[922]: info: Jul 20 03:51:45 volumio volumio[922]: ---------------------------- MPD announces state update: player Jul 20 03:51:45 volumio volumio[922]: info: ControllerMpd::getState Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand status Jul 20 03:51:45 volumio volumio[922]: info: Jul 20 03:51:45 volumio volumio[922]: ---------------------------- MPD announces state update: player Jul 20 03:51:45 volumio volumio[922]: info: ControllerMpd::getState Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand status Jul 20 03:51:45 volumio volumio[922]: info: sendMpdCommand status took 12 milliseconds Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::parseState Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 20 03:51:45 volumio volumio[922]: info: Jul 20 03:51:45 volumio volumio[922]: ---------------------------- MPD announces state update: player Jul 20 03:51:45 volumio volumio[922]: info: ControllerMpd::getState Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand status Jul 20 03:51:45 volumio volumio[922]: info: sendMpdCommand status took 13 milliseconds Jul 20 03:51:45 volumio volumio[922]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::parseState Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::parseTrackInfo Jul 20 03:51:45 volumio volumio[922]: info: ControllerMpd::pushState Jul 20 03:51:45 volumio volumio[922]: info: CoreCommandRouter::servicePushState Jul 20 03:51:45 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:45 volumio volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":145,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"나윤선-1-In My Heart.mp3","artist":null,"album":null,"uri":"USB/0E93-C36B/NAVERMUSIC_20200823/나윤선-1-In My Heart.mp3","trackType":"mp3"} Jul 20 03:51:45 volumio volumio[922]: verbose: CURRENT POSITION 0 Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::syncState stateService play Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::syncState currentStatus stop Jul 20 03:51:45 volumio volumio[922]: info: ------------------------------ 19ms Jul 20 03:51:45 volumio volumio[922]: info: Jul 20 03:51:45 volumio volumio[922]: ---------------------------- MPD announces state update: player Jul 20 03:51:45 volumio volumio[922]: info: ControllerMpd::getState Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand status Jul 20 03:51:45 volumio volumio[922]: info: sendMpdCommand status took 7 milliseconds Jul 20 03:51:45 volumio volumio[922]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 20 03:51:45 volumio volumio[922]: info: sendMpdCommand status took 1 milliseconds Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::parseState Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::parseTrackInfo Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::parseState Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 20 03:51:45 volumio volumio[922]: info: ControllerMpd::pushState Jul 20 03:51:45 volumio volumio[922]: info: CoreCommandRouter::servicePushState Jul 20 03:51:45 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:45 volumio volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":115,"duration":145,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"나윤선-1-In My Heart.mp3","artist":null,"album":null,"uri":"USB/0E93-C36B/NAVERMUSIC_20200823/나윤선-1-In My Heart.mp3","trackType":"mp3"} Jul 20 03:51:45 volumio volumio[922]: verbose: CURRENT POSITION 0 Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::syncState stateService play Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::syncState currentStatus play Jul 20 03:51:45 volumio volumio[922]: info: Received an update from plugin. extracting info from payload Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:45 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:45 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 03:51:45 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:45 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:45 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:45 volumio volumio[922]: info: ------------------------------ 45ms Jul 20 03:51:45 volumio volumio[922]: info: sendMpdCommand playlistinfo took 24 milliseconds Jul 20 03:51:45 volumio volumio[922]: info: sendMpdCommand playlistinfo took 24 milliseconds Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::parseTrackInfo Jul 20 03:51:45 volumio volumio[922]: verbose: ControllerMpd::parseTrackInfo Jul 20 03:51:45 volumio volumio[922]: info: ControllerMpd::pushState Jul 20 03:51:45 volumio volumio[922]: info: CoreCommandRouter::servicePushState Jul 20 03:51:45 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:45 volumio volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":241,"duration":145,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"나윤선-1-In My Heart.mp3","artist":null,"album":null,"uri":"USB/0E93-C36B/NAVERMUSIC_20200823/나윤선-1-In My Heart.mp3","trackType":"mp3"} Jul 20 03:51:45 volumio volumio[922]: verbose: CURRENT POSITION 0 Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::syncState stateService play Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::syncState currentStatus play Jul 20 03:51:45 volumio volumio[922]: info: Received an update from plugin. extracting info from payload Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:45 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:45 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 03:51:45 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:45 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:45 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:45 volumio volumio[922]: info: ControllerMpd::pushState Jul 20 03:51:45 volumio volumio[922]: info: CoreCommandRouter::servicePushState Jul 20 03:51:45 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:45 volumio volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":378,"duration":145,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"나윤선-1-In My Heart.mp3","artist":null,"album":null,"uri":"USB/0E93-C36B/NAVERMUSIC_20200823/나윤선-1-In My Heart.mp3","trackType":"mp3"} Jul 20 03:51:45 volumio volumio[922]: verbose: CURRENT POSITION 0 Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::syncState stateService play Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::syncState currentStatus play Jul 20 03:51:45 volumio volumio[922]: info: Received an update from plugin. extracting info from payload Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:45 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:45 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 03:51:45 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:45 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:45 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:45 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:45 volumio volumio[922]: info: ------------------------------ 65ms Jul 20 03:51:45 volumio volumio[922]: info: ------------------------------ 59ms Jul 20 03:51:50 volumio volumio[922]: info: Jul 20 03:51:50 volumio volumio[922]: ---------------------------- MPD announces state update: player Jul 20 03:51:50 volumio volumio[922]: info: ControllerMpd::getState Jul 20 03:51:50 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand status Jul 20 03:51:50 volumio volumio[922]: info: Jul 20 03:51:50 volumio volumio[922]: ---------------------------- MPD announces state update: player Jul 20 03:51:50 volumio volumio[922]: info: ControllerMpd::getState Jul 20 03:51:50 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand status Jul 20 03:51:50 volumio volumio[922]: info: sendMpdCommand status took 2 milliseconds Jul 20 03:51:50 volumio volumio[922]: info: sendMpdCommand status took 1 milliseconds Jul 20 03:51:50 volumio volumio[922]: verbose: ControllerMpd::parseState Jul 20 03:51:50 volumio volumio[922]: verbose: ControllerMpd::parseState Jul 20 03:51:50 volumio volumio[922]: info: ControllerMpd::pushState Jul 20 03:51:50 volumio volumio[922]: info: CoreCommandRouter::servicePushState Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:50 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:50 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 03:51:50 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:50 volumio volumio[922]: info: CorePlayQueue::getTrack 0 Jul 20 03:51:50 volumio volumio[922]: 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} Jul 20 03:51:50 volumio volumio[922]: verbose: CURRENT POSITION 0 Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::syncState stateService stop Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::syncState currentStatus play Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::play index undefined Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:50 volumio volumio[922]: info: CorePlayQueue::getTrack 8 Jul 20 03:51:50 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 03:51:50 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:50 volumio volumio[922]: info: ControllerMpd::pushState Jul 20 03:51:50 volumio volumio[922]: info: CoreCommandRouter::servicePushState Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:50 volumio volumio[922]: info: CorePlayQueue::getTrack 8 Jul 20 03:51:50 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:50 volumio volumio[922]: info: CorePlayQueue::getTrack 8 Jul 20 03:51:50 volumio volumio[922]: 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} Jul 20 03:51:50 volumio volumio[922]: verbose: CURRENT POSITION 8 Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::syncState stateService stop Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::syncState currentStatus stop Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:50 volumio volumio[922]: info: CorePlayQueue::getTrack 8 Jul 20 03:51:50 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:50 volumio volumio[922]: info: No code Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:50 volumio volumio[922]: info: CorePlayQueue::getTrack 8 Jul 20 03:51:50 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:50 volumio volumio[922]: info: CorePlayQueue::getTrack 8 Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::startPlaybackTimer Jul 20 03:51:50 volumio volumio[922]: info: CorePlayQueue::getTrack 8 Jul 20 03:51:50 volumio volumio[922]: verbose: ControllerMpd::clearAddPlayTracks USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Wrecking Ball.mp3 Jul 20 03:51:50 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand stop Jul 20 03:51:50 volumio volumio[922]: info: ------------------------------ 41ms Jul 20 03:51:50 volumio volumio[922]: info: ------------------------------ 39ms Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:50 volumio volumio[922]: info: CorePlayQueue::getTrack 8 Jul 20 03:51:50 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 03:51:50 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:50 volumio volumio[922]: info: sendMpdCommand stop took 12 milliseconds Jul 20 03:51:50 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand clear Jul 20 03:51:50 volumio volumio[922]: info: Jul 20 03:51:50 volumio volumio[922]: ---------------------------- MPD announces system playlist update Jul 20 03:51:50 volumio volumio[922]: info: Ignoring MPD Status Update Jul 20 03:51:50 volumio volumio[922]: info: sendMpdCommand clear took 17 milliseconds Jul 20 03:51:50 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand add "USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Wrecking Ball.mp3" Jul 20 03:51:50 volumio volumio[922]: info: Jul 20 03:51:50 volumio volumio[922]: ---------------------------- MPD announces system playlist update Jul 20 03:51:50 volumio volumio[922]: info: Ignoring MPD Status Update Jul 20 03:51:50 volumio volumio[922]: error: updateQueue error: null Jul 20 03:51:50 volumio volumio[922]: info: Jul 20 03:51:50 volumio volumio[922]: ---------------------------- MPD announces system playlist update Jul 20 03:51:50 volumio volumio[922]: info: Ignoring MPD Status Update Jul 20 03:51:50 volumio volumio[922]: info: ------------------------------ 5ms Jul 20 03:51:50 volumio volumio[922]: info: sendMpdCommand add "USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Wrecking Ball.mp3" took 4 milliseconds Jul 20 03:51:50 volumio volumio[922]: info: ------------------------------ 2ms Jul 20 03:51:50 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand play Jul 20 03:51:50 volumio volumio[922]: info: Jul 20 03:51:50 volumio volumio[922]: ---------------------------- MPD announces system playlist update Jul 20 03:51:50 volumio volumio[922]: info: Ignoring MPD Status Update Jul 20 03:51:50 volumio volumio[922]: info: Jul 20 03:51:50 volumio volumio[922]: ---------------------------- MPD announces state update: player Jul 20 03:51:50 volumio volumio[922]: info: ------------------------------ 6ms Jul 20 03:51:50 volumio volumio[922]: info: sendMpdCommand play took 6 milliseconds Jul 20 03:51:50 volumio volumio[922]: info: ControllerMpd::getState Jul 20 03:51:50 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand status Jul 20 03:51:50 volumio volumio[922]: info: ------------------------------ 5ms Jul 20 03:51:50 volumio volumio[922]: info: Jul 20 03:51:50 volumio volumio[922]: ---------------------------- MPD announces state update: player Jul 20 03:51:50 volumio volumio[922]: info: ControllerMpd::getState Jul 20 03:51:50 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand status Jul 20 03:51:50 volumio volumio[922]: info: Jul 20 03:51:50 volumio volumio[922]: ---------------------------- MPD announces state update: player Jul 20 03:51:50 volumio volumio[922]: info: sendMpdCommand status took 22 milliseconds Jul 20 03:51:50 volumio volumio[922]: info: ControllerMpd::getState Jul 20 03:51:50 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand status Jul 20 03:51:50 volumio volumio[922]: info: sendMpdCommand status took 22 milliseconds Jul 20 03:51:50 volumio volumio[922]: verbose: ControllerMpd::parseState Jul 20 03:51:50 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 20 03:51:50 volumio volumio[922]: verbose: ControllerMpd::parseState Jul 20 03:51:50 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 20 03:51:50 volumio volumio[922]: info: Jul 20 03:51:50 volumio volumio[922]: ---------------------------- MPD announces state update: player Jul 20 03:51:50 volumio volumio[922]: info: ControllerMpd::getState Jul 20 03:51:50 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand status Jul 20 03:51:50 volumio volumio[922]: info: sendMpdCommand status took 8 milliseconds Jul 20 03:51:50 volumio volumio[922]: info: sendMpdCommand playlistinfo took 7 milliseconds Jul 20 03:51:50 volumio volumio[922]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 20 03:51:50 volumio volumio[922]: info: sendMpdCommand status took 3 milliseconds Jul 20 03:51:50 volumio volumio[922]: verbose: ControllerMpd::parseState Jul 20 03:51:50 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 20 03:51:50 volumio volumio[922]: verbose: ControllerMpd::parseTrackInfo Jul 20 03:51:50 volumio volumio[922]: verbose: ControllerMpd::parseTrackInfo Jul 20 03:51:50 volumio volumio[922]: verbose: ControllerMpd::parseState Jul 20 03:51:50 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 20 03:51:50 volumio volumio[922]: info: ControllerMpd::pushState Jul 20 03:51:50 volumio volumio[922]: info: CoreCommandRouter::servicePushState Jul 20 03:51:50 volumio volumio[922]: info: CorePlayQueue::getTrack 8 Jul 20 03:51:50 volumio volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Wrecking Ball","artist":"Miley Cyrus","album":"Wrecking Ball","uri":"USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Wrecking Ball.mp3","trackType":"mp3"} Jul 20 03:51:50 volumio volumio[922]: verbose: CURRENT POSITION 8 Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::syncState stateService play Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::syncState currentStatus stop Jul 20 03:51:50 volumio volumio[922]: info: ControllerMpd::pushState Jul 20 03:51:50 volumio volumio[922]: info: CoreCommandRouter::servicePushState Jul 20 03:51:50 volumio volumio[922]: info: CorePlayQueue::getTrack 8 Jul 20 03:51:50 volumio volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":223,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Wrecking Ball","artist":"Miley Cyrus","album":"Wrecking Ball","uri":"USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Wrecking Ball.mp3","trackType":"mp3"} Jul 20 03:51:50 volumio volumio[922]: verbose: CURRENT POSITION 8 Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::syncState stateService play Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::syncState currentStatus play Jul 20 03:51:50 volumio volumio[922]: info: Received an update from plugin. extracting info from payload Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:50 volumio volumio[922]: info: CorePlayQueue::getTrack 8 Jul 20 03:51:50 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 03:51:50 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:50 volumio volumio[922]: info: CorePlayQueue::getTrack 8 Jul 20 03:51:50 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:50 volumio volumio[922]: info: ------------------------------ 66ms Jul 20 03:51:50 volumio volumio[922]: info: ------------------------------ 72ms Jul 20 03:51:50 volumio volumio[922]: info: sendMpdCommand playlistinfo took 38 milliseconds Jul 20 03:51:50 volumio volumio[922]: info: sendMpdCommand playlistinfo took 36 milliseconds Jul 20 03:51:50 volumio volumio[922]: verbose: ControllerMpd::parseTrackInfo Jul 20 03:51:50 volumio volumio[922]: verbose: ControllerMpd::parseTrackInfo Jul 20 03:51:50 volumio volumio[922]: info: ControllerMpd::pushState Jul 20 03:51:50 volumio volumio[922]: info: CoreCommandRouter::servicePushState Jul 20 03:51:50 volumio volumio[922]: info: CorePlayQueue::getTrack 8 Jul 20 03:51:50 volumio volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":102,"duration":223,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Wrecking Ball","artist":"Miley Cyrus","album":"Wrecking Ball","uri":"USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Wrecking Ball.mp3","trackType":"mp3"} Jul 20 03:51:50 volumio volumio[922]: verbose: CURRENT POSITION 8 Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::syncState stateService play Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::syncState currentStatus play Jul 20 03:51:50 volumio volumio[922]: info: Received an update from plugin. extracting info from payload Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:50 volumio volumio[922]: info: CorePlayQueue::getTrack 8 Jul 20 03:51:50 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 03:51:50 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:50 volumio volumio[922]: info: CorePlayQueue::getTrack 8 Jul 20 03:51:50 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:50 volumio volumio[922]: info: ControllerMpd::pushState Jul 20 03:51:50 volumio volumio[922]: info: CoreCommandRouter::servicePushState Jul 20 03:51:50 volumio volumio[922]: info: CorePlayQueue::getTrack 8 Jul 20 03:51:50 volumio volumio[922]: verbose: STATE SERVICE {"status":"play","position":0,"seek":194,"duration":223,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Wrecking Ball","artist":"Miley Cyrus","album":"Wrecking Ball","uri":"USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Wrecking Ball.mp3","trackType":"mp3"} Jul 20 03:51:50 volumio volumio[922]: verbose: CURRENT POSITION 8 Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::syncState stateService play Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::syncState currentStatus play Jul 20 03:51:50 volumio volumio[922]: info: Received an update from plugin. extracting info from payload Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:50 volumio volumio[922]: info: CorePlayQueue::getTrack 8 Jul 20 03:51:50 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 03:51:50 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:50 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:51:50 volumio volumio[922]: info: CorePlayQueue::getTrack 8 Jul 20 03:51:50 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:51:50 volumio volumio[922]: info: ------------------------------ 89ms Jul 20 03:51:50 volumio volumio[922]: info: ------------------------------ 82ms Jul 20 03:51:54 volumio volumio[922]: info: [jellyfin-poller-worker] _doPoll(): All servers polled. Will poll again in 30000ms. Jul 20 03:52:02 volumio volumio[922]: info: CoreCommandRouter::volumioPause Jul 20 03:52:02 volumio volumio[922]: info: CoreStateMachine::pause Jul 20 03:52:02 volumio volumio[922]: info: CoreStateMachine::stPlaybackTimer Jul 20 03:52:02 volumio volumio[922]: info: CoreStateMachine::servicePause Jul 20 03:52:02 volumio volumio[922]: info: CorePlayQueue::getTrack 8 Jul 20 03:52:02 volumio volumio[922]: info: CoreCommandRouter::servicePause Jul 20 03:52:02 volumio volumio[922]: info: ControllerMpd::pause Jul 20 03:52:02 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand pause Jul 20 03:52:02 volumio volumio[922]: info: sendMpdCommand pause took 94 milliseconds Jul 20 03:52:02 volumio volumio[922]: info: Jul 20 03:52:02 volumio volumio[922]: ---------------------------- MPD announces state update: player Jul 20 03:52:02 volumio volumio[922]: info: ControllerMpd::getState Jul 20 03:52:02 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand status Jul 20 03:52:02 volumio volumio[922]: info: Jul 20 03:52:02 volumio volumio[922]: ---------------------------- MPD announces state update: player Jul 20 03:52:02 volumio volumio[922]: info: ControllerMpd::getState Jul 20 03:52:02 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand status Jul 20 03:52:02 volumio volumio[922]: info: sendMpdCommand status took 3 milliseconds Jul 20 03:52:02 volumio volumio[922]: info: sendMpdCommand status took 1 milliseconds Jul 20 03:52:02 volumio volumio[922]: verbose: ControllerMpd::parseState Jul 20 03:52:02 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 20 03:52:02 volumio volumio[922]: verbose: ControllerMpd::parseState Jul 20 03:52:02 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 20 03:52:02 volumio volumio[922]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 20 03:52:02 volumio volumio[922]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 20 03:52:02 volumio volumio[922]: verbose: ControllerMpd::parseTrackInfo Jul 20 03:52:02 volumio volumio[922]: verbose: ControllerMpd::parseTrackInfo Jul 20 03:52:02 volumio volumio[922]: info: ControllerMpd::pushState Jul 20 03:52:02 volumio volumio[922]: info: CoreCommandRouter::servicePushState Jul 20 03:52:02 volumio volumio[922]: info: CorePlayQueue::getTrack 8 Jul 20 03:52:02 volumio volumio[922]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":12891,"duration":223,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Wrecking Ball","artist":"Miley Cyrus","album":"Wrecking Ball","uri":"USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Wrecking Ball.mp3","trackType":"mp3"} Jul 20 03:52:02 volumio volumio[922]: verbose: CURRENT POSITION 8 Jul 20 03:52:02 volumio volumio[922]: info: CoreStateMachine::syncState stateService pause Jul 20 03:52:02 volumio volumio[922]: info: CoreStateMachine::syncState currentStatus pause Jul 20 03:52:02 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:52:02 volumio volumio[922]: info: CorePlayQueue::getTrack 8 Jul 20 03:52:02 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 03:52:02 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:52:02 volumio volumio[922]: info: CoreStateMachine::stPlaybackTimer Jul 20 03:52:02 volumio volumio[922]: info: ControllerMpd::pushState Jul 20 03:52:02 volumio volumio[922]: info: CoreCommandRouter::servicePushState Jul 20 03:52:02 volumio volumio[922]: info: CorePlayQueue::getTrack 8 Jul 20 03:52:02 volumio volumio[922]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":12891,"duration":223,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Wrecking Ball","artist":"Miley Cyrus","album":"Wrecking Ball","uri":"USB/0E93-C36B/NAVERMUSIC_20200823/Miley Cyrus-1-Wrecking Ball.mp3","trackType":"mp3"} Jul 20 03:52:02 volumio volumio[922]: verbose: CURRENT POSITION 8 Jul 20 03:52:02 volumio volumio[922]: info: CoreStateMachine::syncState stateService pause Jul 20 03:52:02 volumio volumio[922]: info: CoreStateMachine::syncState currentStatus pause Jul 20 03:52:02 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:52:02 volumio volumio[922]: info: CorePlayQueue::getTrack 8 Jul 20 03:52:02 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:52:02 volumio volumio[922]: info: CoreStateMachine::stPlaybackTimer Jul 20 03:52:02 volumio volumio[922]: info: ------------------------------ 30ms Jul 20 03:52:02 volumio volumio[922]: info: ------------------------------ 29ms Jul 20 03:52:03 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Jul 20 03:52:03 volumio volumio[922]: info: Preload queue cleared Jul 20 03:52:04 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: personal_radio , handleBrowseUri Jul 20 03:52:04 volumio volumio[922]: info: Preload queue cleared Jul 20 03:52:11 volumio volumio[922]: info: Preload queue cleared Jul 20 03:52:11 volumio volumio[922]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 20 03:52:11 volumio volumio[922]: info: CoreStateMachine::ClearQueue Jul 20 03:52:11 volumio volumio[922]: info: CoreStateMachine::stop Jul 20 03:52:11 volumio volumio[922]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 20 03:52:11 volumio volumio[922]: info: CoreStateMachine::updateTrackBlock Jul 20 03:52:11 volumio volumio[922]: info: CorePlayQueue::getTrackBlock Jul 20 03:52:11 volumio volumio[922]: info: CoreStateMachine::stPlaybackTimer Jul 20 03:52:11 volumio volumio[922]: info: CoreStateMachine::pushState Jul 20 03:52:11 volumio volumio[922]: info: CorePlayQueue::getTrack 8 Jul 20 03:52:11 volumio volumio[922]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 03:52:11 volumio volumio[922]: info: CoreCommandRouter::volumioPushState Jul 20 03:52:11 volumio volumio[922]: info: CoreStateMachine::serviceStop Jul 20 03:52:11 volumio volumio[922]: info: CorePlayQueue::getTrack 8 Jul 20 03:52:11 volumio volumio[922]: info: CoreCommandRouter::serviceStop Jul 20 03:52:11 volumio volumio[922]: info: ControllerMpd::stop Jul 20 03:52:11 volumio volumio[922]: verbose: ControllerMpd::sendMpdCommand stop Jul 20 03:52:11 volumio volumio[922]: info: CorePlayQueue::clearPlayQueue Jul 20 03:52:11 volumio volumio[922]: info: CorePlayQueue::saveQueue Jul 20 03:52:11 volumio volumio[922]: info: CoreCommandRouter::volumioPushQueue Jul 20 03:52:11 volumio volumio[922]: info: CoreStateMachine::addQueueItems Jul 20 03:52:11 volumio volumio[922]: info: CorePlayQueue::addQueueItems Jul 20 03:52:11 volumio volumio[922]: info: Preload queue cleared Jul 20 03:52:11 volumio volumio[922]: info: Adding Item to queue: webkbs/0 Jul 20 03:52:11 volumio volumio[922]: info: Exploding uri webkbs/0 in service personal_radio Jul 20 03:52:11 volumio volumio[922]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 20 03:52:11 volumio volumio[922]: ReferenceError: self is not defined Jul 20 03:52:11 volumio volumio[922]: at ControllerPersonalRadio.errorToast (/data/plugins/music_service/personal_radio/index.js:575:22) Jul 20 03:52:11 volumio volumio[922]: at /data/plugins/music_service/personal_radio/index.js:487:12 Jul 20 03:52:11 volumio volumio[922]: at Request.handleRequestResponse [as _callback] (/data/plugins/music_service/personal_radio/node_modules/unirest/index.js:355:15) Jul 20 03:52:11 volumio volumio[922]: at self.callback (/data/plugins/music_service/personal_radio/node_modules/request/request.js:187:22) Jul 20 03:52:11 volumio volumio[922]: at Request.emit (events.js:315:20) Jul 20 03:52:11 volumio volumio[922]: at Request.init (/data/plugins/music_service/personal_radio/node_modules/request/request.js:233:17) Jul 20 03:52:11 volumio volumio[922]: at new Request (/data/plugins/music_service/personal_radio/node_modules/request/request.js:129:8) Jul 20 03:52:11 volumio volumio[922]: at Function.request (/data/plugins/music_service/personal_radio/node_modules/request/index.js:55:10) Jul 20 03:52:11 volumio volumio[922]: at Object.end (/data/plugins/music_service/personal_radio/node_modules/unirest/index.js:595:27) Jul 20 03:52:11 volumio volumio[922]: at ControllerPersonalRadio.getStreamUrl (/data/plugins/music_service/personal_radio/index.js:482:4) Jul 20 03:52:11 volumio volumio[922]: at ControllerPersonalRadio.explodeUri (/data/plugins/music_service/personal_radio/index.js:355:12) Jul 20 03:52:11 volumio volumio[922]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1353:16) Jul 20 03:52:11 volumio volumio[922]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Jul 20 03:52:11 volumio volumio[922]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Jul 20 03:52:11 volumio volumio[922]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Jul 20 03:52:11 volumio volumio[922]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:243:25) Jul 20 03:52:11 volumio volumio[922]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 20 03:52:11 volumio sudo[1815]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-20 03:51 Jul 20 03:52:11 volumio sudo[1815]: 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="b1c3cf61c2a0027c66bab1eb0a3795f80c1f2e95" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="e3eb3ee5b16063502f3a1735e11a28cfe54a0f46" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 25 Jun 2023 07:20:58 PM CEST" VOLUMIO_VERSION="3.512" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="946a42b62509f37b5e7e2d86a2932a62"