-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sat 2025-03-01 21:15:39 CET. -- Mar 01 21:14:39 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 01 21:14:39 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 01 21:14:39 volumio volumio[801]: info: Discovery: Getting this device information Mar 01 21:14:39 volumio volumio[801]: info: CoreCommandRouter::volumioGetState Mar 01 21:14:39 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 01 21:14:40 volumio volumio[801]: verbose: New Socket.io Connection to 192.168.178.171:3000 from 192.168.178.163 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Mar 01 21:14:40 volumio volumio[801]: info: CoreCommandRouter::volumioGetState Mar 01 21:14:40 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 01 21:14:40 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 01 21:14:40 volumio volumio-remote-updater[521]: No test mode Mar 01 21:14:40 volumio volumio-remote-updater[521]: No alpha test mode Mar 01 21:14:40 volumio volumio[801]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 01 21:14:40 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 01 21:14:40 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 01 21:14:40 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 01 21:14:40 volumio volumio[801]: info: Discovery: Getting this device information Mar 01 21:14:40 volumio volumio[801]: info: CoreCommandRouter::volumioGetState Mar 01 21:14:40 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 01 21:14:42 volumio sudo[14580]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 01 21:14:42 volumio sudo[14580]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 21:14:42 volumio sudo[14580]: pam_unix(sudo:session): session closed for user root Mar 01 21:14:42 volumio sudo[14582]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 01 21:14:42 volumio sudo[14582]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 21:14:42 volumio sudo[14582]: pam_unix(sudo:session): session closed for user root Mar 01 21:14:43 volumio volumio[801]: verbose: New Socket.io Connection to 192.168.178.171 from 192.168.178.163 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 6 Mar 01 21:14:43 volumio volumio[801]: info: CoreCommandRouter::volumioGetVisibleSources Mar 01 21:14:43 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 01 21:14:43 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Mar 01 21:14:43 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Mar 01 21:14:43 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Mar 01 21:14:43 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Mar 01 21:14:43 volumio volumio[801]: info: Received Get System Info Mar 01 21:14:43 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 01 21:14:43 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 01 21:14:43 volumio volumio[801]: info: Discovery: Getting this device information Mar 01 21:14:43 volumio volumio[801]: info: CoreCommandRouter::volumioGetState Mar 01 21:14:43 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 01 21:14:43 volumio volumio-remote-updater[521]: No test mode Mar 01 21:14:43 volumio volumio-remote-updater[521]: No alpha test mode Mar 01 21:14:43 volumio volumio[801]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 01 21:14:43 volumio volumio[801]: info: Retrieving Cloud Streaming UI Mar 01 21:14:43 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 01 21:14:43 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 01 21:14:43 volumio volumio[801]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 01 21:14:43 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 01 21:14:43 volumio volumio[801]: info: Getting Tidal Cloud Configuration Mar 01 21:14:43 volumio volumio[801]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 01 21:14:43 volumio volumio[801]: info: Getting Qobuz Cloud Configuration Mar 01 21:14:43 volumio volumio[801]: info: Asking plugin for UI Config Mar 01 21:14:43 volumio volumio[801]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 01 21:14:43 volumio volumio[801]: info: Getting Spotify Cloud Configuration Mar 01 21:14:43 volumio volumio[801]: info: Asking plugin for UI Config Mar 01 21:14:43 volumio volumio[801]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 01 21:14:43 volumio volumio[801]: info: Saving Spotify Acccount Mar 01 21:14:43 volumio volumio[801]: info: Got Tidal Cloud Configuration Mar 01 21:14:43 volumio volumio[801]: info: Got it Mar 01 21:14:43 volumio volumio[801]: info: Got it Mar 01 21:14:43 volumio volumio[801]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 01 21:14:43 volumio volumio[801]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 01 21:14:43 volumio volumio[801]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 01 21:14:44 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Mar 01 21:14:44 volumio volumio[801]: info: Loading i18n strings for locale nl Mar 01 21:14:44 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Mar 01 21:14:44 volumio volumio[801]: info: Setting timezone to Europe/Amsterdam Mar 01 21:14:44 volumio sudo[14606]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Mar 01 21:14:44 volumio sudo[14606]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 21:14:44 volumio sudo[14606]: pam_unix(sudo:session): session closed for user root Mar 01 21:14:44 volumio sudo[14609]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Amsterdam /etc/localtime Mar 01 21:14:44 volumio sudo[14609]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 21:14:44 volumio sudo[14609]: pam_unix(sudo:session): session closed for user root Mar 01 21:14:44 volumio sudo[14613]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Mar 01 21:14:44 volumio sudo[14613]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 21:14:44 volumio sudo[14613]: pam_unix(sudo:session): session closed for user root Mar 01 21:14:44 volumio systemd[1]: Starting Daily apt download activities... Mar 01 21:14:44 volumio sudo[14616]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Amsterdam Mar 01 21:14:44 volumio sudo[14616]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 21:14:44 volumio dbus-daemon[525]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.18' (uid=0 pid=14617 comm="/usr/bin/timedatectl set-timezone Europe/Amsterdam") Mar 01 21:14:44 volumio systemd[1]: Starting Time & Date Service... Mar 01 21:14:44 volumio dbus-daemon[525]: [system] Successfully activated service 'org.freedesktop.timedate1' Mar 01 21:14:44 volumio systemd[1]: Started Time & Date Service. Mar 01 21:14:44 volumio sudo[14616]: pam_unix(sudo:session): session closed for user root Mar 01 21:14:44 volumio volumio[801]: Updating browse sources language Mar 01 21:14:44 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 01 21:14:44 volumio volumio[801]: info: Fetching Streaming Services browse cache Mar 01 21:14:44 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 01 21:14:45 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 01 21:14:46 volumio systemd[1]: apt-daily.service: Succeeded. Mar 01 21:14:46 volumio systemd[1]: Started Daily apt download activities. Mar 01 21:14:46 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Mar 01 21:14:46 volumio volumio[801]: info: Loading i18n strings for locale nl Mar 01 21:14:46 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Mar 01 21:14:46 volumio volumio[801]: info: Setting timezone to Europe/Amsterdam Mar 01 21:14:46 volumio sudo[14667]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Mar 01 21:14:46 volumio sudo[14667]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 21:14:46 volumio sudo[14667]: pam_unix(sudo:session): session closed for user root Mar 01 21:14:46 volumio sudo[14670]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Amsterdam /etc/localtime Mar 01 21:14:46 volumio sudo[14670]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 21:14:46 volumio sudo[14670]: pam_unix(sudo:session): session closed for user root Mar 01 21:14:46 volumio sudo[14673]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Mar 01 21:14:46 volumio sudo[14673]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 21:14:46 volumio sudo[14673]: pam_unix(sudo:session): session closed for user root Mar 01 21:14:46 volumio sudo[14676]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Amsterdam Mar 01 21:14:46 volumio sudo[14676]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 21:14:46 volumio sudo[14676]: pam_unix(sudo:session): session closed for user root Mar 01 21:14:46 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Mar 01 21:14:46 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Mar 01 21:14:46 volumio volumio[801]: Updating browse sources language Mar 01 21:14:46 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 01 21:14:46 volumio volumio[801]: info: Fetching Streaming Services browse cache Mar 01 21:14:52 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Mar 01 21:14:52 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Mar 01 21:14:52 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 01 21:14:52 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 21:14:52 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Mar 01 21:14:56 volumio volumio[801]: info: Preparing to save Alsa Options, stopping services first Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::volumioGetState Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::volumioPause Mar 01 21:14:56 volumio volumio[801]: info: CoreStateMachine::pause Mar 01 21:14:56 volumio volumio[801]: info: Saving Audio Output to: {"i2s":true,"i2sid":{"label":"Audiophonics I-Sabre ES9028Q2M"},"output_device":{"value":1,"label":"Audiophonics I-Sabre ES9028Q2M"},"disallowPush":true} Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 21:14:56 volumio volumio[801]: info: Found match in i2s Card Database: setting mixer Digital for card Audiophonics I-Sabre ES9028Q2M Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::volumioUpdateVolumeSettings Mar 01 21:14:56 volumio volumio[801]: info: Updating Volume Controller Parameters: Device: 2 Name: Audiophonics I-Sabre ES9028Q2M Mixer: Digital Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Mar 01 21:14:56 volumio volumio[801]: info: Disabling external Volume Control Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 01 21:14:56 volumio volumio[801]: info: Preparing to generate the ALSA configuration file Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 01 21:14:56 volumio volumio[801]: info: Retrieving Cloud Streaming UI Mar 01 21:14:56 volumio volumio[801]: info: Asound.conf file unchanged, so no further update is needed Mar 01 21:14:56 volumio volumio[801]: info: Output device has changed, restarting MPD Mar 01 21:14:56 volumio sudo[14706]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 01 21:14:56 volumio sudo[14706]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 21:14:56 volumio volumio[801]: info: Output device has changed, restarting Shairport Sync Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 21:14:56 volumio sudo[14706]: pam_unix(sudo:session): session closed for user root Mar 01 21:14:56 volumio sudo[14709]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 01 21:14:56 volumio sudo[14709]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 21:14:56 volumio systemd[1]: Stopping Music Player Daemon... Mar 01 21:14:56 volumio volumio[801]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 01 21:14:56 volumio volumio[801]: info: Getting Tidal Cloud Configuration Mar 01 21:14:56 volumio systemd[1]: mpd.service: Succeeded. Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 01 21:14:56 volumio systemd[1]: Stopped Music Player Daemon. Mar 01 21:14:56 volumio volumio[801]: info: Getting Qobuz Cloud Configuration Mar 01 21:14:56 volumio volumio[801]: info: Asking plugin for UI Config Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 01 21:14:56 volumio volumio[801]: info: Getting Spotify Cloud Configuration Mar 01 21:14:56 volumio volumio[801]: info: Asking plugin for UI Config Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 01 21:14:56 volumio volumio[801]: info: Saving Spotify Acccount Mar 01 21:14:56 volumio volumio[801]: info: Got Tidal Cloud Configuration Mar 01 21:14:56 volumio volumio[801]: info: Got it Mar 01 21:14:56 volumio volumio[801]: info: Got it Mar 01 21:14:56 volumio volumio[801]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 01 21:14:56 volumio systemd[1]: Starting Music Player Daemon... Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 01 21:14:56 volumio volumio[801]: info: Getting Alsa Cards List without I2S DAC Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 21:14:56 volumio sudo[14714]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 01 21:14:56 volumio sudo[14714]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 21:14:56 volumio sudo[14714]: pam_unix(sudo:session): session closed for user root Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 01 21:14:56 volumio volumio[801]: info: MPD Permissions set Mar 01 21:14:56 volumio volumio[801]: info: VolumeController:: Volume=58 Mute =true Mar 01 21:14:56 volumio volumio[801]: info: CoreStateMachine::pushState Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::volumioPushState Mar 01 21:14:56 volumio volumio[801]: SPOTIFY: RECEIVED VOLUMIO VOLUME 0 Mar 01 21:14:56 volumio volumio[801]: SPOTIFY: SPOTIFY VOLUME 58 Mar 01 21:14:56 volumio volumio[801]: SPOTIFY: VOLUMIO VOLUME 0 Mar 01 21:14:56 volumio volumio[801]: SPOTIFY: DELTA VOLUME ENOUGH: true Mar 01 21:14:56 volumio volumio[801]: info: Setting Spotify Volume from Volumio: 0 Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 21:14:56 volumio volumio[801]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 01 21:14:56 volumio volumio[801]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 01 21:14:56 volumio volumio[801]: info: Starting Shairport Sync Mar 01 21:14:56 volumio sudo[14730]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 01 21:14:56 volumio sudo[14730]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 21:14:56 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 01 21:14:56 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 01 21:14:56 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 01 21:14:57 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 01 21:14:57 volumio sudo[14730]: pam_unix(sudo:session): session closed for user root Mar 01 21:14:57 volumio volumio[801]: info: Shairport-Sync Started Mar 01 21:14:57 volumio mpd[14722]: Mar 01 21:14 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 01 21:14:57 volumio systemd[1]: Started Music Player Daemon. Mar 01 21:14:57 volumio sudo[14709]: pam_unix(sudo:session): session closed for user root Mar 01 21:14:58 volumio volumio[801]: error: updateQueue error: null Mar 01 21:14:58 volumio volumio[801]: SPOTIFY: SETTING SPOTIFY VOLUME 0 Mar 01 21:14:58 volumio volumio[801]: info: Sending Spotify command with payload to local API: /player/volume Mar 01 21:15:00 volumio volumio[801]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Mar 01 21:15:00 volumio volumio[801]: info: CoreStateMachine::getcurrentVolume Mar 01 21:15:00 volumio volumio[801]: info: CoreCommandRouter::volumioRetrievevolume Mar 01 21:15:00 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Mar 01 21:15:00 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Mar 01 21:15:00 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Mar 01 21:15:00 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Mar 01 21:15:00 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Mar 01 21:15:00 volumio volumio[801]: info: VolumeController:: Volume=58 Mute =true Mar 01 21:15:00 volumio volumio[801]: info: CoreStateMachine::pushState Mar 01 21:15:00 volumio volumio[801]: info: CoreCommandRouter::volumioPushState Mar 01 21:15:00 volumio volumio[801]: info: CoreStateMachine::updateTrackBlock Mar 01 21:15:00 volumio volumio[801]: info: CorePlayQueue::getTrackBlock Mar 01 21:15:00 volumio volumio[801]: info: CoreCommandRouter::volumioRetrievevolume Mar 01 21:15:00 volumio volumio[801]: SPOTIFY: RECEIVED VOLUMIO VOLUME 0 Mar 01 21:15:00 volumio volumio[801]: info: VolumeController:: Volume=58 Mute =true Mar 01 21:15:00 volumio volumio[801]: info: CoreStateMachine::pushState Mar 01 21:15:00 volumio volumio[801]: info: CoreCommandRouter::volumioPushState Mar 01 21:15:00 volumio volumio[801]: SPOTIFY: RECEIVED VOLUMIO VOLUME 0 Mar 01 21:15:01 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 01 21:15:01 volumio volumio[801]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 01 21:15:01 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 01 21:15:01 volumio volumio[801]: info: Received Get System Version Mar 01 21:15:01 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 01 21:15:01 volumio volumio[801]: info: Received Get System Info Mar 01 21:15:01 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 01 21:15:01 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 01 21:15:01 volumio volumio[801]: info: Discovery: Getting this device information Mar 01 21:15:01 volumio volumio[801]: info: CoreCommandRouter::volumioGetState Mar 01 21:15:01 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 01 21:15:03 volumio volumio[801]: info: CALLMETHOD: system_controller system saveUpdateSettings [object Object] Mar 01 21:15:03 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , saveUpdateSettings Mar 01 21:15:03 volumio volumio[801]: error: Failed callmethod call: TypeError: Cannot read property 'value' of undefined Mar 01 21:15:04 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 01 21:15:04 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 01 21:15:04 volumio volumio[801]: info: Discovery: Getting this device information Mar 01 21:15:04 volumio volumio[801]: info: CoreCommandRouter::volumioGetState Mar 01 21:15:04 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 01 21:15:05 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Mar 01 21:15:05 volumio volumio[801]: info: CoreCommandRouter::Reload Ui Mar 01 21:15:05 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard Mar 01 21:15:05 volumio volumio[801]: info: Wizard terminated Successfully Mar 01 21:15:05 volumio volumio[801]: info: CoreCommandRouter::volumiosetStartupVolume Mar 01 21:15:05 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 01 21:15:06 volumio sudo[14767]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 01 21:15:06 volumio sudo[14767]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 21:15:06 volumio sudo[14767]: pam_unix(sudo:session): session closed for user root Mar 01 21:15:06 volumio sudo[14769]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 01 21:15:06 volumio sudo[14769]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 21:15:06 volumio sudo[14769]: pam_unix(sudo:session): session closed for user root Mar 01 21:15:06 volumio volumio[801]: verbose: New Socket.io Connection to 192.168.178.171 from 192.168.178.163 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 6 Mar 01 21:15:06 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 01 21:15:06 volumio volumio[801]: info: CoreCommandRouter::volumioGetVisibleSources Mar 01 21:15:06 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 01 21:15:06 volumio volumio[801]: info: CoreCommandRouter::volumioGetState Mar 01 21:15:06 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 01 21:15:06 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 01 21:15:06 volumio volumio[801]: info: Received Get System Info Mar 01 21:15:06 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 01 21:15:06 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 01 21:15:06 volumio volumio[801]: info: Discovery: Getting this device information Mar 01 21:15:06 volumio volumio[801]: info: CoreCommandRouter::volumioGetState Mar 01 21:15:06 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 01 21:15:06 volumio volumio[801]: info: CoreCommandRouter::volumioGetState Mar 01 21:15:06 volumio volumio[801]: info: Listing playlists Mar 01 21:15:06 volumio sudo[14773]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 01 21:15:06 volumio sudo[14773]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 21:15:06 volumio sudo[14773]: pam_unix(sudo:session): session closed for user root Mar 01 21:15:06 volumio sudo[14775]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 01 21:15:06 volumio sudo[14775]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 01 21:15:06 volumio sudo[14775]: pam_unix(sudo:session): session closed for user root Mar 01 21:15:06 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 01 21:15:06 volumio volumio[801]: verbose: New Socket.io Connection to 192.168.178.171 from 192.168.178.163 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 6 Mar 01 21:15:06 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 01 21:15:06 volumio volumio[801]: info: CoreCommandRouter::volumioGetVisibleSources Mar 01 21:15:06 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 01 21:15:06 volumio volumio[801]: info: CoreCommandRouter::volumioGetState Mar 01 21:15:06 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 01 21:15:06 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 01 21:15:06 volumio volumio[801]: info: Received Get System Info Mar 01 21:15:06 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 01 21:15:06 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 01 21:15:06 volumio volumio[801]: info: Discovery: Getting this device information Mar 01 21:15:06 volumio volumio[801]: info: CoreCommandRouter::volumioGetState Mar 01 21:15:06 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 01 21:15:06 volumio volumio[801]: info: CoreCommandRouter::volumioGetState Mar 01 21:15:06 volumio volumio[801]: info: Listing playlists Mar 01 21:15:06 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 01 21:15:06 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 01 21:15:06 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 01 21:15:08 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 01 21:15:08 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 01 21:15:08 volumio volumio[801]: info: Received Get System Info Mar 01 21:15:08 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 01 21:15:08 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 01 21:15:08 volumio volumio[801]: info: Discovery: Getting this device information Mar 01 21:15:08 volumio volumio[801]: info: CoreCommandRouter::volumioGetState Mar 01 21:15:08 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 01 21:15:09 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 01 21:15:09 volumio volumio[801]: info: Received Get System Info Mar 01 21:15:09 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 01 21:15:09 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 01 21:15:09 volumio volumio[801]: info: Discovery: Getting this device information Mar 01 21:15:09 volumio volumio[801]: info: CoreCommandRouter::volumioGetState Mar 01 21:15:09 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 01 21:15:14 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Mar 01 21:15:14 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 01 21:15:14 volumio volumio-remote-updater[521]: No test mode Mar 01 21:15:14 volumio volumio-remote-updater[521]: No alpha test mode Mar 01 21:15:14 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 01 21:15:14 volumio volumio[801]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 01 21:15:14 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 01 21:15:16 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Mar 01 21:15:16 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 01 21:15:16 volumio systemd[1]: systemd-timedated.service: Succeeded. Mar 01 21:15:16 volumio volumio-remote-updater[521]: No test mode Mar 01 21:15:16 volumio volumio-remote-updater[521]: No alpha test mode Mar 01 21:15:16 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 01 21:15:16 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 01 21:15:16 volumio volumio[801]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 01 21:15:16 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 01 21:15:24 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 01 21:15:24 volumio volumio[801]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 01 21:15:24 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 01 21:15:24 volumio volumio[801]: info: Received Get System Version Mar 01 21:15:24 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 01 21:15:24 volumio volumio[801]: info: Received Get System Info Mar 01 21:15:24 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 01 21:15:24 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 01 21:15:24 volumio volumio[801]: info: Discovery: Getting this device information Mar 01 21:15:24 volumio volumio[801]: info: CoreCommandRouter::volumioGetState Mar 01 21:15:24 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 01 21:15:34 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 01 21:15:34 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 01 21:15:34 volumio volumio[801]: info: Discovery: Getting this device information Mar 01 21:15:34 volumio volumio[801]: info: CoreCommandRouter::volumioGetState Mar 01 21:15:34 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 01 21:15:36 volumio volumio[801]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse Mar 01 21:15:39 volumio volumio[801]: info: ___________ PLUGINS: Run Shutdown Tasks ___________ Mar 01 21:15:39 volumio volumio[801]: info: PLUGIN onShutdown : networkfs Mar 01 21:15:39 volumio volumio[801]: info: PLUGIN onShutdown : audiophonicsonoff Mar 01 21:15:39 volumio volumio[801]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 01 21:15:39 volumio volumio[801]: TypeError: Cannot read property 'writeSync' of undefined Mar 01 21:15:39 volumio volumio[801]: at ControllerAudiophonicsOnOff.onVolumioShutdown (/data/plugins/system_controller/audiophonicsonoff/index.js:43:25) Mar 01 21:15:39 volumio volumio[801]: at PluginManager.onVolumioShutdownPlugin (/volumio/app/pluginmanager.js:638:30) Mar 01 21:15:39 volumio volumio[801]: at HashMap. (/volumio/app/pluginmanager.js:621:31) Mar 01 21:15:39 volumio volumio[801]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Mar 01 21:15:39 volumio volumio[801]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Mar 01 21:15:39 volumio volumio[801]: at PluginManager.onVolumioShutdown (/volumio/app/pluginmanager.js:619:20) Mar 01 21:15:39 volumio volumio[801]: at CoreCommandRouter.shutdown (/volumio/app/index.js:1332:24) Mar 01 21:15:39 volumio volumio[801]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:859:33) Mar 01 21:15:39 volumio volumio[801]: at Socket.emit (events.js:315:20) Mar 01 21:15:39 volumio volumio[801]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Mar 01 21:15:39 volumio volumio[801]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Mar 01 21:15:39 volumio volumio[801]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 01 21:15:39 volumio sudo[14884]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-01 21:14 Mar 01 21:15:39 volumio sudo[14884]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"