-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Mon 2026-05-25 08:37:08 CST. -- May 25 08:36:01 volumio volumio[26762]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 08:36:05 volumio volumio[26762]: info: MyVolumio login type: Token May 25 08:36:05 volumio volumio[26762]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 08:36:09 volumio volumio[26762]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 08:36:13 volumio volumio[26762]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 08:36:17 volumio volumio[26762]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 08:36:21 volumio volumio[26762]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 08:36:25 volumio volumio[26762]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 08:36:29 volumio volumio[26762]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 08:36:33 volumio volumio[26762]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 08:36:35 volumio volumio[26762]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. May 25 08:36:35 volumio volumio[26762]: info: Retrying Login Due to Network Error May 25 08:36:37 volumio volumio[26762]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 08:36:41 volumio volumio[26762]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 08:36:45 volumio volumio[26762]: info: MyVolumio login type: Token May 25 08:36:45 volumio volumio[26762]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 08:36:49 volumio volumio[26762]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 08:36:53 volumio volumio[26762]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 08:36:55 volumio volumio[26762]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 08:36:55 volumio volumio[26762]: Error: socket hang up May 25 08:36:55 volumio volumio[26762]: at connResetException (internal/errors.js:607:14) May 25 08:36:55 volumio volumio[26762]: at TLSSocket.socketOnEnd (_http_client.js:493:23) May 25 08:36:55 volumio volumio[26762]: at TLSSocket.emit (events.js:327:22) May 25 08:36:55 volumio volumio[26762]: at endReadableNT (internal/streams/readable.js:1327:12) May 25 08:36:55 volumio volumio[26762]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { May 25 08:36:55 volumio volumio[26762]: code: 'ECONNRESET' May 25 08:36:55 volumio volumio[26762]: } May 25 08:36:55 volumio volumio[26762]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 08:36:56 volumio sudo[27851]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-05-25 08:35 May 25 08:36:56 volumio sudo[27851]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 08:36:56 volumio sudo[27851]: pam_unix(sudo:session): session closed for user root May 25 08:36:57 volumio volumio-remote-updater[604]: [2026-05-25 08:36:57] [error] handle_read_frame error: websocketpp.transport:7 (End of File) May 25 08:36:57 volumio volumio-remote-updater[604]: [2026-05-25 08:36:57] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] May 25 08:36:57 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE May 25 08:36:57 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. May 25 08:36:57 volumio systemd[1]: Started dynamicswap service. May 25 08:36:57 volumio systemd[1]: dynamicswap.service: Succeeded. May 25 08:36:57 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. May 25 08:36:57 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 6. May 25 08:36:57 volumio systemd[1]: Started dynamicswap service. May 25 08:36:57 volumio systemd[1]: Stopped Volumio Backend Module. May 25 08:36:57 volumio systemd[1]: Started Volumio Backend Module. May 25 08:36:57 volumio systemd[1]: dynamicswap.service: Succeeded. May 25 08:36:58 volumio volumio[27866]: info: ------------------------------------------- May 25 08:36:58 volumio volumio[27866]: info: ----- Volumio3 ---- May 25 08:36:58 volumio volumio[27866]: info: ------------------------------------------- May 25 08:36:58 volumio volumio[27866]: info: ----- System startup ---- May 25 08:36:58 volumio volumio[27866]: info: ------------------------------------------- May 25 08:36:59 volumio volumio[27866]: info: MYVOLUMIO Environment detected May 25 08:36:59 volumio volumio[27866]: info: Plugin folders cleanup May 25 08:36:59 volumio volumio[27866]: info: Scanning into folder /volumio/app/plugins/ May 25 08:36:59 volumio volumio[27866]: info: Scanning category audio_interface May 25 08:36:59 volumio volumio[27866]: info: Scanning category miscellanea May 25 08:36:59 volumio volumio[27866]: info: Scanning category music_service May 25 08:36:59 volumio volumio[27866]: info: Scanning category plugins.json May 25 08:36:59 volumio volumio[27866]: info: Scanning category system_controller May 25 08:36:59 volumio volumio[27866]: info: Scanning category user_interface May 25 08:36:59 volumio volumio[27866]: info: Scanning into folder /data/plugins/ May 25 08:36:59 volumio volumio[27866]: info: Scanning category system_hardware May 25 08:36:59 volumio volumio[27866]: info: Scanning category user_interface May 25 08:36:59 volumio volumio[27866]: info: Plugin folders cleanup completed May 25 08:36:59 volumio volumio[27866]: info: ------------------------------------------- May 25 08:36:59 volumio volumio[27866]: info: ----- Core plugins startup ---- May 25 08:36:59 volumio volumio[27866]: info: ------------------------------------------- May 25 08:36:59 volumio volumio[27866]: info: Loading plugins from folder /volumio/app/plugins/ May 25 08:36:59 volumio volumio[27866]: info: Adding plugin upnp to MyMusic Plugins May 25 08:36:59 volumio volumio[27866]: info: Adding plugin airplay_emulation to MyMusic Plugins May 25 08:36:59 volumio volumio[27866]: info: Adding plugin upnp_browser to MyMusic Plugins May 25 08:36:59 volumio volumio[27866]: info: Loading plugins from folder /data/plugins/ May 25 08:36:59 volumio volumio[27866]: info: Loading plugin "system"... May 25 08:36:59 volumio volumio[27866]: info: Loading plugin "appearance"... May 25 08:37:00 volumio volumio[27866]: info: Loading plugin "network"... May 25 08:37:00 volumio volumio[27866]: info: Refreshing Cached IP Addresses May 25 08:37:00 volumio sudo[27894]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 25 08:37:00 volumio sudo[27894]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 08:37:00 volumio sudo[27894]: pam_unix(sudo:session): session closed for user root May 25 08:37:00 volumio sudo[27896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 25 08:37:00 volumio sudo[27896]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 08:37:00 volumio sudo[27896]: pam_unix(sudo:session): session closed for user root May 25 08:37:00 volumio volumio[27866]: info: Loading plugin "services"... May 25 08:37:00 volumio volumio[27866]: info: Loading plugin "alsa_controller"... May 25 08:37:00 volumio sudo[27908]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 25 08:37:00 volumio sudo[27908]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 08:37:00 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 25 08:37:00 volumio volumio[27866]: info: Loading plugin "wizard"... May 25 08:37:00 volumio volumio[27866]: info: Loading plugin "networkfs"... May 25 08:37:00 volumio volumio[27866]: info: Cannot mount NAS DS1618 at system boot, trial number 1 ,retrying in 5 seconds May 25 08:37:00 volumio volumio[27866]: info: Starting Udev Watcher for removable devices May 25 08:37:00 volumio volumio[27866]: info: Ignoring mount for partition: boot May 25 08:37:00 volumio volumio[27866]: info: Ignoring mount for partition: volumio May 25 08:37:00 volumio volumio[27866]: info: Ignoring mount for partition: volumio_data May 25 08:37:00 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 25 08:37:00 volumio volumio[27866]: info: Loading plugin "volumio_command_line_client"... May 25 08:37:00 volumio volumio[27866]: info: Loading plugin "upnp"... May 25 08:37:00 volumio volumio[27866]: info: [1779669420474] Starting Upmpd Daemon May 25 08:37:00 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 25 08:37:00 volumio volumio[27866]: info: Loading plugin "my_music"... May 25 08:37:00 volumio volumio[27866]: info: Loading plugin "mpd"... May 25 08:37:00 volumio volumio[27866]: info: Loading plugin "upnp_browser"... May 25 08:37:00 volumio volumio[27866]: info: Loading plugin "alarm-clock"... May 25 08:37:00 volumio volumio[27866]: info: Loading plugin "airplay_emulation"... May 25 08:37:00 volumio volumio[27866]: info: Starting Shairport Sync May 25 08:37:00 volumio volumio[27866]: info: Loading plugin "last_100"... May 25 08:37:00 volumio volumio[27866]: info: Loading plugin "webradio"... May 25 08:37:01 volumio volumio[27866]: info: Loading plugin "i2s_dacs"... May 25 08:37:01 volumio volumio[27866]: info: I2S DAC not set, start Auto-detection May 25 08:37:01 volumio volumio[27866]: info: Loading plugin "volumiodiscovery"... May 25 08:37:01 volumio volumio[27866]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 25 08:37:01 volumio volumio[27866]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 08:37:01 volumio node[27866]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 25 08:37:01 volumio volumio[27866]: *** WARNING *** For more information see May 25 08:37:01 volumio volumio[27866]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 25 08:37:01 volumio volumio[27866]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 08:37:01 volumio volumio[27866]: *** WARNING *** For more information see May 25 08:37:01 volumio node[27866]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 08:37:01 volumio node[27866]: *** WARNING *** For more information see May 25 08:37:01 volumio node[27866]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 25 08:37:01 volumio node[27866]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 08:37:01 volumio node[27866]: *** WARNING *** For more information see May 25 08:37:01 volumio volumio[27866]: info: Applying required configuration parameters for plugin volumiodiscovery May 25 08:37:01 volumio volumio[27866]: info: Discovery: Started advertising with name: Volumio May 25 08:37:01 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 25 08:37:01 volumio volumio[27866]: info: Loading plugin "gpio-buttons"... May 25 08:37:01 volumio volumio[27866]: info: GPIO-Buttons initialized May 25 08:37:01 volumio volumio[27866]: info: Loading plugin "outputs"... May 25 08:37:01 volumio volumio[27866]: info: Loading plugin "albumart"... May 25 08:37:01 volumio volumio[27866]: info: Plugin example_plugin is not enabled May 25 08:37:01 volumio volumio[27866]: info: Loading plugin "inputs"... May 25 08:37:01 volumio volumio[27866]: info: Loading plugin "updater_comm"... May 25 08:37:01 volumio volumio[27866]: info: Plugin mpdemulation is not enabled May 25 08:37:01 volumio volumio[27866]: info: Loading plugin "rest_api"... May 25 08:37:01 volumio volumio[27866]: info: Loading plugin "websocket"... May 25 08:37:01 volumio volumio[27866]: info: Starting Socket.io Server version 2.3.0 May 25 08:37:01 volumio volumio[27866]: info: Loading plugin "touch_display"... May 25 08:37:01 volumio volumio[27866]: Forking 3 albumart workers May 25 08:37:01 volumio volumio[27866]: info: Applying required configuration parameters for plugin touch_display May 25 08:37:01 volumio sudo[27908]: pam_unix(sudo:session): session closed for user root May 25 08:37:01 volumio volumio[27866]: info: Loading i18n strings for locale zh May 25 08:37:01 volumio volumio[27866]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. May 25 08:37:01 volumio volumio[27866]: Updating browse sources language May 25 08:37:01 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 08:37:02 volumio volumio-remote-updater[604]: [2026-05-25 08:37:02] [connect] Successful connection May 25 08:37:02 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 08:37:02 volumio volumio[27866]: info: CoreCommandRouter::initPlayerControls May 25 08:37:02 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 08:37:02 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 08:37:02 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 08:37:02 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 08:37:02 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 08:37:02 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 08:37:02 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 08:37:02 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 08:37:02 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 08:37:02 volumio volumio[27866]: Express server listening on port 3000 May 25 08:37:02 volumio volumio[27866]: [Metrics] WebUI: 3s 708.69ms May 25 08:37:02 volumio volumio[27866]: info: CoreStateMachine::resetVolumioState May 25 08:37:02 volumio volumio[27866]: info: CoreStateMachine::getcurrentVolume May 25 08:37:02 volumio volumio[27866]: info: CoreCommandRouter::volumioRetrievevolume May 25 08:37:02 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 08:37:02 volumio volumio[27866]: info: Volumio Network Manager: Network status updated: 1 May 25 08:37:02 volumio volumio[27866]: Starting albumart workers May 25 08:37:02 volumio volumio-remote-updater[604]: [2026-05-25 08:37:02] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1779669422 101 May 25 08:37:02 volumio volumio[27866]: Starting albumart workers May 25 08:37:02 volumio volumio[27866]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 May 25 08:37:02 volumio volumio[27866]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 May 25 08:37:02 volumio volumio[27866]: Starting albumart workers May 25 08:37:02 volumio volumio[27866]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 May 25 08:37:02 volumio volumio[27866]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 May 25 08:37:02 volumio volumio[27866]: info: Reloading queue from file May 25 08:37:02 volumio volumio[27866]: info: VolumeController:: Volume=undefined Mute =false May 25 08:37:02 volumio volumio[27866]: info: CoreStateMachine::pushState May 25 08:37:02 volumio volumio[27866]: info: CorePlayQueue::getTrack 0 May 25 08:37:02 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 08:37:02 volumio volumio[27866]: info: CoreCommandRouter::volumioPushState May 25 08:37:02 volumio volumio[27866]: info: CoreStateMachine::updateTrackBlock May 25 08:37:02 volumio volumio[27866]: info: CorePlayQueue::getTrackBlock May 25 08:37:02 volumio volumio[27866]: info: CoreCommandRouter::volumioRetrievevolume May 25 08:37:02 volumio volumio[27866]: info: CoreStateMachine::setRepeat true single undefined May 25 08:37:02 volumio volumio[27866]: info: CoreStateMachine::pushState May 25 08:37:02 volumio volumio[27866]: info: CorePlayQueue::getTrack 0 May 25 08:37:02 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 08:37:02 volumio volumio[27866]: info: CoreCommandRouter::volumioPushState May 25 08:37:02 volumio volumio[27866]: info: CoreStateMachine::setRandom true May 25 08:37:02 volumio volumio[27866]: info: CoreStateMachine::pushState May 25 08:37:02 volumio volumio[27866]: info: CorePlayQueue::getTrack 0 May 25 08:37:02 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 08:37:02 volumio volumio[27866]: info: CoreCommandRouter::volumioPushState May 25 08:37:02 volumio volumio[27866]: info: Setting Device type: Raspberry PI May 25 08:37:02 volumio volumio[27866]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb May 25 08:37:02 volumio volumio[27866]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03112 May 25 08:37:02 volumio volumio[27866]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI May 25 08:37:02 volumio volumio[27866]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 May 25 08:37:03 volumio volumio[27866]: info: VolumeController:: Volume=undefined Mute =false May 25 08:37:03 volumio volumio[27866]: info: CoreStateMachine::pushState May 25 08:37:03 volumio volumio[27866]: info: CorePlayQueue::getTrack 0 May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::volumioPushState May 25 08:37:03 volumio volumio[27866]: info: Completed loading Core Plugins May 25 08:37:03 volumio volumio[27866]: info: Preparing to generate the ALSA configuration file May 25 08:37:03 volumio volumio[27866]: info: Asound.conf file unchanged, so no further update is needed May 25 08:37:03 volumio volumio[27866]: info: Output device has changed, restarting MPD May 25 08:37:03 volumio sudo[27989]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 25 08:37:03 volumio sudo[27989]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 08:37:03 volumio volumio[27866]: info: Output device has changed, restarting Shairport Sync May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 08:37:03 volumio sudo[27989]: pam_unix(sudo:session): session closed for user root May 25 08:37:03 volumio sudo[27992]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 25 08:37:03 volumio sudo[27992]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 08:37:03 volumio systemd[1]: Stopping Music Player Daemon... May 25 08:37:03 volumio volumio[27866]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 25 08:37:03 volumio volumio[27866]: info: ___________ START PLUGINS ___________ May 25 08:37:03 volumio volumio[27866]: info: ControllerMpd::onStart: Initializing MPD May 25 08:37:03 volumio volumio[27866]: info: Creating MPD Configuration file May 25 08:37:03 volumio sudo[27999]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 25 08:37:03 volumio sudo[27999]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 25 08:37:03 volumio volumio[27866]: info: [1779669423262] CoreMusicLibrary::Adding element 媒体服务器 May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 08:37:03 volumio sudo[27999]: pam_unix(sudo:session): session closed for user root May 25 08:37:03 volumio sudo[28002]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 25 08:37:03 volumio sudo[28002]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 08:37:03 volumio volumio[27866]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 08:37:03 volumio systemd[1]: mpd.service: Succeeded. May 25 08:37:03 volumio systemd[1]: Stopped Music Player Daemon. May 25 08:37:03 volumio volumio[27866]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 25 08:37:03 volumio volumio[27866]: info: [1779669423366] CoreMusicLibrary::Adding element Last_100 May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 25 08:37:03 volumio volumio[27866]: info: [1779669423368] CoreMusicLibrary::Adding element Webradio May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 25 08:37:03 volumio volumio[27866]: info: Initializing BBC Radios May 25 08:37:03 volumio systemd[1]: Starting Music Player Daemon... May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 08:37:03 volumio volumio[27866]: info: GPIO-Buttons: Reading config and creating triggers... May 25 08:37:03 volumio volumio[27866]: info: GPIO-Buttons: shutdown on pin 518 May 25 08:37:03 volumio volumio[27866]: info: Loading i18n strings for locale zh May 25 08:37:03 volumio volumio[27866]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 25 08:37:03 volumio volumio[27866]: info: Volumio Calling Home May 25 08:37:03 volumio sudo[28010]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 25 08:37:03 volumio sudo[28010]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 08:37:03 volumio sudo[28010]: pam_unix(sudo:session): session closed for user root May 25 08:37:03 volumio volumio[27866]: info: GPIO-Buttons started May 25 08:37:03 volumio sudo[28032]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service May 25 08:37:03 volumio sudo[28032]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 08:37:03 volumio sudo[28035]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service May 25 08:37:03 volumio sudo[28035]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 08:37:03 volumio sudo[28038]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload May 25 08:37:03 volumio sudo[28038]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 08:37:03 volumio volumio[27866]: info: Discovery: adding 1c412013-320c-4027-bd30-4cc1953ba36e May 25 08:37:03 volumio volumio[27866]: info: Discovery: Found device Volumio May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::volumioGetState May 25 08:37:03 volumio volumio[27866]: info: CorePlayQueue::getTrack 0 May 25 08:37:03 volumio volumio[27866]: info: Discovery: this is already registered, 1c412013-320c-4027-bd30-4cc1953ba36e May 25 08:37:03 volumio volumio[27866]: info: Discovery: Found device Volumio May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::volumioGetState May 25 08:37:03 volumio volumio[27866]: info: CorePlayQueue::getTrack 0 May 25 08:37:03 volumio sudo[28032]: pam_unix(sudo:session): session closed for user root May 25 08:37:03 volumio volumio[27866]: info: touch_display: Backlight interface detected. May 25 08:37:03 volumio systemd[1]: Reloading. May 25 08:37:03 volumio volumio[27866]: info: MPD Permissions set May 25 08:37:03 volumio volumio[27866]: info: touch_display: systemctl stop getty@tty1.service succeeded. May 25 08:37:03 volumio volumio[27866]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 08:37:03 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 08:37:03 volumio volumio[27866]: info: touch_display: Raspberry Pi Foundation touch screen detected. May 25 08:37:03 volumio sudo[28064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+w /sys/class/backlight/rpi_backlight/brightness May 25 08:37:03 volumio sudo[28064]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 08:37:03 volumio volumio[27866]: info: Starting Shairport Sync May 25 08:37:03 volumio sudo[28064]: pam_unix(sudo:session): session closed for user root May 25 08:37:03 volumio volumio[27866]: info: Starting Shairport Sync May 25 08:37:04 volumio sudo[28066]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf May 25 08:37:04 volumio sudo[28066]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 08:37:04 volumio sudo[28066]: pam_unix(sudo:session): session closed for user root May 25 08:37:04 volumio volumio[27866]: info: Starting Shairport Sync May 25 08:37:04 volumio sudo[28069]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 25 08:37:04 volumio sudo[28069]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 08:37:04 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. May 25 08:37:04 volumio volumio[27866]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 May 25 08:37:04 volumio sudo[28072]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 25 08:37:04 volumio volumio[27866]: info: CoreCommandRouter::volumioGetState May 25 08:37:04 volumio volumio[27866]: info: CorePlayQueue::getTrack 0 May 25 08:37:04 volumio sudo[28072]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 08:37:04 volumio sudo[28075]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 25 08:37:04 volumio sudo[28075]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 08:37:04 volumio volumio[27866]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. May 25 08:37:04 volumio volumio[27866]: info: touch_display: File permissions for backlight brightness control set. May 25 08:37:04 volumio volumio[27866]: info: Volumio called home May 25 08:37:04 volumio systemd[1]: Reloading. May 25 08:37:04 volumio sudo[28038]: pam_unix(sudo:session): session closed for user root May 25 08:37:04 volumio volumio[27866]: info: touch_display: systemctl daemon-reload succeeded. May 25 08:37:04 volumio mpd[28028]: May 25 08:37 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 25 08:37:04 volumio sudo[28081]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service May 25 08:37:04 volumio sudo[28081]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 08:37:04 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. May 25 08:37:05 volumio sudo[28035]: pam_unix(sudo:session): session closed for user root May 25 08:37:05 volumio volumio[27866]: info: touch_display: systemctl disable getty@tty1.service succeeded. May 25 08:37:05 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 25 08:37:05 volumio systemd[1]: shairport-sync.service: Succeeded. May 25 08:37:05 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 25 08:37:05 volumio sudo[28081]: pam_unix(sudo:session): session closed for user root May 25 08:37:05 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 25 08:37:05 volumio volumio[27866]: info: touch_display: systemctl start volumio-kiosk.service succeeded. May 25 08:37:05 volumio sudo[28075]: pam_unix(sudo:session): session closed for user root May 25 08:37:05 volumio sudo[28072]: pam_unix(sudo:session): session closed for user root May 25 08:37:05 volumio volumio[27866]: info: touch_display: Volumio Kiosk started. May 25 08:37:05 volumio sudo[28069]: pam_unix(sudo:session): session closed for user root May 25 08:37:05 volumio volumio[27866]: info: CoreCommandRouter::volumioGetState May 25 08:37:05 volumio volumio[27866]: info: CorePlayQueue::getTrack 0 May 25 08:37:05 volumio volumio[27866]: info: CoreCommandRouter::volumioGetState May 25 08:37:05 volumio volumio[27866]: info: CorePlayQueue::getTrack 0 May 25 08:37:05 volumio volumio[27866]: info: Shairport-Sync Started May 25 08:37:05 volumio volumio[27866]: Error adding Membership: Error: addMembership EINVAL May 25 08:37:05 volumio volumio[27866]: info: Shairport-Sync Started May 25 08:37:05 volumio volumio[27866]: info: Shairport-Sync Started May 25 08:37:05 volumio volumio[27866]: info: touch_display: X display number found: 0 May 25 08:37:05 volumio volumio[27866]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 May 25 08:37:05 volumio volumio[27866]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 May 25 08:37:05 volumio volumio[27866]: info: touch_display: X display number found: 0 May 25 08:37:05 volumio volumio[27866]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 May 25 08:37:05 volumio volumio[27866]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 May 25 08:37:05 volumio volumio[27866]: info: touch_display: Setting screensaver timeout to 0 seconds. May 25 08:37:05 volumio volumio[27866]: info: Cannot mount NAS DS1618 at system boot, trial number 2 ,retrying in 5 seconds May 25 08:37:05 volumio systemd[1]: Started Music Player Daemon. May 25 08:37:05 volumio sudo[28002]: pam_unix(sudo:session): session closed for user root May 25 08:37:05 volumio sudo[27992]: pam_unix(sudo:session): session closed for user root May 25 08:37:05 volumio volumio[27866]: info: Completed starting Core Plugins May 25 08:37:05 volumio volumio[27866]: info: ------------------------------------------- May 25 08:37:05 volumio volumio[27866]: info: ----- MyVolumio plugins startup ---- May 25 08:37:05 volumio volumio[27866]: info: ------------------------------------------- May 25 08:37:05 volumio volumio[27866]: info: [MyVolumio PluginManager] Fetching plans data.... May 25 08:37:05 volumio volumio[27866]: error: MPD error: The expression evaluated to a falsy value: May 25 08:37:05 volumio volumio[27866]: assert.ok(self.idling) May 25 08:37:05 volumio volumio[27866]: error: The expression evaluated to a falsy value: May 25 08:37:05 volumio volumio[27866]: assert.ok(self.idling) May 25 08:37:05 volumio volumio[27866]: error: updateQueue error: null May 25 08:37:05 volumio volumio[27866]: info: MPD running with PID28028 May 25 08:37:05 volumio volumio[27866]: ,establishing connection May 25 08:37:05 volumio volumio[27866]: error: updateQueue error: null May 25 08:37:06 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 08:37:06 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 08:37:06 volumio volumio[27866]: info: CoreCommandRouter::volumioGetState May 25 08:37:06 volumio volumio[27866]: info: CorePlayQueue::getTrack 0 May 25 08:37:06 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 25 08:37:06 volumio volumio[27866]: info: Listing playlists May 25 08:37:06 volumio volumio[27866]: info: CoreCommandRouter::volumioGetVisibleSources May 25 08:37:06 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 08:37:06 volumio volumio[27866]: info: CoreCommandRouter::volumioGetQueue May 25 08:37:06 volumio volumio[27866]: info: CoreStateMachine::getQueue May 25 08:37:06 volumio volumio[27866]: info: CorePlayQueue::getQueue May 25 08:37:06 volumio volumio[27866]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 25 08:37:07 volumio volumio[27866]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 08:37:07 volumio volumio[27866]: TypeError: Cannot read property 'slice' of null May 25 08:37:07 volumio volumio[27866]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) May 25 08:37:07 volumio volumio[27866]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) May 25 08:37:07 volumio volumio[27866]: at Object.onceWrapper (events.js:422:26) May 25 08:37:07 volumio volumio[27866]: at ClientRequest.emit (events.js:315:20) May 25 08:37:07 volumio volumio[27866]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27) May 25 08:37:07 volumio volumio[27866]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17) May 25 08:37:07 volumio volumio[27866]: at TLSSocket.socketOnData (_http_client.js:509:22) May 25 08:37:07 volumio volumio[27866]: at TLSSocket.emit (events.js:315:20) May 25 08:37:07 volumio volumio[27866]: at addChunk (internal/streams/readable.js:309:12) May 25 08:37:07 volumio volumio[27866]: at readableAddChunk (internal/streams/readable.js:284:9) May 25 08:37:07 volumio volumio[27866]: at TLSSocket.Readable.push (internal/streams/readable.js:223:10) May 25 08:37:07 volumio volumio[27866]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) May 25 08:37:07 volumio volumio[27866]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 08:37:08 volumio sudo[28123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-05-25 08:36 May 25 08:37:08 volumio sudo[28123]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"