Oct 02 21:10:02 volumio volumio[1325]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 02 21:10:02 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Oct 02 21:10:02 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork
Oct 02 21:10:02 volumio sudo[3708]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0
Oct 02 21:10:02 volumio sudo[3708]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:02 volumio sudo[3713]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Oct 02 21:10:02 volumio sudo[3713]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:02 volumio sudo[3713]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:02 volumio sudo[3719]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Oct 02 21:10:02 volumio sudo[3719]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:02 volumio sudo[3708]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:02 volumio sudo[3719]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:02 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Oct 02 21:10:02 volumio sudo[3725]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Oct 02 21:10:02 volumio sudo[3725]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:02 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Oct 02 21:10:02 volumio sudo[3725]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:02 volumio sudo[3730]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 02 21:10:02 volumio sudo[3734]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 02 21:10:02 volumio sudo[3734]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:02 volumio sudo[3730]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:02 volumio sudo[3734]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:02 volumio sudo[3730]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:02 volumio sudo[3738]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Oct 02 21:10:02 volumio sudo[3738]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:05 volumio sudo[3738]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:06 volumio volumio[1325]: info: Received Get System Info
Oct 02 21:10:06 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 02 21:10:06 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 02 21:10:06 volumio volumio[1325]: info: Discovery: Getting this device information
Oct 02 21:10:06 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:06 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 02 21:10:06 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Oct 02 21:10:06 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Oct 02 21:10:07 volumio volumio5-onboarding[1581]: time=2026-10-02T21:10:07.131+03:00 level=INFO msg="service successfully established" component=discovery/localnet
Oct 02 21:10:09 volumio volumio[1325]: info: CALLMETHOD: system_controller network saveHotspotSettings [object Object]
Oct 02 21:10:09 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , saveHotspotSettings
Oct 02 21:10:10 volumio sudo[3745]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hostapd/hostapd.conf
Oct 02 21:10:10 volumio sudo[3745]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:10 volumio sudo[3745]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:10 volumio volumio[1325]: info: Permissions for /etc/hostapd/hostapd.conf
Oct 02 21:10:10 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart
Oct 02 21:10:10 volumio sudo[3748]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart wireless.service
Oct 02 21:10:10 volumio sudo[3748]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:10 volumio systemd[1]: Stopping wireless.service - Wireless Services...
Oct 02 21:10:10 volumio systemd[1]: wireless.service: Killing process 1447 (wpa_supplicant) with signal SIGKILL.
Oct 02 21:10:10 volumio systemd[1]: wireless.service: Deactivated successfully.
Oct 02 21:10:10 volumio systemd[1]: Stopped wireless.service - Wireless Services.
Oct 02 21:10:10 volumio systemd[1]: wireless.service: Consumed 1.332s CPU time.
Oct 02 21:10:10 volumio systemd[1]: Starting wireless.service - Wireless Services...
Oct 02 21:10:10 volumio wireless.js[3750]: WIRELESS.JS - INFO: Single Network Mode enabled (default) - only one network device can be active at a time between ethernet and wireless
Oct 02 21:10:10 volumio wireless.js[3750]: WIRELESS.JS - INFO: === SNM TRANSITION ===
Oct 02 21:10:10 volumio wireless.js[3750]: WIRELESS.JS - INFO: Previous ethernet state: disconnected
Oct 02 21:10:10 volumio wireless.js[3750]: WIRELESS.JS - INFO: New ethernet state: connected
Oct 02 21:10:10 volumio wireless.js[3750]: WIRELESS.JS - INFO: Single Network Mode: enabled
Oct 02 21:10:10 volumio wireless.js[3750]: WIRELESS.JS - INFO: First start: yes
Oct 02 21:10:10 volumio wireless.js[3750]: WIRELESS.JS - INFO: Action: Switch to ethernet (WiFi scan mode)
Oct 02 21:10:10 volumio wireless.js[3750]: WIRELESS.JS - INFO: === END TRANSITION ===
Oct 02 21:10:10 volumio wireless.js[3750]: WIRELESS.JS - INFO: Wireless.js initializing wireless flow
Oct 02 21:10:10 volumio sudo[3773]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Oct 02 21:10:10 volumio sudo[3773]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Oct 02 21:10:10 volumio sudo[3773]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:10 volumio sudo[3775]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down
Oct 02 21:10:10 volumio sudo[3775]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Oct 02 21:10:11 volumio sudo[3775]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:11 volumio wireless.js[3750]: WIRELESS.JS - INFO: Cleaning previous...
Oct 02 21:10:11 volumio sudo[3778]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Oct 02 21:10:11 volumio sudo[3778]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Oct 02 21:10:11 volumio sudo[3778]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:11 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Oct 02 21:10:11 volumio wireless.js[3750]: WIRELESS.JS - INFO: InterfaceValidator: READY - wlan0 is ready for operations
Oct 02 21:10:11 volumio wireless.js[3750]: WIRELESS.JS - INFO: InterfaceValidator: wlan0 became ready after 2ms
Oct 02 21:10:11 volumio wireless.js[3750]: WIRELESS.JS - INFO: ensureInterfaceReady: Interface ready (MAC: 2c:cf:67:61:05:f0)
Oct 02 21:10:11 volumio sudo[3785]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get
Oct 02 21:10:11 volumio sudo[3785]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:11 volumio sudo[3785]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:11 volumio sudo[3794]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan
Oct 02 21:10:11 volumio sudo[3794]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:11 volumio volumio[1325]: info: Received Get System Info
Oct 02 21:10:11 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 02 21:10:11 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 02 21:10:11 volumio volumio[1325]: info: Discovery: Getting this device information
Oct 02 21:10:11 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:11 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 02 21:10:11 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Oct 02 21:10:11 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Oct 02 21:10:12 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:12 volumio volumio5-onboarding[1581]: time=2026-10-02T21:10:12.484+03:00 level=INFO msg="service successfully established" component=discovery/localnet
Oct 02 21:10:13 volumio sudo[3794]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:13 volumio wireless.js[3750]: WIRELESS.JS - INFO: Regdomain already correct: RU
Oct 02 21:10:13 volumio wireless.js[3750]: WIRELESS.JS - INFO: netconfigured file not found, starting hotspot
Oct 02 21:10:13 volumio wireless.js[3750]: WIRELESS.JS - INFO: Single Network Mode: Ethernet active, maintaining WiFi scan capability
Oct 02 21:10:13 volumio wireless.js[3750]: WIRELESS.JS - INFO: SNM: Maintaining wlan0 UP without IP (scan mode)
Oct 02 21:10:13 volumio wireless.js[3750]: WIRELESS.JS - INFO: SNM: Users can configure WiFi via WebUI while ethernet is active
Oct 02 21:10:13 volumio sudo[3817]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up
Oct 02 21:10:13 volumio sudo[3817]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Oct 02 21:10:13 volumio sudo[3817]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:13 volumio sudo[3820]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0
Oct 02 21:10:13 volumio sudo[3820]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Oct 02 21:10:13 volumio sudo[3820]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:13 volumio wpa_supplicant[3823]: Successfully initialized wpa_supplicant
Oct 02 21:10:14 volumio wpa_supplicant[3823]: nl80211: kernel reports: Registration to specific type not supported
Oct 02 21:10:14 volumio wireless.js[3750]: WIRELESS.JS - INFO: SNM: Transition to scan mode completed in 3614ms
Oct 02 21:10:14 volumio wireless.js[3750]: WIRELESS.JS - INFO: SNM: wlan0 is UP without IP, scan capable
Oct 02 21:10:14 volumio wireless.js[3750]: Failed to connect to non-global ctrl_ifname: wlan0 error: No such file or directory
Oct 02 21:10:14 volumio wireless.js[3750]: WIRELESS.JS - INFO: Notified systemd about wireless ready
Oct 02 21:10:14 volumio kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled
Oct 02 21:10:14 volumio systemd[1]: Started wireless.service - Wireless Services.
Oct 02 21:10:14 volumio sudo[3748]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:14 volumio volumio[1325]: info: Received Get System Info
Oct 02 21:10:14 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 02 21:10:14 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 02 21:10:14 volumio volumio[1325]: info: Discovery: Getting this device information
Oct 02 21:10:14 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:14 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 02 21:10:14 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Oct 02 21:10:14 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Oct 02 21:10:15 volumio volumio5-onboarding[1581]: time=2026-10-02T21:10:15.353+03:00 level=INFO msg="service successfully established" component=discovery/localnet
Oct 02 21:10:19 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: wizard , reportWirelessConnection
Oct 02 21:10:19 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessInfo
Oct 02 21:10:19 volumio sudo[3843]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 02 21:10:19 volumio sudo[3843]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:19 volumio sudo[3843]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:20 volumio volumio[1325]: info: Discovery: Networking Restart detected, restarting advertisement and browsing
Oct 02 21:10:20 volumio volumio[1325]: info: Discovery: Restarting Advertising
Oct 02 21:10:20 volumio volumio[1325]: info: Discovery: Stopping existing advertisement
Oct 02 21:10:20 volumio volumio[1325]: info: Discovery: Restarting Browsing
Oct 02 21:10:20 volumio volumio[1325]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 02 21:10:20 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Oct 02 21:10:20 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork
Oct 02 21:10:20 volumio sudo[3850]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0
Oct 02 21:10:20 volumio sudo[3850]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:20 volumio sudo[3850]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:20 volumio sudo[3856]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Oct 02 21:10:20 volumio sudo[3856]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:20 volumio sudo[3856]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:20 volumio sudo[3863]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Oct 02 21:10:20 volumio sudo[3863]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:20 volumio sudo[3873]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 02 21:10:20 volumio sudo[3873]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:20 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Oct 02 21:10:20 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Oct 02 21:10:20 volumio sudo[3863]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:20 volumio sudo[3873]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:20 volumio sudo[3868]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Oct 02 21:10:20 volumio sudo[3868]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:20 volumio sudo[3877]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 02 21:10:20 volumio sudo[3877]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:20 volumio sudo[3877]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:20 volumio sudo[3868]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:20 volumio sudo[3881]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Oct 02 21:10:20 volumio sudo[3881]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:21 volumio volumio[1325]: info: Discovery: A device disappeared from network
Oct 02 21:10:21 volumio volumio[1325]: info: Discovery: A device disappeared from network
Oct 02 21:10:23 volumio sudo[3881]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart
Oct 02 21:10:24 volumio volumio[1325]: info: Refreshing Cached IP Addresses
Oct 02 21:10:24 volumio sudo[3899]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli
Oct 02 21:10:24 volumio sudo[3899]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:24 volumio sudo[3901]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 02 21:10:24 volumio sudo[3901]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:24 volumio sudo[3903]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 02 21:10:24 volumio sudo[3903]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:24 volumio sudo[3901]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:24 volumio sudo[3899]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:24 volumio sudo[3903]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:24 volumio sudo[3909]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 02 21:10:24 volumio sudo[3909]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:24 volumio sudo[3911]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 02 21:10:24 volumio sudo[3911]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:24 volumio sudo[3909]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:24 volumio sudo[3911]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:24 volumio volumio[1325]: info: Received Get System Info
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 02 21:10:24 volumio volumio[1325]: info: Discovery: Getting this device information
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Oct 02 21:10:24 volumio volumio[1325]: verbose: New Socket.io Connection to 192.168.1.18 from 192.168.1.59 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/150.0.0.0 YaBrowser/26.8.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 02 21:10:24 volumio volumio[1325]: info: Received Get System Info
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 02 21:10:24 volumio volumio[1325]: info: Discovery: Getting this device information
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:24 volumio volumio[1325]: info: Listing playlists
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork
Oct 02 21:10:24 volumio sudo[3918]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0
Oct 02 21:10:24 volumio sudo[3918]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:24 volumio sudo[3918]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:24 volumio sudo[3923]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Oct 02 21:10:24 volumio sudo[3923]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:24 volumio sudo[3923]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:24 volumio sudo[3936]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Oct 02 21:10:24 volumio sudo[3942]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 02 21:10:24 volumio sudo[3942]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:24 volumio sudo[3936]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:24 volumio sudo[3930]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0
Oct 02 21:10:24 volumio sudo[3942]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:24 volumio sudo[3930]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:24 volumio sudo[3936]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:24 volumio sudo[3930]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:24 volumio sudo[3944]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 02 21:10:24 volumio sudo[3944]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:24 volumio sudo[3944]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:24 volumio sudo[3948]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Oct 02 21:10:24 volumio sudo[3948]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:24 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Oct 02 21:10:25 volumio volumio[1325]: info: Discovery: Started advertising with name: Volumio
Oct 02 21:10:25 volumio volumio5-onboarding[1581]: time=2026-10-02T21:10:25.186+03:00 level=INFO msg="service successfully established" component=discovery/localnet
Oct 02 21:10:25 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Oct 02 21:10:26 volumio volumio[1325]: info: Discovery: adding c6002790-9293-427e-864b-396923918403
Oct 02 21:10:26 volumio volumio[1325]: info: Discovery: Found device Volumio
Oct 02 21:10:26 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:26 volumio volumio[1325]: info: Discovery: this is already registered, c6002790-9293-427e-864b-396923918403
Oct 02 21:10:26 volumio volumio[1325]: info: Discovery: Found device Volumio
Oct 02 21:10:26 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:26 volumio volumio[1325]: info: Discovery: this is already registered, c6002790-9293-427e-864b-396923918403
Oct 02 21:10:26 volumio volumio[1325]: info: Discovery: Found device Volumio
Oct 02 21:10:26 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:26 volumio volumio[1325]: info: Discovery: this is already registered, c6002790-9293-427e-864b-396923918403
Oct 02 21:10:26 volumio volumio[1325]: info: Discovery: Found device Volumio
Oct 02 21:10:26 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:26 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 02 21:10:26 volumio volumio[1325]: info: Received Get System Info
Oct 02 21:10:26 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 02 21:10:26 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 02 21:10:26 volumio volumio[1325]: info: Discovery: Getting this device information
Oct 02 21:10:26 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:26 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 02 21:10:26 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Oct 02 21:10:27 volumio sudo[3948]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:27 volumio volumio[1325]: info: Received Get System Info
Oct 02 21:10:27 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 02 21:10:27 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 02 21:10:27 volumio volumio[1325]: info: Discovery: Getting this device information
Oct 02 21:10:27 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:27 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 02 21:10:27 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Oct 02 21:10:27 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Oct 02 21:10:28 volumio volumio5-onboarding[1581]: time=2026-10-02T21:10:28.832+03:00 level=INFO msg="service successfully established" component=discovery/localnet
Oct 02 21:10:29 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:31 volumio volumio[1325]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 02 21:10:31 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Oct 02 21:10:31 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Oct 02 21:10:31 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Oct 02 21:10:31 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs
Oct 02 21:10:31 volumio volumio[1325]: info: Received Get System Version
Oct 02 21:10:31 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 02 21:10:34 volumio sudo[3992]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 02 21:10:34 volumio sudo[3992]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:34 volumio sudo[3994]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 02 21:10:34 volumio sudo[3994]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:34 volumio sudo[3994]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:34 volumio sudo[3992]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:34 volumio sudo[3998]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Oct 02 21:10:34 volumio sudo[3998]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:34 volumio sudo[3998]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:34 volumio volumio[1325]: info: Upmpdcli Daemon Started
Oct 02 21:10:34 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 02 21:10:37 volumio volumio[1325]: info: CALLMETHOD: system_controller system savePrivacySettings [object Object]
Oct 02 21:10:37 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , savePrivacySettings
Oct 02 21:10:37 volumio volumio[1325]: info: CoreCommandRouter::Reload Ui
Oct 02 21:10:37 volumio sudo[4002]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 02 21:10:37 volumio sudo[4002]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:37 volumio sudo[4002]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:37 volumio sudo[4003]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 02 21:10:37 volumio sudo[4003]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:37 volumio sudo[4003]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:37 volumio volumio[1325]: verbose: New Socket.io Connection to 192.168.1.18 from 192.168.1.59 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/150.0.0.0 YaBrowser/26.8.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
Oct 02 21:10:37 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 02 21:10:37 volumio volumio[1325]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 02 21:10:37 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 02 21:10:37 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:37 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Oct 02 21:10:37 volumio volumio[1325]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 02 21:10:37 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Oct 02 21:10:37 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 02 21:10:37 volumio volumio[1325]: info: Received Get System Info
Oct 02 21:10:37 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 02 21:10:37 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 02 21:10:37 volumio volumio[1325]: info: Discovery: Getting this device information
Oct 02 21:10:37 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:37 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 02 21:10:37 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:37 volumio volumio[1325]: info: Listing playlists
Oct 02 21:10:37 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Oct 02 21:10:37 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 02 21:10:38 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Oct 02 21:10:38 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Oct 02 21:10:38 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs
Oct 02 21:10:38 volumio volumio[1325]: info: Received Get System Version
Oct 02 21:10:38 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 02 21:10:38 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Oct 02 21:10:38 volumio volumio[1325]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/154.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
Oct 02 21:10:38 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 02 21:10:38 volumio volumio[1325]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 02 21:10:38 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 02 21:10:38 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:38 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Oct 02 21:10:38 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 02 21:10:38 volumio volumio[1325]: info: Received Get System Info
Oct 02 21:10:38 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 02 21:10:38 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 02 21:10:38 volumio volumio[1325]: info: Discovery: Getting this device information
Oct 02 21:10:38 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:38 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 02 21:10:38 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:38 volumio volumio[1325]: info: Listing playlists
Oct 02 21:10:38 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Oct 02 21:10:38 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 02 21:10:38 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Oct 02 21:10:39 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:39 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Oct 02 21:10:39 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 02 21:10:39 volumio volumio[1325]: info: Received Get System Info
Oct 02 21:10:39 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 02 21:10:39 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 02 21:10:39 volumio volumio[1325]: info: Discovery: Getting this device information
Oct 02 21:10:39 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:39 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 02 21:10:39 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Oct 02 21:10:40 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 02 21:10:40 volumio volumio[1325]: info: Received Get System Info
Oct 02 21:10:40 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 02 21:10:40 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 02 21:10:40 volumio volumio[1325]: info: Discovery: Getting this device information
Oct 02 21:10:40 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:40 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 02 21:10:40 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Oct 02 21:10:41 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 02 21:10:41 volumio volumio[1325]: info: Received Get System Info
Oct 02 21:10:41 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 02 21:10:41 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 02 21:10:41 volumio volumio[1325]: info: Discovery: Getting this device information
Oct 02 21:10:41 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:41 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 02 21:10:41 volumio volumio[1325]: info: CALLMETHOD: miscellanea appearance setVolumio3UI [object Object]
Oct 02 21:10:41 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: appearance , setVolumio3UI
Oct 02 21:10:41 volumio volumio[1325]: info: Setting active UI to: {"uiPrettyName":"Manifest","uiName":"manifest","uiPath":"/volumio/http/www4"}
Oct 02 21:10:42 volumio volumio[1325]: info: CoreCommandRouter::Reload Ui
Oct 02 21:10:42 volumio sudo[4051]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Oct 02 21:10:42 volumio sudo[4051]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:42 volumio sudo[4051]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:42 volumio sudo[4052]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Oct 02 21:10:42 volumio sudo[4052]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:42 volumio sudo[4052]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:42 volumio volumio[1325]: verbose: New Socket.io Connection to 192.168.1.18 from 192.168.1.59 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/150.0.0.0 YaBrowser/26.8.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
Oct 02 21:10:42 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 02 21:10:42 volumio volumio[1325]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 02 21:10:42 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 02 21:10:42 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:42 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Oct 02 21:10:42 volumio volumio[1325]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 02 21:10:42 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Oct 02 21:10:42 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 02 21:10:42 volumio volumio[1325]: info: Received Get System Info
Oct 02 21:10:42 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 02 21:10:42 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 02 21:10:42 volumio volumio[1325]: info: Discovery: Getting this device information
Oct 02 21:10:42 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:42 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 02 21:10:42 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:42 volumio volumio[1325]: info: Listing playlists
Oct 02 21:10:42 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Oct 02 21:10:42 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 02 21:10:42 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Oct 02 21:10:42 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Oct 02 21:10:42 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs
Oct 02 21:10:42 volumio volumio[1325]: info: Received Get System Version
Oct 02 21:10:42 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 02 21:10:42 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Oct 02 21:10:43 volumio volumio[1325]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/154.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
Oct 02 21:10:43 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Oct 02 21:10:43 volumio volumio[1325]: info: CoreCommandRouter::volumioGetVisibleSources
Oct 02 21:10:43 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 02 21:10:43 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:43 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Oct 02 21:10:43 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Oct 02 21:10:43 volumio volumio[1325]: info: Received Get System Info
Oct 02 21:10:43 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 02 21:10:43 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 02 21:10:43 volumio volumio[1325]: info: Discovery: Getting this device information
Oct 02 21:10:43 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:43 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 02 21:10:43 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:43 volumio volumio[1325]: info: Listing playlists
Oct 02 21:10:43 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Oct 02 21:10:43 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 02 21:10:43 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Oct 02 21:10:44 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:44 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:44 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Oct 02 21:10:44 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 02 21:10:44 volumio volumio[1325]: info: Received Get System Info
Oct 02 21:10:44 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 02 21:10:44 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 02 21:10:44 volumio volumio[1325]: info: Discovery: Getting this device information
Oct 02 21:10:44 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:44 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 02 21:10:44 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Oct 02 21:10:44 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Oct 02 21:10:44 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 02 21:10:44 volumio volumio[1325]: info: Received Get System Info
Oct 02 21:10:44 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 02 21:10:44 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 02 21:10:44 volumio volumio[1325]: info: Discovery: Getting this device information
Oct 02 21:10:44 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:44 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 02 21:10:45 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 02 21:10:45 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Oct 02 21:10:45 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 02 21:10:45 volumio volumio[1325]: info: Received Get System Info
Oct 02 21:10:45 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 02 21:10:45 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 02 21:10:45 volumio volumio[1325]: info: Discovery: Getting this device information
Oct 02 21:10:45 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:10:45 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 02 21:10:51 volumio volumio[1325]: info: Enabling plugin RoonBridge
Oct 02 21:10:51 volumio volumio[1325]: info: Loading plugin "RoonBridge"...
Oct 02 21:10:51 volumio volumio[1325]: info: PLUGIN START: RoonBridge
Oct 02 21:10:51 volumio sudo[4074]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service
Oct 02 21:10:51 volumio sudo[4074]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Oct 02 21:10:51 volumio sudo[4074]: pam_unix(sudo:session): session closed for user root
Oct 02 21:10:51 volumio volumio[1325]: error: Cannot start Roon Bridge Error: Command failed: /usr/bin/sudo /bin/systemctl start roonbridge.service
Oct 02 21:10:51 volumio volumio[1325]: Failed to start roonbridge.service: Unit roonbridge.service not found.
Oct 02 21:10:51 volumio volumio[1325]: info: Error: Error: Command failed: /usr/bin/sudo /bin/systemctl start roonbridge.service
Oct 02 21:10:51 volumio volumio[1325]: Failed to start roonbridge.service: Unit roonbridge.service not found.
Oct 02 21:10:52 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 02 21:10:53 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Oct 02 21:10:54 volumio volumio[1325]: info: CoreCommandRouter::getUIConfigOnPlugin
Oct 02 21:10:55 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 02 21:10:55 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Oct 02 21:10:55 volumio volumio[1325]: error: Cannot download Available plugins list: Error: ESOCKETTIMEDOUT
Oct 02 21:10:58 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:11:00 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Oct 02 21:11:00 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Oct 02 21:11:00 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Oct 02 21:11:00 volumio volumio[1325]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Oct 02 21:11:00 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Oct 02 21:11:00 volumio volumio[1325]: info: Received Get System Version
Oct 02 21:11:00 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 02 21:11:00 volumio volumio[1325]: info: Received Get System Info
Oct 02 21:11:00 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 02 21:11:00 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 02 21:11:00 volumio volumio[1325]: info: Discovery: Getting this device information
Oct 02 21:11:00 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:11:00 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 02 21:11:06 volumio volumio[1325]: error: Cannot download Available plugins list: Error: ESOCKETTIMEDOUT
Oct 02 21:11:06 volumio volumio[1325]: info: Enabling plugin rp2
Oct 02 21:11:06 volumio volumio[1325]: info: Loading plugin "rp2"...
Oct 02 21:11:07 volumio volumio[1325]: info: PLUGIN START: rp2
Oct 02 21:11:07 volumio volumio[1325]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Oct 02 21:11:07 volumio volumio[1325]: info: [1790964667160] CoreMusicLibrary::Adding element Radio Paradise (RP2)
Oct 02 21:11:07 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 02 21:11:07 volumio volumio[1325]: Cannot find translation for source Яндекс Музыка
Oct 02 21:11:07 volumio volumio[1325]: Cannot find translation for source Radio Paradise (RP2)
Oct 02 21:11:07 volumio volumio[1325]: info: Done.
Oct 02 21:11:07 volumio volumio[1325]: info: Enabling plugin radio_paradise
Oct 02 21:11:07 volumio volumio[1325]: info: Loading plugin "radio_paradise"...
Oct 02 21:11:07 volumio volumio[1325]: info: [1790964667361] [RadioParadise] API delay: 5
Oct 02 21:11:07 volumio volumio[1325]: info: PLUGIN START: radio_paradise
Oct 02 21:11:07 volumio volumio[1325]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Oct 02 21:11:07 volumio volumio[1325]: info: [1790964667363] CoreMusicLibrary::Adding element Radio Paradise
Oct 02 21:11:07 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Oct 02 21:11:07 volumio volumio[1325]: Cannot find translation for source Яндекс Музыка
Oct 02 21:11:07 volumio volumio[1325]: Cannot find translation for source Radio Paradise (RP2)
Oct 02 21:11:07 volumio volumio[1325]: Cannot find translation for source Radio Paradise
Oct 02 21:11:07 volumio volumio[1325]: info: Done.
Oct 02 21:11:11 volumio volumio[1325]: error: Cannot download Available plugins list: Error: ESOCKETTIMEDOUT
Oct 02 21:11:31 volumio volumio[1325]: info: CoreCommandRouter::volumioGetState
Oct 02 21:11:31 volumio volumio[1325]: info: CoreCommandRouter::volumioPlay
Oct 02 21:11:31 volumio volumio[1325]: info: CoreStateMachine::play index undefined
Oct 02 21:11:31 volumio volumio[1325]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 02 21:11:31 volumio volumio[1325]: info: CorePlayQueue::getTrack 0
Oct 02 21:11:31 volumio volumio[1325]: info: CoreStateMachine::startPlaybackTimer
Oct 02 21:11:31 volumio volumio[1325]: info: CorePlayQueue::getTrack 0
Oct 02 21:11:31 volumio volumio[1325]: verbose: ControllerMpd::sendMpdCommand stop
Oct 02 21:11:31 volumio volumio[1325]: info: sendMpdCommand stop took 0 milliseconds
Oct 02 21:11:31 volumio volumio[1325]: verbose: ControllerMpd::sendMpdCommand clear
Oct 02 21:11:31 volumio volumio[1325]: info:
Oct 02 21:11:31 volumio volumio[1325]: ---------------------------- MPD announces system playlist update
Oct 02 21:11:31 volumio volumio[1325]: info: Ignoring MPD Status Update
Oct 02 21:11:31 volumio volumio[1325]: info: sendMpdCommand clear took 0 milliseconds
Oct 02 21:11:31 volumio volumio[1325]: error: updateQueue error: null
Oct 02 21:11:31 volumio volumio[1325]: info: ------------------------------ 8ms
Oct 02 21:11:31 volumio volumio[1325]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fext-strm-rurov10ttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D23ed89fb728b1a4dbb303a2dc8c78bc877c4293efa6493a1cb8bcc564fa9be45%2Clid%3D1745%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6ace4829%2F0%2F910201%2F18e9cf64.226433800.5.155374635%2F320.mp3&ext=.mp3"
Oct 02 21:11:31 volumio volumio[1325]: info:
Oct 02 21:11:31 volumio volumio[1325]: ---------------------------- MPD announces system playlist update
Oct 02 21:11:31 volumio volumio[1325]: info: Ignoring MPD Status Update
Oct 02 21:11:31 volumio volumio[1325]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fext-strm-rurov10ttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D23ed89fb728b1a4dbb303a2dc8c78bc877c4293efa6493a1cb8bcc564fa9be45%2Clid%3D1745%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6ace4829%2F0%2F910201%2F18e9cf64.226433800.5.155374635%2F320.mp3&ext=.mp3" took 1 milliseconds
Oct 02 21:11:31 volumio volumio[1325]: verbose: MPD COMMAND [object Object]
Oct 02 21:11:31 volumio volumio[1325]: verbose: MPD COMMAND [object Object]
Oct 02 21:11:31 volumio volumio[1325]: verbose: MPD COMMAND [object Object]
Oct 02 21:11:31 volumio volumio[1325]: info:
Oct 02 21:11:31 volumio volumio[1325]: ---------------------------- MPD announces system playlist update
Oct 02 21:11:31 volumio volumio[1325]: info: Ignoring MPD Status Update
Oct 02 21:11:31 volumio volumio[1325]: info: ------------------------------ 2ms
Oct 02 21:11:31 volumio volumio[1325]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 02 21:11:31 volumio volumio[1325]: verbose: ControllerMpd::sendMpdCommand play
Oct 02 21:11:31 volumio volumio[1325]: info: ------------------------------ 1ms
Oct 02 21:11:31 volumio volumio[1325]: info: sendMpdCommand play took 2 milliseconds
Oct 02 21:11:32 volumio volumio[1325]: info: CoreCommandRouter::volumioGetQueue
Oct 02 21:11:32 volumio volumio[1325]: info: CoreStateMachine::getQueue
Oct 02 21:11:32 volumio volumio[1325]: info: CorePlayQueue::getQueue
Oct 02 21:11:34 volumio volumio[1325]: info:
Oct 02 21:11:34 volumio volumio[1325]: ---------------------------- MPD announces state update: player
Oct 02 21:11:34 volumio volumio[1325]: info: ControllerMpd::getState
Oct 02 21:11:34 volumio volumio[1325]: verbose: ControllerMpd::sendMpdCommand status
Oct 02 21:11:34 volumio volumio[1325]: info:
Oct 02 21:11:34 volumio volumio[1325]: ---------------------------- MPD announces state update: player
Oct 02 21:11:34 volumio volumio[1325]: error: MPD returned error for command status: Failed to open "alsa" (alsa); Failed to open ALSA device "volumio": Unknown error 524
Oct 02 21:11:34 volumio volumio[1325]: verbose: ControllerMpd::sendMpdCommand clearerror
Oct 02 21:11:34 volumio volumio[1325]: info: sendMpdCommand status took 11 milliseconds
Oct 02 21:11:34 volumio volumio[1325]: info: ControllerMpd::getState
Oct 02 21:11:34 volumio volumio[1325]: verbose: ControllerMpd::sendMpdCommand status
Oct 02 21:11:34 volumio volumio[1325]: verbose: ControllerMpd::parseState
Oct 02 21:11:34 volumio volumio[1325]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 02 21:11:34 volumio volumio[1325]: info: sendMpdCommand clearerror took 2 milliseconds
Oct 02 21:11:34 volumio volumio[1325]: info: sendMpdCommand status took 1 milliseconds
Oct 02 21:11:34 volumio volumio[1325]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 02 21:11:34 volumio volumio[1325]: verbose: ControllerMpd::parseState
Oct 02 21:11:34 volumio volumio[1325]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 02 21:11:34 volumio volumio[1325]: verbose: ControllerMpd::parseTrackInfo
Oct 02 21:11:34 volumio volumio[1325]: info: ControllerMpd::pushState
Oct 02 21:11:34 volumio volumio[1325]: info: CoreCommandRouter::servicePushState
Oct 02 21:11:34 volumio volumio[1325]: info: CorePlayQueue::getTrack 0
Oct 02 21:11:34 volumio volumio[1325]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":152,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Победа за мной","artist":"BEARWOLF","album":"Победа за мной","uri":"http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fext-strm-rurov10ttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D23ed89fb728b1a4dbb303a2dc8c78bc877c4293efa6493a1cb8bcc564fa9be45%2Clid%3D1745%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6ace4829%2F0%2F910201%2F18e9cf64.226433800.5.155374635%2F320.mp3&ext=.mp3","trackType":"mp3"}
Oct 02 21:11:34 volumio volumio[1325]: verbose: CURRENT POSITION 0
Oct 02 21:11:34 volumio volumio[1325]: info: CoreStateMachine::syncState stateService pause
Oct 02 21:11:34 volumio volumio[1325]: info: CoreStateMachine::syncState currentStatus stop
Oct 02 21:11:34 volumio volumio[1325]: info: CoreStateMachine::pushState
Oct 02 21:11:34 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 02 21:11:34 volumio volumio[1325]: info: CoreCommandRouter::volumioPushState
Oct 02 21:11:34 volumio volumio5-onboarding[1581]: time=2026-10-02T21:11:34.825+03:00 level=WARN msg="received unknown player status" component=volumio status=""
Oct 02 21:11:34 volumio volumio[1325]: info: ------------------------------ 28ms
Oct 02 21:11:34 volumio volumio[1325]: info: sendMpdCommand playlistinfo took 20 milliseconds
Oct 02 21:11:34 volumio volumio[1325]: verbose: ControllerMpd::parseTrackInfo
Oct 02 21:11:34 volumio volumio[1325]: info: ControllerMpd::pushState
Oct 02 21:11:34 volumio volumio[1325]: info: CoreCommandRouter::servicePushState
Oct 02 21:11:34 volumio volumio[1325]: info: CorePlayQueue::getTrack 0
Oct 02 21:11:34 volumio volumio[1325]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":152,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Победа за мной","artist":"BEARWOLF","album":"Победа за мной","uri":"http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fext-strm-rurov10ttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D23ed89fb728b1a4dbb303a2dc8c78bc877c4293efa6493a1cb8bcc564fa9be45%2Clid%3D1745%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6ace4829%2F0%2F910201%2F18e9cf64.226433800.5.155374635%2F320.mp3&ext=.mp3","trackType":"mp3"}
Oct 02 21:11:34 volumio volumio[1325]: verbose: CURRENT POSITION 0
Oct 02 21:11:34 volumio volumio[1325]: info: CoreStateMachine::syncState stateService pause
Oct 02 21:11:34 volumio volumio[1325]: info: CoreStateMachine::syncState currentStatus stop
Oct 02 21:11:34 volumio volumio[1325]: info: CoreStateMachine::pushState
Oct 02 21:11:34 volumio volumio[1325]: info: CoreCommandRouter::volumioPushState
Oct 02 21:11:34 volumio volumio5-onboarding[1581]: time=2026-10-02T21:11:34.844+03:00 level=WARN msg="received unknown player status" component=volumio status=""
Oct 02 21:11:34 volumio volumio[1325]: info: ------------------------------ 37ms
Oct 02 21:11:34 volumio volumio[1325]: warn: glass: pushState: no status
Oct 02 21:11:37 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Oct 02 21:11:37 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Oct 02 21:11:37 volumio volumio[1325]: info: Preload queue cleared
Oct 02 21:11:41 volumio volumio[1325]: info: CoreCommandRouter::executeOnPlugin: rp2 , handleBrowseUri
Oct 02 21:11:43 volumio volumio[1325]: info: Preload queue cleared
Oct 02 21:11:46 volumio volumio[1325]: info: Preload queue cleared
Oct 02 21:11:46 volumio volumio[1325]: info: CoreCommandRouter::volumioReplaceandPlayItems
Oct 02 21:11:46 volumio volumio[1325]: info: CoreStateMachine::ClearQueue
Oct 02 21:11:46 volumio volumio[1325]: info: CoreStateMachine::stop
Oct 02 21:11:46 volumio volumio[1325]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 02 21:11:46 volumio volumio[1325]: info: CorePlayQueue::clearPlayQueue
Oct 02 21:11:46 volumio volumio[1325]: info: CorePlayQueue::saveQueue
Oct 02 21:11:46 volumio volumio[1325]: info: CoreCommandRouter::volumioPushQueue
Oct 02 21:11:46 volumio volumio[1325]: info: CoreStateMachine::addQueueItems
Oct 02 21:11:46 volumio volumio[1325]: info: CorePlayQueue::addQueueItems
Oct 02 21:11:46 volumio volumio[1325]: info: Preload queue cleared
Oct 02 21:11:46 volumio volumio[1325]: info: Adding Item to queue: rp2/channel@qi=%7B%22service%22%3A%22rp2%22%2C%22uri%22%3A%22rp2%2Fchannel%40id%3D0%22%2C%22name%22%3A%22The%20Main%20Mix%22%2C%22title%22%3A%22The%20Main%20Mix%22%2C%22artist%22%3A%22Radio%20Paradise%22%2C%22albumart%22%3A%22https%3A%2F%2Fimg.radioparadise.com%2Fchannels%2F0%2F0%2Fcover_512x512%2F0.jpg%22%7D
Oct 02 21:11:46 volumio volumio[1325]: info: Exploding uri rp2/channel@qi=%7B%22service%22%3A%22rp2%22%2C%22uri%22%3A%22rp2%2Fchannel%40id%3D0%22%2C%22name%22%3A%22The%20Main%20Mix%22%2C%22title%22%3A%22The%20Main%20Mix%22%2C%22artist%22%3A%22Radio%20Paradise%22%2C%22albumart%22%3A%22https%3A%2F%2Fimg.radioparadise.com%2Fchannels%2F0%2F0%2Fcover_512x512%2F0.jpg%22%7D in service rp2
Oct 02 21:11:46 volumio volumio[1325]: info: CoreCommandRouter::volumioPushQueue
Oct 02 21:11:46 volumio volumio[1325]: info: CorePlayQueue::saveQueue
Oct 02 21:11:46 volumio volumio[1325]: info: CoreStateMachine::updateTrackBlock
Oct 02 21:11:46 volumio volumio[1325]: info: CorePlayQueue::getTrackBlock
Oct 02 21:11:46 volumio volumio[1325]: info: CoreCommandRouter::volumioPlay
Oct 02 21:11:46 volumio volumio[1325]: info: CoreStateMachine::play index 0
Oct 02 21:11:46 volumio volumio[1325]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 02 21:11:46 volumio volumio[1325]: info: CoreStateMachine::stop
Oct 02 21:11:46 volumio volumio[1325]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 02 21:11:46 volumio volumio[1325]: info: CoreStateMachine::play index undefined
Oct 02 21:11:46 volumio volumio[1325]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 02 21:11:46 volumio volumio[1325]: info: CorePlayQueue::getTrack 0
Oct 02 21:11:46 volumio volumio[1325]: info: CoreStateMachine::startPlaybackTimer
Oct 02 21:11:46 volumio volumio[1325]: info: CorePlayQueue::getTrack 0
Oct 02 21:11:46 volumio volumio[1325]: info: [rp2] clearAddPlayTrack: rp2/channel@id=0
Oct 02 21:11:47 volumio volumio[1325]: verbose: [rp2] API: https://api.radioparadise.com/api/play?source=24&event=0&elapsed=0&bitrate=4&action=start&player_id=********&info=true&chan=0&audio_type=
Oct 02 21:11:48 volumio volumio[1325]: info: [rp2] Obtained block for channel "0"
Oct 02 21:11:48 volumio volumio[1325]: info: [rp2] -------------
Oct 02 21:11:48 volumio volumio[1325]: info: [rp2] Block summary
Oct 02 21:11:48 volumio volumio[1325]: info: [rp2] -------------
Oct 02 21:11:48 volumio volumio[1325]: info: [rp2] Stream URL: https://audio.radioparadise.stream/audio/blocks/0/x/2173/4/b/2173-0.flac
Oct 02 21:11:48 volumio volumio[1325]: info: [rp2] Tracks:
Oct 02 21:11:48 volumio volumio[1325]: info: [rp2] 0. Keep Your Nose Clean (3:41 | elapsed: 20m 20s)
Oct 02 21:11:48 volumio volumio[1325]: info: [rp2] 1. Another thing that I'm supposed to do (and I don't want to) (3:14 | elapsed: 24m 2s)
Oct 02 21:11:48 volumio volumio[1325]: info: [rp2] 2. Burning Out (3:13 | elapsed: 27m 17s)
Oct 02 21:11:48 volumio volumio[1325]: info: [rp2]
Oct 02 21:11:48 volumio volumio[1325]: verbose: [rp2] Current track scheduled playback vs. current time: 10/2/2026, 9:08:31 PM <-> 10/2/2026, 9:11:48 PM
Oct 02 21:11:48 volumio volumio[1325]: info: [rp2] Going to start playback of current track at 3:17 (track position in stream: 20:20)
Oct 02 21:11:48 volumio volumio[1325]: info: [rp2] Starting mpv
Oct 02 21:11:48 volumio volumio[1325]: /bin/sh: 1: mpv: not found
Oct 02 21:11:48 volumio volumio[1325]: error: [rp2] [mpv] Failed to get mpv version: Command failed: mpv --version
Oct 02 21:11:48 volumio volumio[1325]: /bin/sh: 1: mpv: not found
Oct 02 21:11:48 volumio volumio[1325]: info: [rp2] [mpv] mpv process spawned
Oct 02 21:11:48 volumio volumio[1325]: verbose: [rp2] Waiting for player event "playing"...
Oct 02 21:11:48 volumio volumio[1325]: info: [rp2] [mpv] (PID: 4183) /bin/sh: 1: mpv: not found
Oct 02 21:11:48 volumio volumio[1325]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 02 21:11:48 volumio volumio[1325]: TypeError: Cannot read properties of null (reading 'reset')
Oct 02 21:11:48 volumio volumio[1325]: at /data/plugins/music_service/rp2/node_modules/volumio-ext-players/dist/mpv/MPVService.js:207:48
Oct 02 21:11:48 volumio volumio[1325]: at ChildProcess. (/data/plugins/music_service/rp2/node_modules/volumio-ext-players/dist/mpv/MPVService.js:221:19)
Oct 02 21:11:48 volumio volumio[1325]: at ChildProcess.emit (node:events:514:28)
Oct 02 21:11:48 volumio volumio[1325]: at maybeClose (node:internal/child_process:1105:16)
Oct 02 21:11:48 volumio volumio[1325]: at Socket. (node:internal/child_process:457:11)
Oct 02 21:11:48 volumio volumio[1325]: at Socket.emit (node:events:514:28)
Oct 02 21:11:48 volumio volumio[1325]: at Pipe. (node:net:337:12)
Oct 02 21:11:48 volumio volumio[1325]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 02 21:11:48 volumio sudo[4198]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-02 21:10'
Oct 02 21:11:48 volumio sudo[4198]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026"
VOLUMIO_VERSION="4.119"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"