-- Logs begin at Sun 2025-06-29 10:36:37 CEST, end at Sun 2025-06-29 10:40:24 CEST. -- Jun 29 10:39:17 volumio-tarci go-librespot[1844]: time="2025-06-29T10:39:17+02:00" level=trace msg="received accesspoint ping" Jun 29 10:39:17 volumio-tarci go-librespot[1844]: time="2025-06-29T10:39:17+02:00" level=trace msg="received accesspoint pong ack" Jun 29 10:39:17 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 29 10:39:17 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 29 10:39:17 volumio-tarci volumio[1296]: info: Discovery: Getting this device information Jun 29 10:39:17 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioGetState Jun 29 10:39:17 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 29 10:39:17 volumio-tarci volumio[1296]: verbose: New Socket.io Connection to 192.168.43.128:3000 from 192.168.43.97 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Jun 29 10:39:17 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioGetState Jun 29 10:39:17 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 29 10:39:17 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 29 10:39:17 volumio-tarci go-librespot[1844]: time="2025-06-29T10:39:17+02:00" level=trace msg="sent dealer ping" Jun 29 10:39:17 volumio-tarci go-librespot[1844]: time="2025-06-29T10:39:17+02:00" level=trace msg="received dealer pong" Jun 29 10:39:19 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioGetState Jun 29 10:39:22 volumio-tarci sudo[2821]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 29 10:39:22 volumio-tarci sudo[2821]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 10:39:22 volumio-tarci sudo[2821]: pam_unix(sudo:session): session closed for user root Jun 29 10:39:22 volumio-tarci sudo[2824]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 29 10:39:22 volumio-tarci sudo[2824]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 10:39:22 volumio-tarci sudo[2824]: pam_unix(sudo:session): session closed for user root Jun 29 10:39:23 volumio-tarci volumio[1296]: verbose: New Socket.io Connection to 192.168.43.128 from 192.168.43.97 UA: Mozilla/5.0 (Linux; Android 12; SM-A125F Build/SP1A.210812.016; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Jun 29 10:39:24 volumio-tarci sudo[2845]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 29 10:39:24 volumio-tarci sudo[2845]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 10:39:24 volumio-tarci sudo[2845]: pam_unix(sudo:session): session closed for user root Jun 29 10:39:24 volumio-tarci sudo[2848]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 29 10:39:24 volumio-tarci sudo[2848]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 10:39:24 volumio-tarci sudo[2848]: pam_unix(sudo:session): session closed for user root Jun 29 10:39:24 volumio-tarci volumio[1296]: verbose: New Socket.io Connection to 192.168.43.128 from 192.168.43.97 UA: Mozilla/5.0 (Linux; Android 12; SM-A125F Build/SP1A.210812.016; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Jun 29 10:39:25 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 29 10:39:25 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioGetVisibleSources Jun 29 10:39:25 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 29 10:39:25 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioGetState Jun 29 10:39:25 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 29 10:39:25 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioGetQueue Jun 29 10:39:25 volumio-tarci volumio[1296]: info: CoreStateMachine::getQueue Jun 29 10:39:25 volumio-tarci volumio[1296]: info: CorePlayQueue::getQueue Jun 29 10:39:25 volumio-tarci volumio[1296]: info: Listing playlists Jun 29 10:39:25 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 29 10:39:25 volumio-tarci volumio[1296]: info: Received Get System Info Jun 29 10:39:25 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 29 10:39:25 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 29 10:39:25 volumio-tarci volumio[1296]: info: Discovery: Getting this device information Jun 29 10:39:25 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioGetState Jun 29 10:39:25 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 29 10:39:25 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioGetState Jun 29 10:39:25 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 29 10:39:25 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 29 10:39:25 volumio-tarci volumio[1296]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 29 10:39:25 volumio-tarci volumio[1296]: info: FusionDsp - no preset used Jun 29 10:39:26 volumio-tarci volumio[1296]: info: FusionDsp - undefined Jun 29 10:39:26 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 29 10:39:26 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 29 10:39:26 volumio-tarci volumio[1296]: info: Received Get System Info Jun 29 10:39:26 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 29 10:39:26 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 29 10:39:26 volumio-tarci volumio[1296]: info: Discovery: Getting this device information Jun 29 10:39:26 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioGetState Jun 29 10:39:26 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 29 10:39:27 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jun 29 10:39:28 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 29 10:39:28 volumio-tarci volumio[1296]: info: Received Get System Info Jun 29 10:39:28 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 29 10:39:28 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 29 10:39:28 volumio-tarci volumio[1296]: info: Discovery: Getting this device information Jun 29 10:39:28 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioGetState Jun 29 10:39:28 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 29 10:39:34 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 29 10:39:39 volumio-tarci volumio[1296]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 29 10:39:39 volumio-tarci volumio[1296]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 29 10:39:39 volumio-tarci volumio[1296]: info: Retrieving Cloud Streaming UI Jun 29 10:39:39 volumio-tarci volumio[1296]: info: Getting Tidal Cloud Configuration Jun 29 10:39:39 volumio-tarci volumio[1296]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 29 10:39:39 volumio-tarci volumio[1296]: info: Getting Qobuz Cloud Configuration Jun 29 10:39:39 volumio-tarci volumio[1296]: info: Asking plugin for UI Config Jun 29 10:39:39 volumio-tarci volumio[1296]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 29 10:39:39 volumio-tarci volumio[1296]: info: Getting Spotify Cloud Configuration Jun 29 10:39:39 volumio-tarci volumio[1296]: info: Asking plugin for UI Config Jun 29 10:39:39 volumio-tarci volumio[1296]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 29 10:39:39 volumio-tarci volumio[1296]: info: Saving Spotify Acccount Jun 29 10:39:39 volumio-tarci volumio[1296]: info: Got Tidal Cloud Configuration Jun 29 10:39:39 volumio-tarci volumio[1296]: info: Got it Jun 29 10:39:39 volumio-tarci volumio[1296]: info: Got it Jun 29 10:39:39 volumio-tarci volumio[1296]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jun 29 10:39:40 volumio-tarci volumio[1296]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 29 10:39:40 volumio-tarci volumio[1296]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Jun 29 10:39:40 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 29 10:39:40 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 29 10:39:40 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 29 10:39:40 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jun 29 10:39:40 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 29 10:39:40 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 29 10:39:40 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 29 10:39:40 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 29 10:39:40 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioGetBrowseSources Jun 29 10:39:40 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioGetBrowseSources Jun 29 10:39:40 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioGetBrowseSources Jun 29 10:39:41 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 29 10:39:42 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jun 29 10:39:42 volumio-tarci volumiologrotate[974]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Jun 29 10:39:42 volumio-tarci volumiologrotate[974]: ls: cannot access 'TARCI': No such file or directory Jun 29 10:39:43 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 29 10:39:43 volumio-tarci volumio[1296]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jun 29 10:39:43 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jun 29 10:39:43 volumio-tarci volumio[1296]: info: Received Get System Version Jun 29 10:39:43 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 29 10:39:43 volumio-tarci volumio[1296]: info: Received Get System Info Jun 29 10:39:43 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 29 10:39:43 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 29 10:39:43 volumio-tarci volumio[1296]: info: Discovery: Getting this device information Jun 29 10:39:43 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioGetState Jun 29 10:39:43 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 29 10:39:45 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 29 10:39:47 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 29 10:39:47 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 29 10:39:47 volumio-tarci volumio[1296]: info: Discovery: Getting this device information Jun 29 10:39:47 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioGetState Jun 29 10:39:47 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 29 10:39:47 volumio-tarci go-librespot[1844]: time="2025-06-29T10:39:47+02:00" level=trace msg="sent dealer ping" Jun 29 10:39:47 volumio-tarci go-librespot[1844]: time="2025-06-29T10:39:47+02:00" level=trace msg="received dealer pong" Jun 29 10:39:48 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Jun 29 10:39:48 volumio-tarci volumio[1296]: verbose: ControllerMpd::sendMpdCommand update Jun 29 10:39:48 volumio-tarci volumio[1296]: verbose: ControllerMpd::sendMpdCommand status Jun 29 10:39:48 volumio-tarci volumio[1296]: info: Jun 29 10:39:48 volumio-tarci volumio[1296]: ---------------------------- MPD announces state update: update Jun 29 10:39:48 volumio-tarci volumio[1296]: info: sendMpdCommand update took 11 milliseconds Jun 29 10:39:48 volumio-tarci volumio[1296]: info: ControllerMpd::getState Jun 29 10:39:48 volumio-tarci volumio[1296]: verbose: ControllerMpd::sendMpdCommand status Jun 29 10:39:48 volumio-tarci volumio[1296]: info: sendMpdCommand status took 7 milliseconds Jun 29 10:39:48 volumio-tarci volumio[1296]: info: sendMpdCommand status took 4 milliseconds Jun 29 10:39:48 volumio-tarci volumio[1296]: verbose: ControllerMpd::parseState Jun 29 10:39:48 volumio-tarci volumio[1296]: info: Command Router : Notfying DB Updatetrue Jun 29 10:39:48 volumio-tarci volumio[1296]: verbose: ControllerMpd::parseState Jun 29 10:39:48 volumio-tarci volumio[1296]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 29 10:39:48 volumio-tarci volumio[1296]: info: sendMpdCommand playlistinfo took 9 milliseconds Jun 29 10:39:48 volumio-tarci volumio[1296]: verbose: ControllerMpd::parseTrackInfo Jun 29 10:39:48 volumio-tarci volumio[1296]: info: ControllerMpd::pushState Jun 29 10:39:48 volumio-tarci volumio[1296]: info: CoreCommandRouter::servicePushState Jun 29 10:39:48 volumio-tarci volumio[1296]: verbose: In UPNP mode Jun 29 10:39:48 volumio-tarci volumio[1296]: verbose: STATE SERVICE {"status":"play","position":0,"seek":122472,"duration":203,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"A Change Is Gonna Come","artist":"Greta Van Fleet","album":"From The Fires","uri":"http://192.168.43.97:17116/local/5031427c08acd4f79603bfa22a927262.mp3","trackType":"mp3"} Jun 29 10:39:48 volumio-tarci volumio[1296]: verbose: CURRENT POSITION 0 Jun 29 10:39:48 volumio-tarci volumio[1296]: info: CoreStateMachine::syncState stateService play Jun 29 10:39:48 volumio-tarci volumio[1296]: info: CoreStateMachine::syncState currentStatus play Jun 29 10:39:48 volumio-tarci volumio[1296]: info: Received an update from plugin. extracting info from payload Jun 29 10:39:48 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 29 10:39:48 volumio-tarci volumio[1296]: info: CoreStateMachine::pushState Jun 29 10:39:48 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 29 10:39:48 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioPushState Jun 29 10:39:48 volumio-tarci volumio[1296]: info: CoreStateMachine::pushState Jun 29 10:39:48 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioPushState Jun 29 10:39:48 volumio-tarci volumio[1296]: info: ------------------------------ 124ms Jun 29 10:39:48 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioGetQueue Jun 29 10:39:48 volumio-tarci volumio[1296]: info: CoreStateMachine::getQueue Jun 29 10:39:48 volumio-tarci volumio[1296]: info: CorePlayQueue::getQueue Jun 29 10:39:48 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioGetQueue Jun 29 10:39:48 volumio-tarci volumio[1296]: info: CoreStateMachine::getQueue Jun 29 10:39:48 volumio-tarci volumio[1296]: info: CorePlayQueue::getQueue Jun 29 10:39:49 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 29 10:39:50 volumio-tarci volumio[1296]: info: CoreCommandRouter::Close All Modals sent Jun 29 10:39:54 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 29 10:39:57 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Jun 29 10:39:57 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Jun 29 10:39:57 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 29 10:40:02 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 29 10:40:06 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 29 10:40:10 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 29 10:40:12 volumio-tarci volumio[1296]: info: Disabling MyMusic plugin airplay_emulation Jun 29 10:40:12 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesShairport-Sync Jun 29 10:40:12 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 29 10:40:12 volumio-tarci volumio[1296]: Cannot find translation for source YouTube Music Jun 29 10:40:12 volumio-tarci volumio[1296]: Cannot find translation for source 80s80s Radio Jun 29 10:40:12 volumio-tarci volumio[1296]: Cannot find translation for source Mother Earth Radio Jun 29 10:40:12 volumio-tarci volumio[1296]: Cannot find translation for source Podcast Jun 29 10:40:12 volumio-tarci volumio[1296]: Cannot find translation for source Radio Paradise Jun 29 10:40:12 volumio-tarci volumio[1296]: Cannot find translation for source Spotify Jun 29 10:40:12 volumio-tarci volumio[1296]: info: Disabling plugin airplay_emulation Jun 29 10:40:12 volumio-tarci volumio[1296]: info: Done. Jun 29 10:40:12 volumio-tarci sudo[3062]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Jun 29 10:40:12 volumio-tarci sudo[3062]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 10:40:12 volumio-tarci systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 29 10:40:12 volumio-tarci systemd[1]: shairport-sync.service: Succeeded. Jun 29 10:40:12 volumio-tarci systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 29 10:40:12 volumio-tarci sudo[3062]: pam_unix(sudo:session): session closed for user root Jun 29 10:40:12 volumio-tarci volumio[1296]: info: Shairport-Sync Stopped Jun 29 10:40:13 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 29 10:40:17 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 29 10:40:17 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 29 10:40:17 volumio-tarci volumio[1296]: info: Discovery: Getting this device information Jun 29 10:40:17 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioGetState Jun 29 10:40:17 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 29 10:40:17 volumio-tarci volumio[1296]: info: MPD Database updated - AlbumList cache refreshed Jun 29 10:40:17 volumio-tarci volumio[1296]: info: Jun 29 10:40:17 volumio-tarci volumio[1296]: ---------------------------- MPD announces state update: database Jun 29 10:40:17 volumio-tarci volumio[1296]: verbose: ControllerMpd::sendMpdCommand status Jun 29 10:40:17 volumio-tarci volumio[1296]: info: Jun 29 10:40:17 volumio-tarci volumio[1296]: ---------------------------- MPD announces state update: update Jun 29 10:40:17 volumio-tarci volumio[1296]: info: ControllerMpd::getState Jun 29 10:40:17 volumio-tarci volumio[1296]: verbose: ControllerMpd::sendMpdCommand status Jun 29 10:40:17 volumio-tarci go-librespot[1844]: time="2025-06-29T10:40:17+02:00" level=trace msg="sent dealer ping" Jun 29 10:40:17 volumio-tarci volumio[1296]: info: ControllerMpd::getState Jun 29 10:40:17 volumio-tarci volumio[1296]: verbose: ControllerMpd::sendMpdCommand status Jun 29 10:40:17 volumio-tarci go-librespot[1844]: time="2025-06-29T10:40:17+02:00" level=trace msg="received dealer pong" Jun 29 10:40:17 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 29 10:40:19 volumio-tarci volumio[1296]: info: sendMpdCommand status took 1998 milliseconds Jun 29 10:40:19 volumio-tarci volumio[1296]: info: sendMpdCommand status took 1995 milliseconds Jun 29 10:40:19 volumio-tarci volumio[1296]: info: sendMpdCommand status took 1992 milliseconds Jun 29 10:40:19 volumio-tarci volumio[1296]: verbose: ControllerMpd::parseState Jun 29 10:40:19 volumio-tarci volumio[1296]: info: Command Router : Notfying DB Updatefalse Jun 29 10:40:19 volumio-tarci volumio[1296]: info: CoreCommandRouter::Close All Modals sent Jun 29 10:40:19 volumio-tarci volumio[1296]: verbose: ControllerMpd::parseState Jun 29 10:40:19 volumio-tarci volumio[1296]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 29 10:40:19 volumio-tarci volumio[1296]: verbose: ControllerMpd::parseState Jun 29 10:40:19 volumio-tarci volumio[1296]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 29 10:40:19 volumio-tarci volumio[1296]: info: sendMpdCommand playlistinfo took 16 milliseconds Jun 29 10:40:19 volumio-tarci volumio[1296]: info: sendMpdCommand playlistinfo took 15 milliseconds Jun 29 10:40:19 volumio-tarci volumio[1296]: verbose: ControllerMpd::parseTrackInfo Jun 29 10:40:19 volumio-tarci volumio[1296]: verbose: ControllerMpd::parseTrackInfo Jun 29 10:40:19 volumio-tarci volumio[1296]: info: ControllerMpd::pushState Jun 29 10:40:19 volumio-tarci volumio[1296]: info: CoreCommandRouter::servicePushState Jun 29 10:40:19 volumio-tarci volumio[1296]: verbose: In UPNP mode Jun 29 10:40:19 volumio-tarci volumio[1296]: verbose: STATE SERVICE {"status":"play","position":0,"seek":152091,"duration":203,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"A Change Is Gonna Come","artist":"Greta Van Fleet","album":"From The Fires","uri":"http://192.168.43.97:17116/local/5031427c08acd4f79603bfa22a927262.mp3","trackType":"mp3"} Jun 29 10:40:19 volumio-tarci volumio[1296]: verbose: CURRENT POSITION 0 Jun 29 10:40:19 volumio-tarci volumio[1296]: info: CoreStateMachine::syncState stateService play Jun 29 10:40:19 volumio-tarci volumio[1296]: info: CoreStateMachine::syncState currentStatus play Jun 29 10:40:19 volumio-tarci volumio[1296]: info: Received an update from plugin. extracting info from payload Jun 29 10:40:19 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 29 10:40:19 volumio-tarci volumio[1296]: info: CoreStateMachine::pushState Jun 29 10:40:19 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 29 10:40:19 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioPushState Jun 29 10:40:19 volumio-tarci volumio[1296]: info: CoreStateMachine::pushState Jun 29 10:40:19 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioPushState Jun 29 10:40:19 volumio-tarci volumio[1296]: info: ControllerMpd::pushState Jun 29 10:40:19 volumio-tarci volumio[1296]: info: CoreCommandRouter::servicePushState Jun 29 10:40:19 volumio-tarci volumio[1296]: verbose: In UPNP mode Jun 29 10:40:19 volumio-tarci volumio[1296]: verbose: STATE SERVICE {"status":"play","position":0,"seek":152091,"duration":203,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"A Change Is Gonna Come","artist":"Greta Van Fleet","album":"From The Fires","uri":"http://192.168.43.97:17116/local/5031427c08acd4f79603bfa22a927262.mp3","trackType":"mp3"} Jun 29 10:40:19 volumio-tarci volumio[1296]: verbose: CURRENT POSITION 0 Jun 29 10:40:19 volumio-tarci volumio[1296]: info: CoreStateMachine::syncState stateService play Jun 29 10:40:19 volumio-tarci volumio[1296]: info: CoreStateMachine::syncState currentStatus play Jun 29 10:40:19 volumio-tarci volumio[1296]: info: Received an update from plugin. extracting info from payload Jun 29 10:40:19 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 29 10:40:19 volumio-tarci volumio[1296]: info: CoreStateMachine::pushState Jun 29 10:40:19 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioPushState Jun 29 10:40:19 volumio-tarci volumio[1296]: info: CoreStateMachine::pushState Jun 29 10:40:19 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioPushState Jun 29 10:40:20 volumio-tarci volumio[1296]: info: ------------------------------ 2162ms Jun 29 10:40:20 volumio-tarci volumio[1296]: info: ------------------------------ 2161ms Jun 29 10:40:20 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioGetQueue Jun 29 10:40:20 volumio-tarci volumio[1296]: info: CoreStateMachine::getQueue Jun 29 10:40:20 volumio-tarci volumio[1296]: info: CorePlayQueue::getQueue Jun 29 10:40:20 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioGetQueue Jun 29 10:40:20 volumio-tarci volumio[1296]: info: CoreStateMachine::getQueue Jun 29 10:40:20 volumio-tarci volumio[1296]: info: CorePlayQueue::getQueue Jun 29 10:40:20 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioGetQueue Jun 29 10:40:20 volumio-tarci volumio[1296]: info: CoreStateMachine::getQueue Jun 29 10:40:20 volumio-tarci volumio[1296]: info: CorePlayQueue::getQueue Jun 29 10:40:20 volumio-tarci volumio[1296]: info: CoreCommandRouter::volumioGetQueue Jun 29 10:40:20 volumio-tarci volumio[1296]: info: CoreStateMachine::getQueue Jun 29 10:40:20 volumio-tarci volumio[1296]: info: CorePlayQueue::getQueue Jun 29 10:40:21 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 29 10:40:23 volumio-tarci volumio[1296]: info: Disabling MyMusic plugin upnp Jun 29 10:40:23 volumio-tarci sudo[3102]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Jun 29 10:40:23 volumio-tarci sudo[3102]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 29 10:40:23 volumio-tarci systemd[1]: Stopping UPnP Renderer front-end to MPD... Jun 29 10:40:23 volumio-tarci volumio[1296]: error: Upnp client error: Error: This socket has been ended by the other party Jun 29 10:40:24 volumio-tarci volumio[1296]: info: Enabling MyMusic plugin upnp Jun 29 10:40:24 volumio-tarci volumio[1296]: info: Enabling plugin upnp Jun 29 10:40:24 volumio-tarci volumio[1296]: info: Loading plugin "upnp"... Jun 29 10:40:24 volumio-tarci volumio[1296]: info: [1751186424313] Starting Upmpd Daemon Jun 29 10:40:24 volumio-tarci volumio[1296]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 29 10:40:24 volumio-tarci volumio[1296]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 29 10:40:24 volumio-tarci volumio[1296]: Error: listen EADDRINUSE: address already in use :::6599 Jun 29 10:40:24 volumio-tarci volumio[1296]: at Server.setupListenHandle [as _listen2] (net.js:1331:16) Jun 29 10:40:24 volumio-tarci volumio[1296]: at listenInCluster (net.js:1379:12) Jun 29 10:40:24 volumio-tarci volumio[1296]: at Server.listen (net.js:1465:7) Jun 29 10:40:24 volumio-tarci volumio[1296]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Jun 29 10:40:24 volumio-tarci volumio[1296]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Jun 29 10:40:24 volumio-tarci volumio[1296]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Jun 29 10:40:24 volumio-tarci volumio[1296]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jun 29 10:40:24 volumio-tarci volumio[1296]: at processTicksAndRejections (internal/process/task_queues.js:77:11) { Jun 29 10:40:24 volumio-tarci volumio[1296]: code: 'EADDRINUSE', Jun 29 10:40:24 volumio-tarci volumio[1296]: errno: -98, Jun 29 10:40:24 volumio-tarci volumio[1296]: syscall: 'listen', Jun 29 10:40:24 volumio-tarci volumio[1296]: address: '::', Jun 29 10:40:24 volumio-tarci volumio[1296]: port: 6599 Jun 29 10:40:24 volumio-tarci volumio[1296]: } Jun 29 10:40:24 volumio-tarci volumio[1296]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 29 10:40:24 volumio-tarci sudo[3131]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-29 10:39 Jun 29 10:40:24 volumio-tarci sudo[3131]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 05:26:48 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="a63f40325536655a08b14de2b295ce76"