-- Logs begin at Fri 2025-01-17 08:09:56 MST, end at Fri 2025-01-17 08:38:05 MST. -- Jan 17 08:37:44 volumio systemd-timedated[914]: Changed local time to Fri Jan 17 08:37:44 2025 Jan 17 08:37:44 volumio sudo[887]: pam_unix(sudo:session): session closed for user root Jan 17 08:37:44 volumio volumio-time-update[567]: volumio-time-update-util: System time updated successfully. Jan 17 08:37:44 volumio systemd[1]: Started Volumio Time Update Utility. Jan 17 08:37:44 volumio mpd[820]: Jan 17 08:37 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 17 08:37:44 volumio winbindd[904]: [2025/01/17 08:37:44.328817, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Jan 17 08:37:44 volumio winbindd[904]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Jan 17 08:37:45 volumio systemd[1]: Started Music Player Daemon. Jan 17 08:37:45 volumio mpd_monitor.sh[571]: MPD restarted due to no mpc output. Jan 17 08:37:45 volumio nmbd[768]: [2025/01/17 08:37:45.628412, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Jan 17 08:37:45 volumio nmbd[768]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.127 for name WORKGROUP<1d>. Jan 17 08:37:45 volumio nmbd[768]: This response was from IP 192.168.1.117, reporting an IP address of 192.168.1.117. Jan 17 08:37:45 volumio winbindd[904]: [2025/01/17 08:37:45.632547, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jan 17 08:37:45 volumio systemd[1]: Started Samba Winbind Daemon. Jan 17 08:37:45 volumio winbindd[904]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Jan 17 08:37:45 volumio systemd[1]: Starting Samba SMB Daemon... Jan 17 08:37:46 volumio smbd[927]: [2025/01/17 08:37:46.233485, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jan 17 08:37:46 volumio smbd[927]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Jan 17 08:37:46 volumio systemd[1]: Started Samba SMB Daemon. Jan 17 08:37:46 volumio systemd[1]: Reached target Multi-User System. Jan 17 08:37:46 volumio systemd[1]: Reached target Graphical Interface. Jan 17 08:37:46 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Jan 17 08:37:46 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jan 17 08:37:46 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Jan 17 08:37:46 volumio systemd[1]: Startup finished in 26.990s (kernel) + 18.499s (userspace) = 45.489s. Jan 17 08:37:48 volumio volumio-remote-updater[568]: [2025-01-17 08:37:48] [info] asio async_connect error: system:111 (Connection refused) Jan 17 08:37:48 volumio volumio-remote-updater[568]: [2025-01-17 08:37:48] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jan 17 08:37:48 volumio volumio-remote-updater[568]: [2025-01-17 08:37:48] [error] handle_connect error: Underlying Transport Error Jan 17 08:37:50 volumio volumio[841]: info: ------------------------------------------- Jan 17 08:37:50 volumio volumio[841]: info: ----- Volumio3 ---- Jan 17 08:37:50 volumio volumio[841]: info: ------------------------------------------- Jan 17 08:37:50 volumio volumio[841]: info: ----- System startup ---- Jan 17 08:37:50 volumio volumio[841]: info: ------------------------------------------- Jan 17 08:37:51 volumio volumio[841]: info: MYVOLUMIO Environment detected Jan 17 08:37:51 volumio volumio[841]: info: Plugin folders cleanup Jan 17 08:37:51 volumio volumio[841]: info: Scanning into folder /volumio/app/plugins/ Jan 17 08:37:51 volumio volumio[841]: info: Scanning category audio_interface Jan 17 08:37:51 volumio volumio[841]: info: Scanning category miscellanea Jan 17 08:37:51 volumio volumio[841]: info: Scanning category music_service Jan 17 08:37:51 volumio volumio[841]: info: Scanning category plugins.json Jan 17 08:37:51 volumio volumio[841]: info: Scanning category system_controller Jan 17 08:37:51 volumio volumio[841]: info: Scanning category user_interface Jan 17 08:37:51 volumio volumio[841]: info: Scanning into folder /data/plugins/ Jan 17 08:37:51 volumio volumio[841]: info: Scanning category audio_interface Jan 17 08:37:51 volumio volumio[841]: info: Scanning category music_service Jan 17 08:37:51 volumio volumio[841]: info: Scanning category system_controller Jan 17 08:37:51 volumio volumio[841]: info: Scanning category system_hardware Jan 17 08:37:51 volumio volumio[841]: info: Scanning category user_interface Jan 17 08:37:51 volumio volumio[841]: info: Plugin folders cleanup completed Jan 17 08:37:51 volumio volumio[841]: info: ------------------------------------------- Jan 17 08:37:51 volumio volumio[841]: info: ----- Core plugins startup ---- Jan 17 08:37:51 volumio volumio[841]: info: ------------------------------------------- Jan 17 08:37:51 volumio volumio[841]: info: Loading plugins from folder /volumio/app/plugins/ Jan 17 08:37:51 volumio volumio[841]: info: Adding plugin upnp to MyMusic Plugins Jan 17 08:37:51 volumio volumio[841]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 17 08:37:51 volumio volumio[841]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 17 08:37:51 volumio volumio[841]: info: Loading plugins from folder /data/plugins/ Jan 17 08:37:51 volumio volumio[841]: info: Loading plugin "system"... Jan 17 08:37:51 volumio volumio[841]: info: Loading plugin "appearance"... Jan 17 08:37:53 volumio volumio[841]: info: Loading plugin "network"... Jan 17 08:37:53 volumio volumio[841]: info: Refreshing Cached IP Addresses Jan 17 08:37:53 volumio sudo[950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 17 08:37:53 volumio sudo[950]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 08:37:53 volumio volumio[841]: info: Loading plugin "services"... Jan 17 08:37:53 volumio sudo[950]: pam_unix(sudo:session): session closed for user root Jan 17 08:37:53 volumio volumio[841]: info: Loading plugin "alsa_controller"... Jan 17 08:37:53 volumio sudo[952]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 17 08:37:53 volumio sudo[952]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 08:37:53 volumio sudo[952]: pam_unix(sudo:session): session closed for user root Jan 17 08:37:53 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 08:37:53 volumio volumio[841]: info: Loading plugin "wizard"... Jan 17 08:37:53 volumio volumio[841]: info: Loading plugin "networkfs"... Jan 17 08:37:53 volumio volumio[841]: info: Starting Udev Watcher for removable devices Jan 17 08:37:53 volumio sudo[973]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=jim,password=cheese,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.152/data/usenet/complete/music /mnt/NAS/TrueNas Jan 17 08:37:53 volumio sudo[973]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 08:37:53 volumio volumio[841]: info: Ignoring mount for partition: boot Jan 17 08:37:53 volumio volumio[841]: info: Ignoring mount for partition: volumio Jan 17 08:37:53 volumio volumio[841]: info: Ignoring mount for partition: volumio_data Jan 17 08:37:53 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 08:37:53 volumio volumio[841]: info: Loading plugin "volumio_command_line_client"... Jan 17 08:37:53 volumio volumio[841]: info: Loading plugin "upnp"... Jan 17 08:37:53 volumio volumio[841]: info: [1737128273919] Starting Upmpd Daemon Jan 17 08:37:53 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 08:37:53 volumio volumio[841]: info: Loading plugin "my_music"... Jan 17 08:37:53 volumio volumio[841]: info: Loading plugin "mpd"... Jan 17 08:37:54 volumio kernel: Key type cifs.spnego registered Jan 17 08:37:54 volumio kernel: Key type cifs.idmap registered Jan 17 08:37:54 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. Jan 17 08:37:54 volumio kernel: CIFS: Attempting to mount //192.168.1.152/data/usenet/complete/music Jan 17 08:37:54 volumio kernel: cryptd: max_cpu_qlen set to 1000 Jan 17 08:37:54 volumio sudo[973]: pam_unix(sudo:session): session closed for user root Jan 17 08:37:54 volumio volumio[841]: info: Plugin upnp_browser is not enabled Jan 17 08:37:54 volumio volumio[841]: info: Loading plugin "alarm-clock"... Jan 17 08:37:54 volumio volumio[841]: info: Plugin airplay_emulation is not enabled Jan 17 08:37:54 volumio volumio[841]: info: Loading plugin "last_100"... Jan 17 08:37:54 volumio volumio[841]: info: Loading plugin "webradio"... Jan 17 08:37:55 volumio volumio[841]: info: Loading plugin "i2s_dacs"... Jan 17 08:37:55 volumio volumio[841]: info: Loading plugin "volumiodiscovery"... Jan 17 08:37:55 volumio volumio[841]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 17 08:37:55 volumio volumio[841]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 08:37:55 volumio volumio[841]: *** WARNING *** For more information see Jan 17 08:37:55 volumio node[841]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 17 08:37:55 volumio volumio[841]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 17 08:37:55 volumio volumio[841]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 08:37:55 volumio volumio[841]: *** WARNING *** For more information see Jan 17 08:37:55 volumio node[841]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 08:37:55 volumio node[841]: *** WARNING *** For more information see Jan 17 08:37:55 volumio node[841]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 17 08:37:55 volumio node[841]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 08:37:55 volumio node[841]: *** WARNING *** For more information see Jan 17 08:37:55 volumio volumio[841]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 17 08:37:55 volumio volumio[841]: info: Discovery: Started advertising with name: Volumio Jan 17 08:37:55 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 08:37:55 volumio volumio[841]: info: Plugin spop is not enabled Jan 17 08:37:55 volumio volumio[841]: info: Loading plugin "outputs"... Jan 17 08:37:55 volumio volumio[841]: info: Loading plugin "albumart"... Jan 17 08:37:55 volumio volumio[841]: info: Plugin example_plugin is not enabled Jan 17 08:37:55 volumio volumio[841]: info: Loading plugin "inputs"... Jan 17 08:37:55 volumio volumio[841]: info: Loading plugin "updater_comm"... Jan 17 08:37:55 volumio volumio[841]: info: Plugin mpdemulation is not enabled Jan 17 08:37:55 volumio volumio[841]: info: Loading plugin "rest_api"... Jan 17 08:37:55 volumio volumio[841]: info: Loading plugin "websocket"... Jan 17 08:37:55 volumio volumio[841]: info: Starting Socket.io Server version 2.3.0 Jan 17 08:37:55 volumio volumio[841]: info: Loading plugin "fusiondsp"... Jan 17 08:37:55 volumio volumio[841]: Forking 3 albumart workers Jan 17 08:37:56 volumio volumio[841]: info: Applying required configuration parameters for plugin fusiondsp Jan 17 08:37:56 volumio volumio[841]: Starting albumart workers Jan 17 08:37:56 volumio volumio[841]: info: Loading plugin "motherearthradio"... Jan 17 08:37:56 volumio volumio[841]: Starting albumart workers Jan 17 08:37:56 volumio volumio[841]: Starting albumart workers Jan 17 08:37:57 volumio volumio[841]: info: Applying required configuration parameters for plugin motherearthradio Jan 17 08:37:57 volumio volumio[841]: info: [1737128277271] [MotherEarth] API delay: 5 Jan 17 08:37:57 volumio volumio[841]: info: Loading plugin "pandora"... Jan 17 08:37:58 volumio volumio-remote-updater[568]: [2025-01-17 08:37:58] [connect] Successful connection Jan 17 08:37:59 volumio volumio[841]: info: Applying required configuration parameters for plugin pandora Jan 17 08:37:59 volumio volumio[841]: info: Loading plugin "radio_paradise"... Jan 17 08:37:59 volumio volumio[841]: info: Applying required configuration parameters for plugin radio_paradise Jan 17 08:37:59 volumio volumio[841]: info: [1737128279644] [RadioParadise] API delay: 5 Jan 17 08:37:59 volumio volumio[841]: info: Loading plugin "backup_restore"... Jan 17 08:38:00 volumio volumio[841]: info: Applying required configuration parameters for plugin backup_restore Jan 17 08:38:00 volumio volumio[841]: info: Loading plugin "ir_controller"... Jan 17 08:38:00 volumio volumio[841]: info: Applying required configuration parameters for plugin ir_controller Jan 17 08:38:00 volumio volumio[841]: info: Loading plugin "peppyspectrum"... Jan 17 08:38:01 volumio volumio[841]: info: Loading plugin "randomizer"... Jan 17 08:38:01 volumio systemd[1]: systemd-fsckd.service: Succeeded. Jan 17 08:38:01 volumio volumio[841]: info: Applying required configuration parameters for plugin randomizer Jan 17 08:38:01 volumio volumio[841]: info: Loading i18n strings for locale en Jan 17 08:38:01 volumio volumio[841]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored. Jan 17 08:38:01 volumio volumio[841]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored. Jan 17 08:38:01 volumio volumio[841]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. Jan 17 08:38:01 volumio volumio[841]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. Jan 17 08:38:01 volumio volumio[841]: Updating browse sources language Jan 17 08:38:01 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::initPlayerControls Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 08:38:02 volumio volumio[841]: Express server listening on port 3000 Jan 17 08:38:02 volumio volumio[841]: [Metrics] WebUI: 12s 577.39ms Jan 17 08:38:02 volumio volumio[841]: info: CoreStateMachine::resetVolumioState Jan 17 08:38:02 volumio volumio[841]: info: CoreStateMachine::getcurrentVolume Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::volumioRetrievevolume Jan 17 08:38:02 volumio volumio[841]: info: CoreStateMachine::pushState Jan 17 08:38:02 volumio volumio[841]: info: CorePlayQueue::getTrack 0 Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::volumioPushState Jan 17 08:38:02 volumio volumio[841]: info: Volumio Network Manager: Network status updated: 1 Jan 17 08:38:02 volumio volumio-remote-updater[568]: [2025-01-17 08:38:02] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1737128278 101 Jan 17 08:38:02 volumio volumio[841]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 08:38:02 volumio volumio[841]: info: Reloading queue from file Jan 17 08:38:02 volumio volumio[841]: info: CoreStateMachine::setRepeat true single undefined Jan 17 08:38:02 volumio volumio[841]: info: CoreStateMachine::pushState Jan 17 08:38:02 volumio volumio[841]: info: CorePlayQueue::getTrack 0 Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::volumioPushState Jan 17 08:38:02 volumio volumio[841]: info: CoreStateMachine::setRandom false Jan 17 08:38:02 volumio volumio[841]: info: CoreStateMachine::pushState Jan 17 08:38:02 volumio volumio[841]: info: CorePlayQueue::getTrack 0 Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::volumioPushState Jan 17 08:38:02 volumio volumio[841]: info: Setting Device type: Raspberry PI Jan 17 08:38:02 volumio volumio[841]: info: Completed loading Core Plugins Jan 17 08:38:02 volumio volumio[841]: info: Preparing to generate the ALSA configuration file Jan 17 08:38:02 volumio volumio[841]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jan 17 08:38:02 volumio volumio[841]: info: USB Boot Capable - System SBC Revision found in cpuinfo: a22082 Jan 17 08:38:02 volumio volumio[841]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jan 17 08:38:02 volumio volumio[841]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 17 08:38:02 volumio volumio[841]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Jan 17 08:38:02 volumio volumio[841]: info: Reading ALSA contributions from plugins. Jan 17 08:38:02 volumio volumio[841]: info: Asound.conf file unchanged, so no further update is needed Jan 17 08:38:02 volumio volumio[841]: info: Output device has changed, restarting MPD Jan 17 08:38:02 volumio volumio[841]: info: ___________ START PLUGINS ___________ Jan 17 08:38:02 volumio sudo[1077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 08:38:02 volumio sudo[1077]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 08:38:02 volumio sudo[1077]: pam_unix(sudo:session): session closed for user root Jan 17 08:38:02 volumio volumio[841]: info: ControllerMpd::onStart: Initializing MPD Jan 17 08:38:02 volumio volumio[841]: info: Creating MPD Configuration file Jan 17 08:38:02 volumio sudo[1079]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 08:38:02 volumio sudo[1079]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 08:38:02 volumio systemd[1]: Stopping Music Player Daemon... Jan 17 08:38:02 volumio sudo[1083]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 08:38:02 volumio sudo[1083]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 08:38:02 volumio sudo[1083]: pam_unix(sudo:session): session closed for user root Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 08:38:02 volumio volumio[841]: info: [1737128282437] CoreMusicLibrary::Adding element Last_100 Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 08:38:02 volumio volumio[841]: info: [1737128282444] CoreMusicLibrary::Adding element Webradio Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 08:38:02 volumio sudo[1086]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 08:38:02 volumio sudo[1086]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 08:38:02 volumio volumio[841]: info: Initializing BBC Radios Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 08:38:02 volumio volumio[841]: info: Loading i18n strings for locale en Jan 17 08:38:02 volumio volumio[841]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored. Jan 17 08:38:02 volumio volumio[841]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored. Jan 17 08:38:02 volumio volumio[841]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. Jan 17 08:38:02 volumio volumio[841]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:02 volumio volumio[841]: info: FusionDsp - mixtype--------------------- None Jan 17 08:38:02 volumio systemd[1]: mpd.service: Succeeded. Jan 17 08:38:02 volumio systemd[1]: Stopped Music Player Daemon. Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 08:38:02 volumio volumio[841]: info: [1737128282627] CoreMusicLibrary::Adding element Mother Earth Radio Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 08:38:02 volumio volumio[841]: Cannot find translation for source Mother Earth Radio Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 08:38:02 volumio volumio[841]: info: [1737128282639] CoreMusicLibrary::Adding element Pandora Radio Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 08:38:02 volumio volumio[841]: Cannot find translation for source Mother Earth Radio Jan 17 08:38:02 volumio volumio[841]: Cannot find translation for source Pandora Radio Jan 17 08:38:02 volumio volumio[841]: info: [1737128282642] ControllerPandora::initializeMQTT Jan 17 08:38:02 volumio volumio[841]: info: [1737128282643] [Pandora] initializeMQTT: MQTT is not enabled in Plugin Configuration Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 08:38:02 volumio volumio[841]: info: [1737128282649] CoreMusicLibrary::Adding element Radio Paradise Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 08:38:02 volumio volumio[841]: Cannot find translation for source Mother Earth Radio Jan 17 08:38:02 volumio volumio[841]: Cannot find translation for source Pandora Radio Jan 17 08:38:02 volumio volumio[841]: Cannot find translation for source Radio Paradise Jan 17 08:38:02 volumio volumio[841]: info: Loading i18n strings for locale en Jan 17 08:38:02 volumio volumio[841]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored. Jan 17 08:38:02 volumio volumio[841]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored. Jan 17 08:38:02 volumio volumio[841]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. Jan 17 08:38:02 volumio volumio[841]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 08:38:02 volumio systemd[1]: Starting Music Player Daemon... Jan 17 08:38:02 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jan 17 08:38:02 volumio volumio[841]: info: Volumio Calling Home Jan 17 08:38:02 volumio sudo[1098]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 17 08:38:02 volumio sudo[1098]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 08:38:02 volumio sudo[1098]: pam_unix(sudo:session): session closed for user root Jan 17 08:38:02 volumio volumio[841]: info: Preparing to generate the ALSA configuration file Jan 17 08:38:02 volumio volumio[841]: info: [1737128282875] ControllerPandora::initialSetup Jan 17 08:38:02 volumio volumio[841]: info: [1737128282880] ControllerPandora::PandoraHandler::init Jan 17 08:38:02 volumio volumio[841]: info: [1737128282881] ControllerPandora::PandoraHandler::loadErrorCodes Jan 17 08:38:03 volumio sudo[1107]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R a+rwX /etc/lirc/irexec.lircrc /etc/lirc/lirc_options.conf /etc/lirc/lircd.conf /etc/lirc/lircd.conf.d /etc/lirc/lircmd.conf /etc/lirc/lircrc Jan 17 08:38:03 volumio volumio[841]: info: [1737128283045] [Pandora] PandoraHandler::setMaxStationTracks: 16 Jan 17 08:38:03 volumio volumio[841]: info: [1737128283047] [Pandora] PandoraHandler::setBandFilter: bandfilter is empty Jan 17 08:38:03 volumio volumio[841]: info: [1737128283048] ControllerPandora::flushPandora Jan 17 08:38:03 volumio sudo[1107]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 08:38:03 volumio volumio[841]: info: CorePlayQueue::getQueue Jan 17 08:38:03 volumio volumio[841]: info: CorePlayQueue::clearAddPlayQueue Jan 17 08:38:03 volumio volumio[841]: info: CorePlayQueue::saveQueue Jan 17 08:38:03 volumio volumio[841]: info: CoreCommandRouter::serviceClearAddPlayTracks Jan 17 08:38:03 volumio volumio[841]: error: WARNING: No clearAddPlayTracks method for service mpd Jan 17 08:38:03 volumio volumio[841]: info: CoreCommandRouter::volumioPushQueue Jan 17 08:38:03 volumio sudo[1107]: pam_unix(sudo:session): session closed for user root Jan 17 08:38:03 volumio volumio[841]: info: [1737128283063] ControllerPandora::validateAndSetAccountOptions Jan 17 08:38:03 volumio volumio[841]: info: [1737128283064] ControllerPandora::PandoraHandler::setAccountOptions Jan 17 08:38:03 volumio volumio[841]: info: [1737128283066] ControllerPandora::flushPandora Jan 17 08:38:03 volumio volumio[841]: info: CorePlayQueue::getQueue Jan 17 08:38:03 volumio volumio[841]: info: CorePlayQueue::clearAddPlayQueue Jan 17 08:38:03 volumio volumio[841]: info: CorePlayQueue::saveQueue Jan 17 08:38:03 volumio volumio[841]: info: CoreCommandRouter::serviceClearAddPlayTracks Jan 17 08:38:03 volumio volumio[841]: error: WARNING: No clearAddPlayTracks method for service mpd Jan 17 08:38:03 volumio volumio[841]: info: CoreCommandRouter::volumioPushQueue Jan 17 08:38:03 volumio volumio[841]: info: [1737128283075] [Pandora] PreventAuthTimeout::init: Timer loaded Jan 17 08:38:03 volumio volumio[841]: info: [1737128283075] [Pandora] PreventAuthTimeout::init: Interval set to 10800000 ms Jan 17 08:38:03 volumio volumio[841]: info: [1737128283076] [Pandora] PreventAuthTimeout::init: Starting delayed timer after next interval Jan 17 08:38:03 volumio volumio[841]: info: [1737128283077] ControllerPandora::PandoraHandler::pandoraLoginAndGetStations Jan 17 08:38:03 volumio volumio[841]: info: Discovery: adding 654c19d1-7cb5-4567-97c8-0dce8e49b7f0 Jan 17 08:38:03 volumio volumio[841]: info: Discovery: Found device Volumio Jan 17 08:38:03 volumio volumio[841]: info: CoreCommandRouter::volumioGetState Jan 17 08:38:03 volumio volumio[841]: info: CorePlayQueue::getTrack 0 Jan 17 08:38:03 volumio volumio[841]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 17 08:38:03 volumio volumio[841]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Jan 17 08:38:03 volumio volumio[841]: info: Reading ALSA contributions from plugins. Jan 17 08:38:03 volumio volumio[841]: info: ir_controller: File permissions successfully set on /etc/lirc/*. Jan 17 08:38:03 volumio volumio[841]: info: MPD Permissions set Jan 17 08:38:03 volumio volumio[841]: info: MPD Permissions set Jan 17 08:38:03 volumio volumio[841]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Jan 17 08:38:03 volumio volumio[841]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jan 17 08:38:03 volumio volumio[841]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jan 17 08:38:03 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:03 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:03 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:03 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:03 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:03 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:03 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:03 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:03 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 08:38:03 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:03 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:03 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:03 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:03 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:03 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:03 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:03 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:03 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:03 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 08:38:03 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:03 volumio volumio[841]: info: CoreCommandRouter::volumioGetState Jan 17 08:38:03 volumio volumio[841]: info: CorePlayQueue::getTrack 0 Jan 17 08:38:03 volumio volumio[841]: info: Volumio called home Jan 17 08:38:03 volumio volumio[841]: info: ir_controller: LIRC correctly updated. Jan 17 08:38:03 volumio volumio[841]: info: ir_controller: HAT did not load /proc/device-tree/ir_receiver! Jan 17 08:38:03 volumio volumio[841]: info: Asound.conf file unchanged, so no further update is needed Jan 17 08:38:03 volumio volumio[841]: info: Output device has changed, restarting MPD Jan 17 08:38:03 volumio volumio[841]: info: Preparing to generate the ALSA configuration file Jan 17 08:38:03 volumio sudo[1134]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 08:38:03 volumio sudo[1134]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 08:38:03 volumio sudo[1134]: pam_unix(sudo:session): session closed for user root Jan 17 08:38:03 volumio sudo[1136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 08:38:03 volumio sudo[1136]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 08:38:03 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jan 17 08:38:03 volumio systemd[1]: mpd.service: Succeeded. Jan 17 08:38:03 volumio systemd[1]: Stopped Music Player Daemon. Jan 17 08:38:03 volumio volumio[841]: info: ir_controller: Raspberry Pi revision code: a22082 Jan 17 08:38:03 volumio systemd[1]: Starting Music Player Daemon... Jan 17 08:38:03 volumio volumio[841]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 17 08:38:03 volumio volumio[841]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Jan 17 08:38:03 volumio sudo[1143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 17 08:38:03 volumio sudo[1143]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 08:38:03 volumio volumio[841]: info: Reading ALSA contributions from plugins. Jan 17 08:38:04 volumio sudo[1145]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 17 08:38:04 volumio sudo[1143]: pam_unix(sudo:session): session closed for user root Jan 17 08:38:04 volumio sudo[1145]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 08:38:04 volumio sudo[1145]: pam_unix(sudo:session): session closed for user root Jan 17 08:38:04 volumio volumio[841]: info: MPD Permissions set Jan 17 08:38:04 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:04 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:04 volumio sudo[1150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r -1 Jan 17 08:38:04 volumio sudo[1150]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 08:38:04 volumio sudo[1150]: pam_unix(sudo:session): session closed for user root Jan 17 08:38:04 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 08:38:04 volumio sudo[1139]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 17 08:38:04 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:04 volumio sudo[1139]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 08:38:04 volumio sudo[1139]: pam_unix(sudo:session): session closed for user root Jan 17 08:38:04 volumio sudo[1161]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 17 08:38:04 volumio sudo[1161]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 08:38:04 volumio volumio[841]: info: Asound.conf file unchanged, so no further update is needed Jan 17 08:38:04 volumio volumio[841]: info: Output device has changed, restarting MPD Jan 17 08:38:04 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jan 17 08:38:04 volumio sudo[1168]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 08:38:04 volumio sudo[1161]: pam_unix(sudo:session): session closed for user root Jan 17 08:38:04 volumio sudo[1168]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 08:38:04 volumio sudo[1166]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 08:38:04 volumio sudo[1166]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 08:38:04 volumio sudo[1166]: pam_unix(sudo:session): session closed for user root Jan 17 08:38:04 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jan 17 08:38:04 volumio systemd[1]: mpd.service: Succeeded. Jan 17 08:38:04 volumio systemd[1]: Stopped Music Player Daemon. Jan 17 08:38:04 volumio volumio[841]: info: [1737128284337] [Pandora] PandoraHandler::pandoraLoginAndGetStations::pandoraLogin: [<=- Logged in to Pandora Servers -=>] Jan 17 08:38:04 volumio systemd[1]: Starting Music Player Daemon... Jan 17 08:38:04 volumio volumio[841]: info: [1737128284349] [Pandora] validateAndSetAccountOptions: ***DEBUG*** self.loggedIn: true Jan 17 08:38:04 volumio volumio[841]: info: [1737128284351] [Pandora] ExpireOldTracks::init: Timer loaded Jan 17 08:38:04 volumio volumio[841]: info: [1737128284352] [Pandora] ExpireOldTracks::init: Interval set to 300000 ms Jan 17 08:38:04 volumio volumio[841]: info: [1737128284352] [Pandora] ExpireOldTracks::init: Starting delayed timer after next interval Jan 17 08:38:04 volumio volumio[841]: info: [1737128284353] ControllerPandora::PandoraHandler::fillStationData Jan 17 08:38:04 volumio volumio[841]: info: MPD Permissions set Jan 17 08:38:04 volumio volumio[841]: info: Upmpdcli Daemon Started Jan 17 08:38:04 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:04 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:04 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:04 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:04 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:04 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:04 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:04 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:04 volumio sudo[1177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-ir gpio_pin=25 gpio_pull=up Jan 17 08:38:04 volumio sudo[1177]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 08:38:04 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 08:38:04 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:04 volumio sudo[1177]: pam_unix(sudo:session): session closed for user root Jan 17 08:38:04 volumio sudo[1175]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 17 08:38:04 volumio kernel: Registered IR keymap rc-rc6-mce Jan 17 08:38:04 volumio sudo[1175]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 08:38:04 volumio volumio[841]: info: ir_controller: Overlay gpio-ir gpio_pin=25 gpio_pull=up loaded. Jan 17 08:38:04 volumio sudo[1175]: pam_unix(sudo:session): session closed for user root Jan 17 08:38:04 volumio kernel: IR RC6 protocol handler initialized Jan 17 08:38:04 volumio sudo[1195]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart lircd.service Jan 17 08:38:04 volumio kernel: rc rc0: gpio_ir_recv as /devices/platform/ir-receiver@19/rc/rc0 Jan 17 08:38:04 volumio kernel: rc rc0: lirc_dev: driver gpio_ir_recv registered at minor = 0, raw IR receiver, no transmitter Jan 17 08:38:04 volumio kernel: input: gpio_ir_recv as /devices/platform/ir-receiver@19/rc/rc0/input0 Jan 17 08:38:04 volumio sudo[1195]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 08:38:04 volumio systemd[1]: Starting lircd(8) initialization helper tool... Jan 17 08:38:04 volumio volumio[841]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Jan 17 08:38:04 volumio volumio[841]: info: camilladsp service started and running in background, instance 1 Jan 17 08:38:04 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 08:38:04 volumio volumio[841]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jan 17 08:38:04 volumio volumio[841]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jan 17 08:38:04 volumio volumio[841]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jan 17 08:38:04 volumio volumio[841]: info: FusionDsp loaded Jan 17 08:38:04 volumio volumio[841]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 17 08:38:04 volumio sudo[1212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jan 17 08:38:04 volumio sudo[1212]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 08:38:04 volumio volumio[841]: info: FusionDsp - Reporting Fusion DSP Enabled Jan 17 08:38:04 volumio volumio[841]: info: Adding Signal Path Element [object Object] Jan 17 08:38:04 volumio volumio[841]: info: Adding fusiondspeq DSP Signal Path Element Jan 17 08:38:04 volumio volumio[841]: info: FusionDsp - ---- installed callbackRead Jan 17 08:38:04 volumio volumio[841]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 08:38:04 volumio volumio[841]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jan 17 08:38:04 volumio volumio[841]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Jan 17 08:38:04 volumio volumio[841]: at onErrorNT (internal/child_process.js:465:16) Jan 17 08:38:04 volumio volumio[841]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Jan 17 08:38:04 volumio volumio[841]: errno: -2, Jan 17 08:38:04 volumio volumio[841]: code: 'ENOENT', Jan 17 08:38:04 volumio volumio[841]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jan 17 08:38:04 volumio volumio[841]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jan 17 08:38:04 volumio volumio[841]: spawnargs: [ Jan 17 08:38:04 volumio volumio[841]: '-p', Jan 17 08:38:04 volumio volumio[841]: 9876, Jan 17 08:38:04 volumio volumio[841]: '-o', Jan 17 08:38:04 volumio volumio[841]: '/tmp/camilladsp.log', Jan 17 08:38:04 volumio volumio[841]: '-l', Jan 17 08:38:04 volumio volumio[841]: 'warn', Jan 17 08:38:04 volumio volumio[841]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jan 17 08:38:04 volumio volumio[841]: ] Jan 17 08:38:04 volumio volumio[841]: } Jan 17 08:38:04 volumio volumio[841]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 08:38:04 volumio sudo[1212]: pam_unix(sudo:session): session closed for user root Jan 17 08:38:04 volumio systemd-udevd[1189]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 17 08:38:04 volumio systemd-logind[563]: Watching system buttons on /dev/input/event0 (gpio_ir_recv) Jan 17 08:38:05 volumio lircd-setup[1200]: /usr/sbin/lircd-setup:37: DeprecationWarning: The SafeConfigParser class has been renamed to ConfigParser in Python 3.2. This alias will be removed in future versions. Use ConfigParser directly instead. Jan 17 08:38:05 volumio lircd-setup[1200]: parser = configparser.SafeConfigParser() Jan 17 08:38:05 volumio systemd[1]: lircd-setup.service: Succeeded. Jan 17 08:38:05 volumio systemd[1]: Started lircd(8) initialization helper tool. Jan 17 08:38:05 volumio systemd[1]: Starting Flexible IR remote input/output application support... Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Info: lircd: Opening log, level: Info Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: Version: lircd 0.10.1 Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: System info: Linux volumio 6.6.62-v7+ #1816 SMP Mon Nov 18 15:30:49 GMT 2024 armv7l GNU/Linux Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Info: Initial device: /dev/lirc0 Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: 'lirc' written to protocols file /sys/class/rc/rc0/protocols Jan 17 08:38:05 volumio lircd[1222]: lircd-0.10.1[1222]: Info: lircd: Opening log, level: Info Jan 17 08:38:05 volumio lircd[1222]: lircd-0.10.1[1222]: Notice: Using systemd fd Jan 17 08:38:05 volumio lircd[1222]: lircd-0.10.1[1222]: Warning: Running as root Jan 17 08:38:05 volumio lircd[1222]: lircd-0.10.1[1222]: Info: Using remote: lircd.conf. Jan 17 08:38:05 volumio lircd[1222]: lircd-0.10.1[1222]: Notice: lircd(default) ready, using /var/run/lirc/lircd Jan 17 08:38:05 volumio systemd[1]: Started Flexible IR remote input/output application support. Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Info: Initial device: /dev/lirc0 Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Info: [lirc] protocol is enabled Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: Options: driver: default Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: Options: output: /var/run/lirc/lircd Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: Options: nodaemon: 1 Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: Options: plugindir: /usr/lib/arm-linux-gnueabihf/lirc/plugins Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: Options: logfile: syslog Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: Options: immediate-init: 0 Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: Options: permission: 666 Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: Options: driver-options: Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: Options: pidfile: /var/run/lirc/lircd.pid Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: Options: listen: 0 Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: Options: connect: (null) Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: Options: userelease: 0 Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: Options: effective_user: (null) Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: Options: release_suffix: _EVUP Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: Options: allow_simulate: 0 Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: Options: repeat_max: 600 Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: Options: configfile: /etc/lirc/lircd.conf Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: Options: dynamic_codes: (null) Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: Current driver: default Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: Driver API version: 3 Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: Driver version: 0.10.0 Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: Driver info: See file:///usr/share/doc/lirc/plugindocs/default.html Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Info: lircd: Opening log, level: Info Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: Using systemd fd Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Warning: Running as root Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Info: Using remote: lircd.conf. Jan 17 08:38:05 volumio lircd-0.10.1[1222]: Notice: lircd(default) ready, using /var/run/lirc/lircd Jan 17 08:38:05 volumio sudo[1195]: pam_unix(sudo:session): session closed for user root Jan 17 08:38:05 volumio sudo[1228]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-17 08:37 Jan 17 08:38:05 volumio sudo[1228]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"