Apr 03 11:37:12 volumio go-librespot[2142]: time="2026-04-03T11:37:12-05:00" level=trace msg="sent dealer ping" Apr 03 11:37:12 volumio go-librespot[2142]: time="2026-04-03T11:37:12-05:00" level=trace msg="received dealer pong" Apr 03 11:37:42 volumio go-librespot[2142]: time="2026-04-03T11:37:42-05:00" level=trace msg="sent dealer ping" Apr 03 11:37:43 volumio go-librespot[2142]: time="2026-04-03T11:37:43-05:00" level=trace msg="received dealer pong" Apr 03 11:38:04 volumio volumio[1504]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: unknown Engine version: 4 Transport: websocket Total Clients: 10 Apr 03 11:38:04 volumio volumio[1504]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: unknown Engine version: 4 Transport: websocket Total Clients: 10 Apr 03 11:38:04 volumio volumio[1504]: info: CoreCommandRouter::volumioGetState Apr 03 11:38:04 volumio volumio[1504]: info: CorePlayQueue::getTrack 1132 Apr 03 11:38:04 volumio volumio[1504]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 03 11:38:04 volumio volumio[1504]: info: CoreCommandRouter::volumioGetQueue Apr 03 11:38:04 volumio volumio[1504]: info: CoreStateMachine::getQueue Apr 03 11:38:04 volumio volumio[1504]: info: CorePlayQueue::getQueue Apr 03 11:38:11 volumio go-librespot[2142]: time="2026-04-03T11:38:11-05:00" level=trace msg="received accesspoint ping" Apr 03 11:38:11 volumio go-librespot[2142]: time="2026-04-03T11:38:11-05:00" level=trace msg="received accesspoint pong ack" Apr 03 11:38:12 volumio go-librespot[2142]: time="2026-04-03T11:38:12-05:00" level=trace msg="sent dealer ping" Apr 03 11:38:12 volumio go-librespot[2142]: time="2026-04-03T11:38:12-05:00" level=trace msg="received dealer pong" Apr 03 11:38:18 volumio volumio[1504]: info: CorePlayQueue::getQueue Apr 03 11:38:18 volumio volumio[1504]: info: CorePlayQueue::getTrack 1132 Apr 03 11:38:18 volumio volumio[1504]: info: [1775234298585] ControllerPandora::ExpireOldTracks::reaper Apr 03 11:38:18 volumio volumio[1504]: info: [1775234298585] [Pandora] ExpireOldTracks::reaper: No victims found: Expiring zero tracks. Don't worry -- Jason will return. Apr 03 11:38:39 volumio volumio[1504]: info: peppy_screensaver: Start PeppyMeter Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::volumioNext Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::next Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::stop Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::stPlaybackTimer Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::updateTrackBlock Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrackBlock Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::pushState Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 1132 Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::volumioPushState Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::serviceStop Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 1132 Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::serviceStop Apr 03 11:38:41 volumio volumio[1504]: info: ControllerMpd::stop Apr 03 11:38:41 volumio volumio[1504]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 11:38:41 volumio volumio[1504]: info: peppy_screensaver: pushState - status=stop service=mpd volatile=false Apr 03 11:38:41 volumio volumio[1504]: info: FusionDsp - Volumio is not playing Apr 03 11:38:41 volumio volumio[1504]: info: FusionDsp - Clipped samples monitor stopped Apr 03 11:38:41 volumio volumio[1504]: SPOTIFY: RECEIVED VOLUMIO VOLUME 41 Apr 03 11:38:41 volumio volumio[1504]: info: sendMpdCommand stop took 18 milliseconds Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::play index undefined Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 2667 Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::startPlaybackTimer Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 2667 Apr 03 11:38:41 volumio volumio[1504]: verbose: ControllerMpd::clearAddPlayTracks USB/Music/The Union Underground/…An Education in Rebellion/02. Drivel.flac Apr 03 11:38:41 volumio volumio[1504]: verbose: ControllerMpd::sendMpdCommand stop Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::updateTrackBlock Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrackBlock Apr 03 11:38:41 volumio volumio[1504]: info: ControllerMpd::getState Apr 03 11:38:41 volumio volumio[1504]: verbose: ControllerMpd::sendMpdCommand status Apr 03 11:38:41 volumio volumio[1504]: info: Apr 03 11:38:41 volumio volumio[1504]: ---------------------------- MPD announces state update: player Apr 03 11:38:41 volumio volumio[1504]: info: ControllerMpd::getState Apr 03 11:38:41 volumio volumio[1504]: verbose: ControllerMpd::sendMpdCommand status Apr 03 11:38:41 volumio volumio[1504]: info: sendMpdCommand stop took 1 milliseconds Apr 03 11:38:41 volumio volumio[1504]: verbose: ControllerMpd::sendMpdCommand clear Apr 03 11:38:41 volumio volumio[1504]: info: Apr 03 11:38:41 volumio volumio[1504]: ---------------------------- MPD announces state update: player Apr 03 11:38:41 volumio volumio[1504]: info: ControllerMpd::getState Apr 03 11:38:41 volumio volumio[1504]: verbose: ControllerMpd::sendMpdCommand status Apr 03 11:38:41 volumio volumio[1504]: info: Apr 03 11:38:41 volumio volumio[1504]: ---------------------------- MPD announces state update: player Apr 03 11:38:41 volumio volumio[1504]: info: ControllerMpd::getState Apr 03 11:38:41 volumio volumio[1504]: verbose: ControllerMpd::sendMpdCommand status Apr 03 11:38:41 volumio volumio[1504]: info: Apr 03 11:38:41 volumio volumio[1504]: ---------------------------- MPD announces state update: player Apr 03 11:38:41 volumio volumio[1504]: info: ControllerMpd::getState Apr 03 11:38:41 volumio volumio[1504]: verbose: ControllerMpd::sendMpdCommand status Apr 03 11:38:41 volumio volumio[1504]: info: Apr 03 11:38:41 volumio volumio[1504]: ---------------------------- MPD announces state update: player Apr 03 11:38:41 volumio volumio[1504]: info: ControllerMpd::getState Apr 03 11:38:41 volumio volumio[1504]: verbose: ControllerMpd::sendMpdCommand status Apr 03 11:38:41 volumio volumio[1504]: info: Apr 03 11:38:41 volumio volumio[1504]: ---------------------------- MPD announces state update: player Apr 03 11:38:41 volumio volumio[1504]: info: ControllerMpd::getState Apr 03 11:38:41 volumio volumio[1504]: verbose: ControllerMpd::sendMpdCommand status Apr 03 11:38:41 volumio volumio[1504]: info: Apr 03 11:38:41 volumio volumio[1504]: ---------------------------- MPD announces state update: player Apr 03 11:38:41 volumio volumio[1504]: info: ControllerMpd::getState Apr 03 11:38:41 volumio volumio[1504]: verbose: ControllerMpd::sendMpdCommand status Apr 03 11:38:41 volumio volumio[1504]: info: Apr 03 11:38:41 volumio volumio[1504]: ---------------------------- MPD announces system playlist update Apr 03 11:38:41 volumio volumio[1504]: info: Ignoring MPD Status Update Apr 03 11:38:41 volumio volumio[1504]: info: sendMpdCommand status took 5 milliseconds Apr 03 11:38:41 volumio volumio[1504]: info: sendMpdCommand status took 5 milliseconds Apr 03 11:38:41 volumio volumio[1504]: info: sendMpdCommand clear took 4 milliseconds Apr 03 11:38:41 volumio volumio[1504]: info: sendMpdCommand status took 4 milliseconds Apr 03 11:38:41 volumio volumio[1504]: info: sendMpdCommand status took 4 milliseconds Apr 03 11:38:41 volumio volumio[1504]: info: sendMpdCommand status took 2 milliseconds Apr 03 11:38:41 volumio volumio[1504]: info: sendMpdCommand status took 1 milliseconds Apr 03 11:38:41 volumio volumio[1504]: info: sendMpdCommand status took 2 milliseconds Apr 03 11:38:41 volumio volumio[1504]: info: sendMpdCommand status took 2 milliseconds Apr 03 11:38:41 volumio volumio[1504]: verbose: ControllerMpd::parseState Apr 03 11:38:41 volumio volumio[1504]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 11:38:41 volumio volumio[1504]: verbose: ControllerMpd::parseState Apr 03 11:38:41 volumio volumio[1504]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 03 11:38:41 volumio volumio[1504]: verbose: ControllerMpd::sendMpdCommand add "USB/Music/The Union Underground/…An Education in Rebellion/02. Drivel.flac" Apr 03 11:38:41 volumio volumio[1504]: verbose: ControllerMpd::parseState Apr 03 11:38:41 volumio volumio[1504]: verbose: ControllerMpd::parseState Apr 03 11:38:41 volumio volumio[1504]: verbose: ControllerMpd::parseState Apr 03 11:38:41 volumio volumio[1504]: verbose: ControllerMpd::parseState Apr 03 11:38:41 volumio volumio[1504]: verbose: ControllerMpd::parseState Apr 03 11:38:41 volumio volumio[1504]: verbose: ControllerMpd::parseState Apr 03 11:38:41 volumio volumio[1504]: info: ControllerMpd::pushState Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::servicePushState Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::pushState Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 2667 Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::volumioPushState Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 2667 Apr 03 11:38:41 volumio volumio[1504]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 03 11:38:41 volumio volumio[1504]: verbose: CURRENT POSITION 2667 Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::syncState stateService stop Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::syncState currentStatus stop Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::pushState Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 2667 Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::volumioPushState Apr 03 11:38:41 volumio volumio[1504]: info: No code Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::pushState Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 2667 Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::volumioPushState Apr 03 11:38:41 volumio volumio[1504]: info: ControllerMpd::pushState Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::servicePushState Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::pushState Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 2667 Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::volumioPushState Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 2667 Apr 03 11:38:41 volumio volumio[1504]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 03 11:38:41 volumio volumio[1504]: verbose: CURRENT POSITION 2667 Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::syncState stateService stop Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::syncState currentStatus stop Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::pushState Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 2667 Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::volumioPushState Apr 03 11:38:41 volumio volumio[1504]: info: No code Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::pushState Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 2667 Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::volumioPushState Apr 03 11:38:41 volumio volumio[1504]: info: ControllerMpd::pushState Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::servicePushState Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::pushState Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 2667 Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::volumioPushState Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 2667 Apr 03 11:38:41 volumio volumio[1504]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 03 11:38:41 volumio volumio[1504]: verbose: CURRENT POSITION 2667 Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::syncState stateService stop Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::syncState currentStatus stop Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::pushState Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 2667 Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::volumioPushState Apr 03 11:38:41 volumio volumio[1504]: info: No code Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::pushState Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 2667 Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::volumioPushState Apr 03 11:38:41 volumio volumio[1504]: info: ControllerMpd::pushState Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::servicePushState Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::pushState Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 2667 Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::volumioPushState Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 2667 Apr 03 11:38:41 volumio volumio[1504]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 03 11:38:41 volumio volumio[1504]: verbose: CURRENT POSITION 2667 Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::syncState stateService stop Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::syncState currentStatus stop Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::pushState Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 2667 Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::volumioPushState Apr 03 11:38:41 volumio volumio[1504]: info: No code Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::pushState Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 2667 Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::volumioPushState Apr 03 11:38:41 volumio volumio[1504]: info: ControllerMpd::pushState Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::servicePushState Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::pushState Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 2667 Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::volumioPushState Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 2667 Apr 03 11:38:41 volumio volumio[1504]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 03 11:38:41 volumio volumio[1504]: verbose: CURRENT POSITION 2667 Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::syncState stateService stop Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::syncState currentStatus stop Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::pushState Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 2667 Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::volumioPushState Apr 03 11:38:41 volumio volumio[1504]: info: No code Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::pushState Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 2667 Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::volumioPushState Apr 03 11:38:41 volumio volumio[1504]: info: ControllerMpd::pushState Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::servicePushState Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::pushState Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 2667 Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::volumioPushState Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 2667 Apr 03 11:38:41 volumio volumio[1504]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 03 11:38:41 volumio volumio[1504]: verbose: CURRENT POSITION 2667 Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::syncState stateService stop Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::syncState currentStatus stop Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::pushState Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 2667 Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::volumioPushState Apr 03 11:38:41 volumio volumio[1504]: info: No code Apr 03 11:38:41 volumio volumio[1504]: info: CoreStateMachine::pushState Apr 03 11:38:41 volumio volumio[1504]: info: CorePlayQueue::getTrack 2667 Apr 03 11:38:41 volumio volumio[1504]: info: CoreCommandRouter::volumioPushState Apr 03 11:38:41 volumio volumio[1504]: info: ------------------------------ 39ms Apr 03 11:38:41 volumio volumio[1504]: info: ------------------------------ 40ms Apr 03 11:38:41 volumio volumio[1504]: info: ------------------------------ 40ms Apr 03 11:38:41 volumio volumio[1504]: info: ------------------------------ 38ms Apr 03 11:38:41 volumio volumio[1504]: info: ------------------------------ 39ms Apr 03 11:38:41 volumio volumio[1504]: info: ------------------------------ 39ms Apr 03 11:38:41 volumio volumio[1504]: info: Apr 03 11:38:41 volumio volumio[1504]: ---------------------------- MPD announces system playlist update Apr 03 11:38:41 volumio volumio[1504]: info: Ignoring MPD Status Update Apr 03 11:38:41 volumio volumio[1504]: info: Apr 03 11:38:41 volumio volumio[1504]: ---------------------------- MPD announces system playlist update Apr 03 11:38:41 volumio volumio[1504]: info: Ignoring MPD Status Update Apr 03 11:38:41 volumio volumio[1504]: info: Apr 03 11:38:41 volumio volumio[1504]: ---------------------------- MPD announces system playlist update Apr 03 11:38:41 volumio volumio[1504]: info: Ignoring MPD Status Update Apr 03 11:38:41 volumio volumio[1504]: info: Apr 03 11:38:41 volumio volumio[1504]: ---------------------------- MPD announces system playlist update Apr 03 11:38:41 volumio volumio[1504]: info: Ignoring MPD Status Update Apr 03 11:38:41 volumio volumio[1504]: info: Apr 03 11:38:41 volumio volumio[1504]: ---------------------------- MPD announces system playlist update Apr 03 11:38:41 volumio volumio[1504]: info: Ignoring MPD Status Update Apr 03 11:38:41 volumio volumio[1504]: info: Apr 03 11:38:41 volumio volumio[1504]: ---------------------------- MPD announces system playlist update Apr 03 11:38:41 volumio volumio[1504]: info: Ignoring MPD Status Update Apr 03 11:38:41 volumio volumio[1504]: info: touch_display: Setting screensaver timeout to 30 seconds. Apr 03 11:38:41 volumio volumio[1504]: error: updateQueue error: null Apr 03 11:38:41 volumio volumio[1504]: info: Apr 03 11:38:41 volumio volumio[1504]: ---------------------------- MPD announces system playlist update Apr 03 11:38:41 volumio volumio[1504]: info: Ignoring MPD Status Update Apr 03 11:38:41 volumio volumio[1504]: info: ------------------------------ 42ms Apr 03 11:38:41 volumio volumio[1504]: info: sendMpdCommand playlistinfo took 41 milliseconds Apr 03 11:38:41 volumio volumio[1504]: info: sendMpdCommand playlistinfo took 41 milliseconds Apr 03 11:38:41 volumio volumio[1504]: info: sendMpdCommand add "USB/Music/The Union Underground/…An Education in Rebellion/02. Drivel.flac" took 41 milliseconds Apr 03 11:38:41 volumio volumio[1504]: info: ------------------------------ 5ms Apr 03 11:38:41 volumio volumio[1504]: info: ------------------------------ 3ms Apr 03 11:38:41 volumio volumio[1504]: info: ------------------------------ 3ms Apr 03 11:38:41 volumio volumio[1504]: info: ------------------------------ 3ms Apr 03 11:38:41 volumio volumio[1504]: info: ------------------------------ 3ms Apr 03 11:38:41 volumio volumio[1504]: info: ------------------------------ 2ms Apr 03 11:38:41 volumio volumio[1504]: verbose: ControllerMpd::parseTrackInfo Apr 03 11:38:41 volumio volumio[1504]: verbose: ControllerMpd::parseTrackInfo Apr 03 11:38:41 volumio volumio[1504]: verbose: ControllerMpd::sendMpdCommand play Apr 03 11:38:41 volumio volumio[1504]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Apr 03 11:38:41 volumio volumio[1504]: info: ------------------------------ 49ms Apr 03 11:38:41 volumio volumio[1504]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 03 11:38:41 volumio volumio[1504]: TypeError: Cannot read properties of undefined (reading 'split') Apr 03 11:38:41 volumio volumio[1504]: at Promise._successFn (/volumio/app/plugins/music_service/mpd/index.js:280:60) Apr 03 11:38:41 volumio volumio[1504]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 03 11:38:41 volumio volumio[1504]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Apr 03 11:38:41 volumio volumio[1504]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 03 11:38:41 volumio sudo[7771]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-03 11:37' Apr 03 11:38:41 volumio sudo[7771]: 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="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"