-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Wed 2025-10-15 23:26:24 CEST. -- Oct 15 23:25:00 playerone volumio[3089]: info: Loading plugin "upnp_browser"... Oct 15 23:25:00 playerone volumio-remote-updater[587]: [2025-10-15 23:25:00] [connect] Successful connection Oct 15 23:25:00 playerone volumio[3089]: info: Loading plugin "alarm-clock"... Oct 15 23:25:00 playerone sudo[3127]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:00 playerone volumio[3089]: info: Loading plugin "airplay_emulation"... Oct 15 23:25:00 playerone volumio[3089]: info: Starting Shairport Sync Oct 15 23:25:00 playerone volumio[3089]: info: Loading plugin "last_100"... Oct 15 23:25:00 playerone volumio[3089]: info: Loading plugin "webradio"... Oct 15 23:25:00 playerone volumio[3089]: info: Loading plugin "i2s_dacs"... Oct 15 23:25:00 playerone volumio[3089]: info: I2S DAC not set, start Auto-detection Oct 15 23:25:00 playerone volumio[3089]: info: Loading plugin "volumiodiscovery"... Oct 15 23:25:00 playerone volumio[3089]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 15 23:25:00 playerone volumio[3089]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:25:00 playerone volumio[3089]: *** WARNING *** For more information see Oct 15 23:25:00 playerone node[3089]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 15 23:25:00 playerone volumio[3089]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 15 23:25:00 playerone volumio[3089]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:25:00 playerone volumio[3089]: *** WARNING *** For more information see Oct 15 23:25:00 playerone node[3089]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:25:00 playerone node[3089]: *** WARNING *** For more information see Oct 15 23:25:00 playerone node[3089]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 15 23:25:00 playerone node[3089]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:25:00 playerone node[3089]: *** WARNING *** For more information see Oct 15 23:25:00 playerone volumio[3089]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 15 23:25:00 playerone volumio[3089]: info: Discovery: Started advertising with name: playerONE Oct 15 23:25:00 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 23:25:00 playerone volumio[3089]: info: Loading plugin "outputs"... Oct 15 23:25:00 playerone volumio[3089]: info: Loading plugin "albumart"... Oct 15 23:25:00 playerone volumio[3089]: info: Plugin example_plugin is not enabled Oct 15 23:25:00 playerone volumio[3089]: info: Loading plugin "inputs"... Oct 15 23:25:00 playerone volumio[3089]: info: Loading plugin "updater_comm"... Oct 15 23:25:00 playerone volumio[3089]: info: Plugin mpdemulation is not enabled Oct 15 23:25:00 playerone volumio[3089]: info: Loading plugin "rest_api"... Oct 15 23:25:00 playerone volumio[3089]: info: Loading plugin "websocket"... Oct 15 23:25:01 playerone volumio[3089]: info: Starting Socket.io Server version 2.3.0 Oct 15 23:25:01 playerone volumio[3089]: info: Loading plugin "fusiondsp"... Oct 15 23:25:01 playerone volumio[3089]: Forking 3 albumart workers Oct 15 23:25:01 playerone volumio[3089]: info: Applying required configuration parameters for plugin fusiondsp Oct 15 23:25:01 playerone volumio[3089]: info: Loading i18n strings for locale en Oct 15 23:25:01 playerone volumio[3089]: Updating browse sources language Oct 15 23:25:01 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:01 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:25:01 playerone volumio[3089]: info: CoreCommandRouter::initPlayerControls Oct 15 23:25:01 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:01 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:01 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:01 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:01 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:01 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:01 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:01 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:01 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:25:01 playerone volumio[3089]: Express server listening on port 3000 Oct 15 23:25:01 playerone volumio[3089]: [Metrics] WebUI: 5s 60.45ms Oct 15 23:25:01 playerone volumio[3089]: info: CoreStateMachine::resetVolumioState Oct 15 23:25:01 playerone volumio[3089]: info: CoreStateMachine::getcurrentVolume Oct 15 23:25:01 playerone volumio[3089]: info: CoreCommandRouter::volumioRetrievevolume Oct 15 23:25:01 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:02 playerone volumio[3089]: info: Volumio Network Manager: Network status updated: 1 Oct 15 23:25:02 playerone volumio-remote-updater[587]: [2025-10-15 23:25:02] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1760563500 101 Oct 15 23:25:02 playerone volumio[3089]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Oct 15 23:25:02 playerone volumio[3089]: info: Reloading queue from file Oct 15 23:25:02 playerone volumio[3089]: info: CoreStateMachine::setRepeat null single undefined Oct 15 23:25:02 playerone volumio[3089]: info: CoreStateMachine::pushState Oct 15 23:25:02 playerone volumio[3089]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:02 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 23:25:02 playerone volumio[3089]: info: CoreCommandRouter::volumioPushState Oct 15 23:25:02 playerone volumio[3089]: info: CoreStateMachine::setRandom null Oct 15 23:25:02 playerone volumio[3089]: info: CoreStateMachine::pushState Oct 15 23:25:02 playerone volumio[3089]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:02 playerone volumio[3089]: info: CoreCommandRouter::volumioPushState Oct 15 23:25:02 playerone volumio[3089]: info: Setting Device type: Raspberry PI Oct 15 23:25:02 playerone volumio[3089]: info: VolumeController:: Volume=20 Mute =false Oct 15 23:25:02 playerone volumio[3089]: info: CoreStateMachine::pushState Oct 15 23:25:02 playerone volumio[3089]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:02 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 23:25:02 playerone volumio[3089]: Starting albumart workers Oct 15 23:25:02 playerone volumio[3089]: info: CoreCommandRouter::volumioPushState Oct 15 23:25:02 playerone volumio[3089]: info: CoreStateMachine::updateTrackBlock Oct 15 23:25:02 playerone volumio[3089]: info: CorePlayQueue::getTrackBlock Oct 15 23:25:02 playerone volumio[3089]: info: CoreCommandRouter::volumioRetrievevolume Oct 15 23:25:02 playerone volumio[3089]: Starting albumart workers Oct 15 23:25:02 playerone volumio[3089]: info: Discovery: adding 76640995-2991-45ef-aafc-08dc8d3a1ee7 Oct 15 23:25:02 playerone volumio[3089]: info: Discovery: Found device playerONE Oct 15 23:25:02 playerone volumio[3089]: info: CoreCommandRouter::volumioGetState Oct 15 23:25:02 playerone volumio[3089]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:02 playerone volumio[3089]: info: Discovery: this is already registered, 76640995-2991-45ef-aafc-08dc8d3a1ee7 Oct 15 23:25:02 playerone volumio[3089]: info: Discovery: Found device playerONE Oct 15 23:25:02 playerone volumio[3089]: info: CoreCommandRouter::volumioGetState Oct 15 23:25:02 playerone volumio[3089]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:02 playerone volumio[3089]: info: Completed loading Core Plugins Oct 15 23:25:02 playerone volumio[3089]: Starting albumart workers Oct 15 23:25:02 playerone volumio[3089]: info: Preparing to generate the ALSA configuration file Oct 15 23:25:02 playerone volumio[3089]: info: VolumeController:: Volume=20 Mute =false Oct 15 23:25:02 playerone volumio[3089]: info: CoreStateMachine::pushState Oct 15 23:25:02 playerone volumio[3089]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:02 playerone volumio[3089]: info: CoreCommandRouter::volumioPushState Oct 15 23:25:02 playerone volumio[3089]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 15 23:25:02 playerone volumio[3089]: info: Reading ALSA contributions from plugins. Oct 15 23:25:02 playerone volumio[3089]: info: Asound.conf file unchanged, so no further update is needed Oct 15 23:25:02 playerone volumio[3089]: info: Output device has changed, restarting MPD Oct 15 23:25:02 playerone volumio[3089]: info: Output device has changed, restarting Shairport Sync Oct 15 23:25:02 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:02 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:02 playerone sudo[3187]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 23:25:02 playerone sudo[3187]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:02 playerone sudo[3187]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:02 playerone sudo[3189]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 23:25:02 playerone sudo[3189]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:02 playerone systemd[1]: Stopping Music Player Daemon... Oct 15 23:25:02 playerone volumio[3089]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:25:02 playerone volumio[3089]: info: ___________ START PLUGINS ___________ Oct 15 23:25:02 playerone systemd[1]: mpd.service: Succeeded. Oct 15 23:25:02 playerone systemd[1]: Stopped Music Player Daemon. Oct 15 23:25:02 playerone volumio[3089]: info: ControllerMpd::onStart: Initializing MPD Oct 15 23:25:02 playerone volumio[3089]: info: Creating MPD Configuration file Oct 15 23:25:02 playerone systemd[1]: Starting Music Player Daemon... Oct 15 23:25:02 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:25:02 playerone volumio[3089]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 23:25:02 playerone volumio[3089]: info: [1760563502855] CoreMusicLibrary::Adding element Media Servers Oct 15 23:25:02 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:02 playerone sudo[3197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 23:25:02 playerone sudo[3197]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:02 playerone sudo[3197]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:02 playerone sudo[3199]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 23:25:02 playerone sudo[3199]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:02 playerone systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Oct 15 23:25:02 playerone systemd[1]: mpd.service: Succeeded. Oct 15 23:25:02 playerone systemd[1]: Stopped Music Player Daemon. Oct 15 23:25:02 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:02 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:03 playerone volumio[3089]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:03 playerone systemd[1]: Starting Music Player Daemon... Oct 15 23:25:03 playerone volumio[3089]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 23:25:03 playerone volumio[3089]: info: [1760563503097] CoreMusicLibrary::Adding element Last_100 Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 23:25:03 playerone volumio[3089]: info: [1760563503102] CoreMusicLibrary::Adding element Webradio Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:25:03 playerone volumio[3089]: info: Initializing BBC Radios Oct 15 23:25:03 playerone sudo[3202]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 15 23:25:03 playerone sudo[3202]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:03 playerone sudo[3202]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:03 playerone volumio[3089]: info: Loading i18n strings for locale en Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:03 playerone volumio[3089]: info: FusionDsp - mixtype--------------------- Hardware Oct 15 23:25:03 playerone volumio[3089]: info: Volumio Calling Home Oct 15 23:25:03 playerone volumio[3089]: info: Preparing to generate the ALSA configuration file Oct 15 23:25:03 playerone volumio[3089]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 15 23:25:03 playerone volumio[3089]: info: Reading ALSA contributions from plugins. Oct 15 23:25:03 playerone volumio[3089]: info: MPD Permissions set Oct 15 23:25:03 playerone volumio[3089]: info: MPD Permissions set Oct 15 23:25:03 playerone volumio[3089]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Oct 15 23:25:03 playerone volumio[3089]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Oct 15 23:25:03 playerone volumio[3089]: info: Volumio called home Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:03 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:03 playerone volumio[3089]: info: Starting Shairport Sync Oct 15 23:25:03 playerone volumio[3089]: info: Starting Shairport Sync Oct 15 23:25:04 playerone volumio[3089]: info: Starting Shairport Sync Oct 15 23:25:04 playerone sudo[3257]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:25:04 playerone sudo[3257]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:04 playerone sudo[3259]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:25:04 playerone sudo[3259]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:04 playerone systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 15 23:25:04 playerone systemd[1]: shairport-sync.service: Succeeded. Oct 15 23:25:04 playerone systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 15 23:25:04 playerone sudo[3262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:25:04 playerone sudo[3262]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:04 playerone volumio[3089]: info: CoreCommandRouter::volumioGetState Oct 15 23:25:04 playerone volumio[3089]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:04 playerone systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 15 23:25:04 playerone sudo[3257]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:04 playerone volumio[3089]: info: Asound.conf file unchanged, so no further update is needed Oct 15 23:25:04 playerone volumio[3089]: info: Output device has changed, restarting MPD Oct 15 23:25:04 playerone systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 15 23:25:04 playerone systemd[1]: shairport-sync.service: Succeeded. Oct 15 23:25:04 playerone systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 15 23:25:04 playerone systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 15 23:25:04 playerone volumio[3089]: info: Output device has changed, restarting Shairport Sync Oct 15 23:25:04 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:04 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:04 playerone sudo[3262]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:04 playerone sudo[3259]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:04 playerone sudo[3268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 23:25:04 playerone sudo[3268]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:04 playerone sudo[3268]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:04 playerone sudo[3271]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 23:25:04 playerone sudo[3271]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:04 playerone systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 15 23:25:04 playerone systemd[1]: mpd.service: Succeeded. Oct 15 23:25:04 playerone systemd[1]: Stopped Music Player Daemon. Oct 15 23:25:04 playerone volumio[3089]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:25:04 playerone systemd[1]: Starting Music Player Daemon... Oct 15 23:25:04 playerone volumio[3089]: info: CoreCommandRouter::volumioGetState Oct 15 23:25:04 playerone volumio[3089]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:04 playerone volumio[3089]: info: MPD Permissions set Oct 15 23:25:04 playerone volumio[3089]: info: Shairport-Sync Started Oct 15 23:25:04 playerone volumio[3089]: Error adding Membership: Error: addMembership EINVAL Oct 15 23:25:04 playerone volumio[3089]: info: Shairport-Sync Started Oct 15 23:25:04 playerone volumio[3089]: info: Shairport-Sync Started Oct 15 23:25:04 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:04 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:04 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:04 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:04 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:04 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:04 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:04 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:04 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:04 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:04 playerone sudo[3298]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 15 23:25:04 playerone sudo[3298]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:04 playerone sudo[3298]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:04 playerone volumio[3089]: info: CoreCommandRouter::volumioGetQueue Oct 15 23:25:04 playerone volumio[3089]: info: CoreStateMachine::getQueue Oct 15 23:25:04 playerone volumio[3089]: info: CorePlayQueue::getQueue Oct 15 23:25:04 playerone volumio[3089]: info: CoreCommandRouter::volumioGetVisibleSources Oct 15 23:25:04 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:04 playerone volumio[3089]: info: Listing playlists Oct 15 23:25:04 playerone volumio[3089]: info: Starting Shairport Sync Oct 15 23:25:04 playerone sudo[3326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:25:04 playerone sudo[3326]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:04 playerone systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 15 23:25:04 playerone systemd[1]: shairport-sync.service: Succeeded. Oct 15 23:25:04 playerone systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 15 23:25:04 playerone systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 15 23:25:04 playerone sudo[3326]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:04 playerone volumio[3089]: info: Shairport-Sync Started Oct 15 23:25:05 playerone volumio[3089]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Oct 15 23:25:05 playerone volumio[3089]: 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 Oct 15 23:25:05 playerone volumio[3089]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Oct 15 23:25:05 playerone volumio[3089]: info: camilladsp service started and running in background, instance 1 Oct 15 23:25:05 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:05 playerone volumio[3089]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Oct 15 23:25:05 playerone volumio[3089]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Oct 15 23:25:05 playerone volumio[3089]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Oct 15 23:25:05 playerone volumio[3089]: info: FusionDsp loaded Oct 15 23:25:05 playerone volumio[3089]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 23:25:05 playerone sudo[3341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Oct 15 23:25:05 playerone sudo[3341]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:05 playerone volumio[3089]: info: FusionDsp - Reporting Fusion DSP Enabled Oct 15 23:25:05 playerone volumio[3089]: info: Adding Signal Path Element [object Object] Oct 15 23:25:05 playerone volumio[3089]: info: Adding fusiondspeq DSP Signal Path Element Oct 15 23:25:05 playerone sudo[3341]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:05 playerone volumio[3089]: info: FusionDsp - ---- installed callbackRead Oct 15 23:25:05 playerone volumio[3089]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 23:25:05 playerone volumio[3089]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Oct 15 23:25:05 playerone volumio[3089]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Oct 15 23:25:05 playerone volumio[3089]: at onErrorNT (internal/child_process.js:465:16) Oct 15 23:25:05 playerone volumio[3089]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Oct 15 23:25:05 playerone volumio[3089]: errno: -2, Oct 15 23:25:05 playerone volumio[3089]: code: 'ENOENT', Oct 15 23:25:05 playerone volumio[3089]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Oct 15 23:25:05 playerone volumio[3089]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Oct 15 23:25:05 playerone volumio[3089]: spawnargs: [ Oct 15 23:25:05 playerone volumio[3089]: '-p', Oct 15 23:25:05 playerone volumio[3089]: 9876, Oct 15 23:25:05 playerone volumio[3089]: '-o', Oct 15 23:25:05 playerone volumio[3089]: '/tmp/camilladsp.log', Oct 15 23:25:05 playerone volumio[3089]: '-l', Oct 15 23:25:05 playerone volumio[3089]: 'warn', Oct 15 23:25:05 playerone volumio[3089]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Oct 15 23:25:05 playerone volumio[3089]: ] Oct 15 23:25:05 playerone volumio[3089]: } Oct 15 23:25:05 playerone volumio[3089]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 23:25:06 playerone sudo[3352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-15 23:24 Oct 15 23:25:06 playerone sudo[3352]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:06 playerone mpd[3324]: Oct 15 23:25 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 15 23:25:06 playerone systemd[1]: Started Music Player Daemon. Oct 15 23:25:06 playerone sudo[3189]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:06 playerone sudo[3199]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:06 playerone sudo[3271]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:06 playerone sudo[3352]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:06 playerone volumio-remote-updater[587]: [2025-10-15 23:25:06] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Oct 15 23:25:06 playerone volumio-remote-updater[587]: [2025-10-15 23:25:06] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Oct 15 23:25:06 playerone systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 15 23:25:06 playerone systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 15 23:25:06 playerone systemd[1]: Started dynamicswap service. Oct 15 23:25:06 playerone systemd[1]: dynamicswap.service: Succeeded. Oct 15 23:25:06 playerone systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Oct 15 23:25:06 playerone systemd[1]: volumio.service: Scheduled restart job, restart counter is at 10. Oct 15 23:25:06 playerone systemd[1]: Stopped Volumio Backend Module. Oct 15 23:25:06 playerone systemd[1]: Started Volumio Backend Module. Oct 15 23:25:06 playerone systemd[1]: Started dynamicswap service. Oct 15 23:25:06 playerone systemd[1]: dynamicswap.service: Succeeded. Oct 15 23:25:08 playerone volumio[3364]: info: ------------------------------------------- Oct 15 23:25:08 playerone volumio[3364]: info: ----- Volumio3 ---- Oct 15 23:25:08 playerone volumio[3364]: info: ------------------------------------------- Oct 15 23:25:08 playerone volumio[3364]: info: ----- System startup ---- Oct 15 23:25:08 playerone volumio[3364]: info: ------------------------------------------- Oct 15 23:25:09 playerone volumio[3364]: info: MYVOLUMIO Environment detected Oct 15 23:25:09 playerone volumio[3364]: info: Plugin folders cleanup Oct 15 23:25:09 playerone volumio[3364]: info: Scanning into folder /volumio/app/plugins/ Oct 15 23:25:09 playerone volumio[3364]: info: Scanning category audio_interface Oct 15 23:25:09 playerone volumio[3364]: info: Scanning category miscellanea Oct 15 23:25:09 playerone volumio[3364]: info: Scanning category music_service Oct 15 23:25:09 playerone volumio[3364]: info: Scanning category plugins.json Oct 15 23:25:09 playerone volumio[3364]: info: Scanning category system_controller Oct 15 23:25:09 playerone volumio[3364]: info: Scanning category user_interface Oct 15 23:25:09 playerone volumio[3364]: info: Scanning into folder /data/plugins/ Oct 15 23:25:09 playerone volumio[3364]: info: Scanning category audio_interface Oct 15 23:25:09 playerone volumio[3364]: info: Plugin folders cleanup completed Oct 15 23:25:09 playerone volumio[3364]: info: ------------------------------------------- Oct 15 23:25:09 playerone volumio[3364]: info: ----- Core plugins startup ---- Oct 15 23:25:09 playerone volumio[3364]: info: ------------------------------------------- Oct 15 23:25:09 playerone volumio[3364]: info: Loading plugins from folder /volumio/app/plugins/ Oct 15 23:25:09 playerone volumio[3364]: info: Adding plugin upnp to MyMusic Plugins Oct 15 23:25:09 playerone volumio[3364]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 15 23:25:09 playerone volumio[3364]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 15 23:25:09 playerone volumio[3364]: info: Loading plugins from folder /data/plugins/ Oct 15 23:25:09 playerone volumio[3364]: info: Loading plugin "system"... Oct 15 23:25:09 playerone volumio[3364]: info: Loading plugin "appearance"... Oct 15 23:25:10 playerone volumio[3364]: info: Loading plugin "network"... Oct 15 23:25:10 playerone volumio[3364]: info: Refreshing Cached IP Addresses Oct 15 23:25:10 playerone sudo[3391]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 15 23:25:10 playerone sudo[3391]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:10 playerone sudo[3391]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:10 playerone sudo[3393]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 15 23:25:10 playerone sudo[3393]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:10 playerone sudo[3393]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:10 playerone volumio[3364]: info: Loading plugin "services"... Oct 15 23:25:10 playerone volumio[3364]: info: Loading plugin "alsa_controller"... Oct 15 23:25:10 playerone sudo[3406]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 15 23:25:10 playerone sudo[3406]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:10 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:25:10 playerone volumio[3364]: info: Loading plugin "wizard"... Oct 15 23:25:10 playerone volumio[3364]: info: Loading plugin "networkfs"... Oct 15 23:25:10 playerone volumio[3364]: info: Starting Udev Watcher for removable devices Oct 15 23:25:10 playerone volumio[3364]: info: Ignoring mount for partition: boot Oct 15 23:25:10 playerone volumio[3364]: info: Ignoring mount for partition: volumio Oct 15 23:25:10 playerone volumio[3364]: info: Ignoring mount for partition: volumio_data Oct 15 23:25:10 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 23:25:10 playerone volumio[3364]: info: Loading plugin "volumio_command_line_client"... Oct 15 23:25:10 playerone volumio[3364]: info: Loading plugin "upnp"... Oct 15 23:25:10 playerone volumio[3364]: info: [1760563510629] Starting Upmpd Daemon Oct 15 23:25:10 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 23:25:10 playerone volumio[3364]: info: Loading plugin "my_music"... Oct 15 23:25:10 playerone volumio[3364]: info: Loading plugin "mpd"... Oct 15 23:25:10 playerone volumio[3364]: info: Loading plugin "upnp_browser"... Oct 15 23:25:11 playerone volumio-remote-updater[587]: [2025-10-15 23:25:11] [connect] Successful connection Oct 15 23:25:11 playerone sudo[3406]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:11 playerone volumio[3364]: info: Loading plugin "alarm-clock"... Oct 15 23:25:11 playerone volumio[3364]: info: Loading plugin "airplay_emulation"... Oct 15 23:25:11 playerone volumio[3364]: info: Starting Shairport Sync Oct 15 23:25:11 playerone volumio[3364]: info: Loading plugin "last_100"... Oct 15 23:25:11 playerone volumio[3364]: info: Loading plugin "webradio"... Oct 15 23:25:11 playerone volumio[3364]: info: Loading plugin "i2s_dacs"... Oct 15 23:25:11 playerone volumio[3364]: info: I2S DAC not set, start Auto-detection Oct 15 23:25:11 playerone volumio[3364]: info: Loading plugin "volumiodiscovery"... Oct 15 23:25:11 playerone volumio[3364]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 15 23:25:11 playerone volumio[3364]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:25:11 playerone volumio[3364]: *** WARNING *** For more information see Oct 15 23:25:11 playerone node[3364]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 15 23:25:11 playerone volumio[3364]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 15 23:25:11 playerone volumio[3364]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:25:11 playerone volumio[3364]: *** WARNING *** For more information see Oct 15 23:25:11 playerone node[3364]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:25:11 playerone node[3364]: *** WARNING *** For more information see Oct 15 23:25:11 playerone node[3364]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 15 23:25:11 playerone node[3364]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:25:11 playerone node[3364]: *** WARNING *** For more information see Oct 15 23:25:11 playerone volumio[3364]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 15 23:25:11 playerone volumio[3364]: info: Discovery: Started advertising with name: playerONE Oct 15 23:25:11 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 23:25:11 playerone volumio[3364]: info: Loading plugin "outputs"... Oct 15 23:25:11 playerone volumio[3364]: info: Loading plugin "albumart"... Oct 15 23:25:11 playerone volumio[3364]: info: Plugin example_plugin is not enabled Oct 15 23:25:11 playerone volumio[3364]: info: Loading plugin "inputs"... Oct 15 23:25:11 playerone volumio[3364]: info: Loading plugin "updater_comm"... Oct 15 23:25:11 playerone volumio[3364]: info: Plugin mpdemulation is not enabled Oct 15 23:25:11 playerone volumio[3364]: info: Loading plugin "rest_api"... Oct 15 23:25:12 playerone volumio[3364]: info: Loading plugin "websocket"... Oct 15 23:25:12 playerone volumio[3364]: info: Starting Socket.io Server version 2.3.0 Oct 15 23:25:12 playerone volumio[3364]: info: Loading plugin "fusiondsp"... Oct 15 23:25:12 playerone volumio[3364]: Forking 3 albumart workers Oct 15 23:25:12 playerone volumio[3364]: info: Applying required configuration parameters for plugin fusiondsp Oct 15 23:25:12 playerone volumio[3364]: info: Loading i18n strings for locale en Oct 15 23:25:12 playerone volumio[3364]: Updating browse sources language Oct 15 23:25:12 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:12 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:25:12 playerone volumio[3364]: info: CoreCommandRouter::initPlayerControls Oct 15 23:25:12 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:12 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:12 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:12 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:12 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:12 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:12 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:12 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:12 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:25:12 playerone volumio[3364]: Express server listening on port 3000 Oct 15 23:25:12 playerone volumio[3364]: [Metrics] WebUI: 5s 138.80ms Oct 15 23:25:12 playerone volumio[3364]: info: CoreStateMachine::resetVolumioState Oct 15 23:25:12 playerone volumio[3364]: info: CoreStateMachine::getcurrentVolume Oct 15 23:25:12 playerone volumio[3364]: info: CoreCommandRouter::volumioRetrievevolume Oct 15 23:25:13 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:13 playerone volumio[3364]: info: Volumio Network Manager: Network status updated: 1 Oct 15 23:25:13 playerone volumio[3364]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Oct 15 23:25:13 playerone volumio[3364]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Oct 15 23:25:13 playerone volumio[3364]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Oct 15 23:25:13 playerone volumio[3364]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Oct 15 23:25:13 playerone volumio-remote-updater[587]: [2025-10-15 23:25:13] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1760563511 101 Oct 15 23:25:13 playerone volumio[3364]: 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 Oct 15 23:25:13 playerone volumio[3364]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Oct 15 23:25:13 playerone volumio[3364]: Starting albumart workers Oct 15 23:25:13 playerone volumio[3364]: Starting albumart workers Oct 15 23:25:13 playerone volumio[3364]: Starting albumart workers Oct 15 23:25:13 playerone volumio[3364]: info: Reloading queue from file Oct 15 23:25:13 playerone volumio[3364]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 15 23:25:13 playerone volumio[3364]: info: CoreStateMachine::setRepeat null single undefined Oct 15 23:25:13 playerone volumio[3364]: info: CoreStateMachine::pushState Oct 15 23:25:13 playerone volumio[3364]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:13 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 23:25:13 playerone volumio[3364]: info: CoreCommandRouter::volumioPushState Oct 15 23:25:13 playerone volumio[3364]: info: CoreStateMachine::setRandom null Oct 15 23:25:13 playerone volumio[3364]: info: CoreStateMachine::pushState Oct 15 23:25:13 playerone volumio[3364]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:13 playerone volumio[3364]: info: CoreCommandRouter::volumioPushState Oct 15 23:25:13 playerone volumio[3364]: info: Setting Device type: Raspberry PI Oct 15 23:25:13 playerone volumio[3364]: info: VolumeController:: Volume=20 Mute =false Oct 15 23:25:13 playerone volumio[3364]: info: CoreStateMachine::pushState Oct 15 23:25:13 playerone volumio[3364]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:13 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 23:25:13 playerone volumio[3364]: info: CoreCommandRouter::volumioPushState Oct 15 23:25:13 playerone volumio[3364]: info: CoreStateMachine::updateTrackBlock Oct 15 23:25:13 playerone volumio[3364]: info: CorePlayQueue::getTrackBlock Oct 15 23:25:13 playerone volumio[3364]: info: CoreCommandRouter::volumioRetrievevolume Oct 15 23:25:13 playerone volumio[3364]: info: Completed loading Core Plugins Oct 15 23:25:13 playerone volumio[3364]: info: Preparing to generate the ALSA configuration file Oct 15 23:25:13 playerone volumio[3364]: info: Discovery: adding 76640995-2991-45ef-aafc-08dc8d3a1ee7 Oct 15 23:25:13 playerone volumio[3364]: info: Discovery: Found device playerONE Oct 15 23:25:13 playerone volumio[3364]: info: CoreCommandRouter::volumioGetState Oct 15 23:25:13 playerone volumio[3364]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:13 playerone volumio[3364]: info: Discovery: this is already registered, 76640995-2991-45ef-aafc-08dc8d3a1ee7 Oct 15 23:25:13 playerone volumio[3364]: info: Discovery: Found device playerONE Oct 15 23:25:13 playerone volumio[3364]: info: CoreCommandRouter::volumioGetState Oct 15 23:25:13 playerone volumio[3364]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:13 playerone volumio[3364]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 15 23:25:13 playerone volumio[3364]: info: Reading ALSA contributions from plugins. Oct 15 23:25:13 playerone volumio[3364]: info: CoreCommandRouter::volumioGetState Oct 15 23:25:13 playerone volumio[3364]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:13 playerone volumio[3364]: info: CoreCommandRouter::volumioGetQueue Oct 15 23:25:13 playerone volumio[3364]: info: CoreStateMachine::getQueue Oct 15 23:25:13 playerone volumio[3364]: info: CorePlayQueue::getQueue Oct 15 23:25:13 playerone volumio[3364]: info: CoreCommandRouter::volumioGetVisibleSources Oct 15 23:25:13 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:13 playerone volumio[3364]: info: Listing playlists Oct 15 23:25:13 playerone volumio[3364]: info: VolumeController:: Volume=20 Mute =false Oct 15 23:25:13 playerone volumio[3364]: info: CoreStateMachine::pushState Oct 15 23:25:13 playerone volumio[3364]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:13 playerone volumio[3364]: info: CoreCommandRouter::volumioPushState Oct 15 23:25:14 playerone volumio[3364]: info: Asound.conf file unchanged, so no further update is needed Oct 15 23:25:14 playerone volumio[3364]: info: Output device has changed, restarting MPD Oct 15 23:25:14 playerone volumio[3364]: info: Output device has changed, restarting Shairport Sync Oct 15 23:25:14 playerone sudo[3462]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:14 playerone sudo[3462]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:14 playerone sudo[3462]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:14 playerone sudo[3464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 23:25:14 playerone sudo[3464]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:14 playerone volumio[3364]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:25:14 playerone volumio[3364]: info: ___________ START PLUGINS ___________ Oct 15 23:25:14 playerone systemd[1]: Stopping Music Player Daemon... Oct 15 23:25:14 playerone volumio[3364]: info: ControllerMpd::onStart: Initializing MPD Oct 15 23:25:14 playerone volumio[3364]: info: Creating MPD Configuration file Oct 15 23:25:14 playerone systemd[1]: mpd.service: Succeeded. Oct 15 23:25:14 playerone systemd[1]: Stopped Music Player Daemon. Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 23:25:14 playerone volumio[3364]: info: [1760563514265] CoreMusicLibrary::Adding element Media Servers Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:14 playerone sudo[3498]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 23:25:14 playerone sudo[3495]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 23:25:14 playerone systemd[1]: Starting Music Player Daemon... Oct 15 23:25:14 playerone sudo[3498]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:14 playerone sudo[3495]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:14 playerone sudo[3495]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:14 playerone systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Oct 15 23:25:14 playerone systemd[1]: mpd.service: Succeeded. Oct 15 23:25:14 playerone systemd[1]: Stopped Music Player Daemon. Oct 15 23:25:14 playerone systemd[1]: Starting Music Player Daemon... Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 23:25:14 playerone volumio[3364]: info: [1760563514453] CoreMusicLibrary::Adding element Last_100 Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 23:25:14 playerone volumio[3364]: info: [1760563514458] CoreMusicLibrary::Adding element Webradio Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:25:14 playerone volumio[3364]: info: Initializing BBC Radios Oct 15 23:25:14 playerone sudo[3501]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 15 23:25:14 playerone sudo[3501]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:14 playerone sudo[3501]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: Loading i18n strings for locale en Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: FusionDsp - mixtype--------------------- Hardware Oct 15 23:25:14 playerone volumio[3364]: info: Volumio Calling Home Oct 15 23:25:14 playerone volumio[3364]: info: Preparing to generate the ALSA configuration file Oct 15 23:25:14 playerone volumio[3364]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 15 23:25:14 playerone volumio[3364]: info: Reading ALSA contributions from plugins. Oct 15 23:25:14 playerone volumio[3364]: info: MPD Permissions set Oct 15 23:25:14 playerone volumio[3364]: info: MPD Permissions set Oct 15 23:25:14 playerone volumio[3364]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Oct 15 23:25:14 playerone volumio[3364]: info: Volumio called home Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:14 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:15 playerone volumio[3364]: info: Starting Shairport Sync Oct 15 23:25:15 playerone volumio[3364]: info: Starting Shairport Sync Oct 15 23:25:15 playerone volumio[3364]: info: Starting Shairport Sync Oct 15 23:25:15 playerone sudo[3534]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:25:15 playerone sudo[3534]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:15 playerone sudo[3536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:25:15 playerone sudo[3536]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:15 playerone volumio[3364]: info: CoreCommandRouter::volumioGetState Oct 15 23:25:15 playerone volumio[3364]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:15 playerone sudo[3539]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:25:15 playerone sudo[3539]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:15 playerone systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 15 23:25:15 playerone systemd[1]: shairport-sync.service: Succeeded. Oct 15 23:25:15 playerone systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 15 23:25:15 playerone volumio[3364]: info: Asound.conf file unchanged, so no further update is needed Oct 15 23:25:15 playerone volumio[3364]: info: Output device has changed, restarting MPD Oct 15 23:25:15 playerone sudo[3544]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 23:25:15 playerone sudo[3544]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:15 playerone volumio[3364]: info: Output device has changed, restarting Shairport Sync Oct 15 23:25:15 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:15 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:15 playerone sudo[3544]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:15 playerone sudo[3546]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 23:25:15 playerone sudo[3546]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:15 playerone systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 15 23:25:15 playerone sudo[3534]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:15 playerone volumio[3364]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:25:15 playerone systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 15 23:25:15 playerone systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 15 23:25:15 playerone systemd[1]: mpd.service: Succeeded. Oct 15 23:25:15 playerone systemd[1]: Stopped Music Player Daemon. Oct 15 23:25:15 playerone systemd[1]: shairport-sync.service: Succeeded. Oct 15 23:25:15 playerone systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 15 23:25:15 playerone volumio[3364]: info: MPD Permissions set Oct 15 23:25:15 playerone volumio[3364]: info: Shairport-Sync Started Oct 15 23:25:15 playerone volumio[3364]: Error adding Membership: Error: addMembership EINVAL Oct 15 23:25:15 playerone systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 15 23:25:15 playerone sudo[3536]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:15 playerone sudo[3539]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:15 playerone systemd[1]: Starting Music Player Daemon... Oct 15 23:25:15 playerone volumio[3364]: info: Shairport-Sync Started Oct 15 23:25:15 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:15 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:15 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:15 playerone volumio[3364]: info: Starting Shairport Sync Oct 15 23:25:15 playerone sudo[3563]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:25:15 playerone sudo[3563]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:15 playerone systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 15 23:25:15 playerone systemd[1]: shairport-sync.service: Succeeded. Oct 15 23:25:15 playerone sudo[3554]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 15 23:25:15 playerone systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 15 23:25:15 playerone sudo[3554]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:15 playerone sudo[3554]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:15 playerone systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 15 23:25:15 playerone sudo[3563]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:15 playerone volumio[3364]: info: Shairport-Sync Started Oct 15 23:25:16 playerone volumio[3364]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Oct 15 23:25:16 playerone volumio[3364]: 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 Oct 15 23:25:16 playerone volumio[3364]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Oct 15 23:25:16 playerone volumio[3364]: info: camilladsp service started and running in background, instance 1 Oct 15 23:25:16 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:16 playerone volumio[3364]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Oct 15 23:25:16 playerone volumio[3364]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Oct 15 23:25:16 playerone volumio[3364]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Oct 15 23:25:16 playerone volumio[3364]: info: FusionDsp loaded Oct 15 23:25:16 playerone volumio[3364]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 23:25:16 playerone sudo[3580]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Oct 15 23:25:16 playerone sudo[3580]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:16 playerone volumio[3364]: info: FusionDsp - Reporting Fusion DSP Enabled Oct 15 23:25:16 playerone volumio[3364]: info: Adding Signal Path Element [object Object] Oct 15 23:25:16 playerone volumio[3364]: info: Adding fusiondspeq DSP Signal Path Element Oct 15 23:25:16 playerone volumio[3364]: info: FusionDsp - ---- installed callbackRead Oct 15 23:25:16 playerone volumio[3364]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 23:25:16 playerone sudo[3580]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:16 playerone volumio[3364]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Oct 15 23:25:16 playerone volumio[3364]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Oct 15 23:25:16 playerone volumio[3364]: at onErrorNT (internal/child_process.js:465:16) Oct 15 23:25:16 playerone volumio[3364]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Oct 15 23:25:16 playerone volumio[3364]: errno: -2, Oct 15 23:25:16 playerone volumio[3364]: code: 'ENOENT', Oct 15 23:25:16 playerone volumio[3364]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Oct 15 23:25:16 playerone volumio[3364]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Oct 15 23:25:16 playerone volumio[3364]: spawnargs: [ Oct 15 23:25:16 playerone volumio[3364]: '-p', Oct 15 23:25:16 playerone volumio[3364]: 9876, Oct 15 23:25:16 playerone volumio[3364]: '-o', Oct 15 23:25:16 playerone volumio[3364]: '/tmp/camilladsp.log', Oct 15 23:25:16 playerone volumio[3364]: '-l', Oct 15 23:25:16 playerone volumio[3364]: 'warn', Oct 15 23:25:16 playerone volumio[3364]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Oct 15 23:25:16 playerone volumio[3364]: ] Oct 15 23:25:16 playerone volumio[3364]: } Oct 15 23:25:16 playerone volumio[3364]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 23:25:17 playerone mpd[3567]: Oct 15 23:25 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 15 23:25:17 playerone systemd[1]: Started Music Player Daemon. Oct 15 23:25:17 playerone sudo[3546]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:17 playerone sudo[3498]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:17 playerone sudo[3464]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:17 playerone sudo[3594]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-15 23:24 Oct 15 23:25:17 playerone sudo[3594]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:17 playerone sudo[3594]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:17 playerone volumio-remote-updater[587]: [2025-10-15 23:25:17] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Oct 15 23:25:17 playerone volumio-remote-updater[587]: [2025-10-15 23:25:17] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Oct 15 23:25:17 playerone systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 15 23:25:17 playerone systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 15 23:25:17 playerone systemd[1]: Started dynamicswap service. Oct 15 23:25:17 playerone systemd[1]: dynamicswap.service: Succeeded. Oct 15 23:25:17 playerone systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Oct 15 23:25:17 playerone systemd[1]: volumio.service: Scheduled restart job, restart counter is at 11. Oct 15 23:25:17 playerone systemd[1]: Stopped Volumio Backend Module. Oct 15 23:25:17 playerone systemd[1]: Started Volumio Backend Module. Oct 15 23:25:17 playerone systemd[1]: Started dynamicswap service. Oct 15 23:25:17 playerone systemd[1]: dynamicswap.service: Succeeded. Oct 15 23:25:19 playerone volumio[3604]: info: ------------------------------------------- Oct 15 23:25:19 playerone volumio[3604]: info: ----- Volumio3 ---- Oct 15 23:25:19 playerone volumio[3604]: info: ------------------------------------------- Oct 15 23:25:19 playerone volumio[3604]: info: ----- System startup ---- Oct 15 23:25:19 playerone volumio[3604]: info: ------------------------------------------- Oct 15 23:25:20 playerone volumio[3604]: info: MYVOLUMIO Environment detected Oct 15 23:25:20 playerone volumio[3604]: info: Plugin folders cleanup Oct 15 23:25:20 playerone volumio[3604]: info: Scanning into folder /volumio/app/plugins/ Oct 15 23:25:20 playerone volumio[3604]: info: Scanning category audio_interface Oct 15 23:25:20 playerone volumio[3604]: info: Scanning category miscellanea Oct 15 23:25:20 playerone volumio[3604]: info: Scanning category music_service Oct 15 23:25:20 playerone volumio[3604]: info: Scanning category plugins.json Oct 15 23:25:20 playerone volumio[3604]: info: Scanning category system_controller Oct 15 23:25:20 playerone volumio[3604]: info: Scanning category user_interface Oct 15 23:25:20 playerone volumio[3604]: info: Scanning into folder /data/plugins/ Oct 15 23:25:20 playerone volumio[3604]: info: Scanning category audio_interface Oct 15 23:25:20 playerone volumio[3604]: info: Plugin folders cleanup completed Oct 15 23:25:20 playerone volumio[3604]: info: ------------------------------------------- Oct 15 23:25:20 playerone volumio[3604]: info: ----- Core plugins startup ---- Oct 15 23:25:20 playerone volumio[3604]: info: ------------------------------------------- Oct 15 23:25:20 playerone volumio[3604]: info: Loading plugins from folder /volumio/app/plugins/ Oct 15 23:25:20 playerone volumio[3604]: info: Adding plugin upnp to MyMusic Plugins Oct 15 23:25:20 playerone volumio[3604]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 15 23:25:20 playerone volumio[3604]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 15 23:25:20 playerone volumio[3604]: info: Loading plugins from folder /data/plugins/ Oct 15 23:25:20 playerone volumio[3604]: info: Loading plugin "system"... Oct 15 23:25:20 playerone volumio[3604]: info: Loading plugin "appearance"... Oct 15 23:25:21 playerone volumio[3604]: info: Loading plugin "network"... Oct 15 23:25:21 playerone volumio[3604]: info: Refreshing Cached IP Addresses Oct 15 23:25:21 playerone sudo[3631]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 15 23:25:21 playerone sudo[3631]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:21 playerone sudo[3631]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:21 playerone sudo[3633]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 15 23:25:21 playerone sudo[3633]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:21 playerone sudo[3633]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:21 playerone volumio[3604]: info: Loading plugin "services"... Oct 15 23:25:21 playerone volumio[3604]: info: Loading plugin "alsa_controller"... Oct 15 23:25:21 playerone sudo[3642]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 15 23:25:21 playerone sudo[3642]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:21 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:25:21 playerone volumio[3604]: info: Loading plugin "wizard"... Oct 15 23:25:21 playerone volumio[3604]: info: Loading plugin "networkfs"... Oct 15 23:25:21 playerone volumio[3604]: info: Starting Udev Watcher for removable devices Oct 15 23:25:21 playerone volumio[3604]: info: Ignoring mount for partition: boot Oct 15 23:25:21 playerone volumio[3604]: info: Ignoring mount for partition: volumio Oct 15 23:25:21 playerone volumio[3604]: info: Ignoring mount for partition: volumio_data Oct 15 23:25:21 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 23:25:21 playerone volumio[3604]: info: Loading plugin "volumio_command_line_client"... Oct 15 23:25:21 playerone volumio[3604]: info: Loading plugin "upnp"... Oct 15 23:25:21 playerone volumio[3604]: info: [1760563521981] Starting Upmpd Daemon Oct 15 23:25:21 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 23:25:21 playerone volumio[3604]: info: Loading plugin "my_music"... Oct 15 23:25:21 playerone volumio[3604]: info: Loading plugin "mpd"... Oct 15 23:25:22 playerone volumio[3604]: info: Loading plugin "upnp_browser"... Oct 15 23:25:22 playerone volumio-remote-updater[587]: [2025-10-15 23:25:22] [connect] Successful connection Oct 15 23:25:22 playerone volumio[3604]: info: Loading plugin "alarm-clock"... Oct 15 23:25:22 playerone sudo[3642]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:22 playerone volumio[3604]: info: Loading plugin "airplay_emulation"... Oct 15 23:25:22 playerone volumio[3604]: info: Starting Shairport Sync Oct 15 23:25:22 playerone volumio[3604]: info: Loading plugin "last_100"... Oct 15 23:25:22 playerone volumio[3604]: info: Loading plugin "webradio"... Oct 15 23:25:22 playerone volumio[3604]: info: Loading plugin "i2s_dacs"... Oct 15 23:25:22 playerone volumio[3604]: info: I2S DAC not set, start Auto-detection Oct 15 23:25:22 playerone volumio[3604]: info: Loading plugin "volumiodiscovery"... Oct 15 23:25:23 playerone volumio[3604]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 15 23:25:23 playerone volumio[3604]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:25:23 playerone volumio[3604]: *** WARNING *** For more information see Oct 15 23:25:23 playerone node[3604]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 15 23:25:23 playerone volumio[3604]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 15 23:25:23 playerone volumio[3604]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:25:23 playerone volumio[3604]: *** WARNING *** For more information see Oct 15 23:25:23 playerone node[3604]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:25:23 playerone node[3604]: *** WARNING *** For more information see Oct 15 23:25:23 playerone node[3604]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 15 23:25:23 playerone node[3604]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:25:23 playerone node[3604]: *** WARNING *** For more information see Oct 15 23:25:23 playerone volumio[3604]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 15 23:25:23 playerone volumio[3604]: info: Discovery: Started advertising with name: playerONE Oct 15 23:25:23 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 23:25:23 playerone volumio[3604]: info: Loading plugin "outputs"... Oct 15 23:25:23 playerone volumio[3604]: info: Loading plugin "albumart"... Oct 15 23:25:23 playerone volumio[3604]: info: Plugin example_plugin is not enabled Oct 15 23:25:23 playerone volumio[3604]: info: Loading plugin "inputs"... Oct 15 23:25:23 playerone volumio[3604]: info: Loading plugin "updater_comm"... Oct 15 23:25:23 playerone volumio[3604]: info: Plugin mpdemulation is not enabled Oct 15 23:25:23 playerone volumio[3604]: info: Loading plugin "rest_api"... Oct 15 23:25:23 playerone volumio[3604]: info: Loading plugin "websocket"... Oct 15 23:25:23 playerone volumio[3604]: info: Starting Socket.io Server version 2.3.0 Oct 15 23:25:23 playerone volumio[3604]: info: Loading plugin "fusiondsp"... Oct 15 23:25:23 playerone volumio[3604]: Forking 3 albumart workers Oct 15 23:25:23 playerone volumio[3604]: info: Applying required configuration parameters for plugin fusiondsp Oct 15 23:25:23 playerone volumio[3604]: info: Loading i18n strings for locale en Oct 15 23:25:23 playerone volumio[3604]: Updating browse sources language Oct 15 23:25:23 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:24 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:25:24 playerone volumio[3604]: info: CoreCommandRouter::initPlayerControls Oct 15 23:25:24 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:24 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:24 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:24 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:24 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:24 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:24 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:24 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:24 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:25:24 playerone volumio[3604]: Express server listening on port 3000 Oct 15 23:25:24 playerone volumio[3604]: [Metrics] WebUI: 5s 65.20ms Oct 15 23:25:24 playerone volumio[3604]: info: CoreStateMachine::resetVolumioState Oct 15 23:25:24 playerone volumio[3604]: info: CoreStateMachine::getcurrentVolume Oct 15 23:25:24 playerone volumio[3604]: info: CoreCommandRouter::volumioRetrievevolume Oct 15 23:25:24 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:24 playerone volumio[3604]: info: Volumio Network Manager: Network status updated: 1 Oct 15 23:25:24 playerone volumio[3604]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Oct 15 23:25:24 playerone volumio[3604]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Oct 15 23:25:24 playerone volumio[3604]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Oct 15 23:25:24 playerone volumio[3604]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Oct 15 23:25:24 playerone volumio-remote-updater[587]: [2025-10-15 23:25:24] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1760563522 101 Oct 15 23:25:24 playerone volumio[3604]: 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 Oct 15 23:25:24 playerone volumio[3604]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Oct 15 23:25:24 playerone volumio[3604]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 15 23:25:24 playerone volumio[3604]: Starting albumart workers Oct 15 23:25:24 playerone volumio[3604]: info: Reloading queue from file Oct 15 23:25:24 playerone volumio[3604]: info: CoreStateMachine::setRepeat null single undefined Oct 15 23:25:24 playerone volumio[3604]: info: CoreStateMachine::pushState Oct 15 23:25:24 playerone volumio[3604]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:24 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 23:25:24 playerone volumio[3604]: info: CoreCommandRouter::volumioPushState Oct 15 23:25:24 playerone volumio[3604]: info: CoreStateMachine::setRandom null Oct 15 23:25:24 playerone volumio[3604]: info: CoreStateMachine::pushState Oct 15 23:25:24 playerone volumio[3604]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:24 playerone volumio[3604]: info: CoreCommandRouter::volumioPushState Oct 15 23:25:24 playerone volumio[3604]: info: Setting Device type: Raspberry PI Oct 15 23:25:24 playerone volumio[3604]: info: CoreCommandRouter::volumioGetState Oct 15 23:25:24 playerone volumio[3604]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:24 playerone volumio[3604]: Starting albumart workers Oct 15 23:25:24 playerone volumio[3604]: info: VolumeController:: Volume=20 Mute =false Oct 15 23:25:24 playerone volumio[3604]: info: CoreStateMachine::pushState Oct 15 23:25:24 playerone volumio[3604]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:24 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 23:25:24 playerone volumio[3604]: info: CoreCommandRouter::volumioPushState Oct 15 23:25:24 playerone volumio[3604]: info: CoreStateMachine::updateTrackBlock Oct 15 23:25:24 playerone volumio[3604]: info: CorePlayQueue::getTrackBlock Oct 15 23:25:24 playerone volumio[3604]: info: CoreCommandRouter::volumioRetrievevolume Oct 15 23:25:24 playerone volumio[3604]: Starting albumart workers Oct 15 23:25:24 playerone volumio[3604]: info: CoreCommandRouter::volumioGetQueue Oct 15 23:25:24 playerone volumio[3604]: info: CoreStateMachine::getQueue Oct 15 23:25:24 playerone volumio[3604]: info: CorePlayQueue::getQueue Oct 15 23:25:24 playerone volumio[3604]: info: CoreCommandRouter::volumioGetVisibleSources Oct 15 23:25:24 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:24 playerone volumio[3604]: info: Listing playlists Oct 15 23:25:25 playerone volumio[3604]: info: Completed loading Core Plugins Oct 15 23:25:25 playerone volumio[3604]: info: Preparing to generate the ALSA configuration file Oct 15 23:25:25 playerone volumio[3604]: info: Discovery: adding 76640995-2991-45ef-aafc-08dc8d3a1ee7 Oct 15 23:25:25 playerone volumio[3604]: info: Discovery: Found device playerONE Oct 15 23:25:25 playerone volumio[3604]: info: CoreCommandRouter::volumioGetState Oct 15 23:25:25 playerone volumio[3604]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:25 playerone volumio[3604]: info: Discovery: this is already registered, 76640995-2991-45ef-aafc-08dc8d3a1ee7 Oct 15 23:25:25 playerone volumio[3604]: info: Discovery: Found device playerONE Oct 15 23:25:25 playerone volumio[3604]: info: CoreCommandRouter::volumioGetState Oct 15 23:25:25 playerone volumio[3604]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:25 playerone volumio[3604]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 15 23:25:25 playerone volumio[3604]: info: Reading ALSA contributions from plugins. Oct 15 23:25:25 playerone volumio[3604]: info: VolumeController:: Volume=20 Mute =false Oct 15 23:25:25 playerone volumio[3604]: info: CoreStateMachine::pushState Oct 15 23:25:25 playerone volumio[3604]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:25 playerone volumio[3604]: info: CoreCommandRouter::volumioPushState Oct 15 23:25:25 playerone volumio[3604]: info: Asound.conf file unchanged, so no further update is needed Oct 15 23:25:25 playerone volumio[3604]: info: Output device has changed, restarting MPD Oct 15 23:25:25 playerone volumio[3604]: info: Output device has changed, restarting Shairport Sync Oct 15 23:25:25 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:25 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:25 playerone sudo[3702]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 23:25:25 playerone sudo[3702]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:25 playerone sudo[3708]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 23:25:25 playerone sudo[3708]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:25 playerone sudo[3702]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:25 playerone systemd[1]: Stopping Music Player Daemon... Oct 15 23:25:25 playerone systemd[1]: mpd.service: Succeeded. Oct 15 23:25:25 playerone systemd[1]: Stopped Music Player Daemon. Oct 15 23:25:25 playerone volumio[3604]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:25:25 playerone volumio[3604]: info: ___________ START PLUGINS ___________ Oct 15 23:25:25 playerone volumio[3604]: info: ControllerMpd::onStart: Initializing MPD Oct 15 23:25:25 playerone systemd[1]: Starting Music Player Daemon... Oct 15 23:25:25 playerone volumio[3604]: info: Creating MPD Configuration file Oct 15 23:25:25 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:25:25 playerone volumio[3604]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 23:25:25 playerone volumio[3604]: info: [1760563525561] CoreMusicLibrary::Adding element Media Servers Oct 15 23:25:25 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:25 playerone sudo[3720]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 23:25:25 playerone sudo[3720]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:25 playerone sudo[3720]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:25 playerone sudo[3722]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 23:25:25 playerone sudo[3722]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:25 playerone systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Oct 15 23:25:25 playerone systemd[1]: mpd.service: Succeeded. Oct 15 23:25:25 playerone systemd[1]: Stopped Music Player Daemon. Oct 15 23:25:25 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:25 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:25 playerone systemd[1]: Starting Music Player Daemon... Oct 15 23:25:25 playerone volumio[3604]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:25:25 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:25 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:25 playerone volumio[3604]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:25:25 playerone volumio[3604]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 23:25:25 playerone volumio[3604]: info: [1760563525781] CoreMusicLibrary::Adding element Last_100 Oct 15 23:25:25 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:25 playerone volumio[3604]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 23:25:25 playerone volumio[3604]: info: [1760563525785] CoreMusicLibrary::Adding element Webradio Oct 15 23:25:25 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:25 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:25:25 playerone volumio[3604]: info: Initializing BBC Radios Oct 15 23:25:25 playerone sudo[3733]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 15 23:25:25 playerone sudo[3733]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:25 playerone sudo[3733]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:25 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:25:25 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:25 playerone volumio[3604]: info: Loading i18n strings for locale en Oct 15 23:25:25 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Oct 15 23:25:25 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:25 playerone volumio[3604]: info: FusionDsp - mixtype--------------------- Hardware Oct 15 23:25:25 playerone volumio[3604]: info: Volumio Calling Home Oct 15 23:25:26 playerone volumio[3604]: info: Preparing to generate the ALSA configuration file Oct 15 23:25:26 playerone volumio[3604]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 15 23:25:26 playerone volumio[3604]: info: Reading ALSA contributions from plugins. Oct 15 23:25:26 playerone volumio[3604]: info: MPD Permissions set Oct 15 23:25:26 playerone volumio[3604]: info: MPD Permissions set Oct 15 23:25:26 playerone volumio[3604]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Oct 15 23:25:26 playerone volumio[3604]: info: Volumio called home Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: Starting Shairport Sync Oct 15 23:25:26 playerone volumio[3604]: info: Starting Shairport Sync Oct 15 23:25:26 playerone volumio[3604]: info: Starting Shairport Sync Oct 15 23:25:26 playerone sudo[3772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:25:26 playerone sudo[3772]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:26 playerone sudo[3774]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:25:26 playerone sudo[3774]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::volumioGetState Oct 15 23:25:26 playerone volumio[3604]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:26 playerone systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 15 23:25:26 playerone systemd[1]: shairport-sync.service: Succeeded. Oct 15 23:25:26 playerone systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 15 23:25:26 playerone sudo[3777]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:25:26 playerone sudo[3777]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:26 playerone volumio[3604]: info: Asound.conf file unchanged, so no further update is needed Oct 15 23:25:26 playerone volumio[3604]: info: Output device has changed, restarting MPD Oct 15 23:25:26 playerone systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 15 23:25:26 playerone sudo[3774]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:26 playerone sudo[3772]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:26 playerone sudo[3777]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:26 playerone sudo[3784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 23:25:26 playerone sudo[3784]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:26 playerone volumio[3604]: info: Output device has changed, restarting Shairport Sync Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:26 playerone sudo[3784]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:26 playerone sudo[3787]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 23:25:26 playerone sudo[3787]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:26 playerone systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 15 23:25:26 playerone systemd[1]: mpd.service: Succeeded. Oct 15 23:25:26 playerone systemd[1]: Stopped Music Player Daemon. Oct 15 23:25:26 playerone volumio[3604]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:25:26 playerone volumio[3604]: info: MPD Permissions set Oct 15 23:25:26 playerone volumio[3604]: info: Shairport-Sync Started Oct 15 23:25:26 playerone volumio[3604]: Error adding Membership: Error: addMembership EINVAL Oct 15 23:25:26 playerone volumio[3604]: info: Shairport-Sync Started Oct 15 23:25:26 playerone volumio[3604]: info: Shairport-Sync Started Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:26 playerone volumio[3604]: info: Starting Shairport Sync Oct 15 23:25:26 playerone systemd[1]: Starting Music Player Daemon... Oct 15 23:25:26 playerone sudo[3800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:25:26 playerone sudo[3800]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:26 playerone systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 15 23:25:26 playerone systemd[1]: shairport-sync.service: Succeeded. Oct 15 23:25:26 playerone systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 15 23:25:26 playerone systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 15 23:25:26 playerone sudo[3800]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:26 playerone volumio[3604]: info: Shairport-Sync Started Oct 15 23:25:26 playerone sudo[3794]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 15 23:25:26 playerone sudo[3794]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:26 playerone sudo[3794]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:27 playerone volumio[3604]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Oct 15 23:25:27 playerone volumio[3604]: 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 Oct 15 23:25:27 playerone volumio[3604]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Oct 15 23:25:27 playerone volumio[3604]: info: camilladsp service started and running in background, instance 1 Oct 15 23:25:27 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:27 playerone volumio[3604]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Oct 15 23:25:27 playerone volumio[3604]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Oct 15 23:25:27 playerone volumio[3604]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Oct 15 23:25:27 playerone volumio[3604]: info: FusionDsp loaded Oct 15 23:25:27 playerone volumio[3604]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 23:25:27 playerone sudo[3818]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Oct 15 23:25:28 playerone sudo[3818]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:28 playerone volumio[3604]: info: FusionDsp - Reporting Fusion DSP Enabled Oct 15 23:25:28 playerone volumio[3604]: info: Adding Signal Path Element [object Object] Oct 15 23:25:28 playerone volumio[3604]: info: Adding fusiondspeq DSP Signal Path Element Oct 15 23:25:28 playerone volumio[3604]: info: FusionDsp - ---- installed callbackRead Oct 15 23:25:28 playerone volumio[3604]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 23:25:28 playerone sudo[3818]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:28 playerone volumio[3604]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Oct 15 23:25:28 playerone volumio[3604]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Oct 15 23:25:28 playerone volumio[3604]: at onErrorNT (internal/child_process.js:465:16) Oct 15 23:25:28 playerone volumio[3604]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Oct 15 23:25:28 playerone volumio[3604]: errno: -2, Oct 15 23:25:28 playerone volumio[3604]: code: 'ENOENT', Oct 15 23:25:28 playerone volumio[3604]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Oct 15 23:25:28 playerone volumio[3604]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Oct 15 23:25:28 playerone volumio[3604]: spawnargs: [ Oct 15 23:25:28 playerone volumio[3604]: '-p', Oct 15 23:25:28 playerone volumio[3604]: 9876, Oct 15 23:25:28 playerone volumio[3604]: '-o', Oct 15 23:25:28 playerone volumio[3604]: '/tmp/camilladsp.log', Oct 15 23:25:28 playerone volumio[3604]: '-l', Oct 15 23:25:28 playerone volumio[3604]: 'warn', Oct 15 23:25:28 playerone volumio[3604]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Oct 15 23:25:28 playerone volumio[3604]: ] Oct 15 23:25:28 playerone volumio[3604]: } Oct 15 23:25:28 playerone volumio[3604]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 23:25:28 playerone mpd[3807]: Oct 15 23:25 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 15 23:25:28 playerone systemd[1]: Started Music Player Daemon. Oct 15 23:25:28 playerone sudo[3708]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:28 playerone sudo[3787]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:28 playerone sudo[3722]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:28 playerone sudo[3831]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-15 23:24 Oct 15 23:25:28 playerone sudo[3831]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:28 playerone sudo[3831]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:28 playerone volumio-remote-updater[587]: [2025-10-15 23:25:28] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Oct 15 23:25:28 playerone volumio-remote-updater[587]: [2025-10-15 23:25:28] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Oct 15 23:25:28 playerone systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 15 23:25:28 playerone systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 15 23:25:29 playerone systemd[1]: Started dynamicswap service. Oct 15 23:25:29 playerone systemd[1]: dynamicswap.service: Succeeded. Oct 15 23:25:29 playerone systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Oct 15 23:25:29 playerone systemd[1]: volumio.service: Scheduled restart job, restart counter is at 12. Oct 15 23:25:29 playerone systemd[1]: Started dynamicswap service. Oct 15 23:25:29 playerone systemd[1]: Stopped Volumio Backend Module. Oct 15 23:25:29 playerone systemd[1]: Started Volumio Backend Module. Oct 15 23:25:29 playerone systemd[1]: dynamicswap.service: Succeeded. Oct 15 23:25:30 playerone volumio[3842]: info: ------------------------------------------- Oct 15 23:25:30 playerone volumio[3842]: info: ----- Volumio3 ---- Oct 15 23:25:30 playerone volumio[3842]: info: ------------------------------------------- Oct 15 23:25:30 playerone volumio[3842]: info: ----- System startup ---- Oct 15 23:25:30 playerone volumio[3842]: info: ------------------------------------------- Oct 15 23:25:31 playerone volumio[3842]: info: MYVOLUMIO Environment detected Oct 15 23:25:31 playerone volumio[3842]: info: Plugin folders cleanup Oct 15 23:25:31 playerone volumio[3842]: info: Scanning into folder /volumio/app/plugins/ Oct 15 23:25:31 playerone volumio[3842]: info: Scanning category audio_interface Oct 15 23:25:31 playerone volumio[3842]: info: Scanning category miscellanea Oct 15 23:25:31 playerone volumio[3842]: info: Scanning category music_service Oct 15 23:25:31 playerone volumio[3842]: info: Scanning category plugins.json Oct 15 23:25:31 playerone volumio[3842]: info: Scanning category system_controller Oct 15 23:25:31 playerone volumio[3842]: info: Scanning category user_interface Oct 15 23:25:31 playerone volumio[3842]: info: Scanning into folder /data/plugins/ Oct 15 23:25:31 playerone volumio[3842]: info: Scanning category audio_interface Oct 15 23:25:31 playerone volumio[3842]: info: Plugin folders cleanup completed Oct 15 23:25:31 playerone volumio[3842]: info: ------------------------------------------- Oct 15 23:25:31 playerone volumio[3842]: info: ----- Core plugins startup ---- Oct 15 23:25:31 playerone volumio[3842]: info: ------------------------------------------- Oct 15 23:25:31 playerone volumio[3842]: info: Loading plugins from folder /volumio/app/plugins/ Oct 15 23:25:31 playerone volumio[3842]: info: Adding plugin upnp to MyMusic Plugins Oct 15 23:25:31 playerone volumio[3842]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 15 23:25:31 playerone volumio[3842]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 15 23:25:31 playerone volumio[3842]: info: Loading plugins from folder /data/plugins/ Oct 15 23:25:31 playerone volumio[3842]: info: Loading plugin "system"... Oct 15 23:25:31 playerone volumio[3842]: info: Loading plugin "appearance"... Oct 15 23:25:32 playerone volumio[3842]: info: Loading plugin "network"... Oct 15 23:25:32 playerone volumio[3842]: info: Refreshing Cached IP Addresses Oct 15 23:25:32 playerone sudo[3868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 15 23:25:32 playerone sudo[3868]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:32 playerone sudo[3868]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:32 playerone sudo[3870]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 15 23:25:32 playerone sudo[3870]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:32 playerone sudo[3870]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:32 playerone volumio[3842]: info: Loading plugin "services"... Oct 15 23:25:32 playerone volumio[3842]: info: Loading plugin "alsa_controller"... Oct 15 23:25:32 playerone sudo[3883]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 15 23:25:32 playerone sudo[3883]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:33 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:25:33 playerone volumio[3842]: info: Loading plugin "wizard"... Oct 15 23:25:33 playerone volumio[3842]: info: Loading plugin "networkfs"... Oct 15 23:25:33 playerone volumio[3842]: info: Starting Udev Watcher for removable devices Oct 15 23:25:33 playerone volumio[3842]: info: Ignoring mount for partition: boot Oct 15 23:25:33 playerone volumio[3842]: info: Ignoring mount for partition: volumio Oct 15 23:25:33 playerone volumio[3842]: info: Ignoring mount for partition: volumio_data Oct 15 23:25:33 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 23:25:33 playerone volumio[3842]: info: Loading plugin "volumio_command_line_client"... Oct 15 23:25:33 playerone volumio[3842]: info: Loading plugin "upnp"... Oct 15 23:25:33 playerone volumio[3842]: info: [1760563533143] Starting Upmpd Daemon Oct 15 23:25:33 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 23:25:33 playerone volumio[3842]: info: Loading plugin "my_music"... Oct 15 23:25:33 playerone volumio[3842]: info: Loading plugin "mpd"... Oct 15 23:25:33 playerone volumio[3842]: info: Loading plugin "upnp_browser"... Oct 15 23:25:33 playerone volumio[3842]: info: Loading plugin "alarm-clock"... Oct 15 23:25:33 playerone sudo[3883]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:33 playerone volumio-remote-updater[587]: [2025-10-15 23:25:33] [connect] Successful connection Oct 15 23:25:33 playerone volumio[3842]: info: Loading plugin "airplay_emulation"... Oct 15 23:25:34 playerone volumio[3842]: info: Starting Shairport Sync Oct 15 23:25:34 playerone volumio[3842]: info: Loading plugin "last_100"... Oct 15 23:25:34 playerone volumio[3842]: info: Loading plugin "webradio"... Oct 15 23:25:34 playerone volumio[3842]: info: Loading plugin "i2s_dacs"... Oct 15 23:25:34 playerone volumio[3842]: info: I2S DAC not set, start Auto-detection Oct 15 23:25:34 playerone volumio[3842]: info: Loading plugin "volumiodiscovery"... Oct 15 23:25:34 playerone volumio[3842]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 15 23:25:34 playerone volumio[3842]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:25:34 playerone volumio[3842]: *** WARNING *** For more information see Oct 15 23:25:34 playerone node[3842]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 15 23:25:34 playerone volumio[3842]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 15 23:25:34 playerone volumio[3842]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:25:34 playerone volumio[3842]: *** WARNING *** For more information see Oct 15 23:25:34 playerone node[3842]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:25:34 playerone node[3842]: *** WARNING *** For more information see Oct 15 23:25:34 playerone node[3842]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 15 23:25:34 playerone node[3842]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:25:34 playerone node[3842]: *** WARNING *** For more information see Oct 15 23:25:34 playerone volumio[3842]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 15 23:25:34 playerone volumio[3842]: info: Discovery: Started advertising with name: playerONE Oct 15 23:25:34 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 23:25:34 playerone volumio[3842]: info: Loading plugin "outputs"... Oct 15 23:25:34 playerone volumio[3842]: info: Loading plugin "albumart"... Oct 15 23:25:34 playerone volumio[3842]: info: Plugin example_plugin is not enabled Oct 15 23:25:34 playerone volumio[3842]: info: Loading plugin "inputs"... Oct 15 23:25:34 playerone volumio[3842]: info: Loading plugin "updater_comm"... Oct 15 23:25:34 playerone volumio[3842]: info: Plugin mpdemulation is not enabled Oct 15 23:25:34 playerone volumio[3842]: info: Loading plugin "rest_api"... Oct 15 23:25:34 playerone volumio[3842]: info: Loading plugin "websocket"... Oct 15 23:25:34 playerone volumio[3842]: info: Starting Socket.io Server version 2.3.0 Oct 15 23:25:34 playerone volumio[3842]: info: Loading plugin "fusiondsp"... Oct 15 23:25:34 playerone volumio[3842]: Forking 3 albumart workers Oct 15 23:25:34 playerone volumio[3842]: info: Applying required configuration parameters for plugin fusiondsp Oct 15 23:25:35 playerone volumio[3842]: info: Loading i18n strings for locale en Oct 15 23:25:35 playerone volumio[3842]: Updating browse sources language Oct 15 23:25:35 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:35 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:25:35 playerone volumio[3842]: info: CoreCommandRouter::initPlayerControls Oct 15 23:25:35 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:35 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:35 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:35 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:35 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:35 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:35 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:35 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:35 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:25:35 playerone volumio[3842]: Express server listening on port 3000 Oct 15 23:25:35 playerone volumio[3842]: [Metrics] WebUI: 5s 75.16ms Oct 15 23:25:35 playerone volumio[3842]: info: CoreStateMachine::resetVolumioState Oct 15 23:25:35 playerone volumio[3842]: info: CoreStateMachine::getcurrentVolume Oct 15 23:25:35 playerone volumio[3842]: info: CoreCommandRouter::volumioRetrievevolume Oct 15 23:25:35 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:35 playerone volumio[3842]: info: Volumio Network Manager: Network status updated: 1 Oct 15 23:25:35 playerone volumio[3842]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Oct 15 23:25:35 playerone volumio[3842]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Oct 15 23:25:35 playerone volumio[3842]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Oct 15 23:25:35 playerone volumio[3842]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Oct 15 23:25:35 playerone volumio-remote-updater[587]: [2025-10-15 23:25:35] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1760563533 101 Oct 15 23:25:35 playerone volumio[3842]: Starting albumart workers Oct 15 23:25:35 playerone volumio[3842]: 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 Oct 15 23:25:35 playerone volumio[3842]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Oct 15 23:25:35 playerone volumio[3842]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 15 23:25:35 playerone volumio[3842]: info: CoreCommandRouter::volumioGetState Oct 15 23:25:35 playerone volumio[3842]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:35 playerone volumio[3842]: Starting albumart workers Oct 15 23:25:35 playerone volumio[3842]: info: Reloading queue from file Oct 15 23:25:35 playerone volumio[3842]: info: VolumeController:: Volume=20 Mute =false Oct 15 23:25:35 playerone volumio[3842]: info: CoreStateMachine::pushState Oct 15 23:25:35 playerone volumio[3842]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:35 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 23:25:35 playerone volumio[3842]: info: CoreCommandRouter::volumioPushState Oct 15 23:25:35 playerone volumio[3842]: info: CoreStateMachine::updateTrackBlock Oct 15 23:25:35 playerone volumio[3842]: info: CorePlayQueue::getTrackBlock Oct 15 23:25:35 playerone volumio[3842]: info: CoreCommandRouter::volumioRetrievevolume Oct 15 23:25:36 playerone volumio[3842]: Starting albumart workers Oct 15 23:25:36 playerone volumio[3842]: info: CoreStateMachine::setRepeat null single undefined Oct 15 23:25:36 playerone volumio[3842]: info: CoreStateMachine::pushState Oct 15 23:25:36 playerone volumio[3842]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:36 playerone volumio[3842]: info: CoreCommandRouter::volumioPushState Oct 15 23:25:36 playerone volumio[3842]: info: CoreStateMachine::setRandom null Oct 15 23:25:36 playerone volumio[3842]: info: CoreStateMachine::pushState Oct 15 23:25:36 playerone volumio[3842]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:36 playerone volumio[3842]: info: CoreCommandRouter::volumioPushState Oct 15 23:25:36 playerone volumio[3842]: info: Setting Device type: Raspberry PI Oct 15 23:25:36 playerone volumio[3842]: info: CoreCommandRouter::volumioGetQueue Oct 15 23:25:36 playerone volumio[3842]: info: CoreStateMachine::getQueue Oct 15 23:25:36 playerone volumio[3842]: info: CorePlayQueue::getQueue Oct 15 23:25:36 playerone volumio[3842]: info: CoreCommandRouter::volumioGetVisibleSources Oct 15 23:25:36 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:36 playerone volumio[3842]: info: Listing playlists Oct 15 23:25:36 playerone volumio[3842]: info: Discovery: adding 76640995-2991-45ef-aafc-08dc8d3a1ee7 Oct 15 23:25:36 playerone volumio[3842]: info: Discovery: Found device playerONE Oct 15 23:25:36 playerone volumio[3842]: info: CoreCommandRouter::volumioGetState Oct 15 23:25:36 playerone volumio[3842]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:36 playerone volumio[3842]: info: VolumeController:: Volume=20 Mute =false Oct 15 23:25:36 playerone volumio[3842]: info: CoreStateMachine::pushState Oct 15 23:25:36 playerone volumio[3842]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:36 playerone volumio[3842]: info: CoreCommandRouter::volumioPushState Oct 15 23:25:36 playerone volumio[3842]: info: Discovery: this is already registered, 76640995-2991-45ef-aafc-08dc8d3a1ee7 Oct 15 23:25:36 playerone volumio[3842]: info: Discovery: Found device playerONE Oct 15 23:25:36 playerone volumio[3842]: info: CoreCommandRouter::volumioGetState Oct 15 23:25:36 playerone volumio[3842]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:36 playerone volumio[3842]: info: Completed loading Core Plugins Oct 15 23:25:36 playerone volumio[3842]: info: Preparing to generate the ALSA configuration file Oct 15 23:25:36 playerone volumio[3842]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 15 23:25:36 playerone volumio[3842]: info: Reading ALSA contributions from plugins. Oct 15 23:25:36 playerone volumio[3842]: info: Asound.conf file unchanged, so no further update is needed Oct 15 23:25:36 playerone volumio[3842]: info: Output device has changed, restarting MPD Oct 15 23:25:36 playerone sudo[3948]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 23:25:36 playerone sudo[3948]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:36 playerone volumio[3842]: info: Output device has changed, restarting Shairport Sync Oct 15 23:25:36 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:36 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:36 playerone sudo[3948]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:36 playerone sudo[3955]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 23:25:36 playerone sudo[3955]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:36 playerone systemd[1]: Stopping Music Player Daemon... Oct 15 23:25:36 playerone volumio[3842]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:25:36 playerone systemd[1]: mpd.service: Succeeded. Oct 15 23:25:36 playerone systemd[1]: Stopped Music Player Daemon. Oct 15 23:25:36 playerone volumio[3842]: info: ___________ START PLUGINS ___________ Oct 15 23:25:36 playerone volumio[3842]: info: ControllerMpd::onStart: Initializing MPD Oct 15 23:25:36 playerone volumio[3842]: info: Creating MPD Configuration file Oct 15 23:25:36 playerone systemd[1]: Starting Music Player Daemon... Oct 15 23:25:36 playerone sudo[3966]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 23:25:36 playerone sudo[3966]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:36 playerone sudo[3966]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:36 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:25:36 playerone volumio[3842]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 23:25:36 playerone volumio[3842]: info: [1760563536831] CoreMusicLibrary::Adding element Media Servers Oct 15 23:25:36 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:36 playerone sudo[3969]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 23:25:36 playerone sudo[3969]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:36 playerone systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Oct 15 23:25:36 playerone systemd[1]: mpd.service: Succeeded. Oct 15 23:25:36 playerone systemd[1]: Stopped Music Player Daemon. Oct 15 23:25:36 playerone systemd[1]: Starting Music Player Daemon... Oct 15 23:25:36 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:36 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:36 playerone volumio[3842]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:25:36 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:36 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:37 playerone volumio[3842]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 23:25:37 playerone volumio[3842]: info: [1760563537017] CoreMusicLibrary::Adding element Last_100 Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 23:25:37 playerone volumio[3842]: info: [1760563537021] CoreMusicLibrary::Adding element Webradio Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:25:37 playerone volumio[3842]: info: Initializing BBC Radios Oct 15 23:25:37 playerone sudo[3979]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 15 23:25:37 playerone sudo[3979]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:37 playerone sudo[3979]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:37 playerone volumio[3842]: info: Loading i18n strings for locale en Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:37 playerone volumio[3842]: info: FusionDsp - mixtype--------------------- Hardware Oct 15 23:25:37 playerone volumio[3842]: info: Volumio Calling Home Oct 15 23:25:37 playerone volumio[3842]: info: Preparing to generate the ALSA configuration file Oct 15 23:25:37 playerone volumio[3842]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 15 23:25:37 playerone volumio[3842]: info: Reading ALSA contributions from plugins. Oct 15 23:25:37 playerone volumio[3842]: info: MPD Permissions set Oct 15 23:25:37 playerone volumio[3842]: info: MPD Permissions set Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 15 23:25:37 playerone volumio[3842]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Oct 15 23:25:37 playerone volumio[3842]: info: Volumio called home Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:37 playerone volumio[3842]: info: Starting Shairport Sync Oct 15 23:25:37 playerone volumio[3842]: info: Starting Shairport Sync Oct 15 23:25:37 playerone volumio[3842]: info: Starting Shairport Sync Oct 15 23:25:37 playerone sudo[4012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:25:37 playerone sudo[4012]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:37 playerone sudo[4014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:25:37 playerone sudo[4014]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:37 playerone systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 15 23:25:37 playerone sudo[4018]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:25:37 playerone sudo[4018]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:37 playerone systemd[1]: shairport-sync.service: Succeeded. Oct 15 23:25:37 playerone systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::volumioGetState Oct 15 23:25:37 playerone volumio[3842]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:37 playerone systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 15 23:25:37 playerone sudo[4014]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:37 playerone sudo[4012]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:37 playerone volumio[3842]: info: Asound.conf file unchanged, so no further update is needed Oct 15 23:25:37 playerone volumio[3842]: info: Output device has changed, restarting MPD Oct 15 23:25:37 playerone systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 15 23:25:37 playerone systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Oct 15 23:25:37 playerone systemd[1]: shairport-sync.service: Succeeded. Oct 15 23:25:37 playerone systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 15 23:25:37 playerone systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 15 23:25:37 playerone sudo[4018]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:37 playerone volumio[3842]: info: Output device has changed, restarting Shairport Sync Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:37 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:37 playerone sudo[4022]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 23:25:37 playerone sudo[4022]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:37 playerone sudo[4022]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:37 playerone sudo[4025]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 23:25:37 playerone sudo[4025]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:37 playerone systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 15 23:25:37 playerone systemd[1]: mpd.service: Succeeded. Oct 15 23:25:37 playerone systemd[1]: Stopped Music Player Daemon. Oct 15 23:25:37 playerone volumio[3842]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:25:38 playerone volumio[3842]: info: Shairport-Sync Started Oct 15 23:25:38 playerone volumio[3842]: Error adding Membership: Error: addMembership EINVAL Oct 15 23:25:38 playerone volumio[3842]: info: Shairport-Sync Started Oct 15 23:25:38 playerone systemd[1]: Starting Music Player Daemon... Oct 15 23:25:38 playerone volumio[3842]: info: MPD Permissions set Oct 15 23:25:38 playerone volumio[3842]: info: Shairport-Sync Started Oct 15 23:25:38 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:38 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:38 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:38 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:38 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:38 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:38 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:38 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:38 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:38 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:38 playerone volumio[3842]: info: Starting Shairport Sync Oct 15 23:25:38 playerone sudo[4040]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:25:38 playerone sudo[4040]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:38 playerone sudo[4032]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 15 23:25:38 playerone sudo[4032]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:38 playerone systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 15 23:25:38 playerone systemd[1]: shairport-sync.service: Succeeded. Oct 15 23:25:38 playerone systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 15 23:25:38 playerone sudo[4032]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:38 playerone systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 15 23:25:38 playerone sudo[4040]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:38 playerone volumio[3842]: info: Shairport-Sync Started Oct 15 23:25:39 playerone volumio[3842]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Oct 15 23:25:39 playerone volumio[3842]: 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 Oct 15 23:25:39 playerone volumio[3842]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Oct 15 23:25:39 playerone volumio[3842]: info: camilladsp service started and running in background, instance 1 Oct 15 23:25:39 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:39 playerone volumio[3842]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Oct 15 23:25:39 playerone volumio[3842]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Oct 15 23:25:39 playerone volumio[3842]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Oct 15 23:25:39 playerone volumio[3842]: info: FusionDsp loaded Oct 15 23:25:39 playerone volumio[3842]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 23:25:39 playerone sudo[4057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Oct 15 23:25:39 playerone sudo[4057]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:39 playerone volumio[3842]: info: FusionDsp - Reporting Fusion DSP Enabled Oct 15 23:25:39 playerone volumio[3842]: info: Adding Signal Path Element [object Object] Oct 15 23:25:39 playerone volumio[3842]: info: Adding fusiondspeq DSP Signal Path Element Oct 15 23:25:39 playerone volumio[3842]: info: FusionDsp - ---- installed callbackRead Oct 15 23:25:39 playerone volumio[3842]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 23:25:39 playerone sudo[4057]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:39 playerone volumio[3842]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Oct 15 23:25:39 playerone volumio[3842]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Oct 15 23:25:39 playerone volumio[3842]: at onErrorNT (internal/child_process.js:465:16) Oct 15 23:25:39 playerone volumio[3842]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Oct 15 23:25:39 playerone volumio[3842]: errno: -2, Oct 15 23:25:39 playerone volumio[3842]: code: 'ENOENT', Oct 15 23:25:39 playerone volumio[3842]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Oct 15 23:25:39 playerone volumio[3842]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Oct 15 23:25:39 playerone volumio[3842]: spawnargs: [ Oct 15 23:25:39 playerone volumio[3842]: '-p', Oct 15 23:25:39 playerone volumio[3842]: 9876, Oct 15 23:25:39 playerone volumio[3842]: '-o', Oct 15 23:25:39 playerone volumio[3842]: '/tmp/camilladsp.log', Oct 15 23:25:39 playerone volumio[3842]: '-l', Oct 15 23:25:39 playerone volumio[3842]: 'warn', Oct 15 23:25:39 playerone volumio[3842]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Oct 15 23:25:39 playerone volumio[3842]: ] Oct 15 23:25:39 playerone volumio[3842]: } Oct 15 23:25:39 playerone volumio[3842]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 23:25:39 playerone mpd[4044]: Oct 15 23:25 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 15 23:25:39 playerone systemd[1]: Started Music Player Daemon. Oct 15 23:25:39 playerone sudo[3969]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:39 playerone sudo[3955]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:39 playerone sudo[4025]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:39 playerone sudo[4071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-15 23:24 Oct 15 23:25:39 playerone sudo[4071]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:40 playerone sudo[4071]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:40 playerone volumio-remote-updater[587]: [2025-10-15 23:25:40] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Oct 15 23:25:40 playerone volumio-remote-updater[587]: [2025-10-15 23:25:40] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Oct 15 23:25:40 playerone systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 15 23:25:40 playerone systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 15 23:25:40 playerone systemd[1]: Started dynamicswap service. Oct 15 23:25:40 playerone systemd[1]: dynamicswap.service: Succeeded. Oct 15 23:25:40 playerone systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Oct 15 23:25:40 playerone systemd[1]: volumio.service: Scheduled restart job, restart counter is at 13. Oct 15 23:25:40 playerone systemd[1]: Stopped Volumio Backend Module. Oct 15 23:25:40 playerone systemd[1]: Started Volumio Backend Module. Oct 15 23:25:40 playerone systemd[1]: Started dynamicswap service. Oct 15 23:25:40 playerone systemd[1]: dynamicswap.service: Succeeded. Oct 15 23:25:42 playerone volumio[4081]: info: ------------------------------------------- Oct 15 23:25:42 playerone volumio[4081]: info: ----- Volumio3 ---- Oct 15 23:25:42 playerone volumio[4081]: info: ------------------------------------------- Oct 15 23:25:42 playerone volumio[4081]: info: ----- System startup ---- Oct 15 23:25:42 playerone volumio[4081]: info: ------------------------------------------- Oct 15 23:25:43 playerone volumio[4081]: info: MYVOLUMIO Environment detected Oct 15 23:25:43 playerone volumio[4081]: info: Plugin folders cleanup Oct 15 23:25:43 playerone volumio[4081]: info: Scanning into folder /volumio/app/plugins/ Oct 15 23:25:43 playerone volumio[4081]: info: Scanning category audio_interface Oct 15 23:25:43 playerone volumio[4081]: info: Scanning category miscellanea Oct 15 23:25:43 playerone volumio[4081]: info: Scanning category music_service Oct 15 23:25:43 playerone volumio[4081]: info: Scanning category plugins.json Oct 15 23:25:43 playerone volumio[4081]: info: Scanning category system_controller Oct 15 23:25:43 playerone volumio[4081]: info: Scanning category user_interface Oct 15 23:25:43 playerone volumio[4081]: info: Scanning into folder /data/plugins/ Oct 15 23:25:43 playerone volumio[4081]: info: Scanning category audio_interface Oct 15 23:25:43 playerone volumio[4081]: info: Plugin folders cleanup completed Oct 15 23:25:43 playerone volumio[4081]: info: ------------------------------------------- Oct 15 23:25:43 playerone volumio[4081]: info: ----- Core plugins startup ---- Oct 15 23:25:43 playerone volumio[4081]: info: ------------------------------------------- Oct 15 23:25:43 playerone volumio[4081]: info: Loading plugins from folder /volumio/app/plugins/ Oct 15 23:25:43 playerone volumio[4081]: info: Adding plugin upnp to MyMusic Plugins Oct 15 23:25:43 playerone volumio[4081]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 15 23:25:43 playerone volumio[4081]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 15 23:25:43 playerone volumio[4081]: info: Loading plugins from folder /data/plugins/ Oct 15 23:25:43 playerone volumio[4081]: info: Loading plugin "system"... Oct 15 23:25:43 playerone volumio[4081]: info: Loading plugin "appearance"... Oct 15 23:25:44 playerone volumio[4081]: info: Loading plugin "network"... Oct 15 23:25:44 playerone volumio[4081]: info: Refreshing Cached IP Addresses Oct 15 23:25:44 playerone sudo[4108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 15 23:25:44 playerone sudo[4108]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:44 playerone sudo[4108]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:44 playerone sudo[4110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 15 23:25:44 playerone sudo[4110]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:44 playerone sudo[4110]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:44 playerone volumio[4081]: info: Loading plugin "services"... Oct 15 23:25:44 playerone volumio[4081]: info: Loading plugin "alsa_controller"... Oct 15 23:25:44 playerone sudo[4119]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 15 23:25:44 playerone sudo[4119]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:44 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:25:44 playerone volumio[4081]: info: Loading plugin "wizard"... Oct 15 23:25:44 playerone volumio[4081]: info: Loading plugin "networkfs"... Oct 15 23:25:44 playerone volumio[4081]: info: Starting Udev Watcher for removable devices Oct 15 23:25:44 playerone volumio[4081]: info: Ignoring mount for partition: boot Oct 15 23:25:44 playerone volumio[4081]: info: Ignoring mount for partition: volumio Oct 15 23:25:44 playerone volumio[4081]: info: Ignoring mount for partition: volumio_data Oct 15 23:25:44 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 23:25:44 playerone volumio[4081]: info: Loading plugin "volumio_command_line_client"... Oct 15 23:25:44 playerone volumio[4081]: info: Loading plugin "upnp"... Oct 15 23:25:44 playerone volumio[4081]: info: [1760563544602] Starting Upmpd Daemon Oct 15 23:25:44 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 23:25:44 playerone volumio[4081]: info: Loading plugin "my_music"... Oct 15 23:25:44 playerone volumio[4081]: info: Loading plugin "mpd"... Oct 15 23:25:44 playerone volumio[4081]: info: Loading plugin "upnp_browser"... Oct 15 23:25:45 playerone volumio-remote-updater[587]: [2025-10-15 23:25:45] [connect] Successful connection Oct 15 23:25:45 playerone volumio[4081]: info: Loading plugin "alarm-clock"... Oct 15 23:25:45 playerone sudo[4119]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:45 playerone volumio[4081]: info: Loading plugin "airplay_emulation"... Oct 15 23:25:45 playerone volumio[4081]: info: Starting Shairport Sync Oct 15 23:25:45 playerone volumio[4081]: info: Loading plugin "last_100"... Oct 15 23:25:45 playerone volumio[4081]: info: Loading plugin "webradio"... Oct 15 23:25:45 playerone volumio[4081]: info: Loading plugin "i2s_dacs"... Oct 15 23:25:45 playerone volumio[4081]: info: I2S DAC not set, start Auto-detection Oct 15 23:25:45 playerone volumio[4081]: info: Loading plugin "volumiodiscovery"... Oct 15 23:25:45 playerone volumio[4081]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 15 23:25:45 playerone volumio[4081]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:25:45 playerone volumio[4081]: *** WARNING *** For more information see Oct 15 23:25:45 playerone node[4081]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 15 23:25:45 playerone volumio[4081]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 15 23:25:45 playerone volumio[4081]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:25:45 playerone volumio[4081]: *** WARNING *** For more information see Oct 15 23:25:45 playerone node[4081]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:25:45 playerone node[4081]: *** WARNING *** For more information see Oct 15 23:25:45 playerone node[4081]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 15 23:25:45 playerone node[4081]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:25:45 playerone node[4081]: *** WARNING *** For more information see Oct 15 23:25:45 playerone volumio[4081]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 15 23:25:45 playerone volumio[4081]: info: Discovery: Started advertising with name: playerONE Oct 15 23:25:45 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 23:25:45 playerone volumio[4081]: info: Loading plugin "outputs"... Oct 15 23:25:45 playerone volumio[4081]: info: Loading plugin "albumart"... Oct 15 23:25:45 playerone volumio[4081]: info: Plugin example_plugin is not enabled Oct 15 23:25:45 playerone volumio[4081]: info: Loading plugin "inputs"... Oct 15 23:25:45 playerone volumio[4081]: info: Loading plugin "updater_comm"... Oct 15 23:25:45 playerone volumio[4081]: info: Plugin mpdemulation is not enabled Oct 15 23:25:45 playerone volumio[4081]: info: Loading plugin "rest_api"... Oct 15 23:25:45 playerone volumio[4081]: info: Loading plugin "websocket"... Oct 15 23:25:45 playerone volumio[4081]: info: Starting Socket.io Server version 2.3.0 Oct 15 23:25:45 playerone volumio[4081]: info: Loading plugin "fusiondsp"... Oct 15 23:25:46 playerone volumio[4081]: Forking 3 albumart workers Oct 15 23:25:46 playerone volumio[4081]: info: Applying required configuration parameters for plugin fusiondsp Oct 15 23:25:46 playerone volumio[4081]: info: Loading i18n strings for locale en Oct 15 23:25:46 playerone volumio[4081]: Updating browse sources language Oct 15 23:25:46 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:46 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:25:46 playerone volumio[4081]: info: CoreCommandRouter::initPlayerControls Oct 15 23:25:46 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:46 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:46 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:46 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:46 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:46 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:46 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:46 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:46 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:25:46 playerone volumio[4081]: Express server listening on port 3000 Oct 15 23:25:46 playerone volumio[4081]: [Metrics] WebUI: 5s 127.52ms Oct 15 23:25:46 playerone volumio[4081]: info: CoreStateMachine::resetVolumioState Oct 15 23:25:46 playerone volumio[4081]: info: CoreStateMachine::getcurrentVolume Oct 15 23:25:46 playerone volumio[4081]: info: CoreCommandRouter::volumioRetrievevolume Oct 15 23:25:47 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:47 playerone volumio[4081]: info: Volumio Network Manager: Network status updated: 1 Oct 15 23:25:47 playerone volumio[4081]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Oct 15 23:25:47 playerone volumio[4081]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Oct 15 23:25:47 playerone volumio[4081]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Oct 15 23:25:47 playerone volumio[4081]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Oct 15 23:25:47 playerone volumio-remote-updater[587]: [2025-10-15 23:25:47] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1760563545 101 Oct 15 23:25:47 playerone volumio[4081]: 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 Oct 15 23:25:47 playerone volumio[4081]: Starting albumart workers Oct 15 23:25:47 playerone volumio[4081]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Oct 15 23:25:47 playerone volumio[4081]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 15 23:25:47 playerone volumio[4081]: Starting albumart workers Oct 15 23:25:47 playerone volumio[4081]: info: CoreCommandRouter::volumioGetState Oct 15 23:25:47 playerone volumio[4081]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:47 playerone volumio[4081]: info: Reloading queue from file Oct 15 23:25:47 playerone volumio[4081]: Starting albumart workers Oct 15 23:25:47 playerone volumio[4081]: info: VolumeController:: Volume=20 Mute =false Oct 15 23:25:47 playerone volumio[4081]: info: CoreStateMachine::pushState Oct 15 23:25:47 playerone volumio[4081]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:47 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 23:25:47 playerone volumio[4081]: info: CoreCommandRouter::volumioPushState Oct 15 23:25:47 playerone volumio[4081]: info: CoreStateMachine::updateTrackBlock Oct 15 23:25:47 playerone volumio[4081]: info: CorePlayQueue::getTrackBlock Oct 15 23:25:47 playerone volumio[4081]: info: CoreCommandRouter::volumioRetrievevolume Oct 15 23:25:47 playerone volumio[4081]: info: CoreStateMachine::setRepeat null single undefined Oct 15 23:25:47 playerone volumio[4081]: info: CoreStateMachine::pushState Oct 15 23:25:47 playerone volumio[4081]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:47 playerone volumio[4081]: info: CoreCommandRouter::volumioPushState Oct 15 23:25:47 playerone volumio[4081]: info: CoreStateMachine::setRandom null Oct 15 23:25:47 playerone volumio[4081]: info: CoreStateMachine::pushState Oct 15 23:25:47 playerone volumio[4081]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:47 playerone volumio[4081]: info: CoreCommandRouter::volumioPushState Oct 15 23:25:47 playerone volumio[4081]: info: Setting Device type: Raspberry PI Oct 15 23:25:47 playerone volumio[4081]: info: CoreCommandRouter::volumioGetQueue Oct 15 23:25:47 playerone volumio[4081]: info: CoreStateMachine::getQueue Oct 15 23:25:47 playerone volumio[4081]: info: CorePlayQueue::getQueue Oct 15 23:25:47 playerone volumio[4081]: info: CoreCommandRouter::volumioGetVisibleSources Oct 15 23:25:47 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:47 playerone volumio[4081]: info: Listing playlists Oct 15 23:25:47 playerone volumio[4081]: info: VolumeController:: Volume=20 Mute =false Oct 15 23:25:47 playerone volumio[4081]: info: CoreStateMachine::pushState Oct 15 23:25:47 playerone volumio[4081]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:47 playerone volumio[4081]: info: CoreCommandRouter::volumioPushState Oct 15 23:25:47 playerone volumio[4081]: info: Discovery: adding 76640995-2991-45ef-aafc-08dc8d3a1ee7 Oct 15 23:25:47 playerone volumio[4081]: info: Discovery: Found device playerONE Oct 15 23:25:47 playerone volumio[4081]: info: CoreCommandRouter::volumioGetState Oct 15 23:25:47 playerone volumio[4081]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:47 playerone volumio[4081]: info: Discovery: this is already registered, 76640995-2991-45ef-aafc-08dc8d3a1ee7 Oct 15 23:25:47 playerone volumio[4081]: info: Discovery: Found device playerONE Oct 15 23:25:47 playerone volumio[4081]: info: CoreCommandRouter::volumioGetState Oct 15 23:25:47 playerone volumio[4081]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:47 playerone volumio[4081]: info: Completed loading Core Plugins Oct 15 23:25:47 playerone volumio[4081]: info: Preparing to generate the ALSA configuration file Oct 15 23:25:47 playerone volumio[4081]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 15 23:25:47 playerone volumio[4081]: info: Reading ALSA contributions from plugins. Oct 15 23:25:47 playerone volumio[4081]: info: Asound.conf file unchanged, so no further update is needed Oct 15 23:25:47 playerone volumio[4081]: info: Output device has changed, restarting MPD Oct 15 23:25:48 playerone volumio[4081]: info: Output device has changed, restarting Shairport Sync Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:48 playerone sudo[4179]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 23:25:48 playerone sudo[4179]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:48 playerone sudo[4181]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 23:25:48 playerone sudo[4181]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:48 playerone sudo[4179]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:48 playerone systemd[1]: Stopping Music Player Daemon... Oct 15 23:25:48 playerone systemd[1]: mpd.service: Succeeded. Oct 15 23:25:48 playerone systemd[1]: Stopped Music Player Daemon. Oct 15 23:25:48 playerone volumio[4081]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:25:48 playerone volumio[4081]: info: ___________ START PLUGINS ___________ Oct 15 23:25:48 playerone volumio[4081]: info: ControllerMpd::onStart: Initializing MPD Oct 15 23:25:48 playerone volumio[4081]: info: Creating MPD Configuration file Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 23:25:48 playerone volumio[4081]: info: [1760563548227] CoreMusicLibrary::Adding element Media Servers Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:48 playerone systemd[1]: Starting Music Player Daemon... Oct 15 23:25:48 playerone sudo[4197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 23:25:48 playerone sudo[4197]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:48 playerone sudo[4197]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:48 playerone sudo[4203]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 23:25:48 playerone sudo[4203]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:48 playerone systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Oct 15 23:25:48 playerone systemd[1]: mpd.service: Succeeded. Oct 15 23:25:48 playerone systemd[1]: Stopped Music Player Daemon. Oct 15 23:25:48 playerone systemd[1]: Starting Music Player Daemon... Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 23:25:48 playerone volumio[4081]: info: [1760563548464] CoreMusicLibrary::Adding element Last_100 Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 23:25:48 playerone volumio[4081]: info: [1760563548470] CoreMusicLibrary::Adding element Webradio Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:48 playerone sudo[4218]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 15 23:25:48 playerone sudo[4218]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:25:48 playerone volumio[4081]: info: Initializing BBC Radios Oct 15 23:25:48 playerone sudo[4218]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: Loading i18n strings for locale en Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: FusionDsp - mixtype--------------------- Hardware Oct 15 23:25:48 playerone volumio[4081]: info: Volumio Calling Home Oct 15 23:25:48 playerone volumio[4081]: info: Preparing to generate the ALSA configuration file Oct 15 23:25:48 playerone volumio[4081]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 15 23:25:48 playerone volumio[4081]: info: Reading ALSA contributions from plugins. Oct 15 23:25:48 playerone volumio[4081]: info: MPD Permissions set Oct 15 23:25:48 playerone volumio[4081]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Oct 15 23:25:48 playerone volumio[4081]: info: Volumio called home Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:48 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:49 playerone volumio[4081]: info: Starting Shairport Sync Oct 15 23:25:49 playerone volumio[4081]: info: Starting Shairport Sync Oct 15 23:25:49 playerone volumio[4081]: info: Starting Shairport Sync Oct 15 23:25:49 playerone sudo[4249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:25:49 playerone sudo[4249]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:49 playerone sudo[4251]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:25:49 playerone sudo[4251]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:49 playerone volumio[4081]: info: CoreCommandRouter::volumioGetState Oct 15 23:25:49 playerone volumio[4081]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:49 playerone sudo[4255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:25:49 playerone sudo[4255]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:49 playerone systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 15 23:25:49 playerone systemd[1]: shairport-sync.service: Succeeded. Oct 15 23:25:49 playerone systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 15 23:25:49 playerone volumio[4081]: info: Asound.conf file unchanged, so no further update is needed Oct 15 23:25:49 playerone volumio[4081]: info: Output device has changed, restarting MPD Oct 15 23:25:49 playerone volumio[4081]: info: Output device has changed, restarting Shairport Sync Oct 15 23:25:49 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:49 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:49 playerone sudo[4258]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 23:25:49 playerone sudo[4258]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:49 playerone sudo[4258]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:49 playerone sudo[4261]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 23:25:49 playerone sudo[4261]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:49 playerone systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 15 23:25:49 playerone sudo[4249]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:49 playerone sudo[4255]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:49 playerone volumio[4081]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:25:49 playerone sudo[4251]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:49 playerone systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 15 23:25:49 playerone systemd[1]: mpd.service: Succeeded. Oct 15 23:25:49 playerone systemd[1]: Stopped Music Player Daemon. Oct 15 23:25:49 playerone systemd[1]: Starting Music Player Daemon... Oct 15 23:25:49 playerone volumio[4081]: info: MPD Permissions set Oct 15 23:25:49 playerone volumio[4081]: info: Shairport-Sync Started Oct 15 23:25:49 playerone volumio[4081]: Error adding Membership: Error: addMembership EINVAL Oct 15 23:25:49 playerone volumio[4081]: info: Shairport-Sync Started Oct 15 23:25:49 playerone volumio[4081]: info: Shairport-Sync Started Oct 15 23:25:49 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:49 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:49 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:49 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:49 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:49 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:49 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:49 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:49 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:49 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:49 playerone volumio[4081]: info: Starting Shairport Sync Oct 15 23:25:49 playerone sudo[4276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:25:49 playerone sudo[4276]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:49 playerone sudo[4269]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 15 23:25:49 playerone sudo[4269]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:49 playerone sudo[4269]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:49 playerone systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 15 23:25:49 playerone systemd[1]: shairport-sync.service: Succeeded. Oct 15 23:25:49 playerone systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 15 23:25:49 playerone systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 15 23:25:49 playerone sudo[4276]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:49 playerone volumio[4081]: info: Shairport-Sync Started Oct 15 23:25:50 playerone volumio[4081]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Oct 15 23:25:50 playerone volumio[4081]: 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 Oct 15 23:25:50 playerone volumio[4081]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Oct 15 23:25:50 playerone volumio[4081]: info: camilladsp service started and running in background, instance 1 Oct 15 23:25:50 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:50 playerone volumio[4081]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Oct 15 23:25:50 playerone volumio[4081]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Oct 15 23:25:50 playerone volumio[4081]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Oct 15 23:25:50 playerone volumio[4081]: info: FusionDsp loaded Oct 15 23:25:50 playerone volumio[4081]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 23:25:50 playerone sudo[4293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Oct 15 23:25:50 playerone sudo[4293]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:50 playerone volumio[4081]: info: FusionDsp - Reporting Fusion DSP Enabled Oct 15 23:25:50 playerone volumio[4081]: info: Adding Signal Path Element [object Object] Oct 15 23:25:50 playerone volumio[4081]: info: Adding fusiondspeq DSP Signal Path Element Oct 15 23:25:50 playerone volumio[4081]: info: FusionDsp - ---- installed callbackRead Oct 15 23:25:50 playerone sudo[4293]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:50 playerone volumio[4081]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 23:25:50 playerone volumio[4081]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Oct 15 23:25:50 playerone volumio[4081]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Oct 15 23:25:50 playerone volumio[4081]: at onErrorNT (internal/child_process.js:465:16) Oct 15 23:25:50 playerone volumio[4081]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Oct 15 23:25:50 playerone volumio[4081]: errno: -2, Oct 15 23:25:50 playerone volumio[4081]: code: 'ENOENT', Oct 15 23:25:50 playerone volumio[4081]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Oct 15 23:25:50 playerone volumio[4081]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Oct 15 23:25:50 playerone volumio[4081]: spawnargs: [ Oct 15 23:25:50 playerone volumio[4081]: '-p', Oct 15 23:25:50 playerone volumio[4081]: 9876, Oct 15 23:25:50 playerone volumio[4081]: '-o', Oct 15 23:25:50 playerone volumio[4081]: '/tmp/camilladsp.log', Oct 15 23:25:50 playerone volumio[4081]: '-l', Oct 15 23:25:50 playerone volumio[4081]: 'warn', Oct 15 23:25:50 playerone volumio[4081]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Oct 15 23:25:50 playerone volumio[4081]: ] Oct 15 23:25:50 playerone volumio[4081]: } Oct 15 23:25:50 playerone volumio[4081]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 23:25:51 playerone mpd[4279]: Oct 15 23:25 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 15 23:25:51 playerone systemd[1]: Started Music Player Daemon. Oct 15 23:25:51 playerone sudo[4203]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:51 playerone sudo[4261]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:51 playerone sudo[4181]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:51 playerone sudo[4306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-15 23:24 Oct 15 23:25:51 playerone sudo[4306]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:51 playerone sudo[4306]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:51 playerone volumio-remote-updater[587]: [2025-10-15 23:25:51] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Oct 15 23:25:51 playerone volumio-remote-updater[587]: [2025-10-15 23:25:51] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Oct 15 23:25:51 playerone systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 15 23:25:51 playerone systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 15 23:25:51 playerone systemd[1]: Started dynamicswap service. Oct 15 23:25:51 playerone systemd[1]: dynamicswap.service: Succeeded. Oct 15 23:25:51 playerone systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Oct 15 23:25:51 playerone systemd[1]: volumio.service: Scheduled restart job, restart counter is at 14. Oct 15 23:25:51 playerone systemd[1]: Started dynamicswap service. Oct 15 23:25:51 playerone systemd[1]: Stopped Volumio Backend Module. Oct 15 23:25:51 playerone systemd[1]: Started Volumio Backend Module. Oct 15 23:25:51 playerone systemd[1]: dynamicswap.service: Succeeded. Oct 15 23:25:53 playerone volumio[4317]: info: ------------------------------------------- Oct 15 23:25:53 playerone volumio[4317]: info: ----- Volumio3 ---- Oct 15 23:25:53 playerone volumio[4317]: info: ------------------------------------------- Oct 15 23:25:53 playerone volumio[4317]: info: ----- System startup ---- Oct 15 23:25:53 playerone volumio[4317]: info: ------------------------------------------- Oct 15 23:25:54 playerone volumio[4317]: info: MYVOLUMIO Environment detected Oct 15 23:25:54 playerone volumio[4317]: info: Plugin folders cleanup Oct 15 23:25:54 playerone volumio[4317]: info: Scanning into folder /volumio/app/plugins/ Oct 15 23:25:54 playerone volumio[4317]: info: Scanning category audio_interface Oct 15 23:25:54 playerone volumio[4317]: info: Scanning category miscellanea Oct 15 23:25:54 playerone volumio[4317]: info: Scanning category music_service Oct 15 23:25:54 playerone volumio[4317]: info: Scanning category plugins.json Oct 15 23:25:54 playerone volumio[4317]: info: Scanning category system_controller Oct 15 23:25:54 playerone volumio[4317]: info: Scanning category user_interface Oct 15 23:25:54 playerone volumio[4317]: info: Scanning into folder /data/plugins/ Oct 15 23:25:54 playerone volumio[4317]: info: Scanning category audio_interface Oct 15 23:25:54 playerone volumio[4317]: info: Plugin folders cleanup completed Oct 15 23:25:54 playerone volumio[4317]: info: ------------------------------------------- Oct 15 23:25:54 playerone volumio[4317]: info: ----- Core plugins startup ---- Oct 15 23:25:54 playerone volumio[4317]: info: ------------------------------------------- Oct 15 23:25:54 playerone volumio[4317]: info: Loading plugins from folder /volumio/app/plugins/ Oct 15 23:25:54 playerone volumio[4317]: info: Adding plugin upnp to MyMusic Plugins Oct 15 23:25:54 playerone volumio[4317]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 15 23:25:54 playerone volumio[4317]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 15 23:25:54 playerone volumio[4317]: info: Loading plugins from folder /data/plugins/ Oct 15 23:25:54 playerone volumio[4317]: info: Loading plugin "system"... Oct 15 23:25:54 playerone volumio[4317]: info: Loading plugin "appearance"... Oct 15 23:25:55 playerone volumio[4317]: info: Loading plugin "network"... Oct 15 23:25:55 playerone volumio[4317]: info: Refreshing Cached IP Addresses Oct 15 23:25:55 playerone sudo[4344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 15 23:25:55 playerone sudo[4344]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:55 playerone sudo[4344]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:55 playerone sudo[4346]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 15 23:25:55 playerone sudo[4346]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:55 playerone sudo[4346]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:55 playerone volumio[4317]: info: Loading plugin "services"... Oct 15 23:25:55 playerone volumio[4317]: info: Loading plugin "alsa_controller"... Oct 15 23:25:55 playerone sudo[4359]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 15 23:25:55 playerone sudo[4359]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:55 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:25:55 playerone volumio[4317]: info: Loading plugin "wizard"... Oct 15 23:25:55 playerone volumio[4317]: info: Loading plugin "networkfs"... Oct 15 23:25:55 playerone volumio[4317]: info: Starting Udev Watcher for removable devices Oct 15 23:25:55 playerone volumio[4317]: info: Ignoring mount for partition: boot Oct 15 23:25:55 playerone volumio[4317]: info: Ignoring mount for partition: volumio Oct 15 23:25:55 playerone volumio[4317]: info: Ignoring mount for partition: volumio_data Oct 15 23:25:55 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 23:25:55 playerone volumio[4317]: info: Loading plugin "volumio_command_line_client"... Oct 15 23:25:55 playerone volumio[4317]: info: Loading plugin "upnp"... Oct 15 23:25:55 playerone volumio[4317]: info: [1760563555871] Starting Upmpd Daemon Oct 15 23:25:55 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 23:25:55 playerone volumio[4317]: info: Loading plugin "my_music"... Oct 15 23:25:55 playerone volumio[4317]: info: Loading plugin "mpd"... Oct 15 23:25:56 playerone volumio[4317]: info: Loading plugin "upnp_browser"... Oct 15 23:25:56 playerone sudo[4359]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:56 playerone volumio[4317]: info: Loading plugin "alarm-clock"... Oct 15 23:25:56 playerone volumio-remote-updater[587]: [2025-10-15 23:25:56] [connect] Successful connection Oct 15 23:25:56 playerone volumio[4317]: info: Loading plugin "airplay_emulation"... Oct 15 23:25:56 playerone volumio[4317]: info: Starting Shairport Sync Oct 15 23:25:56 playerone volumio[4317]: info: Loading plugin "last_100"... Oct 15 23:25:56 playerone volumio[4317]: info: Loading plugin "webradio"... Oct 15 23:25:56 playerone volumio[4317]: info: Loading plugin "i2s_dacs"... Oct 15 23:25:56 playerone volumio[4317]: info: I2S DAC not set, start Auto-detection Oct 15 23:25:56 playerone volumio[4317]: info: Loading plugin "volumiodiscovery"... Oct 15 23:25:56 playerone volumio[4317]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 15 23:25:56 playerone volumio[4317]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:25:56 playerone volumio[4317]: *** WARNING *** For more information see Oct 15 23:25:56 playerone node[4317]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 15 23:25:56 playerone volumio[4317]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 15 23:25:56 playerone volumio[4317]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:25:56 playerone volumio[4317]: *** WARNING *** For more information see Oct 15 23:25:56 playerone node[4317]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:25:56 playerone node[4317]: *** WARNING *** For more information see Oct 15 23:25:56 playerone node[4317]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 15 23:25:56 playerone node[4317]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:25:56 playerone node[4317]: *** WARNING *** For more information see Oct 15 23:25:56 playerone volumio[4317]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 15 23:25:56 playerone volumio[4317]: info: Discovery: Started advertising with name: playerONE Oct 15 23:25:56 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 23:25:56 playerone volumio[4317]: info: Loading plugin "outputs"... Oct 15 23:25:56 playerone volumio[4317]: info: Loading plugin "albumart"... Oct 15 23:25:56 playerone volumio[4317]: info: Plugin example_plugin is not enabled Oct 15 23:25:56 playerone volumio[4317]: info: Loading plugin "inputs"... Oct 15 23:25:56 playerone volumio[4317]: info: Loading plugin "updater_comm"... Oct 15 23:25:57 playerone volumio[4317]: info: Plugin mpdemulation is not enabled Oct 15 23:25:57 playerone volumio[4317]: info: Loading plugin "rest_api"... Oct 15 23:25:57 playerone volumio[4317]: info: Loading plugin "websocket"... Oct 15 23:25:57 playerone volumio[4317]: info: Starting Socket.io Server version 2.3.0 Oct 15 23:25:57 playerone volumio[4317]: info: Loading plugin "fusiondsp"... Oct 15 23:25:57 playerone volumio[4317]: Forking 3 albumart workers Oct 15 23:25:57 playerone volumio[4317]: info: Applying required configuration parameters for plugin fusiondsp Oct 15 23:25:57 playerone volumio[4317]: info: Loading i18n strings for locale en Oct 15 23:25:57 playerone volumio[4317]: Updating browse sources language Oct 15 23:25:57 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:58 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:25:58 playerone volumio[4317]: info: CoreCommandRouter::initPlayerControls Oct 15 23:25:58 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:58 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:58 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:58 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:58 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:58 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:58 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:58 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:58 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:25:58 playerone volumio[4317]: Express server listening on port 3000 Oct 15 23:25:58 playerone volumio[4317]: [Metrics] WebUI: 5s 282.88ms Oct 15 23:25:58 playerone volumio[4317]: info: CoreStateMachine::resetVolumioState Oct 15 23:25:58 playerone volumio[4317]: info: CoreStateMachine::getcurrentVolume Oct 15 23:25:58 playerone volumio[4317]: info: CoreCommandRouter::volumioRetrievevolume Oct 15 23:25:58 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:58 playerone volumio[4317]: Starting albumart workers Oct 15 23:25:58 playerone volumio[4317]: info: Volumio Network Manager: Network status updated: 1 Oct 15 23:25:58 playerone volumio[4317]: Starting albumart workers Oct 15 23:25:58 playerone volumio[4317]: Starting albumart workers Oct 15 23:25:58 playerone volumio[4317]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Oct 15 23:25:58 playerone volumio[4317]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Oct 15 23:25:58 playerone volumio[4317]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Oct 15 23:25:58 playerone volumio[4317]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Oct 15 23:25:58 playerone volumio-remote-updater[587]: [2025-10-15 23:25:58] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1760563556 101 Oct 15 23:25:58 playerone volumio[4317]: 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 Oct 15 23:25:58 playerone volumio[4317]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Oct 15 23:25:58 playerone volumio[4317]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 15 23:25:58 playerone volumio[4317]: info: VolumeController:: Volume=20 Mute =false Oct 15 23:25:58 playerone volumio[4317]: info: CoreStateMachine::pushState Oct 15 23:25:58 playerone volumio[4317]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:58 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 23:25:58 playerone volumio[4317]: info: CoreCommandRouter::volumioPushState Oct 15 23:25:58 playerone volumio[4317]: info: CoreStateMachine::updateTrackBlock Oct 15 23:25:58 playerone volumio[4317]: info: CorePlayQueue::getTrackBlock Oct 15 23:25:58 playerone volumio[4317]: info: CoreCommandRouter::volumioRetrievevolume Oct 15 23:25:58 playerone volumio[4317]: info: Reloading queue from file Oct 15 23:25:58 playerone volumio[4317]: info: CoreCommandRouter::volumioGetState Oct 15 23:25:58 playerone volumio[4317]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:58 playerone volumio[4317]: info: CoreStateMachine::setRepeat null single undefined Oct 15 23:25:58 playerone volumio[4317]: info: CoreStateMachine::pushState Oct 15 23:25:58 playerone volumio[4317]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:58 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 23:25:58 playerone volumio[4317]: info: CoreCommandRouter::volumioPushState Oct 15 23:25:58 playerone volumio[4317]: info: CoreStateMachine::setRandom null Oct 15 23:25:58 playerone volumio[4317]: info: CoreStateMachine::pushState Oct 15 23:25:58 playerone volumio[4317]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:58 playerone volumio[4317]: info: CoreCommandRouter::volumioPushState Oct 15 23:25:59 playerone volumio[4317]: info: Setting Device type: Raspberry PI Oct 15 23:25:59 playerone volumio[4317]: info: CoreCommandRouter::volumioGetQueue Oct 15 23:25:59 playerone volumio[4317]: info: CoreStateMachine::getQueue Oct 15 23:25:59 playerone volumio[4317]: info: CorePlayQueue::getQueue Oct 15 23:25:59 playerone volumio[4317]: info: CoreCommandRouter::volumioGetVisibleSources Oct 15 23:25:59 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:59 playerone volumio[4317]: info: Listing playlists Oct 15 23:25:59 playerone volumio[4317]: info: VolumeController:: Volume=20 Mute =false Oct 15 23:25:59 playerone volumio[4317]: info: CoreStateMachine::pushState Oct 15 23:25:59 playerone volumio[4317]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:59 playerone volumio[4317]: info: CoreCommandRouter::volumioPushState Oct 15 23:25:59 playerone volumio[4317]: info: Discovery: adding 76640995-2991-45ef-aafc-08dc8d3a1ee7 Oct 15 23:25:59 playerone volumio[4317]: info: Discovery: Found device playerONE Oct 15 23:25:59 playerone volumio[4317]: info: CoreCommandRouter::volumioGetState Oct 15 23:25:59 playerone volumio[4317]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:59 playerone volumio[4317]: info: Completed loading Core Plugins Oct 15 23:25:59 playerone volumio[4317]: info: Preparing to generate the ALSA configuration file Oct 15 23:25:59 playerone volumio[4317]: info: Discovery: this is already registered, 76640995-2991-45ef-aafc-08dc8d3a1ee7 Oct 15 23:25:59 playerone volumio[4317]: info: Discovery: Found device playerONE Oct 15 23:25:59 playerone volumio[4317]: info: CoreCommandRouter::volumioGetState Oct 15 23:25:59 playerone volumio[4317]: info: CorePlayQueue::getTrack 0 Oct 15 23:25:59 playerone volumio[4317]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 15 23:25:59 playerone volumio[4317]: info: Reading ALSA contributions from plugins. Oct 15 23:25:59 playerone volumio[4317]: info: Asound.conf file unchanged, so no further update is needed Oct 15 23:25:59 playerone volumio[4317]: info: Output device has changed, restarting MPD Oct 15 23:25:59 playerone sudo[4439]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 23:25:59 playerone volumio[4317]: info: Output device has changed, restarting Shairport Sync Oct 15 23:25:59 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:59 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:59 playerone sudo[4439]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:59 playerone sudo[4439]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:59 playerone sudo[4441]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 23:25:59 playerone sudo[4441]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:59 playerone systemd[1]: Stopping Music Player Daemon... Oct 15 23:25:59 playerone volumio[4317]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:25:59 playerone volumio[4317]: info: ___________ START PLUGINS ___________ Oct 15 23:25:59 playerone systemd[1]: mpd.service: Succeeded. Oct 15 23:25:59 playerone systemd[1]: Stopped Music Player Daemon. Oct 15 23:25:59 playerone volumio[4317]: info: ControllerMpd::onStart: Initializing MPD Oct 15 23:25:59 playerone volumio[4317]: info: Creating MPD Configuration file Oct 15 23:25:59 playerone sudo[4449]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 23:25:59 playerone sudo[4449]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:59 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:25:59 playerone volumio[4317]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 23:25:59 playerone volumio[4317]: info: [1760563559634] CoreMusicLibrary::Adding element Media Servers Oct 15 23:25:59 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:59 playerone sudo[4449]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:59 playerone systemd[1]: Starting Music Player Daemon... Oct 15 23:25:59 playerone sudo[4451]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 23:25:59 playerone sudo[4451]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:59 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:59 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:59 playerone systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Oct 15 23:25:59 playerone systemd[1]: mpd.service: Succeeded. Oct 15 23:25:59 playerone systemd[1]: Stopped Music Player Daemon. Oct 15 23:25:59 playerone systemd[1]: Starting Music Player Daemon... Oct 15 23:25:59 playerone volumio[4317]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:25:59 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:59 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:59 playerone volumio[4317]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:25:59 playerone volumio[4317]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 23:25:59 playerone volumio[4317]: info: [1760563559781] CoreMusicLibrary::Adding element Last_100 Oct 15 23:25:59 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:59 playerone volumio[4317]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 23:25:59 playerone volumio[4317]: info: [1760563559785] CoreMusicLibrary::Adding element Webradio Oct 15 23:25:59 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:25:59 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:25:59 playerone volumio[4317]: info: Initializing BBC Radios Oct 15 23:25:59 playerone sudo[4455]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 15 23:25:59 playerone sudo[4455]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:25:59 playerone sudo[4455]: pam_unix(sudo:session): session closed for user root Oct 15 23:25:59 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:25:59 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:25:59 playerone volumio[4317]: info: Loading i18n strings for locale en Oct 15 23:25:59 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Oct 15 23:25:59 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:25:59 playerone volumio[4317]: info: FusionDsp - mixtype--------------------- Hardware Oct 15 23:25:59 playerone volumio[4317]: info: Volumio Calling Home Oct 15 23:26:00 playerone volumio[4317]: info: Preparing to generate the ALSA configuration file Oct 15 23:26:00 playerone volumio[4317]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 15 23:26:00 playerone volumio[4317]: info: Reading ALSA contributions from plugins. Oct 15 23:26:00 playerone volumio[4317]: info: MPD Permissions set Oct 15 23:26:00 playerone volumio[4317]: info: MPD Permissions set Oct 15 23:26:00 playerone volumio[4317]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Oct 15 23:26:00 playerone volumio[4317]: info: Volumio called home Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: Starting Shairport Sync Oct 15 23:26:00 playerone volumio[4317]: info: Starting Shairport Sync Oct 15 23:26:00 playerone volumio[4317]: info: Starting Shairport Sync Oct 15 23:26:00 playerone sudo[4487]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:26:00 playerone sudo[4487]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:00 playerone sudo[4489]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:26:00 playerone sudo[4489]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:00 playerone sudo[4492]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:26:00 playerone sudo[4492]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:00 playerone systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::volumioGetState Oct 15 23:26:00 playerone volumio[4317]: info: CorePlayQueue::getTrack 0 Oct 15 23:26:00 playerone systemd[1]: shairport-sync.service: Succeeded. Oct 15 23:26:00 playerone systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 15 23:26:00 playerone volumio[4317]: info: Asound.conf file unchanged, so no further update is needed Oct 15 23:26:00 playerone volumio[4317]: info: Output device has changed, restarting MPD Oct 15 23:26:00 playerone volumio[4317]: info: Output device has changed, restarting Shairport Sync Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:26:00 playerone systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 15 23:26:00 playerone sudo[4489]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:00 playerone sudo[4492]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:00 playerone sudo[4497]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 23:26:00 playerone sudo[4499]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 23:26:00 playerone sudo[4499]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:00 playerone sudo[4487]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:00 playerone volumio[4317]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:26:00 playerone sudo[4497]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:00 playerone sudo[4497]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:00 playerone systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 15 23:26:00 playerone systemd[1]: mpd.service: Succeeded. Oct 15 23:26:00 playerone systemd[1]: Stopped Music Player Daemon. Oct 15 23:26:00 playerone volumio[4317]: info: MPD Permissions set Oct 15 23:26:00 playerone volumio[4317]: info: Shairport-Sync Started Oct 15 23:26:00 playerone volumio[4317]: Error adding Membership: Error: addMembership EINVAL Oct 15 23:26:00 playerone volumio[4317]: info: Shairport-Sync Started Oct 15 23:26:00 playerone volumio[4317]: info: Shairport-Sync Started Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:00 playerone volumio[4317]: info: Starting Shairport Sync Oct 15 23:26:00 playerone sudo[4513]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:26:00 playerone sudo[4513]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:00 playerone systemd[1]: Starting Music Player Daemon... Oct 15 23:26:00 playerone systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 15 23:26:00 playerone systemd[1]: shairport-sync.service: Succeeded. Oct 15 23:26:00 playerone systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 15 23:26:00 playerone systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 15 23:26:00 playerone sudo[4513]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:00 playerone volumio[4317]: info: Shairport-Sync Started Oct 15 23:26:00 playerone sudo[4506]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 15 23:26:00 playerone sudo[4506]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:00 playerone sudo[4506]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:01 playerone volumio[4317]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Oct 15 23:26:01 playerone volumio[4317]: 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 Oct 15 23:26:01 playerone volumio[4317]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Oct 15 23:26:01 playerone volumio[4317]: info: camilladsp service started and running in background, instance 1 Oct 15 23:26:01 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:01 playerone volumio[4317]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Oct 15 23:26:01 playerone volumio[4317]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Oct 15 23:26:01 playerone volumio[4317]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Oct 15 23:26:01 playerone volumio[4317]: info: FusionDsp loaded Oct 15 23:26:01 playerone volumio[4317]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 23:26:02 playerone sudo[4531]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Oct 15 23:26:02 playerone sudo[4531]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:02 playerone volumio[4317]: info: FusionDsp - Reporting Fusion DSP Enabled Oct 15 23:26:02 playerone volumio[4317]: info: Adding Signal Path Element [object Object] Oct 15 23:26:02 playerone volumio[4317]: info: Adding fusiondspeq DSP Signal Path Element Oct 15 23:26:02 playerone volumio[4317]: info: FusionDsp - ---- installed callbackRead Oct 15 23:26:02 playerone volumio[4317]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 23:26:02 playerone sudo[4531]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:02 playerone volumio[4317]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Oct 15 23:26:02 playerone volumio[4317]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Oct 15 23:26:02 playerone volumio[4317]: at onErrorNT (internal/child_process.js:465:16) Oct 15 23:26:02 playerone volumio[4317]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Oct 15 23:26:02 playerone volumio[4317]: errno: -2, Oct 15 23:26:02 playerone volumio[4317]: code: 'ENOENT', Oct 15 23:26:02 playerone volumio[4317]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Oct 15 23:26:02 playerone volumio[4317]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Oct 15 23:26:02 playerone volumio[4317]: spawnargs: [ Oct 15 23:26:02 playerone volumio[4317]: '-p', Oct 15 23:26:02 playerone volumio[4317]: 9876, Oct 15 23:26:02 playerone volumio[4317]: '-o', Oct 15 23:26:02 playerone volumio[4317]: '/tmp/camilladsp.log', Oct 15 23:26:02 playerone volumio[4317]: '-l', Oct 15 23:26:02 playerone volumio[4317]: 'warn', Oct 15 23:26:02 playerone volumio[4317]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Oct 15 23:26:02 playerone volumio[4317]: ] Oct 15 23:26:02 playerone volumio[4317]: } Oct 15 23:26:02 playerone volumio[4317]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 23:26:02 playerone mpd[4519]: Oct 15 23:26 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 15 23:26:02 playerone systemd[1]: Started Music Player Daemon. Oct 15 23:26:02 playerone sudo[4499]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:02 playerone sudo[4441]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:02 playerone sudo[4451]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:02 playerone sudo[4545]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-15 23:25 Oct 15 23:26:02 playerone sudo[4545]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:02 playerone sudo[4545]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:02 playerone volumio-remote-updater[587]: [2025-10-15 23:26:02] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Oct 15 23:26:02 playerone volumio-remote-updater[587]: [2025-10-15 23:26:02] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Oct 15 23:26:02 playerone systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 15 23:26:02 playerone systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 15 23:26:02 playerone systemd[1]: Started dynamicswap service. Oct 15 23:26:03 playerone systemd[1]: dynamicswap.service: Succeeded. Oct 15 23:26:03 playerone systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Oct 15 23:26:03 playerone systemd[1]: volumio.service: Scheduled restart job, restart counter is at 15. Oct 15 23:26:03 playerone systemd[1]: Started dynamicswap service. Oct 15 23:26:03 playerone systemd[1]: Stopped Volumio Backend Module. Oct 15 23:26:03 playerone systemd[1]: Started Volumio Backend Module. Oct 15 23:26:03 playerone systemd[1]: dynamicswap.service: Succeeded. Oct 15 23:26:04 playerone volumio[4556]: info: ------------------------------------------- Oct 15 23:26:04 playerone volumio[4556]: info: ----- Volumio3 ---- Oct 15 23:26:04 playerone volumio[4556]: info: ------------------------------------------- Oct 15 23:26:04 playerone volumio[4556]: info: ----- System startup ---- Oct 15 23:26:04 playerone volumio[4556]: info: ------------------------------------------- Oct 15 23:26:05 playerone volumio[4556]: info: MYVOLUMIO Environment detected Oct 15 23:26:05 playerone volumio[4556]: info: Plugin folders cleanup Oct 15 23:26:05 playerone volumio[4556]: info: Scanning into folder /volumio/app/plugins/ Oct 15 23:26:05 playerone volumio[4556]: info: Scanning category audio_interface Oct 15 23:26:05 playerone volumio[4556]: info: Scanning category miscellanea Oct 15 23:26:05 playerone volumio[4556]: info: Scanning category music_service Oct 15 23:26:05 playerone volumio[4556]: info: Scanning category plugins.json Oct 15 23:26:05 playerone volumio[4556]: info: Scanning category system_controller Oct 15 23:26:05 playerone volumio[4556]: info: Scanning category user_interface Oct 15 23:26:05 playerone volumio[4556]: info: Scanning into folder /data/plugins/ Oct 15 23:26:05 playerone volumio[4556]: info: Scanning category audio_interface Oct 15 23:26:05 playerone volumio[4556]: info: Plugin folders cleanup completed Oct 15 23:26:05 playerone volumio[4556]: info: ------------------------------------------- Oct 15 23:26:05 playerone volumio[4556]: info: ----- Core plugins startup ---- Oct 15 23:26:05 playerone volumio[4556]: info: ------------------------------------------- Oct 15 23:26:05 playerone volumio[4556]: info: Loading plugins from folder /volumio/app/plugins/ Oct 15 23:26:05 playerone volumio[4556]: info: Adding plugin upnp to MyMusic Plugins Oct 15 23:26:05 playerone volumio[4556]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 15 23:26:05 playerone volumio[4556]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 15 23:26:05 playerone volumio[4556]: info: Loading plugins from folder /data/plugins/ Oct 15 23:26:05 playerone volumio[4556]: info: Loading plugin "system"... Oct 15 23:26:05 playerone volumio[4556]: info: Loading plugin "appearance"... Oct 15 23:26:06 playerone volumio[4556]: info: Loading plugin "network"... Oct 15 23:26:06 playerone volumio[4556]: info: Refreshing Cached IP Addresses Oct 15 23:26:06 playerone sudo[4620]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 15 23:26:06 playerone sudo[4620]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:06 playerone sudo[4620]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:06 playerone sudo[4622]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 15 23:26:06 playerone sudo[4622]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:06 playerone sudo[4622]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:06 playerone volumio[4556]: info: Loading plugin "services"... Oct 15 23:26:06 playerone volumio[4556]: info: Loading plugin "alsa_controller"... Oct 15 23:26:06 playerone sudo[4634]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 15 23:26:06 playerone sudo[4634]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:07 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:26:07 playerone volumio[4556]: info: Loading plugin "wizard"... Oct 15 23:26:07 playerone volumio[4556]: info: Loading plugin "networkfs"... Oct 15 23:26:07 playerone volumio[4556]: info: Starting Udev Watcher for removable devices Oct 15 23:26:07 playerone volumio[4556]: info: Ignoring mount for partition: boot Oct 15 23:26:07 playerone volumio[4556]: info: Ignoring mount for partition: volumio Oct 15 23:26:07 playerone volumio[4556]: info: Ignoring mount for partition: volumio_data Oct 15 23:26:07 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 23:26:07 playerone volumio[4556]: info: Loading plugin "volumio_command_line_client"... Oct 15 23:26:07 playerone volumio[4556]: info: Loading plugin "upnp"... Oct 15 23:26:07 playerone volumio[4556]: info: [1760563567086] Starting Upmpd Daemon Oct 15 23:26:07 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 23:26:07 playerone volumio[4556]: info: Loading plugin "my_music"... Oct 15 23:26:07 playerone volumio[4556]: info: Loading plugin "mpd"... Oct 15 23:26:07 playerone volumio[4556]: info: Loading plugin "upnp_browser"... Oct 15 23:26:07 playerone sudo[4634]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:07 playerone volumio[4556]: info: Loading plugin "alarm-clock"... Oct 15 23:26:07 playerone volumio-remote-updater[587]: [2025-10-15 23:26:07] [connect] Successful connection Oct 15 23:26:07 playerone volumio[4556]: info: Loading plugin "airplay_emulation"... Oct 15 23:26:07 playerone volumio[4556]: info: Starting Shairport Sync Oct 15 23:26:07 playerone volumio[4556]: info: Loading plugin "last_100"... Oct 15 23:26:07 playerone volumio[4556]: info: Loading plugin "webradio"... Oct 15 23:26:08 playerone volumio[4556]: info: Loading plugin "i2s_dacs"... Oct 15 23:26:08 playerone volumio[4556]: info: I2S DAC not set, start Auto-detection Oct 15 23:26:08 playerone volumio[4556]: info: Loading plugin "volumiodiscovery"... Oct 15 23:26:08 playerone volumio[4556]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 15 23:26:08 playerone volumio[4556]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:26:08 playerone volumio[4556]: *** WARNING *** For more information see Oct 15 23:26:08 playerone volumio[4556]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 15 23:26:08 playerone node[4556]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 15 23:26:08 playerone volumio[4556]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:26:08 playerone volumio[4556]: *** WARNING *** For more information see Oct 15 23:26:08 playerone node[4556]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:26:08 playerone node[4556]: *** WARNING *** For more information see Oct 15 23:26:08 playerone node[4556]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 15 23:26:08 playerone node[4556]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:26:08 playerone node[4556]: *** WARNING *** For more information see Oct 15 23:26:08 playerone volumio[4556]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 15 23:26:08 playerone volumio[4556]: info: Discovery: Started advertising with name: playerONE Oct 15 23:26:08 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 23:26:08 playerone volumio[4556]: info: Loading plugin "outputs"... Oct 15 23:26:08 playerone volumio[4556]: info: Loading plugin "albumart"... Oct 15 23:26:08 playerone volumio[4556]: info: Plugin example_plugin is not enabled Oct 15 23:26:08 playerone volumio[4556]: info: Loading plugin "inputs"... Oct 15 23:26:08 playerone volumio[4556]: info: Loading plugin "updater_comm"... Oct 15 23:26:08 playerone volumio[4556]: info: Plugin mpdemulation is not enabled Oct 15 23:26:08 playerone volumio[4556]: info: Loading plugin "rest_api"... Oct 15 23:26:08 playerone volumio[4556]: info: Loading plugin "websocket"... Oct 15 23:26:08 playerone volumio[4556]: info: Starting Socket.io Server version 2.3.0 Oct 15 23:26:08 playerone volumio[4556]: info: Loading plugin "fusiondsp"... Oct 15 23:26:08 playerone volumio[4556]: Forking 3 albumart workers Oct 15 23:26:08 playerone volumio[4556]: info: Applying required configuration parameters for plugin fusiondsp Oct 15 23:26:09 playerone volumio[4556]: info: Loading i18n strings for locale en Oct 15 23:26:09 playerone volumio[4556]: Updating browse sources language Oct 15 23:26:09 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:26:09 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:26:09 playerone volumio[4556]: info: CoreCommandRouter::initPlayerControls Oct 15 23:26:09 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:09 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:09 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:09 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:09 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:09 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:09 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:09 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:09 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:26:09 playerone volumio[4556]: Express server listening on port 3000 Oct 15 23:26:09 playerone volumio[4556]: [Metrics] WebUI: 5s 160.29ms Oct 15 23:26:09 playerone volumio[4556]: info: CoreStateMachine::resetVolumioState Oct 15 23:26:09 playerone volumio[4556]: info: CoreStateMachine::getcurrentVolume Oct 15 23:26:09 playerone volumio[4556]: info: CoreCommandRouter::volumioRetrievevolume Oct 15 23:26:09 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:26:09 playerone volumio[4556]: info: Volumio Network Manager: Network status updated: 1 Oct 15 23:26:09 playerone volumio[4556]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Oct 15 23:26:09 playerone volumio[4556]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Oct 15 23:26:09 playerone volumio[4556]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Oct 15 23:26:09 playerone volumio[4556]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Oct 15 23:26:09 playerone volumio-remote-updater[587]: [2025-10-15 23:26:09] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1760563567 101 Oct 15 23:26:09 playerone volumio[4556]: Starting albumart workers Oct 15 23:26:09 playerone volumio[4556]: 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 Oct 15 23:26:09 playerone volumio[4556]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Oct 15 23:26:09 playerone volumio[4556]: Starting albumart workers Oct 15 23:26:09 playerone volumio[4556]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 15 23:26:09 playerone volumio[4556]: info: Reloading queue from file Oct 15 23:26:09 playerone volumio[4556]: info: Setting Device type: Raspberry PI Oct 15 23:26:09 playerone volumio[4556]: info: CoreStateMachine::setRepeat null single undefined Oct 15 23:26:09 playerone volumio[4556]: info: CoreStateMachine::pushState Oct 15 23:26:09 playerone volumio[4556]: info: CorePlayQueue::getTrack 0 Oct 15 23:26:09 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 23:26:09 playerone volumio[4556]: info: CoreCommandRouter::volumioPushState Oct 15 23:26:09 playerone volumio[4556]: Starting albumart workers Oct 15 23:26:09 playerone volumio[4556]: info: CoreStateMachine::setRandom null Oct 15 23:26:09 playerone volumio[4556]: info: CoreStateMachine::pushState Oct 15 23:26:09 playerone volumio[4556]: info: CorePlayQueue::getTrack 0 Oct 15 23:26:09 playerone volumio[4556]: info: CoreCommandRouter::volumioPushState Oct 15 23:26:10 playerone volumio[4556]: info: CoreCommandRouter::volumioGetState Oct 15 23:26:10 playerone volumio[4556]: info: CorePlayQueue::getTrack 0 Oct 15 23:26:10 playerone volumio[4556]: info: VolumeController:: Volume=20 Mute =false Oct 15 23:26:10 playerone volumio[4556]: info: CoreStateMachine::pushState Oct 15 23:26:10 playerone volumio[4556]: info: CorePlayQueue::getTrack 0 Oct 15 23:26:10 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 23:26:10 playerone volumio[4556]: info: CoreCommandRouter::volumioPushState Oct 15 23:26:10 playerone volumio[4556]: info: CoreStateMachine::updateTrackBlock Oct 15 23:26:10 playerone volumio[4556]: info: CorePlayQueue::getTrackBlock Oct 15 23:26:10 playerone volumio[4556]: info: CoreCommandRouter::volumioRetrievevolume Oct 15 23:26:10 playerone volumio[4556]: info: CoreCommandRouter::volumioGetQueue Oct 15 23:26:10 playerone volumio[4556]: info: CoreStateMachine::getQueue Oct 15 23:26:10 playerone volumio[4556]: info: CorePlayQueue::getQueue Oct 15 23:26:10 playerone volumio[4556]: info: CoreCommandRouter::volumioGetVisibleSources Oct 15 23:26:10 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:26:10 playerone volumio[4556]: info: Listing playlists Oct 15 23:26:10 playerone volumio[4556]: info: Discovery: adding 76640995-2991-45ef-aafc-08dc8d3a1ee7 Oct 15 23:26:10 playerone volumio[4556]: info: Discovery: Found device playerONE Oct 15 23:26:10 playerone volumio[4556]: info: CoreCommandRouter::volumioGetState Oct 15 23:26:10 playerone volumio[4556]: info: CorePlayQueue::getTrack 0 Oct 15 23:26:10 playerone volumio[4556]: info: VolumeController:: Volume=20 Mute =false Oct 15 23:26:10 playerone volumio[4556]: info: CoreStateMachine::pushState Oct 15 23:26:10 playerone volumio[4556]: info: CorePlayQueue::getTrack 0 Oct 15 23:26:10 playerone volumio[4556]: info: CoreCommandRouter::volumioPushState Oct 15 23:26:10 playerone volumio[4556]: info: Discovery: this is already registered, 76640995-2991-45ef-aafc-08dc8d3a1ee7 Oct 15 23:26:10 playerone volumio[4556]: info: Discovery: Found device playerONE Oct 15 23:26:10 playerone volumio[4556]: info: CoreCommandRouter::volumioGetState Oct 15 23:26:10 playerone volumio[4556]: info: CorePlayQueue::getTrack 0 Oct 15 23:26:10 playerone volumio[4556]: info: Completed loading Core Plugins Oct 15 23:26:10 playerone volumio[4556]: info: Preparing to generate the ALSA configuration file Oct 15 23:26:10 playerone volumio[4556]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 15 23:26:10 playerone volumio[4556]: info: Reading ALSA contributions from plugins. Oct 15 23:26:10 playerone volumio[4556]: info: Asound.conf file unchanged, so no further update is needed Oct 15 23:26:10 playerone volumio[4556]: info: Output device has changed, restarting MPD Oct 15 23:26:10 playerone sudo[4707]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 23:26:10 playerone sudo[4707]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:10 playerone volumio[4556]: info: Output device has changed, restarting Shairport Sync Oct 15 23:26:10 playerone sudo[4707]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:10 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:10 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:26:10 playerone sudo[4718]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 23:26:10 playerone sudo[4718]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:10 playerone systemd[1]: Stopping Music Player Daemon... Oct 15 23:26:10 playerone volumio[4556]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:26:10 playerone volumio[4556]: info: ___________ START PLUGINS ___________ Oct 15 23:26:10 playerone systemd[1]: mpd.service: Succeeded. Oct 15 23:26:10 playerone systemd[1]: Stopped Music Player Daemon. Oct 15 23:26:10 playerone volumio[4556]: info: ControllerMpd::onStart: Initializing MPD Oct 15 23:26:10 playerone volumio[4556]: info: Creating MPD Configuration file Oct 15 23:26:10 playerone sudo[4725]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 23:26:10 playerone sudo[4725]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:10 playerone systemd[1]: Starting Music Player Daemon... Oct 15 23:26:10 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:26:10 playerone volumio[4556]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 23:26:10 playerone volumio[4556]: info: [1760563570840] CoreMusicLibrary::Adding element Media Servers Oct 15 23:26:10 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:26:10 playerone sudo[4725]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:10 playerone sudo[4727]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 23:26:10 playerone sudo[4727]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:10 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:10 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:26:10 playerone systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Oct 15 23:26:10 playerone systemd[1]: mpd.service: Succeeded. Oct 15 23:26:10 playerone systemd[1]: Stopped Music Player Daemon. Oct 15 23:26:10 playerone systemd[1]: Starting Music Player Daemon... Oct 15 23:26:10 playerone volumio[4556]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:26:10 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:10 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:26:10 playerone volumio[4556]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:26:10 playerone volumio[4556]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 23:26:10 playerone volumio[4556]: info: [1760563570987] CoreMusicLibrary::Adding element Last_100 Oct 15 23:26:10 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:26:10 playerone volumio[4556]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 23:26:10 playerone volumio[4556]: info: [1760563570991] CoreMusicLibrary::Adding element Webradio Oct 15 23:26:10 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:26:10 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:26:11 playerone volumio[4556]: info: Initializing BBC Radios Oct 15 23:26:11 playerone sudo[4731]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 15 23:26:11 playerone sudo[4731]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:11 playerone sudo[4731]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:11 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:26:11 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:26:11 playerone volumio[4556]: info: Loading i18n strings for locale en Oct 15 23:26:11 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Oct 15 23:26:11 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:11 playerone volumio[4556]: info: FusionDsp - mixtype--------------------- Hardware Oct 15 23:26:11 playerone volumio[4556]: info: Volumio Calling Home Oct 15 23:26:11 playerone volumio[4556]: info: Preparing to generate the ALSA configuration file Oct 15 23:26:11 playerone volumio[4556]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 15 23:26:11 playerone volumio[4556]: info: Reading ALSA contributions from plugins. Oct 15 23:26:11 playerone volumio[4556]: info: MPD Permissions set Oct 15 23:26:11 playerone volumio[4556]: info: MPD Permissions set Oct 15 23:26:11 playerone volumio[4556]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Oct 15 23:26:11 playerone volumio[4556]: info: Volumio called home Oct 15 23:26:11 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:11 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:11 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:11 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:11 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:11 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:11 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:11 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:11 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:26:11 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:11 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:11 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:11 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:11 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:11 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:11 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:11 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:11 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:11 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:26:11 playerone volumio[4556]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:11 playerone volumio[4556]: info: Starting Shairport Sync Oct 15 23:26:11 playerone volumio[4556]: info: Starting Shairport Sync Oct 15 23:26:11 playerone volumio[4556]: info: Starting Shairport Sync Oct 15 23:26:11 playerone sudo[4761]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:26:11 playerone sudo[4761]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:11 playerone sudo[4763]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:26:11 playerone sudo[4763]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:11 playerone systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 15 23:26:11 playerone systemd[1]: shairport-sync.service: Succeeded. Oct 15 23:26:11 playerone systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 15 23:26:11 playerone sudo[4766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:26:11 playerone sudo[4766]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:11 playerone volumio[4556]: info: CoreCommandRouter::volumioGetState Oct 15 23:26:11 playerone volumio[4556]: info: CorePlayQueue::getTrack 0 Oct 15 23:26:11 playerone volumio[4556]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 23:26:11 playerone volumio[4556]: TypeError: Cannot read property 'off' of undefined Oct 15 23:26:11 playerone volumio[4556]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:107:15) Oct 15 23:26:11 playerone volumio[4556]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Oct 15 23:26:11 playerone volumio[4556]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8) Oct 15 23:26:11 playerone volumio[4556]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1556:29) Oct 15 23:26:11 playerone volumio[4556]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1401:47) Oct 15 23:26:11 playerone volumio[4556]: at Socket.emit (events.js:315:20) Oct 15 23:26:11 playerone volumio[4556]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Oct 15 23:26:11 playerone volumio[4556]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Oct 15 23:26:11 playerone volumio[4556]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 23:26:11 playerone systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 15 23:26:11 playerone sudo[4761]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:11 playerone sudo[4763]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:11 playerone sudo[4766]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:12 playerone sudo[4781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-15 23:25 Oct 15 23:26:12 playerone sudo[4781]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:12 playerone sudo[4781]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:12 playerone mpd[4744]: Oct 15 23:26 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 15 23:26:12 playerone systemd[1]: Started Music Player Daemon. Oct 15 23:26:12 playerone sudo[4718]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:12 playerone sudo[4727]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:13 playerone volumio-remote-updater[587]: [2025-10-15 23:26:13] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Oct 15 23:26:13 playerone volumio-remote-updater[587]: [2025-10-15 23:26:13] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Oct 15 23:26:13 playerone systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 15 23:26:13 playerone systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 15 23:26:13 playerone systemd[1]: Started dynamicswap service. Oct 15 23:26:13 playerone systemd[1]: dynamicswap.service: Succeeded. Oct 15 23:26:13 playerone systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Oct 15 23:26:13 playerone systemd[1]: volumio.service: Scheduled restart job, restart counter is at 16. Oct 15 23:26:13 playerone systemd[1]: Started dynamicswap service. Oct 15 23:26:13 playerone systemd[1]: Stopped Volumio Backend Module. Oct 15 23:26:13 playerone systemd[1]: Started Volumio Backend Module. Oct 15 23:26:13 playerone systemd[1]: dynamicswap.service: Succeeded. Oct 15 23:26:15 playerone volumio[4797]: info: ------------------------------------------- Oct 15 23:26:15 playerone volumio[4797]: info: ----- Volumio3 ---- Oct 15 23:26:15 playerone volumio[4797]: info: ------------------------------------------- Oct 15 23:26:15 playerone volumio[4797]: info: ----- System startup ---- Oct 15 23:26:15 playerone volumio[4797]: info: ------------------------------------------- Oct 15 23:26:15 playerone volumio[4797]: info: MYVOLUMIO Environment detected Oct 15 23:26:16 playerone volumio[4797]: info: Plugin folders cleanup Oct 15 23:26:16 playerone volumio[4797]: info: Scanning into folder /volumio/app/plugins/ Oct 15 23:26:16 playerone volumio[4797]: info: Scanning category audio_interface Oct 15 23:26:16 playerone volumio[4797]: info: Scanning category miscellanea Oct 15 23:26:16 playerone volumio[4797]: info: Scanning category music_service Oct 15 23:26:16 playerone volumio[4797]: info: Scanning category plugins.json Oct 15 23:26:16 playerone volumio[4797]: info: Scanning category system_controller Oct 15 23:26:16 playerone volumio[4797]: info: Scanning category user_interface Oct 15 23:26:16 playerone volumio[4797]: info: Scanning into folder /data/plugins/ Oct 15 23:26:16 playerone volumio[4797]: info: Scanning category audio_interface Oct 15 23:26:16 playerone volumio[4797]: info: Plugin folders cleanup completed Oct 15 23:26:16 playerone volumio[4797]: info: ------------------------------------------- Oct 15 23:26:16 playerone volumio[4797]: info: ----- Core plugins startup ---- Oct 15 23:26:16 playerone volumio[4797]: info: ------------------------------------------- Oct 15 23:26:16 playerone volumio[4797]: info: Loading plugins from folder /volumio/app/plugins/ Oct 15 23:26:16 playerone volumio[4797]: info: Adding plugin upnp to MyMusic Plugins Oct 15 23:26:16 playerone volumio[4797]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 15 23:26:16 playerone volumio[4797]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 15 23:26:16 playerone volumio[4797]: info: Loading plugins from folder /data/plugins/ Oct 15 23:26:16 playerone volumio[4797]: info: Loading plugin "system"... Oct 15 23:26:16 playerone volumio[4797]: info: Loading plugin "appearance"... Oct 15 23:26:17 playerone volumio[4797]: info: Loading plugin "network"... Oct 15 23:26:17 playerone volumio[4797]: info: Refreshing Cached IP Addresses Oct 15 23:26:17 playerone sudo[4824]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 15 23:26:17 playerone sudo[4824]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:17 playerone sudo[4826]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 15 23:26:17 playerone sudo[4826]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:17 playerone sudo[4824]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:17 playerone sudo[4826]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:17 playerone volumio[4797]: info: Loading plugin "services"... Oct 15 23:26:17 playerone volumio[4797]: info: Loading plugin "alsa_controller"... Oct 15 23:26:17 playerone sudo[4837]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 15 23:26:17 playerone sudo[4837]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:17 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:26:17 playerone volumio[4797]: info: Loading plugin "wizard"... Oct 15 23:26:17 playerone volumio[4797]: info: Loading plugin "networkfs"... Oct 15 23:26:17 playerone volumio[4797]: info: Starting Udev Watcher for removable devices Oct 15 23:26:17 playerone volumio[4797]: info: Ignoring mount for partition: boot Oct 15 23:26:17 playerone volumio[4797]: info: Ignoring mount for partition: volumio Oct 15 23:26:17 playerone volumio[4797]: info: Ignoring mount for partition: volumio_data Oct 15 23:26:17 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 23:26:17 playerone volumio[4797]: info: Loading plugin "volumio_command_line_client"... Oct 15 23:26:17 playerone volumio[4797]: info: Loading plugin "upnp"... Oct 15 23:26:17 playerone volumio[4797]: info: [1760563577420] Starting Upmpd Daemon Oct 15 23:26:17 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 23:26:17 playerone volumio[4797]: info: Loading plugin "my_music"... Oct 15 23:26:17 playerone volumio[4797]: info: Loading plugin "mpd"... Oct 15 23:26:17 playerone volumio[4797]: info: Loading plugin "upnp_browser"... Oct 15 23:26:18 playerone volumio-remote-updater[587]: [2025-10-15 23:26:18] [connect] Successful connection Oct 15 23:26:18 playerone volumio[4797]: info: Loading plugin "alarm-clock"... Oct 15 23:26:18 playerone sudo[4837]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:18 playerone volumio[4797]: info: Loading plugin "airplay_emulation"... Oct 15 23:26:18 playerone volumio[4797]: info: Starting Shairport Sync Oct 15 23:26:18 playerone volumio[4797]: info: Loading plugin "last_100"... Oct 15 23:26:18 playerone volumio[4797]: info: Loading plugin "webradio"... Oct 15 23:26:18 playerone volumio[4797]: info: Loading plugin "i2s_dacs"... Oct 15 23:26:18 playerone volumio[4797]: info: I2S DAC not set, start Auto-detection Oct 15 23:26:18 playerone volumio[4797]: info: Loading plugin "volumiodiscovery"... Oct 15 23:26:18 playerone volumio[4797]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 15 23:26:18 playerone volumio[4797]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:26:18 playerone volumio[4797]: *** WARNING *** For more information see Oct 15 23:26:18 playerone node[4797]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 15 23:26:18 playerone volumio[4797]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 15 23:26:18 playerone volumio[4797]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:26:18 playerone volumio[4797]: *** WARNING *** For more information see Oct 15 23:26:18 playerone node[4797]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:26:18 playerone node[4797]: *** WARNING *** For more information see Oct 15 23:26:18 playerone node[4797]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 15 23:26:18 playerone node[4797]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 15 23:26:18 playerone node[4797]: *** WARNING *** For more information see Oct 15 23:26:18 playerone volumio[4797]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 15 23:26:18 playerone volumio[4797]: info: Discovery: Started advertising with name: playerONE Oct 15 23:26:18 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 15 23:26:18 playerone volumio[4797]: info: Loading plugin "outputs"... Oct 15 23:26:18 playerone volumio[4797]: info: Loading plugin "albumart"... Oct 15 23:26:18 playerone volumio[4797]: info: Plugin example_plugin is not enabled Oct 15 23:26:18 playerone volumio[4797]: info: Loading plugin "inputs"... Oct 15 23:26:18 playerone volumio[4797]: info: Loading plugin "updater_comm"... Oct 15 23:26:18 playerone volumio[4797]: info: Plugin mpdemulation is not enabled Oct 15 23:26:18 playerone volumio[4797]: info: Loading plugin "rest_api"... Oct 15 23:26:18 playerone volumio[4797]: info: Loading plugin "websocket"... Oct 15 23:26:18 playerone volumio[4797]: info: Starting Socket.io Server version 2.3.0 Oct 15 23:26:18 playerone volumio[4797]: info: Loading plugin "fusiondsp"... Oct 15 23:26:18 playerone volumio[4797]: Forking 3 albumart workers Oct 15 23:26:19 playerone volumio[4797]: info: Applying required configuration parameters for plugin fusiondsp Oct 15 23:26:19 playerone volumio[4797]: info: Loading i18n strings for locale en Oct 15 23:26:19 playerone volumio[4797]: Updating browse sources language Oct 15 23:26:19 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:26:19 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:26:19 playerone volumio[4797]: info: CoreCommandRouter::initPlayerControls Oct 15 23:26:19 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:19 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:19 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:19 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:19 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:19 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:19 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:19 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:19 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:26:19 playerone volumio[4797]: Express server listening on port 3000 Oct 15 23:26:19 playerone volumio[4797]: [Metrics] WebUI: 5s 143.93ms Oct 15 23:26:19 playerone volumio[4797]: info: CoreStateMachine::resetVolumioState Oct 15 23:26:19 playerone volumio[4797]: info: CoreStateMachine::getcurrentVolume Oct 15 23:26:19 playerone volumio[4797]: info: CoreCommandRouter::volumioRetrievevolume Oct 15 23:26:19 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:26:19 playerone volumio[4797]: info: Volumio Network Manager: Network status updated: 1 Oct 15 23:26:20 playerone volumio[4797]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Oct 15 23:26:20 playerone volumio[4797]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Oct 15 23:26:20 playerone volumio[4797]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Oct 15 23:26:20 playerone volumio[4797]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Oct 15 23:26:20 playerone volumio[4797]: Starting albumart workers Oct 15 23:26:20 playerone volumio-remote-updater[587]: [2025-10-15 23:26:20] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1760563578 101 Oct 15 23:26:20 playerone volumio[4797]: 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 Oct 15 23:26:20 playerone volumio[4797]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Oct 15 23:26:20 playerone volumio[4797]: Starting albumart workers Oct 15 23:26:20 playerone volumio[4797]: Starting albumart workers Oct 15 23:26:20 playerone volumio[4797]: verbose: New Socket.io Connection to 192.168.1.159 from 192.168.1.144 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) SamsungBrowser/28.0 Chrome/130.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 15 23:26:20 playerone volumio[4797]: info: Reloading queue from file Oct 15 23:26:20 playerone volumio[4797]: info: CoreStateMachine::setRepeat null single undefined Oct 15 23:26:20 playerone volumio[4797]: info: CoreStateMachine::pushState Oct 15 23:26:20 playerone volumio[4797]: info: CorePlayQueue::getTrack 0 Oct 15 23:26:20 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 23:26:20 playerone volumio[4797]: info: CoreCommandRouter::volumioPushState Oct 15 23:26:20 playerone volumio[4797]: info: CoreStateMachine::setRandom null Oct 15 23:26:20 playerone volumio[4797]: info: CoreStateMachine::pushState Oct 15 23:26:20 playerone volumio[4797]: info: CorePlayQueue::getTrack 0 Oct 15 23:26:20 playerone volumio[4797]: info: CoreCommandRouter::volumioPushState Oct 15 23:26:20 playerone volumio[4797]: info: Setting Device type: Raspberry PI Oct 15 23:26:20 playerone volumio[4797]: info: CoreCommandRouter::volumioGetState Oct 15 23:26:20 playerone volumio[4797]: info: CorePlayQueue::getTrack 0 Oct 15 23:26:20 playerone volumio[4797]: info: VolumeController:: Volume=20 Mute =false Oct 15 23:26:20 playerone volumio[4797]: info: CoreStateMachine::pushState Oct 15 23:26:20 playerone volumio[4797]: info: CorePlayQueue::getTrack 0 Oct 15 23:26:20 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 15 23:26:20 playerone volumio[4797]: info: CoreCommandRouter::volumioPushState Oct 15 23:26:20 playerone volumio[4797]: info: CoreStateMachine::updateTrackBlock Oct 15 23:26:20 playerone volumio[4797]: info: CorePlayQueue::getTrackBlock Oct 15 23:26:20 playerone volumio[4797]: info: CoreCommandRouter::volumioRetrievevolume Oct 15 23:26:20 playerone volumio[4797]: info: CoreCommandRouter::volumioGetQueue Oct 15 23:26:20 playerone volumio[4797]: info: CoreStateMachine::getQueue Oct 15 23:26:20 playerone volumio[4797]: info: CorePlayQueue::getQueue Oct 15 23:26:20 playerone volumio[4797]: info: CoreCommandRouter::volumioGetVisibleSources Oct 15 23:26:20 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:26:20 playerone volumio[4797]: info: Listing playlists Oct 15 23:26:20 playerone volumio[4797]: info: Discovery: adding 76640995-2991-45ef-aafc-08dc8d3a1ee7 Oct 15 23:26:20 playerone volumio[4797]: info: Discovery: Found device playerONE Oct 15 23:26:20 playerone volumio[4797]: info: CoreCommandRouter::volumioGetState Oct 15 23:26:20 playerone volumio[4797]: info: CorePlayQueue::getTrack 0 Oct 15 23:26:20 playerone volumio[4797]: info: Discovery: this is already registered, 76640995-2991-45ef-aafc-08dc8d3a1ee7 Oct 15 23:26:20 playerone volumio[4797]: info: Discovery: Found device playerONE Oct 15 23:26:20 playerone volumio[4797]: info: CoreCommandRouter::volumioGetState Oct 15 23:26:20 playerone volumio[4797]: info: CorePlayQueue::getTrack 0 Oct 15 23:26:20 playerone volumio[4797]: info: Completed loading Core Plugins Oct 15 23:26:20 playerone volumio[4797]: info: Preparing to generate the ALSA configuration file Oct 15 23:26:20 playerone volumio[4797]: info: VolumeController:: Volume=20 Mute =false Oct 15 23:26:20 playerone volumio[4797]: info: CoreStateMachine::pushState Oct 15 23:26:20 playerone volumio[4797]: info: CorePlayQueue::getTrack 0 Oct 15 23:26:20 playerone volumio[4797]: info: CoreCommandRouter::volumioPushState Oct 15 23:26:20 playerone volumio[4797]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 15 23:26:20 playerone volumio[4797]: info: Reading ALSA contributions from plugins. Oct 15 23:26:20 playerone volumio[4797]: info: Asound.conf file unchanged, so no further update is needed Oct 15 23:26:20 playerone volumio[4797]: info: Output device has changed, restarting MPD Oct 15 23:26:20 playerone sudo[4919]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 23:26:20 playerone sudo[4919]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:20 playerone volumio[4797]: info: Output device has changed, restarting Shairport Sync Oct 15 23:26:21 playerone sudo[4919]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:26:21 playerone sudo[4922]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 23:26:21 playerone sudo[4922]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:21 playerone systemd[1]: Stopping Music Player Daemon... Oct 15 23:26:21 playerone volumio[4797]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:26:21 playerone volumio[4797]: info: ___________ START PLUGINS ___________ Oct 15 23:26:21 playerone systemd[1]: mpd.service: Succeeded. Oct 15 23:26:21 playerone systemd[1]: Stopped Music Player Daemon. Oct 15 23:26:21 playerone volumio[4797]: info: ControllerMpd::onStart: Initializing MPD Oct 15 23:26:21 playerone volumio[4797]: info: Creating MPD Configuration file Oct 15 23:26:21 playerone systemd[1]: Starting Music Player Daemon... Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 15 23:26:21 playerone sudo[4929]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 23:26:21 playerone volumio[4797]: info: [1760563581127] CoreMusicLibrary::Adding element Media Servers Oct 15 23:26:21 playerone sudo[4929]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:26:21 playerone sudo[4929]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:21 playerone sudo[4931]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 23:26:21 playerone sudo[4931]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:26:21 playerone systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Oct 15 23:26:21 playerone systemd[1]: mpd.service: Succeeded. Oct 15 23:26:21 playerone systemd[1]: Stopped Music Player Daemon. Oct 15 23:26:21 playerone systemd[1]: Starting Music Player Daemon... Oct 15 23:26:21 playerone volumio[4797]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:26:21 playerone volumio[4797]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 23:26:21 playerone volumio[4797]: info: [1760563581275] CoreMusicLibrary::Adding element Last_100 Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 15 23:26:21 playerone volumio[4797]: info: [1760563581280] CoreMusicLibrary::Adding element Webradio Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:26:21 playerone volumio[4797]: info: Initializing BBC Radios Oct 15 23:26:21 playerone sudo[4935]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 15 23:26:21 playerone sudo[4935]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:21 playerone sudo[4935]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:26:21 playerone volumio[4797]: info: Loading i18n strings for locale en Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:21 playerone volumio[4797]: info: FusionDsp - mixtype--------------------- Hardware Oct 15 23:26:21 playerone volumio[4797]: info: Volumio Calling Home Oct 15 23:26:21 playerone volumio[4797]: info: Preparing to generate the ALSA configuration file Oct 15 23:26:21 playerone volumio[4797]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 15 23:26:21 playerone volumio[4797]: info: Reading ALSA contributions from plugins. Oct 15 23:26:21 playerone volumio[4797]: info: MPD Permissions set Oct 15 23:26:21 playerone volumio[4797]: info: MPD Permissions set Oct 15 23:26:21 playerone volumio[4797]: info: Volumio called home Oct 15 23:26:21 playerone volumio[4797]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:21 playerone volumio[4797]: info: Starting Shairport Sync Oct 15 23:26:21 playerone volumio[4797]: info: Starting Shairport Sync Oct 15 23:26:21 playerone volumio[4797]: info: Starting Shairport Sync Oct 15 23:26:21 playerone sudo[4965]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:26:21 playerone sudo[4965]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:21 playerone sudo[4967]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:26:21 playerone sudo[4967]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:21 playerone sudo[4970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:26:21 playerone sudo[4970]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:21 playerone systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 15 23:26:21 playerone systemd[1]: shairport-sync.service: Succeeded. Oct 15 23:26:21 playerone systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 15 23:26:21 playerone volumio[4797]: info: CoreCommandRouter::volumioGetState Oct 15 23:26:21 playerone volumio[4797]: info: CorePlayQueue::getTrack 0 Oct 15 23:26:22 playerone volumio[4797]: info: Asound.conf file unchanged, so no further update is needed Oct 15 23:26:22 playerone volumio[4797]: info: Output device has changed, restarting MPD Oct 15 23:26:22 playerone volumio[4797]: info: Output device has changed, restarting Shairport Sync Oct 15 23:26:22 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:22 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:26:22 playerone sudo[4975]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 15 23:26:22 playerone systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 15 23:26:22 playerone sudo[4975]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:22 playerone sudo[4975]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:22 playerone sudo[4965]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:22 playerone sudo[4977]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 15 23:26:22 playerone sudo[4977]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:22 playerone sudo[4967]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:22 playerone systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 15 23:26:22 playerone systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Oct 15 23:26:22 playerone systemd[1]: shairport-sync.service: Succeeded. Oct 15 23:26:22 playerone systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 15 23:26:22 playerone volumio[4797]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 15 23:26:22 playerone systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 15 23:26:22 playerone sudo[4970]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:22 playerone systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 15 23:26:22 playerone systemd[1]: mpd.service: Succeeded. Oct 15 23:26:22 playerone systemd[1]: Stopped Music Player Daemon. Oct 15 23:26:22 playerone systemd[1]: Starting Music Player Daemon... Oct 15 23:26:22 playerone volumio[4797]: info: MPD Permissions set Oct 15 23:26:22 playerone volumio[4797]: info: Shairport-Sync Started Oct 15 23:26:22 playerone volumio[4797]: Error adding Membership: Error: addMembership EINVAL Oct 15 23:26:22 playerone volumio[4797]: info: Shairport-Sync Started Oct 15 23:26:22 playerone volumio[4797]: info: Shairport-Sync Started Oct 15 23:26:22 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:22 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:22 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:22 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:22 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 15 23:26:22 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:22 playerone volumio[4797]: info: Starting Shairport Sync Oct 15 23:26:22 playerone sudo[4993]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 15 23:26:22 playerone sudo[4993]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:22 playerone sudo[4984]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 15 23:26:22 playerone sudo[4984]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:22 playerone sudo[4984]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:22 playerone systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 15 23:26:22 playerone systemd[1]: shairport-sync.service: Succeeded. Oct 15 23:26:22 playerone systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 15 23:26:22 playerone systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 15 23:26:22 playerone sudo[4993]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:22 playerone volumio[4797]: info: Shairport-Sync Started Oct 15 23:26:23 playerone volumio[4797]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Oct 15 23:26:23 playerone volumio[4797]: 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 Oct 15 23:26:23 playerone volumio[4797]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Oct 15 23:26:23 playerone volumio[4797]: info: camilladsp service started and running in background, instance 1 Oct 15 23:26:23 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 15 23:26:23 playerone volumio[4797]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Oct 15 23:26:23 playerone volumio[4797]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Oct 15 23:26:23 playerone volumio[4797]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Oct 15 23:26:23 playerone volumio[4797]: info: FusionDsp loaded Oct 15 23:26:23 playerone volumio[4797]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 15 23:26:23 playerone sudo[5012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Oct 15 23:26:23 playerone sudo[5012]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 15 23:26:23 playerone volumio[4797]: info: FusionDsp - Reporting Fusion DSP Enabled Oct 15 23:26:23 playerone volumio[4797]: info: Adding Signal Path Element [object Object] Oct 15 23:26:23 playerone volumio[4797]: info: Adding fusiondspeq DSP Signal Path Element Oct 15 23:26:23 playerone sudo[5012]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:23 playerone volumio[4797]: info: FusionDsp - ---- installed callbackRead Oct 15 23:26:23 playerone volumio[4797]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 23:26:23 playerone volumio[4797]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Oct 15 23:26:23 playerone volumio[4797]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Oct 15 23:26:23 playerone volumio[4797]: at onErrorNT (internal/child_process.js:465:16) Oct 15 23:26:23 playerone volumio[4797]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Oct 15 23:26:23 playerone volumio[4797]: errno: -2, Oct 15 23:26:23 playerone volumio[4797]: code: 'ENOENT', Oct 15 23:26:23 playerone volumio[4797]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Oct 15 23:26:23 playerone volumio[4797]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Oct 15 23:26:23 playerone volumio[4797]: spawnargs: [ Oct 15 23:26:23 playerone volumio[4797]: '-p', Oct 15 23:26:23 playerone volumio[4797]: 9876, Oct 15 23:26:23 playerone volumio[4797]: '-o', Oct 15 23:26:23 playerone volumio[4797]: '/tmp/camilladsp.log', Oct 15 23:26:23 playerone volumio[4797]: '-l', Oct 15 23:26:23 playerone volumio[4797]: 'warn', Oct 15 23:26:23 playerone volumio[4797]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Oct 15 23:26:23 playerone volumio[4797]: ] Oct 15 23:26:23 playerone volumio[4797]: } Oct 15 23:26:23 playerone volumio[4797]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 23:26:23 playerone mpd[4996]: Oct 15 23:26 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 15 23:26:23 playerone systemd[1]: Started Music Player Daemon. Oct 15 23:26:23 playerone sudo[4977]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:23 playerone sudo[4922]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:23 playerone sudo[4931]: pam_unix(sudo:session): session closed for user root Oct 15 23:26:24 playerone sudo[5026]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-15 23:25 Oct 15 23:26:24 playerone sudo[5026]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"