-- Logs begin at Sun 2025-04-27 04:55:34 UTC, end at Sun 2025-04-27 07:04:17 UTC. -- Apr 27 07:03:19 volumio volumio[1161]: info: CorePlayQueue::getTrack 14 Apr 27 07:03:19 volumio volumio[1161]: info: CorePlayQueue::getTrack 15 Apr 27 07:03:19 volumio volumio[1161]: info: Prefetching next song Apr 27 07:03:19 volumio volumio[1161]: info: DOING PREFETCH IN MPD Apr 27 07:03:19 volumio volumio[1161]: verbose: ControllerMpd::sendMpdCommand add "USB/MEMORIA_USB/Bobby Cole - G Funk Hip Hop (2021)/16. Bobby Cole - Hip Hop Ligero.flac" Apr 27 07:03:19 volumio volumio[1161]: info: Apr 27 07:03:19 volumio volumio[1161]: ---------------------------- MPD announces system playlist update Apr 27 07:03:19 volumio volumio[1161]: info: Ignoring MPD Status Update Apr 27 07:03:19 volumio volumio[1161]: info: sendMpdCommand add "USB/MEMORIA_USB/Bobby Cole - G Funk Hip Hop (2021)/16. Bobby Cole - Hip Hop Ligero.flac" took 0 milliseconds Apr 27 07:03:19 volumio volumio-remote-updater[785]: [2025-04-27 07:03:19] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Apr 27 07:03:19 volumio volumio-remote-updater[785]: [2025-04-27 07:03:19] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Apr 27 07:03:19 volumio systemd[1]: volumio.service: Main process exited, code=killed, status=11/SEGV Apr 27 07:03:19 volumio systemd[1]: volumio.service: Failed with result 'signal'. Apr 27 07:03:19 volumio systemd[1]: Started dynamicswap service. Apr 27 07:03:20 volumio systemd[1]: dynamicswap.service: Succeeded. Apr 27 07:03:20 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Apr 27 07:03:20 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Apr 27 07:03:20 volumio systemd[1]: Started dynamicswap service. Apr 27 07:03:20 volumio systemd[1]: Stopped Volumio Backend Module. Apr 27 07:03:20 volumio systemd[1]: Started Volumio Backend Module. Apr 27 07:03:20 volumio systemd[1]: dynamicswap.service: Succeeded. Apr 27 07:03:20 volumio volumio[31371]: info: ------------------------------------------- Apr 27 07:03:20 volumio volumio[31371]: info: ----- Volumio3 ---- Apr 27 07:03:20 volumio volumio[31371]: info: ------------------------------------------- Apr 27 07:03:20 volumio volumio[31371]: info: ----- System startup ---- Apr 27 07:03:20 volumio volumio[31371]: info: ------------------------------------------- Apr 27 07:03:20 volumio volumio[31371]: info: MYVOLUMIO Environment detected Apr 27 07:03:20 volumio volumio[31371]: info: Plugin folders cleanup Apr 27 07:03:20 volumio volumio[31371]: info: Scanning into folder /volumio/app/plugins/ Apr 27 07:03:20 volumio volumio[31371]: info: Scanning category audio_interface Apr 27 07:03:20 volumio volumio[31371]: info: Scanning category miscellanea Apr 27 07:03:20 volumio volumio[31371]: info: Scanning category music_service Apr 27 07:03:20 volumio volumio[31371]: info: Scanning category plugins.json Apr 27 07:03:20 volumio volumio[31371]: info: Scanning category system_controller Apr 27 07:03:20 volumio volumio[31371]: info: Scanning category user_interface Apr 27 07:03:20 volumio volumio[31371]: info: Scanning into folder /data/plugins/ Apr 27 07:03:20 volumio volumio[31371]: info: Scanning category audio_interface Apr 27 07:03:20 volumio volumio[31371]: info: Scanning category music_service Apr 27 07:03:20 volumio volumio[31371]: info: Plugin folders cleanup completed Apr 27 07:03:20 volumio volumio[31371]: info: ------------------------------------------- Apr 27 07:03:20 volumio volumio[31371]: info: ----- Core plugins startup ---- Apr 27 07:03:20 volumio volumio[31371]: info: ------------------------------------------- Apr 27 07:03:20 volumio volumio[31371]: info: Loading plugins from folder /volumio/app/plugins/ Apr 27 07:03:20 volumio volumio[31371]: info: Adding plugin upnp to MyMusic Plugins Apr 27 07:03:20 volumio volumio[31371]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 27 07:03:20 volumio volumio[31371]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 27 07:03:20 volumio volumio[31371]: info: Loading plugins from folder /data/plugins/ Apr 27 07:03:20 volumio volumio[31371]: info: Loading plugin "system"... Apr 27 07:03:20 volumio volumio[31371]: info: Loading plugin "appearance"... Apr 27 07:03:20 volumio volumio[31371]: info: Loading plugin "network"... Apr 27 07:03:20 volumio volumio[31371]: info: Refreshing Cached IP Addresses Apr 27 07:03:20 volumio sudo[31398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 27 07:03:20 volumio sudo[31398]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:20 volumio sudo[31398]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:20 volumio sudo[31400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 27 07:03:20 volumio sudo[31400]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:20 volumio sudo[31400]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:20 volumio volumio[31371]: info: Loading plugin "services"... Apr 27 07:03:20 volumio volumio[31371]: info: Loading plugin "alsa_controller"... Apr 27 07:03:20 volumio sudo[31413]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 27 07:03:20 volumio sudo[31413]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:20 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 27 07:03:20 volumio volumio[31371]: info: Loading plugin "wizard"... Apr 27 07:03:20 volumio volumio[31371]: info: Loading plugin "networkfs"... Apr 27 07:03:20 volumio volumio[31371]: info: Starting Udev Watcher for removable devices Apr 27 07:03:20 volumio volumio[31371]: info: Mounting Device MEMORIA_USB Apr 27 07:03:20 volumio sudo[31429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdc1 /mnt/USB/MEMORIA_USB -o noatime Apr 27 07:03:20 volumio sudo[31429]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:21 volumio sudo[31429]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:21 volumio volumio[31371]: mount: /media/MEMORIA_USB: /dev/sdc1 already mounted on /media/MEMORIA_USB. Apr 27 07:03:21 volumio volumio[31371]: error: Failed to mount MEMORIA_USB: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sdc1" "/mnt/USB/MEMORIA_USB" -o noatime Apr 27 07:03:21 volumio volumio[31371]: mount: /media/MEMORIA_USB: /dev/sdc1 already mounted on /media/MEMORIA_USB. Apr 27 07:03:21 volumio volumio[31371]: info: Ignoring mount for partition: boot Apr 27 07:03:21 volumio volumio[31371]: info: Ignoring mount for partition: volumio Apr 27 07:03:21 volumio volumio[31371]: info: Ignoring mount for partition: volumio_data Apr 27 07:03:21 volumio volumio[31371]: info: Ignoring mount for partition: efi-boot Apr 27 07:03:21 volumio volumio[31371]: info: Ignoring mount for partition: DaphileBoot Apr 27 07:03:21 volumio volumio[31371]: info: Ignoring mount for partition: DaphileData Apr 27 07:03:21 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 27 07:03:21 volumio volumio[31371]: info: Loading plugin "volumio_command_line_client"... Apr 27 07:03:21 volumio volumio[31371]: info: Loading plugin "upnp"... Apr 27 07:03:21 volumio volumio[31371]: info: [1745737401033] Starting Upmpd Daemon Apr 27 07:03:21 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 27 07:03:21 volumio volumio[31371]: info: Loading plugin "my_music"... Apr 27 07:03:21 volumio volumio[31371]: info: Loading plugin "mpd"... Apr 27 07:03:21 volumio volumio[31371]: info: Loading plugin "upnp_browser"... Apr 27 07:03:21 volumio volumio[31371]: info: Loading plugin "alarm-clock"... Apr 27 07:03:21 volumio volumio[31371]: info: Loading plugin "airplay_emulation"... Apr 27 07:03:21 volumio volumio[31371]: info: Starting Shairport Sync Apr 27 07:03:21 volumio volumio[31371]: info: Loading plugin "last_100"... Apr 27 07:03:21 volumio volumio[31371]: info: Loading plugin "webradio"... Apr 27 07:03:21 volumio volumio[31371]: info: Loading plugin "i2s_dacs"... Apr 27 07:03:21 volumio volumio[31371]: info: I2S DAC not set, start Auto-detection Apr 27 07:03:21 volumio volumio[31371]: info: Loading plugin "volumiodiscovery"... Apr 27 07:03:21 volumio volumio[31371]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 27 07:03:21 volumio volumio[31371]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 27 07:03:21 volumio volumio[31371]: *** WARNING *** For more information see Apr 27 07:03:21 volumio volumio[31371]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 27 07:03:21 volumio node[31371]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 27 07:03:21 volumio volumio[31371]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 27 07:03:21 volumio volumio[31371]: *** WARNING *** For more information see Apr 27 07:03:21 volumio node[31371]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 27 07:03:21 volumio node[31371]: *** WARNING *** For more information see Apr 27 07:03:21 volumio node[31371]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 27 07:03:21 volumio node[31371]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 27 07:03:21 volumio node[31371]: *** WARNING *** For more information see Apr 27 07:03:21 volumio volumio[31371]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 27 07:03:21 volumio volumio[31371]: info: Discovery: Started advertising with name: Volumio Apr 27 07:03:21 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 27 07:03:21 volumio volumio[31371]: info: Loading plugin "youtube2"... Apr 27 07:03:21 volumio volumio[31371]: info: Loading plugin "outputs"... Apr 27 07:03:21 volumio volumio[31371]: info: Loading plugin "albumart"... Apr 27 07:03:21 volumio volumio[31371]: info: Plugin example_plugin is not enabled Apr 27 07:03:21 volumio volumio[31371]: info: Loading plugin "inputs"... Apr 27 07:03:21 volumio volumio[31371]: info: Loading plugin "updater_comm"... Apr 27 07:03:21 volumio volumio[31371]: info: Plugin mpdemulation is not enabled Apr 27 07:03:21 volumio volumio[31371]: info: Loading plugin "rest_api"... Apr 27 07:03:21 volumio volumio[31371]: info: Loading plugin "websocket"... Apr 27 07:03:21 volumio volumio[31371]: info: Starting Socket.io Server version 2.3.0 Apr 27 07:03:21 volumio volumio[31371]: info: Loading plugin "fusiondsp"... Apr 27 07:03:21 volumio volumio[31371]: Forking 3 albumart workers Apr 27 07:03:21 volumio volumio[31371]: info: Applying required configuration parameters for plugin fusiondsp Apr 27 07:03:21 volumio volumio[31371]: info: Loading plugin "radio_paradise"... Apr 27 07:03:21 volumio volumio[31371]: info: Applying required configuration parameters for plugin radio_paradise Apr 27 07:03:21 volumio volumio[31371]: info: [1745737401834] [RadioParadise] API delay: 5 Apr 27 07:03:21 volumio volumio[31371]: info: Loading i18n strings for locale es Apr 27 07:03:21 volumio volumio[31371]: Updating browse sources language Apr 27 07:03:21 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 07:03:21 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 27 07:03:21 volumio volumio[31371]: info: CoreCommandRouter::initPlayerControls Apr 27 07:03:21 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:21 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:21 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:21 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:21 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:21 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:21 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:21 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:21 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 27 07:03:21 volumio volumio[31371]: Starting albumart workers Apr 27 07:03:21 volumio volumio[31371]: Express server listening on port 3000 Apr 27 07:03:21 volumio volumio[31371]: [Metrics] WebUI: 1s 545.41ms Apr 27 07:03:21 volumio volumio[31371]: info: Setting Device type: x86 Apr 27 07:03:21 volumio volumio[31371]: Starting albumart workers Apr 27 07:03:21 volumio volumio[31371]: info: CoreStateMachine::resetVolumioState Apr 27 07:03:21 volumio volumio[31371]: info: CoreStateMachine::getcurrentVolume Apr 27 07:03:21 volumio volumio[31371]: info: CoreCommandRouter::volumioRetrievevolume Apr 27 07:03:21 volumio volumio[31371]: Starting albumart workers Apr 27 07:03:21 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:03:21 volumio volumio[31371]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Apr 27 07:03:21 volumio volumio[31371]: info: Completed loading Core Plugins Apr 27 07:03:21 volumio volumio[31371]: info: Preparing to generate the ALSA configuration file Apr 27 07:03:21 volumio volumio[31371]: info: Volumio Network Manager: Network status updated: 2 Apr 27 07:03:21 volumio volumio[31371]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Apr 27 07:03:21 volumio volumio[31371]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 27 07:03:21 volumio volumio[31371]: info: Reading ALSA contributions from plugins. Apr 27 07:03:22 volumio volumio[31371]: 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 27 07:03:22 volumio volumio[31371]: 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 27 07:03:22 volumio volumio[31371]: info: Reloading queue from file Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 27 07:03:22 volumio volumio[31371]: info: VolumeController:: Volume=67 Mute =false Apr 27 07:03:22 volumio volumio[31371]: info: CoreStateMachine::pushState Apr 27 07:03:22 volumio volumio[31371]: info: CorePlayQueue::getTrack 0 Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::volumioPushState Apr 27 07:03:22 volumio volumio[31371]: info: CoreStateMachine::updateTrackBlock Apr 27 07:03:22 volumio volumio[31371]: info: CorePlayQueue::getTrackBlock Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::volumioRetrievevolume Apr 27 07:03:22 volumio volumio[31371]: info: CoreStateMachine::setRepeat null single undefined Apr 27 07:03:22 volumio volumio[31371]: info: CoreStateMachine::pushState Apr 27 07:03:22 volumio volumio[31371]: info: CorePlayQueue::getTrack 0 Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::volumioPushState Apr 27 07:03:22 volumio volumio[31371]: info: CoreStateMachine::setRandom null Apr 27 07:03:22 volumio volumio[31371]: info: CoreStateMachine::pushState Apr 27 07:03:22 volumio volumio[31371]: info: CorePlayQueue::getTrack 0 Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::volumioPushState Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::volumioGetVisibleSources Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::volumioGetState Apr 27 07:03:22 volumio volumio[31371]: info: CorePlayQueue::getTrack 0 Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::volumioGetQueue Apr 27 07:03:22 volumio volumio[31371]: info: CoreStateMachine::getQueue Apr 27 07:03:22 volumio volumio[31371]: info: CorePlayQueue::getQueue Apr 27 07:03:22 volumio volumio[31371]: info: Listing playlists Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 27 07:03:22 volumio volumio[31371]: info: Received Get System Info Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 07:03:22 volumio volumio[31371]: info: Discovery: Getting this device information Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::volumioGetState Apr 27 07:03:22 volumio volumio[31371]: info: CorePlayQueue::getTrack 0 Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::volumioGetState Apr 27 07:03:22 volumio volumio[31371]: info: CorePlayQueue::getTrack 0 Apr 27 07:03:22 volumio volumio[31371]: info: VolumeController:: Volume=67 Mute =false Apr 27 07:03:22 volumio volumio[31371]: info: CoreStateMachine::pushState Apr 27 07:03:22 volumio volumio[31371]: info: CorePlayQueue::getTrack 0 Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::volumioPushState Apr 27 07:03:22 volumio volumio[31371]: info: Asound.conf file unchanged, so no further update is needed Apr 27 07:03:22 volumio volumio[31371]: info: Output device has changed, restarting MPD Apr 27 07:03:22 volumio sudo[31504]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 27 07:03:22 volumio sudo[31504]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:22 volumio sudo[31504]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:22 volumio volumio[31371]: info: Output device has changed, restarting Shairport Sync Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:03:22 volumio sudo[31508]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 27 07:03:22 volumio sudo[31508]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:22 volumio systemd[1]: Stopping Music Player Daemon... Apr 27 07:03:22 volumio volumio[31371]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 27 07:03:22 volumio volumio[31371]: info: ___________ START PLUGINS ___________ Apr 27 07:03:22 volumio volumio[31371]: info: ControllerMpd::onStart: Initializing MPD Apr 27 07:03:22 volumio volumio[31371]: info: Creating MPD Configuration file Apr 27 07:03:22 volumio systemd[1]: mpd.service: Succeeded. Apr 27 07:03:22 volumio systemd[1]: Stopped Music Player Daemon. Apr 27 07:03:22 volumio sudo[31515]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 27 07:03:22 volumio sudo[31515]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 27 07:03:22 volumio volumio[31371]: info: [1745737402169] CoreMusicLibrary::Adding element Media Servers Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:03:22 volumio sudo[31515]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:22 volumio systemd[1]: Starting Music Player Daemon... Apr 27 07:03:22 volumio sudo[31518]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 27 07:03:22 volumio sudo[31518]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:22 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Apr 27 07:03:22 volumio systemd[1]: mpd.service: Succeeded. Apr 27 07:03:22 volumio systemd[1]: Stopped Music Player Daemon. Apr 27 07:03:22 volumio systemd[1]: Starting Music Player Daemon... Apr 27 07:03:22 volumio volumio[31371]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 27 07:03:22 volumio volumio[31371]: info: [1745737402200] CoreMusicLibrary::Adding element Last_100 Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 27 07:03:22 volumio volumio[31371]: info: [1745737402201] CoreMusicLibrary::Adding element Webradio Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 27 07:03:22 volumio volumio[31371]: info: Initializing BBC Radios Apr 27 07:03:22 volumio sudo[31523]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 27 07:03:22 volumio sudo[31523]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:22 volumio sudo[31523]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 27 07:03:22 volumio volumio[31371]: info: [1745737402230] CoreMusicLibrary::Adding element YouTube2 Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 07:03:22 volumio volumio[31371]: Cannot find translation for source YouTube2 Apr 27 07:03:22 volumio volumio[31371]: info: Loading i18n strings for locale es Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: FusionDsp - mixtype--------------------- Hardware Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 27 07:03:22 volumio volumio[31371]: info: [1745737402235] CoreMusicLibrary::Adding element Radio Paradise Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 07:03:22 volumio volumio[31371]: Cannot find translation for source YouTube2 Apr 27 07:03:22 volumio volumio[31371]: Cannot find translation for source Radio Paradise Apr 27 07:03:22 volumio volumio[31371]: info: Volumio Calling Home Apr 27 07:03:22 volumio volumio[31371]: info: Preparing to generate the ALSA configuration file Apr 27 07:03:22 volumio volumio[31371]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 27 07:03:22 volumio volumio[31371]: info: Reading ALSA contributions from plugins. Apr 27 07:03:22 volumio volumio[31371]: info: MPD Permissions set Apr 27 07:03:22 volumio volumio[31371]: info: MPD Permissions set Apr 27 07:03:22 volumio volumio[31371]: 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 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: Starting Shairport Sync Apr 27 07:03:22 volumio volumio[31371]: info: Starting Shairport Sync Apr 27 07:03:22 volumio sudo[31555]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 27 07:03:22 volumio sudo[31555]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:22 volumio volumio[31371]: info: Starting Shairport Sync Apr 27 07:03:22 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 27 07:03:22 volumio sudo[31558]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 27 07:03:22 volumio sudo[31558]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:22 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 27 07:03:22 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 27 07:03:22 volumio volumio[31371]: info: Asound.conf file unchanged, so no further update is needed Apr 27 07:03:22 volumio volumio[31371]: info: Output device has changed, restarting MPD Apr 27 07:03:22 volumio sudo[31561]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 27 07:03:22 volumio sudo[31561]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:22 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 27 07:03:22 volumio volumio[31371]: info: Output device has changed, restarting Shairport Sync Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:03:22 volumio sudo[31565]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 27 07:03:22 volumio sudo[31565]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:22 volumio sudo[31565]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:22 volumio sudo[31568]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 27 07:03:22 volumio sudo[31568]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:22 volumio sudo[31555]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:22 volumio volumio[31371]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 27 07:03:22 volumio volumio[31371]: info: MPD Permissions set Apr 27 07:03:22 volumio volumio[31371]: info: Shairport-Sync Started Apr 27 07:03:22 volumio sudo[31558]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:22 volumio volumio[31371]: Error adding Membership: Error: addMembership EINVAL Apr 27 07:03:22 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 27 07:03:22 volumio volumio[31371]: info: Shairport-Sync Started Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 27 07:03:22 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 27 07:03:22 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 27 07:03:22 volumio systemd[1]: mpd.service: Succeeded. Apr 27 07:03:22 volumio systemd[1]: Stopped Music Player Daemon. Apr 27 07:03:22 volumio systemd[1]: Starting Music Player Daemon... Apr 27 07:03:22 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 27 07:03:22 volumio sudo[31561]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 27 07:03:22 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:22 volumio volumio[31371]: info: Shairport-Sync Started Apr 27 07:03:22 volumio volumio[31371]: info: Starting Shairport Sync Apr 27 07:03:22 volumio sudo[31574]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 27 07:03:22 volumio sudo[31574]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:22 volumio sudo[31574]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:22 volumio sudo[31585]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 27 07:03:22 volumio sudo[31585]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:22 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 27 07:03:22 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 27 07:03:22 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 27 07:03:22 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 27 07:03:22 volumio sudo[31585]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:22 volumio volumio[31371]: info: Shairport-Sync Started Apr 27 07:03:22 volumio mpd[31588]: Apr 27 07:03 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 27 07:03:22 volumio systemd[1]: Started Music Player Daemon. Apr 27 07:03:22 volumio sudo[31518]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:22 volumio sudo[31508]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:22 volumio sudo[31568]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:22 volumio volumio[31371]: info: Completed starting Core Plugins Apr 27 07:03:22 volumio volumio[31371]: info: ------------------------------------------- Apr 27 07:03:22 volumio volumio[31371]: info: ----- MyVolumio plugins startup ---- Apr 27 07:03:22 volumio volumio[31371]: info: ------------------------------------------- Apr 27 07:03:22 volumio volumio[31371]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 27 07:03:22 volumio volumio[31371]: error: MPD error: The expression evaluated to a falsy value: Apr 27 07:03:22 volumio volumio[31371]: assert.ok(self.idling) Apr 27 07:03:22 volumio volumio[31371]: error: The expression evaluated to a falsy value: Apr 27 07:03:22 volumio volumio[31371]: assert.ok(self.idling) Apr 27 07:03:22 volumio volumio[31371]: error: MPD error: The expression evaluated to a falsy value: Apr 27 07:03:22 volumio volumio[31371]: assert.ok(self.idling) Apr 27 07:03:22 volumio volumio[31371]: error: The expression evaluated to a falsy value: Apr 27 07:03:22 volumio volumio[31371]: assert.ok(self.idling) Apr 27 07:03:22 volumio volumio[31371]: error: updateQueue error: null Apr 27 07:03:22 volumio volumio[31371]: info: MPD running with PID31588 Apr 27 07:03:22 volumio volumio[31371]: ,establishing connection Apr 27 07:03:22 volumio volumio[31371]: error: updateQueue error: null Apr 27 07:03:24 volumio volumio[31371]: 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 27 07:03:24 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 27 07:03:24 volumio volumio[31371]: info: CoreCommandRouter::volumioGetVisibleSources Apr 27 07:03:24 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 07:03:24 volumio volumio[31371]: info: CoreCommandRouter::volumioGetState Apr 27 07:03:24 volumio volumio[31371]: info: CorePlayQueue::getTrack 0 Apr 27 07:03:24 volumio volumio[31371]: info: CoreCommandRouter::volumioGetState Apr 27 07:03:24 volumio volumio[31371]: info: CorePlayQueue::getTrack 0 Apr 27 07:03:24 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 27 07:03:24 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 27 07:03:24 volumio volumio[31371]: info: Received Get System Info Apr 27 07:03:24 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 07:03:24 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 07:03:24 volumio volumio[31371]: info: Discovery: Getting this device information Apr 27 07:03:24 volumio volumio[31371]: info: CoreCommandRouter::volumioGetState Apr 27 07:03:24 volumio volumio[31371]: info: CorePlayQueue::getTrack 0 Apr 27 07:03:24 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 07:03:24 volumio volumio[31371]: info: CoreCommandRouter::volumioGetState Apr 27 07:03:24 volumio volumio[31371]: info: CorePlayQueue::getTrack 0 Apr 27 07:03:24 volumio volumio[31371]: info: Listing playlists Apr 27 07:03:24 volumio volumio[31371]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 07:03:24 volumio volumio[31371]: info: FusionDsp - no preset used Apr 27 07:03:24 volumio volumio[31371]: info: FusionDsp - kef.json,test.json Apr 27 07:03:24 volumio volumio[31371]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 07:03:24 volumio volumio[31371]: info: FusionDsp - no preset used Apr 27 07:03:24 volumio volumio[31371]: info: FusionDsp - kef.json,test.json Apr 27 07:03:24 volumio volumio[31371]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Apr 27 07:03:24 volumio volumio[31371]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Apr 27 07:03:24 volumio volumio[31371]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Apr 27 07:03:24 volumio volumio[31371]: info: camilladsp service started and running in background, instance 1 Apr 27 07:03:24 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:24 volumio volumio[31371]: cannot open device 'volumioHw': Device or resource busy Apr 27 07:03:24 volumio volumio[31371]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Apr 27 07:03:24 volumio volumio[31371]: cannot open device 'volumioHw': Device or resource busy Apr 27 07:03:24 volumio volumio[31371]: info: FusionDsp loaded Apr 27 07:03:24 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 07:03:24 volumio sudo[31612]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Apr 27 07:03:24 volumio sudo[31612]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:24 volumio volumio[31371]: info: FusionDsp - Reporting Fusion DSP Enabled Apr 27 07:03:24 volumio volumio[31371]: info: Adding Signal Path Element [object Object] Apr 27 07:03:24 volumio volumio[31371]: info: Adding fusiondspeq DSP Signal Path Element Apr 27 07:03:24 volumio volumio[31371]: info: FusionDsp - ---- installed callbackRead Apr 27 07:03:24 volumio sudo[31612]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:24 volumio volumio[31371]: error: FusionDsp - File size not found in array! Apr 27 07:03:24 volumio volumio[31371]: info: FusionDsp - crossfeed chumoy Apr 27 07:03:24 volumio volumio[31371]: info: FusionDsp - Loudness is ON true Apr 27 07:03:24 volumio volumio[31371]: info: FusionDsp - Nulleq applied Apr 27 07:03:24 volumio volumio-remote-updater[785]: [2025-04-27 07:03:24] [connect] Successful connection Apr 27 07:03:24 volumio volumio-remote-updater[785]: [2025-04-27 07:03:24] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1745737404 101 Apr 27 07:03:24 volumio volumio[31371]: 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: 5 Apr 27 07:03:25 volumio sudo[31413]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:27 volumio volumio[31371]: info: Discovery: adding 1e594295-a03d-4768-bce8-ca6711f04f30 Apr 27 07:03:27 volumio volumio[31371]: info: Discovery: Found device Volumio Apr 27 07:03:27 volumio volumio[31371]: info: CoreCommandRouter::volumioGetState Apr 27 07:03:27 volumio volumio[31371]: info: CorePlayQueue::getTrack 0 Apr 27 07:03:27 volumio volumio[31371]: info: CoreCommandRouter::volumioGetState Apr 27 07:03:27 volumio volumio[31371]: info: CorePlayQueue::getTrack 0 Apr 27 07:03:27 volumio volumio[31371]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Apr 27 07:03:27 volumio volumio[31371]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 27 07:03:28 volumio volumio[31371]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 07:03:28 volumio volumio[31371]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 07:03:28 volumio volumio[31371]: info: FusionDsp - no preset used Apr 27 07:03:28 volumio volumio[31371]: info: FusionDsp - no preset used Apr 27 07:03:28 volumio volumio[31371]: info: FusionDsp - kef.json,test.json Apr 27 07:03:28 volumio volumio[31371]: info: FusionDsp - kef.json,test.json Apr 27 07:03:30 volumio volumio[31371]: Worker 1 died :( Apr 27 07:03:30 volumio volumio[31371]: Starting albumart workers Apr 27 07:03:30 volumio volumio[31371]: info: Volumio called home Apr 27 07:03:31 volumio sudo[31647]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 27 07:03:31 volumio sudo[31647]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:31 volumio sudo[31647]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:31 volumio sudo[31650]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 27 07:03:31 volumio sudo[31650]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:31 volumio sudo[31650]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:31 volumio sudo[31653]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 27 07:03:31 volumio sudo[31653]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:31 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Apr 27 07:03:31 volumio sudo[31653]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:31 volumio volumio[31371]: info: Upmpdcli Daemon Started Apr 27 07:03:31 volumio volumio[31655]: writing RSA key Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 27 07:03:31 volumio volumio[31371]: info: Adding plugin bluetooth to MyMusic Plugins Apr 27 07:03:31 volumio volumio[31371]: info: Adding plugin multiroom to MyMusic Plugins Apr 27 07:03:31 volumio volumio[31371]: info: Adding plugin metavolumio to MyMusic Plugins Apr 27 07:03:31 volumio volumio[31371]: info: Adding plugin cd_controller to MyMusic Plugins Apr 27 07:03:31 volumio volumio[31371]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 27 07:03:31 volumio volumio[31371]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 27 07:03:31 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:03:31 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:03:31 volumio volumio[31371]: info: Starting MyVolumio Remote Streaming Endpoints Apr 27 07:03:31 volumio volumio[31371]: info: MyVolumio login type: Token Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 27 07:03:31 volumio volumio[31371]: info: Starting Streaming Service Transparent Proxy Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 27 07:03:31 volumio volumio[31371]: info: Streaming services startup Apr 27 07:03:31 volumio volumio[31371]: info: Starting Streaming Daemon Apr 27 07:03:31 volumio sudo[31693]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 27 07:03:31 volumio sudo[31693]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:31 volumio sudo[31693]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:31 volumio volumio[31371]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Apr 27 07:03:31 volumio volumio[31371]: error: Cannot start Volumio Streaming Daemon Apr 27 07:03:31 volumio volumio[31371]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 27 07:03:31 volumio volumio[31371]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 27 07:03:31 volumio volumio[31371]: STREAMING PROXY: Starting server on port 3245 Apr 27 07:03:31 volumio volumio[31371]: Node JS runtime: 14 Apr 27 07:03:31 volumio volumio[31371]: error: MyVolumio Custom Token format not valid, refreshing it Apr 27 07:03:32 volumio volumio[31371]: info: MyVolumio login type: Token Apr 27 07:03:33 volumio volumio[31371]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 27 07:03:33 volumio volumio[31371]: info: MyVolumio token set successfully Apr 27 07:03:33 volumio volumio[31371]: info: MYVOLUMIO: Adding device Apr 27 07:03:33 volumio volumio[31371]: info: MYVOLUMIO: Evaluating Server Apr 27 07:03:33 volumio volumio[31371]: info: MyVolumio status changed Apr 27 07:03:33 volumio volumio[31371]: info: Streaming services startup Apr 27 07:03:33 volumio volumio[31371]: info: Starting Streaming Daemon Apr 27 07:03:34 volumio volumio[31371]: info: Removing browser output: myVolumio user plan is not superstar Apr 27 07:03:34 volumio volumio[31371]: info: Removing audio output: Apr 27 07:03:34 volumio volumio[31371]: info: Stoppping Tunnel 1 Apr 27 07:03:34 volumio sudo[31717]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 27 07:03:34 volumio sudo[31717]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:34 volumio sudo[31717]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:34 volumio volumio[31371]: error: Cannot start Volumio Streaming Daemon Apr 27 07:03:34 volumio volumio[31371]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 27 07:03:34 volumio volumio[31371]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 27 07:03:34 volumio sudo[31720]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Apr 27 07:03:34 volumio sudo[31720]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:34 volumio sudo[31720]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:34 volumio volumio[31371]: info: Remote SSH Stopped Apr 27 07:03:39 volumio volumio[31371]: info: Setting Geolocation for MyVolumio to us2 Apr 27 07:03:39 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:03:39 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:03:39 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:03:39 volumio volumio[31371]: error: Streaming Proxy Server FATAL ERROR: null Apr 27 07:03:40 volumio volumio[31371]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Apr 27 07:03:40 volumio volumio[31371]: info: Updating MyVolumio device info Apr 27 07:03:40 volumio volumio[31371]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:03:40 volumio volumio[31371]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 27 07:03:44 volumio volumio[31371]: info: MYVOLUMIO: Adding device Apr 27 07:03:44 volumio volumio[31371]: info: MYVOLUMIO: Evaluating Server Apr 27 07:03:44 volumio volumio-remote-updater[785]: [2025-04-27 07:03:44] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Apr 27 07:03:44 volumio volumio-remote-updater[785]: [2025-04-27 07:03:44] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Apr 27 07:03:44 volumio systemd[1]: volumio.service: Main process exited, code=killed, status=11/SEGV Apr 27 07:03:44 volumio systemd[1]: volumio.service: Failed with result 'signal'. Apr 27 07:03:44 volumio systemd[1]: Started dynamicswap service. Apr 27 07:03:44 volumio systemd[1]: dynamicswap.service: Succeeded. Apr 27 07:03:44 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Apr 27 07:03:44 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Apr 27 07:03:44 volumio systemd[1]: Started dynamicswap service. Apr 27 07:03:44 volumio systemd[1]: Stopped Volumio Backend Module. Apr 27 07:03:44 volumio systemd[1]: Started Volumio Backend Module. Apr 27 07:03:44 volumio systemd[1]: dynamicswap.service: Succeeded. Apr 27 07:03:44 volumio volumio[31792]: info: ------------------------------------------- Apr 27 07:03:44 volumio volumio[31792]: info: ----- Volumio3 ---- Apr 27 07:03:44 volumio volumio[31792]: info: ------------------------------------------- Apr 27 07:03:44 volumio volumio[31792]: info: ----- System startup ---- Apr 27 07:03:44 volumio volumio[31792]: info: ------------------------------------------- Apr 27 07:03:44 volumio volumio[31792]: info: MYVOLUMIO Environment detected Apr 27 07:03:44 volumio volumio[31792]: info: Plugin folders cleanup Apr 27 07:03:44 volumio volumio[31792]: info: Scanning into folder /volumio/app/plugins/ Apr 27 07:03:44 volumio volumio[31792]: info: Scanning category audio_interface Apr 27 07:03:44 volumio volumio[31792]: info: Scanning category miscellanea Apr 27 07:03:44 volumio volumio[31792]: info: Scanning category music_service Apr 27 07:03:44 volumio volumio[31792]: info: Scanning category plugins.json Apr 27 07:03:44 volumio volumio[31792]: info: Scanning category system_controller Apr 27 07:03:44 volumio volumio[31792]: info: Scanning category user_interface Apr 27 07:03:44 volumio volumio[31792]: info: Scanning into folder /data/plugins/ Apr 27 07:03:44 volumio volumio[31792]: info: Scanning category audio_interface Apr 27 07:03:44 volumio volumio[31792]: info: Scanning category music_service Apr 27 07:03:44 volumio volumio[31792]: info: Plugin folders cleanup completed Apr 27 07:03:44 volumio volumio[31792]: info: ------------------------------------------- Apr 27 07:03:44 volumio volumio[31792]: info: ----- Core plugins startup ---- Apr 27 07:03:44 volumio volumio[31792]: info: ------------------------------------------- Apr 27 07:03:44 volumio volumio[31792]: info: Loading plugins from folder /volumio/app/plugins/ Apr 27 07:03:44 volumio volumio[31792]: info: Adding plugin upnp to MyMusic Plugins Apr 27 07:03:44 volumio volumio[31792]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 27 07:03:44 volumio volumio[31792]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 27 07:03:44 volumio volumio[31792]: info: Loading plugins from folder /data/plugins/ Apr 27 07:03:44 volumio volumio[31792]: info: Loading plugin "system"... Apr 27 07:03:44 volumio volumio[31792]: info: Loading plugin "appearance"... Apr 27 07:03:44 volumio volumio[31792]: info: Loading plugin "network"... Apr 27 07:03:44 volumio volumio[31792]: info: Refreshing Cached IP Addresses Apr 27 07:03:44 volumio sudo[31818]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 27 07:03:44 volumio sudo[31818]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:44 volumio sudo[31818]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:44 volumio sudo[31820]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 27 07:03:44 volumio sudo[31820]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:44 volumio sudo[31820]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:44 volumio volumio[31792]: info: Loading plugin "services"... Apr 27 07:03:44 volumio volumio[31792]: info: Loading plugin "alsa_controller"... Apr 27 07:03:44 volumio sudo[31833]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 27 07:03:44 volumio sudo[31833]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:45 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 27 07:03:45 volumio volumio[31792]: info: Loading plugin "wizard"... Apr 27 07:03:45 volumio volumio[31792]: info: Loading plugin "networkfs"... Apr 27 07:03:45 volumio volumio[31792]: info: Starting Udev Watcher for removable devices Apr 27 07:03:45 volumio volumio[31792]: info: Mounting Device MEMORIA_USB Apr 27 07:03:45 volumio sudo[31849]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdc1 /mnt/USB/MEMORIA_USB -o noatime Apr 27 07:03:45 volumio sudo[31849]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:45 volumio sudo[31849]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:45 volumio volumio[31792]: mount: /media/MEMORIA_USB: /dev/sdc1 already mounted on /media/MEMORIA_USB. Apr 27 07:03:45 volumio volumio[31792]: error: Failed to mount MEMORIA_USB: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sdc1" "/mnt/USB/MEMORIA_USB" -o noatime Apr 27 07:03:45 volumio volumio[31792]: mount: /media/MEMORIA_USB: /dev/sdc1 already mounted on /media/MEMORIA_USB. Apr 27 07:03:45 volumio volumio[31792]: info: Ignoring mount for partition: boot Apr 27 07:03:45 volumio volumio[31792]: info: Ignoring mount for partition: volumio Apr 27 07:03:45 volumio volumio[31792]: info: Ignoring mount for partition: volumio_data Apr 27 07:03:45 volumio volumio[31792]: info: Ignoring mount for partition: efi-boot Apr 27 07:03:45 volumio volumio[31792]: info: Ignoring mount for partition: DaphileBoot Apr 27 07:03:45 volumio volumio[31792]: info: Ignoring mount for partition: DaphileData Apr 27 07:03:45 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 27 07:03:45 volumio volumio[31792]: info: Loading plugin "volumio_command_line_client"... Apr 27 07:03:45 volumio volumio[31792]: info: Loading plugin "upnp"... Apr 27 07:03:45 volumio volumio[31792]: info: [1745737425062] Starting Upmpd Daemon Apr 27 07:03:45 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 27 07:03:45 volumio volumio[31792]: info: Loading plugin "my_music"... Apr 27 07:03:45 volumio volumio[31792]: info: Loading plugin "mpd"... Apr 27 07:03:45 volumio volumio[31792]: info: Loading plugin "upnp_browser"... Apr 27 07:03:45 volumio volumio[31792]: info: Loading plugin "alarm-clock"... Apr 27 07:03:45 volumio volumio[31792]: info: Loading plugin "airplay_emulation"... Apr 27 07:03:45 volumio volumio[31792]: info: Starting Shairport Sync Apr 27 07:03:45 volumio volumio[31792]: info: Loading plugin "last_100"... Apr 27 07:03:45 volumio volumio[31792]: info: Loading plugin "webradio"... Apr 27 07:03:45 volumio volumio[31792]: info: Loading plugin "i2s_dacs"... Apr 27 07:03:45 volumio volumio[31792]: info: I2S DAC not set, start Auto-detection Apr 27 07:03:45 volumio volumio[31792]: info: Loading plugin "volumiodiscovery"... Apr 27 07:03:45 volumio volumio[31792]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 27 07:03:45 volumio volumio[31792]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 27 07:03:45 volumio volumio[31792]: *** WARNING *** For more information see Apr 27 07:03:45 volumio volumio[31792]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 27 07:03:45 volumio volumio[31792]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 27 07:03:45 volumio volumio[31792]: *** WARNING *** For more information see Apr 27 07:03:45 volumio node[31792]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 27 07:03:45 volumio node[31792]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 27 07:03:45 volumio node[31792]: *** WARNING *** For more information see Apr 27 07:03:45 volumio node[31792]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 27 07:03:45 volumio node[31792]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 27 07:03:45 volumio node[31792]: *** WARNING *** For more information see Apr 27 07:03:45 volumio volumio[31792]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 27 07:03:45 volumio volumio[31792]: info: Discovery: Started advertising with name: Volumio Apr 27 07:03:45 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 27 07:03:45 volumio volumio[31792]: info: Loading plugin "youtube2"... Apr 27 07:03:45 volumio volumio[31792]: info: Loading plugin "outputs"... Apr 27 07:03:45 volumio volumio[31792]: info: Loading plugin "albumart"... Apr 27 07:03:45 volumio volumio[31792]: info: Plugin example_plugin is not enabled Apr 27 07:03:45 volumio volumio[31792]: info: Loading plugin "inputs"... Apr 27 07:03:45 volumio volumio[31792]: info: Loading plugin "updater_comm"... Apr 27 07:03:45 volumio volumio[31792]: info: Plugin mpdemulation is not enabled Apr 27 07:03:45 volumio volumio[31792]: info: Loading plugin "rest_api"... Apr 27 07:03:45 volumio volumio[31792]: info: Loading plugin "websocket"... Apr 27 07:03:45 volumio volumio[31792]: Forking 3 albumart workers Apr 27 07:03:45 volumio volumio[31792]: info: Starting Socket.io Server version 2.3.0 Apr 27 07:03:45 volumio volumio[31792]: info: Loading plugin "fusiondsp"... Apr 27 07:03:45 volumio volumio[31792]: info: Applying required configuration parameters for plugin fusiondsp Apr 27 07:03:45 volumio volumio[31792]: info: Loading plugin "radio_paradise"... Apr 27 07:03:45 volumio volumio[31792]: info: Applying required configuration parameters for plugin radio_paradise Apr 27 07:03:45 volumio volumio[31792]: info: [1745737425862] [RadioParadise] API delay: 5 Apr 27 07:03:45 volumio volumio[31792]: info: Loading i18n strings for locale es Apr 27 07:03:45 volumio volumio[31792]: Updating browse sources language Apr 27 07:03:45 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 07:03:45 volumio volumio[31792]: Starting albumart workers Apr 27 07:03:45 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 27 07:03:45 volumio volumio[31792]: info: CoreCommandRouter::initPlayerControls Apr 27 07:03:45 volumio volumio[31792]: Starting albumart workers Apr 27 07:03:45 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:45 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:45 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:45 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:45 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:45 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:45 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:45 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:45 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 27 07:03:45 volumio volumio[31792]: Express server listening on port 3000 Apr 27 07:03:45 volumio volumio[31792]: [Metrics] WebUI: 1s 335.54ms Apr 27 07:03:45 volumio volumio[31792]: Starting albumart workers Apr 27 07:03:45 volumio volumio[31792]: info: Setting Device type: x86 Apr 27 07:03:45 volumio volumio[31792]: info: CoreStateMachine::resetVolumioState Apr 27 07:03:45 volumio volumio[31792]: info: CoreStateMachine::getcurrentVolume Apr 27 07:03:45 volumio volumio[31792]: info: CoreCommandRouter::volumioRetrievevolume Apr 27 07:03:45 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:03:45 volumio volumio[31792]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Apr 27 07:03:45 volumio volumio[31792]: info: Completed loading Core Plugins Apr 27 07:03:45 volumio volumio[31792]: info: Preparing to generate the ALSA configuration file Apr 27 07:03:45 volumio volumio[31792]: info: Volumio Network Manager: Network status updated: 2 Apr 27 07:03:45 volumio volumio[31792]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Apr 27 07:03:45 volumio volumio[31792]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 27 07:03:45 volumio volumio[31792]: info: Reading ALSA contributions from plugins. Apr 27 07:03:46 volumio volumio[31792]: 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 27 07:03:46 volumio volumio[31792]: info: Reloading queue from file Apr 27 07:03:46 volumio volumio[31792]: info: VolumeController:: Volume=67 Mute =false Apr 27 07:03:46 volumio volumio[31792]: info: CoreStateMachine::pushState Apr 27 07:03:46 volumio volumio[31792]: info: CorePlayQueue::getTrack 0 Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::volumioPushState Apr 27 07:03:46 volumio volumio[31792]: info: CoreStateMachine::updateTrackBlock Apr 27 07:03:46 volumio volumio[31792]: info: CorePlayQueue::getTrackBlock Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::volumioRetrievevolume Apr 27 07:03:46 volumio volumio[31792]: info: CoreStateMachine::setRepeat null single undefined Apr 27 07:03:46 volumio volumio[31792]: info: CoreStateMachine::pushState Apr 27 07:03:46 volumio volumio[31792]: info: CorePlayQueue::getTrack 0 Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::volumioPushState Apr 27 07:03:46 volumio volumio[31792]: info: CoreStateMachine::setRandom null Apr 27 07:03:46 volumio volumio[31792]: info: CoreStateMachine::pushState Apr 27 07:03:46 volumio volumio[31792]: info: CorePlayQueue::getTrack 0 Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::volumioPushState Apr 27 07:03:46 volumio volumio[31792]: info: Asound.conf file unchanged, so no further update is needed Apr 27 07:03:46 volumio volumio[31792]: info: Output device has changed, restarting MPD Apr 27 07:03:46 volumio sudo[31922]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 27 07:03:46 volumio sudo[31922]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:46 volumio sudo[31922]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:46 volumio volumio[31792]: info: Output device has changed, restarting Shairport Sync Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:03:46 volumio sudo[31925]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 27 07:03:46 volumio sudo[31925]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:46 volumio systemd[1]: Stopping Music Player Daemon... Apr 27 07:03:46 volumio volumio[31792]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 27 07:03:46 volumio volumio[31792]: info: ___________ START PLUGINS ___________ Apr 27 07:03:46 volumio systemd[1]: mpd.service: Succeeded. Apr 27 07:03:46 volumio systemd[1]: Stopped Music Player Daemon. Apr 27 07:03:46 volumio volumio[31792]: info: ControllerMpd::onStart: Initializing MPD Apr 27 07:03:46 volumio volumio[31792]: info: Creating MPD Configuration file Apr 27 07:03:46 volumio sudo[31932]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 27 07:03:46 volumio sudo[31932]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 27 07:03:46 volumio volumio[31792]: info: [1745737426159] CoreMusicLibrary::Adding element Media Servers Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:03:46 volumio sudo[31932]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:46 volumio systemd[1]: Starting Music Player Daemon... Apr 27 07:03:46 volumio sudo[31935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 27 07:03:46 volumio sudo[31935]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:46 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Apr 27 07:03:46 volumio systemd[1]: mpd.service: Succeeded. Apr 27 07:03:46 volumio systemd[1]: Stopped Music Player Daemon. Apr 27 07:03:46 volumio systemd[1]: Starting Music Player Daemon... Apr 27 07:03:46 volumio volumio[31792]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 27 07:03:46 volumio volumio[31792]: info: [1745737426195] CoreMusicLibrary::Adding element Last_100 Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 27 07:03:46 volumio volumio[31792]: info: [1745737426195] CoreMusicLibrary::Adding element Webradio Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 27 07:03:46 volumio volumio[31792]: info: Initializing BBC Radios Apr 27 07:03:46 volumio sudo[31940]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 27 07:03:46 volumio sudo[31940]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:46 volumio sudo[31940]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 27 07:03:46 volumio volumio[31792]: info: [1745737426226] CoreMusicLibrary::Adding element YouTube2 Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 07:03:46 volumio volumio[31792]: Cannot find translation for source YouTube2 Apr 27 07:03:46 volumio volumio[31792]: info: Loading i18n strings for locale es Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: FusionDsp - mixtype--------------------- Hardware Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 27 07:03:46 volumio volumio[31792]: info: [1745737426233] CoreMusicLibrary::Adding element Radio Paradise Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 07:03:46 volumio volumio[31792]: Cannot find translation for source YouTube2 Apr 27 07:03:46 volumio volumio[31792]: Cannot find translation for source Radio Paradise Apr 27 07:03:46 volumio volumio[31792]: info: Volumio Calling Home Apr 27 07:03:46 volumio volumio[31792]: info: Preparing to generate the ALSA configuration file Apr 27 07:03:46 volumio volumio[31792]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 27 07:03:46 volumio volumio[31792]: info: Reading ALSA contributions from plugins. Apr 27 07:03:46 volumio volumio[31792]: info: MPD Permissions set Apr 27 07:03:46 volumio volumio[31792]: info: MPD Permissions set Apr 27 07:03:46 volumio volumio[31792]: 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 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: VolumeController:: Volume=67 Mute =false Apr 27 07:03:46 volumio volumio[31792]: info: CoreStateMachine::pushState Apr 27 07:03:46 volumio volumio[31792]: info: CorePlayQueue::getTrack 0 Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::volumioPushState Apr 27 07:03:46 volumio volumio[31792]: info: Starting Shairport Sync Apr 27 07:03:46 volumio volumio[31792]: info: Starting Shairport Sync Apr 27 07:03:46 volumio sudo[31974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 27 07:03:46 volumio sudo[31974]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:46 volumio volumio[31792]: info: Starting Shairport Sync Apr 27 07:03:46 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 27 07:03:46 volumio sudo[31977]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 27 07:03:46 volumio sudo[31977]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:46 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 27 07:03:46 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 27 07:03:46 volumio sudo[31981]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 27 07:03:46 volumio sudo[31981]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:46 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::volumioGetState Apr 27 07:03:46 volumio volumio[31792]: info: CorePlayQueue::getTrack 0 Apr 27 07:03:46 volumio volumio[31792]: info: Asound.conf file unchanged, so no further update is needed Apr 27 07:03:46 volumio volumio[31792]: info: Output device has changed, restarting MPD Apr 27 07:03:46 volumio sudo[31984]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 27 07:03:46 volumio sudo[31984]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:46 volumio sudo[31984]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:46 volumio volumio[31792]: info: Output device has changed, restarting Shairport Sync Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:03:46 volumio sudo[31974]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:46 volumio sudo[31987]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 27 07:03:46 volumio sudo[31987]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:46 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 27 07:03:46 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 27 07:03:46 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 27 07:03:46 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 27 07:03:46 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 27 07:03:46 volumio sudo[31981]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:46 volumio sudo[31977]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:46 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 27 07:03:46 volumio volumio[31792]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 27 07:03:46 volumio systemd[1]: mpd.service: Succeeded. Apr 27 07:03:46 volumio systemd[1]: Stopped Music Player Daemon. Apr 27 07:03:46 volumio systemd[1]: Starting Music Player Daemon... Apr 27 07:03:46 volumio volumio[31792]: info: Discovery: adding 1e594295-a03d-4768-bce8-ca6711f04f30 Apr 27 07:03:46 volumio volumio[31792]: info: Discovery: Found device Volumio Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::volumioGetState Apr 27 07:03:46 volumio volumio[31792]: info: CorePlayQueue::getTrack 0 Apr 27 07:03:46 volumio volumio[31792]: info: MPD Permissions set Apr 27 07:03:46 volumio volumio[31792]: info: Shairport-Sync Started Apr 27 07:03:46 volumio volumio[31792]: Error adding Membership: Error: addMembership EINVAL Apr 27 07:03:46 volumio volumio[31792]: info: Shairport-Sync Started Apr 27 07:03:46 volumio volumio[31792]: info: Shairport-Sync Started Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 27 07:03:46 volumio sudo[31995]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 27 07:03:46 volumio sudo[31995]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:46 volumio sudo[31995]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:46 volumio volumio[31792]: info: Starting Shairport Sync Apr 27 07:03:46 volumio sudo[32006]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 27 07:03:46 volumio sudo[32006]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:46 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 27 07:03:46 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 27 07:03:46 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 27 07:03:46 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 27 07:03:46 volumio sudo[32006]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:46 volumio volumio[31792]: info: Shairport-Sync Started Apr 27 07:03:46 volumio mpd[32004]: Apr 27 07:03 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 27 07:03:46 volumio systemd[1]: Started Music Player Daemon. Apr 27 07:03:46 volumio sudo[31987]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:46 volumio sudo[31925]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:46 volumio sudo[31935]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:46 volumio volumio[31792]: info: Completed starting Core Plugins Apr 27 07:03:46 volumio volumio[31792]: info: ------------------------------------------- Apr 27 07:03:46 volumio volumio[31792]: info: ----- MyVolumio plugins startup ---- Apr 27 07:03:46 volumio volumio[31792]: info: ------------------------------------------- Apr 27 07:03:46 volumio volumio[31792]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 27 07:03:46 volumio volumio[31792]: error: MPD error: The expression evaluated to a falsy value: Apr 27 07:03:46 volumio volumio[31792]: assert.ok(self.idling) Apr 27 07:03:46 volumio volumio[31792]: error: The expression evaluated to a falsy value: Apr 27 07:03:46 volumio volumio[31792]: assert.ok(self.idling) Apr 27 07:03:46 volumio volumio[31792]: error: MPD error: The expression evaluated to a falsy value: Apr 27 07:03:46 volumio volumio[31792]: assert.ok(self.idling) Apr 27 07:03:46 volumio volumio[31792]: error: The expression evaluated to a falsy value: Apr 27 07:03:46 volumio volumio[31792]: assert.ok(self.idling) Apr 27 07:03:46 volumio volumio[31792]: info: MPD running with PID32004 Apr 27 07:03:46 volumio volumio[31792]: ,establishing connection Apr 27 07:03:46 volumio volumio[31792]: error: updateQueue error: null Apr 27 07:03:46 volumio volumio[31792]: error: updateQueue error: null Apr 27 07:03:46 volumio volumio[31792]: 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 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::volumioGetVisibleSources Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::volumioGetState Apr 27 07:03:46 volumio volumio[31792]: info: CorePlayQueue::getTrack 0 Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::volumioGetQueue Apr 27 07:03:46 volumio volumio[31792]: info: CoreStateMachine::getQueue Apr 27 07:03:46 volumio volumio[31792]: info: CorePlayQueue::getQueue Apr 27 07:03:46 volumio volumio[31792]: info: Listing playlists Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 27 07:03:46 volumio volumio[31792]: info: Received Get System Info Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 07:03:46 volumio volumio[31792]: info: Discovery: Getting this device information Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::volumioGetState Apr 27 07:03:46 volumio volumio[31792]: info: CorePlayQueue::getTrack 0 Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 07:03:46 volumio volumio[31792]: info: CoreCommandRouter::volumioGetState Apr 27 07:03:46 volumio volumio[31792]: info: CorePlayQueue::getTrack 0 Apr 27 07:03:48 volumio volumio[31792]: 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 27 07:03:48 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 27 07:03:48 volumio volumio[31792]: info: CoreCommandRouter::volumioGetVisibleSources Apr 27 07:03:48 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 07:03:48 volumio volumio[31792]: info: CoreCommandRouter::volumioGetState Apr 27 07:03:48 volumio volumio[31792]: info: CorePlayQueue::getTrack 0 Apr 27 07:03:48 volumio volumio[31792]: info: CoreCommandRouter::volumioGetState Apr 27 07:03:48 volumio volumio[31792]: info: CorePlayQueue::getTrack 0 Apr 27 07:03:48 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 27 07:03:48 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 27 07:03:48 volumio volumio[31792]: info: Received Get System Info Apr 27 07:03:48 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 07:03:48 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 07:03:48 volumio volumio[31792]: info: Discovery: Getting this device information Apr 27 07:03:48 volumio volumio[31792]: info: CoreCommandRouter::volumioGetState Apr 27 07:03:48 volumio volumio[31792]: info: CorePlayQueue::getTrack 0 Apr 27 07:03:48 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 07:03:48 volumio volumio[31792]: info: CoreCommandRouter::volumioGetState Apr 27 07:03:48 volumio volumio[31792]: info: CorePlayQueue::getTrack 0 Apr 27 07:03:48 volumio volumio[31792]: info: Listing playlists Apr 27 07:03:48 volumio volumio[31792]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 07:03:48 volumio volumio[31792]: info: FusionDsp - no preset used Apr 27 07:03:48 volumio volumio[31792]: info: FusionDsp - kef.json,test.json Apr 27 07:03:48 volumio volumio[31792]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 07:03:48 volumio volumio[31792]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 07:03:48 volumio volumio[31792]: info: FusionDsp - no preset used Apr 27 07:03:48 volumio volumio[31792]: info: FusionDsp - no preset used Apr 27 07:03:48 volumio volumio[31792]: info: FusionDsp - kef.json,test.json Apr 27 07:03:48 volumio volumio[31792]: info: FusionDsp - kef.json,test.json Apr 27 07:03:48 volumio volumio[31792]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 07:03:48 volumio volumio[31792]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 07:03:48 volumio volumio[31792]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 07:03:48 volumio volumio[31792]: info: FusionDsp - no preset used Apr 27 07:03:48 volumio volumio[31792]: info: FusionDsp - no preset used Apr 27 07:03:48 volumio volumio[31792]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Apr 27 07:03:48 volumio volumio[31792]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Apr 27 07:03:48 volumio volumio[31792]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Apr 27 07:03:48 volumio volumio[31792]: info: camilladsp service started and running in background, instance 1 Apr 27 07:03:48 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:03:48 volumio volumio[31792]: cannot open device 'volumioHw': Device or resource busy Apr 27 07:03:48 volumio volumio[31792]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Apr 27 07:03:48 volumio volumio[31792]: cannot open device 'volumioHw': Device or resource busy Apr 27 07:03:48 volumio volumio[31792]: info: FusionDsp loaded Apr 27 07:03:48 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 07:03:48 volumio sudo[32032]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Apr 27 07:03:48 volumio sudo[32032]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:48 volumio volumio[31792]: info: FusionDsp - Reporting Fusion DSP Enabled Apr 27 07:03:48 volumio volumio[31792]: info: Adding Signal Path Element [object Object] Apr 27 07:03:48 volumio volumio[31792]: info: Adding fusiondspeq DSP Signal Path Element Apr 27 07:03:48 volumio volumio[31792]: info: FusionDsp - ---- installed callbackRead Apr 27 07:03:48 volumio volumio[31792]: error: FusionDsp - File size not found in array! Apr 27 07:03:48 volumio volumio[31792]: info: FusionDsp - crossfeed chumoy Apr 27 07:03:48 volumio volumio[31792]: info: FusionDsp - Loudness is ON true Apr 27 07:03:48 volumio volumio[31792]: info: FusionDsp - Nulleq applied Apr 27 07:03:48 volumio sudo[32032]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:48 volumio volumio[31792]: info: FusionDsp - no preset used Apr 27 07:03:48 volumio volumio[31792]: info: FusionDsp - kef.json,test.json Apr 27 07:03:48 volumio volumio[31792]: info: FusionDsp - kef.json,test.json Apr 27 07:03:48 volumio volumio[31792]: info: FusionDsp - kef.json,test.json Apr 27 07:03:48 volumio volumio[31792]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Apr 27 07:03:48 volumio volumio[31792]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 27 07:03:49 volumio volumio-remote-updater[785]: [2025-04-27 07:03:49] [connect] Successful connection Apr 27 07:03:49 volumio volumio-remote-updater[785]: [2025-04-27 07:03:49] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1745737429 101 Apr 27 07:03:49 volumio volumio[31792]: 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 27 07:03:55 volumio sudo[32051]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 27 07:03:55 volumio sudo[32051]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:55 volumio sudo[32051]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:55 volumio sudo[32054]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 27 07:03:55 volumio sudo[32054]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:55 volumio sudo[32054]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:55 volumio sudo[32057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 27 07:03:55 volumio sudo[32057]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:03:55 volumio sudo[32057]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:55 volumio volumio[31792]: info: Upmpdcli Daemon Started Apr 27 07:03:55 volumio sudo[31833]: pam_unix(sudo:session): session closed for user root Apr 27 07:03:56 volumio volumio[31792]: info: Volumio called home Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Apr 27 07:04:00 volumio volumio[31792]: info: Adding plugin bluetooth to MyMusic Plugins Apr 27 07:04:00 volumio volumio[31792]: info: Adding plugin multiroom to MyMusic Plugins Apr 27 07:04:00 volumio volumio[31792]: info: Adding plugin metavolumio to MyMusic Plugins Apr 27 07:04:00 volumio volumio[31792]: info: Adding plugin cd_controller to MyMusic Plugins Apr 27 07:04:00 volumio volumio[31792]: info: Adding plugin smart_inputs to MyMusic Plugins Apr 27 07:04:00 volumio volumio[31792]: info: Adding plugin tidalconnect to MyMusic Plugins Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 27 07:04:00 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:04:00 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:04:00 volumio volumio[31792]: info: Starting MyVolumio Remote Streaming Endpoints Apr 27 07:04:00 volumio volumio[31792]: info: MyVolumio login type: Token Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 27 07:04:00 volumio volumio[31792]: info: Starting Streaming Service Transparent Proxy Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 27 07:04:00 volumio volumio[31792]: info: Streaming services startup Apr 27 07:04:00 volumio volumio[31792]: info: Starting Streaming Daemon Apr 27 07:04:00 volumio sudo[32070]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 27 07:04:00 volumio sudo[32070]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:04:00 volumio sudo[32070]: pam_unix(sudo:session): session closed for user root Apr 27 07:04:00 volumio volumio[31792]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Apr 27 07:04:00 volumio volumio[31792]: error: Cannot start Volumio Streaming Daemon Apr 27 07:04:00 volumio volumio[31792]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 27 07:04:00 volumio volumio[31792]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 27 07:04:00 volumio volumio[31792]: error: Streaming Proxy Server FATAL ERROR: null Apr 27 07:04:00 volumio volumio[31792]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 27 07:04:01 volumio volumio[31792]: info: MyVolumio token set successfully Apr 27 07:04:01 volumio volumio[31792]: info: MYVOLUMIO: Adding device Apr 27 07:04:01 volumio volumio[31792]: info: MYVOLUMIO: Evaluating Server Apr 27 07:04:01 volumio volumio[31792]: info: MyVolumio status changed Apr 27 07:04:01 volumio volumio[31792]: info: Streaming services startup Apr 27 07:04:01 volumio volumio[31792]: info: Starting Streaming Daemon Apr 27 07:04:01 volumio volumio[31792]: info: Removing browser output: myVolumio user plan is not superstar Apr 27 07:04:01 volumio volumio[31792]: info: Removing audio output: Apr 27 07:04:01 volumio volumio[31792]: info: Stoppping Tunnel 1 Apr 27 07:04:01 volumio sudo[32094]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 27 07:04:01 volumio sudo[32094]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:04:01 volumio sudo[32094]: pam_unix(sudo:session): session closed for user root Apr 27 07:04:01 volumio sudo[32097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Apr 27 07:04:01 volumio sudo[32097]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:04:01 volumio volumio[31792]: error: Cannot start Volumio Streaming Daemon Apr 27 07:04:01 volumio volumio[31792]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 27 07:04:01 volumio volumio[31792]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 27 07:04:01 volumio sudo[32097]: pam_unix(sudo:session): session closed for user root Apr 27 07:04:01 volumio volumio[31792]: info: Remote SSH Stopped Apr 27 07:04:01 volumio volumio[31792]: info: Setting Geolocation for MyVolumio to us2 Apr 27 07:04:01 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:04:01 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:04:01 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:04:02 volumio volumio[31792]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Apr 27 07:04:02 volumio volumio[31792]: info: Updating MyVolumio device info Apr 27 07:04:02 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:04:02 volumio volumio[31792]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:04:03 volumio volumio[31792]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 27 07:04:06 volumio volumio[31792]: info: MYVOLUMIO: Adding device Apr 27 07:04:06 volumio volumio[31792]: info: MYVOLUMIO: Evaluating Server Apr 27 07:04:10 volumio volumio-remote-updater[785]: [2025-04-27 07:04:10] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Apr 27 07:04:10 volumio volumio-remote-updater[785]: [2025-04-27 07:04:10] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Apr 27 07:04:10 volumio systemd[1]: volumio.service: Main process exited, code=killed, status=11/SEGV Apr 27 07:04:10 volumio systemd[1]: volumio.service: Failed with result 'signal'. Apr 27 07:04:10 volumio systemd[1]: Started dynamicswap service. Apr 27 07:04:10 volumio systemd[1]: dynamicswap.service: Succeeded. Apr 27 07:04:10 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Apr 27 07:04:10 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 3. Apr 27 07:04:10 volumio systemd[1]: Started dynamicswap service. Apr 27 07:04:10 volumio systemd[1]: Stopped Volumio Backend Module. Apr 27 07:04:10 volumio systemd[1]: Started Volumio Backend Module. Apr 27 07:04:10 volumio systemd[1]: dynamicswap.service: Succeeded. Apr 27 07:04:10 volumio volumio[32136]: info: ------------------------------------------- Apr 27 07:04:10 volumio volumio[32136]: info: ----- Volumio3 ---- Apr 27 07:04:10 volumio volumio[32136]: info: ------------------------------------------- Apr 27 07:04:10 volumio volumio[32136]: info: ----- System startup ---- Apr 27 07:04:10 volumio volumio[32136]: info: ------------------------------------------- Apr 27 07:04:10 volumio volumio[32136]: info: MYVOLUMIO Environment detected Apr 27 07:04:10 volumio volumio[32136]: info: Plugin folders cleanup Apr 27 07:04:10 volumio volumio[32136]: info: Scanning into folder /volumio/app/plugins/ Apr 27 07:04:10 volumio volumio[32136]: info: Scanning category audio_interface Apr 27 07:04:10 volumio volumio[32136]: info: Scanning category miscellanea Apr 27 07:04:10 volumio volumio[32136]: info: Scanning category music_service Apr 27 07:04:10 volumio volumio[32136]: info: Scanning category plugins.json Apr 27 07:04:10 volumio volumio[32136]: info: Scanning category system_controller Apr 27 07:04:10 volumio volumio[32136]: info: Scanning category user_interface Apr 27 07:04:10 volumio volumio[32136]: info: Scanning into folder /data/plugins/ Apr 27 07:04:10 volumio volumio[32136]: info: Scanning category audio_interface Apr 27 07:04:10 volumio volumio[32136]: info: Scanning category music_service Apr 27 07:04:10 volumio volumio[32136]: info: Plugin folders cleanup completed Apr 27 07:04:10 volumio volumio[32136]: info: ------------------------------------------- Apr 27 07:04:10 volumio volumio[32136]: info: ----- Core plugins startup ---- Apr 27 07:04:10 volumio volumio[32136]: info: ------------------------------------------- Apr 27 07:04:10 volumio volumio[32136]: info: Loading plugins from folder /volumio/app/plugins/ Apr 27 07:04:10 volumio volumio[32136]: info: Adding plugin upnp to MyMusic Plugins Apr 27 07:04:10 volumio volumio[32136]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 27 07:04:10 volumio volumio[32136]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 27 07:04:10 volumio volumio[32136]: info: Loading plugins from folder /data/plugins/ Apr 27 07:04:10 volumio volumio[32136]: info: Loading plugin "system"... Apr 27 07:04:10 volumio volumio[32136]: info: Loading plugin "appearance"... Apr 27 07:04:10 volumio volumio[32136]: info: Loading plugin "network"... Apr 27 07:04:10 volumio volumio[32136]: info: Refreshing Cached IP Addresses Apr 27 07:04:10 volumio sudo[32162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 27 07:04:10 volumio sudo[32162]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:04:10 volumio sudo[32162]: pam_unix(sudo:session): session closed for user root Apr 27 07:04:10 volumio sudo[32164]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 27 07:04:10 volumio sudo[32164]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:04:10 volumio sudo[32164]: pam_unix(sudo:session): session closed for user root Apr 27 07:04:10 volumio volumio[32136]: info: Loading plugin "services"... Apr 27 07:04:10 volumio volumio[32136]: info: Loading plugin "alsa_controller"... Apr 27 07:04:10 volumio sudo[32177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 27 07:04:10 volumio sudo[32177]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:04:11 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 27 07:04:11 volumio volumio[32136]: info: Loading plugin "wizard"... Apr 27 07:04:11 volumio volumio[32136]: info: Loading plugin "networkfs"... Apr 27 07:04:11 volumio volumio[32136]: info: Starting Udev Watcher for removable devices Apr 27 07:04:11 volumio volumio[32136]: info: Mounting Device MEMORIA_USB Apr 27 07:04:11 volumio sudo[32193]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdc1 /mnt/USB/MEMORIA_USB -o noatime Apr 27 07:04:11 volumio sudo[32193]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:04:11 volumio sudo[32193]: pam_unix(sudo:session): session closed for user root Apr 27 07:04:11 volumio volumio[32136]: mount: /media/MEMORIA_USB: /dev/sdc1 already mounted on /media/MEMORIA_USB. Apr 27 07:04:11 volumio volumio[32136]: error: Failed to mount MEMORIA_USB: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sdc1" "/mnt/USB/MEMORIA_USB" -o noatime Apr 27 07:04:11 volumio volumio[32136]: mount: /media/MEMORIA_USB: /dev/sdc1 already mounted on /media/MEMORIA_USB. Apr 27 07:04:11 volumio volumio[32136]: info: Ignoring mount for partition: boot Apr 27 07:04:11 volumio volumio[32136]: info: Ignoring mount for partition: volumio Apr 27 07:04:11 volumio volumio[32136]: info: Ignoring mount for partition: volumio_data Apr 27 07:04:11 volumio volumio[32136]: info: Ignoring mount for partition: efi-boot Apr 27 07:04:11 volumio volumio[32136]: info: Ignoring mount for partition: DaphileBoot Apr 27 07:04:11 volumio volumio[32136]: info: Ignoring mount for partition: DaphileData Apr 27 07:04:11 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 27 07:04:11 volumio volumio[32136]: info: Loading plugin "volumio_command_line_client"... Apr 27 07:04:11 volumio volumio[32136]: info: Loading plugin "upnp"... Apr 27 07:04:11 volumio volumio[32136]: info: [1745737451067] Starting Upmpd Daemon Apr 27 07:04:11 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 27 07:04:11 volumio volumio[32136]: info: Loading plugin "my_music"... Apr 27 07:04:11 volumio volumio[32136]: info: Loading plugin "mpd"... Apr 27 07:04:11 volumio volumio[32136]: info: Loading plugin "upnp_browser"... Apr 27 07:04:11 volumio volumio[32136]: info: Loading plugin "alarm-clock"... Apr 27 07:04:11 volumio volumio[32136]: info: Loading plugin "airplay_emulation"... Apr 27 07:04:11 volumio volumio[32136]: info: Starting Shairport Sync Apr 27 07:04:11 volumio volumio[32136]: info: Loading plugin "last_100"... Apr 27 07:04:11 volumio volumio[32136]: info: Loading plugin "webradio"... Apr 27 07:04:11 volumio volumio[32136]: info: Loading plugin "i2s_dacs"... Apr 27 07:04:11 volumio volumio[32136]: info: I2S DAC not set, start Auto-detection Apr 27 07:04:11 volumio volumio[32136]: info: Loading plugin "volumiodiscovery"... Apr 27 07:04:11 volumio volumio[32136]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 27 07:04:11 volumio volumio[32136]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 27 07:04:11 volumio volumio[32136]: *** WARNING *** For more information see Apr 27 07:04:11 volumio volumio[32136]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 27 07:04:11 volumio volumio[32136]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 27 07:04:11 volumio node[32136]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 27 07:04:11 volumio volumio[32136]: *** WARNING *** For more information see Apr 27 07:04:11 volumio node[32136]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 27 07:04:11 volumio node[32136]: *** WARNING *** For more information see Apr 27 07:04:11 volumio node[32136]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 27 07:04:11 volumio node[32136]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 27 07:04:11 volumio node[32136]: *** WARNING *** For more information see Apr 27 07:04:11 volumio volumio[32136]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 27 07:04:11 volumio volumio[32136]: info: Discovery: Started advertising with name: Volumio Apr 27 07:04:11 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 27 07:04:11 volumio volumio[32136]: info: Loading plugin "youtube2"... Apr 27 07:04:11 volumio volumio[32136]: info: Loading plugin "outputs"... Apr 27 07:04:11 volumio volumio[32136]: info: Loading plugin "albumart"... Apr 27 07:04:11 volumio volumio[32136]: info: Plugin example_plugin is not enabled Apr 27 07:04:11 volumio volumio[32136]: info: Loading plugin "inputs"... Apr 27 07:04:11 volumio volumio[32136]: info: Loading plugin "updater_comm"... Apr 27 07:04:11 volumio volumio[32136]: info: Plugin mpdemulation is not enabled Apr 27 07:04:11 volumio volumio[32136]: info: Loading plugin "rest_api"... Apr 27 07:04:11 volumio volumio[32136]: info: Loading plugin "websocket"... Apr 27 07:04:11 volumio volumio[32136]: info: Starting Socket.io Server version 2.3.0 Apr 27 07:04:11 volumio volumio[32136]: info: Loading plugin "fusiondsp"... Apr 27 07:04:11 volumio volumio[32136]: Forking 3 albumart workers Apr 27 07:04:11 volumio volumio[32136]: info: Applying required configuration parameters for plugin fusiondsp Apr 27 07:04:11 volumio volumio[32136]: info: Loading plugin "radio_paradise"... Apr 27 07:04:11 volumio volumio[32136]: info: Applying required configuration parameters for plugin radio_paradise Apr 27 07:04:11 volumio volumio[32136]: info: [1745737451891] [RadioParadise] API delay: 5 Apr 27 07:04:11 volumio volumio[32136]: info: Loading i18n strings for locale es Apr 27 07:04:11 volumio volumio[32136]: Updating browse sources language Apr 27 07:04:11 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 07:04:11 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 27 07:04:11 volumio volumio[32136]: info: CoreCommandRouter::initPlayerControls Apr 27 07:04:11 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:11 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:11 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:11 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:11 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:11 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:11 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:11 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:11 volumio volumio[32136]: Starting albumart workers Apr 27 07:04:11 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 27 07:04:11 volumio volumio[32136]: Express server listening on port 3000 Apr 27 07:04:11 volumio volumio[32136]: [Metrics] WebUI: 1s 361.35ms Apr 27 07:04:11 volumio volumio[32136]: Starting albumart workers Apr 27 07:04:11 volumio volumio[32136]: info: Setting Device type: x86 Apr 27 07:04:11 volumio volumio[32136]: Starting albumart workers Apr 27 07:04:11 volumio volumio[32136]: info: CoreStateMachine::resetVolumioState Apr 27 07:04:11 volumio volumio[32136]: info: CoreStateMachine::getcurrentVolume Apr 27 07:04:11 volumio volumio[32136]: info: CoreCommandRouter::volumioRetrievevolume Apr 27 07:04:11 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:04:11 volumio volumio[32136]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Apr 27 07:04:11 volumio volumio[32136]: info: Completed loading Core Plugins Apr 27 07:04:11 volumio volumio[32136]: info: Preparing to generate the ALSA configuration file Apr 27 07:04:12 volumio volumio[32136]: info: Volumio Network Manager: Network status updated: 2 Apr 27 07:04:12 volumio volumio[32136]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Apr 27 07:04:12 volumio volumio[32136]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 27 07:04:12 volumio volumio[32136]: info: Reading ALSA contributions from plugins. Apr 27 07:04:12 volumio volumio[32136]: 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 27 07:04:12 volumio volumio[32136]: 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 27 07:04:12 volumio volumio[32136]: info: Reloading queue from file Apr 27 07:04:12 volumio volumio[32136]: info: VolumeController:: Volume=67 Mute =false Apr 27 07:04:12 volumio volumio[32136]: info: CoreStateMachine::pushState Apr 27 07:04:12 volumio volumio[32136]: info: CorePlayQueue::getTrack 0 Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::volumioPushState Apr 27 07:04:12 volumio volumio[32136]: info: CoreStateMachine::updateTrackBlock Apr 27 07:04:12 volumio volumio[32136]: info: CorePlayQueue::getTrackBlock Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::volumioRetrievevolume Apr 27 07:04:12 volumio volumio[32136]: info: CoreStateMachine::setRepeat null single undefined Apr 27 07:04:12 volumio volumio[32136]: info: CoreStateMachine::pushState Apr 27 07:04:12 volumio volumio[32136]: info: CorePlayQueue::getTrack 0 Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::volumioPushState Apr 27 07:04:12 volumio volumio[32136]: info: CoreStateMachine::setRandom null Apr 27 07:04:12 volumio volumio[32136]: info: CoreStateMachine::pushState Apr 27 07:04:12 volumio volumio[32136]: info: CorePlayQueue::getTrack 0 Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::volumioPushState Apr 27 07:04:12 volumio volumio[32136]: info: Discovery: A device disappeared from network Apr 27 07:04:12 volumio volumio[32136]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Apr 27 07:04:12 volumio volumio[32136]: info: Asound.conf file unchanged, so no further update is needed Apr 27 07:04:12 volumio volumio[32136]: info: Output device has changed, restarting MPD Apr 27 07:04:12 volumio sudo[32269]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 27 07:04:12 volumio sudo[32269]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:04:12 volumio sudo[32269]: pam_unix(sudo:session): session closed for user root Apr 27 07:04:12 volumio volumio[32136]: info: Output device has changed, restarting Shairport Sync Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:04:12 volumio sudo[32272]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 27 07:04:12 volumio sudo[32272]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:04:12 volumio systemd[1]: Stopping Music Player Daemon... Apr 27 07:04:12 volumio volumio[32136]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 27 07:04:12 volumio volumio[32136]: info: ___________ START PLUGINS ___________ Apr 27 07:04:12 volumio systemd[1]: mpd.service: Succeeded. Apr 27 07:04:12 volumio systemd[1]: Stopped Music Player Daemon. Apr 27 07:04:12 volumio volumio[32136]: info: ControllerMpd::onStart: Initializing MPD Apr 27 07:04:12 volumio volumio[32136]: info: Creating MPD Configuration file Apr 27 07:04:12 volumio sudo[32279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 27 07:04:12 volumio sudo[32279]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 27 07:04:12 volumio volumio[32136]: info: [1745737452208] CoreMusicLibrary::Adding element Media Servers Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 07:04:12 volumio sudo[32279]: pam_unix(sudo:session): session closed for user root Apr 27 07:04:12 volumio systemd[1]: Starting Music Player Daemon... Apr 27 07:04:12 volumio sudo[32282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 27 07:04:12 volumio sudo[32282]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:04:12 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Apr 27 07:04:12 volumio systemd[1]: mpd.service: Succeeded. Apr 27 07:04:12 volumio systemd[1]: Stopped Music Player Daemon. Apr 27 07:04:12 volumio systemd[1]: Starting Music Player Daemon... Apr 27 07:04:12 volumio volumio[32136]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:04:12 volumio sudo[32284]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 27 07:04:12 volumio sudo[32284]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:04:12 volumio sudo[32284]: pam_unix(sudo:session): session closed for user root Apr 27 07:04:12 volumio volumio[32136]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 27 07:04:12 volumio volumio[32136]: info: [1745737452242] CoreMusicLibrary::Adding element Last_100 Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 27 07:04:12 volumio volumio[32136]: info: [1745737452242] CoreMusicLibrary::Adding element Webradio Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 27 07:04:12 volumio volumio[32136]: info: Initializing BBC Radios Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 27 07:04:12 volumio volumio[32136]: info: [1745737452270] CoreMusicLibrary::Adding element YouTube2 Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 07:04:12 volumio volumio[32136]: Cannot find translation for source YouTube2 Apr 27 07:04:12 volumio volumio[32136]: info: Loading i18n strings for locale es Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: FusionDsp - mixtype--------------------- Hardware Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 27 07:04:12 volumio volumio[32136]: info: [1745737452278] CoreMusicLibrary::Adding element Radio Paradise Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 07:04:12 volumio volumio[32136]: Cannot find translation for source YouTube2 Apr 27 07:04:12 volumio volumio[32136]: Cannot find translation for source Radio Paradise Apr 27 07:04:12 volumio volumio[32136]: info: Volumio Calling Home Apr 27 07:04:12 volumio volumio[32136]: info: Preparing to generate the ALSA configuration file Apr 27 07:04:12 volumio volumio[32136]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 27 07:04:12 volumio volumio[32136]: info: Reading ALSA contributions from plugins. Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 27 07:04:12 volumio volumio[32136]: info: MPD Permissions set Apr 27 07:04:12 volumio volumio[32136]: info: MPD Permissions set Apr 27 07:04:12 volumio volumio[32136]: info: VolumeController:: Volume=67 Mute =false Apr 27 07:04:12 volumio volumio[32136]: info: CoreStateMachine::pushState Apr 27 07:04:12 volumio volumio[32136]: info: CorePlayQueue::getTrack 0 Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::volumioPushState Apr 27 07:04:12 volumio volumio[32136]: 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 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::volumioGetVisibleSources Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::volumioGetState Apr 27 07:04:12 volumio volumio[32136]: info: CorePlayQueue::getTrack 0 Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::volumioGetQueue Apr 27 07:04:12 volumio volumio[32136]: info: CoreStateMachine::getQueue Apr 27 07:04:12 volumio volumio[32136]: info: CorePlayQueue::getQueue Apr 27 07:04:12 volumio volumio[32136]: info: Listing playlists Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 27 07:04:12 volumio volumio[32136]: info: Received Get System Info Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 07:04:12 volumio volumio[32136]: info: Discovery: Getting this device information Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::volumioGetState Apr 27 07:04:12 volumio volumio[32136]: info: CorePlayQueue::getTrack 0 Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::volumioGetState Apr 27 07:04:12 volumio volumio[32136]: info: CorePlayQueue::getTrack 0 Apr 27 07:04:12 volumio volumio[32136]: info: Starting Shairport Sync Apr 27 07:04:12 volumio volumio[32136]: info: Starting Shairport Sync Apr 27 07:04:12 volumio sudo[32319]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 27 07:04:12 volumio sudo[32319]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:04:12 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 27 07:04:12 volumio volumio[32136]: info: Starting Shairport Sync Apr 27 07:04:12 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 27 07:04:12 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 27 07:04:12 volumio sudo[32322]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 27 07:04:12 volumio sudo[32322]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:04:12 volumio sudo[32326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 27 07:04:12 volumio volumio[32136]: info: Asound.conf file unchanged, so no further update is needed Apr 27 07:04:12 volumio volumio[32136]: info: Output device has changed, restarting MPD Apr 27 07:04:12 volumio volumio[32136]: info: Output device has changed, restarting Shairport Sync Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:04:12 volumio sudo[32326]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:04:12 volumio sudo[32329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 27 07:04:12 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 27 07:04:12 volumio sudo[32329]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:04:12 volumio sudo[32329]: pam_unix(sudo:session): session closed for user root Apr 27 07:04:12 volumio sudo[32332]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 27 07:04:12 volumio sudo[32332]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:04:12 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 27 07:04:12 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 27 07:04:12 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 27 07:04:12 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 27 07:04:12 volumio sudo[32319]: pam_unix(sudo:session): session closed for user root Apr 27 07:04:12 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 27 07:04:12 volumio volumio[32136]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 27 07:04:12 volumio sudo[32322]: pam_unix(sudo:session): session closed for user root Apr 27 07:04:12 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 27 07:04:12 volumio volumio[32136]: info: MPD Permissions set Apr 27 07:04:12 volumio volumio[32136]: info: Shairport-Sync Started Apr 27 07:04:12 volumio systemd[1]: mpd.service: Succeeded. Apr 27 07:04:12 volumio systemd[1]: Stopped Music Player Daemon. Apr 27 07:04:12 volumio volumio[32136]: Error adding Membership: Error: addMembership EINVAL Apr 27 07:04:12 volumio volumio[32136]: info: Shairport-Sync Started Apr 27 07:04:12 volumio sudo[32326]: pam_unix(sudo:session): session closed for user root Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio systemd[1]: Starting Music Player Daemon... Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:12 volumio volumio[32136]: info: Shairport-Sync Started Apr 27 07:04:12 volumio volumio[32136]: info: Starting Shairport Sync Apr 27 07:04:12 volumio sudo[32338]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 27 07:04:12 volumio sudo[32338]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:04:12 volumio sudo[32338]: pam_unix(sudo:session): session closed for user root Apr 27 07:04:12 volumio sudo[32350]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 27 07:04:12 volumio sudo[32350]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:04:12 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 27 07:04:12 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 27 07:04:12 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 27 07:04:12 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 27 07:04:12 volumio sudo[32350]: pam_unix(sudo:session): session closed for user root Apr 27 07:04:12 volumio volumio[32136]: info: Shairport-Sync Started Apr 27 07:04:12 volumio mpd[32349]: Apr 27 07:04 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 27 07:04:12 volumio systemd[1]: Started Music Player Daemon. Apr 27 07:04:12 volumio sudo[32282]: pam_unix(sudo:session): session closed for user root Apr 27 07:04:12 volumio sudo[32272]: pam_unix(sudo:session): session closed for user root Apr 27 07:04:12 volumio sudo[32332]: pam_unix(sudo:session): session closed for user root Apr 27 07:04:12 volumio volumio[32136]: info: Completed starting Core Plugins Apr 27 07:04:12 volumio volumio[32136]: info: ------------------------------------------- Apr 27 07:04:12 volumio volumio[32136]: info: ----- MyVolumio plugins startup ---- Apr 27 07:04:12 volumio volumio[32136]: info: ------------------------------------------- Apr 27 07:04:12 volumio volumio[32136]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 27 07:04:12 volumio volumio[32136]: error: MPD error: The expression evaluated to a falsy value: Apr 27 07:04:12 volumio volumio[32136]: assert.ok(self.idling) Apr 27 07:04:12 volumio volumio[32136]: error: The expression evaluated to a falsy value: Apr 27 07:04:12 volumio volumio[32136]: assert.ok(self.idling) Apr 27 07:04:12 volumio volumio[32136]: error: MPD error: The expression evaluated to a falsy value: Apr 27 07:04:12 volumio volumio[32136]: assert.ok(self.idling) Apr 27 07:04:12 volumio volumio[32136]: error: The expression evaluated to a falsy value: Apr 27 07:04:12 volumio volumio[32136]: assert.ok(self.idling) Apr 27 07:04:12 volumio volumio[32136]: error: updateQueue error: null Apr 27 07:04:12 volumio volumio[32136]: info: MPD running with PID32349 Apr 27 07:04:12 volumio volumio[32136]: ,establishing connection Apr 27 07:04:12 volumio volumio[32136]: error: updateQueue error: null Apr 27 07:04:12 volumio volumio[32136]: info: Discovery: adding 1e594295-a03d-4768-bce8-ca6711f04f30 Apr 27 07:04:12 volumio volumio[32136]: info: Discovery: Found device Volumio Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::volumioGetState Apr 27 07:04:12 volumio volumio[32136]: info: CorePlayQueue::getTrack 0 Apr 27 07:04:12 volumio volumio[32136]: info: CoreCommandRouter::volumioGetState Apr 27 07:04:12 volumio volumio[32136]: info: CorePlayQueue::getTrack 0 Apr 27 07:04:12 volumio volumio[32136]: info: Volumio called home Apr 27 07:04:13 volumio volumio[32136]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 07:04:13 volumio volumio[32136]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 07:04:13 volumio volumio[32136]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 07:04:13 volumio volumio[32136]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 07:04:13 volumio volumio[32136]: info: FusionDsp - no preset used Apr 27 07:04:13 volumio volumio[32136]: info: FusionDsp - no preset used Apr 27 07:04:13 volumio volumio[32136]: info: FusionDsp - no preset used Apr 27 07:04:13 volumio volumio[32136]: info: FusionDsp - no preset used Apr 27 07:04:13 volumio volumio[32136]: info: FusionDsp - kef.json,test.json Apr 27 07:04:13 volumio volumio[32136]: info: FusionDsp - kef.json,test.json Apr 27 07:04:13 volumio volumio[32136]: info: FusionDsp - kef.json,test.json Apr 27 07:04:13 volumio volumio[32136]: info: FusionDsp - kef.json,test.json Apr 27 07:04:13 volumio volumio[32136]: 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 27 07:04:13 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 27 07:04:13 volumio volumio[32136]: info: CoreCommandRouter::volumioGetVisibleSources Apr 27 07:04:13 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 27 07:04:13 volumio volumio[32136]: info: CoreCommandRouter::volumioGetState Apr 27 07:04:13 volumio volumio[32136]: info: CorePlayQueue::getTrack 0 Apr 27 07:04:13 volumio volumio[32136]: info: CoreCommandRouter::volumioGetState Apr 27 07:04:13 volumio volumio[32136]: info: CorePlayQueue::getTrack 0 Apr 27 07:04:13 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 27 07:04:13 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 27 07:04:13 volumio volumio[32136]: info: Received Get System Info Apr 27 07:04:13 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 27 07:04:13 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 27 07:04:13 volumio volumio[32136]: info: Discovery: Getting this device information Apr 27 07:04:13 volumio volumio[32136]: info: CoreCommandRouter::volumioGetState Apr 27 07:04:13 volumio volumio[32136]: info: CorePlayQueue::getTrack 0 Apr 27 07:04:13 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 07:04:13 volumio volumio[32136]: info: CoreCommandRouter::volumioGetState Apr 27 07:04:13 volumio volumio[32136]: info: CorePlayQueue::getTrack 0 Apr 27 07:04:13 volumio volumio[32136]: info: Listing playlists Apr 27 07:04:13 volumio volumio[32136]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 07:04:13 volumio volumio[32136]: info: FusionDsp - no preset used Apr 27 07:04:13 volumio volumio[32136]: info: FusionDsp - kef.json,test.json Apr 27 07:04:13 volumio volumio[32136]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 07:04:13 volumio volumio[32136]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 07:04:13 volumio volumio[32136]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 27 07:04:13 volumio volumio[32136]: info: FusionDsp - no preset used Apr 27 07:04:13 volumio volumio[32136]: info: FusionDsp - no preset used Apr 27 07:04:13 volumio volumio[32136]: info: FusionDsp - no preset used Apr 27 07:04:13 volumio volumio[32136]: info: FusionDsp - kef.json,test.json Apr 27 07:04:13 volumio volumio[32136]: info: FusionDsp - kef.json,test.json Apr 27 07:04:13 volumio volumio[32136]: info: FusionDsp - kef.json,test.json Apr 27 07:04:14 volumio volumio[32136]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Apr 27 07:04:14 volumio volumio[32136]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Apr 27 07:04:14 volumio volumio[32136]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Apr 27 07:04:14 volumio volumio[32136]: info: camilladsp service started and running in background, instance 1 Apr 27 07:04:14 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 27 07:04:14 volumio volumio[32136]: cannot open device 'volumioHw': Device or resource busy Apr 27 07:04:14 volumio volumio[32136]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Apr 27 07:04:14 volumio volumio[32136]: cannot open device 'volumioHw': Device or resource busy Apr 27 07:04:14 volumio volumio[32136]: info: FusionDsp loaded Apr 27 07:04:14 volumio volumio[32136]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 27 07:04:14 volumio sudo[32376]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Apr 27 07:04:14 volumio sudo[32376]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 27 07:04:14 volumio volumio[32136]: info: FusionDsp - Reporting Fusion DSP Enabled Apr 27 07:04:14 volumio volumio[32136]: info: Adding Signal Path Element [object Object] Apr 27 07:04:14 volumio volumio[32136]: info: Adding fusiondspeq DSP Signal Path Element Apr 27 07:04:14 volumio volumio[32136]: info: FusionDsp - ---- installed callbackRead Apr 27 07:04:14 volumio sudo[32376]: pam_unix(sudo:session): session closed for user root Apr 27 07:04:14 volumio volumio[32136]: error: FusionDsp - File size not found in array! Apr 27 07:04:14 volumio volumio[32136]: info: FusionDsp - crossfeed chumoy Apr 27 07:04:14 volumio volumio[32136]: info: FusionDsp - Loudness is ON true Apr 27 07:04:14 volumio volumio[32136]: info: FusionDsp - Nulleq applied Apr 27 07:04:14 volumio volumio[32136]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Apr 27 07:04:14 volumio volumio[32136]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 27 07:04:15 volumio volumio-remote-updater[785]: [2025-04-27 07:04:15] [connect] Successful connection Apr 27 07:04:15 volumio volumio-remote-updater[785]: [2025-04-27 07:04:15] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1745737455 101 Apr 27 07:04:15 volumio volumio[32136]: 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 27 07:04:16 volumio sudo[32177]: pam_unix(sudo:session): session closed for user root Apr 27 07:04:17 volumio volumio[32136]: info: Discovery: this is already registered, 1e594295-a03d-4768-bce8-ca6711f04f30 Apr 27 07:04:17 volumio volumio[32136]: info: Discovery: Found device Volumio Apr 27 07:04:17 volumio volumio[32136]: info: CoreCommandRouter::volumioGetState Apr 27 07:04:17 volumio volumio[32136]: info: CorePlayQueue::getTrack 0 Apr 27 07:04:17 volumio volumio[32136]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 27 07:04:17 volumio volumio[32136]: TypeError: buf.slice is not a function Apr 27 07:04:17 volumio volumio[32136]: at Receiver.consume (/volumio/node_modules/engine.io-client/node_modules/ws/lib/receiver.js:86:30) Apr 27 07:04:17 volumio volumio[32136]: at Receiver.getInfo (/volumio/node_modules/engine.io-client/node_modules/ws/lib/receiver.js:157:22) Apr 27 07:04:17 volumio volumio[32136]: at Receiver.startLoop (/volumio/node_modules/engine.io-client/node_modules/ws/lib/receiver.js:121:22) Apr 27 07:04:17 volumio volumio[32136]: at Receiver._write (/volumio/node_modules/engine.io-client/node_modules/ws/lib/receiver.js:69:10) Apr 27 07:04:17 volumio volumio[32136]: at writeOrBuffer (internal/streams/writable.js:358:12) Apr 27 07:04:17 volumio volumio[32136]: at Receiver.Writable.write (internal/streams/writable.js:303:10) Apr 27 07:04:17 volumio volumio[32136]: at Socket.socketOnData (/volumio/node_modules/engine.io-client/node_modules/ws/lib/websocket.js:819:35) Apr 27 07:04:17 volumio volumio[32136]: at Socket.emit (events.js:400:28) Apr 27 07:04:17 volumio volumio[32136]: at addChunk (internal/streams/readable.js:293:12) Apr 27 07:04:17 volumio volumio[32136]: at readableAddChunk (internal/streams/readable.js:267:9) Apr 27 07:04:17 volumio volumio[32136]: at Socket.Readable.push (internal/streams/readable.js:206:10) Apr 27 07:04:17 volumio volumio[32136]: at TCP.onStreamRead (internal/stream_base_commons.js:188:23) Apr 27 07:04:17 volumio volumio[32136]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 27 07:04:17 volumio sudo[32388]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-27 07:03 Apr 27 07:04:17 volumio sudo[32388]: 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"