-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sun 2024-12-01 10:06:24 CET. --
Dec 01 10:06:15 volumiokhv systemd-timedated[1000]: Changed local time to Sun Dec 1 10:06:15 2024
Dec 01 10:06:15 volumiokhv sudo[985]: pam_unix(sudo:session): session closed for user root
Dec 01 10:06:15 volumiokhv volumio-time-update[573]: volumio-time-update-util: System time updated successfully.
Dec 01 10:06:15 volumiokhv systemd[1]: Started Volumio Time Update Utility.
Dec 01 10:06:16 volumiokhv nmbd[729]: [2024/12/01 10:06:16.088990, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Dec 01 10:06:16 volumiokhv systemd[1]: Started Samba NMB Daemon.
Dec 01 10:06:16 volumiokhv nmbd[729]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections
Dec 01 10:06:16 volumiokhv ntpd[768]: Listen normally on 3 wlan0 192.168.1.65:123
Dec 01 10:06:16 volumiokhv ntpd[768]: new interface(s) found: waking up resolver
Dec 01 10:06:16 volumiokhv systemd[1]: Starting Samba Winbind Daemon...
Dec 01 10:06:16 volumiokhv winbindd[1006]: [2024/12/01 10:06:16.361500, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache)
Dec 01 10:06:16 volumiokhv winbindd[1006]: initialize_winbindd_cache: clearing cache and re-creating with version number 2
Dec 01 10:06:16 volumiokhv winbindd[1006]: [2024/12/01 10:06:16.399752, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Dec 01 10:06:16 volumiokhv winbindd[1006]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections
Dec 01 10:06:16 volumiokhv systemd[1]: Started Samba Winbind Daemon.
Dec 01 10:06:16 volumiokhv systemd[1]: Starting Samba SMB Daemon...
Dec 01 10:06:16 volumiokhv volumio[987]: info: -------------------------------------------
Dec 01 10:06:16 volumiokhv volumio[987]: info: ----- Volumio3 ----
Dec 01 10:06:16 volumiokhv volumio[987]: info: -------------------------------------------
Dec 01 10:06:16 volumiokhv volumio[987]: info: ----- System startup ----
Dec 01 10:06:16 volumiokhv volumio[987]: info: -------------------------------------------
Dec 01 10:06:16 volumiokhv smbd[1019]: [2024/12/01 10:06:16.846910, 0] ../lib/util/become_daemon.c:138(daemon_ready)
Dec 01 10:06:16 volumiokhv smbd[1019]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections
Dec 01 10:06:16 volumiokhv systemd[1]: Started Samba SMB Daemon.
Dec 01 10:06:16 volumiokhv systemd[1]: Reached target Multi-User System.
Dec 01 10:06:16 volumiokhv systemd[1]: Reached target Graphical Interface.
Dec 01 10:06:16 volumiokhv volumio-remote-updater[578]: [2024-12-01 10:06:16] [connect] Successful connection
Dec 01 10:06:16 volumiokhv systemd[1]: Starting Update UTMP about System Runlevel Changes...
Dec 01 10:06:16 volumiokhv systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Dec 01 10:06:16 volumiokhv systemd[1]: Started Update UTMP about System Runlevel Changes.
Dec 01 10:06:16 volumiokhv systemd[1]: Startup finished in 13.624s (kernel) + 29.697s (userspace) = 43.322s.
Dec 01 10:06:17 volumiokhv volumio[987]: info: MYVOLUMIO Environment detected
Dec 01 10:06:17 volumiokhv volumio[987]: info: Plugin folders cleanup
Dec 01 10:06:17 volumiokhv volumio[987]: info: Scanning into folder /volumio/app/plugins/
Dec 01 10:06:17 volumiokhv volumio[987]: info: Scanning category audio_interface
Dec 01 10:06:17 volumiokhv volumio[987]: info: Scanning category miscellanea
Dec 01 10:06:17 volumiokhv volumio[987]: info: Scanning category music_service
Dec 01 10:06:17 volumiokhv volumio[987]: info: Scanning category plugins.json
Dec 01 10:06:17 volumiokhv volumio[987]: info: Scanning category system_controller
Dec 01 10:06:17 volumiokhv volumio[987]: info: Scanning category user_interface
Dec 01 10:06:17 volumiokhv volumio[987]: info: Scanning into folder /data/plugins/
Dec 01 10:06:17 volumiokhv volumio[987]: info: Scanning category audio_interface
Dec 01 10:06:17 volumiokhv volumio[987]: info: Scanning category music_service
Dec 01 10:06:17 volumiokhv volumio[987]: info: Scanning category system_hardware
Dec 01 10:06:17 volumiokhv volumio[987]: info: Scanning category user_interface
Dec 01 10:06:17 volumiokhv volumio[987]: info: Plugin folders cleanup completed
Dec 01 10:06:17 volumiokhv volumio[987]: info: -------------------------------------------
Dec 01 10:06:17 volumiokhv volumio[987]: info: ----- Core plugins startup ----
Dec 01 10:06:17 volumiokhv volumio[987]: info: -------------------------------------------
Dec 01 10:06:17 volumiokhv volumio[987]: info: Loading plugins from folder /volumio/app/plugins/
Dec 01 10:06:17 volumiokhv volumio[987]: info: Adding plugin upnp to MyMusic Plugins
Dec 01 10:06:17 volumiokhv volumio[987]: info: Adding plugin airplay_emulation to MyMusic Plugins
Dec 01 10:06:17 volumiokhv volumio[987]: info: Adding plugin upnp_browser to MyMusic Plugins
Dec 01 10:06:17 volumiokhv volumio[987]: info: Loading plugins from folder /data/plugins/
Dec 01 10:06:17 volumiokhv volumio[987]: info: Loading plugin "system"...
Dec 01 10:06:17 volumiokhv volumio[987]: info: Loading plugin "appearance"...
Dec 01 10:06:18 volumiokhv volumio[987]: info: Loading plugin "network"...
Dec 01 10:06:18 volumiokhv volumio[987]: info: Refreshing Cached IP Addresses
Dec 01 10:06:18 volumiokhv sudo[1037]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Dec 01 10:06:18 volumiokhv sudo[1037]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 01 10:06:18 volumiokhv sudo[1037]: pam_unix(sudo:session): session closed for user root
Dec 01 10:06:18 volumiokhv sudo[1039]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Dec 01 10:06:18 volumiokhv sudo[1039]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 01 10:06:18 volumiokhv volumio[987]: info: Loading plugin "services"...
Dec 01 10:06:18 volumiokhv sudo[1039]: pam_unix(sudo:session): session closed for user root
Dec 01 10:06:18 volumiokhv volumio[987]: info: Loading plugin "alsa_controller"...
Dec 01 10:06:18 volumiokhv sudo[1048]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Dec 01 10:06:18 volumiokhv sudo[1048]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 01 10:06:18 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 01 10:06:18 volumiokhv volumio[987]: info: Loading plugin "wizard"...
Dec 01 10:06:18 volumiokhv volumio[987]: info: Loading plugin "networkfs"...
Dec 01 10:06:18 volumiokhv sudo[1065]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=musicshare,password=oofahSh3,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.15/musicshare /mnt/NAS/Musik
Dec 01 10:06:18 volumiokhv sudo[1065]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 01 10:06:18 volumiokhv sudo[1067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=musicshare,password=oofahSh3,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.15/musicshare_new /mnt/NAS/Musik_neu
Dec 01 10:06:18 volumiokhv volumio[987]: info: Starting Udev Watcher for removable devices
Dec 01 10:06:18 volumiokhv sudo[1067]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 01 10:06:18 volumiokhv sudo[1070]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=musicshare,password=oofahSh3,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.15/musicshare_hires /mnt/NAS/Musicshare_HiRes
Dec 01 10:06:18 volumiokhv sudo[1070]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 01 10:06:18 volumiokhv volumio[987]: info: Ignoring mount for partition: boot
Dec 01 10:06:18 volumiokhv volumio[987]: info: Ignoring mount for partition: volumio
Dec 01 10:06:18 volumiokhv volumio[987]: info: Ignoring mount for partition: volumio_data
Dec 01 10:06:18 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Dec 01 10:06:18 volumiokhv volumio[987]: info: Loading plugin "volumio_command_line_client"...
Dec 01 10:06:18 volumiokhv volumio[987]: info: Plugin upnp is not enabled
Dec 01 10:06:18 volumiokhv volumio[987]: info: Loading plugin "my_music"...
Dec 01 10:06:18 volumiokhv volumio[987]: info: Loading plugin "mpd"...
Dec 01 10:06:18 volumiokhv kernel: Key type cifs.spnego registered
Dec 01 10:06:18 volumiokhv kernel: Key type cifs.idmap registered
Dec 01 10:06:18 volumiokhv 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.
Dec 01 10:06:18 volumiokhv kernel: CIFS: Attempting to mount //192.168.1.15/musicshare_hires
Dec 01 10:06:19 volumiokhv volumio[987]: info: Plugin upnp_browser is not enabled
Dec 01 10:06:19 volumiokhv volumio[987]: info: Loading plugin "alarm-clock"...
Dec 01 10:06:19 volumiokhv sudo[1070]: pam_unix(sudo:session): session closed for user root
Dec 01 10:06:19 volumiokhv volumio[987]: info: Plugin airplay_emulation is not enabled
Dec 01 10:06:19 volumiokhv volumio[987]: info: Loading plugin "last_100"...
Dec 01 10:06:19 volumiokhv kernel: CIFS: Attempting to mount //192.168.1.15/musicshare
Dec 01 10:06:19 volumiokhv volumio[987]: info: Loading plugin "webradio"...
Dec 01 10:06:19 volumiokhv sudo[1065]: pam_unix(sudo:session): session closed for user root
Dec 01 10:06:19 volumiokhv kernel: CIFS: Attempting to mount //192.168.1.15/musicshare_new
Dec 01 10:06:19 volumiokhv volumio[987]: info: Loading plugin "i2s_dacs"...
Dec 01 10:06:19 volumiokhv volumio[987]: info: Loading plugin "volumiodiscovery"...
Dec 01 10:06:19 volumiokhv sudo[1067]: pam_unix(sudo:session): session closed for user root
Dec 01 10:06:19 volumiokhv volumio[987]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Dec 01 10:06:19 volumiokhv volumio[987]: *** WARNING *** Please fix your application to use the native API of Avahi!
Dec 01 10:06:19 volumiokhv volumio[987]: *** WARNING *** For more information see
Dec 01 10:06:19 volumiokhv node[987]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Dec 01 10:06:19 volumiokhv volumio[987]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Dec 01 10:06:19 volumiokhv volumio[987]: *** WARNING *** Please fix your application to use the native API of Avahi!
Dec 01 10:06:19 volumiokhv volumio[987]: *** WARNING *** For more information see
Dec 01 10:06:19 volumiokhv node[987]: *** WARNING *** Please fix your application to use the native API of Avahi!
Dec 01 10:06:19 volumiokhv node[987]: *** WARNING *** For more information see
Dec 01 10:06:19 volumiokhv node[987]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Dec 01 10:06:19 volumiokhv node[987]: *** WARNING *** Please fix your application to use the native API of Avahi!
Dec 01 10:06:19 volumiokhv node[987]: *** WARNING *** For more information see
Dec 01 10:06:19 volumiokhv volumio[987]: info: Applying required configuration parameters for plugin volumiodiscovery
Dec 01 10:06:19 volumiokhv volumio[987]: info: Discovery: Started advertising with name: VolumioKHV
Dec 01 10:06:19 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Dec 01 10:06:19 volumiokhv volumio[987]: info: Loading plugin "gpio-buttons"...
Dec 01 10:06:19 volumiokhv volumio[987]: info: GPIO-Buttons initialized
Dec 01 10:06:19 volumiokhv volumio[987]: info: Loading plugin "outputs"...
Dec 01 10:06:19 volumiokhv volumio[987]: info: Loading plugin "albumart"...
Dec 01 10:06:19 volumiokhv volumio[987]: info: Plugin example_plugin is not enabled
Dec 01 10:06:19 volumiokhv volumio[987]: info: Loading plugin "inputs"...
Dec 01 10:06:19 volumiokhv volumio[987]: info: Loading plugin "updater_comm"...
Dec 01 10:06:20 volumiokhv volumio[987]: info: Plugin mpdemulation is not enabled
Dec 01 10:06:20 volumiokhv volumio[987]: info: Loading plugin "rest_api"...
Dec 01 10:06:20 volumiokhv volumio[987]: info: Loading plugin "websocket"...
Dec 01 10:06:20 volumiokhv volumio[987]: info: Starting Socket.io Server version 2.3.0
Dec 01 10:06:20 volumiokhv volumio[987]: info: Loading plugin "fusiondsp"...
Dec 01 10:06:20 volumiokhv volumio[987]: Forking 3 albumart workers
Dec 01 10:06:20 volumiokhv volumio[987]: info: Applying required configuration parameters for plugin fusiondsp
Dec 01 10:06:20 volumiokhv volumio[987]: info: Loading plugin "podcast"...
Dec 01 10:06:20 volumiokhv volumio[987]: Starting albumart workers
Dec 01 10:06:20 volumiokhv volumio[987]: Starting albumart workers
Dec 01 10:06:20 volumiokhv volumio[987]: Starting albumart workers
Dec 01 10:06:20 volumiokhv volumio[987]: info: ControllerPodcast::constructor
Dec 01 10:06:21 volumiokhv systemd[1]: systemd-fsckd.service: Succeeded.
Dec 01 10:06:21 volumiokhv volumio[987]: info: Loading plugin "Systeminfo"...
Dec 01 10:06:21 volumiokhv volumio[987]: info: Loading i18n strings for locale de
Dec 01 10:06:21 volumiokhv volumio[987]: Updating browse sources language
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreCommandRouter::initPlayerControls
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Dec 01 10:06:21 volumiokhv volumio[987]: Express server listening on port 3000
Dec 01 10:06:21 volumiokhv volumio[987]: [Metrics] WebUI: 5s 666.72ms
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreStateMachine::resetVolumioState
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreStateMachine::getcurrentVolume
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreCommandRouter::volumioRetrievevolume
Dec 01 10:06:21 volumiokhv volumio[987]: info: Volumio Network Manager: Network status updated: 2
Dec 01 10:06:21 volumiokhv volumio-remote-updater[578]: [2024-12-01 10:06:21] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1733043976 101
Dec 01 10:06:21 volumiokhv volumio[987]: 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
Dec 01 10:06:21 volumiokhv volumio[987]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 01 10:06:21 volumiokhv volumio[987]: info: Executing start script for DAC IQaudIO DAC Plus
Dec 01 10:06:21 volumiokhv volumio[987]: info: Reloading queue from file
Dec 01 10:06:21 volumiokhv volumio[987]: info: VolumeController:: Volume=86 Mute =false
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreStateMachine::pushState
Dec 01 10:06:21 volumiokhv volumio[987]: info: CorePlayQueue::getTrack 0
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreCommandRouter::volumioPushState
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreStateMachine::updateTrackBlock
Dec 01 10:06:21 volumiokhv volumio[987]: info: CorePlayQueue::getTrackBlock
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreCommandRouter::volumioRetrievevolume
Dec 01 10:06:21 volumiokhv volumio[987]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb
Dec 01 10:06:21 volumiokhv volumio[987]: info: USB Boot Capable - System SBC Revision found in cpuinfo: b03115
Dec 01 10:06:21 volumiokhv volumio[987]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreStateMachine::setRepeat null single undefined
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreStateMachine::pushState
Dec 01 10:06:21 volumiokhv volumio[987]: info: CorePlayQueue::getTrack 0
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreCommandRouter::volumioPushState
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreStateMachine::setRandom null
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreStateMachine::pushState
Dec 01 10:06:21 volumiokhv volumio[987]: info: CorePlayQueue::getTrack 0
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreCommandRouter::volumioPushState
Dec 01 10:06:21 volumiokhv volumio[987]: info: Setting Device type: Raspberry PI
Dec 01 10:06:21 volumiokhv volumio[987]: info: DAC script executed
Dec 01 10:06:21 volumiokhv volumio[987]: info: Completed loading Core Plugins
Dec 01 10:06:21 volumiokhv volumio[987]: info: Preparing to generate the ALSA configuration file
Dec 01 10:06:21 volumiokhv volumio[987]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Dec 01 10:06:21 volumiokhv volumio[987]: info: Reading ALSA contributions from plugins.
Dec 01 10:06:21 volumiokhv volumio[987]: info: Discovery: adding e0ed2b2d-5c9b-4828-8bd9-ec133ab8cc1b
Dec 01 10:06:21 volumiokhv volumio[987]: info: Discovery: Found device VolumioKHV
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreCommandRouter::volumioGetState
Dec 01 10:06:21 volumiokhv volumio[987]: info: CorePlayQueue::getTrack 0
Dec 01 10:06:21 volumiokhv volumio[987]: info: VolumeController:: Volume=86 Mute =false
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreStateMachine::pushState
Dec 01 10:06:21 volumiokhv volumio[987]: info: CorePlayQueue::getTrack 0
Dec 01 10:06:21 volumiokhv volumio[987]: info: CoreCommandRouter::volumioPushState
Dec 01 10:06:21 volumiokhv volumio[987]: info: Asound.conf file unchanged, so no further update is needed
Dec 01 10:06:21 volumiokhv volumio[987]: info: Output device has changed, restarting MPD
Dec 01 10:06:21 volumiokhv sudo[1175]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 01 10:06:22 volumiokhv volumio[987]: info: ___________ START PLUGINS ___________
Dec 01 10:06:22 volumiokhv sudo[1175]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 01 10:06:22 volumiokhv sudo[1175]: pam_unix(sudo:session): session closed for user root
Dec 01 10:06:22 volumiokhv volumio[987]: info: ControllerMpd::onStart: Initializing MPD
Dec 01 10:06:22 volumiokhv volumio[987]: info: Creating MPD Configuration file
Dec 01 10:06:22 volumiokhv sudo[1177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Dec 01 10:06:22 volumiokhv sudo[1177]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 01 10:06:22 volumiokhv systemd[1]: Stopping Music Player Daemon...
Dec 01 10:06:22 volumiokhv sudo[1181]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 01 10:06:22 volumiokhv sudo[1181]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 01 10:06:22 volumiokhv sudo[1181]: pam_unix(sudo:session): session closed for user root
Dec 01 10:06:22 volumiokhv sudo[1183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Dec 01 10:06:22 volumiokhv sudo[1183]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Dec 01 10:06:22 volumiokhv volumio[987]: info: [1733043982049] CoreMusicLibrary::Adding element Last_100
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Dec 01 10:06:22 volumiokhv volumio[987]: info: [1733043982063] CoreMusicLibrary::Adding element Webradio
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 01 10:06:22 volumiokhv volumio[987]: info: Initializing BBC Radios
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 01 10:06:22 volumiokhv volumio[987]: info: GPIO-Buttons: Reading config and creating triggers...
Dec 01 10:06:22 volumiokhv volumio[987]: info: GPIO-Buttons: playPause on pin 17
Dec 01 10:06:22 volumiokhv volumio[987]: error: Plugin gpio-buttons failed to start! Error: EINVAL: invalid argument, write
Dec 01 10:06:22 volumiokhv kernel: export_store: invalid GPIO 17
Dec 01 10:06:22 volumiokhv volumio[987]: info: Loading i18n strings for locale de
Dec 01 10:06:22 volumiokhv systemd[1]: mpd.service: Succeeded.
Dec 01 10:06:22 volumiokhv systemd[1]: Stopped Music Player Daemon.
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:22 volumiokhv volumio[987]: info: FusionDsp - mixtype--------------------- Hardware
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Dec 01 10:06:22 volumiokhv volumio[987]: info: [1733043982159] CoreMusicLibrary::Adding element Podcast
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 01 10:06:22 volumiokhv volumio[987]: Cannot find translation for source Podcast
Dec 01 10:06:22 volumiokhv volumio[987]: info: Volumio Calling Home
Dec 01 10:06:22 volumiokhv volumio[987]: info: Preparing to generate the ALSA configuration file
Dec 01 10:06:22 volumiokhv systemd[1]: Starting Music Player Daemon...
Dec 01 10:06:22 volumiokhv volumio[987]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Dec 01 10:06:22 volumiokhv volumio[987]: info: Reading ALSA contributions from plugins.
Dec 01 10:06:22 volumiokhv volumio[987]: info: MPD Permissions set
Dec 01 10:06:22 volumiokhv volumio[987]: info: MPD Permissions set
Dec 01 10:06:22 volumiokhv volumio[987]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:22 volumiokhv sudo[1196]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:22 volumiokhv sudo[1196]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 01 10:06:22 volumiokhv sudo[1196]: pam_unix(sudo:session): session closed for user root
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::volumioGetState
Dec 01 10:06:22 volumiokhv volumio[987]: info: CorePlayQueue::getTrack 0
Dec 01 10:06:22 volumiokhv volumio[987]: info: Asound.conf file unchanged, so no further update is needed
Dec 01 10:06:22 volumiokhv volumio[987]: info: Output device has changed, restarting MPD
Dec 01 10:06:22 volumiokhv sudo[1211]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Dec 01 10:06:22 volumiokhv sudo[1211]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 01 10:06:22 volumiokhv sudo[1211]: pam_unix(sudo:session): session closed for user root
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:22 volumiokhv sudo[1213]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Dec 01 10:06:22 volumiokhv sudo[1213]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:22 volumiokhv systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Dec 01 10:06:22 volumiokhv systemd[1]: mpd.service: Succeeded.
Dec 01 10:06:22 volumiokhv systemd[1]: Stopped Music Player Daemon.
Dec 01 10:06:22 volumiokhv volumio[987]: info: MPD Permissions set
Dec 01 10:06:22 volumiokhv systemd[1]: Starting Music Player Daemon...
Dec 01 10:06:22 volumiokhv sudo[1220]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Dec 01 10:06:22 volumiokhv sudo[1220]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 01 10:06:22 volumiokhv sudo[1220]: pam_unix(sudo:session): session closed for user root
Dec 01 10:06:22 volumiokhv sudo[1048]: pam_unix(sudo:session): session closed for user root
Dec 01 10:06:22 volumiokhv volumio[987]: info: Volumio called home
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Dec 01 10:06:22 volumiokhv volumio[987]: info: Discovery: Getting this device information
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::volumioGetState
Dec 01 10:06:22 volumiokhv volumio[987]: info: CorePlayQueue::getTrack 0
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 01 10:06:22 volumiokhv volumio[987]: verbose: New Socket.io Connection to 192.168.1.65:3000 from 192.168.1.202 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::volumioGetState
Dec 01 10:06:22 volumiokhv volumio[987]: info: CorePlayQueue::getTrack 0
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Dec 01 10:06:22 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Dec 01 10:06:23 volumiokhv mpd[1224]: Dec 01 10:06 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Dec 01 10:06:23 volumiokhv systemd[1]: Started Music Player Daemon.
Dec 01 10:06:23 volumiokhv sudo[1213]: pam_unix(sudo:session): session closed for user root
Dec 01 10:06:23 volumiokhv sudo[1183]: pam_unix(sudo:session): session closed for user root
Dec 01 10:06:23 volumiokhv sudo[1177]: pam_unix(sudo:session): session closed for user root
Dec 01 10:06:23 volumiokhv volumio[987]: info: Completed starting Core Plugins
Dec 01 10:06:23 volumiokhv volumio[987]: info: -------------------------------------------
Dec 01 10:06:23 volumiokhv volumio[987]: info: ----- MyVolumio plugins startup ----
Dec 01 10:06:23 volumiokhv volumio[987]: info: -------------------------------------------
Dec 01 10:06:23 volumiokhv volumio[987]: info: [MyVolumio PluginManager] Fetching plans data....
Dec 01 10:06:23 volumiokhv volumio[987]: error: MPD error: The expression evaluated to a falsy value:
Dec 01 10:06:23 volumiokhv volumio[987]: assert.ok(self.idling)
Dec 01 10:06:23 volumiokhv volumio[987]: error: The expression evaluated to a falsy value:
Dec 01 10:06:23 volumiokhv volumio[987]: assert.ok(self.idling)
Dec 01 10:06:23 volumiokhv volumio[987]: error: MPD error: The expression evaluated to a falsy value:
Dec 01 10:06:23 volumiokhv volumio[987]: assert.ok(self.idling)
Dec 01 10:06:23 volumiokhv volumio[987]: error: The expression evaluated to a falsy value:
Dec 01 10:06:23 volumiokhv volumio[987]: assert.ok(self.idling)
Dec 01 10:06:23 volumiokhv volumio[987]: info: MPD running with PID1224
Dec 01 10:06:23 volumiokhv volumio[987]: ,establishing connection
Dec 01 10:06:23 volumiokhv volumio[987]: error: MPD error: The expression evaluated to a falsy value:
Dec 01 10:06:23 volumiokhv volumio[987]: assert.ok(self.idling)
Dec 01 10:06:23 volumiokhv volumio[987]: error: The expression evaluated to a falsy value:
Dec 01 10:06:23 volumiokhv volumio[987]: assert.ok(self.idling)
Dec 01 10:06:23 volumiokhv volumio[987]: error: updateQueue error: null
Dec 01 10:06:23 volumiokhv sh[504]: timed out
Dec 01 10:06:23 volumiokhv dhcpcd[543]: timed out
Dec 01 10:06:23 volumiokhv sh[504]: dhcpcd exited
Dec 01 10:06:23 volumiokhv dhcpcd[543]: dhcpcd exited
Dec 01 10:06:23 volumiokhv sh[504]: ifup: failed to bring up eth0
Dec 01 10:06:23 volumiokhv systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE
Dec 01 10:06:23 volumiokhv systemd[1]: ifup@eth0.service: Failed with result 'exit-code'.
Dec 01 10:06:24 volumiokhv volumio[987]: info: camilladsp spawned new process with pid undefined, instance 1, run: true
Dec 01 10:06:24 volumiokhv volumio[987]: info: camilladsp service started and running in background, instance 1
Dec 01 10:06:24 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Dec 01 10:06:24 volumiokhv volumio[987]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Dec 01 10:06:24 volumiokhv volumio[987]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
Dec 01 10:06:24 volumiokhv volumio[987]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Dec 01 10:06:24 volumiokhv volumio[987]: info: FusionDsp loaded
Dec 01 10:06:24 volumiokhv volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Dec 01 10:06:24 volumiokhv sudo[1241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Dec 01 10:06:24 volumiokhv sudo[1241]: pam_unix(sudo:session): session opened for user root by (uid=0)
Dec 01 10:06:24 volumiokhv volumio[987]: info: FusionDsp - Reporting Fusion DSP Enabled
Dec 01 10:06:24 volumiokhv volumio[987]: info: Adding Signal Path Element [object Object]
Dec 01 10:06:24 volumiokhv volumio[987]: info: Adding fusiondspeq DSP Signal Path Element
Dec 01 10:06:24 volumiokhv volumio[987]: info: FusionDsp - ---- installed callbackRead
Dec 01 10:06:24 volumiokhv volumio[987]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 01 10:06:24 volumiokhv volumio[987]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Dec 01 10:06:24 volumiokhv volumio[987]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
Dec 01 10:06:24 volumiokhv volumio[987]: at onErrorNT (internal/child_process.js:465:16)
Dec 01 10:06:24 volumiokhv volumio[987]: at processTicksAndRejections (internal/process/task_queues.js:80:21) {
Dec 01 10:06:24 volumiokhv volumio[987]: errno: -2,
Dec 01 10:06:24 volumiokhv volumio[987]: code: 'ENOENT',
Dec 01 10:06:24 volumiokhv volumio[987]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Dec 01 10:06:24 volumiokhv volumio[987]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Dec 01 10:06:24 volumiokhv volumio[987]: spawnargs: [
Dec 01 10:06:24 volumiokhv volumio[987]: '-p',
Dec 01 10:06:24 volumiokhv volumio[987]: 9876,
Dec 01 10:06:24 volumiokhv volumio[987]: '-o',
Dec 01 10:06:24 volumiokhv volumio[987]: '/tmp/camilladsp.log',
Dec 01 10:06:24 volumiokhv volumio[987]: '-l',
Dec 01 10:06:24 volumiokhv volumio[987]: 'warn',
Dec 01 10:06:24 volumiokhv volumio[987]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Dec 01 10:06:24 volumiokhv volumio[987]: ]
Dec 01 10:06:24 volumiokhv volumio[987]: }
Dec 01 10:06:24 volumiokhv volumio[987]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 01 10:06:24 volumiokhv systemd[1]: Started FusionDsp Daemon.
Dec 01 10:06:24 volumiokhv sudo[1241]: pam_unix(sudo:session): session closed for user root
Dec 01 10:06:24 volumiokhv volumio[1243]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Dec 01 10:06:24 volumiokhv systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Dec 01 10:06:24 volumiokhv systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Dec 01 10:06:24 volumiokhv sudo[1253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-12-01 10:05
Dec 01 10:06:24 volumiokhv sudo[1253]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET"
VOLUMIO_VERSION="3.779"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"