-- Logs begin at Thu 2019-02-14 15:41:59 IST, end at Mon 2026-01-12 11:48:11 IST. --
Jan 12 11:47:06 subbufr volumio[998]: info: CoreCommandRouter::volumioPause
Jan 12 11:47:06 subbufr volumio[998]: info: CoreStateMachine::pause
Jan 12 11:47:06 subbufr volumio[998]: info: CoreStateMachine::stPlaybackTimer
Jan 12 11:47:06 subbufr volumio[998]: info: CoreStateMachine::servicePause
Jan 12 11:47:06 subbufr volumio[998]: info: CorePlayQueue::getTrack 0
Jan 12 11:47:06 subbufr volumio[998]: info: CoreCommandRouter::servicePause
Jan 12 11:47:06 subbufr volumio[998]: info: ControllerMpd::pause
Jan 12 11:47:06 subbufr volumio[998]: verbose: ControllerMpd::sendMpdCommand pause
Jan 12 11:47:06 subbufr volumio[998]: info: sendMpdCommand pause took 2 milliseconds
Jan 12 11:47:06 subbufr volumio[998]: info:
Jan 12 11:47:06 subbufr volumio[998]: ---------------------------- MPD announces state update: player
Jan 12 11:47:06 subbufr volumio[998]: info: ControllerMpd::getState
Jan 12 11:47:06 subbufr volumio[998]: verbose: ControllerMpd::sendMpdCommand status
Jan 12 11:47:06 subbufr volumio[998]: info:
Jan 12 11:47:06 subbufr volumio[998]: ---------------------------- MPD announces state update: player
Jan 12 11:47:06 subbufr volumio[998]: info: ControllerMpd::getState
Jan 12 11:47:06 subbufr volumio[998]: verbose: ControllerMpd::sendMpdCommand status
Jan 12 11:47:06 subbufr volumio[998]: info:
Jan 12 11:47:06 subbufr volumio[998]: ---------------------------- MPD announces state update: player
Jan 12 11:47:06 subbufr volumio[998]: info: ControllerMpd::getState
Jan 12 11:47:06 subbufr volumio[998]: verbose: ControllerMpd::sendMpdCommand status
Jan 12 11:47:06 subbufr volumio[998]: info: sendMpdCommand status took 7 milliseconds
Jan 12 11:47:06 subbufr volumio[998]: info: sendMpdCommand status took 5 milliseconds
Jan 12 11:47:06 subbufr volumio[998]: info: sendMpdCommand status took 3 milliseconds
Jan 12 11:47:06 subbufr volumio[998]: verbose: ControllerMpd::parseState
Jan 12 11:47:06 subbufr volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 12 11:47:06 subbufr volumio[998]: verbose: ControllerMpd::parseState
Jan 12 11:47:06 subbufr volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 12 11:47:06 subbufr volumio[998]: verbose: ControllerMpd::parseState
Jan 12 11:47:06 subbufr volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 12 11:47:06 subbufr volumio[998]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jan 12 11:47:06 subbufr volumio[998]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jan 12 11:47:06 subbufr volumio[998]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jan 12 11:47:06 subbufr volumio[998]: verbose: ControllerMpd::parseTrackInfo
Jan 12 11:47:06 subbufr volumio[998]: verbose: ControllerMpd::parseTrackInfo
Jan 12 11:47:06 subbufr volumio[998]: verbose: ControllerMpd::parseTrackInfo
Jan 12 11:47:06 subbufr volumio[998]: info: ControllerMpd::pushState
Jan 12 11:47:06 subbufr volumio[998]: info: CoreCommandRouter::servicePushState
Jan 12 11:47:06 subbufr volumio[998]: info: CorePlayQueue::getTrack 0
Jan 12 11:47:06 subbufr volumio[998]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":124969,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Kokomo","artist":"Various Artists","album":"Ultimate Retro","uri":"USB/HiRes/Compilations/Ultimate Retro/1-05 Kokomo.aif","trackType":"aif"}
Jan 12 11:47:06 subbufr volumio[998]: verbose: CURRENT POSITION 0
Jan 12 11:47:06 subbufr volumio[998]: info: CoreStateMachine::syncState stateService pause
Jan 12 11:47:06 subbufr volumio[998]: info: CoreStateMachine::syncState currentStatus pause
Jan 12 11:47:06 subbufr volumio[998]: info: CoreStateMachine::pushState
Jan 12 11:47:06 subbufr volumio[998]: info: CorePlayQueue::getTrack 0
Jan 12 11:47:06 subbufr volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 12 11:47:06 subbufr volumio[998]: info: CoreCommandRouter::volumioPushState
Jan 12 11:47:07 subbufr volumio[998]: info: CoreStateMachine::stPlaybackTimer
Jan 12 11:47:07 subbufr volumio[998]: info: ControllerMpd::pushState
Jan 12 11:47:07 subbufr volumio[998]: info: CoreCommandRouter::servicePushState
Jan 12 11:47:07 subbufr volumio[998]: info: CorePlayQueue::getTrack 0
Jan 12 11:47:07 subbufr volumio[998]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":124969,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Kokomo","artist":"Various Artists","album":"Ultimate Retro","uri":"USB/HiRes/Compilations/Ultimate Retro/1-05 Kokomo.aif","trackType":"aif"}
Jan 12 11:47:07 subbufr volumio[998]: verbose: CURRENT POSITION 0
Jan 12 11:47:07 subbufr volumio[998]: info: CoreStateMachine::syncState stateService pause
Jan 12 11:47:07 subbufr volumio[998]: info: CoreStateMachine::syncState currentStatus pause
Jan 12 11:47:07 subbufr volumio[998]: info: CoreStateMachine::pushState
Jan 12 11:47:07 subbufr volumio[998]: info: CorePlayQueue::getTrack 0
Jan 12 11:47:07 subbufr volumio[998]: info: CoreCommandRouter::volumioPushState
Jan 12 11:47:07 subbufr volumio[998]: info: CoreStateMachine::stPlaybackTimer
Jan 12 11:47:07 subbufr volumio[998]: info: ControllerMpd::pushState
Jan 12 11:47:07 subbufr volumio[998]: info: CoreCommandRouter::servicePushState
Jan 12 11:47:07 subbufr volumio[998]: info: CorePlayQueue::getTrack 0
Jan 12 11:47:07 subbufr volumio[998]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":124969,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Kokomo","artist":"Various Artists","album":"Ultimate Retro","uri":"USB/HiRes/Compilations/Ultimate Retro/1-05 Kokomo.aif","trackType":"aif"}
Jan 12 11:47:07 subbufr volumio[998]: verbose: CURRENT POSITION 0
Jan 12 11:47:07 subbufr volumio[998]: info: CoreStateMachine::syncState stateService pause
Jan 12 11:47:07 subbufr volumio[998]: info: CoreStateMachine::syncState currentStatus pause
Jan 12 11:47:07 subbufr volumio[998]: info: CoreStateMachine::pushState
Jan 12 11:47:07 subbufr volumio[998]: info: CorePlayQueue::getTrack 0
Jan 12 11:47:07 subbufr volumio[998]: info: CoreCommandRouter::volumioPushState
Jan 12 11:47:07 subbufr volumio[998]: info: CoreStateMachine::stPlaybackTimer
Jan 12 11:47:07 subbufr volumio[998]: info: ------------------------------ 64ms
Jan 12 11:47:07 subbufr volumio[998]: info: ------------------------------ 63ms
Jan 12 11:47:07 subbufr volumio[998]: info: ------------------------------ 61ms
Jan 12 11:47:11 subbufr volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jan 12 11:47:11 subbufr volumio[998]: info: CURURI: music-library
Jan 12 11:47:11 subbufr volumio[998]: info: Preload queue cleared
Jan 12 11:47:15 subbufr volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jan 12 11:47:15 subbufr volumio[998]: info: CURURI: music-library/USB
Jan 12 11:47:15 subbufr volumio[998]: info: Preload queue cleared
Jan 12 11:47:16 subbufr volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jan 12 11:47:16 subbufr volumio[998]: info: CURURI: music-library/USB/HiRes
Jan 12 11:47:16 subbufr volumio[998]: info: Preload queue cleared
Jan 12 11:47:24 subbufr volumio[998]: info: MPD Database updated - AlbumList cache refreshed
Jan 12 11:47:24 subbufr volumio[998]: info:
Jan 12 11:47:24 subbufr volumio[998]: ---------------------------- MPD announces state update: database
Jan 12 11:47:24 subbufr volumio[998]: verbose: ControllerMpd::sendMpdCommand status
Jan 12 11:47:24 subbufr volumio[998]: info:
Jan 12 11:47:24 subbufr volumio[998]: ---------------------------- MPD announces state update: update
Jan 12 11:47:24 subbufr volumio[998]: info: ControllerMpd::getState
Jan 12 11:47:24 subbufr volumio[998]: verbose: ControllerMpd::sendMpdCommand status
Jan 12 11:47:24 subbufr volumio[998]: info: ControllerMpd::getState
Jan 12 11:47:24 subbufr volumio[998]: verbose: ControllerMpd::sendMpdCommand status
Jan 12 11:47:24 subbufr volumio[998]: info: MPD Database updated - AlbumList cache refreshed
Jan 12 11:47:24 subbufr volumio[998]: info:
Jan 12 11:47:24 subbufr volumio[998]: ---------------------------- MPD announces state update: database
Jan 12 11:47:24 subbufr volumio[998]: verbose: ControllerMpd::sendMpdCommand status
Jan 12 11:47:24 subbufr volumio[998]: info:
Jan 12 11:47:24 subbufr volumio[998]: ---------------------------- MPD announces state update: update
Jan 12 11:47:24 subbufr volumio[998]: info: ControllerMpd::getState
Jan 12 11:47:24 subbufr volumio[998]: verbose: ControllerMpd::sendMpdCommand status
Jan 12 11:47:24 subbufr volumio[998]: info: ControllerMpd::getState
Jan 12 11:47:24 subbufr volumio[998]: verbose: ControllerMpd::sendMpdCommand status
Jan 12 11:47:24 subbufr volumio[998]: info: MPD Database updated - AlbumList cache refreshed
Jan 12 11:47:24 subbufr volumio[998]: info:
Jan 12 11:47:24 subbufr volumio[998]: ---------------------------- MPD announces state update: database
Jan 12 11:47:24 subbufr volumio[998]: verbose: ControllerMpd::sendMpdCommand status
Jan 12 11:47:24 subbufr volumio[998]: info:
Jan 12 11:47:24 subbufr volumio[998]: ---------------------------- MPD announces state update: update
Jan 12 11:47:24 subbufr volumio[998]: info: ControllerMpd::getState
Jan 12 11:47:24 subbufr volumio[998]: verbose: ControllerMpd::sendMpdCommand status
Jan 12 11:47:24 subbufr volumio[998]: info: ControllerMpd::getState
Jan 12 11:47:24 subbufr volumio[998]: verbose: ControllerMpd::sendMpdCommand status
Jan 12 11:47:25 subbufr volumio[998]: info: sendMpdCommand status took 1299 milliseconds
Jan 12 11:47:25 subbufr volumio[998]: info: sendMpdCommand status took 1297 milliseconds
Jan 12 11:47:25 subbufr volumio[998]: verbose: ControllerMpd::parseState
Jan 12 11:47:25 subbufr volumio[998]: info: Command Router : Notfying DB Updatefalse
Jan 12 11:47:25 subbufr volumio[998]: info: CoreCommandRouter::Close All Modals sent
Jan 12 11:47:25 subbufr volumio[998]: verbose: ControllerMpd::parseState
Jan 12 11:47:25 subbufr volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 12 11:47:25 subbufr volumio[998]: verbose: ControllerMpd::parseState
Jan 12 11:47:25 subbufr volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 12 11:47:26 subbufr volumio[998]: info: sendMpdCommand status took 2194 milliseconds
Jan 12 11:47:26 subbufr volumio[998]: info: sendMpdCommand status took 2194 milliseconds
Jan 12 11:47:26 subbufr volumio[998]: info: sendMpdCommand status took 2194 milliseconds
Jan 12 11:47:26 subbufr volumio[998]: verbose: ControllerMpd::parseState
Jan 12 11:47:26 subbufr volumio[998]: info: Command Router : Notfying DB Updatefalse
Jan 12 11:47:26 subbufr volumio[998]: info: CoreCommandRouter::Close All Modals sent
Jan 12 11:47:26 subbufr volumio[998]: verbose: ControllerMpd::parseState
Jan 12 11:47:26 subbufr volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 12 11:47:26 subbufr volumio[998]: verbose: ControllerMpd::parseState
Jan 12 11:47:26 subbufr volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 12 11:47:27 subbufr volumio[998]: info: sendMpdCommand status took 2996 milliseconds
Jan 12 11:47:27 subbufr volumio[998]: info: sendMpdCommand status took 2995 milliseconds
Jan 12 11:47:27 subbufr volumio[998]: verbose: ControllerMpd::parseState
Jan 12 11:47:27 subbufr volumio[998]: info: Command Router : Notfying DB Updatefalse
Jan 12 11:47:27 subbufr volumio[998]: info: CoreCommandRouter::Close All Modals sent
Jan 12 11:47:27 subbufr volumio[998]: verbose: ControllerMpd::parseState
Jan 12 11:47:27 subbufr volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 12 11:47:27 subbufr volumio[998]: verbose: ControllerMpd::parseState
Jan 12 11:47:27 subbufr volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 12 11:47:27 subbufr volumio[998]: info: sendMpdCommand playlistinfo took 1692 milliseconds
Jan 12 11:47:27 subbufr volumio[998]: info: sendMpdCommand playlistinfo took 1692 milliseconds
Jan 12 11:47:27 subbufr volumio[998]: verbose: ControllerMpd::parseTrackInfo
Jan 12 11:47:27 subbufr volumio[998]: verbose: ControllerMpd::parseTrackInfo
Jan 12 11:47:27 subbufr volumio[998]: info: ControllerMpd::pushState
Jan 12 11:47:27 subbufr volumio[998]: info: CoreCommandRouter::servicePushState
Jan 12 11:47:27 subbufr volumio[998]: info: CorePlayQueue::getTrack 0
Jan 12 11:47:27 subbufr volumio[998]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":124969,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Kokomo","artist":"Various Artists","album":"Ultimate Retro","uri":"USB/HiRes/Compilations/Ultimate Retro/1-05 Kokomo.aif","trackType":"aif"}
Jan 12 11:47:27 subbufr volumio[998]: verbose: CURRENT POSITION 0
Jan 12 11:47:27 subbufr volumio[998]: info: CoreStateMachine::syncState stateService pause
Jan 12 11:47:27 subbufr volumio[998]: info: CoreStateMachine::syncState currentStatus pause
Jan 12 11:47:27 subbufr volumio[998]: info: CoreStateMachine::pushState
Jan 12 11:47:27 subbufr volumio[998]: info: CorePlayQueue::getTrack 0
Jan 12 11:47:27 subbufr volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 12 11:47:27 subbufr volumio[998]: info: CoreCommandRouter::volumioPushState
Jan 12 11:47:27 subbufr volumio[998]: info: CoreStateMachine::stPlaybackTimer
Jan 12 11:47:27 subbufr volumio[998]: info: ControllerMpd::pushState
Jan 12 11:47:27 subbufr volumio[998]: info: CoreCommandRouter::servicePushState
Jan 12 11:47:27 subbufr volumio[998]: info: CorePlayQueue::getTrack 0
Jan 12 11:47:27 subbufr volumio[998]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":124969,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Kokomo","artist":"Various Artists","album":"Ultimate Retro","uri":"USB/HiRes/Compilations/Ultimate Retro/1-05 Kokomo.aif","trackType":"aif"}
Jan 12 11:47:27 subbufr volumio[998]: verbose: CURRENT POSITION 0
Jan 12 11:47:27 subbufr volumio[998]: info: CoreStateMachine::syncState stateService pause
Jan 12 11:47:27 subbufr volumio[998]: info: CoreStateMachine::syncState currentStatus pause
Jan 12 11:47:27 subbufr volumio[998]: info: CoreStateMachine::pushState
Jan 12 11:47:27 subbufr volumio[998]: info: CorePlayQueue::getTrack 0
Jan 12 11:47:27 subbufr volumio[998]: info: CoreCommandRouter::volumioPushState
Jan 12 11:47:27 subbufr volumio[998]: info: CoreStateMachine::stPlaybackTimer
Jan 12 11:47:27 subbufr volumio[998]: info: ------------------------------ 3082ms
Jan 12 11:47:27 subbufr volumio[998]: info: ------------------------------ 3082ms
Jan 12 11:47:27 subbufr volumio[998]: info: sendMpdCommand playlistinfo took 859 milliseconds
Jan 12 11:47:27 subbufr volumio[998]: info: sendMpdCommand playlistinfo took 858 milliseconds
Jan 12 11:47:27 subbufr volumio[998]: verbose: ControllerMpd::parseTrackInfo
Jan 12 11:47:27 subbufr volumio[998]: verbose: ControllerMpd::parseTrackInfo
Jan 12 11:47:27 subbufr volumio[998]: info: ControllerMpd::pushState
Jan 12 11:47:27 subbufr volumio[998]: info: CoreCommandRouter::servicePushState
Jan 12 11:47:27 subbufr volumio[998]: info: CorePlayQueue::getTrack 0
Jan 12 11:47:27 subbufr volumio[998]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":124969,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Kokomo","artist":"Various Artists","album":"Ultimate Retro","uri":"USB/HiRes/Compilations/Ultimate Retro/1-05 Kokomo.aif","trackType":"aif"}
Jan 12 11:47:27 subbufr volumio[998]: verbose: CURRENT POSITION 0
Jan 12 11:47:27 subbufr volumio[998]: info: CoreStateMachine::syncState stateService pause
Jan 12 11:47:27 subbufr volumio[998]: info: CoreStateMachine::syncState currentStatus pause
Jan 12 11:47:27 subbufr volumio[998]: info: CoreStateMachine::pushState
Jan 12 11:47:27 subbufr volumio[998]: info: CorePlayQueue::getTrack 0
Jan 12 11:47:27 subbufr volumio[998]: info: CoreCommandRouter::volumioPushState
Jan 12 11:47:27 subbufr volumio[998]: info: CoreStateMachine::stPlaybackTimer
Jan 12 11:47:27 subbufr volumio[998]: info: ControllerMpd::pushState
Jan 12 11:47:27 subbufr volumio[998]: info: CoreCommandRouter::servicePushState
Jan 12 11:47:27 subbufr volumio[998]: info: CorePlayQueue::getTrack 0
Jan 12 11:47:27 subbufr volumio[998]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":124969,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Kokomo","artist":"Various Artists","album":"Ultimate Retro","uri":"USB/HiRes/Compilations/Ultimate Retro/1-05 Kokomo.aif","trackType":"aif"}
Jan 12 11:47:27 subbufr volumio[998]: verbose: CURRENT POSITION 0
Jan 12 11:47:27 subbufr volumio[998]: info: CoreStateMachine::syncState stateService pause
Jan 12 11:47:27 subbufr volumio[998]: info: CoreStateMachine::syncState currentStatus pause
Jan 12 11:47:27 subbufr volumio[998]: info: CoreStateMachine::pushState
Jan 12 11:47:27 subbufr volumio[998]: info: CorePlayQueue::getTrack 0
Jan 12 11:47:27 subbufr volumio[998]: info: CoreCommandRouter::volumioPushState
Jan 12 11:47:27 subbufr volumio[998]: info: CoreStateMachine::stPlaybackTimer
Jan 12 11:47:27 subbufr volumio[998]: info: ------------------------------ 3113ms
Jan 12 11:47:27 subbufr volumio[998]: info: ------------------------------ 3113ms
Jan 12 11:47:27 subbufr volumio[998]: info: sendMpdCommand playlistinfo took 87 milliseconds
Jan 12 11:47:27 subbufr volumio[998]: info: sendMpdCommand playlistinfo took 87 milliseconds
Jan 12 11:47:27 subbufr volumio[998]: verbose: ControllerMpd::parseTrackInfo
Jan 12 11:47:27 subbufr volumio[998]: verbose: ControllerMpd::parseTrackInfo
Jan 12 11:47:27 subbufr volumio[998]: info: ControllerMpd::pushState
Jan 12 11:47:27 subbufr volumio[998]: info: CoreCommandRouter::servicePushState
Jan 12 11:47:27 subbufr volumio[998]: info: CorePlayQueue::getTrack 0
Jan 12 11:47:27 subbufr volumio[998]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":124969,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Kokomo","artist":"Various Artists","album":"Ultimate Retro","uri":"USB/HiRes/Compilations/Ultimate Retro/1-05 Kokomo.aif","trackType":"aif"}
Jan 12 11:47:27 subbufr volumio[998]: verbose: CURRENT POSITION 0
Jan 12 11:47:27 subbufr volumio[998]: info: CoreStateMachine::syncState stateService pause
Jan 12 11:47:27 subbufr volumio[998]: info: CoreStateMachine::syncState currentStatus pause
Jan 12 11:47:27 subbufr volumio[998]: info: CoreStateMachine::pushState
Jan 12 11:47:27 subbufr volumio[998]: info: CorePlayQueue::getTrack 0
Jan 12 11:47:27 subbufr volumio[998]: info: CoreCommandRouter::volumioPushState
Jan 12 11:47:27 subbufr volumio[998]: info: CoreStateMachine::stPlaybackTimer
Jan 12 11:47:27 subbufr volumio[998]: info: ControllerMpd::pushState
Jan 12 11:47:27 subbufr volumio[998]: info: CoreCommandRouter::servicePushState
Jan 12 11:47:27 subbufr volumio[998]: info: CorePlayQueue::getTrack 0
Jan 12 11:47:27 subbufr volumio[998]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":124969,"duration":202,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Kokomo","artist":"Various Artists","album":"Ultimate Retro","uri":"USB/HiRes/Compilations/Ultimate Retro/1-05 Kokomo.aif","trackType":"aif"}
Jan 12 11:47:27 subbufr volumio[998]: verbose: CURRENT POSITION 0
Jan 12 11:47:27 subbufr volumio[998]: info: CoreStateMachine::syncState stateService pause
Jan 12 11:47:27 subbufr volumio[998]: info: CoreStateMachine::syncState currentStatus pause
Jan 12 11:47:27 subbufr volumio[998]: info: CoreStateMachine::pushState
Jan 12 11:47:27 subbufr volumio[998]: info: CorePlayQueue::getTrack 0
Jan 12 11:47:27 subbufr volumio[998]: info: CoreCommandRouter::volumioPushState
Jan 12 11:47:27 subbufr volumio[998]: info: CoreStateMachine::stPlaybackTimer
Jan 12 11:47:27 subbufr volumio[998]: info: ------------------------------ 3163ms
Jan 12 11:47:27 subbufr volumio[998]: info: ------------------------------ 3164ms
Jan 12 11:47:36 subbufr volumio[998]: Searching plugin music_service/mpd
Jan 12 11:47:36 subbufr volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Jan 12 11:47:36 subbufr volumio[998]: info: All search sources collected, pushing search results
Jan 12 11:47:36 subbufr volumio[998]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Jan 12 11:47:36 subbufr volumio[998]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Jan 12 11:47:36 subbufr volumio[998]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Jan 12 11:47:38 subbufr volumio[998]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg'
Jan 12 11:47:39 subbufr volumio[998]: Searching plugin music_service/mpd
Jan 12 11:47:39 subbufr volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Jan 12 11:47:40 subbufr volumio[998]: info: All search sources collected, pushing search results
Jan 12 11:47:58 subbufr volumio[998]: Searching plugin music_service/mpd
Jan 12 11:47:58 subbufr volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Jan 12 11:47:59 subbufr volumio[998]: info: All search sources collected, pushing search results
Jan 12 11:48:01 subbufr volumio[998]: Searching plugin music_service/mpd
Jan 12 11:48:01 subbufr volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Jan 12 11:48:02 subbufr volumio[998]: info: All search sources collected, pushing search results
Jan 12 11:48:06 subbufr volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jan 12 11:48:06 subbufr volumio[998]: info: CURURI: artists://Depeche%20Mode
Jan 12 11:48:06 subbufr volumio[998]: info: Preload queue cleared
Jan 12 11:48:06 subbufr volumio[998]: info: Preloading song: music-library/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/01 I Feel You.aif
Jan 12 11:48:06 subbufr volumio[998]: info: Preloading song: music-library/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/02 Walking In My Shoes.aif
Jan 12 11:48:06 subbufr volumio[998]: info: Preloading song: music-library/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/03 Condemnation.aif
Jan 12 11:48:06 subbufr volumio[998]: info: Preloading song: music-library/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/04 Mercy In You.aif
Jan 12 11:48:06 subbufr volumio[998]: info: Preloading song: music-library/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/05 Judas.aif
Jan 12 11:48:06 subbufr volumio[998]: info: Preloading song: music-library/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/06 In Your Room.aif
Jan 12 11:48:06 subbufr volumio[998]: info: Preloading song: music-library/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/07 Get Right With Me.aif
Jan 12 11:48:06 subbufr volumio[998]: info: Preloading song: music-library/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/08 Rush.aif
Jan 12 11:48:06 subbufr volumio[998]: info: Preloading song: music-library/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/09 One Caress.aif
Jan 12 11:48:06 subbufr volumio[998]: info: Preloading song: music-library/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/10 Higher Love.aif
Jan 12 11:48:06 subbufr volumio[998]: info: Exploding uri music-library/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/01 I Feel You.aif in service mpd
Jan 12 11:48:06 subbufr volumio[998]: info: ALBUMART /albumart?cacheid=77&web=Depeche%20Mode/Songs%20Of%20Faith%20And%20Devotion/extralarge&path=%2Fmnt%2FUSB%2FHiRes%2FDepeche%20Mode%2FSongs%20Of%20Faith%20And%20Devotion%2F01%20I%20Feel%20You.aif&metadata=false
Jan 12 11:48:06 subbufr volumio[998]: info: URI /mnt/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/01 I Feel You.aif
Jan 12 11:48:06 subbufr volumio[998]: info: Exploding uri music-library/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/02 Walking In My Shoes.aif in service mpd
Jan 12 11:48:06 subbufr volumio[998]: info: ALBUMART /albumart?cacheid=77&web=Depeche%20Mode/Songs%20Of%20Faith%20And%20Devotion/extralarge&path=%2Fmnt%2FUSB%2FHiRes%2FDepeche%20Mode%2FSongs%20Of%20Faith%20And%20Devotion%2F02%20Walking%20In%20My%20Shoes.aif&metadata=false
Jan 12 11:48:06 subbufr volumio[998]: info: URI /mnt/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/02 Walking In My Shoes.aif
Jan 12 11:48:06 subbufr volumio[998]: info: Exploding uri music-library/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/03 Condemnation.aif in service mpd
Jan 12 11:48:06 subbufr volumio[998]: info: ALBUMART /albumart?cacheid=77&web=Depeche%20Mode/Songs%20Of%20Faith%20And%20Devotion/extralarge&path=%2Fmnt%2FUSB%2FHiRes%2FDepeche%20Mode%2FSongs%20Of%20Faith%20And%20Devotion%2F03%20Condemnation.aif&metadata=false
Jan 12 11:48:06 subbufr volumio[998]: info: URI /mnt/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/03 Condemnation.aif
Jan 12 11:48:06 subbufr volumio[998]: info: Exploding uri music-library/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/04 Mercy In You.aif in service mpd
Jan 12 11:48:06 subbufr volumio[998]: info: ALBUMART /albumart?cacheid=77&web=Depeche%20Mode/Songs%20Of%20Faith%20And%20Devotion/extralarge&path=%2Fmnt%2FUSB%2FHiRes%2FDepeche%20Mode%2FSongs%20Of%20Faith%20And%20Devotion%2F04%20Mercy%20In%20You.aif&metadata=false
Jan 12 11:48:06 subbufr volumio[998]: info: URI /mnt/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/04 Mercy In You.aif
Jan 12 11:48:06 subbufr volumio[998]: info: Exploding uri music-library/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/05 Judas.aif in service mpd
Jan 12 11:48:06 subbufr volumio[998]: info: ALBUMART /albumart?cacheid=77&web=Depeche%20Mode/Songs%20Of%20Faith%20And%20Devotion/extralarge&path=%2Fmnt%2FUSB%2FHiRes%2FDepeche%20Mode%2FSongs%20Of%20Faith%20And%20Devotion%2F05%20Judas.aif&metadata=false
Jan 12 11:48:06 subbufr volumio[998]: info: URI /mnt/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/05 Judas.aif
Jan 12 11:48:06 subbufr volumio[998]: info: Exploding uri music-library/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/06 In Your Room.aif in service mpd
Jan 12 11:48:06 subbufr volumio[998]: info: ALBUMART /albumart?cacheid=77&web=Depeche%20Mode/Songs%20Of%20Faith%20And%20Devotion/extralarge&path=%2Fmnt%2FUSB%2FHiRes%2FDepeche%20Mode%2FSongs%20Of%20Faith%20And%20Devotion%2F06%20In%20Your%20Room.aif&metadata=false
Jan 12 11:48:06 subbufr volumio[998]: info: URI /mnt/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/06 In Your Room.aif
Jan 12 11:48:07 subbufr volumio[998]: info: Exploding uri music-library/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/07 Get Right With Me.aif in service mpd
Jan 12 11:48:07 subbufr volumio[998]: info: ALBUMART /albumart?cacheid=77&web=Depeche%20Mode/Songs%20Of%20Faith%20And%20Devotion/extralarge&path=%2Fmnt%2FUSB%2FHiRes%2FDepeche%20Mode%2FSongs%20Of%20Faith%20And%20Devotion%2F07%20Get%20Right%20With%20Me.aif&metadata=false
Jan 12 11:48:07 subbufr volumio[998]: info: URI /mnt/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/07 Get Right With Me.aif
Jan 12 11:48:07 subbufr volumio[998]: info: Exploding uri music-library/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/08 Rush.aif in service mpd
Jan 12 11:48:07 subbufr volumio[998]: info: ALBUMART /albumart?cacheid=77&web=Depeche%20Mode/Songs%20Of%20Faith%20And%20Devotion/extralarge&path=%2Fmnt%2FUSB%2FHiRes%2FDepeche%20Mode%2FSongs%20Of%20Faith%20And%20Devotion%2F08%20Rush.aif&metadata=false
Jan 12 11:48:07 subbufr volumio[998]: info: URI /mnt/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/08 Rush.aif
Jan 12 11:48:07 subbufr volumio[998]: info: Exploding uri music-library/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/09 One Caress.aif in service mpd
Jan 12 11:48:07 subbufr volumio[998]: info: ALBUMART /albumart?cacheid=77&web=Depeche%20Mode/Songs%20Of%20Faith%20And%20Devotion/extralarge&path=%2Fmnt%2FUSB%2FHiRes%2FDepeche%20Mode%2FSongs%20Of%20Faith%20And%20Devotion%2F09%20One%20Caress.aif&metadata=false
Jan 12 11:48:07 subbufr volumio[998]: info: URI /mnt/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/09 One Caress.aif
Jan 12 11:48:07 subbufr volumio[998]: info: Exploding uri music-library/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/10 Higher Love.aif in service mpd
Jan 12 11:48:07 subbufr volumio[998]: info: ALBUMART /albumart?cacheid=77&web=Depeche%20Mode/Songs%20Of%20Faith%20And%20Devotion/extralarge&path=%2Fmnt%2FUSB%2FHiRes%2FDepeche%20Mode%2FSongs%20Of%20Faith%20And%20Devotion%2F10%20Higher%20Love.aif&metadata=false
Jan 12 11:48:07 subbufr volumio[998]: info: URI /mnt/USB/HiRes/Depeche Mode/Songs Of Faith And Devotion/10 Higher Love.aif
Jan 12 11:48:10 subbufr volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jan 12 11:48:10 subbufr volumio[998]: info: CURURI: artists://Depeche%20Mode/Songs%20Of%20Faith%20And%20Devotion
Jan 12 11:48:10 subbufr volumio[998]: info: Preload queue cleared
Jan 12 11:48:10 subbufr volumio[998]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 12 11:48:10 subbufr volumio[998]: TypeError: Cannot read property 'slice' of null
Jan 12 11:48:10 subbufr volumio[998]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41)
Jan 12 11:48:10 subbufr volumio[998]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7)
Jan 12 11:48:10 subbufr volumio[998]: at Object.onceWrapper (events.js:422:26)
Jan 12 11:48:10 subbufr volumio[998]: at ClientRequest.emit (events.js:315:20)
Jan 12 11:48:10 subbufr volumio[998]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27)
Jan 12 11:48:10 subbufr volumio[998]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17)
Jan 12 11:48:10 subbufr volumio[998]: at TLSSocket.socketOnData (_http_client.js:509:22)
Jan 12 11:48:10 subbufr volumio[998]: at TLSSocket.emit (events.js:315:20)
Jan 12 11:48:10 subbufr volumio[998]: at addChunk (internal/streams/readable.js:309:12)
Jan 12 11:48:10 subbufr volumio[998]: at readableAddChunk (internal/streams/readable.js:284:9)
Jan 12 11:48:10 subbufr volumio[998]: at TLSSocket.Readable.push (internal/streams/readable.js:223:10)
Jan 12 11:48:10 subbufr volumio[998]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23)
Jan 12 11:48:10 subbufr volumio[998]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 12 11:48:11 subbufr sudo[2043]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-12 11:47
Jan 12 11:48:11 subbufr sudo[2043]: 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="b43c85cc0006d3f1efecba101311ec96e334d1fd"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET"
VOLUMIO_VERSION="3.886"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"