Dec 26 19:03:18 volumio ntpd[1216]: CLOCK: time stepped by 1808442.438766 Dec 26 19:03:18 volumio ntpd[1216]: CLOCK: time changed from 2025-12-05 to 2025-12-26 Dec 26 19:03:18 volumio ntpd[1216]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Dec 26 19:03:18 volumio systemd[1]: Starting dpkg-db-backup.service - Daily dpkg database backup service... Dec 26 19:03:18 volumio systemd[1]: Started ntpsec-rotate-stats.service - Rotate ntpd stats. Dec 26 19:03:18 volumio systemd[1]: ntpsec-rotate-stats.service: Deactivated successfully. Dec 26 19:03:18 volumio firststart.sh[2123]: rescue-ssh.target is a disabled or a static unit not running, not starting it. Dec 26 19:03:18 volumio firststart.sh[2123]: ssh.service is a disabled or a static unit not running, not starting it. Dec 26 19:03:19 volumio volumio[1415]: info: Command Router : Notfying DB Updatefalse Dec 26 19:03:19 volumio volumio[1415]: info: CoreCommandRouter::Close All Modals sent Dec 26 19:03:19 volumio volumio[1415]: info: sendMpdCommand status took 1808443632 milliseconds Dec 26 19:03:19 volumio volumio[1415]: info: sendMpdCommand status took 1808443632 milliseconds Dec 26 19:03:19 volumio volumio[1415]: info: sendMpdCommand status took 1808443632 milliseconds Dec 26 19:03:19 volumio volumio[1415]: verbose: ControllerMpd::parseState Dec 26 19:03:19 volumio volumio[1415]: verbose: ControllerMpd::parseState Dec 26 19:03:19 volumio systemd[1]: Reloading. Dec 26 19:03:19 volumio volumio[1415]: info: Command Router : Notfying DB Updatefalse Dec 26 19:03:19 volumio volumio[1415]: info: CoreCommandRouter::Close All Modals sent Dec 26 19:03:19 volumio volumio[1415]: verbose: ControllerMpd::parseState Dec 26 19:03:19 volumio volumio[1415]: info: ControllerMpd::pushState Dec 26 19:03:19 volumio volumio[1415]: info: CoreCommandRouter::servicePushState Dec 26 19:03:19 volumio volumio[1415]: info: CoreStateMachine::pushState Dec 26 19:03:19 volumio volumio[1415]: info: CorePlayQueue::getTrack 0 Dec 26 19:03:19 volumio volumio[1415]: info: CoreCommandRouter::volumioPushState Dec 26 19:03:19 volumio volumio[1415]: info: CorePlayQueue::getTrack 0 Dec 26 19:03:19 volumio volumio[1415]: 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 26 19:03:19 volumio volumio[1415]: verbose: CURRENT POSITION 0 Dec 26 19:03:19 volumio volumio[1415]: info: CoreStateMachine::syncState stateService stop Dec 26 19:03:19 volumio volumio[1415]: info: CoreStateMachine::syncState currentStatus stop Dec 26 19:03:19 volumio volumio[1415]: info: CoreStateMachine::pushState Dec 26 19:03:19 volumio volumio[1415]: info: CorePlayQueue::getTrack 0 Dec 26 19:03:19 volumio volumio[1415]: info: CoreCommandRouter::volumioPushState Dec 26 19:03:19 volumio volumio[1415]: info: No code Dec 26 19:03:19 volumio volumio[1415]: info: CoreStateMachine::pushState Dec 26 19:03:19 volumio volumio[1415]: info: CorePlayQueue::getTrack 0 Dec 26 19:03:19 volumio volumio[1415]: info: CoreCommandRouter::volumioPushState Dec 26 19:03:19 volumio volumio[1415]: info: ControllerMpd::pushState Dec 26 19:03:19 volumio volumio[1415]: info: CoreCommandRouter::servicePushState Dec 26 19:03:19 volumio volumio[1415]: info: CoreStateMachine::pushState Dec 26 19:03:19 volumio volumio[1415]: info: CorePlayQueue::getTrack 0 Dec 26 19:03:19 volumio volumio[1415]: info: CoreCommandRouter::volumioPushState Dec 26 19:03:19 volumio volumio[1415]: info: CorePlayQueue::getTrack 0 Dec 26 19:03:19 volumio volumio[1415]: 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 26 19:03:19 volumio volumio[1415]: verbose: CURRENT POSITION 0 Dec 26 19:03:19 volumio volumio[1415]: info: CoreStateMachine::syncState stateService stop Dec 26 19:03:19 volumio volumio[1415]: info: CoreStateMachine::syncState currentStatus stop Dec 26 19:03:19 volumio volumio[1415]: info: CoreStateMachine::pushState Dec 26 19:03:19 volumio volumio[1415]: info: CorePlayQueue::getTrack 0 Dec 26 19:03:19 volumio volumio[1415]: info: CoreCommandRouter::volumioPushState Dec 26 19:03:19 volumio volumio[1415]: info: No code Dec 26 19:03:19 volumio volumio[1415]: info: CoreStateMachine::pushState Dec 26 19:03:19 volumio volumio[1415]: info: CorePlayQueue::getTrack 0 Dec 26 19:03:19 volumio volumio[1415]: info: CoreCommandRouter::volumioPushState Dec 26 19:03:19 volumio volumio[1415]: info: ------------------------------ 1808443749ms Dec 26 19:03:19 volumio volumio[1415]: info: ------------------------------ 1808443751ms Dec 26 19:03:19 volumio sudo[2231]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 26 19:03:19 volumio sudo[2231]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 19:03:19 volumio sudo[2233]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 26 19:03:19 volumio sudo[2233]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 19:03:19 volumio sudo[2231]: pam_unix(sudo:session): session closed for user root Dec 26 19:03:19 volumio sudo[2233]: pam_unix(sudo:session): session closed for user root Dec 26 19:03:19 volumio sudo[2237]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 26 19:03:19 volumio sudo[2237]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 19:03:19 volumio systemd[1]: dpkg-db-backup.service: Deactivated successfully. Dec 26 19:03:19 volumio systemd[1]: Finished dpkg-db-backup.service - Daily dpkg database backup service. Dec 26 19:03:19 volumio firststart.sh[2239]: ssh.socket is a disabled or a static unit not running, not starting it. Dec 26 19:03:19 volumio sudo[2050]: pam_unix(sudo:session): session closed for user root Dec 26 19:03:19 volumio wireless.js[1955]: WIRELESS.JS: SETTING APPROPRIATE REG DOMAIN: DE Dec 26 19:03:19 volumio sudo[2247]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Dec 26 19:03:19 volumio sudo[2247]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 19:03:19 volumio sudo[2247]: pam_unix(sudo:session): session closed for user root Dec 26 19:03:19 volumio sudo[2249]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set DE Dec 26 19:03:19 volumio sudo[2249]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 19:03:19 volumio sudo[2249]: pam_unix(sudo:session): session closed for user root Dec 26 19:03:19 volumio wireless.js[1955]: WIRELESS.JS: SUCCESSFULLY SET NEW REGDOMAIN: DE Dec 26 19:03:19 volumio wireless.js[1955]: WIRELESS.JS: Single Network Mode: Wired network active, not starting wireless flow Dec 26 19:03:19 volumio nmbd[1273]: [2025/12/26 19:03:19.588906, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Dec 26 19:03:19 volumio nmbd[1273]: Packet send failed to 192.168.211.255(138) ERRNO=Network is unreachable Dec 26 19:03:19 volumio nmbd[1273]: [2025/12/26 19:03:19.589037, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Dec 26 19:03:19 volumio nmbd[1273]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Dec 26 19:03:19 volumio nmbd[1273]: [2025/12/26 19:03:19.589054, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Dec 26 19:03:19 volumio nmbd[1273]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Dec 26 19:03:19 volumio nmbd[1273]: [2025/12/26 19:03:19.589079, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Dec 26 19:03:19 volumio nmbd[1273]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Dec 26 19:03:19 volumio nmbd[1273]: [2025/12/26 19:03:19.589093, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Dec 26 19:03:19 volumio nmbd[1273]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Dec 26 19:03:19 volumio nmbd[1273]: [2025/12/26 19:03:19.589106, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Dec 26 19:03:19 volumio nmbd[1273]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Dec 26 19:03:19 volumio nmbd[1273]: [2025/12/26 19:03:19.589119, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Dec 26 19:03:19 volumio nmbd[1273]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Dec 26 19:03:19 volumio nmbd[1273]: [2025/12/26 19:03:19.589133, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Dec 26 19:03:19 volumio nmbd[1273]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Dec 26 19:03:19 volumio nmbd[1273]: [2025/12/26 19:03:19.589146, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Dec 26 19:03:19 volumio nmbd[1273]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Dec 26 19:03:19 volumio nmbd[1273]: [2025/12/26 19:03:19.589160, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Dec 26 19:03:19 volumio nmbd[1273]: Packet send failed to 127.0.0.1(137) ERRNO=Network is unreachable Dec 26 19:03:19 volumio nmbd[1273]: [2025/12/26 19:03:19.589173, 0] ../../source3/nmbd/nmbd_packets.c:180(send_netbios_packet) Dec 26 19:03:19 volumio nmbd[1273]: send_netbios_packet: send_packet() to IP 127.0.0.1 port 137 failed Dec 26 19:03:19 volumio wireless.js[1955]: WIRELESS.JS: Notified systemd about wireless ready Dec 26 19:03:19 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Dec 26 19:03:19 volumio systemd[1]: Started wireless.service - Wireless Services. Dec 26 19:03:19 volumio sudo[1950]: pam_unix(sudo:session): session closed for user root Dec 26 19:03:19 volumio firststart.sh[1418]: Enabling SSH for first boot Dec 26 19:03:19 volumio systemd[1]: Starting ssh.service - OpenBSD Secure Shell server... Dec 26 19:03:19 volumio sshd[2262]: Server listening on 0.0.0.0 port 22. Dec 26 19:03:19 volumio sshd[2262]: Server listening on :: port 22. Dec 26 19:03:19 volumio systemd[1]: Started ssh.service - OpenBSD Secure Shell server. Dec 26 19:03:19 volumio firststart.sh[1418]: Disabling firststart service Dec 26 19:03:19 volumio sudo[2265]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 26 19:03:19 volumio sudo[2265]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 19:03:19 volumio sudo[2267]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 26 19:03:19 volumio sudo[2267]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 19:03:20 volumio systemctl[2263]: Removed "/etc/systemd/system/multi-user.target.wants/firststart.service". Dec 26 19:03:20 volumio systemd[1]: Reloading. Dec 26 19:03:20 volumio firststart.sh[1418]: Finalizing Dec 26 19:03:20 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 26 19:03:20 volumio sudo[2267]: pam_unix(sudo:session): session closed for user root Dec 26 19:03:20 volumio sudo[2265]: pam_unix(sudo:session): session closed for user root Dec 26 19:03:20 volumio volumio[1415]: info: Successfully started MPD Monitor Dec 26 19:03:20 volumio mpd_monitor.sh[2288]: MPD Monitor Service: Starting MPD Monitor Service Dec 26 19:03:20 volumio volumio[1415]: info: Successfully started MPD Monitor Dec 26 19:03:20 volumio volumio[1415]: info: Discovery: Started advertising with name: Volumio Dec 26 19:03:20 volumio systemd[1]: firststart.service: Deactivated successfully. Dec 26 19:03:20 volumio systemd[1]: firststart.service: Consumed 9.899s CPU time. Dec 26 19:03:21 volumio volumio[1415]: compat.c: read() failed: Resource temporarily unavailable Dec 26 19:03:21 volumio volumio[1415]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 26 19:03:21 volumio volumio[1415]: Error: dns service error: unknown Dec 26 19:03:21 volumio volumio[1415]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Dec 26 19:03:21 volumio volumio[1415]: errorCode: -65537 Dec 26 19:03:21 volumio volumio[1415]: } Dec 26 19:03:21 volumio volumio[1415]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 26 19:03:21 volumio sudo[2308]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-26 19:02' Dec 26 19:03:21 volumio sudo[2308]: 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"