-- Logs begin at Thu 2019-02-14 10:11:58 GMT, end at Thu 2026-04-02 21:54:57 BST. --
Apr 02 21:53:12 volumio volumio[6589]: info: CoreCommandRouter::volumioNext
Apr 02 21:53:12 volumio volumio[6589]: info: CoreStateMachine::next
Apr 02 21:53:12 volumio volumio[6589]: info: CoreStateMachine::stop
Apr 02 21:53:12 volumio volumio[6589]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 02 21:53:12 volumio volumio[6589]: info: CoreStateMachine::stPlaybackTimer
Apr 02 21:53:12 volumio volumio[6589]: info: CoreStateMachine::updateTrackBlock
Apr 02 21:53:12 volumio volumio[6589]: info: CorePlayQueue::getTrackBlock
Apr 02 21:53:12 volumio volumio[6589]: info: CoreStateMachine::pushState
Apr 02 21:53:12 volumio volumio[6589]: info: CorePlayQueue::getTrack 4
Apr 02 21:53:12 volumio volumio[6589]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 02 21:53:12 volumio volumio[6589]: info: CoreCommandRouter::volumioPushState
Apr 02 21:53:12 volumio volumio[6589]: info: MRS: Pushing multiroomSync output update for this device
Apr 02 21:53:12 volumio volumio[6589]: info: MRS: Pushing multiroomSync output
Apr 02 21:53:12 volumio volumio[6589]: info: CoreCommandRouter::volumioGetState
Apr 02 21:53:12 volumio volumio[6589]: info: CorePlayQueue::getTrack 4
Apr 02 21:53:12 volumio volumio[6589]: info: CoreStateMachine::serviceStop
Apr 02 21:53:12 volumio volumio[6589]: info: CorePlayQueue::getTrack 4
Apr 02 21:53:12 volumio volumio[6589]: info: CoreCommandRouter::serviceStop
Apr 02 21:53:12 volumio volumio[6589]: info: ControllerMpd::stop
Apr 02 21:53:12 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand stop
Apr 02 21:53:12 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:12.872+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" state=STATUS_STOPPED positionMs=0 volume=58
Apr 02 21:53:12 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:12.873+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" id="mnt/INTERNAL/FLAC/Christina Aguilera/Stripped/06. Infatuation.flac" title="6 - Infatuation"
Apr 02 21:53:12 volumio volumio[6589]: info:
Apr 02 21:53:12 volumio volumio[6589]: ---------------------------- MPD announces state update: player
Apr 02 21:53:12 volumio volumio[6589]: info: sendMpdCommand stop took 4 milliseconds
Apr 02 21:53:12 volumio volumio[6589]: info: ControllerMpd::getState
Apr 02 21:53:12 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand status
Apr 02 21:53:12 volumio volumio[6589]: info: CoreStateMachine::play index undefined
Apr 02 21:53:12 volumio volumio[6589]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 02 21:53:12 volumio volumio[6589]: info: CorePlayQueue::getTrack 5
Apr 02 21:53:12 volumio volumio[6589]: info: CoreStateMachine::startPlaybackTimer
Apr 02 21:53:12 volumio volumio[6589]: info: CorePlayQueue::getTrack 5
Apr 02 21:53:12 volumio volumio[6589]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/FLAC/Christina Aguilera/Stripped/07. Loves Embrace (interlude).flac
Apr 02 21:53:12 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand stop
Apr 02 21:53:12 volumio volumio[6589]: info: CoreStateMachine::updateTrackBlock
Apr 02 21:53:12 volumio volumio[6589]: info: CorePlayQueue::getTrackBlock
Apr 02 21:53:12 volumio volumio[6589]: info: sendMpdCommand status took 1 milliseconds
Apr 02 21:53:12 volumio volumio[6589]: info: sendMpdCommand stop took 0 milliseconds
Apr 02 21:53:12 volumio volumio[6589]: verbose: ControllerMpd::parseState
Apr 02 21:53:12 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 02 21:53:12 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand clear
Apr 02 21:53:12 volumio volumio[6589]: info:
Apr 02 21:53:12 volumio volumio[6589]: ---------------------------- MPD announces system playlist update
Apr 02 21:53:12 volumio volumio[6589]: info: Ignoring MPD Status Update
Apr 02 21:53:12 volumio volumio[6589]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 02 21:53:12 volumio volumio[6589]: info: sendMpdCommand clear took 1 milliseconds
Apr 02 21:53:12 volumio volumio[6589]: verbose: ControllerMpd::parseTrackInfo
Apr 02 21:53:12 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/FLAC/Christina Aguilera/Stripped/07. Loves Embrace (interlude).flac"
Apr 02 21:53:12 volumio volumio[6589]: info: ControllerMpd::pushState
Apr 02 21:53:12 volumio volumio[6589]: info: CoreCommandRouter::servicePushState
Apr 02 21:53:12 volumio volumio[6589]: info: CoreStateMachine::pushState
Apr 02 21:53:12 volumio volumio[6589]: info: CorePlayQueue::getTrack 5
Apr 02 21:53:12 volumio volumio[6589]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 02 21:53:12 volumio volumio[6589]: info: CoreCommandRouter::volumioPushState
Apr 02 21:53:12 volumio volumio[6589]: info: MRS: Pushing multiroomSync output update for this device
Apr 02 21:53:12 volumio volumio[6589]: info: MRS: Pushing multiroomSync output
Apr 02 21:53:12 volumio volumio[6589]: info: CoreCommandRouter::volumioGetState
Apr 02 21:53:12 volumio volumio[6589]: info: CorePlayQueue::getTrack 5
Apr 02 21:53:12 volumio volumio[6589]: info: CorePlayQueue::getTrack 5
Apr 02 21:53:12 volumio volumio[6589]: 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":"Infatuation","artist":"Christina Aguilera","album":"Stripped","uri":"INTERNAL/FLAC/Christina Aguilera/Stripped/06. Infatuation.flac","trackType":"flac"}
Apr 02 21:53:12 volumio volumio[6589]: verbose: CURRENT POSITION 5
Apr 02 21:53:12 volumio volumio[6589]: info: CoreStateMachine::syncState stateService stop
Apr 02 21:53:12 volumio volumio[6589]: info: CoreStateMachine::syncState currentStatus stop
Apr 02 21:53:12 volumio volumio[6589]: info: CoreStateMachine::pushState
Apr 02 21:53:12 volumio volumio[6589]: info: CorePlayQueue::getTrack 5
Apr 02 21:53:12 volumio volumio[6589]: info: CoreCommandRouter::volumioPushState
Apr 02 21:53:12 volumio volumio[6589]: info: MRS: Pushing multiroomSync output update for this device
Apr 02 21:53:12 volumio volumio[6589]: info: MRS: Pushing multiroomSync output
Apr 02 21:53:12 volumio volumio[6589]: info: CoreCommandRouter::volumioGetState
Apr 02 21:53:12 volumio volumio[6589]: info: CorePlayQueue::getTrack 5
Apr 02 21:53:12 volumio volumio[6589]: info: No code
Apr 02 21:53:12 volumio volumio[6589]: info: CoreStateMachine::pushState
Apr 02 21:53:12 volumio volumio[6589]: info: CorePlayQueue::getTrack 5
Apr 02 21:53:12 volumio volumio[6589]: info: CoreCommandRouter::volumioPushState
Apr 02 21:53:12 volumio volumio[6589]: info: MRS: Pushing multiroomSync output update for this device
Apr 02 21:53:12 volumio volumio[6589]: info: MRS: Pushing multiroomSync output
Apr 02 21:53:12 volumio volumio[6589]: info: CoreCommandRouter::volumioGetState
Apr 02 21:53:12 volumio volumio[6589]: info: CorePlayQueue::getTrack 5
Apr 02 21:53:12 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:12.884+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" state=STATUS_STOPPED positionMs=1 volume=58
Apr 02 21:53:12 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:12.884+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" id="mnt/INTERNAL/FLAC/Christina Aguilera/Stripped/07. Loves Embrace (interlude).flac" title="7 - Loves Embrace (interlude)"
Apr 02 21:53:12 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:12.884+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" state=STATUS_STOPPED positionMs=1 volume=58
Apr 02 21:53:12 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:12.884+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" id="mnt/INTERNAL/FLAC/Christina Aguilera/Stripped/07. Loves Embrace (interlude).flac" title="7 - Loves Embrace (interlude)"
Apr 02 21:53:12 volumio volumio[6589]: info: ------------------------------ 14ms
Apr 02 21:53:12 volumio volumio[6589]: error: updateQueue error: null
Apr 02 21:53:12 volumio volumio[6589]: info:
Apr 02 21:53:12 volumio volumio[6589]: ---------------------------- MPD announces system playlist update
Apr 02 21:53:12 volumio volumio[6589]: info: Ignoring MPD Status Update
Apr 02 21:53:12 volumio volumio[6589]: info: ------------------------------ 14ms
Apr 02 21:53:12 volumio volumio[6589]: info: sendMpdCommand add "INTERNAL/FLAC/Christina Aguilera/Stripped/07. Loves Embrace (interlude).flac" took 13 milliseconds
Apr 02 21:53:12 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand play
Apr 02 21:53:12 volumio volumio[6589]: info:
Apr 02 21:53:12 volumio volumio[6589]: ---------------------------- MPD announces state update: player
Apr 02 21:53:12 volumio volumio[6589]: info: ------------------------------ 6ms
Apr 02 21:53:12 volumio volumio[6589]: info: sendMpdCommand play took 5 milliseconds
Apr 02 21:53:12 volumio volumio[6589]: info: ControllerMpd::getState
Apr 02 21:53:12 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand status
Apr 02 21:53:12 volumio volumio[6589]: info:
Apr 02 21:53:12 volumio volumio[6589]: ---------------------------- MPD announces state update: player
Apr 02 21:53:12 volumio volumio[6589]: info: ControllerMpd::getState
Apr 02 21:53:12 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand status
Apr 02 21:53:12 volumio volumio[6589]: info: sendMpdCommand status took 1 milliseconds
Apr 02 21:53:12 volumio volumio[6589]: verbose: ControllerMpd::parseState
Apr 02 21:53:12 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 02 21:53:12 volumio volumio[6589]: info: sendMpdCommand status took 1 milliseconds
Apr 02 21:53:12 volumio volumio[6589]: verbose: ControllerMpd::parseState
Apr 02 21:53:12 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 02 21:53:12 volumio volumio[6589]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 02 21:53:12 volumio volumio[6589]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 02 21:53:12 volumio volumio[6589]: verbose: ControllerMpd::parseTrackInfo
Apr 02 21:53:12 volumio volumio[6589]: verbose: ControllerMpd::parseTrackInfo
Apr 02 21:53:12 volumio volumio[6589]: info: ControllerMpd::pushState
Apr 02 21:53:12 volumio volumio[6589]: info: CoreCommandRouter::servicePushState
Apr 02 21:53:12 volumio volumio[6589]: info: CorePlayQueue::getTrack 5
Apr 02 21:53:12 volumio volumio[6589]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":47,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"713 Kbps","isStreaming":false,"title":"Loves Embrace (interlude)","artist":"Christina Aguilera","album":"Stripped","uri":"INTERNAL/FLAC/Christina Aguilera/Stripped/07. Loves Embrace (interlude).flac","trackType":"flac"}
Apr 02 21:53:12 volumio volumio[6589]: verbose: CURRENT POSITION 5
Apr 02 21:53:12 volumio volumio[6589]: info: CoreStateMachine::syncState stateService play
Apr 02 21:53:12 volumio volumio[6589]: info: CoreStateMachine::syncState currentStatus stop
Apr 02 21:53:12 volumio volumio[6589]: info: ControllerMpd::pushState
Apr 02 21:53:12 volumio volumio[6589]: info: CoreCommandRouter::servicePushState
Apr 02 21:53:12 volumio volumio[6589]: info: CorePlayQueue::getTrack 5
Apr 02 21:53:12 volumio volumio[6589]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":47,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"774 Kbps","isStreaming":false,"title":"Loves Embrace (interlude)","artist":"Christina Aguilera","album":"Stripped","uri":"INTERNAL/FLAC/Christina Aguilera/Stripped/07. Loves Embrace (interlude).flac","trackType":"flac"}
Apr 02 21:53:12 volumio volumio[6589]: verbose: CURRENT POSITION 5
Apr 02 21:53:12 volumio volumio[6589]: info: CoreStateMachine::syncState stateService play
Apr 02 21:53:12 volumio volumio[6589]: info: CoreStateMachine::syncState currentStatus play
Apr 02 21:53:12 volumio volumio[6589]: info: Received an update from plugin. extracting info from payload
Apr 02 21:53:12 volumio volumio[6589]: info: CoreStateMachine::pushState
Apr 02 21:53:12 volumio volumio[6589]: info: CorePlayQueue::getTrack 5
Apr 02 21:53:12 volumio volumio[6589]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 02 21:53:12 volumio volumio[6589]: info: CoreCommandRouter::volumioPushState
Apr 02 21:53:12 volumio volumio[6589]: info: MRS: Pushing multiroomSync output update for this device
Apr 02 21:53:12 volumio volumio[6589]: info: MRS: Pushing multiroomSync output
Apr 02 21:53:12 volumio volumio[6589]: info: CoreCommandRouter::volumioGetState
Apr 02 21:53:12 volumio volumio[6589]: info: CorePlayQueue::getTrack 5
Apr 02 21:53:12 volumio volumio[6589]: info: CoreStateMachine::pushState
Apr 02 21:53:12 volumio volumio[6589]: info: CorePlayQueue::getTrack 5
Apr 02 21:53:12 volumio volumio[6589]: info: CoreCommandRouter::volumioPushState
Apr 02 21:53:12 volumio volumio[6589]: info: MRS: Pushing multiroomSync output update for this device
Apr 02 21:53:12 volumio volumio[6589]: info: MRS: Pushing multiroomSync output
Apr 02 21:53:12 volumio volumio[6589]: info: CoreCommandRouter::volumioGetState
Apr 02 21:53:12 volumio volumio[6589]: info: CorePlayQueue::getTrack 5
Apr 02 21:53:12 volumio volumio[6589]: info: ------------------------------ 12ms
Apr 02 21:53:12 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:12.909+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" state=STATUS_PLAYING positionMs=1212 volume=58
Apr 02 21:53:12 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:12.909+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" id="mnt/INTERNAL/FLAC/Christina Aguilera/Stripped/07. Loves Embrace (interlude).flac" title="7 - Loves Embrace (interlude)"
Apr 02 21:53:12 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:12.909+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" state=STATUS_PLAYING positionMs=1212 volume=58
Apr 02 21:53:12 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:12.910+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" id="mnt/INTERNAL/FLAC/Christina Aguilera/Stripped/07. Loves Embrace (interlude).flac" title="7 - Loves Embrace (interlude)"
Apr 02 21:53:12 volumio volumio[6589]: info: ------------------------------ 14ms
Apr 02 21:53:13 volumio kernel: hwmon hwmon4: Undervoltage detected!
Apr 02 21:53:15 volumio volumio[6589]: info: CoreCommandRouter::volumioNext
Apr 02 21:53:15 volumio volumio[6589]: info: CoreStateMachine::next
Apr 02 21:53:15 volumio volumio[6589]: info: CoreStateMachine::stop
Apr 02 21:53:15 volumio volumio[6589]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 02 21:53:15 volumio volumio[6589]: info: CoreStateMachine::stPlaybackTimer
Apr 02 21:53:15 volumio volumio[6589]: info: CoreStateMachine::updateTrackBlock
Apr 02 21:53:15 volumio volumio[6589]: info: CorePlayQueue::getTrackBlock
Apr 02 21:53:15 volumio volumio[6589]: info: CoreStateMachine::pushState
Apr 02 21:53:15 volumio volumio[6589]: info: CorePlayQueue::getTrack 5
Apr 02 21:53:15 volumio volumio[6589]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 02 21:53:15 volumio volumio[6589]: info: CoreCommandRouter::volumioPushState
Apr 02 21:53:15 volumio volumio[6589]: info: MRS: Pushing multiroomSync output update for this device
Apr 02 21:53:15 volumio volumio[6589]: info: MRS: Pushing multiroomSync output
Apr 02 21:53:15 volumio volumio[6589]: info: CoreCommandRouter::volumioGetState
Apr 02 21:53:15 volumio volumio[6589]: info: CorePlayQueue::getTrack 5
Apr 02 21:53:15 volumio volumio[6589]: info: CoreStateMachine::serviceStop
Apr 02 21:53:15 volumio volumio[6589]: info: CorePlayQueue::getTrack 5
Apr 02 21:53:15 volumio volumio[6589]: info: CoreCommandRouter::serviceStop
Apr 02 21:53:15 volumio volumio[6589]: info: ControllerMpd::stop
Apr 02 21:53:15 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand stop
Apr 02 21:53:15 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:15.817+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" state=STATUS_STOPPED positionMs=0 volume=58
Apr 02 21:53:15 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:15.817+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" id="mnt/INTERNAL/FLAC/Christina Aguilera/Stripped/07. Loves Embrace (interlude).flac" title="7 - Loves Embrace (interlude)"
Apr 02 21:53:15 volumio volumio[6589]: info:
Apr 02 21:53:15 volumio volumio[6589]: ---------------------------- MPD announces state update: player
Apr 02 21:53:15 volumio volumio[6589]: info: sendMpdCommand stop took 6 milliseconds
Apr 02 21:53:15 volumio volumio[6589]: info: ControllerMpd::getState
Apr 02 21:53:15 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand status
Apr 02 21:53:15 volumio volumio[6589]: info: CoreStateMachine::play index undefined
Apr 02 21:53:15 volumio volumio[6589]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 02 21:53:15 volumio volumio[6589]: info: CorePlayQueue::getTrack 6
Apr 02 21:53:15 volumio volumio[6589]: info: CoreStateMachine::startPlaybackTimer
Apr 02 21:53:15 volumio volumio[6589]: info: CorePlayQueue::getTrack 6
Apr 02 21:53:15 volumio volumio[6589]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/FLAC/Christina Aguilera/Stripped/08. Loving Me 4 Me.flac
Apr 02 21:53:15 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand stop
Apr 02 21:53:15 volumio volumio[6589]: info: CoreStateMachine::updateTrackBlock
Apr 02 21:53:15 volumio volumio[6589]: info: CorePlayQueue::getTrackBlock
Apr 02 21:53:15 volumio volumio[6589]: info: sendMpdCommand status took 0 milliseconds
Apr 02 21:53:15 volumio volumio[6589]: info: sendMpdCommand stop took 0 milliseconds
Apr 02 21:53:15 volumio volumio[6589]: verbose: ControllerMpd::parseState
Apr 02 21:53:15 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 02 21:53:15 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand clear
Apr 02 21:53:15 volumio volumio[6589]: info:
Apr 02 21:53:15 volumio volumio[6589]: ---------------------------- MPD announces system playlist update
Apr 02 21:53:15 volumio volumio[6589]: info: Ignoring MPD Status Update
Apr 02 21:53:15 volumio volumio[6589]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 02 21:53:15 volumio volumio[6589]: info: sendMpdCommand clear took 0 milliseconds
Apr 02 21:53:15 volumio volumio[6589]: verbose: ControllerMpd::parseTrackInfo
Apr 02 21:53:15 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/FLAC/Christina Aguilera/Stripped/08. Loving Me 4 Me.flac"
Apr 02 21:53:15 volumio volumio[6589]: info: ControllerMpd::pushState
Apr 02 21:53:15 volumio volumio[6589]: info: CoreCommandRouter::servicePushState
Apr 02 21:53:15 volumio volumio[6589]: info: CoreStateMachine::pushState
Apr 02 21:53:15 volumio volumio[6589]: info: CorePlayQueue::getTrack 6
Apr 02 21:53:15 volumio volumio[6589]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 02 21:53:15 volumio volumio[6589]: info: CoreCommandRouter::volumioPushState
Apr 02 21:53:15 volumio volumio[6589]: info: MRS: Pushing multiroomSync output update for this device
Apr 02 21:53:15 volumio volumio[6589]: info: MRS: Pushing multiroomSync output
Apr 02 21:53:15 volumio volumio[6589]: info: CoreCommandRouter::volumioGetState
Apr 02 21:53:15 volumio volumio[6589]: info: CorePlayQueue::getTrack 6
Apr 02 21:53:15 volumio volumio[6589]: info: CorePlayQueue::getTrack 6
Apr 02 21:53:15 volumio volumio[6589]: 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":"Loves Embrace (interlude)","artist":"Christina Aguilera","album":"Stripped","uri":"INTERNAL/FLAC/Christina Aguilera/Stripped/07. Loves Embrace (interlude).flac","trackType":"flac"}
Apr 02 21:53:15 volumio volumio[6589]: verbose: CURRENT POSITION 6
Apr 02 21:53:15 volumio volumio[6589]: info: CoreStateMachine::syncState stateService stop
Apr 02 21:53:15 volumio volumio[6589]: info: CoreStateMachine::syncState currentStatus stop
Apr 02 21:53:15 volumio volumio[6589]: info: CoreStateMachine::pushState
Apr 02 21:53:15 volumio volumio[6589]: info: CorePlayQueue::getTrack 6
Apr 02 21:53:15 volumio volumio[6589]: info: CoreCommandRouter::volumioPushState
Apr 02 21:53:15 volumio volumio[6589]: info: MRS: Pushing multiroomSync output update for this device
Apr 02 21:53:15 volumio volumio[6589]: info: MRS: Pushing multiroomSync output
Apr 02 21:53:15 volumio volumio[6589]: info: CoreCommandRouter::volumioGetState
Apr 02 21:53:15 volumio volumio[6589]: info: CorePlayQueue::getTrack 6
Apr 02 21:53:15 volumio volumio[6589]: info: No code
Apr 02 21:53:15 volumio volumio[6589]: info: CoreStateMachine::pushState
Apr 02 21:53:15 volumio volumio[6589]: info: CorePlayQueue::getTrack 6
Apr 02 21:53:15 volumio volumio[6589]: info: CoreCommandRouter::volumioPushState
Apr 02 21:53:15 volumio volumio[6589]: info: MRS: Pushing multiroomSync output update for this device
Apr 02 21:53:15 volumio volumio[6589]: info: MRS: Pushing multiroomSync output
Apr 02 21:53:15 volumio volumio[6589]: info: CoreCommandRouter::volumioGetState
Apr 02 21:53:15 volumio volumio[6589]: info: CorePlayQueue::getTrack 6
Apr 02 21:53:15 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:15.830+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" state=STATUS_STOPPED positionMs=0 volume=58
Apr 02 21:53:15 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:15.830+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" id="mnt/INTERNAL/FLAC/Christina Aguilera/Stripped/08. Loving Me 4 Me.flac" title="8 - Loving Me 4 Me"
Apr 02 21:53:15 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:15.830+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" state=STATUS_STOPPED positionMs=0 volume=58
Apr 02 21:53:15 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:15.830+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" id="mnt/INTERNAL/FLAC/Christina Aguilera/Stripped/08. Loving Me 4 Me.flac" title="8 - Loving Me 4 Me"
Apr 02 21:53:15 volumio volumio[6589]: info: ------------------------------ 14ms
Apr 02 21:53:15 volumio volumio[6589]: error: updateQueue error: null
Apr 02 21:53:15 volumio volumio[6589]: info:
Apr 02 21:53:15 volumio volumio[6589]: ---------------------------- MPD announces system playlist update
Apr 02 21:53:15 volumio volumio[6589]: info: Ignoring MPD Status Update
Apr 02 21:53:15 volumio volumio[6589]: info: ------------------------------ 13ms
Apr 02 21:53:15 volumio volumio[6589]: info: sendMpdCommand add "INTERNAL/FLAC/Christina Aguilera/Stripped/08. Loving Me 4 Me.flac" took 13 milliseconds
Apr 02 21:53:15 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand play
Apr 02 21:53:15 volumio volumio[6589]: info:
Apr 02 21:53:15 volumio volumio[6589]: ---------------------------- MPD announces state update: player
Apr 02 21:53:15 volumio volumio[6589]: info: ------------------------------ 9ms
Apr 02 21:53:15 volumio volumio[6589]: info: sendMpdCommand play took 9 milliseconds
Apr 02 21:53:15 volumio volumio[6589]: info: ControllerMpd::getState
Apr 02 21:53:15 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand status
Apr 02 21:53:15 volumio volumio[6589]: info:
Apr 02 21:53:15 volumio volumio[6589]: ---------------------------- MPD announces state update: player
Apr 02 21:53:15 volumio volumio[6589]: info: ControllerMpd::getState
Apr 02 21:53:15 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand status
Apr 02 21:53:15 volumio volumio[6589]: info: sendMpdCommand status took 1 milliseconds
Apr 02 21:53:15 volumio volumio[6589]: verbose: ControllerMpd::parseState
Apr 02 21:53:15 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 02 21:53:15 volumio volumio[6589]: info: sendMpdCommand status took 4 milliseconds
Apr 02 21:53:15 volumio volumio[6589]: verbose: ControllerMpd::parseState
Apr 02 21:53:15 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 02 21:53:15 volumio volumio[6589]: info: sendMpdCommand playlistinfo took 2 milliseconds
Apr 02 21:53:15 volumio volumio[6589]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 02 21:53:15 volumio volumio[6589]: verbose: ControllerMpd::parseTrackInfo
Apr 02 21:53:15 volumio volumio[6589]: verbose: ControllerMpd::parseTrackInfo
Apr 02 21:53:15 volumio volumio[6589]: info: ControllerMpd::pushState
Apr 02 21:53:15 volumio volumio[6589]: info: CoreCommandRouter::servicePushState
Apr 02 21:53:15 volumio volumio[6589]: info: CorePlayQueue::getTrack 6
Apr 02 21:53:15 volumio volumio[6589]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"746 Kbps","isStreaming":false,"title":"Loving Me 4 Me","artist":"Christina Aguilera","album":"Stripped","uri":"INTERNAL/FLAC/Christina Aguilera/Stripped/08. Loving Me 4 Me.flac","trackType":"flac"}
Apr 02 21:53:15 volumio volumio[6589]: verbose: CURRENT POSITION 6
Apr 02 21:53:15 volumio volumio[6589]: info: CoreStateMachine::syncState stateService play
Apr 02 21:53:15 volumio volumio[6589]: info: CoreStateMachine::syncState currentStatus stop
Apr 02 21:53:15 volumio volumio[6589]: info: ControllerMpd::pushState
Apr 02 21:53:15 volumio volumio[6589]: info: CoreCommandRouter::servicePushState
Apr 02 21:53:15 volumio volumio[6589]: info: CorePlayQueue::getTrack 6
Apr 02 21:53:15 volumio volumio[6589]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":277,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"820 Kbps","isStreaming":false,"title":"Loving Me 4 Me","artist":"Christina Aguilera","album":"Stripped","uri":"INTERNAL/FLAC/Christina Aguilera/Stripped/08. Loving Me 4 Me.flac","trackType":"flac"}
Apr 02 21:53:15 volumio volumio[6589]: verbose: CURRENT POSITION 6
Apr 02 21:53:15 volumio volumio[6589]: info: CoreStateMachine::syncState stateService play
Apr 02 21:53:15 volumio volumio[6589]: info: CoreStateMachine::syncState currentStatus play
Apr 02 21:53:15 volumio volumio[6589]: info: Received an update from plugin. extracting info from payload
Apr 02 21:53:15 volumio volumio[6589]: info: CoreStateMachine::pushState
Apr 02 21:53:15 volumio volumio[6589]: info: CorePlayQueue::getTrack 6
Apr 02 21:53:15 volumio volumio[6589]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 02 21:53:15 volumio volumio[6589]: info: CoreCommandRouter::volumioPushState
Apr 02 21:53:15 volumio volumio[6589]: info: MRS: Pushing multiroomSync output update for this device
Apr 02 21:53:15 volumio volumio[6589]: info: MRS: Pushing multiroomSync output
Apr 02 21:53:15 volumio volumio[6589]: info: CoreCommandRouter::volumioGetState
Apr 02 21:53:15 volumio volumio[6589]: info: CorePlayQueue::getTrack 6
Apr 02 21:53:15 volumio volumio[6589]: info: CoreStateMachine::pushState
Apr 02 21:53:15 volumio volumio[6589]: info: CorePlayQueue::getTrack 6
Apr 02 21:53:15 volumio volumio[6589]: info: CoreCommandRouter::volumioPushState
Apr 02 21:53:15 volumio volumio[6589]: info: MRS: Pushing multiroomSync output update for this device
Apr 02 21:53:15 volumio volumio[6589]: info: MRS: Pushing multiroomSync output
Apr 02 21:53:15 volumio volumio[6589]: info: CoreCommandRouter::volumioGetState
Apr 02 21:53:15 volumio volumio[6589]: info: CorePlayQueue::getTrack 6
Apr 02 21:53:15 volumio volumio[6589]: info: ------------------------------ 10ms
Apr 02 21:53:15 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:15.856+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" state=STATUS_PLAYING positionMs=1212 volume=58
Apr 02 21:53:15 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:15.856+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" id="mnt/INTERNAL/FLAC/Christina Aguilera/Stripped/08. Loving Me 4 Me.flac" title="8 - Loving Me 4 Me"
Apr 02 21:53:15 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:15.856+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" state=STATUS_PLAYING positionMs=1212 volume=58
Apr 02 21:53:15 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:15.856+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" id="mnt/INTERNAL/FLAC/Christina Aguilera/Stripped/08. Loving Me 4 Me.flac" title="8 - Loving Me 4 Me"
Apr 02 21:53:15 volumio volumio[6589]: info: ------------------------------ 14ms
Apr 02 21:53:17 volumio volumio[6589]: info: CoreCommandRouter::volumioNext
Apr 02 21:53:17 volumio volumio[6589]: info: CoreStateMachine::next
Apr 02 21:53:17 volumio volumio[6589]: info: CoreStateMachine::stop
Apr 02 21:53:17 volumio volumio[6589]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 02 21:53:17 volumio volumio[6589]: info: CoreStateMachine::stPlaybackTimer
Apr 02 21:53:17 volumio volumio[6589]: info: CoreStateMachine::updateTrackBlock
Apr 02 21:53:17 volumio volumio[6589]: info: CorePlayQueue::getTrackBlock
Apr 02 21:53:17 volumio volumio[6589]: info: CoreStateMachine::pushState
Apr 02 21:53:17 volumio volumio[6589]: info: CorePlayQueue::getTrack 6
Apr 02 21:53:17 volumio volumio[6589]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 02 21:53:17 volumio volumio[6589]: info: CoreCommandRouter::volumioPushState
Apr 02 21:53:17 volumio volumio[6589]: info: MRS: Pushing multiroomSync output update for this device
Apr 02 21:53:17 volumio volumio[6589]: info: MRS: Pushing multiroomSync output
Apr 02 21:53:17 volumio volumio[6589]: info: CoreCommandRouter::volumioGetState
Apr 02 21:53:17 volumio volumio[6589]: info: CorePlayQueue::getTrack 6
Apr 02 21:53:17 volumio volumio[6589]: info: CoreStateMachine::serviceStop
Apr 02 21:53:17 volumio volumio[6589]: info: CorePlayQueue::getTrack 6
Apr 02 21:53:17 volumio volumio[6589]: info: CoreCommandRouter::serviceStop
Apr 02 21:53:17 volumio volumio[6589]: info: ControllerMpd::stop
Apr 02 21:53:17 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand stop
Apr 02 21:53:17 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:17.675+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" state=STATUS_STOPPED positionMs=0 volume=58
Apr 02 21:53:17 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:17.675+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" id="mnt/INTERNAL/FLAC/Christina Aguilera/Stripped/08. Loving Me 4 Me.flac" title="8 - Loving Me 4 Me"
Apr 02 21:53:17 volumio volumio[6589]: info:
Apr 02 21:53:17 volumio volumio[6589]: ---------------------------- MPD announces state update: player
Apr 02 21:53:17 volumio volumio[6589]: info: sendMpdCommand stop took 5 milliseconds
Apr 02 21:53:17 volumio volumio[6589]: info: ControllerMpd::getState
Apr 02 21:53:17 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand status
Apr 02 21:53:17 volumio volumio[6589]: info: CoreStateMachine::play index undefined
Apr 02 21:53:17 volumio volumio[6589]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 02 21:53:17 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:53:17 volumio volumio[6589]: info: CoreStateMachine::startPlaybackTimer
Apr 02 21:53:17 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:53:17 volumio volumio[6589]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/FLAC/Christina Aguilera/Stripped/10. Underappreciated.flac
Apr 02 21:53:17 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand stop
Apr 02 21:53:17 volumio volumio[6589]: info: CoreStateMachine::updateTrackBlock
Apr 02 21:53:17 volumio volumio[6589]: info: CorePlayQueue::getTrackBlock
Apr 02 21:53:17 volumio volumio[6589]: info: sendMpdCommand status took 1 milliseconds
Apr 02 21:53:17 volumio volumio[6589]: info: sendMpdCommand stop took 0 milliseconds
Apr 02 21:53:17 volumio volumio[6589]: verbose: ControllerMpd::parseState
Apr 02 21:53:17 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 02 21:53:17 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand clear
Apr 02 21:53:17 volumio volumio[6589]: info:
Apr 02 21:53:17 volumio volumio[6589]: ---------------------------- MPD announces system playlist update
Apr 02 21:53:17 volumio volumio[6589]: info: Ignoring MPD Status Update
Apr 02 21:53:17 volumio volumio[6589]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 02 21:53:17 volumio volumio[6589]: info: sendMpdCommand clear took 1 milliseconds
Apr 02 21:53:17 volumio volumio[6589]: verbose: ControllerMpd::parseTrackInfo
Apr 02 21:53:17 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/FLAC/Christina Aguilera/Stripped/10. Underappreciated.flac"
Apr 02 21:53:17 volumio volumio[6589]: info: ControllerMpd::pushState
Apr 02 21:53:17 volumio volumio[6589]: info: CoreCommandRouter::servicePushState
Apr 02 21:53:17 volumio volumio[6589]: info: CoreStateMachine::pushState
Apr 02 21:53:17 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:53:17 volumio volumio[6589]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 02 21:53:17 volumio volumio[6589]: info: CoreCommandRouter::volumioPushState
Apr 02 21:53:17 volumio volumio[6589]: info: MRS: Pushing multiroomSync output update for this device
Apr 02 21:53:17 volumio volumio[6589]: info: MRS: Pushing multiroomSync output
Apr 02 21:53:17 volumio volumio[6589]: info: CoreCommandRouter::volumioGetState
Apr 02 21:53:17 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:53:17 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:53:17 volumio volumio[6589]: 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":"Loving Me 4 Me","artist":"Christina Aguilera","album":"Stripped","uri":"INTERNAL/FLAC/Christina Aguilera/Stripped/08. Loving Me 4 Me.flac","trackType":"flac"}
Apr 02 21:53:17 volumio volumio[6589]: verbose: CURRENT POSITION 7
Apr 02 21:53:17 volumio volumio[6589]: info: CoreStateMachine::syncState stateService stop
Apr 02 21:53:17 volumio volumio[6589]: info: CoreStateMachine::syncState currentStatus stop
Apr 02 21:53:17 volumio volumio[6589]: info: CoreStateMachine::pushState
Apr 02 21:53:17 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:53:17 volumio volumio[6589]: info: CoreCommandRouter::volumioPushState
Apr 02 21:53:17 volumio volumio[6589]: info: MRS: Pushing multiroomSync output update for this device
Apr 02 21:53:17 volumio volumio[6589]: info: MRS: Pushing multiroomSync output
Apr 02 21:53:17 volumio volumio[6589]: info: CoreCommandRouter::volumioGetState
Apr 02 21:53:17 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:53:17 volumio volumio[6589]: info: No code
Apr 02 21:53:17 volumio volumio[6589]: info: CoreStateMachine::pushState
Apr 02 21:53:17 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:53:17 volumio volumio[6589]: info: CoreCommandRouter::volumioPushState
Apr 02 21:53:17 volumio volumio[6589]: info: MRS: Pushing multiroomSync output update for this device
Apr 02 21:53:17 volumio volumio[6589]: info: MRS: Pushing multiroomSync output
Apr 02 21:53:17 volumio volumio[6589]: info: CoreCommandRouter::volumioGetState
Apr 02 21:53:17 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:53:17 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:17.686+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" state=STATUS_STOPPED positionMs=0 volume=58
Apr 02 21:53:17 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:17.686+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" id="mnt/INTERNAL/FLAC/Christina Aguilera/Stripped/10. Underappreciated.flac" title="10 - Underappreciated"
Apr 02 21:53:17 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:17.686+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" state=STATUS_STOPPED positionMs=0 volume=58
Apr 02 21:53:17 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:17.686+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" id="mnt/INTERNAL/FLAC/Christina Aguilera/Stripped/10. Underappreciated.flac" title="10 - Underappreciated"
Apr 02 21:53:17 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:17.687+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" state=STATUS_STOPPED positionMs=0 volume=58
Apr 02 21:53:17 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:17.687+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" id="mnt/INTERNAL/FLAC/Christina Aguilera/Stripped/10. Underappreciated.flac" title="10 - Underappreciated"
Apr 02 21:53:17 volumio volumio[6589]: info: ------------------------------ 9ms
Apr 02 21:53:17 volumio volumio[6589]: error: updateQueue error: null
Apr 02 21:53:17 volumio volumio[6589]: info:
Apr 02 21:53:17 volumio volumio[6589]: ---------------------------- MPD announces system playlist update
Apr 02 21:53:17 volumio volumio[6589]: info: Ignoring MPD Status Update
Apr 02 21:53:17 volumio volumio[6589]: info: ------------------------------ 9ms
Apr 02 21:53:17 volumio volumio[6589]: info: sendMpdCommand add "INTERNAL/FLAC/Christina Aguilera/Stripped/10. Underappreciated.flac" took 8 milliseconds
Apr 02 21:53:17 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand play
Apr 02 21:53:17 volumio volumio[6589]: info: ------------------------------ 4ms
Apr 02 21:53:17 volumio volumio[6589]: info: sendMpdCommand play took 4 milliseconds
Apr 02 21:53:17 volumio volumio[6589]: info:
Apr 02 21:53:17 volumio volumio[6589]: ---------------------------- MPD announces state update: player
Apr 02 21:53:17 volumio volumio[6589]: info: ControllerMpd::getState
Apr 02 21:53:17 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand status
Apr 02 21:53:17 volumio volumio[6589]: info:
Apr 02 21:53:17 volumio volumio[6589]: ---------------------------- MPD announces state update: player
Apr 02 21:53:17 volumio volumio[6589]: info: sendMpdCommand status took 3 milliseconds
Apr 02 21:53:17 volumio volumio[6589]: info: ControllerMpd::getState
Apr 02 21:53:17 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand status
Apr 02 21:53:17 volumio volumio[6589]: verbose: ControllerMpd::parseState
Apr 02 21:53:17 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 02 21:53:17 volumio volumio[6589]: info: sendMpdCommand status took 0 milliseconds
Apr 02 21:53:17 volumio volumio[6589]: verbose: ControllerMpd::parseState
Apr 02 21:53:17 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 02 21:53:17 volumio volumio[6589]: info: sendMpdCommand playlistinfo took 1 milliseconds
Apr 02 21:53:17 volumio volumio[6589]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 02 21:53:17 volumio volumio[6589]: verbose: ControllerMpd::parseTrackInfo
Apr 02 21:53:17 volumio volumio[6589]: verbose: ControllerMpd::parseTrackInfo
Apr 02 21:53:17 volumio volumio[6589]: info: ControllerMpd::pushState
Apr 02 21:53:17 volumio volumio[6589]: info: CoreCommandRouter::servicePushState
Apr 02 21:53:17 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:53:17 volumio volumio[6589]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":241,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"575 Kbps","isStreaming":false,"title":"Underappreciated","artist":"Christina Aguilera","album":"Stripped","uri":"INTERNAL/FLAC/Christina Aguilera/Stripped/10. Underappreciated.flac","trackType":"flac"}
Apr 02 21:53:17 volumio volumio[6589]: verbose: CURRENT POSITION 7
Apr 02 21:53:17 volumio volumio[6589]: info: CoreStateMachine::syncState stateService play
Apr 02 21:53:17 volumio volumio[6589]: info: CoreStateMachine::syncState currentStatus stop
Apr 02 21:53:17 volumio volumio[6589]: info: ControllerMpd::pushState
Apr 02 21:53:17 volumio volumio[6589]: info: CoreCommandRouter::servicePushState
Apr 02 21:53:17 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:53:17 volumio volumio[6589]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":241,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"546 Kbps","isStreaming":false,"title":"Underappreciated","artist":"Christina Aguilera","album":"Stripped","uri":"INTERNAL/FLAC/Christina Aguilera/Stripped/10. Underappreciated.flac","trackType":"flac"}
Apr 02 21:53:17 volumio volumio[6589]: verbose: CURRENT POSITION 7
Apr 02 21:53:17 volumio volumio[6589]: info: CoreStateMachine::syncState stateService play
Apr 02 21:53:17 volumio volumio[6589]: info: CoreStateMachine::syncState currentStatus play
Apr 02 21:53:17 volumio volumio[6589]: info: Received an update from plugin. extracting info from payload
Apr 02 21:53:17 volumio volumio[6589]: info: CoreStateMachine::pushState
Apr 02 21:53:17 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:53:17 volumio volumio[6589]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 02 21:53:17 volumio volumio[6589]: info: CoreCommandRouter::volumioPushState
Apr 02 21:53:17 volumio volumio[6589]: info: MRS: Pushing multiroomSync output update for this device
Apr 02 21:53:17 volumio volumio[6589]: info: MRS: Pushing multiroomSync output
Apr 02 21:53:17 volumio volumio[6589]: info: CoreCommandRouter::volumioGetState
Apr 02 21:53:17 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:53:17 volumio volumio[6589]: info: CoreStateMachine::pushState
Apr 02 21:53:17 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:53:17 volumio volumio[6589]: info: CoreCommandRouter::volumioPushState
Apr 02 21:53:17 volumio volumio[6589]: info: MRS: Pushing multiroomSync output update for this device
Apr 02 21:53:17 volumio volumio[6589]: info: MRS: Pushing multiroomSync output
Apr 02 21:53:17 volumio volumio[6589]: info: CoreCommandRouter::volumioGetState
Apr 02 21:53:17 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:53:17 volumio volumio[6589]: info: ------------------------------ 10ms
Apr 02 21:53:17 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:17.705+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" state=STATUS_PLAYING positionMs=1212 volume=58
Apr 02 21:53:17 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:17.705+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" id="mnt/INTERNAL/FLAC/Christina Aguilera/Stripped/10. Underappreciated.flac" title="10 - Underappreciated"
Apr 02 21:53:17 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:17.705+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" state=STATUS_PLAYING positionMs=1212 volume=58
Apr 02 21:53:17 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:17.706+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" id="mnt/INTERNAL/FLAC/Christina Aguilera/Stripped/10. Underappreciated.flac" title="10 - Underappreciated"
Apr 02 21:53:17 volumio volumio[6589]: info: ------------------------------ 10ms
Apr 02 21:53:19 volumio volumio[6589]: info: CoreCommandRouter::volumioSeek
Apr 02 21:53:19 volumio volumio[6589]: info: CoreStateMachine::seek
Apr 02 21:53:19 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:53:19 volumio volumio[6589]: info: TRACKBLOCK {"uri":"mnt/INTERNAL/FLAC/Christina Aguilera/Stripped/10. Underappreciated.flac","service":"mpd","name":"10 - Underappreciated","artist":"Christina Aguilera","album":"Stripped","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=484&web=Christina%20Aguilera/Stripped/extralarge&path=%2FINTERNAL%2FFLAC%2FChristina%20Aguilera%2FStripped&metadata=false","duration":241,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"flac","channels":2}
Apr 02 21:53:19 volumio volumio[6589]: info: CoreStateMachine::startPlaybackTimer
Apr 02 21:53:19 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:53:19 volumio volumio[6589]: info: ControllerMpd::seek
Apr 02 21:53:19 volumio volumio[6589]: info: CoreStateMachine::pushState
Apr 02 21:53:19 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:53:19 volumio volumio[6589]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 02 21:53:19 volumio volumio[6589]: info: CoreCommandRouter::volumioPushState
Apr 02 21:53:19 volumio volumio[6589]: info: MRS: Pushing multiroomSync output update for this device
Apr 02 21:53:19 volumio volumio[6589]: info: MRS: Pushing multiroomSync output
Apr 02 21:53:19 volumio volumio[6589]: info: CoreCommandRouter::volumioGetState
Apr 02 21:53:19 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:53:19 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:19.791+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" state=STATUS_PLAYING positionMs=75000 volume=58
Apr 02 21:53:19 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:19.791+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" id="mnt/INTERNAL/FLAC/Christina Aguilera/Stripped/10. Underappreciated.flac" title="10 - Underappreciated"
Apr 02 21:53:19 volumio volumio[6589]: error: null
Apr 02 21:53:19 volumio volumio[6589]: info:
Apr 02 21:53:19 volumio volumio[6589]: ---------------------------- MPD announces state update: player
Apr 02 21:53:19 volumio volumio[6589]: info: ControllerMpd::getState
Apr 02 21:53:19 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand status
Apr 02 21:53:19 volumio volumio[6589]: info: sendMpdCommand status took 0 milliseconds
Apr 02 21:53:19 volumio volumio[6589]: verbose: ControllerMpd::parseState
Apr 02 21:53:19 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 02 21:53:19 volumio volumio[6589]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 02 21:53:19 volumio volumio[6589]: verbose: ControllerMpd::parseTrackInfo
Apr 02 21:53:19 volumio volumio[6589]: info: ControllerMpd::pushState
Apr 02 21:53:19 volumio volumio[6589]: info: CoreCommandRouter::servicePushState
Apr 02 21:53:19 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:53:19 volumio volumio[6589]: verbose: STATE SERVICE {"status":"play","position":0,"seek":75000,"duration":241,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"559 Kbps","isStreaming":false,"title":"Underappreciated","artist":"Christina Aguilera","album":"Stripped","uri":"INTERNAL/FLAC/Christina Aguilera/Stripped/10. Underappreciated.flac","trackType":"flac"}
Apr 02 21:53:19 volumio volumio[6589]: verbose: CURRENT POSITION 7
Apr 02 21:53:19 volumio volumio[6589]: info: CoreStateMachine::syncState stateService play
Apr 02 21:53:19 volumio volumio[6589]: info: CoreStateMachine::syncState currentStatus play
Apr 02 21:53:19 volumio volumio[6589]: info: Received an update from plugin. extracting info from payload
Apr 02 21:53:19 volumio volumio[6589]: info: CoreStateMachine::pushState
Apr 02 21:53:19 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:53:19 volumio volumio[6589]: info: CoreCommandRouter::volumioPushState
Apr 02 21:53:19 volumio volumio[6589]: info: MRS: Pushing multiroomSync output update for this device
Apr 02 21:53:19 volumio volumio[6589]: info: MRS: Pushing multiroomSync output
Apr 02 21:53:19 volumio volumio[6589]: info: CoreCommandRouter::volumioGetState
Apr 02 21:53:19 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:53:19 volumio volumio[6589]: info: CoreStateMachine::pushState
Apr 02 21:53:19 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:53:19 volumio volumio[6589]: info: CoreCommandRouter::volumioPushState
Apr 02 21:53:19 volumio volumio[6589]: info: MRS: Pushing multiroomSync output update for this device
Apr 02 21:53:19 volumio volumio[6589]: info: MRS: Pushing multiroomSync output
Apr 02 21:53:19 volumio volumio[6589]: info: CoreCommandRouter::volumioGetState
Apr 02 21:53:19 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:53:19 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:19.799+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" state=STATUS_PLAYING positionMs=75000 volume=58
Apr 02 21:53:19 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:19.799+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" state=STATUS_PLAYING positionMs=75000 volume=58
Apr 02 21:53:19 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:19.800+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" id="mnt/INTERNAL/FLAC/Christina Aguilera/Stripped/10. Underappreciated.flac" title="10 - Underappreciated"
Apr 02 21:53:19 volumio volumio5-onboarding[1789]: time=2026-04-02T21:53:19.800+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" id="mnt/INTERNAL/FLAC/Christina Aguilera/Stripped/10. Underappreciated.flac" title="10 - Underappreciated"
Apr 02 21:53:19 volumio volumio[6589]: info: ------------------------------ 7ms
Apr 02 21:53:21 volumio kernel: hwmon hwmon4: Voltage normalised
Apr 02 21:54:50 volumio volumio[6589]: info: CoreCommandRouter::volumioSeek
Apr 02 21:54:50 volumio volumio[6589]: info: CoreStateMachine::seek
Apr 02 21:54:50 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:54:50 volumio volumio[6589]: info: TRACKBLOCK {"uri":"mnt/INTERNAL/FLAC/Christina Aguilera/Stripped/10. Underappreciated.flac","service":"mpd","name":"10 - Underappreciated","artist":"Christina Aguilera","album":"Stripped","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=484&web=Christina%20Aguilera/Stripped/extralarge&path=%2FINTERNAL%2FFLAC%2FChristina%20Aguilera%2FStripped&metadata=false","duration":241,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"flac","channels":2}
Apr 02 21:54:50 volumio volumio[6589]: info: CoreStateMachine::startPlaybackTimer
Apr 02 21:54:50 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:54:50 volumio volumio[6589]: info: ControllerMpd::seek
Apr 02 21:54:50 volumio volumio[6589]: info: CoreStateMachine::pushState
Apr 02 21:54:50 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:54:50 volumio volumio[6589]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 02 21:54:50 volumio volumio[6589]: info: CoreCommandRouter::volumioPushState
Apr 02 21:54:50 volumio volumio[6589]: info: MRS: Pushing multiroomSync output update for this device
Apr 02 21:54:50 volumio volumio[6589]: info: MRS: Pushing multiroomSync output
Apr 02 21:54:50 volumio volumio[6589]: info: CoreCommandRouter::volumioGetState
Apr 02 21:54:50 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:54:50 volumio volumio5-onboarding[1789]: time=2026-04-02T21:54:50.809+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" state=STATUS_PLAYING positionMs=164000 volume=58
Apr 02 21:54:50 volumio volumio5-onboarding[1789]: time=2026-04-02T21:54:50.809+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" id="mnt/INTERNAL/FLAC/Christina Aguilera/Stripped/10. Underappreciated.flac" title="10 - Underappreciated"
Apr 02 21:54:50 volumio volumio[6589]: error: null
Apr 02 21:54:50 volumio volumio[6589]: info:
Apr 02 21:54:50 volumio volumio[6589]: ---------------------------- MPD announces state update: player
Apr 02 21:54:50 volumio volumio[6589]: info: ControllerMpd::getState
Apr 02 21:54:50 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand status
Apr 02 21:54:50 volumio volumio[6589]: info: sendMpdCommand status took 5 milliseconds
Apr 02 21:54:50 volumio volumio[6589]: verbose: ControllerMpd::parseState
Apr 02 21:54:50 volumio volumio[6589]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 02 21:54:50 volumio volumio[6589]: info: sendMpdCommand playlistinfo took 0 milliseconds
Apr 02 21:54:50 volumio volumio[6589]: verbose: ControllerMpd::parseTrackInfo
Apr 02 21:54:50 volumio volumio[6589]: info: ControllerMpd::pushState
Apr 02 21:54:50 volumio volumio[6589]: info: CoreCommandRouter::servicePushState
Apr 02 21:54:50 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:54:50 volumio volumio[6589]: verbose: STATE SERVICE {"status":"play","position":0,"seek":165212,"duration":241,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1191 Kbps","isStreaming":false,"title":"Underappreciated","artist":"Christina Aguilera","album":"Stripped","uri":"INTERNAL/FLAC/Christina Aguilera/Stripped/10. Underappreciated.flac","trackType":"flac"}
Apr 02 21:54:50 volumio volumio[6589]: verbose: CURRENT POSITION 7
Apr 02 21:54:50 volumio volumio[6589]: info: CoreStateMachine::syncState stateService play
Apr 02 21:54:50 volumio volumio[6589]: info: CoreStateMachine::syncState currentStatus play
Apr 02 21:54:50 volumio volumio[6589]: info: Received an update from plugin. extracting info from payload
Apr 02 21:54:50 volumio volumio[6589]: info: CoreStateMachine::pushState
Apr 02 21:54:50 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:54:50 volumio volumio[6589]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 02 21:54:50 volumio volumio[6589]: info: CoreCommandRouter::volumioPushState
Apr 02 21:54:50 volumio volumio[6589]: info: MRS: Pushing multiroomSync output update for this device
Apr 02 21:54:50 volumio volumio[6589]: info: MRS: Pushing multiroomSync output
Apr 02 21:54:50 volumio volumio[6589]: info: CoreCommandRouter::volumioGetState
Apr 02 21:54:50 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:54:50 volumio volumio[6589]: info: CoreStateMachine::pushState
Apr 02 21:54:50 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:54:50 volumio volumio[6589]: info: CoreCommandRouter::volumioPushState
Apr 02 21:54:50 volumio volumio[6589]: info: MRS: Pushing multiroomSync output update for this device
Apr 02 21:54:50 volumio volumio[6589]: info: MRS: Pushing multiroomSync output
Apr 02 21:54:50 volumio volumio[6589]: info: CoreCommandRouter::volumioGetState
Apr 02 21:54:50 volumio volumio[6589]: info: CorePlayQueue::getTrack 7
Apr 02 21:54:50 volumio volumio5-onboarding[1789]: time=2026-04-02T21:54:50.822+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" state=STATUS_PLAYING positionMs=165212 volume=58
Apr 02 21:54:50 volumio volumio5-onboarding[1789]: time=2026-04-02T21:54:50.823+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" id="mnt/INTERNAL/FLAC/Christina Aguilera/Stripped/10. Underappreciated.flac" title="10 - Underappreciated"
Apr 02 21:54:50 volumio volumio5-onboarding[1789]: time=2026-04-02T21:54:50.824+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" state=STATUS_PLAYING positionMs=165212 volume=58
Apr 02 21:54:50 volumio volumio5-onboarding[1789]: time=2026-04-02T21:54:50.824+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.4.118:34580 @ 0x17bc5a0" id="mnt/INTERNAL/FLAC/Christina Aguilera/Stripped/10. Underappreciated.flac" title="10 - Underappreciated"
Apr 02 21:54:50 volumio volumio[6589]: info: ------------------------------ 14ms
Apr 02 21:54:57 volumio volumio[6589]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPlay
Apr 02 21:54:57 volumio volumio[6589]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPlay] in plugin multiroom
Apr 02 21:54:57 volumio volumio[6589]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 02 21:54:57 volumio volumio[6589]: TypeError: Cannot read property 'then' of undefined
Apr 02 21:54:57 volumio volumio[6589]: at outputs.audioOutputPlay (/volumio/app/plugins/audio_interface/outputs/index.js:367:9)
Apr 02 21:54:57 volumio volumio[6589]: at CoreCommandRouter.audioOutputPlay (/volumio/app/index.js:2279:30)
Apr 02 21:54:57 volumio volumio[6589]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1467:26)
Apr 02 21:54:57 volumio volumio[6589]: at Socket.emit (events.js:315:20)
Apr 02 21:54:57 volumio volumio[6589]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
Apr 02 21:54:57 volumio volumio[6589]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Apr 02 21:54:57 volumio volumio[6589]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 02 21:54:57 volumio sudo[11616]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-02 21:53
Apr 02 21:54:57 volumio sudo[11616]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET"
VOLUMIO_VERSION="3.912"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"