-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sat 2026-05-30 19:05:50 CEST. --
May 30 19:05:33 volumio systemd-timedated[968]: Changed local time to Sat May 30 19:05:33 2026
May 30 19:05:33 volumio sudo[966]: pam_unix(sudo:session): session closed for user root
May 30 19:05:33 volumio volumio-time-update[609]: volumio-time-update-util: System time updated successfully.
May 30 19:05:33 volumio volumio[848]: info: Starting Udev Watcher for removable devices
May 30 19:05:33 volumio systemd[1]: Starting Daily apt download activities...
May 30 19:05:33 volumio systemd[1]: Started Volumio Time Update Utility.
May 30 19:05:33 volumio systemd[1]: Reached target Multi-User System.
May 30 19:05:33 volumio systemd[1]: Reached target Graphical Interface.
May 30 19:05:33 volumio sudo[998]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=volumio,password=volumio,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //10.0.1.5/volumio /mnt/NAS/PI-SERVER
May 30 19:05:33 volumio sudo[998]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 30 19:05:33 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes...
May 30 19:05:33 volumio volumio[848]: info: Ignoring mount for partition: boot
May 30 19:05:33 volumio volumio[848]: info: Ignoring mount for partition: volumio
May 30 19:05:33 volumio volumio[848]: info: Ignoring mount for partition: volumio_data
May 30 19:05:33 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 30 19:05:33 volumio volumio[848]: info: Loading plugin "volumio_command_line_client"...
May 30 19:05:33 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
May 30 19:05:33 volumio systemd[1]: Started Update UTMP about System Runlevel Changes.
May 30 19:05:33 volumio volumio[848]: info: Loading plugin "upnp"...
May 30 19:05:33 volumio volumio[848]: info: [1780160733213] Starting Upmpd Daemon
May 30 19:05:33 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 30 19:05:33 volumio volumio[848]: info: Loading plugin "my_music"...
May 30 19:05:33 volumio volumio[848]: info: Loading plugin "mpd"...
May 30 19:05:33 volumio nmbd[739]: [2026/05/30 19:05:33.401648, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
May 30 19:05:33 volumio nmbd[739]: query_name_response: Multiple (2) responses received for a query on subnet 10.0.1.2 for name WORKGROUP<1d>.
May 30 19:05:33 volumio nmbd[739]: This response was from IP 10.0.1.5, reporting an IP address of 10.0.1.5.
May 30 19:05:33 volumio kernel: Key type cifs.spnego registered
May 30 19:05:33 volumio kernel: Key type cifs.idmap registered
May 30 19:05:33 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 30 19:05:33 volumio kernel: CIFS: Attempting to mount //10.0.1.5/volumio
May 30 19:05:33 volumio ntpd[907]: Soliciting pool server 213.222.217.10
May 30 19:05:33 volumio ntpd[907]: Soliciting pool server 178.215.228.24
May 30 19:05:33 volumio ntpd[907]: Soliciting pool server 212.127.78.21
May 30 19:05:33 volumio sudo[998]: pam_unix(sudo:session): session closed for user root
May 30 19:05:34 volumio volumio[848]: info: Loading plugin "upnp_browser"...
May 30 19:05:34 volumio volumio[848]: info: Loading plugin "alarm-clock"...
May 30 19:05:35 volumio volumio[848]: info: Loading plugin "airplay_emulation"...
May 30 19:05:35 volumio volumio[848]: info: Starting Shairport Sync
May 30 19:05:35 volumio volumio[848]: info: Loading plugin "last_100"...
May 30 19:05:35 volumio volumio[848]: info: Loading plugin "webradio"...
May 30 19:05:36 volumio volumio[848]: info: Loading plugin "i2s_dacs"...
May 30 19:05:36 volumio volumio[848]: info: Loading plugin "volumiodiscovery"...
May 30 19:05:36 volumio volumio[848]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 30 19:05:36 volumio volumio[848]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 30 19:05:36 volumio volumio[848]: *** WARNING *** For more information see
May 30 19:05:36 volumio node[848]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
May 30 19:05:36 volumio volumio[848]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 30 19:05:36 volumio volumio[848]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 30 19:05:36 volumio volumio[848]: *** WARNING *** For more information see
May 30 19:05:36 volumio node[848]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 30 19:05:36 volumio node[848]: *** WARNING *** For more information see
May 30 19:05:36 volumio node[848]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
May 30 19:05:36 volumio node[848]: *** WARNING *** Please fix your application to use the native API of Avahi!
May 30 19:05:36 volumio node[848]: *** WARNING *** For more information see
May 30 19:05:36 volumio volumio[848]: info: Applying required configuration parameters for plugin volumiodiscovery
May 30 19:05:36 volumio volumio[848]: info: Discovery: Started advertising with name: Volumio
May 30 19:05:36 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
May 30 19:05:36 volumio volumio[848]: info: Loading plugin "spop"...
May 30 19:05:38 volumio systemd[1]: apt-daily.service: Succeeded.
May 30 19:05:38 volumio systemd[1]: Started Daily apt download activities.
May 30 19:05:38 volumio systemd[1]: Starting Daily apt upgrade and clean activities...
May 30 19:05:38 volumio volumio[848]: info: Loading plugin "ytcr"...
May 30 19:05:40 volumio ntpd[907]: receive: Unexpected origin timestamp 0xedc59763.b416d072 does not match aorg 0000000000.00000000 from server@51.38.131.245 xmt 0xedc59764.c1ef67ca
May 30 19:05:40 volumio ntpd[907]: receive: Unexpected origin timestamp 0xedc59763.b40f5fac does not match aorg 0000000000.00000000 from server@109.206.205.233 xmt 0xedc59764.c1c9a1bd
May 30 19:05:40 volumio ntpd[907]: receive: Unexpected origin timestamp 0xedc59763.b40da650 does not match aorg 0000000000.00000000 from server@212.127.78.21 xmt 0xedc59764.c24bdf71
May 30 19:05:40 volumio ntpd[907]: receive: Unexpected origin timestamp 0xedc59763.b4199737 does not match aorg 0000000000.00000000 from server@46.175.224.7 xmt 0xedc59764.c2909a7b
May 30 19:05:40 volumio ntpd[907]: receive: Unexpected origin timestamp 0xedc59763.b405d7aa does not match aorg 0000000000.00000000 from server@213.222.217.10 xmt 0xedc59764.c282216d
May 30 19:05:40 volumio ntpd[907]: receive: Unexpected origin timestamp 0xedc59763.b41838f0 does not match aorg 0000000000.00000000 from server@176.32.165.145 xmt 0xedc59764.c386f7ee
May 30 19:05:40 volumio ntpd[907]: receive: Unexpected origin timestamp 0xedc59763.b41111f1 does not match aorg 0000000000.00000000 from server@195.46.37.22 xmt 0xedc59764.c33fe5ae
May 30 19:05:40 volumio ntpd[907]: receive: Unexpected origin timestamp 0xedc59763.b4129e84 does not match aorg 0000000000.00000000 from server@89.161.47.132 xmt 0xedc59764.d5a9c4fc
May 30 19:05:40 volumio volumio-remote-updater[600]: [2026-05-30 19:05:40] [connect] Successful connection
May 30 19:05:41 volumio systemd[1]: apt-daily-upgrade.service: Succeeded.
May 30 19:05:41 volumio systemd[1]: Started Daily apt upgrade and clean activities.
May 30 19:05:41 volumio systemd[1]: Startup finished in 15.712s (kernel) + 24.747s (userspace) = 40.459s.
May 30 19:05:44 volumio volumio[848]: info: Loading plugin "outputs"...
May 30 19:05:44 volumio volumio[848]: info: Loading plugin "albumart"...
May 30 19:05:44 volumio volumio[848]: info: Plugin example_plugin is not enabled
May 30 19:05:44 volumio volumio[848]: info: Loading plugin "inputs"...
May 30 19:05:44 volumio volumio[848]: info: Loading plugin "updater_comm"...
May 30 19:05:44 volumio volumio[848]: info: Plugin mpdemulation is not enabled
May 30 19:05:44 volumio volumio[848]: info: Loading plugin "rest_api"...
May 30 19:05:44 volumio volumio[848]: info: Loading plugin "websocket"...
May 30 19:05:44 volumio volumio[848]: info: Starting Socket.io Server version 2.3.0
May 30 19:05:44 volumio volumio[848]: info: Loading plugin "fusiondsp"...
May 30 19:05:44 volumio volumio[848]: Forking 3 albumart workers
May 30 19:05:44 volumio volumio[848]: info: Applying required configuration parameters for plugin fusiondsp
May 30 19:05:45 volumio volumio[848]: info: Loading plugin "backup_restore"...
May 30 19:05:45 volumio volumio[848]: Starting albumart workers
May 30 19:05:45 volumio volumio[848]: Starting albumart workers
May 30 19:05:45 volumio volumio[848]: Starting albumart workers
May 30 19:05:45 volumio volumio[848]: info: Applying required configuration parameters for plugin backup_restore
May 30 19:05:45 volumio volumio[848]: info: Loading i18n strings for locale pl
May 30 19:05:45 volumio volumio[848]: Updating browse sources language
May 30 19:05:45 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::initPlayerControls
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 30 19:05:46 volumio volumio[848]: Express server listening on port 3000
May 30 19:05:46 volumio volumio[848]: [Metrics] WebUI: 17s 778.87ms
May 30 19:05:46 volumio volumio[848]: info: CoreStateMachine::resetVolumioState
May 30 19:05:46 volumio volumio[848]: info: CoreStateMachine::getcurrentVolume
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::volumioRetrievevolume
May 30 19:05:46 volumio sudo[1185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 30 19:05:46 volumio sudo[1185]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 30 19:05:46 volumio sudo[1185]: pam_unix(sudo:session): session closed for user root
May 30 19:05:46 volumio sudo[1193]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 30 19:05:46 volumio sudo[1193]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 30 19:05:46 volumio sudo[1193]: pam_unix(sudo:session): session closed for user root
May 30 19:05:46 volumio volumio[848]: info: Volumio Network Manager: Network status updated: 1
May 30 19:05:46 volumio volumio[848]: verbose: New Socket.io Connection to 10.0.1.2:3000 from 10.0.1.28 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 1
May 30 19:05:46 volumio volumio[848]: verbose: New Socket.io Connection to 10.0.1.2:3000 from 10.0.1.28 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 30 19:05:46 volumio volumio[848]: info: Discovery: Getting this device information
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::volumioGetState
May 30 19:05:46 volumio volumio[848]: info: CorePlayQueue::getTrack 0
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 30 19:05:46 volumio volumio[848]: info: Discovery: Getting this device information
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::volumioGetState
May 30 19:05:46 volumio volumio[848]: info: CorePlayQueue::getTrack 0
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 30 19:05:46 volumio volumio[848]: info: VolumeController:: Volume=50 Mute =false
May 30 19:05:46 volumio volumio[848]: info: CoreStateMachine::pushState
May 30 19:05:46 volumio volumio[848]: info: CorePlayQueue::getTrack 0
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::volumioPushState
May 30 19:05:46 volumio volumio[848]: info: CoreStateMachine::updateTrackBlock
May 30 19:05:46 volumio volumio[848]: info: CorePlayQueue::getTrackBlock
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::volumioRetrievevolume
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 30 19:05:46 volumio volumio[848]: info: Reloading queue from file
May 30 19:05:46 volumio volumio[848]: info: CoreStateMachine::setRepeat null single undefined
May 30 19:05:46 volumio volumio[848]: info: CoreStateMachine::pushState
May 30 19:05:46 volumio volumio[848]: info: CorePlayQueue::getTrack 0
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::volumioPushState
May 30 19:05:46 volumio volumio[848]: info: CoreStateMachine::setRandom null
May 30 19:05:46 volumio volumio[848]: info: CoreStateMachine::pushState
May 30 19:05:46 volumio volumio[848]: info: CorePlayQueue::getTrack 0
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::volumioPushState
May 30 19:05:46 volumio volumio[848]: info: Setting Device type: Raspberry PI
May 30 19:05:46 volumio volumio[848]: info: Completed loading Core Plugins
May 30 19:05:46 volumio volumio[848]: info: Preparing to generate the ALSA configuration file
May 30 19:05:46 volumio volumio[848]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
May 30 19:05:46 volumio volumio[848]: info: Reading ALSA contributions from plugins.
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 30 19:05:46 volumio volumio[848]: info: Discovery: Getting this device information
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::volumioGetState
May 30 19:05:46 volumio volumio[848]: info: CorePlayQueue::getTrack 0
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 30 19:05:46 volumio volumio[848]: verbose: New Socket.io Connection to 10.0.1.2:3000 from 10.0.1.28 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 3
May 30 19:05:46 volumio volumio[848]: info: Discovery: adding 9ea900e4-bd24-4831-a95f-29dfd13f3bf0
May 30 19:05:46 volumio volumio[848]: info: Discovery: Found device Volumio
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::volumioGetState
May 30 19:05:46 volumio volumio[848]: info: CorePlayQueue::getTrack 0
May 30 19:05:46 volumio volumio[848]: info: VolumeController:: Volume=50 Mute =false
May 30 19:05:46 volumio sudo[1217]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
May 30 19:05:46 volumio volumio[848]: info: CoreStateMachine::pushState
May 30 19:05:46 volumio sudo[1217]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 30 19:05:46 volumio volumio[848]: info: CorePlayQueue::getTrack 0
May 30 19:05:46 volumio volumio[848]: info: CoreCommandRouter::volumioPushState
May 30 19:05:46 volumio volumio[848]: info: Asound.conf file unchanged, so no further update is needed
May 30 19:05:46 volumio volumio[848]: info: Output device has changed, restarting MPD
May 30 19:05:47 volumio volumio[848]: info: Output device has changed, restarting Shairport Sync
May 30 19:05:47 volumio sudo[1221]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 30 19:05:47 volumio sudo[1221]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 30 19:05:47 volumio volumio[848]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 30 19:05:47 volumio volumio[848]: info: ___________ START PLUGINS ___________
May 30 19:05:47 volumio volumio[848]: info: ControllerMpd::onStart: Initializing MPD
May 30 19:05:47 volumio volumio[848]: info: Creating MPD Configuration file
May 30 19:05:47 volumio sudo[1221]: pam_unix(sudo:session): session closed for user root
May 30 19:05:47 volumio sudo[1223]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 30 19:05:47 volumio sudo[1223]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 30 19:05:47 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
May 30 19:05:47 volumio sudo[1217]: pam_unix(sudo:session): session closed for user root
May 30 19:05:47 volumio sudo[1230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 30 19:05:47 volumio sudo[1230]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 30 19:05:47 volumio sudo[1230]: pam_unix(sudo:session): session closed for user root
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 30 19:05:47 volumio volumio[848]: info: [1780160747143] CoreMusicLibrary::Adding element Serwery Mediów
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 30 19:05:47 volumio systemd[1]: Listening on mpd.socket.
May 30 19:05:47 volumio sudo[1233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 30 19:05:47 volumio sudo[1233]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 30 19:05:47 volumio systemd[1]: Starting Music Player Daemon...
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 30 19:05:47 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
May 30 19:05:47 volumio systemd[1]: mpd.service: Succeeded.
May 30 19:05:47 volumio systemd[1]: Stopped Music Player Daemon.
May 30 19:05:47 volumio systemd[1]: Starting Music Player Daemon...
May 30 19:05:47 volumio volumio[848]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 30 19:05:47 volumio volumio[848]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 30 19:05:47 volumio volumio[848]: info: [1780160747291] CoreMusicLibrary::Adding element Last_100
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
May 30 19:05:47 volumio volumio[848]: info: [1780160747295] CoreMusicLibrary::Adding element Webradio
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 30 19:05:47 volumio volumio[848]: info: Initializing BBC Radios
May 30 19:05:47 volumio sudo[1240]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
May 30 19:05:47 volumio sudo[1240]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 30 19:05:47 volumio sudo[1240]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
May 30 19:05:47 volumio sudo[1240]: pam_unix(sudo:session): session closed for user root
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 30 19:05:47 volumio volumio[848]: info: Creating Spotify config file
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:47 volumio volumio[848]: info: Loading i18n strings for locale pl
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:47 volumio volumio[848]: info: FusionDsp - mixtype--------------------- Hardware
May 30 19:05:47 volumio volumio[848]: info: Volumio Calling Home
May 30 19:05:47 volumio volumio[848]: info: Preparing to generate the ALSA configuration file
May 30 19:05:47 volumio volumio[848]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
May 30 19:05:47 volumio volumio[848]: info: Reading ALSA contributions from plugins.
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
May 30 19:05:47 volumio volumio[848]: info: MPD Permissions set
May 30 19:05:47 volumio volumio[848]: info: MPD Permissions set
May 30 19:05:47 volumio volumio[848]: info: Upmpdcli Daemon Started
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 30 19:05:47 volumio volumio[848]: info: Discovery: Getting this device information
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::volumioGetState
May 30 19:05:47 volumio volumio[848]: info: CorePlayQueue::getTrack 0
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 30 19:05:47 volumio volumio[848]: info: Volumio called home
May 30 19:05:47 volumio volumio[848]: info: Spotify config file written
May 30 19:05:47 volumio volumio[848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4
May 30 19:05:47 volumio sudo[1260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service
May 30 19:05:47 volumio sudo[1260]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:47 volumio volumio[848]: info: No need to fix Spotify hosts
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 30 19:05:47 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:48 volumio systemd[1]: Started go-librespot Daemon.
May 30 19:05:48 volumio go-librespot[1266]: go-librespot daemon starting...
May 30 19:05:48 volumio sudo[1260]: pam_unix(sudo:session): session closed for user root
May 30 19:05:48 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 30 19:05:48 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
May 30 19:05:48 volumio volumio[848]: info: Starting Shairport Sync
May 30 19:05:48 volumio volumio[848]: info: Starting Shairport Sync
May 30 19:05:48 volumio volumio[848]: info: Starting Shairport Sync
May 30 19:05:48 volumio sudo[1273]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 30 19:05:48 volumio sudo[1273]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 30 19:05:48 volumio sudo[1275]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 30 19:05:48 volumio sudo[1275]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 30 19:05:48 volumio sudo[1278]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 30 19:05:48 volumio sudo[1278]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 30 19:05:48 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
May 30 19:05:48 volumio systemd[1]: shairport-sync.service: Succeeded.
May 30 19:05:48 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
May 30 19:05:48 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
May 30 19:05:48 volumio sudo[1273]: pam_unix(sudo:session): session closed for user root
May 30 19:05:48 volumio sudo[1275]: pam_unix(sudo:session): session closed for user root
May 30 19:05:48 volumio sudo[1278]: pam_unix(sudo:session): session closed for user root
May 30 19:05:48 volumio volumio[848]: info: CoreCommandRouter::volumioGetState
May 30 19:05:48 volumio volumio[848]: info: CorePlayQueue::getTrack 0
May 30 19:05:48 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone
May 30 19:05:48 volumio volumio[848]: info: Shairport-Sync Started
May 30 19:05:48 volumio volumio[848]: Error adding Membership: Error: addMembership EINVAL
May 30 19:05:48 volumio volumio[848]: info: Shairport-Sync Started
May 30 19:05:48 volumio volumio[848]: info: Asound.conf file unchanged, so no further update is needed
May 30 19:05:48 volumio volumio[848]: info: Output device has changed, restarting MPD
May 30 19:05:48 volumio volumio[848]: info: Output device has changed, restarting Shairport Sync
May 30 19:05:48 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:48 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 30 19:05:48 volumio sudo[1292]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
May 30 19:05:48 volumio sudo[1292]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 30 19:05:48 volumio sudo[1290]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
May 30 19:05:48 volumio sudo[1290]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 30 19:05:48 volumio sudo[1290]: pam_unix(sudo:session): session closed for user root
May 30 19:05:48 volumio volumio[848]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
May 30 19:05:48 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
May 30 19:05:48 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork
May 30 19:05:48 volumio systemd[1]: mpd.service: Succeeded.
May 30 19:05:48 volumio systemd[1]: Stopped Music Player Daemon.
May 30 19:05:49 volumio sudo[1300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0
May 30 19:05:49 volumio sudo[1300]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 30 19:05:49 volumio sudo[1305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
May 30 19:05:49 volumio systemd[1]: Starting Music Player Daemon...
May 30 19:05:49 volumio sudo[1305]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 30 19:05:49 volumio sudo[1305]: pam_unix(sudo:session): session closed for user root
May 30 19:05:49 volumio sudo[1300]: pam_unix(sudo:session): session closed for user root
May 30 19:05:49 volumio sudo[1313]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
May 30 19:05:49 volumio sudo[1313]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 30 19:05:49 volumio sudo[1313]: pam_unix(sudo:session): session closed for user root
May 30 19:05:49 volumio sudo[1318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
May 30 19:05:49 volumio sudo[1318]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 30 19:05:49 volumio sudo[1318]: pam_unix(sudo:session): session closed for user root
May 30 19:05:49 volumio sudo[1325]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
May 30 19:05:49 volumio sudo[1325]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 30 19:05:49 volumio sudo[1325]: pam_unix(sudo:session): session closed for user root
May 30 19:05:49 volumio sudo[1328]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
May 30 19:05:49 volumio sudo[1328]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 30 19:05:49 volumio sudo[1328]: pam_unix(sudo:session): session closed for user root
May 30 19:05:49 volumio volumio[848]: info: MPD Permissions set
May 30 19:05:49 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:49 volumio sudo[1298]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
May 30 19:05:49 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:49 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:49 volumio sudo[1298]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 30 19:05:49 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:49 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:49 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:49 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:49 volumio sudo[1298]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
May 30 19:05:49 volumio sudo[1298]: pam_unix(sudo:session): session closed for user root
May 30 19:05:49 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 30 19:05:49 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:49 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
May 30 19:05:49 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
May 30 19:05:49 volumio volumio[848]: info: Starting Shairport Sync
May 30 19:05:49 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 30 19:05:49 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 30 19:05:49 volumio volumio[848]: info: Discovery: Getting this device information
May 30 19:05:49 volumio volumio[848]: info: CoreCommandRouter::volumioGetState
May 30 19:05:49 volumio volumio[848]: info: CorePlayQueue::getTrack 0
May 30 19:05:49 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 30 19:05:49 volumio sudo[1338]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
May 30 19:05:49 volumio sudo[1338]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 30 19:05:49 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 30 19:05:49 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 30 19:05:49 volumio volumio[848]: info: Discovery: Getting this device information
May 30 19:05:49 volumio volumio[848]: info: CoreCommandRouter::volumioGetState
May 30 19:05:49 volumio volumio[848]: info: CorePlayQueue::getTrack 0
May 30 19:05:49 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 30 19:05:49 volumio go-librespot[1266]: time="2026-05-30T19:05:49+02:00" level=info msg="running go-librespot 0.4.0"
May 30 19:05:49 volumio go-librespot[1266]: time="2026-05-30T19:05:49+02:00" level=debug msg="app state loaded"
May 30 19:05:49 volumio go-librespot[1266]: time="2026-05-30T19:05:49+02:00" level=debug msg="stored credentials not found"
May 30 19:05:49 volumio go-librespot[1266]: time="2026-05-30T19:05:49+02:00" level=info msg="api server listening on 127.0.0.1:9879"
May 30 19:05:49 volumio volumio[848]: info: CoreCommandRouter::volumioGetState
May 30 19:05:49 volumio volumio[848]: info: CorePlayQueue::getTrack 0
May 30 19:05:49 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
May 30 19:05:49 volumio systemd[1]: shairport-sync.service: Succeeded.
May 30 19:05:49 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
May 30 19:05:49 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
May 30 19:05:49 volumio sudo[1338]: pam_unix(sudo:session): session closed for user root
May 30 19:05:49 volumio volumio[848]: info: Shairport-Sync Started
May 30 19:05:49 volumio volumio[848]: verbose: New Socket.io Connection to 10.0.1.2:3000 from 10.0.1.28 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4
May 30 19:05:49 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
May 30 19:05:49 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
May 30 19:05:49 volumio volumio[848]: info: camilladsp service started and running in background, instance 1
May 30 19:05:49 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 30 19:05:49 volumio volumio[848]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
May 30 19:05:49 volumio volumio[848]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
May 30 19:05:49 volumio volumio[848]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
May 30 19:05:49 volumio volumio[848]: info: FusionDsp loaded
May 30 19:05:49 volumio volumio[848]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 30 19:05:49 volumio sudo[1356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
May 30 19:05:49 volumio sudo[1356]: pam_unix(sudo:session): session opened for user root by (uid=0)
May 30 19:05:49 volumio volumio[848]: info: FusionDsp - Reporting Fusion DSP Enabled
May 30 19:05:49 volumio volumio[848]: info: Adding Signal Path Element [object Object]
May 30 19:05:49 volumio volumio[848]: info: Adding fusiondspeq DSP Signal Path Element
May 30 19:05:49 volumio volumio[848]: info: FusionDsp - ---- installed callbackRead
May 30 19:05:49 volumio volumio[848]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 30 19:05:49 volumio volumio[848]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
May 30 19:05:49 volumio volumio[848]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
May 30 19:05:49 volumio volumio[848]: at onErrorNT (internal/child_process.js:465:16)
May 30 19:05:49 volumio volumio[848]: at processTicksAndRejections (internal/process/task_queues.js:80:21) {
May 30 19:05:49 volumio volumio[848]: errno: -2,
May 30 19:05:49 volumio volumio[848]: code: 'ENOENT',
May 30 19:05:49 volumio volumio[848]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
May 30 19:05:49 volumio volumio[848]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
May 30 19:05:49 volumio volumio[848]: spawnargs: [
May 30 19:05:49 volumio volumio[848]: '-p',
May 30 19:05:49 volumio volumio[848]: 9876,
May 30 19:05:49 volumio volumio[848]: '-o',
May 30 19:05:49 volumio volumio[848]: '/tmp/camilladsp.log',
May 30 19:05:49 volumio volumio[848]: '-l',
May 30 19:05:49 volumio volumio[848]: 'warn',
May 30 19:05:49 volumio volumio[848]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
May 30 19:05:49 volumio volumio[848]: ]
May 30 19:05:49 volumio volumio[848]: }
May 30 19:05:49 volumio volumio[848]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 30 19:05:49 volumio systemd[1]: Started FusionDsp Daemon.
May 30 19:05:49 volumio go-librespot[1266]: time="2026-05-30T19:05:49+02:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]"
May 30 19:05:49 volumio go-librespot[1266]: time="2026-05-30T19:05:49+02:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]"
May 30 19:05:49 volumio go-librespot[1266]: time="2026-05-30T19:05:49+02:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]"
May 30 19:05:49 volumio sudo[1356]: pam_unix(sudo:session): session closed for user root
May 30 19:05:49 volumio go-librespot[1266]: time="2026-05-30T19:05:49+02:00" level=info msg="zeroconf server listening on port 38019"
May 30 19:05:49 volumio go-librespot[1266]: time="2026-05-30T19:05:49+02:00" level=debug msg="obtained new client token: AAAxwHx4XoblCe5OFjwe5MPydl6BjMyAJTiaJfIk74BVg23O2C11HXG8CbHV45IJmyzg205cTJknyCdVS0PuumcO6quD3AX7k6Ux8wMMl8uXeuk3uKhmBrEgf9GkzSOSHeebIXGyuR8hS7+qqIeQmYzH2jPXl515sq4md2cXdcTc8E1gLuQwwhH0s4PS9H28TV8MADN3HbarQKnzkfcwI7IBy9k5UZ9HiFXeme/GKGKmhcn/72AgrukqAVs="
May 30 19:05:50 volumio go-librespot[1266]: time="2026-05-30T19:05:50+02:00" level=debug msg="connected to ap-gew4.spotify.com:4070"
May 30 19:05:50 volumio go-librespot[1266]: time="2026-05-30T19:05:50+02:00" level=debug msg="completed keyexchange"
May 30 19:05:50 volumio go-librespot[1266]: time="2026-05-30T19:05:50+02:00" level=debug msg="completed challenge"
May 30 19:05:50 volumio go-librespot[1266]: time="2026-05-30T19:05:50+02:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with username and spotify token: failed authenticating: accesspoint login failed: BadCredentials "
May 30 19:05:50 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE
May 30 19:05:50 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'.
May 30 19:05:50 volumio systemd[1]: systemd-fsckd.service: Succeeded.
May 30 19:05:50 volumio sudo[1368]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-05-30 19:04
May 30 19:05:50 volumio sudo[1368]: 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="cc50ad4a2058d01de272214eb33827883bd2b7d8"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="502750e5d54ecf269d25125b622bfabc030fb553"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 12 Nov 2025 06:58:02 PM CET"
VOLUMIO_VERSION="3.874"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="4ae6504ed6f22e44c01a6e93b16badbd"