-- Logs begin at Thu 2019-02-14 07:11:58 -03, end at Fri 2025-05-02 01:05:46 -04. -- May 02 01:04:11 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 02 01:04:11 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 02 01:04:11 volumio volumio[932]: info: Discovery: Getting this device information May 02 01:04:11 volumio volumio[932]: info: CoreCommandRouter::volumioGetState May 02 01:04:11 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:04:11 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 02 01:04:11 volumio volumio[932]: verbose: New Socket.io Connection to 192.168.100.204:3000 from 192.168.100.89 UA: Dart/3.7 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 May 02 01:04:11 volumio volumio[932]: info: CoreCommandRouter::volumioGetState May 02 01:04:11 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:04:11 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 02 01:04:11 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 02 01:04:12 volumio volumio-remote-updater[644]: No test mode May 02 01:04:12 volumio volumio-remote-updater[644]: No alpha test mode May 02 01:04:12 volumio volumio[932]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} May 02 01:04:12 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 02 01:04:14 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 02 01:04:14 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 02 01:04:14 volumio volumio[932]: info: Discovery: Getting this device information May 02 01:04:14 volumio volumio[932]: info: CoreCommandRouter::volumioGetState May 02 01:04:14 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:04:14 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 02 01:04:30 volumio volumio[932]: info: CoreCommandRouter::volumioGetState May 02 01:04:30 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:04:31 volumio sudo[2053]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 02 01:04:31 volumio sudo[2053]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:04:31 volumio sudo[2053]: pam_unix(sudo:session): session closed for user root May 02 01:04:31 volumio sudo[2055]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 02 01:04:31 volumio sudo[2055]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:04:31 volumio sudo[2055]: pam_unix(sudo:session): session closed for user root May 02 01:04:31 volumio volumio[932]: verbose: New Socket.io Connection to 192.168.100.204 from 192.168.100.89 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 5 May 02 01:04:31 volumio volumio[932]: info: CoreCommandRouter::volumioGetVisibleSources May 02 01:04:31 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 02 01:04:31 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps May 02 01:04:31 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode May 02 01:04:31 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages May 02 01:04:31 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones May 02 01:04:31 volumio volumio[932]: info: Received Get System Info May 02 01:04:31 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 02 01:04:31 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 02 01:04:31 volumio volumio[932]: info: Discovery: Getting this device information May 02 01:04:31 volumio volumio[932]: info: CoreCommandRouter::volumioGetState May 02 01:04:31 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:04:31 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 02 01:04:31 volumio volumio-remote-updater[644]: No test mode May 02 01:04:31 volumio volumio-remote-updater[644]: No alpha test mode May 02 01:04:31 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 02 01:04:31 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 02 01:04:31 volumio volumio[932]: info: CoreCommandRouter::getUIConfigOnPlugin May 02 01:04:31 volumio volumio[932]: info: Retrieving Cloud Streaming UI May 02 01:04:31 volumio volumio[932]: info: Getting Tidal Cloud Configuration May 02 01:04:31 volumio volumio[932]: info: CoreCommandRouter::getUIConfigOnPlugin May 02 01:04:31 volumio volumio[932]: info: Getting Qobuz Cloud Configuration May 02 01:04:31 volumio volumio[932]: info: Asking plugin for UI Config May 02 01:04:31 volumio volumio[932]: info: CoreCommandRouter::getUIConfigOnPlugin May 02 01:04:31 volumio volumio[932]: info: Getting Spotify Cloud Configuration May 02 01:04:31 volumio volumio[932]: info: Asking plugin for UI Config May 02 01:04:31 volumio volumio[932]: info: CoreCommandRouter::getUIConfigOnPlugin May 02 01:04:31 volumio volumio[932]: info: Saving Spotify Acccount May 02 01:04:31 volumio volumio[932]: info: Got Tidal Cloud Configuration May 02 01:04:31 volumio volumio[932]: info: Got it May 02 01:04:31 volumio volumio[932]: info: Got it May 02 01:04:31 volumio volumio[932]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 02 01:04:31 volumio volumio[932]: info: CoreCommandRouter::getUIConfigOnPlugin May 02 01:04:31 volumio volumio[932]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 02 01:04:31 volumio volumio[932]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} May 02 01:04:31 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 02 01:04:32 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage May 02 01:04:32 volumio volumio[932]: info: Loading i18n strings for locale es May 02 01:04:32 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone May 02 01:04:32 volumio volumio[932]: info: Setting timezone to America/Santiago May 02 01:04:32 volumio sudo[2063]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime May 02 01:04:32 volumio sudo[2063]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:04:32 volumio sudo[2063]: pam_unix(sudo:session): session closed for user root May 02 01:04:32 volumio sudo[2066]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/America/Santiago /etc/localtime May 02 01:04:32 volumio sudo[2066]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:04:32 volumio sudo[2066]: pam_unix(sudo:session): session closed for user root May 02 01:04:32 volumio sudo[2069]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime May 02 01:04:32 volumio sudo[2069]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:04:32 volumio sudo[2069]: pam_unix(sudo:session): session closed for user root May 02 01:04:32 volumio sudo[2072]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone America/Santiago May 02 01:04:32 volumio sudo[2072]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:04:32 volumio dbus-daemon[648]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.22' (uid=0 pid=2073 comm="/usr/bin/timedatectl set-timezone America/Santiago") May 02 01:04:32 volumio systemd[1]: Starting Time & Date Service... May 02 01:04:32 volumio dbus-daemon[648]: [system] Successfully activated service 'org.freedesktop.timedate1' May 02 01:04:32 volumio systemd[1]: Started Time & Date Service. May 02 01:04:32 volumio sudo[2072]: pam_unix(sudo:session): session closed for user root May 02 01:04:32 volumio volumio[932]: Updating browse sources language May 02 01:04:32 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 02 01:04:33 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 02 01:04:33 volumio volumio[932]: info: Fetching Streaming Services browse cache May 02 01:04:34 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage May 02 01:04:34 volumio volumio[932]: info: Loading i18n strings for locale es May 02 01:04:34 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone May 02 01:04:34 volumio volumio[932]: info: Setting timezone to America/Santiago May 02 01:04:34 volumio sudo[2076]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime May 02 01:04:34 volumio sudo[2076]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:04:34 volumio sudo[2076]: pam_unix(sudo:session): session closed for user root May 02 01:04:34 volumio sudo[2079]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/America/Santiago /etc/localtime May 02 01:04:34 volumio sudo[2079]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:04:34 volumio sudo[2079]: pam_unix(sudo:session): session closed for user root May 02 01:04:34 volumio sudo[2082]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime May 02 01:04:34 volumio sudo[2082]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:04:34 volumio sudo[2082]: pam_unix(sudo:session): session closed for user root May 02 01:04:34 volumio sudo[2085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone America/Santiago May 02 01:04:34 volumio sudo[2085]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:04:34 volumio sudo[2085]: pam_unix(sudo:session): session closed for user root May 02 01:04:34 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache May 02 01:04:34 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks May 02 01:04:34 volumio sudo[2092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 02 01:04:34 volumio sudo[2092]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:04:34 volumio volumio[932]: Updating browse sources language May 02 01:04:34 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 02 01:04:34 volumio volumio[932]: info: Fetching Streaming Services browse cache May 02 01:04:35 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 02 01:04:36 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 02 01:04:36 volumio volumio[932]: info: MyVolumio login type: Token May 02 01:04:36 volumio volumio[932]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN May 02 01:04:37 volumio volumio[932]: info: MyVolumio token set successfully May 02 01:04:37 volumio volumio[932]: info: MYVOLUMIO: Adding device May 02 01:04:37 volumio volumio[932]: info: MYVOLUMIO: Evaluating Server May 02 01:04:37 volumio volumio[932]: info: MyVolumio status changed May 02 01:04:37 volumio volumio[932]: info: Streaming services startup May 02 01:04:37 volumio volumio[932]: info: Starting Streaming Daemon May 02 01:04:37 volumio volumio[932]: info: Removing browser output: myVolumio user plan is not superstar May 02 01:04:37 volumio volumio[932]: info: Removing audio output: May 02 01:04:37 volumio volumio[932]: info: Stoppping Tunnel 1 May 02 01:04:37 volumio sudo[2165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 02 01:04:37 volumio sudo[2165]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:04:37 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings May 02 01:04:37 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices May 02 01:04:37 volumio sudo[2167]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service May 02 01:04:37 volumio sudo[2167]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:04:37 volumio sudo[2165]: pam_unix(sudo:session): session closed for user root May 02 01:04:37 volumio sudo[2167]: pam_unix(sudo:session): session closed for user root May 02 01:04:37 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 02 01:04:37 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 01:04:37 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 02 01:04:37 volumio volumio[932]: info: Remote SSH Stopped May 02 01:04:37 volumio volumio[932]: error: Cannot start Volumio Streaming Daemon May 02 01:04:37 volumio volumio[932]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 02 01:04:37 volumio volumio[932]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 02 01:04:38 volumio sudo[2092]: pam_unix(sudo:session): session closed for user root May 02 01:04:38 volumio volumio[932]: info: Setting Geolocation for MyVolumio to us1 May 02 01:04:38 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 01:04:38 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 01:04:38 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 01:04:38 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 02 01:04:38 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 02 01:04:39 volumio volumio[932]: info: Updating MyVolumio device info May 02 01:04:39 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 01:04:39 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 01:04:39 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 01:04:39 volumio volumio[932]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} May 02 01:04:39 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 02 01:04:39 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 02 01:04:39 volumio volumio[932]: info: Discovery: Getting this device information May 02 01:04:39 volumio volumio[932]: info: CoreCommandRouter::volumioGetState May 02 01:04:39 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:04:39 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 02 01:04:39 volumio volumio[932]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} May 02 01:04:43 volumio volumio[932]: info: MYVOLUMIO: Adding device May 02 01:04:43 volumio volumio[932]: info: MYVOLUMIO: Evaluating Server May 02 01:04:44 volumio volumio[932]: info: Setting Geolocation for MyVolumio to us1 May 02 01:04:44 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 01:04:44 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 01:04:44 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 01:04:44 volumio volumio[932]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} May 02 01:04:45 volumio volumio[932]: info: Updating MyVolumio device info May 02 01:04:45 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 01:04:45 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 01:04:45 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 01:04:45 volumio volumio[932]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} May 02 01:04:50 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 02 01:04:50 volumio volumio[932]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 02 01:04:50 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 02 01:04:50 volumio volumio[932]: info: Received Get System Version May 02 01:04:50 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 02 01:04:50 volumio volumio[932]: info: Received Get System Info May 02 01:04:50 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 02 01:04:50 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 02 01:04:50 volumio volumio[932]: info: Discovery: Getting this device information May 02 01:04:50 volumio volumio[932]: info: CoreCommandRouter::volumioGetState May 02 01:04:50 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:04:50 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 02 01:04:53 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions May 02 01:04:53 volumio volumio[932]: info: Preparing to save Alsa Options, stopping services first May 02 01:04:53 volumio volumio[932]: info: CoreCommandRouter::volumioGetState May 02 01:04:53 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:04:53 volumio volumio[932]: info: CoreCommandRouter::volumioPause May 02 01:04:53 volumio volumio[932]: info: CoreStateMachine::pause May 02 01:04:53 volumio volumio[932]: info: Saving Audio Output to: {"i2s":true,"i2sid":{"value":"allo-boss-dac","label":"Allo BOSS"},"output_device":{"value":1,"label":"Allo BOSS"},"disallowPush":true} May 02 01:04:53 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 02 01:04:53 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber May 02 01:04:53 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 01:04:53 volumio volumio[932]: info: Enabling I2S DAC: Allo BOSS May 02 01:04:53 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , enableI2SDAC May 02 01:04:53 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 01:04:53 volumio sudo[2206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l May 02 01:04:53 volumio sudo[2206]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:04:53 volumio sudo[2206]: pam_unix(sudo:session): session closed for user root May 02 01:04:53 volumio volumio[932]: info: No Overlays Loaded May 02 01:04:53 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 01:04:53 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName May 02 01:04:53 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 01:04:53 volumio sudo[2209]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay allo-boss-dac-pcm512x-audio May 02 01:04:53 volumio sudo[2209]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:04:53 volumio sudo[2209]: pam_unix(sudo:session): session closed for user root May 02 01:04:53 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 02 01:04:53 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer May 02 01:04:53 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 01:04:53 volumio volumio[932]: info: Found match in i2s Card Database: setting mixer Digital for card Allo BOSS May 02 01:04:53 volumio volumio[932]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 02 01:04:53 volumio volumio[932]: info: Updating Volume Controller Parameters: Device: 2 Name: Allo BOSS Mixer: Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 May 02 01:04:53 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume May 02 01:04:53 volumio volumio[932]: info: Disabling external Volume Control May 02 01:04:53 volumio volumio[932]: info: CoreCommandRouter::getUIConfigOnPlugin May 02 01:04:53 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction May 02 01:04:53 volumio volumio[932]: info: Preparing to generate the ALSA configuration file May 02 01:04:53 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache May 02 01:04:53 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks May 02 01:04:53 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache May 02 01:04:53 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks May 02 01:04:53 volumio sudo[2225]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 02 01:04:53 volumio sudo[2225]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:04:53 volumio volumio[932]: error: Cannot enable I2S Param: Error: Command failed: /usr/bin/sudo /usr/bin/dtoverlay allo-boss-dac-pcm512x-audio May 02 01:04:53 volumio volumio[932]: * Failed to apply overlay '0_allo-boss-dac-pcm512x-audio' (kernel) May 02 01:04:53 volumio sudo[2227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 02 01:04:53 volumio sudo[2227]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:04:53 volumio sudo[2227]: pam_unix(sudo:session): session closed for user root May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 02 01:04:54 volumio volumio[932]: info: Getting Alsa Cards List without I2S DAC May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 02 01:04:54 volumio volumio[932]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan May 02 01:04:54 volumio volumio[932]: wlan0 Interface doesn't support scanning : Device or resource busy May 02 01:04:54 volumio volumio[932]: info: Cannot use regular scanning, forcing with ap-force May 02 01:04:54 volumio sudo[2240]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force May 02 01:04:54 volumio sudo[2240]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:04:54 volumio sudo[2240]: pam_unix(sudo:session): session closed for user root May 02 01:04:54 volumio volumio[932]: command failed: Device or resource busy (-16) May 02 01:04:54 volumio volumio[932]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force May 02 01:04:54 volumio volumio[932]: command failed: Device or resource busy (-16) May 02 01:04:54 volumio volumio[932]: info: VolumeController:: Volume=100 Mute =false May 02 01:04:54 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:04:54 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:04:54 volumio volumio[932]: info: Asound.conf file written May 02 01:04:54 volumio sudo[2243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf May 02 01:04:54 volumio sudo[2243]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:04:54 volumio sudo[2243]: pam_unix(sudo:session): session closed for user root May 02 01:04:54 volumio volumio[932]: No state is present for card b1 May 02 01:04:54 volumio volumio[932]: /usr/share/alsa/init/bcm2835:14: control element not found May 02 01:04:54 volumio volumio[932]: No state is present for card b1 May 02 01:04:54 volumio volumio[932]: No state is present for card Headphones May 02 01:04:54 volumio volumio[932]: /usr/share/alsa/init/bcm2835:20: control element not found May 02 01:04:54 volumio volumio[932]: No state is present for card Headphones May 02 01:04:54 volumio volumio[932]: No state is present for card BossDAC May 02 01:04:54 volumio volumio[932]: Found hardware: "BossDAC" "" "" "" "" May 02 01:04:54 volumio volumio[932]: Hardware is initialized using a generic method May 02 01:04:54 volumio volumio[932]: No state is present for card BossDAC May 02 01:04:54 volumio volumio[932]: info: Output device has changed, restarting MPD May 02 01:04:54 volumio sudo[2248]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 02 01:04:54 volumio sudo[2248]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:04:54 volumio volumio[932]: info: Output device has changed, restarting Shairport Sync May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 01:04:54 volumio sudo[2248]: pam_unix(sudo:session): session closed for user root May 02 01:04:54 volumio sudo[2251]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 02 01:04:54 volumio sudo[2251]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:04:54 volumio systemd[1]: Stopping Music Player Daemon... May 02 01:04:54 volumio volumio[932]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 02 01:04:54 volumio volumio[932]: info: Output device has changed, restarting MPD May 02 01:04:54 volumio systemd[1]: mpd.service: Succeeded. May 02 01:04:54 volumio systemd[1]: Stopped Music Player Daemon. May 02 01:04:54 volumio sudo[2258]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 02 01:04:54 volumio sudo[2258]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:04:54 volumio volumio[932]: info: Output device has changed, restarting Shairport Sync May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 01:04:54 volumio sudo[2258]: pam_unix(sudo:session): session closed for user root May 02 01:04:54 volumio sudo[2261]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 02 01:04:54 volumio sudo[2261]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:04:54 volumio systemd[1]: Starting Music Player Daemon... May 02 01:04:54 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM May 02 01:04:54 volumio systemd[1]: mpd.service: Succeeded. May 02 01:04:54 volumio systemd[1]: Stopped Music Player Daemon. May 02 01:04:54 volumio volumio[932]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 02 01:04:54 volumio systemd[1]: Starting Music Player Daemon... May 02 01:04:54 volumio volumio[932]: info: MPD Permissions set May 02 01:04:54 volumio volumio[932]: info: MPD Permissions set May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 02 01:04:54 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 01:04:54 volumio sudo[2266]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 02 01:04:54 volumio sudo[2266]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:04:54 volumio volumio[932]: info: Starting Shairport Sync May 02 01:04:54 volumio sudo[2266]: pam_unix(sudo:session): session closed for user root May 02 01:04:54 volumio volumio[932]: info: Starting Shairport Sync May 02 01:04:54 volumio sudo[2278]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 02 01:04:54 volumio sudo[2278]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:04:54 volumio sudo[2281]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 02 01:04:54 volumio sudo[2281]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:04:54 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 02 01:04:54 volumio systemd[1]: shairport-sync.service: Succeeded. May 02 01:04:54 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 02 01:04:54 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 02 01:04:54 volumio sudo[2278]: pam_unix(sudo:session): session closed for user root May 02 01:04:54 volumio sudo[2281]: pam_unix(sudo:session): session closed for user root May 02 01:04:54 volumio volumio[932]: info: Shairport-Sync Started May 02 01:04:54 volumio volumio[932]: info: Shairport-Sync Started May 02 01:04:55 volumio mpd[2277]: May 02 01:04 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 02 01:04:55 volumio systemd[1]: Started Music Player Daemon. May 02 01:04:55 volumio sudo[2251]: pam_unix(sudo:session): session closed for user root May 02 01:04:55 volumio sudo[2261]: pam_unix(sudo:session): session closed for user root May 02 01:04:55 volumio volumio[932]: error: MPD error: The expression evaluated to a falsy value: May 02 01:04:55 volumio volumio[932]: assert.ok(self.idling) May 02 01:04:55 volumio volumio[932]: error: The expression evaluated to a falsy value: May 02 01:04:55 volumio volumio[932]: assert.ok(self.idling) May 02 01:04:55 volumio volumio[932]: error: updateQueue error: null May 02 01:04:55 volumio volumio[932]: info: CoreCommandRouter::getUIConfigOnPlugin May 02 01:04:55 volumio volumio[932]: info: Retrieving Cloud Streaming UI May 02 01:04:55 volumio volumio[932]: info: Getting Tidal Cloud Configuration May 02 01:04:55 volumio volumio[932]: info: CoreCommandRouter::getUIConfigOnPlugin May 02 01:04:55 volumio volumio[932]: info: Getting Qobuz Cloud Configuration May 02 01:04:55 volumio volumio[932]: info: Asking plugin for UI Config May 02 01:04:55 volumio volumio[932]: info: CoreCommandRouter::getUIConfigOnPlugin May 02 01:04:55 volumio volumio[932]: info: Getting Spotify Cloud Configuration May 02 01:04:55 volumio volumio[932]: info: Asking plugin for UI Config May 02 01:04:55 volumio volumio[932]: info: CoreCommandRouter::getUIConfigOnPlugin May 02 01:04:55 volumio volumio[932]: info: Saving Spotify Acccount May 02 01:04:55 volumio volumio[932]: info: Got Tidal Cloud Configuration May 02 01:04:55 volumio volumio[932]: info: Got it May 02 01:04:55 volumio volumio[932]: info: Got it May 02 01:04:55 volumio volumio[932]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 02 01:04:55 volumio volumio[932]: info: CoreCommandRouter::getUIConfigOnPlugin May 02 01:04:55 volumio volumio[932]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 02 01:04:57 volumio sudo[2225]: pam_unix(sudo:session): session closed for user root May 02 01:04:57 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation May 02 01:04:57 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware May 02 01:04:57 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray May 02 01:04:57 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage May 02 01:04:57 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware May 02 01:04:57 volumio volumio[932]: info: CoreCommandRouter::volumioRetrieveVolumeLevels May 02 01:04:57 volumio volumio[932]: info: CoreStateMachine::getcurrentVolume May 02 01:04:57 volumio volumio[932]: info: CoreCommandRouter::volumioRetrievevolume May 02 01:04:58 volumio volumio[932]: info: VolumeController:: Volume=100 Mute =false May 02 01:04:58 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:04:58 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:04:58 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:04:58 volumio volumio[932]: info: CoreStateMachine::updateTrackBlock May 02 01:04:58 volumio volumio[932]: info: CorePlayQueue::getTrackBlock May 02 01:04:58 volumio volumio[932]: info: CoreCommandRouter::volumioRetrievevolume May 02 01:04:58 volumio volumio[932]: info: VolumeController:: Volume=100 Mute =false May 02 01:04:58 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:04:58 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:04:58 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:04:59 volumio volumio[932]: info: CALLMETHOD: system_controller system saveUpdateSettings [object Object] May 02 01:04:59 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , saveUpdateSettings May 02 01:04:59 volumio volumio[932]: error: Failed callmethod call: TypeError: Cannot read property 'value' of undefined May 02 01:05:00 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction May 02 01:05:00 volumio volumio[932]: info: CoreCommandRouter::Reload Ui May 02 01:05:00 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard May 02 01:05:00 volumio volumio[932]: info: Wizard terminated Successfully May 02 01:05:00 volumio volumio[932]: info: CoreCommandRouter::volumiosetStartupVolume May 02 01:05:00 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 02 01:05:00 volumio volumio[932]: info: Player Reboot required after I2S DAC has been enabled in wizard May 02 01:05:01 volumio sudo[2316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 02 01:05:01 volumio sudo[2316]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:05:01 volumio sudo[2316]: pam_unix(sudo:session): session closed for user root May 02 01:05:01 volumio sudo[2318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 02 01:05:01 volumio sudo[2318]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:05:01 volumio sudo[2318]: pam_unix(sudo:session): session closed for user root May 02 01:05:01 volumio volumio[932]: verbose: New Socket.io Connection to 192.168.100.204 from 192.168.100.89 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 5 May 02 01:05:01 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 02 01:05:01 volumio sudo[2322]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 02 01:05:01 volumio sudo[2322]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:05:01 volumio sudo[2322]: pam_unix(sudo:session): session closed for user root May 02 01:05:01 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 02 01:05:01 volumio sudo[2325]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 02 01:05:01 volumio sudo[2325]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 01:05:01 volumio sudo[2325]: pam_unix(sudo:session): session closed for user root May 02 01:05:01 volumio volumio[932]: verbose: New Socket.io Connection to 192.168.100.204 from 192.168.100.89 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 6 May 02 01:05:01 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 02 01:05:01 volumio volumio[932]: info: CoreCommandRouter::volumioGetVisibleSources May 02 01:05:01 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 02 01:05:01 volumio volumio[932]: info: CoreCommandRouter::volumioGetState May 02 01:05:01 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:01 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 02 01:05:01 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 02 01:05:01 volumio volumio[932]: info: Received Get System Info May 02 01:05:01 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 02 01:05:01 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 02 01:05:01 volumio volumio[932]: info: Discovery: Getting this device information May 02 01:05:01 volumio volumio[932]: info: CoreCommandRouter::volumioGetState May 02 01:05:01 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:01 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 02 01:05:01 volumio volumio[932]: info: CoreCommandRouter::volumioGetState May 02 01:05:01 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:01 volumio volumio[932]: info: Listing playlists May 02 01:05:01 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 02 01:05:01 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 02 01:05:01 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 02 01:05:02 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule May 02 01:05:02 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 02 01:05:03 volumio volumio-remote-updater[644]: No test mode May 02 01:05:03 volumio volumio-remote-updater[644]: No alpha test mode May 02 01:05:03 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled May 02 01:05:03 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 02 01:05:03 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 02 01:05:03 volumio volumio[932]: info: Received Get System Info May 02 01:05:03 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 02 01:05:03 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 02 01:05:03 volumio volumio[932]: info: Discovery: Getting this device information May 02 01:05:03 volumio volumio[932]: info: CoreCommandRouter::volumioGetState May 02 01:05:03 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:03 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 02 01:05:03 volumio volumio[932]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} May 02 01:05:03 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 02 01:05:04 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule May 02 01:05:04 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 02 01:05:04 volumio systemd[1]: systemd-timedated.service: Succeeded. May 02 01:05:04 volumio volumio-remote-updater[644]: No test mode May 02 01:05:04 volumio volumio-remote-updater[644]: No alpha test mode May 02 01:05:04 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled May 02 01:05:05 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 02 01:05:05 volumio volumio[932]: info: Received Get System Info May 02 01:05:05 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 02 01:05:05 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 02 01:05:05 volumio volumio[932]: info: Discovery: Getting this device information May 02 01:05:05 volumio volumio[932]: info: CoreCommandRouter::volumioGetState May 02 01:05:05 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:05 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 02 01:05:05 volumio volumio[932]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} May 02 01:05:05 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 02 01:05:06 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse May 02 01:05:06 volumio volumio[932]: info: CoreCommandRouter::volumioPlay May 02 01:05:06 volumio volumio[932]: info: CoreStateMachine::play index undefined May 02 01:05:06 volumio volumio[932]: info: CoreStateMachine::setConsumeUpdateService undefined May 02 01:05:06 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:08 volumio volumio[932]: info: CoreCommandRouter::volumioGetQueue May 02 01:05:08 volumio volumio[932]: info: CoreStateMachine::getQueue May 02 01:05:08 volumio volumio[932]: info: CorePlayQueue::getQueue May 02 01:05:09 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 02 01:05:09 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 02 01:05:09 volumio volumio[932]: info: Discovery: Getting this device information May 02 01:05:09 volumio volumio[932]: info: CoreCommandRouter::volumioGetState May 02 01:05:09 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:09 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 02 01:05:09 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 02 01:05:09 volumio volumio[932]: info: CURURI: music-library May 02 01:05:09 volumio volumio[932]: error: Failed LSINFO: null May 02 01:05:10 volumio volumio[932]: info: Preload queue cleared May 02 01:05:11 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 02 01:05:12 volumio volumio[932]: info: CoreCommandRouter::Close All Modals sent May 02 01:05:12 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: appearance , setTOSAccepted May 02 01:05:18 volumio volumio[932]: info: CoreCommandRouter::getUIConfigOnPlugin May 02 01:05:18 volumio volumio[932]: info: CoreCommandRouter::getUIConfigOnPlugin May 02 01:05:18 volumio volumio[932]: info: Retrieving Cloud Streaming UI May 02 01:05:18 volumio volumio[932]: info: Getting Tidal Cloud Configuration May 02 01:05:18 volumio volumio[932]: info: CoreCommandRouter::getUIConfigOnPlugin May 02 01:05:18 volumio volumio[932]: info: Getting Qobuz Cloud Configuration May 02 01:05:18 volumio volumio[932]: info: Asking plugin for UI Config May 02 01:05:18 volumio volumio[932]: info: CoreCommandRouter::getUIConfigOnPlugin May 02 01:05:18 volumio volumio[932]: info: Getting Spotify Cloud Configuration May 02 01:05:18 volumio volumio[932]: info: Asking plugin for UI Config May 02 01:05:18 volumio volumio[932]: info: CoreCommandRouter::getUIConfigOnPlugin May 02 01:05:18 volumio volumio[932]: info: Saving Spotify Acccount May 02 01:05:18 volumio volumio[932]: info: Got Tidal Cloud Configuration May 02 01:05:18 volumio volumio[932]: info: Got it May 02 01:05:18 volumio volumio[932]: info: Got it May 02 01:05:18 volumio volumio[932]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 02 01:05:18 volumio volumio[932]: info: CoreCommandRouter::getUIConfigOnPlugin May 02 01:05:18 volumio volumio[932]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 02 01:05:18 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 02 01:05:18 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 02 01:05:18 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 02 01:05:18 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 02 01:05:18 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 02 01:05:18 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 02 01:05:18 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 02 01:05:18 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 02 01:05:18 volumio volumio[932]: info: CoreCommandRouter::volumioGetBrowseSources May 02 01:05:18 volumio volumio[932]: info: CoreCommandRouter::volumioGetBrowseSources May 02 01:05:18 volumio volumio[932]: info: CoreCommandRouter::volumioGetBrowseSources May 02 01:05:18 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 02 01:05:18 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb May 02 01:05:19 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand rescan May 02 01:05:19 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand status May 02 01:05:19 volumio volumio[932]: info: May 02 01:05:19 volumio volumio[932]: ---------------------------- MPD announces state update: update May 02 01:05:19 volumio volumio[932]: info: sendMpdCommand rescan took 4 milliseconds May 02 01:05:19 volumio volumio[932]: info: ControllerMpd::getState May 02 01:05:19 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand status May 02 01:05:19 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand status May 02 01:05:19 volumio volumio[932]: info: May 02 01:05:19 volumio volumio[932]: ---------------------------- MPD announces state update: update May 02 01:05:19 volumio volumio[932]: info: ControllerMpd::getState May 02 01:05:19 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand status May 02 01:05:19 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand status May 02 01:05:19 volumio volumio[932]: info: May 02 01:05:19 volumio volumio[932]: ---------------------------- MPD announces state update: update May 02 01:05:19 volumio volumio[932]: info: ControllerMpd::getState May 02 01:05:19 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand status May 02 01:05:19 volumio volumio[932]: info: sendMpdCommand status took 7 milliseconds May 02 01:05:19 volumio volumio[932]: info: sendMpdCommand status took 4 milliseconds May 02 01:05:19 volumio volumio[932]: info: sendMpdCommand status took 3 milliseconds May 02 01:05:19 volumio volumio[932]: info: sendMpdCommand status took 2 milliseconds May 02 01:05:19 volumio volumio[932]: verbose: ControllerMpd::parseState May 02 01:05:19 volumio volumio[932]: info: Command Router : Notfying DB Updatefalse May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::Close All Modals sent May 02 01:05:19 volumio volumio[932]: verbose: ControllerMpd::parseState May 02 01:05:19 volumio volumio[932]: verbose: ControllerMpd::parseState May 02 01:05:19 volumio volumio[932]: info: Command Router : Notfying DB Updatefalse May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::Close All Modals sent May 02 01:05:19 volumio volumio[932]: verbose: ControllerMpd::parseState May 02 01:05:19 volumio volumio[932]: info: ControllerMpd::pushState May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::servicePushState May 02 01:05:19 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:05:19 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:05:19 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:19 volumio volumio[932]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 02 01:05:19 volumio volumio[932]: verbose: CURRENT POSITION 0 May 02 01:05:19 volumio volumio[932]: info: CoreStateMachine::syncState stateService stop May 02 01:05:19 volumio volumio[932]: info: CoreStateMachine::syncState currentStatus stop May 02 01:05:19 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:05:19 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:05:19 volumio volumio[932]: info: No code May 02 01:05:19 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:05:19 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:05:19 volumio volumio[932]: info: ControllerMpd::pushState May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::servicePushState May 02 01:05:19 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:05:19 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:05:19 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:19 volumio volumio[932]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 02 01:05:19 volumio volumio[932]: verbose: CURRENT POSITION 0 May 02 01:05:19 volumio volumio[932]: info: CoreStateMachine::syncState stateService stop May 02 01:05:19 volumio volumio[932]: info: CoreStateMachine::syncState currentStatus stop May 02 01:05:19 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:05:19 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:05:19 volumio volumio[932]: info: No code May 02 01:05:19 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:05:19 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:05:19 volumio volumio[932]: info: ------------------------------ 98ms May 02 01:05:19 volumio volumio[932]: info: ------------------------------ 95ms May 02 01:05:19 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand status May 02 01:05:19 volumio volumio[932]: info: May 02 01:05:19 volumio volumio[932]: ---------------------------- MPD announces state update: update May 02 01:05:19 volumio volumio[932]: info: ControllerMpd::getState May 02 01:05:19 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand status May 02 01:05:19 volumio volumio[932]: info: sendMpdCommand status took 97 milliseconds May 02 01:05:19 volumio volumio[932]: info: sendMpdCommand status took 96 milliseconds May 02 01:05:19 volumio volumio[932]: info: sendMpdCommand status took 2 milliseconds May 02 01:05:19 volumio volumio[932]: info: sendMpdCommand status took 2 milliseconds May 02 01:05:19 volumio volumio[932]: verbose: ControllerMpd::parseState May 02 01:05:19 volumio volumio[932]: info: Command Router : Notfying DB Updatefalse May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::Close All Modals sent May 02 01:05:19 volumio volumio[932]: verbose: ControllerMpd::parseState May 02 01:05:19 volumio volumio[932]: verbose: ControllerMpd::parseState May 02 01:05:19 volumio volumio[932]: info: Command Router : Notfying DB Updatefalse May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::Close All Modals sent May 02 01:05:19 volumio volumio[932]: verbose: ControllerMpd::parseState May 02 01:05:19 volumio volumio[932]: info: ControllerMpd::pushState May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::servicePushState May 02 01:05:19 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:05:19 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:05:19 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:19 volumio volumio[932]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 02 01:05:19 volumio volumio[932]: verbose: CURRENT POSITION 0 May 02 01:05:19 volumio volumio[932]: info: CoreStateMachine::syncState stateService stop May 02 01:05:19 volumio volumio[932]: info: CoreStateMachine::syncState currentStatus stop May 02 01:05:19 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:05:19 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:05:19 volumio volumio[932]: info: No code May 02 01:05:19 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:05:19 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:05:19 volumio volumio[932]: info: ControllerMpd::pushState May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::servicePushState May 02 01:05:19 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:05:19 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:05:19 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:19 volumio volumio[932]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 02 01:05:19 volumio volumio[932]: verbose: CURRENT POSITION 0 May 02 01:05:19 volumio volumio[932]: info: CoreStateMachine::syncState stateService stop May 02 01:05:19 volumio volumio[932]: info: CoreStateMachine::syncState currentStatus stop May 02 01:05:19 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:05:19 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:05:19 volumio volumio[932]: info: No code May 02 01:05:19 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:05:19 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:05:19 volumio volumio[932]: info: ------------------------------ 173ms May 02 01:05:19 volumio volumio[932]: info: ------------------------------ 78ms May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 02 01:05:19 volumio volumio[932]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 02 01:05:19 volumio volumio[932]: info: Received Get System Version May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 02 01:05:19 volumio volumio[932]: info: Received Get System Info May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 02 01:05:19 volumio volumio[932]: info: Discovery: Getting this device information May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::volumioGetState May 02 01:05:19 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:19 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 02 01:05:22 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 02 01:05:24 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 02 01:05:24 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand update May 02 01:05:24 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand status May 02 01:05:24 volumio volumio[932]: info: May 02 01:05:24 volumio volumio[932]: ---------------------------- MPD announces state update: update May 02 01:05:24 volumio volumio[932]: info: sendMpdCommand update took 2 milliseconds May 02 01:05:24 volumio volumio[932]: info: ControllerMpd::getState May 02 01:05:24 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand status May 02 01:05:24 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand status May 02 01:05:24 volumio volumio[932]: info: May 02 01:05:24 volumio volumio[932]: ---------------------------- MPD announces state update: update May 02 01:05:24 volumio volumio[932]: info: ControllerMpd::getState May 02 01:05:24 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand status May 02 01:05:24 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand status May 02 01:05:24 volumio volumio[932]: info: May 02 01:05:24 volumio volumio[932]: ---------------------------- MPD announces state update: update May 02 01:05:24 volumio volumio[932]: info: ControllerMpd::getState May 02 01:05:24 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand status May 02 01:05:24 volumio volumio[932]: info: sendMpdCommand status took 4 milliseconds May 02 01:05:24 volumio volumio[932]: info: sendMpdCommand status took 3 milliseconds May 02 01:05:24 volumio volumio[932]: info: sendMpdCommand status took 3 milliseconds May 02 01:05:24 volumio volumio[932]: info: sendMpdCommand status took 2 milliseconds May 02 01:05:24 volumio volumio[932]: verbose: ControllerMpd::parseState May 02 01:05:24 volumio volumio[932]: info: Command Router : Notfying DB Updatefalse May 02 01:05:24 volumio volumio[932]: info: CoreCommandRouter::Close All Modals sent May 02 01:05:24 volumio volumio[932]: verbose: ControllerMpd::parseState May 02 01:05:24 volumio volumio[932]: verbose: ControllerMpd::parseState May 02 01:05:24 volumio volumio[932]: info: Command Router : Notfying DB Updatefalse May 02 01:05:24 volumio volumio[932]: info: CoreCommandRouter::Close All Modals sent May 02 01:05:24 volumio volumio[932]: verbose: ControllerMpd::parseState May 02 01:05:24 volumio volumio[932]: info: ControllerMpd::pushState May 02 01:05:24 volumio volumio[932]: info: CoreCommandRouter::servicePushState May 02 01:05:24 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:05:24 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:24 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:05:24 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:24 volumio volumio[932]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 02 01:05:24 volumio volumio[932]: verbose: CURRENT POSITION 0 May 02 01:05:24 volumio volumio[932]: info: CoreStateMachine::syncState stateService stop May 02 01:05:24 volumio volumio[932]: info: CoreStateMachine::syncState currentStatus stop May 02 01:05:24 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:05:24 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:24 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:05:24 volumio volumio[932]: info: No code May 02 01:05:24 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:05:24 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:24 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:05:24 volumio volumio[932]: info: ControllerMpd::pushState May 02 01:05:24 volumio volumio[932]: info: CoreCommandRouter::servicePushState May 02 01:05:24 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:05:24 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:24 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:05:24 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:24 volumio volumio[932]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 02 01:05:24 volumio volumio[932]: verbose: CURRENT POSITION 0 May 02 01:05:24 volumio volumio[932]: info: CoreStateMachine::syncState stateService stop May 02 01:05:24 volumio volumio[932]: info: CoreStateMachine::syncState currentStatus stop May 02 01:05:24 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:05:24 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:24 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:05:24 volumio volumio[932]: info: No code May 02 01:05:24 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:05:24 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:24 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:05:24 volumio volumio[932]: info: ------------------------------ 87ms May 02 01:05:24 volumio volumio[932]: info: ------------------------------ 87ms May 02 01:05:24 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand status May 02 01:05:24 volumio volumio[932]: info: May 02 01:05:24 volumio volumio[932]: ---------------------------- MPD announces state update: update May 02 01:05:24 volumio volumio[932]: info: ControllerMpd::getState May 02 01:05:24 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand status May 02 01:05:24 volumio volumio[932]: info: sendMpdCommand status took 88 milliseconds May 02 01:05:24 volumio volumio[932]: info: sendMpdCommand status took 87 milliseconds May 02 01:05:24 volumio volumio[932]: info: sendMpdCommand status took 2 milliseconds May 02 01:05:24 volumio volumio[932]: info: sendMpdCommand status took 1 milliseconds May 02 01:05:24 volumio volumio[932]: verbose: ControllerMpd::parseState May 02 01:05:24 volumio volumio[932]: info: Command Router : Notfying DB Updatefalse May 02 01:05:24 volumio volumio[932]: info: CoreCommandRouter::Close All Modals sent May 02 01:05:24 volumio volumio[932]: verbose: ControllerMpd::parseState May 02 01:05:24 volumio volumio[932]: verbose: ControllerMpd::parseState May 02 01:05:24 volumio volumio[932]: info: Command Router : Notfying DB Updatefalse May 02 01:05:24 volumio volumio[932]: info: CoreCommandRouter::Close All Modals sent May 02 01:05:24 volumio volumio[932]: verbose: ControllerMpd::parseState May 02 01:05:24 volumio volumio[932]: info: ControllerMpd::pushState May 02 01:05:24 volumio volumio[932]: info: CoreCommandRouter::servicePushState May 02 01:05:24 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:05:24 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:24 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:05:24 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:24 volumio volumio[932]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 02 01:05:24 volumio volumio[932]: verbose: CURRENT POSITION 0 May 02 01:05:24 volumio volumio[932]: info: CoreStateMachine::syncState stateService stop May 02 01:05:24 volumio volumio[932]: info: CoreStateMachine::syncState currentStatus stop May 02 01:05:24 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:05:24 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:24 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:05:24 volumio volumio[932]: info: No code May 02 01:05:24 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:05:24 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:24 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:05:24 volumio volumio[932]: info: ControllerMpd::pushState May 02 01:05:24 volumio volumio[932]: info: CoreCommandRouter::servicePushState May 02 01:05:24 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:05:24 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:24 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:05:24 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:24 volumio volumio[932]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 02 01:05:24 volumio volumio[932]: verbose: CURRENT POSITION 0 May 02 01:05:24 volumio volumio[932]: info: CoreStateMachine::syncState stateService stop May 02 01:05:24 volumio volumio[932]: info: CoreStateMachine::syncState currentStatus stop May 02 01:05:24 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:05:24 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:24 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:05:24 volumio volumio[932]: info: No code May 02 01:05:24 volumio volumio[932]: info: CoreStateMachine::pushState May 02 01:05:24 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:24 volumio volumio[932]: info: CoreCommandRouter::volumioPushState May 02 01:05:24 volumio volumio[932]: info: ------------------------------ 165ms May 02 01:05:24 volumio volumio[932]: info: ------------------------------ 80ms May 02 01:05:26 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 02 01:05:30 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 02 01:05:34 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 02 01:05:38 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 02 01:05:39 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 02 01:05:39 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 02 01:05:39 volumio volumio[932]: info: Discovery: Getting this device information May 02 01:05:39 volumio volumio[932]: info: CoreCommandRouter::volumioGetState May 02 01:05:39 volumio volumio[932]: info: CorePlayQueue::getTrack 0 May 02 01:05:39 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 02 01:05:40 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares May 02 01:05:40 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService May 02 01:05:42 volumio volumio[932]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L EXCALIBUR.local. May 02 01:05:42 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 02 01:05:45 volumio volumio[932]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 02 01:05:45 volumio volumio[932]: Error: dns service error: unknown May 02 01:05:45 volumio volumio[932]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) May 02 01:05:45 volumio volumio[932]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { May 02 01:05:45 volumio volumio[932]: errorCode: -65537 May 02 01:05:45 volumio volumio[932]: } May 02 01:05:45 volumio volumio[932]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 02 01:05:46 volumio sudo[2491]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-02 01:04 May 02 01:05:46 volumio sudo[2491]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 09:33:57 AM CEST" VOLUMIO_VERSION="3.804" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="354f95cf0a6c2cbcd57b1aca3179c81c"