-- Logs begin at Sun 2025-06-01 07:35:35 CEST, end at Fri 2025-06-20 16:49:43 CEST. --
Jun 20 16:49:21 volumio volumio[6229]: info: CorePlayQueue::getTrack 3264
Jun 20 16:49:21 volumio volumio[6229]: info: CorePlayQueue::getTrack 2274
Jun 20 16:49:21 volumio volumio[6229]: info: Prefetching next song
Jun 20 16:49:21 volumio volumio[6229]: info: DOING PREFETCH IN MPD
Jun 20 16:49:21 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand add "NAS/Mp3/Kelly Family/Celtic Myst 3/19 Who'll Come With Me (Davids Song).mp3"
Jun 20 16:49:21 volumio volumio[6229]: info:
Jun 20 16:49:21 volumio volumio[6229]: ---------------------------- MPD announces system playlist update
Jun 20 16:49:21 volumio volumio[6229]: info: Ignoring MPD Status Update
Jun 20 16:49:21 volumio volumio[6229]: info: sendMpdCommand add "NAS/Mp3/Kelly Family/Celtic Myst 3/19 Who'll Come With Me (Davids Song).mp3" took 5 milliseconds
Jun 20 16:49:21 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand consume 1
Jun 20 16:49:21 volumio volumio[6229]: info: ------------------------------ 4ms
Jun 20 16:49:21 volumio volumio[6229]: info: sendMpdCommand consume 1 took 2 milliseconds
Jun 20 16:49:21 volumio volumio[6229]: info:
Jun 20 16:49:21 volumio volumio[6229]: ---------------------------- MPD announces system playlist update
Jun 20 16:49:21 volumio volumio[6229]: info: Ignoring MPD Status Update
Jun 20 16:49:21 volumio volumio[6229]: info:
Jun 20 16:49:21 volumio volumio[6229]: ---------------------------- MPD announces system playlist update
Jun 20 16:49:21 volumio volumio[6229]: info: Ignoring MPD Status Update
Jun 20 16:49:21 volumio volumio[6229]: info: ------------------------------ 5ms
Jun 20 16:49:21 volumio volumio[6229]: info: ------------------------------ 3ms
Jun 20 16:49:26 volumio volumio[6229]: info: CoreStateMachine::startPlaybackTimer
Jun 20 16:49:26 volumio volumio[6229]: info: CorePlayQueue::getTrack 2274
Jun 20 16:49:26 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:26 volumio volumio[6229]: info: CorePlayQueue::getTrack 2274
Jun 20 16:49:26 volumio volumio[6229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 20 16:49:26 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:26 volumio volumio[6229]: Error saving last played file: Error: ENOSPC: no space left on device, write
Jun 20 16:49:27 volumio volumio[6229]: info:
Jun 20 16:49:27 volumio volumio[6229]: ---------------------------- MPD announces system playlist update
Jun 20 16:49:27 volumio volumio[6229]: info: Ignoring MPD Status Update
Jun 20 16:49:27 volumio volumio[6229]: info:
Jun 20 16:49:27 volumio volumio[6229]: ---------------------------- MPD announces state update: player
Jun 20 16:49:27 volumio volumio[6229]: info: ControllerMpd::getState
Jun 20 16:49:27 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 16:49:27 volumio volumio[6229]: info:
Jun 20 16:49:27 volumio volumio[6229]: ---------------------------- MPD announces system playlist update
Jun 20 16:49:27 volumio volumio[6229]: info: Ignoring MPD Status Update
Jun 20 16:49:27 volumio volumio[6229]: info:
Jun 20 16:49:27 volumio volumio[6229]: ---------------------------- MPD announces state update: player
Jun 20 16:49:27 volumio volumio[6229]: info: ControllerMpd::getState
Jun 20 16:49:27 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 16:49:27 volumio volumio[6229]: info:
Jun 20 16:49:27 volumio volumio[6229]: ---------------------------- MPD announces system playlist update
Jun 20 16:49:27 volumio volumio[6229]: info: Ignoring MPD Status Update
Jun 20 16:49:27 volumio volumio[6229]: info:
Jun 20 16:49:27 volumio volumio[6229]: ---------------------------- MPD announces state update: player
Jun 20 16:49:27 volumio volumio[6229]: info: ControllerMpd::getState
Jun 20 16:49:27 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 16:49:27 volumio volumio[6229]: info: ------------------------------ 12ms
Jun 20 16:49:27 volumio volumio[6229]: info: sendMpdCommand status took 10 milliseconds
Jun 20 16:49:27 volumio volumio[6229]: info: ------------------------------ 9ms
Jun 20 16:49:27 volumio volumio[6229]: info: sendMpdCommand status took 8 milliseconds
Jun 20 16:49:27 volumio volumio[6229]: info: ------------------------------ 7ms
Jun 20 16:49:27 volumio volumio[6229]: info: sendMpdCommand status took 6 milliseconds
Jun 20 16:49:27 volumio volumio[6229]: verbose: ControllerMpd::parseState
Jun 20 16:49:27 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 20 16:49:27 volumio volumio[6229]: verbose: ControllerMpd::parseState
Jun 20 16:49:27 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 20 16:49:27 volumio volumio[6229]: verbose: ControllerMpd::parseState
Jun 20 16:49:27 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 20 16:49:27 volumio volumio[6229]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jun 20 16:49:27 volumio volumio[6229]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jun 20 16:49:27 volumio volumio[6229]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jun 20 16:49:27 volumio volumio[6229]: verbose: ControllerMpd::parseTrackInfo
Jun 20 16:49:27 volumio volumio[6229]: verbose: ControllerMpd::parseTrackInfo
Jun 20 16:49:27 volumio volumio[6229]: verbose: ControllerMpd::parseTrackInfo
Jun 20 16:49:27 volumio volumio[6229]: info: ControllerMpd::pushState
Jun 20 16:49:27 volumio volumio[6229]: info: CoreCommandRouter::servicePushState
Jun 20 16:49:27 volumio volumio[6229]: info: CorePlayQueue::getTrack 2274
Jun 20 16:49:27 volumio volumio[6229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":189,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Who'll Come With Me (Davids Song)","artist":"Kelly Family","album":"Celtic Myst 3","uri":"NAS/Mp3/Kelly Family/Celtic Myst 3/19 Who'll Come With Me (Davids Song).mp3","trackType":"mp3"}
Jun 20 16:49:27 volumio volumio[6229]: verbose: CURRENT POSITION 2274
Jun 20 16:49:27 volumio volumio[6229]: info: CoreStateMachine::syncState stateService play
Jun 20 16:49:27 volumio volumio[6229]: info: CoreStateMachine::syncState currentStatus play
Jun 20 16:49:27 volumio volumio[6229]: info: Received an update from plugin. extracting info from payload
Jun 20 16:49:27 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:27 volumio volumio[6229]: info: CorePlayQueue::getTrack 2274
Jun 20 16:49:27 volumio volumio[6229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 20 16:49:27 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:27 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:27 volumio volumio[6229]: info: CorePlayQueue::getTrack 2274
Jun 20 16:49:27 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:27 volumio volumio[6229]: info: ControllerMpd::pushState
Jun 20 16:49:27 volumio volumio[6229]: info: CoreCommandRouter::servicePushState
Jun 20 16:49:27 volumio volumio[6229]: info: CorePlayQueue::getTrack 2274
Jun 20 16:49:27 volumio volumio[6229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":189,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Who'll Come With Me (Davids Song)","artist":"Kelly Family","album":"Celtic Myst 3","uri":"NAS/Mp3/Kelly Family/Celtic Myst 3/19 Who'll Come With Me (Davids Song).mp3","trackType":"mp3"}
Jun 20 16:49:27 volumio volumio[6229]: verbose: CURRENT POSITION 2274
Jun 20 16:49:27 volumio volumio[6229]: info: CoreStateMachine::syncState stateService play
Jun 20 16:49:27 volumio volumio[6229]: info: CoreStateMachine::syncState currentStatus play
Jun 20 16:49:27 volumio volumio[6229]: info: Received an update from plugin. extracting info from payload
Jun 20 16:49:27 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:27 volumio volumio[6229]: info: CorePlayQueue::getTrack 2274
Jun 20 16:49:27 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:27 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:27 volumio volumio[6229]: info: CorePlayQueue::getTrack 2274
Jun 20 16:49:27 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:27 volumio volumio[6229]: info: ControllerMpd::pushState
Jun 20 16:49:27 volumio volumio[6229]: info: CoreCommandRouter::servicePushState
Jun 20 16:49:27 volumio volumio[6229]: info: CorePlayQueue::getTrack 2274
Jun 20 16:49:27 volumio volumio[6229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":189,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Who'll Come With Me (Davids Song)","artist":"Kelly Family","album":"Celtic Myst 3","uri":"NAS/Mp3/Kelly Family/Celtic Myst 3/19 Who'll Come With Me (Davids Song).mp3","trackType":"mp3"}
Jun 20 16:49:27 volumio volumio[6229]: verbose: CURRENT POSITION 2274
Jun 20 16:49:27 volumio volumio[6229]: info: CoreStateMachine::syncState stateService play
Jun 20 16:49:27 volumio volumio[6229]: info: CoreStateMachine::syncState currentStatus play
Jun 20 16:49:27 volumio volumio[6229]: info: Received an update from plugin. extracting info from payload
Jun 20 16:49:27 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:27 volumio volumio[6229]: info: CorePlayQueue::getTrack 2274
Jun 20 16:49:27 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:27 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:27 volumio volumio[6229]: info: CorePlayQueue::getTrack 2274
Jun 20 16:49:27 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:27 volumio volumio[6229]: info: ------------------------------ 55ms
Jun 20 16:49:27 volumio volumio[6229]: info: ------------------------------ 53ms
Jun 20 16:49:27 volumio volumio[6229]: info: ------------------------------ 51ms
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::volumioNext
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::next
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::stop
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::stPlaybackTimer
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::updateTrackBlock
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrackBlock
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 2274
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::serviceStop
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 2274
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::serviceStop
Jun 20 16:49:39 volumio volumio[6229]: info: ControllerMpd::stop
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand stop
Jun 20 16:49:39 volumio volumio[6229]: info:
Jun 20 16:49:39 volumio volumio[6229]: ---------------------------- MPD announces state update: player
Jun 20 16:49:39 volumio volumio[6229]: info: sendMpdCommand stop took 13 milliseconds
Jun 20 16:49:39 volumio volumio[6229]: info: ControllerMpd::getState
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::play index undefined
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::startPlaybackTimer
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::clearAddPlayTracks NAS/Mp3/Dire Straits/Unknown Album/Ticket To Heaven.mp3
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand stop
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::updateTrackBlock
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrackBlock
Jun 20 16:49:39 volumio volumio[6229]: info: sendMpdCommand status took 15 milliseconds
Jun 20 16:49:39 volumio volumio[6229]: info: sendMpdCommand stop took 4 milliseconds
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::parseState
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand clear
Jun 20 16:49:39 volumio volumio[6229]: info:
Jun 20 16:49:39 volumio volumio[6229]: ---------------------------- MPD announces state update: player
Jun 20 16:49:39 volumio volumio[6229]: info: ControllerMpd::getState
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 16:49:39 volumio volumio[6229]: info:
Jun 20 16:49:39 volumio volumio[6229]: ---------------------------- MPD announces state update: player
Jun 20 16:49:39 volumio volumio[6229]: info: ControllerMpd::getState
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 16:49:39 volumio volumio[6229]: info:
Jun 20 16:49:39 volumio volumio[6229]: ---------------------------- MPD announces system playlist update
Jun 20 16:49:39 volumio volumio[6229]: info: Ignoring MPD Status Update
Jun 20 16:49:39 volumio volumio[6229]: info: sendMpdCommand playlistinfo took 10 milliseconds
Jun 20 16:49:39 volumio volumio[6229]: info: sendMpdCommand clear took 10 milliseconds
Jun 20 16:49:39 volumio volumio[6229]: info: sendMpdCommand status took 9 milliseconds
Jun 20 16:49:39 volumio volumio[6229]: info: sendMpdCommand status took 8 milliseconds
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::parseTrackInfo
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand add "NAS/Mp3/Dire Straits/Unknown Album/Ticket To Heaven.mp3"
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::parseState
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::parseState
Jun 20 16:49:39 volumio volumio[6229]: info: ControllerMpd::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::servicePushState
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: 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":"Who'll Come With Me (Davids Song)","artist":"Kelly Family","album":"Celtic Myst 3","uri":"NAS/Mp3/Kelly Family/Celtic Myst 3/19 Who'll Come With Me (Davids Song).mp3","trackType":"mp3"}
Jun 20 16:49:39 volumio volumio[6229]: verbose: CURRENT POSITION 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::syncState stateService stop
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::syncState currentStatus stop
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:39 volumio volumio[6229]: info: No code
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:39 volumio volumio[6229]: info: ControllerMpd::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::servicePushState
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jun 20 16:49:39 volumio volumio[6229]: verbose: CURRENT POSITION 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::syncState stateService stop
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::syncState currentStatus stop
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:39 volumio volumio[6229]: info: No code
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:39 volumio volumio[6229]: info: ControllerMpd::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::servicePushState
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jun 20 16:49:39 volumio volumio[6229]: verbose: CURRENT POSITION 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::syncState stateService stop
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::syncState currentStatus stop
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:39 volumio volumio[6229]: info: No code
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:39 volumio volumio[6229]: info: ------------------------------ 119ms
Jun 20 16:49:39 volumio volumio[6229]: info: ------------------------------ 101ms
Jun 20 16:49:39 volumio volumio[6229]: info: ------------------------------ 100ms
Jun 20 16:49:39 volumio volumio[6229]: info:
Jun 20 16:49:39 volumio volumio[6229]: ---------------------------- MPD announces system playlist update
Jun 20 16:49:39 volumio volumio[6229]: info: Ignoring MPD Status Update
Jun 20 16:49:39 volumio volumio[6229]: info:
Jun 20 16:49:39 volumio volumio[6229]: ---------------------------- MPD announces system playlist update
Jun 20 16:49:39 volumio volumio[6229]: info: Ignoring MPD Status Update
Jun 20 16:49:39 volumio volumio[6229]: error: updateQueue error: null
Jun 20 16:49:39 volumio volumio[6229]: info:
Jun 20 16:49:39 volumio volumio[6229]: ---------------------------- MPD announces system playlist update
Jun 20 16:49:39 volumio volumio[6229]: info: Ignoring MPD Status Update
Jun 20 16:49:39 volumio volumio[6229]: info: ------------------------------ 107ms
Jun 20 16:49:39 volumio volumio[6229]: info: sendMpdCommand add "NAS/Mp3/Dire Straits/Unknown Album/Ticket To Heaven.mp3" took 100 milliseconds
Jun 20 16:49:39 volumio volumio[6229]: info: ------------------------------ 9ms
Jun 20 16:49:39 volumio volumio[6229]: info: ------------------------------ 7ms
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand play
Jun 20 16:49:39 volumio volumio[6229]: info:
Jun 20 16:49:39 volumio volumio[6229]: ---------------------------- MPD announces system playlist update
Jun 20 16:49:39 volumio volumio[6229]: info: Ignoring MPD Status Update
Jun 20 16:49:39 volumio volumio[6229]: info:
Jun 20 16:49:39 volumio volumio[6229]: ---------------------------- MPD announces system playlist update
Jun 20 16:49:39 volumio volumio[6229]: info: Ignoring MPD Status Update
Jun 20 16:49:39 volumio volumio[6229]: info: ------------------------------ 31ms
Jun 20 16:49:39 volumio volumio[6229]: info: sendMpdCommand play took 28 milliseconds
Jun 20 16:49:39 volumio volumio[6229]: info: ------------------------------ 26ms
Jun 20 16:49:39 volumio volumio[6229]: info: ------------------------------ 24ms
Jun 20 16:49:39 volumio volumio[6229]: info:
Jun 20 16:49:39 volumio volumio[6229]: ---------------------------- MPD announces state update: player
Jun 20 16:49:39 volumio volumio[6229]: info: ControllerMpd::getState
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 16:49:39 volumio volumio[6229]: info:
Jun 20 16:49:39 volumio volumio[6229]: ---------------------------- MPD announces state update: player
Jun 20 16:49:39 volumio volumio[6229]: info: ControllerMpd::getState
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 16:49:39 volumio volumio[6229]: info:
Jun 20 16:49:39 volumio volumio[6229]: ---------------------------- MPD announces state update: player
Jun 20 16:49:39 volumio volumio[6229]: info: ControllerMpd::getState
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 16:49:39 volumio volumio[6229]: info:
Jun 20 16:49:39 volumio volumio[6229]: ---------------------------- MPD announces state update: player
Jun 20 16:49:39 volumio volumio[6229]: info: ControllerMpd::getState
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 16:49:39 volumio volumio[6229]: info: sendMpdCommand status took 9 milliseconds
Jun 20 16:49:39 volumio volumio[6229]: info: sendMpdCommand status took 7 milliseconds
Jun 20 16:49:39 volumio volumio[6229]: info: sendMpdCommand status took 5 milliseconds
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::parseState
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::parseState
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::parseState
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 20 16:49:39 volumio volumio[6229]: info:
Jun 20 16:49:39 volumio volumio[6229]: ---------------------------- MPD announces state update: player
Jun 20 16:49:39 volumio volumio[6229]: info: ControllerMpd::getState
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 16:49:39 volumio volumio[6229]: info:
Jun 20 16:49:39 volumio volumio[6229]: ---------------------------- MPD announces state update: player
Jun 20 16:49:39 volumio volumio[6229]: info: ControllerMpd::getState
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 16:49:39 volumio volumio[6229]: info: sendMpdCommand status took 13 milliseconds
Jun 20 16:49:39 volumio volumio[6229]: info: sendMpdCommand playlistinfo took 11 milliseconds
Jun 20 16:49:39 volumio volumio[6229]: info: sendMpdCommand playlistinfo took 10 milliseconds
Jun 20 16:49:39 volumio volumio[6229]: info: sendMpdCommand playlistinfo took 11 milliseconds
Jun 20 16:49:39 volumio volumio[6229]: info: sendMpdCommand status took 8 milliseconds
Jun 20 16:49:39 volumio volumio[6229]: info: sendMpdCommand status took 7 milliseconds
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::parseState
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::parseTrackInfo
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::parseTrackInfo
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::parseTrackInfo
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::parseState
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::parseState
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 20 16:49:39 volumio volumio[6229]: info: ControllerMpd::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::servicePushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":266,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"Ticket To Heaven","artist":"Dire Straits","album":null,"uri":"NAS/Mp3/Dire Straits/Unknown Album/Ticket To Heaven.mp3","trackType":"mp3"}
Jun 20 16:49:39 volumio volumio[6229]: verbose: CURRENT POSITION 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::syncState stateService play
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::syncState currentStatus stop
Jun 20 16:49:39 volumio volumio[6229]: info: ControllerMpd::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::servicePushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":266,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"Ticket To Heaven","artist":"Dire Straits","album":null,"uri":"NAS/Mp3/Dire Straits/Unknown Album/Ticket To Heaven.mp3","trackType":"mp3"}
Jun 20 16:49:39 volumio volumio[6229]: verbose: CURRENT POSITION 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::syncState stateService play
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::syncState currentStatus play
Jun 20 16:49:39 volumio volumio[6229]: info: Received an update from plugin. extracting info from payload
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:39 volumio volumio[6229]: info: ControllerMpd::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::servicePushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":266,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"Ticket To Heaven","artist":"Dire Straits","album":null,"uri":"NAS/Mp3/Dire Straits/Unknown Album/Ticket To Heaven.mp3","trackType":"mp3"}
Jun 20 16:49:39 volumio volumio[6229]: verbose: CURRENT POSITION 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::syncState stateService play
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::syncState currentStatus play
Jun 20 16:49:39 volumio volumio[6229]: info: Received an update from plugin. extracting info from payload
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:39 volumio volumio[6229]: info: ------------------------------ 57ms
Jun 20 16:49:39 volumio volumio[6229]: info: ------------------------------ 71ms
Jun 20 16:49:39 volumio volumio[6229]: info: sendMpdCommand playlistinfo took 53 milliseconds
Jun 20 16:49:39 volumio volumio[6229]: info: sendMpdCommand playlistinfo took 51 milliseconds
Jun 20 16:49:39 volumio volumio[6229]: info: sendMpdCommand playlistinfo took 50 milliseconds
Jun 20 16:49:39 volumio volumio[6229]: verbose: ControllerMpd::parseTrackInfo
Jun 20 16:49:39 volumio volumio[6229]: info: ControllerMpd::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::servicePushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":266,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"Ticket To Heaven","artist":"Dire Straits","album":null,"uri":"NAS/Mp3/Dire Straits/Unknown Album/Ticket To Heaven.mp3","trackType":"mp3"}
Jun 20 16:49:39 volumio volumio[6229]: verbose: CURRENT POSITION 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::syncState stateService play
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::syncState currentStatus play
Jun 20 16:49:39 volumio volumio[6229]: info: Received an update from plugin. extracting info from payload
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:39 volumio volumio[6229]: info: ControllerMpd::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::servicePushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":266,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"Ticket To Heaven","artist":"Dire Straits","album":null,"uri":"NAS/Mp3/Dire Straits/Unknown Album/Ticket To Heaven.mp3","trackType":"mp3"}
Jun 20 16:49:39 volumio volumio[6229]: verbose: CURRENT POSITION 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::syncState stateService play
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::syncState currentStatus play
Jun 20 16:49:39 volumio volumio[6229]: info: Received an update from plugin. extracting info from payload
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:39 volumio volumio[6229]: info: ControllerMpd::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::servicePushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":266,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"Ticket To Heaven","artist":"Dire Straits","album":null,"uri":"NAS/Mp3/Dire Straits/Unknown Album/Ticket To Heaven.mp3","trackType":"mp3"}
Jun 20 16:49:39 volumio volumio[6229]: verbose: CURRENT POSITION 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::syncState stateService play
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::syncState currentStatus play
Jun 20 16:49:39 volumio volumio[6229]: info: Received an update from plugin. extracting info from payload
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:39 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:39 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:39 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:39 volumio volumio[6229]: info: ------------------------------ 133ms
Jun 20 16:49:39 volumio volumio[6229]: info: ------------------------------ 127ms
Jun 20 16:49:39 volumio volumio[6229]: info: ------------------------------ 126ms
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::volumioNext
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::next
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::stop
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::stPlaybackTimer
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::updateTrackBlock
Jun 20 16:49:41 volumio volumio[6229]: info: CorePlayQueue::getTrackBlock
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:41 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::serviceStop
Jun 20 16:49:41 volumio volumio[6229]: info: CorePlayQueue::getTrack 1312
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::serviceStop
Jun 20 16:49:41 volumio volumio[6229]: info: ControllerMpd::stop
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand stop
Jun 20 16:49:41 volumio volumio[6229]: info:
Jun 20 16:49:41 volumio volumio[6229]: ---------------------------- MPD announces state update: player
Jun 20 16:49:41 volumio volumio[6229]: info: sendMpdCommand stop took 13 milliseconds
Jun 20 16:49:41 volumio volumio[6229]: info: ControllerMpd::getState
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::play index undefined
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::setConsumeUpdateService undefined
Jun 20 16:49:41 volumio volumio[6229]: info: CorePlayQueue::getTrack 6500
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::startPlaybackTimer
Jun 20 16:49:41 volumio volumio[6229]: info: CorePlayQueue::getTrack 6500
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::clearAddPlayTracks NAS/Mp3/Tangerine Dream/Vulcano/07 Afternoon On The Nile.mp3
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand stop
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::updateTrackBlock
Jun 20 16:49:41 volumio volumio[6229]: info: CorePlayQueue::getTrackBlock
Jun 20 16:49:41 volumio volumio[6229]: info:
Jun 20 16:49:41 volumio volumio[6229]: ---------------------------- MPD announces state update: player
Jun 20 16:49:41 volumio volumio[6229]: info: ControllerMpd::getState
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 16:49:41 volumio volumio[6229]: info:
Jun 20 16:49:41 volumio volumio[6229]: ---------------------------- MPD announces state update: player
Jun 20 16:49:41 volumio volumio[6229]: info: ControllerMpd::getState
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 16:49:41 volumio volumio[6229]: info: sendMpdCommand status took 19 milliseconds
Jun 20 16:49:41 volumio volumio[6229]: info: sendMpdCommand stop took 8 milliseconds
Jun 20 16:49:41 volumio volumio[6229]: info: sendMpdCommand status took 6 milliseconds
Jun 20 16:49:41 volumio volumio[6229]: info: sendMpdCommand status took 4 milliseconds
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::parseState
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand clear
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::parseState
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::parseState
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 20 16:49:41 volumio volumio[6229]: info:
Jun 20 16:49:41 volumio volumio[6229]: ---------------------------- MPD announces system playlist update
Jun 20 16:49:41 volumio volumio[6229]: info: Ignoring MPD Status Update
Jun 20 16:49:41 volumio volumio[6229]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jun 20 16:49:41 volumio volumio[6229]: info: sendMpdCommand clear took 5 milliseconds
Jun 20 16:49:41 volumio volumio[6229]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jun 20 16:49:41 volumio volumio[6229]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::parseTrackInfo
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand add "NAS/Mp3/Tangerine Dream/Vulcano/07 Afternoon On The Nile.mp3"
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::parseTrackInfo
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::parseTrackInfo
Jun 20 16:49:41 volumio volumio[6229]: info: ControllerMpd::pushState
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::servicePushState
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:41 volumio volumio[6229]: info: CorePlayQueue::getTrack 6500
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:41 volumio volumio[6229]: info: CorePlayQueue::getTrack 6500
Jun 20 16:49:41 volumio volumio[6229]: 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":"Ticket To Heaven","artist":"Dire Straits","album":null,"uri":"NAS/Mp3/Dire Straits/Unknown Album/Ticket To Heaven.mp3","trackType":"mp3"}
Jun 20 16:49:41 volumio volumio[6229]: verbose: CURRENT POSITION 6500
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::syncState stateService stop
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::syncState currentStatus stop
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:41 volumio volumio[6229]: info: CorePlayQueue::getTrack 6500
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:41 volumio volumio[6229]: info: No code
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:41 volumio volumio[6229]: info: CorePlayQueue::getTrack 6500
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:41 volumio volumio[6229]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Jun 20 16:49:41 volumio volumio[6229]: info: ------------------------------ 52ms
Jun 20 16:49:41 volumio volumio[6229]: info: ------------------------------ 39ms
Jun 20 16:49:41 volumio volumio[6229]: info: ------------------------------ 37ms
Jun 20 16:49:41 volumio volumio[6229]: info:
Jun 20 16:49:41 volumio volumio[6229]: ---------------------------- MPD announces system playlist update
Jun 20 16:49:41 volumio volumio[6229]: info: Ignoring MPD Status Update
Jun 20 16:49:41 volumio volumio[6229]: info:
Jun 20 16:49:41 volumio volumio[6229]: ---------------------------- MPD announces system playlist update
Jun 20 16:49:41 volumio volumio[6229]: info: Ignoring MPD Status Update
Jun 20 16:49:41 volumio volumio[6229]: error: updateQueue error: null
Jun 20 16:49:41 volumio volumio[6229]: info:
Jun 20 16:49:41 volumio volumio[6229]: ---------------------------- MPD announces system playlist update
Jun 20 16:49:41 volumio volumio[6229]: info: Ignoring MPD Status Update
Jun 20 16:49:41 volumio volumio[6229]: info: ------------------------------ 36ms
Jun 20 16:49:41 volumio volumio[6229]: info: sendMpdCommand add "NAS/Mp3/Tangerine Dream/Vulcano/07 Afternoon On The Nile.mp3" took 33 milliseconds
Jun 20 16:49:41 volumio volumio[6229]: info: ------------------------------ 8ms
Jun 20 16:49:41 volumio volumio[6229]: info: ------------------------------ 6ms
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand play
Jun 20 16:49:41 volumio volumio[6229]: info:
Jun 20 16:49:41 volumio volumio[6229]: ---------------------------- MPD announces system playlist update
Jun 20 16:49:41 volumio volumio[6229]: info: Ignoring MPD Status Update
Jun 20 16:49:41 volumio volumio[6229]: info:
Jun 20 16:49:41 volumio volumio[6229]: ---------------------------- MPD announces system playlist update
Jun 20 16:49:41 volumio volumio[6229]: info: Ignoring MPD Status Update
Jun 20 16:49:41 volumio volumio[6229]: info: ------------------------------ 16ms
Jun 20 16:49:41 volumio volumio[6229]: info: sendMpdCommand play took 13 milliseconds
Jun 20 16:49:41 volumio volumio[6229]: info: ------------------------------ 12ms
Jun 20 16:49:41 volumio volumio[6229]: info: ------------------------------ 10ms
Jun 20 16:49:41 volumio volumio[6229]: info:
Jun 20 16:49:41 volumio volumio[6229]: ---------------------------- MPD announces state update: player
Jun 20 16:49:41 volumio volumio[6229]: info: ControllerMpd::getState
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 16:49:41 volumio volumio[6229]: info:
Jun 20 16:49:41 volumio volumio[6229]: ---------------------------- MPD announces state update: player
Jun 20 16:49:41 volumio volumio[6229]: info: ControllerMpd::getState
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 16:49:41 volumio volumio[6229]: info:
Jun 20 16:49:41 volumio volumio[6229]: ---------------------------- MPD announces state update: player
Jun 20 16:49:41 volumio volumio[6229]: info: ControllerMpd::getState
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 16:49:41 volumio volumio[6229]: info:
Jun 20 16:49:41 volumio volumio[6229]: ---------------------------- MPD announces state update: player
Jun 20 16:49:41 volumio volumio[6229]: info: ControllerMpd::getState
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 16:49:41 volumio volumio[6229]: info: sendMpdCommand status took 11 milliseconds
Jun 20 16:49:41 volumio volumio[6229]: info: sendMpdCommand status took 9 milliseconds
Jun 20 16:49:41 volumio volumio[6229]: info: sendMpdCommand status took 8 milliseconds
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::parseState
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::parseState
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::parseState
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 20 16:49:41 volumio volumio[6229]: info:
Jun 20 16:49:41 volumio volumio[6229]: ---------------------------- MPD announces state update: player
Jun 20 16:49:41 volumio volumio[6229]: info: ControllerMpd::getState
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 16:49:41 volumio volumio[6229]: info:
Jun 20 16:49:41 volumio volumio[6229]: ---------------------------- MPD announces state update: player
Jun 20 16:49:41 volumio volumio[6229]: info: ControllerMpd::getState
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand status
Jun 20 16:49:41 volumio volumio[6229]: info: sendMpdCommand status took 15 milliseconds
Jun 20 16:49:41 volumio volumio[6229]: info: sendMpdCommand playlistinfo took 13 milliseconds
Jun 20 16:49:41 volumio volumio[6229]: info: sendMpdCommand playlistinfo took 13 milliseconds
Jun 20 16:49:41 volumio volumio[6229]: info: sendMpdCommand playlistinfo took 13 milliseconds
Jun 20 16:49:41 volumio volumio[6229]: info: sendMpdCommand status took 10 milliseconds
Jun 20 16:49:41 volumio volumio[6229]: info: sendMpdCommand status took 9 milliseconds
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::parseState
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::parseTrackInfo
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::parseTrackInfo
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::parseTrackInfo
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::parseState
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::parseState
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jun 20 16:49:41 volumio volumio[6229]: info: ControllerMpd::pushState
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::servicePushState
Jun 20 16:49:41 volumio volumio[6229]: info: CorePlayQueue::getTrack 6500
Jun 20 16:49:41 volumio volumio[6229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":415,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Afternoon On The Nile","artist":"Tangerine Dream","album":"Vulcano","uri":"NAS/Mp3/Tangerine Dream/Vulcano/07 Afternoon On The Nile.mp3","trackType":"mp3"}
Jun 20 16:49:41 volumio volumio[6229]: verbose: CURRENT POSITION 6500
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::syncState stateService play
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::syncState currentStatus stop
Jun 20 16:49:41 volumio volumio[6229]: info: ControllerMpd::pushState
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::servicePushState
Jun 20 16:49:41 volumio volumio[6229]: info: CorePlayQueue::getTrack 6500
Jun 20 16:49:41 volumio volumio[6229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":415,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Afternoon On The Nile","artist":"Tangerine Dream","album":"Vulcano","uri":"NAS/Mp3/Tangerine Dream/Vulcano/07 Afternoon On The Nile.mp3","trackType":"mp3"}
Jun 20 16:49:41 volumio volumio[6229]: verbose: CURRENT POSITION 6500
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::syncState stateService play
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::syncState currentStatus play
Jun 20 16:49:41 volumio volumio[6229]: info: Received an update from plugin. extracting info from payload
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:41 volumio volumio[6229]: info: CorePlayQueue::getTrack 6500
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:41 volumio volumio[6229]: info: CorePlayQueue::getTrack 6500
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:41 volumio volumio[6229]: info: ControllerMpd::pushState
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::servicePushState
Jun 20 16:49:41 volumio volumio[6229]: info: CorePlayQueue::getTrack 6500
Jun 20 16:49:41 volumio volumio[6229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":331,"duration":415,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"Afternoon On The Nile","artist":"Tangerine Dream","album":"Vulcano","uri":"NAS/Mp3/Tangerine Dream/Vulcano/07 Afternoon On The Nile.mp3","trackType":"mp3"}
Jun 20 16:49:41 volumio volumio[6229]: verbose: CURRENT POSITION 6500
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::syncState stateService play
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::syncState currentStatus play
Jun 20 16:49:41 volumio volumio[6229]: info: Received an update from plugin. extracting info from payload
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:41 volumio volumio[6229]: info: CorePlayQueue::getTrack 6500
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:41 volumio volumio[6229]: info: CorePlayQueue::getTrack 6500
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:41 volumio volumio[6229]: info: ------------------------------ 62ms
Jun 20 16:49:41 volumio volumio[6229]: info: ------------------------------ 74ms
Jun 20 16:49:41 volumio volumio[6229]: info: ------------------------------ 74ms
Jun 20 16:49:41 volumio volumio[6229]: info: sendMpdCommand playlistinfo took 54 milliseconds
Jun 20 16:49:41 volumio volumio[6229]: info: sendMpdCommand playlistinfo took 53 milliseconds
Jun 20 16:49:41 volumio volumio[6229]: info: sendMpdCommand playlistinfo took 53 milliseconds
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::parseTrackInfo
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::parseTrackInfo
Jun 20 16:49:41 volumio volumio[6229]: verbose: ControllerMpd::parseTrackInfo
Jun 20 16:49:41 volumio volumio[6229]: info: ControllerMpd::pushState
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::servicePushState
Jun 20 16:49:41 volumio volumio[6229]: info: CorePlayQueue::getTrack 6500
Jun 20 16:49:41 volumio volumio[6229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":415,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"Afternoon On The Nile","artist":"Tangerine Dream","album":"Vulcano","uri":"NAS/Mp3/Tangerine Dream/Vulcano/07 Afternoon On The Nile.mp3","trackType":"mp3"}
Jun 20 16:49:41 volumio volumio[6229]: verbose: CURRENT POSITION 6500
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::syncState stateService play
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::syncState currentStatus play
Jun 20 16:49:41 volumio volumio[6229]: info: Received an update from plugin. extracting info from payload
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:41 volumio volumio[6229]: info: CorePlayQueue::getTrack 6500
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:41 volumio volumio[6229]: info: CorePlayQueue::getTrack 6500
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:41 volumio volumio[6229]: info: ControllerMpd::pushState
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::servicePushState
Jun 20 16:49:41 volumio volumio[6229]: info: CorePlayQueue::getTrack 6500
Jun 20 16:49:41 volumio volumio[6229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":415,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"Afternoon On The Nile","artist":"Tangerine Dream","album":"Vulcano","uri":"NAS/Mp3/Tangerine Dream/Vulcano/07 Afternoon On The Nile.mp3","trackType":"mp3"}
Jun 20 16:49:41 volumio volumio[6229]: verbose: CURRENT POSITION 6500
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::syncState stateService play
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::syncState currentStatus play
Jun 20 16:49:41 volumio volumio[6229]: info: Received an update from plugin. extracting info from payload
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:41 volumio volumio[6229]: info: CorePlayQueue::getTrack 6500
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:41 volumio volumio[6229]: info: CorePlayQueue::getTrack 6500
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:41 volumio volumio[6229]: info: ControllerMpd::pushState
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::servicePushState
Jun 20 16:49:41 volumio volumio[6229]: info: CorePlayQueue::getTrack 6500
Jun 20 16:49:41 volumio volumio[6229]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":415,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"Afternoon On The Nile","artist":"Tangerine Dream","album":"Vulcano","uri":"NAS/Mp3/Tangerine Dream/Vulcano/07 Afternoon On The Nile.mp3","trackType":"mp3"}
Jun 20 16:49:41 volumio volumio[6229]: verbose: CURRENT POSITION 6500
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::syncState stateService play
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::syncState currentStatus play
Jun 20 16:49:41 volumio volumio[6229]: info: Received an update from plugin. extracting info from payload
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:41 volumio volumio[6229]: info: CorePlayQueue::getTrack 6500
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:41 volumio volumio[6229]: info: CoreStateMachine::pushState
Jun 20 16:49:41 volumio volumio[6229]: info: CorePlayQueue::getTrack 6500
Jun 20 16:49:41 volumio volumio[6229]: info: CoreCommandRouter::volumioPushState
Jun 20 16:49:41 volumio volumio[6229]: info: ------------------------------ 132ms
Jun 20 16:49:41 volumio volumio[6229]: info: ------------------------------ 124ms
Jun 20 16:49:41 volumio volumio[6229]: info: ------------------------------ 124ms
Jun 20 16:49:41 volumio volumio[6229]: Error saving last played file: Error: ENOSPC: no space left on device, write
Jun 20 16:49:42 volumio volumio[6229]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 20 16:49:42 volumio volumio[6229]: [Error: ENOSPC: no space left on device, write] {
Jun 20 16:49:42 volumio volumio[6229]: errno: -28,
Jun 20 16:49:42 volumio volumio[6229]: code: 'ENOSPC',
Jun 20 16:49:42 volumio volumio[6229]: syscall: 'write'
Jun 20 16:49:42 volumio volumio[6229]: }
Jun 20 16:49:42 volumio volumio[6229]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 20 16:49:43 volumio sudo[8410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-20 16:48
Jun 20 16:49:43 volumio sudo[8410]: 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="570c5791513f5bac7da274aba6690c1a961705de"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST"
VOLUMIO_VERSION="3.812"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"