-- Logs begin at Sun 2026-08-23 04:43:34 UTC, end at Wed 2026-08-26 04:06:26 UTC. -- Aug 26 04:05:42 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:42.042Z level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.86.22:55980 Aug 26 04:05:42 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:42.094Z level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.86.22:55980 @ 0x20bf0e0" latency=-667.563091ms platform=PLATFORM_ANDROID version=6.260807.0 Aug 26 04:05:42 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:42.095Z level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.86.22:55980 @ 0x20bf0e0" latency=-669.485215ms timeout=20s Aug 26 04:05:42 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:42.095Z level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.86.22:55980 @ 0x20bf0e0" Aug 26 04:05:42 volumio volumio[1110]: info: Received Get System Info Aug 26 04:05:42 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 04:05:42 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 04:05:42 volumio volumio[1110]: info: Discovery: Getting this device information Aug 26 04:05:42 volumio volumio[1110]: info: CoreCommandRouter::volumioGetState Aug 26 04:05:42 volumio volumio[1110]: info: CorePlayQueue::getTrack 10 Aug 26 04:05:42 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 04:05:42 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 26 04:05:42 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 26 04:05:42 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:42.111Z level=INFO msg="emitting device name changed event" component=server peer="192.168.86.22:55980 @ 0x20bf0e0" name=Volumio Aug 26 04:05:42 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:42.124Z level=INFO msg="emitting device language changed event" component=server peer="192.168.86.22:55980 @ 0x20bf0e0" language=en Aug 26 04:05:42 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Aug 26 04:05:42 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:42.126Z level=INFO msg="emitting device timezone changed event" component=server peer="192.168.86.22:55980 @ 0x20bf0e0" timezone=UTC Aug 26 04:05:42 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:42.134Z level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.86.22:55980 @ 0x20bf0e0" available=true connected=false macAddress= ip4Address= ip6Address= Aug 26 04:05:42 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:42.136Z level=INFO msg="emitting wifi info changed event" component=server peer="192.168.86.22:55980 @ 0x20bf0e0" available=true connected=true macAddress=70:66:55:e6:42:fb ip4Address=192.168.86.250/24 ip6Address= ssid=Sartors Aug 26 04:05:42 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:42.137Z level=INFO msg="emitting device setup status changed event" component=server peer="192.168.86.22:55980 @ 0x20bf0e0" setupComplete=true Aug 26 04:05:42 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Aug 26 04:05:42 volumio volumio[1110]: No protocol specified Aug 26 04:05:42 volumio volumio[1110]: xcb_connection_has_error() returned true Aug 26 04:05:42 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 26 04:05:42 volumio volumio[1110]: Invalid card number. Aug 26 04:05:42 volumio volumio[1110]: Invalid card number. Aug 26 04:05:42 volumio volumio[1110]: No protocol specified Aug 26 04:05:42 volumio volumio[1110]: xcb_connection_has_error() returned true Aug 26 04:05:42 volumio volumio[1110]: amixer -c 0 info | grep "Analog RCA Output" Aug 26 04:05:42 volumio volumio[1110]: No protocol specified Aug 26 04:05:42 volumio volumio[1110]: xcb_connection_has_error() returned true Aug 26 04:05:42 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:42.540Z level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.86.22:55980 @ 0x20bf0e0" selectedOutputId=1,1 Aug 26 04:05:42 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 04:05:42 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 04:05:42 volumio volumio[1110]: info: Discovery: Getting this device information Aug 26 04:05:42 volumio volumio[1110]: info: CoreCommandRouter::volumioGetState Aug 26 04:05:42 volumio volumio[1110]: info: CorePlayQueue::getTrack 10 Aug 26 04:05:42 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 04:05:42 volumio volumio[1110]: verbose: New Socket.io Connection to 192.168.86.250:3000 from 192.168.86.22 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Aug 26 04:05:42 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 26 04:05:42 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 26 04:05:42 volumio volumio[1110]: info: Received Get System Info Aug 26 04:05:42 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 04:05:42 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 04:05:42 volumio volumio[1110]: info: Discovery: Getting this device information Aug 26 04:05:42 volumio volumio[1110]: info: CoreCommandRouter::volumioGetState Aug 26 04:05:42 volumio volumio[1110]: info: CorePlayQueue::getTrack 10 Aug 26 04:05:42 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 04:05:42 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:42.601Z level=INFO msg="emitting software info changed event" component=server peer="192.168.86.22:55980 @ 0x20bf0e0" currentVersion=3.912 latestVersion=3.912 Aug 26 04:05:42 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:42.602Z level=INFO msg="emitting software update progress event" component=server peer="192.168.86.22:55980 @ 0x20bf0e0" status=UPDATE_STATUS_NONE progress=0 Aug 26 04:05:42 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:42.602Z level=INFO msg="emitting user changed event" component=server peer="192.168.86.22:55980 @ 0x20bf0e0" userId= Aug 26 04:05:42 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:42.602Z level=INFO msg="emitting music providers changed event" component=server peer="192.168.86.22:55980 @ 0x20bf0e0" providers=3 Aug 26 04:05:42 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 26 04:05:42 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 26 04:05:42 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 26 04:05:43 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:43.585Z level=INFO msg="emitting plugins changed event" component=server peer="192.168.86.22:55980 @ 0x20bf0e0" plugins=54 Aug 26 04:05:43 volumio volumio[1110]: info: CoreCommandRouter::volumioGetState Aug 26 04:05:43 volumio volumio[1110]: info: CorePlayQueue::getTrack 10 Aug 26 04:05:43 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:43.589Z level=INFO msg="emitting player state changed event" component=server peer="192.168.86.22:55980 @ 0x20bf0e0" state=STATUS_PAUSED positionMs=27888 volume=100 Aug 26 04:05:43 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:43.590Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.86.22:55980 @ 0x20bf0e0" id="music-library/USB/Muz/David Bowie/David Bowie - The Rise And Fall Of Ziggy Stardust And The Spiders From Mars (1972) [2003 DSD Remaster] [24-88 FLAC]/1.11. Rock 'n' Roll Suicide.flac" title="Rock 'n' Roll Suicide" Aug 26 04:05:45 volumio kernel: rtk_btcoex: update_profile_connection: is_add 1, profile_index 1 Aug 26 04:05:45 volumio kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_bitmap 0x02 Aug 26 04:05:45 volumio kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[0] = 0 Aug 26 04:05:45 volumio kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[1] = 1 Aug 26 04:05:45 volumio kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[2] = 0 Aug 26 04:05:45 volumio kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[3] = 0 Aug 26 04:05:45 volumio kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[4] = 0 Aug 26 04:05:45 volumio kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[5] = 0 Aug 26 04:05:45 volumio kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[6] = 0 Aug 26 04:05:45 volumio kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[7] = 0 Aug 26 04:05:45 volumio kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: BufferSize 5 Aug 26 04:05:45 volumio kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: NumberOfHandles 1 Aug 26 04:05:45 volumio kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: handle 0x0010 Aug 26 04:05:45 volumio kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_bitmap 0x02 Aug 26 04:05:45 volumio kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_status 0x00 Aug 26 04:05:45 volumio kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc19 Aug 26 04:05:45 volumio kernel: rtk_btcoex: update_hid_active_state: handle 0x0010, interval 39 Aug 26 04:05:45 volumio kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: BufferSize 5 Aug 26 04:05:45 volumio kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: NumberOfHandles 1 Aug 26 04:05:45 volumio kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: handle 0x0010 Aug 26 04:05:45 volumio kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_bitmap 0x12 Aug 26 04:05:45 volumio kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_status 0x02 Aug 26 04:05:45 volumio kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc19 Aug 26 04:05:50 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:50.036Z level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.86.22:55980 @ 0x20bf0e0" latency=-695.035997ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Aug 26 04:05:50 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:50.153Z level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.22:55980 @ 0x20bf0e0" latency=-661.022829ms timeout=10s Aug 26 04:05:50 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:50.532Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.22:55980 @ 0x20bf0e0" latency=-661.022829ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=377.626126ms Aug 26 04:05:50 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:50.653Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.22:55980 @ 0x20bf0e0" latency=-661.022829ms timeout=10s endpoint=https://www.googleapis.com duration=497.909235ms Aug 26 04:05:50 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:50.688Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.22:55980 @ 0x20bf0e0" latency=-661.022829ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=533.59464ms Aug 26 04:05:50 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:50.725Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.22:55980 @ 0x20bf0e0" latency=-661.022829ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=571.331061ms Aug 26 04:05:50 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:50.823Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.22:55980 @ 0x20bf0e0" latency=-661.022829ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=668.181487ms Aug 26 04:05:50 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:50.825Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.22:55980 @ 0x20bf0e0" latency=-661.022829ms timeout=10s endpoint=http://pushupdates.volumio.org duration=668.027777ms Aug 26 04:05:50 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:50.882Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.22:55980 @ 0x20bf0e0" latency=-661.022829ms timeout=10s endpoint=https://functions.volumio.cloud duration=727.352659ms Aug 26 04:05:50 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:50.884Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.22:55980 @ 0x20bf0e0" latency=-661.022829ms timeout=10s endpoint=https://database.volumio.cloud duration=727.928997ms Aug 26 04:05:50 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:50.885Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.22:55980 @ 0x20bf0e0" latency=-661.022829ms timeout=10s endpoint=https://securetoken.googleapis.com duration=728.169331ms Aug 26 04:05:50 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:50.903Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.22:55980 @ 0x20bf0e0" latency=-661.022829ms timeout=10s endpoint=https://functions.volumio.cloud duration=746.281681ms Aug 26 04:05:51 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:51.402Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.22:55980 @ 0x20bf0e0" latency=-661.022829ms timeout=10s endpoint=http://plugins.volumio.org duration=1.246112432s Aug 26 04:05:51 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:51.789Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.22:55980 @ 0x20bf0e0" latency=-661.022829ms timeout=10s endpoint=https://google.com duration=1.635138439s Aug 26 04:05:52 volumio sudo[6099]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 26 04:05:52 volumio sudo[6099]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 04:05:52 volumio sudo[6102]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 26 04:05:52 volumio sudo[6099]: pam_unix(sudo:session): session closed for user root Aug 26 04:05:52 volumio sudo[6102]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 04:05:52 volumio sudo[6102]: pam_unix(sudo:session): session closed for user root Aug 26 04:05:52 volumio volumio5-onboarding[1585]: time=2026-08-26T04:05:52.137Z level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.22:55980 @ 0x20bf0e0" latency=-661.022829ms timeout=10s endpoint=http://cddb.volumio.org duration=1.981503778s Aug 26 04:05:52 volumio volumio[1110]: verbose: New Socket.io Connection to 192.168.86.250 from 192.168.86.22 UA: Mozilla/5.0 (Linux; Android 13; CPH2211 Build/TP1A.220905.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/151.0.7922.199 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Aug 26 04:05:52 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 26 04:05:52 volumio sudo[6120]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 26 04:05:52 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 26 04:05:52 volumio sudo[6120]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 04:05:52 volumio sudo[6123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 26 04:05:52 volumio sudo[6120]: pam_unix(sudo:session): session closed for user root Aug 26 04:05:52 volumio sudo[6123]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 04:05:52 volumio sudo[6123]: pam_unix(sudo:session): session closed for user root Aug 26 04:05:52 volumio volumio[1110]: verbose: New Socket.io Connection to 192.168.86.250 from 192.168.86.22 UA: Mozilla/5.0 (Linux; Android 13; CPH2211 Build/TP1A.220905.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/151.0.7922.199 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Aug 26 04:05:52 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 26 04:05:53 volumio volumio[1110]: info: CoreCommandRouter::volumioGetVisibleSources Aug 26 04:05:53 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 04:05:53 volumio volumio[1110]: info: CoreCommandRouter::volumioGetState Aug 26 04:05:53 volumio volumio[1110]: info: CorePlayQueue::getTrack 10 Aug 26 04:05:53 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 26 04:05:53 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 26 04:05:53 volumio volumio[1110]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Aug 26 04:05:53 volumio volumio[1110]: info: Received Get System Info Aug 26 04:05:53 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 04:05:53 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 04:05:53 volumio volumio[1110]: info: Discovery: Getting this device information Aug 26 04:05:53 volumio volumio[1110]: info: CoreCommandRouter::volumioGetState Aug 26 04:05:53 volumio volumio[1110]: info: CorePlayQueue::getTrack 10 Aug 26 04:05:53 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 04:05:53 volumio volumio[1110]: info: CoreCommandRouter::volumioGetState Aug 26 04:05:53 volumio volumio[1110]: info: CorePlayQueue::getTrack 10 Aug 26 04:05:53 volumio volumio[1110]: info: Listing playlists Aug 26 04:05:53 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 26 04:05:53 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 26 04:05:53 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 26 04:05:54 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 26 04:05:54 volumio volumio[1110]: info: Received Get System Info Aug 26 04:05:54 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 04:05:54 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 04:05:54 volumio volumio[1110]: info: Discovery: Getting this device information Aug 26 04:05:54 volumio volumio[1110]: info: CoreCommandRouter::volumioGetState Aug 26 04:05:54 volumio volumio[1110]: info: CorePlayQueue::getTrack 10 Aug 26 04:05:54 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 04:05:54 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 26 04:05:54 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 26 04:05:56 volumio volumio[1110]: info: CoreCommandRouter::volumioGetQueue Aug 26 04:05:56 volumio volumio[1110]: info: CoreStateMachine::getQueue Aug 26 04:05:56 volumio volumio[1110]: info: CorePlayQueue::getQueue Aug 26 04:05:56 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 26 04:05:56 volumio volumio[1110]: info: Received Get System Info Aug 26 04:05:56 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 04:05:56 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 04:05:56 volumio volumio[1110]: info: Discovery: Getting this device information Aug 26 04:05:56 volumio volumio[1110]: info: CoreCommandRouter::volumioGetState Aug 26 04:05:56 volumio volumio[1110]: info: CorePlayQueue::getTrack 10 Aug 26 04:05:56 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 04:05:58 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 26 04:05:58 volumio volumio[1110]: info: Received Get System Info Aug 26 04:05:58 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 04:05:58 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 04:05:58 volumio volumio[1110]: info: Discovery: Getting this device information Aug 26 04:05:58 volumio volumio[1110]: info: CoreCommandRouter::volumioGetState Aug 26 04:05:58 volumio volumio[1110]: info: CorePlayQueue::getTrack 10 Aug 26 04:05:58 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 04:05:58 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 26 04:05:58 volumio volumio[1110]: info: Received Get System Info Aug 26 04:05:58 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 04:05:58 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 04:05:58 volumio volumio[1110]: info: Discovery: Getting this device information Aug 26 04:05:58 volumio volumio[1110]: info: CoreCommandRouter::volumioGetState Aug 26 04:05:58 volumio volumio[1110]: info: CorePlayQueue::getTrack 10 Aug 26 04:05:58 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 04:06:01 volumio kernel: rtk_btcoex: process disconn complete event. Aug 26 04:06:01 volumio kernel: rtk_btcoex: update_profile_connection: is_add 0, profile_index 1 Aug 26 04:06:01 volumio kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[1] = 0 Aug 26 04:06:01 volumio kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_bitmap 0x00 Aug 26 04:06:01 volumio kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[0] = 0 Aug 26 04:06:01 volumio kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[1] = 0 Aug 26 04:06:01 volumio kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[2] = 0 Aug 26 04:06:01 volumio kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[3] = 0 Aug 26 04:06:01 volumio kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[4] = 0 Aug 26 04:06:01 volumio kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[5] = 0 Aug 26 04:06:01 volumio kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[6] = 0 Aug 26 04:06:01 volumio kernel: rtk_btcoex: update_profile_connection: btrtl_coex.profile_refcount[7] = 0 Aug 26 04:06:01 volumio kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: BufferSize 2 Aug 26 04:06:01 volumio kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: NumberOfHandles 0 Aug 26 04:06:01 volumio kernel: rtk_btcoex: rtk_notify_profileinfo_to_fw: profile_status 0x00 Aug 26 04:06:01 volumio kernel: rtk_btcoex: rtk_vendor_cmd_to_fw: opcode 0xfc19 Aug 26 04:06:02 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 26 04:06:03 volumio volumio[1110]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 26 04:06:03 volumio volumio[1110]: info: CURURI: artists:// Aug 26 04:06:04 volumio volumio[1110]: info: Preload queue cleared Aug 26 04:06:05 volumio volumio[1110]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 04:06:05 volumio volumio[1110]: Error: connect ECONNREFUSED 158.69.209.125:443 Aug 26 04:06:05 volumio volumio[1110]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Aug 26 04:06:05 volumio volumio[1110]: errno: -111, Aug 26 04:06:05 volumio volumio[1110]: code: 'ECONNREFUSED', Aug 26 04:06:05 volumio volumio[1110]: syscall: 'connect', Aug 26 04:06:05 volumio volumio[1110]: address: '158.69.209.125', Aug 26 04:06:05 volumio volumio[1110]: port: 443 Aug 26 04:06:05 volumio volumio[1110]: } Aug 26 04:06:05 volumio volumio[1110]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 04:06:06 volumio sudo[6179]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-26 04:05 Aug 26 04:06:06 volumio sudo[6179]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 04:06:06 volumio sudo[6179]: pam_unix(sudo:session): session closed for user root Aug 26 04:06:07 volumio volumio5-onboarding[1585]: time=2026-08-26T04:06:07.763Z level=ERROR msg="failed reading message" error="websocket: close 1006 (abnormal closure): unexpected EOF" Aug 26 04:06:07 volumio volumio-remote-updater[588]: [2026-08-26 04:06:07] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Aug 26 04:06:07 volumio volumio-remote-updater[588]: [2026-08-26 04:06:07] [error] handle_read_frame error: websocketpp.transport:2 (Underlying Transport Error) Aug 26 04:06:07 volumio volumio5-onboarding[1585]: time=2026-08-26T04:06:07.773Z level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:42220->127.0.0.1:3000: read: connection reset by peer" Aug 26 04:06:07 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Aug 26 04:06:07 volumio systemd[1]: media-Muz.mount: Succeeded. Aug 26 04:06:07 volumio systemd[1]: media-Tv_Shows.mount: Succeeded. Aug 26 04:06:07 volumio volumio-remote-updater[588]: [2026-08-26 04:06:07] [disconnect] Disconnect close local:[1006,Underlying Transport Error] remote:[1006] Aug 26 04:06:07 volumio qobuz-connect[2139]: 20260826 04:06:07.793 [2139.2139] INFO SampleApp: Socket closed Aug 26 04:06:07 volumio ntfs-3g[1433]: Unmounting /dev/sda1 (Tv Shows) Aug 26 04:06:07 volumio ntfs-3g[27703]: Unmounting /dev/sdb1 (Muz) Aug 26 04:06:07 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Aug 26 04:06:07 volumio systemd[1]: Started dynamicswap service. Aug 26 04:06:07 volumio systemd[1]: dynamicswap.service: Succeeded. Aug 26 04:06:08 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Aug 26 04:06:08 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Aug 26 04:06:08 volumio systemd[1]: Stopped Volumio Backend Module. Aug 26 04:06:08 volumio systemd[1]: Started Volumio Backend Module. Aug 26 04:06:08 volumio systemd[1]: Started dynamicswap service. Aug 26 04:06:08 volumio systemd[1]: dynamicswap.service: Succeeded. Aug 26 04:06:08 volumio volumio5-onboarding[1585]: time=2026-08-26T04:06:08.775Z level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Aug 26 04:06:09 volumio volumio[6202]: info: ------------------------------------------- Aug 26 04:06:09 volumio volumio[6202]: info: ----- Volumio3 ---- Aug 26 04:06:09 volumio volumio[6202]: info: ------------------------------------------- Aug 26 04:06:09 volumio volumio[6202]: info: ----- System startup ---- Aug 26 04:06:09 volumio volumio[6202]: info: ------------------------------------------- Aug 26 04:06:09 volumio volumio[6202]: info: MYVOLUMIO Environment detected Aug 26 04:06:10 volumio volumio[6202]: info: Plugin folders cleanup Aug 26 04:06:10 volumio volumio[6202]: info: Scanning into folder /volumio/app/plugins/ Aug 26 04:06:10 volumio volumio[6202]: info: Scanning category audio_interface Aug 26 04:06:10 volumio volumio[6202]: info: Scanning category miscellanea Aug 26 04:06:10 volumio volumio[6202]: info: Scanning category music_service Aug 26 04:06:10 volumio volumio[6202]: info: Scanning category plugins.json Aug 26 04:06:10 volumio volumio[6202]: info: Scanning category system_controller Aug 26 04:06:10 volumio volumio[6202]: info: Scanning category user_interface Aug 26 04:06:10 volumio volumio[6202]: info: Scanning into folder /data/plugins/ Aug 26 04:06:10 volumio volumio[6202]: info: Plugin folders cleanup completed Aug 26 04:06:10 volumio volumio[6202]: info: ------------------------------------------- Aug 26 04:06:10 volumio volumio[6202]: info: ----- Core plugins startup ---- Aug 26 04:06:10 volumio volumio[6202]: info: ------------------------------------------- Aug 26 04:06:10 volumio volumio[6202]: info: Loading plugins from folder /volumio/app/plugins/ Aug 26 04:06:10 volumio volumio[6202]: info: Adding plugin upnp to MyMusic Plugins Aug 26 04:06:10 volumio volumio[6202]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 26 04:06:10 volumio volumio[6202]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 26 04:06:10 volumio volumio[6202]: info: Loading plugins from folder /data/plugins/ Aug 26 04:06:10 volumio volumio[6202]: info: Loading plugin "system"... Aug 26 04:06:10 volumio volumio[6202]: info: Loading plugin "appearance"... Aug 26 04:06:10 volumio volumio[6202]: info: Loading plugin "network"... Aug 26 04:06:10 volumio volumio[6202]: info: Refreshing Cached IP Addresses Aug 26 04:06:10 volumio sudo[6230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 26 04:06:10 volumio sudo[6232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 26 04:06:10 volumio volumio[6202]: info: Loading plugin "services"... Aug 26 04:06:10 volumio sudo[6230]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 04:06:10 volumio volumio[6202]: info: Loading plugin "volumio5onboarding"... Aug 26 04:06:10 volumio sudo[6232]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 04:06:10 volumio sudo[6247]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 26 04:06:10 volumio volumio[6202]: info: Loading plugin "alsa_controller"... Aug 26 04:06:10 volumio sudo[6230]: pam_unix(sudo:session): session closed for user root Aug 26 04:06:10 volumio sudo[6232]: pam_unix(sudo:session): session closed for user root Aug 26 04:06:10 volumio sudo[6247]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 04:06:10 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 26 04:06:10 volumio volumio[6202]: info: Loading plugin "wizard"... Aug 26 04:06:10 volumio volumio[6202]: info: Loading plugin "networkfs"... Aug 26 04:06:11 volumio volumio[6202]: info: Starting Udev Watcher for removable devices Aug 26 04:06:11 volumio volumio[6202]: info: Ignoring mount for partition: BOOT Aug 26 04:06:11 volumio volumio[6202]: info: Ignoring mount for partition: volumio Aug 26 04:06:11 volumio volumio[6202]: info: Ignoring mount for partition: volumio_data Aug 26 04:06:11 volumio volumio[6202]: info: Mounting Device Muz Aug 26 04:06:11 volumio sudo[6286]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/Muz -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Aug 26 04:06:11 volumio sudo[6286]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 04:06:11 volumio sudo[6247]: pam_unix(sudo:session): session closed for user root Aug 26 04:06:12 volumio volumio-remote-updater[588]: [2026-08-26 04:06:12] [connect] Successful connection Aug 26 04:06:15 volumio ntfs-3g[6296]: Version 2017.3.23AR.3 integrated FUSE 28 Aug 26 04:06:15 volumio ntfs-3g[6296]: Mounted /dev/sdb1 (Read-Write, label "Muz", NTFS 3.1) Aug 26 04:06:15 volumio ntfs-3g[6296]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Aug 26 04:06:15 volumio ntfs-3g[6296]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sdb1,blkdev,blksize=4096 Aug 26 04:06:15 volumio ntfs-3g[6296]: Global ownership and permissions enforced, configuration type 7 Aug 26 04:06:15 volumio sudo[6286]: pam_unix(sudo:session): session closed for user root Aug 26 04:06:15 volumio ntfs-3g[6296]: Unmounting /dev/sdb1 (Muz) Aug 26 04:06:15 volumio volumio[6202]: The disk contains an unclean file system (0, 0). Aug 26 04:06:15 volumio volumio[6202]: The file system wasn't safely closed on Windows. Fixing. Aug 26 04:06:16 volumio volumio[6202]: info: Mounting Device Tv_Shows Aug 26 04:06:16 volumio sudo[6304]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Tv_Shows -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Aug 26 04:06:16 volumio sudo[6304]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 04:06:16 volumio ntfs-3g[6311]: Version 2017.3.23AR.3 integrated FUSE 28 Aug 26 04:06:16 volumio ntfs-3g[6311]: Mounted /dev/sda1 (Read-Write, label "Tv Shows", NTFS 3.1) Aug 26 04:06:16 volumio ntfs-3g[6311]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Aug 26 04:06:16 volumio ntfs-3g[6311]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Aug 26 04:06:16 volumio ntfs-3g[6311]: Global ownership and permissions enforced, configuration type 7 Aug 26 04:06:16 volumio sudo[6304]: pam_unix(sudo:session): session closed for user root Aug 26 04:06:16 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 26 04:06:16 volumio volumio[6202]: info: Loading plugin "volumio_command_line_client"... Aug 26 04:06:16 volumio volumio[6202]: info: Loading plugin "upnp"... Aug 26 04:06:16 volumio volumio[6202]: info: [1787717176299] Starting Upmpd Daemon Aug 26 04:06:16 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 26 04:06:16 volumio volumio[6202]: info: Loading plugin "my_music"... Aug 26 04:06:16 volumio volumio[6202]: info: Loading plugin "mpd"... Aug 26 04:06:16 volumio volumio[6202]: info: Loading plugin "upnp_browser"... Aug 26 04:06:16 volumio volumio[6202]: info: Starting UPNP Browser Aug 26 04:06:16 volumio volumio[6202]: info: Loading plugin "alarm-clock"... Aug 26 04:06:17 volumio volumio[6202]: info: Loading plugin "airplay_emulation"... Aug 26 04:06:17 volumio volumio[6202]: info: Starting Shairport Sync Aug 26 04:06:17 volumio volumio[6202]: info: Loading plugin "last_100"... Aug 26 04:06:17 volumio volumio[6202]: info: Loading plugin "webradio"... Aug 26 04:06:17 volumio volumio[6202]: info: Loading plugin "i2s_dacs"... Aug 26 04:06:17 volumio volumio[6202]: info: I2S DAC not set, start Auto-detection Aug 26 04:06:17 volumio volumio[6202]: info: Loading plugin "volumiodiscovery"... Aug 26 04:06:17 volumio volumio[6202]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 26 04:06:17 volumio volumio[6202]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 26 04:06:17 volumio volumio[6202]: *** WARNING *** For more information see Aug 26 04:06:17 volumio volumio[6202]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 26 04:06:17 volumio node[6202]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 26 04:06:17 volumio volumio[6202]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 26 04:06:17 volumio volumio[6202]: *** WARNING *** For more information see Aug 26 04:06:17 volumio node[6202]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 26 04:06:17 volumio node[6202]: *** WARNING *** For more information see Aug 26 04:06:17 volumio node[6202]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 26 04:06:17 volumio node[6202]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 26 04:06:17 volumio node[6202]: *** WARNING *** For more information see Aug 26 04:06:17 volumio volumio[6202]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 26 04:06:17 volumio volumio[6202]: info: Discovery: Started advertising with name: Volumio Aug 26 04:06:17 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 26 04:06:17 volumio volumio[6202]: info: Loading plugin "outputs"... Aug 26 04:06:17 volumio volumio[6202]: info: Loading plugin "albumart"... Aug 26 04:06:17 volumio volumio[6202]: info: Plugin example_plugin is not enabled Aug 26 04:06:17 volumio volumio[6202]: info: Loading plugin "inputs"... Aug 26 04:06:17 volumio volumio[6202]: info: Loading plugin "updater_comm"... Aug 26 04:06:17 volumio volumio[6202]: info: Plugin mpdemulation is not enabled Aug 26 04:06:17 volumio volumio[6202]: info: Loading plugin "rest_api"... Aug 26 04:06:17 volumio volumio[6202]: info: Loading plugin "websocket"... Aug 26 04:06:17 volumio volumio[6202]: info: Starting Socket.io Server version 2.3.0 Aug 26 04:06:17 volumio volumio[6202]: info: Loading i18n strings for locale en Aug 26 04:06:17 volumio volumio[6202]: Updating browse sources language Aug 26 04:06:17 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 04:06:17 volumio volumio[6202]: Forking 3 albumart workers Aug 26 04:06:17 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 04:06:17 volumio volumio[6202]: info: CoreCommandRouter::initPlayerControls Aug 26 04:06:17 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:17 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:17 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:17 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:17 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:17 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:17 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:17 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:17 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 04:06:17 volumio volumio[6202]: Express server listening on port 3000 Aug 26 04:06:17 volumio volumio[6202]: [Metrics] WebUI: 8s 736.75ms Aug 26 04:06:17 volumio volumio[6202]: info: CoreStateMachine::resetVolumioState Aug 26 04:06:17 volumio volumio[6202]: info: CoreStateMachine::getcurrentVolume Aug 26 04:06:17 volumio volumio[6202]: info: CoreCommandRouter::volumioRetrievevolume Aug 26 04:06:17 volumio volumio[6202]: info: CoreStateMachine::pushState Aug 26 04:06:17 volumio volumio[6202]: info: CorePlayQueue::getTrack 0 Aug 26 04:06:17 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 04:06:17 volumio volumio[6202]: info: CoreCommandRouter::volumioPushState Aug 26 04:06:17 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 04:06:17 volumio volumio[6202]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Aug 26 04:06:17 volumio volumio[6202]: info: Completed loading Core Plugins Aug 26 04:06:17 volumio volumio[6202]: info: Preparing to generate the ALSA configuration file Aug 26 04:06:17 volumio volumio[6202]: info: Volumio Network Manager: Network status updated: 2 Aug 26 04:06:17 volumio volumio[6202]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 1 Aug 26 04:06:17 volumio volumio[6202]: 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: 2 Aug 26 04:06:17 volumio volumio[6202]: verbose: New Socket.io Connection to 192.168.86.250 from 192.168.86.22 UA: Mozilla/5.0 (Linux; Android 13; CPH2211 Build/TP1A.220905.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/151.0.7922.199 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Aug 26 04:06:17 volumio volumio[6202]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 3 Aug 26 04:06:17 volumio volumio[6202]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 4 Aug 26 04:06:17 volumio volumio[6202]: verbose: New Socket.io Connection to 192.168.86.250 from 192.168.86.22 UA: Mozilla/5.0 (Linux; Android 13; CPH2211 Build/TP1A.220905.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/151.0.7922.199 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Aug 26 04:06:18 volumio volumio[6202]: info: Reloading queue from file Aug 26 04:06:18 volumio volumio[6202]: 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: 6 Aug 26 04:06:18 volumio volumio[6202]: info: CoreStateMachine::setRepeat false single undefined Aug 26 04:06:18 volumio volumio[6202]: info: CoreStateMachine::pushState Aug 26 04:06:18 volumio volumio[6202]: info: CorePlayQueue::getTrack 0 Aug 26 04:06:18 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 04:06:18 volumio volumio[6202]: info: CoreCommandRouter::volumioPushState Aug 26 04:06:18 volumio volumio[6202]: info: CoreStateMachine::setRandom false Aug 26 04:06:18 volumio volumio[6202]: info: CoreStateMachine::pushState Aug 26 04:06:18 volumio volumio[6202]: info: CorePlayQueue::getTrack 0 Aug 26 04:06:18 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 04:06:18 volumio volumio[6202]: info: CoreCommandRouter::volumioPushState Aug 26 04:06:18 volumio volumio[6202]: 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: 6 Aug 26 04:06:18 volumio volumio[6202]: info: Setting Device type: Tinkerboard Aug 26 04:06:18 volumio volumio[6202]: 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: 6 Aug 26 04:06:18 volumio volumio[6202]: info: Asound.conf file written Aug 26 04:06:18 volumio sudo[6354]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Aug 26 04:06:18 volumio sudo[6354]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 04:06:18 volumio sudo[6354]: pam_unix(sudo:session): session closed for user root Aug 26 04:06:18 volumio volumio[6202]: info: Output device has changed, restarting MPD Aug 26 04:06:18 volumio volumio[6202]: info: Output device has changed, restarting Shairport Sync Aug 26 04:06:18 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:18 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 04:06:18 volumio sudo[6366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 26 04:06:18 volumio sudo[6369]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 26 04:06:18 volumio sudo[6366]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 04:06:18 volumio volumio[6202]: info: ___________ START PLUGINS ___________ Aug 26 04:06:18 volumio sudo[6369]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 04:06:18 volumio sudo[6366]: pam_unix(sudo:session): session closed for user root Aug 26 04:06:18 volumio volumio[6202]: info: ControllerMpd::onStart: Initializing MPD Aug 26 04:06:18 volumio volumio[6202]: info: Creating MPD Configuration file Aug 26 04:06:18 volumio systemd[1]: Stopping Music Player Daemon... Aug 26 04:06:18 volumio sudo[6385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Aug 26 04:06:18 volumio sudo[6385]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 04:06:18 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 26 04:06:18 volumio volumio[6202]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 26 04:06:18 volumio volumio[6202]: info: [1787717178543] CoreMusicLibrary::Adding element Media Servers Aug 26 04:06:18 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 04:06:18 volumio sudo[6389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 26 04:06:18 volumio volumio[6202]: info: UPNP Browser: Client initialized successfully Aug 26 04:06:18 volumio volumio[6202]: Starting albumart workers Aug 26 04:06:18 volumio sudo[6385]: pam_unix(sudo:session): session closed for user root Aug 26 04:06:18 volumio volumio[6202]: Starting albumart workers Aug 26 04:06:18 volumio volumio[6202]: Starting albumart workers Aug 26 04:06:18 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:18 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 04:06:18 volumio sudo[6395]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 26 04:06:18 volumio sudo[6389]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 04:06:18 volumio sudo[6389]: pam_unix(sudo:session): session closed for user root Aug 26 04:06:18 volumio sudo[6395]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 04:06:18 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:18 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 04:06:18 volumio volumio[6202]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 26 04:06:18 volumio volumio[6202]: info: [1787717178724] CoreMusicLibrary::Adding element Last_100 Aug 26 04:06:18 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 04:06:18 volumio volumio[6202]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 26 04:06:18 volumio volumio[6202]: info: [1787717178730] CoreMusicLibrary::Adding element Webradio Aug 26 04:06:18 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 04:06:18 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 26 04:06:18 volumio volumio[6202]: info: Initializing BBC Radios Aug 26 04:06:18 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 26 04:06:18 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 04:06:18 volumio volumio[6202]: info: Volumio Calling Home Aug 26 04:06:19 volumio volumio[6202]: info: MPD Permissions set Aug 26 04:06:19 volumio volumio[6202]: info: MPD Permissions set Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 04:06:19 volumio volumio[6202]: info: Discovery: Getting this device information Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::volumioGetState Aug 26 04:06:19 volumio volumio[6202]: info: CorePlayQueue::getTrack 0 Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 04:06:19 volumio volumio[6202]: info: Discovery: adding a5eb5ea9-652f-4065-a247-7d5757a6d889 Aug 26 04:06:19 volumio volumio[6202]: info: Discovery: Found device Volumio Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::volumioGetState Aug 26 04:06:19 volumio volumio[6202]: info: CorePlayQueue::getTrack 0 Aug 26 04:06:19 volumio volumio[6202]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 26 04:06:19 volumio systemd[1]: mpd.service: Succeeded. Aug 26 04:06:19 volumio systemd[1]: Stopped Music Player Daemon. Aug 26 04:06:19 volumio systemd[1]: Starting Music Player Daemon... Aug 26 04:06:19 volumio volumio[6202]: verbose: New Socket.io Connection to 192.168.86.250:3000 from 192.168.86.22 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Aug 26 04:06:19 volumio sudo[6468]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 26 04:06:19 volumio sudo[6468]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 04:06:19 volumio sudo[6468]: pam_unix(sudo:session): session closed for user root Aug 26 04:06:19 volumio volumio[6202]: info: Starting Shairport Sync Aug 26 04:06:19 volumio volumio[6202]: info: Starting Shairport Sync Aug 26 04:06:19 volumio volumio[6202]: info: Starting Shairport Sync Aug 26 04:06:19 volumio sudo[6478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 26 04:06:19 volumio sudo[6478]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 04:06:19 volumio sudo[6480]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 26 04:06:19 volumio sudo[6486]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 26 04:06:19 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 26 04:06:19 volumio sudo[6480]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 04:06:19 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 26 04:06:19 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 26 04:06:19 volumio sudo[6486]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 26 04:06:19 volumio volumio[6202]: info: CoreCommandRouter::volumioGetState Aug 26 04:06:19 volumio volumio[6202]: info: CorePlayQueue::getTrack 0 Aug 26 04:06:19 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 26 04:06:19 volumio sudo[6478]: pam_unix(sudo:session): session closed for user root Aug 26 04:06:19 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 26 04:06:19 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Aug 26 04:06:19 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 26 04:06:19 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 26 04:06:19 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 26 04:06:19 volumio sudo[6480]: pam_unix(sudo:session): session closed for user root Aug 26 04:06:19 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 26 04:06:19 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Aug 26 04:06:19 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 26 04:06:19 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 26 04:06:19 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 26 04:06:19 volumio sudo[6486]: pam_unix(sudo:session): session closed for user root Aug 26 04:06:19 volumio volumio[6202]: info: Shairport-Sync Started Aug 26 04:06:19 volumio volumio[6202]: Error adding Membership: Error: addMembership EINVAL Aug 26 04:06:19 volumio volumio[6202]: info: Shairport-Sync Started Aug 26 04:06:19 volumio volumio[6202]: info: Volumio called home Aug 26 04:06:19 volumio volumio[6202]: info: Shairport-Sync Started Aug 26 04:06:20 volumio volumio[6202]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 8 Aug 26 04:06:20 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 26 04:06:20 volumio volumio[6202]: info: CoreCommandRouter::volumioGetVisibleSources Aug 26 04:06:20 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 04:06:20 volumio volumio[6202]: info: CoreCommandRouter::volumioGetState Aug 26 04:06:20 volumio volumio[6202]: info: CorePlayQueue::getTrack 0 Aug 26 04:06:20 volumio volumio[6202]: info: CoreCommandRouter::volumioGetState Aug 26 04:06:20 volumio volumio[6202]: info: CorePlayQueue::getTrack 0 Aug 26 04:06:20 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 26 04:06:20 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 26 04:06:20 volumio volumio[6202]: info: Received Get System Info Aug 26 04:06:20 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 04:06:20 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 04:06:20 volumio volumio[6202]: info: Discovery: Getting this device information Aug 26 04:06:20 volumio volumio[6202]: info: CoreCommandRouter::volumioGetState Aug 26 04:06:20 volumio volumio[6202]: info: CorePlayQueue::getTrack 0 Aug 26 04:06:20 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 04:06:20 volumio volumio[6202]: info: CoreCommandRouter::volumioGetState Aug 26 04:06:20 volumio volumio[6202]: info: CorePlayQueue::getTrack 0 Aug 26 04:06:20 volumio volumio[6202]: info: Listing playlists Aug 26 04:06:21 volumio mpd[6491]: Aug 26 04:06 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 26 04:06:21 volumio volumio[6202]: verbose: New Socket.io Connection to 192.168.86.250 from 192.168.86.22 UA: Mozilla/5.0 (Linux; Android 13; CPH2211 Build/TP1A.220905.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/151.0.7922.199 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Aug 26 04:06:21 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 26 04:06:21 volumio volumio[6202]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 26 04:06:21 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 26 04:06:21 volumio volumio[6202]: info: Received Get System Version Aug 26 04:06:21 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 26 04:06:21 volumio volumio[6202]: info: Received Get System Info Aug 26 04:06:21 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 04:06:21 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 04:06:21 volumio volumio[6202]: info: Discovery: Getting this device information Aug 26 04:06:21 volumio volumio[6202]: info: CoreCommandRouter::volumioGetState Aug 26 04:06:21 volumio volumio[6202]: info: CorePlayQueue::getTrack 0 Aug 26 04:06:21 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 04:06:21 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 26 04:06:21 volumio volumio[6202]: info: CoreCommandRouter::volumioGetVisibleSources Aug 26 04:06:21 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 26 04:06:21 volumio volumio[6202]: info: CoreCommandRouter::volumioGetState Aug 26 04:06:21 volumio volumio[6202]: info: CorePlayQueue::getTrack 0 Aug 26 04:06:21 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 26 04:06:21 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 26 04:06:21 volumio volumio[6202]: info: Received Get System Info Aug 26 04:06:21 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 26 04:06:21 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 26 04:06:21 volumio volumio[6202]: info: Discovery: Getting this device information Aug 26 04:06:21 volumio volumio[6202]: info: CoreCommandRouter::volumioGetState Aug 26 04:06:21 volumio volumio[6202]: info: CorePlayQueue::getTrack 0 Aug 26 04:06:21 volumio volumio[6202]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 26 04:06:21 volumio volumio[6202]: info: CoreCommandRouter::volumioGetState Aug 26 04:06:21 volumio volumio[6202]: info: CorePlayQueue::getTrack 0 Aug 26 04:06:21 volumio volumio[6202]: info: Listing playlists Aug 26 04:06:21 volumio volumio[6202]: info: CoreCommandRouter::volumioGetQueue Aug 26 04:06:21 volumio volumio[6202]: info: CoreStateMachine::getQueue Aug 26 04:06:21 volumio volumio[6202]: info: CorePlayQueue::getQueue Aug 26 04:06:21 volumio systemd[1]: Started Music Player Daemon. Aug 26 04:06:21 volumio sudo[6369]: pam_unix(sudo:session): session closed for user root Aug 26 04:06:21 volumio sudo[6395]: pam_unix(sudo:session): session closed for user root Aug 26 04:06:21 volumio volumio[6202]: info: Completed starting Core Plugins Aug 26 04:06:21 volumio volumio[6202]: info: ------------------------------------------- Aug 26 04:06:21 volumio volumio[6202]: info: ----- MyVolumio plugins startup ---- Aug 26 04:06:21 volumio volumio[6202]: info: ------------------------------------------- Aug 26 04:06:21 volumio volumio[6202]: info: [MyVolumio PluginManager] Fetching plans data.... Aug 26 04:06:21 volumio volumio[6202]: error: MPD error: The expression evaluated to a falsy value: Aug 26 04:06:21 volumio volumio[6202]: assert.ok(self.idling) Aug 26 04:06:21 volumio volumio[6202]: error: The expression evaluated to a falsy value: Aug 26 04:06:21 volumio volumio[6202]: assert.ok(self.idling) Aug 26 04:06:21 volumio volumio[6202]: info: MPD running with PID6491 Aug 26 04:06:21 volumio volumio[6202]: ,establishing connection Aug 26 04:06:21 volumio volumio[6202]: error: updateQueue error: null Aug 26 04:06:21 volumio volumio[6202]: error: updateQueue error: null Aug 26 04:06:24 volumio volumio[6202]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/65daysofstatic/191cfcac-3777-4b1e-8723-5a0a6f5b98de.jpg' Aug 26 04:06:24 volumio volumio[6202]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/65daysofstatic%20/e69d33ad-7ccb-4f3f-b762-abaad09a98c0.jpg' Aug 26 04:06:25 volumio volumio-remote-updater[588]: [2026-08-26 04:06:25] [connect] Successful connection Aug 26 04:06:25 volumio volumio-remote-updater[588]: [2026-08-26 04:06:25] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1787717185 101 Aug 26 04:06:25 volumio volumio[6202]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 10 Aug 26 04:06:25 volumio volumio[6202]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 04:06:25 volumio volumio[6202]: Error: connect ECONNREFUSED 158.69.210.98:443 Aug 26 04:06:25 volumio volumio[6202]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Aug 26 04:06:25 volumio volumio[6202]: errno: -111, Aug 26 04:06:25 volumio volumio[6202]: code: 'ECONNREFUSED', Aug 26 04:06:25 volumio volumio[6202]: syscall: 'connect', Aug 26 04:06:25 volumio volumio[6202]: address: '158.69.210.98', Aug 26 04:06:25 volumio volumio[6202]: port: 443 Aug 26 04:06:25 volumio volumio[6202]: } Aug 26 04:06:25 volumio volumio[6202]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 04:06:26 volumio sudo[6591]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-26 04:05 Aug 26 04:06:26 volumio sudo[6591]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="3dada8b1e619a5feb94867e0865ace17474d7bce" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="30045b259d1a704a832ca7c1460c1fdfa4b723f9" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 05 Mar 2026 12:25:22 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="cf5455596c5328b0cbc691c04ff0184a"