Feb 10 12:27:04 volumio go-librespot[1490]: time="2026-02-10T12:27:04+09:00" level=trace msg="received accesspoint ping" Feb 10 12:27:04 volumio go-librespot[1490]: time="2026-02-10T12:27:04+09:00" level=trace msg="received accesspoint pong ack" Feb 10 12:27:09 volumio go-librespot[1490]: time="2026-02-10T12:27:09+09:00" level=trace msg="sent dealer ping" Feb 10 12:27:09 volumio go-librespot[1490]: time="2026-02-10T12:27:09+09:00" level=trace msg="received dealer pong" Feb 10 12:27:39 volumio go-librespot[1490]: time="2026-02-10T12:27:39+09:00" level=trace msg="sent dealer ping" Feb 10 12:27:39 volumio go-librespot[1490]: time="2026-02-10T12:27:39+09:00" level=trace msg="received dealer pong" Feb 10 12:27:51 volumio nmbd[1101]: [2026/02/10 12:27:51.749331, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Feb 10 12:27:51 volumio nmbd[1101]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.10.38 for name WORKGROUP<1d>. Feb 10 12:27:51 volumio nmbd[1101]: This response was from IP 192.168.10.212, reporting an IP address of 192.168.10.212. Feb 10 12:28:09 volumio go-librespot[1490]: time="2026-02-10T12:28:09+09:00" level=trace msg="sent dealer ping" Feb 10 12:28:09 volumio go-librespot[1490]: time="2026-02-10T12:28:09+09:00" level=trace msg="received dealer pong" Feb 10 12:28:19 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.10.38 from 192.168.10.5 UA: Mozilla/5.0 (Linux; Android 15; SM-F926N Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.109 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Feb 10 12:28:19 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 10 12:28:19 volumio volumio[1138]: info: CoreCommandRouter::volumioGetVisibleSources Feb 10 12:28:19 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 10 12:28:19 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Feb 10 12:28:19 volumio volumio[1138]: info: CorePlayQueue::getTrack 1 Feb 10 12:28:19 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 10 12:28:19 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 10 12:28:19 volumio volumio[1138]: info: Received Get System Info Feb 10 12:28:19 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 10 12:28:19 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 10 12:28:19 volumio volumio[1138]: info: Discovery: Getting this device information Feb 10 12:28:19 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Feb 10 12:28:19 volumio volumio[1138]: info: CorePlayQueue::getTrack 1 Feb 10 12:28:19 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 10 12:28:19 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Feb 10 12:28:19 volumio volumio[1138]: info: CorePlayQueue::getTrack 1 Feb 10 12:28:19 volumio volumio[1138]: info: Listing playlists Feb 10 12:28:19 volumio volumio[1138]: info: CoreCommandRouter::volumioGetQueue Feb 10 12:28:19 volumio volumio[1138]: info: CoreStateMachine::getQueue Feb 10 12:28:19 volumio volumio[1138]: info: CorePlayQueue::getQueue Feb 10 12:28:19 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 10 12:28:25 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 10 12:28:25 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 10 12:28:25 volumio volumio[1138]: info: Discovery: Getting this device information Feb 10 12:28:25 volumio volumio[1138]: info: CoreCommandRouter::volumioGetState Feb 10 12:28:25 volumio volumio[1138]: info: CorePlayQueue::getTrack 1 Feb 10 12:28:25 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 10 12:28:25 volumio volumio[1138]: verbose: New Socket.io Connection to 192.168.10.38:3000 from 192.168.10.5 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Feb 10 12:28:25 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 10 12:28:25 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::ClearQueue Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::stop Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::stPlaybackTimer Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::updateTrackBlock Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrackBlock Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 1 Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::volumioPushState Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::serviceStop Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 1 Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::serviceStop Feb 10 12:28:27 volumio volumio[1138]: info: ControllerMpd::stop Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::sendMpdCommand stop Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::clearPlayQueue Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::saveQueue Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::volumioPushQueue Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::addQueueItems Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::addQueueItems Feb 10 12:28:27 volumio volumio[1138]: info: Preload queue cleared Feb 10 12:28:27 volumio volumio[1138]: info: Adding Item to queue: music-library/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192] Feb 10 12:28:27 volumio volumio[1138]: info: Exploding uri music-library/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192] in service mpd Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.654+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.654+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" id="mnt/NAS/FLAC/Jazz/Fourplay - Elixir/02 - Dream Come True.flac" title="2 - Dream Come True" Feb 10 12:28:27 volumio volumio[1138]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 12:28:27 volumio volumio[1138]: info: Feb 10 12:28:27 volumio volumio[1138]: ---------------------------- MPD announces state update: player Feb 10 12:28:27 volumio volumio[1138]: info: sendMpdCommand stop took 30 milliseconds Feb 10 12:28:27 volumio volumio[1138]: info: ControllerMpd::getState Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::sendMpdCommand status Feb 10 12:28:27 volumio volumio[1138]: info: Feb 10 12:28:27 volumio volumio[1138]: ---------------------------- MPD announces state update: player Feb 10 12:28:27 volumio volumio[1138]: info: ControllerMpd::getState Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::sendMpdCommand status Feb 10 12:28:27 volumio volumio[1138]: info: Feb 10 12:28:27 volumio volumio[1138]: ---------------------------- MPD announces state update: player Feb 10 12:28:27 volumio volumio[1138]: info: ControllerMpd::getState Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::sendMpdCommand status Feb 10 12:28:27 volumio volumio[1138]: info: ALBUMART /albumart?cacheid=271&web=Freddie%20Hubbard/Ready%20For%20Freddie/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FFreddie%20Hubbard%20-%20Ready%20For%20Freddie%20(1961)%20%5BHDTracks%2024-192%5D%2F01-Arietis.flac&metadata=false Feb 10 12:28:27 volumio volumio[1138]: info: URI /mnt/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac Feb 10 12:28:27 volumio volumio[1138]: info: ALBUMART /albumart?cacheid=271&web=Freddie%20Hubbard/Ready%20For%20Freddie/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FFreddie%20Hubbard%20-%20Ready%20For%20Freddie%20(1961)%20%5BHDTracks%2024-192%5D%2F02-Weaver%20Of%20Dreams.flac&metadata=false Feb 10 12:28:27 volumio volumio[1138]: info: URI /mnt/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/02-Weaver Of Dreams.flac Feb 10 12:28:27 volumio volumio[1138]: info: ALBUMART /albumart?cacheid=271&web=Freddie%20Hubbard/Ready%20For%20Freddie/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FFreddie%20Hubbard%20-%20Ready%20For%20Freddie%20(1961)%20%5BHDTracks%2024-192%5D%2F03-Marie%20Antoinette.flac&metadata=false Feb 10 12:28:27 volumio volumio[1138]: info: URI /mnt/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/03-Marie Antoinette.flac Feb 10 12:28:27 volumio volumio[1138]: info: ALBUMART /albumart?cacheid=271&web=Freddie%20Hubbard/Ready%20For%20Freddie/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FFreddie%20Hubbard%20-%20Ready%20For%20Freddie%20(1961)%20%5BHDTracks%2024-192%5D%2F04-Birdlike.flac&metadata=false Feb 10 12:28:27 volumio volumio[1138]: info: URI /mnt/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/04-Birdlike.flac Feb 10 12:28:27 volumio volumio[1138]: info: ALBUMART /albumart?cacheid=271&web=Freddie%20Hubbard/Ready%20For%20Freddie/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FFreddie%20Hubbard%20-%20Ready%20For%20Freddie%20(1961)%20%5BHDTracks%2024-192%5D%2F05-Crisis.flac&metadata=false Feb 10 12:28:27 volumio volumio[1138]: info: URI /mnt/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/05-Crisis.flac Feb 10 12:28:27 volumio volumio[1138]: info: sendMpdCommand status took 2 milliseconds Feb 10 12:28:27 volumio volumio[1138]: info: sendMpdCommand status took 2 milliseconds Feb 10 12:28:27 volumio volumio[1138]: info: sendMpdCommand status took 2 milliseconds Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::parseState Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::parseState Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::parseState Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::volumioPushQueue Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::saveQueue Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::updateTrackBlock Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrackBlock Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::volumioPlay Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::play index 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::stop Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::play index undefined Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::startPlaybackTimer Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::clearAddPlayTracks NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::sendMpdCommand stop Feb 10 12:28:27 volumio volumio[1138]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 10 12:28:27 volumio volumio[1138]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 10 12:28:27 volumio volumio[1138]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 10 12:28:27 volumio volumio[1138]: info: sendMpdCommand stop took 0 milliseconds Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::parseTrackInfo Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::parseTrackInfo Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::parseTrackInfo Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::sendMpdCommand clear Feb 10 12:28:27 volumio volumio[1138]: info: ControllerMpd::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::servicePushState Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::volumioPushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: 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":"Dream Come True","artist":"Fourplay","album":"Elixir","uri":"NAS/FLAC/Jazz/Fourplay - Elixir/02 - Dream Come True.flac","trackType":"flac"} Feb 10 12:28:27 volumio volumio[1138]: verbose: CURRENT POSITION 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::syncState stateService stop Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::syncState currentStatus stop Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::volumioPushState Feb 10 12:28:27 volumio volumio[1138]: info: No code Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::volumioPushState Feb 10 12:28:27 volumio volumio[1138]: info: ControllerMpd::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::servicePushState Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::volumioPushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: 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":"Dream Come True","artist":"Fourplay","album":"Elixir","uri":"NAS/FLAC/Jazz/Fourplay - Elixir/02 - Dream Come True.flac","trackType":"flac"} Feb 10 12:28:27 volumio volumio[1138]: verbose: CURRENT POSITION 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::syncState stateService stop Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::syncState currentStatus stop Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::volumioPushState Feb 10 12:28:27 volumio volumio[1138]: info: No code Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::volumioPushState Feb 10 12:28:27 volumio volumio[1138]: info: ControllerMpd::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::servicePushState Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::volumioPushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: 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":"Dream Come True","artist":"Fourplay","album":"Elixir","uri":"NAS/FLAC/Jazz/Fourplay - Elixir/02 - Dream Come True.flac","trackType":"flac"} Feb 10 12:28:27 volumio volumio[1138]: verbose: CURRENT POSITION 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::syncState stateService stop Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::syncState currentStatus stop Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::volumioPushState Feb 10 12:28:27 volumio volumio[1138]: info: No code Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::volumioPushState Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.666+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.666+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.666+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.667+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" id="mnt/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac" title="1 - Arietis" Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.668+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" id="mnt/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac" title="1 - Arietis" Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.667+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.667+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.667+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.667+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.667+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.667+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.667+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" id="mnt/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac" title="1 - Arietis" Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.669+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" id="mnt/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac" title="1 - Arietis" Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.669+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" id="mnt/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac" title="1 - Arietis" Feb 10 12:28:27 volumio volumio[1138]: info: ------------------------------ 12ms Feb 10 12:28:27 volumio volumio[1138]: info: ------------------------------ 12ms Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.669+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" id="mnt/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac" title="1 - Arietis" Feb 10 12:28:27 volumio volumio[1138]: info: ------------------------------ 12ms Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.669+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" id="mnt/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac" title="1 - Arietis" Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.668+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" id="mnt/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac" title="1 - Arietis" Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.669+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" id="mnt/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac" title="1 - Arietis" Feb 10 12:28:27 volumio volumio[1138]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 12:28:27 volumio volumio[1138]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 12:28:27 volumio volumio[1138]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 12:28:27 volumio volumio[1138]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 12:28:27 volumio volumio[1138]: info: Feb 10 12:28:27 volumio volumio[1138]: ---------------------------- MPD announces system playlist update Feb 10 12:28:27 volumio volumio[1138]: info: Ignoring MPD Status Update Feb 10 12:28:27 volumio volumio[1138]: info: sendMpdCommand clear took 11 milliseconds Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::sendMpdCommand add "NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac" Feb 10 12:28:27 volumio volumio[1138]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 12:28:27 volumio volumio[1138]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 12:28:27 volumio volumio[1138]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 12:28:27 volumio volumio[1138]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 12:28:27 volumio volumio[1138]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 12:28:27 volumio volumio[1138]: info: Feb 10 12:28:27 volumio volumio[1138]: ---------------------------- MPD announces system playlist update Feb 10 12:28:27 volumio volumio[1138]: info: Ignoring MPD Status Update Feb 10 12:28:27 volumio volumio[1138]: info: Feb 10 12:28:27 volumio volumio[1138]: ---------------------------- MPD announces system playlist update Feb 10 12:28:27 volumio volumio[1138]: info: Ignoring MPD Status Update Feb 10 12:28:27 volumio volumio[1138]: error: updateQueue error: null Feb 10 12:28:27 volumio volumio[1138]: info: Feb 10 12:28:27 volumio volumio[1138]: ---------------------------- MPD announces system playlist update Feb 10 12:28:27 volumio volumio[1138]: info: Ignoring MPD Status Update Feb 10 12:28:27 volumio volumio[1138]: info: ------------------------------ 2ms Feb 10 12:28:27 volumio volumio[1138]: info: sendMpdCommand add "NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac" took 2 milliseconds Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::sendMpdCommand play Feb 10 12:28:27 volumio volumio[1138]: info: Feb 10 12:28:27 volumio volumio[1138]: ---------------------------- MPD announces system playlist update Feb 10 12:28:27 volumio volumio[1138]: info: Ignoring MPD Status Update Feb 10 12:28:27 volumio volumio[1138]: info: ------------------------------ 2ms Feb 10 12:28:27 volumio volumio[1138]: info: ------------------------------ 2ms Feb 10 12:28:27 volumio volumio[1138]: info: ------------------------------ 2ms Feb 10 12:28:27 volumio volumio[1138]: info: sendMpdCommand play took 2 milliseconds Feb 10 12:28:27 volumio volumio[1138]: info: ------------------------------ 0ms Feb 10 12:28:27 volumio volumio[1138]: info: Feb 10 12:28:27 volumio volumio[1138]: ---------------------------- MPD announces system playlist update Feb 10 12:28:27 volumio volumio[1138]: info: Ignoring MPD Status Update Feb 10 12:28:27 volumio volumio[1138]: info: ------------------------------ 0ms Feb 10 12:28:27 volumio volumio[1138]: info: Feb 10 12:28:27 volumio volumio[1138]: ---------------------------- MPD announces state update: player Feb 10 12:28:27 volumio volumio[1138]: info: ControllerMpd::getState Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::sendMpdCommand status Feb 10 12:28:27 volumio volumio[1138]: info: Feb 10 12:28:27 volumio volumio[1138]: ---------------------------- MPD announces state update: player Feb 10 12:28:27 volumio volumio[1138]: info: ControllerMpd::getState Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::sendMpdCommand status Feb 10 12:28:27 volumio volumio[1138]: info: Feb 10 12:28:27 volumio volumio[1138]: ---------------------------- MPD announces state update: player Feb 10 12:28:27 volumio volumio[1138]: info: ControllerMpd::getState Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::sendMpdCommand status Feb 10 12:28:27 volumio volumio[1138]: info: sendMpdCommand status took 29 milliseconds Feb 10 12:28:27 volumio volumio[1138]: info: sendMpdCommand status took 29 milliseconds Feb 10 12:28:27 volumio volumio[1138]: info: sendMpdCommand status took 28 milliseconds Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::parseState Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::parseState Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::parseState Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 12:28:27 volumio volumio[1138]: info: Feb 10 12:28:27 volumio volumio[1138]: ---------------------------- MPD announces state update: player Feb 10 12:28:27 volumio volumio[1138]: info: ControllerMpd::getState Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::sendMpdCommand status Feb 10 12:28:27 volumio volumio[1138]: info: Feb 10 12:28:27 volumio volumio[1138]: ---------------------------- MPD announces state update: player Feb 10 12:28:27 volumio volumio[1138]: info: ControllerMpd::getState Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::sendMpdCommand status Feb 10 12:28:27 volumio volumio[1138]: info: Feb 10 12:28:27 volumio volumio[1138]: ---------------------------- MPD announces state update: player Feb 10 12:28:27 volumio volumio[1138]: info: ControllerMpd::getState Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::sendMpdCommand status Feb 10 12:28:27 volumio volumio[1138]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 10 12:28:27 volumio volumio[1138]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 10 12:28:27 volumio volumio[1138]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 10 12:28:27 volumio volumio[1138]: info: sendMpdCommand status took 2 milliseconds Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::parseTrackInfo Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::parseTrackInfo Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::parseTrackInfo Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::parseState Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 12:28:27 volumio volumio[1138]: info: ControllerMpd::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::servicePushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":401,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Arietis","artist":"Freddie Hubbard","album":"Ready For Freddie","uri":"NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac","trackType":"flac"} Feb 10 12:28:27 volumio volumio[1138]: verbose: CURRENT POSITION 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::syncState stateService play Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::syncState currentStatus stop Feb 10 12:28:27 volumio volumio[1138]: info: ControllerMpd::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::servicePushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":401,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Arietis","artist":"Freddie Hubbard","album":"Ready For Freddie","uri":"NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac","trackType":"flac"} Feb 10 12:28:27 volumio volumio[1138]: verbose: CURRENT POSITION 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::syncState stateService play Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::syncState currentStatus play Feb 10 12:28:27 volumio volumio[1138]: info: Received an update from plugin. extracting info from payload Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::volumioPushState Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::volumioPushState Feb 10 12:28:27 volumio volumio[1138]: info: ControllerMpd::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::servicePushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":401,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Arietis","artist":"Freddie Hubbard","album":"Ready For Freddie","uri":"NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac","trackType":"flac"} Feb 10 12:28:27 volumio volumio[1138]: verbose: CURRENT POSITION 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::syncState stateService play Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::syncState currentStatus play Feb 10 12:28:27 volumio volumio[1138]: info: Received an update from plugin. extracting info from payload Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::volumioPushState Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::volumioPushState Feb 10 12:28:27 volumio volumio[1138]: info: ------------------------------ 37ms Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.772+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" state=STATUS_PLAYING positionMs=0 volume=100 Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.774+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" id="mnt/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac" title="1 - Arietis" Feb 10 12:28:27 volumio volumio[1138]: info: ------------------------------ 43ms Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.777+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" state=STATUS_PLAYING positionMs=0 volume=100 Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.777+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" id="mnt/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac" title="1 - Arietis" Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.777+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" state=STATUS_PLAYING positionMs=0 volume=100 Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.777+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" id="mnt/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac" title="1 - Arietis" Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.777+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" state=STATUS_PLAYING positionMs=0 volume=100 Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.777+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" id="mnt/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac" title="1 - Arietis" Feb 10 12:28:27 volumio volumio[1138]: info: ------------------------------ 45ms Feb 10 12:28:27 volumio volumio[1138]: info: sendMpdCommand status took 15 milliseconds Feb 10 12:28:27 volumio volumio[1138]: info: sendMpdCommand status took 15 milliseconds Feb 10 12:28:27 volumio volumio[1138]: info: sendMpdCommand playlistinfo took 15 milliseconds Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::parseState Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::parseState Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::parseTrackInfo Feb 10 12:28:27 volumio volumio[1138]: info: ControllerMpd::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::servicePushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":401,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Arietis","artist":"Freddie Hubbard","album":"Ready For Freddie","uri":"NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac","trackType":"flac"} Feb 10 12:28:27 volumio volumio[1138]: verbose: CURRENT POSITION 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::syncState stateService play Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::syncState currentStatus play Feb 10 12:28:27 volumio volumio[1138]: info: Received an update from plugin. extracting info from payload Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::volumioPushState Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::volumioPushState Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.783+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" state=STATUS_PLAYING positionMs=0 volume=100 Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.783+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" id="mnt/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac" title="1 - Arietis" Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.784+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" state=STATUS_PLAYING positionMs=0 volume=100 Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.784+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" id="mnt/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac" title="1 - Arietis" Feb 10 12:28:27 volumio volumio[1138]: info: ------------------------------ 23ms Feb 10 12:28:27 volumio volumio[1138]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 12:28:27 volumio volumio[1138]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 12:28:27 volumio volumio[1138]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 12:28:27 volumio volumio[1138]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 12:28:27 volumio volumio[1138]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 12:28:27 volumio volumio[1138]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 12:28:27 volumio volumio[1138]: info: sendMpdCommand playlistinfo took 14 milliseconds Feb 10 12:28:27 volumio volumio[1138]: info: sendMpdCommand playlistinfo took 15 milliseconds Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::parseTrackInfo Feb 10 12:28:27 volumio volumio[1138]: verbose: ControllerMpd::parseTrackInfo Feb 10 12:28:27 volumio volumio[1138]: info: ControllerMpd::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::servicePushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":401,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Arietis","artist":"Freddie Hubbard","album":"Ready For Freddie","uri":"NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac","trackType":"flac"} Feb 10 12:28:27 volumio volumio[1138]: verbose: CURRENT POSITION 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::syncState stateService play Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::syncState currentStatus play Feb 10 12:28:27 volumio volumio[1138]: info: Received an update from plugin. extracting info from payload Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::volumioPushState Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::volumioPushState Feb 10 12:28:27 volumio volumio[1138]: info: ControllerMpd::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::servicePushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":401,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Arietis","artist":"Freddie Hubbard","album":"Ready For Freddie","uri":"NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac","trackType":"flac"} Feb 10 12:28:27 volumio volumio[1138]: verbose: CURRENT POSITION 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::syncState stateService play Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::syncState currentStatus play Feb 10 12:28:27 volumio volumio[1138]: info: Received an update from plugin. extracting info from payload Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::volumioPushState Feb 10 12:28:27 volumio volumio[1138]: info: CoreStateMachine::pushState Feb 10 12:28:27 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:27 volumio volumio[1138]: info: CoreCommandRouter::volumioPushState Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.801+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" state=STATUS_PLAYING positionMs=0 volume=100 Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.802+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" state=STATUS_PLAYING positionMs=0 volume=100 Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.802+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" state=STATUS_PLAYING positionMs=0 volume=100 Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.802+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" id="mnt/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac" title="1 - Arietis" Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.802+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" id="mnt/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac" title="1 - Arietis" Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.802+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" id="mnt/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac" title="1 - Arietis" Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.802+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" state=STATUS_PLAYING positionMs=0 volume=100 Feb 10 12:28:27 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:27.803+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" id="mnt/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac" title="1 - Arietis" Feb 10 12:28:27 volumio volumio[1138]: info: ------------------------------ 41ms Feb 10 12:28:27 volumio volumio[1138]: info: ------------------------------ 41ms Feb 10 12:28:27 volumio volumio[1138]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 12:28:27 volumio volumio[1138]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 12:28:27 volumio volumio[1138]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 12:28:27 volumio volumio[1138]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 12:28:31 volumio volumio[1138]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 10 12:28:31 volumio volumio[1138]: info: CoreStateMachine::ClearQueue Feb 10 12:28:31 volumio volumio[1138]: info: CoreStateMachine::stop Feb 10 12:28:31 volumio volumio[1138]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 10 12:28:31 volumio volumio[1138]: info: CoreStateMachine::stPlaybackTimer Feb 10 12:28:31 volumio volumio[1138]: info: CoreStateMachine::updateTrackBlock Feb 10 12:28:31 volumio volumio[1138]: info: CorePlayQueue::getTrackBlock Feb 10 12:28:31 volumio volumio[1138]: info: CoreStateMachine::pushState Feb 10 12:28:31 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:31 volumio volumio[1138]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 10 12:28:31 volumio volumio[1138]: info: CoreCommandRouter::volumioPushState Feb 10 12:28:31 volumio volumio[1138]: info: CoreStateMachine::serviceStop Feb 10 12:28:31 volumio volumio[1138]: info: CorePlayQueue::getTrack 0 Feb 10 12:28:31 volumio volumio[1138]: info: CoreCommandRouter::serviceStop Feb 10 12:28:31 volumio volumio[1138]: info: ControllerMpd::stop Feb 10 12:28:31 volumio volumio[1138]: verbose: ControllerMpd::sendMpdCommand stop Feb 10 12:28:31 volumio volumio[1138]: info: CorePlayQueue::clearPlayQueue Feb 10 12:28:31 volumio volumio[1138]: info: CorePlayQueue::saveQueue Feb 10 12:28:31 volumio volumio[1138]: info: CoreCommandRouter::volumioPushQueue Feb 10 12:28:31 volumio volumio[1138]: info: CoreStateMachine::addQueueItems Feb 10 12:28:31 volumio volumio[1138]: info: CorePlayQueue::addQueueItems Feb 10 12:28:31 volumio volumio[1138]: info: Preload queue cleared Feb 10 12:28:31 volumio volumio[1138]: info: Adding Item to queue: music-library/NAS/FLAC/Jazz/Gary Burton, Pat Metheny, Steve Swallow, Antonio Sanchez - Quartet Live (2009) Feb 10 12:28:31 volumio volumio[1138]: info: Exploding uri music-library/NAS/FLAC/Jazz/Gary Burton, Pat Metheny, Steve Swallow, Antonio Sanchez - Quartet Live (2009) in service mpd Feb 10 12:28:31 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:31.524+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" state=STATUS_STOPPED positionMs=0 volume=100 Feb 10 12:28:31 volumio volumio5-onboarding[1412]: time=2026-02-10T12:28:31.524+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.10.5:60772 @ 0xc000302d50" id="mnt/NAS/FLAC/Jazz/Freddie Hubbard - Ready For Freddie (1961) [HDTracks 24-192]/01-Arietis.flac" title="1 - Arietis" Feb 10 12:28:31 volumio volumio[1138]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 10 12:28:31 volumio volumio[1138]: info: ALBUMART /albumart?cacheid=271&web=Gary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez/Quartet%20Live!/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FGary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez%20-%20Quartet%20Live%20(2009)%2F01.%20Sea%20Journey.flac&metadata=false Feb 10 12:28:31 volumio volumio[1138]: info: URI /mnt/NAS/FLAC/Jazz/Gary Burton, Pat Metheny, Steve Swallow, Antonio Sanchez - Quartet Live (2009)/01. Sea Journey.flac Feb 10 12:28:31 volumio volumio[1138]: info: ALBUMART /albumart?cacheid=271&web=Gary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez/Quartet%20Live!/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FGary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez%20-%20Quartet%20Live%20(2009)%2F02.%20Olhos%20de%20gato.flac&metadata=false Feb 10 12:28:31 volumio volumio[1138]: info: URI /mnt/NAS/FLAC/Jazz/Gary Burton, Pat Metheny, Steve Swallow, Antonio Sanchez - Quartet Live (2009)/02. Olhos de gato.flac Feb 10 12:28:31 volumio volumio[1138]: info: ALBUMART /albumart?cacheid=271&web=Gary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez/Quartet%20Live!/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FGary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez%20-%20Quartet%20Live%20(2009)%2F03.%20Falling%20Grace.flac&metadata=false Feb 10 12:28:31 volumio volumio[1138]: info: URI /mnt/NAS/FLAC/Jazz/Gary Burton, Pat Metheny, Steve Swallow, Antonio Sanchez - Quartet Live (2009)/03. Falling Grace.flac Feb 10 12:28:31 volumio volumio[1138]: info: ALBUMART /albumart?cacheid=271&web=Gary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez/Quartet%20Live!/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FGary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez%20-%20Quartet%20Live%20(2009)%2F04.%20Coral.flac&metadata=false Feb 10 12:28:31 volumio volumio[1138]: info: URI /mnt/NAS/FLAC/Jazz/Gary Burton, Pat Metheny, Steve Swallow, Antonio Sanchez - Quartet Live (2009)/04. Coral.flac Feb 10 12:28:31 volumio volumio[1138]: info: ALBUMART /albumart?cacheid=271&web=Gary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez/Quartet%20Live!/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FGary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez%20-%20Quartet%20Live%20(2009)%2F05.%20Walter%20L.flac&metadata=false Feb 10 12:28:31 volumio volumio[1138]: info: URI /mnt/NAS/FLAC/Jazz/Gary Burton, Pat Metheny, Steve Swallow, Antonio Sanchez - Quartet Live (2009)/05. Walter L.flac Feb 10 12:28:31 volumio volumio[1138]: info: ALBUMART /albumart?cacheid=271&web=Gary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez/Quartet%20Live!/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FGary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez%20-%20Quartet%20Live%20(2009)%2F06.%20B%20and%20G%20(Midwestern%20Night's%20Dream).flac&metadata=false Feb 10 12:28:31 volumio volumio[1138]: info: URI /mnt/NAS/FLAC/Jazz/Gary Burton, Pat Metheny, Steve Swallow, Antonio Sanchez - Quartet Live (2009)/06. B and G (Midwestern Night's Dream).flac Feb 10 12:28:31 volumio volumio[1138]: info: ALBUMART /albumart?cacheid=271&web=Gary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez/Quartet%20Live!/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FGary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez%20-%20Quartet%20Live%20(2009)%2F07.%20Missouri%20Uncompromised.flac&metadata=false Feb 10 12:28:31 volumio volumio[1138]: info: URI /mnt/NAS/FLAC/Jazz/Gary Burton, Pat Metheny, Steve Swallow, Antonio Sanchez - Quartet Live (2009)/07. Missouri Uncompromised.flac Feb 10 12:28:31 volumio volumio[1138]: info: ALBUMART /albumart?cacheid=271&web=Gary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez/Quartet%20Live!/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FGary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez%20-%20Quartet%20Live%20(2009)%2F08.%20Fleurette%20Africaine%20(Little%20African%20Flower).flac&metadata=false Feb 10 12:28:31 volumio volumio[1138]: info: URI /mnt/NAS/FLAC/Jazz/Gary Burton, Pat Metheny, Steve Swallow, Antonio Sanchez - Quartet Live (2009)/08. Fleurette Africaine (Little African Flower).flac Feb 10 12:28:31 volumio volumio[1138]: info: ALBUMART /albumart?cacheid=271&web=Gary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez/Quartet%20Live!/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FGary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez%20-%20Quartet%20Live%20(2009)%2F09.%20Hullo%2C%20Bolinas.flac&metadata=false Feb 10 12:28:31 volumio volumio[1138]: info: URI /mnt/NAS/FLAC/Jazz/Gary Burton, Pat Metheny, Steve Swallow, Antonio Sanchez - Quartet Live (2009)/09. Hullo, Bolinas.flac Feb 10 12:28:31 volumio volumio[1138]: info: ALBUMART /albumart?cacheid=271&web=Gary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez/Quartet%20Live!/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FGary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez%20-%20Quartet%20Live%20(2009)%2F10.%20Syndrome.flac&metadata=false Feb 10 12:28:31 volumio volumio[1138]: info: URI /mnt/NAS/FLAC/Jazz/Gary Burton, Pat Metheny, Steve Swallow, Antonio Sanchez - Quartet Live (2009)/10. Syndrome.flac Feb 10 12:28:31 volumio volumio[1138]: info: ALBUMART /albumart?cacheid=271&web=Gary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez/Quartet%20Live!/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FGary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez%20-%20Quartet%20Live%20(2009)%2F11.%20Question%20and%20Answer.flac&metadata=false Feb 10 12:28:31 volumio volumio[1138]: info: URI /mnt/NAS/FLAC/Jazz/Gary Burton, Pat Metheny, Steve Swallow, Antonio Sanchez - Quartet Live (2009)/11. Question and Answer.flac Feb 10 12:28:31 volumio volumio[1138]: info: ALBUMART /albumart?cacheid=271&web=Gary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez/Quartet%20Live!/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FGary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez%20-%20Quartet%20Live%20(2009)%2FGary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez%20-%20Quartet%20Live.cue&metadata=false Feb 10 12:28:31 volumio volumio[1138]: info: URI /mnt/NAS/FLAC/Jazz/Gary Burton, Pat Metheny, Steve Swallow, Antonio Sanchez - Quartet Live (2009)/Gary Burton, Pat Metheny, Steve Swallow, Antonio Sanchez - Quartet Live.cue Feb 10 12:28:31 volumio volumio[1138]: info: ALBUMART /albumart?cacheid=271&web=Gary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez/Quartet%20Live!/medium&path=%2Fmnt%2FNAS%2FFLAC%2FJazz%2FGary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez%20-%20Quartet%20Live%20(2009)%2FGary%20Burton%2C%20Pat%20Metheny%2C%20Steve%20Swallow%2C%20Antonio%20Sanchez%20-%20Quartet%20Live.cue&metadata=false Feb 10 12:28:31 volumio volumio[1138]: info: URI /mnt/NAS/FLAC/Jazz/Gary Burton, Pat Metheny, Steve Swallow, Antonio Sanchez - Quartet Live (2009)/Gary Burton, Pat Metheny, Steve Swallow, Antonio Sanchez - Quartet Live.cue Feb 10 12:28:31 volumio volumio[1138]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 10 12:28:31 volumio volumio[1138]: Error: Unable to resolve or reject the same promise twice Feb 10 12:28:31 volumio volumio[1138]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Feb 10 12:28:31 volumio volumio[1138]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Feb 10 12:28:31 volumio volumio[1138]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Feb 10 12:28:31 volumio volumio[1138]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Feb 10 12:28:31 volumio volumio[1138]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Feb 10 12:28:31 volumio volumio[1138]: at Socket.emit (node:events:514:28) Feb 10 12:28:31 volumio volumio[1138]: at addChunk (node:internal/streams/readable:343:12) Feb 10 12:28:31 volumio volumio[1138]: at readableAddChunk (node:internal/streams/readable:312:11) Feb 10 12:28:31 volumio volumio[1138]: at Readable.push (node:internal/streams/readable:253:10) Feb 10 12:28:31 volumio volumio[1138]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Feb 10 12:28:31 volumio volumio[1138]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 10 12:28:31 volumio sudo[365572]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-10 12:27' Feb 10 12:28:31 volumio sudo[365572]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:31:57 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6759e875c98b942866984e844891d6c1"