-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sat 2024-10-26 15:35:50 CEST. --
Oct 26 15:34:07 volumio-digipro volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 26 15:34:07 volumio-digipro volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 26 15:34:07 volumio-digipro volumio[1017]: info: Discovery: Getting this device information
Oct 26 15:34:07 volumio-digipro volumio[1017]: info: CoreCommandRouter::volumioGetState
Oct 26 15:34:07 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 26 15:34:07 volumio-digipro volumio[1017]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 26 15:34:16 volumio-digipro volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 26 15:34:16 volumio-digipro volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 26 15:34:16 volumio-digipro volumio[1017]: info: Discovery: Getting this device information
Oct 26 15:34:16 volumio-digipro volumio[1017]: info: CoreCommandRouter::volumioGetState
Oct 26 15:34:16 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 26 15:34:16 volumio-digipro volumio[1017]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 26 15:34:39 volumio-digipro volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 26 15:34:39 volumio-digipro volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 26 15:34:39 volumio-digipro volumio[1017]: info: Discovery: Getting this device information
Oct 26 15:34:39 volumio-digipro volumio[1017]: info: CoreCommandRouter::volumioGetState
Oct 26 15:34:39 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 26 15:34:39 volumio-digipro volumio[1017]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 26 15:34:46 volumio-digipro volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 26 15:34:46 volumio-digipro volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 26 15:34:46 volumio-digipro volumio[1017]: info: Discovery: Getting this device information
Oct 26 15:34:46 volumio-digipro volumio[1017]: info: CoreCommandRouter::volumioGetState
Oct 26 15:34:46 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 26 15:34:46 volumio-digipro volumio[1017]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 1
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: Prefetching next song
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: DOING PREFETCH IN MPD
Oct 26 15:35:05 volumio-digipro volumio[1017]: verbose: ControllerMpd::sendMpdCommand add "USB/KINGSTON/muzika flac/Natalie Merchant/2015 Paradise Is There {EU, Nonesuch 7559-79501-5}/02 - Beloved Wife.flac"
Oct 26 15:35:05 volumio-digipro volumio[1017]: info:
Oct 26 15:35:05 volumio-digipro volumio[1017]: ---------------------------- MPD announces system playlist update
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: Ignoring MPD Status Update
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: sendMpdCommand add "USB/KINGSTON/muzika flac/Natalie Merchant/2015 Paradise Is There {EU, Nonesuch 7559-79501-5}/02 - Beloved Wife.flac" took 4 milliseconds
Oct 26 15:35:05 volumio-digipro volumio[1017]: verbose: ControllerMpd::sendMpdCommand consume 1
Oct 26 15:35:05 volumio-digipro volumio[1017]: info:
Oct 26 15:35:05 volumio-digipro volumio[1017]: ---------------------------- MPD announces system playlist update
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: Ignoring MPD Status Update
Oct 26 15:35:05 volumio-digipro volumio[1017]: info:
Oct 26 15:35:05 volumio-digipro volumio[1017]: ---------------------------- MPD announces system playlist update
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: Ignoring MPD Status Update
Oct 26 15:35:05 volumio-digipro volumio[1017]: info:
Oct 26 15:35:05 volumio-digipro volumio[1017]: ---------------------------- MPD announces state update: options
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: ------------------------------ 39ms
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: sendMpdCommand consume 1 took 34 milliseconds
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: ControllerMpd::getState
Oct 26 15:35:05 volumio-digipro volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: ------------------------------ 16ms
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: ------------------------------ 13ms
Oct 26 15:35:05 volumio-digipro volumio[1017]: info:
Oct 26 15:35:05 volumio-digipro volumio[1017]: ---------------------------- MPD announces state update: options
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: ControllerMpd::getState
Oct 26 15:35:05 volumio-digipro volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 15:35:05 volumio-digipro volumio[1017]: info:
Oct 26 15:35:05 volumio-digipro volumio[1017]: ---------------------------- MPD announces state update: options
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: ControllerMpd::getState
Oct 26 15:35:05 volumio-digipro volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: sendMpdCommand status took 13 milliseconds
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: sendMpdCommand status took 9 milliseconds
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: sendMpdCommand status took 6 milliseconds
Oct 26 15:35:05 volumio-digipro volumio[1017]: verbose: ControllerMpd::parseState
Oct 26 15:35:05 volumio-digipro volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 15:35:05 volumio-digipro volumio[1017]: verbose: ControllerMpd::parseState
Oct 26 15:35:05 volumio-digipro volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 15:35:05 volumio-digipro volumio[1017]: verbose: ControllerMpd::parseState
Oct 26 15:35:05 volumio-digipro volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: sendMpdCommand playlistinfo took 11 milliseconds
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: sendMpdCommand playlistinfo took 8 milliseconds
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: sendMpdCommand playlistinfo took 7 milliseconds
Oct 26 15:35:05 volumio-digipro volumio[1017]: verbose: ControllerMpd::parseTrackInfo
Oct 26 15:35:05 volumio-digipro volumio[1017]: verbose: ControllerMpd::parseTrackInfo
Oct 26 15:35:05 volumio-digipro volumio[1017]: verbose: ControllerMpd::parseTrackInfo
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: ControllerMpd::pushState
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CoreCommandRouter::servicePushState
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 26 15:35:05 volumio-digipro volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":284464,"duration":289,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"277 Kbps","isStreaming":false,"title":"San Andreas Fault","artist":"Natalie Merchant","album":"Paradise Is There: The New Tigerlily Recordings","uri":"USB/KINGSTON/muzika flac/Natalie Merchant/2015 Paradise Is There {EU, Nonesuch 7559-79501-5}/01 - San Andreas Fault.flac","trackType":"flac"}
Oct 26 15:35:05 volumio-digipro volumio[1017]: verbose: CURRENT POSITION 0
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CoreStateMachine::syncState stateService play
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CoreStateMachine::syncState currentStatus play
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: Received an update from plugin. extracting info from payload
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CoreStateMachine::pushState
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CoreCommandRouter::volumioPushState
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CoreStateMachine::pushState
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CoreCommandRouter::volumioPushState
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: ControllerMpd::pushState
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CoreCommandRouter::servicePushState
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 26 15:35:05 volumio-digipro volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":284464,"duration":289,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"277 Kbps","isStreaming":false,"title":"San Andreas Fault","artist":"Natalie Merchant","album":"Paradise Is There: The New Tigerlily Recordings","uri":"USB/KINGSTON/muzika flac/Natalie Merchant/2015 Paradise Is There {EU, Nonesuch 7559-79501-5}/01 - San Andreas Fault.flac","trackType":"flac"}
Oct 26 15:35:05 volumio-digipro volumio[1017]: verbose: CURRENT POSITION 0
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CoreStateMachine::syncState stateService play
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CoreStateMachine::syncState currentStatus play
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: Received an update from plugin. extracting info from payload
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CoreStateMachine::pushState
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CoreCommandRouter::volumioPushState
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CoreStateMachine::pushState
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CoreCommandRouter::volumioPushState
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: ControllerMpd::pushState
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CoreCommandRouter::servicePushState
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 26 15:35:05 volumio-digipro volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":284464,"duration":289,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"277 Kbps","isStreaming":false,"title":"San Andreas Fault","artist":"Natalie Merchant","album":"Paradise Is There: The New Tigerlily Recordings","uri":"USB/KINGSTON/muzika flac/Natalie Merchant/2015 Paradise Is There {EU, Nonesuch 7559-79501-5}/01 - San Andreas Fault.flac","trackType":"flac"}
Oct 26 15:35:05 volumio-digipro volumio[1017]: verbose: CURRENT POSITION 0
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CoreStateMachine::syncState stateService play
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CoreStateMachine::syncState currentStatus play
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: Received an update from plugin. extracting info from payload
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CoreStateMachine::pushState
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CoreCommandRouter::volumioPushState
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CoreStateMachine::pushState
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: CoreCommandRouter::volumioPushState
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: ------------------------------ 220ms
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: ------------------------------ 213ms
Oct 26 15:35:05 volumio-digipro volumio[1017]: info: ------------------------------ 211ms
Oct 26 15:35:09 volumio-digipro volumio[1017]: info:
Oct 26 15:35:09 volumio-digipro volumio[1017]: ---------------------------- MPD announces system playlist update
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: Ignoring MPD Status Update
Oct 26 15:35:09 volumio-digipro volumio[1017]: info:
Oct 26 15:35:09 volumio-digipro volumio[1017]: ---------------------------- MPD announces state update: player
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: ControllerMpd::getState
Oct 26 15:35:09 volumio-digipro volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 15:35:09 volumio-digipro volumio[1017]: info:
Oct 26 15:35:09 volumio-digipro volumio[1017]: ---------------------------- MPD announces system playlist update
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: Ignoring MPD Status Update
Oct 26 15:35:09 volumio-digipro volumio[1017]: info:
Oct 26 15:35:09 volumio-digipro volumio[1017]: ---------------------------- MPD announces state update: player
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: ControllerMpd::getState
Oct 26 15:35:09 volumio-digipro volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 15:35:09 volumio-digipro volumio[1017]: info:
Oct 26 15:35:09 volumio-digipro volumio[1017]: ---------------------------- MPD announces system playlist update
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: Ignoring MPD Status Update
Oct 26 15:35:09 volumio-digipro volumio[1017]: info:
Oct 26 15:35:09 volumio-digipro volumio[1017]: ---------------------------- MPD announces state update: player
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: ControllerMpd::getState
Oct 26 15:35:09 volumio-digipro volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: ------------------------------ 16ms
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: sendMpdCommand status took 15 milliseconds
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: ------------------------------ 13ms
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: sendMpdCommand status took 10 milliseconds
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: ------------------------------ 9ms
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: sendMpdCommand status took 7 milliseconds
Oct 26 15:35:09 volumio-digipro volumio[1017]: verbose: ControllerMpd::parseState
Oct 26 15:35:09 volumio-digipro volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 15:35:09 volumio-digipro volumio[1017]: verbose: ControllerMpd::parseState
Oct 26 15:35:09 volumio-digipro volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 15:35:09 volumio-digipro volumio[1017]: verbose: ControllerMpd::parseState
Oct 26 15:35:09 volumio-digipro volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: sendMpdCommand playlistinfo took 6 milliseconds
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: sendMpdCommand playlistinfo took 5 milliseconds
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: sendMpdCommand playlistinfo took 5 milliseconds
Oct 26 15:35:09 volumio-digipro volumio[1017]: verbose: ControllerMpd::parseTrackInfo
Oct 26 15:35:09 volumio-digipro volumio[1017]: verbose: ControllerMpd::parseTrackInfo
Oct 26 15:35:09 volumio-digipro volumio[1017]: verbose: ControllerMpd::parseTrackInfo
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: ControllerMpd::pushState
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CoreCommandRouter::servicePushState
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 26 15:35:09 volumio-digipro volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":326,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"483 Kbps","isStreaming":false,"title":"Beloved Wife","artist":"Natalie Merchant","album":"Paradise Is There: The New Tigerlily Recordings","uri":"USB/KINGSTON/muzika flac/Natalie Merchant/2015 Paradise Is There {EU, Nonesuch 7559-79501-5}/02 - Beloved Wife.flac","trackType":"flac"}
Oct 26 15:35:09 volumio-digipro volumio[1017]: verbose: CURRENT POSITION 0
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CoreStateMachine::syncState stateService play
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CoreStateMachine::syncState currentStatus play
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: Received an update from plugin. extracting info from payload
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CoreStateMachine::pushState
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CoreCommandRouter::volumioPushState
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CoreStateMachine::pushState
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CoreCommandRouter::volumioPushState
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: ControllerMpd::pushState
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CoreCommandRouter::servicePushState
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 26 15:35:09 volumio-digipro volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":326,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"483 Kbps","isStreaming":false,"title":"Beloved Wife","artist":"Natalie Merchant","album":"Paradise Is There: The New Tigerlily Recordings","uri":"USB/KINGSTON/muzika flac/Natalie Merchant/2015 Paradise Is There {EU, Nonesuch 7559-79501-5}/02 - Beloved Wife.flac","trackType":"flac"}
Oct 26 15:35:09 volumio-digipro volumio[1017]: verbose: CURRENT POSITION 0
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CoreStateMachine::syncState stateService play
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CoreStateMachine::syncState currentStatus play
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: Received an update from plugin. extracting info from payload
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CoreStateMachine::pushState
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CoreCommandRouter::volumioPushState
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CoreStateMachine::pushState
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CoreCommandRouter::volumioPushState
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: ControllerMpd::pushState
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CoreCommandRouter::servicePushState
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 26 15:35:09 volumio-digipro volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":326,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"483 Kbps","isStreaming":false,"title":"Beloved Wife","artist":"Natalie Merchant","album":"Paradise Is There: The New Tigerlily Recordings","uri":"USB/KINGSTON/muzika flac/Natalie Merchant/2015 Paradise Is There {EU, Nonesuch 7559-79501-5}/02 - Beloved Wife.flac","trackType":"flac"}
Oct 26 15:35:09 volumio-digipro volumio[1017]: verbose: CURRENT POSITION 0
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CoreStateMachine::syncState stateService play
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CoreStateMachine::syncState currentStatus play
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: Received an update from plugin. extracting info from payload
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CoreStateMachine::pushState
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 26 15:35:09 volumio-digipro volumio[1017]: info: CoreCommandRouter::volumioPushState
Oct 26 15:35:10 volumio-digipro volumio[1017]: info: CoreStateMachine::pushState
Oct 26 15:35:10 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 26 15:35:10 volumio-digipro volumio[1017]: info: CoreCommandRouter::volumioPushState
Oct 26 15:35:10 volumio-digipro volumio[1017]: info: ------------------------------ 171ms
Oct 26 15:35:10 volumio-digipro volumio[1017]: info: ------------------------------ 167ms
Oct 26 15:35:10 volumio-digipro volumio[1017]: info: ------------------------------ 165ms
Oct 26 15:35:10 volumio-digipro volumio[1017]: info: CoreStateMachine::startPlaybackTimer
Oct 26 15:35:10 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 1
Oct 26 15:35:10 volumio-digipro volumio[1017]: info: CoreStateMachine::pushState
Oct 26 15:35:10 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 1
Oct 26 15:35:10 volumio-digipro volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 15:35:10 volumio-digipro volumio[1017]: info: CoreCommandRouter::volumioPushState
Oct 26 15:35:16 volumio-digipro volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 26 15:35:16 volumio-digipro volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 26 15:35:16 volumio-digipro volumio[1017]: info: Discovery: Getting this device information
Oct 26 15:35:16 volumio-digipro volumio[1017]: info: CoreCommandRouter::volumioGetState
Oct 26 15:35:16 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 1
Oct 26 15:35:16 volumio-digipro volumio[1017]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 26 15:35:39 volumio-digipro volumio[1017]: info: CoreCommandRouter::volumioGetQueue
Oct 26 15:35:39 volumio-digipro volumio[1017]: info: CoreStateMachine::getQueue
Oct 26 15:35:39 volumio-digipro volumio[1017]: info: CorePlayQueue::getQueue
Oct 26 15:35:46 volumio-digipro volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 26 15:35:46 volumio-digipro volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 26 15:35:46 volumio-digipro volumio[1017]: info: Discovery: Getting this device information
Oct 26 15:35:46 volumio-digipro volumio[1017]: info: CoreCommandRouter::volumioGetState
Oct 26 15:35:46 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 1
Oct 26 15:35:46 volumio-digipro volumio[1017]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: Preload queue cleared
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: CoreCommandRouter::volumioReplaceandPlayItems
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: CoreStateMachine::ClearQueue
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: CoreStateMachine::stop
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: CoreStateMachine::stPlaybackTimer
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: CoreStateMachine::updateTrackBlock
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrackBlock
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: CoreStateMachine::pushState
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 1
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: CoreCommandRouter::volumioPushState
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: CoreStateMachine::serviceStop
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: CorePlayQueue::getTrack 1
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: CoreCommandRouter::serviceStop
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: ControllerMpd::stop
Oct 26 15:35:49 volumio-digipro volumio[1017]: verbose: ControllerMpd::sendMpdCommand stop
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: CorePlayQueue::clearPlayQueue
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: CorePlayQueue::saveQueue
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: CoreCommandRouter::volumioPushQueue
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: CoreStateMachine::addQueueItems
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: CorePlayQueue::addQueueItems
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: Preload queue cleared
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: Adding Item to queue: music-library/USB/KINGSTON/muzika flac/Laura Marling/2013 Once I Was An Eagle
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: Exploding uri music-library/USB/KINGSTON/muzika flac/Laura Marling/2013 Once I Was An Eagle in service mpd
Oct 26 15:35:49 volumio-digipro volumio[1017]: info:
Oct 26 15:35:49 volumio-digipro volumio[1017]: ---------------------------- MPD announces state update: player
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: ALBUMART /albumart?cacheid=280&web=Laura%20Marling/Once%20I%20Was%20An%20Eagle/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2Fmuzika%20flac%2FLaura%20Marling%2F2013%20Once%20I%20Was%20An%20Eagle%2F01%20Take%20The%20Night%20Off.flac&metadata=false
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: URI /mnt/USB/KINGSTON/muzika flac/Laura Marling/2013 Once I Was An Eagle/01 Take The Night Off.flac
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: ALBUMART /albumart?cacheid=280&web=Laura%20Marling/Once%20I%20Was%20An%20Eagle/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2Fmuzika%20flac%2FLaura%20Marling%2F2013%20Once%20I%20Was%20An%20Eagle%2F02%20I%20Was%20An%20Eagle.flac&metadata=false
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: URI /mnt/USB/KINGSTON/muzika flac/Laura Marling/2013 Once I Was An Eagle/02 I Was An Eagle.flac
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: ALBUMART /albumart?cacheid=280&web=Laura%20Marling/Once%20I%20Was%20An%20Eagle/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2Fmuzika%20flac%2FLaura%20Marling%2F2013%20Once%20I%20Was%20An%20Eagle%2F03%20You%20Know.flac&metadata=false
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: URI /mnt/USB/KINGSTON/muzika flac/Laura Marling/2013 Once I Was An Eagle/03 You Know.flac
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: ALBUMART /albumart?cacheid=280&web=Laura%20Marling/Once%20I%20Was%20An%20Eagle/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2Fmuzika%20flac%2FLaura%20Marling%2F2013%20Once%20I%20Was%20An%20Eagle%2F04%20Breathe.flac&metadata=false
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: URI /mnt/USB/KINGSTON/muzika flac/Laura Marling/2013 Once I Was An Eagle/04 Breathe.flac
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: ALBUMART /albumart?cacheid=280&web=Laura%20Marling/Once%20I%20Was%20An%20Eagle/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2Fmuzika%20flac%2FLaura%20Marling%2F2013%20Once%20I%20Was%20An%20Eagle%2F05%20Master%20Hunter.flac&metadata=false
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: URI /mnt/USB/KINGSTON/muzika flac/Laura Marling/2013 Once I Was An Eagle/05 Master Hunter.flac
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: ALBUMART /albumart?cacheid=280&web=Laura%20Marling/Once%20I%20Was%20An%20Eagle/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2Fmuzika%20flac%2FLaura%20Marling%2F2013%20Once%20I%20Was%20An%20Eagle%2F06%20Little%20Love%20Caster.flac&metadata=false
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: URI /mnt/USB/KINGSTON/muzika flac/Laura Marling/2013 Once I Was An Eagle/06 Little Love Caster.flac
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: ALBUMART /albumart?cacheid=280&web=Laura%20Marling/Once%20I%20Was%20An%20Eagle/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2Fmuzika%20flac%2FLaura%20Marling%2F2013%20Once%20I%20Was%20An%20Eagle%2F07%20Devil's%20Resting%20Place.flac&metadata=false
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: URI /mnt/USB/KINGSTON/muzika flac/Laura Marling/2013 Once I Was An Eagle/07 Devil's Resting Place.flac
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: ALBUMART /albumart?cacheid=280&web=Laura%20Marling/Once%20I%20Was%20An%20Eagle/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2Fmuzika%20flac%2FLaura%20Marling%2F2013%20Once%20I%20Was%20An%20Eagle%2F08%20Interlude.flac&metadata=false
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: URI /mnt/USB/KINGSTON/muzika flac/Laura Marling/2013 Once I Was An Eagle/08 Interlude.flac
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: ALBUMART /albumart?cacheid=280&web=Laura%20Marling/Once%20I%20Was%20An%20Eagle/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2Fmuzika%20flac%2FLaura%20Marling%2F2013%20Once%20I%20Was%20An%20Eagle%2F09%20Undine.flac&metadata=false
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: URI /mnt/USB/KINGSTON/muzika flac/Laura Marling/2013 Once I Was An Eagle/09 Undine.flac
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: ALBUMART /albumart?cacheid=280&web=Laura%20Marling/Once%20I%20Was%20An%20Eagle/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2Fmuzika%20flac%2FLaura%20Marling%2F2013%20Once%20I%20Was%20An%20Eagle%2F10%20Where%20Can%20I%20Go.flac&metadata=false
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: URI /mnt/USB/KINGSTON/muzika flac/Laura Marling/2013 Once I Was An Eagle/10 Where Can I Go.flac
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: ALBUMART /albumart?cacheid=280&web=Laura%20Marling/Once%20I%20Was%20An%20Eagle/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2Fmuzika%20flac%2FLaura%20Marling%2F2013%20Once%20I%20Was%20An%20Eagle%2F11%20Once.flac&metadata=false
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: URI /mnt/USB/KINGSTON/muzika flac/Laura Marling/2013 Once I Was An Eagle/11 Once.flac
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: ALBUMART /albumart?cacheid=280&web=Laura%20Marling/Once%20I%20Was%20An%20Eagle/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2Fmuzika%20flac%2FLaura%20Marling%2F2013%20Once%20I%20Was%20An%20Eagle%2F12%20Pray%20For%20Me.flac&metadata=false
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: URI /mnt/USB/KINGSTON/muzika flac/Laura Marling/2013 Once I Was An Eagle/12 Pray For Me.flac
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: ALBUMART /albumart?cacheid=280&web=Laura%20Marling/Once%20I%20Was%20An%20Eagle/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2Fmuzika%20flac%2FLaura%20Marling%2F2013%20Once%20I%20Was%20An%20Eagle%2F13%20When%20Were%20You%20Happy.flac&metadata=false
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: URI /mnt/USB/KINGSTON/muzika flac/Laura Marling/2013 Once I Was An Eagle/13 When Were You Happy.flac
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: ALBUMART /albumart?cacheid=280&web=Laura%20Marling/Once%20I%20Was%20An%20Eagle/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2Fmuzika%20flac%2FLaura%20Marling%2F2013%20Once%20I%20Was%20An%20Eagle%2F14%20Love%20Be%20Brave.flac&metadata=false
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: URI /mnt/USB/KINGSTON/muzika flac/Laura Marling/2013 Once I Was An Eagle/14 Love Be Brave.flac
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: ALBUMART /albumart?cacheid=280&web=Laura%20Marling/Once%20I%20Was%20An%20Eagle/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2Fmuzika%20flac%2FLaura%20Marling%2F2013%20Once%20I%20Was%20An%20Eagle%2F15%20Little%20Bird.flac&metadata=false
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: URI /mnt/USB/KINGSTON/muzika flac/Laura Marling/2013 Once I Was An Eagle/15 Little Bird.flac
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: ALBUMART /albumart?cacheid=280&web=Laura%20Marling/Once%20I%20Was%20An%20Eagle/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2Fmuzika%20flac%2FLaura%20Marling%2F2013%20Once%20I%20Was%20An%20Eagle%2F16%20Saved%20These%20Words.flac&metadata=false
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: URI /mnt/USB/KINGSTON/muzika flac/Laura Marling/2013 Once I Was An Eagle/16 Saved These Words.flac
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: ALBUMART /albumart?cacheid=280&web=Laura%20Marling/Once%20I%20Was%20An%20Eagle/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2Fmuzika%20flac%2FLaura%20Marling%2F2013%20Once%20I%20Was%20An%20Eagle%2FOnce%20I%20Was%20An%20Eagle.cue&metadata=false
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: URI /mnt/USB/KINGSTON/muzika flac/Laura Marling/2013 Once I Was An Eagle/Once I Was An Eagle.cue
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: ALBUMART /albumart?cacheid=280&web=Laura%20Marling/Once%20I%20Was%20An%20Eagle/extralarge&path=%2Fmnt%2FUSB%2FKINGSTON%2Fmuzika%20flac%2FLaura%20Marling%2F2013%20Once%20I%20Was%20An%20Eagle%2FOnce%20I%20Was%20An%20Eagle.cue&metadata=false
Oct 26 15:35:49 volumio-digipro volumio[1017]: info: URI /mnt/USB/KINGSTON/muzika flac/Laura Marling/2013 Once I Was An Eagle/Once I Was An Eagle.cue
Oct 26 15:35:49 volumio-digipro volumio[1017]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 26 15:35:49 volumio-digipro volumio[1017]: Error: Unable to resolve or reject the same promise twice
Oct 26 15:35:49 volumio-digipro volumio[1017]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Oct 26 15:35:49 volumio-digipro volumio[1017]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21
Oct 26 15:35:49 volumio-digipro volumio[1017]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3)
Oct 26 15:35:49 volumio-digipro volumio[1017]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12)
Oct 26 15:35:49 volumio-digipro volumio[1017]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12)
Oct 26 15:35:49 volumio-digipro volumio[1017]: at Socket.emit (events.js:315:20)
Oct 26 15:35:49 volumio-digipro volumio[1017]: at addChunk (internal/streams/readable.js:309:12)
Oct 26 15:35:49 volumio-digipro volumio[1017]: at readableAddChunk (internal/streams/readable.js:280:11)
Oct 26 15:35:49 volumio-digipro volumio[1017]: at Socket.Readable.push (internal/streams/readable.js:223:10)
Oct 26 15:35:49 volumio-digipro volumio[1017]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23)
Oct 26 15:35:49 volumio-digipro volumio[1017]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 26 15:35:50 volumio-digipro sudo[2424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-26 15:34
Oct 26 15:35:50 volumio-digipro sudo[2424]: 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"