-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Tue 2024-08-27 19:38:27 CEST. -- Aug 27 19:37:00 volumio systemd[1]: apt-daily.service: Succeeded. Aug 27 19:37:00 volumio systemd[1]: Started Daily apt download activities. Aug 27 19:37:00 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Aug 27 19:37:00 volumio volumio[929]: info: Adding plugin bluetooth to MyMusic Plugins Aug 27 19:37:00 volumio volumio[929]: info: Adding plugin multiroom to MyMusic Plugins Aug 27 19:37:00 volumio volumio[929]: info: Adding plugin metavolumio to MyMusic Plugins Aug 27 19:37:00 volumio volumio[929]: info: Adding plugin cd_controller to MyMusic Plugins Aug 27 19:37:00 volumio volumio[929]: info: Adding plugin smart_inputs to MyMusic Plugins Aug 27 19:37:00 volumio volumio[929]: info: Adding plugin tidalconnect to MyMusic Plugins Aug 27 19:37:00 volumio volumio[929]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Aug 27 19:37:01 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Aug 27 19:37:01 volumio systemd[1]: Started Daily apt upgrade and clean activities. Aug 27 19:37:02 volumio volumio[929]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Aug 27 19:37:02 volumio volumio[929]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Aug 27 19:37:02 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 27 19:37:02 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 27 19:37:02 volumio volumio[929]: info: Starting MyVolumio Remote Streaming Endpoints Aug 27 19:37:02 volumio volumio[929]: info: MyVolumio not started Aug 27 19:37:02 volumio volumio[929]: info: Initializing device activation check Aug 27 19:37:02 volumio volumio[929]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Aug 27 19:37:02 volumio volumio[929]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Aug 27 19:37:03 volumio volumio[929]: info: Starting Streaming Service Transparent Proxy Aug 27 19:37:03 volumio volumio[929]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Aug 27 19:37:03 volumio volumio[929]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Aug 27 19:37:03 volumio volumio[929]: info: Streaming services startup Aug 27 19:37:03 volumio volumio[929]: info: Starting Streaming Daemon Aug 27 19:37:03 volumio sudo[1762]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 27 19:37:03 volumio sudo[1762]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 19:37:03 volumio volumio[929]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Aug 27 19:37:03 volumio sudo[1762]: pam_unix(sudo:session): session closed for user root Aug 27 19:37:03 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Aug 27 19:37:03 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 27 19:37:04 volumio volumio[929]: error: Cannot start Volumio Streaming Daemon Aug 27 19:37:04 volumio volumio[929]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 27 19:37:04 volumio volumio[929]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 27 19:37:04 volumio volumio-remote-updater[623]: No test mode Aug 27 19:37:04 volumio volumio-remote-updater[623]: No alpha test mode Aug 27 19:37:04 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Aug 27 19:37:04 volumio volumio[929]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Aug 27 19:37:04 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Aug 27 19:37:05 volumio volumio[929]: STREAMING PROXY: Starting server on port 3245 Aug 27 19:37:05 volumio volumio[929]: Node JS runtime: 14 Aug 27 19:37:05 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Aug 27 19:37:05 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 27 19:37:05 volumio volumio-remote-updater[623]: No test mode Aug 27 19:37:05 volumio volumio-remote-updater[623]: No alpha test mode Aug 27 19:37:05 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Aug 27 19:37:05 volumio volumio[929]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Aug 27 19:37:05 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Aug 27 19:37:08 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Aug 27 19:37:08 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 27 19:37:08 volumio systemd[1]: systemd-timedated.service: Succeeded. Aug 27 19:37:08 volumio volumio-remote-updater[623]: No test mode Aug 27 19:37:08 volumio volumio-remote-updater[623]: No alpha test mode Aug 27 19:37:08 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Aug 27 19:37:08 volumio volumio[929]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Aug 27 19:37:08 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Aug 27 19:37:09 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Aug 27 19:37:09 volumio volumio[929]: info: Preparing to save Alsa Options, stopping services first Aug 27 19:37:09 volumio volumio[929]: info: CoreCommandRouter::volumioGetState Aug 27 19:37:09 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Aug 27 19:37:09 volumio volumio[929]: info: CoreCommandRouter::volumioPause Aug 27 19:37:09 volumio volumio[929]: info: CoreStateMachine::pause Aug 27 19:37:09 volumio volumio[929]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"0","label":"HDMI Out"},"disallowPush":true} Aug 27 19:37:09 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 27 19:37:09 volumio volumio[929]: info: Enabling PI HDMI Output Aug 27 19:37:09 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 27 19:37:09 volumio volumio[929]: info: Found match in Cards Database: setting mixer PCM for card HDMI Out Aug 27 19:37:09 volumio volumio[929]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 27 19:37:09 volumio volumio[929]: info: Updating Volume Controller Parameters: Device: 0 Name: HDMI Out Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Aug 27 19:37:09 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Aug 27 19:37:09 volumio volumio[929]: info: Disabling external Volume Control Aug 27 19:37:09 volumio volumio[929]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 27 19:37:09 volumio volumio[929]: info: Preparing to generate the ALSA configuration file Aug 27 19:37:09 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Aug 27 19:37:09 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Aug 27 19:37:09 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Aug 27 19:37:09 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Aug 27 19:37:09 volumio sudo[1786]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 27 19:37:09 volumio sudo[1786]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 19:37:09 volumio sudo[1788]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 27 19:37:09 volumio sudo[1788]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 19:37:09 volumio volumio[929]: info: Raspberry PI HDMI Output Enabled Aug 27 19:37:09 volumio sudo[1788]: pam_unix(sudo:session): session closed for user root Aug 27 19:37:09 volumio volumio[929]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Aug 27 19:37:09 volumio volumio[929]: wlan0 Interface doesn't support scanning : Device or resource busy Aug 27 19:37:10 volumio volumio[929]: info: Cannot use regular scanning, forcing with ap-force Aug 27 19:37:10 volumio sudo[1793]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/alsactl store Aug 27 19:37:10 volumio sudo[1793]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 19:37:10 volumio sudo[1796]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Aug 27 19:37:10 volumio sudo[1796]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 19:37:10 volumio sudo[1796]: pam_unix(sudo:session): session closed for user root Aug 27 19:37:10 volumio volumio[929]: command failed: Device or resource busy (-16) Aug 27 19:37:10 volumio volumio[929]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Aug 27 19:37:10 volumio volumio[929]: command failed: Device or resource busy (-16) Aug 27 19:37:10 volumio sudo[1793]: pam_unix(sudo:session): session closed for user root Aug 27 19:37:10 volumio volumio[929]: info: VolumeController:: Volume=86 Mute =false Aug 27 19:37:10 volumio volumio[929]: info: CoreStateMachine::pushState Aug 27 19:37:10 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Aug 27 19:37:10 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Aug 27 19:37:10 volumio volumio[929]: info: Asound.conf file unchanged, so no further update is needed Aug 27 19:37:10 volumio volumio[929]: info: Output device has changed, restarting MPD Aug 27 19:37:10 volumio sudo[1799]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 27 19:37:10 volumio volumio[929]: info: Output device has changed, restarting Shairport Sync Aug 27 19:37:10 volumio sudo[1799]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 19:37:10 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 19:37:10 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 27 19:37:10 volumio sudo[1799]: pam_unix(sudo:session): session closed for user root Aug 27 19:37:10 volumio sudo[1801]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 27 19:37:10 volumio sudo[1801]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 19:37:10 volumio systemd[1]: Stopping Music Player Daemon... Aug 27 19:37:10 volumio volumio[929]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 27 19:37:10 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 27 19:37:10 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 27 19:37:10 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 27 19:37:10 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 27 19:37:10 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 27 19:37:10 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 27 19:37:10 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 27 19:37:10 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 27 19:37:10 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 27 19:37:10 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 27 19:37:10 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 27 19:37:10 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 27 19:37:10 volumio volumio[929]: info: Alsa Settings successfully stored Aug 27 19:37:10 volumio volumio[929]: info: MPD Permissions set Aug 27 19:37:10 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 19:37:10 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 19:37:10 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 19:37:10 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 19:37:10 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 19:37:10 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 19:37:10 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 19:37:10 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 27 19:37:10 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 19:37:10 volumio volumio[929]: info: Starting Shairport Sync Aug 27 19:37:10 volumio systemd[1]: mpd.service: Succeeded. Aug 27 19:37:10 volumio systemd[1]: Stopped Music Player Daemon. Aug 27 19:37:10 volumio sudo[1819]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 27 19:37:10 volumio sudo[1819]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 19:37:10 volumio systemd[1]: Starting Music Player Daemon... Aug 27 19:37:10 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 27 19:37:10 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 27 19:37:10 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 27 19:37:10 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 27 19:37:10 volumio sudo[1819]: pam_unix(sudo:session): session closed for user root Aug 27 19:37:10 volumio volumio[929]: info: Shairport-Sync Started Aug 27 19:37:10 volumio sudo[1818]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 27 19:37:10 volumio sudo[1818]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 19:37:10 volumio sudo[1818]: pam_unix(sudo:session): session closed for user root Aug 27 19:37:11 volumio mpd[1825]: Aug 27 19:37 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 27 19:37:11 volumio systemd[1]: Started Music Player Daemon. Aug 27 19:37:11 volumio sudo[1801]: pam_unix(sudo:session): session closed for user root Aug 27 19:37:12 volumio volumio[929]: error: updateQueue error: null Aug 27 19:37:13 volumio sudo[1786]: pam_unix(sudo:session): session closed for user root Aug 27 19:37:13 volumio volumio[929]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Aug 27 19:37:13 volumio volumio[929]: info: CoreStateMachine::getcurrentVolume Aug 27 19:37:13 volumio volumio[929]: info: CoreCommandRouter::volumioRetrievevolume Aug 27 19:37:13 volumio volumio[929]: info: VolumeController:: Volume=86 Mute =false Aug 27 19:37:13 volumio volumio[929]: info: CoreStateMachine::pushState Aug 27 19:37:13 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Aug 27 19:37:13 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Aug 27 19:37:13 volumio volumio[929]: info: CoreStateMachine::updateTrackBlock Aug 27 19:37:13 volumio volumio[929]: info: CorePlayQueue::getTrackBlock Aug 27 19:37:13 volumio volumio[929]: info: CoreCommandRouter::volumioRetrievevolume Aug 27 19:37:14 volumio volumio[929]: info: VolumeController:: Volume=86 Mute =false Aug 27 19:37:14 volumio volumio[929]: info: CoreStateMachine::pushState Aug 27 19:37:14 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Aug 27 19:37:14 volumio volumio[929]: info: CoreCommandRouter::volumioPushState Aug 27 19:37:15 volumio volumio[929]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 27 19:37:15 volumio volumio[929]: info: Retrieving Cloud Streaming UI Aug 27 19:37:15 volumio volumio[929]: info: Getting Tidal Cloud Configuration Aug 27 19:37:15 volumio volumio[929]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 27 19:37:15 volumio volumio[929]: info: Getting Qobuz Cloud Configuration Aug 27 19:37:15 volumio volumio[929]: info: Asking plugin for UI Config Aug 27 19:37:15 volumio volumio[929]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 27 19:37:15 volumio volumio[929]: info: Getting Spotify Cloud Configuration Aug 27 19:37:15 volumio volumio[929]: info: Asking plugin for UI Config Aug 27 19:37:15 volumio volumio[929]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 27 19:37:15 volumio volumio[929]: info: Saving Spotify Acccount Aug 27 19:37:15 volumio volumio[929]: info: Got Tidal Cloud Configuration Aug 27 19:37:15 volumio volumio[929]: info: Got it Aug 27 19:37:15 volumio volumio[929]: info: Got it Aug 27 19:37:15 volumio volumio[929]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Aug 27 19:37:15 volumio volumio[929]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 27 19:37:15 volumio volumio[929]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Aug 27 19:37:17 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 27 19:37:17 volumio volumio[929]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Aug 27 19:37:17 volumio volumio[929]: info: CoreCommandRouter::volumioGetState Aug 27 19:37:17 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Aug 27 19:37:22 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Aug 27 19:37:22 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Aug 27 19:37:22 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Aug 27 19:37:22 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Aug 27 19:37:22 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Aug 27 19:37:22 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 19:37:22 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 19:37:22 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Aug 27 19:37:22 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 27 19:37:22 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Aug 27 19:37:22 volumio volumio[929]: info: CoreCommandRouter::volumioGetBrowseSources Aug 27 19:37:22 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 27 19:37:29 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Aug 27 19:37:29 volumio volumio[929]: info: CoreCommandRouter::Reload Ui Aug 27 19:37:29 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard Aug 27 19:37:29 volumio volumio[929]: info: Wizard terminated Successfully Aug 27 19:37:29 volumio volumio[929]: info: CoreCommandRouter::volumiosetStartupVolume Aug 27 19:37:29 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 27 19:37:31 volumio sudo[1839]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 27 19:37:31 volumio sudo[1839]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 19:37:31 volumio sudo[1839]: pam_unix(sudo:session): session closed for user root Aug 27 19:37:31 volumio sudo[1841]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 27 19:37:31 volumio sudo[1841]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 19:37:31 volumio sudo[1841]: pam_unix(sudo:session): session closed for user root Aug 27 19:37:31 volumio volumio[929]: verbose: New Socket.io Connection to 192.168.178.75 from 192.168.178.31 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Aug 27 19:37:31 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 27 19:37:31 volumio volumio[929]: info: CoreCommandRouter::volumioGetVisibleSources Aug 27 19:37:31 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 27 19:37:31 volumio volumio[929]: info: CoreCommandRouter::volumioGetState Aug 27 19:37:31 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Aug 27 19:37:31 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 27 19:37:31 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 27 19:37:31 volumio volumio[929]: info: Received Get System Info Aug 27 19:37:31 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 27 19:37:31 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 27 19:37:31 volumio volumio[929]: info: Discovery: Getting this device information Aug 27 19:37:31 volumio volumio[929]: info: CoreCommandRouter::volumioGetState Aug 27 19:37:31 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Aug 27 19:37:31 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 27 19:37:31 volumio volumio[929]: info: CoreCommandRouter::volumioGetState Aug 27 19:37:31 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Aug 27 19:37:31 volumio volumio[929]: info: Listing playlists Aug 27 19:37:31 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 27 19:37:31 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 27 19:37:31 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 27 19:37:31 volumio sudo[1845]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 27 19:37:31 volumio sudo[1845]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 19:37:31 volumio sudo[1845]: pam_unix(sudo:session): session closed for user root Aug 27 19:37:31 volumio sudo[1847]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 27 19:37:31 volumio sudo[1847]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 19:37:31 volumio sudo[1847]: pam_unix(sudo:session): session closed for user root Aug 27 19:37:31 volumio volumio[929]: verbose: New Socket.io Connection to 192.168.178.75 from 192.168.178.31 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Aug 27 19:37:32 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 27 19:37:32 volumio volumio[929]: info: CoreCommandRouter::volumioGetVisibleSources Aug 27 19:37:32 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 27 19:37:32 volumio volumio[929]: info: CoreCommandRouter::volumioGetState Aug 27 19:37:32 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Aug 27 19:37:32 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 27 19:37:32 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 27 19:37:32 volumio volumio[929]: info: Received Get System Info Aug 27 19:37:32 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 27 19:37:32 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 27 19:37:32 volumio volumio[929]: info: Discovery: Getting this device information Aug 27 19:37:32 volumio volumio[929]: info: CoreCommandRouter::volumioGetState Aug 27 19:37:32 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Aug 27 19:37:32 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 27 19:37:32 volumio volumio[929]: info: CoreCommandRouter::volumioGetState Aug 27 19:37:32 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Aug 27 19:37:32 volumio volumio[929]: info: Listing playlists Aug 27 19:37:32 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 27 19:37:32 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 27 19:37:32 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 27 19:37:32 volumio volumio[929]: info: CoreCommandRouter::volumioGetState Aug 27 19:37:32 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Aug 27 19:37:33 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 27 19:37:33 volumio volumio[929]: info: Received Get System Info Aug 27 19:37:33 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 27 19:37:33 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 27 19:37:33 volumio volumio[929]: info: Discovery: Getting this device information Aug 27 19:37:33 volumio volumio[929]: info: CoreCommandRouter::volumioGetState Aug 27 19:37:33 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Aug 27 19:37:33 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 27 19:37:33 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 27 19:37:41 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 27 19:37:49 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 27 19:37:49 volumio volumio[929]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 27 19:37:49 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 27 19:37:49 volumio volumio[929]: info: Received Get System Version Aug 27 19:37:49 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 27 19:37:49 volumio volumio[929]: info: Received Get System Info Aug 27 19:37:49 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 27 19:37:49 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 27 19:37:49 volumio volumio[929]: info: Discovery: Getting this device information Aug 27 19:37:49 volumio volumio[929]: info: CoreCommandRouter::volumioGetState Aug 27 19:37:49 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Aug 27 19:37:49 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 27 19:38:04 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse Aug 27 19:38:06 volumio volumio[929]: info: CoreCommandRouter::volumioPlay Aug 27 19:38:06 volumio volumio[929]: info: CoreStateMachine::play index undefined Aug 27 19:38:06 volumio volumio[929]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 27 19:38:06 volumio volumio[929]: info: CorePlayQueue::getTrack 0 Aug 27 19:38:17 volumio volumio[929]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 27 19:38:17 volumio volumio[929]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 27 19:38:17 volumio volumio[929]: info: Retrieving Cloud Streaming UI Aug 27 19:38:17 volumio volumio[929]: info: Getting Tidal Cloud Configuration Aug 27 19:38:17 volumio volumio[929]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 27 19:38:17 volumio volumio[929]: info: Getting Qobuz Cloud Configuration Aug 27 19:38:17 volumio volumio[929]: info: Asking plugin for UI Config Aug 27 19:38:17 volumio volumio[929]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 27 19:38:17 volumio volumio[929]: info: Getting Spotify Cloud Configuration Aug 27 19:38:17 volumio volumio[929]: info: Asking plugin for UI Config Aug 27 19:38:17 volumio volumio[929]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 27 19:38:17 volumio volumio[929]: info: Saving Spotify Acccount Aug 27 19:38:17 volumio volumio[929]: info: Got Tidal Cloud Configuration Aug 27 19:38:17 volumio volumio[929]: info: Got it Aug 27 19:38:17 volumio volumio[929]: info: Got it Aug 27 19:38:17 volumio volumio[929]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Aug 27 19:38:17 volumio volumio[929]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 27 19:38:17 volumio volumio[929]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Aug 27 19:38:17 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 27 19:38:17 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 27 19:38:17 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 27 19:38:17 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 27 19:38:17 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 27 19:38:17 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 27 19:38:17 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 27 19:38:17 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 27 19:38:17 volumio volumio[929]: info: CoreCommandRouter::volumioGetBrowseSources Aug 27 19:38:17 volumio volumio[929]: info: CoreCommandRouter::volumioGetBrowseSources Aug 27 19:38:17 volumio volumio[929]: info: CoreCommandRouter::volumioGetBrowseSources Aug 27 19:38:18 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 27 19:38:18 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Aug 27 19:38:22 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 27 19:38:25 volumio volumio[929]: info: Disabling MyMusic plugin upnp Aug 27 19:38:25 volumio sudo[1895]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Aug 27 19:38:25 volumio sudo[1895]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 27 19:38:25 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Aug 27 19:38:25 volumio volumio[929]: error: Upnp client error: Error: This socket has been ended by the other party Aug 27 19:38:26 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 27 19:38:27 volumio volumio[929]: info: Enabling MyMusic plugin upnp Aug 27 19:38:27 volumio volumio[929]: info: Enabling plugin upnp Aug 27 19:38:27 volumio volumio[929]: info: Loading plugin "upnp"... Aug 27 19:38:27 volumio volumio[929]: info: [1724780307019] Starting Upmpd Daemon Aug 27 19:38:27 volumio volumio[929]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 27 19:38:27 volumio volumio[929]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 27 19:38:27 volumio volumio[929]: Error: listen EADDRINUSE: address already in use :::6599 Aug 27 19:38:27 volumio volumio[929]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Aug 27 19:38:27 volumio volumio[929]: at listenInCluster (net.js:1366:12) Aug 27 19:38:27 volumio volumio[929]: at Server.listen (net.js:1452:7) Aug 27 19:38:27 volumio volumio[929]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Aug 27 19:38:27 volumio volumio[929]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Aug 27 19:38:27 volumio volumio[929]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Aug 27 19:38:27 volumio volumio[929]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Aug 27 19:38:27 volumio volumio[929]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Aug 27 19:38:27 volumio volumio[929]: code: 'EADDRINUSE', Aug 27 19:38:27 volumio volumio[929]: errno: -98, Aug 27 19:38:27 volumio volumio[929]: syscall: 'listen', Aug 27 19:38:27 volumio volumio[929]: address: '::', Aug 27 19:38:27 volumio volumio[929]: port: 6599 Aug 27 19:38:27 volumio volumio[929]: } Aug 27 19:38:27 volumio volumio[929]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 27 19:38:27 volumio sudo[1906]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-27 19:37 Aug 27 19:38:27 volumio sudo[1906]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"