Dec 18 23:17:06 volumio go-librespot[1316]: time="2025-12-18T23:17:06+02:00" level=trace msg="received accesspoint ping" Dec 18 23:17:06 volumio go-librespot[1316]: time="2025-12-18T23:17:06+02:00" level=trace msg="received accesspoint pong ack" Dec 18 23:17:08 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Dec 18 23:17:10 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Dec 18 23:17:10 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Dec 18 23:17:10 volumio systemd[1]: setdatetime-helper.service: Consumed 1.632s CPU time. Dec 18 23:17:10 volumio go-librespot[1316]: time="2025-12-18T23:17:10+02:00" level=trace msg="sent dealer ping" Dec 18 23:17:10 volumio go-librespot[1316]: time="2025-12-18T23:17:10+02:00" level=trace msg="received dealer pong" Dec 18 23:17:40 volumio go-librespot[1316]: time="2025-12-18T23:17:40+02:00" level=trace msg="sent dealer ping" Dec 18 23:17:40 volumio go-librespot[1316]: time="2025-12-18T23:17:40+02:00" level=trace msg="received dealer pong" Dec 18 23:18:10 volumio go-librespot[1316]: time="2025-12-18T23:18:10+02:00" level=trace msg="sent dealer ping" Dec 18 23:18:10 volumio go-librespot[1316]: time="2025-12-18T23:18:10+02:00" level=trace msg="received dealer pong" Dec 18 23:18:19 volumio volumio[906]: verbose: New Socket.io Connection to 192.168.42.111:3000 from 172.16.42.3 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Dec 18 23:18:19 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 18 23:18:19 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 18 23:18:19 volumio volumio[906]: info: Discovery: Getting this device information Dec 18 23:18:19 volumio volumio[906]: info: CoreCommandRouter::volumioGetState Dec 18 23:18:19 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 18 23:18:19 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 18 23:18:19 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 18 23:18:19 volumio volumio[906]: info: Discovery: Getting this device information Dec 18 23:18:19 volumio volumio[906]: info: CoreCommandRouter::volumioGetState Dec 18 23:18:19 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 18 23:18:19 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 18 23:18:19 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Dec 18 23:18:19 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Dec 18 23:18:19 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 18 23:18:19 volumio sudo[22130]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 18 23:18:19 volumio sudo[22130]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 23:18:19 volumio sudo[22135]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 18 23:18:19 volumio sudo[22135]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 23:18:19 volumio sudo[22130]: pam_unix(sudo:session): session closed for user root Dec 18 23:18:19 volumio sudo[22141]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 18 23:18:19 volumio sudo[22141]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 23:18:19 volumio sudo[22145]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 18 23:18:19 volumio sudo[22145]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 23:18:19 volumio sudo[22152]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 18 23:18:19 volumio sudo[22152]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 23:18:19 volumio sudo[22152]: pam_unix(sudo:session): session closed for user root Dec 18 23:18:19 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 18 23:18:19 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 18 23:18:19 volumio volumio[906]: info: Discovery: Getting this device information Dec 18 23:18:19 volumio volumio[906]: info: CoreCommandRouter::volumioGetState Dec 18 23:18:19 volumio sudo[22158]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 18 23:18:19 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 18 23:18:19 volumio sudo[22158]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 23:18:19 volumio sudo[22135]: pam_unix(sudo:session): session closed for user root Dec 18 23:18:19 volumio volumio[906]: verbose: New Socket.io Connection to 192.168.42.111:3000 from 172.16.42.3 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Dec 18 23:18:19 volumio sudo[22141]: pam_unix(sudo:session): session closed for user root Dec 18 23:18:19 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 18 23:18:19 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 18 23:18:19 volumio sudo[22158]: pam_unix(sudo:session): session closed for user root Dec 18 23:18:19 volumio sudo[22145]: pam_unix(sudo:session): session closed for user root Dec 18 23:18:19 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 18 23:18:19 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 18 23:18:19 volumio volumio[906]: info: Discovery: Getting this device information Dec 18 23:18:19 volumio volumio[906]: info: CoreCommandRouter::volumioGetState Dec 18 23:18:19 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 18 23:18:20 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 18 23:18:20 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 18 23:18:20 volumio volumio[906]: info: Discovery: Getting this device information Dec 18 23:18:20 volumio volumio[906]: info: CoreCommandRouter::volumioGetState Dec 18 23:18:20 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 18 23:18:20 volumio volumio[906]: info: CoreCommandRouter::volumioGetState Dec 18 23:18:20 volumio volumio[906]: verbose: New Socket.io Connection to 192.168.42.111:3000 from 172.16.42.3 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Dec 18 23:18:20 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 18 23:18:20 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 18 23:18:21 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 18 23:18:21 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 18 23:18:23 volumio sudo[22192]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 18 23:18:23 volumio sudo[22192]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 23:18:23 volumio sudo[22192]: pam_unix(sudo:session): session closed for user root Dec 18 23:18:23 volumio sudo[22194]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 18 23:18:23 volumio sudo[22194]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 23:18:23 volumio sudo[22194]: pam_unix(sudo:session): session closed for user root Dec 18 23:18:23 volumio volumio[906]: verbose: New Socket.io Connection to 192.168.42.111 from 172.16.42.3 UA: Mozilla/5.0 (Linux; Android 16; Pixel 7 Build/BP4A.251205.006; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.34 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Dec 18 23:18:23 volumio sudo[22200]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 18 23:18:23 volumio sudo[22200]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 23:18:23 volumio sudo[22200]: pam_unix(sudo:session): session closed for user root Dec 18 23:18:23 volumio sudo[22202]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 18 23:18:23 volumio sudo[22202]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 18 23:18:23 volumio sudo[22202]: pam_unix(sudo:session): session closed for user root Dec 18 23:18:24 volumio volumio[906]: verbose: New Socket.io Connection to 192.168.42.111 from 172.16.42.3 UA: Mozilla/5.0 (Linux; Android 16; Pixel 7 Build/BP4A.251205.006; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.34 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Dec 18 23:18:24 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 18 23:18:24 volumio volumio[906]: info: CoreCommandRouter::volumioGetVisibleSources Dec 18 23:18:24 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 18 23:18:24 volumio volumio[906]: info: CoreCommandRouter::volumioGetState Dec 18 23:18:24 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 18 23:18:24 volumio volumio[906]: info: CoreCommandRouter::volumioGetQueue Dec 18 23:18:24 volumio volumio[906]: info: CoreStateMachine::getQueue Dec 18 23:18:24 volumio volumio[906]: info: CorePlayQueue::getQueue Dec 18 23:18:24 volumio volumio[906]: info: Listing playlists Dec 18 23:18:24 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 18 23:18:24 volumio volumio[906]: info: Received Get System Info Dec 18 23:18:24 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 18 23:18:24 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 18 23:18:24 volumio volumio[906]: info: Discovery: Getting this device information Dec 18 23:18:24 volumio volumio[906]: info: CoreCommandRouter::volumioGetState Dec 18 23:18:24 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 18 23:18:24 volumio volumio[906]: info: CoreCommandRouter::volumioGetState Dec 18 23:18:24 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 18 23:18:24 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 18 23:18:24 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 18 23:18:25 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 18 23:18:25 volumio volumio[906]: info: Received Get System Info Dec 18 23:18:25 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 18 23:18:25 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 18 23:18:25 volumio volumio[906]: info: Discovery: Getting this device information Dec 18 23:18:25 volumio volumio[906]: info: CoreCommandRouter::volumioGetState Dec 18 23:18:25 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 18 23:18:26 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 18 23:18:26 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 18 23:18:26 volumio volumio[906]: info: Received Get System Info Dec 18 23:18:26 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 18 23:18:26 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 18 23:18:26 volumio volumio[906]: info: Discovery: Getting this device information Dec 18 23:18:26 volumio volumio[906]: info: CoreCommandRouter::volumioGetState Dec 18 23:18:26 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 18 23:18:31 volumio volumio[906]: info: Preload queue cleared Dec 18 23:18:31 volumio volumio[906]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 18 23:18:31 volumio volumio[906]: info: CoreStateMachine::ClearQueue Dec 18 23:18:31 volumio volumio[906]: info: CoreStateMachine::stop Dec 18 23:18:31 volumio volumio[906]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 23:18:31 volumio volumio[906]: info: CoreStateMachine::updateTrackBlock Dec 18 23:18:31 volumio volumio[906]: info: CorePlayQueue::getTrackBlock Dec 18 23:18:31 volumio volumio[906]: info: CoreStateMachine::stPlaybackTimer Dec 18 23:18:31 volumio volumio[906]: info: CoreStateMachine::pushState Dec 18 23:18:31 volumio volumio[906]: info: CorePlayQueue::getTrack 2 Dec 18 23:18:31 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 23:18:31 volumio volumio[906]: info: CoreCommandRouter::volumioPushState Dec 18 23:18:31 volumio volumio[906]: info: CoreStateMachine::serviceStop Dec 18 23:18:31 volumio volumio[906]: info: CorePlayQueue::getTrack 2 Dec 18 23:18:31 volumio volumio[906]: info: CoreCommandRouter::serviceStop Dec 18 23:18:31 volumio volumio[906]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 18 23:18:31 volumio volumio[906]: info: ControllerMpd::stop Dec 18 23:18:31 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand stop Dec 18 23:18:31 volumio volumio[906]: info: CorePlayQueue::clearPlayQueue Dec 18 23:18:31 volumio volumio[906]: info: CorePlayQueue::saveQueue Dec 18 23:18:31 volumio volumio[906]: info: CoreCommandRouter::volumioPushQueue Dec 18 23:18:31 volumio volumio[906]: info: CoreStateMachine::addQueueItems Dec 18 23:18:31 volumio volumio[906]: info: CorePlayQueue::addQueueItems Dec 18 23:18:31 volumio volumio[906]: info: Preload queue cleared Dec 18 23:18:31 volumio volumio[906]: info: Adding Item to queue: jellyfin/claudio@26cce8cb5dbf41ef8a6df9e3fd4b8a6a/albums@search=Jasmin@collatedSearchResults=1/songs@albumId=59f44aa9205239013ceac0825bc0a7cb Dec 18 23:18:31 volumio volumio[906]: info: Exploding uri jellyfin/claudio@26cce8cb5dbf41ef8a6df9e3fd4b8a6a/albums@search=Jasmin@collatedSearchResults=1/songs@albumId=59f44aa9205239013ceac0825bc0a7cb in service jellyfin Dec 18 23:18:31 volumio volumio[906]: info: [jellyfin-browse] explodeUri: jellyfin/claudio@26cce8cb5dbf41ef8a6df9e3fd4b8a6a/albums@search=Jasmin@collatedSearchResults=1/songs@albumId=59f44aa9205239013ceac0825bc0a7cb Dec 18 23:18:31 volumio volumio[906]: verbose: [jellyfin] getItemsFromAPI(): {"userId":"9ab3d6a38f6b4a4c8168339c8f7c2e09","enableImageTypes":["Primary"],"imageTypeLimit":1,"recursive":true,"parentId":"59f44aa9205239013ceac0825bc0a7cb","startIndex":0,"sortBy":["SortName"],"sortOrder":["Ascending"],"fields":["MediaSources"],"includeItemTypes":["Audio"]} Dec 18 23:18:31 volumio volumio[906]: SPOTIFY: RECEIVED VOLUMIO VOLUME 24 Dec 18 23:18:31 volumio volumio[906]: SPOTIFY: SPOTIFY VOLUME 23 Dec 18 23:18:31 volumio volumio[906]: SPOTIFY: VOLUMIO VOLUME 24 Dec 18 23:18:31 volumio volumio[906]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 18 23:18:31 volumio volumio[906]: info: ControllerMpd::getState Dec 18 23:18:31 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status Dec 18 23:18:31 volumio volumio[906]: info: Dec 18 23:18:31 volumio volumio[906]: ---------------------------- MPD announces state update: player Dec 18 23:18:31 volumio volumio[906]: info: sendMpdCommand stop took 75 milliseconds Dec 18 23:18:31 volumio volumio[906]: info: ControllerMpd::getState Dec 18 23:18:31 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status Dec 18 23:18:31 volumio volumio[906]: info: Dec 18 23:18:31 volumio volumio[906]: ---------------------------- MPD announces state update: player Dec 18 23:18:31 volumio volumio[906]: info: ControllerMpd::getState Dec 18 23:18:31 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status Dec 18 23:18:31 volumio volumio[906]: info: Dec 18 23:18:31 volumio volumio[906]: ---------------------------- MPD announces state update: player Dec 18 23:18:31 volumio volumio[906]: info: ControllerMpd::getState Dec 18 23:18:31 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand status Dec 18 23:18:32 volumio volumio[906]: info: sendMpdCommand status took 15 milliseconds Dec 18 23:18:32 volumio volumio[906]: info: sendMpdCommand status took 12 milliseconds Dec 18 23:18:32 volumio volumio[906]: info: sendMpdCommand status took 9 milliseconds Dec 18 23:18:32 volumio volumio[906]: info: sendMpdCommand status took 7 milliseconds Dec 18 23:18:32 volumio volumio[906]: verbose: ControllerMpd::parseState Dec 18 23:18:32 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 23:18:32 volumio volumio[906]: verbose: ControllerMpd::parseState Dec 18 23:18:32 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 23:18:32 volumio volumio[906]: verbose: ControllerMpd::parseState Dec 18 23:18:32 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 23:18:32 volumio volumio[906]: verbose: ControllerMpd::parseState Dec 18 23:18:32 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 18 23:18:32 volumio volumio[906]: info: sendMpdCommand playlistinfo took 9 milliseconds Dec 18 23:18:32 volumio volumio[906]: info: sendMpdCommand playlistinfo took 10 milliseconds Dec 18 23:18:32 volumio volumio[906]: info: sendMpdCommand playlistinfo took 10 milliseconds Dec 18 23:18:32 volumio volumio[906]: info: sendMpdCommand playlistinfo took 11 milliseconds Dec 18 23:18:32 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo Dec 18 23:18:32 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo Dec 18 23:18:32 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo Dec 18 23:18:32 volumio volumio[906]: verbose: ControllerMpd::parseTrackInfo Dec 18 23:18:32 volumio volumio[906]: info: ControllerMpd::pushState Dec 18 23:18:32 volumio volumio[906]: info: CoreCommandRouter::servicePushState Dec 18 23:18:32 volumio volumio[906]: info: CoreStateMachine::pushState Dec 18 23:18:32 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 18 23:18:32 volumio volumio[906]: info: CoreCommandRouter::volumioPushState Dec 18 23:18:32 volumio volumio[906]: info: CorePlayQueue::getTrack 2 Dec 18 23:18:32 volumio volumio[906]: 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":"No Moon at All","artist":"Keith Jarrett / Charlie Haden","album":"Jasmine","uri":"http://192.168.42.136:8096/Audio/cac46e7e00fca52a14c4dab04591b96a/stream.flac?static=true&mediaSourceId=cac46e7e00fca52a14c4dab04591b96a&tag=d37746f2502f42a3f65c211360229ba6&t.flac","trackType":"flac"} Dec 18 23:18:32 volumio volumio[906]: verbose: CURRENT POSITION 2 Dec 18 23:18:32 volumio volumio[906]: info: CoreStateMachine::syncState stateService stop Dec 18 23:18:32 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus stop Dec 18 23:18:32 volumio volumio[906]: info: CoreStateMachine::pushState Dec 18 23:18:32 volumio volumio[906]: info: CoreCommandRouter::volumioPushState Dec 18 23:18:32 volumio volumio[906]: info: No code Dec 18 23:18:32 volumio volumio[906]: info: CoreStateMachine::pushState Dec 18 23:18:32 volumio volumio[906]: info: CoreCommandRouter::volumioPushState Dec 18 23:18:32 volumio volumio[906]: info: ControllerMpd::pushState Dec 18 23:18:32 volumio volumio[906]: info: CoreCommandRouter::servicePushState Dec 18 23:18:32 volumio volumio[906]: info: CoreStateMachine::pushState Dec 18 23:18:32 volumio volumio[906]: info: CoreCommandRouter::volumioPushState Dec 18 23:18:32 volumio volumio[906]: info: CorePlayQueue::getTrack 2 Dec 18 23:18:32 volumio volumio[906]: 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":"No Moon at All","artist":"Keith Jarrett / Charlie Haden","album":"Jasmine","uri":"http://192.168.42.136:8096/Audio/cac46e7e00fca52a14c4dab04591b96a/stream.flac?static=true&mediaSourceId=cac46e7e00fca52a14c4dab04591b96a&tag=d37746f2502f42a3f65c211360229ba6&t.flac","trackType":"flac"} Dec 18 23:18:32 volumio volumio[906]: verbose: CURRENT POSITION 2 Dec 18 23:18:32 volumio volumio[906]: info: CoreStateMachine::syncState stateService stop Dec 18 23:18:32 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus stop Dec 18 23:18:32 volumio volumio[906]: info: CoreStateMachine::pushState Dec 18 23:18:32 volumio volumio[906]: info: CoreCommandRouter::volumioPushState Dec 18 23:18:32 volumio volumio[906]: info: No code Dec 18 23:18:32 volumio volumio[906]: info: CoreStateMachine::pushState Dec 18 23:18:32 volumio volumio[906]: info: CoreCommandRouter::volumioPushState Dec 18 23:18:32 volumio volumio[906]: info: ControllerMpd::pushState Dec 18 23:18:32 volumio volumio[906]: info: CoreCommandRouter::servicePushState Dec 18 23:18:32 volumio volumio[906]: info: CoreStateMachine::pushState Dec 18 23:18:32 volumio volumio[906]: info: CoreCommandRouter::volumioPushState Dec 18 23:18:32 volumio volumio[906]: info: CorePlayQueue::getTrack 2 Dec 18 23:18:32 volumio volumio[906]: 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":"No Moon at All","artist":"Keith Jarrett / Charlie Haden","album":"Jasmine","uri":"http://192.168.42.136:8096/Audio/cac46e7e00fca52a14c4dab04591b96a/stream.flac?static=true&mediaSourceId=cac46e7e00fca52a14c4dab04591b96a&tag=d37746f2502f42a3f65c211360229ba6&t.flac","trackType":"flac"} Dec 18 23:18:32 volumio volumio[906]: verbose: CURRENT POSITION 2 Dec 18 23:18:32 volumio volumio[906]: info: CoreStateMachine::syncState stateService stop Dec 18 23:18:32 volumio volumio[906]: info: CoreStateMachine::syncState currentStatus stop Dec 18 23:18:32 volumio volumio[906]: info: CoreStateMachine::pushState Dec 18 23:18:32 volumio volumio[906]: info: CoreCommandRouter::volumioPushState Dec 18 23:18:32 volumio volumio[906]: info: No code Dec 18 23:18:32 volumio volumio[906]: info: CoreStateMachine::pushState Dec 18 23:18:32 volumio volumio[906]: info: CoreCommandRouter::volumioPushState Dec 18 23:18:32 volumio volumio[906]: info: ------------------------------ 119ms Dec 18 23:18:32 volumio volumio[906]: info: ------------------------------ 116ms Dec 18 23:18:32 volumio volumio[906]: info: ------------------------------ 115ms Dec 18 23:18:32 volumio volumio[906]: info: Pushing Favourites {"favourite":false} Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: RECEIVED VOLUMIO VOLUME 24 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: SPOTIFY VOLUME 23 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: VOLUMIO VOLUME 24 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: RECEIVED VOLUMIO VOLUME 24 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: SPOTIFY VOLUME 23 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: VOLUMIO VOLUME 24 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: RECEIVED VOLUMIO VOLUME 24 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: SPOTIFY VOLUME 23 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: VOLUMIO VOLUME 24 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: RECEIVED VOLUMIO VOLUME 24 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: SPOTIFY VOLUME 23 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: VOLUMIO VOLUME 24 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: RECEIVED VOLUMIO VOLUME 24 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: SPOTIFY VOLUME 23 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: VOLUMIO VOLUME 24 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: RECEIVED VOLUMIO VOLUME 24 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: SPOTIFY VOLUME 23 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: VOLUMIO VOLUME 24 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: RECEIVED VOLUMIO VOLUME 24 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: SPOTIFY VOLUME 23 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: VOLUMIO VOLUME 24 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: RECEIVED VOLUMIO VOLUME 24 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: SPOTIFY VOLUME 23 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: VOLUMIO VOLUME 24 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: RECEIVED VOLUMIO VOLUME 24 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: SPOTIFY VOLUME 23 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: VOLUMIO VOLUME 24 Dec 18 23:18:32 volumio volumio[906]: SPOTIFY: DELTA VOLUME ENOUGH: false Dec 18 23:18:32 volumio volumio[906]: info: Pushing Favourites {"service":"mpd","uri":"jellyfin/claudio@26cce8cb5dbf41ef8a6df9e3fd4b8a6a/song@songId=ab98d867cffb906d0c780245c2e8df7a","favourite":false} Dec 18 23:18:34 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 18 23:18:37 volumio volumio[906]: info: [jellyfin-play]: Reported 'stop' for song: No Moon at All (at 219203 ms) Dec 18 23:18:37 volumio volumio[906]: verbose: [jellyfin] getItemsFromAPI(): http://192.168.42.136:8096/Items?userId=9ab3d6a38f6b4a4c8168339c8f7c2e09&startIndex=0&recursive=true&sortOrder=Ascending&parentId=59f44aa9205239013ceac0825bc0a7cb&fields=MediaSources&includeItemTypes=Audio&sortBy=SortName&imageTypeLimit=1&enableImageTypes=Primary Dec 18 23:18:37 volumio volumio[906]: info: CoreCommandRouter::volumioPushQueue Dec 18 23:18:37 volumio volumio[906]: info: CorePlayQueue::saveQueue Dec 18 23:18:37 volumio volumio[906]: info: CoreStateMachine::updateTrackBlock Dec 18 23:18:37 volumio volumio[906]: info: CorePlayQueue::getTrackBlock Dec 18 23:18:37 volumio volumio[906]: info: CoreCommandRouter::volumioPlay Dec 18 23:18:37 volumio volumio[906]: info: CoreStateMachine::play index 0 Dec 18 23:18:37 volumio volumio[906]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 23:18:37 volumio volumio[906]: info: CoreStateMachine::stop Dec 18 23:18:37 volumio volumio[906]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 23:18:37 volumio volumio[906]: info: CoreStateMachine::play index undefined Dec 18 23:18:37 volumio volumio[906]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 23:18:37 volumio volumio[906]: info: CorePlayQueue::getTrack 0 Dec 18 23:18:37 volumio volumio[906]: info: CoreStateMachine::startPlaybackTimer Dec 18 23:18:37 volumio volumio[906]: info: CorePlayQueue::getTrack 0 Dec 18 23:18:37 volumio volumio[906]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/claudio@26cce8cb5dbf41ef8a6df9e3fd4b8a6a/song@songId=ab98d867cffb906d0c780245c2e8df7a Dec 18 23:18:37 volumio volumio[906]: info: [jellyfin-play] Stream URL for For All We Know: http://192.168.42.136:8096/Audio/ab98d867cffb906d0c780245c2e8df7a/stream.flac?static=true&mediaSourceId=ab98d867cffb906d0c780245c2e8df7a&tag=855d3cce856cf622b94fdd321855802e Dec 18 23:18:37 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand stop Dec 18 23:18:37 volumio volumio[906]: info: sendMpdCommand stop took 2 milliseconds Dec 18 23:18:37 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand clear Dec 18 23:18:37 volumio volumio[906]: info: sendMpdCommand clear took 2 milliseconds Dec 18 23:18:37 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.42.136:8096/Audio/ab98d867cffb906d0c780245c2e8df7a/stream.flac?static=true&mediaSourceId=ab98d867cffb906d0c780245c2e8df7a&tag=855d3cce856cf622b94fdd321855802e&t.flac" Dec 18 23:18:37 volumio volumio[906]: info: Dec 18 23:18:37 volumio volumio[906]: ---------------------------- MPD announces system playlist update Dec 18 23:18:37 volumio volumio[906]: info: Ignoring MPD Status Update Dec 18 23:18:37 volumio volumio[906]: info: Dec 18 23:18:37 volumio volumio[906]: ---------------------------- MPD announces system playlist update Dec 18 23:18:37 volumio volumio[906]: info: Ignoring MPD Status Update Dec 18 23:18:37 volumio volumio[906]: info: Dec 18 23:18:37 volumio volumio[906]: ---------------------------- MPD announces system playlist update Dec 18 23:18:37 volumio volumio[906]: info: Ignoring MPD Status Update Dec 18 23:18:38 volumio volumio[906]: info: Preload queue cleared Dec 18 23:18:38 volumio volumio[906]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 18 23:18:38 volumio volumio[906]: info: CoreStateMachine::ClearQueue Dec 18 23:18:38 volumio volumio[906]: info: CoreStateMachine::stop Dec 18 23:18:38 volumio volumio[906]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 23:18:38 volumio volumio[906]: info: CorePlayQueue::clearPlayQueue Dec 18 23:18:38 volumio volumio[906]: info: CorePlayQueue::saveQueue Dec 18 23:18:38 volumio volumio[906]: info: CoreCommandRouter::volumioPushQueue Dec 18 23:18:38 volumio volumio[906]: info: CoreStateMachine::addQueueItems Dec 18 23:18:38 volumio volumio[906]: info: CorePlayQueue::addQueueItems Dec 18 23:18:38 volumio volumio[906]: info: Preload queue cleared Dec 18 23:18:38 volumio volumio[906]: info: Adding Item to queue: jellyfin/claudio@26cce8cb5dbf41ef8a6df9e3fd4b8a6a/albums@search=Jasmin@collatedSearchResults=1/songs@albumId=59f44aa9205239013ceac0825bc0a7cb Dec 18 23:18:38 volumio volumio[906]: info: Using cached record of: jellyfin/claudio@26cce8cb5dbf41ef8a6df9e3fd4b8a6a/albums@search=Jasmin@collatedSearchResults=1/songs@albumId=59f44aa9205239013ceac0825bc0a7cb Dec 18 23:18:38 volumio volumio[906]: info: CoreCommandRouter::volumioPushQueue Dec 18 23:18:38 volumio volumio[906]: info: CorePlayQueue::saveQueue Dec 18 23:18:38 volumio volumio[906]: info: CoreStateMachine::updateTrackBlock Dec 18 23:18:38 volumio volumio[906]: info: CorePlayQueue::getTrackBlock Dec 18 23:18:38 volumio volumio[906]: info: CoreCommandRouter::volumioPlay Dec 18 23:18:38 volumio volumio[906]: info: CoreStateMachine::play index 0 Dec 18 23:18:38 volumio volumio[906]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 23:18:38 volumio volumio[906]: info: CoreStateMachine::stop Dec 18 23:18:38 volumio volumio[906]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 23:18:38 volumio volumio[906]: info: CoreStateMachine::play index undefined Dec 18 23:18:38 volumio volumio[906]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 23:18:38 volumio volumio[906]: info: CorePlayQueue::getTrack 0 Dec 18 23:18:38 volumio volumio[906]: info: CoreStateMachine::startPlaybackTimer Dec 18 23:18:38 volumio volumio[906]: info: CorePlayQueue::getTrack 0 Dec 18 23:18:38 volumio volumio[906]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/claudio@26cce8cb5dbf41ef8a6df9e3fd4b8a6a/song@songId=ab98d867cffb906d0c780245c2e8df7a Dec 18 23:18:38 volumio volumio[906]: info: [jellyfin-play] Stream URL for For All We Know: http://192.168.42.136:8096/Audio/ab98d867cffb906d0c780245c2e8df7a/stream.flac?static=true&mediaSourceId=ab98d867cffb906d0c780245c2e8df7a&tag=855d3cce856cf622b94fdd321855802e Dec 18 23:18:38 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand stop Dec 18 23:18:40 volumio volumio[906]: info: CoreCommandRouter::volumioPlay Dec 18 23:18:40 volumio volumio[906]: info: CoreStateMachine::play index undefined Dec 18 23:18:40 volumio volumio[906]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 18 23:18:40 volumio volumio[906]: info: CorePlayQueue::getTrack 0 Dec 18 23:18:40 volumio volumio[906]: info: CoreStateMachine::startPlaybackTimer Dec 18 23:18:40 volumio volumio[906]: info: CorePlayQueue::getTrack 0 Dec 18 23:18:40 volumio volumio[906]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/claudio@26cce8cb5dbf41ef8a6df9e3fd4b8a6a/song@songId=ab98d867cffb906d0c780245c2e8df7a Dec 18 23:18:40 volumio volumio[906]: info: [jellyfin-play] Stream URL for For All We Know: http://192.168.42.136:8096/Audio/ab98d867cffb906d0c780245c2e8df7a/stream.flac?static=true&mediaSourceId=ab98d867cffb906d0c780245c2e8df7a&tag=855d3cce856cf622b94fdd321855802e Dec 18 23:18:40 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand stop Dec 18 23:18:40 volumio go-librespot[1316]: time="2025-12-18T23:18:40+02:00" level=trace msg="sent dealer ping" Dec 18 23:18:40 volumio go-librespot[1316]: time="2025-12-18T23:18:40+02:00" level=trace msg="received dealer pong" Dec 18 23:18:42 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 18 23:18:42 volumio volumio[906]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 18 23:18:42 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 18 23:18:42 volumio volumio[906]: info: Received Get System Version Dec 18 23:18:42 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 18 23:18:42 volumio volumio[906]: info: Received Get System Info Dec 18 23:18:42 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 18 23:18:42 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 18 23:18:42 volumio volumio[906]: info: Discovery: Getting this device information Dec 18 23:18:42 volumio volumio[906]: info: CoreCommandRouter::volumioGetState Dec 18 23:18:42 volumio volumio[906]: info: CorePlayQueue::getTrack 0 Dec 18 23:18:42 volumio volumio[906]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 18 23:18:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand addid "http://192.168.42.136:8096/Audio/ab98d867cffb906d0c780245c2e8df7a/stream.flac?static=true&mediaSourceId=ab98d867cffb906d0c780245c2e8df7a&tag=855d3cce856cf622b94fdd321855802e&t.flac" Dec 18 23:18:42 volumio volumio[906]: error: updateQueue error: null Dec 18 23:18:42 volumio volumio[906]: error: updateQueue error: null Dec 18 23:18:42 volumio volumio[906]: error: updateQueue error: null Dec 18 23:18:42 volumio volumio[906]: info: Dec 18 23:18:42 volumio volumio[906]: ---------------------------- MPD announces system playlist update Dec 18 23:18:42 volumio volumio[906]: info: Ignoring MPD Status Update Dec 18 23:18:42 volumio volumio[906]: info: ------------------------------ 5132ms Dec 18 23:18:42 volumio volumio[906]: info: ------------------------------ 5130ms Dec 18 23:18:42 volumio volumio[906]: info: ------------------------------ 5128ms Dec 18 23:18:42 volumio volumio[906]: info: sendMpdCommand stop took 3898 milliseconds Dec 18 23:18:42 volumio volumio[906]: info: sendMpdCommand stop took 2227 milliseconds Dec 18 23:18:42 volumio volumio[906]: info: sendMpdCommand addid "http://192.168.42.136:8096/Audio/ab98d867cffb906d0c780245c2e8df7a/stream.flac?static=true&mediaSourceId=ab98d867cffb906d0c780245c2e8df7a&tag=855d3cce856cf622b94fdd321855802e&t.flac" took 9 milliseconds Dec 18 23:18:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand clear Dec 18 23:18:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand clear Dec 18 23:18:42 volumio volumio[906]: verbose: MPD COMMAND [object Object] Dec 18 23:18:42 volumio volumio[906]: verbose: MPD COMMAND [object Object] Dec 18 23:18:42 volumio volumio[906]: verbose: MPD COMMAND [object Object] Dec 18 23:18:42 volumio volumio[906]: info: Dec 18 23:18:42 volumio volumio[906]: ---------------------------- MPD announces system playlist update Dec 18 23:18:42 volumio volumio[906]: info: Ignoring MPD Status Update Dec 18 23:18:42 volumio volumio[906]: info: Dec 18 23:18:42 volumio volumio[906]: ---------------------------- MPD announces system playlist update Dec 18 23:18:42 volumio volumio[906]: info: Ignoring MPD Status Update Dec 18 23:18:42 volumio volumio[906]: info: Dec 18 23:18:42 volumio volumio[906]: ---------------------------- MPD announces system playlist update Dec 18 23:18:42 volumio volumio[906]: info: Ignoring MPD Status Update Dec 18 23:18:42 volumio volumio[906]: info: Dec 18 23:18:42 volumio volumio[906]: ---------------------------- MPD announces system playlist update Dec 18 23:18:42 volumio volumio[906]: info: Ignoring MPD Status Update Dec 18 23:18:42 volumio volumio[906]: error: updateQueue error: null Dec 18 23:18:42 volumio volumio[906]: error: updateQueue error: null Dec 18 23:18:42 volumio volumio[906]: info: ------------------------------ 25ms Dec 18 23:18:42 volumio volumio[906]: info: sendMpdCommand clear took 22 milliseconds Dec 18 23:18:42 volumio volumio[906]: info: sendMpdCommand clear took 21 milliseconds Dec 18 23:18:42 volumio volumio[906]: info: ------------------------------ 10ms Dec 18 23:18:42 volumio volumio[906]: info: ------------------------------ 9ms Dec 18 23:18:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.42.136:8096/Audio/ab98d867cffb906d0c780245c2e8df7a/stream.flac?static=true&mediaSourceId=ab98d867cffb906d0c780245c2e8df7a&tag=855d3cce856cf622b94fdd321855802e&t.flac" Dec 18 23:18:42 volumio volumio[906]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.42.136:8096/Audio/ab98d867cffb906d0c780245c2e8df7a/stream.flac?static=true&mediaSourceId=ab98d867cffb906d0c780245c2e8df7a&tag=855d3cce856cf622b94fdd321855802e&t.flac" Dec 18 23:18:42 volumio volumio[906]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 18 23:18:42 volumio volumio[906]: Error: [50@0] {addtagid} No such song Dec 18 23:18:42 volumio volumio[906]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:63:17) Dec 18 23:18:42 volumio volumio[906]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Dec 18 23:18:42 volumio volumio[906]: at Socket.emit (node:events:514:28) Dec 18 23:18:42 volumio volumio[906]: at addChunk (node:internal/streams/readable:343:12) Dec 18 23:18:42 volumio volumio[906]: at readableAddChunk (node:internal/streams/readable:312:11) Dec 18 23:18:42 volumio volumio[906]: at Readable.push (node:internal/streams/readable:253:10) Dec 18 23:18:42 volumio volumio[906]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Dec 18 23:18:42 volumio volumio[906]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 18 23:18:44 volumio sudo[22258]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-18 23:17' Dec 18 23:18:44 volumio sudo[22258]: 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"