-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Mon 2025-05-19 10:57:19 CST. -- May 19 10:56:00 volumio3 volumio[836]: info: CALLMETHOD: system_controller system saveUpdateSettings [object Object] May 19 10:56:00 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: system , saveUpdateSettings May 19 10:56:00 volumio3 volumio[836]: error: Failed callmethod call: TypeError: Cannot read property 'value' of undefined May 19 10:56:00 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule May 19 10:56:00 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 19 10:56:01 volumio3 volumio-remote-updater[513]: No test mode May 19 10:56:01 volumio3 volumio-remote-updater[513]: No alpha test mode May 19 10:56:01 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled May 19 10:56:02 volumio3 volumio[836]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

\n\n

NEW ADDITIONS

\n\n","title":"Update v3.812","updateavailable":true} May 19 10:56:02 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 19 10:56:03 volumio3 sudo[2597]: pam_unix(sudo:session): session closed for user root May 19 10:56:04 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings May 19 10:56:04 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices May 19 10:56:04 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 19 10:56:04 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 19 10:56:04 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 19 10:56:06 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions May 19 10:56:06 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 19 10:56:06 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber May 19 10:56:06 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 19 10:56:06 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SAlsaName May 19 10:56:06 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 19 10:56:06 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 19 10:56:06 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SMixer May 19 10:56:06 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 19 10:56:06 volumio3 volumio[836]: info: Found match in i2s Card Database: setting mixer Digital for card IQaudIO Pi-DigiAMP+ May 19 10:56:06 volumio3 volumio[836]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 19 10:56:06 volumio3 volumio[836]: info: Updating Volume Controller Parameters: Device: 2 Name: IQaudIO Pi-DigiAMP+ Mixer: Digital Max Vol: 80 Vol Curve; logarithmic Vol Steps: 5 May 19 10:56:06 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume May 19 10:56:06 volumio3 volumio[836]: info: Disabling external Volume Control May 19 10:56:06 volumio3 volumio[836]: info: CoreCommandRouter::getUIConfigOnPlugin May 19 10:56:06 volumio3 volumio[836]: info: Preparing to generate the ALSA configuration file May 19 10:56:06 volumio3 volumio[836]: info: CoreCommandRouter::getUIConfigOnPlugin May 19 10:56:06 volumio3 volumio[836]: info: Retrieving Cloud Streaming UI May 19 10:56:06 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 19 10:56:06 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 19 10:56:06 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 19 10:56:06 volumio3 volumio[836]: info: Getting Alsa Cards List without I2S DAC May 19 10:56:06 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber May 19 10:56:06 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 19 10:56:07 volumio3 volumio[836]: info: Asound.conf file unchanged, so no further update is needed May 19 10:56:07 volumio3 volumio[836]: info: Output device has changed, restarting MPD May 19 10:56:07 volumio3 volumio[836]: info: Output device has changed, restarting Shairport Sync May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 19 10:56:07 volumio3 volumio[836]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 19 10:56:07 volumio3 volumio[836]: info: Getting Tidal Cloud Configuration May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::getUIConfigOnPlugin May 19 10:56:07 volumio3 volumio[836]: info: Getting Qobuz Cloud Configuration May 19 10:56:07 volumio3 volumio[836]: info: Asking plugin for UI Config May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::getUIConfigOnPlugin May 19 10:56:07 volumio3 volumio[836]: info: Getting Spotify Cloud Configuration May 19 10:56:07 volumio3 volumio[836]: info: Asking plugin for UI Config May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::getUIConfigOnPlugin May 19 10:56:07 volumio3 volumio[836]: info: Saving Spotify Acccount May 19 10:56:07 volumio3 volumio[836]: info: Got Tidal Cloud Configuration May 19 10:56:07 volumio3 volumio[836]: info: Got it May 19 10:56:07 volumio3 volumio[836]: info: Got it May 19 10:56:07 volumio3 volumio[836]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 19 10:56:07 volumio3 volumio[836]: info: VolumeController:: Volume=30 Mute =false May 19 10:56:07 volumio3 volumio[836]: info: CoreStateMachine::pushState May 19 10:56:07 volumio3 volumio[836]: info: CorePlayQueue::getTrack 14 May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::volumioPushState May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::getUIConfigOnPlugin May 19 10:56:07 volumio3 volumio[836]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 19 10:56:07 volumio3 volumio[836]: info: Starting Shairport Sync May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage May 19 10:56:07 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware May 19 10:56:07 volumio3 sudo[2643]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 19 10:56:07 volumio3 sudo[2641]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 19 10:56:07 volumio3 sudo[2654]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 19 10:56:07 volumio3 sudo[2641]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 10:56:07 volumio3 sudo[2654]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 10:56:07 volumio3 sudo[2641]: pam_unix(sudo:session): session closed for user root May 19 10:56:07 volumio3 sudo[2643]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 10:56:07 volumio3 volumio[836]: info: MPD Permissions set May 19 10:56:07 volumio3 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 19 10:56:07 volumio3 systemd[1]: Stopping Music Player Daemon... May 19 10:56:07 volumio3 systemd[1]: shairport-sync.service: Succeeded. May 19 10:56:07 volumio3 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 19 10:56:07 volumio3 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 19 10:56:08 volumio3 sudo[2654]: pam_unix(sudo:session): session closed for user root May 19 10:56:08 volumio3 volumio[836]: info: Shairport-Sync Started May 19 10:56:08 volumio3 volumio[836]: error: Upnp client error: Error: This socket has been ended by the other party May 19 10:56:09 volumio3 systemd[1]: mpd.service: Succeeded. May 19 10:56:09 volumio3 systemd[1]: Stopped Music Player Daemon. May 19 10:56:09 volumio3 systemd[1]: Starting Music Player Daemon... May 19 10:56:09 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction May 19 10:56:09 volumio3 volumio[836]: info: CoreCommandRouter::Reload Ui May 19 10:56:09 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard May 19 10:56:09 volumio3 volumio[836]: info: Wizard terminated Successfully May 19 10:56:10 volumio3 sudo[2673]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 19 10:56:10 volumio3 sudo[2673]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 10:56:10 volumio3 sudo[2673]: pam_unix(sudo:session): session closed for user root May 19 10:56:10 volumio3 sudo[2676]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 19 10:56:10 volumio3 sudo[2676]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 10:56:10 volumio3 sudo[2676]: pam_unix(sudo:session): session closed for user root May 19 10:56:10 volumio3 volumio[836]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.101 UA: okhttp/3.12.12 Total Clients: 5 May 19 10:56:10 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 19 10:56:10 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 19 10:56:10 volumio3 volumio[836]: info: CoreCommandRouter::volumioGetVisibleSources May 19 10:56:10 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 19 10:56:10 volumio3 volumio[836]: info: CoreCommandRouter::volumioGetState May 19 10:56:10 volumio3 volumio[836]: info: CorePlayQueue::getTrack 14 May 19 10:56:10 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 19 10:56:10 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 19 10:56:10 volumio3 volumio[836]: info: Received Get System Info May 19 10:56:10 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 19 10:56:10 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 19 10:56:10 volumio3 volumio[836]: info: Discovery: Getting this device information May 19 10:56:10 volumio3 volumio[836]: info: CoreCommandRouter::volumioGetState May 19 10:56:10 volumio3 volumio[836]: info: CorePlayQueue::getTrack 14 May 19 10:56:10 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 19 10:56:10 volumio3 volumio[836]: info: CoreCommandRouter::volumioGetState May 19 10:56:10 volumio3 volumio[836]: info: CorePlayQueue::getTrack 14 May 19 10:56:10 volumio3 volumio[836]: info: Listing playlists May 19 10:56:10 volumio3 volumio[836]: info: CoreCommandRouter::volumioRetrieveVolumeLevels May 19 10:56:10 volumio3 volumio[836]: info: CoreStateMachine::getcurrentVolume May 19 10:56:10 volumio3 volumio[836]: info: CoreCommandRouter::volumioRetrievevolume May 19 10:56:10 volumio3 sudo[2681]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 19 10:56:10 volumio3 sudo[2681]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 10:56:10 volumio3 volumio[836]: info: VolumeController:: Volume=30 Mute =false May 19 10:56:10 volumio3 volumio[836]: info: CoreStateMachine::pushState May 19 10:56:10 volumio3 volumio[836]: info: CorePlayQueue::getTrack 14 May 19 10:56:10 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 10:56:10 volumio3 volumio[836]: info: CoreCommandRouter::volumioPushState May 19 10:56:10 volumio3 sudo[2681]: pam_unix(sudo:session): session closed for user root May 19 10:56:10 volumio3 volumio[836]: info: CoreStateMachine::updateTrackBlock May 19 10:56:10 volumio3 volumio[836]: info: CorePlayQueue::getTrackBlock May 19 10:56:10 volumio3 volumio[836]: info: CoreCommandRouter::volumioRetrievevolume May 19 10:56:10 volumio3 sudo[2684]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 19 10:56:10 volumio3 sudo[2684]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 10:56:10 volumio3 sudo[2684]: pam_unix(sudo:session): session closed for user root May 19 10:56:11 volumio3 volumio[836]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.101 UA: okhttp/3.12.12 Total Clients: 6 May 19 10:56:11 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 19 10:56:11 volumio3 volumio[836]: info: VolumeController:: Volume=30 Mute =false May 19 10:56:11 volumio3 volumio[836]: info: CoreStateMachine::pushState May 19 10:56:11 volumio3 volumio[836]: info: CorePlayQueue::getTrack 14 May 19 10:56:11 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 10:56:11 volumio3 volumio[836]: info: CoreCommandRouter::volumioPushState May 19 10:56:11 volumio3 wpa_supplicant[730]: wlan0: CTRL-EVENT-BEACON-LOSS May 19 10:56:11 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 19 10:56:11 volumio3 volumio[836]: info: CoreCommandRouter::volumioGetVisibleSources May 19 10:56:11 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 19 10:56:11 volumio3 volumio[836]: info: CoreCommandRouter::volumioGetState May 19 10:56:11 volumio3 volumio[836]: info: CorePlayQueue::getTrack 14 May 19 10:56:11 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 19 10:56:11 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 19 10:56:11 volumio3 volumio[836]: info: Received Get System Info May 19 10:56:11 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 19 10:56:11 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 19 10:56:11 volumio3 volumio[836]: info: Discovery: Getting this device information May 19 10:56:11 volumio3 volumio[836]: info: CoreCommandRouter::volumioGetState May 19 10:56:11 volumio3 volumio[836]: info: CorePlayQueue::getTrack 14 May 19 10:56:11 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 19 10:56:11 volumio3 volumio[836]: info: CoreCommandRouter::volumioGetState May 19 10:56:11 volumio3 volumio[836]: info: CorePlayQueue::getTrack 14 May 19 10:56:11 volumio3 volumio[836]: info: Listing playlists May 19 10:56:11 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 19 10:56:11 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 19 10:56:11 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 19 10:56:11 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 19 10:56:11 volumio3 mpd[2671]: May 19 10:56 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 19 10:56:12 volumio3 mpd[2671]: May 19 10:56 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured May 19 10:56:12 volumio3 mpd[2671]: May 19 10:56 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured May 19 10:56:12 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 19 10:56:12 volumio3 volumio[836]: info: Received Get System Info May 19 10:56:12 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 19 10:56:12 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 19 10:56:12 volumio3 volumio[836]: info: Discovery: Getting this device information May 19 10:56:12 volumio3 volumio[836]: info: CoreCommandRouter::volumioGetState May 19 10:56:12 volumio3 volumio[836]: info: CorePlayQueue::getTrack 14 May 19 10:56:12 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 19 10:56:12 volumio3 systemd[1]: Started Music Player Daemon. May 19 10:56:12 volumio3 volumio[836]: Upnp client error: Error: This socket has been ended by the other party May 19 10:56:12 volumio3 sudo[2643]: pam_unix(sudo:session): session closed for user root May 19 10:56:12 volumio3 volumio[836]: error: updateQueue error: null May 19 10:56:18 volumio3 volumio[836]: info: CoreCommandRouter::getUIConfigOnPlugin May 19 10:56:18 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 19 10:56:18 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork May 19 10:56:18 volumio3 sudo[2705]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 May 19 10:56:18 volumio3 sudo[2705]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 10:56:18 volumio3 sudo[2711]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 19 10:56:18 volumio3 sudo[2711]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 10:56:18 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache May 19 10:56:18 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks May 19 10:56:20 volumio3 sudo[2705]: pam_unix(sudo:session): session closed for user root May 19 10:56:20 volumio3 sudo[2711]: pam_unix(sudo:session): session closed for user root May 19 10:56:20 volumio3 sudo[2718]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 19 10:56:20 volumio3 sudo[2722]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 May 19 10:56:20 volumio3 sudo[2718]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 10:56:20 volumio3 sudo[2722]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 10:56:20 volumio3 sudo[2727]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 19 10:56:20 volumio3 sudo[2727]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 10:56:20 volumio3 sudo[2729]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 19 10:56:20 volumio3 sudo[2729]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 10:56:21 volumio3 sudo[2718]: pam_unix(sudo:session): session closed for user root May 19 10:56:21 volumio3 sudo[2722]: pam_unix(sudo:session): session closed for user root May 19 10:56:21 volumio3 sudo[2727]: pam_unix(sudo:session): session closed for user root May 19 10:56:21 volumio3 sudo[2729]: pam_unix(sudo:session): session closed for user root May 19 10:56:21 volumio3 sudo[2731]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 19 10:56:21 volumio3 sudo[2731]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 10:56:24 volumio3 sudo[2748]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 19 10:56:24 volumio3 sudo[2750]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 19 10:56:24 volumio3 sudo[2748]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 10:56:24 volumio3 sudo[2750]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 10:56:24 volumio3 sudo[2748]: pam_unix(sudo:session): session closed for user root May 19 10:56:24 volumio3 sudo[2750]: pam_unix(sudo:session): session closed for user root May 19 10:56:24 volumio3 volumio[836]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.101 UA: okhttp/3.12.12 Total Clients: 5 May 19 10:56:24 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 19 10:56:24 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 19 10:56:24 volumio3 volumio[836]: info: CoreCommandRouter::volumioGetVisibleSources May 19 10:56:24 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 19 10:56:24 volumio3 volumio[836]: info: CoreCommandRouter::volumioGetState May 19 10:56:24 volumio3 volumio[836]: info: CorePlayQueue::getTrack 14 May 19 10:56:24 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 19 10:56:24 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 19 10:56:24 volumio3 volumio[836]: info: Received Get System Info May 19 10:56:24 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 19 10:56:24 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 19 10:56:24 volumio3 volumio[836]: info: Discovery: Getting this device information May 19 10:56:24 volumio3 volumio[836]: info: CoreCommandRouter::volumioGetState May 19 10:56:24 volumio3 volumio[836]: info: CorePlayQueue::getTrack 14 May 19 10:56:24 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 19 10:56:24 volumio3 volumio[836]: info: CoreCommandRouter::volumioGetState May 19 10:56:24 volumio3 volumio[836]: info: CorePlayQueue::getTrack 14 May 19 10:56:24 volumio3 volumio[836]: info: Listing playlists May 19 10:56:24 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 19 10:56:24 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 19 10:56:24 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 19 10:56:24 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 19 10:56:24 volumio3 volumio[836]: info: Received Get System Info May 19 10:56:24 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 19 10:56:24 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 19 10:56:24 volumio3 volumio[836]: info: Discovery: Getting this device information May 19 10:56:24 volumio3 volumio[836]: info: CoreCommandRouter::volumioGetState May 19 10:56:24 volumio3 volumio[836]: info: CorePlayQueue::getTrack 14 May 19 10:56:24 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 19 10:56:26 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule May 19 10:56:26 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 19 10:56:26 volumio3 systemd[1]: systemd-timedated.service: Succeeded. May 19 10:56:26 volumio3 volumio-remote-updater[513]: No test mode May 19 10:56:26 volumio3 volumio-remote-updater[513]: No alpha test mode May 19 10:56:26 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled May 19 10:56:27 volumio3 sudo[2731]: pam_unix(sudo:session): session closed for user root May 19 10:56:27 volumio3 volumio[836]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

\n\n

NEW ADDITIONS

\n\n","title":"Update v3.812","updateavailable":true} May 19 10:56:27 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache May 19 10:56:27 volumio3 volumio[836]: info: CoreCommandRouter::getUIConfigOnPlugin May 19 10:56:27 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 19 10:56:27 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 19 10:56:27 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 19 10:56:27 volumio3 volumio[836]: info: Getting Alsa Cards List without I2S DAC May 19 10:56:27 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber May 19 10:56:27 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 19 10:56:28 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 19 10:56:28 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 19 10:56:28 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 19 10:56:28 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 19 10:56:28 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 19 10:56:28 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 19 10:56:28 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 19 10:56:28 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 19 10:56:28 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 19 10:56:30 volumio3 wpa_supplicant[730]: wlan0: CTRL-EVENT-BEACON-LOSS May 19 10:56:33 volumio3 wpa_supplicant[730]: wlan0: CTRL-EVENT-BEACON-LOSS May 19 10:56:38 volumio3 wpa_supplicant[730]: wlan0: CTRL-EVENT-BEACON-LOSS May 19 10:56:39 volumio3 volumio[836]: info: CoreCommandRouter::getUIConfigOnPlugin May 19 10:56:39 volumio3 volumio[836]: info: CoreCommandRouter::getUIConfigOnPlugin May 19 10:56:39 volumio3 volumio[836]: info: Retrieving Cloud Streaming UI May 19 10:56:39 volumio3 volumio[836]: info: Getting Tidal Cloud Configuration May 19 10:56:39 volumio3 volumio[836]: info: CoreCommandRouter::getUIConfigOnPlugin May 19 10:56:39 volumio3 volumio[836]: info: Getting Qobuz Cloud Configuration May 19 10:56:39 volumio3 volumio[836]: info: Asking plugin for UI Config May 19 10:56:39 volumio3 volumio[836]: info: CoreCommandRouter::getUIConfigOnPlugin May 19 10:56:39 volumio3 volumio[836]: info: Getting Spotify Cloud Configuration May 19 10:56:39 volumio3 volumio[836]: info: Asking plugin for UI Config May 19 10:56:39 volumio3 volumio[836]: info: CoreCommandRouter::getUIConfigOnPlugin May 19 10:56:39 volumio3 volumio[836]: info: Saving Spotify Acccount May 19 10:56:39 volumio3 volumio[836]: info: Got Tidal Cloud Configuration May 19 10:56:39 volumio3 volumio[836]: info: Got it May 19 10:56:39 volumio3 volumio[836]: info: Got it May 19 10:56:39 volumio3 volumio[836]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 19 10:56:39 volumio3 volumio[836]: info: CoreCommandRouter::getUIConfigOnPlugin May 19 10:56:39 volumio3 volumio[836]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 19 10:56:39 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 19 10:56:39 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 19 10:56:39 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 19 10:56:39 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 19 10:56:39 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 19 10:56:39 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 19 10:56:39 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 19 10:56:39 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 19 10:56:39 volumio3 volumio[836]: info: CoreCommandRouter::volumioGetBrowseSources May 19 10:56:39 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 19 10:56:39 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 19 10:56:43 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 19 10:56:43 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare May 19 10:56:44 volumio3 sudo[2809]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/music May 19 10:56:44 volumio3 sudo[2809]: pam_unix(sudo:session): session opened for user root by (uid=0) May 19 10:56:44 volumio3 systemd[1]: mnt-NAS-music.mount: Succeeded. May 19 10:56:44 volumio3 sudo[2809]: pam_unix(sudo:session): session closed for user root May 19 10:56:44 volumio3 volumio[836]: info: Share music successfully unmounted May 19 10:56:45 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 19 10:56:46 volumio3 volumio[836]: verbose: ControllerMpd::sendMpdCommand status May 19 10:56:46 volumio3 volumio[836]: info: May 19 10:56:46 volumio3 volumio[836]: ---------------------------- MPD announces state update: update May 19 10:56:46 volumio3 volumio[836]: info: ControllerMpd::getState May 19 10:56:46 volumio3 volumio[836]: verbose: ControllerMpd::sendMpdCommand status May 19 10:56:46 volumio3 volumio[836]: info: sendMpdCommand status took 3 milliseconds May 19 10:56:46 volumio3 volumio[836]: info: sendMpdCommand status took 2 milliseconds May 19 10:56:46 volumio3 volumio[836]: verbose: ControllerMpd::parseState May 19 10:56:47 volumio3 volumio[836]: info: Command Router : Notfying DB Updatetrue May 19 10:56:47 volumio3 volumio[836]: info: CoreCommandRouter::Close All Modals sent May 19 10:56:47 volumio3 volumio[836]: verbose: ControllerMpd::parseState May 19 10:56:47 volumio3 volumio[836]: info: ControllerMpd::pushState May 19 10:56:47 volumio3 volumio[836]: info: CoreCommandRouter::servicePushState May 19 10:56:47 volumio3 volumio[836]: info: CoreStateMachine::pushState May 19 10:56:47 volumio3 volumio[836]: info: CorePlayQueue::getTrack 14 May 19 10:56:47 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 10:56:47 volumio3 volumio[836]: info: CoreCommandRouter::volumioPushState May 19 10:56:47 volumio3 volumio[836]: info: CorePlayQueue::getTrack 14 May 19 10:56:47 volumio3 volumio[836]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 19 10:56:47 volumio3 volumio[836]: verbose: CURRENT POSITION 14 May 19 10:56:47 volumio3 volumio[836]: info: CoreStateMachine::syncState stateService stop May 19 10:56:47 volumio3 volumio[836]: info: CoreStateMachine::syncState currentStatus play May 19 10:56:47 volumio3 volumio[836]: info: CoreCommandRouter::volumioPushState May 19 10:56:47 volumio3 volumio[836]: info: CoreStateMachine::stPlaybackTimer May 19 10:56:47 volumio3 volumio[836]: info: ------------------------------ 127ms May 19 10:56:47 volumio3 volumio[836]: info: [1747623407075] Database update started May 19 10:56:47 volumio3 volumio[836]: info: MPD Database updated - AlbumList cache refreshed May 19 10:56:47 volumio3 volumio[836]: info: May 19 10:56:47 volumio3 volumio[836]: ---------------------------- MPD announces state update: database May 19 10:56:47 volumio3 volumio[836]: verbose: ControllerMpd::sendMpdCommand status May 19 10:56:47 volumio3 volumio[836]: info: May 19 10:56:47 volumio3 volumio[836]: ---------------------------- MPD announces state update: update May 19 10:56:47 volumio3 volumio[836]: info: ControllerMpd::getState May 19 10:56:47 volumio3 volumio[836]: verbose: ControllerMpd::sendMpdCommand status May 19 10:56:47 volumio3 volumio[836]: info: ControllerMpd::getState May 19 10:56:47 volumio3 volumio[836]: verbose: ControllerMpd::sendMpdCommand status May 19 10:56:47 volumio3 volumio[836]: info: sendMpdCommand status took 25 milliseconds May 19 10:56:47 volumio3 volumio[836]: info: sendMpdCommand status took 23 milliseconds May 19 10:56:47 volumio3 volumio[836]: info: sendMpdCommand status took 24 milliseconds May 19 10:56:47 volumio3 volumio[836]: verbose: ControllerMpd::parseState May 19 10:56:47 volumio3 volumio[836]: info: Command Router : Notfying DB Updatefalse May 19 10:56:47 volumio3 volumio[836]: info: CoreCommandRouter::Close All Modals sent May 19 10:56:47 volumio3 volumio[836]: verbose: ControllerMpd::parseState May 19 10:56:47 volumio3 volumio[836]: verbose: ControllerMpd::parseState May 19 10:56:47 volumio3 volumio[836]: info: ControllerMpd::pushState May 19 10:56:47 volumio3 volumio[836]: info: CoreCommandRouter::servicePushState May 19 10:56:47 volumio3 volumio[836]: info: CoreStateMachine::pushState May 19 10:56:47 volumio3 volumio[836]: info: CorePlayQueue::getTrack 0 May 19 10:56:47 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 10:56:47 volumio3 volumio[836]: info: CoreCommandRouter::volumioPushState May 19 10:56:47 volumio3 volumio[836]: info: CorePlayQueue::getTrack 0 May 19 10:56:47 volumio3 volumio[836]: 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 19 10:56:47 volumio3 volumio[836]: verbose: CURRENT POSITION 0 May 19 10:56:47 volumio3 volumio[836]: info: CoreStateMachine::syncState stateService stop May 19 10:56:47 volumio3 volumio[836]: info: CoreStateMachine::syncState currentStatus stop May 19 10:56:47 volumio3 volumio[836]: info: CoreStateMachine::pushState May 19 10:56:47 volumio3 volumio[836]: info: CorePlayQueue::getTrack 0 May 19 10:56:47 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 10:56:47 volumio3 volumio[836]: info: CoreCommandRouter::volumioPushState May 19 10:56:47 volumio3 volumio[836]: info: No code May 19 10:56:47 volumio3 volumio[836]: info: CoreStateMachine::pushState May 19 10:56:47 volumio3 volumio[836]: info: CorePlayQueue::getTrack 0 May 19 10:56:47 volumio3 volumio[836]: info: CoreCommandRouter::volumioPushState May 19 10:56:47 volumio3 volumio[836]: info: ControllerMpd::pushState May 19 10:56:47 volumio3 volumio[836]: info: CoreCommandRouter::servicePushState May 19 10:56:47 volumio3 volumio[836]: info: CoreStateMachine::pushState May 19 10:56:47 volumio3 volumio[836]: info: CorePlayQueue::getTrack 0 May 19 10:56:47 volumio3 volumio[836]: info: CoreCommandRouter::volumioPushState May 19 10:56:47 volumio3 volumio[836]: info: CorePlayQueue::getTrack 0 May 19 10:56:47 volumio3 volumio[836]: 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 19 10:56:47 volumio3 volumio[836]: verbose: CURRENT POSITION 0 May 19 10:56:47 volumio3 volumio[836]: info: CoreStateMachine::syncState stateService stop May 19 10:56:47 volumio3 volumio[836]: info: CoreStateMachine::syncState currentStatus stop May 19 10:56:47 volumio3 volumio[836]: info: CoreStateMachine::pushState May 19 10:56:47 volumio3 volumio[836]: info: CorePlayQueue::getTrack 0 May 19 10:56:47 volumio3 volumio[836]: info: CoreCommandRouter::volumioPushState May 19 10:56:47 volumio3 volumio[836]: info: No code May 19 10:56:47 volumio3 volumio[836]: info: CoreStateMachine::pushState May 19 10:56:47 volumio3 volumio[836]: info: CorePlayQueue::getTrack 0 May 19 10:56:47 volumio3 volumio[836]: info: CoreCommandRouter::volumioPushState May 19 10:56:48 volumio3 volumio[836]: info: ------------------------------ 152ms May 19 10:56:48 volumio3 volumio[836]: info: ------------------------------ 152ms May 19 10:56:49 volumio3 volumio[836]: info: CoreCommandRouter::volumioGetQueue May 19 10:56:49 volumio3 volumio[836]: info: CoreStateMachine::getQueue May 19 10:56:49 volumio3 volumio[836]: info: CorePlayQueue::getQueue May 19 10:56:52 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 19 10:56:52 volumio3 volumio[836]: info: CURURI: music-library May 19 10:56:52 volumio3 volumio[836]: info: Preload queue cleared May 19 10:56:54 volumio3 wpa_supplicant[730]: wlan0: CTRL-EVENT-BEACON-LOSS May 19 10:56:54 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 19 10:56:54 volumio3 volumio[836]: info: CURURI: music-library/INTERNAL May 19 10:56:54 volumio3 volumio[836]: info: Preload queue cleared May 19 10:56:54 volumio3 volumio[836]: info: Preloading song: music-library/INTERNAL/08 加州酒店.flac May 19 10:56:54 volumio3 volumio[836]: info: Preloading song: music-library/INTERNAL/05.天涯歌女.flac May 19 10:56:54 volumio3 volumio[836]: info: Exploding uri music-library/INTERNAL/08 加州酒店.flac in service mpd May 19 10:56:54 volumio3 volumio[836]: info: ALBUMART /albumart?cacheid=210&web=%E8%80%81%E9%B9%B0%E4%B9%90%E9%98%9F/T200A%E8%AF%95%E9%9F%B3%E7%A2%9F/extralarge&path=%2Fmnt%2FINTERNAL%2F08%20%E5%8A%A0%E5%B7%9E%E9%85%92%E5%BA%97.flac&metadata=false May 19 10:56:54 volumio3 volumio[836]: info: URI /mnt/INTERNAL/08 加州酒店.flac May 19 10:56:54 volumio3 volumio[836]: info: Exploding uri music-library/INTERNAL/05.天涯歌女.flac in service mpd May 19 10:56:54 volumio3 volumio[836]: info: ALBUMART /albumart?cacheid=210&web=%E9%99%88%E6%B4%81%E4%B8%BD/%E4%BE%AC%E6%83%85%20%5B%E6%97%A5%E6%9C%AC%E7%89%88%5D/extralarge&path=%2Fmnt%2FINTERNAL%2F05.%E5%A4%A9%E6%B6%AF%E6%AD%8C%E5%A5%B3.flac&metadata=false May 19 10:56:54 volumio3 volumio[836]: info: URI /mnt/INTERNAL/05.天涯歌女.flac May 19 10:56:56 volumio3 volumio[836]: info: Preload queue cleared May 19 10:56:56 volumio3 volumio[836]: info: CoreCommandRouter::volumioReplaceandPlayItems May 19 10:56:56 volumio3 volumio[836]: info: CoreStateMachine::ClearQueue May 19 10:56:56 volumio3 volumio[836]: info: CoreStateMachine::stop May 19 10:56:56 volumio3 volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined May 19 10:56:56 volumio3 volumio[836]: info: CorePlayQueue::clearPlayQueue May 19 10:56:56 volumio3 volumio[836]: info: CorePlayQueue::saveQueue May 19 10:56:56 volumio3 volumio[836]: info: CoreCommandRouter::volumioPushQueue May 19 10:56:56 volumio3 volumio[836]: info: CoreStateMachine::addQueueItems May 19 10:56:56 volumio3 volumio[836]: info: CorePlayQueue::addQueueItems May 19 10:56:56 volumio3 volumio[836]: info: Preload queue cleared May 19 10:56:56 volumio3 volumio[836]: info: Adding Item to queue: music-library/INTERNAL/08 加州酒店.flac May 19 10:56:56 volumio3 volumio[836]: info: Using cached record of: music-library/INTERNAL/08 加州酒店.flac May 19 10:56:56 volumio3 volumio[836]: info: Adding Item to queue: music-library/INTERNAL/05.天涯歌女.flac May 19 10:56:56 volumio3 volumio[836]: info: Using cached record of: music-library/INTERNAL/05.天涯歌女.flac May 19 10:56:56 volumio3 volumio[836]: info: CoreCommandRouter::volumioPushQueue May 19 10:56:56 volumio3 volumio[836]: info: CorePlayQueue::saveQueue May 19 10:56:56 volumio3 volumio[836]: info: CoreStateMachine::updateTrackBlock May 19 10:56:56 volumio3 volumio[836]: info: CorePlayQueue::getTrackBlock May 19 10:56:56 volumio3 volumio[836]: info: CoreCommandRouter::volumioPlay May 19 10:56:56 volumio3 volumio[836]: info: CoreStateMachine::play index 1 May 19 10:56:56 volumio3 volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined May 19 10:56:56 volumio3 volumio[836]: info: CoreStateMachine::stop May 19 10:56:56 volumio3 volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined May 19 10:56:56 volumio3 volumio[836]: info: CoreStateMachine::play index undefined May 19 10:56:56 volumio3 volumio[836]: info: CoreStateMachine::setConsumeUpdateService undefined May 19 10:56:56 volumio3 volumio[836]: info: CorePlayQueue::getTrack 1 May 19 10:56:56 volumio3 volumio[836]: info: CoreStateMachine::startPlaybackTimer May 19 10:56:56 volumio3 volumio[836]: info: CorePlayQueue::getTrack 1 May 19 10:56:56 volumio3 volumio[836]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/05.天涯歌女.flac May 19 10:56:56 volumio3 volumio[836]: verbose: ControllerMpd::sendMpdCommand stop May 19 10:56:56 volumio3 volumio[836]: info: sendMpdCommand stop took 9 milliseconds May 19 10:56:56 volumio3 volumio[836]: verbose: ControllerMpd::sendMpdCommand clear May 19 10:56:56 volumio3 volumio[836]: info: May 19 10:56:56 volumio3 volumio[836]: ---------------------------- MPD announces system playlist update May 19 10:56:56 volumio3 volumio[836]: info: Ignoring MPD Status Update May 19 10:56:56 volumio3 volumio[836]: info: sendMpdCommand clear took 2 milliseconds May 19 10:56:56 volumio3 volumio[836]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/05.天涯歌女.flac" May 19 10:56:56 volumio3 volumio[836]: error: updateQueue error: null May 19 10:56:56 volumio3 volumio[836]: info: May 19 10:56:56 volumio3 volumio[836]: ---------------------------- MPD announces system playlist update May 19 10:56:56 volumio3 volumio[836]: info: Ignoring MPD Status Update May 19 10:56:56 volumio3 volumio[836]: info: ------------------------------ 4ms May 19 10:56:56 volumio3 volumio[836]: info: sendMpdCommand add "INTERNAL/05.天涯歌女.flac" took 2 milliseconds May 19 10:56:56 volumio3 volumio[836]: verbose: ControllerMpd::sendMpdCommand play May 19 10:56:56 volumio3 volumio[836]: info: ------------------------------ 4ms May 19 10:56:56 volumio3 volumio[836]: info: sendMpdCommand play took 5 milliseconds May 19 10:56:56 volumio3 volumio[836]: info: May 19 10:56:56 volumio3 volumio[836]: ---------------------------- MPD announces state update: player May 19 10:56:56 volumio3 volumio[836]: info: ControllerMpd::getState May 19 10:56:56 volumio3 volumio[836]: verbose: ControllerMpd::sendMpdCommand status May 19 10:56:56 volumio3 kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 May 19 10:56:56 volumio3 volumio[836]: info: May 19 10:56:56 volumio3 volumio[836]: ---------------------------- MPD announces state update: player May 19 10:56:56 volumio3 volumio[836]: info: sendMpdCommand status took 16 milliseconds May 19 10:56:56 volumio3 volumio[836]: info: ControllerMpd::getState May 19 10:56:56 volumio3 volumio[836]: verbose: ControllerMpd::sendMpdCommand status May 19 10:56:56 volumio3 volumio[836]: verbose: ControllerMpd::parseState May 19 10:56:56 volumio3 volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 10:56:56 volumio3 volumio[836]: info: sendMpdCommand status took 4 milliseconds May 19 10:56:56 volumio3 volumio[836]: info: sendMpdCommand playlistinfo took 3 milliseconds May 19 10:56:56 volumio3 volumio[836]: verbose: ControllerMpd::parseState May 19 10:56:56 volumio3 volumio[836]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 19 10:56:56 volumio3 volumio[836]: verbose: ControllerMpd::parseTrackInfo May 19 10:56:56 volumio3 volumio[836]: info: ControllerMpd::pushState May 19 10:56:56 volumio3 volumio[836]: info: CoreCommandRouter::servicePushState May 19 10:56:56 volumio3 volumio[836]: info: CorePlayQueue::getTrack 1 May 19 10:56:56 volumio3 volumio[836]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":302,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"天涯歌女","artist":"陈洁丽","album":"侬情 [日本版]","uri":"INTERNAL/05.天涯歌女.flac","trackType":"flac"} May 19 10:56:56 volumio3 volumio[836]: verbose: CURRENT POSITION 1 May 19 10:56:56 volumio3 volumio[836]: info: CoreStateMachine::syncState stateService play May 19 10:56:56 volumio3 volumio[836]: info: CoreStateMachine::syncState currentStatus stop May 19 10:56:56 volumio3 volumio[836]: info: ------------------------------ 29ms May 19 10:56:56 volumio3 volumio[836]: info: sendMpdCommand playlistinfo took 4 milliseconds May 19 10:56:56 volumio3 volumio[836]: verbose: ControllerMpd::parseTrackInfo May 19 10:56:56 volumio3 volumio[836]: info: ControllerMpd::pushState May 19 10:56:56 volumio3 volumio[836]: info: CoreCommandRouter::servicePushState May 19 10:56:56 volumio3 volumio[836]: info: CorePlayQueue::getTrack 1 May 19 10:56:56 volumio3 volumio[836]: verbose: STATE SERVICE {"status":"play","position":0,"seek":868,"duration":302,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"396 Kbps","isStreaming":false,"title":"天涯歌女","artist":"陈洁丽","album":"侬情 [日本版]","uri":"INTERNAL/05.天涯歌女.flac","trackType":"flac"} May 19 10:56:56 volumio3 volumio[836]: verbose: CURRENT POSITION 1 May 19 10:56:56 volumio3 volumio[836]: info: CoreStateMachine::syncState stateService play May 19 10:56:56 volumio3 volumio[836]: info: CoreStateMachine::syncState currentStatus play May 19 10:56:56 volumio3 volumio[836]: info: Received an update from plugin. extracting info from payload May 19 10:56:56 volumio3 volumio[836]: info: CoreStateMachine::pushState May 19 10:56:56 volumio3 volumio[836]: info: CorePlayQueue::getTrack 1 May 19 10:56:56 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 19 10:56:56 volumio3 volumio[836]: info: CoreCommandRouter::volumioPushState May 19 10:56:56 volumio3 volumio[836]: info: CoreStateMachine::pushState May 19 10:56:56 volumio3 volumio[836]: info: CorePlayQueue::getTrack 1 May 19 10:56:56 volumio3 volumio[836]: info: CoreCommandRouter::volumioPushState May 19 10:56:56 volumio3 volumio[836]: info: ------------------------------ 43ms May 19 10:57:01 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 19 10:57:01 volumio3 volumio[836]: info: CURURI: music-library May 19 10:57:01 volumio3 volumio[836]: info: Preload queue cleared May 19 10:57:04 volumio3 wpa_supplicant[730]: wlan0: CTRL-EVENT-BEACON-LOSS May 19 10:57:09 volumio3 volumio[836]: info: CoreCommandRouter::getUIConfigOnPlugin May 19 10:57:09 volumio3 volumio[836]: info: CoreCommandRouter::getUIConfigOnPlugin May 19 10:57:09 volumio3 volumio[836]: info: Retrieving Cloud Streaming UI May 19 10:57:09 volumio3 volumio[836]: info: Getting Tidal Cloud Configuration May 19 10:57:09 volumio3 volumio[836]: info: CoreCommandRouter::getUIConfigOnPlugin May 19 10:57:09 volumio3 volumio[836]: info: Getting Qobuz Cloud Configuration May 19 10:57:09 volumio3 volumio[836]: info: Asking plugin for UI Config May 19 10:57:09 volumio3 volumio[836]: info: CoreCommandRouter::getUIConfigOnPlugin May 19 10:57:09 volumio3 volumio[836]: info: Getting Spotify Cloud Configuration May 19 10:57:09 volumio3 volumio[836]: info: Asking plugin for UI Config May 19 10:57:09 volumio3 volumio[836]: info: CoreCommandRouter::getUIConfigOnPlugin May 19 10:57:09 volumio3 volumio[836]: info: Saving Spotify Acccount May 19 10:57:09 volumio3 volumio[836]: info: Got Tidal Cloud Configuration May 19 10:57:09 volumio3 volumio[836]: info: Got it May 19 10:57:09 volumio3 volumio[836]: info: Got it May 19 10:57:09 volumio3 volumio[836]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 19 10:57:09 volumio3 volumio[836]: info: CoreCommandRouter::getUIConfigOnPlugin May 19 10:57:09 volumio3 volumio[836]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 19 10:57:09 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 19 10:57:09 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 19 10:57:09 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 19 10:57:09 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 19 10:57:09 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 19 10:57:09 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 19 10:57:09 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 19 10:57:09 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 19 10:57:09 volumio3 volumio[836]: info: CoreCommandRouter::volumioGetBrowseSources May 19 10:57:09 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 19 10:57:09 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 19 10:57:13 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 19 10:57:13 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares May 19 10:57:13 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService May 19 10:57:17 volumio3 volumio[836]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 19 10:57:18 volumio3 volumio[836]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 19 10:57:18 volumio3 volumio[836]: Error: dns service error: unknown May 19 10:57:18 volumio3 volumio[836]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) May 19 10:57:18 volumio3 volumio[836]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { May 19 10:57:18 volumio3 volumio[836]: errorCode: -65537 May 19 10:57:18 volumio3 volumio[836]: } May 19 10:57:18 volumio3 volumio[836]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 19 10:57:19 volumio3 sudo[2901]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-19 10:56 May 19 10:57:19 volumio3 sudo[2901]: 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="b1c3cf61c2a0027c66bab1eb0a3795f80c1f2e95" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="e3eb3ee5b16063502f3a1735e11a28cfe54a0f46" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 25 Jun 2023 07:20:58 PM CEST" VOLUMIO_VERSION="3.512" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="946a42b62509f37b5e7e2d86a2932a62"