Jan 27 21:36:07 volumio ntpd[1312]: PROTO: 204.2.134.173 unlink local addr 192.168.68.55 -> Jan 27 21:36:15 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: network , saveWirelessNetworkSettings Jan 27 21:36:15 volumio volumio[1464]: info: Saving new wireless network Jan 27 21:36:15 volumio sudo[4591]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/wpa_supplicant/wpa_supplicant.conf Jan 27 21:36:15 volumio sudo[4591]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:15 volumio sudo[4591]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:15 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Jan 27 21:36:15 volumio volumio[1464]: info: Discovery: Restarting Advertising due to device name change Jan 27 21:36:15 volumio sudo[4594]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service Jan 27 21:36:15 volumio sudo[4594]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:15 volumio systemd[1]: Stopping wireless.service - Wireless Services... Jan 27 21:36:15 volumio systemd[1]: wireless.service: Deactivated successfully. Jan 27 21:36:15 volumio systemd[1]: Stopped wireless.service - Wireless Services. Jan 27 21:36:15 volumio systemd[1]: Starting wireless.service - Wireless Services... Jan 27 21:36:15 volumio wireless.js[4600]: WIRELESS.JS: Single Network Mode enabled, only one network device can be active at a time between ethernet and wireless Jan 27 21:36:15 volumio wireless.js[4600]: WIRELESS.JS: Wired network status changed to: ---connected--- Jan 27 21:36:15 volumio wireless.js[4600]: WIRELESS.JS: Wireless.js initializing wireless flow Jan 27 21:36:15 volumio wireless.js[4600]: WIRELESS.JS: Cleaning previous... Jan 27 21:36:15 volumio sudo[4620]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Jan 27 21:36:15 volumio sudo[4620]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 27 21:36:15 volumio sudo[4620]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:15 volumio sudo[4622]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Jan 27 21:36:15 volumio sudo[4622]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 27 21:36:15 volumio sudo[4622]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:15 volumio wireless.js[4600]: WIRELESS.JS: Stopped aP Jan 27 21:36:15 volumio sudo[4630]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jan 27 21:36:15 volumio sudo[4630]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:16 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jan 27 21:36:16 volumio sudo[4630]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:16 volumio sudo[4633]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Jan 27 21:36:16 volumio sudo[4633]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:16 volumio sudo[4633]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:16 volumio sudo[4641]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jan 27 21:36:16 volumio sudo[4641]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:16 volumio sudo[4641]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:16 volumio sudo[4643]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Jan 27 21:36:16 volumio sudo[4643]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:16 volumio volumio[1464]: info: Discovery: A device disappeared from network Jan 27 21:36:16 volumio volumio[1464]: info: Discovery: Device volumio disappeared from network Jan 27 21:36:16 volumio sudo[4650]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:16 volumio sudo[4650]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:16 volumio volumio[1464]: info: Discovery: A device disappeared from network Jan 27 21:36:16 volumio sudo[4650]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:17 volumio sudo[4655]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:17 volumio sudo[4655]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:17 volumio sudo[4655]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:18 volumio sudo[4660]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:18 volumio sudo[4660]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:18 volumio sudo[4660]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:18 volumio sudo[4643]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:18 volumio wireless.js[4600]: WIRELESS.JS: SETTING APPROPRIATE REG DOMAIN: US Jan 27 21:36:18 volumio sudo[4664]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jan 27 21:36:18 volumio sudo[4664]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:18 volumio sudo[4664]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:18 volumio sudo[4666]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set US Jan 27 21:36:18 volumio sudo[4666]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:18 volumio sudo[4666]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:18 volumio wireless.js[4600]: WIRELESS.JS: SUCCESSFULLY SET NEW REGDOMAIN: US Jan 27 21:36:18 volumio wireless.js[4600]: WIRELESS.JS: Single Network Mode: Wired network active, not starting wireless flow Jan 27 21:36:18 volumio wireless.js[4600]: WIRELESS.JS: Notified systemd about wireless ready Jan 27 21:36:18 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jan 27 21:36:18 volumio systemd[1]: Started wireless.service - Wireless Services. Jan 27 21:36:18 volumio sudo[4594]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:19 volumio sudo[4679]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:19 volumio sudo[4679]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:19 volumio sudo[4679]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:20 volumio volumio[1464]: info: Discovery: Started advertising with name: Volumio Jan 27 21:36:20 volumio sudo[4685]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:20 volumio sudo[4685]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:20 volumio sudo[4685]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:21 volumio volumio[1464]: info: Discovery: adding f0c727d6-ae68-4bd6-9818-59cc77d3c309 Jan 27 21:36:21 volumio volumio[1464]: info: Discovery: Found device Volumio Jan 27 21:36:21 volumio volumio[1464]: info: CoreCommandRouter::volumioGetState Jan 27 21:36:21 volumio volumio[1464]: info: Discovery: this is already registered, f0c727d6-ae68-4bd6-9818-59cc77d3c309 Jan 27 21:36:21 volumio volumio[1464]: info: Discovery: Found device Volumio Jan 27 21:36:21 volumio volumio[1464]: info: CoreCommandRouter::volumioGetState Jan 27 21:36:21 volumio sudo[4692]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:21 volumio sudo[4692]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:21 volumio sudo[4692]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:22 volumio sudo[4697]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:22 volumio sudo[4697]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:22 volumio sudo[4697]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:23 volumio sudo[4702]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:23 volumio sudo[4702]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:23 volumio sudo[4702]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:23 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection Jan 27 21:36:23 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo Jan 27 21:36:23 volumio sudo[4719]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:23 volumio sudo[4719]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:23 volumio sudo[4719]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:23 volumio go-librespot[1891]: time="2026-01-27T21:36:23-06:00" level=trace msg="sent dealer ping" Jan 27 21:36:24 volumio go-librespot[1891]: time="2026-01-27T21:36:24-06:00" level=trace msg="received dealer pong" Jan 27 21:36:24 volumio sudo[4724]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:24 volumio sudo[4724]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:24 volumio sudo[4724]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:25 volumio sudo[4729]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:25 volumio sudo[4729]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:25 volumio sudo[4729]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:26 volumio sudo[4734]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:26 volumio sudo[4734]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:26 volumio sudo[4734]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:27 volumio sudo[4739]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:27 volumio sudo[4739]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:27 volumio sudo[4739]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:28 volumio sudo[4744]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:28 volumio sudo[4744]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:28 volumio sudo[4744]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:28 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Jan 27 21:36:28 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Jan 27 21:36:28 volumio volumio[1464]: info: Refreshing Cached IP Addresses Jan 27 21:36:28 volumio sudo[4747]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Jan 27 21:36:28 volumio sudo[4747]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:28 volumio sudo[4749]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 27 21:36:28 volumio sudo[4749]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:28 volumio sudo[4749]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:28 volumio sudo[4747]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:28 volumio sudo[4752]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:28 volumio sudo[4752]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:28 volumio sudo[4752]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:29 volumio sudo[4756]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 27 21:36:29 volumio sudo[4756]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:29 volumio sudo[4756]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:29 volumio sudo[4758]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:29 volumio sudo[4758]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:29 volumio sudo[4758]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:29 volumio volumio[1464]: verbose: New Socket.io Connection to 192.168.68.55 from 192.168.68.52 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jan 27 21:36:29 volumio volumio[1464]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 27 21:36:29 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jan 27 21:36:29 volumio volumio[1464]: info: CoreCommandRouter::volumioGetState Jan 27 21:36:29 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 27 21:36:29 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jan 27 21:36:29 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jan 27 21:36:29 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 27 21:36:29 volumio sudo[4768]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:29 volumio sudo[4768]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:29 volumio sudo[4768]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:29 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Jan 27 21:36:29 volumio sudo[4771]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Jan 27 21:36:29 volumio sudo[4771]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:29 volumio sudo[4776]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jan 27 21:36:29 volumio sudo[4776]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:29 volumio sudo[4771]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:29 volumio sudo[4783]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jan 27 21:36:29 volumio sudo[4783]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:29 volumio sudo[4776]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:29 volumio sudo[4783]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:29 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Jan 27 21:36:29 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Jan 27 21:36:29 volumio sudo[4798]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:29 volumio sudo[4794]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 27 21:36:29 volumio sudo[4794]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:29 volumio sudo[4798]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:29 volumio sudo[4788]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Jan 27 21:36:29 volumio sudo[4788]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:29 volumio sudo[4798]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:29 volumio sudo[4794]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:29 volumio sudo[4800]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 27 21:36:29 volumio sudo[4800]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:29 volumio sudo[4788]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:29 volumio systemd[1]: upmpdcli.service: Deactivated successfully. Jan 27 21:36:30 volumio sudo[4807]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:30 volumio sudo[4807]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:30 volumio sudo[4807]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:31 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 27 21:36:31 volumio volumio[1464]: info: Received Get System Info Jan 27 21:36:31 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 27 21:36:31 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 27 21:36:31 volumio volumio[1464]: info: Discovery: Getting this device information Jan 27 21:36:31 volumio volumio[1464]: info: CoreCommandRouter::volumioGetState Jan 27 21:36:31 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 27 21:36:31 volumio sudo[4810]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:31 volumio sudo[4810]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:31 volumio sudo[4810]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:31 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 27 21:36:31 volumio volumio[1464]: info: Received Get System Info Jan 27 21:36:31 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 27 21:36:31 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 27 21:36:31 volumio volumio[1464]: info: Discovery: Getting this device information Jan 27 21:36:31 volumio volumio[1464]: info: CoreCommandRouter::volumioGetState Jan 27 21:36:31 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 27 21:36:32 volumio sudo[4800]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:32 volumio sudo[4813]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:32 volumio sudo[4813]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:32 volumio sudo[4813]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:33 volumio sudo[4819]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:33 volumio sudo[4819]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:33 volumio sudo[4819]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:34 volumio sudo[4836]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:34 volumio sudo[4836]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:34 volumio sudo[4836]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:35 volumio sudo[4839]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:35 volumio sudo[4839]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:35 volumio sudo[4839]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:36 volumio sudo[4842]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:36 volumio sudo[4842]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:36 volumio sudo[4842]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:37 volumio sudo[4845]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:37 volumio sudo[4845]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:37 volumio sudo[4845]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:38 volumio sudo[4848]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:38 volumio sudo[4848]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:38 volumio sudo[4848]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:38 volumio sudo[4851]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 27 21:36:38 volumio sudo[4851]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:38 volumio sudo[4851]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:38 volumio sudo[4853]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:38 volumio sudo[4853]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:38 volumio sudo[4853]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:38 volumio sudo[4857]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 27 21:36:38 volumio sudo[4857]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:39 volumio sudo[4860]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:39 volumio sudo[4860]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:39 volumio sudo[4860]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:40 volumio sudo[4863]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:40 volumio sudo[4863]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:40 volumio sudo[4863]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:41 volumio sudo[4866]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:41 volumio sudo[4866]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:41 volumio sudo[4866]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:42 volumio sudo[4869]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:42 volumio sudo[4869]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:42 volumio sudo[4869]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:43 volumio sudo[4873]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:43 volumio sudo[4873]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:43 volumio sudo[4873]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:44 volumio sudo[4890]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:44 volumio sudo[4890]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:44 volumio sudo[4890]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:44 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 4. Jan 27 21:36:44 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Jan 27 21:36:44 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Jan 27 21:36:44 volumio sudo[4857]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:44 volumio volumio[1464]: info: Upmpdcli Daemon Started Jan 27 21:36:44 volumio upmpdcli[4910]: writing RSA key Jan 27 21:36:45 volumio sudo[4917]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:36:45 volumio sudo[4917]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:36:45 volumio sudo[4917]: pam_unix(sudo:session): session closed for user root Jan 27 21:36:47 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 27 21:36:47 volumio volumio[1464]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jan 27 21:36:47 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jan 27 21:36:47 volumio volumio[1464]: info: Received Get System Version Jan 27 21:36:47 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 27 21:36:47 volumio volumio[1464]: info: Received Get System Info Jan 27 21:36:47 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 27 21:36:47 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 27 21:36:47 volumio volumio[1464]: info: Discovery: Getting this device information Jan 27 21:36:47 volumio volumio[1464]: info: CoreCommandRouter::volumioGetState Jan 27 21:36:47 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 27 21:36:53 volumio go-librespot[1891]: time="2026-01-27T21:36:53-06:00" level=trace msg="sent dealer ping" Jan 27 21:36:54 volumio go-librespot[1891]: time="2026-01-27T21:36:54-06:00" level=trace msg="received dealer pong" Jan 27 21:36:56 volumio dhcpcd[1172]: eth0: carrier lost Jan 27 21:36:56 volumio dhcpcd[1010]: eth0: carrier lost Jan 27 21:36:56 volumio kernel: macb 1f00100000.ethernet eth0: Link is Down Jan 27 21:36:56 volumio avahi-daemon[1098]: Withdrawing address record for 192.168.68.55 on eth0. Jan 27 21:36:56 volumio avahi-daemon[1098]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.68.55. Jan 27 21:36:56 volumio avahi-daemon[1098]: Interface eth0.IPv4 no longer relevant for mDNS. Jan 27 21:36:56 volumio dhcpcd[1172]: eth0: deleting route to 192.168.68.0/22 Jan 27 21:36:56 volumio dhcpcd[1172]: eth0: deleting default route via 192.168.68.1 Jan 27 21:36:56 volumio dhcpcd[1010]: eth0: deleting route to 192.168.68.0/22 Jan 27 21:36:56 volumio dhcpcd[1010]: eth0: deleting default route via 192.168.68.1 Jan 27 21:36:56 volumio volumio[1464]: info: Discovery: A device disappeared from network Jan 27 21:36:56 volumio volumio[1464]: info: Discovery: Device volumio disappeared from network Jan 27 21:36:56 volumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Jan 27 21:36:56 volumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Jan 27 21:36:56 volumio systemd[1]: welcome.service: Deactivated successfully. Jan 27 21:36:56 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Jan 27 21:36:56 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Jan 27 21:36:56 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Jan 27 21:36:56 volumio welcome[5011]: Resolved ip:[0] Jan 27 21:36:56 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Jan 27 21:36:56 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Jan 27 21:36:57 volumio ifplugd(eth0)[1324]: Link beat lost. Jan 27 21:36:58 volumio ntpd[1312]: IO: Deleting interface #3 eth0, 192.168.68.55#123, interface stats: received=291, sent=297, dropped=1, active_time=791 secs Jan 27 21:36:58 volumio ntpd[1312]: PROTO: 23.186.168.133 unlink local addr 192.168.68.55 -> Jan 27 21:36:58 volumio ntpd[1312]: PROTO: 163.123.152.14 unlink local addr 192.168.68.55 -> Jan 27 21:36:58 volumio ntpd[1312]: PROTO: 173.255.230.96 unlink local addr 192.168.68.55 -> Jan 27 21:36:58 volumio ntpd[1312]: PROTO: 46.37.96.107 unlink local addr 192.168.68.55 -> Jan 27 21:36:58 volumio ntpd[1312]: PROTO: 23.159.16.194 unlink local addr 192.168.68.55 -> Jan 27 21:36:58 volumio ntpd[1312]: PROTO: 104.234.61.117 unlink local addr 192.168.68.55 -> Jan 27 21:36:58 volumio ntpd[1312]: PROTO: 138.89.14.60 unlink local addr 192.168.68.55 -> Jan 27 21:36:58 volumio ntpd[1312]: PROTO: 23.157.160.168 unlink local addr 192.168.68.55 -> Jan 27 21:36:58 volumio ntpd[1312]: PROTO: 198.199.14.20 unlink local addr 192.168.68.55 -> Jan 27 21:36:58 volumio ntpd[1312]: PROTO: 23.155.72.147 unlink local addr 192.168.68.55 -> Jan 27 21:36:58 volumio ntpd[1312]: PROTO: 137.110.222.27 unlink local addr 192.168.68.55 -> Jan 27 21:36:58 volumio ntpd[1312]: PROTO: 23.186.168.132 unlink local addr 192.168.68.55 -> Jan 27 21:36:58 volumio ntpd[1312]: PROTO: 23.186.168.129 unlink local addr 192.168.68.55 -> Jan 27 21:37:03 volumio volumio[1464]: info: Volumio Network Manager: Network status updated: 0 Jan 27 21:37:07 volumio ifplugd(eth0)[1324]: Executing '/etc/ifplugd/ifplugd.action eth0 down'. Jan 27 21:37:07 volumio dhcpcd[5062]: sending signal ALRM to pid 1009 Jan 27 21:37:07 volumio dhcpcd[5062]: waiting for pid 1009 to exit Jan 27 21:37:07 volumio ifplugd(eth0)[1324]: client: sending signal ALRM to pid 1009 Jan 27 21:37:07 volumio ifplugd(eth0)[1324]: client: waiting for pid 1009 to exit Jan 27 21:37:07 volumio dhcpcd[1010]: received SIGALRM, releasing Jan 27 21:37:07 volumio dhcpcd[1010]: eth0: removing interface Jan 27 21:37:07 volumio kernel: macb 1f00100000.ethernet: gem-ptp-timer ptp clock unregistered. Jan 27 21:37:07 volumio wireless.js[4600]: WIRELESS.JS: Wired network status changed to: ---disconnected--- Jan 27 21:37:07 volumio wireless.js[4600]: WIRELESS.JS: Wireless.js initializing wireless flow Jan 27 21:37:07 volumio wireless.js[4600]: WIRELESS.JS: Cleaning previous... Jan 27 21:37:07 volumio ifplugd(eth0)[1324]: Program executed successfully. Jan 27 21:37:07 volumio kernel: macb 1f00100000.ethernet eth0: PHY [1f00100000.ethernet-ffffffff:01] driver [Broadcom BCM54213PE] (irq=POLL) Jan 27 21:37:07 volumio kernel: macb 1f00100000.ethernet eth0: configuring for phy/rgmii-id link mode Jan 27 21:37:07 volumio kernel: macb 1f00100000.ethernet: gem-ptp-timer ptp clock registered. Jan 27 21:37:07 volumio sudo[5087]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Jan 27 21:37:07 volumio sudo[5087]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 27 21:37:07 volumio sudo[5087]: pam_unix(sudo:session): session closed for user root Jan 27 21:37:07 volumio sudo[5089]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Jan 27 21:37:07 volumio sudo[5089]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 27 21:37:07 volumio sudo[5089]: pam_unix(sudo:session): session closed for user root Jan 27 21:37:07 volumio wireless.js[4600]: WIRELESS.JS: Stopped aP Jan 27 21:37:07 volumio sudo[5099]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jan 27 21:37:07 volumio sudo[5099]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:37:07 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jan 27 21:37:07 volumio sudo[5099]: pam_unix(sudo:session): session closed for user root Jan 27 21:37:07 volumio sudo[5101]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Jan 27 21:37:07 volumio sudo[5101]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:37:08 volumio sudo[5101]: pam_unix(sudo:session): session closed for user root Jan 27 21:37:08 volumio sudo[5109]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jan 27 21:37:08 volumio sudo[5109]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:37:08 volumio sudo[5109]: pam_unix(sudo:session): session closed for user root Jan 27 21:37:08 volumio sudo[5111]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Jan 27 21:37:08 volumio sudo[5111]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:37:10 volumio sudo[5111]: pam_unix(sudo:session): session closed for user root Jan 27 21:37:10 volumio wireless.js[4600]: WIRELESS.JS: SETTING APPROPRIATE REG DOMAIN: US Jan 27 21:37:10 volumio sudo[5124]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Jan 27 21:37:10 volumio sudo[5124]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:37:10 volumio sudo[5124]: pam_unix(sudo:session): session closed for user root Jan 27 21:37:10 volumio sudo[5126]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set US Jan 27 21:37:10 volumio sudo[5126]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:37:10 volumio sudo[5126]: pam_unix(sudo:session): session closed for user root Jan 27 21:37:10 volumio wireless.js[4600]: WIRELESS.JS: SUCCESSFULLY SET NEW REGDOMAIN: US Jan 27 21:37:10 volumio wireless.js[4600]: WIRELESS.JS: Start wireless flow Jan 27 21:37:10 volumio wireless.js[4600]: WIRELESS.JS: Stopped hotspot (if there).. Jan 27 21:37:10 volumio sudo[5136]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 Jan 27 21:37:10 volumio sudo[5136]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 27 21:37:10 volumio sudo[5136]: pam_unix(sudo:session): session closed for user root Jan 27 21:37:10 volumio sudo[5138]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down Jan 27 21:37:10 volumio sudo[5138]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 27 21:37:11 volumio sudo[5138]: pam_unix(sudo:session): session closed for user root Jan 27 21:37:11 volumio wireless.js[4600]: WIRELESS.JS: DHCP IP fallback Jan 27 21:37:11 volumio wireless.js[4600]: WIRELESS.JS: Start ap Jan 27 21:37:11 volumio wpa_supplicant[5143]: Successfully initialized wpa_supplicant Jan 27 21:37:11 volumio sudo[5144]: root : PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Jan 27 21:37:11 volumio sudo[5144]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 27 21:37:11 volumio dhcpcd[1172]: control command: /sbin/dhcpcd Jan 27 21:37:11 volumio dhcpcd[1172]: control_free: No such file or directory Jan 27 21:37:11 volumio sudo[5144]: pam_unix(sudo:session): session closed for user root Jan 27 21:37:11 volumio dhcpcd[1172]: lo: IAID 00:00:00:00 Jan 27 21:37:11 volumio dhcpcd[1172]: lo: ipv6_start: Operation not supported Jan 27 21:37:11 volumio dhcpcd[1172]: lo: using static address 127.0.0.1/8 Jan 27 21:37:11 volumio dhcpcd[1172]: lo: adding route to 127.0.0.0/8 Jan 27 21:37:11 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Jan 27 21:37:11 volumio systemd[1]: Reached target ip-changed@lo.target - IP Address changed on lo. Jan 27 21:37:11 volumio wpa_supplicant[5143]: nl80211: kernel reports: Registration to specific type not supported Jan 27 21:37:12 volumio wireless.js[4600]: WIRELESS.JS: trying... Jan 27 21:37:12 volumio sudo[5179]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 27 21:37:12 volumio sudo[5179]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:37:12 volumio sudo[5179]: pam_unix(sudo:session): session closed for user root Jan 27 21:37:13 volumio wireless.js[4600]: WIRELESS.JS: trying... Jan 27 21:37:13 volumio sudo[5188]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 27 21:37:13 volumio sudo[5188]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:37:13 volumio sudo[5188]: pam_unix(sudo:session): session closed for user root Jan 27 21:37:13 volumio volumio[1464]: info: [jellyfin-poller] Polled http:\\192.168.68.52:8096: offline (lost) Jan 27 21:37:14 volumio wpa_supplicant[5174]: wlan0: Trying to associate with 3e:62:cf:e8:ef:4b (SSID='Fragile' freq=5180 MHz) Jan 27 21:37:14 volumio wireless.js[4600]: WIRELESS.JS: trying... Jan 27 21:37:14 volumio sudo[5208]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 27 21:37:14 volumio sudo[5208]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:37:14 volumio sudo[5208]: pam_unix(sudo:session): session closed for user root Jan 27 21:37:14 volumio wpa_supplicant[5174]: wlan0: Associated with 3e:62:cf:e8:ef:4b Jan 27 21:37:14 volumio wpa_supplicant[5174]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Jan 27 21:37:14 volumio wpa_supplicant[5174]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Jan 27 21:37:14 volumio wpa_supplicant[5174]: wlan0: WPA: Key negotiation completed with 3e:62:cf:e8:ef:4b [PTK=CCMP GTK=CCMP] Jan 27 21:37:14 volumio wpa_supplicant[5174]: wlan0: CTRL-EVENT-CONNECTED - Connection to 3e:62:cf:e8:ef:4b completed [id=0 id_str=] Jan 27 21:37:14 volumio dhcpcd[1172]: wlan0: carrier acquired Jan 27 21:37:14 volumio dhcpcd[1172]: wlan0: connected to Access Point: Fragile Jan 27 21:37:14 volumio dhcpcd[1172]: wlan0: IAID 67:45:8a:fd Jan 27 21:37:14 volumio dhcpcd[1172]: wlan0: adding address fe80::2ecf:67ff:fe45:8afd Jan 27 21:37:14 volumio dhcpcd[1172]: ipv6_addaddr1: Permission denied Jan 27 21:37:14 volumio dhcpcd[1172]: wlan0: soliciting a DHCP lease Jan 27 21:37:14 volumio dhcpcd[1172]: wlan0: soliciting an IPv6 router Jan 27 21:37:15 volumio dhcpcd[1172]: wlan0: offered 192.168.68.51 from 192.168.68.1 Jan 27 21:37:15 volumio dhcpcd[1172]: wlan0: probing address 192.168.68.51/22 Jan 27 21:37:15 volumio wireless.js[4600]: WIRELESS.JS: trying... Jan 27 21:37:15 volumio sudo[5217]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 27 21:37:15 volumio sudo[5217]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:37:15 volumio sudo[5217]: pam_unix(sudo:session): session closed for user root Jan 27 21:37:16 volumio wireless.js[4600]: WIRELESS.JS: trying... Jan 27 21:37:16 volumio sudo[5223]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 27 21:37:16 volumio sudo[5223]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:37:16 volumio sudo[5223]: pam_unix(sudo:session): session closed for user root Jan 27 21:37:17 volumio wireless.js[4600]: WIRELESS.JS: trying... Jan 27 21:37:17 volumio sudo[5229]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 27 21:37:17 volumio sudo[5229]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:37:17 volumio sudo[5229]: pam_unix(sudo:session): session closed for user root Jan 27 21:37:18 volumio kernel: drm-rp1-dsi 1f00130000.dsi: [drm] rp1dsi: Command time (outvact): 33 Jan 27 21:37:18 volumio kernel: drm-rp1-dsi 1f00130000.dsi: [drm] rp1dsi: Nominal Byte clock 90000000 DPI clock 30000000 (parent rate 90000000) Jan 27 21:37:18 volumio wireless.js[4600]: WIRELESS.JS: trying... Jan 27 21:37:18 volumio sudo[5235]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 27 21:37:18 volumio sudo[5235]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:37:18 volumio sudo[5235]: pam_unix(sudo:session): session closed for user root Jan 27 21:37:18 volumio volumio[1464]: info: VolumeController::SetAlsaVolume51 Jan 27 21:37:18 volumio volumio[1464]: info: CoreStateMachine::pushState Jan 27 21:37:18 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 21:37:18 volumio volumio[1464]: info: CoreCommandRouter::volumioPushState Jan 27 21:37:18 volumio volumio[1464]: SPOTIFY: RECEIVED VOLUMIO VOLUME 51 Jan 27 21:37:18 volumio volumio[1464]: SPOTIFY: SPOTIFY VOLUME 100 Jan 27 21:37:18 volumio volumio[1464]: SPOTIFY: VOLUMIO VOLUME 51 Jan 27 21:37:18 volumio volumio[1464]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 27 21:37:18 volumio volumio[1464]: info: Setting Spotify Volume from Volumio: 51 Jan 27 21:37:19 volumio wireless.js[4600]: WIRELESS.JS: trying... Jan 27 21:37:19 volumio sudo[5242]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 27 21:37:19 volumio sudo[5242]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:37:19 volumio sudo[5242]: pam_unix(sudo:session): session closed for user root Jan 27 21:37:19 volumio dhcpcd[1172]: wlan0: leased 192.168.68.51 for 7200 seconds Jan 27 21:37:19 volumio avahi-daemon[1098]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.68.51. Jan 27 21:37:19 volumio avahi-daemon[1098]: New relevant interface wlan0.IPv4 for mDNS. Jan 27 21:37:19 volumio avahi-daemon[1098]: Registering new address record for 192.168.68.51 on wlan0.IPv4. Jan 27 21:37:19 volumio dhcpcd[1172]: wlan0: adding route to 192.168.68.0/22 Jan 27 21:37:19 volumio systemd[1]: welcome.service: Deactivated successfully. Jan 27 21:37:19 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Jan 27 21:37:19 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Jan 27 21:37:19 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Jan 27 21:37:19 volumio welcome[5252]: Resolved ip:[1] 192.168.68.51 Jan 27 21:37:19 volumio dhcpcd[1172]: wlan0: adding default route via 192.168.68.1 Jan 27 21:37:19 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Jan 27 21:37:19 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Jan 27 21:37:19 volumio volumio[1464]: SPOTIFY: SETTING SPOTIFY VOLUME 51 Jan 27 21:37:19 volumio volumio[1464]: info: Sending Spotify command with payload to local API: /player/volume Jan 27 21:37:19 volumio go-librespot[1891]: time="2026-01-27T21:37:19-06:00" level=debug msg="update volume requested to 33422/65535" Jan 27 21:37:20 volumio go-librespot[1891]: time="2026-01-27T21:37:20-06:00" level=debug msg="put connect state because VOLUME_CHANGED" Jan 27 21:37:20 volumio go-librespot[1891]: time="2026-01-27T21:37:20-06:00" level=trace msg="emitting websocket event: volume" Jan 27 21:37:20 volumio volumio[1464]: SPOTIFY: received: {"type":"volume","data":{"value":51,"max":100}} Jan 27 21:37:20 volumio volumio[1464]: SPOTIFY: RECEIVED SPOTIFY VOLUME 51 Jan 27 21:37:20 volumio wireless.js[4600]: WIRELESS.JS: trying... Jan 27 21:37:20 volumio sudo[5278]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Jan 27 21:37:20 volumio sudo[5278]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 27 21:37:20 volumio sudo[5278]: pam_unix(sudo:session): session closed for user root Jan 27 21:37:20 volumio wireless.js[4600]: WIRELESS.JS: Connected to: ----Fragile---- Jan 27 21:37:20 volumio sudo[5281]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 27 21:37:20 volumio sudo[5281]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 27 21:37:20 volumio sudo[5281]: pam_unix(sudo:session): session closed for user root Jan 27 21:37:20 volumio wireless.js[4600]: WIRELESS.JS: ... joined AP, wlan0 IPv4 is 192.168.68.51, ipV6 is undefined Jan 27 21:37:20 volumio wireless.js[4600]: WIRELESS.JS: It's done! AP Jan 27 21:37:20 volumio wireless.js[4600]: WIRELESS.JS: Restarting avahi-daemon... Jan 27 21:37:20 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 27 21:37:20 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Jan 27 21:37:20 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 27 21:37:20 volumio systemd[1]: shairport-sync.service: Consumed 2.315s CPU time. Jan 27 21:37:20 volumio systemd[1]: Stopping avahi-daemon.service - Avahi mDNS/DNS-SD Stack... Jan 27 21:37:20 volumio avahi-daemon[1098]: Got SIGTERM, quitting. Jan 27 21:37:20 volumio avahi-daemon[1098]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.68.51. Jan 27 21:37:20 volumio avahi-daemon[1098]: Leaving mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Jan 27 21:37:20 volumio volumio[1464]: info: Discovery: Browse raised the following error Error: dns service error: unknown Jan 27 21:37:20 volumio wireless.js[4600]: WIRELESS.JS: Notified systemd about wireless ready Jan 27 21:37:20 volumio volumio[1464]: error: Discovery: Advertisement error: Error: dns service error: unknown Jan 27 21:37:20 volumio volumio[1464]: error: Discovery: advertisement error: Error: dns service error: unknown Jan 27 21:37:20 volumio volumio[1464]: info: Discovery: Advertisement raised the following error Error: dns service error: unknown Jan 27 21:37:20 volumio volumio[1464]: info: Discovery: Browse raised the following error Error: dns service error: unknown Jan 27 21:37:20 volumio dbus-daemon[1100]: [system] Activating via systemd: service name='org.freedesktop.Avahi' unit='dbus-org.freedesktop.Avahi.service' requested by ':1.31' (uid=0 pid=1677 comm="/usr/sbin/smbd --foreground --no-process-group") Jan 27 21:37:20 volumio avahi-daemon[1098]: avahi-daemon 0.8 exiting. Jan 27 21:37:20 volumio systemd[1]: avahi-daemon.service: Deactivated successfully. Jan 27 21:37:20 volumio systemd[1]: Stopped avahi-daemon.service - Avahi mDNS/DNS-SD Stack. Jan 27 21:37:20 volumio systemd[1]: Starting avahi-daemon.service - Avahi mDNS/DNS-SD Stack... Jan 27 21:37:20 volumio avahi-daemon[5287]: Process 1098 died: No such process; trying to remove PID file. (/run/avahi-daemon//pid) Jan 27 21:37:20 volumio avahi-daemon[5287]: Found user 'avahi' (UID 103) and group 'avahi' (GID 109). Jan 27 21:37:20 volumio avahi-daemon[5287]: Successfully dropped root privileges. Jan 27 21:37:20 volumio avahi-daemon[5287]: avahi-daemon 0.8 starting up. Jan 27 21:37:20 volumio dbus-daemon[1100]: [system] Successfully activated service 'org.freedesktop.Avahi' Jan 27 21:37:20 volumio systemd[1]: Started avahi-daemon.service - Avahi mDNS/DNS-SD Stack. Jan 27 21:37:20 volumio avahi-daemon[5287]: Successfully called chroot(). Jan 27 21:37:20 volumio avahi-daemon[5287]: Successfully dropped remaining capabilities. Jan 27 21:37:20 volumio avahi-daemon[5287]: No service file found in /etc/avahi/services. Jan 27 21:37:20 volumio avahi-daemon[5287]: *** WARNING: Detected another IPv4 mDNS stack running on this host. This makes mDNS unreliable and is thus not recommended. *** Jan 27 21:37:20 volumio avahi-daemon[5287]: *** WARNING: Detected another IPv6 mDNS stack running on this host. This makes mDNS unreliable and is thus not recommended. *** Jan 27 21:37:20 volumio avahi-daemon[5287]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.68.51. Jan 27 21:37:20 volumio avahi-daemon[5287]: New relevant interface wlan0.IPv4 for mDNS. Jan 27 21:37:20 volumio avahi-daemon[5287]: Joining mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Jan 27 21:37:20 volumio avahi-daemon[5287]: New relevant interface lo.IPv4 for mDNS. Jan 27 21:37:20 volumio avahi-daemon[5287]: Network interface enumeration completed. Jan 27 21:37:20 volumio avahi-daemon[5287]: Registering new address record for 192.168.68.51 on wlan0.IPv4. Jan 27 21:37:20 volumio avahi-daemon[5287]: Registering new address record for 127.0.0.1 on lo.IPv4. Jan 27 21:37:20 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 27 21:37:21 volumio volumio[1464]: info: VolumeController::SetAlsaVolume56 Jan 27 21:37:21 volumio ntpd[1312]: IO: Listen normally on 4 wlan0 192.168.68.51:123 Jan 27 21:37:21 volumio ntpd[1312]: IO: new interface(s) found: waking up resolver Jan 27 21:37:21 volumio volumio[1464]: info: CoreStateMachine::pushState Jan 27 21:37:21 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 21:37:21 volumio volumio[1464]: info: CoreCommandRouter::volumioPushState Jan 27 21:37:21 volumio volumio[1464]: SPOTIFY: RECEIVED VOLUMIO VOLUME 56 Jan 27 21:37:21 volumio volumio[1464]: SPOTIFY: SPOTIFY VOLUME 51 Jan 27 21:37:21 volumio volumio[1464]: SPOTIFY: VOLUMIO VOLUME 56 Jan 27 21:37:21 volumio volumio[1464]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 27 21:37:21 volumio volumio[1464]: info: Setting Spotify Volume from Volumio: 56 Jan 27 21:37:21 volumio avahi-daemon[5287]: Server startup complete. Host name is volumio.local. Local service cookie is 2873066848. Jan 27 21:37:22 volumio volumio[1464]: info: VolumeController::SetAlsaVolume100 Jan 27 21:37:22 volumio volumio[1464]: info: CoreStateMachine::pushState Jan 27 21:37:22 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 21:37:22 volumio volumio[1464]: info: CoreCommandRouter::volumioPushState Jan 27 21:37:22 volumio volumio[1464]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Jan 27 21:37:22 volumio volumio[1464]: SPOTIFY: SPOTIFY VOLUME 56 Jan 27 21:37:22 volumio volumio[1464]: SPOTIFY: VOLUMIO VOLUME 100 Jan 27 21:37:22 volumio volumio[1464]: SPOTIFY: DELTA VOLUME ENOUGH: true Jan 27 21:37:22 volumio volumio[1464]: info: Setting Spotify Volume from Volumio: 100 Jan 27 21:37:22 volumio volumio[1464]: info: VolumeController::SetAlsaVolume0 Jan 27 21:37:22 volumio volumio[1464]: info: CoreStateMachine::pushState Jan 27 21:37:22 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 21:37:22 volumio volumio[1464]: info: CoreCommandRouter::volumioPushState Jan 27 21:37:23 volumio volumio[1464]: info: Volumio Network Manager: Network status updated: 2 Jan 27 21:37:23 volumio volumio[1464]: SPOTIFY: SETTING SPOTIFY VOLUME 100 Jan 27 21:37:23 volumio volumio[1464]: info: Sending Spotify command with payload to local API: /player/volume Jan 27 21:37:23 volumio go-librespot[1891]: time="2026-01-27T21:37:23-06:00" level=debug msg="update volume requested to 65535/65535" Jan 27 21:37:23 volumio go-librespot[1891]: time="2026-01-27T21:37:23-06:00" level=trace msg="sent dealer ping" Jan 27 21:37:24 volumio go-librespot[1891]: time="2026-01-27T21:37:24-06:00" level=debug msg="put connect state because VOLUME_CHANGED" Jan 27 21:37:24 volumio go-librespot[1891]: time="2026-01-27T21:37:24-06:00" level=trace msg="emitting websocket event: volume" Jan 27 21:37:24 volumio volumio[1464]: SPOTIFY: received: {"type":"volume","data":{"value":100,"max":100}} Jan 27 21:37:24 volumio volumio[1464]: SPOTIFY: RECEIVED SPOTIFY VOLUME 100 Jan 27 21:37:24 volumio volumio[1464]: info: CorePlayQueue::getTrack 29 Jan 27 21:37:24 volumio volumio[1464]: info: CorePlayQueue::getTrack 30 Jan 27 21:37:24 volumio volumio[1464]: info: Prefetching next song Jan 27 21:37:24 volumio volumio[1464]: error: [jellyfin-play] Prefetch failed: Error: Server unavailable Jan 27 21:37:25 volumio volumio[1464]: info: Discovery: Started advertising with name: Volumio Jan 27 21:37:28 volumio volumio[1464]: info: Jan 27 21:37:28 volumio volumio[1464]: ---------------------------- MPD announces system playlist update Jan 27 21:37:28 volumio volumio[1464]: info: Ignoring MPD Status Update Jan 27 21:37:28 volumio volumio[1464]: info: Jan 27 21:37:28 volumio volumio[1464]: ---------------------------- MPD announces state update: player Jan 27 21:37:28 volumio volumio[1464]: info: ControllerMpd::getState Jan 27 21:37:28 volumio volumio[1464]: verbose: ControllerMpd::sendMpdCommand status Jan 27 21:37:28 volumio volumio[1464]: info: Jan 27 21:37:28 volumio volumio[1464]: ---------------------------- MPD announces system playlist update Jan 27 21:37:28 volumio volumio[1464]: info: Ignoring MPD Status Update Jan 27 21:37:28 volumio volumio[1464]: info: Jan 27 21:37:28 volumio volumio[1464]: ---------------------------- MPD announces state update: player Jan 27 21:37:28 volumio volumio[1464]: info: ControllerMpd::getState Jan 27 21:37:28 volumio volumio[1464]: verbose: ControllerMpd::sendMpdCommand status Jan 27 21:37:28 volumio volumio[1464]: info: Jan 27 21:37:28 volumio volumio[1464]: ---------------------------- MPD announces system playlist update Jan 27 21:37:28 volumio volumio[1464]: info: Ignoring MPD Status Update Jan 27 21:37:28 volumio volumio[1464]: info: ControllerMpd::getState Jan 27 21:37:28 volumio volumio[1464]: verbose: ControllerMpd::sendMpdCommand status Jan 27 21:37:28 volumio volumio[1464]: info: Jan 27 21:37:28 volumio volumio[1464]: ---------------------------- MPD announces state update: player Jan 27 21:37:28 volumio volumio[1464]: info: ControllerMpd::getState Jan 27 21:37:28 volumio volumio[1464]: verbose: ControllerMpd::sendMpdCommand status Jan 27 21:37:28 volumio volumio[1464]: info: ------------------------------ 1ms Jan 27 21:37:28 volumio volumio[1464]: info: sendMpdCommand status took 2 milliseconds Jan 27 21:37:28 volumio volumio[1464]: info: ------------------------------ 1ms Jan 27 21:37:28 volumio volumio[1464]: info: sendMpdCommand status took 1 milliseconds Jan 27 21:37:28 volumio volumio[1464]: verbose: ControllerMpd::parseState Jan 27 21:37:28 volumio volumio[1464]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 21:37:28 volumio volumio[1464]: verbose: ControllerMpd::parseState Jan 27 21:37:28 volumio volumio[1464]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 21:37:28 volumio volumio[1464]: info: sendMpdCommand status took 1 milliseconds Jan 27 21:37:28 volumio volumio[1464]: info: ------------------------------ 1ms Jan 27 21:37:28 volumio volumio[1464]: info: sendMpdCommand status took 1 milliseconds Jan 27 21:37:28 volumio volumio[1464]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 27 21:37:28 volumio volumio[1464]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 27 21:37:28 volumio volumio[1464]: verbose: ControllerMpd::parseState Jan 27 21:37:28 volumio volumio[1464]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 21:37:28 volumio volumio[1464]: verbose: ControllerMpd::parseState Jan 27 21:37:28 volumio volumio[1464]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 27 21:37:28 volumio volumio[1464]: verbose: ControllerMpd::parseTrackInfo Jan 27 21:37:28 volumio volumio[1464]: verbose: ControllerMpd::parseTrackInfo Jan 27 21:37:28 volumio volumio[1464]: info: ControllerMpd::pushState Jan 27 21:37:28 volumio volumio[1464]: info: CoreCommandRouter::servicePushState Jan 27 21:37:28 volumio volumio[1464]: info: CorePlayQueue::getTrack 29 Jan 27 21:37:28 volumio volumio[1464]: verbose: STATE SERVICE {"status":"play","position":0,"seek":325581,"duration":326,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Orgasmatron","artist":"Motorhead","album":"The Best Of Motorhead","uri":"http://192.168.68.52:8096/Audio/ac1e1e025a4d678cf7ae8024da08c4ba/stream.mp3?static=true&mediaSourceId=ac1e1e025a4d678cf7ae8024da08c4ba&tag=f85cabde8b4b641b9001fff1756e53db&t.mp3","trackType":"mp3"} Jan 27 21:37:28 volumio volumio[1464]: verbose: CURRENT POSITION 29 Jan 27 21:37:28 volumio volumio[1464]: info: CoreStateMachine::syncState stateService play Jan 27 21:37:28 volumio volumio[1464]: info: CoreStateMachine::syncState currentStatus play Jan 27 21:37:28 volumio volumio[1464]: info: Received an update from plugin. extracting info from payload Jan 27 21:37:28 volumio volumio[1464]: info: CoreStateMachine::pushState Jan 27 21:37:28 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 21:37:28 volumio volumio[1464]: info: CoreCommandRouter::volumioPushState Jan 27 21:37:28 volumio volumio[1464]: info: CoreStateMachine::pushState Jan 27 21:37:28 volumio volumio[1464]: info: CoreCommandRouter::volumioPushState Jan 27 21:37:28 volumio volumio[1464]: info: ControllerMpd::pushState Jan 27 21:37:28 volumio volumio[1464]: info: CoreCommandRouter::servicePushState Jan 27 21:37:28 volumio volumio[1464]: info: CorePlayQueue::getTrack 29 Jan 27 21:37:28 volumio volumio[1464]: verbose: STATE SERVICE {"status":"play","position":0,"seek":325581,"duration":326,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Orgasmatron","artist":"Motorhead","album":"The Best Of Motorhead","uri":"http://192.168.68.52:8096/Audio/ac1e1e025a4d678cf7ae8024da08c4ba/stream.mp3?static=true&mediaSourceId=ac1e1e025a4d678cf7ae8024da08c4ba&tag=f85cabde8b4b641b9001fff1756e53db&t.mp3","trackType":"mp3"} Jan 27 21:37:28 volumio volumio[1464]: verbose: CURRENT POSITION 29 Jan 27 21:37:28 volumio volumio[1464]: info: CoreStateMachine::syncState stateService play Jan 27 21:37:28 volumio volumio[1464]: info: CoreStateMachine::syncState currentStatus play Jan 27 21:37:28 volumio volumio[1464]: info: Received an update from plugin. extracting info from payload Jan 27 21:37:28 volumio volumio[1464]: info: CoreStateMachine::pushState Jan 27 21:37:28 volumio volumio[1464]: info: CoreCommandRouter::volumioPushState Jan 27 21:37:28 volumio volumio[1464]: info: CoreStateMachine::pushState Jan 27 21:37:28 volumio volumio[1464]: info: CoreCommandRouter::volumioPushState Jan 27 21:37:28 volumio volumio[1464]: info: ------------------------------ 16ms Jan 27 21:37:28 volumio volumio[1464]: info: ------------------------------ 15ms Jan 27 21:37:28 volumio volumio[1464]: info: sendMpdCommand playlistinfo took 14 milliseconds Jan 27 21:37:28 volumio volumio[1464]: info: sendMpdCommand playlistinfo took 14 milliseconds Jan 27 21:37:28 volumio volumio[1464]: verbose: ControllerMpd::parseTrackInfo Jan 27 21:37:28 volumio volumio[1464]: verbose: ControllerMpd::parseTrackInfo Jan 27 21:37:28 volumio volumio[1464]: info: ControllerMpd::pushState Jan 27 21:37:28 volumio volumio[1464]: info: CoreCommandRouter::servicePushState Jan 27 21:37:28 volumio volumio[1464]: info: CorePlayQueue::getTrack 29 Jan 27 21:37:28 volumio volumio[1464]: verbose: STATE SERVICE {"status":"play","position":0,"seek":325581,"duration":326,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Orgasmatron","artist":"Motorhead","album":"The Best Of Motorhead","uri":"http://192.168.68.52:8096/Audio/ac1e1e025a4d678cf7ae8024da08c4ba/stream.mp3?static=true&mediaSourceId=ac1e1e025a4d678cf7ae8024da08c4ba&tag=f85cabde8b4b641b9001fff1756e53db&t.mp3","trackType":"mp3"} Jan 27 21:37:28 volumio volumio[1464]: verbose: CURRENT POSITION 29 Jan 27 21:37:28 volumio volumio[1464]: info: CoreStateMachine::syncState stateService play Jan 27 21:37:28 volumio volumio[1464]: info: CoreStateMachine::syncState currentStatus play Jan 27 21:37:28 volumio volumio[1464]: info: Received an update from plugin. extracting info from payload Jan 27 21:37:28 volumio volumio[1464]: info: CoreStateMachine::pushState Jan 27 21:37:28 volumio volumio[1464]: info: CoreCommandRouter::volumioPushState Jan 27 21:37:28 volumio volumio[1464]: info: CoreStateMachine::pushState Jan 27 21:37:28 volumio volumio[1464]: info: CoreCommandRouter::volumioPushState Jan 27 21:37:28 volumio volumio[1464]: info: ------------------------------ 23ms Jan 27 21:37:28 volumio volumio[1464]: info: Pushing Favourites {"favourite":false} Jan 27 21:37:28 volumio volumio[1464]: info: [jellyfin-play]: Reported 'timeupdate' for song: Orgasmatron (at 325581 ms) Jan 27 21:37:29 volumio volumio[1464]: info: Jan 27 21:37:29 volumio volumio[1464]: ---------------------------- MPD announces state update: player Jan 27 21:37:29 volumio volumio[1464]: info: ControllerMpd::getState Jan 27 21:37:29 volumio volumio[1464]: verbose: ControllerMpd::sendMpdCommand status Jan 27 21:37:29 volumio volumio[1464]: info: Jan 27 21:37:29 volumio volumio[1464]: ---------------------------- MPD announces state update: player Jan 27 21:37:29 volumio volumio[1464]: info: ControllerMpd::getState Jan 27 21:37:29 volumio volumio[1464]: verbose: ControllerMpd::sendMpdCommand status Jan 27 21:37:29 volumio volumio[1464]: info: ControllerMpd::getState Jan 27 21:37:29 volumio volumio[1464]: verbose: ControllerMpd::sendMpdCommand status Jan 27 21:37:29 volumio volumio[1464]: info: Jan 27 21:37:29 volumio volumio[1464]: ---------------------------- MPD announces state update: player Jan 27 21:37:29 volumio volumio[1464]: info: ControllerMpd::getState Jan 27 21:37:29 volumio volumio[1464]: verbose: ControllerMpd::sendMpdCommand status Jan 27 21:37:29 volumio volumio[1464]: info: sendMpdCommand status took 1 milliseconds Jan 27 21:37:29 volumio volumio[1464]: info: sendMpdCommand status took 1 milliseconds Jan 27 21:37:29 volumio volumio[1464]: verbose: ControllerMpd::parseState Jan 27 21:37:29 volumio volumio[1464]: verbose: ControllerMpd::parseState Jan 27 21:37:29 volumio volumio[1464]: info: ControllerMpd::pushState Jan 27 21:37:29 volumio volumio[1464]: info: CoreCommandRouter::servicePushState Jan 27 21:37:29 volumio volumio[1464]: info: CoreStateMachine::pushState Jan 27 21:37:29 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 21:37:29 volumio volumio[1464]: info: CoreCommandRouter::volumioPushState Jan 27 21:37:29 volumio volumio[1464]: info: CorePlayQueue::getTrack 29 Jan 27 21:37:29 volumio volumio[1464]: 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} Jan 27 21:37:29 volumio volumio[1464]: verbose: CURRENT POSITION 29 Jan 27 21:37:29 volumio volumio[1464]: info: CoreStateMachine::syncState stateService stop Jan 27 21:37:29 volumio volumio[1464]: info: CoreStateMachine::syncState currentStatus play Jan 27 21:37:29 volumio volumio[1464]: info: CoreStateMachine::play index undefined Jan 27 21:37:29 volumio volumio[1464]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 27 21:37:29 volumio volumio[1464]: info: CoreStateMachine::pushState Jan 27 21:37:29 volumio volumio[1464]: info: CorePlayQueue::getTrack 30 Jan 27 21:37:29 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 21:37:29 volumio volumio[1464]: info: CoreCommandRouter::volumioPushState Jan 27 21:37:29 volumio volumio[1464]: info: ControllerMpd::pushState Jan 27 21:37:29 volumio volumio[1464]: info: CoreCommandRouter::servicePushState Jan 27 21:37:29 volumio volumio[1464]: info: CoreStateMachine::pushState Jan 27 21:37:29 volumio volumio[1464]: info: CorePlayQueue::getTrack 30 Jan 27 21:37:29 volumio volumio[1464]: info: CoreCommandRouter::volumioPushState Jan 27 21:37:29 volumio volumio[1464]: info: CorePlayQueue::getTrack 30 Jan 27 21:37:29 volumio volumio[1464]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current jellyfin Received mpd Jan 27 21:37:29 volumio volumio[1464]: info: CorePlayQueue::getTrack 30 Jan 27 21:37:29 volumio volumio[1464]: info: CoreStateMachine::startPlaybackTimer Jan 27 21:37:29 volumio volumio[1464]: info: CorePlayQueue::getTrack 30 Jan 27 21:37:29 volumio volumio[1464]: info: [jellyfin-play] clearAddPlayTrack: jellyfin/Eric@80541656596941e29156dd9ea6df0667/song@songId=369b6cbd28d2f8f9c7247078976ffb71 Jan 27 21:37:29 volumio volumio[1464]: info: ------------------------------ 11ms Jan 27 21:37:29 volumio volumio[1464]: info: ------------------------------ 11ms Jan 27 21:37:29 volumio volumio[1464]: info: CoreStateMachine::pushState Jan 27 21:37:29 volumio volumio[1464]: info: CorePlayQueue::getTrack 30 Jan 27 21:37:29 volumio volumio[1464]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 27 21:37:29 volumio volumio[1464]: info: CoreCommandRouter::volumioPushState Jan 27 21:37:29 volumio volumio[1464]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 27 21:37:29 volumio volumio[1464]: Error: Server unavailable Jan 27 21:37:29 volumio volumio[1464]: at PlayController.getSongFromTrack (/data/plugins/music_service/jellyfin/dist/lib/controller/play/PlayController.js:166:19) Jan 27 21:37:29 volumio volumio[1464]: at PlayController.clearAddPlayTrack (/data/plugins/music_service/jellyfin/dist/lib/controller/play/PlayController.js:77:49) Jan 27 21:37:29 volumio volumio[1464]: at ControllerJellyfin.clearAddPlayTrack (/data/plugins/music_service/jellyfin/dist/index.js:405:87) Jan 27 21:37:29 volumio volumio[1464]: at Promise._successFn (/volumio/app/statemachine.js:1028:24) Jan 27 21:37:29 volumio volumio[1464]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jan 27 21:37:29 volumio volumio[1464]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Jan 27 21:37:29 volumio volumio[1464]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 27 21:37:30 volumio sudo[5369]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-27 21:36' Jan 27 21:37:30 volumio sudo[5369]: 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"