-- 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"