-- Logs begin at Tue 2024-02-27 04:52:17 CET, end at Mon 2024-04-29 20:41:37 CEST. -- Apr 29 20:40:03 volumio volumio-remote-updater[294]: [2024-04-29 20:40:03] [connect] Successful connection Apr 29 20:40:05 volumio systemd[1]: apt-daily.service: Succeeded. Apr 29 20:40:05 volumio systemd[1]: Started Daily apt download activities. Apr 29 20:40:05 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Apr 29 20:40:07 volumio volumio[436]: info: ------------------------------------------- Apr 29 20:40:07 volumio volumio[436]: info: ----- Volumio3 ---- Apr 29 20:40:07 volumio volumio[436]: info: ------------------------------------------- Apr 29 20:40:07 volumio volumio[436]: info: ----- System startup ---- Apr 29 20:40:07 volumio volumio[436]: info: ------------------------------------------- Apr 29 20:40:18 volumio volumio-remote-updater[294]: [2024-04-29 20:40:18] [connect] Successful connection Apr 29 20:40:19 volumio volumio[436]: info: MYVOLUMIO Environment detected Apr 29 20:40:20 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Apr 29 20:40:20 volumio systemd[1]: Started Daily apt upgrade and clean activities. Apr 29 20:40:20 volumio systemd[1]: Startup finished in 13.741s (kernel) + 1min 37.817s (userspace) = 1min 51.559s. Apr 29 20:40:20 volumio volumio[436]: info: Plugin folders cleanup Apr 29 20:40:20 volumio volumio[436]: info: Scanning into folder /volumio/app/plugins/ Apr 29 20:40:20 volumio volumio[436]: info: Scanning category audio_interface Apr 29 20:40:20 volumio volumio[436]: info: Scanning category miscellanea Apr 29 20:40:20 volumio volumio[436]: info: Scanning category music_service Apr 29 20:40:20 volumio volumio[436]: info: Scanning category plugins.json Apr 29 20:40:20 volumio volumio[436]: info: Scanning category system_controller Apr 29 20:40:20 volumio volumio[436]: info: Scanning category user_interface Apr 29 20:40:20 volumio volumio[436]: info: Scanning into folder /data/plugins/ Apr 29 20:40:20 volumio volumio[436]: info: Scanning category audio_interface Apr 29 20:40:20 volumio volumio[436]: info: Plugin folders cleanup completed Apr 29 20:40:20 volumio volumio[436]: info: ------------------------------------------- Apr 29 20:40:20 volumio volumio[436]: info: ----- Core plugins startup ---- Apr 29 20:40:20 volumio volumio[436]: info: ------------------------------------------- Apr 29 20:40:20 volumio volumio[436]: info: Loading plugins from folder /volumio/app/plugins/ Apr 29 20:40:20 volumio volumio[436]: info: Adding plugin upnp to MyMusic Plugins Apr 29 20:40:20 volumio volumio[436]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 29 20:40:20 volumio volumio[436]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 29 20:40:20 volumio volumio[436]: info: Loading plugins from folder /data/plugins/ Apr 29 20:40:20 volumio volumio[436]: info: Loading plugin "system"... Apr 29 20:40:20 volumio volumio[436]: info: Loading plugin "appearance"... Apr 29 20:40:28 volumio volumio[436]: info: Loading plugin "network"... Apr 29 20:40:28 volumio volumio[436]: info: Refreshing Cached IP Addresses Apr 29 20:40:28 volumio volumio[436]: info: Loading plugin "services"... Apr 29 20:40:28 volumio volumio[436]: info: Loading plugin "alsa_controller"... Apr 29 20:40:28 volumio sudo[908]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 29 20:40:28 volumio sudo[910]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 29 20:40:28 volumio sudo[910]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 20:40:28 volumio sudo[912]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Apr 29 20:40:28 volumio sudo[908]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 20:40:28 volumio sudo[912]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 20:40:29 volumio sudo[908]: pam_unix(sudo:session): session closed for user root Apr 29 20:40:29 volumio sudo[910]: pam_unix(sudo:session): session closed for user root Apr 29 20:40:29 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 29 20:40:29 volumio volumio[436]: info: Loading plugin "wizard"... Apr 29 20:40:29 volumio volumio[436]: info: Loading plugin "networkfs"... Apr 29 20:40:29 volumio volumio[436]: info: Starting Udev Watcher for removable devices Apr 29 20:40:29 volumio sudo[919]: 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.1/WD(d795)/Music /mnt/NAS/Music_NAS Apr 29 20:40:29 volumio sudo[919]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 20:40:30 volumio volumio[436]: info: Ignoring mount for partition: boot Apr 29 20:40:30 volumio volumio[436]: info: Ignoring mount for partition: volumio Apr 29 20:40:30 volumio volumio[436]: info: Ignoring mount for partition: volumio_data Apr 29 20:40:30 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 29 20:40:30 volumio volumio[436]: info: Loading plugin "volumio_command_line_client"... Apr 29 20:40:30 volumio volumio[436]: info: Loading plugin "upnp"... Apr 29 20:40:30 volumio volumio[436]: info: [1714416030350] Starting Upmpd Daemon Apr 29 20:40:30 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 29 20:40:30 volumio volumio[436]: info: Loading plugin "my_music"... Apr 29 20:40:30 volumio volumio[436]: info: Loading plugin "mpd"... Apr 29 20:40:31 volumio kernel: Key type cifs.spnego registered Apr 29 20:40:31 volumio kernel: Key type cifs.idmap registered Apr 29 20:40:31 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 29 20:40:31 volumio kernel: CIFS: Attempting to mount \\192.168.1.1\WD(d795) Apr 29 20:40:32 volumio kernel: CIFS: VFS: \\192.168.1.1\WD(d795) error -9 on ioctl to get interface list Apr 29 20:40:32 volumio sudo[919]: pam_unix(sudo:session): session closed for user root Apr 29 20:40:33 volumio volumio-remote-updater[294]: [2024-04-29 20:40:33] [connect] Successful connection Apr 29 20:40:33 volumio volumio[436]: info: Loading plugin "upnp_browser"... Apr 29 20:40:34 volumio sudo[912]: pam_unix(sudo:session): session closed for user root Apr 29 20:40:36 volumio volumio[436]: info: Loading plugin "alarm-clock"... Apr 29 20:40:38 volumio volumio[436]: info: Loading plugin "airplay_emulation"... Apr 29 20:40:38 volumio volumio[436]: info: Starting Shairport Sync Apr 29 20:40:38 volumio volumio[436]: info: Loading plugin "last_100"... Apr 29 20:40:38 volumio volumio[436]: info: Loading plugin "webradio"... Apr 29 20:40:39 volumio volumio[436]: info: Loading plugin "i2s_dacs"... Apr 29 20:40:39 volumio volumio[436]: info: Loading plugin "volumiodiscovery"... Apr 29 20:40:39 volumio volumio[436]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 29 20:40:39 volumio node[436]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 29 20:40:39 volumio volumio[436]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 29 20:40:39 volumio node[436]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 29 20:40:39 volumio volumio[436]: *** WARNING *** For more information see Apr 29 20:40:39 volumio volumio[436]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 29 20:40:39 volumio volumio[436]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 29 20:40:39 volumio volumio[436]: *** WARNING *** For more information see Apr 29 20:40:39 volumio node[436]: *** WARNING *** For more information see Apr 29 20:40:39 volumio node[436]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 29 20:40:39 volumio node[436]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 29 20:40:39 volumio node[436]: *** WARNING *** For more information see Apr 29 20:40:39 volumio volumio[436]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 29 20:40:39 volumio volumio[436]: info: Discovery: Started advertising with name: Volumio Apr 29 20:40:39 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 29 20:40:39 volumio volumio[436]: info: Loading plugin "outputs"... Apr 29 20:40:40 volumio volumio[436]: info: Loading plugin "albumart"... Apr 29 20:40:40 volumio volumio[436]: info: Plugin example_plugin is not enabled Apr 29 20:40:40 volumio volumio[436]: info: Loading plugin "inputs"... Apr 29 20:40:40 volumio volumio[436]: info: Loading plugin "updater_comm"... Apr 29 20:40:42 volumio volumio[436]: info: Plugin mpdemulation is not enabled Apr 29 20:40:42 volumio volumio[436]: info: Loading plugin "rest_api"... Apr 29 20:40:42 volumio volumio[436]: info: Loading plugin "websocket"... Apr 29 20:40:42 volumio volumio[436]: info: Loading plugin "fusiondsp"... Apr 29 20:40:44 volumio volumio[436]: Forking 1 albumart workers Apr 29 20:40:47 volumio volumio[436]: info: Applying required configuration parameters for plugin fusiondsp Apr 29 20:40:48 volumio volumio-remote-updater[294]: [2024-04-29 20:40:48] [connect] Successful connection Apr 29 20:40:48 volumio volumio[436]: info: Loading i18n strings for locale ru Apr 29 20:40:49 volumio volumio[436]: Updating browse sources language Apr 29 20:40:49 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 20:40:52 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 20:40:52 volumio volumio[436]: info: CoreCommandRouter::initPlayerControls Apr 29 20:40:52 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:40:52 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:40:52 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:40:52 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:40:52 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:40:52 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:40:52 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:40:52 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:40:52 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 20:40:52 volumio volumio[436]: Express server listening on port 3000 Apr 29 20:40:52 volumio volumio[436]: [Metrics] WebUI: 54s 39.82ms Apr 29 20:40:52 volumio volumio[436]: info: CoreStateMachine::resetVolumioState Apr 29 20:40:52 volumio volumio[436]: info: CoreStateMachine::getcurrentVolume Apr 29 20:40:52 volumio volumio[436]: info: CoreCommandRouter::volumioRetrievevolume Apr 29 20:40:53 volumio sudo[979]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 29 20:40:53 volumio sudo[979]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 20:40:53 volumio sudo[981]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 29 20:40:53 volumio sudo[981]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 20:40:53 volumio sudo[979]: pam_unix(sudo:session): session closed for user root Apr 29 20:40:53 volumio sudo[981]: pam_unix(sudo:session): session closed for user root Apr 29 20:40:55 volumio volumio[436]: Starting albumart workers Apr 29 20:40:56 volumio volumio[436]: info: CoreStateMachine::pushState Apr 29 20:40:56 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:40:56 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 20:40:56 volumio volumio[436]: info: CoreCommandRouter::volumioPushState Apr 29 20:40:56 volumio volumio[436]: info: CoreStateMachine::updateTrackBlock Apr 29 20:40:56 volumio volumio[436]: info: CorePlayQueue::getTrackBlock Apr 29 20:40:56 volumio volumio[436]: info: CoreCommandRouter::volumioRetrievevolume Apr 29 20:40:57 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 20:40:57 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 20:40:57 volumio volumio[436]: info: Discovery: Getting this device information Apr 29 20:40:57 volumio volumio[436]: info: CoreCommandRouter::volumioGetState Apr 29 20:40:57 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:40:57 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 20:40:57 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 20:40:57 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 20:40:57 volumio volumio[436]: info: Discovery: Getting this device information Apr 29 20:40:57 volumio volumio[436]: info: CoreCommandRouter::volumioGetState Apr 29 20:40:57 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:40:57 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 20:40:57 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 20:40:57 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 20:40:57 volumio volumio[436]: info: Discovery: Getting this device information Apr 29 20:40:57 volumio volumio[436]: info: CoreCommandRouter::volumioGetState Apr 29 20:40:57 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:40:57 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 20:40:57 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 20:40:57 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 20:40:57 volumio volumio[436]: info: Discovery: Getting this device information Apr 29 20:40:57 volumio volumio[436]: info: CoreCommandRouter::volumioGetState Apr 29 20:40:57 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:40:57 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 20:40:57 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 20:40:57 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 20:40:57 volumio volumio[436]: info: Discovery: Getting this device information Apr 29 20:40:57 volumio volumio[436]: info: CoreCommandRouter::volumioGetState Apr 29 20:40:57 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:40:57 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 20:40:58 volumio volumio[436]: info: Discovery: Getting this device information Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::volumioGetState Apr 29 20:40:58 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 20:40:58 volumio volumio[436]: info: Discovery: Getting this device information Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::volumioGetState Apr 29 20:40:58 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 20:40:58 volumio volumio[436]: info: Discovery: Getting this device information Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::volumioGetState Apr 29 20:40:58 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 20:40:58 volumio volumio[436]: info: Discovery: Getting this device information Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::volumioGetState Apr 29 20:40:58 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 20:40:58 volumio volumio[436]: info: Discovery: Getting this device information Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::volumioGetState Apr 29 20:40:58 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 20:40:58 volumio volumio[436]: info: Discovery: Getting this device information Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::volumioGetState Apr 29 20:40:58 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 20:40:58 volumio volumio[436]: info: Discovery: Getting this device information Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::volumioGetState Apr 29 20:40:58 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 20:40:58 volumio volumio[436]: info: Discovery: Getting this device information Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::volumioGetState Apr 29 20:40:58 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 20:40:58 volumio volumio[436]: info: Discovery: Getting this device information Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::volumioGetState Apr 29 20:40:58 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 20:40:58 volumio volumio[436]: info: Discovery: Getting this device information Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::volumioGetState Apr 29 20:40:58 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 20:40:58 volumio volumio[436]: info: Discovery: Getting this device information Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::volumioGetState Apr 29 20:40:58 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 20:40:58 volumio volumio[436]: info: Discovery: Getting this device information Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::volumioGetState Apr 29 20:40:58 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 20:40:58 volumio volumio[436]: info: Discovery: Getting this device information Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::volumioGetState Apr 29 20:40:58 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:40:58 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 20:40:59 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 20:40:59 volumio volumio[436]: info: Reloading queue from file Apr 29 20:40:59 volumio volumio[436]: info: CoreStateMachine::pushState Apr 29 20:40:59 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:40:59 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 29 20:40:59 volumio volumio[436]: info: CoreCommandRouter::volumioPushState Apr 29 20:40:59 volumio volumio[436]: info: CoreStateMachine::setRepeat null single undefined Apr 29 20:40:59 volumio volumio[436]: info: CoreStateMachine::pushState Apr 29 20:40:59 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:40:59 volumio volumio[436]: info: CoreCommandRouter::volumioPushState Apr 29 20:40:59 volumio volumio[436]: info: CoreStateMachine::setRandom null Apr 29 20:40:59 volumio volumio[436]: info: CoreStateMachine::pushState Apr 29 20:40:59 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:40:59 volumio volumio[436]: info: CoreCommandRouter::volumioPushState Apr 29 20:41:00 volumio volumio[436]: info: Setting Device type: Raspberry PI Apr 29 20:41:00 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 20:41:00 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 20:41:00 volumio volumio[436]: info: Discovery: Getting this device information Apr 29 20:41:00 volumio volumio[436]: info: CoreCommandRouter::volumioGetState Apr 29 20:41:00 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:41:00 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 20:41:00 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 29 20:41:00 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 29 20:41:00 volumio volumio[436]: info: Discovery: Getting this device information Apr 29 20:41:00 volumio volumio[436]: info: CoreCommandRouter::volumioGetState Apr 29 20:41:00 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:41:00 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 20:41:00 volumio sudo[997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 29 20:41:00 volumio sudo[997]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 20:41:00 volumio volumio[436]: verbose: New Socket.io Connection to 192.168.1.107 from 192.168.1.206 UA: unknown Total Clients: 1 Apr 29 20:41:01 volumio volumio[436]: verbose: New Socket.io Connection to 192.168.1.108 from 192.168.1.206 UA: unknown Total Clients: 2 Apr 29 20:41:01 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Apr 29 20:41:01 volumio sudo[997]: pam_unix(sudo:session): session closed for user root Apr 29 20:41:01 volumio volumio[436]: info: Discovery: adding d58dbe95-e4fe-4a0f-9d2f-8f29d8117de6 Apr 29 20:41:01 volumio volumio[436]: info: Discovery: Found device Volumio Apr 29 20:41:01 volumio volumio[436]: info: CoreCommandRouter::volumioGetState Apr 29 20:41:01 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:41:01 volumio volumio[436]: info: Discovery: this is already registered, d58dbe95-e4fe-4a0f-9d2f-8f29d8117de6 Apr 29 20:41:01 volumio volumio[436]: info: Discovery: Found device Volumio Apr 29 20:41:01 volumio volumio[436]: info: CoreCommandRouter::volumioGetState Apr 29 20:41:01 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:41:02 volumio volumio[436]: info: CoreCommandRouter::volumioGetState Apr 29 20:41:02 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:41:02 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 29 20:41:02 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 29 20:41:02 volumio volumio[436]: info: CoreCommandRouter::volumioGetState Apr 29 20:41:02 volumio volumio[436]: info: CorePlayQueue::getTrack 0 Apr 29 20:41:02 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 29 20:41:02 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 29 20:41:02 volumio volumio[436]: info: Upmpdcli Daemon Started Apr 29 20:41:02 volumio volumio[436]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Apr 29 20:41:03 volumio volumio-remote-updater[294]: [2024-04-29 20:41:03] [connect] Successful connection Apr 29 20:41:03 volumio volumio-remote-updater[294]: [2024-04-29 20:41:03] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1714416063 101 Apr 29 20:41:03 volumio volumio[436]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 3 Apr 29 20:41:05 volumio volumio[436]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Apr 29 20:41:11 volumio volumio[436]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Apr 29 20:41:18 volumio volumio[436]: error: Plugin system_controller system failed to complete 'onVolumioStart' in a timely fashion Apr 29 20:41:18 volumio volumio[436]: info: Preparing to generate the ALSA configuration file Apr 29 20:41:18 volumio volumio[436]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Apr 29 20:41:18 volumio volumio[436]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 29 20:41:18 volumio volumio[436]: info: Reading ALSA contributions from plugins. Apr 29 20:41:18 volumio volumio[436]: info: Asound.conf file unchanged, so no further update is needed Apr 29 20:41:18 volumio volumio[436]: info: Output device has changed, restarting MPD Apr 29 20:41:19 volumio volumio[436]: info: Output device has changed, restarting Shairport Sync Apr 29 20:41:19 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:41:19 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 20:41:19 volumio sudo[1044]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 29 20:41:19 volumio sudo[1044]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 20:41:19 volumio sudo[1044]: pam_unix(sudo:session): session closed for user root Apr 29 20:41:19 volumio sudo[1046]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 29 20:41:19 volumio sudo[1046]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 20:41:19 volumio systemd[1]: Listening on mpd.socket. Apr 29 20:41:19 volumio volumio[436]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 29 20:41:19 volumio systemd[1]: Starting Music Player Daemon... Apr 29 20:41:19 volumio volumio[436]: info: ___________ START PLUGINS ___________ Apr 29 20:41:19 volumio volumio[436]: info: ControllerMpd::onStart: Initializing MPD Apr 29 20:41:19 volumio volumio[436]: info: Creating MPD Configuration file Apr 29 20:41:20 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 29 20:41:20 volumio volumio[436]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 29 20:41:20 volumio volumio[436]: info: [1714416080421] CoreMusicLibrary::Adding element Медиа-серверы Apr 29 20:41:20 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 20:41:20 volumio sudo[1055]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 29 20:41:20 volumio sudo[1055]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 20:41:20 volumio sudo[1055]: pam_unix(sudo:session): session closed for user root Apr 29 20:41:20 volumio sudo[1057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 29 20:41:20 volumio sudo[1057]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 20:41:21 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:41:21 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 20:41:21 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 29 20:41:21 volumio systemd[1]: mpd.service: Succeeded. Apr 29 20:41:21 volumio systemd[1]: Stopped Music Player Daemon. Apr 29 20:41:21 volumio systemd[1]: Starting Music Player Daemon... Apr 29 20:41:21 volumio volumio[436]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 29 20:41:21 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:41:21 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 29 20:41:22 volumio volumio[436]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 29 20:41:22 volumio volumio[436]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 29 20:41:22 volumio volumio[436]: info: [1714416082176] CoreMusicLibrary::Adding element Last_100 Apr 29 20:41:22 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 20:41:22 volumio volumio[436]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 29 20:41:22 volumio volumio[436]: info: [1714416082227] CoreMusicLibrary::Adding element Webradio Apr 29 20:41:22 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 29 20:41:22 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 29 20:41:22 volumio volumio[436]: info: Loading i18n strings for locale ru Apr 29 20:41:22 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Apr 29 20:41:22 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:41:22 volumio volumio[436]: info: FusionDsp - mixtype--------------------- Software Apr 29 20:41:22 volumio volumio[436]: info: Volumio Calling Home Apr 29 20:41:24 volumio volumio[436]: info: Preparing to generate the ALSA configuration file Apr 29 20:41:25 volumio volumio[436]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Apr 29 20:41:25 volumio volumio[436]: info: camilladsp service started and running in background, instance 1 Apr 29 20:41:25 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 29 20:41:25 volumio volumio[436]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Apr 29 20:41:25 volumio volumio[436]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Apr 29 20:41:25 volumio volumio[436]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Apr 29 20:41:25 volumio volumio[436]: info: FusionDsp loaded Apr 29 20:41:25 volumio volumio[436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 29 20:41:26 volumio sudo[1080]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Apr 29 20:41:26 volumio sudo[1080]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 29 20:41:26 volumio volumio[436]: info: FusionDsp - Reporting Fusion DSP Enabled Apr 29 20:41:26 volumio volumio[436]: info: Adding Signal Path Element [object Object] Apr 29 20:41:26 volumio volumio[436]: info: Adding fusiondspeq DSP Signal Path Element Apr 29 20:41:26 volumio volumio[436]: info: FusionDsp - ---- installed callbackRead Apr 29 20:41:26 volumio volumio[436]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 29 20:41:26 volumio systemd[1]: Started FusionDsp Daemon. Apr 29 20:41:26 volumio sudo[1080]: pam_unix(sudo:session): session closed for user root Apr 29 20:41:26 volumio volumio[436]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Apr 29 20:41:26 volumio volumio[436]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Apr 29 20:41:26 volumio volumio[436]: at onErrorNT (internal/child_process.js:465:16) Apr 29 20:41:26 volumio volumio[436]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Apr 29 20:41:26 volumio volumio[436]: at runNextTicks (internal/process/task_queues.js:62:3) Apr 29 20:41:26 volumio volumio[436]: at listOnTimeout (internal/timers.js:523:9) Apr 29 20:41:26 volumio volumio[436]: at processTimers (internal/timers.js:497:7) { Apr 29 20:41:26 volumio volumio[436]: errno: -2, Apr 29 20:41:26 volumio volumio[436]: code: 'ENOENT', Apr 29 20:41:26 volumio volumio[436]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Apr 29 20:41:26 volumio volumio[436]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Apr 29 20:41:26 volumio volumio[436]: spawnargs: [ Apr 29 20:41:26 volumio volumio[436]: '-p', Apr 29 20:41:26 volumio volumio[436]: 9876, Apr 29 20:41:26 volumio volumio[436]: '-o', Apr 29 20:41:26 volumio volumio[436]: '/tmp/camilladsp.log', Apr 29 20:41:26 volumio volumio[436]: '-l', Apr 29 20:41:26 volumio volumio[436]: 'warn', Apr 29 20:41:26 volumio volumio[436]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Apr 29 20:41:26 volumio volumio[436]: ] Apr 29 20:41:26 volumio volumio[436]: } Apr 29 20:41:26 volumio volumio[436]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 29 20:41:37 volumio sudo[1092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-29 20:40 Apr 29 20:41:37 volumio sudo[1092]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"