Feb 25 02:00:01 volumio systemd[1]: firststart.service: Deactivated successfully. Feb 25 02:00:01 volumio systemd[1]: firststart.service: Consumed 2.752s CPU time. Feb 25 02:00:02 volumio upmpdcli[1731]: :2:../src/mpdcli.cxx:113::MPDCli::openconn: mpd_connection_new failed: Timeout Feb 25 02:00:02 volumio upmpdcli[1731]: :2:../src/main.cxx:728::MPD connection failed Feb 25 02:00:02 volumio volumio5-onboarding[1693]: time=2026-02-25T01:00:02.102Z level=INFO msg="running volumio5-device-gateway" version=30d1950e+CHANGES buildDate=2026-01-29T13:10:08Z Feb 25 02:00:02 volumio volumio[1047]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Feb 25 02:00:02 volumio dbus-daemon[758]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.17' (uid=0 pid=1693 comm="/usr/bin/volumio5-onboarding") Feb 25 02:00:02 volumio systemd[1]: Starting bluetooth.service - Bluetooth service... Feb 25 02:00:02 volumio kernel: Bluetooth: Core ver 2.22 Feb 25 02:00:02 volumio kernel: NET: Registered PF_BLUETOOTH protocol family Feb 25 02:00:02 volumio kernel: Bluetooth: HCI device and connection manager initialized Feb 25 02:00:02 volumio kernel: Bluetooth: HCI socket layer initialized Feb 25 02:00:02 volumio kernel: Bluetooth: L2CAP socket layer initialized Feb 25 02:00:02 volumio kernel: Bluetooth: SCO socket layer initialized Feb 25 02:00:02 volumio bluetoothd[1846]: Bluetooth daemon 5.83 Feb 25 02:00:02 volumio dbus-daemon[758]: [system] Successfully activated service 'org.bluez' Feb 25 02:00:02 volumio systemd[1]: Started bluetooth.service - Bluetooth service. Feb 25 02:00:02 volumio bluetoothd[1846]: Starting SDP server Feb 25 02:00:02 volumio bluetoothd[1846]: Excluding (cli) sap Feb 25 02:00:02 volumio bluetoothd[1846]: Excluding (cli) midi Feb 25 02:00:02 volumio bluetoothd[1846]: Excluding (cli) battery Feb 25 02:00:02 volumio kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Feb 25 02:00:02 volumio kernel: Bluetooth: BNEP filters: protocol multicast Feb 25 02:00:02 volumio kernel: Bluetooth: BNEP socket layer initialized Feb 25 02:00:02 volumio bluetoothd[1846]: Bluetooth management interface 1.23 initialized Feb 25 02:00:02 volumio dbus-daemon[758]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.18' (uid=0 pid=1846 comm="/usr/libexec/bluetooth/bluetoothd --noplugin=sap,b") Feb 25 02:00:02 volumio volumio5-onboarding[1693]: time=2026-02-25T01:00:02.878Z level=WARN msg="failed to enable Bluetooth adapter" adapter=hci0 error="bluetooth: adapter /org/bluez/hci0 does not exist" Feb 25 02:00:02 volumio volumio5-onboarding[1693]: time=2026-02-25T01:00:02.879Z level=WARN msg="failed to enable Bluetooth adapter" adapter=hci1 error="bluetooth: adapter /org/bluez/hci1 does not exist" Feb 25 02:00:02 volumio volumio5-onboarding[1693]: time=2026-02-25T01:00:02.880Z level=WARN msg="failed to enable Bluetooth adapter" adapter=hci2 error="bluetooth: adapter /org/bluez/hci2 does not exist" Feb 25 02:00:02 volumio volumio5-onboarding[1693]: time=2026-02-25T01:00:02.886Z level=WARN msg="failed to enable Bluetooth adapter" adapter=hci3 error="bluetooth: adapter /org/bluez/hci3 does not exist" Feb 25 02:00:02 volumio volumio5-onboarding[1693]: time=2026-02-25T01:00:02.887Z level=WARN msg="failed to enable Bluetooth adapter" adapter=hci4 error="bluetooth: adapter /org/bluez/hci4 does not exist" Feb 25 02:00:02 volumio volumio5-onboarding[1693]: time=2026-02-25T01:00:02.887Z level=WARN msg="no Bluetooth adapter found, BLE discovery disabled" Feb 25 02:00:02 volumio volumio[1047]: info: Received Get System Info Feb 25 02:00:02 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 02:00:02 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 02:00:02 volumio volumio[1047]: info: Discovery: Getting this device information Feb 25 02:00:02 volumio volumio[1047]: info: CoreCommandRouter::volumioGetState Feb 25 02:00:02 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:00:02 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 02:00:02 volumio volumio5-onboarding[1693]: time=2026-02-25T01:00:02.901Z level=INFO msg="system info for aa868d5415a1e9b3205a6b49f2c5b49b" deviceName=Volumio deviceVariant=volumio deviceModel= softwareVersion=4.096 Feb 25 02:00:02 volumio volumio[1047]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 7 Feb 25 02:00:02 volumio volumio[1047]: info: Received Get System Info Feb 25 02:00:02 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 02:00:02 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 02:00:02 volumio volumio[1047]: info: Discovery: Getting this device information Feb 25 02:00:02 volumio volumio[1047]: info: CoreCommandRouter::volumioGetState Feb 25 02:00:02 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:00:02 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 02:00:02 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 25 02:00:02 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 25 02:00:02 volumio systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Feb 25 02:00:02 volumio volumio5-onboarding[1693]: time=2026-02-25T01:00:02.936Z level=INFO msg="enabling local network discovery" Feb 25 02:00:02 volumio volumio5-onboarding[1693]: time=2026-02-25T01:00:02.963Z level=INFO msg="bootstrapping state" hasInternet=true Feb 25 02:00:02 volumio volumio[1047]: info: Received Get System Info Feb 25 02:00:02 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 02:00:02 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 02:00:02 volumio volumio[1047]: info: Discovery: Getting this device information Feb 25 02:00:02 volumio volumio[1047]: info: CoreCommandRouter::volumioGetState Feb 25 02:00:02 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:00:02 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 02:00:02 volumio volumio-remote-updater[768]: Test mode disabled Feb 25 02:00:02 volumio volumio-remote-updater[768]: Alpha mode disabled Feb 25 02:00:02 volumio volumio-remote-updater[768]: Alpha legacy test mode disabled Feb 25 02:00:03 volumio dbus-daemon[758]: [system] Successfully activated service 'org.freedesktop.hostname1' Feb 25 02:00:03 volumio systemd[1]: Started systemd-hostnamed.service - Hostname Service. Feb 25 02:00:03 volumio volumio[1047]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 25 02:00:03 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 25 02:00:03 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 25 02:00:03 volumio volumio5-onboarding[1693]: time=2026-02-25T01:00:03.219Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=tidal error="could not open plugin config file for \"tidal\": open /data/configuration/music_service/tidal/config.json: no such file or directory" Feb 25 02:00:03 volumio volumio5-onboarding[1693]: time=2026-02-25T01:00:03.219Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=qobuz error="could not open plugin config file for \"qobuz\": open /data/configuration/music_service/qobuz/config.json: no such file or directory" Feb 25 02:00:03 volumio volumio5-onboarding[1693]: time=2026-02-25T01:00:03.219Z level=WARN msg="could not read username/password data for music provider" component=volumio provider=hi_res_audio error="could not open plugin config file for \"hi_res_audio\": open /data/configuration/music_service/hi_res_audio/config.json: no such file or directory" Feb 25 02:00:03 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 25 02:00:03 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 25 02:00:04 volumio volumio[1047]: info: Discovery: Networking Restart detected, restarting advertisement and browsing Feb 25 02:00:04 volumio volumio[1047]: info: Discovery: Restarting Advertising Feb 25 02:00:04 volumio volumio[1047]: info: Discovery: Stopping existing advertisement Feb 25 02:00:04 volumio volumio[1047]: info: Discovery: Restarting Browsing Feb 25 02:00:05 volumio volumio[1047]: info: Discovery: A device disappeared from network Feb 25 02:00:05 volumio volumio[1047]: info: Discovery: Device volumio disappeared from network Feb 25 02:00:05 volumio volumio[1047]: info: Discovery: A device disappeared from network Feb 25 02:00:05 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 25 02:00:05 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 02:00:05 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 25 02:00:05 volumio volumio[1047]: error: Plugin music_service mpd failed to complete 'onStart' in a timely fashion Feb 25 02:00:05 volumio volumio[1047]: info: ------------------------------------------- Feb 25 02:00:05 volumio volumio[1047]: info: ----- MyVolumio plugins startup ---- Feb 25 02:00:05 volumio volumio[1047]: info: ------------------------------------------- Feb 25 02:00:05 volumio volumio[1047]: info: [MyVolumio PluginManager] Fetching plans data.... Feb 25 02:00:06 volumio upmpdcli[1731]: :2:../src/mpdcli.cxx:113::MPDCli::openconn: mpd_connection_new failed: Timeout Feb 25 02:00:06 volumio upmpdcli[1731]: :2:../src/main.cxx:728::MPD connection failed Feb 25 02:00:07 volumio sudo[1921]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 25 02:00:07 volumio sudo[1921]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:07 volumio sudo[1920]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 25 02:00:07 volumio sudo[1920]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:07 volumio sudo[1921]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:07 volumio sudo[1920]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:07 volumio volumio[1047]: verbose: New Socket.io Connection to 192.168.68.82 from 192.168.68.200 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.2 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 6 Feb 25 02:00:07 volumio volumio[1047]: info: CoreCommandRouter::volumioGetVisibleSources Feb 25 02:00:07 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 02:00:07 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Feb 25 02:00:08 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Feb 25 02:00:08 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Feb 25 02:00:08 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Feb 25 02:00:08 volumio volumio[1047]: info: Received Get System Info Feb 25 02:00:08 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 02:00:08 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 02:00:08 volumio volumio[1047]: info: Discovery: Getting this device information Feb 25 02:00:08 volumio volumio[1047]: info: CoreCommandRouter::volumioGetState Feb 25 02:00:08 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:00:08 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 02:00:08 volumio volumio-remote-updater[768]: Test mode disabled Feb 25 02:00:08 volumio volumio-remote-updater[768]: Alpha mode disabled Feb 25 02:00:08 volumio volumio-remote-updater[768]: Alpha legacy test mode disabled Feb 25 02:00:08 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:00:08 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 25 02:00:08 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 25 02:00:08 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 25 02:00:09 volumio volumio[1047]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 25 02:00:09 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 25 02:00:09 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Feb 25 02:00:09 volumio volumio[1047]: info: Loading i18n strings for locale ru Feb 25 02:00:09 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Feb 25 02:00:09 volumio volumio[1047]: info: Setting timezone to Europe/Belgrade Feb 25 02:00:09 volumio sudo[1931]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Feb 25 02:00:09 volumio sudo[1931]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:09 volumio sudo[1931]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:09 volumio sudo[1935]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Belgrade /etc/localtime Feb 25 02:00:09 volumio sudo[1935]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:09 volumio sudo[1935]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:09 volumio sudo[1939]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Feb 25 02:00:09 volumio sudo[1939]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:12 volumio sudo[1939]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:12 volumio upmpdcli[1731]: :2:../src/mpdcli.cxx:113::MPDCli::openconn: mpd_connection_new failed: Timeout Feb 25 02:00:12 volumio upmpdcli[1731]: :2:../src/main.cxx:728::MPD connection failed Feb 25 02:00:12 volumio sudo[1945]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Belgrade Feb 25 02:00:12 volumio sudo[1945]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:12 volumio dbus-daemon[758]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.20' (uid=0 pid=1946 comm="/usr/bin/timedatectl set-timezone Europe/Belgrade") Feb 25 02:00:12 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Feb 25 02:00:12 volumio dbus-daemon[758]: [system] Successfully activated service 'org.freedesktop.timedate1' Feb 25 02:00:12 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Feb 25 02:00:12 volumio sudo[1945]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:12 volumio volumio[1047]: info: Discovery: Started advertising with name: Volumio Feb 25 02:00:12 volumio volumio[1047]: info: Discovery: adding 31968723-20fd-466f-94af-ec6794d78d2c Feb 25 02:00:12 volumio volumio[1047]: info: Discovery: Found device Volumio3 Feb 25 02:00:12 volumio volumio[1047]: info: Discovery: adding 00e2faf5-cd61-4550-9211-cac7fffc8d5b Feb 25 02:00:12 volumio volumio[1047]: info: Discovery: Found device Volumio4 Feb 25 02:00:12 volumio volumio[1047]: Updating browse sources language Feb 25 02:00:12 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 02:00:12 volumio mpd[1703]: 2026-02-25T02:00:12 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 25 02:00:12 volumio mpd[1703]: 2026-02-25T02:00:12 exception: Database corrupted Feb 25 02:00:12 volumio systemd[1]: Started mpd.service - Music Player Daemon. Feb 25 02:00:12 volumio sudo[1616]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:12 volumio sudo[1628]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:13 volumio volumio[1047]: error: MPD error: The expression evaluated to a falsy value: Feb 25 02:00:13 volumio volumio[1047]: assert.ok(self.idling) Feb 25 02:00:13 volumio volumio[1047]: error: The expression evaluated to a falsy value: Feb 25 02:00:13 volumio volumio[1047]: assert.ok(self.idling) Feb 25 02:00:14 volumio volumio[1047]: verbose: ControllerMpd::sendMpdCommand status Feb 25 02:00:14 volumio volumio[1047]: info: Feb 25 02:00:14 volumio volumio[1047]: ---------------------------- MPD announces state update: update Feb 25 02:00:14 volumio volumio[1047]: info: ControllerMpd::getState Feb 25 02:00:14 volumio volumio[1047]: verbose: ControllerMpd::sendMpdCommand status Feb 25 02:00:14 volumio volumio[1047]: info: MPD running with PID1703 Feb 25 02:00:14 volumio volumio[1047]: ,establishing connection Feb 25 02:00:14 volumio volumio[1047]: verbose: New Socket.io Connection to 192.168.68.82:3000 from 192.168.68.19 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Feb 25 02:00:14 volumio volumio[1047]: verbose: New Socket.io Connection to 192.168.68.82:3000 from 192.168.68.19 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Feb 25 02:00:14 volumio volumio[1047]: verbose: New Socket.io Connection to 192.168.68.82:3000 from 192.168.68.77 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 25 02:00:14 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Feb 25 02:00:14 volumio volumio[1047]: info: CoreCommandRouter::volumioGetState Feb 25 02:00:14 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:00:14 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Feb 25 02:00:14 volumio volumio[1047]: info: Discovery: adding 030204bd-faf7-45f9-91a2-4f75b0cb3084 Feb 25 02:00:14 volumio volumio[1047]: info: Discovery: Found device Volumio Feb 25 02:00:14 volumio volumio[1047]: info: CoreCommandRouter::volumioGetState Feb 25 02:00:14 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:00:14 volumio volumio[1047]: info: CoreCommandRouter::volumioGetState Feb 25 02:00:14 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:00:14 volumio volumio[1047]: info: Discovery: this is already registered, 030204bd-faf7-45f9-91a2-4f75b0cb3084 Feb 25 02:00:14 volumio volumio[1047]: info: Discovery: Found device Volumio Feb 25 02:00:14 volumio volumio[1047]: info: CoreCommandRouter::volumioGetState Feb 25 02:00:14 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:00:14 volumio volumio[1047]: info: Discovery: this is already registered, 030204bd-faf7-45f9-91a2-4f75b0cb3084 Feb 25 02:00:14 volumio volumio[1047]: info: Discovery: Found device Volumio Feb 25 02:00:14 volumio volumio[1047]: info: CoreCommandRouter::volumioGetState Feb 25 02:00:14 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:00:14 volumio volumio[1047]: info: Discovery: this is already registered, 030204bd-faf7-45f9-91a2-4f75b0cb3084 Feb 25 02:00:14 volumio volumio[1047]: info: Discovery: Found device Volumio Feb 25 02:00:14 volumio volumio[1047]: info: CoreCommandRouter::volumioGetState Feb 25 02:00:14 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Feb 25 02:00:15 volumio volumio[1047]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Feb 25 02:00:15 volumio volumio[1047]: info: Adding plugin bluetooth to MyMusic Plugins Feb 25 02:00:15 volumio volumio[1047]: info: Adding plugin multiroom to MyMusic Plugins Feb 25 02:00:17 volumio volumio[1047]: info: Adding plugin metavolumio to MyMusic Plugins Feb 25 02:00:17 volumio volumio[1047]: info: Adding plugin cd_controller to MyMusic Plugins Feb 25 02:00:19 volumio volumio[1047]: info: Adding plugin qobuzconnect to MyMusic Plugins Feb 25 02:00:19 volumio volumio[1047]: info: Adding plugin smart_inputs to MyMusic Plugins Feb 25 02:00:19 volumio volumio[1047]: info: Adding plugin tidalconnect to MyMusic Plugins Feb 25 02:00:19 volumio volumio[1047]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Feb 25 02:00:21 volumio volumio[1047]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Feb 25 02:00:21 volumio volumio[1047]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Feb 25 02:00:21 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 02:00:21 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 02:00:21 volumio volumio[1047]: info: Starting MyVolumio Remote Streaming Endpoints Feb 25 02:00:21 volumio volumio[1047]: info: MyVolumio not started Feb 25 02:00:21 volumio volumio[1047]: info: Initializing device activation check Feb 25 02:00:21 volumio volumio[1047]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Feb 25 02:00:21 volumio volumio[1047]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Feb 25 02:00:22 volumio upmpdcli[1995]: writing RSA key Feb 25 02:00:23 volumio volumio[1047]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Feb 25 02:00:23 volumio volumio[1047]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Feb 25 02:00:23 volumio volumio[1047]: info: Streaming services startup Feb 25 02:00:23 volumio volumio[1047]: info: Starting Streaming Daemon Feb 25 02:00:23 volumio volumio[1047]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Feb 25 02:00:23 volumio volumio[1047]: error: MPD error: The expression evaluated to a falsy value: Feb 25 02:00:23 volumio volumio[1047]: assert.ok(self.idling) Feb 25 02:00:23 volumio volumio[1047]: error: The expression evaluated to a falsy value: Feb 25 02:00:23 volumio volumio[1047]: assert.ok(self.idling) Feb 25 02:00:23 volumio volumio[1047]: error: MPD error: The expression evaluated to a falsy value: Feb 25 02:00:23 volumio volumio[1047]: assert.ok(self.idling) Feb 25 02:00:23 volumio volumio[1047]: error: The expression evaluated to a falsy value: Feb 25 02:00:23 volumio volumio[1047]: assert.ok(self.idling) Feb 25 02:00:24 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Feb 25 02:00:24 volumio volumio[1047]: info: Loading i18n strings for locale ru Feb 25 02:00:24 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Feb 25 02:00:24 volumio volumio[1047]: info: Setting timezone to Europe/Belgrade Feb 25 02:00:24 volumio sudo[2013]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Feb 25 02:00:24 volumio sudo[2013]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:24 volumio sudo[2013]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:24 volumio sudo[2003]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 25 02:00:24 volumio sudo[2003]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:24 volumio sudo[2019]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Belgrade /etc/localtime Feb 25 02:00:24 volumio sudo[2019]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:24 volumio sudo[2003]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:24 volumio sudo[2019]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:24 volumio sudo[2023]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Feb 25 02:00:24 volumio sudo[2023]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:24 volumio sudo[2023]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:24 volumio sudo[2027]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Belgrade Feb 25 02:00:24 volumio sudo[2027]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:24 volumio sudo[2027]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:24 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Feb 25 02:00:24 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Feb 25 02:00:24 volumio volumio[1047]: verbose: ControllerMpd::sendMpdCommand status Feb 25 02:00:24 volumio volumio[1047]: info: Feb 25 02:00:24 volumio volumio[1047]: ---------------------------- MPD announces state update: update Feb 25 02:00:24 volumio volumio[1047]: error: updateQueue error: null Feb 25 02:00:24 volumio volumio[1047]: info: ControllerMpd::getState Feb 25 02:00:24 volumio volumio[1047]: verbose: ControllerMpd::sendMpdCommand status Feb 25 02:00:24 volumio volumio[1047]: info: sendMpdCommand status took 10144 milliseconds Feb 25 02:00:24 volumio volumio[1047]: info: sendMpdCommand status took 10142 milliseconds Feb 25 02:00:24 volumio volumio[1047]: verbose: ControllerMpd::parseState Feb 25 02:00:24 volumio sudo[2030]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 25 02:00:24 volumio sudo[2030]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:26 volumio sudo[2030]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:33 volumio systemd[1]: systemd-hostnamed.service: Deactivated successfully. Feb 25 02:00:47 volumio volumio[1047]: info: Command Router : Notfying DB Updatefalse Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::Close All Modals sent Feb 25 02:00:47 volumio volumio[1047]: verbose: ControllerMpd::parseState Feb 25 02:00:47 volumio volumio[1047]: info: ControllerMpd::pushState Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::servicePushState Feb 25 02:00:47 volumio volumio[1047]: info: CoreStateMachine::pushState Feb 25 02:00:47 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::volumioPushState Feb 25 02:00:47 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:00:47 volumio volumio[1047]: 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} Feb 25 02:00:47 volumio volumio[1047]: verbose: CURRENT POSITION 0 Feb 25 02:00:47 volumio volumio[1047]: info: CoreStateMachine::syncState stateService stop Feb 25 02:00:47 volumio volumio[1047]: info: CoreStateMachine::syncState currentStatus stop Feb 25 02:00:47 volumio volumio[1047]: info: CoreStateMachine::pushState Feb 25 02:00:47 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::volumioPushState Feb 25 02:00:47 volumio volumio[1047]: info: No code Feb 25 02:00:47 volumio volumio[1047]: info: CoreStateMachine::pushState Feb 25 02:00:47 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::volumioPushState Feb 25 02:00:47 volumio volumio[1047]: info: ------------------------------ 33471ms Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 25 02:00:47 volumio volumio[1047]: info: Fetching Streaming Services browse cache Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::volumioGetBrowseSources Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 25 02:00:47 volumio volumio[1047]: error: MyVolumio Plugin failed to authenticate in a timely fashion Feb 25 02:00:47 volumio volumio[1047]: info: Completed starting MyVolumio Plugin Feb 25 02:00:47 volumio volumio[1047]: [Metrics] CommandRouter: 84s 7.92ms Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::volumiosetStartupVolume Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::Close All Modals sent Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::Close All Modals sent Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 25 02:00:47 volumio volumio[1047]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 25 02:00:47 volumio volumio[1047]: info: Received Get System Version Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 25 02:00:47 volumio volumio[1047]: info: Received Get System Info Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 02:00:47 volumio volumio[1047]: info: Discovery: Getting this device information Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::volumioGetState Feb 25 02:00:47 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 02:00:47 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Feb 25 02:00:48 volumio volumio[1047]: aplay: device_list:274: no soundcards found... Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:00:48 volumio volumio[1047]: info: Retrieving Cloud Streaming UI Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:00:48 volumio volumio[1047]: info: Retrieving Cloud Streaming UI Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:00:48 volumio volumio[1047]: info: Retrieving Cloud Streaming UI Feb 25 02:00:48 volumio volumio[1047]: error: updateQueue error: null Feb 25 02:00:48 volumio volumio[1047]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Feb 25 02:00:48 volumio volumio[1047]: info: sendMpdCommand status took 23631 milliseconds Feb 25 02:00:48 volumio volumio[1047]: info: sendMpdCommand status took 23628 milliseconds Feb 25 02:00:48 volumio volumio[1047]: verbose: ControllerMpd::parseState Feb 25 02:00:48 volumio volumio[1047]: info: Command Router : Notfying DB Updatefalse Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::Close All Modals sent Feb 25 02:00:48 volumio volumio[1047]: verbose: ControllerMpd::parseState Feb 25 02:00:48 volumio volumio[1047]: info: ControllerMpd::pushState Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::servicePushState Feb 25 02:00:48 volumio volumio[1047]: info: CoreStateMachine::pushState Feb 25 02:00:48 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::volumioPushState Feb 25 02:00:48 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:00:48 volumio volumio[1047]: 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} Feb 25 02:00:48 volumio volumio[1047]: verbose: CURRENT POSITION 0 Feb 25 02:00:48 volumio volumio[1047]: info: CoreStateMachine::syncState stateService stop Feb 25 02:00:48 volumio volumio[1047]: info: CoreStateMachine::syncState currentStatus stop Feb 25 02:00:48 volumio volumio[1047]: info: CoreStateMachine::pushState Feb 25 02:00:48 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::volumioPushState Feb 25 02:00:48 volumio volumio[1047]: info: No code Feb 25 02:00:48 volumio volumio[1047]: info: CoreStateMachine::pushState Feb 25 02:00:48 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::volumioPushState Feb 25 02:00:48 volumio volumio[1047]: info: ------------------------------ 23760ms Feb 25 02:00:48 volumio volumio[1047]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Feb 25 02:00:48 volumio volumio[1047]: ALSA lib confmisc.c:165:(snd_config_get_card) Cannot get card index for undefined Feb 25 02:00:48 volumio volumio[1047]: aplay: main:831: audio open error: No such device Feb 25 02:00:48 volumio volumio[1047]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Feb 25 02:00:48 volumio volumio[1047]: wlan0 Interface doesn't support scanning. Feb 25 02:00:48 volumio volumio[1047]: info: Cannot use regular scanning, forcing with ap-force Feb 25 02:00:48 volumio sudo[2122]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Feb 25 02:00:48 volumio sudo[2122]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:48 volumio sudo[2122]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:48 volumio volumio[1047]: command failed: No such device (-19) Feb 25 02:00:48 volumio volumio[1047]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Feb 25 02:00:48 volumio volumio[1047]: command failed: No such device (-19) Feb 25 02:00:48 volumio volumio[1047]: error: Cannot start Volumio Streaming Daemon Feb 25 02:00:48 volumio volumio[1047]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 25 02:00:48 volumio volumio[1047]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:00:48 volumio volumio[1047]: info: Retrieving Cloud Streaming UI Feb 25 02:00:48 volumio volumio[1047]: Updating browse sources language Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 02:00:48 volumio volumio[1047]: info: Getting Tidal Cloud Configuration Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:00:48 volumio volumio[1047]: info: Getting Qobuz Cloud Configuration Feb 25 02:00:48 volumio volumio[1047]: info: Asking plugin for UI Config Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:00:48 volumio volumio[1047]: info: Getting Spotify Cloud Configuration Feb 25 02:00:48 volumio volumio[1047]: info: Asking plugin for UI Config Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:00:48 volumio volumio[1047]: info: Saving Spotify Acccount Feb 25 02:00:48 volumio volumio[1047]: info: Got Tidal Cloud Configuration Feb 25 02:00:48 volumio volumio[1047]: info: Got it Feb 25 02:00:48 volumio volumio[1047]: info: Got it Feb 25 02:00:48 volumio volumio[1047]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 25 02:00:48 volumio volumio[1047]: info: Getting Tidal Cloud Configuration Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:00:48 volumio volumio[1047]: info: Getting Qobuz Cloud Configuration Feb 25 02:00:48 volumio volumio[1047]: info: Asking plugin for UI Config Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:00:48 volumio volumio[1047]: info: Getting Spotify Cloud Configuration Feb 25 02:00:48 volumio volumio[1047]: info: Asking plugin for UI Config Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:00:48 volumio volumio[1047]: info: Saving Spotify Acccount Feb 25 02:00:48 volumio volumio[1047]: info: Got Tidal Cloud Configuration Feb 25 02:00:48 volumio volumio[1047]: info: Got it Feb 25 02:00:48 volumio volumio[1047]: info: Got it Feb 25 02:00:48 volumio volumio[1047]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 25 02:00:48 volumio volumio[1047]: info: Getting Tidal Cloud Configuration Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:00:48 volumio volumio[1047]: info: Getting Qobuz Cloud Configuration Feb 25 02:00:48 volumio volumio[1047]: info: Asking plugin for UI Config Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:00:48 volumio volumio[1047]: info: Getting Spotify Cloud Configuration Feb 25 02:00:48 volumio volumio[1047]: info: Asking plugin for UI Config Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:00:48 volumio volumio[1047]: info: Saving Spotify Acccount Feb 25 02:00:48 volumio volumio[1047]: info: Got Tidal Cloud Configuration Feb 25 02:00:48 volumio volumio[1047]: info: Got it Feb 25 02:00:48 volumio volumio[1047]: info: Got it Feb 25 02:00:48 volumio volumio[1047]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 25 02:00:48 volumio volumio[1047]: info: Getting Tidal Cloud Configuration Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:00:48 volumio volumio[1047]: info: Getting Qobuz Cloud Configuration Feb 25 02:00:48 volumio volumio[1047]: info: Asking plugin for UI Config Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:00:48 volumio volumio[1047]: info: Getting Spotify Cloud Configuration Feb 25 02:00:48 volumio volumio[1047]: info: Asking plugin for UI Config Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:00:48 volumio volumio[1047]: info: Saving Spotify Acccount Feb 25 02:00:48 volumio volumio[1047]: info: Got Tidal Cloud Configuration Feb 25 02:00:48 volumio volumio[1047]: info: Got it Feb 25 02:00:48 volumio volumio[1047]: info: Got it Feb 25 02:00:48 volumio volumio[1047]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 25 02:00:48 volumio volumio[1047]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::volumioGetState Feb 25 02:00:48 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:00:48 volumio volumio-remote-updater[768]: Test mode disabled Feb 25 02:00:48 volumio volumio-remote-updater[768]: Alpha mode disabled Feb 25 02:00:48 volumio volumio-remote-updater[768]: Alpha legacy test mode disabled Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 25 02:00:48 volumio volumio[1047]: aplay: device_list:274: no soundcards found... Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Feb 25 02:00:48 volumio volumio[1047]: info: Version has changed, forcing UI Reload Feb 25 02:00:48 volumio volumio[1047]: info: CoreCommandRouter::Reload Ui Feb 25 02:00:49 volumio volumio[1047]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 25 02:00:49 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 25 02:00:49 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:00:49 volumio volumio[1047]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Feb 25 02:00:49 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:00:49 volumio volumio[1047]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Feb 25 02:00:49 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:00:49 volumio volumio[1047]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Feb 25 02:00:49 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:00:49 volumio volumio[1047]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Feb 25 02:00:49 volumio sudo[2130]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 25 02:00:49 volumio sudo[2134]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 25 02:00:49 volumio sudo[2128]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 25 02:00:49 volumio sudo[2135]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 25 02:00:49 volumio sudo[2135]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:49 volumio sudo[2128]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:49 volumio sudo[2130]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:49 volumio sudo[2134]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:49 volumio sudo[2128]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:49 volumio sudo[2134]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:49 volumio sudo[2151]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 25 02:00:49 volumio sudo[2150]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 25 02:00:49 volumio sudo[2150]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:49 volumio sudo[2151]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:49 volumio sudo[2150]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:50 volumio sudo[2151]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:50 volumio sudo[2135]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:50 volumio sudo[2130]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:50 volumio volumio[1047]: verbose: New Socket.io Connection to 192.168.68.82 from 192.168.68.200 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.2 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 10 Feb 25 02:00:50 volumio volumio[1047]: info: CoreCommandRouter::volumioGetVisibleSources Feb 25 02:00:50 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 02:00:50 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Feb 25 02:00:50 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Feb 25 02:00:50 volumio volumio[1047]: aplay: device_list:274: no soundcards found... Feb 25 02:00:50 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Feb 25 02:00:50 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Feb 25 02:00:50 volumio volumio[1047]: info: Received Get System Info Feb 25 02:00:50 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 02:00:50 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 02:00:50 volumio volumio[1047]: info: Discovery: Getting this device information Feb 25 02:00:50 volumio volumio[1047]: info: CoreCommandRouter::volumioGetState Feb 25 02:00:50 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:00:50 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 02:00:50 volumio volumio-remote-updater[768]: Test mode disabled Feb 25 02:00:50 volumio volumio-remote-updater[768]: Alpha mode disabled Feb 25 02:00:50 volumio volumio-remote-updater[768]: Alpha legacy test mode disabled Feb 25 02:00:50 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 25 02:00:50 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 25 02:00:50 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:00:50 volumio volumio[1047]: info: Retrieving Cloud Streaming UI Feb 25 02:00:50 volumio volumio[1047]: info: Getting Tidal Cloud Configuration Feb 25 02:00:50 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:00:50 volumio volumio[1047]: info: Getting Qobuz Cloud Configuration Feb 25 02:00:50 volumio volumio[1047]: info: Asking plugin for UI Config Feb 25 02:00:50 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:00:50 volumio volumio[1047]: info: Getting Spotify Cloud Configuration Feb 25 02:00:50 volumio volumio[1047]: info: Asking plugin for UI Config Feb 25 02:00:50 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:00:50 volumio volumio[1047]: info: Saving Spotify Acccount Feb 25 02:00:50 volumio volumio[1047]: info: Got Tidal Cloud Configuration Feb 25 02:00:50 volumio volumio[1047]: info: Got it Feb 25 02:00:50 volumio volumio[1047]: info: Got it Feb 25 02:00:50 volumio volumio[1047]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 25 02:00:50 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:00:50 volumio volumio[1047]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Feb 25 02:00:50 volumio volumio[1047]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 25 02:00:50 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 25 02:00:51 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Feb 25 02:00:51 volumio volumio[1047]: info: Loading i18n strings for locale ru Feb 25 02:00:51 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Feb 25 02:00:51 volumio volumio[1047]: info: Setting timezone to Europe/Belgrade Feb 25 02:00:51 volumio sudo[2167]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Feb 25 02:00:51 volumio sudo[2167]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:51 volumio sudo[2167]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:51 volumio sudo[2171]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Belgrade /etc/localtime Feb 25 02:00:51 volumio sudo[2171]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:51 volumio sudo[2171]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:51 volumio sudo[2175]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Feb 25 02:00:51 volumio sudo[2175]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:51 volumio sudo[2175]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:51 volumio sudo[2179]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Belgrade Feb 25 02:00:51 volumio sudo[2179]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:51 volumio sudo[2179]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:51 volumio volumio[1047]: Updating browse sources language Feb 25 02:00:51 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 02:00:51 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 25 02:00:51 volumio volumio[1047]: info: Fetching Streaming Services browse cache Feb 25 02:00:54 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Feb 25 02:00:54 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 25 02:00:54 volumio volumio-remote-updater[768]: Test mode disabled Feb 25 02:00:54 volumio volumio-remote-updater[768]: Alpha mode disabled Feb 25 02:00:54 volumio volumio-remote-updater[768]: Alpha legacy test mode disabled Feb 25 02:00:54 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Feb 25 02:00:54 volumio volumio[1047]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 25 02:00:54 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 25 02:00:54 volumio volumio[1047]: info: BOOT COMPLETED Feb 25 02:00:55 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Feb 25 02:00:55 volumio volumio[1047]: info: Loading i18n strings for locale ru Feb 25 02:00:55 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Feb 25 02:00:55 volumio volumio[1047]: info: Setting timezone to Europe/Belgrade Feb 25 02:00:55 volumio sudo[2190]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Feb 25 02:00:55 volumio sudo[2190]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:55 volumio sudo[2190]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:55 volumio sudo[2194]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Belgrade /etc/localtime Feb 25 02:00:55 volumio sudo[2194]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:55 volumio sudo[2194]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:55 volumio sudo[2198]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Feb 25 02:00:55 volumio sudo[2198]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:55 volumio sudo[2198]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:55 volumio sudo[2202]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Belgrade Feb 25 02:00:55 volumio sudo[2202]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:55 volumio sudo[2202]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:55 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Feb 25 02:00:55 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Feb 25 02:00:55 volumio sudo[2205]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 25 02:00:55 volumio sudo[2205]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:55 volumio sudo[2205]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:55 volumio volumio[1047]: Updating browse sources language Feb 25 02:00:55 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 02:00:55 volumio volumio[1047]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Feb 25 02:00:55 volumio volumio[1047]: wlan0 Interface doesn't support scanning. Feb 25 02:00:55 volumio volumio[1047]: info: Cannot use regular scanning, forcing with ap-force Feb 25 02:00:55 volumio sudo[2211]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Feb 25 02:00:55 volumio sudo[2211]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:00:55 volumio sudo[2211]: pam_unix(sudo:session): session closed for user root Feb 25 02:00:55 volumio volumio[1047]: command failed: No such device (-19) Feb 25 02:00:55 volumio volumio[1047]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Feb 25 02:00:55 volumio volumio[1047]: command failed: No such device (-19) Feb 25 02:00:55 volumio volumio[1047]: info: Fetching Streaming Services browse cache Feb 25 02:01:03 volumio sudo[2284]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 25 02:01:03 volumio sudo[2284]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:01:03 volumio sudo[2283]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 25 02:01:03 volumio sudo[2283]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:01:03 volumio sudo[2284]: pam_unix(sudo:session): session closed for user root Feb 25 02:01:03 volumio sudo[2283]: pam_unix(sudo:session): session closed for user root Feb 25 02:01:03 volumio volumio[1047]: verbose: New Socket.io Connection to 192.168.68.82 from 192.168.68.200 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.2 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 9 Feb 25 02:01:03 volumio volumio[1047]: info: CoreCommandRouter::volumioGetVisibleSources Feb 25 02:01:03 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 02:01:07 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 25 02:01:07 volumio volumio[1047]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 25 02:01:07 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 25 02:01:07 volumio volumio[1047]: info: Received Get System Version Feb 25 02:01:07 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 25 02:01:07 volumio volumio[1047]: info: Received Get System Info Feb 25 02:01:07 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 02:01:07 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 02:01:07 volumio volumio[1047]: info: Discovery: Getting this device information Feb 25 02:01:07 volumio volumio[1047]: info: CoreCommandRouter::volumioGetState Feb 25 02:01:07 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:01:07 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 02:01:21 volumio sudo[2347]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 25 02:01:21 volumio sudo[2347]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:01:21 volumio sudo[2345]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 25 02:01:21 volumio sudo[2345]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:01:21 volumio sudo[2345]: pam_unix(sudo:session): session closed for user root Feb 25 02:01:21 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Feb 25 02:01:21 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 25 02:01:21 volumio volumio-remote-updater[768]: Test mode disabled Feb 25 02:01:21 volumio volumio-remote-updater[768]: Alpha mode disabled Feb 25 02:01:21 volumio volumio-remote-updater[768]: Alpha legacy test mode disabled Feb 25 02:01:21 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Feb 25 02:01:22 volumio volumio[1047]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 25 02:01:22 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 25 02:01:23 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Feb 25 02:01:23 volumio volumio[1047]: info: MyVolumio login type: Token Feb 25 02:01:23 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 25 02:01:23 volumio sudo[2347]: pam_unix(sudo:session): session closed for user root Feb 25 02:01:23 volumio volumio[1047]: verbose: New Socket.io Connection to 192.168.68.82 from 192.168.68.200 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.2 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 9 Feb 25 02:01:23 volumio volumio[1047]: info: CoreCommandRouter::volumioGetVisibleSources Feb 25 02:01:23 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 02:01:23 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Feb 25 02:01:24 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Feb 25 02:01:24 volumio volumio[1047]: aplay: device_list:274: no soundcards found... Feb 25 02:01:24 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Feb 25 02:01:24 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Feb 25 02:01:24 volumio volumio[1047]: info: Received Get System Info Feb 25 02:01:24 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 02:01:24 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 02:01:24 volumio volumio[1047]: info: Discovery: Getting this device information Feb 25 02:01:24 volumio volumio[1047]: info: CoreCommandRouter::volumioGetState Feb 25 02:01:24 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:01:24 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 02:01:24 volumio volumio-remote-updater[768]: Test mode disabled Feb 25 02:01:24 volumio volumio-remote-updater[768]: Alpha mode disabled Feb 25 02:01:24 volumio volumio-remote-updater[768]: Alpha legacy test mode disabled Feb 25 02:01:24 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:01:24 volumio volumio[1047]: info: Retrieving Cloud Streaming UI Feb 25 02:01:25 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Feb 25 02:01:26 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Feb 25 02:01:26 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 25 02:01:26 volumio volumio[1047]: info: Getting Tidal Cloud Configuration Feb 25 02:01:26 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:01:26 volumio volumio[1047]: info: Getting Qobuz Cloud Configuration Feb 25 02:01:26 volumio volumio[1047]: info: Asking plugin for UI Config Feb 25 02:01:26 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:01:26 volumio volumio[1047]: info: Getting Spotify Cloud Configuration Feb 25 02:01:26 volumio volumio[1047]: info: Asking plugin for UI Config Feb 25 02:01:26 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:01:26 volumio volumio[1047]: info: Saving Spotify Acccount Feb 25 02:01:26 volumio volumio[1047]: info: Got Tidal Cloud Configuration Feb 25 02:01:26 volumio volumio[1047]: info: Got it Feb 25 02:01:26 volumio volumio[1047]: info: Got it Feb 25 02:01:26 volumio volumio[1047]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 25 02:01:26 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:01:26 volumio volumio[1047]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Feb 25 02:01:26 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Feb 25 02:01:26 volumio volumio[1047]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Feb 25 02:01:27 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Feb 25 02:01:27 volumio volumio[1047]: info: Loading i18n strings for locale ru Feb 25 02:01:27 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Feb 25 02:01:27 volumio volumio[1047]: info: Setting timezone to Europe/Belgrade Feb 25 02:01:27 volumio volumio-remote-updater[768]: Test mode disabled Feb 25 02:01:27 volumio volumio-remote-updater[768]: Alpha mode disabled Feb 25 02:01:27 volumio volumio-remote-updater[768]: Alpha legacy test mode disabled Feb 25 02:01:28 volumio sudo[2393]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Feb 25 02:01:28 volumio sudo[2393]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:01:29 volumio sudo[2393]: pam_unix(sudo:session): session closed for user root Feb 25 02:01:29 volumio sudo[2400]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Belgrade /etc/localtime Feb 25 02:01:29 volumio sudo[2400]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:01:29 volumio sudo[2400]: pam_unix(sudo:session): session closed for user root Feb 25 02:01:29 volumio sudo[2404]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Feb 25 02:01:29 volumio sudo[2404]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:01:29 volumio sudo[2404]: pam_unix(sudo:session): session closed for user root Feb 25 02:01:29 volumio sudo[2408]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Belgrade Feb 25 02:01:29 volumio sudo[2408]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:01:29 volumio dbus-daemon[758]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.34' (uid=0 pid=2409 comm="/usr/bin/timedatectl set-timezone Europe/Belgrade") Feb 25 02:01:29 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Feb 25 02:01:29 volumio dbus-daemon[758]: [system] Successfully activated service 'org.freedesktop.timedate1' Feb 25 02:01:29 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Feb 25 02:01:29 volumio sudo[2408]: pam_unix(sudo:session): session closed for user root Feb 25 02:01:32 volumio volumio[1047]: info: Fetching Streaming Services browse cache Feb 25 02:01:32 volumio volumio[1047]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 25 02:01:32 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 25 02:01:32 volumio volumio[1047]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 25 02:01:32 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 25 02:01:32 volumio volumio[1047]: Updating browse sources language Feb 25 02:01:32 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 02:01:34 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Feb 25 02:01:34 volumio volumio[1047]: info: System name has changed, restarting Shairport Sync Feb 25 02:01:34 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 02:01:34 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 02:01:34 volumio volumio[1047]: aplay: device_list:274: no soundcards found... Feb 25 02:01:34 volumio volumio[1047]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 25 02:01:34 volumio volumio[1047]: aplay: device_list:274: no soundcards found... Feb 25 02:01:34 volumio volumio[1047]: info: Updating MyVolumio device info Feb 25 02:01:34 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 02:01:34 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 02:01:34 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 02:01:34 volumio volumio[1047]: info: Discovery: Restarting Advertising Feb 25 02:01:34 volumio volumio[1047]: info: Discovery: Stopping existing advertisement Feb 25 02:01:34 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Feb 25 02:01:34 volumio volumio[1047]: aplay: device_list:274: no soundcards found... Feb 25 02:01:34 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 25 02:01:34 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 02:01:34 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 25 02:01:35 volumio volumio[1047]: info: Starting Shairport Sync Feb 25 02:01:35 volumio sudo[2427]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 25 02:01:35 volumio sudo[2427]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:01:35 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 25 02:01:35 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 25 02:01:35 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 25 02:01:35 volumio systemd[1]: shairport-sync.service: Consumed 1.861s CPU time. Feb 25 02:01:35 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 25 02:01:35 volumio sudo[2427]: pam_unix(sudo:session): session closed for user root Feb 25 02:01:35 volumio volumio[1047]: info: Shairport-Sync Started Feb 25 02:01:36 volumio volumio[1047]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Feb 25 02:01:36 volumio volumio[1047]: info: Discovery: A device disappeared from network Feb 25 02:01:36 volumio volumio[1047]: info: Discovery: Device volumio disappeared from network Feb 25 02:01:36 volumio volumio[1047]: info: Discovery: A device disappeared from network Feb 25 02:01:36 volumio volumio[1047]: info: Discovery: A device disappeared from network Feb 25 02:01:36 volumio volumio[1047]: info: Discovery: A device disappeared from network Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Feb 25 02:01:36 volumio volumio[1047]: info: Preparing to save Alsa Options, stopping services first Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::volumioGetState Feb 25 02:01:36 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::volumioPause Feb 25 02:01:36 volumio volumio[1047]: info: CoreStateMachine::pause Feb 25 02:01:36 volumio volumio[1047]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"nodev","label":"Аудиоустройство недоступно"},"disallowPush":true} Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 25 02:01:36 volumio volumio[1047]: aplay: device_list:274: no soundcards found... Feb 25 02:01:36 volumio volumio[1047]: warn: Unable to locate the device Аудиоустройство недоступно a reboot may be required. Feb 25 02:01:36 volumio volumio[1047]: aplay: device_list:274: no soundcards found... Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 25 02:01:36 volumio volumio[1047]: Invalid card number 'nodev'. Feb 25 02:01:36 volumio volumio[1047]: aplay: device_list:274: no soundcards found... Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::volumioUpdateVolumeSettings Feb 25 02:01:36 volumio volumio[1047]: info: Updating Volume Controller Parameters: Device: nodev Name: Аудиоустройство недоступно Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Feb 25 02:01:36 volumio volumio[1047]: info: Disabling external Volume Control Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:01:36 volumio volumio[1047]: info: Preparing to generate the ALSA configuration file Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:01:36 volumio volumio[1047]: info: Retrieving Cloud Streaming UI Feb 25 02:01:36 volumio volumio[1047]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number 'nodev'. Feb 25 02:01:36 volumio volumio[1047]: info: VolumeController:: Volume=undefined Mute =false Feb 25 02:01:36 volumio volumio[1047]: info: CoreStateMachine::pushState Feb 25 02:01:36 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::volumioPushState Feb 25 02:01:36 volumio volumio[1047]: info: Asound.conf file unchanged, so no further update is needed Feb 25 02:01:36 volumio volumio[1047]: info: Output device has changed, restarting MPD Feb 25 02:01:36 volumio volumio[1047]: info: Output device has changed, restarting Shairport Sync Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 02:01:36 volumio sudo[2477]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 25 02:01:36 volumio sudo[2477]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:01:36 volumio sudo[2479]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 25 02:01:36 volumio sudo[2479]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:01:36 volumio volumio[1047]: aplay: device_list:274: no soundcards found... Feb 25 02:01:36 volumio volumio[1047]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 25 02:01:36 volumio volumio[1047]: aplay: device_list:274: no soundcards found... Feb 25 02:01:36 volumio sudo[2477]: pam_unix(sudo:session): session closed for user root Feb 25 02:01:36 volumio volumio[1047]: info: Getting Tidal Cloud Configuration Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:01:36 volumio volumio[1047]: info: Getting Qobuz Cloud Configuration Feb 25 02:01:36 volumio volumio[1047]: info: Asking plugin for UI Config Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:01:36 volumio volumio[1047]: info: Getting Spotify Cloud Configuration Feb 25 02:01:36 volumio volumio[1047]: info: Asking plugin for UI Config Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:01:36 volumio volumio[1047]: info: Saving Spotify Acccount Feb 25 02:01:36 volumio volumio[1047]: info: Got Tidal Cloud Configuration Feb 25 02:01:36 volumio volumio[1047]: info: Got it Feb 25 02:01:36 volumio volumio[1047]: info: Got it Feb 25 02:01:36 volumio volumio[1047]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 25 02:01:36 volumio volumio[1047]: info: MPD Permissions set Feb 25 02:01:36 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 25 02:01:36 volumio upmpdcli[1731]: :2:../src/mpdcli.cxx:243::MPDCli::eventloop: mpd_run_idle_mask returned 0 Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 02:01:36 volumio volumio[1047]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 02:01:36 volumio volumio[1047]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Feb 25 02:01:36 volumio volumio[1047]: info: Starting Shairport Sync Feb 25 02:01:36 volumio sudo[2495]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 25 02:01:36 volumio sudo[2495]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:01:36 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 25 02:01:36 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 25 02:01:36 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 25 02:01:36 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 25 02:01:36 volumio sudo[2495]: pam_unix(sudo:session): session closed for user root Feb 25 02:01:36 volumio volumio[1047]: info: Shairport-Sync Started Feb 25 02:01:40 volumio volumio[1047]: info: Discovery: Started advertising with name: Volumio5 Feb 25 02:01:40 volumio volumio[1047]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Feb 25 02:01:40 volumio volumio[1047]: info: CoreStateMachine::getcurrentVolume Feb 25 02:01:40 volumio volumio[1047]: info: CoreCommandRouter::volumioRetrievevolume Feb 25 02:01:40 volumio volumio[1047]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number 'nodev'. Feb 25 02:01:40 volumio volumio[1047]: info: VolumeController:: Volume=undefined Mute =false Feb 25 02:01:40 volumio volumio[1047]: info: CoreStateMachine::pushState Feb 25 02:01:40 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:01:40 volumio volumio[1047]: info: CoreCommandRouter::volumioPushState Feb 25 02:01:40 volumio volumio[1047]: info: CoreStateMachine::updateTrackBlock Feb 25 02:01:40 volumio volumio[1047]: info: CorePlayQueue::getTrackBlock Feb 25 02:01:40 volumio volumio[1047]: info: CoreCommandRouter::volumioRetrievevolume Feb 25 02:01:40 volumio volumio[1047]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number 'nodev'. Feb 25 02:01:40 volumio volumio[1047]: info: VolumeController:: Volume=undefined Mute =false Feb 25 02:01:40 volumio volumio[1047]: info: CoreStateMachine::pushState Feb 25 02:01:40 volumio volumio[1047]: info: CorePlayQueue::getTrack 0 Feb 25 02:01:40 volumio volumio[1047]: info: CoreCommandRouter::volumioPushState Feb 25 02:01:41 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Feb 25 02:01:41 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Feb 25 02:01:41 volumio volumio[1047]: aplay: device_list:274: no soundcards found... Feb 25 02:01:41 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Feb 25 02:01:41 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Feb 25 02:01:41 volumio volumio[1047]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Feb 25 02:01:41 volumio volumio[1047]: aplay: device_list:274: no soundcards found... Feb 25 02:01:41 volumio volumio[1047]: compat.c: read() failed: Resource temporarily unavailable Feb 25 02:01:41 volumio volumio[1047]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 25 02:01:41 volumio volumio[1047]: Error: dns service error: unknown Feb 25 02:01:41 volumio volumio[1047]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Feb 25 02:01:41 volumio volumio[1047]: errorCode: -65537 Feb 25 02:01:41 volumio volumio[1047]: } Feb 25 02:01:41 volumio volumio[1047]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 25 02:01:42 volumio upmpdcli[1731]: :2:../src/mpdcli.cxx:113::MPDCli::openconn: mpd_connection_new failed: Timeout Feb 25 02:01:42 volumio upmpdcli[1731]: :2:../src/mpdcli.cxx:396::MPDCli::updStatus: connection failed Feb 25 02:01:42 volumio upmpdcli[1731]: :2:../src/mpdcli.cxx:243::MPDCli::eventloop: mpd_run_idle_mask returned 0 Feb 25 02:01:43 volumio sudo[2421]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Feb 25 02:01:43 volumio sudo[2421]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 25 02:01:44 volumio sudo[2421]: pam_unix(sudo:session): session closed for user root Feb 25 02:01:45 volumio sudo[2552]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-25 02:00' Feb 25 02:01:45 volumio sudo[2552]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:31:57 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6759e875c98b942866984e844891d6c1"