-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Mon 2025-05-12 17:34:45 CEST. -- May 12 17:34:14 volumio systemd-timedated[764]: Changed local time to Mon May 12 17:34:14 2025 May 12 17:34:14 volumio sudo[757]: pam_unix(sudo:session): session closed for user root May 12 17:34:14 volumio volumio-time-update[475]: volumio-time-update-util: System time updated successfully. May 12 17:34:14 volumio systemd[1]: Started Volumio Time Update Utility. May 12 17:34:14 volumio systemd[1]: Reached target Multi-User System. May 12 17:34:14 volumio systemd[1]: Reached target Graphical Interface. May 12 17:34:14 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... May 12 17:34:14 volumio systemd[1]: Starting Daily apt download activities... May 12 17:34:14 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. May 12 17:34:14 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. May 12 17:34:14 volumio volumio-remote-updater[472]: [2025-05-12 17:34:14] [connect] Successful connection May 12 17:34:15 volumio volumio[678]: info: ------------------------------------------- May 12 17:34:15 volumio volumio[678]: info: ----- Volumio3 ---- May 12 17:34:15 volumio volumio[678]: info: ------------------------------------------- May 12 17:34:15 volumio volumio[678]: info: ----- System startup ---- May 12 17:34:15 volumio volumio[678]: info: ------------------------------------------- May 12 17:34:16 volumio systemd[1]: apt-daily.service: Succeeded. May 12 17:34:16 volumio systemd[1]: Started Daily apt download activities. May 12 17:34:16 volumio systemd[1]: Starting Daily apt upgrade and clean activities... May 12 17:34:18 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. May 12 17:34:18 volumio systemd[1]: Started Daily apt upgrade and clean activities. May 12 17:34:18 volumio volumio[678]: info: MYVOLUMIO Environment detected May 12 17:34:19 volumio volumio[678]: info: Plugin folders cleanup May 12 17:34:19 volumio volumio[678]: info: Scanning into folder /volumio/app/plugins/ May 12 17:34:19 volumio volumio[678]: info: Scanning category audio_interface May 12 17:34:19 volumio volumio[678]: info: Scanning category miscellanea May 12 17:34:19 volumio volumio[678]: info: Scanning category music_service May 12 17:34:19 volumio volumio[678]: info: Scanning category plugins.json May 12 17:34:19 volumio volumio[678]: info: Scanning category system_controller May 12 17:34:19 volumio volumio[678]: info: Scanning category user_interface May 12 17:34:19 volumio volumio[678]: info: Scanning into folder /data/plugins/ May 12 17:34:19 volumio volumio[678]: info: Plugin folders cleanup completed May 12 17:34:19 volumio volumio[678]: info: ------------------------------------------- May 12 17:34:19 volumio volumio[678]: info: ----- Core plugins startup ---- May 12 17:34:19 volumio volumio[678]: info: ------------------------------------------- May 12 17:34:19 volumio volumio[678]: info: Loading plugins from folder /volumio/app/plugins/ May 12 17:34:19 volumio volumio[678]: info: Adding plugin upnp to MyMusic Plugins May 12 17:34:19 volumio volumio[678]: info: Adding plugin airplay_emulation to MyMusic Plugins May 12 17:34:19 volumio volumio[678]: info: Adding plugin upnp_browser to MyMusic Plugins May 12 17:34:19 volumio volumio[678]: info: Loading plugins from folder /data/plugins/ May 12 17:34:19 volumio volumio[678]: info: Loading plugin "system"... May 12 17:34:19 volumio volumio[678]: info: Loading plugin "appearance"... May 12 17:34:23 volumio volumio[678]: info: Loading plugin "network"... May 12 17:34:23 volumio volumio[678]: info: Refreshing Cached IP Addresses May 12 17:34:23 volumio sudo[882]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 12 17:34:23 volumio sudo[882]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:34:23 volumio sudo[884]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 12 17:34:23 volumio sudo[884]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:34:23 volumio sudo[882]: pam_unix(sudo:session): session closed for user root May 12 17:34:23 volumio sudo[884]: pam_unix(sudo:session): session closed for user root May 12 17:34:23 volumio systemd[1]: Started Music Player Daemon. May 12 17:34:23 volumio mpd_monitor.sh[459]: MPD Monitor Service: MPD restarted due to no mpc output. May 12 17:34:23 volumio systemd[1]: Startup finished in 15.092s (kernel) + 32.854s (userspace) = 47.946s. May 12 17:34:23 volumio volumio[678]: info: Loading plugin "services"... May 12 17:34:23 volumio volumio[678]: info: Loading plugin "alsa_controller"... May 12 17:34:23 volumio sudo[898]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 12 17:34:23 volumio sudo[898]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:34:24 volumio sudo[898]: pam_unix(sudo:session): session closed for user root May 12 17:34:24 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 12 17:34:24 volumio volumio[678]: info: Loading plugin "wizard"... May 12 17:34:24 volumio volumio[678]: info: Loading plugin "networkfs"... May 12 17:34:24 volumio volumio[678]: info: Starting Udev Watcher for removable devices May 12 17:34:24 volumio sudo[917]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.0.32:/volume1/music/flac /mnt/NAS/GlobalFlac May 12 17:34:24 volumio sudo[917]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:34:24 volumio sudo[919]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Musico,password=8Sc95tKd,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.10/Smartphone Music /mnt/NAS/SmartphoneMusic May 12 17:34:24 volumio sudo[919]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:34:24 volumio volumio[678]: info: Ignoring mount for partition: boot May 12 17:34:24 volumio volumio[678]: info: Ignoring mount for partition: volumio May 12 17:34:24 volumio volumio[678]: info: Ignoring mount for partition: volumio_data May 12 17:34:24 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 12 17:34:24 volumio volumio[678]: info: Loading plugin "volumio_command_line_client"... May 12 17:34:24 volumio volumio[678]: info: Loading plugin "upnp"... May 12 17:34:24 volumio volumio[678]: info: [1747064064488] Starting Upmpd Daemon May 12 17:34:24 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 12 17:34:24 volumio volumio[678]: info: Loading plugin "my_music"... May 12 17:34:24 volumio volumio[678]: info: Loading plugin "mpd"... May 12 17:34:24 volumio systemd[1]: /lib/systemd/system/rpc-statd.service:13: PIDFile= references path below legacy directory /var/run/, updating /var/run/rpc.statd.pid → /run/rpc.statd.pid; please update the unit file accordingly. May 12 17:34:24 volumio systemd[1]: Reached target Host and Network Name Lookups. May 12 17:34:24 volumio systemd[1]: Starting Preprocess NFS configuration... May 12 17:34:24 volumio kernel: Key type cifs.spnego registered May 12 17:34:24 volumio kernel: Key type cifs.idmap registered May 12 17:34:24 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. May 12 17:34:24 volumio kernel: CIFS: Attempting to mount //192.168.0.10/Smartphone Music May 12 17:34:24 volumio systemd[1]: nfs-config.service: Succeeded. May 12 17:34:24 volumio systemd[1]: Started Preprocess NFS configuration. May 12 17:34:24 volumio systemd[1]: Starting NFS status monitor for NFSv2/3 locking.... May 12 17:34:24 volumio systemd[1]: Starting Notify NFS peers of a restart... May 12 17:34:24 volumio sm-notify[948]: Version 1.3.3 starting May 12 17:34:25 volumio systemd[1]: rpc-statd-notify.service: Succeeded. May 12 17:34:25 volumio systemd[1]: Started Notify NFS peers of a restart. May 12 17:34:25 volumio rpc.statd[958]: Version 1.3.3 starting May 12 17:34:25 volumio rpc.statd[958]: Flags: TI-RPC May 12 17:34:25 volumio kernel: cryptd: max_cpu_qlen set to 1000 May 12 17:34:25 volumio systemd[1]: Started NFS status monitor for NFSv2/3 locking.. May 12 17:34:25 volumio sudo[919]: pam_unix(sudo:session): session closed for user root May 12 17:34:25 volumio sudo[917]: pam_unix(sudo:session): session closed for user root May 12 17:34:26 volumio volumio[678]: info: Loading plugin "upnp_browser"... May 12 17:34:27 volumio volumio[678]: info: Loading plugin "alarm-clock"... May 12 17:34:27 volumio volumio[678]: info: Loading plugin "airplay_emulation"... May 12 17:34:27 volumio volumio[678]: info: Starting Shairport Sync May 12 17:34:27 volumio volumio[678]: info: Loading plugin "last_100"... May 12 17:34:27 volumio volumio[678]: info: Loading plugin "webradio"... May 12 17:34:28 volumio volumio[678]: info: Loading plugin "i2s_dacs"... May 12 17:34:28 volumio volumio[678]: info: Loading plugin "volumiodiscovery"... May 12 17:34:28 volumio volumio[678]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 12 17:34:28 volumio volumio[678]: *** WARNING *** Please fix your application to use the native API of Avahi! May 12 17:34:28 volumio volumio[678]: *** WARNING *** For more information see May 12 17:34:28 volumio node[678]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 12 17:34:28 volumio volumio[678]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 12 17:34:28 volumio volumio[678]: *** WARNING *** Please fix your application to use the native API of Avahi! May 12 17:34:28 volumio volumio[678]: *** WARNING *** For more information see May 12 17:34:28 volumio node[678]: *** WARNING *** Please fix your application to use the native API of Avahi! May 12 17:34:28 volumio node[678]: *** WARNING *** For more information see May 12 17:34:28 volumio node[678]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 12 17:34:28 volumio node[678]: *** WARNING *** Please fix your application to use the native API of Avahi! May 12 17:34:28 volumio node[678]: *** WARNING *** For more information see May 12 17:34:28 volumio volumio[678]: info: Applying required configuration parameters for plugin volumiodiscovery May 12 17:34:28 volumio volumio[678]: info: Discovery: Started advertising with name: Volumio May 12 17:34:28 volumio systemd[1]: systemd-fsckd.service: Succeeded. May 12 17:34:28 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 12 17:34:28 volumio volumio[678]: info: Loading plugin "outputs"... May 12 17:34:28 volumio volumio[678]: info: Loading plugin "albumart"... May 12 17:34:28 volumio volumio[678]: info: Plugin example_plugin is not enabled May 12 17:34:28 volumio volumio[678]: info: Loading plugin "inputs"... May 12 17:34:28 volumio volumio[678]: info: Loading plugin "updater_comm"... May 12 17:34:29 volumio volumio[678]: info: Plugin mpdemulation is not enabled May 12 17:34:29 volumio volumio[678]: info: Loading plugin "rest_api"... May 12 17:34:29 volumio volumio[678]: info: Loading plugin "websocket"... May 12 17:34:29 volumio volumio[678]: info: Starting Socket.io Server version 2.3.0 May 12 17:34:29 volumio volumio[678]: info: Loading i18n strings for locale fr May 12 17:34:29 volumio volumio[678]: Updating browse sources language May 12 17:34:29 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 12 17:34:29 volumio volumio[678]: Forking 3 albumart workers May 12 17:34:29 volumio volumio-remote-updater[472]: [2025-05-12 17:34:29] [connect] Successful connection May 12 17:34:29 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 12 17:34:29 volumio volumio[678]: info: CoreCommandRouter::initPlayerControls May 12 17:34:29 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:29 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:29 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:29 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:29 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:29 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:29 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:29 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:29 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 12 17:34:30 volumio volumio[678]: Express server listening on port 3000 May 12 17:34:30 volumio volumio[678]: [Metrics] WebUI: 17s 643.29ms May 12 17:34:30 volumio volumio[678]: info: CoreStateMachine::resetVolumioState May 12 17:34:30 volumio volumio[678]: info: CoreStateMachine::getcurrentVolume May 12 17:34:30 volumio volumio[678]: info: CoreCommandRouter::volumioRetrievevolume May 12 17:34:30 volumio volumio[678]: info: Volumio Network Manager: Network status updated: 1 May 12 17:34:30 volumio volumio[678]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan May 12 17:34:30 volumio volumio[678]: wlan0 Interface doesn't support scanning. May 12 17:34:30 volumio volumio[678]: info: Cannot use regular scanning, forcing with ap-force May 12 17:34:30 volumio sudo[1012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force May 12 17:34:30 volumio sudo[1012]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:34:30 volumio sudo[1012]: pam_unix(sudo:session): session closed for user root May 12 17:34:30 volumio volumio[678]: command failed: No such device (-19) May 12 17:34:30 volumio volumio[678]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force May 12 17:34:30 volumio volumio[678]: command failed: No such device (-19) May 12 17:34:30 volumio volumio-remote-updater[472]: [2025-05-12 17:34:30] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1747064069 101 May 12 17:34:30 volumio volumio[678]: 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 May 12 17:34:31 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 17:34:31 volumio volumio[678]: info: Reloading queue from file May 12 17:34:31 volumio volumio[678]: info: VolumeController:: Volume=75 Mute =false May 12 17:34:31 volumio volumio[678]: info: CoreStateMachine::pushState May 12 17:34:31 volumio volumio[678]: info: CorePlayQueue::getTrack 0 May 12 17:34:31 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 17:34:31 volumio volumio[678]: info: CoreCommandRouter::volumioPushState May 12 17:34:31 volumio volumio[678]: info: CoreStateMachine::updateTrackBlock May 12 17:34:31 volumio volumio[678]: info: CorePlayQueue::getTrackBlock May 12 17:34:31 volumio volumio[678]: info: CoreCommandRouter::volumioRetrievevolume May 12 17:34:31 volumio volumio[678]: info: CoreStateMachine::setRepeat undefined single undefined May 12 17:34:31 volumio volumio[678]: info: CoreStateMachine::pushState May 12 17:34:31 volumio volumio[678]: info: CorePlayQueue::getTrack 0 May 12 17:34:31 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 17:34:31 volumio volumio[678]: info: CoreCommandRouter::volumioPushState May 12 17:34:31 volumio volumio[678]: info: CoreStateMachine::setRandom true May 12 17:34:31 volumio volumio[678]: info: CoreStateMachine::pushState May 12 17:34:31 volumio volumio[678]: info: CorePlayQueue::getTrack 0 May 12 17:34:31 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 12 17:34:31 volumio volumio[678]: info: CoreCommandRouter::volumioPushState May 12 17:34:31 volumio volumio[678]: info: Setting Device type: Raspberry PI May 12 17:34:31 volumio volumio[678]: info: Completed loading Core Plugins May 12 17:34:31 volumio volumio[678]: info: Preparing to generate the ALSA configuration file May 12 17:34:31 volumio volumio[678]: Starting albumart workers May 12 17:34:31 volumio volumio[678]: Starting albumart workers May 12 17:34:31 volumio volumio[678]: Starting albumart workers May 12 17:34:31 volumio volumio[678]: info: Discovery: adding 13012fd6-3471-4a06-adb3-50203b7bdc02 May 12 17:34:31 volumio volumio[678]: info: Discovery: Found device Volumio May 12 17:34:31 volumio volumio[678]: info: CoreCommandRouter::volumioGetState May 12 17:34:31 volumio volumio[678]: info: CorePlayQueue::getTrack 0 May 12 17:34:32 volumio volumio[678]: info: VolumeController:: Volume=75 Mute =false May 12 17:34:32 volumio volumio[678]: info: CoreStateMachine::pushState May 12 17:34:32 volumio volumio[678]: info: CorePlayQueue::getTrack 0 May 12 17:34:32 volumio volumio[678]: info: CoreCommandRouter::volumioPushState May 12 17:34:32 volumio volumio[678]: info: Asound.conf file unchanged, so no further update is needed May 12 17:34:32 volumio volumio[678]: info: Output device has changed, restarting MPD May 12 17:34:32 volumio volumio[678]: info: Output device has changed, restarting Shairport Sync May 12 17:34:32 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:32 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 17:34:32 volumio sudo[1025]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 12 17:34:32 volumio sudo[1025]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:34:32 volumio sudo[1025]: pam_unix(sudo:session): session closed for user root May 12 17:34:32 volumio sudo[1027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 12 17:34:32 volumio sudo[1027]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:34:32 volumio volumio[678]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 12 17:34:32 volumio systemd[1]: Stopping Music Player Daemon... May 12 17:34:32 volumio volumio[678]: info: ___________ START PLUGINS ___________ May 12 17:34:32 volumio volumio[678]: info: ControllerMpd::onStart: Initializing MPD May 12 17:34:32 volumio volumio[678]: info: Creating MPD Configuration file May 12 17:34:32 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 12 17:34:32 volumio volumio[678]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 12 17:34:32 volumio volumio[678]: info: [1747064072621] CoreMusicLibrary::Adding element Serveurs Média May 12 17:34:32 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 12 17:34:32 volumio sudo[1036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 12 17:34:32 volumio sudo[1036]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:34:32 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:32 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 17:34:32 volumio sudo[1034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 12 17:34:32 volumio sudo[1034]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:34:32 volumio sudo[1034]: pam_unix(sudo:session): session closed for user root May 12 17:34:33 volumio volumio[678]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 12 17:34:33 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:33 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 17:34:33 volumio systemd[1]: mpd.service: Succeeded. May 12 17:34:33 volumio systemd[1]: Stopped Music Player Daemon. May 12 17:34:33 volumio systemd[1]: Starting Music Player Daemon... May 12 17:34:33 volumio volumio[678]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 12 17:34:33 volumio volumio[678]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 12 17:34:33 volumio volumio[678]: info: [1747064073306] CoreMusicLibrary::Adding element Last_100 May 12 17:34:33 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 12 17:34:33 volumio volumio[678]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 12 17:34:33 volumio volumio[678]: info: [1747064073321] CoreMusicLibrary::Adding element Webradio May 12 17:34:33 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 12 17:34:33 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 12 17:34:33 volumio volumio[678]: info: Initializing BBC Radios May 12 17:34:33 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 12 17:34:33 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 17:34:33 volumio sudo[1043]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 12 17:34:33 volumio sudo[1043]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:34:33 volumio volumio[678]: info: Volumio Calling Home May 12 17:34:33 volumio sudo[1043]: pam_unix(sudo:session): session closed for user root May 12 17:34:34 volumio sudo[1100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 12 17:34:34 volumio sudo[1100]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:34:34 volumio sudo[1100]: pam_unix(sudo:session): session closed for user root May 12 17:34:34 volumio sudo[1102]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 12 17:34:34 volumio sudo[1102]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:34:34 volumio volumio[678]: info: MPD Permissions set May 12 17:34:34 volumio volumio[678]: info: MPD Permissions set May 12 17:34:35 volumio sudo[1102]: pam_unix(sudo:session): session closed for user root May 12 17:34:35 volumio volumio[678]: info: Volumio called home May 12 17:34:35 volumio volumio[678]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 May 12 17:34:35 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:35 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:35 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:35 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:35 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:35 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:35 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:35 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:35 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 17:34:35 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:35 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:35 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:35 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:35 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:35 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:35 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:35 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:35 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:35 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 12 17:34:35 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 12 17:34:35 volumio volumio[678]: info: Starting Shairport Sync May 12 17:34:35 volumio volumio[678]: info: Starting Shairport Sync May 12 17:34:35 volumio volumio[678]: info: Starting Shairport Sync May 12 17:34:35 volumio sudo[1117]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 12 17:34:35 volumio sudo[1117]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:34:35 volumio sudo[1119]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 12 17:34:36 volumio sudo[1119]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:34:36 volumio sudo[1122]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 12 17:34:36 volumio sudo[1122]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:34:36 volumio sudo[1125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 12 17:34:36 volumio sudo[1125]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:34:36 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 12 17:34:36 volumio systemd[1]: shairport-sync.service: Succeeded. May 12 17:34:36 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 12 17:34:36 volumio volumio[678]: info: CoreCommandRouter::volumioGetState May 12 17:34:36 volumio volumio[678]: info: CorePlayQueue::getTrack 0 May 12 17:34:36 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 12 17:34:36 volumio sudo[1119]: pam_unix(sudo:session): session closed for user root May 12 17:34:36 volumio sudo[1117]: pam_unix(sudo:session): session closed for user root May 12 17:34:36 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 12 17:34:36 volumio systemd[1]: Started UPnP Renderer front-end to MPD. May 12 17:34:36 volumio volumio[678]: info: Shairport-Sync Started May 12 17:34:36 volumio volumio[678]: Error adding Membership: Error: addMembership EINVAL May 12 17:34:36 volumio volumio[678]: info: Shairport-Sync Started May 12 17:34:36 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM May 12 17:34:36 volumio sudo[1125]: pam_unix(sudo:session): session closed for user root May 12 17:34:36 volumio systemd[1]: shairport-sync.service: Succeeded. May 12 17:34:36 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 12 17:34:36 volumio volumio[678]: info: Upmpdcli Daemon Started May 12 17:34:36 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 12 17:34:36 volumio sudo[1122]: pam_unix(sudo:session): session closed for user root May 12 17:34:36 volumio volumio[678]: info: Shairport-Sync Started May 12 17:34:36 volumio sudo[1134]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 12 17:34:36 volumio sudo[1136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 12 17:34:36 volumio sudo[1134]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:34:36 volumio sudo[1136]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:34:36 volumio sudo[1134]: pam_unix(sudo:session): session closed for user root May 12 17:34:36 volumio sudo[1136]: pam_unix(sudo:session): session closed for user root May 12 17:34:37 volumio volumio[678]: verbose: New Socket.io Connection to 192.168.0.9 from 192.168.0.10 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:138.0) Gecko/20100101 Firefox/138.0 Engine version: 3 Transport: polling Total Clients: 3 May 12 17:34:37 volumio sudo[1142]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 12 17:34:37 volumio sudo[1142]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:34:37 volumio sudo[1142]: pam_unix(sudo:session): session closed for user root May 12 17:34:37 volumio sudo[1144]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 12 17:34:37 volumio sudo[1144]: pam_unix(sudo:session): session opened for user root by (uid=0) May 12 17:34:37 volumio sudo[1144]: pam_unix(sudo:session): session closed for user root May 12 17:34:37 volumio volumio[678]: verbose: New Socket.io Connection to 192.168.0.9 from 192.168.0.10 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:138.0) Gecko/20100101 Firefox/138.0 Engine version: 3 Transport: polling Total Clients: 4 May 12 17:34:37 volumio mpd[1059]: May 12 17:34 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 12 17:34:37 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 12 17:34:37 volumio volumio[678]: info: CoreCommandRouter::volumioGetVisibleSources May 12 17:34:37 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 12 17:34:38 volumio volumio[678]: info: CoreCommandRouter::volumioGetState May 12 17:34:38 volumio volumio[678]: info: CorePlayQueue::getTrack 0 May 12 17:34:38 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 12 17:34:38 volumio volumio[678]: info: CoreCommandRouter::volumioGetQueue May 12 17:34:38 volumio volumio[678]: info: CoreStateMachine::getQueue May 12 17:34:38 volumio volumio[678]: info: CorePlayQueue::getQueue May 12 17:34:38 volumio volumio[678]: info: Listing playlists May 12 17:34:38 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 12 17:34:38 volumio volumio[678]: info: Received Get System Info May 12 17:34:38 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 12 17:34:38 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 12 17:34:38 volumio volumio[678]: info: Discovery: Getting this device information May 12 17:34:38 volumio volumio[678]: info: CoreCommandRouter::volumioGetState May 12 17:34:38 volumio volumio[678]: info: CorePlayQueue::getTrack 0 May 12 17:34:38 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 12 17:34:38 volumio volumio[678]: info: CoreCommandRouter::volumioGetState May 12 17:34:38 volumio volumio[678]: info: CorePlayQueue::getTrack 0 May 12 17:34:38 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 12 17:34:38 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 12 17:34:39 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 12 17:34:39 volumio volumio[678]: info: Received Get System Info May 12 17:34:39 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 12 17:34:39 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 12 17:34:39 volumio volumio[678]: info: Discovery: Getting this device information May 12 17:34:39 volumio volumio[678]: info: CoreCommandRouter::volumioGetState May 12 17:34:39 volumio volumio[678]: info: CorePlayQueue::getTrack 0 May 12 17:34:39 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 12 17:34:39 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 12 17:34:41 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 12 17:34:41 volumio volumio[678]: info: Received Get System Info May 12 17:34:41 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 12 17:34:41 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 12 17:34:41 volumio volumio[678]: info: Discovery: Getting this device information May 12 17:34:41 volumio volumio[678]: info: CoreCommandRouter::volumioGetState May 12 17:34:41 volumio volumio[678]: info: CorePlayQueue::getTrack 0 May 12 17:34:41 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 12 17:34:42 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 12 17:34:44 volumio systemd[1]: systemd-timedated.service: Succeeded. May 12 17:34:44 volumio volumio[678]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 12 17:34:44 volumio volumio[678]: verbose: ControllerMpd::sendMpdCommand update May 12 17:34:44 volumio volumio[678]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 12 17:34:44 volumio kernel: hwmon hwmon1: Voltage normalised May 12 17:34:44 volumio volumio[678]: TypeError: Cannot read property 'then' of undefined May 12 17:34:44 volumio volumio[678]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:332:6) May 12 17:34:44 volumio volumio[678]: at ControllerMpd.updateDb (/volumio/app/plugins/music_service/mpd/index.js:1899:15) May 12 17:34:44 volumio volumio[678]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) May 12 17:34:44 volumio volumio[678]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1091:26) May 12 17:34:44 volumio volumio[678]: at Socket.emit (events.js:315:20) May 12 17:34:44 volumio volumio[678]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 May 12 17:34:44 volumio volumio[678]: at processTicksAndRejections (internal/process/task_queues.js:75:11) May 12 17:34:44 volumio volumio[678]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 12 17:34:45 volumio sudo[1177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-12 17:33 May 12 17:34:45 volumio sudo[1177]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Apr 2025 09:33:57 AM CEST" VOLUMIO_VERSION="3.804" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="354f95cf0a6c2cbcd57b1aca3179c81c"