Dec 20 09:49:16 walle ntpd[911]: CLOCK: time stepped by 1285070.435100 Dec 20 09:49:16 walle ntpd[911]: CLOCK: time changed from 2025-12-05 to 2025-12-20 Dec 20 09:49:16 walle ntpd[911]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Dec 20 09:49:16 walle systemd[1]: Starting dpkg-db-backup.service - Daily dpkg database backup service... Dec 20 09:49:16 walle systemd[1]: Started ntpsec-rotate-stats.service - Rotate ntpd stats. Dec 20 09:49:16 walle systemd[1]: ntpsec-rotate-stats.service: Deactivated successfully. Dec 20 09:49:16 walle systemd[1]: dpkg-db-backup.service: Deactivated successfully. Dec 20 09:49:16 walle systemd[1]: Finished dpkg-db-backup.service - Daily dpkg database backup service. Dec 20 09:49:17 walle volumio[1217]: info: MYVOLUMIO Environment detected Dec 20 09:49:18 walle volumio[1217]: info: Plugin folders cleanup Dec 20 09:49:18 walle volumio[1217]: info: Scanning into folder /volumio/app/plugins/ Dec 20 09:49:18 walle volumio[1217]: info: Scanning category audio_interface Dec 20 09:49:18 walle volumio[1217]: info: Scanning category miscellanea Dec 20 09:49:18 walle volumio[1217]: info: Scanning category music_service Dec 20 09:49:18 walle volumio[1217]: info: Scanning category plugins.json Dec 20 09:49:18 walle volumio[1217]: info: Scanning category system_controller Dec 20 09:49:18 walle volumio[1217]: info: Scanning category user_interface Dec 20 09:49:18 walle volumio[1217]: info: Scanning into folder /data/plugins/ Dec 20 09:49:18 walle volumio[1217]: info: Plugin folders cleanup completed Dec 20 09:49:18 walle volumio[1217]: info: ------------------------------------------- Dec 20 09:49:18 walle volumio[1217]: info: ----- Core plugins startup ---- Dec 20 09:49:18 walle volumio[1217]: info: ------------------------------------------- Dec 20 09:49:18 walle volumio[1217]: info: Loading plugins from folder /volumio/app/plugins/ Dec 20 09:49:18 walle volumio[1217]: info: Adding plugin upnp to MyMusic Plugins Dec 20 09:49:18 walle volumio[1217]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 20 09:49:18 walle volumio[1217]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 20 09:49:18 walle volumio[1217]: info: Loading plugins from folder /data/plugins/ Dec 20 09:49:18 walle volumio[1217]: info: Loading plugin "system"... Dec 20 09:49:18 walle volumio[1217]: info: Loading plugin "appearance"... Dec 20 09:49:19 walle systemd[1]: systemd-fsckd.service: Deactivated successfully. Dec 20 09:49:20 walle volumio[1217]: info: Loading plugin "network"... Dec 20 09:49:20 walle volumio[1217]: info: Refreshing Cached IP Addresses Dec 20 09:49:20 walle sudo[1359]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 20 09:49:20 walle sudo[1359]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 09:49:20 walle sudo[1361]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 20 09:49:20 walle sudo[1361]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 09:49:20 walle sudo[1361]: pam_unix(sudo:session): session closed for user root Dec 20 09:49:20 walle volumio[1217]: info: Loading plugin "services"... Dec 20 09:49:20 walle sudo[1359]: pam_unix(sudo:session): session closed for user root Dec 20 09:49:20 walle volumio[1217]: info: Loading plugin "alsa_controller"... Dec 20 09:49:20 walle sudo[1374]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 20 09:49:20 walle sudo[1374]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 09:49:20 walle volumio[1217]: warn: The ALSA output card is not set, defaulting to card [object Object] Dec 20 09:49:20 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 20 09:49:20 walle volumio[1217]: info: Loading plugin "wizard"... Dec 20 09:49:20 walle volumio[1217]: info: Loading plugin "networkfs"... Dec 20 09:49:21 walle dhcpcd[677]: timed out Dec 20 09:49:21 walle sh[665]: timed out Dec 20 09:49:21 walle sh[591]: ifup: failed to bring up eth0 Dec 20 09:49:21 walle systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Dec 20 09:49:21 walle systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Dec 20 09:49:21 walle sudo[1394]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=volumio,password=Yolanda1!,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //tk/playback.volumio/MUS /mnt/NAS/CDs Dec 20 09:49:21 walle sudo[1394]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 09:49:21 walle sudo[1399]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=volumio,password=Yolanda1!,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //tk/playback.volumio/MUP /mnt/NAS/Playlists Dec 20 09:49:21 walle sudo[1399]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 09:49:21 walle volumio[1217]: info: Starting Udev Watcher for removable devices Dec 20 09:49:21 walle sudo[1397]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=volumio,password=Yolanda1!,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //tk/playback.volumio/MUK /mnt/NAS/Casettes Dec 20 09:49:21 walle sudo[1397]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 09:49:21 walle volumio[1217]: info: Ignoring mount for partition: boot Dec 20 09:49:21 walle volumio[1217]: info: Ignoring mount for partition: volumio Dec 20 09:49:21 walle volumio[1217]: info: Ignoring mount for partition: volumio_data Dec 20 09:49:21 walle kernel: netfs: FS-Cache loaded Dec 20 09:49:21 walle volumio[1217]: info: Mounting Device empty Dec 20 09:49:21 walle sudo[1374]: pam_unix(sudo:session): session closed for user root Dec 20 09:49:21 walle sudo[1420]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/empty -o noatime Dec 20 09:49:21 walle sudo[1420]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 09:49:21 walle kernel: Key type cifs.spnego registered Dec 20 09:49:21 walle kernel: Key type cifs.idmap registered Dec 20 09:49:21 walle 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 20 09:49:21 walle kernel: CIFS: Attempting to mount //tk/playback.volumio/MUS Dec 20 09:49:22 walle kernel: hfsplus: Filesystem was not cleanly unmounted, running fsck.hfsplus is recommended. mounting read-only. Dec 20 09:49:22 walle sudo[1420]: pam_unix(sudo:session): session closed for user root Dec 20 09:49:22 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 20 09:49:22 walle volumio[1217]: info: Loading plugin "volumio_command_line_client"... Dec 20 09:49:22 walle volumio[1217]: info: Loading plugin "upnp"... Dec 20 09:49:22 walle volumio[1217]: info: [1766252962251] Starting Upmpd Daemon Dec 20 09:49:22 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 20 09:49:22 walle volumio[1217]: info: Loading plugin "my_music"... Dec 20 09:49:22 walle volumio[1217]: info: Loading plugin "mpd"... Dec 20 09:49:23 walle volumio[1217]: info: Loading plugin "upnp_browser"... Dec 20 09:49:23 walle systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2. Dec 20 09:49:23 walle systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Dec 20 09:49:23 walle systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Dec 20 09:49:23 walle upmpdcli[1452]: Could not open config: /tmp/upmpdcli.conf Dec 20 09:49:23 walle systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Dec 20 09:49:23 walle systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Dec 20 09:49:25 walle systemd[1]: systemd-hostnamed.service: Deactivated successfully. Dec 20 09:49:26 walle volumio[1217]: info: Starting UPNP Browser Dec 20 09:49:26 walle volumio[1217]: info: Loading plugin "alarm-clock"... Dec 20 09:49:26 walle volumio[1217]: info: Loading plugin "airplay_emulation"... Dec 20 09:49:26 walle volumio[1217]: info: Starting Shairport Sync Dec 20 09:49:26 walle volumio[1217]: info: Loading plugin "last_100"... Dec 20 09:49:26 walle volumio[1217]: info: Loading plugin "webradio"... Dec 20 09:49:27 walle volumio[1217]: info: Loading plugin "i2s_dacs"... Dec 20 09:49:27 walle volumio[1217]: info: Loading plugin "volumiodiscovery"... Dec 20 09:49:27 walle volumio[1217]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 20 09:49:27 walle volumio[1217]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 20 09:49:27 walle volumio[1217]: *** WARNING *** For more information see Dec 20 09:49:27 walle volumio[1217]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 20 09:49:27 walle volumio[1217]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 20 09:49:27 walle volumio[1217]: *** WARNING *** For more information see Dec 20 09:49:27 walle node[1217]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 20 09:49:27 walle node[1217]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 20 09:49:27 walle node[1217]: *** WARNING *** For more information see Dec 20 09:49:27 walle node[1217]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 20 09:49:27 walle node[1217]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 20 09:49:27 walle node[1217]: *** WARNING *** For more information see Dec 20 09:49:27 walle volumio[1217]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 20 09:49:27 walle volumio[1217]: info: Discovery: Started advertising with name: woody Dec 20 09:49:27 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 20 09:49:27 walle volumio[1217]: info: Loading plugin "outputs"... Dec 20 09:49:27 walle volumio[1217]: info: Loading plugin "albumart"... Dec 20 09:49:27 walle volumio[1217]: info: Plugin example_plugin is not enabled Dec 20 09:49:27 walle volumio[1217]: info: Loading plugin "inputs"... Dec 20 09:49:27 walle volumio[1217]: info: Loading plugin "updater_comm"... Dec 20 09:49:28 walle volumio[1217]: info: Plugin mpdemulation is not enabled Dec 20 09:49:28 walle volumio[1217]: info: Loading plugin "rest_api"... Dec 20 09:49:28 walle volumio[1217]: info: Loading plugin "websocket"... Dec 20 09:49:28 walle volumio[1217]: info: Starting Socket.io Server version 1.7.4 Dec 20 09:49:28 walle volumio[1217]: info: Loading i18n strings for locale en Dec 20 09:49:28 walle volumio[1217]: Updating browse sources language Dec 20 09:49:28 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 09:49:29 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 20 09:49:29 walle volumio[1217]: info: CoreCommandRouter::initPlayerControls Dec 20 09:49:29 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 09:49:29 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 09:49:29 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 09:49:29 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 09:49:29 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 09:49:29 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 09:49:29 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 09:49:29 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 09:49:29 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 20 09:49:29 walle volumio[1217]: Express server listening on port 3000 Dec 20 09:49:29 walle volumio[1217]: [Metrics] WebUI: 14s 488.35ms Dec 20 09:49:29 walle volumio[1217]: info: CoreStateMachine::resetVolumioState Dec 20 09:49:29 walle volumio[1217]: info: CoreStateMachine::getcurrentVolume Dec 20 09:49:29 walle volumio[1217]: info: CoreCommandRouter::volumioRetrievevolume Dec 20 09:49:29 walle volumio[1217]: info: Volumio Network Manager: Network status updated: 2 Dec 20 09:49:29 walle volumio[1217]: verbose: New Socket.io Connection to 192.168.101.63 from 192.168.101.159 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Dec 20 09:49:29 walle volumio[1217]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control 'Analogue Playback Boost',0 Dec 20 09:49:29 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 09:49:29 walle volumio[1217]: info: Reloading queue from file Dec 20 09:49:30 walle volumio[1217]: verbose: New Socket.io Connection to 192.168.101.63 from 192.168.101.159 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Dec 20 09:49:30 walle volumio[1217]: info: VolumeController:: Volume=undefined Mute =false Dec 20 09:49:30 walle volumio[1217]: info: CoreStateMachine::pushState Dec 20 09:49:30 walle volumio[1217]: info: CorePlayQueue::getTrack 0 Dec 20 09:49:30 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 09:49:30 walle volumio[1217]: info: CoreCommandRouter::volumioPushState Dec 20 09:49:30 walle volumio[1217]: info: CoreStateMachine::updateTrackBlock Dec 20 09:49:30 walle volumio[1217]: info: CorePlayQueue::getTrackBlock Dec 20 09:49:30 walle volumio[1217]: info: CoreCommandRouter::volumioRetrievevolume Dec 20 09:49:30 walle volumio[1217]: info: CoreStateMachine::setRepeat false single undefined Dec 20 09:49:30 walle volumio-remote-updater[709]: [2025-12-20 09:49:30] [connect] Successful connection Dec 20 09:49:30 walle volumio[1217]: info: CoreStateMachine::pushState Dec 20 09:49:30 walle volumio[1217]: info: CorePlayQueue::getTrack 0 Dec 20 09:49:30 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 09:49:30 walle volumio[1217]: info: CoreCommandRouter::volumioPushState Dec 20 09:49:30 walle volumio[1217]: info: CoreStateMachine::setRandom false Dec 20 09:49:30 walle volumio[1217]: info: CoreStateMachine::pushState Dec 20 09:49:30 walle volumio[1217]: info: CorePlayQueue::getTrack 0 Dec 20 09:49:30 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 09:49:30 walle volumio[1217]: info: CoreCommandRouter::volumioPushState Dec 20 09:49:30 walle volumio[1217]: info: Setting Device type: Raspberry PI Dec 20 09:49:30 walle volumio[1217]: verbose: New Socket.io Connection to 192.168.101.63 from 192.168.101.159 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Dec 20 09:49:30 walle volumio[1460]: Forking 3 albumart workers Dec 20 09:49:30 walle volumio[1217]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Dec 20 09:49:30 walle volumio[1217]: info: USB Boot Capable - System SBC Revision found in cpuinfo: a22082 Dec 20 09:49:30 walle volumio[1217]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Dec 20 09:49:30 walle volumio[1217]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control 'Analogue Playback Boost',0 Dec 20 09:49:30 walle volumio-remote-updater[709]: [2025-12-20 09:49:30] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1766252970 101 Dec 20 09:49:30 walle volumio[1217]: 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: 4 Dec 20 09:49:30 walle volumio[1217]: info: Discovery: adding dc479ac8-c158-47c0-802a-60ed49f4102e Dec 20 09:49:30 walle volumio[1217]: info: Discovery: Found device woody Dec 20 09:49:30 walle volumio[1217]: info: CoreCommandRouter::volumioGetState Dec 20 09:49:30 walle volumio[1217]: info: CorePlayQueue::getTrack 0 Dec 20 09:49:30 walle volumio[1217]: info: Discovery: this is already registered, dc479ac8-c158-47c0-802a-60ed49f4102e Dec 20 09:49:30 walle volumio[1217]: info: Discovery: Found device woody Dec 20 09:49:30 walle volumio[1217]: info: CoreCommandRouter::volumioGetState Dec 20 09:49:30 walle volumio[1217]: info: CorePlayQueue::getTrack 0 Dec 20 09:49:30 walle volumio[1217]: info: VolumeController:: Volume=undefined Mute =false Dec 20 09:49:30 walle volumio[1217]: info: CoreStateMachine::pushState Dec 20 09:49:30 walle volumio[1217]: info: CorePlayQueue::getTrack 0 Dec 20 09:49:30 walle volumio[1217]: info: CoreCommandRouter::volumioPushState Dec 20 09:49:30 walle systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Dec 20 09:49:32 walle sudo[1553]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 20 09:49:32 walle sudo[1553]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 09:49:32 walle sudo[1553]: pam_unix(sudo:session): session closed for user root Dec 20 09:49:32 walle sudo[1551]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 20 09:49:32 walle sudo[1551]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 09:49:32 walle sudo[1551]: pam_unix(sudo:session): session closed for user root Dec 20 09:49:32 walle sudo[1556]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 20 09:49:32 walle sudo[1556]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 09:49:33 walle sudo[1556]: pam_unix(sudo:session): session closed for user root Dec 20 09:49:33 walle volumio[1217]: verbose: New Socket.io Connection to 192.168.101.63 from 192.168.101.159 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Dec 20 09:49:33 walle sudo[1558]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 20 09:49:33 walle sudo[1558]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 09:49:33 walle sudo[1558]: pam_unix(sudo:session): session closed for user root Dec 20 09:49:33 walle systemd[1]: setdatetime-helper.service: Deactivated successfully. Dec 20 09:49:33 walle systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Dec 20 09:49:33 walle systemd[1]: setdatetime-helper.service: Consumed 1.520s CPU time. Dec 20 09:49:33 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 20 09:49:33 walle volumio[1217]: info: CoreCommandRouter::volumioGetVisibleSources Dec 20 09:49:33 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 09:49:33 walle volumio[1217]: info: CoreCommandRouter::volumioGetState Dec 20 09:49:33 walle volumio[1217]: info: CorePlayQueue::getTrack 0 Dec 20 09:49:33 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 20 09:49:33 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 20 09:49:33 walle volumio[1217]: info: Received Get System Info Dec 20 09:49:33 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 09:49:33 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 09:49:33 walle volumio[1217]: info: Discovery: Getting this device information Dec 20 09:49:33 walle volumio[1217]: info: CoreCommandRouter::volumioGetState Dec 20 09:49:33 walle volumio[1217]: info: CorePlayQueue::getTrack 0 Dec 20 09:49:33 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 09:49:33 walle volumio[1217]: info: CoreCommandRouter::volumioGetState Dec 20 09:49:33 walle volumio[1217]: info: CorePlayQueue::getTrack 0 Dec 20 09:49:33 walle volumio[1217]: info: Listing playlists Dec 20 09:49:33 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 20 09:49:33 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 20 09:49:33 walle sudo[1573]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 20 09:49:33 walle sudo[1573]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 20 09:49:33 walle systemd[1]: Starting e2scrub_all.service - Online ext4 Metadata Check for All Filesystems... Dec 20 09:49:33 walle systemd[1]: e2scrub_all.service: Deactivated successfully. Dec 20 09:49:33 walle systemd[1]: Finished e2scrub_all.service - Online ext4 Metadata Check for All Filesystems. Dec 20 09:49:33 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 20 09:49:33 walle volumio[1217]: info: Received Get System Info Dec 20 09:49:33 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 09:49:33 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 09:49:33 walle volumio[1217]: info: Discovery: Getting this device information Dec 20 09:49:33 walle volumio[1217]: info: CoreCommandRouter::volumioGetState Dec 20 09:49:33 walle volumio[1217]: info: CorePlayQueue::getTrack 0 Dec 20 09:49:33 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 09:49:34 walle volumio[1217]: info: CoreCommandRouter::volumioGetState Dec 20 09:49:34 walle volumio[1217]: info: CorePlayQueue::getTrack 0 Dec 20 09:49:34 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Dec 20 09:49:34 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 20 09:49:34 walle volumio[1217]: info: Received Get System Info Dec 20 09:49:34 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 09:49:34 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 09:49:34 walle volumio[1217]: info: Discovery: Getting this device information Dec 20 09:49:34 walle volumio[1217]: info: CoreCommandRouter::volumioGetState Dec 20 09:49:34 walle volumio[1217]: info: CorePlayQueue::getTrack 0 Dec 20 09:49:34 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 09:49:34 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Dec 20 09:49:35 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 20 09:49:36 walle volumio[1217]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 20 09:49:37 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 20 09:49:37 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 20 09:49:37 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 20 09:49:37 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 20 09:49:37 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 20 09:49:37 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 20 09:49:37 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 20 09:49:37 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 20 09:49:37 walle volumio[1217]: info: CoreCommandRouter::volumioGetBrowseSources Dec 20 09:49:37 walle volumio[1217]: info: CoreCommandRouter::volumioGetBrowseSources Dec 20 09:49:37 walle volumio[1217]: info: CoreCommandRouter::volumioGetBrowseSources Dec 20 09:49:37 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 20 09:49:37 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 20 09:49:38 walle systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 3. Dec 20 09:49:38 walle systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Dec 20 09:49:38 walle systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Dec 20 09:49:38 walle sudo[1573]: pam_unix(sudo:session): session closed for user root Dec 20 09:49:38 walle volumio[1217]: info: Upmpdcli Daemon Started Dec 20 09:49:39 walle volumio[1217]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Dec 20 09:49:40 walle volumio[1488]: Starting albumart workers Dec 20 09:49:40 walle volumio[1487]: Starting albumart workers Dec 20 09:49:41 walle volumio[1489]: Starting albumart workers Dec 20 09:49:41 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 20 09:49:42 walle volumio[1217]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Dec 20 09:49:43 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 20 09:49:45 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 20 09:49:45 walle volumio[1217]: info: CoreCommandRouter::Close All Modals sent Dec 20 09:49:45 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: appearance , setTOSAccepted Dec 20 09:49:48 walle volumio[1217]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Dec 20 09:49:49 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 20 09:49:50 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 20 09:49:50 walle volumio[1217]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 20 09:49:50 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 20 09:49:50 walle volumio[1217]: info: Received Get System Version Dec 20 09:49:50 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 20 09:49:50 walle volumio[1217]: info: Received Get System Info Dec 20 09:49:50 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 09:49:50 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 09:49:50 walle volumio[1217]: info: Discovery: Getting this device information Dec 20 09:49:50 walle volumio[1217]: info: CoreCommandRouter::volumioGetState Dec 20 09:49:50 walle volumio[1217]: info: CorePlayQueue::getTrack 0 Dec 20 09:49:50 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 09:49:53 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 20 09:49:55 walle volumio[1217]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Dec 20 09:49:55 walle volumio[1217]: verbose: ControllerMpd::sendMpdCommand update Dec 20 09:49:55 walle volumio[1217]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 20 09:49:56 walle volumio[1217]: TypeError: Cannot read properties of undefined (reading 'then') Dec 20 09:49:56 walle volumio[1217]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:332:6) Dec 20 09:49:56 walle volumio[1217]: at ControllerMpd.updateDb (/volumio/app/plugins/music_service/mpd/index.js:1917:15) Dec 20 09:49:56 walle volumio[1217]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Dec 20 09:49:56 walle volumio[1217]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1102:26) Dec 20 09:49:56 walle volumio[1217]: at Socket.emit (node:events:514:28) Dec 20 09:49:56 walle volumio[1217]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Dec 20 09:49:56 walle volumio[1217]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Dec 20 09:49:56 walle volumio[1217]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 20 09:50:02 walle kernel: CIFS: Attempting to mount //tk/playback.volumio/MUP Dec 20 09:50:02 walle sudo[1394]: pam_unix(sudo:session): session closed for user root Dec 20 09:50:02 walle kernel: CIFS: Attempting to mount //tk/playback.volumio/MUK Dec 20 09:50:02 walle sudo[1399]: pam_unix(sudo:session): session closed for user root Dec 20 09:50:02 walle sudo[1397]: pam_unix(sudo:session): session closed for user root Dec 20 09:50:02 walle sudo[1677]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-20 09:49' Dec 20 09:50:02 walle sudo[1677]: 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"