-- Logs begin at Thu 2019-02-14 03:11:59 MST, end at Fri 2025-01-17 21:47:51 MST. -- Jan 17 21:47:27 volumio systemd-timedated[881]: Changed local time to Fri Jan 17 21:47:27 2025 Jan 17 21:47:27 volumio sudo[876]: pam_unix(sudo:session): session closed for user root Jan 17 21:47:27 volumio volumio-time-update[597]: volumio-time-update-util: System time updated successfully. Jan 17 21:47:27 volumio systemd[1]: Started Volumio Time Update Utility. Jan 17 21:47:27 volumio bthelper[738]: Changing power off succeeded Jan 17 21:47:27 volumio ntpd[795]: Soliciting pool server 173.71.68.71 Jan 17 21:47:27 volumio ntpd[795]: Soliciting pool server 45.79.111.114 Jan 17 21:47:27 volumio sudo[891]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Jan 17 21:47:27 volumio sudo[891]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 21:47:27 volumio sudo[891]: pam_unix(sudo:session): session closed for user root Jan 17 21:47:27 volumio sudo[894]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Jan 17 21:47:27 volumio sudo[894]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 21:47:27 volumio bthelper[738]: [CHG] Controller B8:27:EB:4D:99:9E Class: 0x0000041c Jan 17 21:47:27 volumio bthelper[738]: Changing power on succeeded Jan 17 21:47:27 volumio bthelper[738]: [CHG] Controller B8:27:EB:4D:99:9E Powered: yes Jan 17 21:47:27 volumio systemd[1]: Started Samba SMB Daemon. Jan 17 21:47:27 volumio smbd[880]: [2025/01/17 21:47:27.532494, 0] ../lib/util/become_daemon.c:138(daemon_ready) Jan 17 21:47:27 volumio smbd[880]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Jan 17 21:47:27 volumio sudo[894]: pam_unix(sudo:session): session closed for user root Jan 17 21:47:27 volumio wireless.js[642]: Stopped aP Jan 17 21:47:27 volumio wireless.js[642]: Wireless Networking DISABLED, not starting wireless flow Jan 17 21:47:28 volumio systemd[1]: wireless.service: Succeeded. Jan 17 21:47:28 volumio systemd[1]: Started Wireless Services. Jan 17 21:47:28 volumio systemd[1]: Started Volumio Backend Module. Jan 17 21:47:28 volumio systemd[1]: Started Volumio Cpu Tweaker. Jan 17 21:47:28 volumio systemd[1]: Reached target Multi-User System. Jan 17 21:47:28 volumio systemd[1]: Reached target Graphical Interface. Jan 17 21:47:28 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Jan 17 21:47:28 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jan 17 21:47:28 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Jan 17 21:47:28 volumio volumio-cpu-tweak[915]: Setting RT Priority for mpd Jan 17 21:47:28 volumio volumio-cpu-tweak[915]: Setting MPD Affinity Jan 17 21:47:28 volumio systemd[1]: volumio_cpu_tweak.service: Succeeded. Jan 17 21:47:28 volumio ntpd[795]: Soliciting pool server 23.131.160.7 Jan 17 21:47:28 volumio volumio-cpu-tweak[915]: pid 818's current affinity mask: f Jan 17 21:47:28 volumio volumio-cpu-tweak[915]: pid 818's new affinity mask: 3 Jan 17 21:47:28 volumio volumio-cpu-tweak[915]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Jan 17 21:47:28 volumio volumio-cpu-tweak[915]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Jan 17 21:47:29 volumio ntpd[795]: Soliciting pool server 2602:f9ba:69::210 Jan 17 21:47:29 volumio mpd[818]: Jan 17 21:47 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 17 21:47:29 volumio systemd[1]: Started Music Player Daemon. Jan 17 21:47:29 volumio mpd_monitor.sh[611]: MPD restarted due to no mpc output. Jan 17 21:47:29 volumio systemd[1]: Startup finished in 22.798s (kernel) + 19.227s (userspace) = 42.026s. Jan 17 21:47:31 volumio volumio[914]: info: ------------------------------------------- Jan 17 21:47:31 volumio volumio[914]: info: ----- Volumio3 ---- Jan 17 21:47:31 volumio volumio[914]: info: ------------------------------------------- Jan 17 21:47:31 volumio volumio[914]: info: ----- System startup ---- Jan 17 21:47:31 volumio volumio[914]: info: ------------------------------------------- Jan 17 21:47:32 volumio volumio-remote-updater[604]: [2025-01-17 21:47:32] [connect] Successful connection Jan 17 21:47:32 volumio volumio[914]: info: MYVOLUMIO Environment detected Jan 17 21:47:33 volumio volumio[914]: info: Plugin folders cleanup Jan 17 21:47:33 volumio volumio[914]: info: Scanning into folder /volumio/app/plugins/ Jan 17 21:47:33 volumio volumio[914]: info: Scanning category audio_interface Jan 17 21:47:33 volumio volumio[914]: info: Scanning category miscellanea Jan 17 21:47:33 volumio volumio[914]: info: Scanning category music_service Jan 17 21:47:33 volumio volumio[914]: info: Scanning category plugins.json Jan 17 21:47:33 volumio volumio[914]: info: Scanning category system_controller Jan 17 21:47:33 volumio volumio[914]: info: Scanning category user_interface Jan 17 21:47:33 volumio volumio[914]: info: Scanning into folder /data/plugins/ Jan 17 21:47:33 volumio volumio[914]: info: Scanning category audio_interface Jan 17 21:47:33 volumio volumio[914]: info: Scanning category music_service Jan 17 21:47:33 volumio volumio[914]: info: Scanning category system_controller Jan 17 21:47:33 volumio volumio[914]: info: Scanning category system_hardware Jan 17 21:47:33 volumio volumio[914]: info: Scanning category user_interface Jan 17 21:47:33 volumio volumio[914]: info: Plugin folders cleanup completed Jan 17 21:47:33 volumio volumio[914]: info: ------------------------------------------- Jan 17 21:47:33 volumio volumio[914]: info: ----- Core plugins startup ---- Jan 17 21:47:33 volumio volumio[914]: info: ------------------------------------------- Jan 17 21:47:33 volumio volumio[914]: info: Loading plugins from folder /volumio/app/plugins/ Jan 17 21:47:33 volumio volumio[914]: info: Adding plugin upnp to MyMusic Plugins Jan 17 21:47:33 volumio volumio[914]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 17 21:47:33 volumio volumio[914]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 17 21:47:33 volumio volumio[914]: info: Loading plugins from folder /data/plugins/ Jan 17 21:47:33 volumio volumio[914]: info: Loading plugin "system"... Jan 17 21:47:33 volumio volumio[914]: info: Loading plugin "appearance"... Jan 17 21:47:37 volumio ntpd[795]: receive: Unexpected origin timestamp 0xeb35b0e6.3ffd7b2e does not match aorg 0000000000.00000000 from server@198.137.202.32 xmt 0xeb35b0e9.12fa417e Jan 17 21:47:37 volumio ntpd[795]: receive: Unexpected origin timestamp 0xeb35b0e6.3fff2fd6 does not match aorg 0000000000.00000000 from server@216.229.4.69 xmt 0xeb35b0e9.15447cf4 Jan 17 21:47:37 volumio volumio[914]: info: Loading plugin "network"... Jan 17 21:47:37 volumio volumio[914]: info: Refreshing Cached IP Addresses Jan 17 21:47:37 volumio sudo[949]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 17 21:47:37 volumio sudo[949]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 21:47:37 volumio volumio[914]: info: Loading plugin "services"... Jan 17 21:47:37 volumio sudo[951]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 17 21:47:37 volumio volumio[914]: info: Loading plugin "alsa_controller"... Jan 17 21:47:37 volumio sudo[951]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 21:47:37 volumio sudo[949]: pam_unix(sudo:session): session closed for user root Jan 17 21:47:37 volumio sudo[951]: pam_unix(sudo:session): session closed for user root Jan 17 21:47:37 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 21:47:37 volumio volumio[914]: info: Loading plugin "wizard"... Jan 17 21:47:37 volumio volumio[914]: info: Loading plugin "networkfs"... Jan 17 21:47:37 volumio volumio[914]: info: Starting Udev Watcher for removable devices Jan 17 21:47:37 volumio sudo[972]: 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 21:47:37 volumio sudo[972]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 21:47:37 volumio volumio[914]: info: Ignoring mount for partition: boot Jan 17 21:47:37 volumio volumio[914]: info: Ignoring mount for partition: volumio Jan 17 21:47:37 volumio volumio[914]: info: Ignoring mount for partition: volumio_data Jan 17 21:47:37 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 21:47:37 volumio volumio[914]: info: Loading plugin "volumio_command_line_client"... Jan 17 21:47:37 volumio volumio[914]: info: Loading plugin "upnp"... Jan 17 21:47:37 volumio volumio[914]: info: [1737175657857] Starting Upmpd Daemon Jan 17 21:47:37 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 21:47:37 volumio volumio[914]: info: Loading plugin "my_music"... Jan 17 21:47:37 volumio volumio[914]: info: Loading plugin "mpd"... Jan 17 21:47:38 volumio kernel: Key type cifs.spnego registered Jan 17 21:47:38 volumio kernel: Key type cifs.idmap registered Jan 17 21:47:38 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 21:47:38 volumio kernel: CIFS: Attempting to mount //192.168.1.152/data/usenet/complete/music Jan 17 21:47:38 volumio kernel: cryptd: max_cpu_qlen set to 1000 Jan 17 21:47:40 volumio sudo[972]: pam_unix(sudo:session): session closed for user root Jan 17 21:47:40 volumio volumio[914]: info: Plugin upnp_browser is not enabled Jan 17 21:47:40 volumio volumio[914]: info: Loading plugin "alarm-clock"... Jan 17 21:47:40 volumio volumio[914]: info: Plugin airplay_emulation is not enabled Jan 17 21:47:40 volumio volumio[914]: info: Loading plugin "last_100"... Jan 17 21:47:40 volumio volumio[914]: info: Loading plugin "webradio"... Jan 17 21:47:40 volumio volumio[914]: info: Loading plugin "i2s_dacs"... Jan 17 21:47:40 volumio volumio[914]: info: Loading plugin "volumiodiscovery"... Jan 17 21:47:40 volumio volumio[914]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 17 21:47:40 volumio volumio[914]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 21:47:40 volumio volumio[914]: *** WARNING *** For more information see Jan 17 21:47:40 volumio node[914]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 17 21:47:40 volumio volumio[914]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 17 21:47:40 volumio volumio[914]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 21:47:40 volumio volumio[914]: *** WARNING *** For more information see Jan 17 21:47:40 volumio node[914]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 21:47:40 volumio node[914]: *** WARNING *** For more information see Jan 17 21:47:40 volumio node[914]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 17 21:47:40 volumio node[914]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 21:47:40 volumio node[914]: *** WARNING *** For more information see Jan 17 21:47:40 volumio volumio[914]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 17 21:47:40 volumio volumio[914]: info: Discovery: Started advertising with name: Volumio Jan 17 21:47:40 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 21:47:40 volumio volumio[914]: info: Plugin spop is not enabled Jan 17 21:47:40 volumio volumio[914]: info: Loading plugin "outputs"... Jan 17 21:47:40 volumio volumio[914]: info: Loading plugin "albumart"... Jan 17 21:47:40 volumio volumio[914]: info: Plugin example_plugin is not enabled Jan 17 21:47:40 volumio volumio[914]: info: Loading plugin "inputs"... Jan 17 21:47:41 volumio volumio[914]: info: Loading plugin "updater_comm"... Jan 17 21:47:41 volumio volumio[914]: info: Plugin mpdemulation is not enabled Jan 17 21:47:41 volumio volumio[914]: info: Loading plugin "rest_api"... Jan 17 21:47:41 volumio volumio[914]: info: Loading plugin "websocket"... Jan 17 21:47:41 volumio volumio[914]: info: Starting Socket.io Server version 2.3.0 Jan 17 21:47:41 volumio volumio[914]: info: Loading plugin "fusiondsp"... Jan 17 21:47:41 volumio volumio[914]: Forking 3 albumart workers Jan 17 21:47:42 volumio volumio[914]: info: Applying required configuration parameters for plugin fusiondsp Jan 17 21:47:42 volumio volumio[914]: info: Loading plugin "motherearthradio"... Jan 17 21:47:42 volumio volumio[914]: Starting albumart workers Jan 17 21:47:42 volumio volumio[914]: Starting albumart workers Jan 17 21:47:42 volumio volumio[914]: Starting albumart workers Jan 17 21:47:42 volumio volumio[914]: info: Applying required configuration parameters for plugin motherearthradio Jan 17 21:47:42 volumio volumio[914]: info: [1737175662807] [MotherEarth] API delay: 5 Jan 17 21:47:42 volumio volumio[914]: info: Loading plugin "pandora"... Jan 17 21:47:44 volumio volumio[914]: info: Applying required configuration parameters for plugin pandora Jan 17 21:47:44 volumio volumio[914]: info: Loading plugin "radio_paradise"... Jan 17 21:47:45 volumio volumio[914]: info: Applying required configuration parameters for plugin radio_paradise Jan 17 21:47:45 volumio volumio[914]: info: [1737175665250] [RadioParadise] API delay: 5 Jan 17 21:47:45 volumio volumio[914]: info: Loading plugin "backup_restore"... Jan 17 21:47:45 volumio volumio[914]: info: Applying required configuration parameters for plugin backup_restore Jan 17 21:47:45 volumio volumio[914]: info: Loading plugin "ir_controller"... Jan 17 21:47:45 volumio volumio[914]: info: Applying required configuration parameters for plugin ir_controller Jan 17 21:47:46 volumio volumio[914]: info: Loading plugin "peppyspectrum"... Jan 17 21:47:46 volumio volumio[914]: info: Loading plugin "randomizer"... Jan 17 21:47:47 volumio volumio[914]: info: Applying required configuration parameters for plugin randomizer Jan 17 21:47:47 volumio volumio[914]: info: Loading i18n strings for locale en Jan 17 21:47:47 volumio volumio[914]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored. Jan 17 21:47:47 volumio volumio[914]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored. Jan 17 21:47:47 volumio volumio[914]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. Jan 17 21:47:47 volumio volumio[914]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. Jan 17 21:47:47 volumio volumio[914]: Updating browse sources language Jan 17 21:47:47 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 21:47:47 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 21:47:47 volumio volumio[914]: info: CoreCommandRouter::initPlayerControls Jan 17 21:47:47 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:47 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:47 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:47 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:47 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:47 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:47 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:47 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:47 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 21:47:47 volumio volumio[914]: Express server listening on port 3000 Jan 17 21:47:47 volumio volumio[914]: [Metrics] WebUI: 14s 278.44ms Jan 17 21:47:47 volumio volumio[914]: info: CoreStateMachine::resetVolumioState Jan 17 21:47:47 volumio volumio[914]: info: CoreStateMachine::getcurrentVolume Jan 17 21:47:47 volumio volumio[914]: info: CoreCommandRouter::volumioRetrievevolume Jan 17 21:47:47 volumio volumio[914]: info: CoreStateMachine::pushState Jan 17 21:47:47 volumio volumio[914]: info: CorePlayQueue::getTrack 0 Jan 17 21:47:47 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 21:47:47 volumio volumio[914]: info: CoreCommandRouter::volumioPushState Jan 17 21:47:47 volumio volumio[914]: info: Volumio Network Manager: Network status updated: 1 Jan 17 21:47:47 volumio sudo[1085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 17 21:47:47 volumio sudo[1085]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 21:47:47 volumio sudo[1085]: pam_unix(sudo:session): session closed for user root Jan 17 21:47:47 volumio sudo[1087]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 17 21:47:47 volumio sudo[1087]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 21:47:47 volumio sudo[1087]: pam_unix(sudo:session): session closed for user root Jan 17 21:47:47 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 21:47:47 volumio volumio[914]: info: Reloading queue from file Jan 17 21:47:47 volumio volumio[914]: info: CoreStateMachine::setRepeat true single undefined Jan 17 21:47:47 volumio volumio[914]: info: CoreStateMachine::pushState Jan 17 21:47:47 volumio volumio[914]: info: CorePlayQueue::getTrack 0 Jan 17 21:47:47 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 21:47:47 volumio volumio[914]: info: CoreCommandRouter::volumioPushState Jan 17 21:47:48 volumio volumio[914]: info: CoreStateMachine::setRandom false Jan 17 21:47:48 volumio volumio[914]: info: CoreStateMachine::pushState Jan 17 21:47:48 volumio volumio[914]: info: CorePlayQueue::getTrack 0 Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::volumioPushState Jan 17 21:47:48 volumio volumio[914]: info: Setting Device type: Raspberry PI Jan 17 21:47:48 volumio volumio[914]: info: Completed loading Core Plugins Jan 17 21:47:48 volumio volumio[914]: info: Preparing to generate the ALSA configuration file Jan 17 21:47:48 volumio volumio[914]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jan 17 21:47:48 volumio volumio[914]: info: USB Boot Capable - System SBC Revision found in cpuinfo: a22082 Jan 17 21:47:48 volumio volumio[914]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jan 17 21:47:48 volumio volumio[914]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 17 21:47:48 volumio volumio[914]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Jan 17 21:47:48 volumio volumio[914]: info: Reading ALSA contributions from plugins. Jan 17 21:47:48 volumio volumio[914]: info: Asound.conf file unchanged, so no further update is needed Jan 17 21:47:48 volumio volumio[914]: info: Output device has changed, restarting MPD Jan 17 21:47:48 volumio sudo[1096]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 17 21:47:48 volumio sudo[1096]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 21:47:48 volumio volumio[914]: info: ___________ START PLUGINS ___________ Jan 17 21:47:48 volumio sudo[1099]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 21:47:48 volumio sudo[1099]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 21:47:48 volumio volumio[914]: info: ControllerMpd::onStart: Initializing MPD Jan 17 21:47:48 volumio volumio[914]: info: Creating MPD Configuration file Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 21:47:48 volumio volumio[914]: info: [1737175668173] CoreMusicLibrary::Adding element Last_100 Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 21:47:48 volumio volumio[914]: info: [1737175668179] CoreMusicLibrary::Adding element Webradio Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 21:47:48 volumio volumio[914]: info: Initializing BBC Radios Jan 17 21:47:48 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jan 17 21:47:48 volumio sudo[1099]: pam_unix(sudo:session): session closed for user root Jan 17 21:47:48 volumio sudo[1101]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 21:47:48 volumio sudo[1101]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 21:47:48 volumio sudo[1106]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 21:47:48 volumio sudo[1106]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 21:47:48 volumio sudo[1106]: pam_unix(sudo:session): session closed for user root Jan 17 21:47:48 volumio sudo[1108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 21:47:48 volumio sudo[1108]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 21:47:48 volumio sudo[1096]: pam_unix(sudo:session): session closed for user root Jan 17 21:47:48 volumio systemd[1]: Stopping Music Player Daemon... Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 21:47:48 volumio volumio[914]: info: Loading i18n strings for locale en Jan 17 21:47:48 volumio volumio[914]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored. Jan 17 21:47:48 volumio volumio[914]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored. Jan 17 21:47:48 volumio volumio[914]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. Jan 17 21:47:48 volumio volumio[914]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:48 volumio volumio[914]: info: FusionDsp - mixtype--------------------- None Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 21:47:48 volumio volumio[914]: info: [1737175668303] CoreMusicLibrary::Adding element Mother Earth Radio Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 21:47:48 volumio volumio[914]: Cannot find translation for source Mother Earth Radio Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 21:47:48 volumio volumio[914]: info: [1737175668309] CoreMusicLibrary::Adding element Pandora Radio Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 21:47:48 volumio volumio[914]: Cannot find translation for source Mother Earth Radio Jan 17 21:47:48 volumio volumio[914]: Cannot find translation for source Pandora Radio Jan 17 21:47:48 volumio volumio[914]: info: [1737175668312] ControllerPandora::initializeMQTT Jan 17 21:47:48 volumio volumio[914]: info: [1737175668313] [Pandora] initializeMQTT: MQTT is not enabled in Plugin Configuration Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 21:47:48 volumio volumio[914]: info: [1737175668334] CoreMusicLibrary::Adding element Radio Paradise Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 21:47:48 volumio volumio[914]: Cannot find translation for source Mother Earth Radio Jan 17 21:47:48 volumio volumio[914]: Cannot find translation for source Pandora Radio Jan 17 21:47:48 volumio volumio[914]: Cannot find translation for source Radio Paradise Jan 17 21:47:48 volumio volumio[914]: info: Loading i18n strings for locale en Jan 17 21:47:48 volumio volumio[914]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored. Jan 17 21:47:48 volumio volumio[914]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored. Jan 17 21:47:48 volumio volumio[914]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. Jan 17 21:47:48 volumio volumio[914]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jan 17 21:47:48 volumio systemd[1]: mpd.service: Succeeded. Jan 17 21:47:48 volumio systemd[1]: Stopped Music Player Daemon. Jan 17 21:47:48 volumio volumio[914]: info: Volumio Calling Home Jan 17 21:47:48 volumio volumio[914]: info: Preparing to generate the ALSA configuration file Jan 17 21:47:48 volumio systemd[1]: Starting Music Player Daemon... Jan 17 21:47:48 volumio volumio[914]: info: [1737175668557] ControllerPandora::initialSetup Jan 17 21:47:48 volumio volumio[914]: info: [1737175668563] ControllerPandora::PandoraHandler::init Jan 17 21:47:48 volumio volumio[914]: info: [1737175668564] ControllerPandora::PandoraHandler::loadErrorCodes Jan 17 21:47:48 volumio sudo[1121]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 17 21:47:48 volumio sudo[1121]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 21:47:48 volumio sudo[1121]: pam_unix(sudo:session): session closed for user root Jan 17 21:47:48 volumio volumio[914]: info: [1737175668725] [Pandora] PandoraHandler::setMaxStationTracks: 16 Jan 17 21:47:48 volumio volumio[914]: info: [1737175668729] [Pandora] PandoraHandler::setBandFilter: bandfilter is empty Jan 17 21:47:48 volumio volumio[914]: info: [1737175668733] ControllerPandora::flushPandora Jan 17 21:47:48 volumio volumio[914]: info: CorePlayQueue::getQueue Jan 17 21:47:48 volumio volumio[914]: info: CorePlayQueue::clearAddPlayQueue Jan 17 21:47:48 volumio volumio[914]: info: CorePlayQueue::saveQueue Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::serviceClearAddPlayTracks Jan 17 21:47:48 volumio volumio[914]: error: WARNING: No clearAddPlayTracks method for service mpd Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::volumioPushQueue Jan 17 21:47:48 volumio sudo[1130]: 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 21:47:48 volumio volumio[914]: info: [1737175668746] ControllerPandora::validateAndSetAccountOptions Jan 17 21:47:48 volumio volumio[914]: info: [1737175668748] ControllerPandora::PandoraHandler::setAccountOptions Jan 17 21:47:48 volumio sudo[1130]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 21:47:48 volumio volumio[914]: info: [1737175668750] ControllerPandora::flushPandora Jan 17 21:47:48 volumio sudo[1130]: pam_unix(sudo:session): session closed for user root Jan 17 21:47:48 volumio volumio[914]: info: CorePlayQueue::getQueue Jan 17 21:47:48 volumio volumio[914]: info: CorePlayQueue::clearAddPlayQueue Jan 17 21:47:48 volumio volumio[914]: info: CorePlayQueue::saveQueue Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::serviceClearAddPlayTracks Jan 17 21:47:48 volumio volumio[914]: error: WARNING: No clearAddPlayTracks method for service mpd Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::volumioPushQueue Jan 17 21:47:48 volumio volumio[914]: info: [1737175668758] [Pandora] PreventAuthTimeout::init: Timer loaded Jan 17 21:47:48 volumio volumio[914]: info: [1737175668758] [Pandora] PreventAuthTimeout::init: Interval set to 10800000 ms Jan 17 21:47:48 volumio volumio[914]: info: [1737175668759] [Pandora] PreventAuthTimeout::init: Starting delayed timer after next interval Jan 17 21:47:48 volumio volumio[914]: info: [1737175668760] ControllerPandora::PandoraHandler::pandoraLoginAndGetStations Jan 17 21:47:48 volumio volumio[914]: info: Discovery: adding 654c19d1-7cb5-4567-97c8-0dce8e49b7f0 Jan 17 21:47:48 volumio volumio[914]: info: Discovery: Found device Volumio Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::volumioGetState Jan 17 21:47:48 volumio volumio[914]: info: CorePlayQueue::getTrack 0 Jan 17 21:47:48 volumio volumio[914]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 17 21:47:48 volumio volumio[914]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Jan 17 21:47:48 volumio volumio[914]: info: Reading ALSA contributions from plugins. Jan 17 21:47:48 volumio volumio[914]: info: ir_controller: File permissions successfully set on /etc/lirc/*. Jan 17 21:47:48 volumio volumio[914]: info: MPD Permissions set Jan 17 21:47:48 volumio volumio[914]: info: MPD Permissions set Jan 17 21:47:48 volumio volumio[914]: info: Upmpdcli Daemon Started Jan 17 21:47:48 volumio volumio[914]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Jan 17 21:47:48 volumio volumio[914]: 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 21:47:48 volumio volumio[914]: 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 21:47:48 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:48 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:49 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 21:47:49 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:49 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:49 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:49 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:49 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:49 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:49 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:49 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:49 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:49 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 21:47:49 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:49 volumio volumio[914]: info: Volumio called home Jan 17 21:47:49 volumio volumio[914]: info: CoreCommandRouter::volumioGetState Jan 17 21:47:49 volumio volumio[914]: info: CorePlayQueue::getTrack 0 Jan 17 21:47:49 volumio volumio[914]: info: ir_controller: LIRC correctly updated. Jan 17 21:47:49 volumio systemd[1]: systemd-fsckd.service: Succeeded. Jan 17 21:47:49 volumio volumio[914]: info: ir_controller: HAT did not load /proc/device-tree/ir_receiver! Jan 17 21:47:49 volumio volumio[914]: info: Asound.conf file unchanged, so no further update is needed Jan 17 21:47:49 volumio volumio[914]: info: Output device has changed, restarting MPD Jan 17 21:47:49 volumio sudo[1143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 21:47:49 volumio volumio[914]: info: Preparing to generate the ALSA configuration file Jan 17 21:47:49 volumio sudo[1143]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 21:47:49 volumio sudo[1143]: pam_unix(sudo:session): session closed for user root Jan 17 21:47:49 volumio sudo[1145]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 21:47:49 volumio sudo[1145]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 21:47:49 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jan 17 21:47:49 volumio systemd[1]: mpd.service: Succeeded. Jan 17 21:47:49 volumio systemd[1]: Stopped Music Player Daemon. Jan 17 21:47:49 volumio volumio[914]: info: ir_controller: Raspberry Pi revision code: a22082 Jan 17 21:47:49 volumio volumio[914]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 17 21:47:49 volumio volumio[914]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Jan 17 21:47:49 volumio volumio[914]: info: Reading ALSA contributions from plugins. Jan 17 21:47:49 volumio systemd[1]: Starting Music Player Daemon... Jan 17 21:47:49 volumio volumio[914]: info: MPD Permissions set Jan 17 21:47:49 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:49 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:49 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:49 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:49 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:49 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:49 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:49 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:49 volumio sudo[1153]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r -1 Jan 17 21:47:49 volumio sudo[1153]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 21:47:49 volumio sudo[1153]: pam_unix(sudo:session): session closed for user root Jan 17 21:47:49 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 21:47:49 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:49 volumio sudo[1148]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 17 21:47:49 volumio sudo[1148]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 21:47:49 volumio sudo[1148]: pam_unix(sudo:session): session closed for user root Jan 17 21:47:49 volumio volumio-remote-updater[604]: [2025-01-17 21:47:49] [connect] Successful connection Jan 17 21:47:49 volumio volumio[914]: info: Asound.conf file unchanged, so no further update is needed Jan 17 21:47:49 volumio volumio[914]: info: Output device has changed, restarting MPD Jan 17 21:47:49 volumio sudo[1166]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-ir gpio_pin=25 gpio_pull=up Jan 17 21:47:49 volumio sudo[1166]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 21:47:49 volumio sudo[1168]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 21:47:49 volumio sudo[1168]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 21:47:49 volumio sudo[1168]: pam_unix(sudo:session): session closed for user root Jan 17 21:47:50 volumio sudo[1166]: pam_unix(sudo:session): session closed for user root Jan 17 21:47:50 volumio sudo[1175]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 21:47:50 volumio kernel: Registered IR keymap rc-rc6-mce Jan 17 21:47:50 volumio sudo[1175]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 21:47:50 volumio volumio-remote-updater[604]: [2025-01-17 21:47:50] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1737175669 101 Jan 17 21:47:50 volumio kernel: IR RC6 protocol handler initialized Jan 17 21:47:50 volumio volumio[914]: 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: 4 Jan 17 21:47:50 volumio volumio[914]: info: MPD Permissions set Jan 17 21:47:50 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jan 17 21:47:50 volumio systemd[1]: mpd.service: Succeeded. Jan 17 21:47:50 volumio systemd[1]: Stopped Music Player Daemon. Jan 17 21:47:50 volumio kernel: rc rc0: gpio_ir_recv as /devices/platform/ir-receiver@19/rc/rc0 Jan 17 21:47:50 volumio kernel: rc rc0: lirc_dev: driver gpio_ir_recv registered at minor = 0, raw IR receiver, no transmitter Jan 17 21:47:50 volumio kernel: input: gpio_ir_recv as /devices/platform/ir-receiver@19/rc/rc0/input0 Jan 17 21:47:50 volumio volumio[914]: info: ir_controller: Overlay gpio-ir gpio_pin=25 gpio_pull=up loaded. Jan 17 21:47:50 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:50 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:50 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:50 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:50 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:50 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:50 volumio sudo[1192]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart lircd.service Jan 17 21:47:50 volumio sudo[1192]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 21:47:50 volumio systemd[1]: Starting Music Player Daemon... Jan 17 21:47:50 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 21:47:50 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:50 volumio systemd[1]: Starting lircd(8) initialization helper tool... Jan 17 21:47:50 volumio sudo[1191]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 17 21:47:50 volumio sudo[1191]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 21:47:50 volumio sudo[1191]: pam_unix(sudo:session): session closed for user root Jan 17 21:47:50 volumio systemd-udevd[1181]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Jan 17 21:47:50 volumio systemd-logind[629]: Watching system buttons on /dev/input/event0 (gpio_ir_recv) Jan 17 21:47:50 volumio volumio[914]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Jan 17 21:47:50 volumio volumio[914]: info: camilladsp service started and running in background, instance 1 Jan 17 21:47:50 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 21:47:50 volumio volumio[914]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jan 17 21:47:50 volumio volumio[914]: 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 21:47:50 volumio volumio[914]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jan 17 21:47:50 volumio volumio[914]: info: FusionDsp loaded Jan 17 21:47:50 volumio volumio[914]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 17 21:47:50 volumio sudo[1212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jan 17 21:47:50 volumio sudo[1212]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 21:47:50 volumio volumio[914]: info: FusionDsp - Reporting Fusion DSP Enabled Jan 17 21:47:50 volumio volumio[914]: info: Adding Signal Path Element [object Object] Jan 17 21:47:50 volumio volumio[914]: info: Adding fusiondspeq DSP Signal Path Element Jan 17 21:47:50 volumio volumio[914]: info: FusionDsp - ---- installed callbackRead Jan 17 21:47:50 volumio volumio[914]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 21:47:50 volumio sudo[1212]: pam_unix(sudo:session): session closed for user root Jan 17 21:47:50 volumio volumio[914]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jan 17 21:47:50 volumio volumio[914]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Jan 17 21:47:50 volumio volumio[914]: at onErrorNT (internal/child_process.js:465:16) Jan 17 21:47:50 volumio volumio[914]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Jan 17 21:47:50 volumio volumio[914]: errno: -2, Jan 17 21:47:50 volumio volumio[914]: code: 'ENOENT', Jan 17 21:47:50 volumio volumio[914]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jan 17 21:47:50 volumio volumio[914]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jan 17 21:47:50 volumio volumio[914]: spawnargs: [ Jan 17 21:47:50 volumio volumio[914]: '-p', Jan 17 21:47:50 volumio volumio[914]: 9876, Jan 17 21:47:50 volumio volumio[914]: '-o', Jan 17 21:47:50 volumio volumio[914]: '/tmp/camilladsp.log', Jan 17 21:47:50 volumio volumio[914]: '-l', Jan 17 21:47:50 volumio volumio[914]: 'warn', Jan 17 21:47:50 volumio volumio[914]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jan 17 21:47:50 volumio volumio[914]: ] Jan 17 21:47:50 volumio volumio[914]: } Jan 17 21:47:50 volumio volumio[914]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 21:47:50 volumio lircd-setup[1198]: /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 21:47:50 volumio lircd-setup[1198]: parser = configparser.SafeConfigParser() Jan 17 21:47:50 volumio systemd[1]: lircd-setup.service: Succeeded. Jan 17 21:47:50 volumio systemd[1]: Started lircd(8) initialization helper tool. Jan 17 21:47:50 volumio systemd[1]: Starting Flexible IR remote input/output application support... Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Info: lircd: Opening log, level: Info Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Notice: Version: lircd 0.10.1 Jan 17 21:47:50 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 21:47:50 volumio lircd-0.10.1[1222]: Info: Initial device: /dev/lirc0 Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Notice: 'lirc' written to protocols file /sys/class/rc/rc0/protocols Jan 17 21:47:50 volumio lircd[1222]: lircd-0.10.1[1222]: Info: lircd: Opening log, level: Info Jan 17 21:47:50 volumio lircd[1222]: lircd-0.10.1[1222]: Notice: Using systemd fd Jan 17 21:47:50 volumio lircd[1222]: lircd-0.10.1[1222]: Warning: Running as root Jan 17 21:47:50 volumio lircd[1222]: lircd-0.10.1[1222]: Info: Using remote: lircd.conf. Jan 17 21:47:50 volumio lircd[1222]: lircd-0.10.1[1222]: Notice: lircd(default) ready, using /var/run/lirc/lircd Jan 17 21:47:50 volumio systemd[1]: Started Flexible IR remote input/output application support. Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Info: Initial device: /dev/lirc0 Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Info: [lirc] protocol is enabled Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Notice: Options: driver: default Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Notice: Options: output: /var/run/lirc/lircd Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Notice: Options: nodaemon: 1 Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Notice: Options: plugindir: /usr/lib/arm-linux-gnueabihf/lirc/plugins Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Notice: Options: logfile: syslog Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Notice: Options: immediate-init: 0 Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Notice: Options: permission: 666 Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Notice: Options: driver-options: Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Notice: Options: pidfile: /var/run/lirc/lircd.pid Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Notice: Options: listen: 0 Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Notice: Options: connect: (null) Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Notice: Options: userelease: 0 Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Notice: Options: effective_user: (null) Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Notice: Options: release_suffix: _EVUP Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Notice: Options: allow_simulate: 0 Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Notice: Options: repeat_max: 600 Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Notice: Options: configfile: /etc/lirc/lircd.conf Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Notice: Options: dynamic_codes: (null) Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Notice: Current driver: default Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Notice: Driver API version: 3 Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Notice: Driver version: 0.10.0 Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Notice: Driver info: See file:///usr/share/doc/lirc/plugindocs/default.html Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Info: lircd: Opening log, level: Info Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Notice: Using systemd fd Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Warning: Running as root Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Info: Using remote: lircd.conf. Jan 17 21:47:50 volumio lircd-0.10.1[1222]: Notice: lircd(default) ready, using /var/run/lirc/lircd Jan 17 21:47:50 volumio sudo[1192]: pam_unix(sudo:session): session closed for user root Jan 17 21:47:51 volumio sudo[1226]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-17 21:46 Jan 17 21:47:51 volumio sudo[1226]: 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"