-- Logs begin at Sun 2024-07-14 11:34:44 UTC, end at Mon 2024-07-15 15:04:30 UTC. --
Jul 15 15:03:00 volumio volumio[876]: info: All search sources collected, pushing search results
Jul 15 15:03:00 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:00 volumio volumio[876]: info: CorePlayQueue::getTrack 0
Jul 15 15:03:00 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:00 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:00 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:01 volumio volumio[876]: Searching plugin music_service/mpd
Jul 15 15:03:01 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Jul 15 15:03:01 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:01 volumio volumio[876]: info: CorePlayQueue::getTrack 0
Jul 15 15:03:01 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:01 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:01 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:01 volumio volumio[876]: info: All search sources collected, pushing search results
Jul 15 15:03:02 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jul 15 15:03:02 volumio volumio[876]: info: CURURI: artists://Destiny's%20Child
Jul 15 15:03:02 volumio volumio[876]: info: Preload queue cleared
Jul 15 15:03:02 volumio volumio[876]: info: Preload queue cleared
Jul 15 15:03:02 volumio volumio[876]: info: Preloading song: music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/01 Intro (The Writing's On The Wall).wav
Jul 15 15:03:02 volumio volumio[876]: info: Preloading song: music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/02 So Good.wav
Jul 15 15:03:02 volumio volumio[876]: info: Preloading song: music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/03 Bills, Bills, Bills.wav
Jul 15 15:03:02 volumio volumio[876]: info: Preloading song: music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/04 Confessions.wav
Jul 15 15:03:02 volumio volumio[876]: info: Preloading song: music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/05 Bug A Boo.wav
Jul 15 15:03:02 volumio volumio[876]: info: Preloading song: music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/06 Temptation.wav
Jul 15 15:03:02 volumio volumio[876]: info: Preloading song: music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/07 Now That She's Gone.wav
Jul 15 15:03:02 volumio volumio[876]: info: Preloading song: music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/08 Where'd You Go.wav
Jul 15 15:03:02 volumio volumio[876]: info: Preloading song: music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/09 Hey Ladies.wav
Jul 15 15:03:02 volumio volumio[876]: info: Preloading song: music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/10 If You Leave.wav
Jul 15 15:03:02 volumio volumio[876]: info: Preloading song: music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/11 Jumpin' Jumpin'.wav
Jul 15 15:03:02 volumio volumio[876]: info: Preloading song: music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/12 Say My Name.wav
Jul 15 15:03:02 volumio volumio[876]: info: Preloading song: music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/13 She Can't Love You.wav
Jul 15 15:03:02 volumio volumio[876]: info: Preloading song: music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/14 Stay.wav
Jul 15 15:03:02 volumio volumio[876]: info: Preloading song: music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/15 Sweet Sixteen.wav
Jul 15 15:03:02 volumio volumio[876]: info: Preloading song: music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/16 Outro (Amazing Grace Dedicated to Andretta Tillman).wav
Jul 15 15:03:02 volumio volumio[876]: info: Preloading song: music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/17 Get On The Bus.wav
Jul 15 15:03:02 volumio volumio[876]: info: Exploding uri music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/01 Intro (The Writing's On The Wall).wav in service mpd
Jul 15 15:03:02 volumio volumio[876]: info: ALBUMART /albumart?cacheid=114&web=Destiny's%20Child/The%20Writing's%20On%20The%20Wall/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FMusic%2FDestiny's%20Child%2FThe%20Writing's%20On%20The%20Wall%2F01%20Intro%20(The%20Writing's%20On%20The%20Wall).wav&metadata=false
Jul 15 15:03:02 volumio volumio[876]: info: URI /mnt/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/01 Intro (The Writing's On The Wall).wav
Jul 15 15:03:02 volumio volumio[876]: info: No valid Plugin REST Endpoint
Jul 15 15:03:02 volumio volumio[876]: info: No valid Plugin REST Endpoint
Jul 15 15:03:02 volumio volumio[876]: info: Exploding uri music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/02 So Good.wav in service mpd
Jul 15 15:03:02 volumio volumio[876]: info: ALBUMART /albumart?cacheid=114&web=Destiny's%20Child/The%20Writing's%20On%20The%20Wall/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FMusic%2FDestiny's%20Child%2FThe%20Writing's%20On%20The%20Wall%2F02%20So%20Good.wav&metadata=false
Jul 15 15:03:02 volumio volumio[876]: info: URI /mnt/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/02 So Good.wav
Jul 15 15:03:02 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:02 volumio volumio[876]: info: CorePlayQueue::getTrack 0
Jul 15 15:03:02 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:02 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:02 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:02 volumio volumio[876]: info: Exploding uri music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/03 Bills, Bills, Bills.wav in service mpd
Jul 15 15:03:02 volumio volumio[876]: info: ALBUMART /albumart?cacheid=114&web=Destiny's%20Child/The%20Writing's%20On%20The%20Wall/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FMusic%2FDestiny's%20Child%2FThe%20Writing's%20On%20The%20Wall%2F03%20Bills%2C%20Bills%2C%20Bills.wav&metadata=false
Jul 15 15:03:02 volumio volumio[876]: info: URI /mnt/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/03 Bills, Bills, Bills.wav
Jul 15 15:03:02 volumio volumio[876]: info: Exploding uri music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/04 Confessions.wav in service mpd
Jul 15 15:03:02 volumio volumio[876]: info: ALBUMART /albumart?cacheid=114&web=Destiny's%20Child/The%20Writing's%20On%20The%20Wall/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FMusic%2FDestiny's%20Child%2FThe%20Writing's%20On%20The%20Wall%2F04%20Confessions.wav&metadata=false
Jul 15 15:03:02 volumio volumio[876]: info: URI /mnt/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/04 Confessions.wav
Jul 15 15:03:02 volumio volumio[876]: info: Exploding uri music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/05 Bug A Boo.wav in service mpd
Jul 15 15:03:02 volumio volumio[876]: info: ALBUMART /albumart?cacheid=114&web=Destiny's%20Child/The%20Writing's%20On%20The%20Wall/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FMusic%2FDestiny's%20Child%2FThe%20Writing's%20On%20The%20Wall%2F05%20Bug%20A%20Boo.wav&metadata=false
Jul 15 15:03:02 volumio volumio[876]: info: URI /mnt/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/05 Bug A Boo.wav
Jul 15 15:03:02 volumio volumio[876]: info: Exploding uri music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/06 Temptation.wav in service mpd
Jul 15 15:03:02 volumio volumio[876]: info: ALBUMART /albumart?cacheid=114&web=Destiny's%20Child/The%20Writing's%20On%20The%20Wall/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FMusic%2FDestiny's%20Child%2FThe%20Writing's%20On%20The%20Wall%2F06%20Temptation.wav&metadata=false
Jul 15 15:03:02 volumio volumio[876]: info: URI /mnt/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/06 Temptation.wav
Jul 15 15:03:02 volumio volumio[876]: info: Exploding uri music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/07 Now That She's Gone.wav in service mpd
Jul 15 15:03:02 volumio volumio[876]: info: ALBUMART /albumart?cacheid=114&web=Destiny's%20Child/The%20Writing's%20On%20The%20Wall/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FMusic%2FDestiny's%20Child%2FThe%20Writing's%20On%20The%20Wall%2F07%20Now%20That%20She's%20Gone.wav&metadata=false
Jul 15 15:03:02 volumio volumio[876]: info: URI /mnt/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/07 Now That She's Gone.wav
Jul 15 15:03:02 volumio volumio[876]: info: Exploding uri music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/08 Where'd You Go.wav in service mpd
Jul 15 15:03:02 volumio volumio[876]: info: ALBUMART /albumart?cacheid=114&web=Destiny's%20Child/The%20Writing's%20On%20The%20Wall/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FMusic%2FDestiny's%20Child%2FThe%20Writing's%20On%20The%20Wall%2F08%20Where'd%20You%20Go.wav&metadata=false
Jul 15 15:03:02 volumio volumio[876]: info: URI /mnt/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/08 Where'd You Go.wav
Jul 15 15:03:02 volumio volumio[876]: info: Exploding uri music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/09 Hey Ladies.wav in service mpd
Jul 15 15:03:02 volumio volumio[876]: info: ALBUMART /albumart?cacheid=114&web=Destiny's%20Child/The%20Writing's%20On%20The%20Wall/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FMusic%2FDestiny's%20Child%2FThe%20Writing's%20On%20The%20Wall%2F09%20Hey%20Ladies.wav&metadata=false
Jul 15 15:03:02 volumio volumio[876]: info: URI /mnt/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/09 Hey Ladies.wav
Jul 15 15:03:02 volumio volumio[876]: info: Exploding uri music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/10 If You Leave.wav in service mpd
Jul 15 15:03:02 volumio volumio[876]: info: ALBUMART /albumart?cacheid=114&web=Destiny's%20Child/The%20Writing's%20On%20The%20Wall/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FMusic%2FDestiny's%20Child%2FThe%20Writing's%20On%20The%20Wall%2F10%20If%20You%20Leave.wav&metadata=false
Jul 15 15:03:02 volumio volumio[876]: info: URI /mnt/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/10 If You Leave.wav
Jul 15 15:03:02 volumio volumio[876]: info: Exploding uri music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/11 Jumpin' Jumpin'.wav in service mpd
Jul 15 15:03:02 volumio volumio[876]: info: ALBUMART /albumart?cacheid=114&web=Destiny's%20Child/The%20Writing's%20On%20The%20Wall/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FMusic%2FDestiny's%20Child%2FThe%20Writing's%20On%20The%20Wall%2F11%20Jumpin'%20Jumpin'.wav&metadata=false
Jul 15 15:03:02 volumio volumio[876]: info: URI /mnt/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/11 Jumpin' Jumpin'.wav
Jul 15 15:03:03 volumio volumio[876]: info: Exploding uri music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/12 Say My Name.wav in service mpd
Jul 15 15:03:03 volumio volumio[876]: info: ALBUMART /albumart?cacheid=114&web=Destiny's%20Child/The%20Writing's%20On%20The%20Wall/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FMusic%2FDestiny's%20Child%2FThe%20Writing's%20On%20The%20Wall%2F12%20Say%20My%20Name.wav&metadata=false
Jul 15 15:03:03 volumio volumio[876]: info: URI /mnt/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/12 Say My Name.wav
Jul 15 15:03:03 volumio volumio[876]: info: Exploding uri music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/13 She Can't Love You.wav in service mpd
Jul 15 15:03:03 volumio volumio[876]: info: ALBUMART /albumart?cacheid=114&web=Destiny's%20Child/The%20Writing's%20On%20The%20Wall/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FMusic%2FDestiny's%20Child%2FThe%20Writing's%20On%20The%20Wall%2F13%20She%20Can't%20Love%20You.wav&metadata=false
Jul 15 15:03:03 volumio volumio[876]: info: URI /mnt/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/13 She Can't Love You.wav
Jul 15 15:03:03 volumio volumio[876]: info: Exploding uri music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/14 Stay.wav in service mpd
Jul 15 15:03:03 volumio volumio[876]: info: ALBUMART /albumart?cacheid=114&web=Destiny's%20Child/The%20Writing's%20On%20The%20Wall/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FMusic%2FDestiny's%20Child%2FThe%20Writing's%20On%20The%20Wall%2F14%20Stay.wav&metadata=false
Jul 15 15:03:03 volumio volumio[876]: info: URI /mnt/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/14 Stay.wav
Jul 15 15:03:03 volumio volumio[876]: info: Exploding uri music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/15 Sweet Sixteen.wav in service mpd
Jul 15 15:03:03 volumio volumio[876]: info: ALBUMART /albumart?cacheid=114&web=Destiny's%20Child/The%20Writing's%20On%20The%20Wall/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FMusic%2FDestiny's%20Child%2FThe%20Writing's%20On%20The%20Wall%2F15%20Sweet%20Sixteen.wav&metadata=false
Jul 15 15:03:03 volumio volumio[876]: info: URI /mnt/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/15 Sweet Sixteen.wav
Jul 15 15:03:03 volumio volumio[876]: info: Exploding uri music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/16 Outro (Amazing Grace Dedicated to Andretta Tillman).wav in service mpd
Jul 15 15:03:03 volumio volumio[876]: info: ALBUMART /albumart?cacheid=114&web=Destiny's%20Child/The%20Writing's%20On%20The%20Wall/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FMusic%2FDestiny's%20Child%2FThe%20Writing's%20On%20The%20Wall%2F16%20Outro%20(Amazing%20Grace%20Dedicated%20to%20Andretta%20Tillman).wav&metadata=false
Jul 15 15:03:03 volumio volumio[876]: info: URI /mnt/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/16 Outro (Amazing Grace Dedicated to Andretta Tillman).wav
Jul 15 15:03:03 volumio volumio[876]: info: Exploding uri music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/17 Get On The Bus.wav in service mpd
Jul 15 15:03:03 volumio volumio[876]: info: ALBUMART /albumart?cacheid=114&web=Destiny's%20Child/The%20Writing's%20On%20The%20Wall/extralarge&path=%2Fmnt%2FNAS%2FMusic%2FMusic%2FDestiny's%20Child%2FThe%20Writing's%20On%20The%20Wall%2F17%20Get%20On%20The%20Bus.wav&metadata=false
Jul 15 15:03:03 volumio volumio[876]: info: URI /mnt/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/17 Get On The Bus.wav
Jul 15 15:03:03 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:03 volumio volumio[876]: info: CorePlayQueue::getTrack 0
Jul 15 15:03:03 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:03 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:03 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:04 volumio volumio[876]: info: CorePlayQueue::getTrack 0
Jul 15 15:03:04 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:04 volumio volumio[876]: info: Prefetching next song
Jul 15 15:03:04 volumio volumio[876]: info: DOING PREFETCH IN MPD
Jul 15 15:03:04 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/Music/Talk Talk/(1984) It's My Life/02 Such A Shame.wav"
Jul 15 15:03:04 volumio volumio[876]: info: sendMpdCommand add "NAS/Music/Music/Talk Talk/(1984) It's My Life/02 Such A Shame.wav" took 0 milliseconds
Jul 15 15:03:04 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand consume 1
Jul 15 15:03:04 volumio volumio[876]: info:
Jul 15 15:03:04 volumio volumio[876]: ---------------------------- MPD announces system playlist update
Jul 15 15:03:04 volumio volumio[876]: info: Ignoring MPD Status Update
Jul 15 15:03:04 volumio volumio[876]: info: sendMpdCommand consume 1 took 0 milliseconds
Jul 15 15:03:04 volumio volumio[876]: info:
Jul 15 15:03:04 volumio volumio[876]: ---------------------------- MPD announces system playlist update
Jul 15 15:03:04 volumio volumio[876]: info: Ignoring MPD Status Update
Jul 15 15:03:04 volumio volumio[876]: info:
Jul 15 15:03:04 volumio volumio[876]: ---------------------------- MPD announces system playlist update
Jul 15 15:03:04 volumio volumio[876]: info: Ignoring MPD Status Update
Jul 15 15:03:04 volumio volumio[876]: info: ------------------------------ 2ms
Jul 15 15:03:04 volumio volumio[876]: info: ------------------------------ 1ms
Jul 15 15:03:04 volumio volumio[876]: info: ------------------------------ 2ms
Jul 15 15:03:04 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:04 volumio volumio[876]: info: CorePlayQueue::getTrack 0
Jul 15 15:03:04 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:04 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:04 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:05 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:05 volumio volumio[876]: info: CorePlayQueue::getTrack 0
Jul 15 15:03:05 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:05 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:05 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:06 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:06 volumio volumio[876]: info: CorePlayQueue::getTrack 0
Jul 15 15:03:06 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:06 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:06 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:07 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:07 volumio volumio[876]: info: CorePlayQueue::getTrack 0
Jul 15 15:03:07 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:07 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:07 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:08 volumio volumio[876]: info: CoreStateMachine::startPlaybackTimer
Jul 15 15:03:08 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:08 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:08 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:08 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:08 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:08 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:08 volumio volumio[876]: info:
Jul 15 15:03:08 volumio volumio[876]: ---------------------------- MPD announces system playlist update
Jul 15 15:03:08 volumio volumio[876]: info: Ignoring MPD Status Update
Jul 15 15:03:08 volumio volumio[876]: info:
Jul 15 15:03:08 volumio volumio[876]: ---------------------------- MPD announces state update: player
Jul 15 15:03:08 volumio volumio[876]: info: ControllerMpd::getState
Jul 15 15:03:08 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 15:03:08 volumio volumio[876]: info:
Jul 15 15:03:08 volumio volumio[876]: ---------------------------- MPD announces system playlist update
Jul 15 15:03:08 volumio volumio[876]: info: Ignoring MPD Status Update
Jul 15 15:03:08 volumio volumio[876]: info:
Jul 15 15:03:08 volumio volumio[876]: ---------------------------- MPD announces state update: player
Jul 15 15:03:08 volumio volumio[876]: info: ControllerMpd::getState
Jul 15 15:03:08 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 15:03:08 volumio volumio[876]: info:
Jul 15 15:03:08 volumio volumio[876]: ---------------------------- MPD announces system playlist update
Jul 15 15:03:08 volumio volumio[876]: info: Ignoring MPD Status Update
Jul 15 15:03:08 volumio volumio[876]: info:
Jul 15 15:03:08 volumio volumio[876]: ---------------------------- MPD announces state update: player
Jul 15 15:03:08 volumio volumio[876]: info: ControllerMpd::getState
Jul 15 15:03:08 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::pushState
Jul 15 15:03:09 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::volumioPushState
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::volumioAddQueueItems
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::addQueueItems
Jul 15 15:03:09 volumio volumio[876]: info: CorePlayQueue::addQueueItems
Jul 15 15:03:09 volumio volumio[876]: info: Preload queue cleared
Jul 15 15:03:09 volumio volumio[876]: info: Adding Item to queue: music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/02 So Good.wav
Jul 15 15:03:09 volumio volumio[876]: info: Using cached record of: music-library/NAS/Music/Music/Destiny's Child/The Writing's On The Wall/02 So Good.wav
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::volumioPushQueue
Jul 15 15:03:09 volumio volumio[876]: info: CorePlayQueue::saveQueue
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::updateTrackBlock
Jul 15 15:03:09 volumio volumio[876]: info: CorePlayQueue::getTrackBlock
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:09 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:09 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:09 volumio kernel: xhci_hcd 0000:01:00.0: ERROR Transfer event for disabled endpoint slot 2 ep 9
Jul 15 15:03:09 volumio kernel: xhci_hcd 0000:01:00.0: @000000042a1162f0 00000000 00000000 0e000000 020a8000
Jul 15 15:03:09 volumio volumio[876]: info:
Jul 15 15:03:09 volumio volumio[876]: ---------------------------- MPD announces state update: player
Jul 15 15:03:09 volumio volumio[876]: info: ------------------------------ 1302ms
Jul 15 15:03:09 volumio volumio[876]: info: sendMpdCommand status took 1302 milliseconds
Jul 15 15:03:09 volumio volumio[876]: info: ControllerMpd::getState
Jul 15 15:03:09 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 15:03:09 volumio volumio[876]: verbose: ControllerMpd::parseState
Jul 15 15:03:09 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 15 15:03:09 volumio volumio[876]: info: ------------------------------ 1303ms
Jul 15 15:03:09 volumio volumio[876]: info: sendMpdCommand status took 1302 milliseconds
Jul 15 15:03:09 volumio volumio[876]: info: ------------------------------ 1303ms
Jul 15 15:03:09 volumio volumio[876]: info: sendMpdCommand status took 1303 milliseconds
Jul 15 15:03:09 volumio volumio[876]: info: sendMpdCommand status took 2 milliseconds
Jul 15 15:03:09 volumio volumio[876]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jul 15 15:03:09 volumio volumio[876]: verbose: ControllerMpd::parseState
Jul 15 15:03:09 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 15 15:03:09 volumio volumio[876]: verbose: ControllerMpd::parseState
Jul 15 15:03:09 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 15 15:03:09 volumio volumio[876]: verbose: ControllerMpd::parseState
Jul 15 15:03:09 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 15 15:03:09 volumio volumio[876]: verbose: ControllerMpd::parseTrackInfo
Jul 15 15:03:09 volumio volumio[876]: info: ControllerMpd::pushState
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::servicePushState
Jul 15 15:03:09 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:09 volumio volumio[876]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":336,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Such A Shame","artist":"Talk Talk","album":"It's My Life","uri":"NAS/Music/Music/Talk Talk/(1984) It's My Life/02 Such A Shame.wav","trackType":"wav"}
Jul 15 15:03:09 volumio volumio[876]: verbose: CURRENT POSITION 1
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::syncState stateService play
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::syncState currentStatus play
Jul 15 15:03:09 volumio volumio[876]: info: Received an update from plugin. extracting info from payload
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::pushState
Jul 15 15:03:09 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::volumioPushState
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::pushState
Jul 15 15:03:09 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::volumioPushState
Jul 15 15:03:09 volumio volumio[876]: info: ------------------------------ 1312ms
Jul 15 15:03:09 volumio volumio[876]: info:
Jul 15 15:03:09 volumio volumio[876]: ---------------------------- MPD announces state update: player
Jul 15 15:03:09 volumio volumio[876]: info: ControllerMpd::getState
Jul 15 15:03:09 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 15:03:09 volumio volumio[876]: info:
Jul 15 15:03:09 volumio volumio[876]: ---------------------------- MPD announces state update: player
Jul 15 15:03:09 volumio volumio[876]: info: ControllerMpd::getState
Jul 15 15:03:09 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand status
Jul 15 15:03:09 volumio volumio[876]: info: sendMpdCommand playlistinfo took 12 milliseconds
Jul 15 15:03:09 volumio volumio[876]: info: sendMpdCommand playlistinfo took 11 milliseconds
Jul 15 15:03:09 volumio volumio[876]: info: sendMpdCommand playlistinfo took 12 milliseconds
Jul 15 15:03:09 volumio volumio[876]: info: sendMpdCommand status took 4 milliseconds
Jul 15 15:03:09 volumio volumio[876]: info: sendMpdCommand status took 3 milliseconds
Jul 15 15:03:09 volumio volumio[876]: verbose: ControllerMpd::parseTrackInfo
Jul 15 15:03:09 volumio volumio[876]: verbose: ControllerMpd::parseTrackInfo
Jul 15 15:03:09 volumio volumio[876]: verbose: ControllerMpd::parseTrackInfo
Jul 15 15:03:09 volumio volumio[876]: verbose: ControllerMpd::parseState
Jul 15 15:03:09 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 15 15:03:09 volumio volumio[876]: verbose: ControllerMpd::parseState
Jul 15 15:03:09 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 15 15:03:09 volumio volumio[876]: info: ControllerMpd::pushState
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::servicePushState
Jul 15 15:03:09 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:09 volumio volumio[876]: verbose: STATE SERVICE {"status":"play","position":0,"seek":114,"duration":336,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Such A Shame","artist":"Talk Talk","album":"It's My Life","uri":"NAS/Music/Music/Talk Talk/(1984) It's My Life/02 Such A Shame.wav","trackType":"wav"}
Jul 15 15:03:09 volumio volumio[876]: verbose: CURRENT POSITION 1
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::syncState stateService play
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::syncState currentStatus play
Jul 15 15:03:09 volumio volumio[876]: info: Received an update from plugin. extracting info from payload
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::pushState
Jul 15 15:03:09 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::volumioPushState
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::pushState
Jul 15 15:03:09 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::volumioPushState
Jul 15 15:03:09 volumio volumio[876]: info: ControllerMpd::pushState
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::servicePushState
Jul 15 15:03:09 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:09 volumio volumio[876]: verbose: STATE SERVICE {"status":"play","position":0,"seek":183,"duration":336,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Such A Shame","artist":"Talk Talk","album":"It's My Life","uri":"NAS/Music/Music/Talk Talk/(1984) It's My Life/02 Such A Shame.wav","trackType":"wav"}
Jul 15 15:03:09 volumio volumio[876]: verbose: CURRENT POSITION 1
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::syncState stateService play
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::syncState currentStatus play
Jul 15 15:03:09 volumio volumio[876]: info: Received an update from plugin. extracting info from payload
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::pushState
Jul 15 15:03:09 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::volumioPushState
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::pushState
Jul 15 15:03:09 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::volumioPushState
Jul 15 15:03:09 volumio volumio[876]: info: ControllerMpd::pushState
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::servicePushState
Jul 15 15:03:09 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:09 volumio volumio[876]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":336,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Such A Shame","artist":"Talk Talk","album":"It's My Life","uri":"NAS/Music/Music/Talk Talk/(1984) It's My Life/02 Such A Shame.wav","trackType":"wav"}
Jul 15 15:03:09 volumio volumio[876]: verbose: CURRENT POSITION 1
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::syncState stateService play
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::syncState currentStatus play
Jul 15 15:03:09 volumio volumio[876]: info: Received an update from plugin. extracting info from payload
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::pushState
Jul 15 15:03:09 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::volumioPushState
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::pushState
Jul 15 15:03:09 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::volumioPushState
Jul 15 15:03:09 volumio volumio[876]: info: ------------------------------ 1342ms
Jul 15 15:03:09 volumio volumio[876]: info: ------------------------------ 1342ms
Jul 15 15:03:09 volumio volumio[876]: info: ------------------------------ 43ms
Jul 15 15:03:09 volumio volumio[876]: info: sendMpdCommand playlistinfo took 27 milliseconds
Jul 15 15:03:09 volumio volumio[876]: info: sendMpdCommand playlistinfo took 26 milliseconds
Jul 15 15:03:09 volumio volumio[876]: verbose: ControllerMpd::parseTrackInfo
Jul 15 15:03:09 volumio volumio[876]: verbose: ControllerMpd::parseTrackInfo
Jul 15 15:03:09 volumio volumio[876]: info: ControllerMpd::pushState
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::servicePushState
Jul 15 15:03:09 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:09 volumio volumio[876]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":336,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Such A Shame","artist":"Talk Talk","album":"It's My Life","uri":"NAS/Music/Music/Talk Talk/(1984) It's My Life/02 Such A Shame.wav","trackType":"wav"}
Jul 15 15:03:09 volumio volumio[876]: verbose: CURRENT POSITION 1
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::syncState stateService play
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::syncState currentStatus play
Jul 15 15:03:09 volumio volumio[876]: info: Received an update from plugin. extracting info from payload
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::pushState
Jul 15 15:03:09 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::volumioPushState
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::pushState
Jul 15 15:03:09 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::volumioPushState
Jul 15 15:03:09 volumio volumio[876]: info: ControllerMpd::pushState
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::servicePushState
Jul 15 15:03:09 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:09 volumio volumio[876]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":336,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Such A Shame","artist":"Talk Talk","album":"It's My Life","uri":"NAS/Music/Music/Talk Talk/(1984) It's My Life/02 Such A Shame.wav","trackType":"wav"}
Jul 15 15:03:09 volumio volumio[876]: verbose: CURRENT POSITION 1
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::syncState stateService play
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::syncState currentStatus play
Jul 15 15:03:09 volumio volumio[876]: info: Received an update from plugin. extracting info from payload
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::pushState
Jul 15 15:03:09 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::volumioPushState
Jul 15 15:03:09 volumio volumio[876]: info: CoreStateMachine::pushState
Jul 15 15:03:09 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:09 volumio volumio[876]: info: CoreCommandRouter::volumioPushState
Jul 15 15:03:09 volumio volumio[876]: info: ------------------------------ 45ms
Jul 15 15:03:09 volumio volumio[876]: info: ------------------------------ 43ms
Jul 15 15:03:10 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:10 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:10 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:10 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:10 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:11 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:11 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:11 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:11 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:11 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:12 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:12 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:12 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:12 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:12 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:13 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:13 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:13 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:13 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:13 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:14 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:14 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:14 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:14 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:14 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:15 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:15 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:15 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:15 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:15 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:16 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:16 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:16 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:16 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:16 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:17 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:17 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:17 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:17 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:17 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:18 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:18 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:18 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:18 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:18 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:19 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:19 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:19 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:19 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:19 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:20 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:20 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:20 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:20 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:20 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:21 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:21 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:21 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:21 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:21 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:22 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:22 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:22 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:22 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:22 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:23 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:23 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:23 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:23 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:23 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:24 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:24 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:24 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:24 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:24 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:25 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:25 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:25 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:25 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:25 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:26 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:26 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:26 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:26 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:26 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:27 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:27 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:27 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:27 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:27 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:27 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:27 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:28 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:28 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:28 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:28 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:28 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:29 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:29 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:29 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:29 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:29 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:29 volumio volumio[876]: info: CoreCommandRouter::getUIConfigOnPlugin
Jul 15 15:03:29 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Jul 15 15:03:29 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 15 15:03:29 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jul 15 15:03:29 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 15 15:03:29 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 15 15:03:29 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 15 15:03:29 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 15 15:03:29 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 15 15:03:29 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 15 15:03:29 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 15 15:03:29 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Jul 15 15:03:29 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Jul 15 15:03:30 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:30 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:30 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:30 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:30 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:31 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:31 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:31 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:31 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:31 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:32 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:32 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:32 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:32 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:32 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:33 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:33 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:33 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:33 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:33 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:34 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:34 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:34 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:34 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:34 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:35 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:35 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:35 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:35 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:35 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:36 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:36 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:36 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:36 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:36 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:37 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:37 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:37 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:37 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:37 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:38 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:38 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:38 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:38 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:38 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:39 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:39 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:39 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:39 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:39 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:40 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:40 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:40 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:40 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:40 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:41 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:41 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:41 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:41 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:41 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:42 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:42 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:42 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:42 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:42 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:43 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:43 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:43 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:43 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:43 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:44 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:44 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:44 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:44 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:44 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:45 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:45 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:45 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:45 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:45 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:46 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:46 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:46 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:46 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:46 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:47 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:47 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:47 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:47 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:47 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:48 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:48 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:48 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:48 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:48 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:49 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:49 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:49 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:49 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:49 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:50 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:50 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:50 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:50 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:50 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:51 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:51 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:51 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:51 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:51 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:52 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:52 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:52 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:52 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:52 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:53 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:53 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:53 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:53 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:53 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:53 volumio volumio[876]: info: CALLMETHOD: music_service mpd savePlaybackOptions [object Object]
Jul 15 15:03:53 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: mpd , savePlaybackOptions
Jul 15 15:03:53 volumio sudo[15302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jul 15 15:03:53 volumio sudo[15302]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 15 15:03:53 volumio sudo[15302]: pam_unix(sudo:session): session closed for user root
Jul 15 15:03:53 volumio volumio[876]: info: MPD Permissions set
Jul 15 15:03:53 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 15 15:03:53 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 15 15:03:53 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 15 15:03:53 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 15 15:03:53 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 15 15:03:53 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 15 15:03:53 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 15 15:03:53 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 15 15:03:53 volumio sudo[15305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jul 15 15:03:53 volumio sudo[15305]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 15 15:03:53 volumio systemd[1]: Stopping Music Player Daemon...
Jul 15 15:03:53 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 15 15:03:53 volumio volumio[876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 15 15:03:54 volumio systemd[1]: mpd.service: Succeeded.
Jul 15 15:03:54 volumio systemd[1]: Stopped Music Player Daemon.
Jul 15 15:03:54 volumio systemd[1]: Starting Music Player Daemon...
Jul 15 15:03:54 volumio sudo[15311]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jul 15 15:03:54 volumio sudo[15311]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 15 15:03:54 volumio sudo[15311]: pam_unix(sudo:session): session closed for user root
Jul 15 15:03:54 volumio volumio[876]: error: Upnp client error: Error: This socket has been ended by the other party
Jul 15 15:03:54 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:54 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:54 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:54 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:54 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:54 volumio mpd[15317]: Jul 15 15:03 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jul 15 15:03:55 volumio systemd[1]: Started Music Player Daemon.
Jul 15 15:03:55 volumio sudo[15305]: pam_unix(sudo:session): session closed for user root
Jul 15 15:03:55 volumio volumio[876]: error: updateQueue error: null
Jul 15 15:03:55 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:55 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:55 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:55 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:55 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:56 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:56 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:56 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:56 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:56 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:57 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:57 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:57 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:57 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:57 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:58 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:58 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:58 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:58 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:58 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:03:59 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:03:59 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:03:59 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:03:59 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:03:59 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:04:00 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:04:00 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:04:00 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:04:00 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:04:00 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:04:01 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:04:01 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:04:01 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:04:01 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:04:01 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:04:02 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:04:02 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:04:02 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:04:02 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:04:02 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:04:03 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:04:03 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:04:03 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:04:03 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:04:03 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:04:04 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:04:04 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:04:04 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:04:04 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:04:04 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:04:05 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:04:05 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:04:05 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:04:05 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:04:05 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:04:06 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:04:06 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:04:06 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:04:06 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:04:06 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:04:06 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:04:06 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:04:07 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:04:07 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:04:07 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:04:07 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:04:07 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:04:08 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:04:08 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:04:08 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:04:08 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:04:08 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:04:08 volumio volumio[876]: info: CoreCommandRouter::volumioPause
Jul 15 15:04:08 volumio volumio[876]: info: CoreStateMachine::pause
Jul 15 15:04:08 volumio volumio[876]: info: CoreStateMachine::stPlaybackTimer
Jul 15 15:04:08 volumio volumio[876]: info: CoreStateMachine::servicePause
Jul 15 15:04:08 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:04:08 volumio volumio[876]: info: CoreCommandRouter::servicePause
Jul 15 15:04:08 volumio volumio[876]: info: ControllerMpd::pause
Jul 15 15:04:08 volumio volumio[876]: verbose: ControllerMpd::sendMpdCommand pause
Jul 15 15:04:08 volumio volumio[876]: info: sendMpdCommand pause took 0 milliseconds
Jul 15 15:04:09 volumio volumio[876]: info: CoreCommandRouter::volumioGetState
Jul 15 15:04:09 volumio volumio[876]: info: CorePlayQueue::getTrack 1
Jul 15 15:04:09 volumio volumio[876]: info: CoreCommandRouter::volumioGetQueue
Jul 15 15:04:09 volumio volumio[876]: info: CoreStateMachine::getQueue
Jul 15 15:04:09 volumio volumio[876]: info: CorePlayQueue::getQueue
Jul 15 15:04:28 volumio volumio[876]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________
Jul 15 15:04:28 volumio volumio[876]: info: PLUGIN onReboot : networkfs
Jul 15 15:04:28 volumio sudo[15387]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /mnt/NAS/DSD_MUSIC
Jul 15 15:04:28 volumio sudo[15387]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 15 15:04:28 volumio systemd[1]: mnt-NAS-DSD_MUSIC.mount: Succeeded.
Jul 15 15:04:29 volumio sudo[15387]: pam_unix(sudo:session): session closed for user root
Jul 15 15:04:29 volumio sudo[15395]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /mnt/NAS/Leftovers
Jul 15 15:04:29 volumio sudo[15395]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 15 15:04:29 volumio systemd[1]: mnt-NAS-Leftovers.mount: Succeeded.
Jul 15 15:04:29 volumio sudo[15395]: pam_unix(sudo:session): session closed for user root
Jul 15 15:04:29 volumio sudo[15399]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /mnt/NAS/Music
Jul 15 15:04:29 volumio sudo[15399]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 15 15:04:29 volumio systemd[1]: mnt-NAS-Music.mount: Succeeded.
Jul 15 15:04:29 volumio sudo[15399]: pam_unix(sudo:session): session closed for user root
Jul 15 15:04:29 volumio volumio[876]: info: PLUGIN onReboot : audiophonicsonoff
Jul 15 15:04:29 volumio volumio[876]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 15 15:04:29 volumio volumio[876]: TypeError: Cannot read property 'writeSync' of undefined
Jul 15 15:04:29 volumio volumio[876]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_controller/audiophonicsonoff/index.js:35:25)
Jul 15 15:04:29 volumio volumio[876]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30)
Jul 15 15:04:29 volumio volumio[876]: at HashMap. (/volumio/app/pluginmanager.js:668:31)
Jul 15 15:04:29 volumio volumio[876]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10)
Jul 15 15:04:29 volumio volumio[876]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7)
Jul 15 15:04:29 volumio volumio[876]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20)
Jul 15 15:04:29 volumio volumio[876]: at CoreCommandRouter.reboot (/volumio/app/index.js:1331:22)
Jul 15 15:04:29 volumio volumio[876]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:857:33)
Jul 15 15:04:29 volumio volumio[876]: at Socket.emit (events.js:315:20)
Jul 15 15:04:29 volumio volumio[876]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
Jul 15 15:04:29 volumio volumio[876]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Jul 15 15:04:29 volumio volumio[876]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 15 15:04:30 volumio sudo[15411]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-15 15:03
Jul 15 15:04:30 volumio sudo[15411]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="4b122b2365bb8c09786cd63b50d1ea6db780eb4e"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST"
VOLUMIO_VERSION="3.703"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"