-- Logs begin at Thu 2025-11-13 13:43:14 CST, end at Sat 2026-04-11 16:41:37 CST. -- Apr 11 16:40:00 volumio-rpi sudo[7855]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-11 16:39 Apr 11 16:40:00 volumio-rpi sudo[7855]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:40:00 volumio-rpi sudo[7855]: pam_unix(sudo:session): session closed for user root Apr 11 16:40:02 volumio-rpi systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Apr 11 16:40:02 volumio-rpi systemd[1]: volumio.service: Failed with result 'exit-code'. Apr 11 16:40:03 volumio-rpi systemd[1]: Started dynamicswap service. Apr 11 16:40:03 volumio-rpi systemd[1]: dynamicswap.service: Succeeded. Apr 11 16:40:03 volumio-rpi systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Apr 11 16:40:03 volumio-rpi systemd[1]: volumio.service: Scheduled restart job, restart counter is at 3. Apr 11 16:40:03 volumio-rpi systemd[1]: Stopped Volumio Backend Module. Apr 11 16:40:03 volumio-rpi systemd[1]: Started Volumio Backend Module. Apr 11 16:40:03 volumio-rpi systemd[1]: Started dynamicswap service. Apr 11 16:40:03 volumio-rpi systemd[1]: dynamicswap.service: Succeeded. Apr 11 16:40:04 volumio-rpi volumio[7876]: info: ------------------------------------------- Apr 11 16:40:04 volumio-rpi volumio[7876]: info: ----- Volumio3 ---- Apr 11 16:40:04 volumio-rpi volumio[7876]: info: ------------------------------------------- Apr 11 16:40:04 volumio-rpi volumio[7876]: info: ----- System startup ---- Apr 11 16:40:04 volumio-rpi volumio[7876]: info: ------------------------------------------- Apr 11 16:40:04 volumio-rpi volumio[7876]: info: MYVOLUMIO Environment detected Apr 11 16:40:04 volumio-rpi volumio[7876]: info: Plugin folders cleanup Apr 11 16:40:04 volumio-rpi volumio[7876]: info: Scanning into folder /volumio/app/plugins/ Apr 11 16:40:04 volumio-rpi volumio[7876]: info: Scanning category audio_interface Apr 11 16:40:04 volumio-rpi volumio[7876]: info: Scanning category miscellanea Apr 11 16:40:04 volumio-rpi volumio[7876]: info: Scanning category music_service Apr 11 16:40:04 volumio-rpi volumio[7876]: info: Scanning category plugins.json Apr 11 16:40:04 volumio-rpi volumio[7876]: info: Scanning category system_controller Apr 11 16:40:04 volumio-rpi volumio[7876]: info: Scanning category user_interface Apr 11 16:40:04 volumio-rpi volumio[7876]: info: Scanning into folder /data/plugins/ Apr 11 16:40:04 volumio-rpi volumio[7876]: info: Scanning category audio_interface Apr 11 16:40:04 volumio-rpi volumio[7876]: info: Scanning category music_service Apr 11 16:40:04 volumio-rpi volumio[7876]: info: Scanning category system_controller Apr 11 16:40:04 volumio-rpi volumio[7876]: info: Scanning category system_hardware Apr 11 16:40:04 volumio-rpi volumio[7876]: info: Scanning category user_interface Apr 11 16:40:04 volumio-rpi volumio[7876]: info: Plugin folders cleanup completed Apr 11 16:40:04 volumio-rpi volumio[7876]: info: ------------------------------------------- Apr 11 16:40:04 volumio-rpi volumio[7876]: info: ----- Core plugins startup ---- Apr 11 16:40:04 volumio-rpi volumio[7876]: info: ------------------------------------------- Apr 11 16:40:04 volumio-rpi volumio[7876]: info: Loading plugins from folder /volumio/app/plugins/ Apr 11 16:40:04 volumio-rpi volumio[7876]: info: Adding plugin upnp to MyMusic Plugins Apr 11 16:40:04 volumio-rpi volumio[7876]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 11 16:40:04 volumio-rpi volumio[7876]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 11 16:40:04 volumio-rpi volumio[7876]: info: Loading plugins from folder /data/plugins/ Apr 11 16:40:04 volumio-rpi volumio[7876]: info: Loading plugin "system"... Apr 11 16:40:04 volumio-rpi volumio[7876]: info: Plugin ampswitch is not enabled Apr 11 16:40:04 volumio-rpi volumio[7876]: info: Loading plugin "appearance"... Apr 11 16:40:05 volumio-rpi volumio[7876]: info: Loading plugin "network"... Apr 11 16:40:05 volumio-rpi volumio[7876]: info: Refreshing Cached IP Addresses Apr 11 16:40:05 volumio-rpi sudo[7905]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 11 16:40:05 volumio-rpi sudo[7905]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:40:05 volumio-rpi sudo[7905]: pam_unix(sudo:session): session closed for user root Apr 11 16:40:05 volumio-rpi sudo[7907]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 11 16:40:05 volumio-rpi volumio[7876]: info: Loading plugin "services"... Apr 11 16:40:05 volumio-rpi sudo[7907]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:40:05 volumio-rpi volumio[7876]: info: Loading plugin "alsa_controller"... Apr 11 16:40:05 volumio-rpi sudo[7907]: pam_unix(sudo:session): session closed for user root Apr 11 16:40:05 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 11 16:40:05 volumio-rpi volumio[7876]: info: Loading plugin "wizard"... Apr 11 16:40:05 volumio-rpi volumio[7876]: info: Loading plugin "networkfs"... Apr 11 16:40:05 volumio-rpi volumio[7876]: info: Cannot mount NAS ljhnas at system boot, trial number 1 ,retrying in 5 seconds Apr 11 16:40:05 volumio-rpi volumio[7876]: info: Starting Udev Watcher for removable devices Apr 11 16:40:05 volumio-rpi volumio[7876]: info: Ignoring mount for partition: boot Apr 11 16:40:05 volumio-rpi volumio[7876]: info: Ignoring mount for partition: volumio Apr 11 16:40:05 volumio-rpi volumio[7876]: info: Ignoring mount for partition: volumio_data Apr 11 16:40:05 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 11 16:40:05 volumio-rpi volumio[7876]: info: Loading plugin "volumio_command_line_client"... Apr 11 16:40:05 volumio-rpi volumio[7876]: info: Loading plugin "upnp"... Apr 11 16:40:05 volumio-rpi volumio[7876]: info: [1775896805531] Starting Upmpd Daemon Apr 11 16:40:05 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 11 16:40:05 volumio-rpi volumio[7876]: info: Loading plugin "my_music"... Apr 11 16:40:05 volumio-rpi volumio[7876]: info: Loading plugin "mpd"... Apr 11 16:40:05 volumio-rpi volumio[7876]: info: Loading plugin "upnp_browser"... Apr 11 16:40:05 volumio-rpi volumio[7876]: info: Loading plugin "alarm-clock"... Apr 11 16:40:06 volumio-rpi volumio[7876]: info: Loading plugin "airplay_emulation"... Apr 11 16:40:06 volumio-rpi volumio[7876]: info: Starting Shairport Sync Apr 11 16:40:06 volumio-rpi volumio[7876]: info: Loading plugin "last_100"... Apr 11 16:40:06 volumio-rpi volumio[7876]: info: Loading plugin "webradio"... Apr 11 16:40:06 volumio-rpi volumio[7876]: info: Loading plugin "i2s_dacs"... Apr 11 16:40:06 volumio-rpi volumio[7876]: info: Loading plugin "volumiodiscovery"... Apr 11 16:40:06 volumio-rpi volumio[7876]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 11 16:40:06 volumio-rpi volumio[7876]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 11 16:40:06 volumio-rpi volumio[7876]: *** WARNING *** For more information see Apr 11 16:40:06 volumio-rpi node[7876]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 11 16:40:06 volumio-rpi volumio[7876]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 11 16:40:06 volumio-rpi volumio[7876]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 11 16:40:06 volumio-rpi volumio[7876]: *** WARNING *** For more information see Apr 11 16:40:06 volumio-rpi node[7876]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 11 16:40:06 volumio-rpi node[7876]: *** WARNING *** For more information see Apr 11 16:40:06 volumio-rpi node[7876]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 11 16:40:06 volumio-rpi node[7876]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 11 16:40:06 volumio-rpi node[7876]: *** WARNING *** For more information see Apr 11 16:40:06 volumio-rpi volumio[7876]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 11 16:40:06 volumio-rpi volumio[7876]: info: Discovery: Started advertising with name: Volumio-rpi Apr 11 16:40:06 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 11 16:40:06 volumio-rpi volumio[7876]: info: Loading plugin "jellyfin"... Apr 11 16:40:06 volumio-rpi volumio[7876]: info: Loading plugin "autostart"... Apr 11 16:40:06 volumio-rpi volumio[7876]: info: Applying required configuration parameters for plugin autostart Apr 11 16:40:06 volumio-rpi volumio[7876]: info: AutoStart - onVolumioStart - read config.json Apr 11 16:40:06 volumio-rpi volumio[7876]: info: Plugin gpio-buttons is not enabled Apr 11 16:40:06 volumio-rpi volumio[7876]: info: Plugin now_playing is not enabled Apr 11 16:40:06 volumio-rpi volumio[7876]: info: Loading plugin "peppy_screensaver"... Apr 11 16:40:07 volumio-rpi volumio[7876]: info: Applying required configuration parameters for plugin peppy_screensaver Apr 11 16:40:07 volumio-rpi volumio[7876]: info: Loading plugin "outputs"... Apr 11 16:40:07 volumio-rpi volumio[7876]: info: Loading plugin "albumart"... Apr 11 16:40:07 volumio-rpi volumio[7876]: info: Plugin example_plugin is not enabled Apr 11 16:40:07 volumio-rpi volumio[7876]: info: Loading plugin "inputs"... Apr 11 16:40:07 volumio-rpi volumio[7876]: info: Loading plugin "updater_comm"... Apr 11 16:40:07 volumio-rpi volumio[7876]: info: Plugin mpdemulation is not enabled Apr 11 16:40:07 volumio-rpi volumio[7876]: info: Loading plugin "rest_api"... Apr 11 16:40:07 volumio-rpi volumio[7876]: info: Loading plugin "websocket"... Apr 11 16:40:07 volumio-rpi volumio[7876]: info: Starting Socket.io Server version 2.3.0 Apr 11 16:40:07 volumio-rpi volumio[7876]: info: Plugin fusiondsp is not enabled Apr 11 16:40:07 volumio-rpi volumio[7876]: info: Plugin mpdoutput is not enabled Apr 11 16:40:07 volumio-rpi volumio[7876]: info: Plugin 80s80s is not enabled Apr 11 16:40:07 volumio-rpi volumio[7876]: info: Loading plugin "RoonBridge"... Apr 11 16:40:07 volumio-rpi volumio[7876]: Forking 3 albumart workers Apr 11 16:40:07 volumio-rpi volumio[7876]: info: Applying required configuration parameters for plugin RoonBridge Apr 11 16:40:07 volumio-rpi volumio[7876]: info: Plugin lms is not enabled Apr 11 16:40:07 volumio-rpi volumio[7876]: info: Loading plugin "minidlna"... Apr 11 16:40:07 volumio-rpi volumio[7876]: info: Applying required configuration parameters for plugin minidlna Apr 11 16:40:07 volumio-rpi volumio[7876]: info: Plugin backup_restore is not enabled Apr 11 16:40:07 volumio-rpi volumio[7876]: info: Plugin ir_controller is not enabled Apr 11 16:40:07 volumio-rpi volumio[7876]: info: Plugin mpd_oled is not enabled Apr 11 16:40:07 volumio-rpi volumio[7876]: info: Plugin Systeminfo is not enabled Apr 11 16:40:07 volumio-rpi volumio[7876]: info: Plugin lastfm is not enabled Apr 11 16:40:07 volumio-rpi volumio[7876]: info: Plugin randomizer is not enabled Apr 11 16:40:07 volumio-rpi volumio[7876]: info: Loading plugin "touch_display"... Apr 11 16:40:07 volumio-rpi volumio[7876]: info: Applying required configuration parameters for plugin touch_display Apr 11 16:40:08 volumio-rpi volumio[7876]: info: Loading i18n strings for locale zh Apr 11 16:40:08 volumio-rpi volumio[7876]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Apr 11 16:40:08 volumio-rpi volumio[7876]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Apr 11 16:40:08 volumio-rpi volumio[7876]: Updating browse sources language Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 16:40:08 volumio-rpi volumio[7876]: Starting albumart workers Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreCommandRouter::initPlayerControls Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 16:40:08 volumio-rpi volumio[7876]: Express server listening on port 3000 Apr 11 16:40:08 volumio-rpi volumio[7876]: [Metrics] WebUI: 4s 327.17ms Apr 11 16:40:08 volumio-rpi volumio[7876]: Starting albumart workers Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreStateMachine::resetVolumioState Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreStateMachine::getcurrentVolume Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 16:40:08 volumio-rpi volumio[7876]: Starting albumart workers Apr 11 16:40:08 volumio-rpi volumio[7876]: info: Volumio Network Manager: Network status updated: 1 Apr 11 16:40:08 volumio-rpi volumio[7876]: 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: 1 Apr 11 16:40:08 volumio-rpi volumio[7876]: 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: 2 Apr 11 16:40:08 volumio-rpi volumio[7876]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Apr 11 16:40:08 volumio-rpi volumio[7876]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreStateMachine::pushState Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioPushState Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreStateMachine::updateTrackBlock Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrackBlock Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioRetrievevolume Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:40:08 volumio-rpi volumio[7876]: info: Reloading queue from file Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreStateMachine::setRepeat null single undefined Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreStateMachine::pushState Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioPushState Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreStateMachine::setRandom false Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreStateMachine::pushState Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioPushState Apr 11 16:40:08 volumio-rpi volumio[7876]: info: Setting Device type: Raspberry PI Apr 11 16:40:08 volumio-rpi volumio[7876]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Apr 11 16:40:08 volumio-rpi volumio[7876]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03112 Apr 11 16:40:08 volumio-rpi volumio[7876]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Apr 11 16:40:08 volumio-rpi volumio[7876]: info: Completed loading Core Plugins Apr 11 16:40:08 volumio-rpi volumio[7876]: info: Preparing to generate the ALSA configuration file Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreStateMachine::pushState Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioPushState Apr 11 16:40:08 volumio-rpi volumio[7876]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Apr 11 16:40:08 volumio-rpi volumio[7876]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Apr 11 16:40:08 volumio-rpi volumio[7876]: info: Reading ALSA contributions from plugins. Apr 11 16:40:08 volumio-rpi volumio[7876]: info: Asound.conf file unchanged, so no further update is needed Apr 11 16:40:08 volumio-rpi volumio[7876]: info: Output device has changed, restarting MPD Apr 11 16:40:08 volumio-rpi volumio[7876]: info: Output device has changed, restarting Shairport Sync Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:40:08 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:40:08 volumio-rpi sudo[7992]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 11 16:40:08 volumio-rpi sudo[7992]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:40:08 volumio-rpi sudo[7992]: pam_unix(sudo:session): session closed for user root Apr 11 16:40:08 volumio-rpi sudo[7996]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 11 16:40:08 volumio-rpi sudo[7996]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:40:08 volumio-rpi systemd[1]: Stopping Music Player Daemon... Apr 11 16:40:08 volumio-rpi volumio[7876]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 11 16:40:08 volumio-rpi volumio[7876]: info: ___________ START PLUGINS ___________ Apr 11 16:40:08 volumio-rpi volumio[7876]: info: ControllerMpd::onStart: Initializing MPD Apr 11 16:40:08 volumio-rpi volumio[7876]: info: Creating MPD Configuration file Apr 11 16:40:09 volumio-rpi sudo[8012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 11 16:40:09 volumio-rpi sudo[8012]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 11 16:40:09 volumio-rpi volumio[7876]: info: [1775896809004] CoreMusicLibrary::Adding element 媒体服务器 Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 16:40:09 volumio-rpi sudo[8012]: pam_unix(sudo:session): session closed for user root Apr 11 16:40:09 volumio-rpi sudo[8014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 11 16:40:09 volumio-rpi sudo[8014]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:40:09 volumio-rpi volumio[7876]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:40:09 volumio-rpi volumio[7876]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 11 16:40:09 volumio-rpi volumio[7876]: info: [1775896809149] CoreMusicLibrary::Adding element Last_100 Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 11 16:40:09 volumio-rpi volumio[7876]: info: [1775896809151] CoreMusicLibrary::Adding element Webradio Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 11 16:40:09 volumio-rpi systemd[1]: mpd.service: Succeeded. Apr 11 16:40:09 volumio-rpi systemd[1]: Stopped Music Player Daemon. Apr 11 16:40:09 volumio-rpi volumio[7876]: info: Initializing BBC Radios Apr 11 16:40:09 volumio-rpi systemd[1]: Starting Music Player Daemon... Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 11 16:40:09 volumio-rpi volumio[7876]: info: Discovery: Getting this device information Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetState Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 11 16:40:09 volumio-rpi volumio[7876]: info: [1775896809235] CoreMusicLibrary::Adding element Jellyfin Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 16:40:09 volumio-rpi volumio[7876]: Cannot find translation for source Jellyfin Apr 11 16:40:09 volumio-rpi volumio[7876]: info: [jellyfin] Initialized plugin with device info: {"id":"6820a00a-30ed-4d93-af7f-63c038d8c9c0","host":"http://192.168.2.14","name":"Volumio-rpi","type":"device","serviceName":"Volumio","state":{"status":"stop","volume":"100","mute":false,"artist":"","track":"04.抱你十個世紀.wav","albumart":"http://192.168.2.14/albumart?cacheid=214&web=//extralarge&path=%2FNAS%2Fljhnas%2F%E5%88%98%2F%E9%9B%A8%E6%9E%9C&metadata=false"}} Apr 11 16:40:09 volumio-rpi volumio[7876]: info: AutoStart - onStart Apr 11 16:40:09 volumio-rpi volumio[7876]: info: Loading i18n strings for locale zh Apr 11 16:40:09 volumio-rpi volumio[7876]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Apr 11 16:40:09 volumio-rpi volumio[7876]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Apr 11 16:40:09 volumio-rpi volumio[7876]: info: /tmp/myfifo created Apr 11 16:40:09 volumio-rpi volumio[7876]: info: /tmp/myfifosa created Apr 11 16:40:09 volumio-rpi sudo[8023]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 11 16:40:09 volumio-rpi sudo[8023]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:40:09 volumio-rpi sudo[8023]: pam_unix(sudo:session): session closed for user root Apr 11 16:40:09 volumio-rpi sudo[8041]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0 Apr 11 16:40:09 volumio-rpi sudo[8041]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:40:09 volumio-rpi sudo[8041]: pam_unix(sudo:session): session closed for user root Apr 11 16:40:09 volumio-rpi volumio[7876]: info: snd-dummy loaded Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startShairportSync Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:40:09 volumio-rpi volumio[7876]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 11 16:40:09 volumio-rpi volumio[7876]: info: Loading i18n strings for locale zh Apr 11 16:40:09 volumio-rpi volumio[7876]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Apr 11 16:40:09 volumio-rpi volumio[7876]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Apr 11 16:40:09 volumio-rpi sudo[8055]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Apr 11 16:40:09 volumio-rpi sudo[8055]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:40:09 volumio-rpi volumio[7876]: info: Loading i18n strings for locale zh Apr 11 16:40:09 volumio-rpi sudo[8055]: pam_unix(sudo:session): session closed for user root Apr 11 16:40:09 volumio-rpi volumio[7876]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Apr 11 16:40:09 volumio-rpi volumio[7876]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Apr 11 16:40:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 11 16:40:09 volumio-rpi volumio[7876]: info: Volumio Calling Home Apr 11 16:40:09 volumio-rpi sudo[8063]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Apr 11 16:40:09 volumio-rpi sudo[8063]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:40:09 volumio-rpi sudo[8065]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Apr 11 16:40:09 volumio-rpi sudo[8065]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:40:09 volumio-rpi sudo[8068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Apr 11 16:40:09 volumio-rpi sudo[8068]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:40:09 volumio-rpi systemd[1]: Reloading. Apr 11 16:40:09 volumio-rpi sudo[8063]: pam_unix(sudo:session): session closed for user root Apr 11 16:40:09 volumio-rpi volumio[7876]: info: touch_display: Backlight interface detected. Apr 11 16:40:09 volumio-rpi volumio[7876]: info: minidlna: Found miniDLNA version 1.2.1 Apr 11 16:40:09 volumio-rpi volumio[7876]: info: minidlna: Starting minidlna.service Apr 11 16:40:10 volumio-rpi volumio[7876]: info: MPD Permissions set Apr 11 16:40:10 volumio-rpi volumio[7876]: info: MPD Permissions set Apr 11 16:40:10 volumio-rpi sudo[8076]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service Apr 11 16:40:10 volumio-rpi sudo[8076]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:40:10 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetState Apr 11 16:40:10 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:10 volumio-rpi volumio[7876]: info: touch_display: systemctl stop getty@tty1.service succeeded. Apr 11 16:40:10 volumio-rpi volumio[7876]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Apr 11 16:40:10 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:40:10 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:40:10 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:40:10 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:40:10 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:40:10 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:40:10 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:40:10 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:40:10 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:40:10 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:40:10 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:40:10 volumio-rpi 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. Apr 11 16:40:10 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:40:10 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:40:10 volumio-rpi mpd[8040]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 11 16:40:10 volumio-rpi mpd[8040]: output: No 'audio_output' defined in config file Apr 11 16:40:10 volumio-rpi mpd[8040]: output: Successfully detected a sndio audio device Apr 11 16:40:10 volumio-rpi mpd[8040]: zeroconf: No global port, disabling zeroconf Apr 11 16:40:10 volumio-rpi sudo[8100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+w /sys/class/backlight/rpi_backlight/brightness Apr 11 16:40:10 volumio-rpi volumio[7876]: info: touch_display: Raspberry Pi Foundation touch screen detected. Apr 11 16:40:10 volumio-rpi volumio[7876]: info: Starting Shairport Sync Apr 11 16:40:10 volumio-rpi sudo[8100]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:40:10 volumio-rpi sudo[8100]: pam_unix(sudo:session): session closed for user root Apr 11 16:40:10 volumio-rpi sudo[8103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Apr 11 16:40:10 volumio-rpi sudo[8103]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:40:10 volumio-rpi volumio[7876]: info: Starting Shairport Sync Apr 11 16:40:10 volumio-rpi sudo[8103]: pam_unix(sudo:session): session closed for user root Apr 11 16:40:10 volumio-rpi volumio[7876]: info: Starting Shairport Sync Apr 11 16:40:10 volumio-rpi volumio[7876]: info: Starting Shairport Sync Apr 11 16:40:10 volumio-rpi sudo[8108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 11 16:40:10 volumio-rpi sudo[8108]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:40:10 volumio-rpi sudo[8106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 11 16:40:10 volumio-rpi sudo[8106]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:40:10 volumio-rpi sudo[8110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 11 16:40:10 volumio-rpi volumio[7876]: info: Cannot mount NAS ljhnas at system boot, trial number 2 ,retrying in 5 seconds Apr 11 16:40:10 volumio-rpi sudo[8110]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:40:10 volumio-rpi volumio[7876]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Apr 11 16:40:10 volumio-rpi volumio[7876]: info: touch_display: File permissions for backlight brightness control set. Apr 11 16:40:10 volumio-rpi sudo[8114]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 11 16:40:10 volumio-rpi sudo[8114]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:40:10 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetState Apr 11 16:40:10 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:10 volumio-rpi systemd[1]: Started Music Player Daemon. Apr 11 16:40:10 volumio-rpi sudo[7996]: pam_unix(sudo:session): session closed for user root Apr 11 16:40:10 volumio-rpi sudo[8014]: pam_unix(sudo:session): session closed for user root Apr 11 16:40:10 volumio-rpi systemd[1]: Reloading. Apr 11 16:40:10 volumio-rpi sudo[8068]: pam_unix(sudo:session): session closed for user root Apr 11 16:40:10 volumio-rpi volumio[7876]: info: touch_display: systemctl daemon-reload succeeded. Apr 11 16:40:10 volumio-rpi sudo[8122]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Apr 11 16:40:10 volumio-rpi sudo[8122]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:40:10 volumio-rpi volumio[7876]: error: MPD error: The expression evaluated to a falsy value: Apr 11 16:40:10 volumio-rpi volumio[7876]: assert.ok(self.idling) Apr 11 16:40:10 volumio-rpi volumio[7876]: error: The expression evaluated to a falsy value: Apr 11 16:40:10 volumio-rpi volumio[7876]: assert.ok(self.idling) Apr 11 16:40:10 volumio-rpi volumio[7876]: error: updateQueue error: null Apr 11 16:40:10 volumio-rpi volumio[7876]: info: MPD running with PID8040 Apr 11 16:40:10 volumio-rpi volumio[7876]: ,establishing connection Apr 11 16:40:10 volumio-rpi volumio[7876]: error: updateQueue error: null Apr 11 16:40:11 volumio-rpi 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. Apr 11 16:40:11 volumio-rpi sudo[8065]: pam_unix(sudo:session): session closed for user root Apr 11 16:40:11 volumio-rpi volumio[7876]: info: touch_display: systemctl disable getty@tty1.service succeeded. Apr 11 16:40:11 volumio-rpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 11 16:40:11 volumio-rpi sudo[8076]: pam_unix(sudo:session): session closed for user root Apr 11 16:40:11 volumio-rpi systemd[1]: shairport-sync.service: Succeeded. Apr 11 16:40:11 volumio-rpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 11 16:40:11 volumio-rpi volumio[7876]: info: minidlna: systemctl start minidlna.service succeeded. Apr 11 16:40:11 volumio-rpi sudo[8122]: pam_unix(sudo:session): session closed for user root Apr 11 16:40:11 volumio-rpi volumio[7876]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Apr 11 16:40:11 volumio-rpi volumio[7876]: info: touch_display: Volumio Kiosk started. Apr 11 16:40:11 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetState Apr 11 16:40:11 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:11 volumio-rpi volumio[7876]: info: Completed starting Core Plugins Apr 11 16:40:11 volumio-rpi volumio[7876]: info: ------------------------------------------- Apr 11 16:40:11 volumio-rpi volumio[7876]: info: ----- MyVolumio plugins startup ---- Apr 11 16:40:11 volumio-rpi volumio[7876]: info: ------------------------------------------- Apr 11 16:40:11 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 11 16:40:11 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetState Apr 11 16:40:11 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:11 volumio-rpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 11 16:40:11 volumio-rpi systemd[1]: Startup finished in 12.028s (kernel) + 17min 47.736s (userspace) = 17min 59.765s. Apr 11 16:40:11 volumio-rpi sudo[8114]: pam_unix(sudo:session): session closed for user root Apr 11 16:40:11 volumio-rpi sudo[8106]: pam_unix(sudo:session): session closed for user root Apr 11 16:40:11 volumio-rpi sudo[8110]: pam_unix(sudo:session): session closed for user root Apr 11 16:40:11 volumio-rpi sudo[8108]: pam_unix(sudo:session): session closed for user root Apr 11 16:40:11 volumio-rpi volumio[7876]: info: Shairport-Sync Started Apr 11 16:40:11 volumio-rpi volumio[7876]: Error adding Membership: Error: addMembership EINVAL Apr 11 16:40:11 volumio-rpi volumio[7876]: info: Shairport-Sync Started Apr 11 16:40:11 volumio-rpi volumio[7876]: info: Shairport-Sync Started Apr 11 16:40:11 volumio-rpi volumio[7876]: info: Shairport-Sync Started Apr 11 16:40:11 volumio-rpi volumio[7876]: info: touch_display: X display number found: 0 Apr 11 16:40:11 volumio-rpi volumio[7876]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Apr 11 16:40:11 volumio-rpi volumio[7876]: info: touch_display: X display number found: 0 Apr 11 16:40:11 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetState Apr 11 16:40:11 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:11 volumio-rpi volumio[7876]: info: touch_display: Setting screensaver timeout to 60 seconds. Apr 11 16:40:13 volumio-rpi volumio[7876]: info: Volumio called home Apr 11 16:40:13 volumio-rpi volumio[7876]: 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 Apr 11 16:40:13 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 11 16:40:13 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetVisibleSources Apr 11 16:40:13 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 16:40:13 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetState Apr 11 16:40:13 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:13 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetState Apr 11 16:40:13 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:13 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 11 16:40:13 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 11 16:40:13 volumio-rpi volumio[7876]: info: Received Get System Info Apr 11 16:40:13 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 11 16:40:13 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 11 16:40:13 volumio-rpi volumio[7876]: info: Discovery: Getting this device information Apr 11 16:40:13 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetState Apr 11 16:40:13 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:13 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 11 16:40:13 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetState Apr 11 16:40:13 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:13 volumio-rpi volumio[7876]: info: Listing playlists Apr 11 16:40:15 volumio-rpi sudo[8167]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 11 16:40:15 volumio-rpi sudo[8167]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:40:15 volumio-rpi sudo[8167]: pam_unix(sudo:session): session closed for user root Apr 11 16:40:15 volumio-rpi volumio[7876]: info: Cannot mount NAS ljhnas at system boot, trial number 3 ,retrying in 5 seconds Apr 11 16:40:15 volumio-rpi sudo[8170]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 11 16:40:15 volumio-rpi sudo[8170]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:40:15 volumio-rpi sudo[8170]: pam_unix(sudo:session): session closed for user root Apr 11 16:40:15 volumio-rpi sudo[8173]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 11 16:40:15 volumio-rpi sudo[8173]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:40:15 volumio-rpi sudo[8173]: pam_unix(sudo:session): session closed for user root Apr 11 16:40:15 volumio-rpi volumio[7876]: info: Upmpdcli Daemon Started Apr 11 16:40:15 volumio-rpi mpd[8040]: exception: No database Apr 11 16:40:15 volumio-rpi mpd[8040]: exception: No database Apr 11 16:40:15 volumio-rpi volumio[7876]: error: Failed LSINFO: Error: [50@0] {lsinfo} No database Apr 11 16:40:16 volumio-rpi volumio[7876]: info: Discovery: adding 6820a00a-30ed-4d93-af7f-63c038d8c9c0 Apr 11 16:40:16 volumio-rpi volumio[7876]: info: Discovery: Found device Volumio-rpi Apr 11 16:40:16 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetState Apr 11 16:40:16 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:17 volumio-rpi volumio[7876]: verbose: New Socket.io Connection to 192.168.2.14 from 192.168.2.67 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 7 Apr 11 16:40:17 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 11 16:40:17 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 11 16:40:17 volumio-rpi volumio[7876]: info: Discovery: Getting this device information Apr 11 16:40:17 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetState Apr 11 16:40:17 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:17 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 11 16:40:17 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetState Apr 11 16:40:17 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:17 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 11 16:40:17 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 11 16:40:17 volumio-rpi volumio[7876]: info: VolumeController::SetAlsaVolume100 Apr 11 16:40:17 volumio-rpi volumio[7876]: info: CoreStateMachine::pushState Apr 11 16:40:17 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:17 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 11 16:40:17 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioPushState Apr 11 16:40:18 volumio-rpi volumio[7876]: verbose: New Socket.io Connection to 192.168.2.14 from 192.168.2.67 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 8 Apr 11 16:40:18 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 11 16:40:18 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetVisibleSources Apr 11 16:40:18 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 16:40:18 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetState Apr 11 16:40:18 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:18 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 11 16:40:18 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 11 16:40:18 volumio-rpi volumio[7876]: info: Received Get System Info Apr 11 16:40:18 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 11 16:40:18 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 11 16:40:18 volumio-rpi volumio[7876]: info: Discovery: Getting this device information Apr 11 16:40:18 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetState Apr 11 16:40:18 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:18 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 11 16:40:18 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetState Apr 11 16:40:18 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:18 volumio-rpi volumio[7876]: info: Listing playlists Apr 11 16:40:20 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioPlay Apr 11 16:40:20 volumio-rpi volumio[7876]: info: CoreStateMachine::play index undefined Apr 11 16:40:20 volumio-rpi volumio[7876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 11 16:40:20 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:20 volumio-rpi volumio[7876]: info: CoreStateMachine::startPlaybackTimer Apr 11 16:40:20 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:20 volumio-rpi volumio[7876]: verbose: ControllerMpd::clearAddPlayTracks NAS/ljhnas/刘/雨果/04.抱你十個世紀.wav Apr 11 16:40:20 volumio-rpi volumio[7876]: verbose: ControllerMpd::sendMpdCommand stop Apr 11 16:40:20 volumio-rpi volumio[7876]: info: sendMpdCommand stop took 1 milliseconds Apr 11 16:40:20 volumio-rpi volumio[7876]: verbose: ControllerMpd::sendMpdCommand clear Apr 11 16:40:20 volumio-rpi volumio[7876]: info: Apr 11 16:40:20 volumio-rpi volumio[7876]: ---------------------------- MPD announces system playlist update Apr 11 16:40:20 volumio-rpi volumio[7876]: info: Ignoring MPD Status Update Apr 11 16:40:20 volumio-rpi volumio[7876]: info: sendMpdCommand clear took 2 milliseconds Apr 11 16:40:20 volumio-rpi volumio[7876]: verbose: ControllerMpd::sendMpdCommand add "NAS/ljhnas/刘/雨果/04.抱你十個世紀.wav" Apr 11 16:40:20 volumio-rpi mpd[8040]: exception: No database Apr 11 16:40:20 volumio-rpi volumio[7876]: info: Apr 11 16:40:20 volumio-rpi volumio[7876]: ---------------------------- MPD announces system playlist update Apr 11 16:40:20 volumio-rpi volumio[7876]: info: Ignoring MPD Status Update Apr 11 16:40:20 volumio-rpi volumio[7876]: info: Apr 11 16:40:20 volumio-rpi volumio[7876]: ---------------------------- MPD announces system playlist update Apr 11 16:40:20 volumio-rpi volumio[7876]: info: Ignoring MPD Status Update Apr 11 16:40:20 volumio-rpi volumio[7876]: error: updateQueue error: null Apr 11 16:40:20 volumio-rpi volumio[7876]: error: updateQueue error: null Apr 11 16:40:20 volumio-rpi volumio[7876]: error: updateQueue error: null Apr 11 16:40:20 volumio-rpi volumio[7876]: info: ------------------------------ 6ms Apr 11 16:40:20 volumio-rpi volumio[7876]: info: ------------------------------ 3ms Apr 11 16:40:20 volumio-rpi volumio[7876]: info: ------------------------------ 2ms Apr 11 16:40:20 volumio-rpi volumio[7876]: info: Cannot mount NAS ljhnas at system boot, trial number 4 ,retrying in 5 seconds Apr 11 16:40:24 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetQueue Apr 11 16:40:24 volumio-rpi volumio[7876]: info: CoreStateMachine::getQueue Apr 11 16:40:24 volumio-rpi volumio[7876]: info: CorePlayQueue::getQueue Apr 11 16:40:25 volumio-rpi volumio[7876]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Apr 11 16:40:29 volumio-rpi volumio[7876]: info: AutoStart - Plugin is starting Apr 11 16:40:29 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetQueue Apr 11 16:40:29 volumio-rpi volumio[7876]: info: CoreStateMachine::getQueue Apr 11 16:40:29 volumio-rpi volumio[7876]: info: CorePlayQueue::getQueue Apr 11 16:40:29 volumio-rpi volumio[7876]: info: AutoStart - start playing Apr 11 16:40:29 volumio-rpi volumio[7876]: info: AutoStart - start playing with no specific position Apr 11 16:40:29 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioPlay Apr 11 16:40:29 volumio-rpi volumio[7876]: info: CoreStateMachine::play index 0 Apr 11 16:40:29 volumio-rpi volumio[7876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 11 16:40:29 volumio-rpi volumio[7876]: info: CoreStateMachine::stop Apr 11 16:40:29 volumio-rpi volumio[7876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 11 16:40:29 volumio-rpi volumio[7876]: info: CoreStateMachine::play index undefined Apr 11 16:40:29 volumio-rpi volumio[7876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 11 16:40:29 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:29 volumio-rpi volumio[7876]: info: CoreStateMachine::startPlaybackTimer Apr 11 16:40:29 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:29 volumio-rpi volumio[7876]: verbose: ControllerMpd::clearAddPlayTracks NAS/ljhnas/刘/雨果/04.抱你十個世紀.wav Apr 11 16:40:29 volumio-rpi volumio[7876]: verbose: ControllerMpd::sendMpdCommand stop Apr 11 16:40:29 volumio-rpi volumio[7876]: info: sendMpdCommand stop took 1 milliseconds Apr 11 16:40:29 volumio-rpi volumio[7876]: verbose: ControllerMpd::sendMpdCommand clear Apr 11 16:40:29 volumio-rpi volumio[7876]: info: Apr 11 16:40:29 volumio-rpi volumio[7876]: ---------------------------- MPD announces system playlist update Apr 11 16:40:29 volumio-rpi volumio[7876]: info: Ignoring MPD Status Update Apr 11 16:40:29 volumio-rpi volumio[7876]: info: sendMpdCommand clear took 1 milliseconds Apr 11 16:40:29 volumio-rpi volumio[7876]: verbose: ControllerMpd::sendMpdCommand add "NAS/ljhnas/刘/雨果/04.抱你十個世紀.wav" Apr 11 16:40:29 volumio-rpi volumio[7876]: info: Apr 11 16:40:29 volumio-rpi volumio[7876]: ---------------------------- MPD announces system playlist update Apr 11 16:40:29 volumio-rpi volumio[7876]: info: Ignoring MPD Status Update Apr 11 16:40:29 volumio-rpi volumio[7876]: info: Apr 11 16:40:29 volumio-rpi volumio[7876]: ---------------------------- MPD announces system playlist update Apr 11 16:40:29 volumio-rpi volumio[7876]: info: Ignoring MPD Status Update Apr 11 16:40:29 volumio-rpi volumio[7876]: error: updateQueue error: null Apr 11 16:40:29 volumio-rpi volumio[7876]: info: ------------------------------ 5ms Apr 11 16:40:29 volumio-rpi volumio[7876]: info: ------------------------------ 3ms Apr 11 16:40:29 volumio-rpi volumio[7876]: info: ------------------------------ 2ms Apr 11 16:40:29 volumio-rpi mpd[8040]: exception: No database Apr 11 16:40:31 volumio-rpi volumio[7876]: error: MyVolumio Plugin failed to start in a timely fashion Apr 11 16:40:31 volumio-rpi volumio[7876]: [Metrics] CommandRouter: 27s 257.51ms Apr 11 16:40:31 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumiosetStartupVolume Apr 11 16:40:31 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 11 16:40:31 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:40:31 volumio-rpi volumio[7876]: info: CoreCommandRouter::Close All Modals sent Apr 11 16:40:31 volumio-rpi volumio[7876]: info: CoreCommandRouter::Close All Modals sent Apr 11 16:40:32 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 11 16:40:32 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 11 16:40:32 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 11 16:40:33 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 11 16:40:33 volumio-rpi volumio[7876]: info: CURURI: music-library Apr 11 16:40:33 volumio-rpi mpd[8040]: exception: No database Apr 11 16:40:33 volumio-rpi volumio[7876]: error: Failed LSINFO: Error: [50@0] {lsinfo} No database Apr 11 16:40:33 volumio-rpi volumio[7876]: info: Preload queue cleared Apr 11 16:40:38 volumio-rpi volumio[7876]: info: BOOT COMPLETED Apr 11 16:40:39 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 11 16:40:39 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:40:39 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 11 16:40:41 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioPlay Apr 11 16:40:41 volumio-rpi volumio[7876]: info: CoreStateMachine::play index undefined Apr 11 16:40:41 volumio-rpi volumio[7876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 11 16:40:41 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:41 volumio-rpi volumio[7876]: info: CoreStateMachine::startPlaybackTimer Apr 11 16:40:41 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:41 volumio-rpi volumio[7876]: verbose: ControllerMpd::clearAddPlayTracks NAS/ljhnas/刘/雨果/04.抱你十個世紀.wav Apr 11 16:40:41 volumio-rpi volumio[7876]: verbose: ControllerMpd::sendMpdCommand stop Apr 11 16:40:41 volumio-rpi volumio[7876]: info: sendMpdCommand stop took 1 milliseconds Apr 11 16:40:41 volumio-rpi volumio[7876]: verbose: ControllerMpd::sendMpdCommand clear Apr 11 16:40:41 volumio-rpi volumio[7876]: info: Apr 11 16:40:41 volumio-rpi volumio[7876]: ---------------------------- MPD announces system playlist update Apr 11 16:40:41 volumio-rpi volumio[7876]: info: Ignoring MPD Status Update Apr 11 16:40:41 volumio-rpi volumio[7876]: info: sendMpdCommand clear took 1 milliseconds Apr 11 16:40:41 volumio-rpi volumio[7876]: verbose: ControllerMpd::sendMpdCommand add "NAS/ljhnas/刘/雨果/04.抱你十個世紀.wav" Apr 11 16:40:41 volumio-rpi mpd[8040]: exception: No database Apr 11 16:40:41 volumio-rpi volumio[7876]: info: Apr 11 16:40:41 volumio-rpi volumio[7876]: ---------------------------- MPD announces system playlist update Apr 11 16:40:41 volumio-rpi volumio[7876]: info: Ignoring MPD Status Update Apr 11 16:40:41 volumio-rpi volumio[7876]: info: Apr 11 16:40:41 volumio-rpi volumio[7876]: ---------------------------- MPD announces system playlist update Apr 11 16:40:41 volumio-rpi volumio[7876]: info: Ignoring MPD Status Update Apr 11 16:40:41 volumio-rpi volumio[7876]: error: updateQueue error: null Apr 11 16:40:41 volumio-rpi volumio[7876]: error: updateQueue error: null Apr 11 16:40:41 volumio-rpi volumio[7876]: error: updateQueue error: null Apr 11 16:40:41 volumio-rpi volumio[7876]: info: ------------------------------ 5ms Apr 11 16:40:41 volumio-rpi volumio[7876]: info: ------------------------------ 4ms Apr 11 16:40:41 volumio-rpi volumio[7876]: info: ------------------------------ 3ms Apr 11 16:40:42 volumio-rpi volumio[7876]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9D%8E%E5%AF%BF%E5%85%A8/8%E5%8F%88%E4%BA%8C%E5%88%86%E4%B9%8B%E4%B8%80/3cf78554-9fac-4a60-88a7-d58beb21b04c.jpg' Apr 11 16:40:42 volumio-rpi volumio[7876]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Alan%20walker/Faded/4577e6a2-fecf-40d1-bb4a-c7f4123724ea.jpg' Apr 11 16:40:42 volumio-rpi volumio[7876]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%AD%99%E9%9C%B2/%E5%AF%82%E5%AF%9E%E5%A5%B3%E4%BA%BA%E5%BF%83/9ebc087c-03b4-4b14-abdc-4d3611001cf5.jpg' Apr 11 16:40:45 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioPlay Apr 11 16:40:45 volumio-rpi volumio[7876]: info: CoreStateMachine::play index undefined Apr 11 16:40:45 volumio-rpi volumio[7876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 11 16:40:45 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:45 volumio-rpi volumio[7876]: info: CoreStateMachine::startPlaybackTimer Apr 11 16:40:45 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 0 Apr 11 16:40:45 volumio-rpi volumio[7876]: verbose: ControllerMpd::clearAddPlayTracks NAS/ljhnas/刘/雨果/04.抱你十個世紀.wav Apr 11 16:40:45 volumio-rpi volumio[7876]: verbose: ControllerMpd::sendMpdCommand stop Apr 11 16:40:45 volumio-rpi volumio[7876]: info: sendMpdCommand stop took 1 milliseconds Apr 11 16:40:45 volumio-rpi volumio[7876]: verbose: ControllerMpd::sendMpdCommand clear Apr 11 16:40:45 volumio-rpi volumio[7876]: info: Apr 11 16:40:45 volumio-rpi volumio[7876]: ---------------------------- MPD announces system playlist update Apr 11 16:40:45 volumio-rpi volumio[7876]: info: Ignoring MPD Status Update Apr 11 16:40:45 volumio-rpi volumio[7876]: info: sendMpdCommand clear took 2 milliseconds Apr 11 16:40:45 volumio-rpi volumio[7876]: verbose: ControllerMpd::sendMpdCommand add "NAS/ljhnas/刘/雨果/04.抱你十個世紀.wav" Apr 11 16:40:45 volumio-rpi mpd[8040]: exception: No database Apr 11 16:40:45 volumio-rpi volumio[7876]: info: Apr 11 16:40:45 volumio-rpi volumio[7876]: ---------------------------- MPD announces system playlist update Apr 11 16:40:45 volumio-rpi volumio[7876]: info: Ignoring MPD Status Update Apr 11 16:40:45 volumio-rpi volumio[7876]: info: Apr 11 16:40:45 volumio-rpi volumio[7876]: ---------------------------- MPD announces system playlist update Apr 11 16:40:45 volumio-rpi volumio[7876]: info: Ignoring MPD Status Update Apr 11 16:40:45 volumio-rpi volumio[7876]: error: updateQueue error: null Apr 11 16:40:45 volumio-rpi volumio[7876]: error: updateQueue error: null Apr 11 16:40:45 volumio-rpi volumio[7876]: error: updateQueue error: null Apr 11 16:40:45 volumio-rpi volumio[7876]: info: ------------------------------ 7ms Apr 11 16:40:45 volumio-rpi volumio[7876]: info: ------------------------------ 5ms Apr 11 16:40:45 volumio-rpi volumio[7876]: info: ------------------------------ 3ms Apr 11 16:40:48 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioPlay Apr 11 16:40:48 volumio-rpi volumio[7876]: info: CoreStateMachine::play index 3 Apr 11 16:40:48 volumio-rpi volumio[7876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 11 16:40:48 volumio-rpi volumio[7876]: info: CoreStateMachine::stop Apr 11 16:40:48 volumio-rpi volumio[7876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 11 16:40:48 volumio-rpi volumio[7876]: info: CoreStateMachine::play index undefined Apr 11 16:40:48 volumio-rpi volumio[7876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 11 16:40:48 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 3 Apr 11 16:40:48 volumio-rpi volumio[7876]: info: CoreStateMachine::startPlaybackTimer Apr 11 16:40:48 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 3 Apr 11 16:40:48 volumio-rpi volumio[7876]: verbose: ControllerMpd::clearAddPlayTracks NAS/ljhnas/刘/雨果/李寿全-.flac Apr 11 16:40:48 volumio-rpi volumio[7876]: verbose: ControllerMpd::sendMpdCommand stop Apr 11 16:40:48 volumio-rpi volumio[7876]: info: sendMpdCommand stop took 1 milliseconds Apr 11 16:40:48 volumio-rpi volumio[7876]: verbose: ControllerMpd::sendMpdCommand clear Apr 11 16:40:48 volumio-rpi volumio[7876]: info: Apr 11 16:40:48 volumio-rpi volumio[7876]: ---------------------------- MPD announces system playlist update Apr 11 16:40:48 volumio-rpi volumio[7876]: info: Ignoring MPD Status Update Apr 11 16:40:48 volumio-rpi volumio[7876]: info: sendMpdCommand clear took 1 milliseconds Apr 11 16:40:48 volumio-rpi volumio[7876]: verbose: ControllerMpd::sendMpdCommand add "NAS/ljhnas/刘/雨果/李寿全-.flac" Apr 11 16:40:48 volumio-rpi mpd[8040]: exception: No database Apr 11 16:40:48 volumio-rpi volumio[7876]: info: Apr 11 16:40:48 volumio-rpi volumio[7876]: ---------------------------- MPD announces system playlist update Apr 11 16:40:48 volumio-rpi volumio[7876]: info: Ignoring MPD Status Update Apr 11 16:40:48 volumio-rpi volumio[7876]: info: Apr 11 16:40:48 volumio-rpi volumio[7876]: ---------------------------- MPD announces system playlist update Apr 11 16:40:48 volumio-rpi volumio[7876]: info: Ignoring MPD Status Update Apr 11 16:40:48 volumio-rpi volumio[7876]: error: updateQueue error: null Apr 11 16:40:48 volumio-rpi volumio[7876]: error: updateQueue error: null Apr 11 16:40:48 volumio-rpi volumio[7876]: error: updateQueue error: null Apr 11 16:40:48 volumio-rpi volumio[7876]: info: ------------------------------ 6ms Apr 11 16:40:48 volumio-rpi volumio[7876]: info: ------------------------------ 4ms Apr 11 16:40:48 volumio-rpi volumio[7876]: info: ------------------------------ 2ms Apr 11 16:40:49 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioPlay Apr 11 16:40:49 volumio-rpi volumio[7876]: info: CoreStateMachine::play index 3 Apr 11 16:40:49 volumio-rpi volumio[7876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 11 16:40:49 volumio-rpi volumio[7876]: info: CoreStateMachine::stop Apr 11 16:40:49 volumio-rpi volumio[7876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 11 16:40:49 volumio-rpi volumio[7876]: info: CoreStateMachine::play index undefined Apr 11 16:40:49 volumio-rpi volumio[7876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 11 16:40:49 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 3 Apr 11 16:40:49 volumio-rpi volumio[7876]: info: CoreStateMachine::startPlaybackTimer Apr 11 16:40:49 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 3 Apr 11 16:40:49 volumio-rpi volumio[7876]: verbose: ControllerMpd::clearAddPlayTracks NAS/ljhnas/刘/雨果/李寿全-.flac Apr 11 16:40:49 volumio-rpi volumio[7876]: verbose: ControllerMpd::sendMpdCommand stop Apr 11 16:40:49 volumio-rpi volumio[7876]: info: sendMpdCommand stop took 1 milliseconds Apr 11 16:40:49 volumio-rpi volumio[7876]: verbose: ControllerMpd::sendMpdCommand clear Apr 11 16:40:49 volumio-rpi volumio[7876]: info: Apr 11 16:40:49 volumio-rpi volumio[7876]: ---------------------------- MPD announces system playlist update Apr 11 16:40:49 volumio-rpi volumio[7876]: info: Ignoring MPD Status Update Apr 11 16:40:49 volumio-rpi volumio[7876]: info: sendMpdCommand clear took 1 milliseconds Apr 11 16:40:49 volumio-rpi volumio[7876]: verbose: ControllerMpd::sendMpdCommand add "NAS/ljhnas/刘/雨果/李寿全-.flac" Apr 11 16:40:49 volumio-rpi mpd[8040]: exception: No database Apr 11 16:40:49 volumio-rpi volumio[7876]: info: Apr 11 16:40:49 volumio-rpi volumio[7876]: ---------------------------- MPD announces system playlist update Apr 11 16:40:49 volumio-rpi volumio[7876]: info: Ignoring MPD Status Update Apr 11 16:40:49 volumio-rpi volumio[7876]: info: Apr 11 16:40:49 volumio-rpi volumio[7876]: ---------------------------- MPD announces system playlist update Apr 11 16:40:49 volumio-rpi volumio[7876]: info: Ignoring MPD Status Update Apr 11 16:40:49 volumio-rpi volumio[7876]: error: updateQueue error: null Apr 11 16:40:49 volumio-rpi volumio[7876]: error: updateQueue error: null Apr 11 16:40:49 volumio-rpi volumio[7876]: error: updateQueue error: null Apr 11 16:40:49 volumio-rpi volumio[7876]: info: ------------------------------ 5ms Apr 11 16:40:49 volumio-rpi volumio[7876]: info: ------------------------------ 3ms Apr 11 16:40:49 volumio-rpi volumio[7876]: info: ------------------------------ 3ms Apr 11 16:40:49 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioPlay Apr 11 16:40:49 volumio-rpi volumio[7876]: info: CoreStateMachine::play index 3 Apr 11 16:40:49 volumio-rpi volumio[7876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 11 16:40:49 volumio-rpi volumio[7876]: info: CoreStateMachine::stop Apr 11 16:40:49 volumio-rpi volumio[7876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 11 16:40:49 volumio-rpi volumio[7876]: info: CoreStateMachine::play index undefined Apr 11 16:40:49 volumio-rpi volumio[7876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 11 16:40:49 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 3 Apr 11 16:40:49 volumio-rpi volumio[7876]: info: CoreStateMachine::startPlaybackTimer Apr 11 16:40:49 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 3 Apr 11 16:40:49 volumio-rpi volumio[7876]: verbose: ControllerMpd::clearAddPlayTracks NAS/ljhnas/刘/雨果/李寿全-.flac Apr 11 16:40:49 volumio-rpi volumio[7876]: verbose: ControllerMpd::sendMpdCommand stop Apr 11 16:40:49 volumio-rpi volumio[7876]: info: sendMpdCommand stop took 1 milliseconds Apr 11 16:40:49 volumio-rpi volumio[7876]: verbose: ControllerMpd::sendMpdCommand clear Apr 11 16:40:49 volumio-rpi volumio[7876]: info: Apr 11 16:40:49 volumio-rpi volumio[7876]: ---------------------------- MPD announces system playlist update Apr 11 16:40:49 volumio-rpi volumio[7876]: info: Ignoring MPD Status Update Apr 11 16:40:49 volumio-rpi volumio[7876]: info: sendMpdCommand clear took 2 milliseconds Apr 11 16:40:49 volumio-rpi volumio[7876]: verbose: ControllerMpd::sendMpdCommand add "NAS/ljhnas/刘/雨果/李寿全-.flac" Apr 11 16:40:49 volumio-rpi volumio[7876]: info: Apr 11 16:40:49 volumio-rpi volumio[7876]: ---------------------------- MPD announces system playlist update Apr 11 16:40:49 volumio-rpi mpd[8040]: exception: No database Apr 11 16:40:49 volumio-rpi volumio[7876]: info: Ignoring MPD Status Update Apr 11 16:40:49 volumio-rpi volumio[7876]: info: Apr 11 16:40:49 volumio-rpi volumio[7876]: ---------------------------- MPD announces system playlist update Apr 11 16:40:49 volumio-rpi volumio[7876]: info: Ignoring MPD Status Update Apr 11 16:40:49 volumio-rpi volumio[7876]: error: updateQueue error: null Apr 11 16:40:49 volumio-rpi volumio[7876]: info: ------------------------------ 4ms Apr 11 16:40:49 volumio-rpi volumio[7876]: error: updateQueue error: null Apr 11 16:40:49 volumio-rpi volumio[7876]: error: updateQueue error: null Apr 11 16:40:49 volumio-rpi volumio[7876]: info: ------------------------------ 3ms Apr 11 16:40:49 volumio-rpi volumio[7876]: info: ------------------------------ 3ms Apr 11 16:40:50 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioPlay Apr 11 16:40:50 volumio-rpi volumio[7876]: info: CoreStateMachine::play index 3 Apr 11 16:40:50 volumio-rpi volumio[7876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 11 16:40:50 volumio-rpi volumio[7876]: info: CoreStateMachine::stop Apr 11 16:40:50 volumio-rpi volumio[7876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 11 16:40:50 volumio-rpi volumio[7876]: info: CoreStateMachine::play index undefined Apr 11 16:40:50 volumio-rpi volumio[7876]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 11 16:40:50 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 3 Apr 11 16:40:50 volumio-rpi volumio[7876]: info: CoreStateMachine::startPlaybackTimer Apr 11 16:40:50 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 3 Apr 11 16:40:50 volumio-rpi volumio[7876]: verbose: ControllerMpd::clearAddPlayTracks NAS/ljhnas/刘/雨果/李寿全-.flac Apr 11 16:40:50 volumio-rpi volumio[7876]: verbose: ControllerMpd::sendMpdCommand stop Apr 11 16:40:50 volumio-rpi volumio[7876]: info: sendMpdCommand stop took 1 milliseconds Apr 11 16:40:50 volumio-rpi volumio[7876]: verbose: ControllerMpd::sendMpdCommand clear Apr 11 16:40:50 volumio-rpi volumio[7876]: info: Apr 11 16:40:50 volumio-rpi volumio[7876]: ---------------------------- MPD announces system playlist update Apr 11 16:40:50 volumio-rpi volumio[7876]: info: Ignoring MPD Status Update Apr 11 16:40:50 volumio-rpi volumio[7876]: info: sendMpdCommand clear took 1 milliseconds Apr 11 16:40:50 volumio-rpi volumio[7876]: verbose: ControllerMpd::sendMpdCommand add "NAS/ljhnas/刘/雨果/李寿全-.flac" Apr 11 16:40:50 volumio-rpi mpd[8040]: exception: No database Apr 11 16:40:50 volumio-rpi volumio[7876]: info: Apr 11 16:40:50 volumio-rpi volumio[7876]: ---------------------------- MPD announces system playlist update Apr 11 16:40:50 volumio-rpi volumio[7876]: info: Ignoring MPD Status Update Apr 11 16:40:50 volumio-rpi volumio[7876]: info: Apr 11 16:40:50 volumio-rpi volumio[7876]: ---------------------------- MPD announces system playlist update Apr 11 16:40:50 volumio-rpi volumio[7876]: info: Ignoring MPD Status Update Apr 11 16:40:50 volumio-rpi volumio[7876]: error: updateQueue error: null Apr 11 16:40:50 volumio-rpi volumio[7876]: error: updateQueue error: null Apr 11 16:40:50 volumio-rpi volumio[7876]: error: updateQueue error: null Apr 11 16:40:50 volumio-rpi volumio[7876]: info: ------------------------------ 5ms Apr 11 16:40:50 volumio-rpi volumio[7876]: info: ------------------------------ 3ms Apr 11 16:40:50 volumio-rpi volumio[7876]: info: ------------------------------ 2ms Apr 11 16:40:56 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 11 16:40:56 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 11 16:40:58 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 11 16:40:58 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 11 16:41:00 volumio-rpi sudo[8293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 11 16:41:00 volumio-rpi sudo[8293]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:41:00 volumio-rpi sudo[8293]: pam_unix(sudo:session): session closed for user root Apr 11 16:41:00 volumio-rpi sudo[8295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 11 16:41:00 volumio-rpi sudo[8295]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:41:00 volumio-rpi sudo[8295]: pam_unix(sudo:session): session closed for user root Apr 11 16:41:00 volumio-rpi volumio[7876]: verbose: New Socket.io Connection to 192.168.2.14 from 192.168.2.67 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 6 Apr 11 16:41:01 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 11 16:41:01 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetVisibleSources Apr 11 16:41:01 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 11 16:41:01 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetState Apr 11 16:41:01 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 3 Apr 11 16:41:01 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 11 16:41:01 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 11 16:41:01 volumio-rpi volumio[7876]: info: Received Get System Info Apr 11 16:41:01 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 11 16:41:01 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 11 16:41:01 volumio-rpi volumio[7876]: info: Discovery: Getting this device information Apr 11 16:41:01 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetState Apr 11 16:41:01 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 3 Apr 11 16:41:01 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 11 16:41:01 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetState Apr 11 16:41:01 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 3 Apr 11 16:41:01 volumio-rpi volumio[7876]: info: Listing playlists Apr 11 16:41:01 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 11 16:41:01 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 11 16:41:02 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 11 16:41:02 volumio-rpi volumio[7876]: info: Received Get System Info Apr 11 16:41:02 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 11 16:41:02 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 11 16:41:02 volumio-rpi volumio[7876]: info: Discovery: Getting this device information Apr 11 16:41:02 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetState Apr 11 16:41:02 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 3 Apr 11 16:41:02 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 11 16:41:03 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Apr 11 16:41:08 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetQueue Apr 11 16:41:08 volumio-rpi volumio[7876]: info: CoreStateMachine::getQueue Apr 11 16:41:08 volumio-rpi volumio[7876]: info: CorePlayQueue::getQueue Apr 11 16:41:09 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 11 16:41:09 volumio-rpi volumio[7876]: info: CURURI: music-library Apr 11 16:41:09 volumio-rpi mpd[8040]: exception: No database Apr 11 16:41:09 volumio-rpi volumio[7876]: error: Failed LSINFO: Error: [50@0] {lsinfo} No database Apr 11 16:41:09 volumio-rpi volumio[7876]: info: Preload queue cleared Apr 11 16:41:11 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 11 16:41:19 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 11 16:41:19 volumio-rpi volumio[7876]: info: CURURI: music-library Apr 11 16:41:19 volumio-rpi mpd[8040]: exception: No database Apr 11 16:41:19 volumio-rpi volumio[7876]: error: Failed LSINFO: Error: [50@0] {lsinfo} No database Apr 11 16:41:19 volumio-rpi volumio[7876]: info: Preload queue cleared Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 11 16:41:19 volumio-rpi volumio[7876]: info: Adding plugin bluetooth to MyMusic Plugins Apr 11 16:41:19 volumio-rpi volumio[7876]: info: Adding plugin multiroom to MyMusic Plugins Apr 11 16:41:19 volumio-rpi volumio[7876]: info: Adding plugin metavolumio to MyMusic Plugins Apr 11 16:41:19 volumio-rpi volumio[7876]: info: Adding plugin cd_controller to MyMusic Plugins Apr 11 16:41:19 volumio-rpi volumio[7876]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 11 16:41:19 volumio-rpi volumio[7876]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 11 16:41:19 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 11 16:41:20 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 11 16:41:20 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 11 16:41:20 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 11 16:41:20 volumio-rpi volumio[7876]: info: Starting MyVolumio Remote Streaming Endpoints Apr 11 16:41:20 volumio-rpi volumio[7876]: info: MyVolumio login type: Token Apr 11 16:41:20 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 11 16:41:20 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 11 16:41:21 volumio-rpi volumio[7876]: info: Starting Streaming Service Transparent Proxy Apr 11 16:41:21 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 11 16:41:21 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 11 16:41:21 volumio-rpi volumio[7876]: info: Streaming services startup Apr 11 16:41:21 volumio-rpi volumio[7876]: info: Starting Streaming Daemon Apr 11 16:41:21 volumio-rpi sudo[8338]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 11 16:41:21 volumio-rpi sudo[8338]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 11 16:41:21 volumio-rpi sudo[8338]: pam_unix(sudo:session): session closed for user root Apr 11 16:41:21 volumio-rpi volumio[7876]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Apr 11 16:41:21 volumio-rpi volumio[7876]: error: Cannot start Volumio Streaming Daemon Apr 11 16:41:21 volumio-rpi volumio[7876]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 11 16:41:21 volumio-rpi volumio[7876]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 11 16:41:21 volumio-rpi volumio[7876]: STREAMING PROXY: Starting server on port 3245 Apr 11 16:41:21 volumio-rpi volumio[7876]: Node JS runtime: 14 Apr 11 16:41:22 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 11 16:41:22 volumio-rpi volumio[7876]: info: Preload queue cleared Apr 11 16:41:23 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 11 16:41:23 volumio-rpi volumio[7876]: info: Preload queue cleared Apr 11 16:41:25 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 11 16:41:25 volumio-rpi volumio[7876]: info: Preload queue cleared Apr 11 16:41:26 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 11 16:41:26 volumio-rpi volumio[7876]: info: Preload queue cleared Apr 11 16:41:27 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 11 16:41:27 volumio-rpi volumio[7876]: info: Preload queue cleared Apr 11 16:41:28 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 11 16:41:28 volumio-rpi volumio[7876]: info: Preload queue cleared Apr 11 16:41:35 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 11 16:41:35 volumio-rpi volumio[7876]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Apr 11 16:41:35 volumio-rpi volumio[7876]: info: CoreCommandRouter::volumioGetState Apr 11 16:41:35 volumio-rpi volumio[7876]: info: CorePlayQueue::getTrack 3 Apr 11 16:41:35 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 11 16:41:35 volumio-rpi volumio[7876]: info: Preload queue cleared Apr 11 16:41:37 volumio-rpi volumio[7876]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Apr 11 16:41:37 volumio-rpi volumio[7876]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 11 16:41:37 volumio-rpi volumio[7876]: TypeError: Cannot read property 'length' of undefined Apr 11 16:41:37 volumio-rpi volumio[7876]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Apr 11 16:41:37 volumio-rpi volumio[7876]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Apr 11 16:41:37 volumio-rpi volumio[7876]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Apr 11 16:41:37 volumio-rpi volumio[7876]: at Parser.emit (events.js:315:20) Apr 11 16:41:37 volumio-rpi volumio[7876]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Apr 11 16:41:37 volumio-rpi volumio[7876]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Apr 11 16:41:37 volumio-rpi volumio[7876]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Apr 11 16:41:37 volumio-rpi volumio[7876]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Apr 11 16:41:37 volumio-rpi volumio[7876]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Apr 11 16:41:37 volumio-rpi volumio[7876]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Apr 11 16:41:37 volumio-rpi volumio[7876]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Apr 11 16:41:37 volumio-rpi volumio[7876]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Apr 11 16:41:37 volumio-rpi volumio[7876]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Apr 11 16:41:37 volumio-rpi volumio[7876]: at IncomingMessage.emit (events.js:327:22) Apr 11 16:41:37 volumio-rpi volumio[7876]: at endReadableNT (internal/streams/readable.js:1327:12) Apr 11 16:41:37 volumio-rpi volumio[7876]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Apr 11 16:41:37 volumio-rpi volumio[7876]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 11 16:41:37 volumio-rpi sudo[8433]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-11 16:40 Apr 11 16:41:37 volumio-rpi sudo[8433]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 09:33:57 AM CEST" VOLUMIO_VERSION="3.804" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="354f95cf0a6c2cbcd57b1aca3179c81c"