Jan 25 12:02:04 volumio volumio[1117]: verbose: New Socket.io Connection to 10.5.112.248:3000 from 10.5.253.70 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6
Jan 25 12:02:04 volumio volumio[1117]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 25 12:02:04 volumio volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 25 12:02:04 volumio volumio[1117]: info: Discovery: Getting this device information
Jan 25 12:02:04 volumio volumio[1117]: info: CoreCommandRouter::volumioGetState
Jan 25 12:02:04 volumio volumio[1117]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 25 12:02:54 volumio volumio[1117]: info:
Jan 25 12:02:54 volumio volumio[1117]: ---------------------------- MPD announces system playlist update
Jan 25 12:02:54 volumio volumio[1117]: info: Ignoring MPD Status Update
Jan 25 12:02:54 volumio volumio[1117]: info:
Jan 25 12:02:54 volumio volumio[1117]: ---------------------------- MPD announces state update: player
Jan 25 12:02:54 volumio volumio[1117]: info: ControllerMpd::getState
Jan 25 12:02:54 volumio volumio[1117]: verbose: ControllerMpd::sendMpdCommand status
Jan 25 12:02:54 volumio volumio[1117]: info:
Jan 25 12:02:54 volumio volumio[1117]: ---------------------------- MPD announces system playlist update
Jan 25 12:02:54 volumio volumio[1117]: info: Ignoring MPD Status Update
Jan 25 12:02:54 volumio volumio[1117]: info:
Jan 25 12:02:54 volumio volumio[1117]: ---------------------------- MPD announces state update: player
Jan 25 12:02:54 volumio volumio[1117]: info: ControllerMpd::getState
Jan 25 12:02:54 volumio volumio[1117]: verbose: ControllerMpd::sendMpdCommand status
Jan 25 12:02:54 volumio volumio[1117]: info:
Jan 25 12:02:54 volumio volumio[1117]: ---------------------------- MPD announces system playlist update
Jan 25 12:02:54 volumio volumio[1117]: info: Ignoring MPD Status Update
Jan 25 12:02:54 volumio volumio[1117]: info:
Jan 25 12:02:54 volumio volumio[1117]: ---------------------------- MPD announces state update: player
Jan 25 12:02:54 volumio volumio[1117]: info: ControllerMpd::getState
Jan 25 12:02:54 volumio volumio[1117]: verbose: ControllerMpd::sendMpdCommand status
Jan 25 12:02:54 volumio volumio[1117]: info: ------------------------------ 13ms
Jan 25 12:02:54 volumio volumio[1117]: info: sendMpdCommand status took 10 milliseconds
Jan 25 12:02:54 volumio volumio[1117]: info: ------------------------------ 9ms
Jan 25 12:02:54 volumio volumio[1117]: info: sendMpdCommand status took 6 milliseconds
Jan 25 12:02:54 volumio volumio[1117]: verbose: ControllerMpd::parseState
Jan 25 12:02:54 volumio volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 25 12:02:54 volumio volumio[1117]: verbose: ControllerMpd::parseState
Jan 25 12:02:54 volumio volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 25 12:02:54 volumio volumio[1117]: info: ------------------------------ 10ms
Jan 25 12:02:54 volumio volumio[1117]: info: sendMpdCommand status took 8 milliseconds
Jan 25 12:02:54 volumio volumio[1117]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jan 25 12:02:54 volumio volumio[1117]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jan 25 12:02:54 volumio volumio[1117]: verbose: ControllerMpd::parseState
Jan 25 12:02:54 volumio volumio[1117]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 25 12:02:54 volumio volumio[1117]: verbose: ControllerMpd::parseTrackInfo
Jan 25 12:02:54 volumio volumio[1117]: verbose: ControllerMpd::parseTrackInfo
Jan 25 12:02:54 volumio volumio[1117]: info: ControllerMpd::pushState
Jan 25 12:02:54 volumio volumio[1117]: info: CoreCommandRouter::servicePushState
Jan 25 12:02:54 volumio volumio[1117]: info: CorePlayQueue::getTrack 0
Jan 25 12:02:54 volumio volumio[1117]: verbose: STATE SERVICE {"status":"play","position":0,"seek":513878,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"127 Kbps","isStreaming":false,"title":"Elton John - Your Song","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""}
Jan 25 12:02:54 volumio volumio[1117]: verbose: CURRENT POSITION 0
Jan 25 12:02:54 volumio volumio[1117]: info: CoreStateMachine::syncState stateService play
Jan 25 12:02:54 volumio volumio[1117]: info: CoreStateMachine::syncState currentStatus play
Jan 25 12:02:54 volumio volumio[1117]: info: Received an update from plugin. extracting info from payload
Jan 25 12:02:54 volumio volumio[1117]: info: CoreStateMachine::pushState
Jan 25 12:02:54 volumio volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 25 12:02:54 volumio volumio[1117]: info: CoreCommandRouter::volumioPushState
Jan 25 12:02:54 volumio volumio[1117]: info: CoreStateMachine::pushState
Jan 25 12:02:54 volumio volumio[1117]: info: CoreCommandRouter::volumioPushState
Jan 25 12:02:54 volumio volumio[1117]: info: ControllerMpd::pushState
Jan 25 12:02:54 volumio volumio[1117]: info: CoreCommandRouter::servicePushState
Jan 25 12:02:54 volumio volumio[1117]: info: CorePlayQueue::getTrack 0
Jan 25 12:02:54 volumio volumio[1117]: verbose: STATE SERVICE {"status":"play","position":0,"seek":513878,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"127 Kbps","isStreaming":false,"title":"Elton John - Your Song","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""}
Jan 25 12:02:54 volumio volumio[1117]: verbose: CURRENT POSITION 0
Jan 25 12:02:54 volumio volumio[1117]: info: CoreStateMachine::syncState stateService play
Jan 25 12:02:54 volumio volumio[1117]: info: CoreStateMachine::syncState currentStatus play
Jan 25 12:02:54 volumio volumio[1117]: info: Received an update from plugin. extracting info from payload
Jan 25 12:02:54 volumio volumio[1117]: info: CoreStateMachine::pushState
Jan 25 12:02:54 volumio volumio[1117]: info: CoreCommandRouter::volumioPushState
Jan 25 12:02:54 volumio volumio[1117]: info: CoreStateMachine::pushState
Jan 25 12:02:54 volumio volumio[1117]: info: CoreCommandRouter::volumioPushState
Jan 25 12:02:54 volumio volumio[1117]: info: ------------------------------ 71ms
Jan 25 12:02:54 volumio volumio[1117]: info: ------------------------------ 66ms
Jan 25 12:02:54 volumio volumio[1117]: info: sendMpdCommand playlistinfo took 53 milliseconds
Jan 25 12:02:54 volumio volumio[1117]: verbose: ControllerMpd::parseTrackInfo
Jan 25 12:02:54 volumio volumio[1117]: info: ControllerMpd::pushState
Jan 25 12:02:54 volumio volumio[1117]: info: CoreCommandRouter::servicePushState
Jan 25 12:02:54 volumio volumio[1117]: info: CorePlayQueue::getTrack 0
Jan 25 12:02:54 volumio volumio[1117]: verbose: STATE SERVICE {"status":"play","position":0,"seek":513878,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"127 Kbps","isStreaming":false,"title":"Elton John - Your Song","artist":"Radio 357","album":null,"uri":"http://stream.rcs.revma.com/ye5kghkgcm0uv","trackType":""}
Jan 25 12:02:54 volumio volumio[1117]: verbose: CURRENT POSITION 0
Jan 25 12:02:54 volumio volumio[1117]: info: CoreStateMachine::syncState stateService play
Jan 25 12:02:54 volumio volumio[1117]: info: CoreStateMachine::syncState currentStatus play
Jan 25 12:02:54 volumio volumio[1117]: info: Received an update from plugin. extracting info from payload
Jan 25 12:02:54 volumio volumio[1117]: info: CoreStateMachine::pushState
Jan 25 12:02:54 volumio volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 25 12:02:54 volumio volumio[1117]: info: CoreCommandRouter::volumioPushState
Jan 25 12:02:54 volumio volumio[1117]: info: CoreStateMachine::pushState
Jan 25 12:02:54 volumio volumio[1117]: info: CoreCommandRouter::volumioPushState
Jan 25 12:02:54 volumio volumio[1117]: info: ------------------------------ 91ms
Jan 25 12:03:10 volumio volumio[1117]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings
Jan 25 12:03:10 volumio volumio[1117]: info: Saving new wireless network
Jan 25 12:03:10 volumio sudo[4364]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf
Jan 25 12:03:10 volumio sudo[4364]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 25 12:03:10 volumio sudo[4364]: pam_unix(sudo:session): session closed for user root
Jan 25 12:03:10 volumio volumio[1117]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart
Jan 25 12:03:10 volumio volumio[1117]: info: Discovery: Restarting Advertising due to device name change
Jan 25 12:03:10 volumio sudo[4367]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service
Jan 25 12:03:10 volumio sudo[4367]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 25 12:03:10 volumio systemd[1]: Stopping wireless.service - Wireless Services...
Jan 25 12:03:10 volumio systemd[1]: wireless.service: Deactivated successfully.
Jan 25 12:03:10 volumio systemd[1]: Stopped wireless.service - Wireless Services.
Jan 25 12:03:10 volumio systemd[1]: wireless.service: Consumed 8min 25.861s CPU time.
Jan 25 12:03:10 volumio systemd[1]: Starting wireless.service - Wireless Services...
Jan 25 12:03:11 volumio wireless.js[4373]: WIRELESS.JS: Single Network Mode enabled, only one network device can be active at a time between ethernet and wireless
Jan 25 12:03:11 volumio wireless.js[4373]: WIRELESS.JS: Wired network status changed to: ---connected---
Jan 25 12:03:11 volumio wireless.js[4373]: WIRELESS.JS: Wireless.js initializing wireless flow
Jan 25 12:03:11 volumio wireless.js[4373]: WIRELESS.JS: Cleaning previous...
Jan 25 12:03:11 volumio sudo[4393]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0
Jan 25 12:03:11 volumio sudo[4393]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Jan 25 12:03:11 volumio sudo[4393]: pam_unix(sudo:session): session closed for user root
Jan 25 12:03:11 volumio sudo[4395]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down
Jan 25 12:03:11 volumio sudo[4395]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Jan 25 12:03:11 volumio volumio[1117]: info: Discovery: A device disappeared from network
Jan 25 12:03:11 volumio volumio[1117]: info: Discovery: Device volumio disappeared from network
Jan 25 12:03:11 volumio volumio[1117]: info: Discovery: A device disappeared from network
Jan 25 12:03:11 volumio sudo[4395]: pam_unix(sudo:session): session closed for user root
Jan 25 12:03:11 volumio sudo[4398]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 25 12:03:11 volumio sudo[4398]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 25 12:03:11 volumio sudo[4398]: pam_unix(sudo:session): session closed for user root
Jan 25 12:03:11 volumio wireless.js[4373]: WIRELESS.JS: Stopped aP
Jan 25 12:03:11 volumio sudo[4406]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Jan 25 12:03:11 volumio sudo[4406]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 25 12:03:11 volumio sudo[4406]: pam_unix(sudo:session): session closed for user root
Jan 25 12:03:11 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Jan 25 12:03:11 volumio sudo[4409]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get
Jan 25 12:03:11 volumio sudo[4409]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 25 12:03:11 volumio sudo[4409]: pam_unix(sudo:session): session closed for user root
Jan 25 12:03:11 volumio sudo[4417]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Jan 25 12:03:11 volumio sudo[4417]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 25 12:03:11 volumio sudo[4417]: pam_unix(sudo:session): session closed for user root
Jan 25 12:03:11 volumio sudo[4419]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan
Jan 25 12:03:11 volumio sudo[4419]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 25 12:03:12 volumio sudo[4428]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 25 12:03:12 volumio sudo[4428]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 25 12:03:12 volumio sudo[4428]: pam_unix(sudo:session): session closed for user root
Jan 25 12:03:13 volumio sudo[4434]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 25 12:03:13 volumio sudo[4434]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 25 12:03:13 volumio sudo[4434]: pam_unix(sudo:session): session closed for user root
Jan 25 12:03:14 volumio sudo[4439]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 25 12:03:14 volumio sudo[4439]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 25 12:03:14 volumio sudo[4439]: pam_unix(sudo:session): session closed for user root
Jan 25 12:03:14 volumio sudo[4419]: pam_unix(sudo:session): session closed for user root
Jan 25 12:03:14 volumio wireless.js[4373]: WIRELESS.JS: SETTING APPROPRIATE REG DOMAIN: PL
Jan 25 12:03:14 volumio sudo[4443]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Jan 25 12:03:14 volumio sudo[4443]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 25 12:03:14 volumio sudo[4443]: pam_unix(sudo:session): session closed for user root
Jan 25 12:03:14 volumio sudo[4445]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set PL
Jan 25 12:03:14 volumio sudo[4445]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 25 12:03:14 volumio sudo[4445]: pam_unix(sudo:session): session closed for user root
Jan 25 12:03:14 volumio wireless.js[4373]: WIRELESS.JS: SUCCESSFULLY SET NEW REGDOMAIN: PL
Jan 25 12:03:14 volumio wireless.js[4373]: WIRELESS.JS: Single Network Mode: Wired network active, not starting wireless flow
Jan 25 12:03:14 volumio wireless.js[4373]: WIRELESS.JS: Notified systemd about wireless ready
Jan 25 12:03:14 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Jan 25 12:03:14 volumio systemd[1]: Started wireless.service - Wireless Services.
Jan 25 12:03:14 volumio sudo[4367]: pam_unix(sudo:session): session closed for user root
Jan 25 12:03:15 volumio volumio[1117]: info: Discovery: Started advertising with name: Volumio
Jan 25 12:03:15 volumio sudo[4456]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jan 25 12:03:15 volumio sudo[4456]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Jan 25 12:03:15 volumio sudo[4456]: pam_unix(sudo:session): session closed for user root
Jan 25 12:03:16 volumio volumio[1117]: compat.c: read() failed: Resource temporarily unavailable
Jan 25 12:03:16 volumio volumio[1117]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 25 12:03:16 volumio volumio[1117]: Error: dns service error: unknown
Jan 25 12:03:16 volumio volumio[1117]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) {
Jan 25 12:03:16 volumio volumio[1117]: errorCode: -65537
Jan 25 12:03:16 volumio volumio[1117]: }
Jan 25 12:03:16 volumio volumio[1117]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 25 12:03:16 volumio sudo[4476]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-25 12:02'
Jan 25 12:03:16 volumio sudo[4476]: 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"