-- Logs begin at Thu 2019-02-14 19:11:59 JST, end at Fri 2025-04-18 12:08:11 JST. -- Apr 18 12:07:47 volumio systemd-timedated[1026]: Changed local time to Fri Apr 18 12:07:47 2025 Apr 18 12:07:47 volumio sudo[1024]: pam_unix(sudo:session): session closed for user root Apr 18 12:07:47 volumio volumio-time-update[633]: volumio-time-update-util: System time updated successfully. Apr 18 12:07:47 volumio systemd[1]: Started Volumio Time Update Utility. Apr 18 12:07:47 volumio systemd[1]: Reached target Multi-User System. Apr 18 12:07:47 volumio systemd[1]: Reached target Graphical Interface. Apr 18 12:07:47 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Apr 18 12:07:47 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Apr 18 12:07:47 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Apr 18 12:07:47 volumio systemd[1]: Startup finished in 14.510s (kernel) + 22.258s (userspace) = 36.768s. Apr 18 12:07:47 volumio volumio[989]: info: ------------------------------------------- Apr 18 12:07:47 volumio volumio[989]: info: ----- Volumio3 ---- Apr 18 12:07:47 volumio volumio[989]: info: ------------------------------------------- Apr 18 12:07:47 volumio volumio[989]: info: ----- System startup ---- Apr 18 12:07:47 volumio volumio[989]: info: ------------------------------------------- Apr 18 12:07:48 volumio volumio[989]: info: MYVOLUMIO Environment detected Apr 18 12:07:48 volumio volumio[989]: info: Plugin folders cleanup Apr 18 12:07:48 volumio volumio[989]: info: Scanning into folder /volumio/app/plugins/ Apr 18 12:07:48 volumio volumio[989]: info: Scanning category audio_interface Apr 18 12:07:48 volumio volumio[989]: info: Scanning category miscellanea Apr 18 12:07:48 volumio volumio[989]: info: Scanning category music_service Apr 18 12:07:48 volumio volumio[989]: info: Scanning category plugins.json Apr 18 12:07:48 volumio volumio[989]: info: Scanning category system_controller Apr 18 12:07:48 volumio volumio[989]: info: Scanning category user_interface Apr 18 12:07:48 volumio volumio[989]: info: Scanning into folder /data/plugins/ Apr 18 12:07:48 volumio volumio[989]: info: Scanning category audio_interface Apr 18 12:07:48 volumio volumio[989]: info: Scanning category music_service Apr 18 12:07:48 volumio volumio[989]: info: Scanning category system_hardware Apr 18 12:07:48 volumio volumio[989]: info: Scanning category user_interface Apr 18 12:07:48 volumio volumio[989]: info: Plugin folders cleanup completed Apr 18 12:07:48 volumio volumio[989]: info: ------------------------------------------- Apr 18 12:07:48 volumio volumio[989]: info: ----- Core plugins startup ---- Apr 18 12:07:48 volumio volumio[989]: info: ------------------------------------------- Apr 18 12:07:48 volumio volumio[989]: info: Loading plugins from folder /volumio/app/plugins/ Apr 18 12:07:48 volumio volumio[989]: info: Adding plugin upnp to MyMusic Plugins Apr 18 12:07:48 volumio volumio[989]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 18 12:07:48 volumio volumio[989]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 18 12:07:48 volumio volumio[989]: info: Loading plugins from folder /data/plugins/ Apr 18 12:07:48 volumio volumio[989]: info: Loading plugin "system"... Apr 18 12:07:48 volumio volumio[989]: info: Loading plugin "appearance"... Apr 18 12:07:50 volumio volumio[989]: info: Loading plugin "network"... Apr 18 12:07:50 volumio volumio[989]: info: Refreshing Cached IP Addresses Apr 18 12:07:50 volumio sudo[1045]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 18 12:07:50 volumio sudo[1045]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 12:07:50 volumio sudo[1047]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 18 12:07:50 volumio sudo[1045]: pam_unix(sudo:session): session closed for user root Apr 18 12:07:50 volumio sudo[1047]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 12:07:50 volumio sudo[1047]: pam_unix(sudo:session): session closed for user root Apr 18 12:07:50 volumio volumio[989]: info: Loading plugin "services"... Apr 18 12:07:50 volumio volumio[989]: info: Loading plugin "alsa_controller"... Apr 18 12:07:50 volumio sudo[1056]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 18 12:07:50 volumio sudo[1056]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 12:07:50 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 18 12:07:50 volumio volumio[989]: info: Loading plugin "wizard"... Apr 18 12:07:50 volumio volumio[989]: info: Loading plugin "networkfs"... Apr 18 12:07:50 volumio volumio[989]: info: Starting Udev Watcher for removable devices Apr 18 12:07:50 volumio sudo[1071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.28/usbshare2\\music\\yoshihko /mnt/NAS/usbshare2 Apr 18 12:07:50 volumio sudo[1071]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 12:07:50 volumio volumio[989]: info: Ignoring mount for partition: boot Apr 18 12:07:50 volumio volumio[989]: info: Ignoring mount for partition: volumio Apr 18 12:07:50 volumio volumio[989]: info: Ignoring mount for partition: volumio_data Apr 18 12:07:50 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 18 12:07:50 volumio volumio[989]: info: Loading plugin "volumio_command_line_client"... Apr 18 12:07:50 volumio volumio[989]: info: Loading plugin "upnp"... Apr 18 12:07:50 volumio volumio[989]: info: [1744945670762] Starting Upmpd Daemon Apr 18 12:07:50 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 18 12:07:50 volumio volumio[989]: info: Loading plugin "my_music"... Apr 18 12:07:50 volumio volumio[989]: info: Loading plugin "mpd"... Apr 18 12:07:50 volumio kernel: Key type cifs.spnego registered Apr 18 12:07:50 volumio kernel: Key type cifs.idmap registered Apr 18 12:07:50 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. Apr 18 12:07:50 volumio kernel: CIFS: Attempting to mount //192.168.1.28/usbshare2/music/yoshihko Apr 18 12:07:51 volumio volumio[989]: info: Loading plugin "upnp_browser"... Apr 18 12:07:51 volumio sudo[1056]: pam_unix(sudo:session): session closed for user root Apr 18 12:07:51 volumio volumio[989]: info: Loading plugin "alarm-clock"... Apr 18 12:07:52 volumio volumio[989]: info: Loading plugin "airplay_emulation"... Apr 18 12:07:52 volumio volumio[989]: info: Starting Shairport Sync Apr 18 12:07:52 volumio volumio[989]: info: Loading plugin "last_100"... Apr 18 12:07:52 volumio volumio[989]: info: Loading plugin "webradio"... Apr 18 12:07:52 volumio volumio[989]: info: Loading plugin "i2s_dacs"... Apr 18 12:07:52 volumio volumio[989]: info: I2S DAC not set, start Auto-detection Apr 18 12:07:52 volumio volumio[989]: info: Loading plugin "volumiodiscovery"... Apr 18 12:07:52 volumio volumio[989]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 18 12:07:52 volumio volumio[989]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 18 12:07:52 volumio volumio[989]: *** WARNING *** For more information see Apr 18 12:07:52 volumio volumio[989]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 18 12:07:52 volumio node[989]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 18 12:07:52 volumio volumio[989]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 18 12:07:52 volumio volumio[989]: *** WARNING *** For more information see Apr 18 12:07:52 volumio node[989]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 18 12:07:52 volumio node[989]: *** WARNING *** For more information see Apr 18 12:07:52 volumio node[989]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 18 12:07:52 volumio node[989]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 18 12:07:52 volumio node[989]: *** WARNING *** For more information see Apr 18 12:07:52 volumio volumio[989]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 18 12:07:52 volumio volumio[989]: info: Discovery: Started advertising with name: Volumio Apr 18 12:07:52 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 18 12:07:52 volumio volumio[989]: info: Loading plugin "youtube2"... Apr 18 12:07:53 volumio volumio-remote-updater[649]: [2025-04-18 12:07:53] [connect] Successful connection Apr 18 12:07:57 volumio volumio[989]: info: Loading plugin "ytmusic"... Apr 18 12:07:58 volumio systemd[1]: systemd-fsckd.service: Succeeded. Apr 18 12:07:58 volumio kernel: cryptd: max_cpu_qlen set to 1000 Apr 18 12:07:59 volumio sh[510]: timed out Apr 18 12:07:59 volumio dhcpcd[548]: timed out Apr 18 12:07:59 volumio sh[510]: dhcpcd exited Apr 18 12:07:59 volumio dhcpcd[548]: dhcpcd exited Apr 18 12:07:59 volumio sh[510]: ifup: failed to bring up eth0 Apr 18 12:07:59 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Apr 18 12:07:59 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Apr 18 12:08:01 volumio volumio[989]: info: Loading plugin "outputs"... Apr 18 12:08:01 volumio volumio[989]: info: Loading plugin "albumart"... Apr 18 12:08:01 volumio volumio[989]: info: Plugin example_plugin is not enabled Apr 18 12:08:01 volumio volumio[989]: info: Loading plugin "inputs"... Apr 18 12:08:01 volumio volumio[989]: info: Loading plugin "updater_comm"... Apr 18 12:08:02 volumio volumio[989]: info: Plugin mpdemulation is not enabled Apr 18 12:08:02 volumio volumio[989]: info: Loading plugin "rest_api"... Apr 18 12:08:02 volumio volumio[989]: info: Loading plugin "websocket"... Apr 18 12:08:02 volumio volumio[989]: info: Starting Socket.io Server version 2.3.0 Apr 18 12:08:02 volumio volumio[989]: info: Loading plugin "fusiondsp"... Apr 18 12:08:02 volumio volumio[989]: Forking 3 albumart workers Apr 18 12:08:02 volumio volumio[989]: info: Applying required configuration parameters for plugin fusiondsp Apr 18 12:08:02 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Apr 18 12:08:02 volumio volumio[989]: info: Loading plugin "music_services_shield"... Apr 18 12:08:03 volumio volumio[989]: info: Applying required configuration parameters for plugin music_services_shield Apr 18 12:08:03 volumio volumio[989]: info: Loading plugin "Systeminfo"... Apr 18 12:08:03 volumio volumio[989]: Starting albumart workers Apr 18 12:08:03 volumio volumio[989]: Starting albumart workers Apr 18 12:08:03 volumio volumio[989]: Starting albumart workers Apr 18 12:08:04 volumio volumio[989]: info: Loading i18n strings for locale ja Apr 18 12:08:04 volumio volumio[989]: Updating browse sources language Apr 18 12:08:04 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 18 12:08:04 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 18 12:08:04 volumio volumio[989]: info: CoreCommandRouter::initPlayerControls Apr 18 12:08:04 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:04 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:04 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:04 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:04 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 18 12:08:04 volumio volumio[989]: Express server listening on port 3000 Apr 18 12:08:04 volumio volumio[989]: [Metrics] WebUI: 18s 283.14ms Apr 18 12:08:04 volumio volumio[989]: info: CoreStateMachine::resetVolumioState Apr 18 12:08:04 volumio volumio[989]: info: CoreStateMachine::getcurrentVolume Apr 18 12:08:04 volumio volumio[989]: info: CoreCommandRouter::volumioRetrievevolume Apr 18 12:08:04 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 18 12:08:04 volumio sudo[1173]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 18 12:08:04 volumio sudo[1173]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 12:08:04 volumio sudo[1173]: pam_unix(sudo:session): session closed for user root Apr 18 12:08:04 volumio sudo[1184]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 18 12:08:04 volumio sudo[1184]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 12:08:04 volumio sudo[1184]: pam_unix(sudo:session): session closed for user root Apr 18 12:08:04 volumio volumio[989]: info: Volumio Network Manager: Network status updated: 2 Apr 18 12:08:04 volumio volumio[989]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 18 12:08:05 volumio volumio[989]: info: VolumeController:: Volume=undefined Mute =false Apr 18 12:08:05 volumio volumio[989]: info: CoreStateMachine::pushState Apr 18 12:08:05 volumio volumio[989]: info: CorePlayQueue::getTrack 0 Apr 18 12:08:05 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 12:08:05 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 18 12:08:05 volumio volumio[989]: info: CoreStateMachine::updateTrackBlock Apr 18 12:08:05 volumio volumio[989]: info: CorePlayQueue::getTrackBlock Apr 18 12:08:05 volumio volumio[989]: info: CoreCommandRouter::volumioRetrievevolume Apr 18 12:08:05 volumio volumio[989]: info: Reloading queue from file Apr 18 12:08:05 volumio volumio[989]: info: Setting Device type: Raspberry PI Apr 18 12:08:05 volumio volumio[989]: info: CoreStateMachine::setRepeat null single undefined Apr 18 12:08:05 volumio volumio[989]: info: CoreStateMachine::pushState Apr 18 12:08:05 volumio volumio[989]: info: CorePlayQueue::getTrack 0 Apr 18 12:08:05 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 12:08:05 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 18 12:08:05 volumio volumio[989]: info: CoreStateMachine::setRandom false Apr 18 12:08:05 volumio volumio[989]: info: CoreStateMachine::pushState Apr 18 12:08:05 volumio volumio[989]: info: CorePlayQueue::getTrack 0 Apr 18 12:08:05 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 18 12:08:05 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 18 12:08:05 volumio volumio[989]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Apr 18 12:08:05 volumio volumio[989]: info: VolumeController:: Volume=undefined Mute =false Apr 18 12:08:05 volumio volumio[989]: info: CoreStateMachine::pushState Apr 18 12:08:05 volumio volumio[989]: info: CorePlayQueue::getTrack 0 Apr 18 12:08:05 volumio volumio[989]: info: CoreCommandRouter::volumioPushState Apr 18 12:08:05 volumio volumio[989]: info: Discovery: adding e1ec6dfe-1eb7-480a-9862-b9e5b8f92f37 Apr 18 12:08:05 volumio volumio[989]: info: Discovery: Found device Volumio Apr 18 12:08:05 volumio volumio[989]: info: CoreCommandRouter::volumioGetState Apr 18 12:08:05 volumio volumio[989]: info: CorePlayQueue::getTrack 0 Apr 18 12:08:05 volumio sudo[1203]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 18 12:08:05 volumio sudo[1203]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 12:08:05 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Apr 18 12:08:05 volumio sudo[1203]: pam_unix(sudo:session): session closed for user root Apr 18 12:08:05 volumio volumio[989]: info: Upmpdcli Daemon Started Apr 18 12:08:05 volumio volumio[1205]: Generating RSA private key, 4096 bit long modulus (2 primes) Apr 18 12:08:07 volumio sudo[1071]: pam_unix(sudo:session): session closed for user root Apr 18 12:08:07 volumio volumio[989]: info: Completed loading Core Plugins Apr 18 12:08:07 volumio volumio[989]: info: Preparing to generate the ALSA configuration file Apr 18 12:08:07 volumio volumio[989]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 18 12:08:07 volumio volumio[989]: info: Reading ALSA contributions from plugins. Apr 18 12:08:07 volumio volumio[989]: info: Asound.conf file unchanged, so no further update is needed Apr 18 12:08:07 volumio volumio[989]: info: Output device has changed, restarting MPD Apr 18 12:08:07 volumio sudo[1223]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 18 12:08:07 volumio sudo[1223]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 12:08:07 volumio volumio[989]: info: Output device has changed, restarting Shairport Sync Apr 18 12:08:07 volumio sudo[1223]: pam_unix(sudo:session): session closed for user root Apr 18 12:08:07 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:07 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 18 12:08:07 volumio sudo[1225]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 18 12:08:07 volumio sudo[1225]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 12:08:07 volumio systemd[1]: musicservicesshield.service: Succeeded. Apr 18 12:08:07 volumio systemd[1]: Stopped Shield Volumio Music Services in the User CPU Set. Apr 18 12:08:07 volumio systemd[1]: Stopping Shield Volumio Music Services in the User CPU Set... Apr 18 12:08:07 volumio systemd[1]: Stopping Music Player Daemon... Apr 18 12:08:07 volumio volumio[989]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 18 12:08:07 volumio volumio[989]: info: ___________ START PLUGINS ___________ Apr 18 12:08:07 volumio volumio[989]: info: ControllerMpd::onStart: Initializing MPD Apr 18 12:08:07 volumio volumio[989]: info: Creating MPD Configuration file Apr 18 12:08:07 volumio sudo[1232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 18 12:08:07 volumio sudo[1232]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 12:08:07 volumio sudo[1232]: pam_unix(sudo:session): session closed for user root Apr 18 12:08:07 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 18 12:08:07 volumio volumio[989]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 18 12:08:07 volumio volumio[989]: info: [1744945687462] CoreMusicLibrary::Adding element DLNAサーバー Apr 18 12:08:07 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 18 12:08:07 volumio sudo[1235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 18 12:08:07 volumio sudo[1235]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 12:08:07 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:07 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 18 12:08:07 volumio volumio[989]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 18 12:08:07 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:07 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 18 12:08:07 volumio systemd[1]: mpd.service: Succeeded. Apr 18 12:08:07 volumio systemd[1]: Stopped Music Player Daemon. Apr 18 12:08:07 volumio volumio[989]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 18 12:08:07 volumio volumio[989]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 18 12:08:07 volumio volumio[989]: info: [1744945687647] CoreMusicLibrary::Adding element Last_100 Apr 18 12:08:07 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 18 12:08:07 volumio volumio[989]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 18 12:08:07 volumio volumio[989]: info: [1744945687650] CoreMusicLibrary::Adding element Webradio Apr 18 12:08:07 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 18 12:08:07 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 18 12:08:07 volumio volumio[989]: info: Initializing BBC Radios Apr 18 12:08:07 volumio systemd[1]: Starting Music Player Daemon... Apr 18 12:08:07 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 18 12:08:07 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 18 12:08:07 volumio volumio[989]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 18 12:08:07 volumio volumio[989]: info: [1744945687792] CoreMusicLibrary::Adding element YouTube2 Apr 18 12:08:07 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 18 12:08:07 volumio volumio[989]: Cannot find translation for source YouTube2 Apr 18 12:08:07 volumio volumio[989]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 18 12:08:07 volumio volumio[989]: info: [1744945687804] CoreMusicLibrary::Adding element YouTube Music Apr 18 12:08:07 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 18 12:08:07 volumio volumio[989]: Cannot find translation for source YouTube2 Apr 18 12:08:07 volumio volumio[989]: Cannot find translation for source YouTube Music Apr 18 12:08:07 volumio volumio[989]: info: Loading i18n strings for locale ja Apr 18 12:08:07 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Apr 18 12:08:07 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:07 volumio volumio[989]: info: FusionDsp - mixtype--------------------- undefined Apr 18 12:08:07 volumio sudo[1243]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 18 12:08:07 volumio sudo[1243]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 12:08:07 volumio sudo[1243]: pam_unix(sudo:session): session closed for user root Apr 18 12:08:08 volumio volumio[1205]: .................++++ Apr 18 12:08:08 volumio volumio[989]: info: Volumio Calling Home Apr 18 12:08:08 volumio volumio[989]: info: Preparing to generate the ALSA configuration file Apr 18 12:08:08 volumio sudo[1282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/moveallprocesses.sh Apr 18 12:08:08 volumio sudo[1282]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 12:08:08 volumio volumio[989]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 18 12:08:08 volumio volumio[989]: info: Reading ALSA contributions from plugins. Apr 18 12:08:08 volumio volumio[989]: info: MPD Permissions set Apr 18 12:08:08 volumio volumio[989]: info: MPD Permissions set Apr 18 12:08:08 volumio volumio-remote-updater[649]: [2025-04-18 12:08:08] [connect] Successful connection Apr 18 12:08:08 volumio volumio[989]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Apr 18 12:08:08 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:08 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:08 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:08 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:08 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:08 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:08 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:08 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:08 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 18 12:08:08 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:08 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:08 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:08 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:08 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:08 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:08 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:08 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:08 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:08 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 18 12:08:08 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:08 volumio volumio-remote-updater[649]: [2025-04-18 12:08:08] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1744945688 101 Apr 18 12:08:08 volumio volumio[989]: 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 Apr 18 12:08:09 volumio volumio[989]: info: Volumio called home Apr 18 12:08:09 volumio volumio[989]: info: Starting Shairport Sync Apr 18 12:08:09 volumio volumio[989]: info: Starting Shairport Sync Apr 18 12:08:09 volumio volumio[989]: info: Starting Shairport Sync Apr 18 12:08:09 volumio sudo[1309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 18 12:08:09 volumio sudo[1309]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 12:08:09 volumio sudo[1311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 18 12:08:09 volumio sudo[1311]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 12:08:09 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 18 12:08:09 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 18 12:08:09 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 18 12:08:09 volumio sudo[1316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 18 12:08:09 volumio volumio[989]: info: CoreCommandRouter::volumioGetState Apr 18 12:08:09 volumio volumio[989]: info: CorePlayQueue::getTrack 0 Apr 18 12:08:09 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 18 12:08:09 volumio sudo[1316]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 12:08:09 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 18 12:08:09 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Apr 18 12:08:09 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 18 12:08:09 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 18 12:08:09 volumio sudo[1311]: pam_unix(sudo:session): session closed for user root Apr 18 12:08:09 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 18 12:08:09 volumio volumio[989]: info: Asound.conf file unchanged, so no further update is needed Apr 18 12:08:09 volumio volumio[989]: info: Output device has changed, restarting MPD Apr 18 12:08:09 volumio sudo[1316]: pam_unix(sudo:session): session closed for user root Apr 18 12:08:09 volumio sudo[1309]: pam_unix(sudo:session): session closed for user root Apr 18 12:08:09 volumio sudo[1282]: pam_unix(sudo:session): session closed for user root Apr 18 12:08:09 volumio sudo[1321]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 18 12:08:09 volumio sudo[1321]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 12:08:09 volumio sudo[1321]: pam_unix(sudo:session): session closed for user root Apr 18 12:08:09 volumio volumio[989]: info: Output device has changed, restarting Shairport Sync Apr 18 12:08:09 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:09 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 18 12:08:09 volumio sudo[1326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 18 12:08:09 volumio sudo[1326]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 12:08:09 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 18 12:08:09 volumio systemd[1]: mpd.service: Succeeded. Apr 18 12:08:09 volumio systemd[1]: Stopped Music Player Daemon. Apr 18 12:08:09 volumio volumio[989]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 18 12:08:09 volumio volumio[989]: info: Shairport-Sync Started Apr 18 12:08:09 volumio volumio[989]: Error adding Membership: Error: addMembership EINVAL Apr 18 12:08:09 volumio volumio[989]: info: MPD Permissions set Apr 18 12:08:09 volumio volumio[989]: info: Shairport-Sync Started Apr 18 12:08:09 volumio systemd[1]: Starting Music Player Daemon... Apr 18 12:08:09 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:09 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:09 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:09 volumio sudo[1331]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 18 12:08:09 volumio sudo[1331]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 12:08:09 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 18 12:08:09 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:09 volumio sudo[1331]: pam_unix(sudo:session): session closed for user root Apr 18 12:08:09 volumio volumio[989]: info: Starting Shairport Sync Apr 18 12:08:09 volumio sudo[1334]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/data/plugins/system_hardware/music_services_shield/addservice.sh Apr 18 12:08:09 volumio sudo[1334]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 12:08:09 volumio sudo[1344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 18 12:08:09 volumio sudo[1344]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 12:08:09 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 18 12:08:09 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 18 12:08:09 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 18 12:08:09 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 18 12:08:09 volumio sudo[1344]: pam_unix(sudo:session): session closed for user root Apr 18 12:08:10 volumio volumio[989]: info: camilladsp service started and running in background, instance 1 Apr 18 12:08:10 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 18 12:08:10 volumio volumio[989]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Apr 18 12:08:10 volumio volumio[989]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Apr 18 12:08:10 volumio volumio[989]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Apr 18 12:08:10 volumio volumio[989]: info: FusionDsp loaded Apr 18 12:08:10 volumio volumio[989]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 18 12:08:10 volumio sudo[1361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Apr 18 12:08:10 volumio sudo[1361]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 18 12:08:10 volumio volumio[989]: info: FusionDsp - Reporting Fusion DSP Enabled Apr 18 12:08:10 volumio volumio[989]: info: Adding Signal Path Element [object Object] Apr 18 12:08:10 volumio volumio[989]: info: Adding fusiondspeq DSP Signal Path Element Apr 18 12:08:10 volumio volumio[989]: info: FusionDsp - ---- installed callbackRead Apr 18 12:08:10 volumio volumio[989]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 18 12:08:10 volumio volumio[989]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Apr 18 12:08:10 volumio volumio[989]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Apr 18 12:08:10 volumio volumio[989]: at onErrorNT (internal/child_process.js:465:16) Apr 18 12:08:10 volumio volumio[989]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Apr 18 12:08:10 volumio volumio[989]: at runNextTicks (internal/process/task_queues.js:62:3) Apr 18 12:08:10 volumio volumio[989]: at listOnTimeout (internal/timers.js:523:9) Apr 18 12:08:10 volumio volumio[989]: at processTimers (internal/timers.js:497:7) { Apr 18 12:08:10 volumio volumio[989]: errno: -2, Apr 18 12:08:10 volumio volumio[989]: code: 'ENOENT', Apr 18 12:08:10 volumio volumio[989]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Apr 18 12:08:10 volumio volumio[989]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Apr 18 12:08:10 volumio volumio[989]: spawnargs: [ Apr 18 12:08:10 volumio volumio[989]: '-p', Apr 18 12:08:10 volumio volumio[989]: 9876, Apr 18 12:08:10 volumio volumio[989]: '-o', Apr 18 12:08:10 volumio volumio[989]: '/tmp/camilladsp.log', Apr 18 12:08:10 volumio volumio[989]: '-l', Apr 18 12:08:10 volumio volumio[989]: 'warn', Apr 18 12:08:10 volumio volumio[989]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Apr 18 12:08:10 volumio volumio[989]: ] Apr 18 12:08:10 volumio volumio[989]: } Apr 18 12:08:10 volumio volumio[989]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 18 12:08:10 volumio systemd[1]: Started FusionDsp Daemon. Apr 18 12:08:10 volumio sudo[1361]: pam_unix(sudo:session): session closed for user root Apr 18 12:08:10 volumio volumio[1205]: ................++++ Apr 18 12:08:10 volumio volumio[1205]: e is 65537 (0x010001) Apr 18 12:08:10 volumio volumio[1205]: writing RSA key Apr 18 12:08:11 volumio sudo[1391]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-18 12:07 Apr 18 12:08:11 volumio sudo[1391]: 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="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 06:54:47 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="436f3f84f6d0b4ffc344f0bc132a32e8"