Feb 22 16:54:00 volumio volumio[1259]: info: CoreStateMachine::startPlaybackTimer
Feb 22 16:54:00 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:54:00 volumio volumio[1259]: info: CoreStateMachine::pushState
Feb 22 16:54:00 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:54:00 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 22 16:54:00 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState
Feb 22 16:54:00 volumio volumio[1259]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false
Feb 22 16:54:00 volumio volumio[1259]: info:
Feb 22 16:54:00 volumio volumio[1259]: ---------------------------- MPD announces system playlist update
Feb 22 16:54:00 volumio volumio[1259]: info: Ignoring MPD Status Update
Feb 22 16:54:00 volumio volumio[1259]: info:
Feb 22 16:54:00 volumio volumio[1259]: ---------------------------- MPD announces state update: player
Feb 22 16:54:00 volumio volumio[1259]: info: ControllerMpd::getState
Feb 22 16:54:00 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 16:54:00 volumio volumio[1259]: info:
Feb 22 16:54:00 volumio volumio[1259]: ---------------------------- MPD announces system playlist update
Feb 22 16:54:00 volumio volumio[1259]: info: Ignoring MPD Status Update
Feb 22 16:54:00 volumio volumio[1259]: info:
Feb 22 16:54:00 volumio volumio[1259]: ---------------------------- MPD announces state update: player
Feb 22 16:54:00 volumio volumio[1259]: info: ControllerMpd::getState
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 16:54:01 volumio volumio[1259]: info:
Feb 22 16:54:01 volumio volumio[1259]: ---------------------------- MPD announces system playlist update
Feb 22 16:54:01 volumio volumio[1259]: info: Ignoring MPD Status Update
Feb 22 16:54:01 volumio volumio[1259]: info:
Feb 22 16:54:01 volumio volumio[1259]: ---------------------------- MPD announces state update: player
Feb 22 16:54:01 volumio volumio[1259]: info: ControllerMpd::getState
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 16:54:01 volumio volumio[1259]: info:
Feb 22 16:54:01 volumio volumio[1259]: ---------------------------- MPD announces system playlist update
Feb 22 16:54:01 volumio volumio[1259]: info: Ignoring MPD Status Update
Feb 22 16:54:01 volumio volumio[1259]: info:
Feb 22 16:54:01 volumio volumio[1259]: ---------------------------- MPD announces state update: player
Feb 22 16:54:01 volumio volumio[1259]: info:
Feb 22 16:54:01 volumio volumio[1259]: ---------------------------- MPD announces state update: player
Feb 22 16:54:01 volumio volumio[1259]: info: ControllerMpd::getState
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 16:54:01 volumio volumio[1259]: info: ------------------------------ 16ms
Feb 22 16:54:01 volumio volumio[1259]: info: ControllerMpd::getState
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 16:54:01 volumio volumio[1259]: info: sendMpdCommand status took 15 milliseconds
Feb 22 16:54:01 volumio volumio[1259]: info: ------------------------------ 14ms
Feb 22 16:54:01 volumio volumio[1259]: info: sendMpdCommand status took 7 milliseconds
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::parseState
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::parseState
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 16:54:01 volumio volumio[1259]: info:
Feb 22 16:54:01 volumio volumio[1259]: ---------------------------- MPD announces state update: player
Feb 22 16:54:01 volumio volumio[1259]: info: ControllerMpd::getState
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 16:54:01 volumio volumio[1259]: info:
Feb 22 16:54:01 volumio volumio[1259]: ---------------------------- MPD announces state update: player
Feb 22 16:54:01 volumio volumio[1259]: info: ControllerMpd::getState
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 16:54:01 volumio volumio[1259]: info:
Feb 22 16:54:01 volumio volumio[1259]: ---------------------------- MPD announces state update: player
Feb 22 16:54:01 volumio volumio[1259]: info: ControllerMpd::getState
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 16:54:01 volumio volumio[1259]: info: ------------------------------ 10ms
Feb 22 16:54:01 volumio volumio[1259]: info: sendMpdCommand status took 9 milliseconds
Feb 22 16:54:01 volumio volumio[1259]: info: ------------------------------ 8ms
Feb 22 16:54:01 volumio volumio[1259]: info: sendMpdCommand status took 6 milliseconds
Feb 22 16:54:01 volumio volumio[1259]: info: sendMpdCommand status took 6 milliseconds
Feb 22 16:54:01 volumio volumio[1259]: info: sendMpdCommand playlistinfo took 4 milliseconds
Feb 22 16:54:01 volumio volumio[1259]: info: sendMpdCommand playlistinfo took 4 milliseconds
Feb 22 16:54:01 volumio volumio[1259]: info: sendMpdCommand status took 3 milliseconds
Feb 22 16:54:01 volumio volumio[1259]: info: sendMpdCommand status took 2 milliseconds
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::parseState
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::parseState
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::parseState
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::parseTrackInfo
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::parseTrackInfo
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::parseState
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::parseState
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 16:54:01 volumio volumio[1259]: info: ControllerMpd::pushState
Feb 22 16:54:01 volumio volumio[1259]: info: CoreCommandRouter::servicePushState
Feb 22 16:54:01 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:54:01 volumio volumio[1259]: verbose: STATE SERVICE {"status":"play","position":0,"seek":17,"duration":253,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"B4 Lovers Rock","artist":"Sade","album":"Lovers Rock,(EU),(ART-9+NG-8(P+G)+Pio)","uri":"NAS/NAS-SERVER/Sade - Lovers Rock - 2000(2010),(EU),DSF(tracks),(ART-9tsw+NG-8(P+G)+Pio_S3)/B4 Lovers Rock.dsf","trackType":"dsf"}
Feb 22 16:54:01 volumio volumio[1259]: verbose: CURRENT POSITION 9
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::syncState stateService play
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::syncState currentStatus play
Feb 22 16:54:01 volumio volumio[1259]: info: Received an update from plugin. extracting info from payload
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::pushState
Feb 22 16:54:01 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:54:01 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 22 16:54:01 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::pushState
Feb 22 16:54:01 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:54:01 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState
Feb 22 16:54:01 volumio volumio[1259]: info: ControllerMpd::pushState
Feb 22 16:54:01 volumio volumio[1259]: info: CoreCommandRouter::servicePushState
Feb 22 16:54:01 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:54:01 volumio volumio[1259]: verbose: STATE SERVICE {"status":"play","position":0,"seek":17,"duration":253,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"B4 Lovers Rock","artist":"Sade","album":"Lovers Rock,(EU),(ART-9+NG-8(P+G)+Pio)","uri":"NAS/NAS-SERVER/Sade - Lovers Rock - 2000(2010),(EU),DSF(tracks),(ART-9tsw+NG-8(P+G)+Pio_S3)/B4 Lovers Rock.dsf","trackType":"dsf"}
Feb 22 16:54:01 volumio volumio[1259]: verbose: CURRENT POSITION 9
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::syncState stateService play
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::syncState currentStatus play
Feb 22 16:54:01 volumio volumio[1259]: info: Received an update from plugin. extracting info from payload
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::pushState
Feb 22 16:54:01 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:54:01 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::pushState
Feb 22 16:54:01 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:54:01 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState
Feb 22 16:54:01 volumio volumio[1259]: info: ------------------------------ 41ms
Feb 22 16:54:01 volumio volumio[1259]: info: ------------------------------ 41ms
Feb 22 16:54:01 volumio volumio[1259]: info: sendMpdCommand status took 23 milliseconds
Feb 22 16:54:01 volumio volumio[1259]: info: sendMpdCommand playlistinfo took 21 milliseconds
Feb 22 16:54:01 volumio volumio[1259]: info: sendMpdCommand playlistinfo took 22 milliseconds
Feb 22 16:54:01 volumio volumio[1259]: info: sendMpdCommand playlistinfo took 22 milliseconds
Feb 22 16:54:01 volumio volumio[1259]: info: sendMpdCommand playlistinfo took 22 milliseconds
Feb 22 16:54:01 volumio volumio[1259]: info: sendMpdCommand playlistinfo took 22 milliseconds
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::parseState
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::parseTrackInfo
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::parseTrackInfo
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::parseTrackInfo
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::parseTrackInfo
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::parseTrackInfo
Feb 22 16:54:01 volumio volumio[1259]: info: ControllerMpd::pushState
Feb 22 16:54:01 volumio volumio[1259]: info: CoreCommandRouter::servicePushState
Feb 22 16:54:01 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:54:01 volumio volumio[1259]: verbose: STATE SERVICE {"status":"play","position":0,"seek":17,"duration":253,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"B4 Lovers Rock","artist":"Sade","album":"Lovers Rock,(EU),(ART-9+NG-8(P+G)+Pio)","uri":"NAS/NAS-SERVER/Sade - Lovers Rock - 2000(2010),(EU),DSF(tracks),(ART-9tsw+NG-8(P+G)+Pio_S3)/B4 Lovers Rock.dsf","trackType":"dsf"}
Feb 22 16:54:01 volumio volumio[1259]: verbose: CURRENT POSITION 9
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::syncState stateService play
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::syncState currentStatus play
Feb 22 16:54:01 volumio volumio[1259]: info: Received an update from plugin. extracting info from payload
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::pushState
Feb 22 16:54:01 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:54:01 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::pushState
Feb 22 16:54:01 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:54:01 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState
Feb 22 16:54:01 volumio volumio[1259]: info: ControllerMpd::pushState
Feb 22 16:54:01 volumio volumio[1259]: info: CoreCommandRouter::servicePushState
Feb 22 16:54:01 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:54:01 volumio volumio[1259]: verbose: STATE SERVICE {"status":"play","position":0,"seek":17,"duration":253,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"B4 Lovers Rock","artist":"Sade","album":"Lovers Rock,(EU),(ART-9+NG-8(P+G)+Pio)","uri":"NAS/NAS-SERVER/Sade - Lovers Rock - 2000(2010),(EU),DSF(tracks),(ART-9tsw+NG-8(P+G)+Pio_S3)/B4 Lovers Rock.dsf","trackType":"dsf"}
Feb 22 16:54:01 volumio volumio[1259]: verbose: CURRENT POSITION 9
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::syncState stateService play
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::syncState currentStatus play
Feb 22 16:54:01 volumio volumio[1259]: info: Received an update from plugin. extracting info from payload
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::pushState
Feb 22 16:54:01 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:54:01 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::pushState
Feb 22 16:54:01 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:54:01 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState
Feb 22 16:54:01 volumio volumio[1259]: info: ControllerMpd::pushState
Feb 22 16:54:01 volumio volumio[1259]: info: CoreCommandRouter::servicePushState
Feb 22 16:54:01 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:54:01 volumio volumio[1259]: verbose: STATE SERVICE {"status":"play","position":0,"seek":17,"duration":253,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"B4 Lovers Rock","artist":"Sade","album":"Lovers Rock,(EU),(ART-9+NG-8(P+G)+Pio)","uri":"NAS/NAS-SERVER/Sade - Lovers Rock - 2000(2010),(EU),DSF(tracks),(ART-9tsw+NG-8(P+G)+Pio_S3)/B4 Lovers Rock.dsf","trackType":"dsf"}
Feb 22 16:54:01 volumio volumio[1259]: verbose: CURRENT POSITION 9
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::syncState stateService play
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::syncState currentStatus play
Feb 22 16:54:01 volumio volumio[1259]: info: Received an update from plugin. extracting info from payload
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::pushState
Feb 22 16:54:01 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:54:01 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::pushState
Feb 22 16:54:01 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:54:01 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState
Feb 22 16:54:01 volumio volumio[1259]: info: ControllerMpd::pushState
Feb 22 16:54:01 volumio volumio[1259]: info: CoreCommandRouter::servicePushState
Feb 22 16:54:01 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:54:01 volumio volumio[1259]: verbose: STATE SERVICE {"status":"play","position":0,"seek":17,"duration":253,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"B4 Lovers Rock","artist":"Sade","album":"Lovers Rock,(EU),(ART-9+NG-8(P+G)+Pio)","uri":"NAS/NAS-SERVER/Sade - Lovers Rock - 2000(2010),(EU),DSF(tracks),(ART-9tsw+NG-8(P+G)+Pio_S3)/B4 Lovers Rock.dsf","trackType":"dsf"}
Feb 22 16:54:01 volumio volumio[1259]: verbose: CURRENT POSITION 9
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::syncState stateService play
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::syncState currentStatus play
Feb 22 16:54:01 volumio volumio[1259]: info: Received an update from plugin. extracting info from payload
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::pushState
Feb 22 16:54:01 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:54:01 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::pushState
Feb 22 16:54:01 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:54:01 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState
Feb 22 16:54:01 volumio volumio[1259]: info: ControllerMpd::pushState
Feb 22 16:54:01 volumio volumio[1259]: info: CoreCommandRouter::servicePushState
Feb 22 16:54:01 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:54:01 volumio volumio[1259]: verbose: STATE SERVICE {"status":"play","position":0,"seek":17,"duration":253,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"B4 Lovers Rock","artist":"Sade","album":"Lovers Rock,(EU),(ART-9+NG-8(P+G)+Pio)","uri":"NAS/NAS-SERVER/Sade - Lovers Rock - 2000(2010),(EU),DSF(tracks),(ART-9tsw+NG-8(P+G)+Pio_S3)/B4 Lovers Rock.dsf","trackType":"dsf"}
Feb 22 16:54:01 volumio volumio[1259]: verbose: CURRENT POSITION 9
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::syncState stateService play
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::syncState currentStatus play
Feb 22 16:54:01 volumio volumio[1259]: info: Received an update from plugin. extracting info from payload
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::pushState
Feb 22 16:54:01 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:54:01 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::pushState
Feb 22 16:54:01 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:54:01 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState
Feb 22 16:54:01 volumio volumio[1259]: info: ------------------------------ 70ms
Feb 22 16:54:01 volumio volumio[1259]: info: ------------------------------ 68ms
Feb 22 16:54:01 volumio volumio[1259]: info: ------------------------------ 78ms
Feb 22 16:54:01 volumio volumio[1259]: info: ------------------------------ 74ms
Feb 22 16:54:01 volumio volumio[1259]: info: ------------------------------ 74ms
Feb 22 16:54:01 volumio volumio[1259]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false
Feb 22 16:54:01 volumio volumio[1259]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false
Feb 22 16:54:01 volumio volumio[1259]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false
Feb 22 16:54:01 volumio volumio[1259]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false
Feb 22 16:54:01 volumio volumio[1259]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false
Feb 22 16:54:01 volumio volumio[1259]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false
Feb 22 16:54:01 volumio volumio[1259]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false
Feb 22 16:54:01 volumio volumio[1259]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false
Feb 22 16:54:01 volumio volumio[1259]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false
Feb 22 16:54:01 volumio volumio[1259]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false
Feb 22 16:54:01 volumio volumio[1259]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false
Feb 22 16:54:01 volumio volumio[1259]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false
Feb 22 16:54:01 volumio volumio[1259]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false
Feb 22 16:54:01 volumio volumio[1259]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false
Feb 22 16:54:01 volumio volumio[1259]: info: sendMpdCommand playlistinfo took 127 milliseconds
Feb 22 16:54:01 volumio volumio[1259]: verbose: ControllerMpd::parseTrackInfo
Feb 22 16:54:01 volumio volumio[1259]: info: ControllerMpd::pushState
Feb 22 16:54:01 volumio volumio[1259]: info: CoreCommandRouter::servicePushState
Feb 22 16:54:01 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:54:01 volumio volumio[1259]: verbose: STATE SERVICE {"status":"play","position":0,"seek":17,"duration":253,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"B4 Lovers Rock","artist":"Sade","album":"Lovers Rock,(EU),(ART-9+NG-8(P+G)+Pio)","uri":"NAS/NAS-SERVER/Sade - Lovers Rock - 2000(2010),(EU),DSF(tracks),(ART-9tsw+NG-8(P+G)+Pio_S3)/B4 Lovers Rock.dsf","trackType":"dsf"}
Feb 22 16:54:01 volumio volumio[1259]: verbose: CURRENT POSITION 9
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::syncState stateService play
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::syncState currentStatus play
Feb 22 16:54:01 volumio volumio[1259]: info: Received an update from plugin. extracting info from payload
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::pushState
Feb 22 16:54:01 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:54:01 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState
Feb 22 16:54:01 volumio volumio[1259]: info: CoreStateMachine::pushState
Feb 22 16:54:01 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:54:01 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState
Feb 22 16:54:01 volumio volumio[1259]: info: ------------------------------ 169ms
Feb 22 16:54:01 volumio volumio[1259]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false
Feb 22 16:54:01 volumio volumio[1259]: info: peppy_screensaver: pushState - status=play service=mpd volatile=false
Feb 22 16:55:01 volumio volumio[1259]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: unknown Engine version: 4 Transport: websocket Total Clients: 10
Feb 22 16:55:01 volumio volumio[1259]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: unknown Engine version: 4 Transport: websocket Total Clients: 10
Feb 22 16:55:01 volumio volumio[1259]: info: CoreCommandRouter::volumioGetState
Feb 22 16:55:01 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:55:01 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Feb 22 16:55:01 volumio volumio[1259]: info: CoreCommandRouter::volumioGetQueue
Feb 22 16:55:01 volumio volumio[1259]: info: CoreStateMachine::getQueue
Feb 22 16:55:01 volumio volumio[1259]: info: CorePlayQueue::getQueue
Feb 22 16:55:43 volumio kernel: usb 1-1.4: new full-speed USB device number 4 using xhci_hcd
Feb 22 16:55:43 volumio kernel: usb 1-1.4: device descriptor read/64, error -32
Feb 22 16:55:43 volumio kernel: usb 1-1.4: device descriptor read/64, error -32
Feb 22 16:55:43 volumio kernel: usb 1-1.4: new full-speed USB device number 5 using xhci_hcd
Feb 22 16:55:43 volumio kernel: usb 1-1.4: device descriptor read/64, error -32
Feb 22 16:55:44 volumio kernel: usb 1-1.4: device descriptor read/64, error -32
Feb 22 16:55:44 volumio kernel: usb 1-1-port4: attempt power cycle
Feb 22 16:55:45 volumio kernel: usb 1-1.4: new high-speed USB device number 6 using xhci_hcd
Feb 22 16:55:45 volumio kernel: usb 1-1.4: New USB device found, idVendor=152a, idProduct=8750, bcdDevice= 1.06
Feb 22 16:55:45 volumio kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=3, SerialNumber=2
Feb 22 16:55:45 volumio kernel: usb 1-1.4: Product: E50
Feb 22 16:55:45 volumio kernel: usb 1-1.4: Manufacturer: Topping
Feb 22 16:55:45 volumio kernel: hid-generic 0003:152A:8750.0002: hiddev97,hidraw1: USB HID v1.10 Device [Topping E50] on usb-0000:01:00.0-1.4/input3
Feb 22 16:55:45 volumio kernel: usbcore: registered new interface driver snd-usb-audio
Feb 22 16:55:45 volumio volumio[1259]: info:
Feb 22 16:55:45 volumio volumio[1259]: ---------------------------- USB Audio Device Attached
Feb 22 16:55:45 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach
Feb 22 16:55:45 volumio volumio[1259]: info: CoreCommandRouter::Close All Modals sent
Feb 22 16:55:45 volumio volumio[1259]: info: Preparing to save Alsa Options, stopping services first
Feb 22 16:55:45 volumio volumio[1259]: info: CoreCommandRouter::volumioGetState
Feb 22 16:55:45 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:55:45 volumio volumio[1259]: info: CoreCommandRouter::volumioPause
Feb 22 16:55:45 volumio volumio[1259]: info: CoreStateMachine::pause
Feb 22 16:55:45 volumio volumio[1259]: info: CoreStateMachine::stPlaybackTimer
Feb 22 16:55:45 volumio volumio[1259]: info: CoreStateMachine::servicePause
Feb 22 16:55:45 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:55:45 volumio volumio[1259]: info: CoreCommandRouter::servicePause
Feb 22 16:55:45 volumio volumio[1259]: info: ControllerMpd::pause
Feb 22 16:55:45 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand pause
Feb 22 16:55:45 volumio volumio[1259]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"E50","alsacard":"E50"},"i2s":false}
Feb 22 16:55:45 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 22 16:55:45 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 22 16:55:45 volumio volumio[1259]: info: Device 5 does not have any Mixer Control Available
Feb 22 16:55:45 volumio vtcs[3642]: [2026-02-22 16:55:45.915] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE
Feb 22 16:55:45 volumio vtcs[3642]: [2026-02-22 16:55:45.915] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected
Feb 22 16:55:45 volumio volumio[1259]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Feb 22 16:55:45 volumio volumio[1259]: info: Updating Volume Controller Parameters: Device: 5 Name: E50 Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Feb 22 16:55:45 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Feb 22 16:55:45 volumio volumio[1259]: info: Disabling external Volume Control
Feb 22 16:55:45 volumio volumio[1259]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 22 16:55:45 volumio volumio[1259]: info: CoreStateMachine::pushState
Feb 22 16:55:45 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:55:45 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 22 16:55:45 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState
Feb 22 16:55:45 volumio volumio[1259]: info: Preparing to generate the ALSA configuration file
Feb 22 16:55:45 volumio sudo[10559]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Feb 22 16:55:45 volumio sudo[10559]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 16:55:46 volumio volumio[1259]: info: peppy_screensaver: pushState - status=pause service=mpd volatile=false
Feb 22 16:55:46 volumio volumio[1259]: info: peppy_screensaver: Starting persist timer - 30s
Feb 22 16:55:46 volumio volumio[1259]: info:
Feb 22 16:55:46 volumio volumio[1259]: ---------------------------- MPD announces state update: player
Feb 22 16:55:46 volumio volumio[1259]: info: sendMpdCommand pause took 222 milliseconds
Feb 22 16:55:46 volumio volumio[1259]: info: ControllerMpd::getState
Feb 22 16:55:46 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 16:55:46 volumio volumio[1259]: info:
Feb 22 16:55:46 volumio volumio[1259]: ---------------------------- MPD announces state update: player
Feb 22 16:55:46 volumio volumio[1259]: info: ControllerMpd::getState
Feb 22 16:55:46 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 16:55:46 volumio volumio[1259]: info:
Feb 22 16:55:46 volumio volumio[1259]: ---------------------------- MPD announces state update: player
Feb 22 16:55:46 volumio volumio[1259]: info: ControllerMpd::getState
Feb 22 16:55:46 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 16:55:46 volumio volumio[1259]: info:
Feb 22 16:55:46 volumio volumio[1259]: ---------------------------- MPD announces state update: player
Feb 22 16:55:46 volumio volumio[1259]: info: ControllerMpd::getState
Feb 22 16:55:46 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand status
Feb 22 16:55:46 volumio volumio[1259]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf
Feb 22 16:55:46 volumio volumio[1259]: info: Reading ALSA contributions from plugins.
Feb 22 16:55:46 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service...
Feb 22 16:55:46 volumio systemd[1]: vtcs.service: Killing process 3649 (vtcs) with signal SIGKILL.
Feb 22 16:55:46 volumio systemd[1]: vtcs.service: Deactivated successfully.
Feb 22 16:55:46 volumio sudo[10568]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Feb 22 16:55:46 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service.
Feb 22 16:55:46 volumio sudo[10568]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 16:55:46 volumio systemd[1]: vtcs.service: Consumed 2.280s CPU time.
Feb 22 16:55:46 volumio volumio[1259]: info: sendMpdCommand status took 23 milliseconds
Feb 22 16:55:46 volumio volumio[1259]: info: sendMpdCommand status took 22 milliseconds
Feb 22 16:55:46 volumio volumio[1259]: info: sendMpdCommand status took 21 milliseconds
Feb 22 16:55:46 volumio volumio[1259]: info: sendMpdCommand status took 20 milliseconds
Feb 22 16:55:46 volumio volumio[1259]: verbose: ControllerMpd::parseState
Feb 22 16:55:46 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 16:55:46 volumio volumio[1259]: verbose: ControllerMpd::parseState
Feb 22 16:55:46 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 16:55:46 volumio volumio[1259]: verbose: ControllerMpd::parseState
Feb 22 16:55:46 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 16:55:46 volumio volumio[1259]: verbose: ControllerMpd::parseState
Feb 22 16:55:46 volumio volumio[1259]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 22 16:55:46 volumio volumio[1259]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 22 16:55:46 volumio volumio[1259]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 22 16:55:46 volumio volumio[1259]: info: sendMpdCommand playlistinfo took 3 milliseconds
Feb 22 16:55:46 volumio volumio[1259]: info: sendMpdCommand playlistinfo took 4 milliseconds
Feb 22 16:55:46 volumio volumio[1259]: verbose: ControllerMpd::parseTrackInfo
Feb 22 16:55:46 volumio volumio[1259]: verbose: ControllerMpd::parseTrackInfo
Feb 22 16:55:46 volumio volumio[1259]: verbose: ControllerMpd::parseTrackInfo
Feb 22 16:55:46 volumio volumio[1259]: verbose: ControllerMpd::parseTrackInfo
Feb 22 16:55:46 volumio volumio[1259]: info: ControllerMpd::pushState
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::servicePushState
Feb 22 16:55:46 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:55:46 volumio volumio[1259]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":104971,"duration":253,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"B4 Lovers Rock","artist":"Sade","album":"Lovers Rock,(EU),(ART-9+NG-8(P+G)+Pio)","uri":"NAS/NAS-SERVER/Sade - Lovers Rock - 2000(2010),(EU),DSF(tracks),(ART-9tsw+NG-8(P+G)+Pio_S3)/B4 Lovers Rock.dsf","trackType":"dsf"}
Feb 22 16:55:46 volumio volumio[1259]: verbose: CURRENT POSITION 9
Feb 22 16:55:46 volumio volumio[1259]: info: CoreStateMachine::syncState stateService pause
Feb 22 16:55:46 volumio volumio[1259]: info: CoreStateMachine::syncState currentStatus pause
Feb 22 16:55:46 volumio volumio[1259]: info: CoreStateMachine::pushState
Feb 22 16:55:46 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState
Feb 22 16:55:46 volumio sudo[10559]: pam_unix(sudo:session): session closed for user root
Feb 22 16:55:46 volumio volumio[1259]: info: CoreStateMachine::stPlaybackTimer
Feb 22 16:55:46 volumio volumio[1259]: info: ControllerMpd::pushState
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::servicePushState
Feb 22 16:55:46 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:55:46 volumio volumio[1259]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":104971,"duration":253,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"B4 Lovers Rock","artist":"Sade","album":"Lovers Rock,(EU),(ART-9+NG-8(P+G)+Pio)","uri":"NAS/NAS-SERVER/Sade - Lovers Rock - 2000(2010),(EU),DSF(tracks),(ART-9tsw+NG-8(P+G)+Pio_S3)/B4 Lovers Rock.dsf","trackType":"dsf"}
Feb 22 16:55:46 volumio volumio[1259]: verbose: CURRENT POSITION 9
Feb 22 16:55:46 volumio volumio[1259]: info: CoreStateMachine::syncState stateService pause
Feb 22 16:55:46 volumio volumio[1259]: info: CoreStateMachine::syncState currentStatus pause
Feb 22 16:55:46 volumio volumio[1259]: info: CoreStateMachine::pushState
Feb 22 16:55:46 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState
Feb 22 16:55:46 volumio volumio[1259]: info: CoreStateMachine::stPlaybackTimer
Feb 22 16:55:46 volumio volumio[1259]: info: ControllerMpd::pushState
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::servicePushState
Feb 22 16:55:46 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:55:46 volumio volumio[1259]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":104971,"duration":253,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"B4 Lovers Rock","artist":"Sade","album":"Lovers Rock,(EU),(ART-9+NG-8(P+G)+Pio)","uri":"NAS/NAS-SERVER/Sade - Lovers Rock - 2000(2010),(EU),DSF(tracks),(ART-9tsw+NG-8(P+G)+Pio_S3)/B4 Lovers Rock.dsf","trackType":"dsf"}
Feb 22 16:55:46 volumio volumio[1259]: verbose: CURRENT POSITION 9
Feb 22 16:55:46 volumio volumio[1259]: info: CoreStateMachine::syncState stateService pause
Feb 22 16:55:46 volumio volumio[1259]: info: CoreStateMachine::syncState currentStatus pause
Feb 22 16:55:46 volumio volumio[1259]: info: CoreStateMachine::pushState
Feb 22 16:55:46 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState
Feb 22 16:55:46 volumio volumio[1259]: info: CoreStateMachine::stPlaybackTimer
Feb 22 16:55:46 volumio volumio[1259]: info: ControllerMpd::pushState
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::servicePushState
Feb 22 16:55:46 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:55:46 volumio volumio[1259]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":104971,"duration":253,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"B4 Lovers Rock","artist":"Sade","album":"Lovers Rock,(EU),(ART-9+NG-8(P+G)+Pio)","uri":"NAS/NAS-SERVER/Sade - Lovers Rock - 2000(2010),(EU),DSF(tracks),(ART-9tsw+NG-8(P+G)+Pio_S3)/B4 Lovers Rock.dsf","trackType":"dsf"}
Feb 22 16:55:46 volumio volumio[1259]: verbose: CURRENT POSITION 9
Feb 22 16:55:46 volumio volumio[1259]: info: CoreStateMachine::syncState stateService pause
Feb 22 16:55:46 volumio volumio[1259]: info: CoreStateMachine::syncState currentStatus pause
Feb 22 16:55:46 volumio volumio[1259]: info: CoreStateMachine::pushState
Feb 22 16:55:46 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState
Feb 22 16:55:46 volumio volumio[1259]: info: CoreStateMachine::stPlaybackTimer
Feb 22 16:55:46 volumio volumio[1259]: info: ------------------------------ 54ms
Feb 22 16:55:46 volumio volumio[1259]: info: ------------------------------ 53ms
Feb 22 16:55:46 volumio volumio[1259]: info: ------------------------------ 53ms
Feb 22 16:55:46 volumio volumio[1259]: info: ------------------------------ 52ms
Feb 22 16:55:46 volumio sudo[10568]: pam_unix(sudo:session): session closed for user root
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Feb 22 16:55:46 volumio volumio[1259]: info: peppy_screensaver: pushState - status=pause service=mpd volatile=false
Feb 22 16:55:46 volumio volumio[1259]: info: peppy_screensaver: Starting persist timer - 30s
Feb 22 16:55:46 volumio volumio[1259]: info: peppy_screensaver: pushState - status=pause service=mpd volatile=false
Feb 22 16:55:46 volumio volumio[1259]: info: peppy_screensaver: Starting persist timer - 30s
Feb 22 16:55:46 volumio volumio[1259]: info: peppy_screensaver: pushState - status=pause service=mpd volatile=false
Feb 22 16:55:46 volumio volumio[1259]: info: peppy_screensaver: Starting persist timer - 30s
Feb 22 16:55:46 volumio volumio[1259]: info: peppy_screensaver: pushState - status=pause service=mpd volatile=false
Feb 22 16:55:46 volumio volumio[1259]: info: peppy_screensaver: Starting persist timer - 30s
Feb 22 16:55:46 volumio volumio[1259]: info: touch_display: Setting screensaver timeout to 0 seconds.
Feb 22 16:55:46 volumio volumio[1259]: info: Asound.conf file unchanged, so no further update is needed
Feb 22 16:55:46 volumio volumio[1259]: info: Output device has changed, restarting MPD
Feb 22 16:55:46 volumio volumio[1259]: info: Output device has changed, restarting Shairport Sync
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 22 16:55:46 volumio sudo[10592]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 22 16:55:46 volumio sudo[10592]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 16:55:46 volumio sudo[10592]: pam_unix(sudo:session): session closed for user root
Feb 22 16:55:46 volumio sudo[10595]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 22 16:55:46 volumio volumio[1259]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 22 16:55:46 volumio sudo[10595]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 16:55:46 volumio volumio[1259]: info: MPD Permissions set
Feb 22 16:55:46 volumio sudo[10602]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Feb 22 16:55:46 volumio sudo[10602]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 16:55:46 volumio systemd[1]: Stopping mpd.service - Music Player Daemon...
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 16:55:46 volumio sudo[10604]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Feb 22 16:55:46 volumio sudo[10604]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 16:55:46 volumio sudo[10602]: pam_unix(sudo:session): session closed for user root
Feb 22 16:55:46 volumio systemd[1]: mpd.service: Deactivated successfully.
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 22 16:55:46 volumio systemd[1]: Stopped mpd.service - Music Player Daemon.
Feb 22 16:55:46 volumio systemd[1]: mpd.service: Consumed 4min 58.518s CPU time.
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 16:55:46 volumio volumio[1259]: info: Starting Shairport Sync
Feb 22 16:55:46 volumio systemd[1]: mpd.socket: Deactivated successfully.
Feb 22 16:55:46 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Feb 22 16:55:46 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Feb 22 16:55:46 volumio sudo[10614]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 22 16:55:46 volumio sudo[10614]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 16:55:46 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Feb 22 16:55:46 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
Feb 22 16:55:46 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Feb 22 16:55:46 volumio systemd[1]: shairport-sync.service: Deactivated successfully.
Feb 22 16:55:46 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 22 16:55:46 volumio systemd[1]: shairport-sync.service: Consumed 19.718s CPU time.
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat
Feb 22 16:55:46 volumio sudo[10604]: pam_unix(sudo:session): session closed for user root
Feb 22 16:55:46 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 22 16:55:46 volumio sudo[10614]: pam_unix(sudo:session): session closed for user root
Feb 22 16:55:46 volumio volumio[1259]: info: Shairport-Sync Started
Feb 22 16:55:46 volumio sudo[10617]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 22 16:55:46 volumio sudo[10617]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 22 16:55:46 volumio sudo[10617]: pam_unix(sudo:session): session closed for user root
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 16:55:46 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 16:55:47 volumio kernel: usb 1-1.4: USB disconnect, device number 6
Feb 22 16:55:47 volumio volumio[1259]: info:
Feb 22 16:55:47 volumio volumio[1259]: ---------------------------- USB Audio Device Detached
Feb 22 16:55:47 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach
Feb 22 16:55:47 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 22 16:55:47 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: raat , onStop
Feb 22 16:55:48 volumio mpd[10621]: 2026-02-22T16:55:48 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Feb 22 16:55:48 volumio systemd[1]: Started mpd.service - Music Player Daemon.
Feb 22 16:55:48 volumio sudo[10595]: pam_unix(sudo:session): session closed for user root
Feb 22 16:55:48 volumio volumio[1259]: error: updateQueue error: null
Feb 22 16:55:49 volumio volumio[1259]: info: TidalConnect service stoped!
Feb 22 16:55:49 volumio kernel: usb 1-1.4: new high-speed USB device number 7 using xhci_hcd
Feb 22 16:55:49 volumio volumio[1259]: info: TidalConnect service stoped!
Feb 22 16:55:49 volumio volumio[1259]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Feb 22 16:55:49 volumio volumio[1259]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Feb 22 16:55:49 volumio sudo[10656]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Feb 22 16:55:49 volumio sudo[10656]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 16:55:49 volumio kernel: usb 1-1.4: New USB device found, idVendor=152a, idProduct=8750, bcdDevice= 1.06
Feb 22 16:55:49 volumio kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=3, SerialNumber=2
Feb 22 16:55:49 volumio kernel: usb 1-1.4: Product: E50
Feb 22 16:55:49 volumio kernel: usb 1-1.4: Manufacturer: Topping
Feb 22 16:55:49 volumio kernel: hid-generic 0003:152A:8750.0003: hiddev97,hidraw1: USB HID v1.10 Device [Topping E50] on usb-0000:01:00.0-1.4/input3
Feb 22 16:55:49 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service.
Feb 22 16:55:49 volumio sudo[10656]: pam_unix(sudo:session): session closed for user root
Feb 22 16:55:49 volumio volumio[1259]: info:
Feb 22 16:55:49 volumio volumio[1259]: ---------------------------- USB Audio Device Attached
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::Close All Modals sent
Feb 22 16:55:49 volumio volumio[1259]: info: Preparing to save Alsa Options, stopping services first
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::volumioGetState
Feb 22 16:55:49 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::volumioPause
Feb 22 16:55:49 volumio volumio[1259]: info: CoreStateMachine::pause
Feb 22 16:55:49 volumio volumio[1259]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"E50","alsacard":"E50"},"i2s":false}
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 22 16:55:49 volumio volumio[1259]: info: Device 5 does not have any Mixer Control Available
Feb 22 16:55:49 volumio sudo[10679]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Feb 22 16:55:49 volumio sudo[10679]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Feb 22 16:55:49 volumio volumio[1259]: info: Updating Volume Controller Parameters: Device: 5 Name: E50 Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Feb 22 16:55:49 volumio volumio[1259]: info: Disabling external Volume Control
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 22 16:55:49 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service...
Feb 22 16:55:49 volumio volumio[1259]: info: CoreStateMachine::pushState
Feb 22 16:55:49 volumio volumio[1259]: info: CorePlayQueue::getTrack 9
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::volumioPushState
Feb 22 16:55:49 volumio systemd[1]: vtcs.service: Deactivated successfully.
Feb 22 16:55:49 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service.
Feb 22 16:55:49 volumio volumio[1259]: info: Preparing to generate the ALSA configuration file
Feb 22 16:55:49 volumio sudo[10679]: pam_unix(sudo:session): session closed for user root
Feb 22 16:55:49 volumio volumio[1259]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf
Feb 22 16:55:49 volumio volumio[1259]: info: Reading ALSA contributions from plugins.
Feb 22 16:55:49 volumio volumio[1259]: info: peppy_screensaver: pushState - status=pause service=mpd volatile=false
Feb 22 16:55:49 volumio volumio[1259]: info: peppy_screensaver: Starting persist timer - 30s
Feb 22 16:55:49 volumio sudo[10689]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Feb 22 16:55:49 volumio sudo[10689]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 16:55:49 volumio volumio[1259]: info: TidalConnect service stoped!
Feb 22 16:55:49 volumio volumio[1259]: info: TidalConnect service stoped!
Feb 22 16:55:49 volumio volumio[1259]: info: Executing endpoint tc_getconfig
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig
Feb 22 16:55:49 volumio sudo[10689]: pam_unix(sudo:session): session closed for user root
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Feb 22 16:55:49 volumio volumio[1259]: info: Asound.conf file unchanged, so no further update is needed
Feb 22 16:55:49 volumio volumio[1259]: info: Output device has changed, restarting MPD
Feb 22 16:55:49 volumio volumio[1259]: info: Output device has changed, restarting Shairport Sync
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 22 16:55:49 volumio sudo[10710]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 22 16:55:49 volumio sudo[10708]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 22 16:55:49 volumio sudo[10710]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 16:55:49 volumio sudo[10708]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 16:55:49 volumio sudo[10708]: pam_unix(sudo:session): session closed for user root
Feb 22 16:55:49 volumio volumio[1259]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 22 16:55:49 volumio systemd[1]: Stopping mpd.service - Music Player Daemon...
Feb 22 16:55:49 volumio volumio[1259]: info: MPD Permissions set
Feb 22 16:55:49 volumio volumio[1259]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Feb 22 16:55:49 volumio volumio[1259]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 16:55:49 volumio sudo[10719]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Feb 22 16:55:49 volumio sudo[10719]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 16:55:49 volumio sudo[10720]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Feb 22 16:55:49 volumio sudo[10720]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 22 16:55:49 volumio volumio[1259]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 16:55:49 volumio systemd[1]: mpd.service: Deactivated successfully.
Feb 22 16:55:49 volumio systemd[1]: Stopped mpd.service - Music Player Daemon.
Feb 22 16:55:49 volumio systemd[1]: mpd.service: Consumed 2.145s CPU time.
Feb 22 16:55:49 volumio systemd[1]: mpd.socket: Deactivated successfully.
Feb 22 16:55:49 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Feb 22 16:55:49 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Feb 22 16:55:49 volumio volumio[1259]: info: Starting Shairport Sync
Feb 22 16:55:49 volumio sudo[10729]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Feb 22 16:55:49 volumio sudo[10729]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 16:55:49 volumio sudo[10732]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 22 16:55:49 volumio sudo[10732]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 16:55:49 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Feb 22 16:55:49 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
Feb 22 16:55:49 volumio sudo[10719]: pam_unix(sudo:session): session closed for user root
Feb 22 16:55:49 volumio volumio[1259]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 22 16:55:49 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Feb 22 16:55:49 volumio sudo[10720]: pam_unix(sudo:session): session closed for user root
Feb 22 16:55:49 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service.
Feb 22 16:55:49 volumio systemd[1]: shairport-sync.service: Deactivated successfully.
Feb 22 16:55:49 volumio sudo[10729]: pam_unix(sudo:session): session closed for user root
Feb 22 16:55:49 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 22 16:55:49 volumio systemd[1]: shairport-sync.service: Consumed 1.596s CPU time.
Feb 22 16:55:49 volumio volumio[1259]: Error: Command failed: /usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3
Feb 22 16:55:49 volumio volumio[1259]: Job for vtcs.service canceled.
Feb 22 16:55:49 volumio volumio[1259]: at ChildProcess.exithandler (node:child_process:421:12)
Feb 22 16:55:49 volumio volumio[1259]: at ChildProcess.emit (node:events:514:28)
Feb 22 16:55:49 volumio volumio[1259]: at maybeClose (node:internal/child_process:1105:16)
Feb 22 16:55:49 volumio volumio[1259]: at ChildProcess._handle.onexit (node:internal/child_process:305:5) {
Feb 22 16:55:49 volumio volumio[1259]: code: 1,
Feb 22 16:55:49 volumio volumio[1259]: killed: false,
Feb 22 16:55:49 volumio volumio[1259]: signal: null,
Feb 22 16:55:49 volumio volumio[1259]: cmd: '/usr/bin/sudo /bin/systemctl stop vtcs.service && sleep 3',
Feb 22 16:55:49 volumio volumio[1259]: stdout: '',
Feb 22 16:55:49 volumio volumio[1259]: stderr: 'Job for vtcs.service canceled.\n'
Feb 22 16:55:49 volumio volumio[1259]: }
Feb 22 16:55:49 volumio volumio[1259]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 22 16:55:49 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 22 16:55:49 volumio sudo[10732]: pam_unix(sudo:session): session closed for user root
Feb 22 16:55:49 volumio sudo[10735]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 22 16:55:49 volumio sudo[10735]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 22 16:55:50 volumio sudo[10735]: pam_unix(sudo:session): session closed for user root
Feb 22 16:55:50 volumio sudo[10771]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-22 16:54'
Feb 22 16:55:50 volumio sudo[10771]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
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="a78d359cf1dc63ac74e9d151015afd30d31a709a"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026"
VOLUMIO_VERSION="4.096"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"