-- Logs begin at Tue 2025-04-29 21:12:33 UTC, end at Tue 2025-04-29 21:26:14 UTC. -- Apr 29 21:25:00 volumio volumio[7232]: info: Setting Geolocation for MyVolumio to us2 Apr 29 21:25:00 volumio volumio[7232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:00 volumio volumio[7232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:00 volumio volumio[7232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:00 volumio volumio[7232]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Apr 29 21:25:01 volumio volumio[7232]: info: Updating MyVolumio device info Apr 29 21:25:01 volumio volumio[7232]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:01 volumio volumio[7232]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 29 21:25:04 volumio volumio[7232]: info: MYVOLUMIO: Adding device Apr 29 21:25:04 volumio volumio[7232]: info: MYVOLUMIO: Evaluating Server Apr 29 21:25:08 volumio volumio[7232]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 29 21:25:08 volumio volumio[7232]: 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 29 21:25:08 volumio volumio[7232]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:08 volumio volumio[7232]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:09 volumio volumio-remote-updater[780]: [2025-04-29 21:25:08] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Apr 29 21:25:09 volumio volumio-remote-updater[780]: [2025-04-29 21:25:08] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Apr 29 21:25:09 volumio systemd[1]: volumio.service: Main process exited, code=killed, status=11/SEGV Apr 29 21:25:09 volumio systemd[1]: volumio.service: Failed with result 'signal'. Apr 29 21:25:09 volumio systemd[1]: Started dynamicswap service. Apr 29 21:25:09 volumio systemd[1]: dynamicswap.service: Succeeded. Apr 29 21:25:09 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Apr 29 21:25:09 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 16. Apr 29 21:25:09 volumio systemd[1]: Started dynamicswap service. Apr 29 21:25:09 volumio systemd[1]: Stopped Volumio Backend Module. Apr 29 21:25:09 volumio systemd[1]: Started Volumio Backend Module. Apr 29 21:25:09 volumio systemd[1]: dynamicswap.service: Succeeded. Apr 29 21:25:09 volumio volumio[7556]: info: ------------------------------------------- Apr 29 21:25:09 volumio volumio[7556]: info: ----- Volumio3 ---- Apr 29 21:25:09 volumio volumio[7556]: info: ------------------------------------------- Apr 29 21:25:09 volumio volumio[7556]: info: ----- System startup ---- Apr 29 21:25:09 volumio volumio[7556]: info: ------------------------------------------- Apr 29 21:25:09 volumio volumio[7556]: info: MYVOLUMIO Environment detected Apr 29 21:25:09 volumio volumio[7556]: info: Plugin folders cleanup Apr 29 21:25:09 volumio volumio[7556]: info: Scanning into folder /volumio/app/plugins/ Apr 29 21:25:09 volumio volumio[7556]: info: Scanning category audio_interface Apr 29 21:25:09 volumio volumio[7556]: info: Scanning category miscellanea Apr 29 21:25:09 volumio volumio[7556]: info: Scanning category music_service Apr 29 21:25:09 volumio volumio[7556]: info: Scanning category plugins.json Apr 29 21:25:09 volumio volumio[7556]: info: Scanning category system_controller Apr 29 21:25:09 volumio volumio[7556]: info: Scanning category user_interface Apr 29 21:25:09 volumio volumio[7556]: info: Scanning into folder /data/plugins/ Apr 29 21:25:09 volumio volumio[7556]: info: Scanning category audio_interface Apr 29 21:25:09 volumio volumio[7556]: info: Scanning category music_service Apr 29 21:25:09 volumio volumio[7556]: info: Plugin folders cleanup completed Apr 29 21:25:09 volumio volumio[7556]: info: ------------------------------------------- Apr 29 21:25:09 volumio volumio[7556]: info: ----- Core plugins startup ---- Apr 29 21:25:09 volumio volumio[7556]: info: ------------------------------------------- Apr 29 21:25:09 volumio volumio[7556]: info: Loading plugins from folder /volumio/app/plugins/ Apr 29 21:25:09 volumio volumio[7556]: info: Adding plugin upnp to MyMusic Plugins Apr 29 21:25:09 volumio volumio[7556]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 29 21:25:09 volumio volumio[7556]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 29 21:25:09 volumio volumio[7556]: info: Loading plugins from folder /data/plugins/ Apr 29 21:25:09 volumio volumio[7556]: info: Loading plugin "system"... Apr 29 21:25:09 volumio volumio[7556]: info: Loading plugin "appearance"... Apr 29 21:25:09 volumio volumio[7556]: info: Loading plugin "network"... Apr 29 21:25:09 volumio volumio[7556]: info: Refreshing Cached IP Addresses Apr 29 21:25:09 volumio sudo[7582]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 29 21:25:09 volumio sudo[7582]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:09 volumio sudo[7582]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:09 volumio sudo[7584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 29 21:25:09 volumio sudo[7584]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:09 volumio sudo[7584]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:09 volumio volumio[7556]: info: Loading plugin "services"... Apr 29 21:25:09 volumio volumio[7556]: info: Loading plugin "alsa_controller"... Apr 29 21:25:09 volumio sudo[7597]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 29 21:25:09 volumio sudo[7597]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:09 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 29 21:25:09 volumio volumio[7556]: info: Loading plugin "wizard"... Apr 29 21:25:09 volumio volumio[7556]: info: Loading plugin "networkfs"... Apr 29 21:25:09 volumio volumio[7556]: info: Starting Udev Watcher for removable devices Apr 29 21:25:09 volumio volumio[7556]: info: Mounting Device MEMORIA_USB Apr 29 21:25:09 volumio sudo[7613]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdc1 /mnt/USB/MEMORIA_USB -o noatime Apr 29 21:25:09 volumio sudo[7613]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:09 volumio sudo[7613]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:09 volumio volumio[7556]: mount: /media/MEMORIA_USB: /dev/sdc1 already mounted on /media/MEMORIA_USB. Apr 29 21:25:09 volumio volumio[7556]: error: Failed to mount MEMORIA_USB: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sdc1" "/mnt/USB/MEMORIA_USB" -o noatime Apr 29 21:25:09 volumio volumio[7556]: mount: /media/MEMORIA_USB: /dev/sdc1 already mounted on /media/MEMORIA_USB. Apr 29 21:25:09 volumio volumio[7556]: info: Ignoring mount for partition: boot Apr 29 21:25:09 volumio volumio[7556]: info: Ignoring mount for partition: volumio Apr 29 21:25:09 volumio volumio[7556]: info: Ignoring mount for partition: volumio_data Apr 29 21:25:09 volumio volumio[7556]: info: Ignoring mount for partition: efi-boot Apr 29 21:25:09 volumio volumio[7556]: info: Ignoring mount for partition: DaphileBoot Apr 29 21:25:09 volumio volumio[7556]: info: Ignoring mount for partition: DaphileData Apr 29 21:25:09 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 29 21:25:09 volumio volumio[7556]: info: Loading plugin "volumio_command_line_client"... Apr 29 21:25:09 volumio volumio[7556]: info: Loading plugin "upnp"... Apr 29 21:25:09 volumio volumio[7556]: info: [1745961909878] Starting Upmpd Daemon Apr 29 21:25:09 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 29 21:25:09 volumio volumio[7556]: info: Loading plugin "my_music"... Apr 29 21:25:09 volumio volumio[7556]: info: Loading plugin "mpd"... Apr 29 21:25:09 volumio volumio[7556]: info: Loading plugin "upnp_browser"... Apr 29 21:25:09 volumio volumio[7556]: info: Loading plugin "alarm-clock"... Apr 29 21:25:10 volumio volumio[7556]: info: Loading plugin "airplay_emulation"... Apr 29 21:25:10 volumio volumio[7556]: info: Starting Shairport Sync Apr 29 21:25:10 volumio volumio[7556]: info: Loading plugin "last_100"... Apr 29 21:25:10 volumio volumio[7556]: info: Loading plugin "webradio"... Apr 29 21:25:10 volumio volumio[7556]: info: Loading plugin "i2s_dacs"... Apr 29 21:25:10 volumio volumio[7556]: info: I2S DAC not set, start Auto-detection Apr 29 21:25:10 volumio volumio[7556]: info: Loading plugin "volumiodiscovery"... Apr 29 21:25:10 volumio volumio[7556]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 29 21:25:10 volumio volumio[7556]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 29 21:25:10 volumio volumio[7556]: *** WARNING *** For more information see Apr 29 21:25:10 volumio volumio[7556]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 29 21:25:10 volumio volumio[7556]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 29 21:25:10 volumio volumio[7556]: *** WARNING *** For more information see Apr 29 21:25:10 volumio node[7556]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 29 21:25:10 volumio node[7556]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 29 21:25:10 volumio node[7556]: *** WARNING *** For more information see Apr 29 21:25:10 volumio node[7556]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 29 21:25:10 volumio node[7556]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 29 21:25:10 volumio node[7556]: *** WARNING *** For more information see Apr 29 21:25:10 volumio volumio[7556]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 29 21:25:10 volumio volumio[7556]: info: Discovery: Started advertising with name: Volumio Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 29 21:25:10 volumio volumio[7556]: info: Loading plugin "youtube2"... Apr 29 21:25:10 volumio volumio[7556]: info: Loading plugin "outputs"... Apr 29 21:25:10 volumio volumio[7556]: info: Loading plugin "albumart"... Apr 29 21:25:10 volumio volumio[7556]: info: Plugin example_plugin is not enabled Apr 29 21:25:10 volumio volumio[7556]: info: Loading plugin "inputs"... Apr 29 21:25:10 volumio volumio[7556]: info: Loading plugin "updater_comm"... Apr 29 21:25:10 volumio volumio[7556]: info: Plugin mpdemulation is not enabled Apr 29 21:25:10 volumio volumio[7556]: info: Loading plugin "rest_api"... Apr 29 21:25:10 volumio volumio[7556]: info: Loading plugin "websocket"... Apr 29 21:25:10 volumio volumio[7556]: info: Starting Socket.io Server version 2.3.0 Apr 29 21:25:10 volumio volumio[7556]: Forking 3 albumart workers Apr 29 21:25:10 volumio volumio[7556]: info: Plugin fusiondsp is not enabled Apr 29 21:25:10 volumio volumio[7556]: info: Loading plugin "radio_paradise"... Apr 29 21:25:10 volumio volumio[7556]: info: Applying required configuration parameters for plugin radio_paradise Apr 29 21:25:10 volumio volumio[7556]: info: [1745961910575] [RadioParadise] API delay: 5 Apr 29 21:25:10 volumio volumio[7556]: info: Loading i18n strings for locale es Apr 29 21:25:10 volumio volumio[7556]: Updating browse sources language Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::initPlayerControls Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 21:25:10 volumio volumio[7556]: Express server listening on port 3000 Apr 29 21:25:10 volumio volumio[7556]: [Metrics] WebUI: 1s 217.89ms Apr 29 21:25:10 volumio volumio[7556]: info: Setting Device type: x86 Apr 29 21:25:10 volumio volumio[7556]: info: CoreStateMachine::resetVolumioState Apr 29 21:25:10 volumio volumio[7556]: info: CoreStateMachine::getcurrentVolume Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::volumioRetrievevolume Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:10 volumio volumio[7556]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Apr 29 21:25:10 volumio volumio[7556]: info: Completed loading Core Plugins Apr 29 21:25:10 volumio volumio[7556]: info: Preparing to generate the ALSA configuration file Apr 29 21:25:10 volumio volumio[7556]: info: Volumio Network Manager: Network status updated: 2 Apr 29 21:25:10 volumio volumio[7556]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Apr 29 21:25:10 volumio volumio[7556]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Apr 29 21:25:10 volumio volumio[7556]: Starting albumart workers Apr 29 21:25:10 volumio volumio[7556]: Starting albumart workers Apr 29 21:25:10 volumio volumio[7556]: Starting albumart workers Apr 29 21:25:10 volumio volumio[7556]: info: Reloading queue from file Apr 29 21:25:10 volumio volumio[7556]: info: VolumeController:: Volume=65 Mute =false Apr 29 21:25:10 volumio volumio[7556]: info: CoreStateMachine::pushState Apr 29 21:25:10 volumio volumio[7556]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::volumioPushState Apr 29 21:25:10 volumio volumio[7556]: info: CoreStateMachine::updateTrackBlock Apr 29 21:25:10 volumio volumio[7556]: info: CorePlayQueue::getTrackBlock Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::volumioRetrievevolume Apr 29 21:25:10 volumio volumio[7556]: info: Asound.conf file unchanged, so no further update is needed Apr 29 21:25:10 volumio volumio[7556]: info: Output device has changed, restarting MPD Apr 29 21:25:10 volumio sudo[7663]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 29 21:25:10 volumio sudo[7663]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:10 volumio sudo[7663]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:10 volumio volumio[7556]: info: Output device has changed, restarting Shairport Sync Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:10 volumio sudo[7677]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 29 21:25:10 volumio sudo[7677]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:10 volumio systemd[1]: Stopping Music Player Daemon... Apr 29 21:25:10 volumio systemd[1]: mpd.service: Succeeded. Apr 29 21:25:10 volumio systemd[1]: Stopped Music Player Daemon. Apr 29 21:25:10 volumio volumio[7556]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 29 21:25:10 volumio volumio[7556]: info: ___________ START PLUGINS ___________ Apr 29 21:25:10 volumio volumio[7556]: info: ControllerMpd::onStart: Initializing MPD Apr 29 21:25:10 volumio volumio[7556]: info: Creating MPD Configuration file Apr 29 21:25:10 volumio sudo[7696]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 29 21:25:10 volumio sudo[7696]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 29 21:25:10 volumio volumio[7556]: info: [1745961910905] CoreMusicLibrary::Adding element Media Servers Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:10 volumio sudo[7696]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:10 volumio systemd[1]: Starting Music Player Daemon... Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:10 volumio sudo[7699]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 29 21:25:10 volumio sudo[7699]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:10 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Apr 29 21:25:10 volumio systemd[1]: mpd.service: Succeeded. Apr 29 21:25:10 volumio systemd[1]: Stopped Music Player Daemon. Apr 29 21:25:10 volumio systemd[1]: Starting Music Player Daemon... Apr 29 21:25:10 volumio volumio[7556]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:10 volumio sudo[7702]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 29 21:25:10 volumio sudo[7702]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:10 volumio sudo[7702]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:10 volumio volumio[7556]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 29 21:25:10 volumio volumio[7556]: info: [1745961910943] CoreMusicLibrary::Adding element Last_100 Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 29 21:25:10 volumio volumio[7556]: info: [1745961910944] CoreMusicLibrary::Adding element Webradio Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 29 21:25:10 volumio volumio[7556]: info: Initializing BBC Radios Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 29 21:25:10 volumio volumio[7556]: info: [1745961910973] CoreMusicLibrary::Adding element YouTube2 Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 21:25:10 volumio volumio[7556]: Cannot find translation for source YouTube2 Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 29 21:25:10 volumio volumio[7556]: info: [1745961910975] CoreMusicLibrary::Adding element Radio Paradise Apr 29 21:25:10 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 21:25:10 volumio volumio[7556]: Cannot find translation for source YouTube2 Apr 29 21:25:10 volumio volumio[7556]: Cannot find translation for source Radio Paradise Apr 29 21:25:10 volumio volumio[7556]: info: Volumio Calling Home Apr 29 21:25:11 volumio volumio[7556]: info: CoreStateMachine::setRepeat null single undefined Apr 29 21:25:11 volumio volumio[7556]: info: CoreStateMachine::pushState Apr 29 21:25:11 volumio volumio[7556]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:11 volumio volumio[7556]: info: CoreCommandRouter::volumioPushState Apr 29 21:25:11 volumio volumio[7556]: info: CoreStateMachine::setRandom true Apr 29 21:25:11 volumio volumio[7556]: info: CoreStateMachine::pushState Apr 29 21:25:11 volumio volumio[7556]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:11 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 21:25:11 volumio volumio[7556]: info: CoreCommandRouter::volumioPushState Apr 29 21:25:11 volumio volumio[7556]: info: MPD Permissions set Apr 29 21:25:11 volumio volumio[7556]: info: MPD Permissions set Apr 29 21:25:11 volumio volumio[7556]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Apr 29 21:25:11 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:11 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:11 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:11 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:11 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:11 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:11 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:11 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:11 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:11 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 29 21:25:11 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:11 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:11 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:11 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:11 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:11 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:11 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:11 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:11 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:11 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:11 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 29 21:25:11 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:11 volumio volumio[7556]: info: VolumeController:: Volume=65 Mute =false Apr 29 21:25:11 volumio volumio[7556]: info: CoreStateMachine::pushState Apr 29 21:25:11 volumio volumio[7556]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:11 volumio volumio[7556]: info: CoreCommandRouter::volumioPushState Apr 29 21:25:11 volumio volumio[7556]: info: Starting Shairport Sync Apr 29 21:25:11 volumio volumio[7556]: info: Starting Shairport Sync Apr 29 21:25:11 volumio sudo[7738]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 29 21:25:11 volumio sudo[7738]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:11 volumio volumio[7556]: info: Starting Shairport Sync Apr 29 21:25:11 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 29 21:25:11 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 29 21:25:11 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 29 21:25:11 volumio sudo[7741]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 29 21:25:11 volumio sudo[7741]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:11 volumio sudo[7745]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 29 21:25:11 volumio sudo[7745]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:11 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 29 21:25:11 volumio sudo[7738]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:11 volumio volumio[7556]: info: Shairport-Sync Started Apr 29 21:25:11 volumio volumio[7556]: Error adding Membership: Error: addMembership EINVAL Apr 29 21:25:11 volumio volumio[7556]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.200 UA: Mozilla/5.0 (X11; Linux x86_64; rv:137.0) Gecko/20100101 Firefox/137.0 Engine version: 3 Transport: polling Total Clients: 3 Apr 29 21:25:11 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 29 21:25:11 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 29 21:25:11 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 29 21:25:11 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 29 21:25:11 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 29 21:25:11 volumio sudo[7741]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:11 volumio sudo[7745]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:11 volumio volumio[7556]: info: Shairport-Sync Started Apr 29 21:25:11 volumio volumio[7556]: info: Shairport-Sync Started Apr 29 21:25:11 volumio mpd[7709]: Apr 29 21:25 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 29 21:25:11 volumio systemd[1]: Started Music Player Daemon. Apr 29 21:25:11 volumio sudo[7699]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:11 volumio sudo[7677]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:11 volumio volumio[7556]: info: Completed starting Core Plugins Apr 29 21:25:11 volumio volumio[7556]: info: ------------------------------------------- Apr 29 21:25:11 volumio volumio[7556]: info: ----- MyVolumio plugins startup ---- Apr 29 21:25:11 volumio volumio[7556]: info: ------------------------------------------- Apr 29 21:25:11 volumio volumio[7556]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 29 21:25:11 volumio volumio[7556]: error: MPD error: The expression evaluated to a falsy value: Apr 29 21:25:11 volumio volumio[7556]: assert.ok(self.idling) Apr 29 21:25:11 volumio volumio[7556]: error: The expression evaluated to a falsy value: Apr 29 21:25:11 volumio volumio[7556]: assert.ok(self.idling) Apr 29 21:25:11 volumio volumio[7556]: error: updateQueue error: null Apr 29 21:25:11 volumio volumio[7556]: info: MPD running with PID7709 Apr 29 21:25:11 volumio volumio[7556]: ,establishing connection Apr 29 21:25:11 volumio volumio[7556]: error: updateQueue error: null Apr 29 21:25:12 volumio volumio[7556]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Apr 29 21:25:12 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 29 21:25:12 volumio volumio[7556]: info: CoreCommandRouter::volumioGetVisibleSources Apr 29 21:25:12 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 21:25:12 volumio volumio[7556]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:12 volumio volumio[7556]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:12 volumio volumio[7556]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:12 volumio volumio[7556]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:12 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 29 21:25:12 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 29 21:25:12 volumio volumio[7556]: info: Received Get System Info Apr 29 21:25:12 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 21:25:12 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 21:25:12 volumio volumio[7556]: info: Discovery: Getting this device information Apr 29 21:25:12 volumio volumio[7556]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:12 volumio volumio[7556]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:12 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 21:25:12 volumio volumio[7556]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:12 volumio volumio[7556]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:12 volumio volumio[7556]: info: Listing playlists Apr 29 21:25:12 volumio volumio[7556]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.200 UA: Mozilla/5.0 (X11; Linux x86_64; rv:137.0) Gecko/20100101 Firefox/137.0 Engine version: 3 Transport: polling Total Clients: 5 Apr 29 21:25:13 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 29 21:25:13 volumio volumio[7556]: info: CoreCommandRouter::volumioGetVisibleSources Apr 29 21:25:13 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 21:25:13 volumio volumio[7556]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:13 volumio volumio[7556]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:13 volumio volumio[7556]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:13 volumio volumio[7556]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:13 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 29 21:25:13 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 29 21:25:13 volumio volumio[7556]: info: Received Get System Info Apr 29 21:25:13 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 21:25:13 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 21:25:13 volumio volumio[7556]: info: Discovery: Getting this device information Apr 29 21:25:13 volumio volumio[7556]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:13 volumio volumio[7556]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:13 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 21:25:13 volumio volumio[7556]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:13 volumio volumio[7556]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:13 volumio volumio[7556]: info: Listing playlists Apr 29 21:25:13 volumio volumio[7556]: info: CoreCommandRouter::volumioGetQueue Apr 29 21:25:13 volumio volumio[7556]: info: CoreStateMachine::getQueue Apr 29 21:25:13 volumio volumio[7556]: info: CorePlayQueue::getQueue Apr 29 21:25:14 volumio volumio-remote-updater[780]: [2025-04-29 21:25:13] [connect] Successful connection Apr 29 21:25:14 volumio volumio-remote-updater[780]: [2025-04-29 21:25:14] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1745961913 101 Apr 29 21:25:14 volumio volumio[7556]: 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: 6 Apr 29 21:25:14 volumio sudo[7597]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:16 volumio volumio[7556]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:16 volumio volumio[7556]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:16 volumio volumio[7556]: info: Discovery: adding 1e594295-a03d-4768-bce8-ca6711f04f30 Apr 29 21:25:16 volumio volumio[7556]: info: Discovery: Found device Volumio Apr 29 21:25:16 volumio volumio[7556]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:16 volumio volumio[7556]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:16 volumio volumio[7556]: info: Volumio called home Apr 29 21:25:18 volumio volumio[7556]: Worker 1 died :( Apr 29 21:25:19 volumio volumio[7556]: Starting albumart workers Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 29 21:25:19 volumio volumio[7556]: info: Adding plugin bluetooth to MyMusic Plugins Apr 29 21:25:19 volumio volumio[7556]: info: Adding plugin multiroom to MyMusic Plugins Apr 29 21:25:19 volumio volumio[7556]: info: Adding plugin metavolumio to MyMusic Plugins Apr 29 21:25:19 volumio volumio[7556]: info: Adding plugin cd_controller to MyMusic Plugins Apr 29 21:25:19 volumio volumio[7556]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 29 21:25:19 volumio volumio[7556]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 29 21:25:19 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:19 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:19 volumio volumio[7556]: info: Starting MyVolumio Remote Streaming Endpoints Apr 29 21:25:19 volumio volumio[7556]: info: MyVolumio login type: Token Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 29 21:25:19 volumio volumio[7556]: info: Starting Streaming Service Transparent Proxy Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 29 21:25:19 volumio volumio[7556]: info: Streaming services startup Apr 29 21:25:19 volumio volumio[7556]: info: Starting Streaming Daemon Apr 29 21:25:19 volumio sudo[7796]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 29 21:25:19 volumio sudo[7796]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:19 volumio sudo[7796]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:19 volumio volumio[7556]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Apr 29 21:25:19 volumio sudo[7803]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 29 21:25:19 volumio sudo[7803]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:19 volumio sudo[7803]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:19 volumio sudo[7806]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 29 21:25:19 volumio sudo[7806]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:19 volumio sudo[7806]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:20 volumio volumio[7556]: error: Cannot start Volumio Streaming Daemon Apr 29 21:25:20 volumio volumio[7556]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 29 21:25:20 volumio volumio[7556]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 29 21:25:20 volumio sudo[7809]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 29 21:25:20 volumio sudo[7809]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:20 volumio sudo[7809]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:20 volumio volumio[7556]: info: Upmpdcli Daemon Started Apr 29 21:25:20 volumio volumio[7556]: STREAMING PROXY: Starting server on port 3245 Apr 29 21:25:20 volumio volumio[7556]: Node JS runtime: 14 Apr 29 21:25:20 volumio volumio[7556]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 29 21:25:21 volumio volumio[7556]: info: MyVolumio token set successfully Apr 29 21:25:21 volumio volumio[7556]: info: MYVOLUMIO: Adding device Apr 29 21:25:21 volumio volumio[7556]: info: MYVOLUMIO: Evaluating Server Apr 29 21:25:21 volumio volumio[7556]: info: MyVolumio status changed Apr 29 21:25:21 volumio volumio[7556]: info: Streaming services startup Apr 29 21:25:21 volumio volumio[7556]: info: Starting Streaming Daemon Apr 29 21:25:21 volumio volumio[7556]: info: Removing browser output: myVolumio user plan is not superstar Apr 29 21:25:21 volumio volumio[7556]: info: Removing audio output: Apr 29 21:25:21 volumio volumio[7556]: info: Stoppping Tunnel 1 Apr 29 21:25:21 volumio sudo[7829]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 29 21:25:21 volumio sudo[7829]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:21 volumio sudo[7829]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:21 volumio volumio[7556]: error: Cannot start Volumio Streaming Daemon Apr 29 21:25:21 volumio volumio[7556]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 29 21:25:21 volumio volumio[7556]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 29 21:25:21 volumio sudo[7832]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Apr 29 21:25:21 volumio sudo[7832]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:21 volumio sudo[7832]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:21 volumio volumio[7556]: info: Remote SSH Stopped Apr 29 21:25:26 volumio volumio[7556]: info: Setting Geolocation for MyVolumio to us2 Apr 29 21:25:26 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:26 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:26 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:27 volumio volumio[7556]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Apr 29 21:25:27 volumio volumio[7556]: Worker 4 died :( Apr 29 21:25:27 volumio volumio[7556]: Starting albumart workers Apr 29 21:25:27 volumio volumio[7556]: info: Updating MyVolumio device info Apr 29 21:25:27 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:28 volumio volumio[7556]: error: Streaming Proxy Server FATAL ERROR: null Apr 29 21:25:28 volumio volumio[7556]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 29 21:25:31 volumio volumio[7556]: info: MYVOLUMIO: Adding device Apr 29 21:25:31 volumio volumio[7556]: info: MYVOLUMIO: Evaluating Server Apr 29 21:25:34 volumio volumio[7556]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 29 21:25:34 volumio volumio[7556]: 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 29 21:25:34 volumio volumio[7556]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:34 volumio volumio[7556]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:34 volumio volumio-remote-updater[780]: [2025-04-29 21:25:34] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Apr 29 21:25:34 volumio volumio-remote-updater[780]: [2025-04-29 21:25:34] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Apr 29 21:25:34 volumio systemd[1]: volumio.service: Main process exited, code=killed, status=11/SEGV Apr 29 21:25:34 volumio systemd[1]: volumio.service: Failed with result 'signal'. Apr 29 21:25:34 volumio systemd[1]: Started dynamicswap service. Apr 29 21:25:34 volumio systemd[1]: dynamicswap.service: Succeeded. Apr 29 21:25:34 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Apr 29 21:25:34 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 17. Apr 29 21:25:34 volumio systemd[1]: Stopped Volumio Backend Module. Apr 29 21:25:35 volumio systemd[1]: Started Volumio Backend Module. Apr 29 21:25:35 volumio systemd[1]: Started dynamicswap service. Apr 29 21:25:35 volumio systemd[1]: dynamicswap.service: Succeeded. Apr 29 21:25:35 volumio volumio[7885]: info: ------------------------------------------- Apr 29 21:25:35 volumio volumio[7885]: info: ----- Volumio3 ---- Apr 29 21:25:35 volumio volumio[7885]: info: ------------------------------------------- Apr 29 21:25:35 volumio volumio[7885]: info: ----- System startup ---- Apr 29 21:25:35 volumio volumio[7885]: info: ------------------------------------------- Apr 29 21:25:35 volumio volumio[7885]: info: MYVOLUMIO Environment detected Apr 29 21:25:35 volumio volumio[7885]: info: Plugin folders cleanup Apr 29 21:25:35 volumio volumio[7885]: info: Scanning into folder /volumio/app/plugins/ Apr 29 21:25:35 volumio volumio[7885]: info: Scanning category audio_interface Apr 29 21:25:35 volumio volumio[7885]: info: Scanning category miscellanea Apr 29 21:25:35 volumio volumio[7885]: info: Scanning category music_service Apr 29 21:25:35 volumio volumio[7885]: info: Scanning category plugins.json Apr 29 21:25:35 volumio volumio[7885]: info: Scanning category system_controller Apr 29 21:25:35 volumio volumio[7885]: info: Scanning category user_interface Apr 29 21:25:35 volumio volumio[7885]: info: Scanning into folder /data/plugins/ Apr 29 21:25:35 volumio volumio[7885]: info: Scanning category audio_interface Apr 29 21:25:35 volumio volumio[7885]: info: Scanning category music_service Apr 29 21:25:35 volumio volumio[7885]: info: Plugin folders cleanup completed Apr 29 21:25:35 volumio volumio[7885]: info: ------------------------------------------- Apr 29 21:25:35 volumio volumio[7885]: info: ----- Core plugins startup ---- Apr 29 21:25:35 volumio volumio[7885]: info: ------------------------------------------- Apr 29 21:25:35 volumio volumio[7885]: info: Loading plugins from folder /volumio/app/plugins/ Apr 29 21:25:35 volumio volumio[7885]: info: Adding plugin upnp to MyMusic Plugins Apr 29 21:25:35 volumio volumio[7885]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 29 21:25:35 volumio volumio[7885]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 29 21:25:35 volumio volumio[7885]: info: Loading plugins from folder /data/plugins/ Apr 29 21:25:35 volumio volumio[7885]: info: Loading plugin "system"... Apr 29 21:25:35 volumio volumio[7885]: info: Loading plugin "appearance"... Apr 29 21:25:35 volumio volumio[7885]: info: Loading plugin "network"... Apr 29 21:25:35 volumio volumio[7885]: info: Refreshing Cached IP Addresses Apr 29 21:25:35 volumio sudo[7956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 29 21:25:35 volumio sudo[7956]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:35 volumio sudo[7956]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:35 volumio sudo[7958]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 29 21:25:35 volumio sudo[7958]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:35 volumio sudo[7958]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:35 volumio volumio[7885]: info: Loading plugin "services"... Apr 29 21:25:35 volumio volumio[7885]: info: Loading plugin "alsa_controller"... Apr 29 21:25:35 volumio sudo[7971]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 29 21:25:35 volumio sudo[7971]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:35 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 29 21:25:35 volumio volumio[7885]: info: Loading plugin "wizard"... Apr 29 21:25:35 volumio volumio[7885]: info: Loading plugin "networkfs"... Apr 29 21:25:35 volumio volumio[7885]: info: Starting Udev Watcher for removable devices Apr 29 21:25:35 volumio volumio[7885]: info: Mounting Device MEMORIA_USB Apr 29 21:25:35 volumio sudo[7987]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdc1 /mnt/USB/MEMORIA_USB -o noatime Apr 29 21:25:35 volumio sudo[7987]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:35 volumio sudo[7987]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:35 volumio volumio[7885]: mount: /media/MEMORIA_USB: /dev/sdc1 already mounted on /media/MEMORIA_USB. Apr 29 21:25:35 volumio volumio[7885]: error: Failed to mount MEMORIA_USB: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sdc1" "/mnt/USB/MEMORIA_USB" -o noatime Apr 29 21:25:35 volumio volumio[7885]: mount: /media/MEMORIA_USB: /dev/sdc1 already mounted on /media/MEMORIA_USB. Apr 29 21:25:35 volumio volumio[7885]: info: Ignoring mount for partition: boot Apr 29 21:25:35 volumio volumio[7885]: info: Ignoring mount for partition: volumio Apr 29 21:25:35 volumio volumio[7885]: info: Ignoring mount for partition: volumio_data Apr 29 21:25:35 volumio volumio[7885]: info: Ignoring mount for partition: efi-boot Apr 29 21:25:35 volumio volumio[7885]: info: Ignoring mount for partition: DaphileBoot Apr 29 21:25:35 volumio volumio[7885]: info: Ignoring mount for partition: DaphileData Apr 29 21:25:35 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 29 21:25:35 volumio volumio[7885]: info: Loading plugin "volumio_command_line_client"... Apr 29 21:25:35 volumio volumio[7885]: info: Loading plugin "upnp"... Apr 29 21:25:35 volumio volumio[7885]: info: [1745961935640] Starting Upmpd Daemon Apr 29 21:25:35 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 29 21:25:35 volumio volumio[7885]: info: Loading plugin "my_music"... Apr 29 21:25:35 volumio volumio[7885]: info: Loading plugin "mpd"... Apr 29 21:25:35 volumio volumio[7885]: info: Loading plugin "upnp_browser"... Apr 29 21:25:35 volumio volumio[7885]: info: Loading plugin "alarm-clock"... Apr 29 21:25:35 volumio volumio[7885]: info: Loading plugin "airplay_emulation"... Apr 29 21:25:35 volumio volumio[7885]: info: Starting Shairport Sync Apr 29 21:25:35 volumio volumio[7885]: info: Loading plugin "last_100"... Apr 29 21:25:35 volumio volumio[7885]: info: Loading plugin "webradio"... Apr 29 21:25:35 volumio volumio[7885]: info: Loading plugin "i2s_dacs"... Apr 29 21:25:35 volumio volumio[7885]: info: I2S DAC not set, start Auto-detection Apr 29 21:25:35 volumio volumio[7885]: info: Loading plugin "volumiodiscovery"... Apr 29 21:25:35 volumio volumio[7885]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 29 21:25:35 volumio volumio[7885]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 29 21:25:35 volumio volumio[7885]: *** WARNING *** For more information see Apr 29 21:25:35 volumio volumio[7885]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 29 21:25:35 volumio volumio[7885]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 29 21:25:35 volumio volumio[7885]: *** WARNING *** For more information see Apr 29 21:25:35 volumio node[7885]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 29 21:25:35 volumio node[7885]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 29 21:25:35 volumio node[7885]: *** WARNING *** For more information see Apr 29 21:25:35 volumio node[7885]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 29 21:25:35 volumio node[7885]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 29 21:25:35 volumio node[7885]: *** WARNING *** For more information see Apr 29 21:25:35 volumio volumio[7885]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 29 21:25:35 volumio volumio[7885]: info: Discovery: Started advertising with name: Volumio Apr 29 21:25:35 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 29 21:25:35 volumio volumio[7885]: info: Loading plugin "youtube2"... Apr 29 21:25:36 volumio volumio[7885]: info: Loading plugin "outputs"... Apr 29 21:25:36 volumio volumio[7885]: info: Loading plugin "albumart"... Apr 29 21:25:36 volumio volumio[7885]: info: Plugin example_plugin is not enabled Apr 29 21:25:36 volumio volumio[7885]: info: Loading plugin "inputs"... Apr 29 21:25:36 volumio volumio[7885]: info: Loading plugin "updater_comm"... Apr 29 21:25:36 volumio volumio[7885]: info: Plugin mpdemulation is not enabled Apr 29 21:25:36 volumio volumio[7885]: info: Loading plugin "rest_api"... Apr 29 21:25:36 volumio volumio[7885]: info: Loading plugin "websocket"... Apr 29 21:25:36 volumio volumio[7885]: Forking 3 albumart workers Apr 29 21:25:36 volumio volumio[7885]: info: Starting Socket.io Server version 2.3.0 Apr 29 21:25:36 volumio volumio[7885]: info: Plugin fusiondsp is not enabled Apr 29 21:25:36 volumio volumio[7885]: info: Loading plugin "radio_paradise"... Apr 29 21:25:36 volumio volumio[7885]: info: Applying required configuration parameters for plugin radio_paradise Apr 29 21:25:36 volumio volumio[7885]: info: [1745961936350] [RadioParadise] API delay: 5 Apr 29 21:25:36 volumio volumio[7885]: info: Loading i18n strings for locale es Apr 29 21:25:36 volumio volumio[7885]: Updating browse sources language Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::initPlayerControls Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: Express server listening on port 3000 Apr 29 21:25:36 volumio volumio[7885]: [Metrics] WebUI: 1s 245.77ms Apr 29 21:25:36 volumio volumio[7885]: info: Setting Device type: x86 Apr 29 21:25:36 volumio volumio[7885]: info: CoreStateMachine::resetVolumioState Apr 29 21:25:36 volumio volumio[7885]: info: CoreStateMachine::getcurrentVolume Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::volumioRetrievevolume Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Apr 29 21:25:36 volumio volumio[7885]: info: Completed loading Core Plugins Apr 29 21:25:36 volumio volumio[7885]: info: Preparing to generate the ALSA configuration file Apr 29 21:25:36 volumio volumio[7885]: info: Volumio Network Manager: Network status updated: 2 Apr 29 21:25:36 volumio volumio[7885]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Apr 29 21:25:36 volumio volumio[7885]: Starting albumart workers Apr 29 21:25:36 volumio volumio[7885]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Apr 29 21:25:36 volumio volumio[7885]: Starting albumart workers Apr 29 21:25:36 volumio volumio[7885]: Starting albumart workers Apr 29 21:25:36 volumio volumio[7885]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.200 UA: Mozilla/5.0 (X11; Linux x86_64; rv:137.0) Gecko/20100101 Firefox/137.0 Engine version: 3 Transport: polling Total Clients: 2 Apr 29 21:25:36 volumio volumio[7885]: info: Reloading queue from file Apr 29 21:25:36 volumio volumio[7885]: info: VolumeController:: Volume=65 Mute =false Apr 29 21:25:36 volumio volumio[7885]: info: CoreStateMachine::pushState Apr 29 21:25:36 volumio volumio[7885]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::volumioPushState Apr 29 21:25:36 volumio volumio[7885]: info: CoreStateMachine::updateTrackBlock Apr 29 21:25:36 volumio volumio[7885]: info: CorePlayQueue::getTrackBlock Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::volumioRetrievevolume Apr 29 21:25:36 volumio volumio[7885]: info: Asound.conf file unchanged, so no further update is needed Apr 29 21:25:36 volumio volumio[7885]: info: Output device has changed, restarting MPD Apr 29 21:25:36 volumio sudo[8048]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 29 21:25:36 volumio sudo[8048]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:36 volumio sudo[8048]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:36 volumio volumio[7885]: info: Output device has changed, restarting Shairport Sync Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:36 volumio sudo[8055]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 29 21:25:36 volumio sudo[8055]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:36 volumio volumio[7885]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 29 21:25:36 volumio systemd[1]: Stopping Music Player Daemon... Apr 29 21:25:36 volumio volumio[7885]: info: ___________ START PLUGINS ___________ Apr 29 21:25:36 volumio volumio[7885]: info: ControllerMpd::onStart: Initializing MPD Apr 29 21:25:36 volumio volumio[7885]: info: Creating MPD Configuration file Apr 29 21:25:36 volumio systemd[1]: mpd.service: Succeeded. Apr 29 21:25:36 volumio systemd[1]: Stopped Music Player Daemon. Apr 29 21:25:36 volumio sudo[8074]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 29 21:25:36 volumio sudo[8074]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 29 21:25:36 volumio volumio[7885]: info: [1745961936676] CoreMusicLibrary::Adding element Media Servers Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:36 volumio systemd[1]: Starting Music Player Daemon... Apr 29 21:25:36 volumio sudo[8074]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:36 volumio sudo[8077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 29 21:25:36 volumio sudo[8077]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:36 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Apr 29 21:25:36 volumio systemd[1]: mpd.service: Succeeded. Apr 29 21:25:36 volumio systemd[1]: Stopped Music Player Daemon. Apr 29 21:25:36 volumio systemd[1]: Starting Music Player Daemon... Apr 29 21:25:36 volumio volumio[7885]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:36 volumio sudo[8080]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 29 21:25:36 volumio sudo[8080]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:36 volumio sudo[8080]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:36 volumio volumio[7885]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 29 21:25:36 volumio volumio[7885]: info: [1745961936710] CoreMusicLibrary::Adding element Last_100 Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 29 21:25:36 volumio volumio[7885]: info: [1745961936711] CoreMusicLibrary::Adding element Webradio Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 29 21:25:36 volumio volumio[7885]: info: Initializing BBC Radios Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 29 21:25:36 volumio volumio[7885]: info: [1745961936743] CoreMusicLibrary::Adding element YouTube2 Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 21:25:36 volumio volumio[7885]: Cannot find translation for source YouTube2 Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 29 21:25:36 volumio volumio[7885]: info: [1745961936745] CoreMusicLibrary::Adding element Radio Paradise Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 21:25:36 volumio volumio[7885]: Cannot find translation for source YouTube2 Apr 29 21:25:36 volumio volumio[7885]: Cannot find translation for source Radio Paradise Apr 29 21:25:36 volumio volumio[7885]: info: Volumio Calling Home Apr 29 21:25:36 volumio volumio[7885]: info: CoreStateMachine::setRepeat null single undefined Apr 29 21:25:36 volumio volumio[7885]: info: CoreStateMachine::pushState Apr 29 21:25:36 volumio volumio[7885]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::volumioPushState Apr 29 21:25:36 volumio volumio[7885]: info: CoreStateMachine::setRandom true Apr 29 21:25:36 volumio volumio[7885]: info: CoreStateMachine::pushState Apr 29 21:25:36 volumio volumio[7885]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::volumioPushState Apr 29 21:25:36 volumio volumio[7885]: info: Discovery: A device disappeared from network Apr 29 21:25:36 volumio volumio[7885]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Apr 29 21:25:36 volumio volumio[7885]: info: MPD Permissions set Apr 29 21:25:36 volumio volumio[7885]: info: MPD Permissions set Apr 29 21:25:36 volumio volumio[7885]: 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 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:36 volumio volumio[7885]: info: VolumeController:: Volume=65 Mute =false Apr 29 21:25:36 volumio volumio[7885]: info: CoreStateMachine::pushState Apr 29 21:25:36 volumio volumio[7885]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::volumioPushState Apr 29 21:25:36 volumio volumio[7885]: info: Starting Shairport Sync Apr 29 21:25:36 volumio volumio[7885]: info: Starting Shairport Sync Apr 29 21:25:36 volumio sudo[8116]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 29 21:25:36 volumio sudo[8116]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:36 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 29 21:25:36 volumio volumio[7885]: info: Starting Shairport Sync Apr 29 21:25:36 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 29 21:25:36 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 29 21:25:36 volumio sudo[8119]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 29 21:25:36 volumio sudo[8119]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:36 volumio volumio[7885]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:36 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 29 21:25:36 volumio sudo[8123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 29 21:25:36 volumio sudo[8123]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:36 volumio sudo[8116]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:36 volumio volumio[7885]: info: Discovery: adding 1e594295-a03d-4768-bce8-ca6711f04f30 Apr 29 21:25:36 volumio volumio[7885]: info: Discovery: Found device Volumio Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:36 volumio volumio[7885]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:36 volumio volumio[7885]: info: Shairport-Sync Started Apr 29 21:25:36 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 29 21:25:36 volumio volumio[7885]: Error adding Membership: Error: addMembership EINVAL Apr 29 21:25:36 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 29 21:25:36 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 29 21:25:36 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 29 21:25:36 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 29 21:25:36 volumio sudo[8123]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:36 volumio sudo[8119]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:36 volumio volumio[7885]: info: Shairport-Sync Started Apr 29 21:25:36 volumio volumio[7885]: info: Shairport-Sync Started Apr 29 21:25:36 volumio mpd[8087]: Apr 29 21:25 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 29 21:25:36 volumio volumio[7885]: info: Discovery: this is already registered, 1e594295-a03d-4768-bce8-ca6711f04f30 Apr 29 21:25:36 volumio volumio[7885]: info: Discovery: Found device Volumio Apr 29 21:25:36 volumio volumio[7885]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:36 volumio volumio[7885]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:36 volumio systemd[1]: Started Music Player Daemon. Apr 29 21:25:36 volumio sudo[8055]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:36 volumio sudo[8077]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:37 volumio volumio[7885]: info: Completed starting Core Plugins Apr 29 21:25:37 volumio volumio[7885]: info: ------------------------------------------- Apr 29 21:25:37 volumio volumio[7885]: info: ----- MyVolumio plugins startup ---- Apr 29 21:25:37 volumio volumio[7885]: info: ------------------------------------------- Apr 29 21:25:37 volumio volumio[7885]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 29 21:25:37 volumio volumio[7885]: error: MPD error: The expression evaluated to a falsy value: Apr 29 21:25:37 volumio volumio[7885]: assert.ok(self.idling) Apr 29 21:25:37 volumio volumio[7885]: error: The expression evaluated to a falsy value: Apr 29 21:25:37 volumio volumio[7885]: assert.ok(self.idling) Apr 29 21:25:37 volumio volumio[7885]: error: updateQueue error: null Apr 29 21:25:37 volumio volumio[7885]: info: MPD running with PID8087 Apr 29 21:25:37 volumio volumio[7885]: ,establishing connection Apr 29 21:25:37 volumio volumio[7885]: error: updateQueue error: null Apr 29 21:25:37 volumio volumio[7885]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Apr 29 21:25:37 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 29 21:25:37 volumio volumio[7885]: info: CoreCommandRouter::volumioGetVisibleSources Apr 29 21:25:37 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 21:25:37 volumio volumio[7885]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:37 volumio volumio[7885]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:37 volumio volumio[7885]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:37 volumio volumio[7885]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:37 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 29 21:25:37 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 29 21:25:37 volumio volumio[7885]: info: Received Get System Info Apr 29 21:25:37 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 21:25:37 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 21:25:37 volumio volumio[7885]: info: Discovery: Getting this device information Apr 29 21:25:37 volumio volumio[7885]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:37 volumio volumio[7885]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:37 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 21:25:37 volumio volumio[7885]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:37 volumio volumio[7885]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:37 volumio volumio[7885]: info: Listing playlists Apr 29 21:25:38 volumio volumio[7885]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.200 UA: Mozilla/5.0 (X11; Linux x86_64; rv:137.0) Gecko/20100101 Firefox/137.0 Engine version: 3 Transport: polling Total Clients: 5 Apr 29 21:25:39 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 29 21:25:39 volumio volumio[7885]: info: CoreCommandRouter::volumioGetVisibleSources Apr 29 21:25:39 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 21:25:39 volumio volumio[7885]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:39 volumio volumio[7885]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:39 volumio volumio[7885]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:39 volumio volumio[7885]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:39 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 29 21:25:39 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 29 21:25:39 volumio volumio[7885]: info: Received Get System Info Apr 29 21:25:39 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 21:25:39 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 21:25:39 volumio volumio[7885]: info: Discovery: Getting this device information Apr 29 21:25:39 volumio volumio[7885]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:39 volumio volumio[7885]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:39 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 21:25:39 volumio volumio[7885]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:39 volumio volumio[7885]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:39 volumio volumio[7885]: info: Listing playlists Apr 29 21:25:39 volumio volumio[7885]: info: CoreCommandRouter::volumioGetQueue Apr 29 21:25:39 volumio volumio[7885]: info: CoreStateMachine::getQueue Apr 29 21:25:39 volumio volumio[7885]: info: CorePlayQueue::getQueue Apr 29 21:25:39 volumio volumio-remote-updater[780]: [2025-04-29 21:25:39] [connect] Successful connection Apr 29 21:25:39 volumio volumio-remote-updater[780]: [2025-04-29 21:25:39] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1745961939 101 Apr 29 21:25:39 volumio volumio[7885]: 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: 6 Apr 29 21:25:40 volumio sudo[7971]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:42 volumio volumio[7885]: info: Volumio called home Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 29 21:25:45 volumio volumio[7885]: info: Adding plugin bluetooth to MyMusic Plugins Apr 29 21:25:45 volumio volumio[7885]: info: Adding plugin multiroom to MyMusic Plugins Apr 29 21:25:45 volumio volumio[7885]: info: Adding plugin metavolumio to MyMusic Plugins Apr 29 21:25:45 volumio volumio[7885]: info: Adding plugin cd_controller to MyMusic Plugins Apr 29 21:25:45 volumio volumio[7885]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 29 21:25:45 volumio volumio[7885]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 29 21:25:45 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:45 volumio volumio[7885]: info: Starting MyVolumio Remote Streaming Endpoints Apr 29 21:25:45 volumio volumio[7885]: info: MyVolumio login type: Token Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 29 21:25:45 volumio volumio[7885]: info: Starting Streaming Service Transparent Proxy Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 29 21:25:45 volumio volumio[7885]: info: Streaming services startup Apr 29 21:25:45 volumio volumio[7885]: info: Starting Streaming Daemon Apr 29 21:25:45 volumio sudo[8155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 29 21:25:45 volumio sudo[8155]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:45 volumio sudo[8155]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:45 volumio volumio[7885]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Apr 29 21:25:45 volumio sudo[8162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 29 21:25:45 volumio sudo[8162]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:45 volumio sudo[8162]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:45 volumio sudo[8165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 29 21:25:45 volumio sudo[8165]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:45 volumio sudo[8165]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:45 volumio volumio[7885]: error: Cannot start Volumio Streaming Daemon Apr 29 21:25:45 volumio volumio[7885]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 29 21:25:45 volumio volumio[7885]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 29 21:25:45 volumio sudo[8168]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 29 21:25:45 volumio sudo[8168]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:45 volumio sudo[8168]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:45 volumio volumio[7885]: info: Upmpdcli Daemon Started Apr 29 21:25:45 volumio volumio[7885]: STREAMING PROXY: Starting server on port 3245 Apr 29 21:25:45 volumio volumio[7885]: Node JS runtime: 14 Apr 29 21:25:46 volumio volumio[7885]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 29 21:25:46 volumio volumio[7885]: info: MyVolumio token set successfully Apr 29 21:25:46 volumio volumio[7885]: info: MYVOLUMIO: Adding device Apr 29 21:25:46 volumio volumio[7885]: info: MYVOLUMIO: Evaluating Server Apr 29 21:25:47 volumio volumio[7885]: info: MyVolumio status changed Apr 29 21:25:47 volumio volumio[7885]: info: Streaming services startup Apr 29 21:25:47 volumio volumio[7885]: info: Starting Streaming Daemon Apr 29 21:25:47 volumio volumio[7885]: info: Removing browser output: myVolumio user plan is not superstar Apr 29 21:25:47 volumio volumio[7885]: info: Removing audio output: Apr 29 21:25:47 volumio volumio[7885]: info: Stoppping Tunnel 1 Apr 29 21:25:47 volumio sudo[8188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 29 21:25:47 volumio sudo[8188]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:47 volumio sudo[8188]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:47 volumio volumio[7885]: error: Cannot start Volumio Streaming Daemon Apr 29 21:25:47 volumio volumio[7885]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 29 21:25:47 volumio volumio[7885]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 29 21:25:47 volumio sudo[8191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Apr 29 21:25:47 volumio sudo[8191]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:47 volumio sudo[8191]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:47 volumio volumio[7885]: info: Remote SSH Stopped Apr 29 21:25:52 volumio volumio[7885]: info: Setting Geolocation for MyVolumio to us2 Apr 29 21:25:52 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:52 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:52 volumio volumio[7885]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:52 volumio volumio-remote-updater[780]: [2025-04-29 21:25:52] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Apr 29 21:25:52 volumio volumio-remote-updater[780]: [2025-04-29 21:25:52] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Apr 29 21:25:52 volumio systemd[1]: volumio.service: Main process exited, code=killed, status=11/SEGV Apr 29 21:25:52 volumio systemd[1]: volumio.service: Failed with result 'signal'. Apr 29 21:25:52 volumio systemd[1]: Started dynamicswap service. Apr 29 21:25:52 volumio systemd[1]: dynamicswap.service: Succeeded. Apr 29 21:25:52 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Apr 29 21:25:52 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 18. Apr 29 21:25:52 volumio systemd[1]: Started dynamicswap service. Apr 29 21:25:52 volumio systemd[1]: Stopped Volumio Backend Module. Apr 29 21:25:52 volumio systemd[1]: Started Volumio Backend Module. Apr 29 21:25:52 volumio systemd[1]: dynamicswap.service: Succeeded. Apr 29 21:25:52 volumio volumio[8202]: info: ------------------------------------------- Apr 29 21:25:52 volumio volumio[8202]: info: ----- Volumio3 ---- Apr 29 21:25:52 volumio volumio[8202]: info: ------------------------------------------- Apr 29 21:25:52 volumio volumio[8202]: info: ----- System startup ---- Apr 29 21:25:52 volumio volumio[8202]: info: ------------------------------------------- Apr 29 21:25:53 volumio volumio[8202]: info: MYVOLUMIO Environment detected Apr 29 21:25:53 volumio volumio[8202]: info: Plugin folders cleanup Apr 29 21:25:53 volumio volumio[8202]: info: Scanning into folder /volumio/app/plugins/ Apr 29 21:25:53 volumio volumio[8202]: info: Scanning category audio_interface Apr 29 21:25:53 volumio volumio[8202]: info: Scanning category miscellanea Apr 29 21:25:53 volumio volumio[8202]: info: Scanning category music_service Apr 29 21:25:53 volumio volumio[8202]: info: Scanning category plugins.json Apr 29 21:25:53 volumio volumio[8202]: info: Scanning category system_controller Apr 29 21:25:53 volumio volumio[8202]: info: Scanning category user_interface Apr 29 21:25:53 volumio volumio[8202]: info: Scanning into folder /data/plugins/ Apr 29 21:25:53 volumio volumio[8202]: info: Scanning category audio_interface Apr 29 21:25:53 volumio volumio[8202]: info: Scanning category music_service Apr 29 21:25:53 volumio volumio[8202]: info: Plugin folders cleanup completed Apr 29 21:25:53 volumio volumio[8202]: info: ------------------------------------------- Apr 29 21:25:53 volumio volumio[8202]: info: ----- Core plugins startup ---- Apr 29 21:25:53 volumio volumio[8202]: info: ------------------------------------------- Apr 29 21:25:53 volumio volumio[8202]: info: Loading plugins from folder /volumio/app/plugins/ Apr 29 21:25:53 volumio volumio[8202]: info: Adding plugin upnp to MyMusic Plugins Apr 29 21:25:53 volumio volumio[8202]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 29 21:25:53 volumio volumio[8202]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 29 21:25:53 volumio volumio[8202]: info: Loading plugins from folder /data/plugins/ Apr 29 21:25:53 volumio volumio[8202]: info: Loading plugin "system"... Apr 29 21:25:53 volumio volumio[8202]: info: Loading plugin "appearance"... Apr 29 21:25:53 volumio volumio[8202]: info: Loading plugin "network"... Apr 29 21:25:53 volumio volumio[8202]: info: Refreshing Cached IP Addresses Apr 29 21:25:53 volumio sudo[8228]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 29 21:25:53 volumio sudo[8228]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:53 volumio sudo[8228]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:53 volumio sudo[8230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 29 21:25:53 volumio sudo[8230]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:53 volumio sudo[8230]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:53 volumio volumio[8202]: info: Loading plugin "services"... Apr 29 21:25:53 volumio volumio[8202]: info: Loading plugin "alsa_controller"... Apr 29 21:25:53 volumio sudo[8243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 29 21:25:53 volumio sudo[8243]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:53 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 29 21:25:53 volumio volumio[8202]: info: Loading plugin "wizard"... Apr 29 21:25:53 volumio volumio[8202]: info: Loading plugin "networkfs"... Apr 29 21:25:53 volumio volumio[8202]: info: Starting Udev Watcher for removable devices Apr 29 21:25:53 volumio volumio[8202]: info: Mounting Device MEMORIA_USB Apr 29 21:25:53 volumio sudo[8259]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdc1 /mnt/USB/MEMORIA_USB -o noatime Apr 29 21:25:53 volumio sudo[8259]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:53 volumio sudo[8259]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:53 volumio volumio[8202]: mount: /media/MEMORIA_USB: /dev/sdc1 already mounted on /media/MEMORIA_USB. Apr 29 21:25:53 volumio volumio[8202]: error: Failed to mount MEMORIA_USB: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sdc1" "/mnt/USB/MEMORIA_USB" -o noatime Apr 29 21:25:53 volumio volumio[8202]: mount: /media/MEMORIA_USB: /dev/sdc1 already mounted on /media/MEMORIA_USB. Apr 29 21:25:53 volumio volumio[8202]: info: Ignoring mount for partition: boot Apr 29 21:25:53 volumio volumio[8202]: info: Ignoring mount for partition: volumio Apr 29 21:25:53 volumio volumio[8202]: info: Ignoring mount for partition: volumio_data Apr 29 21:25:53 volumio volumio[8202]: info: Ignoring mount for partition: efi-boot Apr 29 21:25:53 volumio volumio[8202]: info: Ignoring mount for partition: DaphileBoot Apr 29 21:25:53 volumio volumio[8202]: info: Ignoring mount for partition: DaphileData Apr 29 21:25:53 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 29 21:25:53 volumio volumio[8202]: info: Loading plugin "volumio_command_line_client"... Apr 29 21:25:53 volumio volumio[8202]: info: Loading plugin "upnp"... Apr 29 21:25:53 volumio volumio[8202]: info: [1745961953380] Starting Upmpd Daemon Apr 29 21:25:53 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 29 21:25:53 volumio volumio[8202]: info: Loading plugin "my_music"... Apr 29 21:25:53 volumio volumio[8202]: info: Loading plugin "mpd"... Apr 29 21:25:53 volumio volumio[8202]: info: Loading plugin "upnp_browser"... Apr 29 21:25:53 volumio volumio[8202]: info: Loading plugin "alarm-clock"... Apr 29 21:25:53 volumio volumio[8202]: info: Loading plugin "airplay_emulation"... Apr 29 21:25:53 volumio volumio[8202]: info: Starting Shairport Sync Apr 29 21:25:53 volumio volumio[8202]: info: Loading plugin "last_100"... Apr 29 21:25:53 volumio volumio[8202]: info: Loading plugin "webradio"... Apr 29 21:25:53 volumio volumio[8202]: info: Loading plugin "i2s_dacs"... Apr 29 21:25:53 volumio volumio[8202]: info: I2S DAC not set, start Auto-detection Apr 29 21:25:53 volumio volumio[8202]: info: Loading plugin "volumiodiscovery"... Apr 29 21:25:53 volumio volumio[8202]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 29 21:25:53 volumio volumio[8202]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 29 21:25:53 volumio volumio[8202]: *** WARNING *** For more information see Apr 29 21:25:53 volumio node[8202]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 29 21:25:53 volumio volumio[8202]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 29 21:25:53 volumio volumio[8202]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 29 21:25:53 volumio volumio[8202]: *** WARNING *** For more information see Apr 29 21:25:53 volumio node[8202]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 29 21:25:53 volumio node[8202]: *** WARNING *** For more information see Apr 29 21:25:53 volumio node[8202]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 29 21:25:53 volumio node[8202]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 29 21:25:53 volumio node[8202]: *** WARNING *** For more information see Apr 29 21:25:53 volumio volumio[8202]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 29 21:25:53 volumio volumio[8202]: info: Discovery: Started advertising with name: Volumio Apr 29 21:25:53 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 29 21:25:53 volumio volumio[8202]: info: Loading plugin "youtube2"... Apr 29 21:25:53 volumio volumio[8202]: info: Loading plugin "outputs"... Apr 29 21:25:54 volumio volumio[8202]: info: Loading plugin "albumart"... Apr 29 21:25:54 volumio volumio[8202]: info: Plugin example_plugin is not enabled Apr 29 21:25:54 volumio volumio[8202]: info: Loading plugin "inputs"... Apr 29 21:25:54 volumio volumio[8202]: info: Loading plugin "updater_comm"... Apr 29 21:25:54 volumio volumio[8202]: info: Plugin mpdemulation is not enabled Apr 29 21:25:54 volumio volumio[8202]: info: Loading plugin "rest_api"... Apr 29 21:25:54 volumio volumio[8202]: info: Loading plugin "websocket"... Apr 29 21:25:54 volumio volumio[8202]: Forking 3 albumart workers Apr 29 21:25:54 volumio volumio[8202]: info: Starting Socket.io Server version 2.3.0 Apr 29 21:25:54 volumio volumio[8202]: info: Plugin fusiondsp is not enabled Apr 29 21:25:54 volumio volumio[8202]: info: Loading plugin "radio_paradise"... Apr 29 21:25:54 volumio volumio[8202]: info: Applying required configuration parameters for plugin radio_paradise Apr 29 21:25:54 volumio volumio[8202]: info: [1745961954102] [RadioParadise] API delay: 5 Apr 29 21:25:54 volumio volumio[8202]: info: Loading i18n strings for locale es Apr 29 21:25:54 volumio volumio[8202]: Updating browse sources language Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::initPlayerControls Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: Express server listening on port 3000 Apr 29 21:25:54 volumio volumio[8202]: [Metrics] WebUI: 1s 250.28ms Apr 29 21:25:54 volumio volumio[8202]: info: Setting Device type: x86 Apr 29 21:25:54 volumio volumio[8202]: info: CoreStateMachine::resetVolumioState Apr 29 21:25:54 volumio volumio[8202]: info: CoreStateMachine::getcurrentVolume Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::volumioRetrievevolume Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Apr 29 21:25:54 volumio volumio[8202]: info: Completed loading Core Plugins Apr 29 21:25:54 volumio volumio[8202]: info: Preparing to generate the ALSA configuration file Apr 29 21:25:54 volumio volumio[8202]: info: Volumio Network Manager: Network status updated: 2 Apr 29 21:25:54 volumio volumio[8202]: Starting albumart workers Apr 29 21:25:54 volumio volumio[8202]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Apr 29 21:25:54 volumio volumio[8202]: Starting albumart workers Apr 29 21:25:54 volumio volumio[8202]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Apr 29 21:25:54 volumio volumio[8202]: Starting albumart workers Apr 29 21:25:54 volumio volumio[8202]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.200 UA: Mozilla/5.0 (X11; Linux x86_64; rv:137.0) Gecko/20100101 Firefox/137.0 Engine version: 3 Transport: polling Total Clients: 2 Apr 29 21:25:54 volumio volumio[8202]: info: Reloading queue from file Apr 29 21:25:54 volumio volumio[8202]: info: Asound.conf file unchanged, so no further update is needed Apr 29 21:25:54 volumio volumio[8202]: info: Output device has changed, restarting MPD Apr 29 21:25:54 volumio sudo[8307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 29 21:25:54 volumio sudo[8307]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:54 volumio sudo[8307]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:54 volumio volumio[8202]: info: Output device has changed, restarting Shairport Sync Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:54 volumio sudo[8318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 29 21:25:54 volumio sudo[8318]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:54 volumio systemd[1]: Stopping Music Player Daemon... Apr 29 21:25:54 volumio volumio[8202]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 29 21:25:54 volumio volumio[8202]: info: ___________ START PLUGINS ___________ Apr 29 21:25:54 volumio systemd[1]: mpd.service: Succeeded. Apr 29 21:25:54 volumio systemd[1]: Stopped Music Player Daemon. Apr 29 21:25:54 volumio volumio[8202]: info: ControllerMpd::onStart: Initializing MPD Apr 29 21:25:54 volumio volumio[8202]: info: Creating MPD Configuration file Apr 29 21:25:54 volumio sudo[8333]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 29 21:25:54 volumio sudo[8333]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:54 volumio systemd[1]: Starting Music Player Daemon... Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 29 21:25:54 volumio volumio[8202]: info: [1745961954408] CoreMusicLibrary::Adding element Media Servers Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:54 volumio sudo[8333]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:54 volumio sudo[8336]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 29 21:25:54 volumio sudo[8336]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:54 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Apr 29 21:25:54 volumio systemd[1]: mpd.service: Succeeded. Apr 29 21:25:54 volumio systemd[1]: Stopped Music Player Daemon. Apr 29 21:25:54 volumio systemd[1]: Starting Music Player Daemon... Apr 29 21:25:54 volumio volumio[8202]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:54 volumio sudo[8347]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 29 21:25:54 volumio sudo[8347]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:54 volumio volumio[8202]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 29 21:25:54 volumio volumio[8202]: info: [1745961954445] CoreMusicLibrary::Adding element Last_100 Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 21:25:54 volumio sudo[8347]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 29 21:25:54 volumio volumio[8202]: info: [1745961954446] CoreMusicLibrary::Adding element Webradio Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 29 21:25:54 volumio volumio[8202]: info: Initializing BBC Radios Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 29 21:25:54 volumio volumio[8202]: info: [1745961954474] CoreMusicLibrary::Adding element YouTube2 Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 21:25:54 volumio volumio[8202]: Cannot find translation for source YouTube2 Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 29 21:25:54 volumio volumio[8202]: info: [1745961954476] CoreMusicLibrary::Adding element Radio Paradise Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 21:25:54 volumio volumio[8202]: Cannot find translation for source YouTube2 Apr 29 21:25:54 volumio volumio[8202]: Cannot find translation for source Radio Paradise Apr 29 21:25:54 volumio volumio[8202]: info: Volumio Calling Home Apr 29 21:25:54 volumio volumio[8202]: info: CoreStateMachine::setRepeat null single undefined Apr 29 21:25:54 volumio volumio[8202]: info: CoreStateMachine::pushState Apr 29 21:25:54 volumio volumio[8202]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::volumioPushState Apr 29 21:25:54 volumio volumio[8202]: info: CoreStateMachine::setRandom true Apr 29 21:25:54 volumio volumio[8202]: info: CoreStateMachine::pushState Apr 29 21:25:54 volumio volumio[8202]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::volumioPushState Apr 29 21:25:54 volumio volumio[8202]: info: VolumeController:: Volume=65 Mute =false Apr 29 21:25:54 volumio volumio[8202]: info: CoreStateMachine::pushState Apr 29 21:25:54 volumio volumio[8202]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::volumioPushState Apr 29 21:25:54 volumio volumio[8202]: info: CoreStateMachine::updateTrackBlock Apr 29 21:25:54 volumio volumio[8202]: info: CorePlayQueue::getTrackBlock Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::volumioRetrievevolume Apr 29 21:25:54 volumio volumio[8202]: info: MPD Permissions set Apr 29 21:25:54 volumio volumio[8202]: info: MPD Permissions set Apr 29 21:25:54 volumio volumio[8202]: 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 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 21:25:54 volumio volumio[8202]: info: VolumeController:: Volume=65 Mute =false Apr 29 21:25:54 volumio volumio[8202]: info: CoreStateMachine::pushState Apr 29 21:25:54 volumio volumio[8202]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:54 volumio volumio[8202]: info: CoreCommandRouter::volumioPushState Apr 29 21:25:54 volumio volumio[8202]: info: Starting Shairport Sync Apr 29 21:25:54 volumio volumio[8202]: info: Starting Shairport Sync Apr 29 21:25:54 volumio sudo[8384]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 29 21:25:54 volumio sudo[8384]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:54 volumio volumio[8202]: info: Starting Shairport Sync Apr 29 21:25:54 volumio sudo[8387]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 29 21:25:54 volumio sudo[8387]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:54 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 29 21:25:54 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 29 21:25:54 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 29 21:25:54 volumio sudo[8390]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 29 21:25:54 volumio sudo[8390]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:25:54 volumio mpd[8354]: Apr 29 21:25 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 29 21:25:54 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 29 21:25:54 volumio sudo[8387]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:54 volumio volumio[8202]: info: Shairport-Sync Started Apr 29 21:25:54 volumio sudo[8384]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:54 volumio volumio[8202]: Error adding Membership: Error: addMembership EINVAL Apr 29 21:25:54 volumio volumio[8202]: info: Shairport-Sync Started Apr 29 21:25:54 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 29 21:25:54 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 29 21:25:54 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 29 21:25:54 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 29 21:25:54 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 29 21:25:54 volumio sudo[8390]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:54 volumio volumio[8202]: info: Shairport-Sync Started Apr 29 21:25:54 volumio systemd[1]: Started Music Player Daemon. Apr 29 21:25:54 volumio sudo[8318]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:54 volumio sudo[8336]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:54 volumio volumio[8202]: info: Completed starting Core Plugins Apr 29 21:25:54 volumio volumio[8202]: info: ------------------------------------------- Apr 29 21:25:54 volumio volumio[8202]: info: ----- MyVolumio plugins startup ---- Apr 29 21:25:54 volumio volumio[8202]: info: ------------------------------------------- Apr 29 21:25:54 volumio volumio[8202]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 29 21:25:54 volumio volumio[8202]: error: MPD error: The expression evaluated to a falsy value: Apr 29 21:25:54 volumio volumio[8202]: assert.ok(self.idling) Apr 29 21:25:54 volumio volumio[8202]: error: The expression evaluated to a falsy value: Apr 29 21:25:54 volumio volumio[8202]: assert.ok(self.idling) Apr 29 21:25:54 volumio volumio[8202]: info: MPD running with PID8354 Apr 29 21:25:54 volumio volumio[8202]: ,establishing connection Apr 29 21:25:54 volumio volumio[8202]: error: updateQueue error: null Apr 29 21:25:54 volumio volumio[8202]: error: updateQueue error: null Apr 29 21:25:55 volumio volumio[8202]: verbose: New Socket.io Connection to 192.168.1.65 from 192.168.1.200 UA: Mozilla/5.0 (X11; Linux x86_64; rv:137.0) Gecko/20100101 Firefox/137.0 Engine version: 3 Transport: polling Total Clients: 4 Apr 29 21:25:55 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 29 21:25:55 volumio volumio[8202]: info: CoreCommandRouter::volumioGetVisibleSources Apr 29 21:25:55 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 21:25:55 volumio volumio[8202]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:55 volumio volumio[8202]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:55 volumio volumio[8202]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:55 volumio volumio[8202]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:55 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 29 21:25:55 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 29 21:25:55 volumio volumio[8202]: info: Received Get System Info Apr 29 21:25:55 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 21:25:55 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 21:25:55 volumio volumio[8202]: info: Discovery: Getting this device information Apr 29 21:25:55 volumio volumio[8202]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:55 volumio volumio[8202]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:55 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 21:25:55 volumio volumio[8202]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:55 volumio volumio[8202]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:55 volumio volumio[8202]: info: Listing playlists Apr 29 21:25:55 volumio volumio[8202]: info: CoreCommandRouter::volumioGetQueue Apr 29 21:25:55 volumio volumio[8202]: info: CoreStateMachine::getQueue Apr 29 21:25:55 volumio volumio[8202]: info: CorePlayQueue::getQueue Apr 29 21:25:56 volumio volumio[8202]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Apr 29 21:25:56 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 29 21:25:56 volumio volumio[8202]: info: CoreCommandRouter::volumioGetVisibleSources Apr 29 21:25:56 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 21:25:56 volumio volumio[8202]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:56 volumio volumio[8202]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:56 volumio volumio[8202]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:56 volumio volumio[8202]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:56 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 29 21:25:56 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 29 21:25:56 volumio volumio[8202]: info: Received Get System Info Apr 29 21:25:56 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 21:25:56 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 21:25:56 volumio volumio[8202]: info: Discovery: Getting this device information Apr 29 21:25:56 volumio volumio[8202]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:56 volumio volumio[8202]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:56 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 21:25:56 volumio volumio[8202]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:56 volumio volumio[8202]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:56 volumio volumio[8202]: info: Listing playlists Apr 29 21:25:57 volumio volumio-remote-updater[780]: [2025-04-29 21:25:57] [connect] Successful connection Apr 29 21:25:57 volumio volumio-remote-updater[780]: [2025-04-29 21:25:57] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1745961957 101 Apr 29 21:25:57 volumio volumio[8202]: 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: 6 Apr 29 21:25:58 volumio sudo[8243]: pam_unix(sudo:session): session closed for user root Apr 29 21:25:59 volumio volumio[8202]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:59 volumio volumio[8202]: info: CorePlayQueue::getTrack 0 Apr 29 21:25:59 volumio volumio[8202]: info: Discovery: adding 1e594295-a03d-4768-bce8-ca6711f04f30 Apr 29 21:25:59 volumio volumio[8202]: info: Discovery: Found device Volumio Apr 29 21:25:59 volumio volumio[8202]: info: CoreCommandRouter::volumioGetState Apr 29 21:25:59 volumio volumio[8202]: info: CorePlayQueue::getTrack 0 Apr 29 21:26:02 volumio volumio[8202]: Albumart Server FATAL ERROR: null Apr 29 21:26:02 volumio volumio[8202]: info: Volumio called home Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 29 21:26:03 volumio volumio[8202]: info: Adding plugin bluetooth to MyMusic Plugins Apr 29 21:26:03 volumio volumio[8202]: info: Adding plugin multiroom to MyMusic Plugins Apr 29 21:26:03 volumio volumio[8202]: info: Adding plugin metavolumio to MyMusic Plugins Apr 29 21:26:03 volumio volumio[8202]: info: Adding plugin cd_controller to MyMusic Plugins Apr 29 21:26:03 volumio volumio[8202]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 29 21:26:03 volumio volumio[8202]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 29 21:26:03 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:26:03 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:26:03 volumio volumio[8202]: info: Starting MyVolumio Remote Streaming Endpoints Apr 29 21:26:03 volumio volumio[8202]: info: MyVolumio login type: Token Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 29 21:26:03 volumio volumio[8202]: info: Starting Streaming Service Transparent Proxy Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 29 21:26:03 volumio volumio[8202]: info: Streaming services startup Apr 29 21:26:03 volumio volumio[8202]: info: Starting Streaming Daemon Apr 29 21:26:03 volumio sudo[8426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 29 21:26:03 volumio sudo[8426]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:26:03 volumio sudo[8426]: pam_unix(sudo:session): session closed for user root Apr 29 21:26:03 volumio volumio[8202]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Apr 29 21:26:03 volumio sudo[8433]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 29 21:26:03 volumio sudo[8433]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:26:03 volumio sudo[8433]: pam_unix(sudo:session): session closed for user root Apr 29 21:26:03 volumio sudo[8436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 29 21:26:03 volumio sudo[8436]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:26:03 volumio sudo[8436]: pam_unix(sudo:session): session closed for user root Apr 29 21:26:03 volumio volumio[8202]: error: Cannot start Volumio Streaming Daemon Apr 29 21:26:03 volumio volumio[8202]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 29 21:26:03 volumio volumio[8202]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 29 21:26:03 volumio sudo[8439]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 29 21:26:03 volumio sudo[8439]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:26:03 volumio sudo[8439]: pam_unix(sudo:session): session closed for user root Apr 29 21:26:03 volumio volumio[8202]: info: Upmpdcli Daemon Started Apr 29 21:26:03 volumio volumio[8202]: STREAMING PROXY: Starting server on port 3245 Apr 29 21:26:03 volumio volumio[8202]: Node JS runtime: 14 Apr 29 21:26:04 volumio volumio[8202]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 29 21:26:04 volumio volumio[8202]: info: MyVolumio token set successfully Apr 29 21:26:04 volumio volumio[8202]: info: MYVOLUMIO: Adding device Apr 29 21:26:04 volumio volumio[8202]: info: MYVOLUMIO: Evaluating Server Apr 29 21:26:04 volumio volumio[8202]: info: MyVolumio status changed Apr 29 21:26:04 volumio volumio[8202]: info: Streaming services startup Apr 29 21:26:04 volumio volumio[8202]: info: Starting Streaming Daemon Apr 29 21:26:04 volumio volumio[8202]: info: Removing browser output: myVolumio user plan is not superstar Apr 29 21:26:04 volumio volumio[8202]: info: Removing audio output: Apr 29 21:26:04 volumio volumio[8202]: info: Stoppping Tunnel 1 Apr 29 21:26:04 volumio sudo[8459]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 29 21:26:04 volumio sudo[8459]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:26:04 volumio sudo[8459]: pam_unix(sudo:session): session closed for user root Apr 29 21:26:04 volumio volumio[8202]: error: Cannot start Volumio Streaming Daemon Apr 29 21:26:04 volumio volumio[8202]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 29 21:26:04 volumio volumio[8202]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 29 21:26:04 volumio sudo[8462]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Apr 29 21:26:04 volumio sudo[8462]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 21:26:04 volumio sudo[8462]: pam_unix(sudo:session): session closed for user root Apr 29 21:26:04 volumio volumio[8202]: info: Remote SSH Stopped Apr 29 21:26:07 volumio volumio[8202]: Forking 3 albumart workers Apr 29 21:26:07 volumio volumio[8202]: Starting albumart workers Apr 29 21:26:07 volumio volumio[8202]: Starting albumart workers Apr 29 21:26:07 volumio volumio[8202]: Starting albumart workers Apr 29 21:26:10 volumio volumio[8202]: info: Setting Geolocation for MyVolumio to us2 Apr 29 21:26:10 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:26:10 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:26:10 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:26:10 volumio volumio[8202]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Apr 29 21:26:11 volumio volumio[8202]: info: Updating MyVolumio device info Apr 29 21:26:11 volumio volumio[8202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 21:26:11 volumio volumio[8202]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 29 21:26:14 volumio volumio[8202]: info: MYVOLUMIO: Adding device Apr 29 21:26:14 volumio volumio[8202]: info: MYVOLUMIO: Evaluating Server Apr 29 21:26:14 volumio volumio[8202]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 29 21:26:14 volumio volumio[8202]: TypeError: Cannot read property 'length' of undefined Apr 29 21:26:14 volumio volumio[8202]: at Client.frame (/volumio/node_modules/websocket-driver/lib/websocket/driver/hybi.js:205:45) Apr 29 21:26:14 volumio volumio[8202]: at Client. (/volumio/node_modules/websocket-driver/lib/websocket/driver/hybi.js:307:32) Apr 29 21:26:14 volumio volumio[8202]: at /volumio/node_modules/websocket-extensions/lib/pipeline/index.js:26:51 Apr 29 21:26:14 volumio volumio[8202]: at Pledge.then (/volumio/node_modules/websocket-extensions/lib/pipeline/pledge.js:27:23) Apr 29 21:26:14 volumio volumio[8202]: at Pipeline.close (/volumio/node_modules/websocket-extensions/lib/pipeline/index.js:26:24) Apr 29 21:26:14 volumio volumio[8202]: at Extensions.close (/volumio/node_modules/websocket-extensions/lib/websocket_extensions.js:142:20) Apr 29 21:26:14 volumio volumio[8202]: at Client._shutdown (/volumio/node_modules/websocket-driver/lib/websocket/driver/hybi.js:306:22) Apr 29 21:26:14 volumio volumio[8202]: at Client._fail (/volumio/node_modules/websocket-driver/lib/websocket/driver/hybi.js:316:10) Apr 29 21:26:14 volumio volumio[8202]: at Client. (/volumio/node_modules/websocket-driver/lib/websocket/driver/hybi.js:452:30) Apr 29 21:26:14 volumio volumio[8202]: at pipe (/volumio/node_modules/websocket-extensions/lib/pipeline/index.js:37:40) Apr 29 21:26:14 volumio volumio[8202]: at Pipeline._loop (/volumio/node_modules/websocket-extensions/lib/pipeline/index.js:44:3) Apr 29 21:26:14 volumio volumio[8202]: at Pipeline.processIncomingMessage (/volumio/node_modules/websocket-extensions/lib/pipeline/index.js:13:8) Apr 29 21:26:14 volumio volumio[8202]: at Extensions.processIncomingMessage (/volumio/node_modules/websocket-extensions/lib/websocket_extensions.js:133:20) Apr 29 21:26:14 volumio volumio[8202]: at Client._emitMessage (/volumio/node_modules/websocket-driver/lib/websocket/driver/hybi.js:451:22) Apr 29 21:26:14 volumio volumio[8202]: at Client._emitFrame (/volumio/node_modules/websocket-driver/lib/websocket/driver/hybi.js:411:19) Apr 29 21:26:14 volumio volumio[8202]: at Client.parse (/volumio/node_modules/websocket-driver/lib/websocket/driver/hybi.js:137:18) Apr 29 21:26:14 volumio volumio[8202]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 29 21:26:14 volumio sudo[8541]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-29 21:25 Apr 29 21:26:14 volumio sudo[8541]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 07:27:48 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4bc1ecb08f34ad14b420d6678a2aef1b"