-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Mon 2025-12-29 16:58:08 UTC. -- Dec 29 16:57:57 bunibanibox systemd-timedated[960]: Changed local time to Mon Dec 29 16:57:57 2025 Dec 29 16:57:57 bunibanibox sudo[958]: pam_unix(sudo:session): session closed for user root Dec 29 16:57:57 bunibanibox volumio-time-update[546]: volumio-time-update-util: System time updated successfully. Dec 29 16:57:57 bunibanibox systemd[1]: Started Volumio Time Update Utility. Dec 29 16:57:57 bunibanibox ntpd[916]: Soliciting pool server 185.13.148.71 Dec 29 16:57:57 bunibanibox systemd[1]: Starting Daily apt download activities... Dec 29 16:57:57 bunibanibox ntpd[916]: Soliciting pool server 188.174.253.188 Dec 29 16:57:57 bunibanibox volumio[831]: info: Loading plugin "network"... Dec 29 16:57:57 bunibanibox volumio[831]: info: Refreshing Cached IP Addresses Dec 29 16:57:57 bunibanibox sudo[963]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 29 16:57:57 bunibanibox sudo[963]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 16:57:57 bunibanibox sudo[963]: pam_unix(sudo:session): session closed for user root Dec 29 16:57:57 bunibanibox volumio[831]: info: Loading plugin "services"... Dec 29 16:57:57 bunibanibox sudo[965]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 29 16:57:57 bunibanibox sudo[965]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 29 16:57:57 bunibanibox volumio[831]: info: Loading plugin "alsa_controller"... Dec 29 16:57:57 bunibanibox sudo[965]: pam_unix(sudo:session): session closed for user root Dec 29 16:57:57 bunibanibox volumio[831]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 29 16:57:57 bunibanibox volumio[831]: info: Loading plugin "wizard"... Dec 29 16:57:57 bunibanibox volumio[831]: info: Loading plugin "networkfs"... Dec 29 16:57:57 bunibanibox volumio[831]: info: Starting Udev Watcher for removable devices Dec 29 16:57:57 bunibanibox volumio[831]: info: Ignoring mount for partition: boot Dec 29 16:57:57 bunibanibox volumio[831]: info: Ignoring mount for partition: volumio Dec 29 16:57:57 bunibanibox volumio[831]: info: Ignoring mount for partition: volumio_data Dec 29 16:57:57 bunibanibox volumio[831]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 29 16:57:57 bunibanibox volumio[831]: info: Loading plugin "volumio_command_line_client"... Dec 29 16:57:57 bunibanibox volumio[831]: info: Plugin upnp is not enabled Dec 29 16:57:57 bunibanibox volumio[831]: info: Loading plugin "my_music"... Dec 29 16:57:57 bunibanibox volumio[831]: info: Loading plugin "mpd"... Dec 29 16:57:58 bunibanibox ntpd[916]: Soliciting pool server 159.69.64.189 Dec 29 16:57:58 bunibanibox ntpd[916]: Soliciting pool server 128.140.109.119 Dec 29 16:57:58 bunibanibox ntpd[916]: Soliciting pool server 188.40.99.69 Dec 29 16:57:58 bunibanibox nmbd[750]: [2025/12/29 16:57:58.311035, 0] ../lib/util/become_daemon.c:138(daemon_ready) Dec 29 16:57:58 bunibanibox systemd[1]: Started Samba NMB Daemon. Dec 29 16:57:58 bunibanibox volumio[831]: info: Plugin upnp_browser is not enabled Dec 29 16:57:58 bunibanibox volumio[831]: info: Loading plugin "alarm-clock"... Dec 29 16:57:58 bunibanibox nmbd[750]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Dec 29 16:57:58 bunibanibox systemd[1]: Starting Samba Winbind Daemon... Dec 29 16:57:58 bunibanibox volumio-remote-updater[553]: [2025-12-29 16:57:58] [connect] Successful connection Dec 29 16:57:58 bunibanibox volumio[831]: info: Plugin airplay_emulation is not enabled Dec 29 16:57:58 bunibanibox volumio[831]: info: Loading plugin "last_100"... Dec 29 16:57:58 bunibanibox volumio[831]: info: Loading plugin "webradio"... Dec 29 16:57:59 bunibanibox winbindd[1008]: [2025/12/29 16:57:59.008712, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Dec 29 16:57:59 bunibanibox winbindd[1008]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Dec 29 16:57:59 bunibanibox winbindd[1008]: [2025/12/29 16:57:59.040633, 0] ../lib/util/become_daemon.c:138(daemon_ready) Dec 29 16:57:59 bunibanibox winbindd[1008]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Dec 29 16:57:59 bunibanibox systemd[1]: Started Samba Winbind Daemon. Dec 29 16:57:59 bunibanibox ntpd[916]: Soliciting pool server 194.59.205.229 Dec 29 16:57:59 bunibanibox ntpd[916]: Soliciting pool server 139.162.152.20 Dec 29 16:57:59 bunibanibox systemd[1]: Starting Samba SMB Daemon... Dec 29 16:57:59 bunibanibox ntpd[916]: Soliciting pool server 129.70.132.32 Dec 29 16:57:59 bunibanibox ntpd[916]: Soliciting pool server 185.252.140.125 Dec 29 16:57:59 bunibanibox volumio[831]: info: Loading plugin "i2s_dacs"... Dec 29 16:57:59 bunibanibox volumio[831]: info: I2S DAC not set, start Auto-detection Dec 29 16:57:59 bunibanibox volumio[831]: info: Loading plugin "volumiodiscovery"... Dec 29 16:57:59 bunibanibox volumio[831]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 29 16:57:59 bunibanibox volumio[831]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 29 16:57:59 bunibanibox volumio[831]: *** WARNING *** For more information see Dec 29 16:57:59 bunibanibox volumio[831]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 29 16:57:59 bunibanibox volumio[831]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 29 16:57:59 bunibanibox volumio[831]: *** WARNING *** For more information see Dec 29 16:57:59 bunibanibox node[831]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 29 16:57:59 bunibanibox node[831]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 29 16:57:59 bunibanibox node[831]: *** WARNING *** For more information see Dec 29 16:57:59 bunibanibox node[831]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 29 16:57:59 bunibanibox node[831]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 29 16:57:59 bunibanibox node[831]: *** WARNING *** For more information see Dec 29 16:57:59 bunibanibox volumio[831]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 29 16:57:59 bunibanibox volumio[831]: info: Discovery: Started advertising with name: bunibanibox Dec 29 16:57:59 bunibanibox volumio[831]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 29 16:57:59 bunibanibox volumio[831]: info: Loading plugin "spop"... Dec 29 16:57:59 bunibanibox smbd[1016]: [2025/12/29 16:57:59.843188, 0] ../lib/util/become_daemon.c:138(daemon_ready) Dec 29 16:57:59 bunibanibox systemd[1]: Started Samba SMB Daemon. Dec 29 16:57:59 bunibanibox smbd[1016]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Dec 29 16:57:59 bunibanibox systemd[1]: Reached target Multi-User System. Dec 29 16:57:59 bunibanibox systemd[1]: Reached target Graphical Interface. Dec 29 16:57:59 bunibanibox systemd[1]: Starting Update UTMP about System Runlevel Changes... Dec 29 16:58:00 bunibanibox systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Dec 29 16:58:00 bunibanibox systemd[1]: Started Update UTMP about System Runlevel Changes. Dec 29 16:58:00 bunibanibox ntpd[916]: Soliciting pool server 148.251.5.46 Dec 29 16:58:00 bunibanibox ntpd[916]: Soliciting pool server 94.130.184.193 Dec 29 16:58:00 bunibanibox ntpd[916]: Soliciting pool server 139.162.187.236 Dec 29 16:58:00 bunibanibox systemd[1]: apt-daily.service: Succeeded. Dec 29 16:58:00 bunibanibox systemd[1]: Started Daily apt download activities. Dec 29 16:58:00 bunibanibox systemd[1]: Starting Daily apt upgrade and clean activities... Dec 29 16:58:01 bunibanibox ntpd[916]: Soliciting pool server 194.36.144.87 Dec 29 16:58:01 bunibanibox ntpd[916]: Soliciting pool server 79.133.44.142 Dec 29 16:58:01 bunibanibox volumio[831]: info: Loading plugin "youtube2"... Dec 29 16:58:02 bunibanibox ntpd[916]: Soliciting pool server 217.91.44.17 Dec 29 16:58:02 bunibanibox ntpd[916]: Soliciting pool server 2a01:4f8:c2c:8952:: Dec 29 16:58:02 bunibanibox systemd[1]: apt-daily-upgrade.service: Succeeded. Dec 29 16:58:02 bunibanibox systemd[1]: Started Daily apt upgrade and clean activities. Dec 29 16:58:02 bunibanibox systemd[1]: Startup finished in 14.455s (kernel) + 24.194s (userspace) = 38.650s. Dec 29 16:58:03 bunibanibox volumio[831]: info: Loading plugin "outputs"... Dec 29 16:58:03 bunibanibox volumio[831]: info: Loading plugin "albumart"... Dec 29 16:58:03 bunibanibox volumio[831]: info: Plugin example_plugin is not enabled Dec 29 16:58:03 bunibanibox volumio[831]: info: Loading plugin "inputs"... Dec 29 16:58:03 bunibanibox volumio[831]: info: Loading plugin "updater_comm"... Dec 29 16:58:03 bunibanibox volumio[831]: info: Plugin mpdemulation is not enabled Dec 29 16:58:03 bunibanibox volumio[831]: info: Loading plugin "rest_api"... Dec 29 16:58:03 bunibanibox volumio[831]: info: Loading plugin "websocket"... Dec 29 16:58:03 bunibanibox volumio[831]: info: Starting Socket.io Server version 2.3.0 Dec 29 16:58:03 bunibanibox volumio[831]: info: Loading plugin "fusiondsp"... Dec 29 16:58:04 bunibanibox volumio[831]: Forking 3 albumart workers Dec 29 16:58:04 bunibanibox volumio[831]: info: Applying required configuration parameters for plugin fusiondsp Dec 29 16:58:04 bunibanibox volumio[831]: info: Loading plugin "backup_restore"... Dec 29 16:58:06 bunibanibox ntpd[916]: receive: Unexpected origin timestamp 0xecfd319d.136df79f does not match aorg 0000000000.00000000 from server@148.251.5.46 xmt 0xecfd319e.7397bf26 Dec 29 16:58:06 bunibanibox ntpd[916]: receive: Unexpected origin timestamp 0xecfd319d.1371536b does not match aorg 0000000000.00000000 from server@129.70.132.32 xmt 0xecfd319e.73c977bd Dec 29 16:58:06 bunibanibox ntpd[916]: receive: Unexpected origin timestamp 0xecfd319d.137829f7 does not match aorg 0000000000.00000000 from server@188.174.253.188 xmt 0xecfd319e.74139051 Dec 29 16:58:06 bunibanibox volumio[831]: Starting albumart workers Dec 29 16:58:06 bunibanibox volumio[831]: Starting albumart workers Dec 29 16:58:06 bunibanibox volumio[831]: Starting albumart workers Dec 29 16:58:06 bunibanibox volumio[831]: info: Applying required configuration parameters for plugin backup_restore Dec 29 16:58:06 bunibanibox volumio[831]: info: Loading i18n strings for locale en Dec 29 16:58:06 bunibanibox volumio[831]: Updating browse sources language Dec 29 16:58:06 bunibanibox volumio[831]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreCommandRouter::initPlayerControls Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 29 16:58:07 bunibanibox python2[725]: RFID USB Encoder starts playlist RFID-0010740731 Dec 29 16:58:07 bunibanibox volumio[831]: Express server listening on port 3000 Dec 29 16:58:07 bunibanibox volumio[831]: [Metrics] WebUI: 13s 961.82ms Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreStateMachine::resetVolumioState Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreStateMachine::getcurrentVolume Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreCommandRouter::volumioRetrievevolume Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 29 16:58:07 bunibanibox volumio[831]: info: Volumio Network Manager: Network status updated: 1 Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreStateMachine::pushState Dec 29 16:58:07 bunibanibox volumio[831]: info: CorePlayQueue::getTrack 0 Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreCommandRouter::volumioPushState Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreStateMachine::updateTrackBlock Dec 29 16:58:07 bunibanibox volumio[831]: info: CorePlayQueue::getTrackBlock Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreCommandRouter::volumioRetrievevolume Dec 29 16:58:07 bunibanibox volumio[831]: info: Dec 29 16:58:07 bunibanibox volumio[831]: ---------------------------- Client requests Volumio Play Playlist RFID-0010740731 Dec 29 16:58:07 bunibanibox volumio[831]: info: Play playlist RFID-0010740731 Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreStateMachine::setRepeat true single undefined Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreStateMachine::pushState Dec 29 16:58:07 bunibanibox volumio[831]: info: CorePlayQueue::getTrack 0 Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreCommandRouter::volumioPushState Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreStateMachine::setRandom false Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreStateMachine::pushState Dec 29 16:58:07 bunibanibox volumio[831]: info: CorePlayQueue::getTrack 0 Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreCommandRouter::volumioPushState Dec 29 16:58:07 bunibanibox volumio[831]: info: Setting Device type: Raspberry PI Dec 29 16:58:07 bunibanibox volumio[831]: info: Completed loading Core Plugins Dec 29 16:58:07 bunibanibox volumio[831]: info: Preparing to generate the ALSA configuration file Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreStateMachine::pushState Dec 29 16:58:07 bunibanibox volumio[831]: info: CorePlayQueue::getTrack 0 Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreCommandRouter::volumioPushState Dec 29 16:58:07 bunibanibox volumio[831]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Dec 29 16:58:07 bunibanibox volumio[831]: info: USB Boot Capable - System SBC Revision found in cpuinfo: a03111 Dec 29 16:58:07 bunibanibox volumio[831]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Dec 29 16:58:07 bunibanibox volumio[831]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Dec 29 16:58:07 bunibanibox volumio[831]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 29 16:58:07 bunibanibox volumio[831]: info: Reading ALSA contributions from plugins. Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreCommandRouter::volumioClearQueue Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreStateMachine::ClearQueue Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreStateMachine::stop Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 29 16:58:07 bunibanibox volumio[831]: info: CorePlayQueue::clearPlayQueue Dec 29 16:58:07 bunibanibox volumio[831]: info: CorePlayQueue::saveQueue Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreCommandRouter::volumioPushState Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreCommandRouter::volumioPushQueue Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreCommandRouter::volumioAddQueueItems Dec 29 16:58:07 bunibanibox volumio[831]: info: CoreStateMachine::addQueueItems Dec 29 16:58:07 bunibanibox volumio[831]: info: CorePlayQueue::addQueueItems Dec 29 16:58:07 bunibanibox volumio[831]: info: Preload queue cleared Dec 29 16:58:07 bunibanibox volumio[831]: info: Adding Item to queue: mnt/INTERNAL/fredrik_vahle/anne_kaffeekanne.mp3 Dec 29 16:58:08 bunibanibox volumio[831]: info: Exploding uri mnt/INTERNAL/fredrik_vahle/anne_kaffeekanne.mp3 in service mpd Dec 29 16:58:08 bunibanibox volumio[831]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 29 16:58:08 bunibanibox volumio[831]: TypeError: Cannot read property 'then' of undefined Dec 29 16:58:08 bunibanibox volumio[831]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2546:19) Dec 29 16:58:08 bunibanibox volumio[831]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2344:21) Dec 29 16:58:08 bunibanibox volumio[831]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1384:16) Dec 29 16:58:08 bunibanibox volumio[831]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Dec 29 16:58:08 bunibanibox volumio[831]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Dec 29 16:58:08 bunibanibox volumio[831]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Dec 29 16:58:08 bunibanibox volumio[831]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:251:25) Dec 29 16:58:08 bunibanibox volumio[831]: at CoreCommandRouter.addQueueItems (/volumio/app/index.js:448:28) Dec 29 16:58:08 bunibanibox volumio[831]: at /volumio/app/playlistManager.js:726:30 Dec 29 16:58:08 bunibanibox volumio[831]: at /volumio/node_modules/jsonfile/index.js:46:5 Dec 29 16:58:08 bunibanibox volumio[831]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 29 16:58:08 bunibanibox sudo[1210]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-29 16:57 Dec 29 16:58:08 bunibanibox sudo[1210]: 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"