Dec 17 12:39:17 volumio ntpd[1159]: CLOCK: time stepped by 1007803.032697 Dec 17 12:39:17 volumio ntpd[1159]: CLOCK: time changed from 2025-12-05 to 2025-12-17 Dec 17 12:39:17 volumio ntpd[1159]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Dec 17 12:39:17 volumio volumio[1400]: info: Discovery: A device disappeared from network Dec 17 12:39:17 volumio volumio[1400]: info: Discovery: Browse raised the following error TypeError: Cannot read properties of undefined (reading 'toLowerCase') Dec 17 12:39:17 volumio sudo[2107]: pam_unix(sudo:session): session closed for user root Dec 17 12:39:17 volumio volumio[1400]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 17 12:39:17 volumio sudo[1917]: pam_unix(sudo:session): session closed for user root Dec 17 12:39:17 volumio sudo[1909]: pam_unix(sudo:session): session closed for user root Dec 17 12:39:17 volumio volumio[1400]: error: Cannot start MPD on system Start: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Dec 17 12:39:17 volumio volumio[1400]: Terminated Dec 17 12:39:17 volumio volumio[1400]: info: Completed starting Core Plugins Dec 17 12:39:17 volumio volumio[1400]: info: ------------------------------------------- Dec 17 12:39:17 volumio volumio[1400]: info: ----- MyVolumio plugins startup ---- Dec 17 12:39:17 volumio volumio[1400]: info: ------------------------------------------- Dec 17 12:39:17 volumio volumio[1400]: info: [MyVolumio PluginManager] Fetching plans data.... Dec 17 12:39:17 volumio wireless.js[2030]: WIRELESS.JS: Stopped aP Dec 17 12:39:17 volumio sudo[2121]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 17 12:39:17 volumio sudo[2121]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 12:39:17 volumio systemd[1]: Starting dpkg-db-backup.service - Daily dpkg database backup service... Dec 17 12:39:17 volumio systemd[1]: Started ntpsec-rotate-stats.service - Rotate ntpd stats. Dec 17 12:39:17 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Dec 17 12:39:17 volumio sudo[2121]: pam_unix(sudo:session): session closed for user root Dec 17 12:39:17 volumio sudo[2124]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Dec 17 12:39:17 volumio sudo[2124]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 12:39:17 volumio sudo[2124]: pam_unix(sudo:session): session closed for user root Dec 17 12:39:17 volumio volumio[1400]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service Dec 17 12:39:17 volumio volumio[1400]: Terminated Dec 17 12:39:17 volumio sudo[2132]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 17 12:39:17 volumio sudo[2132]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 12:39:17 volumio sudo[2132]: pam_unix(sudo:session): session closed for user root Dec 17 12:39:17 volumio systemd[1]: ntpsec-rotate-stats.service: Deactivated successfully. Dec 17 12:39:17 volumio sudo[2138]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Dec 17 12:39:17 volumio sudo[2138]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 12:39:17 volumio systemd[1]: firststart.service: Deactivated successfully. Dec 17 12:39:17 volumio systemd[1]: firststart.service: Consumed 7.108s CPU time. Dec 17 12:39:17 volumio volumio[1400]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Dec 17 12:39:17 volumio systemd[1]: dpkg-db-backup.service: Deactivated successfully. Dec 17 12:39:17 volumio systemd[1]: Finished dpkg-db-backup.service - Daily dpkg database backup service. Dec 17 12:39:18 volumio volumio[1400]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 17 12:39:18 volumio mpd[1957]: 2025-12-17T12:39:18 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 17 12:39:18 volumio mpd[1957]: 2025-12-17T12:39:18 exception: Database corrupted Dec 17 12:39:18 volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 17 12:39:18 volumio volumio[1400]: error: MPD error: The expression evaluated to a falsy value: Dec 17 12:39:18 volumio volumio[1400]: assert.ok(self.idling) Dec 17 12:39:18 volumio volumio[1400]: error: The expression evaluated to a falsy value: Dec 17 12:39:18 volumio volumio[1400]: assert.ok(self.idling) Dec 17 12:39:18 volumio volumio[1400]: verbose: ControllerMpd::sendMpdCommand status Dec 17 12:39:18 volumio volumio[1400]: info: Dec 17 12:39:18 volumio volumio[1400]: ---------------------------- MPD announces state update: update Dec 17 12:39:18 volumio volumio[1400]: info: ControllerMpd::getState Dec 17 12:39:18 volumio volumio[1400]: verbose: ControllerMpd::sendMpdCommand status Dec 17 12:39:18 volumio volumio[1400]: verbose: ControllerMpd::sendMpdCommand status Dec 17 12:39:18 volumio volumio[1400]: info: Dec 17 12:39:18 volumio volumio[1400]: ---------------------------- MPD announces state update: update Dec 17 12:39:18 volumio volumio[1400]: error: updateQueue error: null Dec 17 12:39:18 volumio volumio[1400]: info: ControllerMpd::getState Dec 17 12:39:18 volumio volumio[1400]: verbose: ControllerMpd::sendMpdCommand status Dec 17 12:39:18 volumio volumio[1400]: info: sendMpdCommand status took 11 milliseconds Dec 17 12:39:18 volumio volumio[1400]: verbose: ControllerMpd::parseState Dec 17 12:39:18 volumio volumio[1400]: info: Command Router : Notfying DB Updatefalse Dec 17 12:39:18 volumio volumio[1400]: info: CoreCommandRouter::Close All Modals sent Dec 17 12:39:18 volumio volumio[1400]: info: sendMpdCommand status took 109 milliseconds Dec 17 12:39:18 volumio volumio[1400]: info: sendMpdCommand status took 109 milliseconds Dec 17 12:39:18 volumio volumio[1400]: info: sendMpdCommand status took 108 milliseconds Dec 17 12:39:18 volumio volumio[1400]: verbose: ControllerMpd::parseState Dec 17 12:39:18 volumio volumio[1400]: verbose: ControllerMpd::parseState Dec 17 12:39:18 volumio volumio[1400]: info: Command Router : Notfying DB Updatefalse Dec 17 12:39:18 volumio volumio[1400]: info: CoreCommandRouter::Close All Modals sent Dec 17 12:39:18 volumio volumio[1400]: verbose: ControllerMpd::parseState Dec 17 12:39:18 volumio volumio[1400]: info: ControllerMpd::pushState Dec 17 12:39:18 volumio volumio[1400]: info: CoreCommandRouter::servicePushState Dec 17 12:39:18 volumio volumio[1400]: info: CoreStateMachine::pushState Dec 17 12:39:18 volumio volumio[1400]: info: CorePlayQueue::getTrack 0 Dec 17 12:39:18 volumio volumio[1400]: info: CoreCommandRouter::volumioPushState Dec 17 12:39:18 volumio volumio[1400]: info: CorePlayQueue::getTrack 0 Dec 17 12:39:18 volumio volumio[1400]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 17 12:39:18 volumio volumio[1400]: verbose: CURRENT POSITION 0 Dec 17 12:39:18 volumio volumio[1400]: info: CoreStateMachine::syncState stateService stop Dec 17 12:39:18 volumio volumio[1400]: info: CoreStateMachine::syncState currentStatus stop Dec 17 12:39:18 volumio volumio[1400]: info: CoreStateMachine::pushState Dec 17 12:39:18 volumio volumio[1400]: info: CorePlayQueue::getTrack 0 Dec 17 12:39:18 volumio volumio[1400]: info: CoreCommandRouter::volumioPushState Dec 17 12:39:18 volumio volumio[1400]: info: No code Dec 17 12:39:18 volumio volumio[1400]: info: CoreStateMachine::pushState Dec 17 12:39:18 volumio volumio[1400]: info: CorePlayQueue::getTrack 0 Dec 17 12:39:18 volumio volumio[1400]: info: CoreCommandRouter::volumioPushState Dec 17 12:39:18 volumio volumio[1400]: info: ControllerMpd::pushState Dec 17 12:39:18 volumio volumio[1400]: info: CoreCommandRouter::servicePushState Dec 17 12:39:18 volumio volumio[1400]: info: CoreStateMachine::pushState Dec 17 12:39:18 volumio volumio[1400]: info: CorePlayQueue::getTrack 0 Dec 17 12:39:18 volumio volumio[1400]: info: CoreCommandRouter::volumioPushState Dec 17 12:39:18 volumio volumio[1400]: info: CorePlayQueue::getTrack 0 Dec 17 12:39:18 volumio volumio[1400]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 17 12:39:18 volumio volumio[1400]: verbose: CURRENT POSITION 0 Dec 17 12:39:18 volumio volumio[1400]: info: CoreStateMachine::syncState stateService stop Dec 17 12:39:18 volumio volumio[1400]: info: CoreStateMachine::syncState currentStatus stop Dec 17 12:39:18 volumio volumio[1400]: info: CoreStateMachine::pushState Dec 17 12:39:18 volumio volumio[1400]: info: CorePlayQueue::getTrack 0 Dec 17 12:39:18 volumio volumio[1400]: info: CoreCommandRouter::volumioPushState Dec 17 12:39:18 volumio volumio[1400]: info: No code Dec 17 12:39:18 volumio volumio[1400]: info: CoreStateMachine::pushState Dec 17 12:39:18 volumio volumio[1400]: info: CorePlayQueue::getTrack 0 Dec 17 12:39:18 volumio volumio[1400]: info: CoreCommandRouter::volumioPushState Dec 17 12:39:18 volumio volumio[1400]: info: ------------------------------ 135ms Dec 17 12:39:18 volumio volumio[1400]: info: ------------------------------ 136ms Dec 17 12:39:18 volumio volumio[1400]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Dec 17 12:39:18 volumio volumio[1400]: info: Volumio Network Manager: Network status updated: 1 Dec 17 12:39:18 volumio sudo[2220]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 17 12:39:18 volumio sudo[2222]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 17 12:39:18 volumio sudo[2220]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 12:39:18 volumio sudo[2222]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 12:39:18 volumio sudo[2220]: pam_unix(sudo:session): session closed for user root Dec 17 12:39:18 volumio sudo[2224]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 17 12:39:18 volumio sudo[2224]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 12:39:18 volumio sudo[2222]: pam_unix(sudo:session): session closed for user root Dec 17 12:39:19 volumio ntpd[1159]: IO: Deleting interface #3 wlan0, 192.168.211.1#123, interface stats: received=0, sent=4, dropped=0, active_time=12 secs Dec 17 12:39:20 volumio sudo[2138]: pam_unix(sudo:session): session closed for user root Dec 17 12:39:20 volumio wireless.js[2030]: WIRELESS.JS: SETTING APPROPRIATE REG DOMAIN: FR Dec 17 12:39:20 volumio sudo[2230]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 17 12:39:20 volumio sudo[2230]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 12:39:20 volumio sudo[2230]: pam_unix(sudo:session): session closed for user root Dec 17 12:39:20 volumio sudo[2232]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set FR Dec 17 12:39:20 volumio sudo[2232]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 12:39:20 volumio sudo[2232]: pam_unix(sudo:session): session closed for user root Dec 17 12:39:20 volumio wireless.js[2030]: WIRELESS.JS: SUCCESSFULLY SET NEW REGDOMAIN: FR Dec 17 12:39:20 volumio wireless.js[2030]: WIRELESS.JS: Single Network Mode: Wired network active, not starting wireless flow Dec 17 12:39:20 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Dec 17 12:39:20 volumio wireless.js[2030]: WIRELESS.JS: Notified systemd about wireless ready Dec 17 12:39:20 volumio systemd[1]: Started wireless.service - Wireless Services. Dec 17 12:39:20 volumio sudo[2019]: pam_unix(sudo:session): session closed for user root Dec 17 12:39:20 volumio volumio[1400]: info: Discovery: Started advertising with name: Volumio Dec 17 12:39:20 volumio sudo[2242]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 17 12:39:20 volumio sudo[2242]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 12:39:20 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 17 12:39:20 volumio mpd_monitor.sh[2244]: MPD Monitor Service: Starting MPD Monitor Service Dec 17 12:39:20 volumio sudo[2242]: pam_unix(sudo:session): session closed for user root Dec 17 12:39:20 volumio volumio[1400]: info: Successfully started MPD Monitor Dec 17 12:39:20 volumio sudo[2249]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 17 12:39:20 volumio sudo[2249]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 17 12:39:20 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 17 12:39:20 volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 17 12:39:20 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 17 12:39:20 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 17 12:39:20 volumio sudo[2249]: pam_unix(sudo:session): session closed for user root Dec 17 12:39:20 volumio mpd_monitor.sh[2251]: MPD Monitor Service: Starting MPD Monitor Service Dec 17 12:39:20 volumio volumio[1400]: info: Successfully started MPD Monitor Dec 17 12:39:20 volumio nmbd[1251]: [2025/12/17 12:39:20.674192, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Dec 17 12:39:20 volumio nmbd[1251]: Packet send failed to 192.168.211.255(138) ERRNO=Network is unreachable Dec 17 12:39:20 volumio nmbd[1251]: [2025/12/17 12:39:20.674330, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Dec 17 12:39:20 volumio nmbd[1251]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Dec 17 12:39:20 volumio nmbd[1251]: [2025/12/17 12:39:20.674351, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Dec 17 12:39:20 volumio nmbd[1251]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Dec 17 12:39:20 volumio nmbd[1251]: [2025/12/17 12:39:20.674372, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Dec 17 12:39:20 volumio nmbd[1251]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Dec 17 12:39:20 volumio nmbd[1251]: [2025/12/17 12:39:20.674386, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Dec 17 12:39:20 volumio nmbd[1251]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Dec 17 12:39:20 volumio nmbd[1251]: [2025/12/17 12:39:20.674402, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Dec 17 12:39:20 volumio nmbd[1251]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Dec 17 12:39:20 volumio nmbd[1251]: [2025/12/17 12:39:20.674415, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Dec 17 12:39:20 volumio nmbd[1251]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Dec 17 12:39:20 volumio nmbd[1251]: [2025/12/17 12:39:20.674428, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Dec 17 12:39:20 volumio nmbd[1251]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Dec 17 12:39:20 volumio nmbd[1251]: [2025/12/17 12:39:20.674441, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Dec 17 12:39:20 volumio nmbd[1251]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Dec 17 12:39:20 volumio nmbd[1251]: [2025/12/17 12:39:20.674456, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Dec 17 12:39:20 volumio nmbd[1251]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Dec 17 12:39:20 volumio nmbd[1251]: [2025/12/17 12:39:20.674469, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Dec 17 12:39:20 volumio nmbd[1251]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Dec 17 12:39:20 volumio volumio[1400]: compat.c: read() failed: Resource temporarily unavailable Dec 17 12:39:20 volumio volumio[1400]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 17 12:39:20 volumio volumio[1400]: Error: dns service error: unknown Dec 17 12:39:20 volumio volumio[1400]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Dec 17 12:39:20 volumio volumio[1400]: errorCode: -65537 Dec 17 12:39:20 volumio volumio[1400]: } Dec 17 12:39:20 volumio volumio[1400]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 17 12:39:21 volumio sudo[2271]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-17 12:38' Dec 17 12:39:21 volumio sudo[2271]: 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"