-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Wed 2025-10-15 23:43:33 CEST. -- Oct 15 23:42:00 volumio volumio[943]: info: Executing endpoint tc_getconfig Oct 15 23:42:00 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Oct 15 23:42:00 volumio vtcs[1741]: STARTING TidalConnect services, version: 1.5.1-beta1 Oct 15 23:42:00 volumio vtcs[1741]: STARTED TidalConnect services. Oct 15 23:42:00 volumio volumio[943]: info: Executing endpoint tc_connect Oct 15 23:42:00 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Oct 15 23:42:00 volumio volumio[943]: info: Connecting to TidalConnect Oct 15 23:42:00 volumio volumio[943]: info: CoreCommandRouter::servicePushState Oct 15 23:42:00 volumio volumio[943]: info: CoreStateMachine::pushState Oct 15 23:42:00 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:00 volumio volumio[943]: info: CoreCommandRouter::volumioPushState Oct 15 23:42:00 volumio volumio[943]: info: MRS: Pushing multiroomSync output update for this device Oct 15 23:42:00 volumio volumio[943]: info: MRS: Pushing multiroomSync output Oct 15 23:42:00 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:42:00 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:00 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:00 volumio volumio[943]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Oct 15 23:42:00 volumio volumio[943]: info: CoreCommandRouter::servicePushState Oct 15 23:42:00 volumio volumio[943]: info: CoreStateMachine::pushState Oct 15 23:42:00 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:00 volumio volumio[943]: info: CoreCommandRouter::volumioPushState Oct 15 23:42:00 volumio volumio[943]: info: MRS: Pushing multiroomSync output update for this device Oct 15 23:42:00 volumio volumio[943]: info: MRS: Pushing multiroomSync output Oct 15 23:42:00 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:42:00 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:00 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:00 volumio volumio[943]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Oct 15 23:42:01 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 15 23:42:01 volumio volumio[943]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Oct 15 23:42:01 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:42:01 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:01 volumio volumio[943]: info: MRS: Getting audio outputs on start Oct 15 23:42:01 volumio volumio[943]: info: MRS: Requesting all other devices output Oct 15 23:42:01 volumio volumio[943]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 15 23:42:01 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: wizard , openWizard Oct 15 23:42:01 volumio volumio[943]: info: CoreCommandRouter::Reload Ui Oct 15 23:42:01 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Oct 15 23:42:01 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Oct 15 23:42:01 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Oct 15 23:42:02 volumio sudo[1764]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 15 23:42:02 volumio sudo[1764]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:02 volumio sudo[1764]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:02 volumio sudo[1766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 15 23:42:02 volumio sudo[1766]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:02 volumio sudo[1766]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:02 volumio volumio[943]: verbose: New Socket.io Connection to 192.168.1.51 from 192.168.1.18 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_6_2 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.6 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 7 Oct 15 23:42:02 volumio volumio[943]: info: CoreCommandRouter::volumioGetVisibleSources Oct 15 23:42:02 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:42:02 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Oct 15 23:42:02 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Oct 15 23:42:02 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Oct 15 23:42:02 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Oct 15 23:42:02 volumio volumio[943]: info: Received Get System Info Oct 15 23:42:02 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 15 23:42:02 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 15 23:42:02 volumio volumio[943]: info: Discovery: Getting this device information Oct 15 23:42:02 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:42:02 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:02 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 23:42:02 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:02 volumio volumio[943]: info: Retrieving Cloud Streaming UI Oct 15 23:42:02 volumio volumio-remote-updater[562]: No test mode Oct 15 23:42:02 volumio volumio-remote-updater[562]: No alpha test mode Oct 15 23:42:02 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 15 23:42:02 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 15 23:42:02 volumio volumio[943]: info: TidalConnect service started! Oct 15 23:42:02 volumio volumio[943]: [Metrics] CommandRouter: 37s 387.06ms Oct 15 23:42:02 volumio volumio[943]: info: CoreCommandRouter::volumiosetStartupVolume Oct 15 23:42:02 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:42:02 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:42:02 volumio volumio[943]: info: CoreCommandRouter::Close All Modals sent Oct 15 23:42:02 volumio volumio[943]: info: CoreCommandRouter::Close All Modals sent Oct 15 23:42:02 volumio volumio[943]: info: Getting Tidal Cloud Configuration Oct 15 23:42:02 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:02 volumio volumio[943]: info: Getting Qobuz Cloud Configuration Oct 15 23:42:02 volumio volumio[943]: info: Asking plugin for UI Config Oct 15 23:42:02 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:02 volumio volumio[943]: info: Getting Spotify Cloud Configuration Oct 15 23:42:02 volumio volumio[943]: info: Asking plugin for UI Config Oct 15 23:42:02 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:02 volumio volumio[943]: info: Saving Spotify Acccount Oct 15 23:42:03 volumio volumio[943]: info: Got it Oct 15 23:42:03 volumio volumio[943]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 15 23:42:03 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:03 volumio volumio[943]: info: Retrieving Cloud Streaming UI Oct 15 23:42:03 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:03 volumio volumio[943]: info: Retrieving Cloud Streaming UI Oct 15 23:42:03 volumio volumio[943]: info: Getting Tidal Cloud Configuration Oct 15 23:42:03 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:03 volumio volumio[943]: info: Getting Qobuz Cloud Configuration Oct 15 23:42:03 volumio volumio[943]: info: Asking plugin for UI Config Oct 15 23:42:03 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:03 volumio volumio[943]: info: Getting Spotify Cloud Configuration Oct 15 23:42:03 volumio volumio[943]: info: Asking plugin for UI Config Oct 15 23:42:03 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:03 volumio volumio[943]: info: Saving Spotify Acccount Oct 15 23:42:03 volumio volumio[943]: info: Got it Oct 15 23:42:03 volumio volumio[943]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 15 23:42:03 volumio volumio[943]: info: Getting Tidal Cloud Configuration Oct 15 23:42:03 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:03 volumio volumio[943]: info: Getting Qobuz Cloud Configuration Oct 15 23:42:03 volumio volumio[943]: info: Asking plugin for UI Config Oct 15 23:42:03 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:03 volumio volumio[943]: info: Getting Spotify Cloud Configuration Oct 15 23:42:03 volumio volumio[943]: info: Asking plugin for UI Config Oct 15 23:42:03 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:03 volumio volumio[943]: info: Saving Spotify Acccount Oct 15 23:42:03 volumio volumio[943]: info: Got it Oct 15 23:42:03 volumio volumio[943]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 15 23:42:03 volumio volumio[943]: info: Got Tidal Cloud Configuration Oct 15 23:42:03 volumio volumio[943]: info: Got it Oct 15 23:42:03 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:03 volumio volumio[943]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 15 23:42:03 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 15 23:42:03 volumio volumio[943]: info: Got Tidal Cloud Configuration Oct 15 23:42:03 volumio volumio[943]: info: Got it Oct 15 23:42:03 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:03 volumio volumio[943]: info: Got Tidal Cloud Configuration Oct 15 23:42:03 volumio volumio[943]: info: Got it Oct 15 23:42:03 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:03 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:42:03 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:42:03 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 15 23:42:03 volumio volumio[943]: info: CoreCommandRouter::volumioGetVisibleSources Oct 15 23:42:03 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:42:03 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 15 23:42:03 volumio volumio[943]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Oct 15 23:42:03 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:42:03 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:03 volumio volumio-remote-updater[562]: No test mode Oct 15 23:42:03 volumio volumio-remote-updater[562]: No alpha test mode Oct 15 23:42:03 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 15 23:42:03 volumio volumio[943]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 15 23:42:03 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 15 23:42:03 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 15 23:42:03 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 15 23:42:04 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 15 23:42:04 volumio volumio[943]: info: Version has changed, forcing UI Reload Oct 15 23:42:04 volumio volumio[943]: info: CoreCommandRouter::Reload Ui Oct 15 23:42:04 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Oct 15 23:42:04 volumio volumio[943]: info: Loading i18n strings for locale fr Oct 15 23:42:04 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Oct 15 23:42:04 volumio volumio[943]: info: Setting timezone to Europe/Paris Oct 15 23:42:04 volumio sudo[1822]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Oct 15 23:42:04 volumio sudo[1822]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:04 volumio sudo[1822]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:04 volumio sudo[1825]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Paris /etc/localtime Oct 15 23:42:04 volumio sudo[1825]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:04 volumio sudo[1825]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:04 volumio sudo[1828]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Oct 15 23:42:04 volumio sudo[1828]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:04 volumio sudo[1828]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:04 volumio sudo[1831]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Paris Oct 15 23:42:04 volumio sudo[1831]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:04 volumio dbus-daemon[553]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.27' (uid=0 pid=1832 comm="/usr/bin/timedatectl set-timezone Europe/Paris ") Oct 15 23:42:04 volumio systemd[1]: Starting Time & Date Service... Oct 15 23:42:04 volumio dbus-daemon[553]: [system] Successfully activated service 'org.freedesktop.timedate1' Oct 15 23:42:04 volumio systemd[1]: Started Time & Date Service. Oct 15 23:42:04 volumio sudo[1831]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:04 volumio volumio[943]: info: Fetching Streaming Services browse cache Oct 15 23:42:04 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 15 23:42:04 volumio volumio[943]: Updating browse sources language Oct 15 23:42:04 volumio volumio[943]: Cannot find translation for source TIDAL Oct 15 23:42:04 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:42:04 volumio volumio[943]: Cannot find translation for source TIDAL Oct 15 23:42:05 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 15 23:42:05 volumio sudo[1835]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 15 23:42:05 volumio sudo[1835]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:05 volumio sudo[1835]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:05 volumio sudo[1837]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 15 23:42:05 volumio sudo[1837]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:05 volumio sudo[1837]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:05 volumio volumio[943]: verbose: New Socket.io Connection to 192.168.1.51 from 192.168.1.18 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_6_2 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.6 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 6 Oct 15 23:42:05 volumio volumio[943]: info: CoreCommandRouter::volumioGetVisibleSources Oct 15 23:42:05 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:42:05 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Oct 15 23:42:05 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Oct 15 23:42:05 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Oct 15 23:42:05 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Oct 15 23:42:05 volumio volumio[943]: info: Received Get System Info Oct 15 23:42:05 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 15 23:42:05 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 15 23:42:05 volumio volumio[943]: info: Discovery: Getting this device information Oct 15 23:42:05 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:42:05 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:05 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 23:42:05 volumio volumio-remote-updater[562]: No test mode Oct 15 23:42:05 volumio volumio-remote-updater[562]: No alpha test mode Oct 15 23:42:05 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 15 23:42:05 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 15 23:42:05 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:05 volumio volumio[943]: info: Retrieving Cloud Streaming UI Oct 15 23:42:05 volumio volumio[943]: info: Getting Tidal Cloud Configuration Oct 15 23:42:05 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:05 volumio volumio[943]: info: Getting Qobuz Cloud Configuration Oct 15 23:42:05 volumio volumio[943]: info: Asking plugin for UI Config Oct 15 23:42:05 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:05 volumio volumio[943]: info: Getting Spotify Cloud Configuration Oct 15 23:42:05 volumio volumio[943]: info: Asking plugin for UI Config Oct 15 23:42:05 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:05 volumio volumio[943]: info: Saving Spotify Acccount Oct 15 23:42:05 volumio volumio[943]: info: Got it Oct 15 23:42:05 volumio volumio[943]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 15 23:42:05 volumio volumio[943]: info: Got Tidal Cloud Configuration Oct 15 23:42:05 volumio volumio[943]: info: Got it Oct 15 23:42:05 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:05 volumio volumio[943]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 15 23:42:05 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 15 23:42:06 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:42:06 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:42:06 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Oct 15 23:42:06 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 15 23:42:06 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Oct 15 23:42:06 volumio volumio[943]: info: CoreCommandRouter::volumioGetBrowseSources Oct 15 23:42:06 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:42:06 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Oct 15 23:42:06 volumio volumio[943]: info: Loading i18n strings for locale fr Oct 15 23:42:06 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Oct 15 23:42:06 volumio volumio[943]: info: Setting timezone to Europe/Paris Oct 15 23:42:06 volumio sudo[1845]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Oct 15 23:42:06 volumio sudo[1845]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:06 volumio sudo[1845]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:06 volumio sudo[1848]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Paris /etc/localtime Oct 15 23:42:06 volumio sudo[1848]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:06 volumio sudo[1848]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:06 volumio sudo[1851]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Oct 15 23:42:06 volumio sudo[1851]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:06 volumio sudo[1851]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:06 volumio sudo[1854]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Paris Oct 15 23:42:06 volumio sudo[1854]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:06 volumio sudo[1854]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:07 volumio volumio[943]: Updating browse sources language Oct 15 23:42:07 volumio volumio[943]: Cannot find translation for source TIDAL Oct 15 23:42:07 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:42:07 volumio volumio[943]: Cannot find translation for source TIDAL Oct 15 23:42:07 volumio volumio[943]: info: Fetching Streaming Services browse cache Oct 15 23:42:07 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 15 23:42:07 volumio volumio[943]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 15 23:42:07 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 15 23:42:08 volumio volumio[943]: info: CoreCommandRouter::volumioGetVisibleSources Oct 15 23:42:08 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:42:08 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Oct 15 23:42:08 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Oct 15 23:42:08 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Oct 15 23:42:08 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Oct 15 23:42:08 volumio volumio[943]: info: Received Get System Info Oct 15 23:42:08 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 15 23:42:08 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 15 23:42:08 volumio volumio[943]: info: Discovery: Getting this device information Oct 15 23:42:08 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:42:08 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:08 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 23:42:08 volumio volumio-remote-updater[562]: No test mode Oct 15 23:42:08 volumio volumio-remote-updater[562]: No alpha test mode Oct 15 23:42:08 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 15 23:42:08 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 15 23:42:08 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:08 volumio volumio[943]: info: Retrieving Cloud Streaming UI Oct 15 23:42:08 volumio volumio[943]: info: Getting Tidal Cloud Configuration Oct 15 23:42:08 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:08 volumio volumio[943]: info: Getting Qobuz Cloud Configuration Oct 15 23:42:08 volumio volumio[943]: info: Asking plugin for UI Config Oct 15 23:42:08 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:08 volumio volumio[943]: info: Getting Spotify Cloud Configuration Oct 15 23:42:08 volumio volumio[943]: info: Asking plugin for UI Config Oct 15 23:42:08 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:08 volumio volumio[943]: info: Saving Spotify Acccount Oct 15 23:42:08 volumio volumio[943]: info: Got it Oct 15 23:42:08 volumio volumio[943]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 15 23:42:08 volumio volumio[943]: info: Got Tidal Cloud Configuration Oct 15 23:42:08 volumio volumio[943]: info: Got it Oct 15 23:42:08 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:08 volumio volumio[943]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 15 23:42:08 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 15 23:42:09 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 15 23:42:09 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 15 23:42:09 volumio volumio[943]: info: BOOT COMPLETED Oct 15 23:42:10 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Oct 15 23:42:10 volumio volumio[943]: info: Loading i18n strings for locale en Oct 15 23:42:10 volumio volumio[943]: Updating browse sources language Oct 15 23:42:10 volumio volumio[943]: Cannot find translation for source TIDAL Oct 15 23:42:10 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:42:10 volumio volumio[943]: Cannot find translation for source TIDAL Oct 15 23:42:10 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Oct 15 23:42:10 volumio volumio[943]: info: Setting timezone to Europe/Paris Oct 15 23:42:10 volumio sudo[1880]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Oct 15 23:42:10 volumio sudo[1880]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:10 volumio sudo[1880]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:10 volumio sudo[1883]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Paris /etc/localtime Oct 15 23:42:10 volumio sudo[1883]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:10 volumio sudo[1883]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:11 volumio sudo[1886]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Oct 15 23:42:11 volumio sudo[1886]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:11 volumio sudo[1886]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:11 volumio ntpd[738]: Soliciting pool server 193.52.136.2 Oct 15 23:42:11 volumio sudo[1889]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Paris Oct 15 23:42:11 volumio sudo[1889]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:11 volumio ntpd[738]: Soliciting pool server 164.132.166.29 Oct 15 23:42:11 volumio sudo[1889]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:11 volumio volumio[943]: info: Fetching Streaming Services browse cache Oct 15 23:42:12 volumio ntpd[738]: Soliciting pool server 82.64.42.185 Oct 15 23:42:12 volumio ntpd[738]: Soliciting pool server 62.210.217.202 Oct 15 23:42:13 volumio ntpd[738]: Soliciting pool server 45.90.162.253 Oct 15 23:42:13 volumio ntpd[738]: Soliciting pool server 109.190.177.203 Oct 15 23:42:13 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 15 23:42:14 volumio ntpd[738]: Soliciting pool server 37.59.63.125 Oct 15 23:42:14 volumio ntpd[738]: Soliciting pool server 194.177.34.116 Oct 15 23:42:14 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Oct 15 23:42:14 volumio volumio[943]: info: Loading i18n strings for locale fr Oct 15 23:42:14 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Oct 15 23:42:14 volumio volumio[943]: info: Setting timezone to Europe/Paris Oct 15 23:42:14 volumio sudo[2064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Oct 15 23:42:14 volumio sudo[2064]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:14 volumio sudo[2064]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:14 volumio sudo[2088]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Paris /etc/localtime Oct 15 23:42:14 volumio sudo[2088]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:14 volumio sudo[2088]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:14 volumio sudo[2091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Oct 15 23:42:14 volumio sudo[2091]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:14 volumio sudo[2091]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:14 volumio sudo[2094]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Paris Oct 15 23:42:14 volumio sudo[2094]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:14 volumio sudo[2094]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:14 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Oct 15 23:42:14 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Oct 15 23:42:14 volumio volumio[943]: Updating browse sources language Oct 15 23:42:14 volumio volumio[943]: Cannot find translation for source TIDAL Oct 15 23:42:14 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:42:14 volumio volumio[943]: Cannot find translation for source TIDAL Oct 15 23:42:14 volumio sudo[2097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 15 23:42:14 volumio sudo[2097]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:14 volumio volumio[943]: info: Fetching Streaming Services browse cache Oct 15 23:42:15 volumio ntpd[738]: Soliciting pool server 172.232.44.156 Oct 15 23:42:16 volumio ntpd[738]: Soliciting pool server 162.159.200.1 Oct 15 23:42:16 volumio ntpd[738]: Soliciting pool server 195.154.185.215 Oct 15 23:42:17 volumio ntpd[738]: Soliciting pool server 109.190.177.205 Oct 15 23:42:17 volumio ntpd[738]: Soliciting pool server 62.210.129.125 Oct 15 23:42:18 volumio ntpd[738]: Soliciting pool server 82.64.81.218 Oct 15 23:42:18 volumio ntpd[738]: Soliciting pool server 2a12:8ac1:0:1100::250 Oct 15 23:42:18 volumio sudo[2097]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:20 volumio ntpd[738]: receive: Unexpected origin timestamp 0xec9a93bb.0cd116e2 does not match aorg 0000000000.00000000 from server@45.90.162.253 xmt 0xec9a93bc.2e5403a0 Oct 15 23:42:24 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 15 23:42:24 volumio volumio[943]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 15 23:42:24 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 15 23:42:24 volumio volumio[943]: info: Received Get System Version Oct 15 23:42:24 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:42:24 volumio volumio[943]: info: Received Get System Info Oct 15 23:42:24 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 15 23:42:24 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 15 23:42:24 volumio volumio[943]: info: Discovery: Getting this device information Oct 15 23:42:24 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:42:24 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:24 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 23:42:24 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Oct 15 23:42:24 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Oct 15 23:42:24 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 15 23:42:24 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:42:24 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 15 23:42:26 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 15 23:42:26 volumio volumio[943]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 15 23:42:26 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 15 23:42:26 volumio volumio[943]: info: Received Get System Version Oct 15 23:42:26 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:42:26 volumio volumio[943]: info: Received Get System Info Oct 15 23:42:26 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 15 23:42:26 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 15 23:42:26 volumio volumio[943]: info: Discovery: Getting this device information Oct 15 23:42:26 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:42:26 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:26 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 23:42:35 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Oct 15 23:42:35 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 15 23:42:36 volumio volumio-remote-updater[562]: No test mode Oct 15 23:42:36 volumio volumio-remote-updater[562]: No alpha test mode Oct 15 23:42:36 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 15 23:42:36 volumio volumio[943]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 15 23:42:36 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 15 23:42:38 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Oct 15 23:42:38 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 15 23:42:38 volumio volumio-remote-updater[562]: No test mode Oct 15 23:42:38 volumio volumio-remote-updater[562]: No alpha test mode Oct 15 23:42:38 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 15 23:42:38 volumio volumio[943]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 15 23:42:38 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 15 23:42:41 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Oct 15 23:42:41 volumio volumio[943]: info: Preparing to save Alsa Options, stopping services first Oct 15 23:42:41 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:42:41 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:41 volumio volumio[943]: info: CoreCommandRouter::volumioPause Oct 15 23:42:41 volumio volumio[943]: info: CoreStateMachine::pause Oct 15 23:42:41 volumio volumio[943]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"0","label":"Headphones"},"disallowPush":true} Oct 15 23:42:41 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 15 23:42:41 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 15 23:42:41 volumio volumio[943]: info: Found match in Cards Database: setting mixer PCM for card Headphones Oct 15 23:42:41 volumio volumio[943]: info: QobuzConnect: setDeactiveState invoked Oct 15 23:42:41 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:42:41 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:41 volumio vtcs[1741]: [2025-10-15 23:42:41.971] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Oct 15 23:42:41 volumio vtcs[1741]: [2025-10-15 23:42:41.973] [tisoc] [error] [SpkconServer.cpp:380] recv error. client fd=5 errorno=104 error=Connection reset by peer Oct 15 23:42:41 volumio vtcs[1741]: [2025-10-15 23:42:41.973] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Oct 15 23:42:42 volumio sudo[2154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 15 23:42:42 volumio sudo[2154]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:42 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Oct 15 23:42:42 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Oct 15 23:42:42 volumio systemd[1]: vtcs.service: Succeeded. Oct 15 23:42:42 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 15 23:42:42 volumio volumio[943]: info: Updating Volume Controller Parameters: Device: 0 Name: Headphones Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 15 23:42:42 volumio volumio[943]: info: Disabling external Volume Control Oct 15 23:42:42 volumio sudo[2154]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:42 volumio volumio[943]: info: Preparing to generate the ALSA configuration file Oct 15 23:42:42 volumio sudo[2161]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 15 23:42:42 volumio sudo[2161]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:42 volumio sudo[2161]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:42 volumio volumio[943]: info: Retrieving Cloud Streaming UI Oct 15 23:42:42 volumio sudo[2167]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Oct 15 23:42:42 volumio sudo[2167]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:42 volumio volumio[943]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Oct 15 23:42:42 volumio volumio[943]: info: Reading ALSA contributions from plugins. Oct 15 23:42:42 volumio sudo[2167]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:42 volumio sudo[2171]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Oct 15 23:42:42 volumio sudo[2171]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:42 volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Oct 15 23:42:42 volumio qobuz-connect[1668]: 20251015 23:42:42.375 [1668.1668] INFO SampleApp: Stopping Local configuration server Oct 15 23:42:42 volumio qobuz-connect[1668]: 20251015 23:42:42.385 [1668.1668] INFO SampleApp: shat down connection on UNIX socket Oct 15 23:42:42 volumio systemd[1]: qobuz-connect.service: Succeeded. Oct 15 23:42:42 volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 15 23:42:42 volumio systemd[1]: Started Volumio Qobuz Connect Service. Oct 15 23:42:42 volumio sudo[2171]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 15 23:42:42 volumio volumio[943]: info: Getting Tidal Cloud Configuration Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:42 volumio volumio[943]: info: Getting Qobuz Cloud Configuration Oct 15 23:42:42 volumio volumio[943]: info: Asking plugin for UI Config Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:42 volumio volumio[943]: info: Getting Spotify Cloud Configuration Oct 15 23:42:42 volumio volumio[943]: info: Asking plugin for UI Config Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:42 volumio volumio[943]: info: Saving Spotify Acccount Oct 15 23:42:42 volumio volumio[943]: info: Got it Oct 15 23:42:42 volumio volumio[943]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 15 23:42:42 volumio volumio-remote-updater[562]: No test mode Oct 15 23:42:42 volumio volumio-remote-updater[562]: No alpha test mode Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 15 23:42:42 volumio volumio[943]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Oct 15 23:42:42 volumio volumio[943]: info: QobuzConnect: setDeactiveState invoked Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:42:42 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:42 volumio volumio[943]: info: VolumeController:: Volume=50 Mute =false Oct 15 23:42:42 volumio volumio[943]: info: CoreStateMachine::pushState Oct 15 23:42:42 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::volumioPushState Oct 15 23:42:42 volumio volumio[943]: info: MRS: Pushing multiroomSync output update for this device Oct 15 23:42:42 volumio volumio[943]: info: MRS: Pushing multiroomSync output Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:42:42 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:42 volumio volumio[943]: info: Executing endpoint qc_getconfig Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 15 23:42:42 volumio qobuz-connect[2175]: 20251015 23:42:42.615 [2175.2175] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Oct 15 23:42:42 volumio qobuz-connect[2175]: 20251015 23:42:42.621 [2175.2175] INFO VolumeManager: [0x2383ab0]: Setting new playback volume: 75 Oct 15 23:42:42 volumio qobuz-connect[2175]: 20251015 23:42:42.621 [2175.2175] INFO VolumeManager: [0x2383ab0]: Setting new mute state: 0 Oct 15 23:42:42 volumio qobuz-connect[2175]: 20251015 23:42:42.621 [2175.2175] INFO QobuzConnect: [0x2384480]: Client initialized! Oct 15 23:42:42 volumio qobuz-connect[2175]: 20251015 23:42:42.621 [2175.2175] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Oct 15 23:42:42 volumio qobuz-connect[2175]: 20251015 23:42:42.630 [2175.2175] INFO LocalConfigManager: [0x2383390]: Starting Local Configuration server Oct 15 23:42:42 volumio qobuz-connect[2175]: 20251015 23:42:42.630 [2175.2175] INFO SampleApp: Starting Local configuration server Oct 15 23:42:42 volumio qobuz-connect[2175]: 20251015 23:42:42.631 [2175.2175] INFO SampleApp: Connected to UNIX socket client 0x2378f60 Oct 15 23:42:42 volumio volumio[943]: info: Got Tidal Cloud Configuration Oct 15 23:42:42 volumio volumio[943]: info: Got it Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 15 23:42:42 volumio volumio[943]: info: Asound.conf file unchanged, so no further update is needed Oct 15 23:42:42 volumio volumio[943]: info: Output device has changed, restarting MPD Oct 15 23:42:42 volumio sudo[2182]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 23:42:42 volumio sudo[2182]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:42 volumio volumio[943]: info: Output device has changed, restarting Shairport Sync Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:42:42 volumio sudo[2182]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:42 volumio sudo[2185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 23:42:42 volumio sudo[2185]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:42 volumio systemd[1]: Stopping Music Player Daemon... Oct 15 23:42:42 volumio volumio[943]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:42:42 volumio qobuz-connect[2175]: 20251015 23:42:42.765 [2175.2175] INFO SampleApp: Playback volume changed: 75 Oct 15 23:42:42 volumio volumio[943]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:42:42 volumio volumio[943]: info: QobuzConnect: setDeactiveState invoked Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:42:42 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:42 volumio sudo[2193]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 15 23:42:42 volumio sudo[2193]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:42 volumio sudo[2196]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 15 23:42:42 volumio sudo[2196]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:42 volumio sudo[2193]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:42 volumio volumio[943]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Oct 15 23:42:42 volumio volumio[943]: info: QobuzConnect: QOBUZ Connect daemon connected Oct 15 23:42:42 volumio sudo[2203]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Oct 15 23:42:42 volumio sudo[2203]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:42 volumio sudo[2196]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:42 volumio volumio[943]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:42:42 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:42 volumio volumio[943]: info: MPD Permissions set Oct 15 23:42:42 volumio sudo[2203]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:42:42 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:42:42 volumio sudo[2206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Oct 15 23:42:42 volumio sudo[2206]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:42 volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Oct 15 23:42:43 volumio qobuz-connect[2175]: 20251015 23:42:42.999 [2175.2175] INFO SampleApp: Stopping Local configuration server Oct 15 23:42:43 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:42:43 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:42:43 volumio qobuz-connect[2175]: 20251015 23:42:43.009 [2175.2175] INFO SampleApp: shat down connection on UNIX socket Oct 15 23:42:43 volumio systemd[1]: qobuz-connect.service: Succeeded. Oct 15 23:42:43 volumio volumio[943]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Oct 15 23:42:43 volumio volumio[943]: info: QobuzConnect: setDeactiveState invoked Oct 15 23:42:43 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:42:43 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:43 volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Oct 15 23:42:43 volumio volumio[943]: info: Starting Shairport Sync Oct 15 23:42:43 volumio systemd[1]: Started Volumio Qobuz Connect Service. Oct 15 23:42:43 volumio sudo[2206]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:43 volumio sudo[2214]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:42:43 volumio sudo[2214]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:43 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 15 23:42:43 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 15 23:42:43 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 15 23:42:43 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 15 23:42:43 volumio sudo[2214]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:43 volumio volumio[943]: info: Executing endpoint qc_getconfig Oct 15 23:42:43 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 15 23:42:43 volumio qobuz-connect[2212]: 20251015 23:42:43.184 [2212.2212] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Oct 15 23:42:43 volumio volumio[943]: info: Shairport-Sync Started Oct 15 23:42:43 volumio volumio[943]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Oct 15 23:42:43 volumio volumio[943]: info: QobuzConnect: QOBUZ Connect daemon connected Oct 15 23:42:43 volumio qobuz-connect[2212]: 20251015 23:42:43.192 [2212.2212] INFO VolumeManager: [0x116eab0]: Setting new playback volume: 75 Oct 15 23:42:43 volumio qobuz-connect[2212]: 20251015 23:42:43.192 [2212.2212] INFO VolumeManager: [0x116eab0]: Setting new mute state: 0 Oct 15 23:42:43 volumio qobuz-connect[2212]: 20251015 23:42:43.192 [2212.2212] INFO QobuzConnect: [0x116f480]: Client initialized! Oct 15 23:42:43 volumio qobuz-connect[2212]: 20251015 23:42:43.192 [2212.2212] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Oct 15 23:42:43 volumio qobuz-connect[2212]: 20251015 23:42:43.207 [2212.2212] INFO LocalConfigManager: [0x116e390]: Starting Local Configuration server Oct 15 23:42:43 volumio qobuz-connect[2212]: 20251015 23:42:43.207 [2212.2212] INFO SampleApp: Starting Local configuration server Oct 15 23:42:43 volumio qobuz-connect[2212]: 20251015 23:42:43.208 [2212.2212] INFO SampleApp: Connected to UNIX socket client 0x1163f60 Oct 15 23:42:43 volumio qobuz-connect[2212]: 20251015 23:42:43.334 [2212.2212] INFO SampleApp: Playback volume changed: 75 Oct 15 23:42:43 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:42:43 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:43 volumio systemd[1]: mpd.service: Succeeded. Oct 15 23:42:43 volumio systemd[1]: Stopped Music Player Daemon. Oct 15 23:42:43 volumio systemd[1]: Starting Music Player Daemon... Oct 15 23:42:43 volumio sudo[2221]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 15 23:42:43 volumio sudo[2221]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:43 volumio sudo[2221]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:45 volumio volumio[943]: info: TidalConnect service stoped! Oct 15 23:42:45 volumio volumio[943]: info: TidalConnect service stoped! Oct 15 23:42:45 volumio volumio[943]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Oct 15 23:42:45 volumio volumio[943]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Oct 15 23:42:45 volumio sudo[2234]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Oct 15 23:42:45 volumio sudo[2234]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:45 volumio systemd[1]: Started Volumio Tidal Connect Service. Oct 15 23:42:45 volumio sudo[2234]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:45 volumio volumio[943]: info: Executing endpoint tc_getconfig Oct 15 23:42:45 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Oct 15 23:42:45 volumio vtcs[2236]: STARTING TidalConnect services, version: 1.5.1-beta1 Oct 15 23:42:45 volumio vtcs[2236]: STARTED TidalConnect services. Oct 15 23:42:45 volumio volumio[943]: info: Executing endpoint tc_connect Oct 15 23:42:45 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Oct 15 23:42:45 volumio volumio[943]: info: Connecting to TidalConnect Oct 15 23:42:45 volumio volumio[943]: info: CoreCommandRouter::servicePushState Oct 15 23:42:45 volumio volumio[943]: info: CoreStateMachine::pushState Oct 15 23:42:45 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:45 volumio volumio[943]: info: CoreCommandRouter::volumioPushState Oct 15 23:42:45 volumio mpd[2223]: Oct 15 23:42 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 15 23:42:45 volumio systemd[1]: Started Music Player Daemon. Oct 15 23:42:45 volumio sudo[2185]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:45 volumio volumio[943]: info: MRS: Pushing multiroomSync output update for this device Oct 15 23:42:45 volumio volumio[943]: info: MRS: Pushing multiroomSync output Oct 15 23:42:45 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:42:45 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:45 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:45 volumio volumio[943]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Oct 15 23:42:45 volumio volumio[943]: info: CoreCommandRouter::servicePushState Oct 15 23:42:45 volumio volumio[943]: info: CoreStateMachine::pushState Oct 15 23:42:45 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:45 volumio volumio[943]: info: CoreCommandRouter::volumioPushState Oct 15 23:42:45 volumio volumio[943]: info: MRS: Pushing multiroomSync output update for this device Oct 15 23:42:45 volumio volumio[943]: info: MRS: Pushing multiroomSync output Oct 15 23:42:45 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:42:45 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:45 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:45 volumio volumio[943]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Oct 15 23:42:45 volumio volumio[943]: error: updateQueue error: null Oct 15 23:42:45 volumio volumio[943]: info: TidalConnect service stoped! Oct 15 23:42:45 volumio volumio[943]: info: TidalConnect service stoped! Oct 15 23:42:45 volumio volumio[943]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Oct 15 23:42:45 volumio volumio[943]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Oct 15 23:42:46 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Oct 15 23:42:46 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 15 23:42:46 volumio systemd[1]: systemd-timedated.service: Succeeded. Oct 15 23:42:46 volumio sudo[2266]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Oct 15 23:42:46 volumio sudo[2266]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:42:46 volumio volumio[943]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Oct 15 23:42:46 volumio volumio[943]: info: CoreStateMachine::getcurrentVolume Oct 15 23:42:46 volumio volumio[943]: info: CoreCommandRouter::volumioRetrievevolume Oct 15 23:42:46 volumio sudo[2266]: pam_unix(sudo:session): session closed for user root Oct 15 23:42:46 volumio volumio-remote-updater[562]: No test mode Oct 15 23:42:46 volumio volumio-remote-updater[562]: No alpha test mode Oct 15 23:42:46 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 15 23:42:46 volumio volumio[943]: info: VolumeController:: Volume=50 Mute =false Oct 15 23:42:46 volumio volumio[943]: info: CoreStateMachine::pushState Oct 15 23:42:46 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:46 volumio volumio[943]: info: CoreCommandRouter::volumioPushState Oct 15 23:42:46 volumio volumio[943]: info: MRS: Pushing multiroomSync output update for this device Oct 15 23:42:46 volumio volumio[943]: info: MRS: Pushing multiroomSync output Oct 15 23:42:46 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:42:46 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:46 volumio volumio[943]: info: CoreStateMachine::updateTrackBlock Oct 15 23:42:46 volumio volumio[943]: info: CorePlayQueue::getTrackBlock Oct 15 23:42:46 volumio volumio[943]: info: CoreCommandRouter::volumioRetrievevolume Oct 15 23:42:46 volumio volumio[943]: info: VolumeController:: Volume=50 Mute =false Oct 15 23:42:46 volumio volumio[943]: info: CoreStateMachine::pushState Oct 15 23:42:46 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:46 volumio volumio[943]: info: CoreCommandRouter::volumioPushState Oct 15 23:42:46 volumio volumio[943]: info: MRS: Pushing multiroomSync output update for this device Oct 15 23:42:46 volumio volumio[943]: info: MRS: Pushing multiroomSync output Oct 15 23:42:46 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:42:46 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:42:46 volumio volumio[943]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 15 23:42:46 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 15 23:42:48 volumio volumio[943]: info: TidalConnect service started! Oct 15 23:42:49 volumio volumio[943]: info: TidalConnect service started! Oct 15 23:42:54 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Oct 15 23:42:54 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Oct 15 23:42:54 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Oct 15 23:42:54 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Oct 15 23:42:54 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Oct 15 23:42:59 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Oct 15 23:42:59 volumio volumio[943]: info: CoreCommandRouter::Reload Ui Oct 15 23:42:59 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard Oct 15 23:42:59 volumio volumio[943]: info: Wizard terminated Successfully Oct 15 23:42:59 volumio volumio[943]: info: CoreCommandRouter::volumiosetStartupVolume Oct 15 23:42:59 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:43:00 volumio sudo[2301]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 15 23:43:00 volumio sudo[2301]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:43:00 volumio sudo[2301]: pam_unix(sudo:session): session closed for user root Oct 15 23:43:00 volumio sudo[2303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 15 23:43:00 volumio sudo[2303]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:43:00 volumio sudo[2303]: pam_unix(sudo:session): session closed for user root Oct 15 23:43:00 volumio volumio[943]: verbose: New Socket.io Connection to 192.168.1.51 from 192.168.1.18 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_6_2 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.6 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 6 Oct 15 23:43:00 volumio volumio[943]: info: CoreCommandRouter::volumioGetVisibleSources Oct 15 23:43:00 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:43:00 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 15 23:43:00 volumio volumio[943]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Oct 15 23:43:00 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:43:00 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:43:00 volumio sudo[2307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 15 23:43:00 volumio sudo[2307]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:43:00 volumio sudo[2307]: pam_unix(sudo:session): session closed for user root Oct 15 23:43:00 volumio sudo[2310]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 15 23:43:00 volumio sudo[2310]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:43:00 volumio sudo[2310]: pam_unix(sudo:session): session closed for user root Oct 15 23:43:00 volumio volumio[943]: verbose: New Socket.io Connection to 192.168.1.51 from 192.168.1.18 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_6_2 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.6 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 6 Oct 15 23:43:00 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:43:00 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:43:00 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 15 23:43:00 volumio volumio[943]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Oct 15 23:43:00 volumio volumio[943]: info: Listing playlists Oct 15 23:43:00 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 15 23:43:00 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 15 23:43:00 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 15 23:43:00 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 15 23:43:02 volumio volumio[943]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 15 23:43:03 volumio volumio[943]: info: CoreCommandRouter::volumioGetVisibleSources Oct 15 23:43:03 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:43:03 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 15 23:43:03 volumio volumio[943]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Oct 15 23:43:03 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:43:03 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:43:04 volumio volumio[943]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 15 23:43:05 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:43:05 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:43:06 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 15 23:43:06 volumio volumio[943]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Oct 15 23:43:06 volumio volumio[943]: info: CoreCommandRouter::volumioGetVisibleSources Oct 15 23:43:06 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:43:06 volumio volumio[943]: info: Listing playlists Oct 15 23:43:06 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 15 23:43:06 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 15 23:43:06 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 15 23:43:06 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 15 23:43:10 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 15 23:43:10 volumio volumio[943]: info: Received Get System Info Oct 15 23:43:10 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 15 23:43:10 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 15 23:43:10 volumio volumio[943]: info: Discovery: Getting this device information Oct 15 23:43:10 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:43:10 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:43:10 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 23:43:11 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 15 23:43:13 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 15 23:43:13 volumio volumio[943]: info: Received Get System Info Oct 15 23:43:13 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 15 23:43:13 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 15 23:43:13 volumio volumio[943]: info: Discovery: Getting this device information Oct 15 23:43:13 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:43:13 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:43:13 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 23:43:13 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 15 23:43:13 volumio volumio[943]: info: Received Get System Info Oct 15 23:43:13 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 15 23:43:13 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 15 23:43:13 volumio volumio[943]: info: Discovery: Getting this device information Oct 15 23:43:13 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:43:13 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:43:13 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 23:43:18 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 15 23:43:18 volumio volumio[943]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 15 23:43:18 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 15 23:43:18 volumio volumio[943]: info: Received Get System Version Oct 15 23:43:18 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:43:18 volumio volumio[943]: info: Received Get System Info Oct 15 23:43:18 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 15 23:43:18 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 15 23:43:18 volumio volumio[943]: info: Discovery: Getting this device information Oct 15 23:43:18 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:43:18 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:43:18 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 23:43:22 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 15 23:43:22 volumio volumio[943]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 15 23:43:22 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 15 23:43:22 volumio volumio[943]: info: Received Get System Version Oct 15 23:43:22 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:43:22 volumio volumio[943]: info: Received Get System Info Oct 15 23:43:22 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 15 23:43:22 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 15 23:43:22 volumio volumio[943]: info: Discovery: Getting this device information Oct 15 23:43:22 volumio volumio[943]: info: CoreCommandRouter::volumioGetState Oct 15 23:43:22 volumio volumio[943]: info: CorePlayQueue::getTrack 0 Oct 15 23:43:22 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 23:43:31 volumio volumio[943]: info: CoreCommandRouter::executeOnPlugin: multiroom , audioOutputPlay Oct 15 23:43:31 volumio volumio[943]: info: Error : CoreCommandRouter::executeOnPlugin: No method [audioOutputPlay] in plugin multiroom Oct 15 23:43:31 volumio volumio[943]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 23:43:31 volumio volumio[943]: TypeError: Cannot read property 'then' of undefined Oct 15 23:43:31 volumio volumio[943]: at outputs.audioOutputPlay (/volumio/app/plugins/audio_interface/outputs/index.js:367:9) Oct 15 23:43:31 volumio volumio[943]: at CoreCommandRouter.audioOutputPlay (/volumio/app/index.js:2279:30) Oct 15 23:43:31 volumio volumio[943]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1456:26) Oct 15 23:43:31 volumio volumio[943]: at Socket.emit (events.js:315:20) Oct 15 23:43:31 volumio volumio[943]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Oct 15 23:43:31 volumio volumio[943]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Oct 15 23:43:31 volumio volumio[943]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 23:43:33 volumio sudo[2439]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-15 23:42 Oct 15 23:43:33 volumio sudo[2439]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"