-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Tue 2024-04-16 13:03:46 UTC. -- Apr 16 13:02:15 volumio-p4 volumiologrotate[514]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Apr 16 13:02:15 volumio-p4 volumiologrotate[514]: ls: cannot access 'P4': No such file or directory Apr 16 13:02:51 volumio-p4 volumio[875]: info: Preload queue cleared Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::ClearQueue Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::stop Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::stPlaybackTimer Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::updateTrackBlock Apr 16 13:02:51 volumio-p4 volumio[875]: info: CorePlayQueue::getTrackBlock Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:02:51 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:02:51 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:02:51 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::serviceStop Apr 16 13:02:51 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreCommandRouter::serviceStop Apr 16 13:02:51 volumio-p4 volumio[875]: info: ControllerMpd::stop Apr 16 13:02:51 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand stop Apr 16 13:02:51 volumio-p4 volumio[875]: info: CorePlayQueue::clearPlayQueue Apr 16 13:02:51 volumio-p4 volumio[875]: info: CorePlayQueue::saveQueue Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushQueue Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::addQueueItems Apr 16 13:02:51 volumio-p4 volumio[875]: info: CorePlayQueue::addQueueItems Apr 16 13:02:51 volumio-p4 volumio[875]: info: Preload queue cleared Apr 16 13:02:51 volumio-p4 volumio[875]: info: Adding Item to queue: music-library/NAS/NAS2/Jazz/Nils Landgren, Michael Wollny, Lars Danielsson, Wolfgang Haffner - 4 Wheel Drive II (2023) [24-96] Apr 16 13:02:51 volumio-p4 volumio[875]: info: Exploding uri music-library/NAS/NAS2/Jazz/Nils Landgren, Michael Wollny, Lars Danielsson, Wolfgang Haffner - 4 Wheel Drive II (2023) [24-96] in service mpd Apr 16 13:02:51 volumio-p4 volumio[875]: info: Apr 16 13:02:51 volumio-p4 volumio[875]: ---------------------------- MPD announces state update: player Apr 16 13:02:51 volumio-p4 volumio[875]: info: ALBUMART /albumart?cacheid=105&web=Nils%20Landgren%2C%20Michael%20Wollny%2C%20Lars%20Danielsson%2C%20Wolfgang%20Haffner/4%20Wheel%20Drive%20II/extralarge&path=%2Fmnt%2FNAS%2FNAS2%2FJazz%2FNils%20Landgren%2C%20Michael%20Wollny%2C%20Lars%20Danielsson%2C%20Wolfgang%20Haffner%20-%204%20Wheel%20Drive%20II%20(2023)%20%5B24-96%5D%2F01.%20Chapter%20II.flac&metadata=false Apr 16 13:02:51 volumio-p4 volumio[875]: info: URI /mnt/NAS/NAS2/Jazz/Nils Landgren, Michael Wollny, Lars Danielsson, Wolfgang Haffner - 4 Wheel Drive II (2023) [24-96]/01. Chapter II.flac Apr 16 13:02:51 volumio-p4 volumio[875]: info: ALBUMART /albumart?cacheid=105&web=Nils%20Landgren%2C%20Michael%20Wollny%2C%20Lars%20Danielsson%2C%20Wolfgang%20Haffner/4%20Wheel%20Drive%20II/extralarge&path=%2Fmnt%2FNAS%2FNAS2%2FJazz%2FNils%20Landgren%2C%20Michael%20Wollny%2C%20Lars%20Danielsson%2C%20Wolfgang%20Haffner%20-%204%20Wheel%20Drive%20II%20(2023)%20%5B24-96%5D%2F02.%20Still%20Crazy%20After%20All%20These%20Years.flac&metadata=false Apr 16 13:02:51 volumio-p4 volumio[875]: info: URI /mnt/NAS/NAS2/Jazz/Nils Landgren, Michael Wollny, Lars Danielsson, Wolfgang Haffner - 4 Wheel Drive II (2023) [24-96]/02. Still Crazy After All These Years.flac Apr 16 13:02:51 volumio-p4 volumio[875]: info: ALBUMART /albumart?cacheid=105&web=Nils%20Landgren%2C%20Michael%20Wollny%2C%20Lars%20Danielsson%2C%20Wolfgang%20Haffner/4%20Wheel%20Drive%20II/extralarge&path=%2Fmnt%2FNAS%2FNAS2%2FJazz%2FNils%20Landgren%2C%20Michael%20Wollny%2C%20Lars%20Danielsson%2C%20Wolfgang%20Haffner%20-%204%20Wheel%20Drive%20II%20(2023)%20%5B24-96%5D%2F03.%20Hold%20on%20My%20Heart.flac&metadata=false Apr 16 13:02:51 volumio-p4 volumio[875]: info: URI /mnt/NAS/NAS2/Jazz/Nils Landgren, Michael Wollny, Lars Danielsson, Wolfgang Haffner - 4 Wheel Drive II (2023) [24-96]/03. Hold on My Heart.flac Apr 16 13:02:51 volumio-p4 volumio[875]: info: ALBUMART /albumart?cacheid=105&web=Nils%20Landgren%2C%20Michael%20Wollny%2C%20Lars%20Danielsson%2C%20Wolfgang%20Haffner/4%20Wheel%20Drive%20II/extralarge&path=%2Fmnt%2FNAS%2FNAS2%2FJazz%2FNils%20Landgren%2C%20Michael%20Wollny%2C%20Lars%20Danielsson%2C%20Wolfgang%20Haffner%20-%204%20Wheel%20Drive%20II%20(2023)%20%5B24-96%5D%2F04.%20The%20Sound%20of%20Silence.flac&metadata=false Apr 16 13:02:51 volumio-p4 volumio[875]: info: URI /mnt/NAS/NAS2/Jazz/Nils Landgren, Michael Wollny, Lars Danielsson, Wolfgang Haffner - 4 Wheel Drive II (2023) [24-96]/04. The Sound of Silence.flac Apr 16 13:02:51 volumio-p4 volumio[875]: info: ALBUMART /albumart?cacheid=105&web=Nils%20Landgren%2C%20Michael%20Wollny%2C%20Lars%20Danielsson%2C%20Wolfgang%20Haffner/4%20Wheel%20Drive%20II/extralarge&path=%2Fmnt%2FNAS%2FNAS2%2FJazz%2FNils%20Landgren%2C%20Michael%20Wollny%2C%20Lars%20Danielsson%2C%20Wolfgang%20Haffner%20-%204%20Wheel%20Drive%20II%20(2023)%20%5B24-96%5D%2F05.%20Just%20Another%20Minute.flac&metadata=false Apr 16 13:02:51 volumio-p4 volumio[875]: info: URI /mnt/NAS/NAS2/Jazz/Nils Landgren, Michael Wollny, Lars Danielsson, Wolfgang Haffner - 4 Wheel Drive II (2023) [24-96]/05. Just Another Minute.flac Apr 16 13:02:51 volumio-p4 volumio[875]: info: ALBUMART /albumart?cacheid=105&web=Nils%20Landgren%2C%20Michael%20Wollny%2C%20Lars%20Danielsson%2C%20Wolfgang%20Haffner/4%20Wheel%20Drive%20II/extralarge&path=%2Fmnt%2FNAS%2FNAS2%2FJazz%2FNils%20Landgren%2C%20Michael%20Wollny%2C%20Lars%20Danielsson%2C%20Wolfgang%20Haffner%20-%204%20Wheel%20Drive%20II%20(2023)%20%5B24-96%5D%2F06.%20Sunrise.flac&metadata=false Apr 16 13:02:51 volumio-p4 volumio[875]: info: URI /mnt/NAS/NAS2/Jazz/Nils Landgren, Michael Wollny, Lars Danielsson, Wolfgang Haffner - 4 Wheel Drive II (2023) [24-96]/06. Sunrise.flac Apr 16 13:02:51 volumio-p4 volumio[875]: info: ALBUMART /albumart?cacheid=105&web=Nils%20Landgren%2C%20Michael%20Wollny%2C%20Lars%20Danielsson%2C%20Wolfgang%20Haffner/4%20Wheel%20Drive%20II/extralarge&path=%2Fmnt%2FNAS%2FNAS2%2FJazz%2FNils%20Landgren%2C%20Michael%20Wollny%2C%20Lars%20Danielsson%2C%20Wolfgang%20Haffner%20-%204%20Wheel%20Drive%20II%20(2023)%20%5B24-96%5D%2F07.%20Spring%20Dance.flac&metadata=false Apr 16 13:02:51 volumio-p4 volumio[875]: info: URI /mnt/NAS/NAS2/Jazz/Nils Landgren, Michael Wollny, Lars Danielsson, Wolfgang Haffner - 4 Wheel Drive II (2023) [24-96]/07. Spring Dance.flac Apr 16 13:02:51 volumio-p4 volumio[875]: info: ALBUMART /albumart?cacheid=105&web=Nils%20Landgren%2C%20Michael%20Wollny%2C%20Lars%20Danielsson%2C%20Wolfgang%20Haffner/4%20Wheel%20Drive%20II/extralarge&path=%2Fmnt%2FNAS%2FNAS2%2FJazz%2FNils%20Landgren%2C%20Michael%20Wollny%2C%20Lars%20Danielsson%2C%20Wolfgang%20Haffner%20-%204%20Wheel%20Drive%20II%20(2023)%20%5B24-96%5D%2F08.%20Fields%20of%20Gold.flac&metadata=false Apr 16 13:02:51 volumio-p4 volumio[875]: info: URI /mnt/NAS/NAS2/Jazz/Nils Landgren, Michael Wollny, Lars Danielsson, Wolfgang Haffner - 4 Wheel Drive II (2023) [24-96]/08. Fields of Gold.flac Apr 16 13:02:51 volumio-p4 volumio[875]: info: ALBUMART /albumart?cacheid=105&web=Nils%20Landgren%2C%20Michael%20Wollny%2C%20Lars%20Danielsson%2C%20Wolfgang%20Haffner/4%20Wheel%20Drive%20II/extralarge&path=%2Fmnt%2FNAS%2FNAS2%2FJazz%2FNils%20Landgren%2C%20Michael%20Wollny%2C%20Lars%20Danielsson%2C%20Wolfgang%20Haffner%20-%204%20Wheel%20Drive%20II%20(2023)%20%5B24-96%5D%2F09.%20April%20Rain.flac&metadata=false Apr 16 13:02:51 volumio-p4 volumio[875]: info: URI /mnt/NAS/NAS2/Jazz/Nils Landgren, Michael Wollny, Lars Danielsson, Wolfgang Haffner - 4 Wheel Drive II (2023) [24-96]/09. April Rain.flac Apr 16 13:02:51 volumio-p4 volumio[875]: info: ALBUMART /albumart?cacheid=105&web=Nils%20Landgren%2C%20Michael%20Wollny%2C%20Lars%20Danielsson%2C%20Wolfgang%20Haffner/4%20Wheel%20Drive%20II/extralarge&path=%2Fmnt%2FNAS%2FNAS2%2FJazz%2FNils%20Landgren%2C%20Michael%20Wollny%2C%20Lars%20Danielsson%2C%20Wolfgang%20Haffner%20-%204%20Wheel%20Drive%20II%20(2023)%20%5B24-96%5D%2F10.%20Your%20Song.flac&metadata=false Apr 16 13:02:51 volumio-p4 volumio[875]: info: URI /mnt/NAS/NAS2/Jazz/Nils Landgren, Michael Wollny, Lars Danielsson, Wolfgang Haffner - 4 Wheel Drive II (2023) [24-96]/10. Your Song.flac Apr 16 13:02:51 volumio-p4 volumio[875]: info: ALBUMART /albumart?cacheid=105&web=Nils%20Landgren%2C%20Michael%20Wollny%2C%20Lars%20Danielsson%2C%20Wolfgang%20Haffner/4%20Wheel%20Drive%20II/extralarge&path=%2Fmnt%2FNAS%2FNAS2%2FJazz%2FNils%20Landgren%2C%20Michael%20Wollny%2C%20Lars%20Danielsson%2C%20Wolfgang%20Haffner%20-%204%20Wheel%20Drive%20II%20(2023)%20%5B24-96%5D%2F11.%20The%20Wheelers.flac&metadata=false Apr 16 13:02:51 volumio-p4 volumio[875]: info: URI /mnt/NAS/NAS2/Jazz/Nils Landgren, Michael Wollny, Lars Danielsson, Wolfgang Haffner - 4 Wheel Drive II (2023) [24-96]/11. The Wheelers.flac Apr 16 13:02:51 volumio-p4 volumio[875]: info: sendMpdCommand stop took 134 milliseconds Apr 16 13:02:51 volumio-p4 volumio[875]: info: ControllerMpd::getState Apr 16 13:02:51 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand status Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushQueue Apr 16 13:02:51 volumio-p4 volumio[875]: info: CorePlayQueue::saveQueue Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::updateTrackBlock Apr 16 13:02:51 volumio-p4 volumio[875]: info: CorePlayQueue::getTrackBlock Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPlay Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::play index 0 Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::stop Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::play index undefined Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 13:02:51 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::startPlaybackTimer Apr 16 13:02:51 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:02:51 volumio-p4 volumio[875]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS2/Jazz/Nils Landgren, Michael Wollny, Lars Danielsson, Wolfgang Haffner - 4 Wheel Drive II (2023) [24-96]/01. Chapter II.flac Apr 16 13:02:51 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand stop Apr 16 13:02:51 volumio-p4 volumio[875]: info: sendMpdCommand status took 12 milliseconds Apr 16 13:02:51 volumio-p4 volumio[875]: info: sendMpdCommand stop took 5 milliseconds Apr 16 13:02:51 volumio-p4 volumio[875]: verbose: ControllerMpd::parseState Apr 16 13:02:51 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 13:02:51 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand clear Apr 16 13:02:51 volumio-p4 volumio[875]: info: touch_display: Setting screensaver timeout to 120 seconds. Apr 16 13:02:51 volumio-p4 volumio[875]: info: Apr 16 13:02:51 volumio-p4 volumio[875]: ---------------------------- MPD announces system playlist update Apr 16 13:02:51 volumio-p4 volumio[875]: info: Ignoring MPD Status Update Apr 16 13:02:51 volumio-p4 volumio[875]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 16 13:02:51 volumio-p4 volumio[875]: info: sendMpdCommand clear took 5 milliseconds Apr 16 13:02:51 volumio-p4 volumio[875]: verbose: ControllerMpd::parseTrackInfo Apr 16 13:02:51 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS2/Jazz/Nils Landgren, Michael Wollny, Lars Danielsson, Wolfgang Haffner - 4 Wheel Drive II (2023) [24-96]/01. Chapter II.flac" Apr 16 13:02:51 volumio-p4 volumio[875]: info: ControllerMpd::pushState Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreCommandRouter::servicePushState Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:02:51 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:02:51 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:02:51 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:02:51 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:02:51 volumio-p4 volumio[875]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Stolen Moments","artist":"Oliver Nelson","album":"The Blues and the Abstract Truth","uri":"NAS/NAS2/Jazz/Oliver Nelson - The Blues and the Abstract Truth (2007) [24-96]/01 - Stolen Moments.flac","trackType":"flac"} Apr 16 13:02:51 volumio-p4 volumio[875]: verbose: CURRENT POSITION 0 Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::syncState stateService stop Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::syncState currentStatus stop Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:02:51 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:02:51 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:02:51 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:02:51 volumio-p4 volumio[875]: info: No code Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:02:51 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:02:51 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:02:51 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:02:51 volumio-p4 volumio[875]: info: ------------------------------ 47ms Apr 16 13:02:51 volumio-p4 volumio[875]: error: updateQueue error: null Apr 16 13:02:51 volumio-p4 volumio[875]: info: Apr 16 13:02:51 volumio-p4 volumio[875]: ---------------------------- MPD announces system playlist update Apr 16 13:02:51 volumio-p4 volumio[875]: info: Ignoring MPD Status Update Apr 16 13:02:51 volumio-p4 volumio[875]: info: ------------------------------ 28ms Apr 16 13:02:51 volumio-p4 volumio[875]: info: sendMpdCommand add "NAS/NAS2/Jazz/Nils Landgren, Michael Wollny, Lars Danielsson, Wolfgang Haffner - 4 Wheel Drive II (2023) [24-96]/01. Chapter II.flac" took 26 milliseconds Apr 16 13:02:51 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand play Apr 16 13:02:51 volumio-p4 volumio[875]: info: ------------------------------ 8ms Apr 16 13:02:51 volumio-p4 volumio[875]: info: sendMpdCommand play took 6 milliseconds Apr 16 13:02:51 volumio-p4 volumio[875]: info: Apr 16 13:02:51 volumio-p4 volumio[875]: ---------------------------- MPD announces state update: player Apr 16 13:02:51 volumio-p4 volumio[875]: info: ControllerMpd::getState Apr 16 13:02:51 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand status Apr 16 13:02:51 volumio-p4 volumio[875]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Apr 16 13:02:51 volumio-p4 volumio[875]: info: Apr 16 13:02:51 volumio-p4 volumio[875]: ---------------------------- MPD announces state update: player Apr 16 13:02:51 volumio-p4 volumio[875]: info: ControllerMpd::getState Apr 16 13:02:51 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand status Apr 16 13:02:51 volumio-p4 volumio[875]: info: sendMpdCommand status took 11 milliseconds Apr 16 13:02:51 volumio-p4 volumio[875]: verbose: ControllerMpd::parseState Apr 16 13:02:51 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 13:02:51 volumio-p4 volumio[875]: info: touch_display: Setting screensaver timeout to 120 seconds. Apr 16 13:02:51 volumio-p4 volumio[875]: info: sendMpdCommand status took 6 milliseconds Apr 16 13:02:51 volumio-p4 volumio[875]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 16 13:02:51 volumio-p4 volumio[875]: verbose: ControllerMpd::parseState Apr 16 13:02:51 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 13:02:51 volumio-p4 volumio[875]: verbose: ControllerMpd::parseTrackInfo Apr 16 13:02:51 volumio-p4 volumio[875]: info: ControllerMpd::pushState Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreCommandRouter::servicePushState Apr 16 13:02:51 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:02:51 volumio-p4 volumio[875]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":183,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Chapter II","artist":"Nils Landgren, Michael Wollny, Lars Danielsson, Wolfgang Haffner","album":"4 Wheel Drive II","uri":"NAS/NAS2/Jazz/Nils Landgren, Michael Wollny, Lars Danielsson, Wolfgang Haffner - 4 Wheel Drive II (2023) [24-96]/01. Chapter II.flac","trackType":"flac"} Apr 16 13:02:51 volumio-p4 volumio[875]: verbose: CURRENT POSITION 0 Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::syncState stateService play Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::syncState currentStatus stop Apr 16 13:02:51 volumio-p4 volumio[875]: info: ------------------------------ 20ms Apr 16 13:02:51 volumio-p4 volumio[875]: info: sendMpdCommand playlistinfo took 7 milliseconds Apr 16 13:02:51 volumio-p4 volumio[875]: verbose: ControllerMpd::parseTrackInfo Apr 16 13:02:51 volumio-p4 volumio[875]: info: ControllerMpd::pushState Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreCommandRouter::servicePushState Apr 16 13:02:51 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:02:51 volumio-p4 volumio[875]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":183,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Chapter II","artist":"Nils Landgren, Michael Wollny, Lars Danielsson, Wolfgang Haffner","album":"4 Wheel Drive II","uri":"NAS/NAS2/Jazz/Nils Landgren, Michael Wollny, Lars Danielsson, Wolfgang Haffner - 4 Wheel Drive II (2023) [24-96]/01. Chapter II.flac","trackType":"flac"} Apr 16 13:02:51 volumio-p4 volumio[875]: verbose: CURRENT POSITION 0 Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::syncState stateService play Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::syncState currentStatus play Apr 16 13:02:51 volumio-p4 volumio[875]: info: Received an update from plugin. extracting info from payload Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:02:51 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:02:51 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:02:51 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:02:51 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:02:51 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:02:51 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:02:51 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:02:51 volumio-p4 volumio[875]: info: ------------------------------ 38ms Apr 16 13:02:53 volumio-p4 volumio[875]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 16 13:02:53 volumio-p4 volumio[875]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 16 13:02:53 volumio-p4 volumio[875]: info: Discovery: Getting this device information Apr 16 13:02:53 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioGetState Apr 16 13:02:53 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:02:53 volumio-p4 volumio[875]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 16 13:02:54 volumio-p4 kernel: hwmon hwmon1: Undervoltage detected! Apr 16 13:02:58 volumio-p4 kernel: hwmon hwmon1: Voltage normalised Apr 16 13:03:15 volumio-p4 volumiologrotate[514]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Apr 16 13:03:15 volumio-p4 volumiologrotate[514]: ls: cannot access 'P4': No such file or directory Apr 16 13:03:16 volumio-p4 volumio[875]: info: Preload queue cleared Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreStateMachine::ClearQueue Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreStateMachine::stop Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreStateMachine::stPlaybackTimer Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreStateMachine::updateTrackBlock Apr 16 13:03:16 volumio-p4 volumio[875]: info: CorePlayQueue::getTrackBlock Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:16 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:16 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:16 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreStateMachine::serviceStop Apr 16 13:03:16 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreCommandRouter::serviceStop Apr 16 13:03:16 volumio-p4 volumio[875]: info: ControllerMpd::stop Apr 16 13:03:16 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand stop Apr 16 13:03:16 volumio-p4 volumio[875]: info: CorePlayQueue::clearPlayQueue Apr 16 13:03:16 volumio-p4 volumio[875]: info: CorePlayQueue::saveQueue Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushQueue Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreStateMachine::addQueueItems Apr 16 13:03:16 volumio-p4 volumio[875]: info: CorePlayQueue::addQueueItems Apr 16 13:03:16 volumio-p4 volumio[875]: info: Preload queue cleared Apr 16 13:03:16 volumio-p4 volumio[875]: info: Adding Item to queue: music-library/NAS/NAS2/Jazz/Oliver Nelson - The Blues and the Abstract Truth (2007) [24-96] Apr 16 13:03:16 volumio-p4 volumio[875]: info: Using cached record of: music-library/NAS/NAS2/Jazz/Oliver Nelson - The Blues and the Abstract Truth (2007) [24-96] Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushQueue Apr 16 13:03:16 volumio-p4 volumio[875]: info: CorePlayQueue::saveQueue Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreStateMachine::updateTrackBlock Apr 16 13:03:16 volumio-p4 volumio[875]: info: CorePlayQueue::getTrackBlock Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPlay Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreStateMachine::play index 0 Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreStateMachine::stop Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreStateMachine::play index undefined Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 13:03:16 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreStateMachine::startPlaybackTimer Apr 16 13:03:16 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:16 volumio-p4 volumio[875]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS2/Jazz/Oliver Nelson - The Blues and the Abstract Truth (2007) [24-96]/01 - Stolen Moments.flac Apr 16 13:03:16 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand stop Apr 16 13:03:16 volumio-p4 volumio[875]: info: Apr 16 13:03:16 volumio-p4 volumio[875]: ---------------------------- MPD announces state update: player Apr 16 13:03:16 volumio-p4 volumio[875]: info: sendMpdCommand stop took 53 milliseconds Apr 16 13:03:16 volumio-p4 volumio[875]: info: ControllerMpd::getState Apr 16 13:03:16 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand status Apr 16 13:03:16 volumio-p4 volumio[875]: info: sendMpdCommand stop took 40 milliseconds Apr 16 13:03:16 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand clear Apr 16 13:03:16 volumio-p4 volumio[875]: info: Apr 16 13:03:16 volumio-p4 volumio[875]: ---------------------------- MPD announces system playlist update Apr 16 13:03:16 volumio-p4 volumio[875]: info: Ignoring MPD Status Update Apr 16 13:03:16 volumio-p4 volumio[875]: info: sendMpdCommand status took 6 milliseconds Apr 16 13:03:16 volumio-p4 volumio[875]: info: sendMpdCommand clear took 6 milliseconds Apr 16 13:03:16 volumio-p4 volumio[875]: verbose: ControllerMpd::parseState Apr 16 13:03:16 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 13:03:16 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS2/Jazz/Oliver Nelson - The Blues and the Abstract Truth (2007) [24-96]/01 - Stolen Moments.flac" Apr 16 13:03:16 volumio-p4 volumio[875]: error: updateQueue error: null Apr 16 13:03:16 volumio-p4 volumio[875]: info: Apr 16 13:03:16 volumio-p4 volumio[875]: ---------------------------- MPD announces system playlist update Apr 16 13:03:16 volumio-p4 volumio[875]: info: Ignoring MPD Status Update Apr 16 13:03:16 volumio-p4 volumio[875]: info: ------------------------------ 6ms Apr 16 13:03:16 volumio-p4 volumio[875]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 16 13:03:16 volumio-p4 volumio[875]: info: sendMpdCommand add "NAS/NAS2/Jazz/Oliver Nelson - The Blues and the Abstract Truth (2007) [24-96]/01 - Stolen Moments.flac" took 4 milliseconds Apr 16 13:03:16 volumio-p4 volumio[875]: verbose: ControllerMpd::parseTrackInfo Apr 16 13:03:16 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand play Apr 16 13:03:16 volumio-p4 volumio[875]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 16 13:03:16 volumio-p4 volumio[875]: info: ------------------------------ 15ms Apr 16 13:03:16 volumio-p4 volumio[875]: info: touch_display: Setting screensaver timeout to 120 seconds. Apr 16 13:03:16 volumio-p4 volumio[875]: info: ------------------------------ 20ms Apr 16 13:03:16 volumio-p4 volumio[875]: info: sendMpdCommand play took 18 milliseconds Apr 16 13:03:16 volumio-p4 volumio[875]: info: Apr 16 13:03:16 volumio-p4 volumio[875]: ---------------------------- MPD announces state update: player Apr 16 13:03:16 volumio-p4 volumio[875]: info: ControllerMpd::getState Apr 16 13:03:16 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand status Apr 16 13:03:16 volumio-p4 volumio[875]: info: Apr 16 13:03:16 volumio-p4 volumio[875]: ---------------------------- MPD announces state update: player Apr 16 13:03:16 volumio-p4 volumio[875]: info: sendMpdCommand status took 14 milliseconds Apr 16 13:03:16 volumio-p4 volumio[875]: info: ControllerMpd::getState Apr 16 13:03:16 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand status Apr 16 13:03:16 volumio-p4 volumio[875]: verbose: ControllerMpd::parseState Apr 16 13:03:16 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 13:03:16 volumio-p4 volumio[875]: info: sendMpdCommand status took 1 milliseconds Apr 16 13:03:16 volumio-p4 volumio[875]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 16 13:03:16 volumio-p4 volumio[875]: verbose: ControllerMpd::parseState Apr 16 13:03:16 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 13:03:16 volumio-p4 volumio[875]: verbose: ControllerMpd::parseTrackInfo Apr 16 13:03:16 volumio-p4 volumio[875]: info: ControllerMpd::pushState Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreCommandRouter::servicePushState Apr 16 13:03:16 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:16 volumio-p4 volumio[875]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":525,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Stolen Moments","artist":"Oliver Nelson","album":"The Blues and the Abstract Truth","uri":"NAS/NAS2/Jazz/Oliver Nelson - The Blues and the Abstract Truth (2007) [24-96]/01 - Stolen Moments.flac","trackType":"flac"} Apr 16 13:03:16 volumio-p4 volumio[875]: verbose: CURRENT POSITION 0 Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreStateMachine::syncState stateService play Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreStateMachine::syncState currentStatus stop Apr 16 13:03:16 volumio-p4 volumio[875]: info: ------------------------------ 19ms Apr 16 13:03:16 volumio-p4 volumio[875]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 16 13:03:16 volumio-p4 volumio[875]: verbose: ControllerMpd::parseTrackInfo Apr 16 13:03:16 volumio-p4 volumio[875]: info: ControllerMpd::pushState Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreCommandRouter::servicePushState Apr 16 13:03:16 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:16 volumio-p4 volumio[875]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":525,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Stolen Moments","artist":"Oliver Nelson","album":"The Blues and the Abstract Truth","uri":"NAS/NAS2/Jazz/Oliver Nelson - The Blues and the Abstract Truth (2007) [24-96]/01 - Stolen Moments.flac","trackType":"flac"} Apr 16 13:03:16 volumio-p4 volumio[875]: verbose: CURRENT POSITION 0 Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreStateMachine::syncState stateService play Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreStateMachine::syncState currentStatus play Apr 16 13:03:16 volumio-p4 volumio[875]: info: Received an update from plugin. extracting info from payload Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:16 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:16 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:16 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:16 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:16 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:16 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:16 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:16 volumio-p4 volumio[875]: info: ------------------------------ 22ms Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioNext Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreStateMachine::next Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreStateMachine::stop Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreStateMachine::stPlaybackTimer Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreStateMachine::updateTrackBlock Apr 16 13:03:18 volumio-p4 volumio[875]: info: CorePlayQueue::getTrackBlock Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:18 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:18 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:18 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreStateMachine::serviceStop Apr 16 13:03:18 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreCommandRouter::serviceStop Apr 16 13:03:18 volumio-p4 volumio[875]: info: ControllerMpd::stop Apr 16 13:03:18 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand stop Apr 16 13:03:18 volumio-p4 volumio[875]: info: Apr 16 13:03:18 volumio-p4 volumio[875]: ---------------------------- MPD announces state update: player Apr 16 13:03:18 volumio-p4 volumio[875]: info: sendMpdCommand stop took 63 milliseconds Apr 16 13:03:18 volumio-p4 volumio[875]: info: ControllerMpd::getState Apr 16 13:03:18 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand status Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreStateMachine::play index undefined Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 13:03:18 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 1 Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreStateMachine::startPlaybackTimer Apr 16 13:03:18 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 1 Apr 16 13:03:18 volumio-p4 volumio[875]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS2/Jazz/Oliver Nelson - The Blues and the Abstract Truth (2007) [24-96]/02 - Hoe-Down.flac Apr 16 13:03:18 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand stop Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreStateMachine::updateTrackBlock Apr 16 13:03:18 volumio-p4 volumio[875]: info: CorePlayQueue::getTrackBlock Apr 16 13:03:18 volumio-p4 volumio[875]: info: sendMpdCommand status took 10 milliseconds Apr 16 13:03:18 volumio-p4 volumio[875]: info: sendMpdCommand stop took 9 milliseconds Apr 16 13:03:18 volumio-p4 volumio[875]: verbose: ControllerMpd::parseState Apr 16 13:03:18 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 13:03:18 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand clear Apr 16 13:03:18 volumio-p4 volumio[875]: info: touch_display: Setting screensaver timeout to 120 seconds. Apr 16 13:03:18 volumio-p4 volumio[875]: info: Apr 16 13:03:18 volumio-p4 volumio[875]: ---------------------------- MPD announces system playlist update Apr 16 13:03:18 volumio-p4 volumio[875]: info: Ignoring MPD Status Update Apr 16 13:03:18 volumio-p4 volumio[875]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 16 13:03:18 volumio-p4 volumio[875]: info: sendMpdCommand clear took 3 milliseconds Apr 16 13:03:18 volumio-p4 volumio[875]: verbose: ControllerMpd::parseTrackInfo Apr 16 13:03:18 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS2/Jazz/Oliver Nelson - The Blues and the Abstract Truth (2007) [24-96]/02 - Hoe-Down.flac" Apr 16 13:03:18 volumio-p4 volumio[875]: info: ControllerMpd::pushState Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreCommandRouter::servicePushState Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:18 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 1 Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:18 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:18 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:18 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 1 Apr 16 13:03:18 volumio-p4 volumio[875]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Stolen Moments","artist":"Oliver Nelson","album":"The Blues and the Abstract Truth","uri":"NAS/NAS2/Jazz/Oliver Nelson - The Blues and the Abstract Truth (2007) [24-96]/01 - Stolen Moments.flac","trackType":"flac"} Apr 16 13:03:18 volumio-p4 volumio[875]: verbose: CURRENT POSITION 1 Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreStateMachine::syncState stateService stop Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreStateMachine::syncState currentStatus stop Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:18 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 1 Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:18 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:18 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:18 volumio-p4 volumio[875]: info: No code Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:18 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 1 Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:18 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:18 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:18 volumio-p4 volumio[875]: info: ------------------------------ 31ms Apr 16 13:03:18 volumio-p4 volumio[875]: error: updateQueue error: null Apr 16 13:03:18 volumio-p4 volumio[875]: info: Apr 16 13:03:18 volumio-p4 volumio[875]: ---------------------------- MPD announces system playlist update Apr 16 13:03:18 volumio-p4 volumio[875]: info: Ignoring MPD Status Update Apr 16 13:03:18 volumio-p4 volumio[875]: info: ------------------------------ 36ms Apr 16 13:03:18 volumio-p4 volumio[875]: info: sendMpdCommand add "NAS/NAS2/Jazz/Oliver Nelson - The Blues and the Abstract Truth (2007) [24-96]/02 - Hoe-Down.flac" took 35 milliseconds Apr 16 13:03:18 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand play Apr 16 13:03:18 volumio-p4 volumio[875]: info: ------------------------------ 13ms Apr 16 13:03:18 volumio-p4 volumio[875]: info: sendMpdCommand play took 10 milliseconds Apr 16 13:03:18 volumio-p4 volumio[875]: info: Apr 16 13:03:18 volumio-p4 volumio[875]: ---------------------------- MPD announces state update: player Apr 16 13:03:18 volumio-p4 volumio[875]: info: ControllerMpd::getState Apr 16 13:03:18 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand status Apr 16 13:03:18 volumio-p4 volumio[875]: info: Apr 16 13:03:18 volumio-p4 volumio[875]: ---------------------------- MPD announces state update: player Apr 16 13:03:18 volumio-p4 volumio[875]: info: ControllerMpd::getState Apr 16 13:03:18 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand status Apr 16 13:03:18 volumio-p4 volumio[875]: info: sendMpdCommand status took 12 milliseconds Apr 16 13:03:18 volumio-p4 volumio[875]: verbose: ControllerMpd::parseState Apr 16 13:03:18 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 13:03:18 volumio-p4 volumio[875]: info: sendMpdCommand status took 14 milliseconds Apr 16 13:03:18 volumio-p4 volumio[875]: info: sendMpdCommand playlistinfo took 13 milliseconds Apr 16 13:03:18 volumio-p4 volumio[875]: verbose: ControllerMpd::parseState Apr 16 13:03:18 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 13:03:18 volumio-p4 volumio[875]: verbose: ControllerMpd::parseTrackInfo Apr 16 13:03:18 volumio-p4 volumio[875]: info: ControllerMpd::pushState Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreCommandRouter::servicePushState Apr 16 13:03:18 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 1 Apr 16 13:03:18 volumio-p4 volumio[875]: verbose: STATE SERVICE {"status":"play","position":0,"seek":939,"duration":283,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2355 Kbps","isStreaming":false,"title":"Hoe-Down","artist":"Oliver Nelson","album":"The Blues and the Abstract Truth","uri":"NAS/NAS2/Jazz/Oliver Nelson - The Blues and the Abstract Truth (2007) [24-96]/02 - Hoe-Down.flac","trackType":"flac"} Apr 16 13:03:18 volumio-p4 volumio[875]: verbose: CURRENT POSITION 1 Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreStateMachine::syncState stateService play Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreStateMachine::syncState currentStatus stop Apr 16 13:03:18 volumio-p4 volumio[875]: info: ------------------------------ 30ms Apr 16 13:03:18 volumio-p4 volumio[875]: info: sendMpdCommand playlistinfo took 9 milliseconds Apr 16 13:03:18 volumio-p4 volumio[875]: verbose: ControllerMpd::parseTrackInfo Apr 16 13:03:18 volumio-p4 volumio[875]: info: ControllerMpd::pushState Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreCommandRouter::servicePushState Apr 16 13:03:18 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 1 Apr 16 13:03:18 volumio-p4 volumio[875]: verbose: STATE SERVICE {"status":"play","position":0,"seek":939,"duration":283,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2355 Kbps","isStreaming":false,"title":"Hoe-Down","artist":"Oliver Nelson","album":"The Blues and the Abstract Truth","uri":"NAS/NAS2/Jazz/Oliver Nelson - The Blues and the Abstract Truth (2007) [24-96]/02 - Hoe-Down.flac","trackType":"flac"} Apr 16 13:03:18 volumio-p4 volumio[875]: verbose: CURRENT POSITION 1 Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreStateMachine::syncState stateService play Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreStateMachine::syncState currentStatus play Apr 16 13:03:18 volumio-p4 volumio[875]: info: Received an update from plugin. extracting info from payload Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:18 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 1 Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:18 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:18 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:18 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 1 Apr 16 13:03:18 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:18 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:18 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:18 volumio-p4 volumio[875]: info: ------------------------------ 41ms Apr 16 13:03:25 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioSeek Apr 16 13:03:25 volumio-p4 volumio[875]: info: CoreStateMachine::seek Apr 16 13:03:25 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 1 Apr 16 13:03:25 volumio-p4 volumio[875]: info: TRACKBLOCK {"uri":"mnt/NAS/NAS2/Jazz/Oliver Nelson - The Blues and the Abstract Truth (2007) [24-96]/02 - Hoe-Down.flac","service":"mpd","name":"2 - Hoe-Down","artist":"Oliver Nelson","album":"The Blues and the Abstract Truth","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=105&web=Oliver%20Nelson/The%20Blues%20and%20the%20Abstract%20Truth/extralarge&path=%2FNAS%2FNAS2%2FJazz%2FOliver%20Nelson%20-%20The%20Blues%20and%20the%20Abstract%20Truth%20(2007)%20%5B24-96%5D&metadata=false","duration":283,"samplerate":"96 kHz","bitdepth":"24 bit","trackType":"flac","channels":2} Apr 16 13:03:25 volumio-p4 volumio[875]: info: CoreStateMachine::startPlaybackTimer Apr 16 13:03:25 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 1 Apr 16 13:03:25 volumio-p4 volumio[875]: info: ControllerMpd::seek Apr 16 13:03:25 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:25 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 1 Apr 16 13:03:25 volumio-p4 volumio[875]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 13:03:25 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:25 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:25 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:25 volumio-p4 volumio[875]: error: null Apr 16 13:03:25 volumio-p4 volumio[875]: info: Apr 16 13:03:25 volumio-p4 volumio[875]: ---------------------------- MPD announces state update: player Apr 16 13:03:25 volumio-p4 volumio[875]: info: ControllerMpd::getState Apr 16 13:03:25 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand status Apr 16 13:03:25 volumio-p4 volumio[875]: info: sendMpdCommand status took 2 milliseconds Apr 16 13:03:25 volumio-p4 volumio[875]: verbose: ControllerMpd::parseState Apr 16 13:03:25 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 13:03:25 volumio-p4 volumio[875]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 16 13:03:25 volumio-p4 volumio[875]: verbose: ControllerMpd::parseTrackInfo Apr 16 13:03:25 volumio-p4 volumio[875]: info: ControllerMpd::pushState Apr 16 13:03:25 volumio-p4 volumio[875]: info: CoreCommandRouter::servicePushState Apr 16 13:03:25 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 1 Apr 16 13:03:25 volumio-p4 volumio[875]: verbose: STATE SERVICE {"status":"play","position":0,"seek":72000,"duration":283,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2711 Kbps","isStreaming":false,"title":"Hoe-Down","artist":"Oliver Nelson","album":"The Blues and the Abstract Truth","uri":"NAS/NAS2/Jazz/Oliver Nelson - The Blues and the Abstract Truth (2007) [24-96]/02 - Hoe-Down.flac","trackType":"flac"} Apr 16 13:03:25 volumio-p4 volumio[875]: verbose: CURRENT POSITION 1 Apr 16 13:03:25 volumio-p4 volumio[875]: info: CoreStateMachine::syncState stateService play Apr 16 13:03:25 volumio-p4 volumio[875]: info: CoreStateMachine::syncState currentStatus play Apr 16 13:03:25 volumio-p4 volumio[875]: info: Received an update from plugin. extracting info from payload Apr 16 13:03:25 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:25 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 1 Apr 16 13:03:25 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:25 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:25 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:25 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:25 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 1 Apr 16 13:03:25 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:25 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:25 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:25 volumio-p4 volumio[875]: info: ------------------------------ 22ms Apr 16 13:03:27 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioNext Apr 16 13:03:27 volumio-p4 volumio[875]: info: CoreStateMachine::next Apr 16 13:03:27 volumio-p4 volumio[875]: info: CoreStateMachine::stop Apr 16 13:03:27 volumio-p4 volumio[875]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 13:03:27 volumio-p4 volumio[875]: info: CoreStateMachine::stPlaybackTimer Apr 16 13:03:27 volumio-p4 volumio[875]: info: CoreStateMachine::updateTrackBlock Apr 16 13:03:27 volumio-p4 volumio[875]: info: CorePlayQueue::getTrackBlock Apr 16 13:03:27 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:27 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 1 Apr 16 13:03:27 volumio-p4 volumio[875]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 13:03:27 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:27 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:27 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:27 volumio-p4 volumio[875]: info: CoreStateMachine::serviceStop Apr 16 13:03:27 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 1 Apr 16 13:03:27 volumio-p4 volumio[875]: info: CoreCommandRouter::serviceStop Apr 16 13:03:27 volumio-p4 volumio[875]: info: ControllerMpd::stop Apr 16 13:03:27 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand stop Apr 16 13:03:27 volumio-p4 volumio[875]: info: Apr 16 13:03:27 volumio-p4 volumio[875]: ---------------------------- MPD announces state update: player Apr 16 13:03:27 volumio-p4 volumio[875]: info: sendMpdCommand stop took 44 milliseconds Apr 16 13:03:27 volumio-p4 volumio[875]: info: ControllerMpd::getState Apr 16 13:03:27 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand status Apr 16 13:03:27 volumio-p4 volumio[875]: info: CoreStateMachine::play index undefined Apr 16 13:03:27 volumio-p4 volumio[875]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 13:03:27 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 2 Apr 16 13:03:27 volumio-p4 volumio[875]: info: CoreStateMachine::startPlaybackTimer Apr 16 13:03:27 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 2 Apr 16 13:03:27 volumio-p4 volumio[875]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS2/Jazz/Oliver Nelson - The Blues and the Abstract Truth (2007) [24-96]/03 - Cascades.flac Apr 16 13:03:27 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand stop Apr 16 13:03:27 volumio-p4 volumio[875]: info: CoreStateMachine::updateTrackBlock Apr 16 13:03:27 volumio-p4 volumio[875]: info: CorePlayQueue::getTrackBlock Apr 16 13:03:27 volumio-p4 volumio[875]: info: sendMpdCommand status took 8 milliseconds Apr 16 13:03:27 volumio-p4 volumio[875]: info: sendMpdCommand stop took 5 milliseconds Apr 16 13:03:27 volumio-p4 volumio[875]: verbose: ControllerMpd::parseState Apr 16 13:03:27 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 13:03:27 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand clear Apr 16 13:03:27 volumio-p4 volumio[875]: info: touch_display: Setting screensaver timeout to 120 seconds. Apr 16 13:03:27 volumio-p4 volumio[875]: info: Apr 16 13:03:27 volumio-p4 volumio[875]: ---------------------------- MPD announces system playlist update Apr 16 13:03:27 volumio-p4 volumio[875]: info: Ignoring MPD Status Update Apr 16 13:03:27 volumio-p4 volumio[875]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 16 13:03:27 volumio-p4 volumio[875]: info: sendMpdCommand clear took 6 milliseconds Apr 16 13:03:27 volumio-p4 volumio[875]: verbose: ControllerMpd::parseTrackInfo Apr 16 13:03:27 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS2/Jazz/Oliver Nelson - The Blues and the Abstract Truth (2007) [24-96]/03 - Cascades.flac" Apr 16 13:03:27 volumio-p4 volumio[875]: info: ControllerMpd::pushState Apr 16 13:03:27 volumio-p4 volumio[875]: info: CoreCommandRouter::servicePushState Apr 16 13:03:27 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:27 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 2 Apr 16 13:03:27 volumio-p4 volumio[875]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 13:03:27 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:27 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:27 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:27 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 2 Apr 16 13:03:27 volumio-p4 volumio[875]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Hoe-Down","artist":"Oliver Nelson","album":"The Blues and the Abstract Truth","uri":"NAS/NAS2/Jazz/Oliver Nelson - The Blues and the Abstract Truth (2007) [24-96]/02 - Hoe-Down.flac","trackType":"flac"} Apr 16 13:03:27 volumio-p4 volumio[875]: verbose: CURRENT POSITION 2 Apr 16 13:03:27 volumio-p4 volumio[875]: info: CoreStateMachine::syncState stateService stop Apr 16 13:03:27 volumio-p4 volumio[875]: info: CoreStateMachine::syncState currentStatus stop Apr 16 13:03:27 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:27 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 2 Apr 16 13:03:27 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:27 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:27 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:27 volumio-p4 volumio[875]: info: No code Apr 16 13:03:27 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:27 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 2 Apr 16 13:03:27 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:27 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:27 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:27 volumio-p4 volumio[875]: info: ------------------------------ 33ms Apr 16 13:03:27 volumio-p4 volumio[875]: error: updateQueue error: null Apr 16 13:03:27 volumio-p4 volumio[875]: info: Apr 16 13:03:27 volumio-p4 volumio[875]: ---------------------------- MPD announces system playlist update Apr 16 13:03:27 volumio-p4 volumio[875]: info: Ignoring MPD Status Update Apr 16 13:03:27 volumio-p4 volumio[875]: info: ------------------------------ 39ms Apr 16 13:03:27 volumio-p4 volumio[875]: info: sendMpdCommand add "NAS/NAS2/Jazz/Oliver Nelson - The Blues and the Abstract Truth (2007) [24-96]/03 - Cascades.flac" took 38 milliseconds Apr 16 13:03:27 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand play Apr 16 13:03:27 volumio-p4 volumio[875]: info: ------------------------------ 18ms Apr 16 13:03:27 volumio-p4 volumio[875]: info: sendMpdCommand play took 15 milliseconds Apr 16 13:03:28 volumio-p4 volumio[875]: info: Apr 16 13:03:28 volumio-p4 volumio[875]: ---------------------------- MPD announces state update: player Apr 16 13:03:28 volumio-p4 volumio[875]: info: ControllerMpd::getState Apr 16 13:03:28 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand status Apr 16 13:03:28 volumio-p4 volumio[875]: info: Apr 16 13:03:28 volumio-p4 volumio[875]: ---------------------------- MPD announces state update: player Apr 16 13:03:28 volumio-p4 volumio[875]: info: ControllerMpd::getState Apr 16 13:03:28 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand status Apr 16 13:03:28 volumio-p4 volumio[875]: info: sendMpdCommand status took 13 milliseconds Apr 16 13:03:28 volumio-p4 volumio[875]: verbose: ControllerMpd::parseState Apr 16 13:03:28 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 13:03:28 volumio-p4 volumio[875]: info: sendMpdCommand status took 4 milliseconds Apr 16 13:03:28 volumio-p4 volumio[875]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 16 13:03:28 volumio-p4 volumio[875]: verbose: ControllerMpd::parseState Apr 16 13:03:28 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 13:03:28 volumio-p4 volumio[875]: verbose: ControllerMpd::parseTrackInfo Apr 16 13:03:28 volumio-p4 volumio[875]: info: ControllerMpd::pushState Apr 16 13:03:28 volumio-p4 volumio[875]: info: CoreCommandRouter::servicePushState Apr 16 13:03:28 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 2 Apr 16 13:03:28 volumio-p4 volumio[875]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2147,"duration":331,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2710 Kbps","isStreaming":false,"title":"Cascades","artist":"Oliver Nelson","album":"The Blues and the Abstract Truth","uri":"NAS/NAS2/Jazz/Oliver Nelson - The Blues and the Abstract Truth (2007) [24-96]/03 - Cascades.flac","trackType":"flac"} Apr 16 13:03:28 volumio-p4 volumio[875]: verbose: CURRENT POSITION 2 Apr 16 13:03:28 volumio-p4 volumio[875]: info: CoreStateMachine::syncState stateService play Apr 16 13:03:28 volumio-p4 volumio[875]: info: CoreStateMachine::syncState currentStatus stop Apr 16 13:03:28 volumio-p4 volumio[875]: info: ------------------------------ 20ms Apr 16 13:03:28 volumio-p4 volumio[875]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 16 13:03:28 volumio-p4 volumio[875]: verbose: ControllerMpd::parseTrackInfo Apr 16 13:03:28 volumio-p4 volumio[875]: info: ControllerMpd::pushState Apr 16 13:03:28 volumio-p4 volumio[875]: info: CoreCommandRouter::servicePushState Apr 16 13:03:28 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 2 Apr 16 13:03:28 volumio-p4 volumio[875]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2147,"duration":331,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2710 Kbps","isStreaming":false,"title":"Cascades","artist":"Oliver Nelson","album":"The Blues and the Abstract Truth","uri":"NAS/NAS2/Jazz/Oliver Nelson - The Blues and the Abstract Truth (2007) [24-96]/03 - Cascades.flac","trackType":"flac"} Apr 16 13:03:28 volumio-p4 volumio[875]: verbose: CURRENT POSITION 2 Apr 16 13:03:28 volumio-p4 volumio[875]: info: CoreStateMachine::syncState stateService play Apr 16 13:03:28 volumio-p4 volumio[875]: info: CoreStateMachine::syncState currentStatus play Apr 16 13:03:28 volumio-p4 volumio[875]: info: Received an update from plugin. extracting info from payload Apr 16 13:03:28 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:28 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 2 Apr 16 13:03:28 volumio-p4 volumio[875]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 13:03:28 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:28 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:28 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:28 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:28 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 2 Apr 16 13:03:28 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:28 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:28 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:28 volumio-p4 volumio[875]: info: ------------------------------ 29ms Apr 16 13:03:30 volumio-p4 volumio[875]: info: Preload queue cleared Apr 16 13:03:30 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 16 13:03:30 volumio-p4 volumio[875]: info: CoreStateMachine::ClearQueue Apr 16 13:03:30 volumio-p4 volumio[875]: info: CoreStateMachine::stop Apr 16 13:03:30 volumio-p4 volumio[875]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 13:03:30 volumio-p4 volumio[875]: info: CoreStateMachine::stPlaybackTimer Apr 16 13:03:30 volumio-p4 volumio[875]: info: CoreStateMachine::updateTrackBlock Apr 16 13:03:30 volumio-p4 volumio[875]: info: CorePlayQueue::getTrackBlock Apr 16 13:03:30 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:30 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 2 Apr 16 13:03:30 volumio-p4 volumio[875]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 13:03:30 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:30 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:30 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:30 volumio-p4 volumio[875]: info: CoreStateMachine::serviceStop Apr 16 13:03:30 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 2 Apr 16 13:03:30 volumio-p4 volumio[875]: info: CoreCommandRouter::serviceStop Apr 16 13:03:30 volumio-p4 volumio[875]: info: ControllerMpd::stop Apr 16 13:03:30 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand stop Apr 16 13:03:30 volumio-p4 volumio[875]: info: CorePlayQueue::clearPlayQueue Apr 16 13:03:30 volumio-p4 volumio[875]: info: CorePlayQueue::saveQueue Apr 16 13:03:30 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushQueue Apr 16 13:03:30 volumio-p4 volumio[875]: info: CoreStateMachine::addQueueItems Apr 16 13:03:30 volumio-p4 volumio[875]: info: CorePlayQueue::addQueueItems Apr 16 13:03:30 volumio-p4 volumio[875]: info: Preload queue cleared Apr 16 13:03:30 volumio-p4 volumio[875]: info: Adding Item to queue: music-library/NAS/NAS2/Jazz/Niels-Henning Orsted Pedersen - Those Who Were - 2008 Apr 16 13:03:30 volumio-p4 volumio[875]: info: Exploding uri music-library/NAS/NAS2/Jazz/Niels-Henning Orsted Pedersen - Those Who Were - 2008 in service mpd Apr 16 13:03:31 volumio-p4 volumio[875]: info: touch_display: Setting screensaver timeout to 120 seconds. Apr 16 13:03:31 volumio-p4 volumio[875]: info: ALBUMART /albumart?cacheid=105&web=//extralarge&path=%2Fmnt%2FNAS%2FNAS2%2FJazz%2FNiels-Henning%20Orsted%20Pedersen%20-%20Those%20Who%20Were%20-%202008%2FNiels-Henning%20Orsted%20Pedersen%20-%20Those%20Who%20Were.ape&metadata=false Apr 16 13:03:31 volumio-p4 volumio[875]: info: URI /mnt/NAS/NAS2/Jazz/Niels-Henning Orsted Pedersen - Those Who Were - 2008/Niels-Henning Orsted Pedersen - Those Who Were.ape Apr 16 13:03:31 volumio-p4 volumio[875]: info: Apr 16 13:03:31 volumio-p4 volumio[875]: ---------------------------- MPD announces state update: player Apr 16 13:03:31 volumio-p4 volumio[875]: info: sendMpdCommand stop took 357 milliseconds Apr 16 13:03:31 volumio-p4 volumio[875]: info: ControllerMpd::getState Apr 16 13:03:31 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand status Apr 16 13:03:31 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushQueue Apr 16 13:03:31 volumio-p4 volumio[875]: info: CorePlayQueue::saveQueue Apr 16 13:03:31 volumio-p4 volumio[875]: info: CoreStateMachine::updateTrackBlock Apr 16 13:03:31 volumio-p4 volumio[875]: info: CorePlayQueue::getTrackBlock Apr 16 13:03:31 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPlay Apr 16 13:03:31 volumio-p4 volumio[875]: info: CoreStateMachine::play index 0 Apr 16 13:03:31 volumio-p4 volumio[875]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 13:03:31 volumio-p4 volumio[875]: info: CoreStateMachine::stop Apr 16 13:03:31 volumio-p4 volumio[875]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 13:03:31 volumio-p4 volumio[875]: info: CoreStateMachine::play index undefined Apr 16 13:03:31 volumio-p4 volumio[875]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 13:03:31 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:31 volumio-p4 volumio[875]: info: CoreStateMachine::startPlaybackTimer Apr 16 13:03:31 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:31 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioGetVisibleSources Apr 16 13:03:31 volumio-p4 volumio[875]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 16 13:03:31 volumio-p4 volumio[875]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Apr 16 13:03:31 volumio-p4 volumio[875]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS2/Jazz/Niels-Henning Orsted Pedersen - Those Who Were - 2008/Niels-Henning Orsted Pedersen - Those Who Were.ape Apr 16 13:03:31 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand stop Apr 16 13:03:31 volumio-p4 volumio[875]: info: sendMpdCommand status took 16 milliseconds Apr 16 13:03:31 volumio-p4 volumio[875]: info: sendMpdCommand stop took 3 milliseconds Apr 16 13:03:31 volumio-p4 volumio[875]: verbose: ControllerMpd::parseState Apr 16 13:03:31 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 13:03:31 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand clear Apr 16 13:03:31 volumio-p4 volumio[875]: info: Apr 16 13:03:31 volumio-p4 volumio[875]: ---------------------------- MPD announces system playlist update Apr 16 13:03:31 volumio-p4 volumio[875]: info: Ignoring MPD Status Update Apr 16 13:03:31 volumio-p4 volumio[875]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 16 13:03:31 volumio-p4 volumio[875]: info: sendMpdCommand clear took 6 milliseconds Apr 16 13:03:31 volumio-p4 volumio[875]: verbose: ControllerMpd::parseTrackInfo Apr 16 13:03:31 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS2/Jazz/Niels-Henning Orsted Pedersen - Those Who Were - 2008/Niels-Henning Orsted Pedersen - Those Who Were.ape" Apr 16 13:03:31 volumio-p4 volumio[875]: info: ControllerMpd::pushState Apr 16 13:03:31 volumio-p4 volumio[875]: info: CoreCommandRouter::servicePushState Apr 16 13:03:31 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:31 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:31 volumio-p4 volumio[875]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 13:03:31 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:31 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:31 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:31 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:31 volumio-p4 volumio[875]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Cascades","artist":"Oliver Nelson","album":"The Blues and the Abstract Truth","uri":"NAS/NAS2/Jazz/Oliver Nelson - The Blues and the Abstract Truth (2007) [24-96]/03 - Cascades.flac","trackType":"flac"} Apr 16 13:03:31 volumio-p4 volumio[875]: verbose: CURRENT POSITION 0 Apr 16 13:03:31 volumio-p4 volumio[875]: info: CoreStateMachine::syncState stateService stop Apr 16 13:03:31 volumio-p4 volumio[875]: info: CoreStateMachine::syncState currentStatus stop Apr 16 13:03:31 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:31 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:31 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:31 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:31 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:31 volumio-p4 volumio[875]: info: No code Apr 16 13:03:31 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:31 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:31 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:31 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:31 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:31 volumio-p4 volumio[875]: info: ------------------------------ 46ms Apr 16 13:03:31 volumio-p4 volumio[875]: error: updateQueue error: null Apr 16 13:03:31 volumio-p4 volumio[875]: info: Apr 16 13:03:31 volumio-p4 volumio[875]: ---------------------------- MPD announces system playlist update Apr 16 13:03:31 volumio-p4 volumio[875]: info: Ignoring MPD Status Update Apr 16 13:03:31 volumio-p4 volumio[875]: info: ------------------------------ 29ms Apr 16 13:03:31 volumio-p4 volumio[875]: info: sendMpdCommand add "NAS/NAS2/Jazz/Niels-Henning Orsted Pedersen - Those Who Were - 2008/Niels-Henning Orsted Pedersen - Those Who Were.ape" took 28 milliseconds Apr 16 13:03:31 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand play Apr 16 13:03:31 volumio-p4 volumio[875]: info: ------------------------------ 24ms Apr 16 13:03:31 volumio-p4 volumio[875]: info: sendMpdCommand play took 21 milliseconds Apr 16 13:03:32 volumio-p4 volumio[875]: info: Apr 16 13:03:32 volumio-p4 volumio[875]: ---------------------------- MPD announces state update: player Apr 16 13:03:32 volumio-p4 volumio[875]: info: ControllerMpd::getState Apr 16 13:03:32 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand status Apr 16 13:03:32 volumio-p4 volumio[875]: info: Apr 16 13:03:32 volumio-p4 volumio[875]: ---------------------------- MPD announces state update: player Apr 16 13:03:32 volumio-p4 volumio[875]: info: sendMpdCommand status took 36 milliseconds Apr 16 13:03:32 volumio-p4 volumio[875]: info: ControllerMpd::getState Apr 16 13:03:32 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand status Apr 16 13:03:32 volumio-p4 volumio[875]: verbose: ControllerMpd::parseState Apr 16 13:03:32 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 13:03:32 volumio-p4 volumio[875]: info: sendMpdCommand status took 1 milliseconds Apr 16 13:03:32 volumio-p4 volumio[875]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 16 13:03:32 volumio-p4 volumio[875]: verbose: ControllerMpd::parseState Apr 16 13:03:32 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 13:03:32 volumio-p4 volumio[875]: verbose: ControllerMpd::parseTrackInfo Apr 16 13:03:32 volumio-p4 volumio[875]: info: ControllerMpd::pushState Apr 16 13:03:32 volumio-p4 volumio[875]: info: CoreCommandRouter::servicePushState Apr 16 13:03:32 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:32 volumio-p4 volumio[875]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Niels-Henning Orsted Pedersen - Those Who Were.ape","artist":null,"album":null,"uri":"NAS/NAS2/Jazz/Niels-Henning Orsted Pedersen - Those Who Were - 2008/Niels-Henning Orsted Pedersen - Those Who Were.ape","trackType":"ape"} Apr 16 13:03:32 volumio-p4 volumio[875]: verbose: CURRENT POSITION 0 Apr 16 13:03:32 volumio-p4 volumio[875]: info: CoreStateMachine::syncState stateService play Apr 16 13:03:32 volumio-p4 volumio[875]: info: CoreStateMachine::syncState currentStatus stop Apr 16 13:03:32 volumio-p4 volumio[875]: info: ------------------------------ 41ms Apr 16 13:03:32 volumio-p4 volumio[875]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 16 13:03:32 volumio-p4 volumio[875]: verbose: ControllerMpd::parseTrackInfo Apr 16 13:03:32 volumio-p4 volumio[875]: info: ControllerMpd::pushState Apr 16 13:03:32 volumio-p4 volumio[875]: info: CoreCommandRouter::servicePushState Apr 16 13:03:32 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:32 volumio-p4 volumio[875]: verbose: STATE SERVICE {"status":"play","position":0,"seek":709,"duration":3294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Niels-Henning Orsted Pedersen - Those Who Were.ape","artist":null,"album":null,"uri":"NAS/NAS2/Jazz/Niels-Henning Orsted Pedersen - Those Who Were - 2008/Niels-Henning Orsted Pedersen - Those Who Were.ape","trackType":"ape"} Apr 16 13:03:32 volumio-p4 volumio[875]: verbose: CURRENT POSITION 0 Apr 16 13:03:32 volumio-p4 volumio[875]: info: CoreStateMachine::syncState stateService play Apr 16 13:03:32 volumio-p4 volumio[875]: info: CoreStateMachine::syncState currentStatus play Apr 16 13:03:32 volumio-p4 volumio[875]: info: Received an update from plugin. extracting info from payload Apr 16 13:03:32 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:32 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:32 volumio-p4 volumio[875]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 13:03:32 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:32 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:32 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:32 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:32 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:32 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:32 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:32 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:32 volumio-p4 volumio[875]: info: ------------------------------ 21ms Apr 16 13:03:36 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioSeek Apr 16 13:03:36 volumio-p4 volumio[875]: info: CoreStateMachine::seek Apr 16 13:03:36 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:36 volumio-p4 volumio[875]: info: TRACKBLOCK {"uri":"mnt/NAS/NAS2/Jazz/Niels-Henning Orsted Pedersen - Those Who Were - 2008/Niels-Henning Orsted Pedersen - Those Who Were.ape","service":"mpd","name":"Niels-Henning Orsted Pedersen - Those Who Were.ape","artist":"","album":"","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=105&web=//extralarge&path=%2FNAS%2FNAS2%2FJazz%2FNiels-Henning%20Orsted%20Pedersen%20-%20Those%20Who%20Were%20-%202008&metadata=false","duration":3294,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"ape","channels":2} Apr 16 13:03:36 volumio-p4 volumio[875]: info: CoreStateMachine::startPlaybackTimer Apr 16 13:03:36 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:36 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioGetVisibleSources Apr 16 13:03:36 volumio-p4 volumio[875]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 16 13:03:36 volumio-p4 volumio[875]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Apr 16 13:03:36 volumio-p4 volumio[875]: info: ControllerMpd::seek Apr 16 13:03:36 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:36 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:36 volumio-p4 volumio[875]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 13:03:36 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:36 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:36 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:36 volumio-p4 volumio[875]: error: null Apr 16 13:03:36 volumio-p4 volumio[875]: info: Apr 16 13:03:36 volumio-p4 volumio[875]: ---------------------------- MPD announces state update: player Apr 16 13:03:36 volumio-p4 volumio[875]: info: ControllerMpd::getState Apr 16 13:03:36 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand status Apr 16 13:03:36 volumio-p4 volumio[875]: info: sendMpdCommand status took 7 milliseconds Apr 16 13:03:36 volumio-p4 volumio[875]: verbose: ControllerMpd::parseState Apr 16 13:03:36 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 13:03:37 volumio-p4 volumio[875]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 16 13:03:37 volumio-p4 volumio[875]: verbose: ControllerMpd::parseTrackInfo Apr 16 13:03:37 volumio-p4 volumio[875]: info: ControllerMpd::pushState Apr 16 13:03:37 volumio-p4 volumio[875]: info: CoreCommandRouter::servicePushState Apr 16 13:03:37 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:37 volumio-p4 volumio[875]: verbose: STATE SERVICE {"status":"play","position":0,"seek":827000,"duration":3294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Niels-Henning Orsted Pedersen - Those Who Were.ape","artist":null,"album":null,"uri":"NAS/NAS2/Jazz/Niels-Henning Orsted Pedersen - Those Who Were - 2008/Niels-Henning Orsted Pedersen - Those Who Were.ape","trackType":"ape"} Apr 16 13:03:37 volumio-p4 volumio[875]: verbose: CURRENT POSITION 0 Apr 16 13:03:37 volumio-p4 volumio[875]: info: CoreStateMachine::syncState stateService play Apr 16 13:03:37 volumio-p4 volumio[875]: info: CoreStateMachine::syncState currentStatus play Apr 16 13:03:37 volumio-p4 volumio[875]: info: Received an update from plugin. extracting info from payload Apr 16 13:03:37 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:37 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:37 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:37 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:37 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:37 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:37 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:37 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:37 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:37 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:37 volumio-p4 volumio[875]: info: ------------------------------ 22ms Apr 16 13:03:39 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioNext Apr 16 13:03:39 volumio-p4 volumio[875]: info: CoreStateMachine::next Apr 16 13:03:39 volumio-p4 volumio[875]: info: CoreStateMachine::stop Apr 16 13:03:39 volumio-p4 volumio[875]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 13:03:39 volumio-p4 volumio[875]: info: CoreStateMachine::stPlaybackTimer Apr 16 13:03:39 volumio-p4 volumio[875]: info: CoreStateMachine::updateTrackBlock Apr 16 13:03:39 volumio-p4 volumio[875]: info: CorePlayQueue::getTrackBlock Apr 16 13:03:39 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:39 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:39 volumio-p4 volumio[875]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 16 13:03:39 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:39 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:39 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:39 volumio-p4 volumio[875]: info: CoreStateMachine::serviceStop Apr 16 13:03:39 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:39 volumio-p4 volumio[875]: info: CoreCommandRouter::serviceStop Apr 16 13:03:39 volumio-p4 volumio[875]: info: ControllerMpd::stop Apr 16 13:03:39 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand stop Apr 16 13:03:39 volumio-p4 volumio[875]: info: Apr 16 13:03:39 volumio-p4 volumio[875]: ---------------------------- MPD announces state update: player Apr 16 13:03:39 volumio-p4 volumio[875]: info: sendMpdCommand stop took 48 milliseconds Apr 16 13:03:39 volumio-p4 volumio[875]: info: ControllerMpd::getState Apr 16 13:03:39 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand status Apr 16 13:03:39 volumio-p4 volumio[875]: info: CoreStateMachine::play index undefined Apr 16 13:03:39 volumio-p4 volumio[875]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 13:03:39 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 1 Apr 16 13:03:39 volumio-p4 volumio[875]: info: sendMpdCommand status took 5 milliseconds Apr 16 13:03:39 volumio-p4 volumio[875]: verbose: ControllerMpd::parseState Apr 16 13:03:39 volumio-p4 volumio[875]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 16 13:03:39 volumio-p4 volumio[875]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 16 13:03:39 volumio-p4 volumio[875]: verbose: ControllerMpd::parseTrackInfo Apr 16 13:03:39 volumio-p4 volumio[875]: info: ControllerMpd::pushState Apr 16 13:03:39 volumio-p4 volumio[875]: info: CoreCommandRouter::servicePushState Apr 16 13:03:39 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:39 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:39 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:39 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:39 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:39 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:39 volumio-p4 volumio[875]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Niels-Henning Orsted Pedersen - Those Who Were.ape","artist":null,"album":null,"uri":"NAS/NAS2/Jazz/Niels-Henning Orsted Pedersen - Those Who Were - 2008/Niels-Henning Orsted Pedersen - Those Who Were.ape","trackType":"ape"} Apr 16 13:03:39 volumio-p4 volumio[875]: verbose: CURRENT POSITION 0 Apr 16 13:03:39 volumio-p4 volumio[875]: info: CoreStateMachine::syncState stateService stop Apr 16 13:03:39 volumio-p4 volumio[875]: info: CoreStateMachine::syncState currentStatus stop Apr 16 13:03:39 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:39 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:39 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:39 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:39 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:39 volumio-p4 volumio[875]: info: No code Apr 16 13:03:39 volumio-p4 volumio[875]: info: CoreStateMachine::pushState Apr 16 13:03:39 volumio-p4 volumio[875]: info: CorePlayQueue::getTrack 0 Apr 16 13:03:39 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushState Apr 16 13:03:39 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output update for this device Apr 16 13:03:39 volumio-p4 volumio[875]: info: MRS: Pushing multiroomSync output Apr 16 13:03:39 volumio-p4 volumio[875]: info: ------------------------------ 22ms Apr 16 13:03:39 volumio-p4 volumio[875]: info: touch_display: Setting screensaver timeout to 120 seconds. Apr 16 13:03:45 volumio-p4 volumio[875]: info: Preload queue cleared Apr 16 13:03:45 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 16 13:03:45 volumio-p4 volumio[875]: info: CoreStateMachine::ClearQueue Apr 16 13:03:45 volumio-p4 volumio[875]: info: CoreStateMachine::stop Apr 16 13:03:45 volumio-p4 volumio[875]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 16 13:03:45 volumio-p4 volumio[875]: info: CorePlayQueue::clearPlayQueue Apr 16 13:03:45 volumio-p4 volumio[875]: info: CorePlayQueue::saveQueue Apr 16 13:03:45 volumio-p4 volumio[875]: info: CoreCommandRouter::volumioPushQueue Apr 16 13:03:45 volumio-p4 volumio[875]: info: CoreStateMachine::addQueueItems Apr 16 13:03:45 volumio-p4 volumio[875]: info: CorePlayQueue::addQueueItems Apr 16 13:03:45 volumio-p4 volumio[875]: info: Preload queue cleared Apr 16 13:03:45 volumio-p4 volumio[875]: info: Adding Item to queue: music-library/NAS/NAS2/Jazz/Myriam Alter - Where Is There (2007) Apr 16 13:03:45 volumio-p4 volumio[875]: info: Exploding uri music-library/NAS/NAS2/Jazz/Myriam Alter - Where Is There (2007) in service mpd Apr 16 13:03:45 volumio-p4 volumio[875]: info: ALBUMART /albumart?cacheid=105&web=Myriam%20Alter/Where%20Is%20There/extralarge&path=%2Fmnt%2FNAS%2FNAS2%2FJazz%2FMyriam%20Alter%20-%20Where%20Is%20There%20(2007)%2FMyriam%20Alter%20-%20Where%20Is%20There.ape&metadata=false Apr 16 13:03:45 volumio-p4 volumio[875]: info: URI /mnt/NAS/NAS2/Jazz/Myriam Alter - Where Is There (2007)/Myriam Alter - Where Is There.ape Apr 16 13:03:45 volumio-p4 volumio[875]: info: ALBUMART /albumart?cacheid=105&web=Myriam%20Alter/Where%20Is%20There/extralarge&path=%2Fmnt%2FNAS%2FNAS2%2FJazz%2FMyriam%20Alter%20-%20Where%20Is%20There%20(2007)%2FMyriam%20Alter%20-%20Where%20Is%20There.cue&metadata=false Apr 16 13:03:45 volumio-p4 volumio[875]: info: URI /mnt/NAS/NAS2/Jazz/Myriam Alter - Where Is There (2007)/Myriam Alter - Where Is There.cue Apr 16 13:03:45 volumio-p4 volumio[875]: info: ALBUMART /albumart?cacheid=105&web=Myriam%20Alter/Where%20Is%20There/extralarge&path=%2Fmnt%2FNAS%2FNAS2%2FJazz%2FMyriam%20Alter%20-%20Where%20Is%20There%20(2007)%2FMyriam%20Alter%20-%20Where%20Is%20There.cue&metadata=false Apr 16 13:03:45 volumio-p4 volumio[875]: info: URI /mnt/NAS/NAS2/Jazz/Myriam Alter - Where Is There (2007)/Myriam Alter - Where Is There.cue Apr 16 13:03:45 volumio-p4 volumio[875]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 16 13:03:45 volumio-p4 volumio[875]: Error: Unable to resolve or reject the same promise twice Apr 16 13:03:45 volumio-p4 volumio[875]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Apr 16 13:03:45 volumio-p4 volumio[875]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Apr 16 13:03:45 volumio-p4 volumio[875]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Apr 16 13:03:45 volumio-p4 volumio[875]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Apr 16 13:03:45 volumio-p4 volumio[875]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Apr 16 13:03:45 volumio-p4 volumio[875]: at Socket.emit (events.js:315:20) Apr 16 13:03:45 volumio-p4 volumio[875]: at addChunk (internal/streams/readable.js:309:12) Apr 16 13:03:45 volumio-p4 volumio[875]: at readableAddChunk (internal/streams/readable.js:280:11) Apr 16 13:03:45 volumio-p4 volumio[875]: at Socket.Readable.push (internal/streams/readable.js:223:10) Apr 16 13:03:45 volumio-p4 volumio[875]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Apr 16 13:03:45 volumio-p4 volumio[875]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 16 13:03:46 volumio-p4 sudo[6613]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-16 13:02 Apr 16 13:03:46 volumio-p4 sudo[6613]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"