-- Logs begin at Fri 2025-10-24 20:42:41 CST, end at Fri 2025-10-24 20:50:17 CST. -- Oct 24 20:49:08 volumio volumio[2525]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 24 20:49:08 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 24 20:49:08 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 24 20:49:08 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Oct 24 20:49:08 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Oct 24 20:49:08 volumio volumio[2525]: info: Received Get System Version Oct 24 20:49:08 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 24 20:49:32 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: wizard , openWizard Oct 24 20:49:32 volumio volumio[2525]: info: CoreCommandRouter::Reload Ui Oct 24 20:49:33 volumio sudo[3089]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 24 20:49:33 volumio sudo[3089]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 20:49:33 volumio sudo[3089]: pam_unix(sudo:session): session closed for user root Oct 24 20:49:33 volumio sudo[3092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 24 20:49:33 volumio sudo[3092]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 20:49:33 volumio sudo[3092]: pam_unix(sudo:session): session closed for user root Oct 24 20:49:33 volumio volumio[2525]: verbose: New Socket.io Connection to 192.168.31.178 from 192.168.31.112 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/140.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Oct 24 20:49:33 volumio volumio[2525]: info: CoreCommandRouter::volumioGetVisibleSources Oct 24 20:49:33 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 24 20:49:33 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Oct 24 20:49:33 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Oct 24 20:49:33 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Oct 24 20:49:33 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Oct 24 20:49:33 volumio volumio[2525]: info: Received Get System Info Oct 24 20:49:33 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 24 20:49:33 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 24 20:49:33 volumio volumio[2525]: info: Discovery: Getting this device information Oct 24 20:49:33 volumio volumio[2525]: info: CoreCommandRouter::volumioGetState Oct 24 20:49:33 volumio volumio[2525]: info: CorePlayQueue::getTrack 0 Oct 24 20:49:33 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 24 20:49:33 volumio volumio-remote-updater[708]: No test mode Oct 24 20:49:33 volumio volumio-remote-updater[708]: No alpha test mode Oct 24 20:49:33 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 24 20:49:33 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 24 20:49:33 volumio volumio[2525]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 24 20:49:33 volumio volumio[2525]: info: Retrieving Cloud Streaming UI Oct 24 20:49:33 volumio volumio[2525]: info: Getting Tidal Cloud Configuration Oct 24 20:49:33 volumio volumio[2525]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 24 20:49:33 volumio volumio[2525]: info: Getting Qobuz Cloud Configuration Oct 24 20:49:33 volumio volumio[2525]: info: Asking plugin for UI Config Oct 24 20:49:33 volumio volumio[2525]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 24 20:49:33 volumio volumio[2525]: info: Getting Spotify Cloud Configuration Oct 24 20:49:33 volumio volumio[2525]: info: Asking plugin for UI Config Oct 24 20:49:33 volumio volumio[2525]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 24 20:49:33 volumio volumio[2525]: info: Saving Spotify Acccount Oct 24 20:49:33 volumio volumio[2525]: info: Got Tidal Cloud Configuration Oct 24 20:49:33 volumio volumio[2525]: info: Got it Oct 24 20:49:33 volumio volumio[2525]: info: Got it Oct 24 20:49:33 volumio volumio[2525]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 24 20:49:33 volumio volumio[2525]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 24 20:49:33 volumio volumio[2525]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Oct 24 20:49:34 volumio volumio[2525]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 24 20:49:34 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 24 20:49:35 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Oct 24 20:49:35 volumio volumio[2525]: info: Loading i18n strings for locale zh Oct 24 20:49:35 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Oct 24 20:49:35 volumio volumio[2525]: info: Setting timezone to Asia/Shanghai Oct 24 20:49:35 volumio sudo[3099]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Oct 24 20:49:35 volumio sudo[3099]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 20:49:35 volumio sudo[3099]: pam_unix(sudo:session): session closed for user root Oct 24 20:49:35 volumio sudo[3102]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Shanghai /etc/localtime Oct 24 20:49:35 volumio sudo[3102]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 20:49:35 volumio sudo[3102]: pam_unix(sudo:session): session closed for user root Oct 24 20:49:35 volumio sudo[3105]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Oct 24 20:49:35 volumio sudo[3105]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 20:49:35 volumio sudo[3105]: pam_unix(sudo:session): session closed for user root Oct 24 20:49:35 volumio sudo[3108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Shanghai Oct 24 20:49:35 volumio sudo[3108]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 20:49:35 volumio dbus-daemon[703]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.20' (uid=0 pid=3109 comm="/usr/bin/timedatectl set-timezone Asia/Shanghai ") Oct 24 20:49:35 volumio systemd[1]: Starting Time & Date Service... Oct 24 20:49:35 volumio dbus-daemon[703]: [system] Successfully activated service 'org.freedesktop.timedate1' Oct 24 20:49:35 volumio systemd[1]: Started Time & Date Service. Oct 24 20:49:35 volumio sudo[3108]: pam_unix(sudo:session): session closed for user root Oct 24 20:49:35 volumio volumio[2525]: Updating browse sources language Oct 24 20:49:35 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 24 20:49:35 volumio volumio[2525]: info: Fetching Streaming Services browse cache Oct 24 20:49:35 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 24 20:49:36 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Oct 24 20:49:36 volumio volumio[2525]: info: Loading i18n strings for locale zh Oct 24 20:49:36 volumio volumio[2525]: Updating browse sources language Oct 24 20:49:36 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 24 20:49:36 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Oct 24 20:49:36 volumio volumio[2525]: info: Setting timezone to Asia/Shanghai Oct 24 20:49:36 volumio sudo[3112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Oct 24 20:49:36 volumio sudo[3112]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 20:49:36 volumio sudo[3112]: pam_unix(sudo:session): session closed for user root Oct 24 20:49:36 volumio sudo[3115]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Asia/Shanghai /etc/localtime Oct 24 20:49:36 volumio sudo[3115]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 20:49:36 volumio sudo[3115]: pam_unix(sudo:session): session closed for user root Oct 24 20:49:36 volumio sudo[3118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Oct 24 20:49:36 volumio sudo[3118]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 20:49:36 volumio sudo[3118]: pam_unix(sudo:session): session closed for user root Oct 24 20:49:36 volumio sudo[3123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Asia/Shanghai Oct 24 20:49:36 volumio sudo[3123]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 20:49:36 volumio sudo[3123]: pam_unix(sudo:session): session closed for user root Oct 24 20:49:36 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Oct 24 20:49:36 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Oct 24 20:49:36 volumio sudo[3126]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 24 20:49:36 volumio sudo[3126]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 20:49:37 volumio volumio[2525]: info: Fetching Streaming Services browse cache Oct 24 20:49:41 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Oct 24 20:49:41 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Oct 24 20:49:41 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 24 20:49:41 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 24 20:49:41 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 24 20:49:41 volumio sudo[3126]: pam_unix(sudo:session): session closed for user root Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Oct 24 20:49:47 volumio volumio[2525]: info: Preparing to save Alsa Options, stopping services first Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::volumioGetState Oct 24 20:49:47 volumio volumio[2525]: info: CorePlayQueue::getTrack 0 Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::volumioPause Oct 24 20:49:47 volumio volumio[2525]: info: CoreStateMachine::pause Oct 24 20:49:47 volumio volumio[2525]: info: CoreStateMachine::stPlaybackTimer Oct 24 20:49:47 volumio volumio[2525]: info: CoreStateMachine::servicePause Oct 24 20:49:47 volumio volumio[2525]: info: CorePlayQueue::getTrack 0 Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::servicePause Oct 24 20:49:47 volumio volumio[2525]: info: ControllerMpd::pause Oct 24 20:49:47 volumio volumio[2525]: verbose: ControllerMpd::sendMpdCommand pause Oct 24 20:49:47 volumio volumio[2525]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"5","label":"SMSL PS100"},"disallowPush":true} Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 24 20:49:47 volumio volumio[2525]: info: Setting default mixerSoftMaster for Softvolume device Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 24 20:49:47 volumio volumio[2525]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 24 20:49:47 volumio volumio[2525]: info: Disabling external Volume Control Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 24 20:49:47 volumio volumio[2525]: info: Enable softmixer device for audio device undefined Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 24 20:49:47 volumio volumio[2525]: info: Retrieving Cloud Streaming UI Oct 24 20:49:47 volumio volumio[2525]: info: Oct 24 20:49:47 volumio volumio[2525]: ---------------------------- MPD announces state update: player Oct 24 20:49:47 volumio volumio[2525]: info: sendMpdCommand pause took 67 milliseconds Oct 24 20:49:47 volumio volumio[2525]: info: ControllerMpd::getState Oct 24 20:49:47 volumio volumio[2525]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:49:47 volumio volumio[2525]: info: Oct 24 20:49:47 volumio volumio[2525]: ---------------------------- MPD announces state update: player Oct 24 20:49:47 volumio volumio[2525]: info: ControllerMpd::getState Oct 24 20:49:47 volumio volumio[2525]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:49:47 volumio volumio[2525]: info: Oct 24 20:49:47 volumio volumio[2525]: ---------------------------- MPD announces state update: player Oct 24 20:49:47 volumio volumio[2525]: info: ControllerMpd::getState Oct 24 20:49:47 volumio volumio[2525]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:49:47 volumio volumio[2525]: info: sendMpdCommand status took 2 milliseconds Oct 24 20:49:47 volumio volumio[2525]: info: sendMpdCommand status took 2 milliseconds Oct 24 20:49:47 volumio volumio[2525]: info: sendMpdCommand status took 1 milliseconds Oct 24 20:49:47 volumio volumio[2525]: verbose: ControllerMpd::parseState Oct 24 20:49:47 volumio volumio[2525]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 24 20:49:47 volumio volumio[2525]: verbose: ControllerMpd::parseState Oct 24 20:49:47 volumio volumio[2525]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 24 20:49:47 volumio volumio[2525]: verbose: ControllerMpd::parseState Oct 24 20:49:47 volumio volumio[2525]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 24 20:49:47 volumio volumio[2525]: info: CoreStateMachine::pushState Oct 24 20:49:47 volumio volumio[2525]: info: CorePlayQueue::getTrack 0 Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::volumioPushState Oct 24 20:49:47 volumio volumio[2525]: info: Software Volume ALSA configuration written Oct 24 20:49:47 volumio volumio[2525]: info: Preparing to generate the ALSA configuration file Oct 24 20:49:47 volumio volumio[2525]: info: sendMpdCommand playlistinfo took 7 milliseconds Oct 24 20:49:47 volumio volumio[2525]: info: sendMpdCommand playlistinfo took 7 milliseconds Oct 24 20:49:47 volumio volumio[2525]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 24 20:49:47 volumio volumio[2525]: verbose: ControllerMpd::parseTrackInfo Oct 24 20:49:47 volumio volumio[2525]: verbose: ControllerMpd::parseTrackInfo Oct 24 20:49:47 volumio volumio[2525]: verbose: ControllerMpd::parseTrackInfo Oct 24 20:49:47 volumio volumio[2525]: info: ControllerMpd::pushState Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::servicePushState Oct 24 20:49:47 volumio volumio[2525]: info: CorePlayQueue::getTrack 0 Oct 24 20:49:47 volumio volumio[2525]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":105476,"duration":174,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"812 Kbps","isStreaming":false,"title":"Te She Dan Xin","artist":"Roman Tam","album":null,"uri":"USB/My_Book/铁血丹心-罗文、甄妮.flac","trackType":"flac"} Oct 24 20:49:47 volumio volumio[2525]: verbose: CURRENT POSITION 0 Oct 24 20:49:47 volumio volumio[2525]: info: CoreStateMachine::syncState stateService pause Oct 24 20:49:47 volumio volumio[2525]: info: CoreStateMachine::syncState currentStatus pause Oct 24 20:49:47 volumio volumio[2525]: info: CoreStateMachine::pushState Oct 24 20:49:47 volumio volumio[2525]: info: CorePlayQueue::getTrack 0 Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::volumioPushState Oct 24 20:49:47 volumio volumio[2525]: info: CoreStateMachine::stPlaybackTimer Oct 24 20:49:47 volumio volumio[2525]: info: ControllerMpd::pushState Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::servicePushState Oct 24 20:49:47 volumio volumio[2525]: info: CorePlayQueue::getTrack 0 Oct 24 20:49:47 volumio volumio[2525]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":105476,"duration":174,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"812 Kbps","isStreaming":false,"title":"Te She Dan Xin","artist":"Roman Tam","album":null,"uri":"USB/My_Book/铁血丹心-罗文、甄妮.flac","trackType":"flac"} Oct 24 20:49:47 volumio volumio[2525]: verbose: CURRENT POSITION 0 Oct 24 20:49:47 volumio volumio[2525]: info: CoreStateMachine::syncState stateService pause Oct 24 20:49:47 volumio volumio[2525]: info: CoreStateMachine::syncState currentStatus pause Oct 24 20:49:47 volumio volumio[2525]: info: CoreStateMachine::pushState Oct 24 20:49:47 volumio volumio[2525]: info: CorePlayQueue::getTrack 0 Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::volumioPushState Oct 24 20:49:47 volumio volumio[2525]: info: CoreStateMachine::stPlaybackTimer Oct 24 20:49:47 volumio volumio[2525]: info: ControllerMpd::pushState Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::servicePushState Oct 24 20:49:47 volumio volumio[2525]: info: CorePlayQueue::getTrack 0 Oct 24 20:49:47 volumio volumio[2525]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":105476,"duration":174,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"812 Kbps","isStreaming":false,"title":"Te She Dan Xin","artist":"Roman Tam","album":null,"uri":"USB/My_Book/铁血丹心-罗文、甄妮.flac","trackType":"flac"} Oct 24 20:49:47 volumio volumio[2525]: verbose: CURRENT POSITION 0 Oct 24 20:49:47 volumio volumio[2525]: info: CoreStateMachine::syncState stateService pause Oct 24 20:49:47 volumio volumio[2525]: info: CoreStateMachine::syncState currentStatus pause Oct 24 20:49:47 volumio volumio[2525]: info: CoreStateMachine::pushState Oct 24 20:49:47 volumio volumio[2525]: info: CorePlayQueue::getTrack 0 Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::volumioPushState Oct 24 20:49:47 volumio volumio[2525]: info: CoreStateMachine::stPlaybackTimer Oct 24 20:49:47 volumio volumio[2525]: info: ------------------------------ 17ms Oct 24 20:49:47 volumio volumio[2525]: info: ------------------------------ 16ms Oct 24 20:49:47 volumio volumio[2525]: info: ------------------------------ 16ms Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 24 20:49:47 volumio volumio[2525]: info: Getting Tidal Cloud Configuration Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 24 20:49:47 volumio volumio[2525]: info: Getting Qobuz Cloud Configuration Oct 24 20:49:47 volumio volumio[2525]: info: Asking plugin for UI Config Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 24 20:49:47 volumio volumio[2525]: info: Getting Spotify Cloud Configuration Oct 24 20:49:47 volumio volumio[2525]: info: Asking plugin for UI Config Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 24 20:49:47 volumio volumio[2525]: info: Saving Spotify Acccount Oct 24 20:49:47 volumio volumio[2525]: info: Got Tidal Cloud Configuration Oct 24 20:49:47 volumio volumio[2525]: info: Got it Oct 24 20:49:47 volumio volumio[2525]: info: Got it Oct 24 20:49:47 volumio volumio[2525]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 24 20:49:47 volumio volumio[2525]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Oct 24 20:49:47 volumio volumio[2525]: info: Reading ALSA contributions from plugins. Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 24 20:49:47 volumio volumio[2525]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Oct 24 20:49:47 volumio volumio[2525]: info: Asound.conf file written Oct 24 20:49:47 volumio sudo[3208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 24 20:49:47 volumio sudo[3208]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 20:49:47 volumio sudo[3208]: pam_unix(sudo:session): session closed for user root Oct 24 20:49:47 volumio volumio[2525]: No state is present for card PS100 Oct 24 20:49:47 volumio volumio[2525]: Found hardware: "USB-Audio" "USB Mixer" "USB8888:1719" "" "" Oct 24 20:49:47 volumio volumio[2525]: Hardware is initialized using a generic method Oct 24 20:49:47 volumio volumio[2525]: No state is present for card PS100 Oct 24 20:49:47 volumio volumio[2525]: info: Output device has changed, restarting MPD Oct 24 20:49:47 volumio sudo[3213]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 24 20:49:47 volumio sudo[3213]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 20:49:47 volumio sudo[3213]: pam_unix(sudo:session): session closed for user root Oct 24 20:49:47 volumio volumio[2525]: info: Output device has changed, restarting Shairport Sync Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 24 20:49:47 volumio sudo[3216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 24 20:49:47 volumio sudo[3216]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 20:49:47 volumio systemd[1]: Stopping Music Player Daemon... Oct 24 20:49:47 volumio volumio[2525]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 24 20:49:47 volumio systemd[1]: mpd.service: Succeeded. Oct 24 20:49:47 volumio volumio[2525]: info: Output device has changed, restarting MPD Oct 24 20:49:47 volumio systemd[1]: Stopped Music Player Daemon. Oct 24 20:49:47 volumio sudo[3223]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 24 20:49:47 volumio sudo[3223]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 20:49:47 volumio volumio[2525]: info: Output device has changed, restarting Shairport Sync Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 24 20:49:47 volumio volumio[2525]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 24 20:49:47 volumio volumio[2525]: info: MPD Permissions set Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 24 20:49:47 volumio sudo[3223]: pam_unix(sudo:session): session closed for user root Oct 24 20:49:47 volumio systemd[1]: Starting Music Player Daemon... Oct 24 20:49:47 volumio sudo[3226]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 24 20:49:47 volumio sudo[3226]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 20:49:47 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Oct 24 20:49:47 volumio systemd[1]: mpd.service: Succeeded. Oct 24 20:49:47 volumio systemd[1]: Stopped Music Player Daemon. Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 24 20:49:47 volumio systemd[1]: Starting Music Player Daemon... Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 24 20:49:47 volumio sudo[3235]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 24 20:49:47 volumio sudo[3235]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 20:49:47 volumio sudo[3235]: pam_unix(sudo:session): session closed for user root Oct 24 20:49:47 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 24 20:49:47 volumio volumio[2525]: info: Starting Shairport Sync Oct 24 20:49:47 volumio volumio[2525]: info: Starting Shairport Sync Oct 24 20:49:47 volumio sudo[3247]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 24 20:49:47 volumio sudo[3247]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 20:49:47 volumio sudo[3249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 24 20:49:47 volumio sudo[3249]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 20:49:47 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 24 20:49:47 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 24 20:49:47 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 24 20:49:47 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 24 20:49:47 volumio sudo[3247]: pam_unix(sudo:session): session closed for user root Oct 24 20:49:47 volumio volumio[2525]: info: Shairport-Sync Started Oct 24 20:49:47 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 24 20:49:47 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Oct 24 20:49:47 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 24 20:49:47 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 24 20:49:47 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 24 20:49:47 volumio sudo[3249]: pam_unix(sudo:session): session closed for user root Oct 24 20:49:47 volumio volumio[2525]: info: Shairport-Sync Started Oct 24 20:49:47 volumio mpd[3245]: Oct 24 20:49 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 24 20:49:47 volumio systemd[1]: Started Music Player Daemon. Oct 24 20:49:47 volumio sudo[3226]: pam_unix(sudo:session): session closed for user root Oct 24 20:49:47 volumio sudo[3216]: pam_unix(sudo:session): session closed for user root Oct 24 20:49:47 volumio volumio[2525]: error: MPD error: The expression evaluated to a falsy value: Oct 24 20:49:47 volumio volumio[2525]: assert.ok(self.idling) Oct 24 20:49:47 volumio volumio[2525]: error: The expression evaluated to a falsy value: Oct 24 20:49:47 volumio volumio[2525]: assert.ok(self.idling) Oct 24 20:49:47 volumio volumio[2525]: error: updateQueue error: null Oct 24 20:49:49 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Oct 24 20:49:49 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Oct 24 20:49:49 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Oct 24 20:49:49 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Oct 24 20:49:49 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Oct 24 20:49:51 volumio volumio[2525]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Oct 24 20:49:51 volumio volumio[2525]: info: CoreStateMachine::getcurrentVolume Oct 24 20:49:51 volumio volumio[2525]: info: CoreCommandRouter::volumioRetrievevolume Oct 24 20:49:51 volumio volumio[2525]: info: CoreStateMachine::pushState Oct 24 20:49:51 volumio volumio[2525]: info: CorePlayQueue::getTrack 0 Oct 24 20:49:51 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 20:49:51 volumio volumio[2525]: info: CoreCommandRouter::volumioPushState Oct 24 20:49:51 volumio volumio[2525]: info: CoreStateMachine::updateTrackBlock Oct 24 20:49:51 volumio volumio[2525]: info: CorePlayQueue::getTrackBlock Oct 24 20:49:51 volumio volumio[2525]: info: CoreCommandRouter::volumioRetrievevolume Oct 24 20:49:51 volumio volumio[2525]: info: CoreStateMachine::pushState Oct 24 20:49:51 volumio volumio[2525]: info: CorePlayQueue::getTrack 0 Oct 24 20:49:51 volumio volumio[2525]: info: CoreCommandRouter::volumioPushState Oct 24 20:49:52 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Oct 24 20:49:52 volumio volumio[2525]: info: CoreCommandRouter::Reload Ui Oct 24 20:49:52 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard Oct 24 20:49:52 volumio volumio[2525]: info: Wizard terminated Successfully Oct 24 20:49:52 volumio volumio[2525]: info: CoreCommandRouter::volumiosetStartupVolume Oct 24 20:49:52 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 24 20:49:52 volumio sudo[3291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 24 20:49:52 volumio sudo[3291]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 20:49:52 volumio sudo[3291]: pam_unix(sudo:session): session closed for user root Oct 24 20:49:52 volumio sudo[3294]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 24 20:49:52 volumio sudo[3294]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 20:49:52 volumio sudo[3294]: pam_unix(sudo:session): session closed for user root Oct 24 20:49:52 volumio volumio[2525]: verbose: New Socket.io Connection to 192.168.31.178 from 192.168.31.112 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/140.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Oct 24 20:49:52 volumio sudo[3297]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 24 20:49:52 volumio sudo[3297]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 20:49:52 volumio sudo[3297]: pam_unix(sudo:session): session closed for user root Oct 24 20:49:52 volumio sudo[3300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 24 20:49:52 volumio sudo[3300]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 20:49:52 volumio sudo[3300]: pam_unix(sudo:session): session closed for user root Oct 24 20:49:52 volumio volumio[2525]: verbose: New Socket.io Connection to 192.168.31.178 from 192.168.31.112 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/140.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Oct 24 20:49:52 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 24 20:49:52 volumio volumio[2525]: info: CoreCommandRouter::volumioGetVisibleSources Oct 24 20:49:52 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 24 20:49:52 volumio volumio[2525]: info: CoreCommandRouter::volumioGetState Oct 24 20:49:52 volumio volumio[2525]: info: CorePlayQueue::getTrack 0 Oct 24 20:49:52 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 24 20:49:52 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 24 20:49:52 volumio volumio[2525]: info: Received Get System Info Oct 24 20:49:52 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 24 20:49:52 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 24 20:49:52 volumio volumio[2525]: info: Discovery: Getting this device information Oct 24 20:49:52 volumio volumio[2525]: info: CoreCommandRouter::volumioGetState Oct 24 20:49:52 volumio volumio[2525]: info: CorePlayQueue::getTrack 0 Oct 24 20:49:52 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 24 20:49:52 volumio volumio[2525]: info: CoreCommandRouter::volumioGetState Oct 24 20:49:52 volumio volumio[2525]: info: CorePlayQueue::getTrack 0 Oct 24 20:49:52 volumio volumio[2525]: info: Listing playlists Oct 24 20:49:52 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 24 20:49:52 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 24 20:49:52 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 24 20:49:53 volumio volumio[2525]: info: CoreCommandRouter::volumioGetState Oct 24 20:49:53 volumio volumio[2525]: info: CorePlayQueue::getTrack 0 Oct 24 20:49:54 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 24 20:49:54 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 24 20:49:54 volumio volumio[2525]: info: Received Get System Info Oct 24 20:49:54 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 24 20:49:54 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 24 20:49:54 volumio volumio[2525]: info: Discovery: Getting this device information Oct 24 20:49:54 volumio volumio[2525]: info: CoreCommandRouter::volumioGetState Oct 24 20:49:54 volumio volumio[2525]: info: CorePlayQueue::getTrack 0 Oct 24 20:49:54 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 24 20:50:02 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 24 20:50:05 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Oct 24 20:50:05 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 24 20:50:05 volumio volumio-remote-updater[708]: No test mode Oct 24 20:50:05 volumio volumio-remote-updater[708]: No alpha test mode Oct 24 20:50:05 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 24 20:50:05 volumio volumio[2525]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 24 20:50:05 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 24 20:50:06 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Oct 24 20:50:06 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 24 20:50:06 volumio systemd[1]: systemd-timedated.service: Succeeded. Oct 24 20:50:07 volumio volumio-remote-updater[708]: No test mode Oct 24 20:50:07 volumio volumio-remote-updater[708]: No alpha test mode Oct 24 20:50:07 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Oct 24 20:50:07 volumio volumio[2525]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 24 20:50:07 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 24 20:50:08 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse Oct 24 20:50:10 volumio volumio[2525]: info: CoreCommandRouter::volumioPlay Oct 24 20:50:10 volumio volumio[2525]: info: CoreStateMachine::play index undefined Oct 24 20:50:10 volumio volumio[2525]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 24 20:50:10 volumio volumio[2525]: info: CorePlayQueue::getTrack 0 Oct 24 20:50:10 volumio volumio[2525]: info: CoreStateMachine::startPlaybackTimer Oct 24 20:50:10 volumio volumio[2525]: info: CorePlayQueue::getTrack 0 Oct 24 20:50:10 volumio volumio[2525]: info: ControllerMpd::resume Oct 24 20:50:10 volumio volumio[2525]: verbose: ControllerMpd::sendMpdCommand play Oct 24 20:50:10 volumio volumio[2525]: info: sendMpdCommand play took 0 milliseconds Oct 24 20:50:12 volumio volumio[2525]: info: CoreCommandRouter::volumioGetQueue Oct 24 20:50:12 volumio volumio[2525]: info: CoreStateMachine::getQueue Oct 24 20:50:12 volumio volumio[2525]: info: CorePlayQueue::getQueue Oct 24 20:50:13 volumio volumio[2525]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%8D%89%E8%9C%A2/Grasshopper%20The%20Best/9bf85722-1412-4d33-9289-76507c9cb5d0.jpg' Oct 24 20:50:13 volumio volumio[2525]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E8%94%A1%E7%90%B4/%E6%B0%91%E6%AD%8C%E8%94%A1%E7%90%B4/51cd20e3-afbd-4559-915d-d9a9e8d4343d.jpg' Oct 24 20:50:13 volumio volumio[2525]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%9F%A9%E7%BA%A2/%E6%84%9F%E5%8A%A8/b3cce10d-1e4e-42f1-81a9-a51acaaa1def.jpg' Oct 24 20:50:14 volumio volumio[2525]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%B0%B4%E6%9C%A8%E5%B9%B4%E5%8D%8E/70.80/75b97cc9-0b68-4569-a3b7-5ffea3f6884b.jpg' Oct 24 20:50:14 volumio volumio[2525]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%84%9A%E4%BA%BA%E8%8A%B1%E5%9B%AD/%E6%AC%A7%E7%BE%8E%E9%87%91%E5%94%B1%E7%9B%98/3d844800-88de-48f4-9494-21c8b343e966.jpg' Oct 24 20:50:14 volumio volumio[2525]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9D%A8%E4%B8%9E%E7%90%B3/%E6%9B%96%E6%98%A7/a47ee8a7-1b06-4e38-91c4-8bdbceae5d42.jpg' Oct 24 20:50:15 volumio volumio[2525]: info: CoreCommandRouter::volumioPlay Oct 24 20:50:15 volumio volumio[2525]: info: CoreStateMachine::play index 7 Oct 24 20:50:15 volumio volumio[2525]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 24 20:50:15 volumio volumio[2525]: info: CoreStateMachine::stop Oct 24 20:50:15 volumio volumio[2525]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 24 20:50:15 volumio volumio[2525]: info: CoreStateMachine::updateTrackBlock Oct 24 20:50:15 volumio volumio[2525]: info: CorePlayQueue::getTrackBlock Oct 24 20:50:15 volumio volumio[2525]: info: CoreStateMachine::stPlaybackTimer Oct 24 20:50:15 volumio volumio[2525]: info: CoreStateMachine::pushState Oct 24 20:50:15 volumio volumio[2525]: info: CorePlayQueue::getTrack 0 Oct 24 20:50:15 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 20:50:15 volumio volumio[2525]: info: CoreCommandRouter::volumioPushState Oct 24 20:50:15 volumio volumio[2525]: info: CoreStateMachine::serviceStop Oct 24 20:50:15 volumio volumio[2525]: info: CorePlayQueue::getTrack 0 Oct 24 20:50:15 volumio volumio[2525]: info: CoreCommandRouter::serviceStop Oct 24 20:50:15 volumio volumio[2525]: info: ControllerMpd::stop Oct 24 20:50:15 volumio volumio[2525]: verbose: ControllerMpd::sendMpdCommand stop Oct 24 20:50:15 volumio volumio[2525]: info: sendMpdCommand stop took 2 milliseconds Oct 24 20:50:15 volumio volumio[2525]: info: CoreStateMachine::play index undefined Oct 24 20:50:15 volumio volumio[2525]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 24 20:50:15 volumio volumio[2525]: info: CorePlayQueue::getTrack 7 Oct 24 20:50:15 volumio volumio[2525]: info: CoreStateMachine::startPlaybackTimer Oct 24 20:50:15 volumio volumio[2525]: info: CorePlayQueue::getTrack 7 Oct 24 20:50:15 volumio volumio[2525]: verbose: ControllerMpd::clearAddPlayTracks USB/My_Book/程响 - 等你归来.flac Oct 24 20:50:15 volumio volumio[2525]: verbose: ControllerMpd::sendMpdCommand stop Oct 24 20:50:15 volumio volumio[2525]: info: sendMpdCommand stop took 0 milliseconds Oct 24 20:50:15 volumio volumio[2525]: verbose: ControllerMpd::sendMpdCommand clear Oct 24 20:50:15 volumio volumio[2525]: info: Oct 24 20:50:15 volumio volumio[2525]: ---------------------------- MPD announces system playlist update Oct 24 20:50:15 volumio volumio[2525]: info: Ignoring MPD Status Update Oct 24 20:50:15 volumio volumio[2525]: info: sendMpdCommand clear took 0 milliseconds Oct 24 20:50:15 volumio volumio[2525]: verbose: ControllerMpd::sendMpdCommand add "USB/My_Book/程响 - 等你归来.flac" Oct 24 20:50:15 volumio volumio[2525]: info: Oct 24 20:50:15 volumio volumio[2525]: ---------------------------- MPD announces system playlist update Oct 24 20:50:15 volumio volumio[2525]: info: Ignoring MPD Status Update Oct 24 20:50:15 volumio volumio[2525]: error: updateQueue error: null Oct 24 20:50:15 volumio volumio[2525]: info: Oct 24 20:50:15 volumio volumio[2525]: ---------------------------- MPD announces system playlist update Oct 24 20:50:15 volumio volumio[2525]: info: Ignoring MPD Status Update Oct 24 20:50:15 volumio volumio[2525]: info: ------------------------------ 1ms Oct 24 20:50:15 volumio volumio[2525]: info: sendMpdCommand add "USB/My_Book/程响 - 等你归来.flac" took 1 milliseconds Oct 24 20:50:15 volumio volumio[2525]: info: ------------------------------ 1ms Oct 24 20:50:15 volumio volumio[2525]: verbose: ControllerMpd::sendMpdCommand play Oct 24 20:50:15 volumio volumio[2525]: info: Oct 24 20:50:15 volumio volumio[2525]: ---------------------------- MPD announces system playlist update Oct 24 20:50:15 volumio volumio[2525]: info: Ignoring MPD Status Update Oct 24 20:50:15 volumio volumio[2525]: info: ------------------------------ 1ms Oct 24 20:50:15 volumio volumio[2525]: info: sendMpdCommand play took 1 milliseconds Oct 24 20:50:15 volumio volumio[2525]: info: ------------------------------ 1ms Oct 24 20:50:15 volumio volumio[2525]: info: Oct 24 20:50:15 volumio volumio[2525]: ---------------------------- MPD announces state update: player Oct 24 20:50:15 volumio volumio[2525]: info: ControllerMpd::getState Oct 24 20:50:15 volumio volumio[2525]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:50:15 volumio volumio[2525]: info: Oct 24 20:50:15 volumio volumio[2525]: ---------------------------- MPD announces state update: player Oct 24 20:50:15 volumio volumio[2525]: info: ControllerMpd::getState Oct 24 20:50:15 volumio volumio[2525]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:50:15 volumio volumio[2525]: info: Oct 24 20:50:15 volumio volumio[2525]: ---------------------------- MPD announces state update: player Oct 24 20:50:15 volumio volumio[2525]: info: sendMpdCommand status took 29 milliseconds Oct 24 20:50:15 volumio volumio[2525]: info: ControllerMpd::getState Oct 24 20:50:15 volumio volumio[2525]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:50:15 volumio volumio[2525]: info: sendMpdCommand status took 28 milliseconds Oct 24 20:50:15 volumio volumio[2525]: verbose: ControllerMpd::parseState Oct 24 20:50:15 volumio volumio[2525]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 24 20:50:15 volumio volumio[2525]: verbose: ControllerMpd::parseState Oct 24 20:50:15 volumio volumio[2525]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 24 20:50:15 volumio volumio[2525]: info: sendMpdCommand status took 1 milliseconds Oct 24 20:50:15 volumio volumio[2525]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 24 20:50:15 volumio volumio[2525]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 24 20:50:15 volumio volumio[2525]: verbose: ControllerMpd::parseState Oct 24 20:50:15 volumio volumio[2525]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 24 20:50:15 volumio volumio[2525]: verbose: ControllerMpd::parseTrackInfo Oct 24 20:50:15 volumio volumio[2525]: verbose: ControllerMpd::parseTrackInfo Oct 24 20:50:15 volumio volumio[2525]: info: ControllerMpd::pushState Oct 24 20:50:15 volumio volumio[2525]: info: CoreCommandRouter::servicePushState Oct 24 20:50:15 volumio volumio[2525]: info: CorePlayQueue::getTrack 7 Oct 24 20:50:15 volumio volumio[2525]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":235,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"166 Kbps","isStreaming":false,"title":"等你归来","artist":"程响","album":"等你归来","uri":"USB/My_Book/程响 - 等你归来.flac","trackType":"flac"} Oct 24 20:50:15 volumio volumio[2525]: verbose: CURRENT POSITION 7 Oct 24 20:50:15 volumio volumio[2525]: info: CoreStateMachine::syncState stateService play Oct 24 20:50:15 volumio volumio[2525]: info: CoreStateMachine::syncState currentStatus stop Oct 24 20:50:15 volumio volumio[2525]: info: ControllerMpd::pushState Oct 24 20:50:15 volumio volumio[2525]: info: CoreCommandRouter::servicePushState Oct 24 20:50:15 volumio volumio[2525]: info: CorePlayQueue::getTrack 7 Oct 24 20:50:15 volumio volumio[2525]: verbose: STATE SERVICE {"status":"play","position":0,"seek":455,"duration":235,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"606 Kbps","isStreaming":false,"title":"等你归来","artist":"程响","album":"等你归来","uri":"USB/My_Book/程响 - 等你归来.flac","trackType":"flac"} Oct 24 20:50:15 volumio volumio[2525]: verbose: CURRENT POSITION 7 Oct 24 20:50:15 volumio volumio[2525]: info: CoreStateMachine::syncState stateService play Oct 24 20:50:15 volumio volumio[2525]: info: CoreStateMachine::syncState currentStatus play Oct 24 20:50:15 volumio volumio[2525]: info: Received an update from plugin. extracting info from payload Oct 24 20:50:15 volumio volumio[2525]: info: CoreStateMachine::pushState Oct 24 20:50:15 volumio volumio[2525]: info: CorePlayQueue::getTrack 7 Oct 24 20:50:15 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 20:50:15 volumio volumio[2525]: info: CoreCommandRouter::volumioPushState Oct 24 20:50:15 volumio volumio[2525]: info: CoreStateMachine::pushState Oct 24 20:50:15 volumio volumio[2525]: info: CorePlayQueue::getTrack 7 Oct 24 20:50:15 volumio volumio[2525]: info: CoreCommandRouter::volumioPushState Oct 24 20:50:15 volumio volumio[2525]: info: ------------------------------ 33ms Oct 24 20:50:15 volumio volumio[2525]: info: ------------------------------ 33ms Oct 24 20:50:15 volumio volumio[2525]: info: Oct 24 20:50:15 volumio volumio[2525]: ---------------------------- MPD announces state update: player Oct 24 20:50:15 volumio volumio[2525]: info: ControllerMpd::getState Oct 24 20:50:15 volumio volumio[2525]: verbose: ControllerMpd::sendMpdCommand status Oct 24 20:50:15 volumio volumio[2525]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 24 20:50:15 volumio volumio[2525]: info: sendMpdCommand status took 1 milliseconds Oct 24 20:50:15 volumio volumio[2525]: verbose: ControllerMpd::parseTrackInfo Oct 24 20:50:15 volumio volumio[2525]: verbose: ControllerMpd::parseState Oct 24 20:50:15 volumio volumio[2525]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 24 20:50:15 volumio volumio[2525]: info: ControllerMpd::pushState Oct 24 20:50:15 volumio volumio[2525]: info: CoreCommandRouter::servicePushState Oct 24 20:50:15 volumio volumio[2525]: info: CorePlayQueue::getTrack 7 Oct 24 20:50:15 volumio volumio[2525]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":235,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"638 Kbps","isStreaming":false,"title":"等你归来","artist":"程响","album":"等你归来","uri":"USB/My_Book/程响 - 等你归来.flac","trackType":"flac"} Oct 24 20:50:15 volumio volumio[2525]: verbose: CURRENT POSITION 7 Oct 24 20:50:15 volumio volumio[2525]: info: CoreStateMachine::syncState stateService play Oct 24 20:50:15 volumio volumio[2525]: info: CoreStateMachine::syncState currentStatus play Oct 24 20:50:15 volumio volumio[2525]: info: Received an update from plugin. extracting info from payload Oct 24 20:50:15 volumio volumio[2525]: info: CoreStateMachine::pushState Oct 24 20:50:15 volumio volumio[2525]: info: CorePlayQueue::getTrack 7 Oct 24 20:50:15 volumio volumio[2525]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 20:50:15 volumio volumio[2525]: info: CoreCommandRouter::volumioPushState Oct 24 20:50:15 volumio volumio[2525]: info: CoreStateMachine::pushState Oct 24 20:50:15 volumio volumio[2525]: info: CorePlayQueue::getTrack 7 Oct 24 20:50:15 volumio volumio[2525]: info: CoreCommandRouter::volumioPushState Oct 24 20:50:15 volumio volumio[2525]: info: ------------------------------ 10ms Oct 24 20:50:15 volumio volumio[2525]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 24 20:50:15 volumio volumio[2525]: verbose: ControllerMpd::parseTrackInfo Oct 24 20:50:15 volumio volumio[2525]: info: ControllerMpd::pushState Oct 24 20:50:15 volumio volumio[2525]: info: CoreCommandRouter::servicePushState Oct 24 20:50:15 volumio volumio[2525]: info: CorePlayQueue::getTrack 7 Oct 24 20:50:15 volumio volumio[2525]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":235,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"674 Kbps","isStreaming":false,"title":"等你归来","artist":"程响","album":"等你归来","uri":"USB/My_Book/程响 - 等你归来.flac","trackType":"flac"} Oct 24 20:50:15 volumio volumio[2525]: verbose: CURRENT POSITION 7 Oct 24 20:50:15 volumio volumio[2525]: info: CoreStateMachine::syncState stateService play Oct 24 20:50:15 volumio volumio[2525]: info: CoreStateMachine::syncState currentStatus play Oct 24 20:50:15 volumio volumio[2525]: info: Received an update from plugin. extracting info from payload Oct 24 20:50:15 volumio volumio[2525]: info: CoreStateMachine::pushState Oct 24 20:50:15 volumio volumio[2525]: info: CorePlayQueue::getTrack 7 Oct 24 20:50:15 volumio volumio[2525]: info: CoreCommandRouter::volumioPushState Oct 24 20:50:15 volumio volumio[2525]: info: CoreStateMachine::pushState Oct 24 20:50:15 volumio volumio[2525]: info: CorePlayQueue::getTrack 7 Oct 24 20:50:15 volumio volumio[2525]: info: CoreCommandRouter::volumioPushState Oct 24 20:50:15 volumio volumio[2525]: info: ------------------------------ 8ms Oct 24 20:50:17 volumio volumio[2525]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 24 20:50:17 volumio volumio[2525]: Error: connect ETIMEDOUT 199.96.58.85:443 Oct 24 20:50:17 volumio volumio[2525]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Oct 24 20:50:17 volumio volumio[2525]: errno: -110, Oct 24 20:50:17 volumio volumio[2525]: code: 'ETIMEDOUT', Oct 24 20:50:17 volumio volumio[2525]: syscall: 'connect', Oct 24 20:50:17 volumio volumio[2525]: address: '199.96.58.85', Oct 24 20:50:17 volumio volumio[2525]: port: 443 Oct 24 20:50:17 volumio volumio[2525]: } Oct 24 20:50:17 volumio volumio[2525]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 24 20:50:17 volumio sudo[3370]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-24 20:49 Oct 24 20:50:17 volumio sudo[3370]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:08:46 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="9ef0bfa9b61509be20c9051562554f31"