Dec 13 14:23:06 arbeitszimmer-papa ntpd[999]: CLOCK: time stepped by 2567912.124910 Dec 13 14:23:06 arbeitszimmer-papa ntpd[999]: CLOCK: time changed from 2025-11-13 to 2025-12-13 Dec 13 14:23:06 arbeitszimmer-papa ntpd[999]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Dec 13 14:23:06 arbeitszimmer-papa volumio[1264]: info: Loading plugin "network"... Dec 13 14:23:06 arbeitszimmer-papa volumio[1264]: info: Refreshing Cached IP Addresses Dec 13 14:23:07 arbeitszimmer-papa sudo[1341]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 13 14:23:07 arbeitszimmer-papa sudo[1341]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 13 14:23:07 arbeitszimmer-papa sudo[1341]: pam_unix(sudo:session): session closed for user root Dec 13 14:23:07 arbeitszimmer-papa volumio[1264]: info: Loading plugin "services"... Dec 13 14:23:07 arbeitszimmer-papa sudo[1348]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 13 14:23:07 arbeitszimmer-papa sudo[1348]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 13 14:23:07 arbeitszimmer-papa sudo[1339]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 13 14:23:07 arbeitszimmer-papa sudo[1339]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 13 14:23:07 arbeitszimmer-papa volumio[1264]: info: Loading plugin "alsa_controller"... Dec 13 14:23:07 arbeitszimmer-papa sudo[1339]: pam_unix(sudo:session): session closed for user root Dec 13 14:23:07 arbeitszimmer-papa volumio[1264]: warn: Unable to locate the audio output device DigiHug USB Audio. Please configure a valid output device. Dec 13 14:23:07 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 13 14:23:07 arbeitszimmer-papa volumio[1264]: info: Loading plugin "wizard"... Dec 13 14:23:07 arbeitszimmer-papa volumio[1264]: info: Loading plugin "networkfs"... Dec 13 14:23:07 arbeitszimmer-papa volumio[1264]: info: Starting Udev Watcher for removable devices Dec 13 14:23:07 arbeitszimmer-papa volumio[1264]: info: Ignoring mount for partition: boot Dec 13 14:23:07 arbeitszimmer-papa volumio[1264]: info: Ignoring mount for partition: volumio Dec 13 14:23:07 arbeitszimmer-papa volumio[1264]: info: Ignoring mount for partition: volumio_data Dec 13 14:23:07 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 13 14:23:07 arbeitszimmer-papa volumio[1264]: info: Loading plugin "volumio_command_line_client"... Dec 13 14:23:07 arbeitszimmer-papa sudo[1370]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=karsten,password=Ibe1978GJK,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //Srv-DS/music /mnt/NAS/Srv-DS Dec 13 14:23:07 arbeitszimmer-papa sudo[1370]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 13 14:23:07 arbeitszimmer-papa volumio[1264]: info: Loading plugin "upnp"... Dec 13 14:23:07 arbeitszimmer-papa volumio[1264]: info: [1765632187237] Starting Upmpd Daemon Dec 13 14:23:07 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 13 14:23:07 arbeitszimmer-papa volumio[1264]: info: Loading plugin "my_music"... Dec 13 14:23:07 arbeitszimmer-papa volumio[1264]: info: Loading plugin "mpd"... Dec 13 14:23:07 arbeitszimmer-papa kernel: netfs: FS-Cache loaded Dec 13 14:23:07 arbeitszimmer-papa kernel: Key type cifs.spnego registered Dec 13 14:23:07 arbeitszimmer-papa kernel: Key type cifs.idmap registered Dec 13 14:23:07 arbeitszimmer-papa kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Dec 13 14:23:07 arbeitszimmer-papa kernel: CIFS: Attempting to mount //Srv-DS/music Dec 13 14:23:07 arbeitszimmer-papa volumio[1264]: info: Loading plugin "upnp_browser"... Dec 13 14:23:08 arbeitszimmer-papa sudo[1370]: pam_unix(sudo:session): session closed for user root Dec 13 14:23:08 arbeitszimmer-papa systemd[1]: Starting dpkg-db-backup.service - Daily dpkg database backup service... Dec 13 14:23:08 arbeitszimmer-papa systemd[1]: Starting e2scrub_all.service - Online ext4 Metadata Check for All Filesystems... Dec 13 14:23:08 arbeitszimmer-papa systemd[1]: Started ntpsec-rotate-stats.service - Rotate ntpd stats. Dec 13 14:23:08 arbeitszimmer-papa systemd[1]: e2scrub_all.service: Deactivated successfully. Dec 13 14:23:08 arbeitszimmer-papa systemd[1]: Finished e2scrub_all.service - Online ext4 Metadata Check for All Filesystems. Dec 13 14:23:08 arbeitszimmer-papa systemd[1]: ntpsec-rotate-stats.service: Deactivated successfully. Dec 13 14:23:08 arbeitszimmer-papa systemd[1]: dpkg-db-backup.service: Deactivated successfully. Dec 13 14:23:08 arbeitszimmer-papa systemd[1]: Finished dpkg-db-backup.service - Daily dpkg database backup service. Dec 13 14:23:09 arbeitszimmer-papa volumio[1264]: info: Loading plugin "alarm-clock"... Dec 13 14:23:09 arbeitszimmer-papa volumio[1264]: info: Loading plugin "airplay_emulation"... Dec 13 14:23:09 arbeitszimmer-papa volumio[1264]: info: Starting Shairport Sync Dec 13 14:23:09 arbeitszimmer-papa volumio[1264]: info: Loading plugin "last_100"... Dec 13 14:23:09 arbeitszimmer-papa volumio[1264]: info: Loading plugin "webradio"... Dec 13 14:23:09 arbeitszimmer-papa volumio[1264]: info: Loading plugin "i2s_dacs"... Dec 13 14:23:09 arbeitszimmer-papa volumio[1264]: info: I2S DAC not set, start Auto-detection Dec 13 14:23:09 arbeitszimmer-papa volumio[1264]: info: Loading plugin "volumiodiscovery"... Dec 13 14:23:09 arbeitszimmer-papa volumio[1264]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 13 14:23:09 arbeitszimmer-papa volumio[1264]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 13 14:23:09 arbeitszimmer-papa volumio[1264]: *** WARNING *** For more information see Dec 13 14:23:09 arbeitszimmer-papa node[1264]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 13 14:23:09 arbeitszimmer-papa node[1264]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 13 14:23:09 arbeitszimmer-papa node[1264]: *** WARNING *** For more information see Dec 13 14:23:09 arbeitszimmer-papa node[1264]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 13 14:23:09 arbeitszimmer-papa volumio[1264]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 13 14:23:09 arbeitszimmer-papa volumio[1264]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 13 14:23:09 arbeitszimmer-papa volumio[1264]: *** WARNING *** For more information see Dec 13 14:23:09 arbeitszimmer-papa node[1264]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 13 14:23:09 arbeitszimmer-papa node[1264]: *** WARNING *** For more information see Dec 13 14:23:09 arbeitszimmer-papa volumio[1264]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 13 14:23:09 arbeitszimmer-papa volumio[1264]: info: Discovery: Started advertising with name: Arbeitszimmer Papa Dec 13 14:23:09 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 13 14:23:09 arbeitszimmer-papa volumio[1264]: info: Loading plugin "spop"... Dec 13 14:23:10 arbeitszimmer-papa systemd[1]: systemd-fsckd.service: Deactivated successfully. Dec 13 14:23:10 arbeitszimmer-papa sudo[1348]: pam_unix(sudo:session): session closed for user root Dec 13 14:23:11 arbeitszimmer-papa dhcpcd[669]: timed out Dec 13 14:23:11 arbeitszimmer-papa sh[659]: timed out Dec 13 14:23:11 arbeitszimmer-papa dhcpcd[669]: dhcpcd exited Dec 13 14:23:11 arbeitszimmer-papa sh[620]: ifup: failed to bring up eth0 Dec 13 14:23:11 arbeitszimmer-papa systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Dec 13 14:23:11 arbeitszimmer-papa systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Dec 13 14:23:11 arbeitszimmer-papa volumio[1264]: info: Loading plugin "outputs"... Dec 13 14:23:11 arbeitszimmer-papa volumio[1264]: info: Loading plugin "albumart"... Dec 13 14:23:11 arbeitszimmer-papa volumio[1264]: info: Plugin example_plugin is not enabled Dec 13 14:23:11 arbeitszimmer-papa volumio[1264]: info: Loading plugin "inputs"... Dec 13 14:23:11 arbeitszimmer-papa volumio[1264]: info: Loading plugin "updater_comm"... Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: Plugin mpdemulation is not enabled Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: Loading plugin "rest_api"... Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: Loading plugin "websocket"... Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: Starting Socket.io Server version 1.7.4 Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: Loading i18n strings for locale de Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: Updating browse sources language Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::initPlayerControls Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: Express server listening on port 3000 Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: [Metrics] WebUI: 9s 371.75ms Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreStateMachine::resetVolumioState Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreStateMachine::getcurrentVolume Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::volumioRetrievevolume Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: Volumio Network Manager: Network status updated: 2 Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreStateMachine::pushState Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CorePlayQueue::getTrack 0 Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::volumioPushState Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreStateMachine::updateTrackBlock Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CorePlayQueue::getTrackBlock Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::volumioRetrievevolume Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: Reloading queue from file Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreStateMachine::setRepeat true single undefined Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreStateMachine::pushState Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CorePlayQueue::getTrack 0 Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::volumioPushState Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreStateMachine::setRandom null Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreStateMachine::pushState Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CorePlayQueue::getTrack 0 Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::volumioPushState Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreStateMachine::pushState Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CorePlayQueue::getTrack 0 Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::volumioPushState Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03115 Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: Setting Device type: Raspberry PI Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: Completed loading Core Plugins Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: Preparing to generate the ALSA configuration file Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: Reading ALSA contributions from plugins. Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: Discovery: adding d94d8fdb-be4d-48ec-a36a-5f2fda9c2a27 Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: Discovery: Found device Arbeitszimmer Papa Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::volumioGetState Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CorePlayQueue::getTrack 0 Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: Discovery: this is already registered, d94d8fdb-be4d-48ec-a36a-5f2fda9c2a27 Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: Discovery: Found device Arbeitszimmer Papa Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::volumioGetState Dec 13 14:23:12 arbeitszimmer-papa volumio[1264]: info: CorePlayQueue::getTrack 0 Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: Asound.conf file unchanged, so no further update is needed Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: Output device has changed, restarting MPD Dec 13 14:23:13 arbeitszimmer-papa volumio[1414]: Forking 3 albumart workers Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: Output device has changed, restarting Shairport Sync Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 13 14:23:13 arbeitszimmer-papa sudo[1452]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 13 14:23:13 arbeitszimmer-papa sudo[1452]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 13 14:23:13 arbeitszimmer-papa sudo[1450]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 13 14:23:13 arbeitszimmer-papa sudo[1450]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 13 14:23:13 arbeitszimmer-papa sudo[1450]: pam_unix(sudo:session): session closed for user root Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: ___________ START PLUGINS ___________ Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: ControllerMpd::onStart: Initializing MPD Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: Creating MPD Configuration file Dec 13 14:23:13 arbeitszimmer-papa systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 13 14:23:13 arbeitszimmer-papa systemd[1]: Starting mpd.service - Music Player Daemon... Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: [1765632193335] CoreMusicLibrary::Adding element Medienserver Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 13 14:23:13 arbeitszimmer-papa sudo[1484]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 13 14:23:13 arbeitszimmer-papa sudo[1484]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 13 14:23:13 arbeitszimmer-papa sudo[1482]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 13 14:23:13 arbeitszimmer-papa sudo[1482]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 13 14:23:13 arbeitszimmer-papa systemd[1]: systemd-hostnamed.service: Deactivated successfully. Dec 13 14:23:13 arbeitszimmer-papa sudo[1489]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Dec 13 14:23:13 arbeitszimmer-papa sudo[1482]: pam_unix(sudo:session): session closed for user root Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 13 14:23:13 arbeitszimmer-papa sudo[1479]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 13 14:23:13 arbeitszimmer-papa sudo[1479]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 13 14:23:13 arbeitszimmer-papa systemd[1]: mpd.service: Deactivated successfully. Dec 13 14:23:13 arbeitszimmer-papa systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 13 14:23:13 arbeitszimmer-papa systemd[1]: mpd.socket: Deactivated successfully. Dec 13 14:23:13 arbeitszimmer-papa systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 13 14:23:13 arbeitszimmer-papa systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 13 14:23:13 arbeitszimmer-papa systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 13 14:23:13 arbeitszimmer-papa systemd[1]: Starting mpd.service - Music Player Daemon... Dec 13 14:23:13 arbeitszimmer-papa sudo[1479]: pam_unix(sudo:session): session closed for user root Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 13 14:23:13 arbeitszimmer-papa sudo[1503]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 13 14:23:13 arbeitszimmer-papa sudo[1503]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 13 14:23:13 arbeitszimmer-papa sudo[1507]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Dec 13 14:23:13 arbeitszimmer-papa sudo[1503]: pam_unix(sudo:session): session closed for user root Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: [1765632193717] CoreMusicLibrary::Adding element Last_100 Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: [1765632193720] CoreMusicLibrary::Adding element Webradio Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 13 14:23:13 arbeitszimmer-papa volumio[1264]: info: Initializing BBC Radios Dec 13 14:23:14 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 13 14:23:14 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 13 14:23:14 arbeitszimmer-papa volumio[1264]: info: Creating Spotify config file Dec 13 14:23:14 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:15 arbeitszimmer-papa nmbd[1061]: [2025/12/13 14:23:15.440518, 0] ../../source3/nmbd/nmbd_nameregister.c:73(register_name_response) Dec 13 14:23:15 arbeitszimmer-papa nmbd[1061]: register_name_response: Answer name <00> differs from question name <00>. Dec 13 14:23:15 arbeitszimmer-papa nmbd[1061]: [2025/12/13 14:23:15.440894, 0] ../../source3/nmbd/nmbd_nameregister.c:73(register_name_response) Dec 13 14:23:15 arbeitszimmer-papa nmbd[1061]: register_name_response: Answer name <03> differs from question name <03>. Dec 13 14:23:15 arbeitszimmer-papa nmbd[1061]: [2025/12/13 14:23:15.441157, 0] ../../source3/nmbd/nmbd_nameregister.c:73(register_name_response) Dec 13 14:23:15 arbeitszimmer-papa nmbd[1061]: register_name_response: Answer name <20> differs from question name <20>. Dec 13 14:23:16 arbeitszimmer-papa volumio[1264]: info: Volumio Calling Home Dec 13 14:23:17 arbeitszimmer-papa volumio[1459]: Starting albumart workers Dec 13 14:23:17 arbeitszimmer-papa sudo[1548]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 13 14:23:17 arbeitszimmer-papa sudo[1548]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 13 14:23:17 arbeitszimmer-papa volumio[1264]: info: MPD Permissions set Dec 13 14:23:17 arbeitszimmer-papa volumio[1264]: info: MPD Permissions set Dec 13 14:23:17 arbeitszimmer-papa sudo[1548]: pam_unix(sudo:session): session closed for user root Dec 13 14:23:17 arbeitszimmer-papa sudo[1546]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 13 14:23:17 arbeitszimmer-papa sudo[1546]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 13 14:23:17 arbeitszimmer-papa sudo[1546]: pam_unix(sudo:session): session closed for user root Dec 13 14:23:17 arbeitszimmer-papa volumio[1264]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Dec 13 14:23:17 arbeitszimmer-papa volumio[1264]: info: Spotify config file written Dec 13 14:23:17 arbeitszimmer-papa volumio[1264]: info: Volumio called home Dec 13 14:23:17 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:17 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:17 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:17 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:17 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:17 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:17 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:17 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:17 arbeitszimmer-papa sudo[1555]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Dec 13 14:23:17 arbeitszimmer-papa sudo[1555]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 13 14:23:17 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 13 14:23:17 arbeitszimmer-papa systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 13 14:23:17 arbeitszimmer-papa systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 13 14:23:17 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:17 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:17 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:17 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:17 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:17 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:17 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:17 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:17 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:18 arbeitszimmer-papa systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 13 14:23:18 arbeitszimmer-papa go-librespot[1563]: go-librespot daemon starting... Dec 13 14:23:18 arbeitszimmer-papa sudo[1555]: pam_unix(sudo:session): session closed for user root Dec 13 14:23:18 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 13 14:23:18 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 13 14:23:18 arbeitszimmer-papa volumio[1467]: Starting albumart workers Dec 13 14:23:18 arbeitszimmer-papa volumio[1264]: info: No need to fix Spotify hosts Dec 13 14:23:18 arbeitszimmer-papa volumio[1455]: Starting albumart workers Dec 13 14:23:18 arbeitszimmer-papa volumio[1264]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Dec 13 14:23:18 arbeitszimmer-papa volumio[1264]: SPOTIFY: BQDGHnk9V_cdqiVcgSiOU_46CKY3-Oh0KLRR5XhJZY__N5YWyv-VnxpUI80OBzDFYx9GmA5xmorNx45aMuReAdIYs5s3zpo8PYzCvECTk8bmUJjvmxnOeBZcKHEjRn-IDTdw2GfkVsY1g4DYiGfijDuiQbwc1WwqeSwF8-dsmKCMnA6Oz2IF19vqZcsDglDs_nUH2VPsDnTVRMxlKd9mxryXIiLdI7PyITRTcO8xnRz2VI8nQbyVssu4Ho5rsd9kOeuEqrUwj1Jfw_mEJXqIcPG3rOg-TSijT2qhWaS7ztZKdbr_q7CquREi Dec 13 14:23:18 arbeitszimmer-papa volumio[1264]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Dec 13 14:23:18 arbeitszimmer-papa volumio[1264]: info: New Spotify access token = BQDGHnk9V_cdqiVcgSiOU_46CKY3-Oh0KLRR5XhJZY__N5YWyv-VnxpUI80OBzDFYx9GmA5xmorNx45aMuReAdIYs5s3zpo8PYzCvECTk8bmUJjvmxnOeBZcKHEjRn-IDTdw2GfkVsY1g4DYiGfijDuiQbwc1WwqeSwF8-dsmKCMnA6Oz2IF19vqZcsDglDs_nUH2VPsDnTVRMxlKd9mxryXIiLdI7PyITRTcO8xnRz2VI8nQbyVssu4Ho5rsd9kOeuEqrUwj1Jfw_mEJXqIcPG3rOg-TSijT2qhWaS7ztZKdbr_q7CquREi Dec 13 14:23:18 arbeitszimmer-papa volumio[1264]: info: Spotify credentials grant success - running version from March 24, 2019 Dec 13 14:23:18 arbeitszimmer-papa volumio[1264]: info: Starting Shairport Sync Dec 13 14:23:18 arbeitszimmer-papa volumio[1264]: info: Starting Shairport Sync Dec 13 14:23:18 arbeitszimmer-papa volumio[1264]: info: Starting Shairport Sync Dec 13 14:23:18 arbeitszimmer-papa sudo[1578]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 13 14:23:18 arbeitszimmer-papa sudo[1580]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 13 14:23:18 arbeitszimmer-papa sudo[1580]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 13 14:23:18 arbeitszimmer-papa sudo[1576]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 13 14:23:18 arbeitszimmer-papa sudo[1576]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 13 14:23:18 arbeitszimmer-papa sudo[1578]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 13 14:23:19 arbeitszimmer-papa systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 13 14:23:19 arbeitszimmer-papa systemd[1]: shairport-sync.service: Deactivated successfully. Dec 13 14:23:19 arbeitszimmer-papa systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 13 14:23:19 arbeitszimmer-papa systemd[1]: shairport-sync.service: Consumed 1.083s CPU time. Dec 13 14:23:19 arbeitszimmer-papa systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 13 14:23:19 arbeitszimmer-papa sudo[1576]: pam_unix(sudo:session): session closed for user root Dec 13 14:23:19 arbeitszimmer-papa systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 13 14:23:19 arbeitszimmer-papa systemd[1]: shairport-sync.service: Deactivated successfully. Dec 13 14:23:19 arbeitszimmer-papa systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 13 14:23:19 arbeitszimmer-papa systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 13 14:23:19 arbeitszimmer-papa sudo[1578]: pam_unix(sudo:session): session closed for user root Dec 13 14:23:19 arbeitszimmer-papa sudo[1580]: pam_unix(sudo:session): session closed for user root Dec 13 14:23:19 arbeitszimmer-papa sudo[1587]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 13 14:23:19 arbeitszimmer-papa go-librespot[1569]: time="2025-12-13T14:23:19+01:00" level=info msg="running go-librespot 0.4.0" Dec 13 14:23:19 arbeitszimmer-papa sudo[1587]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 13 14:23:19 arbeitszimmer-papa go-librespot[1569]: time="2025-12-13T14:23:19+01:00" level=debug msg="app state loaded" Dec 13 14:23:19 arbeitszimmer-papa go-librespot[1569]: time="2025-12-13T14:23:19+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 13 14:23:19 arbeitszimmer-papa systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Dec 13 14:23:19 arbeitszimmer-papa volumio[1264]: info: Shairport-Sync Started Dec 13 14:23:19 arbeitszimmer-papa volumio[1264]: Error adding Membership: Error: addMembership EINVAL Dec 13 14:23:19 arbeitszimmer-papa volumio[1264]: info: Shairport-Sync Started Dec 13 14:23:19 arbeitszimmer-papa volumio[1264]: info: Shairport-Sync Started Dec 13 14:23:19 arbeitszimmer-papa sudo[1587]: pam_unix(sudo:session): session closed for user root Dec 13 14:23:19 arbeitszimmer-papa mpd[1508]: 2025-12-13T14:23:19 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 13 14:23:19 arbeitszimmer-papa go-librespot[1569]: time="2025-12-13T14:23:19+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gae2.spotify.com:80]" Dec 13 14:23:19 arbeitszimmer-papa go-librespot[1569]: time="2025-12-13T14:23:19+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Dec 13 14:23:19 arbeitszimmer-papa go-librespot[1569]: time="2025-12-13T14:23:19+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Dec 13 14:23:19 arbeitszimmer-papa go-librespot[1569]: time="2025-12-13T14:23:19+01:00" level=info msg="zeroconf server listening on port 39299" Dec 13 14:23:19 arbeitszimmer-papa systemd[1]: Started mpd.service - Music Player Daemon. Dec 13 14:23:19 arbeitszimmer-papa sudo[1452]: pam_unix(sudo:session): session closed for user root Dec 13 14:23:20 arbeitszimmer-papa sudo[1484]: pam_unix(sudo:session): session closed for user root Dec 13 14:23:20 arbeitszimmer-papa go-librespot[1569]: time="2025-12-13T14:23:20+01:00" level=debug msg="obtained new client token: AADQUaTTwN6VdwIf8iNQ/zt1bRsbifHWTxdMduVTx/zyO8lsLmDkXqtIrG6uOEoCJ0mAyq8e8uXtDBc+s9OB0su172oKPg4IhI7w4JTrnim8b9PAdwYIN0zz5fiG6V+pg+GvHFcPGCT70xNm+qjuhKY70j34HaV5pl3IUbYtqlvD9kdQCfLvFAw1P2JHFBiUWMbLToJGccaOWSPcKZ8ZEGwOlMDD0gNOBsWkdIhEoC7j4H8bRgRH" Dec 13 14:23:20 arbeitszimmer-papa go-librespot[1569]: time="2025-12-13T14:23:20+01:00" level=warning msg="failed to connect to AP ap-gew4.spotify.com:4070, retrying with a different AP" error="dial tcp 34.158.1.133:4070: connect: connection refused" Dec 13 14:23:20 arbeitszimmer-papa go-librespot[1569]: time="2025-12-13T14:23:20+01:00" level=debug msg="connected to ap-gew4.spotify.com:443" Dec 13 14:23:20 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::volumioGetState Dec 13 14:23:20 arbeitszimmer-papa volumio[1264]: info: CorePlayQueue::getTrack 0 Dec 13 14:23:20 arbeitszimmer-papa volumio-remote-updater[756]: [2025-12-13 14:23:20] [connect] Successful connection Dec 13 14:23:20 arbeitszimmer-papa volumio[1264]: info: Completed starting Core Plugins Dec 13 14:23:20 arbeitszimmer-papa volumio[1264]: info: ------------------------------------------- Dec 13 14:23:20 arbeitszimmer-papa volumio[1264]: info: ----- MyVolumio plugins startup ---- Dec 13 14:23:20 arbeitszimmer-papa volumio[1264]: info: ------------------------------------------- Dec 13 14:23:20 arbeitszimmer-papa volumio[1264]: info: [MyVolumio PluginManager] Fetching plans data.... Dec 13 14:23:20 arbeitszimmer-papa volumio[1264]: info: Upmpdcli Daemon Started Dec 13 14:23:20 arbeitszimmer-papa volumio[1264]: error: MPD error: The expression evaluated to a falsy value: Dec 13 14:23:20 arbeitszimmer-papa volumio[1264]: assert.ok(self.idling) Dec 13 14:23:20 arbeitszimmer-papa volumio[1264]: error: The expression evaluated to a falsy value: Dec 13 14:23:20 arbeitszimmer-papa volumio[1264]: assert.ok(self.idling) Dec 13 14:23:20 arbeitszimmer-papa volumio-remote-updater[756]: [2025-12-13 14:23:20] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1765632200 101 Dec 13 14:23:21 arbeitszimmer-papa go-librespot[1569]: time="2025-12-13T14:23:21+01:00" level=fatal msg="failed running with username and spotify token" error="failed authenticating accesspoint with stored credentials: failed performing keyexchange: failed reading APResponseMessage message: failed reading message length: read tcp 192.168.178.87:33360->34.158.1.133:443: read: connection reset by peer" Dec 13 14:23:21 arbeitszimmer-papa systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 13 14:23:21 arbeitszimmer-papa systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 13 14:23:21 arbeitszimmer-papa volumio[1264]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 2 Dec 13 14:23:21 arbeitszimmer-papa volumio[1264]: error: updateQueue error: null Dec 13 14:23:21 arbeitszimmer-papa volumio[1264]: info: MPD running with PID1508 Dec 13 14:23:21 arbeitszimmer-papa volumio[1264]: ,establishing connection Dec 13 14:23:21 arbeitszimmer-papa volumio[1264]: error: updateQueue error: null Dec 13 14:23:21 arbeitszimmer-papa volumio[1264]: SPOTIFY: User informations: {"country":"DE","display_name":"Lotenamn","email":"kroeder@web.de","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/ct3jwvn67g34xyjolou0jn45s"},"followers":{"href":null,"total":1},"href":"https://api.spotify.com/v1/users/ct3jwvn67g34xyjolou0jn45s","id":"ct3jwvn67g34xyjolou0jn45s","images":[],"product":"premium","type":"user","uri":"spotify:user:ct3jwvn67g34xyjolou0jn45s"} Dec 13 14:23:21 arbeitszimmer-papa volumio[1264]: info: Spotify Successfully logged in Dec 13 14:23:21 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 13 14:23:21 arbeitszimmer-papa volumio[1264]: info: [1765632201459] CoreMusicLibrary::Adding element Spotify Dec 13 14:23:21 arbeitszimmer-papa volumio[1264]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 13 14:23:21 arbeitszimmer-papa volumio[1264]: Cannot find translation for source Spotify Dec 13 14:23:21 arbeitszimmer-papa volumio[1264]: info: go-librespot daemon successfully initialized Dec 13 14:23:23 arbeitszimmer-papa sudo[1648]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 13 14:23:23 arbeitszimmer-papa sudo[1648]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 13 14:23:23 arbeitszimmer-papa sudo[1646]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 13 14:23:23 arbeitszimmer-papa sudo[1646]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 13 14:23:23 arbeitszimmer-papa systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 13 14:23:23 arbeitszimmer-papa mpd_monitor.sh[1651]: MPD Monitor Service: Starting MPD Monitor Service Dec 13 14:23:23 arbeitszimmer-papa sudo[1646]: pam_unix(sudo:session): session closed for user root Dec 13 14:23:23 arbeitszimmer-papa sudo[1648]: pam_unix(sudo:session): session closed for user root Dec 13 14:23:23 arbeitszimmer-papa volumio[1264]: info: Successfully started MPD Monitor Dec 13 14:23:23 arbeitszimmer-papa volumio[1264]: info: Successfully started MPD Monitor Dec 13 14:23:24 arbeitszimmer-papa systemd[1]: go-librespot-daemon.service: Scheduled restart job, restart counter is at 1. Dec 13 14:23:24 arbeitszimmer-papa systemd[1]: Stopped go-librespot-daemon.service - go-librespot Daemon. Dec 13 14:23:24 arbeitszimmer-papa systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 13 14:23:24 arbeitszimmer-papa go-librespot[1655]: go-librespot daemon starting... Dec 13 14:23:24 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:24+01:00" level=info msg="running go-librespot 0.4.0" Dec 13 14:23:24 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:24+01:00" level=debug msg="app state loaded" Dec 13 14:23:24 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:24+01:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 13 14:23:24 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:24+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gae2.spotify.com:80]" Dec 13 14:23:24 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:24+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gae2-dealer.spotify.com:443]" Dec 13 14:23:24 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:24+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gae2-spclient.spotify.com:443]" Dec 13 14:23:24 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:24+01:00" level=info msg="zeroconf server listening on port 40071" Dec 13 14:23:24 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:24+01:00" level=debug msg="obtained new client token: AACBaE0lUY+1lvNeyme0+txW8UUs/cBP6PfSXVVAYI0fszqYFK1OI8KCNEMSuLbq+1JcloSVzTgy+jYA4RDfhVXCPUk/TOczmU1ELZfcSndJyLMy0JbdkMU9vJd6o37Kp0OYzfCwZNNkilzJ0eXxVc3pdIZO73cCTmIDi33Hz2VJyXSXtaemNrgSwJJBtXmR9afhVuMAcP1MGrXIxmXwi26cJMCMf4Iyrzvl5cOJnj21yDmm72rLVcU=" Dec 13 14:23:24 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:24+01:00" level=debug msg="connected to ap-gew4.spotify.com:4070" Dec 13 14:23:24 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:24+01:00" level=debug msg="completed keyexchange" Dec 13 14:23:24 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:24+01:00" level=debug msg="completed challenge" Dec 13 14:23:24 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:24+01:00" level=info msg="authenticated AP" username="ct*********************5s" Dec 13 14:23:24 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:24+01:00" level=info msg="authenticated Login5" username="ct*********************5s" Dec 13 14:23:25 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:25+01:00" level=debug msg="initializing zeroconf session" username="ct*********************5s" Dec 13 14:23:25 arbeitszimmer-papa volumio[1264]: info: Initializing connection to go-librespot Websocket Dec 13 14:23:25 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:25+01:00" level=debug msg="new websocket client" Dec 13 14:23:25 arbeitszimmer-papa volumio[1264]: info: Connection to go-librespot Websocket established Dec 13 14:23:25 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:25+01:00" level=debug msg="dealer connection opened" Dec 13 14:23:25 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:25+01:00" level=trace msg="starting accesspoint recv loop" Dec 13 14:23:25 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:25+01:00" level=trace msg="starting dealer recv loop" Dec 13 14:23:25 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:25+01:00" level=trace msg="received accesspoint ping" Dec 13 14:23:25 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:25+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Dec 13 14:23:25 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:25+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Dec 13 14:23:25 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:25+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Dec 13 14:23:25 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:25+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Dec 13 14:23:25 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:25+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Dec 13 14:23:25 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:25+01:00" level=debug msg="received connection id: NmI2ZTIxMmQtMzgw...OUU2QUU1NjlBMA==" Dec 13 14:23:25 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:25+01:00" level=trace msg="received accesspoint pong ack" Dec 13 14:23:25 arbeitszimmer-papa go-librespot[1656]: time="2025-12-13T14:23:25+01:00" level=debug msg="put connect state because NEW_DEVICE" Dec 13 14:23:26 arbeitszimmer-papa volumio[1264]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Dec 13 14:23:28 arbeitszimmer-papa volumio[1264]: info: Getting Spotify volume Dec 13 14:23:32 arbeitszimmer-papa volumio[1264]: info: Spotify volume: 100 Dec 13 14:23:38 arbeitszimmer-papa volumio[1264]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Dec 13 14:23:39 arbeitszimmer-papa volumio[1264]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 13 14:23:39 arbeitszimmer-papa volumio[1264]: Error [ERR_INTERNAL_ASSERTION]: This is caused by either a bug in Node.js or incorrect usage of Node.js internals. Dec 13 14:23:39 arbeitszimmer-papa volumio[1264]: Please open an issue with this stack trace at https://github.com/nodejs/node/issues Dec 13 14:23:39 arbeitszimmer-papa volumio[1264]: at new NodeError (node:internal/errors:405:5) Dec 13 14:23:39 arbeitszimmer-papa volumio[1264]: at assert (node:internal/assert:14:11) Dec 13 14:23:39 arbeitszimmer-papa volumio[1264]: at internalConnectMultiple (node:net:1118:3) Dec 13 14:23:39 arbeitszimmer-papa volumio[1264]: at Timeout.internalConnectMultipleTimeout (node:net:1687:3) Dec 13 14:23:39 arbeitszimmer-papa volumio[1264]: at listOnTimeout (node:internal/timers:575:11) Dec 13 14:23:39 arbeitszimmer-papa volumio[1264]: at process.processTimers (node:internal/timers:514:7) { Dec 13 14:23:39 arbeitszimmer-papa volumio[1264]: code: 'ERR_INTERNAL_ASSERTION' Dec 13 14:23:39 arbeitszimmer-papa volumio[1264]: } Dec 13 14:23:39 arbeitszimmer-papa volumio[1264]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 13 14:23:43 arbeitszimmer-papa sudo[1705]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-13 14:22' Dec 13 14:23:43 arbeitszimmer-papa sudo[1705]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="ac7dd5922ede329d1459d48b226ddc71f5209a2c" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="b5a4a000e056eaff366fbb6591bf2240b12246d0" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat Nov 8 06:10:52 UTC 2025" VOLUMIO_VERSION="4.067" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="78c9815e90cf3bee23e5cdc5934a01e9"