-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sat 2025-11-01 20:44:26 CET. --
Nov 01 20:44:12 volumio systemd-timedated[1005]: Changed local time to Sat Nov 1 20:44:12 2025
Nov 01 20:44:12 volumio sudo[1003]: pam_unix(sudo:session): session closed for user root
Nov 01 20:44:12 volumio volumio-time-update[584]: volumio-time-update-util: System time updated successfully.
Nov 01 20:44:12 volumio systemd[1]: Started Volumio Time Update Utility.
Nov 01 20:44:12 volumio nmbd[672]: [2025/11/01 20:44:12.199769, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Nov 01 20:44:12 volumio nmbd[672]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections
Nov 01 20:44:12 volumio systemd[1]: Started Samba NMB Daemon.
Nov 01 20:44:12 volumio nmbd[672]: [2025/11/01 20:44:12.232041, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Nov 01 20:44:12 volumio nmbd[672]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.51.166 for name WORKGROUP<1d>.
Nov 01 20:44:12 volumio nmbd[672]: This response was from IP 192.168.51.147, reporting an IP address of 192.168.51.147.
Nov 01 20:44:12 volumio systemd[1]: Starting Samba Winbind Daemon...
Nov 01 20:44:12 volumio volumio[973]: info: MYVOLUMIO Environment detected
Nov 01 20:44:12 volumio systemd[1]: systemd-fsckd.service: Succeeded.
Nov 01 20:44:12 volumio volumio[973]: info: Plugin folders cleanup
Nov 01 20:44:12 volumio volumio[973]: info: Scanning into folder /volumio/app/plugins/
Nov 01 20:44:12 volumio volumio[973]: info: Scanning category audio_interface
Nov 01 20:44:12 volumio volumio[973]: info: Scanning category miscellanea
Nov 01 20:44:12 volumio volumio[973]: info: Scanning category music_service
Nov 01 20:44:12 volumio volumio[973]: info: Scanning category plugins.json
Nov 01 20:44:12 volumio volumio[973]: info: Scanning category system_controller
Nov 01 20:44:12 volumio volumio[973]: info: Scanning category user_interface
Nov 01 20:44:12 volumio volumio[973]: info: Scanning into folder /data/plugins/
Nov 01 20:44:12 volumio volumio[973]: info: Scanning category audio_interface
Nov 01 20:44:12 volumio volumio[973]: info: Scanning category music_service
Nov 01 20:44:12 volumio volumio[973]: info: Scanning category system_controller
Nov 01 20:44:12 volumio volumio[973]: info: Scanning category system_hardware
Nov 01 20:44:12 volumio volumio[973]: info: Scanning category user_interface
Nov 01 20:44:12 volumio volumio[973]: info: Plugin folders cleanup completed
Nov 01 20:44:12 volumio volumio[973]: info: -------------------------------------------
Nov 01 20:44:12 volumio volumio[973]: info: ----- Core plugins startup ----
Nov 01 20:44:12 volumio volumio[973]: info: -------------------------------------------
Nov 01 20:44:12 volumio volumio[973]: info: Loading plugins from folder /volumio/app/plugins/
Nov 01 20:44:12 volumio volumio[973]: info: Adding plugin upnp to MyMusic Plugins
Nov 01 20:44:12 volumio volumio[973]: info: Adding plugin airplay_emulation to MyMusic Plugins
Nov 01 20:44:12 volumio volumio[973]: info: Adding plugin upnp_browser to MyMusic Plugins
Nov 01 20:44:12 volumio volumio[973]: info: Loading plugins from folder /data/plugins/
Nov 01 20:44:12 volumio volumio[973]: info: Loading plugin "system"...
Nov 01 20:44:12 volumio winbindd[1007]: [2025/11/01 20:44:12.653339, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache)
Nov 01 20:44:12 volumio winbindd[1007]: initialize_winbindd_cache: clearing cache and re-creating with version number 2
Nov 01 20:44:12 volumio volumio[973]: info: Loading plugin "ampswitch"...
Nov 01 20:44:13 volumio winbindd[1007]: [2025/11/01 20:44:13.386582, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Nov 01 20:44:13 volumio systemd[1]: Started Samba Winbind Daemon.
Nov 01 20:44:13 volumio winbindd[1007]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections
Nov 01 20:44:13 volumio systemd[1]: Starting Samba SMB Daemon...
Nov 01 20:44:14 volumio volumio[973]: info: Applying required configuration parameters for plugin ampswitch
Nov 01 20:44:14 volumio sh[476]: timed out
Nov 01 20:44:14 volumio dhcpcd[514]: timed out
Nov 01 20:44:14 volumio sh[476]: dhcpcd exited
Nov 01 20:44:14 volumio dhcpcd[514]: dhcpcd exited
Nov 01 20:44:14 volumio sh[476]: ifup: failed to bring up eth0
Nov 01 20:44:14 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE
Nov 01 20:44:14 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'.
Nov 01 20:44:15 volumio smbd[1017]: [2025/11/01 20:44:15.109971, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Nov 01 20:44:15 volumio systemd[1]: Started Samba SMB Daemon.
Nov 01 20:44:15 volumio smbd[1017]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections
Nov 01 20:44:15 volumio systemd[1]: Reached target Multi-User System.
Nov 01 20:44:15 volumio systemd[1]: Reached target Graphical Interface.
Nov 01 20:44:15 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes...
Nov 01 20:44:15 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Nov 01 20:44:15 volumio systemd[1]: Started Update UTMP about System Runlevel Changes.
Nov 01 20:44:15 volumio systemd[1]: Startup finished in 18.401s (kernel) + 36.193s (userspace) = 54.594s.
Nov 01 20:44:15 volumio volumio[973]: info: Loading plugin "appearance"...
Nov 01 20:44:16 volumio volumio[973]: info: Loading plugin "network"...
Nov 01 20:44:16 volumio volumio[973]: info: Refreshing Cached IP Addresses
Nov 01 20:44:16 volumio sudo[1029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Nov 01 20:44:16 volumio sudo[1029]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 01 20:44:16 volumio sudo[1029]: pam_unix(sudo:session): session closed for user root
Nov 01 20:44:16 volumio sudo[1031]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Nov 01 20:44:16 volumio sudo[1031]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 01 20:44:16 volumio sudo[1031]: pam_unix(sudo:session): session closed for user root
Nov 01 20:44:16 volumio volumio[973]: info: Loading plugin "services"...
Nov 01 20:44:16 volumio volumio[973]: info: Loading plugin "alsa_controller"...
Nov 01 20:44:16 volumio sudo[1044]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Nov 01 20:44:16 volumio sudo[1044]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 01 20:44:16 volumio volumio[973]: warn: The ALSA output card is not set, defaulting to card [object Object]
Nov 01 20:44:16 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Nov 01 20:44:16 volumio volumio[973]: info: Found match in Cards Database: setting mixer PCM for card HDMI Out
Nov 01 20:44:16 volumio volumio[973]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Nov 01 20:44:16 volumio volumio[973]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Nov 01 20:44:16 volumio volumio[973]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Nov 01 20:44:16 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Nov 01 20:44:16 volumio volumio[973]: info: Loading plugin "wizard"...
Nov 01 20:44:16 volumio volumio[973]: info: Loading plugin "networkfs"...
Nov 01 20:44:17 volumio volumio[973]: info: Starting Udev Watcher for removable devices
Nov 01 20:44:17 volumio volumio[973]: info: Ignoring mount for partition: boot
Nov 01 20:44:17 volumio volumio[973]: info: Ignoring mount for partition: volumio
Nov 01 20:44:17 volumio volumio[973]: info: Ignoring mount for partition: volumio_data
Nov 01 20:44:17 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Nov 01 20:44:17 volumio volumio[973]: info: Loading plugin "volumio_command_line_client"...
Nov 01 20:44:17 volumio volumio[973]: info: Loading plugin "upnp"...
Nov 01 20:44:17 volumio volumio[973]: info: [1762026257083] Starting Upmpd Daemon
Nov 01 20:44:17 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Nov 01 20:44:17 volumio volumio[973]: info: Loading plugin "my_music"...
Nov 01 20:44:17 volumio volumio[973]: info: Loading plugin "mpd"...
Nov 01 20:44:17 volumio volumio[973]: info: Loading plugin "upnp_browser"...
Nov 01 20:44:17 volumio volumio-remote-updater[554]: [2025-11-01 20:44:17] [connect] Successful connection
Nov 01 20:44:17 volumio volumio[973]: info: Loading plugin "alarm-clock"...
Nov 01 20:44:18 volumio volumio[973]: info: Loading plugin "airplay_emulation"...
Nov 01 20:44:18 volumio volumio[973]: info: Starting Shairport Sync
Nov 01 20:44:18 volumio volumio[973]: info: Loading plugin "last_100"...
Nov 01 20:44:18 volumio volumio[973]: info: Loading plugin "webradio"...
Nov 01 20:44:18 volumio volumio[973]: info: Loading plugin "i2s_dacs"...
Nov 01 20:44:18 volumio volumio[973]: info: I2S DAC not set, start Auto-detection
Nov 01 20:44:18 volumio volumio[973]: info: Loading plugin "volumiodiscovery"...
Nov 01 20:44:18 volumio volumio[973]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Nov 01 20:44:18 volumio volumio[973]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 01 20:44:18 volumio volumio[973]: *** WARNING *** For more information see
Nov 01 20:44:18 volumio node[973]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Nov 01 20:44:18 volumio volumio[973]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Nov 01 20:44:18 volumio volumio[973]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 01 20:44:18 volumio volumio[973]: *** WARNING *** For more information see
Nov 01 20:44:18 volumio node[973]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 01 20:44:18 volumio node[973]: *** WARNING *** For more information see
Nov 01 20:44:18 volumio node[973]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Nov 01 20:44:18 volumio node[973]: *** WARNING *** Please fix your application to use the native API of Avahi!
Nov 01 20:44:18 volumio node[973]: *** WARNING *** For more information see
Nov 01 20:44:18 volumio volumio[973]: info: Applying required configuration parameters for plugin volumiodiscovery
Nov 01 20:44:18 volumio volumio[973]: info: Discovery: Started advertising with name: Volumio
Nov 01 20:44:18 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Nov 01 20:44:18 volumio volumio[973]: info: Loading plugin "soundcloud"...
Nov 01 20:44:19 volumio volumio[973]: info: Plugin youtube2 is not enabled
Nov 01 20:44:19 volumio volumio[973]: info: Plugin ytcr is not enabled
Nov 01 20:44:19 volumio volumio[973]: info: Loading plugin "outputs"...
Nov 01 20:44:19 volumio volumio[973]: info: Loading plugin "albumart"...
Nov 01 20:44:19 volumio volumio[973]: info: Plugin example_plugin is not enabled
Nov 01 20:44:19 volumio volumio[973]: info: Loading plugin "inputs"...
Nov 01 20:44:19 volumio volumio[973]: info: Loading plugin "updater_comm"...
Nov 01 20:44:19 volumio sudo[1044]: pam_unix(sudo:session): session closed for user root
Nov 01 20:44:19 volumio volumio[973]: info: Plugin mpdemulation is not enabled
Nov 01 20:44:19 volumio volumio[973]: info: Loading plugin "rest_api"...
Nov 01 20:44:19 volumio volumio[973]: info: Loading plugin "websocket"...
Nov 01 20:44:19 volumio volumio[973]: info: Starting Socket.io Server version 2.3.0
Nov 01 20:44:19 volumio volumio[973]: info: Loading plugin "fusiondsp"...
Nov 01 20:44:19 volumio volumio[973]: Forking 3 albumart workers
Nov 01 20:44:20 volumio volumio[973]: info: Applying required configuration parameters for plugin fusiondsp
Nov 01 20:44:20 volumio volumio[973]: info: Loading plugin "music_services_shield"...
Nov 01 20:44:20 volumio volumio[973]: Starting albumart workers
Nov 01 20:44:20 volumio volumio[973]: Starting albumart workers
Nov 01 20:44:20 volumio volumio[973]: Starting albumart workers
Nov 01 20:44:21 volumio volumio[973]: info: Loading plugin "Systeminfo"...
Nov 01 20:44:21 volumio volumio[973]: info: Loading i18n strings for locale pl
Nov 01 20:44:22 volumio volumio[973]: Updating browse sources language
Nov 01 20:44:22 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 01 20:44:22 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 01 20:44:22 volumio volumio[973]: info: CoreCommandRouter::initPlayerControls
Nov 01 20:44:22 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:22 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:22 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:22 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:22 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:22 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:22 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:22 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:22 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 01 20:44:22 volumio volumio[973]: Express server listening on port 3000
Nov 01 20:44:22 volumio volumio[973]: [Metrics] WebUI: 11s 991.73ms
Nov 01 20:44:22 volumio volumio[973]: info: CoreStateMachine::resetVolumioState
Nov 01 20:44:22 volumio volumio[973]: info: CoreStateMachine::getcurrentVolume
Nov 01 20:44:22 volumio volumio[973]: info: CoreCommandRouter::volumioRetrievevolume
Nov 01 20:44:22 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 01 20:44:22 volumio volumio[973]: info: CoreCommandRouter::volumioRetrieveVolumeLevels
Nov 01 20:44:22 volumio volumio[973]: info: CoreStateMachine::getcurrentVolume
Nov 01 20:44:22 volumio volumio[973]: info: CoreCommandRouter::volumioRetrievevolume
Nov 01 20:44:22 volumio volumio[973]: info: Volumio Network Manager: Network status updated: 2
Nov 01 20:44:22 volumio volumio-remote-updater[554]: [2025-11-01 20:44:22] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1762026257 101
Nov 01 20:44:22 volumio volumio[973]: 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
Nov 01 20:44:22 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Nov 01 20:44:22 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Nov 01 20:44:22 volumio volumio[973]: info: Discovery: Getting this device information
Nov 01 20:44:22 volumio volumio[973]: info: CoreCommandRouter::volumioGetState
Nov 01 20:44:22 volumio volumio[973]: info: CorePlayQueue::getTrack 0
Nov 01 20:44:22 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Nov 01 20:44:22 volumio volumio[973]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2
Nov 01 20:44:22 volumio volumio[973]: info: VolumeController:: Volume=86 Mute =false
Nov 01 20:44:22 volumio volumio[973]: info: CoreStateMachine::pushState
Nov 01 20:44:22 volumio volumio[973]: info: CorePlayQueue::getTrack 0
Nov 01 20:44:22 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 01 20:44:22 volumio volumio[973]: info: CoreCommandRouter::volumioPushState
Nov 01 20:44:22 volumio volumio[973]: info: CoreStateMachine::updateTrackBlock
Nov 01 20:44:22 volumio volumio[973]: info: CorePlayQueue::getTrackBlock
Nov 01 20:44:22 volumio volumio[973]: info: CoreCommandRouter::volumioRetrievevolume
Nov 01 20:44:22 volumio volumio[973]: info: VolumeController:: Volume=86 Mute =false
Nov 01 20:44:22 volumio volumio[973]: info: CoreStateMachine::pushState
Nov 01 20:44:22 volumio volumio[973]: info: CorePlayQueue::getTrack 0
Nov 01 20:44:22 volumio volumio[973]: info: CoreCommandRouter::volumioPushState
Nov 01 20:44:22 volumio volumio[973]: info: CoreStateMachine::updateTrackBlock
Nov 01 20:44:22 volumio volumio[973]: info: CorePlayQueue::getTrackBlock
Nov 01 20:44:22 volumio volumio[973]: info: CoreCommandRouter::volumioRetrievevolume
Nov 01 20:44:22 volumio volumio[973]: info: Setting Device type: Raspberry PI
Nov 01 20:44:23 volumio volumio[973]: verbose: New Socket.io Connection to 192.168.51.166:3000 from 192.168.51.237 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 3
Nov 01 20:44:23 volumio volumio[973]: info: CoreStateMachine::setRepeat true single undefined
Nov 01 20:44:23 volumio volumio[973]: info: CoreStateMachine::pushState
Nov 01 20:44:23 volumio volumio[973]: info: CorePlayQueue::getTrack 0
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::volumioPushState
Nov 01 20:44:23 volumio volumio[973]: info: CoreStateMachine::setRandom false
Nov 01 20:44:23 volumio volumio[973]: info: CoreStateMachine::pushState
Nov 01 20:44:23 volumio volumio[973]: info: CorePlayQueue::getTrack 0
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::volumioPushState
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::volumioGetState
Nov 01 20:44:23 volumio volumio[973]: info: CorePlayQueue::getTrack 0
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Nov 01 20:44:23 volumio volumio[973]: info: Discovery: adding 02a0e1fd-3125-46d9-90ce-d9ceb1a5e9d3
Nov 01 20:44:23 volumio volumio[973]: info: Discovery: Found device Volumio
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::volumioGetState
Nov 01 20:44:23 volumio volumio[973]: info: CorePlayQueue::getTrack 0
Nov 01 20:44:23 volumio volumio[973]: info: VolumeController:: Volume=86 Mute =false
Nov 01 20:44:23 volumio volumio[973]: info: CoreStateMachine::pushState
Nov 01 20:44:23 volumio volumio[973]: info: CorePlayQueue::getTrack 0
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::volumioPushState
Nov 01 20:44:23 volumio volumio[973]: info: VolumeController:: Volume=86 Mute =false
Nov 01 20:44:23 volumio volumio[973]: info: CoreStateMachine::pushState
Nov 01 20:44:23 volumio volumio[973]: info: CorePlayQueue::getTrack 0
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::volumioPushState
Nov 01 20:44:23 volumio volumio[973]: info: Completed loading Core Plugins
Nov 01 20:44:23 volumio volumio[973]: info: Preparing to generate the ALSA configuration file
Nov 01 20:44:23 volumio volumio[973]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Nov 01 20:44:23 volumio volumio[973]: info: Reading ALSA contributions from plugins.
Nov 01 20:44:23 volumio volumio[973]: info: Asound.conf file written
Nov 01 20:44:23 volumio sudo[1136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Nov 01 20:44:23 volumio sudo[1136]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 01 20:44:23 volumio sudo[1136]: pam_unix(sudo:session): session closed for user root
Nov 01 20:44:23 volumio volumio[973]: info: Output device has changed, restarting MPD
Nov 01 20:44:23 volumio volumio[973]: info: Output device has changed, restarting Shairport Sync
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 01 20:44:23 volumio sudo[1141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Nov 01 20:44:23 volumio sudo[1141]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 01 20:44:23 volumio sudo[1141]: pam_unix(sudo:session): session closed for user root
Nov 01 20:44:23 volumio sudo[1143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Nov 01 20:44:23 volumio sudo[1143]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 01 20:44:23 volumio volumio[973]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Nov 01 20:44:23 volumio volumio[973]: info: ___________ START PLUGINS ___________
Nov 01 20:44:23 volumio volumio[973]: info: ControllerMpd::onStart: Initializing MPD
Nov 01 20:44:23 volumio volumio[973]: info: Creating MPD Configuration file
Nov 01 20:44:23 volumio systemd[1]: Listening on mpd.socket.
Nov 01 20:44:23 volumio systemd[1]: Starting Music Player Daemon...
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 01 20:44:23 volumio sudo[1163]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Nov 01 20:44:23 volumio volumio[973]: info: [1762026263446] CoreMusicLibrary::Adding element Serwery Mediów
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 01 20:44:23 volumio sudo[1163]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 01 20:44:23 volumio sudo[1163]: pam_unix(sudo:session): session closed for user root
Nov 01 20:44:23 volumio sudo[1166]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Nov 01 20:44:23 volumio sudo[1166]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 01 20:44:23 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Nov 01 20:44:23 volumio systemd[1]: mpd.service: Succeeded.
Nov 01 20:44:23 volumio systemd[1]: Stopped Music Player Daemon.
Nov 01 20:44:23 volumio systemd[1]: Starting Music Player Daemon...
Nov 01 20:44:23 volumio volumio[973]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 01 20:44:23 volumio volumio[973]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 01 20:44:23 volumio volumio[973]: info: [1762026263568] CoreMusicLibrary::Adding element Last_100
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 01 20:44:23 volumio volumio[973]: info: [1762026263571] CoreMusicLibrary::Adding element Webradio
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Nov 01 20:44:23 volumio volumio[973]: info: Initializing BBC Radios
Nov 01 20:44:23 volumio sudo[1172]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Nov 01 20:44:23 volumio sudo[1172]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 01 20:44:23 volumio sudo[1172]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
Nov 01 20:44:23 volumio sudo[1172]: pam_unix(sudo:session): session closed for user root
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Nov 01 20:44:23 volumio volumio[973]: info: [1762026263649] CoreMusicLibrary::Adding element SoundCloud
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Nov 01 20:44:23 volumio volumio[973]: Cannot find translation for source SoundCloud
Nov 01 20:44:23 volumio volumio[973]: info: Loading i18n strings for locale pl
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Nov 01 20:44:23 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:23 volumio volumio[973]: info: FusionDsp - mixtype--------------------- Hardware
Nov 01 20:44:24 volumio volumio[973]: info: Volumio Calling Home
Nov 01 20:44:24 volumio volumio[973]: info: Preparing to generate the ALSA configuration file
Nov 01 20:44:24 volumio volumio[973]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Nov 01 20:44:24 volumio volumio[973]: info: Reading ALSA contributions from plugins.
Nov 01 20:44:24 volumio volumio[973]: info: CoreCommandRouter::volumioGetState
Nov 01 20:44:24 volumio volumio[973]: info: CorePlayQueue::getTrack 0
Nov 01 20:44:24 volumio volumio[973]: info: [ASDebug] CurState: stop PrevState: na
Nov 01 20:44:24 volumio volumio[973]: info: [ASDebug] InitTimeout - Amp off in: 720 ms
Nov 01 20:44:24 volumio volumio[973]: info: [ASDebug] CurState: stop PrevState: na
Nov 01 20:44:24 volumio volumio[973]: info: [ASDebug] InitTimeout - Amp off in: 720 ms
Nov 01 20:44:24 volumio volumio[973]: info: MPD Permissions set
Nov 01 20:44:24 volumio volumio[973]: info: MPD Permissions set
Nov 01 20:44:24 volumio sudo[1214]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh
Nov 01 20:44:24 volumio sudo[1214]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 01 20:44:25 volumio volumio[973]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: Volumio called home
Nov 01 20:44:25 volumio volumio[973]: info: Starting Shairport Sync
Nov 01 20:44:25 volumio volumio[973]: info: Starting Shairport Sync
Nov 01 20:44:25 volumio volumio[973]: info: Starting Shairport Sync
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::volumioGetState
Nov 01 20:44:25 volumio volumio[973]: info: CorePlayQueue::getTrack 0
Nov 01 20:44:25 volumio volumio[973]: info: Asound.conf file unchanged, so no further update is needed
Nov 01 20:44:25 volumio volumio[973]: info: Output device has changed, restarting MPD
Nov 01 20:44:25 volumio volumio[973]: info: Output device has changed, restarting Shairport Sync
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 01 20:44:25 volumio sudo[1236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Nov 01 20:44:25 volumio sudo[1244]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Nov 01 20:44:25 volumio sudo[1242]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Nov 01 20:44:25 volumio sudo[1244]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 01 20:44:25 volumio sudo[1242]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 01 20:44:25 volumio sudo[1238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Nov 01 20:44:25 volumio sudo[1240]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Nov 01 20:44:25 volumio sudo[1238]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 01 20:44:25 volumio sudo[1242]: pam_unix(sudo:session): session closed for user root
Nov 01 20:44:25 volumio sudo[1240]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 01 20:44:25 volumio sudo[1236]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 01 20:44:25 volumio volumio[973]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Nov 01 20:44:25 volumio volumio[973]: info: [ASDebug] Togle GPIO: OFF
Nov 01 20:44:25 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Nov 01 20:44:25 volumio systemd[1]: shairport-sync.service: Succeeded.
Nov 01 20:44:25 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Nov 01 20:44:25 volumio volumio[973]: info: MPD Permissions set
Nov 01 20:44:25 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Nov 01 20:44:25 volumio systemd[1]: mpd.service: Succeeded.
Nov 01 20:44:25 volumio systemd[1]: Stopped Music Player Daemon.
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio systemd[1]: Starting Music Player Daemon...
Nov 01 20:44:25 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Nov 01 20:44:25 volumio sudo[1240]: pam_unix(sudo:session): session closed for user root
Nov 01 20:44:25 volumio sudo[1238]: pam_unix(sudo:session): session closed for user root
Nov 01 20:44:25 volumio sudo[1236]: pam_unix(sudo:session): session closed for user root
Nov 01 20:44:25 volumio volumio[973]: info: camilladsp service started and running in background, instance 1
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Nov 01 20:44:25 volumio volumio[973]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Nov 01 20:44:25 volumio volumio[973]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
Nov 01 20:44:25 volumio volumio[973]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Nov 01 20:44:25 volumio volumio[973]: info: FusionDsp loaded
Nov 01 20:44:25 volumio volumio[973]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Nov 01 20:44:25 volumio sudo[1254]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Nov 01 20:44:25 volumio sudo[1254]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 01 20:44:25 volumio sudo[1254]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
Nov 01 20:44:25 volumio sudo[1254]: pam_unix(sudo:session): session closed for user root
Nov 01 20:44:25 volumio sudo[1271]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Nov 01 20:44:25 volumio sudo[1271]: pam_unix(sudo:session): session opened for user root by (uid=0)
Nov 01 20:44:25 volumio volumio[973]: info: FusionDsp - Reporting Fusion DSP Enabled
Nov 01 20:44:25 volumio volumio[973]: info: Adding Signal Path Element [object Object]
Nov 01 20:44:25 volumio volumio[973]: info: Adding fusiondspeq DSP Signal Path Element
Nov 01 20:44:25 volumio volumio[973]: info: FusionDsp - ---- installed callbackRead
Nov 01 20:44:25 volumio volumio[973]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Nov 01 20:44:25 volumio volumio[973]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Nov 01 20:44:25 volumio volumio[973]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
Nov 01 20:44:25 volumio volumio[973]: at onErrorNT (internal/child_process.js:465:16)
Nov 01 20:44:25 volumio volumio[973]: at processTicksAndRejections (internal/process/task_queues.js:80:21)
Nov 01 20:44:25 volumio volumio[973]: at runNextTicks (internal/process/task_queues.js:62:3)
Nov 01 20:44:25 volumio volumio[973]: at listOnTimeout (internal/timers.js:523:9)
Nov 01 20:44:25 volumio volumio[973]: at processTimers (internal/timers.js:497:7) {
Nov 01 20:44:25 volumio volumio[973]: errno: -2,
Nov 01 20:44:25 volumio volumio[973]: code: 'ENOENT',
Nov 01 20:44:25 volumio volumio[973]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Nov 01 20:44:25 volumio volumio[973]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Nov 01 20:44:25 volumio volumio[973]: spawnargs: [
Nov 01 20:44:25 volumio volumio[973]: '-p',
Nov 01 20:44:25 volumio volumio[973]: 9876,
Nov 01 20:44:25 volumio volumio[973]: '-o',
Nov 01 20:44:25 volumio volumio[973]: '/tmp/camilladsp.log',
Nov 01 20:44:25 volumio volumio[973]: '-l',
Nov 01 20:44:25 volumio volumio[973]: 'warn',
Nov 01 20:44:25 volumio volumio[973]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Nov 01 20:44:25 volumio volumio[973]: ]
Nov 01 20:44:25 volumio volumio[973]: }
Nov 01 20:44:25 volumio volumio[973]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Nov 01 20:44:25 volumio sudo[1271]: pam_unix(sudo:session): session closed for user root
Nov 01 20:44:26 volumio kernel: new mount options do not match the existing superblock, will be ignored
Nov 01 20:44:26 volumio sudo[1291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-01 20:43
Nov 01 20:44:26 volumio sudo[1291]: 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="5d50cd80bebce60dddccd7f5e813d656e28ca4cd"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="7840f283c310c38bfe939a4c485727a6ff6a0ce1"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 21 Oct 2025 03:46:47 PM CEST"
VOLUMIO_VERSION="3.866"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="8e2f3a8aca3147ba51b5da8167dd6ff8"