-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Fri 2025-06-20 09:39:01 CEST. -- Jun 20 09:38:05 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioGetState Jun 20 09:38:05 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:15 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioGetState Jun 20 09:38:15 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:15 smsl-n100 volumio[1204]: info: Listing playlists Jun 20 09:38:15 smsl-n100 volumio[1204]: info: Listing playlists Jun 20 09:38:18 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 20 09:38:18 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 20 09:38:18 smsl-n100 volumio[1204]: info: Discovery: Getting this device information Jun 20 09:38:18 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioGetState Jun 20 09:38:18 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:18 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 20 09:38:18 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 20 09:38:18 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 20 09:38:18 smsl-n100 volumio[1204]: info: Discovery: Getting this device information Jun 20 09:38:18 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioGetState Jun 20 09:38:18 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:18 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 20 09:38:18 smsl-n100 volumio[1204]: verbose: New Socket.io Connection to 192.168.0.120:3000 from 192.168.0.108 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Jun 20 09:38:18 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioGetState Jun 20 09:38:18 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:18 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 20 09:38:18 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 20 09:38:18 smsl-n100 volumio-remote-updater[559]: No test mode Jun 20 09:38:18 smsl-n100 volumio-remote-updater[559]: No alpha test mode Jun 20 09:38:18 smsl-n100 volumio[1204]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jun 20 09:38:18 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jun 20 09:38:19 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 20 09:38:19 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 20 09:38:19 smsl-n100 volumio[1204]: info: Discovery: Getting this device information Jun 20 09:38:19 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioGetState Jun 20 09:38:19 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:19 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 20 09:38:19 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 20 09:38:19 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 20 09:38:19 smsl-n100 volumio[1204]: info: Discovery: Getting this device information Jun 20 09:38:19 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioGetState Jun 20 09:38:19 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:19 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 20 09:38:19 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioGetState Jun 20 09:38:19 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:20 smsl-n100 sudo[12689]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 20 09:38:20 smsl-n100 sudo[12689]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:20 smsl-n100 sudo[12689]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:20 smsl-n100 sudo[12691]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 20 09:38:20 smsl-n100 sudo[12691]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:20 smsl-n100 sudo[12691]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:20 smsl-n100 volumio[1204]: verbose: New Socket.io Connection to 192.168.0.120 from 192.168.0.108 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Engine version: 3 Transport: polling Total Clients: 7 Jun 20 09:38:20 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioGetVisibleSources Jun 20 09:38:20 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 20 09:38:20 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Jun 20 09:38:20 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Jun 20 09:38:20 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:20 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Jun 20 09:38:20 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Jun 20 09:38:20 smsl-n100 volumio[1204]: info: Received Get System Info Jun 20 09:38:20 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 20 09:38:20 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 20 09:38:20 smsl-n100 volumio[1204]: info: Discovery: Getting this device information Jun 20 09:38:20 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioGetState Jun 20 09:38:20 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:20 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 20 09:38:20 smsl-n100 volumio-remote-updater[559]: No test mode Jun 20 09:38:20 smsl-n100 volumio-remote-updater[559]: No alpha test mode Jun 20 09:38:20 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 20 09:38:20 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 20 09:38:20 smsl-n100 volumio[1204]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 20 09:38:20 smsl-n100 volumio[1204]: info: Retrieving Cloud Streaming UI Jun 20 09:38:20 smsl-n100 volumio[1204]: info: Getting Tidal Cloud Configuration Jun 20 09:38:20 smsl-n100 volumio[1204]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 20 09:38:20 smsl-n100 volumio[1204]: info: Getting Qobuz Cloud Configuration Jun 20 09:38:20 smsl-n100 volumio[1204]: info: Asking plugin for UI Config Jun 20 09:38:20 smsl-n100 volumio[1204]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 20 09:38:20 smsl-n100 volumio[1204]: info: Getting Spotify Cloud Configuration Jun 20 09:38:20 smsl-n100 volumio[1204]: info: Asking plugin for UI Config Jun 20 09:38:20 smsl-n100 volumio[1204]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 20 09:38:20 smsl-n100 volumio[1204]: info: Saving Spotify Acccount Jun 20 09:38:20 smsl-n100 volumio[1204]: info: Got it Jun 20 09:38:20 smsl-n100 volumio[1204]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jun 20 09:38:20 smsl-n100 volumio[1204]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jun 20 09:38:20 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jun 20 09:38:20 smsl-n100 volumio[1204]: info: Got Tidal Cloud Configuration Jun 20 09:38:20 smsl-n100 volumio[1204]: info: Got it Jun 20 09:38:20 smsl-n100 volumio[1204]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 20 09:38:21 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Jun 20 09:38:21 smsl-n100 volumio[1204]: info: Loading i18n strings for locale cs Jun 20 09:38:21 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Jun 20 09:38:21 smsl-n100 volumio[1204]: info: Setting timezone to Europe/Prague Jun 20 09:38:21 smsl-n100 sudo[12699]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Jun 20 09:38:21 smsl-n100 sudo[12699]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:21 smsl-n100 sudo[12699]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:21 smsl-n100 sudo[12702]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Prague /etc/localtime Jun 20 09:38:21 smsl-n100 sudo[12702]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:21 smsl-n100 sudo[12702]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:22 smsl-n100 sudo[12705]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Jun 20 09:38:22 smsl-n100 sudo[12705]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:22 smsl-n100 sudo[12705]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:22 smsl-n100 sudo[12708]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Prague Jun 20 09:38:22 smsl-n100 sudo[12708]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:22 smsl-n100 dbus-daemon[581]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.43' (uid=0 pid=12709 comm="/usr/bin/timedatectl set-timezone Europe/Prague ") Jun 20 09:38:22 smsl-n100 systemd[1]: Starting Time & Date Service... Jun 20 09:38:22 smsl-n100 dbus-daemon[581]: [system] Successfully activated service 'org.freedesktop.timedate1' Jun 20 09:38:22 smsl-n100 systemd[1]: Started Time & Date Service. Jun 20 09:38:22 smsl-n100 sudo[12708]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:22 smsl-n100 volumio[1204]: info: Fetching Streaming Services browse cache Jun 20 09:38:22 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 20 09:38:22 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 09:38:22 smsl-n100 volumio[1204]: Updating browse sources language Jun 20 09:38:22 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 20 09:38:23 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Jun 20 09:38:23 smsl-n100 volumio[1204]: info: Loading i18n strings for locale cs Jun 20 09:38:23 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Jun 20 09:38:23 smsl-n100 volumio[1204]: info: Setting timezone to Europe/Prague Jun 20 09:38:24 smsl-n100 sudo[12712]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Jun 20 09:38:24 smsl-n100 sudo[12712]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:24 smsl-n100 sudo[12712]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:24 smsl-n100 sudo[12715]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Prague /etc/localtime Jun 20 09:38:24 smsl-n100 sudo[12715]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:24 smsl-n100 sudo[12715]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:24 smsl-n100 sudo[12718]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Jun 20 09:38:24 smsl-n100 sudo[12718]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:24 smsl-n100 sudo[12718]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:24 smsl-n100 sudo[12721]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Prague Jun 20 09:38:24 smsl-n100 sudo[12721]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:24 smsl-n100 sudo[12721]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:24 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Jun 20 09:38:24 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Jun 20 09:38:24 smsl-n100 sudo[12724]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 20 09:38:24 smsl-n100 sudo[12724]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:24 smsl-n100 volumio[1204]: Updating browse sources language Jun 20 09:38:24 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 20 09:38:24 smsl-n100 volumio[1204]: info: Fetching Streaming Services browse cache Jun 20 09:38:24 smsl-n100 sudo[12724]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:25 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioGetState Jun 20 09:38:25 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:25 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Jun 20 09:38:26 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:26 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 20 09:38:26 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 09:38:26 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 20 09:38:28 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jun 20 09:38:28 smsl-n100 volumio[1204]: info: Preparing to save Alsa Options, stopping services first Jun 20 09:38:28 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioGetState Jun 20 09:38:28 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:28 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPause Jun 20 09:38:28 smsl-n100 volumio[1204]: info: CoreStateMachine::pause Jun 20 09:38:28 smsl-n100 volumio[1204]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"1","label":"SPDIF"},"disallowPush":true} Jun 20 09:38:28 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 20 09:38:28 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:28 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:28 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 20 09:38:28 smsl-n100 volumio[1204]: info: Found match in Cards Database: setting mixer for card SPDIF Jun 20 09:38:28 smsl-n100 volumio[1204]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes Jun 20 09:38:28 smsl-n100 vtcs[1616]: [2025-06-20 09:38:28.374] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Jun 20 09:38:28 smsl-n100 vtcs[1616]: [2025-06-20 09:38:28.377] [tisoc] [error] [SpkconServer.cpp:381] recv error. client fd=8 errorno=104 error=Connection reset by peer Jun 20 09:38:28 smsl-n100 vtcs[1616]: [2025-06-20 09:38:28.377] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Jun 20 09:38:28 smsl-n100 sudo[12748]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 20 09:38:28 smsl-n100 sudo[12748]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:28 smsl-n100 systemd[1]: Stopping Volumio Tidal Connect Service... Jun 20 09:38:28 smsl-n100 systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Jun 20 09:38:28 smsl-n100 systemd[1]: vtcs.service: Succeeded. Jun 20 09:38:28 smsl-n100 systemd[1]: Stopped Volumio Tidal Connect Service. Jun 20 09:38:28 smsl-n100 sudo[12748]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:28 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:28 smsl-n100 volumio[1204]: info: Device 1 does not have any Mixer Control Available Jun 20 09:38:28 smsl-n100 volumio[1204]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes Jun 20 09:38:28 smsl-n100 sudo[12754]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 20 09:38:28 smsl-n100 sudo[12754]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:28 smsl-n100 sudo[12754]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:28 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:28 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jun 20 09:38:28 smsl-n100 volumio[1204]: info: Updating Volume Controller Parameters: Device: 1 Name: SPDIF Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jun 20 09:38:28 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jun 20 09:38:28 smsl-n100 volumio[1204]: info: Disabling external Volume Control Jun 20 09:38:28 smsl-n100 volumio[1204]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 20 09:38:28 smsl-n100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:28 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:28 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 09:38:28 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:28 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:28 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:28 smsl-n100 volumio[1204]: info: Preparing to generate the ALSA configuration file Jun 20 09:38:28 smsl-n100 sudo[12760]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 20 09:38:28 smsl-n100 sudo[12760]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:28 smsl-n100 sudo[12762]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 20 09:38:28 smsl-n100 sudo[12762]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:28 smsl-n100 sudo[12760]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:28 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:28 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:28 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:28 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:28 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:28 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:28 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:28 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:28 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:29 smsl-n100 volumio[1204]: info: Not Reporting Auto name since its the default one Jun 20 09:38:29 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 09:38:29 smsl-n100 sudo[12762]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:29 smsl-n100 volumio[1204]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 20 09:38:29 smsl-n100 volumio[1204]: info: Reading ALSA contributions from plugins. Jun 20 09:38:29 smsl-n100 volumio[1204]: info: Updating RAAT Signal Path Jun 20 09:38:29 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:29 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:29 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:29 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:29 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:29 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:29 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:29 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:29 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:29 smsl-n100 volumio[1204]: info: Not Reporting Auto name since its the default one Jun 20 09:38:29 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 20 09:38:29 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:29 smsl-n100 sudo[12782]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 20 09:38:29 smsl-n100 sudo[12782]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:29 smsl-n100 sudo[12782]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:29 smsl-n100 sudo[12786]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 20 09:38:29 smsl-n100 sudo[12786]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:29 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:29 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 20 09:38:29 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 09:38:29 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 20 09:38:29 smsl-n100 systemd[1]: Stopping RAAT DAEMON... Jun 20 09:38:29 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jun 20 09:38:29 smsl-n100 systemd[1]: raat-daemon.service: Succeeded. Jun 20 09:38:29 smsl-n100 systemd[1]: Stopped RAAT DAEMON. Jun 20 09:38:29 smsl-n100 systemd[1]: Started RAAT DAEMON. Jun 20 09:38:29 smsl-n100 sudo[12786]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:29 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:29 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:29 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:29 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:29 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:29 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:29 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:29 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:29 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 20 09:38:29 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 20 09:38:29 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Jun 20 09:38:29 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 20 09:38:29 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:29 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 09:38:29 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 20 09:38:29 smsl-n100 sudo[12803]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 20 09:38:29 smsl-n100 sudo[12803]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:29 smsl-n100 volumio[1204]: info: Raat Daemon started successfully Jun 20 09:38:29 smsl-n100 sudo[12803]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:29 smsl-n100 volumio[1204]: info: Executing endpoint restartRAATSocket Jun 20 09:38:29 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 20 09:38:29 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:29 smsl-n100 sudo[12805]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 20 09:38:29 smsl-n100 sudo[12805]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:29 smsl-n100 volumio[1204]: info: Asound.conf file unchanged, so no further update is needed Jun 20 09:38:29 smsl-n100 volumio[1204]: info: Output device has changed, restarting MPD Jun 20 09:38:29 smsl-n100 systemd[1]: Stopping RAAT DAEMON... Jun 20 09:38:29 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jun 20 09:38:29 smsl-n100 systemd[1]: raat-daemon.service: Succeeded. Jun 20 09:38:29 smsl-n100 systemd[1]: Stopped RAAT DAEMON. Jun 20 09:38:29 smsl-n100 systemd[1]: Started RAAT DAEMON. Jun 20 09:38:29 smsl-n100 sudo[12805]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:30 smsl-n100 sudo[12810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 20 09:38:30 smsl-n100 sudo[12810]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:30 smsl-n100 volumio[1204]: info: Output device has changed, restarting Shairport Sync Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 09:38:30 smsl-n100 sudo[12810]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:30 smsl-n100 sudo[12818]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 20 09:38:30 smsl-n100 sudo[12818]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:30 smsl-n100 systemd[1]: Stopping Music Player Daemon... Jun 20 09:38:30 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:30 smsl-n100 volumio[1204]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 20 09:38:30 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:30 smsl-n100 volumio[1204]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:30 smsl-n100 systemd[1]: mpd.service: Succeeded. Jun 20 09:38:30 smsl-n100 systemd[1]: Stopped Music Player Daemon. Jun 20 09:38:30 smsl-n100 systemd[1]: Starting Music Player Daemon... Jun 20 09:38:30 smsl-n100 volumio[1204]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:30 smsl-n100 sudo[12833]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 20 09:38:30 smsl-n100 sudo[12833]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:30 smsl-n100 sudo[12835]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 20 09:38:30 smsl-n100 sudo[12835]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:30 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 09:38:30 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 20 09:38:30 smsl-n100 sudo[12833]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:30 smsl-n100 sudo[12829]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 20 09:38:30 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 09:38:30 smsl-n100 sudo[12829]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:30 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 20 09:38:30 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 09:38:30 smsl-n100 sudo[12829]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:30 smsl-n100 volumio[1204]: info: MPD Permissions set Jun 20 09:38:30 smsl-n100 sudo[12835]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:30 smsl-n100 volumio[1204]: info: Raat Daemon started successfully Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:30 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:30 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:30 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 09:38:30 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 20 09:38:30 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 09:38:30 smsl-n100 volumio[1204]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:30 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:30 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:30 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 09:38:30 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 20 09:38:30 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 09:38:30 smsl-n100 volumio[1204]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 20 09:38:30 smsl-n100 volumio[1204]: info: Executing endpoint restartRAATSocket Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 20 09:38:30 smsl-n100 volumio[1204]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:30 smsl-n100 volumio[1204]: info: Not Reporting Auto name since its the default one Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:30 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:31 smsl-n100 volumio[1204]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jun 20 09:38:31 smsl-n100 volumio[1204]: info: Starting Shairport Sync Jun 20 09:38:31 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 20 09:38:31 smsl-n100 sudo[12854]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 20 09:38:31 smsl-n100 sudo[12854]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:31 smsl-n100 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 20 09:38:31 smsl-n100 systemd[1]: shairport-sync.service: Succeeded. Jun 20 09:38:31 smsl-n100 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 20 09:38:31 smsl-n100 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 20 09:38:31 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:31 smsl-n100 sudo[12854]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:31 smsl-n100 sudo[12861]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 20 09:38:31 smsl-n100 sudo[12861]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:31 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 09:38:31 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 20 09:38:31 smsl-n100 sudo[12861]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:31 smsl-n100 volumio[1204]: info: Shairport-Sync Started Jun 20 09:38:31 smsl-n100 sudo[12865]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 20 09:38:31 smsl-n100 sudo[12865]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:31 smsl-n100 systemd[1]: Stopping RAAT DAEMON... Jun 20 09:38:31 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jun 20 09:38:31 smsl-n100 systemd[1]: raat-daemon.service: Succeeded. Jun 20 09:38:31 smsl-n100 systemd[1]: Stopped RAAT DAEMON. Jun 20 09:38:31 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 09:38:31 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 20 09:38:31 smsl-n100 systemd[1]: Started RAAT DAEMON. Jun 20 09:38:31 smsl-n100 sudo[12865]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:31 smsl-n100 volumio[1204]: info: TidalConnect service stoped! Jun 20 09:38:31 smsl-n100 volumio[1204]: info: Raat Daemon started successfully Jun 20 09:38:31 smsl-n100 volumio[1204]: info: TidalConnect service stoped! Jun 20 09:38:31 smsl-n100 volumio[1204]: info: Executing endpoint restartRAATSocket Jun 20 09:38:31 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 20 09:38:31 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:31 smsl-n100 volumio[1204]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jun 20 09:38:31 smsl-n100 volumio[1204]: info: TidalConnect service stoped! Jun 20 09:38:32 smsl-n100 volumio[1204]: info: TidalConnect service stoped! Jun 20 09:38:32 smsl-n100 volumio[1204]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 20 09:38:32 smsl-n100 volumio[1204]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 20 09:38:32 smsl-n100 volumio[1204]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 20 09:38:32 smsl-n100 volumio[1204]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 20 09:38:32 smsl-n100 sudo[12895]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 20 09:38:32 smsl-n100 sudo[12895]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:32 smsl-n100 volumio[1204]: info: RAAT: Requesting Headphone Status Jun 20 09:38:32 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jun 20 09:38:32 smsl-n100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:32 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:32 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:32 smsl-n100 sudo[12898]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 20 09:38:32 smsl-n100 sudo[12898]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:32 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:32 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:32 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 09:38:32 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 20 09:38:32 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 09:38:32 smsl-n100 systemd[1]: Started Volumio Tidal Connect Service. Jun 20 09:38:32 smsl-n100 volumio[1204]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 20 09:38:32 smsl-n100 sudo[12895]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:32 smsl-n100 sudo[12898]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:32 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jun 20 09:38:32 smsl-n100 volumio[1204]: info: CoreStateMachine::getcurrentVolume Jun 20 09:38:32 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioRetrievevolume Jun 20 09:38:32 smsl-n100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:32 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:32 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 09:38:32 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:32 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:32 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:32 smsl-n100 volumio[1204]: info: Updating RAAT Signal Path Jun 20 09:38:32 smsl-n100 volumio[1204]: info: RAAT: Requesting Headphone Status Jun 20 09:38:32 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jun 20 09:38:32 smsl-n100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:32 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:32 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 09:38:32 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:32 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:32 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:32 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 09:38:32 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 20 09:38:32 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 09:38:32 smsl-n100 volumio[1204]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 20 09:38:32 smsl-n100 volumio[1204]: info: Executing endpoint tc_getconfig Jun 20 09:38:32 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jun 20 09:38:33 smsl-n100 vtcs[12900]: STARTING TidalConnect services, version: 1.4.0.34 Jun 20 09:38:33 smsl-n100 vtcs[12900]: STARTED TidalConnect services. Jun 20 09:38:33 smsl-n100 volumio[1204]: info: Executing endpoint tc_connect Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jun 20 09:38:33 smsl-n100 volumio[1204]: info: Connecting to TidalConnect Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CoreCommandRouter::servicePushState Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:33 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:33 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:33 smsl-n100 volumio[1204]: 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} Jun 20 09:38:33 smsl-n100 volumio[1204]: verbose: CURRENT POSITION 0 Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CoreStateMachine::syncState stateService stop Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CoreStateMachine::syncState currentStatus stop Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:33 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:33 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:33 smsl-n100 volumio[1204]: info: No code Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:33 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:33 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CoreCommandRouter::servicePushState Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:33 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:33 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:33 smsl-n100 volumio[1204]: 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} Jun 20 09:38:33 smsl-n100 volumio[1204]: verbose: CURRENT POSITION 0 Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CoreStateMachine::syncState stateService stop Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CoreStateMachine::syncState currentStatus stop Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:33 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:33 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:33 smsl-n100 volumio[1204]: info: No code Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:33 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:33 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:33 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:33 smsl-n100 volumio[1204]: info: TidalConnect service stoped! Jun 20 09:38:33 smsl-n100 volumio[1204]: info: TidalConnect service stoped! Jun 20 09:38:33 smsl-n100 volumio[1204]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 20 09:38:33 smsl-n100 volumio[1204]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 20 09:38:33 smsl-n100 sudo[12929]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 20 09:38:33 smsl-n100 sudo[12929]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:33 smsl-n100 sudo[12929]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:34 smsl-n100 volumio[1204]: info: RAAT: Requesting Headphone Status Jun 20 09:38:34 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jun 20 09:38:34 smsl-n100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:34 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:34 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:34 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:34 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:34 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 09:38:34 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 20 09:38:34 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 09:38:34 smsl-n100 volumio[1204]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 20 09:38:34 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Jun 20 09:38:34 smsl-n100 volumio[1204]: info: Loading i18n strings for locale en Jun 20 09:38:34 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Jun 20 09:38:34 smsl-n100 volumio[1204]: info: Setting timezone to Europe/Prague Jun 20 09:38:34 smsl-n100 sudo[12933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Jun 20 09:38:34 smsl-n100 sudo[12933]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:34 smsl-n100 sudo[12933]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:34 smsl-n100 sudo[12936]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Prague /etc/localtime Jun 20 09:38:34 smsl-n100 sudo[12936]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:34 smsl-n100 sudo[12936]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:34 smsl-n100 mpd[12840]: Jun 20 09:38 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 20 09:38:34 smsl-n100 systemd[1]: Started Music Player Daemon. Jun 20 09:38:34 smsl-n100 sudo[12818]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:35 smsl-n100 sudo[12941]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Jun 20 09:38:35 smsl-n100 sudo[12941]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:35 smsl-n100 sudo[12941]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:35 smsl-n100 sudo[12944]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Prague Jun 20 09:38:35 smsl-n100 sudo[12944]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:35 smsl-n100 sudo[12944]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:35 smsl-n100 volumio[1204]: Updating browse sources language Jun 20 09:38:35 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 20 09:38:35 smsl-n100 volumio[1204]: error: updateQueue error: null Jun 20 09:38:35 smsl-n100 volumio[1204]: info: Fetching Streaming Services browse cache Jun 20 09:38:35 smsl-n100 volumio[1204]: info: TidalConnect service started! Jun 20 09:38:35 smsl-n100 volumio[1204]: info: TidalConnect service started! Jun 20 09:38:35 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Jun 20 09:38:35 smsl-n100 volumio[1204]: info: Loading i18n strings for locale en Jun 20 09:38:35 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioGetState Jun 20 09:38:35 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:35 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Jun 20 09:38:35 smsl-n100 volumio[1204]: info: Setting timezone to Europe/Prague Jun 20 09:38:35 smsl-n100 sudo[12947]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Jun 20 09:38:35 smsl-n100 sudo[12947]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:35 smsl-n100 sudo[12947]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:35 smsl-n100 sudo[12950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Prague /etc/localtime Jun 20 09:38:35 smsl-n100 sudo[12950]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:35 smsl-n100 sudo[12950]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:35 smsl-n100 sudo[12953]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Jun 20 09:38:35 smsl-n100 sudo[12953]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:35 smsl-n100 sudo[12953]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:35 smsl-n100 sudo[12956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Prague Jun 20 09:38:35 smsl-n100 sudo[12956]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:36 smsl-n100 sudo[12956]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:36 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Jun 20 09:38:36 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Jun 20 09:38:36 smsl-n100 sudo[12959]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 20 09:38:36 smsl-n100 sudo[12959]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:36 smsl-n100 volumio[1204]: Updating browse sources language Jun 20 09:38:36 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 20 09:38:36 smsl-n100 volumio[1204]: info: Listing playlists Jun 20 09:38:36 smsl-n100 volumio[1204]: info: Listing playlists Jun 20 09:38:36 smsl-n100 volumio[1204]: info: Fetching Streaming Services browse cache Jun 20 09:38:36 smsl-n100 sudo[12959]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:36 smsl-n100 volumio[1204]: info: TidalConnect service started! Jun 20 09:38:38 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 20 09:38:38 smsl-n100 volumio[1204]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jun 20 09:38:38 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jun 20 09:38:38 smsl-n100 volumio[1204]: info: Received Get System Version Jun 20 09:38:38 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 20 09:38:38 smsl-n100 volumio[1204]: info: Received Get System Info Jun 20 09:38:38 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 20 09:38:38 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 20 09:38:38 smsl-n100 volumio[1204]: info: Discovery: Getting this device information Jun 20 09:38:38 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioGetState Jun 20 09:38:38 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:38 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 20 09:38:41 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Jun 20 09:38:41 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Jun 20 09:38:41 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:41 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 20 09:38:41 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 09:38:41 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 20 09:38:42 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jun 20 09:38:42 smsl-n100 volumio[1204]: info: Preparing to save Alsa Options, stopping services first Jun 20 09:38:42 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioGetState Jun 20 09:38:42 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:42 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPause Jun 20 09:38:42 smsl-n100 volumio[1204]: info: CoreStateMachine::pause Jun 20 09:38:42 smsl-n100 volumio[1204]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"1","label":"SPDIF"},"disallowPush":true} Jun 20 09:38:42 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 20 09:38:43 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:43 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 20 09:38:43 smsl-n100 volumio[1204]: info: Found match in Cards Database: setting mixer for card SPDIF Jun 20 09:38:43 smsl-n100 volumio[1204]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes Jun 20 09:38:43 smsl-n100 vtcs[12900]: [2025-06-20 09:38:43.111] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Jun 20 09:38:43 smsl-n100 vtcs[12900]: [2025-06-20 09:38:43.112] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Jun 20 09:38:43 smsl-n100 sudo[12986]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 20 09:38:43 smsl-n100 sudo[12986]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:43 smsl-n100 systemd[1]: Stopping Volumio Tidal Connect Service... Jun 20 09:38:43 smsl-n100 systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Jun 20 09:38:43 smsl-n100 systemd[1]: vtcs.service: Succeeded. Jun 20 09:38:43 smsl-n100 systemd[1]: Stopped Volumio Tidal Connect Service. Jun 20 09:38:43 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:43 smsl-n100 volumio[1204]: info: Device 1 does not have any Mixer Control Available Jun 20 09:38:43 smsl-n100 volumio[1204]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes Jun 20 09:38:43 smsl-n100 sudo[12986]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:43 smsl-n100 sudo[12992]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 20 09:38:43 smsl-n100 sudo[12992]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:43 smsl-n100 sudo[12992]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:43 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jun 20 09:38:43 smsl-n100 volumio[1204]: info: Updating Volume Controller Parameters: Device: 1 Name: SPDIF Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jun 20 09:38:43 smsl-n100 volumio[1204]: info: Disabling external Volume Control Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:43 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:43 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:43 smsl-n100 volumio[1204]: info: Preparing to generate the ALSA configuration file Jun 20 09:38:43 smsl-n100 sudo[12998]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 20 09:38:43 smsl-n100 sudo[12998]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:43 smsl-n100 sudo[13000]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 20 09:38:43 smsl-n100 sudo[13000]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:43 smsl-n100 sudo[12998]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:43 smsl-n100 volumio[1204]: info: Not Reporting Auto name since its the default one Jun 20 09:38:43 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 09:38:43 smsl-n100 sudo[13000]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:43 smsl-n100 volumio[1204]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 20 09:38:43 smsl-n100 volumio[1204]: info: Reading ALSA contributions from plugins. Jun 20 09:38:43 smsl-n100 volumio[1204]: info: Updating RAAT Signal Path Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:43 smsl-n100 volumio[1204]: info: Not Reporting Auto name since its the default one Jun 20 09:38:43 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 09:38:43 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 20 09:38:44 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:44 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:44 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:44 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:44 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:44 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:44 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:44 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:44 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 20 09:38:44 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 20 09:38:44 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Jun 20 09:38:44 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 20 09:38:44 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:44 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 20 09:38:44 smsl-n100 sudo[13020]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 20 09:38:44 smsl-n100 sudo[13020]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:44 smsl-n100 sudo[13020]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:44 smsl-n100 sudo[13024]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 20 09:38:44 smsl-n100 sudo[13024]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:44 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:44 smsl-n100 systemd[1]: Stopping RAAT DAEMON... Jun 20 09:38:44 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jun 20 09:38:44 smsl-n100 systemd[1]: raat-daemon.service: Succeeded. Jun 20 09:38:44 smsl-n100 systemd[1]: Stopped RAAT DAEMON. Jun 20 09:38:44 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 09:38:44 smsl-n100 systemd[1]: Started RAAT DAEMON. Jun 20 09:38:44 smsl-n100 sudo[13024]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:44 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 20 09:38:44 smsl-n100 sudo[13027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 20 09:38:44 smsl-n100 sudo[13027]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:44 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:44 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:44 smsl-n100 volumio[1204]: info: Raat Daemon started successfully Jun 20 09:38:44 smsl-n100 sudo[13027]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:44 smsl-n100 volumio[1204]: info: Asound.conf file unchanged, so no further update is needed Jun 20 09:38:44 smsl-n100 volumio[1204]: info: Output device has changed, restarting MPD Jun 20 09:38:44 smsl-n100 sudo[13034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 20 09:38:44 smsl-n100 sudo[13034]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:44 smsl-n100 volumio[1204]: info: Output device has changed, restarting Shairport Sync Jun 20 09:38:44 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:44 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 09:38:44 smsl-n100 sudo[13037]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 20 09:38:44 smsl-n100 sudo[13037]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:44 smsl-n100 sudo[13037]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:44 smsl-n100 systemd[1]: Stopping RAAT DAEMON... Jun 20 09:38:44 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jun 20 09:38:44 smsl-n100 systemd[1]: raat-daemon.service: Succeeded. Jun 20 09:38:44 smsl-n100 systemd[1]: Stopped RAAT DAEMON. Jun 20 09:38:44 smsl-n100 sudo[13044]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 20 09:38:44 smsl-n100 sudo[13044]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:44 smsl-n100 systemd[1]: Started RAAT DAEMON. Jun 20 09:38:44 smsl-n100 sudo[13034]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:44 smsl-n100 systemd[1]: Stopping Music Player Daemon... Jun 20 09:38:44 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:44 smsl-n100 volumio[1204]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 20 09:38:44 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:44 smsl-n100 volumio[1204]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 20 09:38:44 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:44 smsl-n100 systemd[1]: mpd.service: Succeeded. Jun 20 09:38:44 smsl-n100 systemd[1]: Stopped Music Player Daemon. Jun 20 09:38:44 smsl-n100 systemd[1]: Starting Music Player Daemon... Jun 20 09:38:44 smsl-n100 volumio[1204]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Jun 20 09:38:44 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:45 smsl-n100 sudo[13064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 20 09:38:45 smsl-n100 sudo[13064]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:45 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 09:38:45 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 20 09:38:45 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 09:38:45 smsl-n100 sudo[13056]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 20 09:38:45 smsl-n100 sudo[13068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 20 09:38:45 smsl-n100 sudo[13056]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:45 smsl-n100 sudo[13068]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:45 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 20 09:38:45 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 09:38:45 smsl-n100 sudo[13056]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:45 smsl-n100 sudo[13064]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:45 smsl-n100 volumio[1204]: info: MPD Permissions set Jun 20 09:38:45 smsl-n100 volumio[1204]: info: Raat Daemon started successfully Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:45 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:45 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:45 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 09:38:45 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 20 09:38:45 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 09:38:45 smsl-n100 volumio[1204]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 20 09:38:45 smsl-n100 sudo[13068]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:45 smsl-n100 volumio[1204]: info: Executing endpoint restartRAATSocket Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 20 09:38:45 smsl-n100 volumio[1204]: info: Executing endpoint restartRAATSocket Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:45 smsl-n100 volumio[1204]: info: Not Reporting Auto name since its the default one Jun 20 09:38:45 smsl-n100 volumio[1204]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jun 20 09:38:45 smsl-n100 volumio[1204]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Jun 20 09:38:45 smsl-n100 volumio[1204]: info: Starting Shairport Sync Jun 20 09:38:45 smsl-n100 sudo[13086]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 20 09:38:45 smsl-n100 sudo[13086]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 20 09:38:45 smsl-n100 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 20 09:38:45 smsl-n100 systemd[1]: shairport-sync.service: Succeeded. Jun 20 09:38:45 smsl-n100 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 20 09:38:45 smsl-n100 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 20 09:38:45 smsl-n100 sudo[13086]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:45 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:45 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 09:38:45 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 20 09:38:45 smsl-n100 sudo[13092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 20 09:38:45 smsl-n100 volumio[1204]: info: Shairport-Sync Started Jun 20 09:38:45 smsl-n100 sudo[13092]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioGetState Jun 20 09:38:45 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:45 smsl-n100 sudo[13092]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:45 smsl-n100 sudo[13096]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 20 09:38:45 smsl-n100 sudo[13096]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:46 smsl-n100 systemd[1]: Stopping RAAT DAEMON... Jun 20 09:38:46 smsl-n100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jun 20 09:38:46 smsl-n100 systemd[1]: raat-daemon.service: Succeeded. Jun 20 09:38:46 smsl-n100 systemd[1]: Stopped RAAT DAEMON. Jun 20 09:38:46 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 09:38:46 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 20 09:38:46 smsl-n100 systemd[1]: Started RAAT DAEMON. Jun 20 09:38:46 smsl-n100 sudo[13096]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:46 smsl-n100 volumio[1204]: info: Raat Daemon started successfully Jun 20 09:38:46 smsl-n100 volumio[1204]: info: Executing endpoint restartRAATSocket Jun 20 09:38:46 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 20 09:38:46 smsl-n100 volumio[1204]: info: TidalConnect service stoped! Jun 20 09:38:46 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:46 smsl-n100 volumio[1204]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Jun 20 09:38:46 smsl-n100 volumio[1204]: info: TidalConnect service stoped! Jun 20 09:38:46 smsl-n100 volumio[1204]: info: TidalConnect service stoped! Jun 20 09:38:46 smsl-n100 volumio[1204]: info: TidalConnect service stoped! Jun 20 09:38:46 smsl-n100 volumio[1204]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 20 09:38:46 smsl-n100 volumio[1204]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 20 09:38:46 smsl-n100 volumio[1204]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 20 09:38:46 smsl-n100 volumio[1204]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 20 09:38:46 smsl-n100 sudo[13126]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 20 09:38:47 smsl-n100 sudo[13126]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 20 09:38:47 smsl-n100 volumio[1204]: info: Discovery: Getting this device information Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioGetState Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 20 09:38:47 smsl-n100 sudo[13129]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 20 09:38:47 smsl-n100 sudo[13129]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:47 smsl-n100 systemd[1]: Started Volumio Tidal Connect Service. Jun 20 09:38:47 smsl-n100 sudo[13126]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:47 smsl-n100 sudo[13129]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:47 smsl-n100 volumio[1204]: info: RAAT: Requesting Headphone Status Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:47 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:47 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:47 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 09:38:47 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 20 09:38:47 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 09:38:47 smsl-n100 volumio[1204]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 20 09:38:47 smsl-n100 volumio[1204]: info: RAAT: Requesting Headphone Status Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:47 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:47 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:47 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 09:38:47 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 20 09:38:47 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 09:38:47 smsl-n100 volumio[1204]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreStateMachine::getcurrentVolume Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioRetrievevolume Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:47 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:47 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:47 smsl-n100 volumio[1204]: info: Updating RAAT Signal Path Jun 20 09:38:47 smsl-n100 volumio[1204]: info: Executing endpoint tc_getconfig Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jun 20 09:38:47 smsl-n100 vtcs[13130]: STARTING TidalConnect services, version: 1.4.0.34 Jun 20 09:38:47 smsl-n100 vtcs[13130]: STARTED TidalConnect services. Jun 20 09:38:47 smsl-n100 volumio[1204]: info: Executing endpoint tc_connect Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jun 20 09:38:47 smsl-n100 volumio[1204]: info: Connecting to TidalConnect Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreCommandRouter::servicePushState Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:47 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:47 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:47 smsl-n100 volumio[1204]: 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} Jun 20 09:38:47 smsl-n100 volumio[1204]: verbose: CURRENT POSITION 0 Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreStateMachine::syncState stateService stop Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreStateMachine::syncState currentStatus stop Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:47 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:47 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:47 smsl-n100 volumio[1204]: info: No code Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:47 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:47 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreCommandRouter::servicePushState Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:47 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:47 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:47 smsl-n100 volumio[1204]: 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} Jun 20 09:38:47 smsl-n100 volumio[1204]: verbose: CURRENT POSITION 0 Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreStateMachine::syncState stateService stop Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreStateMachine::syncState currentStatus stop Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:47 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:47 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:47 smsl-n100 volumio[1204]: info: No code Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:47 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:47 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:47 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:48 smsl-n100 volumio[1204]: info: Updating RAAT Signal Path Jun 20 09:38:48 smsl-n100 volumio[1204]: info: Updating RAAT Signal Path Jun 20 09:38:48 smsl-n100 volumio[1204]: info: Updating RAAT Signal Path Jun 20 09:38:48 smsl-n100 volumio[1204]: info: Updating RAAT Signal Path Jun 20 09:38:48 smsl-n100 volumio[1204]: info: Updating RAAT Signal Path Jun 20 09:38:48 smsl-n100 volumio[1204]: info: Updating RAAT Signal Path Jun 20 09:38:48 smsl-n100 volumio[1204]: info: TidalConnect service stoped! Jun 20 09:38:48 smsl-n100 volumio[1204]: info: TidalConnect service stoped! Jun 20 09:38:48 smsl-n100 volumio[1204]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 20 09:38:48 smsl-n100 volumio[1204]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 20 09:38:48 smsl-n100 sudo[13185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 20 09:38:48 smsl-n100 sudo[13185]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:48 smsl-n100 sudo[13185]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:48 smsl-n100 volumio[1204]: info: RAAT: Requesting Headphone Status Jun 20 09:38:48 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus Jun 20 09:38:48 smsl-n100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:48 smsl-n100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:48 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 09:38:48 smsl-n100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:48 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:48 smsl-n100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:48 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 09:38:48 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 20 09:38:48 smsl-n100 volumio[1204]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 09:38:48 smsl-n100 volumio[1204]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 20 09:38:49 smsl-n100 mpd[13072]: Jun 20 09:38 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 20 09:38:49 smsl-n100 systemd[1]: Started Music Player Daemon. Jun 20 09:38:49 smsl-n100 sudo[13044]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:49 smsl-n100 volumio[1204]: error: updateQueue error: null Jun 20 09:38:50 smsl-n100 volumio[1204]: info: TidalConnect service started! Jun 20 09:38:50 smsl-n100 volumio[1204]: info: TidalConnect service started! Jun 20 09:38:51 smsl-n100 volumio[1204]: info: TidalConnect service started! Jun 20 09:38:52 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Jun 20 09:38:52 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 20 09:38:52 smsl-n100 volumio-remote-updater[559]: No test mode Jun 20 09:38:52 smsl-n100 volumio-remote-updater[559]: No alpha test mode Jun 20 09:38:52 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jun 20 09:38:52 smsl-n100 volumio[1204]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jun 20 09:38:52 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jun 20 09:38:53 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Jun 20 09:38:53 smsl-n100 volumio[1204]: info: System name has changed, restarting Shairport Sync Jun 20 09:38:53 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:53 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 09:38:53 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:53 smsl-n100 volumio[1204]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 20 09:38:53 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:53 smsl-n100 vtcs[13130]: [2025-06-20 09:38:53.205] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Jun 20 09:38:53 smsl-n100 vtcs[13130]: [2025-06-20 09:38:53.205] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Jun 20 09:38:53 smsl-n100 sudo[13226]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 20 09:38:53 smsl-n100 sudo[13226]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:53 smsl-n100 volumio[1204]: info: Discovery: Restarting Advertising due to device name change Jun 20 09:38:53 smsl-n100 systemd[1]: Stopping Volumio Tidal Connect Service... Jun 20 09:38:53 smsl-n100 systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Jun 20 09:38:53 smsl-n100 systemd[1]: vtcs.service: Succeeded. Jun 20 09:38:53 smsl-n100 systemd[1]: Stopped Volumio Tidal Connect Service. Jun 20 09:38:53 smsl-n100 sudo[13228]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Jun 20 09:38:53 smsl-n100 sudo[13228]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:53 smsl-n100 sudo[13226]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:53 smsl-n100 sudo[13228]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:53 smsl-n100 sudo[13233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name SMSL100 Jun 20 09:38:53 smsl-n100 sudo[13233]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:53 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Jun 20 09:38:53 smsl-n100 sudo[13233]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:53 smsl-n100 sudo[13235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 20 09:38:53 smsl-n100 sudo[13235]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:53 smsl-n100 sudo[13235]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:53 smsl-n100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:53 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 20 09:38:53 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 09:38:53 smsl-n100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 20 09:38:53 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 09:38:53 smsl-n100 volumio[1204]: error: Upnp client error: Error: This socket has been ended by the other party Jun 20 09:38:53 smsl-n100 volumio[1204]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'SMSL100' Jun 20 09:38:53 smsl-n100 volumio[1204]: Can't get device info: No such device Jun 20 09:38:53 smsl-n100 volumio[1204]: info: Starting Shairport Sync Jun 20 09:38:53 smsl-n100 sudo[13242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts Jun 20 09:38:53 smsl-n100 sudo[13242]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:53 smsl-n100 sudo[13242]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:53 smsl-n100 volumio[1204]: info: Permissions for /etc/hosts set Jun 20 09:38:53 smsl-n100 sudo[13245]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 20 09:38:53 smsl-n100 sudo[13245]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:53 smsl-n100 volumio[1204]: info: Hostname now is smsl100 Jun 20 09:38:53 smsl-n100 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 20 09:38:53 smsl-n100 systemd[1]: shairport-sync.service: Succeeded. Jun 20 09:38:53 smsl-n100 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 20 09:38:53 smsl-n100 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 20 09:38:53 smsl-n100 sudo[13245]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:53 smsl-n100 sudo[13248]: volumio : unable to resolve host smsl-n100 Jun 20 09:38:53 smsl-n100 sudo[13248]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jun 20 09:38:53 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 09:38:53 smsl-n100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 20 09:38:53 smsl-n100 sudo[13248]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hostname smsl100 Jun 20 09:38:53 smsl-n100 sudo[13248]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:53 smsl100 volumio[1204]: info: Shairport-Sync Started Jun 20 09:38:53 smsl100 sudo[13248]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:53 smsl100 volumio[1204]: info: New hostname set Jun 20 09:38:53 smsl100 sudo[13251]: volumio : unable to resolve host smsl-n100 Jun 20 09:38:53 smsl100 sudo[13251]: volumio : problem with defaults entries ; TTY=unknown ; PWD=/ ; USER=root ; Jun 20 09:38:53 smsl100 sudo[13251]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /etc/avahi/services/ Jun 20 09:38:53 smsl100 sudo[13251]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:53 smsl100 sudo[13251]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:53 smsl100 volumio[1204]: info: Permissions for /etc/avahi/services/volumio.service Jun 20 09:38:53 smsl100 avahi-daemon[569]: Files changed, reloading. Jun 20 09:38:53 smsl100 avahi-daemon[569]: Loading service file /services/volumio.service. Jun 20 09:38:53 smsl100 volumio[1204]: info: Avahi name changed to smsl100 Jun 20 09:38:54 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Jun 20 09:38:54 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 20 09:38:54 smsl100 volumio[1204]: info: Discovery: A device disappeared from network Jun 20 09:38:54 smsl100 volumio[1204]: info: Discovery: A device disappeared from network Jun 20 09:38:54 smsl100 volumio-remote-updater[559]: No test mode Jun 20 09:38:54 smsl100 volumio-remote-updater[559]: No alpha test mode Jun 20 09:38:54 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jun 20 09:38:54 smsl100 volumio[1204]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jun 20 09:38:54 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jun 20 09:38:54 smsl100 avahi-daemon[569]: Service "SMSL100" (/services/volumio.service) successfully established. Jun 20 09:38:55 smsl100 volumio[1204]: info: CoreCommandRouter::volumioGetState Jun 20 09:38:55 smsl100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:55 smsl100 volumio[1204]: info: Listing playlists Jun 20 09:38:55 smsl100 volumio[1204]: info: Listing playlists Jun 20 09:38:56 smsl100 volumio[1204]: info: TidalConnect service stoped! Jun 20 09:38:56 smsl100 volumio[1204]: info: TidalConnect service stoped! Jun 20 09:38:56 smsl100 volumio[1204]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 20 09:38:56 smsl100 volumio[1204]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 20 09:38:56 smsl100 sudo[13266]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 20 09:38:56 smsl100 sudo[13266]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:56 smsl100 systemd[1]: Started Volumio Tidal Connect Service. Jun 20 09:38:56 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Jun 20 09:38:56 smsl100 volumio[1204]: info: Preparing to save Alsa Options, stopping services first Jun 20 09:38:56 smsl100 volumio[1204]: info: CoreCommandRouter::volumioGetState Jun 20 09:38:56 smsl100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:56 smsl100 volumio[1204]: info: CoreCommandRouter::volumioPause Jun 20 09:38:56 smsl100 volumio[1204]: info: CoreStateMachine::pause Jun 20 09:38:56 smsl100 volumio[1204]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"1","label":"SPDIF"},"disallowPush":true} Jun 20 09:38:56 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 20 09:38:56 smsl100 sudo[13266]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:56 smsl100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:56 smsl100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:56 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 20 09:38:56 smsl100 volumio[1204]: info: Found match in Cards Database: setting mixer for card SPDIF Jun 20 09:38:56 smsl100 volumio[1204]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes Jun 20 09:38:57 smsl100 sudo[13277]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 20 09:38:57 smsl100 sudo[13277]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:57 smsl100 systemd[1]: Stopping Volumio Tidal Connect Service... Jun 20 09:38:57 smsl100 systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Jun 20 09:38:57 smsl100 systemd[1]: vtcs.service: Succeeded. Jun 20 09:38:57 smsl100 systemd[1]: Stopped Volumio Tidal Connect Service. Jun 20 09:38:57 smsl100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:57 smsl100 volumio[1204]: info: Device 1 does not have any Mixer Control Available Jun 20 09:38:57 smsl100 volumio[1204]: info: Reconfiguring and Restarting RAAT Plugin due to audio path changes Jun 20 09:38:57 smsl100 sudo[13277]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:57 smsl100 sudo[13284]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 20 09:38:57 smsl100 sudo[13284]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:57 smsl100 sudo[13284]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:57 smsl100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jun 20 09:38:57 smsl100 volumio[1204]: info: Updating Volume Controller Parameters: Device: 1 Name: SPDIF Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jun 20 09:38:57 smsl100 volumio[1204]: info: Disabling external Volume Control Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:57 smsl100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:57 smsl100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:57 smsl100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:57 smsl100 volumio[1204]: info: Preparing to generate the ALSA configuration file Jun 20 09:38:57 smsl100 sudo[13290]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 20 09:38:57 smsl100 sudo[13290]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:57 smsl100 sudo[13293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 20 09:38:57 smsl100 sudo[13293]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:57 smsl100 sudo[13290]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 20 09:38:57 smsl100 volumio[1204]: info: Retrieving Cloud Streaming UI Jun 20 09:38:57 smsl100 sudo[13293]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:57 smsl100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 09:38:57 smsl100 volumio[1204]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 20 09:38:57 smsl100 volumio[1204]: info: Reading ALSA contributions from plugins. Jun 20 09:38:57 smsl100 volumio[1204]: info: Updating RAAT Signal Path Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:57 smsl100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 20 09:38:57 smsl100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: raat , getAdditionalUiSection Jun 20 09:38:57 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 20 09:38:58 smsl100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:58 smsl100 volumio[1204]: info: Getting Tidal Cloud Configuration Jun 20 09:38:58 smsl100 volumio[1204]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 20 09:38:58 smsl100 volumio[1204]: info: Getting Qobuz Cloud Configuration Jun 20 09:38:58 smsl100 volumio[1204]: info: Asking plugin for UI Config Jun 20 09:38:58 smsl100 volumio[1204]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 20 09:38:58 smsl100 volumio[1204]: info: Getting Spotify Cloud Configuration Jun 20 09:38:58 smsl100 volumio[1204]: info: Asking plugin for UI Config Jun 20 09:38:58 smsl100 volumio[1204]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 20 09:38:58 smsl100 volumio[1204]: info: Saving Spotify Acccount Jun 20 09:38:58 smsl100 sudo[13312]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 20 09:38:58 smsl100 volumio[1204]: info: Got it Jun 20 09:38:58 smsl100 volumio[1204]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jun 20 09:38:58 smsl100 sudo[13312]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:58 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 20 09:38:58 smsl100 sudo[13312]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:58 smsl100 sudo[13314]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 20 09:38:58 smsl100 sudo[13314]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:58 smsl100 systemd[1]: Stopping RAAT DAEMON... Jun 20 09:38:58 smsl100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jun 20 09:38:58 smsl100 systemd[1]: raat-daemon.service: Succeeded. Jun 20 09:38:58 smsl100 systemd[1]: Stopped RAAT DAEMON. Jun 20 09:38:58 smsl100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:58 smsl100 systemd[1]: Started RAAT DAEMON. Jun 20 09:38:58 smsl100 sudo[13314]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:58 smsl100 sudo[13324]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 20 09:38:58 smsl100 sudo[13324]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:58 smsl100 volumio[1204]: info: Discovery: Started advertising with name: SMSL100 Jun 20 09:38:58 smsl100 sudo[13324]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:58 smsl100 sudo[13331]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 20 09:38:58 smsl100 sudo[13331]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:58 smsl100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 09:38:58 smsl100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 20 09:38:58 smsl100 systemd[1]: Stopping RAAT DAEMON... Jun 20 09:38:58 smsl100 volumio[1204]: info: Raat Daemon started successfully Jun 20 09:38:58 smsl100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jun 20 09:38:58 smsl100 systemd[1]: raat-daemon.service: Succeeded. Jun 20 09:38:58 smsl100 systemd[1]: Stopped RAAT DAEMON. Jun 20 09:38:58 smsl100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 09:38:58 smsl100 systemd[1]: Started RAAT DAEMON. Jun 20 09:38:58 smsl100 sudo[13331]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:58 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:58 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:58 smsl100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 20 09:38:58 smsl100 volumio[1204]: info: Executing endpoint restartRAATSocket Jun 20 09:38:58 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 20 09:38:58 smsl100 volumio[1204]: info: Asound.conf file unchanged, so no further update is needed Jun 20 09:38:58 smsl100 volumio[1204]: info: Output device has changed, restarting MPD Jun 20 09:38:58 smsl100 sudo[13358]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 20 09:38:58 smsl100 sudo[13358]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:58 smsl100 volumio[1204]: info: Output device has changed, restarting Shairport Sync Jun 20 09:38:58 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:58 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 09:38:58 smsl100 sudo[13358]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:58 smsl100 sudo[13361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 20 09:38:58 smsl100 sudo[13361]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:58 smsl100 systemd[1]: Stopping Music Player Daemon... Jun 20 09:38:58 smsl100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:58 smsl100 systemd[1]: mpd.service: Succeeded. Jun 20 09:38:58 smsl100 volumio[1204]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 20 09:38:58 smsl100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:58 smsl100 volumio[1204]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 20 09:38:58 smsl100 systemd[1]: Stopped Music Player Daemon. Jun 20 09:38:58 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:58 smsl100 systemd[1]: Starting Music Player Daemon... Jun 20 09:38:58 smsl100 volumio[1204]: info: Reconfiguring and Restarting RAAT Plugin due to audio device changes Jun 20 09:38:58 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:59 smsl100 sudo[13372]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 20 09:38:59 smsl100 sudo[13372]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:59 smsl100 volumio[1204]: info: Got Tidal Cloud Configuration Jun 20 09:38:59 smsl100 volumio[1204]: info: Got it Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 20 09:38:59 smsl100 volumio[1204]: info: Raat Daemon started successfully Jun 20 09:38:59 smsl100 sudo[13374]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 20 09:38:59 smsl100 sudo[13374]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:59 smsl100 sudo[13367]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 20 09:38:59 smsl100 sudo[13367]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:38:59 smsl100 sudo[13372]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 20 09:38:59 smsl100 volumio[1204]: info: Retrieving Cloud Streaming UI Jun 20 09:38:59 smsl100 sudo[13367]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:59 smsl100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 09:38:59 smsl100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 20 09:38:59 smsl100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 09:38:59 smsl100 sudo[13374]: pam_unix(sudo:session): session closed for user root Jun 20 09:38:59 smsl100 volumio[1204]: info: MPD Permissions set Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:59 smsl100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:59 smsl100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:59 smsl100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:59 smsl100 volumio[1204]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 09:38:59 smsl100 volumio[1204]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 20 09:38:59 smsl100 volumio[1204]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 09:38:59 smsl100 volumio[1204]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreStateMachine::pushState Jun 20 09:38:59 smsl100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::volumioPushState Jun 20 09:38:59 smsl100 volumio[1204]: info: MRS: Pushing multiroomSync output update for this device Jun 20 09:38:59 smsl100 volumio[1204]: info: MRS: Pushing multiroomSync output Jun 20 09:38:59 smsl100 volumio[1204]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 09:38:59 smsl100 volumio[1204]: error: Serial API: Failed to decode command: MAXVOL, message: Jun 20 09:38:59 smsl100 volumio[1204]: error: Serial API: Failed to decode command: 100, message: undefined Jun 20 09:38:59 smsl100 volumio[1204]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 20 09:38:59 smsl100 volumio[1204]: info: Executing endpoint restartRAATSocket Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jun 20 09:38:59 smsl100 volumio[1204]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Jun 20 09:38:59 smsl100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Jun 20 09:38:59 smsl100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Jun 20 09:38:59 smsl100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 20 09:38:59 smsl100 volumio[1204]: info: Getting Tidal Cloud Configuration Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 20 09:38:59 smsl100 volumio[1204]: info: Getting Qobuz Cloud Configuration Jun 20 09:38:59 smsl100 volumio[1204]: info: Asking plugin for UI Config Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 20 09:38:59 smsl100 volumio[1204]: info: Getting Spotify Cloud Configuration Jun 20 09:38:59 smsl100 volumio[1204]: info: Asking plugin for UI Config Jun 20 09:38:59 smsl100 volumio[1204]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 20 09:38:59 smsl100 volumio[1204]: info: Saving Spotify Acccount Jun 20 09:38:59 smsl100 volumio[1204]: info: Got it Jun 20 09:38:59 smsl100 volumio[1204]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jun 20 09:38:59 smsl100 volumio[1204]: info: TidalConnect service started! Jun 20 09:38:59 smsl100 volumio[1204]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Jun 20 09:38:59 smsl100 volumio[1204]: info: Starting Shairport Sync Jun 20 09:39:00 smsl100 sudo[13403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 20 09:39:00 smsl100 sudo[13403]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:39:00 smsl100 volumio[1204]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jun 20 09:39:00 smsl100 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 20 09:39:00 smsl100 systemd[1]: shairport-sync.service: Succeeded. Jun 20 09:39:00 smsl100 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 20 09:39:00 smsl100 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 20 09:39:00 smsl100 sudo[13403]: pam_unix(sudo:session): session closed for user root Jun 20 09:39:00 smsl100 volumio[1204]: xcb_connection_has_error() returned true Jun 20 09:39:00 smsl100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 20 09:39:00 smsl100 volumio[1204]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 20 09:39:00 smsl100 sudo[13410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed raat-daemon.service Jun 20 09:39:00 smsl100 sudo[13410]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:39:00 smsl100 sudo[13410]: pam_unix(sudo:session): session closed for user root Jun 20 09:39:00 smsl100 volumio[1204]: info: Discovery: adding 798f3b39-1c1a-4810-b2b6-ef4320d32450 Jun 20 09:39:00 smsl100 volumio[1204]: info: Discovery: Found device SMSL100 Jun 20 09:39:00 smsl100 volumio[1204]: info: CoreCommandRouter::volumioGetState Jun 20 09:39:00 smsl100 volumio[1204]: info: CorePlayQueue::getTrack 0 Jun 20 09:39:00 smsl100 volumio[1204]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 20 09:39:00 smsl100 volumio[1204]: Error: The value NaN is not a number Jun 20 09:39:00 smsl100 volumio[1204]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) Jun 20 09:39:00 smsl100 volumio[1204]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) Jun 20 09:39:00 smsl100 volumio[1204]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25) Jun 20 09:39:00 smsl100 volumio[1204]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10) Jun 20 09:39:00 smsl100 volumio[1204]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12) Jun 20 09:39:00 smsl100 volumio[1204]: at Browser.emit (events.js:400:28) Jun 20 09:39:00 smsl100 volumio[1204]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) Jun 20 09:39:00 smsl100 volumio[1204]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7) Jun 20 09:39:00 smsl100 volumio[1204]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5) Jun 20 09:39:00 smsl100 volumio[1204]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21) Jun 20 09:39:00 smsl100 volumio[1204]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 Jun 20 09:39:00 smsl100 volumio[1204]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) Jun 20 09:39:00 smsl100 volumio[1204]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) Jun 20 09:39:00 smsl100 volumio[1204]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 20 09:39:00 smsl100 sudo[13413]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jun 20 09:39:00 smsl100 sudo[13413]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:39:00 smsl100 systemd[1]: Stopping RAAT DAEMON... Jun 20 09:39:00 smsl100 systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Jun 20 09:39:00 smsl100 systemd[1]: raat-daemon.service: Succeeded. Jun 20 09:39:00 smsl100 systemd[1]: Stopped RAAT DAEMON. Jun 20 09:39:00 smsl100 systemd[1]: Started RAAT DAEMON. Jun 20 09:39:00 smsl100 sudo[13413]: pam_unix(sudo:session): session closed for user root Jun 20 09:39:01 smsl100 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 20 09:39:01 smsl100 systemd[1]: mpd.service: Failed with result 'protocol'. Jun 20 09:39:01 smsl100 sudo[13435]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-20 09:38 Jun 20 09:39:01 smsl100 sudo[13435]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 20 09:39:01 smsl100 systemd[1]: Failed to start Music Player Daemon. Jun 20 09:39:01 smsl100 sudo[13361]: pam_unix(sudo:session): session closed for user root Jun 20 09:39:01 smsl100 systemd[1]: Starting Music Player Daemon... 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="cc0042a1eab1cb7982711a1347e242f8947b54b6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="723ba1d50268911818ebdca474fb7656df6050cb" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="smsl" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 14 Feb 2025 02:46:15 PM CET" VOLUMIO_VERSION="3.789" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR_MODEL="SMSL S100" VOLUMIO_VENDOR="SMSL" VOLUMIO_MODEL="S100" VOLUMIO_HASH="215d731aee688e00fb3cc923952be9a7"