-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Sun 2026-02-22 12:22:09 CET. -- Feb 22 12:21:00 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading plugin "network"... Feb 22 12:21:00 ta-mp1260-dig-in-1---volumio volumio[995]: info: Refreshing Cached IP Addresses Feb 22 12:21:00 ta-mp1260-dig-in-1---volumio sudo[1067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 22 12:21:00 ta-mp1260-dig-in-1---volumio sudo[1067]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 12:21:00 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading plugin "services"... Feb 22 12:21:00 ta-mp1260-dig-in-1---volumio sudo[1069]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 22 12:21:00 ta-mp1260-dig-in-1---volumio sudo[1067]: pam_unix(sudo:session): session closed for user root Feb 22 12:21:00 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading plugin "volumio5onboarding"... Feb 22 12:21:00 ta-mp1260-dig-in-1---volumio sudo[1069]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 12:21:00 ta-mp1260-dig-in-1---volumio sudo[1069]: pam_unix(sudo:session): session closed for user root Feb 22 12:21:00 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading plugin "alsa_controller"... Feb 22 12:21:00 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 22 12:21:00 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading plugin "wizard"... Feb 22 12:21:00 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading plugin "networkfs"... Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio sudo[1092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.1.19:/Public/music_flac /mnt/NAS/music_flac Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio sudo[1092]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio volumio[995]: info: Starting Udev Watcher for removable devices Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio sudo[1094]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.1.19:/Public/music_mp3 /mnt/NAS/music_mp3 Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio sudo[1094]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio sudo[1097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.1.19:/Public/music_transfer /mnt/NAS/music_transfer Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio sudo[1097]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio volumio[995]: info: Ignoring mount for partition: boot Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio volumio[995]: info: Ignoring mount for partition: volumio Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio volumio[995]: info: Ignoring mount for partition: volumio_data Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading plugin "volumio_command_line_client"... Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading plugin "upnp"... Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio volumio[995]: info: [1771759261405] Starting Upmpd Daemon Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading plugin "my_music"... Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading plugin "mpd"... Feb 22 12:21:01 ta-mp1260-dig-in-1---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. Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio systemd[1]: Reached target Host and Network Name Lookups. Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio systemd[1]: Starting Preprocess NFS configuration... Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio systemd[1]: nfs-config.service: Succeeded. Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio systemd[1]: Started Preprocess NFS configuration. Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio systemd[1]: Starting NFS status monitor for NFSv2/3 locking.... Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio systemd[1]: Starting Notify NFS peers of a restart... Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio sm-notify[1120]: Version 1.3.3 starting Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio systemd[1]: rpc-statd-notify.service: Succeeded. Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio systemd[1]: Started Notify NFS peers of a restart. Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio rpc.statd[1121]: Version 1.3.3 starting Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio rpc.statd[1121]: Flags: TI-RPC Feb 22 12:21:01 ta-mp1260-dig-in-1---volumio systemd[1]: Started NFS status monitor for NFSv2/3 locking.. Feb 22 12:21:02 ta-mp1260-dig-in-1---volumio sudo[1092]: pam_unix(sudo:session): session closed for user root Feb 22 12:21:02 ta-mp1260-dig-in-1---volumio sudo[1094]: pam_unix(sudo:session): session closed for user root Feb 22 12:21:02 ta-mp1260-dig-in-1---volumio sudo[1097]: pam_unix(sudo:session): session closed for user root Feb 22 12:21:02 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading plugin "upnp_browser"... Feb 22 12:21:03 ta-mp1260-dig-in-1---volumio volumio[995]: info: Starting UPNP Browser Feb 22 12:21:03 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading plugin "alarm-clock"... Feb 22 12:21:03 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading plugin "airplay_emulation"... Feb 22 12:21:03 ta-mp1260-dig-in-1---volumio volumio[995]: info: Starting Shairport Sync Feb 22 12:21:03 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading plugin "last_100"... Feb 22 12:21:03 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading plugin "webradio"... Feb 22 12:21:04 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading plugin "i2s_dacs"... Feb 22 12:21:04 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading plugin "volumiodiscovery"... Feb 22 12:21:04 ta-mp1260-dig-in-1---volumio volumio[995]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 22 12:21:04 ta-mp1260-dig-in-1---volumio volumio[995]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 22 12:21:04 ta-mp1260-dig-in-1---volumio node[995]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 22 12:21:04 ta-mp1260-dig-in-1---volumio volumio[995]: *** WARNING *** For more information see Feb 22 12:21:04 ta-mp1260-dig-in-1---volumio volumio[995]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 22 12:21:04 ta-mp1260-dig-in-1---volumio volumio[995]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 22 12:21:04 ta-mp1260-dig-in-1---volumio volumio[995]: *** WARNING *** For more information see Feb 22 12:21:04 ta-mp1260-dig-in-1---volumio node[995]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 22 12:21:04 ta-mp1260-dig-in-1---volumio node[995]: *** WARNING *** For more information see Feb 22 12:21:04 ta-mp1260-dig-in-1---volumio node[995]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 22 12:21:04 ta-mp1260-dig-in-1---volumio node[995]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 22 12:21:04 ta-mp1260-dig-in-1---volumio node[995]: *** WARNING *** For more information see Feb 22 12:21:04 ta-mp1260-dig-in-1---volumio volumio[995]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 22 12:21:04 ta-mp1260-dig-in-1---volumio volumio[995]: info: Discovery: Started advertising with name: Volumio Feb 22 12:21:04 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 22 12:21:04 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading plugin "now_playing"... Feb 22 12:21:08 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading plugin "outputs"... Feb 22 12:21:08 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading plugin "albumart"... Feb 22 12:21:08 ta-mp1260-dig-in-1---volumio volumio[995]: info: Plugin example_plugin is not enabled Feb 22 12:21:08 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading plugin "inputs"... Feb 22 12:21:08 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading plugin "updater_comm"... Feb 22 12:21:08 ta-mp1260-dig-in-1---volumio volumio[995]: info: Plugin mpdemulation is not enabled Feb 22 12:21:08 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading plugin "rest_api"... Feb 22 12:21:08 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading plugin "websocket"... Feb 22 12:21:08 ta-mp1260-dig-in-1---volumio volumio[995]: info: Starting Socket.io Server version 2.3.0 Feb 22 12:21:08 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading plugin "podcast"... Feb 22 12:21:09 ta-mp1260-dig-in-1---volumio volumio[995]: Forking 3 albumart workers Feb 22 12:21:09 ta-mp1260-dig-in-1---volumio volumio[995]: info: ControllerPodcast::constructor Feb 22 12:21:09 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading plugin "touch_display"... Feb 22 12:21:11 ta-mp1260-dig-in-1---volumio volumio[995]: Starting albumart workers Feb 22 12:21:11 ta-mp1260-dig-in-1---volumio volumio[995]: info: Applying required configuration parameters for plugin touch_display Feb 22 12:21:11 ta-mp1260-dig-in-1---volumio volumio[995]: Starting albumart workers Feb 22 12:21:11 ta-mp1260-dig-in-1---volumio volumio[995]: Starting albumart workers Feb 22 12:21:11 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading i18n strings for locale de Feb 22 12:21:11 ta-mp1260-dig-in-1---volumio volumio[995]: Updating browse sources language Feb 22 12:21:11 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::initPlayerControls Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: Express server listening on port 3000 Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: [Metrics] WebUI: 19s 275.70ms Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreStateMachine::resetVolumioState Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreStateMachine::getcurrentVolume Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumioRetrievevolume Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreStateMachine::pushState Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: info: CorePlayQueue::getTrack 0 Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumioPushState Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio sudo[1191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio sudo[1191]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio sudo[1191]: pam_unix(sudo:session): session closed for user root Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio sudo[1197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio sudo[1197]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: info: Volumio Network Manager: Network status updated: 1 Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio sudo[1197]: pam_unix(sudo:session): session closed for user root Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: verbose: New Socket.io Connection to 192.168.1.29 from 192.168.1.12 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/145.0.0.0 Safari/537.36 Edg/145.0.0.0 Engine version: 3 Transport: polling Total Clients: 1 Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: verbose: New Socket.io Connection to 192.168.1.29 from 192.168.1.12 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/145.0.0.0 Safari/537.36 Edg/145.0.0.0 Engine version: 3 Transport: polling Total Clients: 2 Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: verbose: New Socket.io Connection to 192.168.1.29 from 192.168.1.12 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/145.0.0.0 Safari/537.36 Edg/145.0.0.0 Engine version: 3 Transport: polling Total Clients: 3 Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: verbose: New Socket.io Connection to 192.168.1.29 from 192.168.1.12 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/145.0.0.0 Safari/537.36 Edg/145.0.0.0 Engine version: 3 Transport: polling Total Clients: 4 Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: verbose: New Socket.io Connection to 192.168.1.29 from 192.168.1.12 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/145.0.0.0 Safari/537.36 Edg/145.0.0.0 Engine version: 3 Transport: polling Total Clients: 5 Feb 22 12:21:12 ta-mp1260-dig-in-1---volumio volumio[995]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio volumio[995]: info: Reloading queue from file Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreStateMachine::setRepeat false single undefined Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreStateMachine::pushState Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio volumio[995]: info: CorePlayQueue::getTrack 0 Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumioPushState Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreStateMachine::setRandom false Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreStateMachine::pushState Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio volumio[995]: info: CorePlayQueue::getTrack 0 Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumioPushState Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio volumio[995]: info: Setting Device type: Raspberry PI Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio volumio[995]: info: Completed loading Core Plugins Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio volumio[995]: info: Preparing to generate the ALSA configuration file Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio sudo[1212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio sudo[1212]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio volumio[995]: info: Asound.conf file written Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio systemd[1]: Started UPnP Renderer front-end to MPD. Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio sudo[1212]: pam_unix(sudo:session): session closed for user root Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio volumio-remote-updater[466]: [2026-02-22 12:21:13] [connect] Successful connection Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio sudo[1216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio sudo[1216]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio sudo[1216]: pam_unix(sudo:session): session closed for user root Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio systemd[1]: systemd-fsckd.service: Succeeded. Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio volumio[995]: info: Output device has changed, restarting MPD Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio volumio[995]: info: Output device has changed, restarting Shairport Sync Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio sudo[1221]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio sudo[1221]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio sudo[1221]: pam_unix(sudo:session): session closed for user root Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio sudo[1223]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio sudo[1223]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio volumio[995]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio volumio[995]: info: ___________ START PLUGINS ___________ Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio volumio[995]: info: ControllerMpd::onStart: Initializing MPD Feb 22 12:21:13 ta-mp1260-dig-in-1---volumio volumio[995]: info: Creating MPD Configuration file Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio sudo[1231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio sudo[1231]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio systemd[1]: Listening on mpd.socket. Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio systemd[1]: Starting Music Player Daemon... Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: [1771759274051] CoreMusicLibrary::Adding element Medienserver Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio sudo[1233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio sudo[1233]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio sudo[1233]: pam_unix(sudo:session): session closed for user root Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: UPNP Browser: Client initialized successfully Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio systemd[1]: Started Volumio5 Onboarding Server. Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio sudo[1236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio sudo[1236]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio sudo[1231]: pam_unix(sudo:session): session closed for user root Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio systemd[1]: mpd.service: Succeeded. Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio systemd[1]: Stopped Music Player Daemon. Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio systemd[1]: Starting Music Player Daemon... Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: [1771759274364] CoreMusicLibrary::Adding element Last_100 Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: [1771759274371] CoreMusicLibrary::Adding element Webradio Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: Initializing BBC Radios Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio sudo[1244]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio sudo[1244]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio sudo[1244]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio sudo[1244]: pam_unix(sudo:session): session closed for user root Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: [now-playing] ConfigUpdater: config is up to date. Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: [1771759274650] CoreMusicLibrary::Adding element Podcast Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: Cannot find translation for source Podcast Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: Loading i18n strings for locale de Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio volumio[995]: info: Cannot retrieve data for calling home Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio sudo[1266]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Feb 22 12:21:14 ta-mp1260-dig-in-1---volumio sudo[1266]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 12:21:15 ta-mp1260-dig-in-1---volumio sudo[1268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Feb 22 12:21:15 ta-mp1260-dig-in-1---volumio sudo[1268]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 12:21:15 ta-mp1260-dig-in-1---volumio volumio5-onboarding[1239]: time=2026-02-22T12:21:15.044+01:00 level=INFO msg="running volumio5-device-gateway" version=687ad144+CHANGES buildDate=2026-02-10T16:50:24Z Feb 22 12:21:15 ta-mp1260-dig-in-1---volumio sudo[1271]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Feb 22 12:21:15 ta-mp1260-dig-in-1---volumio sudo[1266]: pam_unix(sudo:session): session closed for user root Feb 22 12:21:15 ta-mp1260-dig-in-1---volumio sudo[1271]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 12:21:15 ta-mp1260-dig-in-1---volumio systemd[1]: Reloading. Feb 22 12:21:15 ta-mp1260-dig-in-1---volumio volumio[995]: info: [now-playing] App is listening on port 4004. Feb 22 12:21:15 ta-mp1260-dig-in-1---volumio volumio[995]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Feb 22 12:21:15 ta-mp1260-dig-in-1---volumio volumio[995]: info: Discovery: adding 1edf222a-0527-4ade-bab1-4424cf949f92 Feb 22 12:21:15 ta-mp1260-dig-in-1---volumio volumio[995]: info: Discovery: Found device Volumio Feb 22 12:21:15 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumioGetState Feb 22 12:21:15 ta-mp1260-dig-in-1---volumio volumio[995]: info: CorePlayQueue::getTrack 0 Feb 22 12:21:15 ta-mp1260-dig-in-1---volumio volumio[995]: error: touch_display: Error detecting backlight interface: Error: ENOENT: no such file or directory, scandir '/sys/class/backlight/' Feb 22 12:21:15 ta-mp1260-dig-in-1---volumio volumio[995]: info: touch_display: systemctl stop getty@tty1.service succeeded. Feb 22 12:21:15 ta-mp1260-dig-in-1---volumio volumio[995]: info: MPD Permissions set Feb 22 12:21:15 ta-mp1260-dig-in-1---volumio volumio[995]: info: MPD Permissions set Feb 22 12:21:15 ta-mp1260-dig-in-1---volumio volumio[995]: info: Upmpdcli Daemon Started Feb 22 12:21:15 ta-mp1260-dig-in-1---volumio volumio-remote-updater[466]: [2026-02-22 12:21:15] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1771759273 101 Feb 22 12:21:15 ta-mp1260-dig-in-1---volumio volumio[995]: 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: 7 Feb 22 12:21:15 ta-mp1260-dig-in-1---volumio volumio[995]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 8 Feb 22 12:21:15 ta-mp1260-dig-in-1---volumio dbus-daemon[457]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.12' (uid=0 pid=1239 comm="/usr/bin/volumio5-onboarding ") Feb 22 12:21:15 ta-mp1260-dig-in-1---volumio volumio[995]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 8 Feb 22 12:21:15 ta-mp1260-dig-in-1---volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Feb 22 12:21:16 ta-mp1260-dig-in-1---volumio systemd[1]: /lib/systemd/system/inputlirc.service:4: Failed to add dependency on udev, ignoring: Unknown error -22 Feb 22 12:21:16 ta-mp1260-dig-in-1---volumio systemd[1]: /lib/systemd/system/inputlirc.service:4: Failed to add dependency on lircd, ignoring: Unknown error -22 Feb 22 12:21:16 ta-mp1260-dig-in-1---volumio volumio[995]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 22 12:21:16 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 12:21:16 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 12:21:16 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 12:21:16 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 12:21:16 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 12:21:16 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 12:21:16 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 12:21:16 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 12:21:16 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 12:21:16 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 12:21:16 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 12:21:16 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 12:21:16 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 12:21:16 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 12:21:16 ta-mp1260-dig-in-1---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. Feb 22 12:21:16 ta-mp1260-dig-in-1---volumio systemd[1]: serial-getty@ttyAMA0.service: Current command vanished from the unit file, execution of the command list won't be resumed. Feb 22 12:21:16 ta-mp1260-dig-in-1---volumio volumio[995]: info: Starting Shairport Sync Feb 22 12:21:16 ta-mp1260-dig-in-1---volumio volumio[995]: info: Starting Shairport Sync Feb 22 12:21:16 ta-mp1260-dig-in-1---volumio volumio[995]: info: Starting Shairport Sync Feb 22 12:21:16 ta-mp1260-dig-in-1---volumio sudo[1303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 22 12:21:16 ta-mp1260-dig-in-1---volumio sudo[1303]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 12:21:17 ta-mp1260-dig-in-1---volumio sudo[1301]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 22 12:21:17 ta-mp1260-dig-in-1---volumio sudo[1301]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 12:21:17 ta-mp1260-dig-in-1---volumio sudo[1271]: pam_unix(sudo:session): session closed for user root Feb 22 12:21:17 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumioGetState Feb 22 12:21:17 ta-mp1260-dig-in-1---volumio volumio[995]: info: CorePlayQueue::getTrack 0 Feb 22 12:21:17 ta-mp1260-dig-in-1---volumio sudo[1305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 22 12:21:17 ta-mp1260-dig-in-1---volumio sudo[1305]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 12:21:17 ta-mp1260-dig-in-1---volumio systemd[1]: Reloading. Feb 22 12:21:17 ta-mp1260-dig-in-1---volumio volumio[995]: info: touch_display: systemctl daemon-reload succeeded. Feb 22 12:21:17 ta-mp1260-dig-in-1---volumio sudo[1310]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Feb 22 12:21:17 ta-mp1260-dig-in-1---volumio sudo[1310]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 12:21:17 ta-mp1260-dig-in-1---volumio volumio[995]: verbose: New Socket.io Connection to 192.168.1.29 from 192.168.1.12 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/145.0.0.0 Safari/537.36 Edg/145.0.0.0 Engine version: 3 Transport: polling Total Clients: 10 Feb 22 12:21:17 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 22 12:21:17 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumioGetState Feb 22 12:21:17 ta-mp1260-dig-in-1---volumio volumio[995]: info: CorePlayQueue::getTrack 0 Feb 22 12:21:17 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumioGetVisibleSources Feb 22 12:21:17 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 12:21:17 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumioGetQueue Feb 22 12:21:17 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreStateMachine::getQueue Feb 22 12:21:17 ta-mp1260-dig-in-1---volumio volumio[995]: info: CorePlayQueue::getQueue Feb 22 12:21:17 ta-mp1260-dig-in-1---volumio volumio[995]: info: Listing playlists Feb 22 12:21:17 ta-mp1260-dig-in-1---volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Feb 22 12:21:18 ta-mp1260-dig-in-1---volumio systemd[1]: /lib/systemd/system/inputlirc.service:4: Failed to add dependency on udev, ignoring: Unknown error -22 Feb 22 12:21:18 ta-mp1260-dig-in-1---volumio systemd[1]: /lib/systemd/system/inputlirc.service:4: Failed to add dependency on lircd, ignoring: Unknown error -22 Feb 22 12:21:18 ta-mp1260-dig-in-1---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. Feb 22 12:21:18 ta-mp1260-dig-in-1---volumio sudo[1268]: pam_unix(sudo:session): session closed for user root Feb 22 12:21:18 ta-mp1260-dig-in-1---volumio volumio[995]: info: touch_display: systemctl disable getty@tty1.service succeeded. Feb 22 12:21:18 ta-mp1260-dig-in-1---volumio systemd[1]: Started Volumio Kiosk. Feb 22 12:21:18 ta-mp1260-dig-in-1---volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 22 12:21:18 ta-mp1260-dig-in-1---volumio sudo[1310]: pam_unix(sudo:session): session closed for user root Feb 22 12:21:18 ta-mp1260-dig-in-1---volumio systemd[1]: Condition check resulted in Bluetooth service being skipped. Feb 22 12:21:18 ta-mp1260-dig-in-1---volumio volumio[995]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Feb 22 12:21:18 ta-mp1260-dig-in-1---volumio volumio[995]: info: touch_display: Volumio Kiosk started. Feb 22 12:21:18 ta-mp1260-dig-in-1---volumio systemd[1]: shairport-sync.service: Succeeded. Feb 22 12:21:18 ta-mp1260-dig-in-1---volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumioGetState Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio sudo[1301]: pam_unix(sudo:session): session closed for user root Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio sudo[1303]: pam_unix(sudo:session): session closed for user root Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio volumio[995]: info: CorePlayQueue::getTrack 0 Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio sudo[1305]: pam_unix(sudo:session): session closed for user root Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumioGetState Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio volumio[995]: info: CorePlayQueue::getTrack 0 Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio volumio[995]: info: Shairport-Sync Started Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio volumio[995]: Error adding Membership: Error: addMembership EINVAL Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio volumio[995]: info: Shairport-Sync Started Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio volumio[995]: info: Shairport-Sync Started Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio volumio[995]: info: touch_display: X display number found: Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio volumio[995]: info: touch_display: X display number found: 0 Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio volumio[995]: info: touch_display: X display number found: 0 Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio startx[1325]: X.Org X Server 1.20.4 Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio startx[1325]: X Protocol Version 11, Revision 0 Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio startx[1325]: Build Operating System: Linux 5.4.0-109-generic armv8l Raspbian Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio startx[1325]: Current Operating System: Linux ta-mp1260-dig-in-1---volumio 6.6.62-v7+ #1816 SMP Mon Nov 18 15:30:49 GMT 2024 armv7l Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio startx[1325]: Kernel command line: coherent_pool=1M snd_bcm2835.enable_headphones=0 cgroup_disable=memory snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=640 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyAMA0,115200 console=tty1 imgpart=UUID=ebb277f3-4b9c-47a7-93c4-0be5bb55cc38 imgfile=/volumio_current.sqsh bootpart=UUID=EF69-E169 datapart=UUID=646e0fa6-8125-4244-820d-96807935d23e uuidconfig=cmdline.txt pcie_aspm=off pci=pcie_bus_safe rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio startx[1325]: Build Date: 04 April 2023 07:50:56AM Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio startx[1325]: xorg-server 2:1.20.4-1+rpt4+deb10u9 (https://www.debian.org/support) Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio startx[1325]: Current version of pixman: 0.36.0 Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio startx[1325]: Before reporting problems, check http://wiki.x.org Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio startx[1325]: to make sure that you have the latest version. Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio startx[1325]: Markers: (--) probed, (**) from config file, (==) default setting, Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio startx[1325]: (++) from command line, (!!) notice, (II) informational, Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio startx[1325]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio startx[1325]: (==) Log file: "/var/log/Xorg.0.log", Time: Sun Feb 22 12:21:19 2026 Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio volumio[995]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio startx[1325]: (==) Using config directory: "/etc/X11/xorg.conf.d" Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio startx[1325]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Feb 22 12:21:19 ta-mp1260-dig-in-1---volumio volumio[995]: info: touch_display: X display number found: 0 Feb 22 12:21:20 ta-mp1260-dig-in-1---volumio mpd[1264]: Feb 22 12:21 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 22 12:21:22 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumioGetState Feb 22 12:21:22 ta-mp1260-dig-in-1---volumio volumio[995]: info: CorePlayQueue::getTrack 0 Feb 22 12:21:22 ta-mp1260-dig-in-1---volumio systemd[1]: systemd-timedated.service: Succeeded. Feb 22 12:21:22 ta-mp1260-dig-in-1---volumio volumio[995]: info: touch_display: Setting screensaver timeout to 120 seconds. Feb 22 12:21:22 ta-mp1260-dig-in-1---volumio systemd[1]: Started Music Player Daemon. Feb 22 12:21:22 ta-mp1260-dig-in-1---volumio volumio[995]: Upnp client error: Error: This socket has been ended by the other party Feb 22 12:21:22 ta-mp1260-dig-in-1---volumio sudo[1236]: pam_unix(sudo:session): session closed for user root Feb 22 12:21:22 ta-mp1260-dig-in-1---volumio sudo[1223]: pam_unix(sudo:session): session closed for user root Feb 22 12:21:22 ta-mp1260-dig-in-1---volumio volumio[995]: info: Completed starting Core Plugins Feb 22 12:21:22 ta-mp1260-dig-in-1---volumio volumio[995]: info: ------------------------------------------- Feb 22 12:21:22 ta-mp1260-dig-in-1---volumio volumio[995]: info: ----- MyVolumio plugins startup ---- Feb 22 12:21:22 ta-mp1260-dig-in-1---volumio volumio[995]: info: ------------------------------------------- Feb 22 12:21:22 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Fetching plans data.... Feb 22 12:21:22 ta-mp1260-dig-in-1---volumio volumio[995]: error: MPD error: The expression evaluated to a falsy value: Feb 22 12:21:22 ta-mp1260-dig-in-1---volumio volumio[995]: assert.ok(self.idling) Feb 22 12:21:22 ta-mp1260-dig-in-1---volumio volumio[995]: error: The expression evaluated to a falsy value: Feb 22 12:21:22 ta-mp1260-dig-in-1---volumio volumio[995]: assert.ok(self.idling) Feb 22 12:21:22 ta-mp1260-dig-in-1---volumio volumio[995]: error: updateQueue error: null Feb 22 12:21:22 ta-mp1260-dig-in-1---volumio volumio[995]: info: MPD running with PID1264 Feb 22 12:21:22 ta-mp1260-dig-in-1---volumio volumio[995]: ,establishing connection Feb 22 12:21:22 ta-mp1260-dig-in-1---volumio volumio[995]: error: updateQueue error: null Feb 22 12:21:23 ta-mp1260-dig-in-1---volumio volumio[1214]: Generating RSA private key, 4096 bit long modulus (2 primes) Feb 22 12:21:30 ta-mp1260-dig-in-1---volumio volumio[995]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: Adding plugin bluetooth to MyMusic Plugins Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: Adding plugin multiroom to MyMusic Plugins Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: Adding plugin metavolumio to MyMusic Plugins Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: Adding plugin cd_controller to MyMusic Plugins Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: Adding plugin qobuzconnect to MyMusic Plugins Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: Adding plugin smart_inputs to MyMusic Plugins Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: Adding plugin tidalconnect to MyMusic Plugins Feb 22 12:21:31 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Feb 22 12:21:34 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Feb 22 12:21:34 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Feb 22 12:21:34 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 12:21:34 ta-mp1260-dig-in-1---volumio volumio[995]: info: Starting MyVolumio Remote Streaming Endpoints Feb 22 12:21:34 ta-mp1260-dig-in-1---volumio volumio[995]: info: MyVolumio login type: Token Feb 22 12:21:35 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Feb 22 12:21:35 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Feb 22 12:21:38 ta-mp1260-dig-in-1---volumio volumio[995]: info: Starting Streaming Service Transparent Proxy Feb 22 12:21:38 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Feb 22 12:21:38 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Feb 22 12:21:38 ta-mp1260-dig-in-1---volumio volumio[995]: info: Streaming services startup Feb 22 12:21:38 ta-mp1260-dig-in-1---volumio volumio[995]: info: Starting Streaming Daemon Feb 22 12:21:39 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Feb 22 12:21:39 ta-mp1260-dig-in-1---volumio sudo[1600]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 22 12:21:39 ta-mp1260-dig-in-1---volumio sudo[1600]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 12:21:39 ta-mp1260-dig-in-1---volumio sudo[1600]: pam_unix(sudo:session): session closed for user root Feb 22 12:21:39 ta-mp1260-dig-in-1---volumio volumio[995]: error: Cannot start Volumio Streaming Daemon Feb 22 12:21:39 ta-mp1260-dig-in-1---volumio volumio[995]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 22 12:21:39 ta-mp1260-dig-in-1---volumio volumio[995]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 22 12:21:40 ta-mp1260-dig-in-1---volumio dbus-daemon[457]: [system] Failed to activate service 'org.bluez': timed out (service_start_timeout=25000ms) Feb 22 12:21:40 ta-mp1260-dig-in-1---volumio volumio5-onboarding[1239]: time=2026-02-22T12:21:40.826+01:00 level=WARN msg="failed to enable Bluetooth adapter" adapter=hci0 error="could not activate BlueZ adapter: Failed to activate service 'org.bluez': timed out (service_start_timeout=25000ms)" Feb 22 12:21:40 ta-mp1260-dig-in-1---volumio dbus-daemon[457]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.12' (uid=0 pid=1239 comm="/usr/bin/volumio5-onboarding ") Feb 22 12:21:40 ta-mp1260-dig-in-1---volumio systemd[1]: Condition check resulted in Bluetooth service being skipped. Feb 22 12:21:41 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 22 12:21:41 ta-mp1260-dig-in-1---volumio volumio[995]: info: Discovery: Getting this device information Feb 22 12:21:41 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumioGetState Feb 22 12:21:41 ta-mp1260-dig-in-1---volumio volumio[995]: info: CorePlayQueue::getTrack 0 Feb 22 12:21:41 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 22 12:21:44 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 22 12:21:44 ta-mp1260-dig-in-1---volumio volumio[995]: info: CURURI: music-library Feb 22 12:21:45 ta-mp1260-dig-in-1---volumio volumio[995]: STREAMING PROXY: Starting server on port 3245 Feb 22 12:21:45 ta-mp1260-dig-in-1---volumio volumio[995]: Node JS runtime: 14 Feb 22 12:21:45 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 22 12:21:45 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 12:21:45 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 22 12:21:45 ta-mp1260-dig-in-1---volumio volumiologrotate[455]: ls: cannot access '/var/log/samba/log.wb-T+A': No such file or directory Feb 22 12:21:45 ta-mp1260-dig-in-1---volumio volumiologrotate[455]: ls: cannot access 'MP1260:': No such file or directory Feb 22 12:21:45 ta-mp1260-dig-in-1---volumio volumio[1214]: ........................................................................................++++ Feb 22 12:21:45 ta-mp1260-dig-in-1---volumio volumiologrotate[455]: ls: cannot access 'DIG': No such file or directory Feb 22 12:21:45 ta-mp1260-dig-in-1---volumio volumiologrotate[455]: ls: cannot access 'IN': No such file or directory Feb 22 12:21:45 ta-mp1260-dig-in-1---volumio volumiologrotate[455]: ls: cannot access '1': No such file or directory Feb 22 12:21:45 ta-mp1260-dig-in-1---volumio volumiologrotate[455]: ls: cannot access '-': No such file or directory Feb 22 12:21:45 ta-mp1260-dig-in-1---volumio volumiologrotate[455]: ls: cannot access 'VOLUMIO': No such file or directory Feb 22 12:21:48 ta-mp1260-dig-in-1---volumio volumio[1214]: .........++++ Feb 22 12:21:48 ta-mp1260-dig-in-1---volumio volumio[1214]: e is 65537 (0x010001) Feb 22 12:21:48 ta-mp1260-dig-in-1---volumio volumio[1214]: writing RSA key Feb 22 12:21:50 ta-mp1260-dig-in-1---volumio volumio-remote-updater[466]: Test mode enabled Feb 22 12:21:50 ta-mp1260-dig-in-1---volumio volumio-remote-updater[466]: No alpha test mode Feb 22 12:21:50 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Feb 22 12:21:50 ta-mp1260-dig-in-1---volumio volumio[995]: info: Preload queue cleared Feb 22 12:21:50 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 22 12:21:50 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreStateMachine::ClearQueue Feb 22 12:21:50 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreStateMachine::stop Feb 22 12:21:50 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 12:21:50 ta-mp1260-dig-in-1---volumio volumio[995]: info: CorePlayQueue::clearPlayQueue Feb 22 12:21:50 ta-mp1260-dig-in-1---volumio volumio[995]: info: CorePlayQueue::saveQueue Feb 22 12:21:50 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumioPushQueue Feb 22 12:21:50 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreStateMachine::addQueueItems Feb 22 12:21:50 ta-mp1260-dig-in-1---volumio volumio[995]: info: CorePlayQueue::addQueueItems Feb 22 12:21:50 ta-mp1260-dig-in-1---volumio volumio[995]: info: Preload queue cleared Feb 22 12:21:50 ta-mp1260-dig-in-1---volumio volumio[995]: info: Adding Item to queue: upnp/folder/http://192.168.1.19:9000/dev0/srv1/control@0$1$13$16442$16606$16607 Feb 22 12:21:50 ta-mp1260-dig-in-1---volumio volumio[995]: info: Exploding uri upnp/folder/http://192.168.1.19:9000/dev0/srv1/control@0$1$13$16442$16606$16607 in service upnp_browser Feb 22 12:21:50 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 22 12:21:50 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 22 12:21:51 ta-mp1260-dig-in-1---volumio volumio[995]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Feb 22 12:21:51 ta-mp1260-dig-in-1---volumio volumio[995]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 22 12:21:51 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 22 12:21:51 ta-mp1260-dig-in-1---volumio volumio[995]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Feb 22 12:21:52 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumioPushQueue Feb 22 12:21:52 ta-mp1260-dig-in-1---volumio volumio[995]: info: CorePlayQueue::saveQueue Feb 22 12:21:52 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreStateMachine::updateTrackBlock Feb 22 12:21:52 ta-mp1260-dig-in-1---volumio volumio[995]: info: CorePlayQueue::getTrackBlock Feb 22 12:21:52 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumioPlay Feb 22 12:21:52 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreStateMachine::play index 0 Feb 22 12:21:52 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 12:21:52 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreStateMachine::stop Feb 22 12:21:52 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 12:21:52 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreStateMachine::play index undefined Feb 22 12:21:52 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 22 12:21:52 ta-mp1260-dig-in-1---volumio volumio[995]: info: CorePlayQueue::getTrack 0 Feb 22 12:21:52 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreStateMachine::startPlaybackTimer Feb 22 12:21:52 ta-mp1260-dig-in-1---volumio volumio[995]: info: CorePlayQueue::getTrack 0 Feb 22 12:21:52 ta-mp1260-dig-in-1---volumio volumio[995]: info: [1771759312616] ControllerUPNPBrowser::clearAddPlayTrack Feb 22 12:21:52 ta-mp1260-dig-in-1---volumio volumio[995]: verbose: ControllerMpd::sendMpdCommand stop Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: error: [now-playing] API endpoint weather/fetchInfo returned error: Error: Could not access weather service: missing geographic coordinates. Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: at WeatherAPI.fetchInfo (/data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:95:19) Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: at Object.api (/data/plugins/user_interface/now_playing/dist/app/Handler.js:115:37) Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: at /data/plugins/user_interface/now_playing/dist/app/Router.js:47:13 Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5) Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: at next (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/route.js:149:13) Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: at Route.dispatch (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/route.js:119:3) Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5) Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: at /data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:284:15 Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: at param (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:365:14) Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: at param (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:376:14) Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: at Function.process_params (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:421:3) Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: at next (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:280:10) Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: at Function.handle (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:175:3) Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: at router (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:47:12) Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5) Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio ntpd[728]: Soliciting pool server 217.144.138.234 Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: info: Listing playlists Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumioGetQueue Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreStateMachine::getQueue Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: info: CorePlayQueue::getQueue Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumioGetVisibleSources Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumioGetState Feb 22 12:21:53 ta-mp1260-dig-in-1---volumio volumio[995]: info: CorePlayQueue::getTrack 0 Feb 22 12:21:54 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::Close All Modals sent Feb 22 12:21:55 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 12:21:55 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 12:21:55 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Feb 22 12:21:55 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Feb 22 12:21:55 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 22 12:21:55 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 22 12:21:55 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumioGetBrowseSources Feb 22 12:21:55 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 22 12:21:55 ta-mp1260-dig-in-1---volumio ntpd[728]: Soliciting pool server 81.169.217.236 Feb 22 12:21:55 ta-mp1260-dig-in-1---volumio ntpd[728]: Soliciting pool server 162.159.200.1 Feb 22 12:21:55 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumioGetState Feb 22 12:21:55 ta-mp1260-dig-in-1---volumio volumio[995]: info: CorePlayQueue::getTrack 0 Feb 22 12:21:56 ta-mp1260-dig-in-1---volumio volumio[995]: info: MyVolumio token set successfully Feb 22 12:21:56 ta-mp1260-dig-in-1---volumio volumio[995]: info: MYVOLUMIO: Adding device Feb 22 12:21:56 ta-mp1260-dig-in-1---volumio volumio[995]: info: MYVOLUMIO: Evaluating Server Feb 22 12:21:56 ta-mp1260-dig-in-1---volumio ntpd[728]: Soliciting pool server 93.241.86.156 Feb 22 12:21:56 ta-mp1260-dig-in-1---volumio ntpd[728]: Soliciting pool server 141.144.246.224 Feb 22 12:21:56 ta-mp1260-dig-in-1---volumio ntpd[728]: Soliciting pool server 217.197.91.176 Feb 22 12:21:57 ta-mp1260-dig-in-1---volumio ntpd[728]: Soliciting pool server 62.113.219.231 Feb 22 12:21:57 ta-mp1260-dig-in-1---volumio ntpd[728]: Soliciting pool server 49.12.35.6 Feb 22 12:21:57 ta-mp1260-dig-in-1---volumio ntpd[728]: Soliciting pool server 162.159.200.123 Feb 22 12:21:58 ta-mp1260-dig-in-1---volumio ntpd[728]: Soliciting pool server 77.42.16.222 Feb 22 12:21:58 ta-mp1260-dig-in-1---volumio ntpd[728]: Soliciting pool server 172.104.134.72 Feb 22 12:21:58 ta-mp1260-dig-in-1---volumio ntpd[728]: Soliciting pool server 212.132.97.26 Feb 22 12:21:59 ta-mp1260-dig-in-1---volumio volumio[995]: info: MyVolumio Plan changed: premium Feb 22 12:21:59 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Feb 22 12:21:59 ta-mp1260-dig-in-1---volumio volumio[995]: info: Removing browser output: myVolumio user plan is not superstar Feb 22 12:21:59 ta-mp1260-dig-in-1---volumio volumio[995]: info: Removing audio output: Feb 22 12:21:59 ta-mp1260-dig-in-1---volumio volumio[995]: info: MYVOLUMIO: Adding device Feb 22 12:21:59 ta-mp1260-dig-in-1---volumio volumio[995]: info: MYVOLUMIO: Evaluating Server Feb 22 12:21:59 ta-mp1260-dig-in-1---volumio volumio[995]: error: MyVolumio Plugin failed to authenticate in a timely fashion Feb 22 12:21:59 ta-mp1260-dig-in-1---volumio volumio[995]: info: Completed starting MyVolumio Plugin Feb 22 12:21:59 ta-mp1260-dig-in-1---volumio volumio[995]: [Metrics] CommandRouter: 64s 196.66ms Feb 22 12:21:59 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::volumiosetStartupVolume Feb 22 12:21:59 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 12:21:59 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 12:21:59 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::Close All Modals sent Feb 22 12:21:59 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::Close All Modals sent Feb 22 12:21:59 ta-mp1260-dig-in-1---volumio ntpd[728]: Soliciting pool server 134.60.111.110 Feb 22 12:21:59 ta-mp1260-dig-in-1---volumio ntpd[728]: Soliciting pool server 2a01:4f8:c17:b041::1 Feb 22 12:21:59 ta-mp1260-dig-in-1---volumio ntpd[728]: Soliciting pool server 18.192.244.117 Feb 22 12:22:00 ta-mp1260-dig-in-1---volumio ntpd[728]: Soliciting pool server 57.129.38.82 Feb 22 12:22:00 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Feb 22 12:22:00 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 22 12:22:00 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Feb 22 12:22:01 ta-mp1260-dig-in-1---volumio volumio[995]: info: Setting Geolocation for MyVolumio to eu6 Feb 22 12:22:01 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 12:22:01 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 12:22:01 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 12:22:01 ta-mp1260-dig-in-1---volumio ntpd[728]: Soliciting pool server 116.202.246.102 Feb 22 12:22:02 ta-mp1260-dig-in-1---volumio volumio[995]: info: Setting Geolocation for MyVolumio to eu10 Feb 22 12:22:02 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 12:22:02 ta-mp1260-dig-in-1---volumio volumio[995]: info: Remote config written successfully Feb 22 12:22:02 ta-mp1260-dig-in-1---volumio volumio[995]: info: Starting Tunnel 1 Feb 22 12:22:02 ta-mp1260-dig-in-1---volumio volumio[995]: info: Starting Tunnel Connection Checker Feb 22 12:22:02 ta-mp1260-dig-in-1---volumio volumio[995]: info: Updating MyVolumio device info Feb 22 12:22:02 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 12:22:02 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 12:22:02 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 12:22:03 ta-mp1260-dig-in-1---volumio volumio[995]: info: Updating MyVolumio device info Feb 22 12:22:03 ta-mp1260-dig-in-1---volumio volumio[995]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 12:22:04 ta-mp1260-dig-in-1---volumio ntpd[728]: receive: Unexpected origin timestamp 0xed45655b.ace73535 does not match aorg 0000000000.00000000 from server@77.42.16.222 xmt 0xed45655c.aae9b52e Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: info: MYVolumio Device enabled Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: [2026-02-22T11:22:05.213Z] @firebase/database: FIREBASE WARNING: Exception was thrown by user callback. TypeError: Cannot read property 'replace' of null Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at MyVolumioPluginManager.fetchPluginKeys (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:8044) Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at MyVolumioPluginManager.loadMyVolumioPlugins (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:11563) Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at MyVolumioPluginManager.myVolumioDeviceStatusChanged (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:5527) Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at /myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:6807 Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at /volumio/node_modules/v-conf/index.js:165:13 Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at /volumio/node_modules/multimap/index.js:150:9 Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at Array.forEach () Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at /volumio/node_modules/multimap/index.js:149:13 Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at mapEach (/volumio/node_modules/multimap/index.js:9:5) Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at Multimap.forEachEntry (/volumio/node_modules/multimap/index.js:143:5) Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at Multimap.forEach (/volumio/node_modules/multimap/index.js:148:10) Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at Config.set (/volumio/node_modules/v-conf/index.js:162:20) Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at myVolumio.togglePremiumPlugins (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:36237) Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at /myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:17857 Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at /volumio/node_modules/@firebase/database/dist/index.node.cjs.js:4549:22 Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at exceptionGuard (/volumio/node_modules/@firebase/database/dist/index.node.cjs.js:698:9) Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: TypeError: Cannot read property 'replace' of null Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at MyVolumioPluginManager.fetchPluginKeys (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:8044) Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at MyVolumioPluginManager.loadMyVolumioPlugins (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:11563) Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at MyVolumioPluginManager.myVolumioDeviceStatusChanged (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:5527) Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at /myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:6807 Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at /volumio/node_modules/v-conf/index.js:165:13 Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at /volumio/node_modules/multimap/index.js:150:9 Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at Array.forEach () Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at /volumio/node_modules/multimap/index.js:149:13 Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at mapEach (/volumio/node_modules/multimap/index.js:9:5) Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at Multimap.forEachEntry (/volumio/node_modules/multimap/index.js:143:5) Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at Multimap.forEach (/volumio/node_modules/multimap/index.js:148:10) Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at Config.set (/volumio/node_modules/v-conf/index.js:162:20) Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at myVolumio.togglePremiumPlugins (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:36237) Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at /myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:17857 Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at /volumio/node_modules/@firebase/database/dist/index.node.cjs.js:4549:22 Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: at exceptionGuard (/volumio/node_modules/@firebase/database/dist/index.node.cjs.js:698:9) Feb 22 12:22:05 ta-mp1260-dig-in-1---volumio volumio[995]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 12:22:06 ta-mp1260-dig-in-1---volumio dbus-daemon[457]: [system] Failed to activate service 'org.bluez': timed out (service_start_timeout=25000ms) Feb 22 12:22:07 ta-mp1260-dig-in-1---volumio volumio5-onboarding[1239]: time=2026-02-22T12:22:07.460+01:00 level=WARN msg="failed to enable Bluetooth adapter" adapter=hci1 error="could not activate BlueZ adapter: Failed to activate service 'org.bluez': timed out (service_start_timeout=25000ms)" Feb 22 12:22:07 ta-mp1260-dig-in-1---volumio dbus-daemon[457]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.12' (uid=0 pid=1239 comm="/usr/bin/volumio5-onboarding ") Feb 22 12:22:07 ta-mp1260-dig-in-1---volumio systemd[1]: Condition check resulted in Bluetooth service being skipped. Feb 22 12:22:09 ta-mp1260-dig-in-1---volumio sudo[1961]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-22 12:21 Feb 22 12:22:09 ta-mp1260-dig-in-1---volumio sudo[1961]: 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"