-- Logs begin at Thu 2019-02-14 03:12:00 MST, end at Fri 2025-01-17 22:03:25 MST. -- Jan 17 22:03:01 volumio systemd-timedated[945]: Changed local time to Fri Jan 17 22:03:01 2025 Jan 17 22:03:01 volumio sudo[939]: pam_unix(sudo:session): session closed for user root Jan 17 22:03:01 volumio volumio-time-update[591]: volumio-time-update-util: System time updated successfully. Jan 17 22:03:01 volumio systemd[1]: Starting Daily apt download activities... Jan 17 22:03:01 volumio systemd[1]: Started Volumio Time Update Utility. Jan 17 22:03:01 volumio systemd[1]: Reached target Multi-User System. Jan 17 22:03:01 volumio systemd[1]: Reached target Graphical Interface. Jan 17 22:03:01 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Jan 17 22:03:01 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jan 17 22:03:01 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Jan 17 22:03:01 volumio volumio[844]: info: ------------------------------------------- Jan 17 22:03:01 volumio volumio[844]: info: ----- Volumio3 ---- Jan 17 22:03:01 volumio volumio[844]: info: ------------------------------------------- Jan 17 22:03:01 volumio volumio[844]: info: ----- System startup ---- Jan 17 22:03:01 volumio volumio[844]: info: ------------------------------------------- Jan 17 22:03:02 volumio volumio-remote-updater[584]: [2025-01-17 22:03:02] [connect] Successful connection Jan 17 22:03:04 volumio volumio[844]: info: MYVOLUMIO Environment detected Jan 17 22:03:04 volumio volumio[844]: info: Plugin folders cleanup Jan 17 22:03:04 volumio volumio[844]: info: Scanning into folder /volumio/app/plugins/ Jan 17 22:03:04 volumio volumio[844]: info: Scanning category audio_interface Jan 17 22:03:04 volumio volumio[844]: info: Scanning category miscellanea Jan 17 22:03:04 volumio volumio[844]: info: Scanning category music_service Jan 17 22:03:04 volumio volumio[844]: info: Scanning category plugins.json Jan 17 22:03:04 volumio volumio[844]: info: Scanning category system_controller Jan 17 22:03:04 volumio volumio[844]: info: Scanning category user_interface Jan 17 22:03:04 volumio volumio[844]: info: Scanning into folder /data/plugins/ Jan 17 22:03:04 volumio volumio[844]: info: Scanning category audio_interface Jan 17 22:03:04 volumio volumio[844]: info: Scanning category music_service Jan 17 22:03:04 volumio volumio[844]: info: Scanning category system_controller Jan 17 22:03:04 volumio volumio[844]: info: Scanning category system_hardware Jan 17 22:03:04 volumio volumio[844]: info: Scanning category user_interface Jan 17 22:03:04 volumio volumio[844]: info: Plugin folders cleanup completed Jan 17 22:03:04 volumio volumio[844]: info: ------------------------------------------- Jan 17 22:03:04 volumio volumio[844]: info: ----- Core plugins startup ---- Jan 17 22:03:04 volumio volumio[844]: info: ------------------------------------------- Jan 17 22:03:04 volumio volumio[844]: info: Loading plugins from folder /volumio/app/plugins/ Jan 17 22:03:04 volumio volumio[844]: info: Adding plugin upnp to MyMusic Plugins Jan 17 22:03:04 volumio volumio[844]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 17 22:03:04 volumio volumio[844]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 17 22:03:04 volumio volumio[844]: info: Loading plugins from folder /data/plugins/ Jan 17 22:03:04 volumio volumio[844]: info: Loading plugin "system"... Jan 17 22:03:04 volumio volumio[844]: info: Loading plugin "appearance"... Jan 17 22:03:06 volumio systemd[1]: apt-daily.service: Succeeded. Jan 17 22:03:06 volumio systemd[1]: Started Daily apt download activities. Jan 17 22:03:06 volumio systemd[1]: Startup finished in 22.196s (kernel) + 32.133s (userspace) = 54.330s. Jan 17 22:03:07 volumio volumio[844]: info: Loading plugin "network"... Jan 17 22:03:07 volumio volumio[844]: info: Refreshing Cached IP Addresses Jan 17 22:03:07 volumio sudo[1008]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 17 22:03:07 volumio sudo[1008]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 22:03:07 volumio volumio[844]: info: Loading plugin "services"... Jan 17 22:03:07 volumio sudo[1008]: pam_unix(sudo:session): session closed for user root Jan 17 22:03:07 volumio sudo[1010]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 17 22:03:07 volumio sudo[1010]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 22:03:07 volumio volumio[844]: info: Loading plugin "alsa_controller"... Jan 17 22:03:07 volumio sudo[1010]: pam_unix(sudo:session): session closed for user root Jan 17 22:03:07 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 22:03:07 volumio volumio[844]: info: Loading plugin "wizard"... Jan 17 22:03:07 volumio volumio[844]: info: Loading plugin "networkfs"... Jan 17 22:03:08 volumio volumio[844]: info: Starting Udev Watcher for removable devices Jan 17 22:03:08 volumio sudo[1031]: 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 22:03:08 volumio sudo[1031]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 22:03:08 volumio volumio[844]: info: Ignoring mount for partition: boot Jan 17 22:03:08 volumio volumio[844]: info: Ignoring mount for partition: volumio Jan 17 22:03:08 volumio volumio[844]: info: Ignoring mount for partition: volumio_data Jan 17 22:03:08 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 22:03:08 volumio volumio[844]: info: Loading plugin "volumio_command_line_client"... Jan 17 22:03:08 volumio volumio[844]: info: Loading plugin "upnp"... Jan 17 22:03:08 volumio volumio[844]: info: [1737176588207] Starting Upmpd Daemon Jan 17 22:03:08 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 22:03:08 volumio volumio[844]: info: Loading plugin "my_music"... Jan 17 22:03:08 volumio volumio[844]: info: Loading plugin "mpd"... Jan 17 22:03:08 volumio kernel: Key type cifs.spnego registered Jan 17 22:03:08 volumio kernel: Key type cifs.idmap registered Jan 17 22:03:08 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 22:03:08 volumio kernel: CIFS: Attempting to mount //192.168.1.152/data/usenet/complete/music Jan 17 22:03:08 volumio kernel: cryptd: max_cpu_qlen set to 1000 Jan 17 22:03:09 volumio sudo[1031]: pam_unix(sudo:session): session closed for user root Jan 17 22:03:09 volumio volumio[844]: info: Plugin upnp_browser is not enabled Jan 17 22:03:09 volumio volumio[844]: info: Loading plugin "alarm-clock"... Jan 17 22:03:09 volumio systemd[1]: systemd-fsckd.service: Succeeded. Jan 17 22:03:09 volumio volumio[844]: info: Plugin airplay_emulation is not enabled Jan 17 22:03:09 volumio volumio[844]: info: Loading plugin "last_100"... Jan 17 22:03:09 volumio volumio[844]: info: Loading plugin "webradio"... Jan 17 22:03:10 volumio volumio[844]: info: Loading plugin "i2s_dacs"... Jan 17 22:03:10 volumio volumio[844]: info: Loading plugin "volumiodiscovery"... Jan 17 22:03:10 volumio volumio[844]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 17 22:03:10 volumio volumio[844]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 22:03:10 volumio volumio[844]: *** WARNING *** For more information see Jan 17 22:03:10 volumio volumio[844]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 17 22:03:10 volumio volumio[844]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 22:03:10 volumio volumio[844]: *** WARNING *** For more information see Jan 17 22:03:10 volumio node[844]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 17 22:03:10 volumio node[844]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 22:03:10 volumio node[844]: *** WARNING *** For more information see Jan 17 22:03:10 volumio node[844]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 17 22:03:10 volumio node[844]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 22:03:10 volumio node[844]: *** WARNING *** For more information see Jan 17 22:03:10 volumio volumio[844]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 17 22:03:10 volumio volumio[844]: info: Discovery: Started advertising with name: Volumio Jan 17 22:03:10 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 22:03:10 volumio volumio[844]: info: Plugin spop is not enabled Jan 17 22:03:10 volumio volumio[844]: info: Loading plugin "outputs"... Jan 17 22:03:10 volumio volumio[844]: info: Loading plugin "albumart"... Jan 17 22:03:10 volumio volumio[844]: info: Plugin example_plugin is not enabled Jan 17 22:03:10 volumio volumio[844]: info: Loading plugin "inputs"... Jan 17 22:03:10 volumio volumio[844]: info: Loading plugin "updater_comm"... Jan 17 22:03:11 volumio volumio[844]: info: Plugin mpdemulation is not enabled Jan 17 22:03:11 volumio volumio[844]: info: Loading plugin "rest_api"... Jan 17 22:03:11 volumio volumio[844]: info: Loading plugin "websocket"... Jan 17 22:03:11 volumio volumio[844]: info: Starting Socket.io Server version 2.3.0 Jan 17 22:03:11 volumio volumio[844]: info: Loading plugin "fusiondsp"... Jan 17 22:03:11 volumio volumio[844]: Forking 3 albumart workers Jan 17 22:03:12 volumio volumio[844]: info: Applying required configuration parameters for plugin fusiondsp Jan 17 22:03:12 volumio volumio[844]: info: Loading plugin "motherearthradio"... Jan 17 22:03:13 volumio volumio[844]: Starting albumart workers Jan 17 22:03:13 volumio volumio[844]: Starting albumart workers Jan 17 22:03:13 volumio volumio[844]: info: Applying required configuration parameters for plugin motherearthradio Jan 17 22:03:13 volumio volumio[844]: info: [1737176593454] [MotherEarth] API delay: 5 Jan 17 22:03:13 volumio volumio[844]: info: Loading plugin "pandora"... Jan 17 22:03:13 volumio volumio[844]: Starting albumart workers Jan 17 22:03:16 volumio volumio[844]: info: Applying required configuration parameters for plugin pandora Jan 17 22:03:16 volumio volumio[844]: info: Loading plugin "radio_paradise"... Jan 17 22:03:17 volumio volumio-remote-updater[584]: [2025-01-17 22:03:17] [connect] Successful connection Jan 17 22:03:17 volumio volumio[844]: info: Applying required configuration parameters for plugin radio_paradise Jan 17 22:03:17 volumio volumio[844]: info: [1737176597262] [RadioParadise] API delay: 5 Jan 17 22:03:17 volumio volumio[844]: info: Loading plugin "backup_restore"... Jan 17 22:03:17 volumio volumio[844]: info: Applying required configuration parameters for plugin backup_restore Jan 17 22:03:17 volumio volumio[844]: info: Loading plugin "ir_controller"... Jan 17 22:03:18 volumio volumio[844]: info: Applying required configuration parameters for plugin ir_controller Jan 17 22:03:18 volumio volumio[844]: info: Loading plugin "peppyspectrum"... Jan 17 22:03:19 volumio volumio[844]: info: Loading plugin "randomizer"... Jan 17 22:03:20 volumio volumio[844]: info: Applying required configuration parameters for plugin randomizer Jan 17 22:03:20 volumio volumio[844]: info: Loading i18n strings for locale en Jan 17 22:03:20 volumio volumio[844]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored. Jan 17 22:03:20 volumio volumio[844]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored. Jan 17 22:03:20 volumio volumio[844]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. Jan 17 22:03:20 volumio volumio[844]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. Jan 17 22:03:20 volumio volumio[844]: Updating browse sources language Jan 17 22:03:20 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 22:03:21 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 22:03:21 volumio volumio[844]: info: CoreCommandRouter::initPlayerControls Jan 17 22:03:21 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:21 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:21 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:21 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:21 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:21 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:21 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:21 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:21 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 22:03:21 volumio volumio[844]: Express server listening on port 3000 Jan 17 22:03:21 volumio volumio[844]: [Metrics] WebUI: 22s 17.91ms Jan 17 22:03:21 volumio volumio[844]: info: CoreStateMachine::resetVolumioState Jan 17 22:03:21 volumio volumio[844]: info: CoreStateMachine::getcurrentVolume Jan 17 22:03:21 volumio volumio[844]: info: CoreCommandRouter::volumioRetrievevolume Jan 17 22:03:21 volumio volumio[844]: info: CoreStateMachine::pushState Jan 17 22:03:21 volumio volumio[844]: info: CorePlayQueue::getTrack 0 Jan 17 22:03:21 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 22:03:21 volumio volumio[844]: info: CoreCommandRouter::volumioPushState Jan 17 22:03:21 volumio sudo[1146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 17 22:03:21 volumio sudo[1146]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 22:03:21 volumio sudo[1146]: pam_unix(sudo:session): session closed for user root Jan 17 22:03:21 volumio sudo[1148]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 17 22:03:21 volumio sudo[1148]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 22:03:21 volumio sudo[1148]: pam_unix(sudo:session): session closed for user root Jan 17 22:03:21 volumio volumio[844]: info: Volumio Network Manager: Network status updated: 1 Jan 17 22:03:21 volumio volumio-remote-updater[584]: [2025-01-17 22:03:21] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1737176597 101 Jan 17 22:03:21 volumio volumio[844]: 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 22:03:21 volumio volumio[844]: info: Reloading queue from file Jan 17 22:03:21 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 22:03:21 volumio volumio[844]: info: CoreStateMachine::setRepeat true single undefined Jan 17 22:03:21 volumio volumio[844]: info: CoreStateMachine::pushState Jan 17 22:03:21 volumio volumio[844]: info: CorePlayQueue::getTrack 0 Jan 17 22:03:21 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 22:03:21 volumio volumio[844]: info: CoreCommandRouter::volumioPushState Jan 17 22:03:21 volumio volumio[844]: info: CoreStateMachine::setRandom false Jan 17 22:03:21 volumio volumio[844]: info: CoreStateMachine::pushState Jan 17 22:03:21 volumio volumio[844]: info: CorePlayQueue::getTrack 0 Jan 17 22:03:21 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 22:03:21 volumio volumio[844]: info: CoreCommandRouter::volumioPushState Jan 17 22:03:21 volumio volumio[844]: info: Setting Device type: Raspberry PI Jan 17 22:03:21 volumio volumio[844]: info: Completed loading Core Plugins Jan 17 22:03:21 volumio volumio[844]: info: Preparing to generate the ALSA configuration file Jan 17 22:03:21 volumio volumio[844]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jan 17 22:03:21 volumio volumio[844]: info: USB Boot Capable - System SBC Revision found in cpuinfo: a22082 Jan 17 22:03:21 volumio volumio[844]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jan 17 22:03:21 volumio volumio[844]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 17 22:03:21 volumio volumio[844]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Jan 17 22:03:21 volumio volumio[844]: info: Reading ALSA contributions from plugins. Jan 17 22:03:21 volumio volumio[844]: info: Asound.conf file unchanged, so no further update is needed Jan 17 22:03:21 volumio volumio[844]: info: Output device has changed, restarting MPD Jan 17 22:03:21 volumio sudo[1157]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 17 22:03:21 volumio sudo[1157]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 22:03:22 volumio sudo[1160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 22:03:22 volumio volumio[844]: info: ___________ START PLUGINS ___________ Jan 17 22:03:22 volumio sudo[1160]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 22:03:22 volumio volumio[844]: info: ControllerMpd::onStart: Initializing MPD Jan 17 22:03:22 volumio volumio[844]: info: Creating MPD Configuration file Jan 17 22:03:22 volumio sudo[1160]: pam_unix(sudo:session): session closed for user root Jan 17 22:03:22 volumio sudo[1162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 22:03:22 volumio sudo[1162]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 22:03:22 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jan 17 22:03:22 volumio systemd[1]: systemd-hostnamed.service: Succeeded. Jan 17 22:03:22 volumio volumio[844]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 22:03:22 volumio volumio[844]: info: [1737176602138] CoreMusicLibrary::Adding element Last_100 Jan 17 22:03:22 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 22:03:22 volumio sudo[1167]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 22:03:22 volumio sudo[1167]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 22:03:22 volumio volumio[844]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 22:03:22 volumio volumio[844]: info: [1737176602186] CoreMusicLibrary::Adding element Webradio Jan 17 22:03:22 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 22:03:22 volumio sudo[1172]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 22:03:22 volumio sudo[1172]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 22:03:22 volumio sudo[1157]: pam_unix(sudo:session): session closed for user root Jan 17 22:03:22 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 22:03:22 volumio volumio[844]: info: Initializing BBC Radios Jan 17 22:03:22 volumio sudo[1167]: pam_unix(sudo:session): session closed for user root Jan 17 22:03:22 volumio systemd[1]: Stopping Music Player Daemon... Jan 17 22:03:22 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 22:03:22 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 22:03:22 volumio volumio[844]: info: Loading i18n strings for locale en Jan 17 22:03:22 volumio volumio[844]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored. Jan 17 22:03:22 volumio volumio[844]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored. Jan 17 22:03:22 volumio volumio[844]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. Jan 17 22:03:22 volumio volumio[844]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. Jan 17 22:03:22 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jan 17 22:03:22 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:22 volumio volumio[844]: info: FusionDsp - mixtype--------------------- None Jan 17 22:03:22 volumio volumio[844]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 22:03:22 volumio volumio[844]: info: [1737176602431] CoreMusicLibrary::Adding element Mother Earth Radio Jan 17 22:03:22 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 22:03:22 volumio volumio[844]: Cannot find translation for source Mother Earth Radio Jan 17 22:03:22 volumio volumio[844]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 22:03:22 volumio volumio[844]: info: [1737176602442] CoreMusicLibrary::Adding element Pandora Radio Jan 17 22:03:22 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 22:03:22 volumio volumio[844]: Cannot find translation for source Mother Earth Radio Jan 17 22:03:22 volumio volumio[844]: Cannot find translation for source Pandora Radio Jan 17 22:03:22 volumio volumio[844]: info: [1737176602449] ControllerPandora::initializeMQTT Jan 17 22:03:22 volumio volumio[844]: info: [1737176602451] [Pandora] initializeMQTT: MQTT is not enabled in Plugin Configuration Jan 17 22:03:22 volumio volumio[844]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 22:03:22 volumio volumio[844]: info: [1737176602462] CoreMusicLibrary::Adding element Radio Paradise Jan 17 22:03:22 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 22:03:22 volumio volumio[844]: Cannot find translation for source Mother Earth Radio Jan 17 22:03:22 volumio volumio[844]: Cannot find translation for source Pandora Radio Jan 17 22:03:22 volumio volumio[844]: Cannot find translation for source Radio Paradise Jan 17 22:03:22 volumio volumio[844]: info: Loading i18n strings for locale en Jan 17 22:03:22 volumio systemd[1]: mpd.service: Succeeded. Jan 17 22:03:22 volumio systemd[1]: Stopped Music Player Daemon. Jan 17 22:03:22 volumio volumio[844]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored. Jan 17 22:03:22 volumio volumio[844]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored. Jan 17 22:03:22 volumio volumio[844]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. Jan 17 22:03:22 volumio volumio[844]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. Jan 17 22:03:22 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 22:03:22 volumio systemd[1]: Starting Music Player Daemon... Jan 17 22:03:22 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jan 17 22:03:22 volumio volumio[844]: info: Volumio Calling Home Jan 17 22:03:22 volumio sudo[1186]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 17 22:03:22 volumio sudo[1186]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 22:03:22 volumio volumio[844]: info: Preparing to generate the ALSA configuration file Jan 17 22:03:22 volumio sudo[1186]: pam_unix(sudo:session): session closed for user root Jan 17 22:03:22 volumio volumio[844]: info: [1737176602917] ControllerPandora::initialSetup Jan 17 22:03:22 volumio volumio[844]: info: [1737176602925] ControllerPandora::PandoraHandler::init Jan 17 22:03:22 volumio volumio[844]: info: [1737176602927] ControllerPandora::PandoraHandler::loadErrorCodes Jan 17 22:03:23 volumio sudo[1195]: 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 22:03:23 volumio volumio[844]: info: [1737176603212] [Pandora] PandoraHandler::setMaxStationTracks: 16 Jan 17 22:03:23 volumio sudo[1195]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 22:03:23 volumio volumio[844]: info: [1737176603216] [Pandora] PandoraHandler::setBandFilter: bandfilter is empty Jan 17 22:03:23 volumio volumio[844]: info: [1737176603219] ControllerPandora::flushPandora Jan 17 22:03:23 volumio volumio[844]: info: CorePlayQueue::getQueue Jan 17 22:03:23 volumio volumio[844]: info: CorePlayQueue::clearAddPlayQueue Jan 17 22:03:23 volumio volumio[844]: info: CorePlayQueue::saveQueue Jan 17 22:03:23 volumio volumio[844]: info: CoreCommandRouter::serviceClearAddPlayTracks Jan 17 22:03:23 volumio volumio[844]: error: WARNING: No clearAddPlayTracks method for service mpd Jan 17 22:03:23 volumio volumio[844]: info: CoreCommandRouter::volumioPushQueue Jan 17 22:03:23 volumio sudo[1195]: pam_unix(sudo:session): session closed for user root Jan 17 22:03:23 volumio volumio[844]: info: [1737176603247] ControllerPandora::validateAndSetAccountOptions Jan 17 22:03:23 volumio volumio[844]: info: [1737176603249] ControllerPandora::PandoraHandler::setAccountOptions Jan 17 22:03:23 volumio volumio[844]: info: [1737176603254] ControllerPandora::flushPandora Jan 17 22:03:23 volumio volumio[844]: info: CorePlayQueue::getQueue Jan 17 22:03:23 volumio volumio[844]: info: CorePlayQueue::clearAddPlayQueue Jan 17 22:03:23 volumio volumio[844]: info: CorePlayQueue::saveQueue Jan 17 22:03:23 volumio volumio[844]: info: CoreCommandRouter::serviceClearAddPlayTracks Jan 17 22:03:23 volumio volumio[844]: error: WARNING: No clearAddPlayTracks method for service mpd Jan 17 22:03:23 volumio volumio[844]: info: CoreCommandRouter::volumioPushQueue Jan 17 22:03:23 volumio volumio[844]: info: [1737176603274] [Pandora] PreventAuthTimeout::init: Timer loaded Jan 17 22:03:23 volumio volumio[844]: info: [1737176603275] [Pandora] PreventAuthTimeout::init: Interval set to 10800000 ms Jan 17 22:03:23 volumio volumio[844]: info: [1737176603276] [Pandora] PreventAuthTimeout::init: Starting delayed timer after next interval Jan 17 22:03:23 volumio volumio[844]: info: [1737176603279] ControllerPandora::PandoraHandler::pandoraLoginAndGetStations Jan 17 22:03:23 volumio volumio[844]: info: Discovery: adding 654c19d1-7cb5-4567-97c8-0dce8e49b7f0 Jan 17 22:03:23 volumio volumio[844]: info: Discovery: Found device Volumio Jan 17 22:03:23 volumio volumio[844]: info: CoreCommandRouter::volumioGetState Jan 17 22:03:23 volumio volumio[844]: info: CorePlayQueue::getTrack 0 Jan 17 22:03:23 volumio volumio[844]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 17 22:03:23 volumio volumio[844]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Jan 17 22:03:23 volumio volumio[844]: info: Reading ALSA contributions from plugins. Jan 17 22:03:23 volumio volumio[844]: info: ir_controller: File permissions successfully set on /etc/lirc/*. Jan 17 22:03:23 volumio volumio[844]: info: MPD Permissions set Jan 17 22:03:23 volumio volumio[844]: info: MPD Permissions set Jan 17 22:03:23 volumio volumio[844]: info: Upmpdcli Daemon Started Jan 17 22:03:23 volumio volumio[844]: info: Volumio called home Jan 17 22:03:23 volumio volumio[844]: 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 22:03:23 volumio volumio[844]: 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 22:03:23 volumio volumio[844]: 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 22:03:23 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:23 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:23 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:23 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:23 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:23 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:23 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:23 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 22:03:23 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:23 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:23 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:23 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:23 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:23 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:23 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:23 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:23 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:23 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 22:03:23 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:24 volumio volumio[844]: info: CoreCommandRouter::volumioGetState Jan 17 22:03:24 volumio volumio[844]: info: CorePlayQueue::getTrack 0 Jan 17 22:03:24 volumio volumio[844]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Jan 17 22:03:24 volumio volumio[844]: info: camilladsp service started and running in background, instance 1 Jan 17 22:03:24 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 22:03:24 volumio volumio[844]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jan 17 22:03:24 volumio volumio[844]: 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 22:03:24 volumio volumio[844]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jan 17 22:03:24 volumio volumio[844]: info: FusionDsp loaded Jan 17 22:03:24 volumio volumio[844]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 17 22:03:24 volumio sudo[1215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jan 17 22:03:24 volumio sudo[1215]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 22:03:24 volumio volumio[844]: info: FusionDsp - Reporting Fusion DSP Enabled Jan 17 22:03:24 volumio volumio[844]: info: Adding Signal Path Element [object Object] Jan 17 22:03:24 volumio volumio[844]: info: Adding fusiondspeq DSP Signal Path Element Jan 17 22:03:24 volumio volumio[844]: info: FusionDsp - ---- installed callbackRead Jan 17 22:03:24 volumio volumio[844]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 22:03:24 volumio sudo[1215]: pam_unix(sudo:session): session closed for user root Jan 17 22:03:24 volumio volumio[844]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jan 17 22:03:24 volumio volumio[844]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Jan 17 22:03:24 volumio volumio[844]: at onErrorNT (internal/child_process.js:465:16) Jan 17 22:03:24 volumio volumio[844]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jan 17 22:03:24 volumio volumio[844]: at runNextTicks (internal/process/task_queues.js:62:3) Jan 17 22:03:24 volumio volumio[844]: at listOnTimeout (internal/timers.js:523:9) Jan 17 22:03:24 volumio volumio[844]: at processTimers (internal/timers.js:497:7) { Jan 17 22:03:24 volumio volumio[844]: errno: -2, Jan 17 22:03:24 volumio volumio[844]: code: 'ENOENT', Jan 17 22:03:24 volumio volumio[844]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jan 17 22:03:24 volumio volumio[844]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jan 17 22:03:24 volumio volumio[844]: spawnargs: [ Jan 17 22:03:24 volumio volumio[844]: '-p', Jan 17 22:03:24 volumio volumio[844]: 9876, Jan 17 22:03:24 volumio volumio[844]: '-o', Jan 17 22:03:24 volumio volumio[844]: '/tmp/camilladsp.log', Jan 17 22:03:24 volumio volumio[844]: '-l', Jan 17 22:03:24 volumio volumio[844]: 'warn', Jan 17 22:03:24 volumio volumio[844]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jan 17 22:03:24 volumio volumio[844]: ] Jan 17 22:03:24 volumio volumio[844]: } Jan 17 22:03:24 volumio volumio[844]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 22:03:25 volumio sudo[1226]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-17 22:02 Jan 17 22:03:25 volumio sudo[1226]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 22:03:25 volumio mpd[1191]: Jan 17 22:03 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg 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"