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