-- Logs begin at Thu 2019-02-14 10:12:00 GMT, end at Mon 2025-03-10 17:24:37 GMT. -- Mar 10 17:24:18 volumio systemd-timedated[984]: Changed local time to Mon Mar 10 17:24:18 2025 Mar 10 17:24:18 volumio sudo[982]: pam_unix(sudo:session): session closed for user root Mar 10 17:24:18 volumio volumio-time-update[603]: volumio-time-update-util: System time updated successfully. Mar 10 17:24:18 volumio systemd[1]: Started Volumio Time Update Utility. Mar 10 17:24:18 volumio systemd[1]: Reached target Multi-User System. Mar 10 17:24:18 volumio systemd[1]: Reached target Graphical Interface. Mar 10 17:24:18 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 10 17:24:18 volumio systemd[1]: Starting Daily apt download activities... Mar 10 17:24:18 volumio kernel: SQUASHFS error: zlib decompression failed, data probably corrupt Mar 10 17:24:18 volumio kernel: SQUASHFS error: Failed to read block 0x1b9d9a50: -5 Mar 10 17:24:18 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [1b9d9a50] Mar 10 17:24:18 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [1b9d9a50] Mar 10 17:24:18 volumio kernel: SQUASHFS error: Unable to read page, block 1b9d9a50, size 11e89 Mar 10 17:24:18 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Mar 10 17:24:18 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 10 17:24:18 volumio nmbd[758]: [2025/03/10 17:24:18.477557, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Mar 10 17:24:18 volumio nmbd[758]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.50.31 for name WORKGROUP<1d>. Mar 10 17:24:18 volumio nmbd[758]: This response was from IP 192.168.50.127, reporting an IP address of 192.168.50.127. Mar 10 17:24:19 volumio volumio-remote-updater[618]: [2025-03-10 17:24:19] [connect] Successful connection Mar 10 17:24:20 volumio volumio[942]: info: ------------------------------------------- Mar 10 17:24:20 volumio volumio[942]: info: ----- Volumio3 ---- Mar 10 17:24:20 volumio volumio[942]: info: ------------------------------------------- Mar 10 17:24:20 volumio volumio[942]: info: ----- System startup ---- Mar 10 17:24:20 volumio volumio[942]: info: ------------------------------------------- Mar 10 17:24:22 volumio volumio[942]: info: MYVOLUMIO Environment detected Mar 10 17:24:22 volumio volumio[942]: info: Found new core plugin miscellanea/albumart. Adding it Mar 10 17:24:22 volumio login[799]: pam_unix(login:session): session opened for user volumio by LOGIN(uid=0) Mar 10 17:24:22 volumio systemd[1]: Created slice User Slice of UID 1000. Mar 10 17:24:22 volumio volumio[942]: info: Configured plugin miscellanea/albumart cannot be loaded. Removing from configuration Mar 10 17:24:22 volumio kernel: SQUASHFS error: zlib decompression failed, data probably corrupt Mar 10 17:24:22 volumio kernel: SQUASHFS error: Failed to read block 0x1b9d9a50: -5 Mar 10 17:24:22 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [1b9d9a50] Mar 10 17:24:22 volumio kernel: SQUASHFS error: Unable to read page, block 1b9d9a50, size 11e89 Mar 10 17:24:22 volumio systemd[1]: Starting User Runtime Directory /run/user/1000... Mar 10 17:24:23 volumio systemd-logind[631]: New session 1 of user volumio. Mar 10 17:24:23 volumio volumio[942]: info: Plugin folders cleanup Mar 10 17:24:23 volumio volumio[942]: info: Scanning into folder /volumio/app/plugins/ Mar 10 17:24:23 volumio volumio[942]: info: Scanning category audio_interface Mar 10 17:24:23 volumio volumio[942]: info: Scanning category miscellanea Mar 10 17:24:23 volumio volumio[942]: info: Scanning category music_service Mar 10 17:24:23 volumio volumio[942]: info: Scanning category plugins.json Mar 10 17:24:23 volumio volumio[942]: info: Scanning category system_controller Mar 10 17:24:23 volumio volumio[942]: info: Scanning category user_interface Mar 10 17:24:23 volumio volumio[942]: info: Scanning into folder /data/plugins/ Mar 10 17:24:23 volumio volumio[942]: info: Scanning category audio_interface Mar 10 17:24:23 volumio volumio[942]: info: Plugin folders cleanup completed Mar 10 17:24:23 volumio volumio[942]: info: ------------------------------------------- Mar 10 17:24:23 volumio volumio[942]: info: ----- Core plugins startup ---- Mar 10 17:24:23 volumio volumio[942]: info: ------------------------------------------- Mar 10 17:24:23 volumio volumio[942]: info: Loading plugins from folder /volumio/app/plugins/ Mar 10 17:24:23 volumio volumio[942]: info: Adding plugin upnp to MyMusic Plugins Mar 10 17:24:23 volumio kernel: SQUASHFS error: zlib decompression failed, data probably corrupt Mar 10 17:24:23 volumio kernel: SQUASHFS error: Failed to read block 0x1b9d9a50: -5 Mar 10 17:24:23 volumio kernel: SQUASHFS error: Unable to read fragment cache entry [1b9d9a50] Mar 10 17:24:23 volumio kernel: SQUASHFS error: Unable to read page, block 1b9d9a50, size 11e89 Mar 10 17:24:23 volumio volumio[942]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 10 17:24:23 volumio volumio[942]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 10 17:24:23 volumio systemd[1]: Started User Runtime Directory /run/user/1000. Mar 10 17:24:23 volumio volumio[942]: info: Loading plugins from folder /data/plugins/ Mar 10 17:24:23 volumio systemd[1]: Starting User Manager for UID 1000... Mar 10 17:24:23 volumio volumio[942]: info: Loading plugin "system"... Mar 10 17:24:23 volumio systemd[1038]: pam_unix(systemd-user:session): session opened for user volumio by (uid=0) Mar 10 17:24:23 volumio volumio[942]: info: Loading plugin "appearance"... Mar 10 17:24:23 volumio systemd[1]: apt-daily.service: Succeeded. Mar 10 17:24:23 volumio systemd[1]: Started Daily apt download activities. Mar 10 17:24:23 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Mar 10 17:24:23 volumio systemd[1038]: Starting D-Bus User Message Bus Socket. Mar 10 17:24:23 volumio systemd[1038]: Listening on GnuPG cryptographic agent and passphrase cache (restricted). Mar 10 17:24:23 volumio systemd[1038]: Listening on GnuPG cryptographic agent and passphrase cache. Mar 10 17:24:23 volumio systemd[1038]: Listening on Sound System. Mar 10 17:24:23 volumio systemd[1038]: Listening on GnuPG cryptographic agent (ssh-agent emulation). Mar 10 17:24:23 volumio systemd[1038]: Reached target Paths. Mar 10 17:24:23 volumio systemd[1038]: Listening on GnuPG network certificate management daemon. Mar 10 17:24:23 volumio systemd[1038]: Reached target Timers. Mar 10 17:24:23 volumio systemd[1038]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers). Mar 10 17:24:23 volumio systemd[1038]: Listening on D-Bus User Message Bus Socket. Mar 10 17:24:23 volumio systemd[1038]: Reached target Sockets. Mar 10 17:24:23 volumio systemd[1038]: Reached target Basic System. Mar 10 17:24:23 volumio systemd[1038]: Reached target Default. Mar 10 17:24:23 volumio systemd[1038]: Startup finished in 652ms. Mar 10 17:24:23 volumio systemd[1]: Started User Manager for UID 1000. Mar 10 17:24:23 volumio systemd[1]: Started Session 1 of user volumio. Mar 10 17:24:26 volumio volumio[942]: info: Loading plugin "network"... Mar 10 17:24:26 volumio volumio[942]: info: Refreshing Cached IP Addresses Mar 10 17:24:26 volumio sudo[1098]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 10 17:24:26 volumio sudo[1098]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 17:24:26 volumio sudo[1098]: pam_unix(sudo:session): session closed for user root Mar 10 17:24:26 volumio sudo[1101]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 10 17:24:26 volumio sudo[1101]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 17:24:26 volumio sudo[1101]: pam_unix(sudo:session): session closed for user root Mar 10 17:24:26 volumio volumio[942]: info: Loading plugin "services"... Mar 10 17:24:26 volumio volumio[942]: info: Loading plugin "alsa_controller"... Mar 10 17:24:26 volumio sudo[1112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 10 17:24:26 volumio sudo[1112]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 17:24:26 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 10 17:24:26 volumio volumio[942]: info: Loading plugin "wizard"... Mar 10 17:24:26 volumio volumio[942]: info: Loading plugin "networkfs"... Mar 10 17:24:27 volumio volumio[942]: info: Starting Udev Watcher for removable devices Mar 10 17:24:27 volumio sudo[1143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=kjartan,password=Le1knir#01,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.50.127/Music /mnt/NAS/Music Mar 10 17:24:27 volumio sudo[1143]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 17:24:27 volumio volumio[942]: info: Ignoring mount for partition: boot Mar 10 17:24:27 volumio volumio[942]: info: Ignoring mount for partition: volumio Mar 10 17:24:27 volumio volumio[942]: info: Ignoring mount for partition: volumio_data Mar 10 17:24:27 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 10 17:24:27 volumio volumio[942]: info: Loading plugin "volumio_command_line_client"... Mar 10 17:24:27 volumio volumio[942]: info: Loading plugin "upnp"... Mar 10 17:24:27 volumio volumio[942]: info: [1741627467172] Starting Upmpd Daemon Mar 10 17:24:27 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 10 17:24:27 volumio volumio[942]: info: Loading plugin "my_music"... Mar 10 17:24:27 volumio volumio[942]: info: Loading plugin "mpd"... Mar 10 17:24:27 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Mar 10 17:24:27 volumio systemd[1]: Started Daily apt upgrade and clean activities. Mar 10 17:24:27 volumio systemd[1]: Startup finished in 16.086s (kernel) + 30.477s (userspace) = 46.564s. Mar 10 17:24:27 volumio kernel: Key type cifs.spnego registered Mar 10 17:24:27 volumio kernel: Key type cifs.idmap registered Mar 10 17:24:27 volumio kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Mar 10 17:24:27 volumio kernel: CIFS: Attempting to mount //192.168.50.127/Music Mar 10 17:24:27 volumio sudo[1112]: pam_unix(sudo:session): session closed for user root Mar 10 17:24:27 volumio kernel: cryptd: max_cpu_qlen set to 1000 Mar 10 17:24:28 volumio sudo[1143]: pam_unix(sudo:session): session closed for user root Mar 10 17:24:28 volumio volumio[942]: info: Loading plugin "upnp_browser"... Mar 10 17:24:29 volumio volumio[942]: info: Loading plugin "alarm-clock"... Mar 10 17:24:29 volumio volumio[942]: info: Loading plugin "airplay_emulation"... Mar 10 17:24:29 volumio volumio[942]: info: Starting Shairport Sync Mar 10 17:24:29 volumio volumio[942]: info: Loading plugin "last_100"... Mar 10 17:24:29 volumio volumio[942]: info: Loading plugin "webradio"... Mar 10 17:24:30 volumio volumio[942]: info: Loading plugin "i2s_dacs"... Mar 10 17:24:30 volumio volumio[942]: info: Loading plugin "volumiodiscovery"... Mar 10 17:24:30 volumio volumio[942]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 10 17:24:30 volumio volumio[942]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 10 17:24:30 volumio volumio[942]: *** WARNING *** For more information see Mar 10 17:24:30 volumio node[942]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 10 17:24:30 volumio volumio[942]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 10 17:24:30 volumio volumio[942]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 10 17:24:30 volumio volumio[942]: *** WARNING *** For more information see Mar 10 17:24:30 volumio node[942]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 10 17:24:30 volumio node[942]: *** WARNING *** For more information see Mar 10 17:24:30 volumio node[942]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 10 17:24:30 volumio node[942]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 10 17:24:30 volumio node[942]: *** WARNING *** For more information see Mar 10 17:24:30 volumio volumio[942]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 10 17:24:30 volumio volumio[942]: info: Discovery: Started advertising with name: Volumio Mar 10 17:24:30 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 10 17:24:30 volumio volumio[942]: info: Loading plugin "outputs"... Mar 10 17:24:30 volumio volumio[942]: info: Plugin example_plugin is not enabled Mar 10 17:24:30 volumio volumio[942]: info: Loading plugin "inputs"... Mar 10 17:24:30 volumio volumio[942]: info: Loading plugin "updater_comm"... Mar 10 17:24:30 volumio volumio[942]: info: Plugin mpdemulation is not enabled Mar 10 17:24:30 volumio volumio[942]: info: Loading plugin "rest_api"... Mar 10 17:24:30 volumio volumio[942]: info: Loading plugin "websocket"... Mar 10 17:24:30 volumio volumio[942]: info: Starting Socket.io Server version 2.3.0 Mar 10 17:24:30 volumio volumio[942]: info: Loading plugin "fusiondsp"... Mar 10 17:24:31 volumio volumio[942]: info: Applying required configuration parameters for plugin fusiondsp Mar 10 17:24:32 volumio volumio[942]: info: Loading i18n strings for locale en Mar 10 17:24:32 volumio volumio[942]: Updating browse sources language Mar 10 17:24:32 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 17:24:32 volumio systemd[1]: systemd-fsckd.service: Succeeded. Mar 10 17:24:32 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 17:24:32 volumio volumio[942]: info: CoreCommandRouter::initPlayerControls Mar 10 17:24:32 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:32 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:32 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:32 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:32 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:32 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:32 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:32 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:32 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 17:24:32 volumio volumio[942]: Express server listening on port 3000 Mar 10 17:24:32 volumio volumio[942]: [Metrics] WebUI: 14s 642.79ms Mar 10 17:24:32 volumio volumio[942]: info: CoreStateMachine::resetVolumioState Mar 10 17:24:32 volumio volumio[942]: info: CoreStateMachine::getcurrentVolume Mar 10 17:24:32 volumio volumio[942]: info: CoreCommandRouter::volumioRetrievevolume Mar 10 17:24:32 volumio volumio[942]: info: Cannot read play queue from file Mar 10 17:24:32 volumio volumio[942]: info: Volumio Network Manager: Network status updated: 1 Mar 10 17:24:33 volumio volumio[942]: info: CoreCommandRouter::volumioGetState Mar 10 17:24:33 volumio volumio[942]: info: CorePlayQueue::getTrack 0 Mar 10 17:24:33 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 10 17:24:33 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 10 17:24:33 volumio volumio[942]: info: Discovery: Getting this device information Mar 10 17:24:33 volumio volumio[942]: info: CoreCommandRouter::volumioGetState Mar 10 17:24:33 volumio volumio[942]: info: CorePlayQueue::getTrack 0 Mar 10 17:24:33 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 17:24:33 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 17:24:33 volumio volumio[942]: info: VolumeController:: Volume=100 Mute =false Mar 10 17:24:33 volumio volumio[942]: info: CoreStateMachine::pushState Mar 10 17:24:33 volumio volumio[942]: info: CorePlayQueue::getTrack 0 Mar 10 17:24:33 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 10 17:24:33 volumio volumio[942]: info: CoreCommandRouter::volumioPushState Mar 10 17:24:33 volumio volumio[942]: info: CoreStateMachine::updateTrackBlock Mar 10 17:24:33 volumio volumio[942]: info: CorePlayQueue::getTrackBlock Mar 10 17:24:33 volumio volumio[942]: info: CoreCommandRouter::volumioRetrievevolume Mar 10 17:24:33 volumio volumio[942]: info: Setting Device type: Raspberry PI Mar 10 17:24:33 volumio volumio[942]: info: CoreStateMachine::setRepeat null single undefined Mar 10 17:24:33 volumio volumio[942]: info: CoreStateMachine::pushState Mar 10 17:24:33 volumio volumio[942]: info: CorePlayQueue::getTrack 0 Mar 10 17:24:33 volumio volumio[942]: info: CoreCommandRouter::volumioPushState Mar 10 17:24:33 volumio volumio[942]: info: CoreStateMachine::setRandom null Mar 10 17:24:33 volumio volumio[942]: info: CoreStateMachine::pushState Mar 10 17:24:33 volumio volumio[942]: info: CorePlayQueue::getTrack 0 Mar 10 17:24:33 volumio volumio[942]: info: CoreCommandRouter::volumioPushState Mar 10 17:24:33 volumio volumio[942]: info: Listing playlists Mar 10 17:24:33 volumio volumio[942]: info: Listing playlists Mar 10 17:24:33 volumio volumio[942]: info: Completed loading Core Plugins Mar 10 17:24:33 volumio volumio[942]: info: Preparing to generate the ALSA configuration file Mar 10 17:24:33 volumio volumio[942]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 10 17:24:33 volumio volumio[942]: info: Reading ALSA contributions from plugins. Mar 10 17:24:33 volumio volumio[942]: verbose: New Socket.io Connection to 192.168.50.31:3000 from 192.168.50.174 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 1 Mar 10 17:24:33 volumio volumio[942]: info: Asound.conf file unchanged, so no further update is needed Mar 10 17:24:33 volumio volumio[942]: info: Output device has changed, restarting MPD Mar 10 17:24:33 volumio volumio[942]: info: Output device has changed, restarting Shairport Sync Mar 10 17:24:33 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:33 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 17:24:33 volumio sudo[1203]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 10 17:24:33 volumio sudo[1203]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 17:24:33 volumio sudo[1203]: pam_unix(sudo:session): session closed for user root Mar 10 17:24:33 volumio sudo[1205]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 10 17:24:33 volumio sudo[1205]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 17:24:33 volumio systemd[1]: Stopping Music Player Daemon... Mar 10 17:24:33 volumio volumio[942]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 10 17:24:33 volumio volumio[942]: info: ___________ START PLUGINS ___________ Mar 10 17:24:33 volumio volumio[942]: info: ControllerMpd::onStart: Initializing MPD Mar 10 17:24:33 volumio volumio[942]: info: Creating MPD Configuration file Mar 10 17:24:33 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 10 17:24:33 volumio volumio[942]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 10 17:24:33 volumio volumio[942]: info: [1741627473779] CoreMusicLibrary::Adding element Media Servers Mar 10 17:24:33 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 17:24:33 volumio sudo[1212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 10 17:24:33 volumio sudo[1212]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 17:24:33 volumio sudo[1212]: pam_unix(sudo:session): session closed for user root Mar 10 17:24:33 volumio sudo[1214]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 10 17:24:33 volumio sudo[1214]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 17:24:33 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:33 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 17:24:33 volumio volumio[942]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 10 17:24:33 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:33 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 17:24:33 volumio systemd[1]: mpd.service: Succeeded. Mar 10 17:24:33 volumio systemd[1]: Stopped Music Player Daemon. Mar 10 17:24:34 volumio systemd[1]: Starting Music Player Daemon... Mar 10 17:24:34 volumio volumio[942]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 10 17:24:34 volumio volumio[942]: info: [1741627474075] CoreMusicLibrary::Adding element Last_100 Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 10 17:24:34 volumio volumio[942]: info: [1741627474082] CoreMusicLibrary::Adding element Webradio Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 10 17:24:34 volumio volumio[942]: info: Initializing BBC Radios Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 17:24:34 volumio volumio[942]: info: Loading i18n strings for locale en Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:34 volumio volumio[942]: info: FusionDsp - mixtype--------------------- Hardware Mar 10 17:24:34 volumio volumio[942]: info: Volumio Calling Home Mar 10 17:24:34 volumio sudo[1221]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 10 17:24:34 volumio sudo[1221]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 17:24:34 volumio sudo[1221]: pam_unix(sudo:session): session closed for user root Mar 10 17:24:34 volumio volumio-remote-updater[618]: [2025-03-10 17:24:34] [connect] Successful connection Mar 10 17:24:34 volumio volumio[942]: info: Preparing to generate the ALSA configuration file Mar 10 17:24:34 volumio volumio[942]: info: Discovery: adding e3f833e6-6790-4bc4-bb6a-c89ad8da11a4 Mar 10 17:24:34 volumio volumio[942]: info: Discovery: Found device Volumio Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::volumioGetState Mar 10 17:24:34 volumio volumio[942]: info: CorePlayQueue::getTrack 0 Mar 10 17:24:34 volumio volumio[942]: info: Discovery: this is already registered, e3f833e6-6790-4bc4-bb6a-c89ad8da11a4 Mar 10 17:24:34 volumio volumio[942]: info: Discovery: Found device Volumio Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::volumioGetState Mar 10 17:24:34 volumio volumio[942]: info: CorePlayQueue::getTrack 0 Mar 10 17:24:34 volumio volumio[942]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 10 17:24:34 volumio volumio[942]: info: Reading ALSA contributions from plugins. Mar 10 17:24:34 volumio volumio[942]: info: MPD Permissions set Mar 10 17:24:34 volumio volumio[942]: info: MPD Permissions set Mar 10 17:24:34 volumio volumio[942]: info: VolumeController:: Volume=100 Mute =false Mar 10 17:24:34 volumio volumio[942]: info: CoreStateMachine::pushState Mar 10 17:24:34 volumio volumio[942]: info: CorePlayQueue::getTrack 0 Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::volumioPushState Mar 10 17:24:34 volumio volumio-remote-updater[618]: [2025-03-10 17:24:34] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1741627474 101 Mar 10 17:24:34 volumio volumio[942]: 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: 2 Mar 10 17:24:34 volumio volumio[942]: info: Volumio called home Mar 10 17:24:34 volumio volumio[942]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:34 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:35 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 17:24:35 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:35 volumio volumio[942]: info: Starting Shairport Sync Mar 10 17:24:35 volumio volumio[942]: info: Starting Shairport Sync Mar 10 17:24:35 volumio volumio[942]: info: Starting Shairport Sync Mar 10 17:24:35 volumio sudo[1248]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 10 17:24:35 volumio sudo[1248]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 17:24:35 volumio sudo[1250]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 10 17:24:35 volumio sudo[1250]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 17:24:35 volumio volumio[942]: info: CoreCommandRouter::volumioGetState Mar 10 17:24:35 volumio volumio[942]: info: CorePlayQueue::getTrack 0 Mar 10 17:24:35 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 10 17:24:35 volumio volumio[942]: info: CoreCommandRouter::volumioGetState Mar 10 17:24:35 volumio sudo[1253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 10 17:24:35 volumio volumio[942]: info: CorePlayQueue::getTrack 0 Mar 10 17:24:35 volumio sudo[1253]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 17:24:35 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 10 17:24:35 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 10 17:24:35 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 10 17:24:35 volumio volumio[942]: info: Asound.conf file unchanged, so no further update is needed Mar 10 17:24:35 volumio volumio[942]: info: Output device has changed, restarting MPD Mar 10 17:24:35 volumio sudo[1248]: pam_unix(sudo:session): session closed for user root Mar 10 17:24:35 volumio volumio[942]: info: Output device has changed, restarting Shairport Sync Mar 10 17:24:35 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:35 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 17:24:35 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 10 17:24:35 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 10 17:24:35 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 10 17:24:35 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 10 17:24:35 volumio sudo[1260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 10 17:24:35 volumio sudo[1260]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 17:24:35 volumio sudo[1250]: pam_unix(sudo:session): session closed for user root Mar 10 17:24:35 volumio sudo[1262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 10 17:24:35 volumio sudo[1262]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 17:24:35 volumio sudo[1253]: pam_unix(sudo:session): session closed for user root Mar 10 17:24:35 volumio sudo[1260]: pam_unix(sudo:session): session closed for user root Mar 10 17:24:35 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Mar 10 17:24:35 volumio systemd[1]: mpd.service: Succeeded. Mar 10 17:24:35 volumio systemd[1]: Stopped Music Player Daemon. Mar 10 17:24:35 volumio volumio[942]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 10 17:24:35 volumio systemd[1]: Starting Music Player Daemon... Mar 10 17:24:35 volumio volumio[942]: info: MPD Permissions set Mar 10 17:24:35 volumio volumio[942]: info: Shairport-Sync Started Mar 10 17:24:35 volumio volumio[942]: Error adding Membership: Error: addMembership EINVAL Mar 10 17:24:35 volumio volumio[942]: info: Shairport-Sync Started Mar 10 17:24:35 volumio volumio[942]: info: Shairport-Sync Started Mar 10 17:24:36 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:36 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:36 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:36 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:36 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:36 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:36 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:36 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:36 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 10 17:24:36 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:36 volumio sudo[1271]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 10 17:24:36 volumio sudo[1271]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 17:24:36 volumio volumio[942]: info: Starting Shairport Sync Mar 10 17:24:36 volumio sudo[1271]: pam_unix(sudo:session): session closed for user root Mar 10 17:24:36 volumio sudo[1282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 10 17:24:36 volumio sudo[1282]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 17:24:36 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 10 17:24:36 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 10 17:24:36 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 10 17:24:36 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 10 17:24:36 volumio sudo[1282]: pam_unix(sudo:session): session closed for user root Mar 10 17:24:36 volumio volumio[942]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Mar 10 17:24:36 volumio volumio[942]: info: camilladsp service started and running in background, instance 1 Mar 10 17:24:36 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 10 17:24:36 volumio volumio[942]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Mar 10 17:24:36 volumio volumio[942]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Mar 10 17:24:36 volumio volumio[942]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Mar 10 17:24:36 volumio volumio[942]: info: FusionDsp loaded Mar 10 17:24:36 volumio volumio[942]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 10 17:24:36 volumio sudo[1297]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Mar 10 17:24:36 volumio sudo[1297]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 10 17:24:36 volumio volumio[942]: info: FusionDsp - Reporting Fusion DSP Enabled Mar 10 17:24:36 volumio volumio[942]: info: Adding Signal Path Element [object Object] Mar 10 17:24:36 volumio volumio[942]: info: Adding fusiondspeq DSP Signal Path Element Mar 10 17:24:36 volumio volumio[942]: info: FusionDsp - ---- installed callbackRead Mar 10 17:24:36 volumio volumio[942]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 10 17:24:36 volumio sudo[1297]: pam_unix(sudo:session): session closed for user root Mar 10 17:24:36 volumio volumio[942]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Mar 10 17:24:36 volumio volumio[942]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Mar 10 17:24:36 volumio volumio[942]: at onErrorNT (internal/child_process.js:465:16) Mar 10 17:24:36 volumio volumio[942]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Mar 10 17:24:36 volumio volumio[942]: at runNextTicks (internal/process/task_queues.js:62:3) Mar 10 17:24:36 volumio volumio[942]: at listOnTimeout (internal/timers.js:523:9) Mar 10 17:24:36 volumio volumio[942]: at processTimers (internal/timers.js:497:7) { Mar 10 17:24:36 volumio volumio[942]: errno: -2, Mar 10 17:24:36 volumio volumio[942]: code: 'ENOENT', Mar 10 17:24:36 volumio volumio[942]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Mar 10 17:24:36 volumio volumio[942]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Mar 10 17:24:36 volumio volumio[942]: spawnargs: [ Mar 10 17:24:36 volumio volumio[942]: '-p', Mar 10 17:24:36 volumio volumio[942]: 9876, Mar 10 17:24:36 volumio volumio[942]: '-o', Mar 10 17:24:36 volumio volumio[942]: '/tmp/camilladsp.log', Mar 10 17:24:36 volumio volumio[942]: '-l', Mar 10 17:24:36 volumio volumio[942]: 'warn', Mar 10 17:24:36 volumio volumio[942]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Mar 10 17:24:36 volumio volumio[942]: ] Mar 10 17:24:36 volumio volumio[942]: } Mar 10 17:24:36 volumio volumio[942]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 10 17:24:37 volumio sudo[1322]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-10 17:23 Mar 10 17:24:37 volumio sudo[1322]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 11:42:54 AM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4049a67f1c09d4a94e033ba35a80a144"