May 03 14:45:02 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::getUIConfigOnPlugin May 03 14:45:02 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 03 14:45:02 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 03 14:45:02 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 03 14:45:02 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs May 03 14:45:03 volumiotouchalfa061 volumio[1179]: info: Received Get System Version May 03 14:45:03 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 03 14:45:04 volumiotouchalfa061 wpa_supplicant[1076]: RRM: Ignoring radio measurement request: Not RRM network May 03 14:45:10 volumiotouchalfa061 wpa_supplicant[1076]: RRM: Ignoring radio measurement request: Not RRM network May 03 14:45:16 volumiotouchalfa061 wpa_supplicant[1076]: RRM: Ignoring radio measurement request: Not RRM network May 03 14:45:17 volumiotouchalfa061 volumio[1179]: info: CALLMETHOD: system_controller system saveGeneralSettings [object Object] May 03 14:45:17 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings May 03 14:45:17 volumiotouchalfa061 volumio[1179]: info: Updating MyVolumio device info May 03 14:45:17 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 03 14:45:17 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 03 14:45:17 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 03 14:45:17 volumiotouchalfa061 vtcs[1938]: [2025-05-03 14:45:17.390] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected May 03 14:45:17 volumiotouchalfa061 vtcs[1938]: [2025-05-03 14:45:17.390] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE May 03 14:45:17 volumiotouchalfa061 volumio[1179]: info: Discovery: Restarting Advertising due to device name change May 03 14:45:17 volumiotouchalfa061 sudo[20321]: volumio : unable to resolve host volumiotouchalfa061: System error May 03 14:45:17 volumiotouchalfa061 sudo[20321]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 03 14:45:17 volumiotouchalfa061 sudo[20321]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 03 14:45:17 volumiotouchalfa061 sudo[20323]: volumio : unable to resolve host volumiotouchalfa061: System error May 03 14:45:17 volumiotouchalfa061 sudo[20325]: volumio : unable to resolve host volumiotouchalfa061: System error May 03 14:45:17 volumiotouchalfa061 sudo[20323]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli May 03 14:45:17 volumiotouchalfa061 sudo[20323]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 03 14:45:17 volumiotouchalfa061 sudo[20325]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 03 14:45:17 volumiotouchalfa061 sudo[20325]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 03 14:45:17 volumiotouchalfa061 sudo[20327]: volumio : unable to resolve host volumiotouchalfa061: System error May 03 14:45:17 volumiotouchalfa061 sudo[20327]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts May 03 14:45:17 volumiotouchalfa061 sudo[20327]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 03 14:45:17 volumiotouchalfa061 sudo[20327]: pam_unix(sudo:session): session closed for user root May 03 14:45:17 volumiotouchalfa061 volumio[1179]: info: Permissions for /etc/hosts set May 03 14:45:17 volumiotouchalfa061 sudo[20323]: pam_unix(sudo:session): session closed for user root May 03 14:45:17 volumiotouchalfa061 volumio[1179]: info: Hostname now is volumiotouch_alfa May 03 14:45:17 volumiotouchalfa061 sudo[20333]: volumio : unable to resolve host volumiotouchalfa061: System error May 03 14:45:17 volumiotouchalfa061 sudo[20333]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/hostname volumiotouch_alfa May 03 14:45:17 volumiotouchalfa061 sudo[20333]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 03 14:45:17 volumiotouchalfa061 volumio[1179]: error: Cannot set new hostname: Error: Command failed: /usr/bin/sudo /bin/hostname volumiotouch_alfa May 03 14:45:17 volumiotouchalfa061 volumio[1179]: sudo: unable to resolve host volumiotouchalfa061: System error May 03 14:45:17 volumiotouchalfa061 volumio[1179]: hostname: the specified hostname is invalid May 03 14:45:17 volumiotouchalfa061 volumio[1179]: info: Permissions for /etc/avahi/services/volumio.service May 03 14:45:17 volumiotouchalfa061 volumio[1179]: info: Avahi name changed to volumiotouch_alfa May 03 14:45:17 volumiotouchalfa061 sudo[20333]: pam_unix(sudo:session): session closed for user root May 03 14:45:17 volumiotouchalfa061 sudo[20335]: volumio : unable to resolve host volumiotouchalfa061: System error May 03 14:45:17 volumiotouchalfa061 sudo[20335]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /etc/avahi/services/ May 03 14:45:17 volumiotouchalfa061 sudo[20335]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 03 14:45:17 volumiotouchalfa061 sudo[20335]: pam_unix(sudo:session): session closed for user root May 03 14:45:17 volumiotouchalfa061 avahi-daemon[584]: Files changed, reloading. May 03 14:45:17 volumiotouchalfa061 avahi-daemon[584]: Service group file /services/volumio.service changed, reloading. May 03 14:45:17 volumiotouchalfa061 systemd[1]: Starting fix-alpha-hosts.service - Fix /etc/hosts and ensure test sentinels... May 03 14:45:17 volumiotouchalfa061 systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... May 03 14:45:17 volumiotouchalfa061 systemd[1]: vtcs.service: Deactivated successfully. May 03 14:45:17 volumiotouchalfa061 systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. May 03 14:45:17 volumiotouchalfa061 systemd[1]: vtcs.service: Consumed 2.819s CPU time. May 03 14:45:17 volumiotouchalfa061 systemd[1]: fix-alpha-hosts.service: Deactivated successfully. May 03 14:45:17 volumiotouchalfa061 systemd[1]: Finished fix-alpha-hosts.service - Fix /etc/hosts and ensure test sentinels. May 03 14:45:17 volumiotouchalfa061 sudo[20321]: pam_unix(sudo:session): session closed for user root May 03 14:45:17 volumiotouchalfa061 sudo[20325]: pam_unix(sudo:session): session closed for user root May 03 14:45:17 volumiotouchalfa061 volumio[1179]: error: Failed to update MyVolumio device: {"message":"Unauthenticated"} May 03 14:45:18 volumiotouchalfa061 volumio[1179]: info: Discovery: A device disappeared from network May 03 14:45:18 volumiotouchalfa061 volumio[1179]: info: Discovery: A device disappeared from network May 03 14:45:18 volumiotouchalfa061 avahi-daemon[584]: Service "Volumiotouch_alfa" (/services/volumio.service) successfully established. May 03 14:45:20 volumiotouchalfa061 volumio[1179]: error: Unable to stop TidalConnect service: May 03 14:45:20 volumiotouchalfa061 volumio[1179]: info: TidalConnect service stoped! May 03 14:45:20 volumiotouchalfa061 volumio[1179]: error: Unable to stop TidalConnect service: May 03 14:45:20 volumiotouchalfa061 volumio[1179]: info: TidalConnect service stoped! May 03 14:45:20 volumiotouchalfa061 volumio[1179]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect May 03 14:45:20 volumiotouchalfa061 volumio[1179]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect May 03 14:45:20 volumiotouchalfa061 sudo[20353]: volumio : unable to resolve host volumiotouchalfa061: System error May 03 14:45:20 volumiotouchalfa061 sudo[20353]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service May 03 14:45:20 volumiotouchalfa061 sudo[20353]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 03 14:45:20 volumiotouchalfa061 systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. May 03 14:45:20 volumiotouchalfa061 sudo[20353]: pam_unix(sudo:session): session closed for user root May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: Executing endpoint tc_getconfig May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig May 03 14:45:21 volumiotouchalfa061 vtcs[20356]: STARTING TidalConnect services, version: 1.5.0.45 May 03 14:45:21 volumiotouchalfa061 vtcs[20356]: STARTED TidalConnect services. May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: Executing endpoint tc_connect May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: Connecting to TidalConnect May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::servicePushState May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CoreStateMachine::pushState May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CorePlayQueue::getTrack 0 May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::volumioPushState May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CorePlayQueue::getTrack 0 May 03 14:45:21 volumiotouchalfa061 volumio[1179]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} May 03 14:45:21 volumiotouchalfa061 volumio[1179]: verbose: CURRENT POSITION 0 May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CoreStateMachine::syncState stateService stop May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CoreStateMachine::syncState currentStatus stop May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CoreStateMachine::pushState May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CorePlayQueue::getTrack 0 May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::volumioPushState May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: No code May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CoreStateMachine::pushState May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CorePlayQueue::getTrack 0 May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::volumioPushState May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::servicePushState May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CoreStateMachine::pushState May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CorePlayQueue::getTrack 0 May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::volumioPushState May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CorePlayQueue::getTrack 0 May 03 14:45:21 volumiotouchalfa061 volumio[1179]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} May 03 14:45:21 volumiotouchalfa061 volumio[1179]: verbose: CURRENT POSITION 0 May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CoreStateMachine::syncState stateService stop May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CoreStateMachine::syncState currentStatus stop May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CoreStateMachine::pushState May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CorePlayQueue::getTrack 0 May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::volumioPushState May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: No code May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CoreStateMachine::pushState May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CorePlayQueue::getTrack 0 May 03 14:45:21 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::volumioPushState May 03 14:45:22 volumiotouchalfa061 volumio[1179]: info: Discovery: Started advertising with name: Volumiotouch_alfa May 03 14:45:22 volumiotouchalfa061 wpa_supplicant[1076]: RRM: Ignoring radio measurement request: Not RRM network May 03 14:45:23 volumiotouchalfa061 volumio[1179]: info: Discovery: adding 8a6a0d03-4b62-46fe-9a0d-881f5e5b9b7c May 03 14:45:23 volumiotouchalfa061 volumio[1179]: info: Discovery: Found device Volumiotouch_alfa May 03 14:45:23 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::volumioGetState May 03 14:45:23 volumiotouchalfa061 volumio[1179]: info: CorePlayQueue::getTrack 0 May 03 14:45:23 volumiotouchalfa061 volumio[1179]: info: Discovery: this is already registered, 8a6a0d03-4b62-46fe-9a0d-881f5e5b9b7c May 03 14:45:23 volumiotouchalfa061 volumio[1179]: info: Discovery: Found device Volumiotouch_alfa May 03 14:45:23 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::volumioGetState May 03 14:45:23 volumiotouchalfa061 volumio[1179]: info: CorePlayQueue::getTrack 0 May 03 14:45:23 volumiotouchalfa061 volumio[1179]: error: Unable to start TidalConnect service: May 03 14:45:23 volumiotouchalfa061 volumio[1179]: info: TidalConnect service started! May 03 14:45:23 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::volumioGetState May 03 14:45:23 volumiotouchalfa061 volumio[1179]: info: CorePlayQueue::getTrack 0 May 03 14:45:27 volumiotouchalfa061 sudo[20391]: volumio : unable to resolve host volumiotouchalfa061: System error May 03 14:45:27 volumiotouchalfa061 sudo[20393]: volumio : unable to resolve host volumiotouchalfa061: System error May 03 14:45:27 volumiotouchalfa061 sudo[20391]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/samba/smb.conf May 03 14:45:27 volumiotouchalfa061 sudo[20391]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 03 14:45:27 volumiotouchalfa061 sudo[20393]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /data/INTERNAL May 03 14:45:27 volumiotouchalfa061 sudo[20393]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 03 14:45:27 volumiotouchalfa061 sudo[20391]: pam_unix(sudo:session): session closed for user root May 03 14:45:27 volumiotouchalfa061 sudo[20393]: pam_unix(sudo:session): session closed for user root May 03 14:45:27 volumiotouchalfa061 volumio[1179]: info: smb.conf Permissions set May 03 14:45:27 volumiotouchalfa061 volumio[1179]: info: Internal perms successfully set May 03 14:45:27 volumiotouchalfa061 sudo[20397]: volumio : unable to resolve host volumiotouchalfa061: System error May 03 14:45:27 volumiotouchalfa061 sudo[20397]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart nmbd.service May 03 14:45:27 volumiotouchalfa061 sudo[20397]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 03 14:45:27 volumiotouchalfa061 sudo[20399]: volumio : unable to resolve host volumiotouchalfa061: System error May 03 14:45:27 volumiotouchalfa061 systemd[1]: Stopping nmbd.service - Samba NMB Daemon... May 03 14:45:27 volumiotouchalfa061 nmbd[999]: [2025/05/03 14:45:27.553256, 0] ../../source3/nmbd/nmbd.c:59(terminate) May 03 14:45:27 volumiotouchalfa061 nmbd[999]: Got SIGTERM: going down... May 03 14:45:27 volumiotouchalfa061 sudo[20401]: volumio : unable to resolve host volumiotouchalfa061: System error May 03 14:45:27 volumiotouchalfa061 sudo[20401]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 03 14:45:27 volumiotouchalfa061 sudo[20401]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 03 14:45:27 volumiotouchalfa061 systemd[1]: nmbd.service: Deactivated successfully. May 03 14:45:27 volumiotouchalfa061 systemd[1]: Stopped nmbd.service - Samba NMB Daemon. May 03 14:45:27 volumiotouchalfa061 systemd[1]: nmbd.service: Consumed 3.952s CPU time. May 03 14:45:27 volumiotouchalfa061 sudo[20404]: volumio : unable to resolve host volumiotouchalfa061: System error May 03 14:45:27 volumiotouchalfa061 sudo[20399]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 03 14:45:27 volumiotouchalfa061 sudo[20401]: pam_unix(sudo:session): session closed for user root May 03 14:45:27 volumiotouchalfa061 systemd[1]: Starting nmbd.service - Samba NMB Daemon... May 03 14:45:27 volumiotouchalfa061 sudo[20399]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 03 14:45:27 volumiotouchalfa061 sudo[20399]: pam_unix(sudo:session): session closed for user root May 03 14:45:27 volumiotouchalfa061 sudo[20404]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 03 14:45:27 volumiotouchalfa061 sudo[20404]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 03 14:45:27 volumiotouchalfa061 sudo[20404]: pam_unix(sudo:session): session closed for user root May 03 14:45:27 volumiotouchalfa061 volumio[1179]: info: Upmpdcli Daemon Started May 03 14:45:27 volumiotouchalfa061 nmbd[20412]: [2025/05/03 14:45:27.950693, 0] ../../source3/nmbd/nmbd.c:901(main) May 03 14:45:27 volumiotouchalfa061 nmbd[20412]: nmbd version 4.17.8-Raspbian started. May 03 14:45:27 volumiotouchalfa061 nmbd[20412]: Copyright Andrew Tridgell and the Samba Team 1992-2022 May 03 14:45:27 volumiotouchalfa061 nmbd[20412]: [2025/05/03 14:45:27.954104, 0] ../../source3/nmbd/asyncdns.c:158(start_async_dns) May 03 14:45:27 volumiotouchalfa061 nmbd[20412]: started asyncdns process 20413 May 03 14:45:27 volumiotouchalfa061 systemd[1]: Started nmbd.service - Samba NMB Daemon. May 03 14:45:27 volumiotouchalfa061 sudo[20397]: pam_unix(sudo:session): session closed for user root May 03 14:45:27 volumiotouchalfa061 sudo[20415]: volumio : unable to resolve host volumiotouchalfa061: System error May 03 14:45:27 volumiotouchalfa061 sudo[20415]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart smbd.service May 03 14:45:27 volumiotouchalfa061 sudo[20415]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 03 14:45:28 volumiotouchalfa061 systemd[1]: Stopping smbd.service - Samba SMB Daemon... May 03 14:45:28 volumiotouchalfa061 systemd[1]: smbd.service: Deactivated successfully. May 03 14:45:28 volumiotouchalfa061 systemd[1]: Stopped smbd.service - Samba SMB Daemon. May 03 14:45:28 volumiotouchalfa061 systemd[1]: Starting smbd.service - Samba SMB Daemon... May 03 14:45:28 volumiotouchalfa061 smbd[20420]: [2025/05/03 14:45:28.310220, 0] ../../source3/smbd/server.c:1741(main) May 03 14:45:28 volumiotouchalfa061 smbd[20420]: smbd version 4.17.8-Raspbian started. May 03 14:45:28 volumiotouchalfa061 smbd[20420]: Copyright Andrew Tridgell and the Samba Team 1992-2022 May 03 14:45:28 volumiotouchalfa061 systemd[1]: Started smbd.service - Samba SMB Daemon. May 03 14:45:28 volumiotouchalfa061 sudo[20415]: pam_unix(sudo:session): session closed for user root May 03 14:45:28 volumiotouchalfa061 volumio[1179]: info: SAMBA Restarted May 03 14:45:29 volumiotouchalfa061 wpa_supplicant[1076]: RRM: Ignoring radio measurement request: Not RRM network May 03 14:45:29 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri May 03 14:45:29 volumiotouchalfa061 volumio[1179]: info: Preload queue cleared May 03 14:45:35 volumiotouchalfa061 wpa_supplicant[1076]: RRM: Ignoring radio measurement request: Not RRM network May 03 14:45:37 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 03 14:45:37 volumiotouchalfa061 volumio[1179]: info: CURURI: music-library May 03 14:45:37 volumiotouchalfa061 volumio[1179]: info: Preload queue cleared May 03 14:45:40 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 03 14:45:40 volumiotouchalfa061 volumio[1179]: info: CURURI: music-library/NAS May 03 14:45:40 volumiotouchalfa061 volumio[1179]: info: Preload queue cleared May 03 14:45:40 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 03 14:45:40 volumiotouchalfa061 volumio[1179]: info: CURURI: music-library/NAS/NAS May 03 14:45:40 volumiotouchalfa061 volumio[1179]: error: Failed LSINFO: null May 03 14:45:41 volumiotouchalfa061 volumio[1179]: info: Preload queue cleared May 03 14:45:41 volumiotouchalfa061 wpa_supplicant[1076]: RRM: Ignoring radio measurement request: Not RRM network May 03 14:45:43 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 03 14:45:43 volumiotouchalfa061 volumio[1179]: info: CURURI: music-library/USB May 03 14:45:43 volumiotouchalfa061 volumio[1179]: error: Failed LSINFO: null May 03 14:45:43 volumiotouchalfa061 volumio[1179]: info: Preload queue cleared May 03 14:45:45 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 03 14:45:45 volumiotouchalfa061 volumio[1179]: info: CURURI: music-library/INTERNAL May 03 14:45:45 volumiotouchalfa061 volumio[1179]: error: Failed LSINFO: null May 03 14:45:45 volumiotouchalfa061 volumio[1179]: info: Preload queue cleared May 03 14:45:47 volumiotouchalfa061 wpa_supplicant[1076]: RRM: Ignoring radio measurement request: Not RRM network May 03 14:45:49 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 03 14:45:49 volumiotouchalfa061 volumio[1179]: info: CURURI: albums:// May 03 14:45:49 volumiotouchalfa061 volumio[1179]: info: listAlbums - loading Albums from cache May 03 14:45:49 volumiotouchalfa061 volumio[1179]: info: Preload queue cleared May 03 14:45:52 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::volumioGetState May 03 14:45:52 volumiotouchalfa061 volumio[1179]: info: CorePlayQueue::getTrack 0 May 03 14:45:53 volumiotouchalfa061 wpa_supplicant[1076]: RRM: Ignoring radio measurement request: Not RRM network May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::getUIConfigOnPlugin May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::getUIConfigOnPlugin May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: Retrieving Cloud Streaming UI May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: Getting Tidal Cloud Configuration May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::getUIConfigOnPlugin May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: Getting Qobuz Cloud Configuration May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: Asking plugin for UI Config May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::getUIConfigOnPlugin May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: Getting Spotify Cloud Configuration May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: Asking plugin for UI Config May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::getUIConfigOnPlugin May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: Saving Spotify Acccount May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: Got it May 03 14:45:55 volumiotouchalfa061 volumio[1179]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: Got Tidal Cloud Configuration May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: Got it May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::getUIConfigOnPlugin May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::volumioGetBrowseSources May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::volumioGetBrowseSources May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::volumioGetBrowseSources May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 03 14:45:55 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 03 14:45:59 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 03 14:45:59 volumiotouchalfa061 wpa_supplicant[1076]: RRM: Ignoring radio measurement request: Not RRM network May 03 14:45:59 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare May 03 14:46:02 volumiotouchalfa061 volumio[1179]: verbose: ControllerMpd::sendMpdCommand status May 03 14:46:02 volumiotouchalfa061 volumio[1179]: info: May 03 14:46:02 volumiotouchalfa061 volumio[1179]: ---------------------------- MPD announces state update: update May 03 14:46:02 volumiotouchalfa061 volumio[1179]: info: ControllerMpd::getState May 03 14:46:02 volumiotouchalfa061 volumio[1179]: verbose: ControllerMpd::sendMpdCommand status May 03 14:46:02 volumiotouchalfa061 volumio[1179]: info: sendMpdCommand status took 2 milliseconds May 03 14:46:02 volumiotouchalfa061 volumio[1179]: info: sendMpdCommand status took 1 milliseconds May 03 14:46:02 volumiotouchalfa061 volumio[1179]: verbose: ControllerMpd::parseState May 03 14:46:02 volumiotouchalfa061 volumio[1179]: info: Command Router : Notfying DB Updatetrue May 03 14:46:02 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::Close All Modals sent May 03 14:46:02 volumiotouchalfa061 volumio[1179]: verbose: ControllerMpd::parseState May 03 14:46:02 volumiotouchalfa061 volumio[1179]: info: ControllerMpd::pushState May 03 14:46:02 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::servicePushState May 03 14:46:02 volumiotouchalfa061 volumio[1179]: info: CoreStateMachine::pushState May 03 14:46:02 volumiotouchalfa061 volumio[1179]: info: CorePlayQueue::getTrack 0 May 03 14:46:02 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::volumioPushState May 03 14:46:02 volumiotouchalfa061 volumio[1179]: info: CorePlayQueue::getTrack 0 May 03 14:46:02 volumiotouchalfa061 volumio[1179]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 03 14:46:02 volumiotouchalfa061 volumio[1179]: verbose: CURRENT POSITION 0 May 03 14:46:02 volumiotouchalfa061 volumio[1179]: info: CoreStateMachine::syncState stateService stop May 03 14:46:02 volumiotouchalfa061 volumio[1179]: info: CoreStateMachine::syncState currentStatus stop May 03 14:46:02 volumiotouchalfa061 volumio[1179]: info: CoreStateMachine::pushState May 03 14:46:02 volumiotouchalfa061 volumio[1179]: info: CorePlayQueue::getTrack 0 May 03 14:46:02 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 03 14:46:02 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::volumioPushState May 03 14:46:02 volumiotouchalfa061 volumio[1179]: info: No code May 03 14:46:02 volumiotouchalfa061 volumio[1179]: info: CoreStateMachine::pushState May 03 14:46:02 volumiotouchalfa061 volumio[1179]: info: CorePlayQueue::getTrack 0 May 03 14:46:02 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::volumioPushState May 03 14:46:02 volumiotouchalfa061 volumio[1179]: info: ------------------------------ 37ms May 03 14:46:02 volumiotouchalfa061 volumio[1179]: info: [1746279962997] Database update started May 03 14:46:03 volumiotouchalfa061 volumio[1179]: verbose: ControllerMpd::sendMpdCommand status May 03 14:46:03 volumiotouchalfa061 volumio[1179]: info: May 03 14:46:03 volumiotouchalfa061 volumio[1179]: ---------------------------- MPD announces state update: update May 03 14:46:03 volumiotouchalfa061 volumio[1179]: info: ControllerMpd::getState May 03 14:46:03 volumiotouchalfa061 volumio[1179]: verbose: ControllerMpd::sendMpdCommand status May 03 14:46:03 volumiotouchalfa061 volumio[1179]: info: sendMpdCommand status took 14 milliseconds May 03 14:46:03 volumiotouchalfa061 volumio[1179]: info: sendMpdCommand status took 13 milliseconds May 03 14:46:03 volumiotouchalfa061 volumio[1179]: verbose: ControllerMpd::parseState May 03 14:46:03 volumiotouchalfa061 volumio[1179]: info: Command Router : Notfying DB Updatefalse May 03 14:46:03 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::Close All Modals sent May 03 14:46:03 volumiotouchalfa061 volumio[1179]: verbose: ControllerMpd::parseState May 03 14:46:03 volumiotouchalfa061 volumio[1179]: info: ControllerMpd::pushState May 03 14:46:03 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::servicePushState May 03 14:46:03 volumiotouchalfa061 volumio[1179]: info: CoreStateMachine::pushState May 03 14:46:03 volumiotouchalfa061 volumio[1179]: info: CorePlayQueue::getTrack 0 May 03 14:46:03 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::volumioPushState May 03 14:46:03 volumiotouchalfa061 volumio[1179]: info: CorePlayQueue::getTrack 0 May 03 14:46:03 volumiotouchalfa061 volumio[1179]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 03 14:46:03 volumiotouchalfa061 volumio[1179]: verbose: CURRENT POSITION 0 May 03 14:46:03 volumiotouchalfa061 volumio[1179]: info: CoreStateMachine::syncState stateService stop May 03 14:46:03 volumiotouchalfa061 volumio[1179]: info: CoreStateMachine::syncState currentStatus stop May 03 14:46:03 volumiotouchalfa061 volumio[1179]: info: CoreStateMachine::pushState May 03 14:46:03 volumiotouchalfa061 volumio[1179]: info: CorePlayQueue::getTrack 0 May 03 14:46:03 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 03 14:46:03 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::volumioPushState May 03 14:46:03 volumiotouchalfa061 volumio[1179]: info: No code May 03 14:46:03 volumiotouchalfa061 volumio[1179]: info: CoreStateMachine::pushState May 03 14:46:03 volumiotouchalfa061 volumio[1179]: info: CorePlayQueue::getTrack 0 May 03 14:46:03 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::volumioPushState May 03 14:46:03 volumiotouchalfa061 volumio[1179]: info: ------------------------------ 60ms May 03 14:46:03 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares May 03 14:46:03 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService May 03 14:46:03 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 03 14:46:04 volumiotouchalfa061 volumio[1179]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L myvol-vm-mojo2.local. May 03 14:46:05 volumiotouchalfa061 sudo[20473]: volumio : unable to resolve host volumiotouchalfa061: System error May 03 14:46:05 volumiotouchalfa061 sudo[20473]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/NAS May 03 14:46:05 volumiotouchalfa061 sudo[20473]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 03 14:46:05 volumiotouchalfa061 systemd[1]: mnt-NAS-NAS.mount: Deactivated successfully. May 03 14:46:05 volumiotouchalfa061 sudo[20473]: pam_unix(sudo:session): session closed for user root May 03 14:46:05 volumiotouchalfa061 volumio[1179]: info: Share NAS successfully unmounted May 03 14:46:06 volumiotouchalfa061 wpa_supplicant[1076]: RRM: Ignoring radio measurement request: Not RRM network May 03 14:46:06 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 03 14:46:07 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 03 14:46:09 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares May 03 14:46:09 volumiotouchalfa061 volumio[1179]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService May 03 14:46:09 volumiotouchalfa061 volumio[1179]: compat.c: read() failed: Resource temporarily unavailable May 03 14:46:09 volumiotouchalfa061 volumio[1179]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 03 14:46:09 volumiotouchalfa061 volumio[1179]: Error: dns service error: unknown May 03 14:46:09 volumiotouchalfa061 volumio[1179]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { May 03 14:46:09 volumiotouchalfa061 volumio[1179]: errorCode: -65537 May 03 14:46:09 volumiotouchalfa061 volumio[1179]: } May 03 14:46:09 volumiotouchalfa061 volumio[1179]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 03 14:46:09 volumiotouchalfa061 sudo[20522]: volumio : unable to resolve host volumiotouchalfa061: System error May 03 14:46:09 volumiotouchalfa061 sudo[20522]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-05-03 14:45' May 03 14:46:09 volumiotouchalfa061 sudo[20522]: 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="79f1f80789345dd4c5f4d4c23193d9ee349bfb22" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="cea21cd6ccc30cdffa3cef0ae4463d42ccc98d68" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu May 1 12:46:53 UTC 2025" VOLUMIO_VERSION="0.062" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="752a4fa765590f3eedcb1f8bcb72a514"