Oct 16 02:54:20 rivo kernel: wl_iw_event: Link Down with e6:6e:3b:33:dd:f5, reason=1 Oct 16 02:54:20 rivo kernel: CFG80211-ERROR) wl_is_linkdown : Link down Reason : WLC_E_LINK Oct 16 02:54:20 rivo kernel: link down if wlan0 may call cfg80211_disconnected. event : 16, reason=1 from e6:6e:3b:33:dd:f5 Oct 16 02:54:20 rivo kernel: dhd_dbg_stop_pkt_monitor, 1963 Oct 16 02:54:20 rivo kernel: wl_iw_event: Link Down with e6:6e:3b:33:dd:f5, reason=2 Oct 16 02:54:20 rivo kernel: CFG80211-ERROR) wl_cfg80211_tdls_config : No change in tdls state. Do nothing. tdls_enable:1 Oct 16 02:54:20 rivo kernel: CFG80211-ERROR) wl_is_linkdown : Link down Reason : WLC_E_LINK Oct 16 02:54:20 rivo kernel: CFG80211-ERROR) wl_cfg80211_tdls_config : No change in tdls state. Do nothing. tdls_enable:1 Oct 16 02:54:20 rivo wpa_supplicant[3421]: wlan0: CTRL-EVENT-DISCONNECTED bssid=e6:6e:3b:33:dd:f5 reason=0 Oct 16 02:54:20 rivo dhcpcd[2973]: wlan0: carrier lost - roaming Oct 16 02:54:20 rivo dhcpcd[2973]: wlan0: changing route to 192.168.1.0/24 Oct 16 02:54:20 rivo dhcpcd[2973]: wlan0: changing default route via 192.168.1.1 Oct 16 02:54:21 rivo volumio[3456]: info: Received Get System Info Oct 16 02:54:21 rivo volumio[3456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 02:54:21 rivo volumio[3456]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 02:54:21 rivo volumio[3456]: info: Discovery: Getting this device information Oct 16 02:54:21 rivo volumio[3456]: info: CoreCommandRouter::volumioGetState Oct 16 02:54:21 rivo volumio[3456]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 02:54:21 rivo volumio[3456]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 16 02:54:21 rivo volumio[3456]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 16 02:54:21 rivo volumio5-onboarding[4826]: time=2026-10-16T02:54:21.923+09:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 16 02:54:22 rivo ntpd[3131]: IO: Deleting interface #3 wlan0, 192.168.1.188#123, interface stats: received=5353, sent=5732, dropped=0, active_time=585959 secs Oct 16 02:54:22 rivo ntpd[3131]: PROTO: 44.30.62.51 unlink local addr 192.168.1.188 -> Oct 16 02:54:22 rivo ntpd[3131]: PROTO: 172.105.192.74 unlink local addr 192.168.1.188 -> Oct 16 02:54:22 rivo ntpd[3131]: PROTO: 138.2.23.206 unlink local addr 192.168.1.188 -> Oct 16 02:54:22 rivo ntpd[3131]: PROTO: 139.162.81.45 unlink local addr 192.168.1.188 -> Oct 16 02:54:22 rivo ntpd[3131]: PROTO: 167.179.119.205 unlink local addr 192.168.1.188 -> Oct 16 02:54:22 rivo ntpd[3131]: PROTO: 140.245.90.15 unlink local addr 192.168.1.188 -> Oct 16 02:54:22 rivo ntpd[3131]: PROTO: 208.88.66.8 unlink local addr 192.168.1.188 -> Oct 16 02:54:24 rivo wpa_supplicant[3421]: wlan0: Trying to associate with ce:6a:8b:22:f0:e0 (SSID='Starlink wifi' freq=2462 MHz) Oct 16 02:54:24 rivo kernel: Connecting with ce:6a:8b:22:f0:e0 ssid "Starlink wifi", len (13) channel=11 Oct 16 02:54:24 rivo kernel: dhd_dbg_start_pkt_monitor, 1724 Oct 16 02:54:24 rivo kernel: wl_iw_event: Link UP with ce:6a:8b:22:f0:e0 Oct 16 02:54:24 rivo kernel: wl_bss_connect_done succeeded with ce:6a:8b:22:f0:e0 Oct 16 02:54:24 rivo kernel: CFG80211-ERROR) wl_cfg80211_scan_abort : scan abort failed Oct 16 02:54:24 rivo wpa_supplicant[3421]: wlan0: Associated with ce:6a:8b:22:f0:e0 Oct 16 02:54:24 rivo wpa_supplicant[3421]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Oct 16 02:54:24 rivo kernel: wl_bss_connect_done succeeded with ce:6a:8b:22:f0:e0 vndr_oui: 00-90-4C 00-0C-43 00-0C-E7 Oct 16 02:54:24 rivo wpa_supplicant[3421]: wlan0: WPA: Key negotiation completed with ce:6a:8b:22:f0:e0 [PTK=CCMP GTK=CCMP] Oct 16 02:54:24 rivo wpa_supplicant[3421]: wlan0: CTRL-EVENT-CONNECTED - Connection to ce:6a:8b:22:f0:e0 completed [id=1 id_str=] Oct 16 02:54:24 rivo dhcpcd[2973]: wlan0: carrier acquired Oct 16 02:54:24 rivo dhcpcd[2973]: wlan0: IAID 5a:6f:51:10 Oct 16 02:54:25 rivo dhcpcd[2973]: wlan0: soliciting an IPv6 router Oct 16 02:54:25 rivo volumio[3456]: info: Received Get System Info Oct 16 02:54:25 rivo volumio[3456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 02:54:25 rivo volumio[3456]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 02:54:25 rivo volumio[3456]: info: Discovery: Getting this device information Oct 16 02:54:25 rivo volumio[3456]: info: CoreCommandRouter::volumioGetState Oct 16 02:54:25 rivo volumio[3456]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 02:54:25 rivo volumio[3456]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 16 02:54:25 rivo volumio[3456]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 16 02:54:26 rivo volumio5-onboarding[4826]: time=2026-10-16T02:54:26.107+09:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 16 02:54:26 rivo ntpd[3131]: IO: Listen normally on 4 wlan0 192.168.1.188:123 Oct 16 02:54:26 rivo ntpd[3131]: IO: new interface(s) found: waking up resolver Oct 16 02:54:26 rivo dhcpcd[2973]: wlan0: rebinding lease of 192.168.1.188 Oct 16 02:54:26 rivo dhcpcd[11207]: ps_bpf_recvmsg: Invalid argument Oct 16 02:54:28 rivo dhcpcd[11207]: ps_bpf_recvmsg: Invalid argument Oct 16 02:54:31 rivo dhcpcd[2973]: wlan0: DHCP lease expired Oct 16 02:54:31 rivo avahi-daemon[2905]: Withdrawing address record for 192.168.1.188 on wlan0. Oct 16 02:54:31 rivo avahi-daemon[2905]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.188. Oct 16 02:54:31 rivo avahi-daemon[2905]: Interface wlan0.IPv4 no longer relevant for mDNS. Oct 16 02:54:31 rivo dhcpcd[2973]: wlan0: deleting route to 192.168.1.0/24 Oct 16 02:54:31 rivo dhcpcd[2973]: wlan0: deleting default route via 192.168.1.1 Oct 16 02:54:31 rivo volumio[3456]: info: Discovery: A device disappeared from network Oct 16 02:54:31 rivo dhcpcd[2973]: wlan0: soliciting a DHCP lease Oct 16 02:54:31 rivo systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Oct 16 02:54:31 rivo systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Oct 16 02:54:31 rivo systemd[1]: welcome.service: Deactivated successfully. Oct 16 02:54:31 rivo systemd[1]: Stopped welcome.service - Show a welcome message on console. Oct 16 02:54:31 rivo systemd[1]: Stopping welcome.service - Show a welcome message on console... Oct 16 02:54:31 rivo systemd[1]: Starting welcome.service - Show a welcome message on console... Oct 16 02:54:31 rivo welcome[11228]: Resolved ip:[0] Oct 16 02:54:31 rivo systemd[1]: Finished welcome.service - Show a welcome message on console. Oct 16 02:54:31 rivo systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Oct 16 02:54:32 rivo volumio[3456]: info: Received Get System Info Oct 16 02:54:32 rivo volumio[3456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 02:54:32 rivo volumio[3456]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 02:54:32 rivo volumio[3456]: info: Discovery: Getting this device information Oct 16 02:54:32 rivo volumio[3456]: info: CoreCommandRouter::volumioGetState Oct 16 02:54:32 rivo volumio[3456]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 02:54:32 rivo volumio[3456]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 16 02:54:32 rivo volumio[3456]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 16 02:54:33 rivo volumio5-onboarding[4826]: time=2026-10-16T02:54:33.031+09:00 level=INFO msg="service successfully established" component=discovery/localnet Oct 16 02:54:33 rivo ntpd[3131]: IO: Deleting interface #4 wlan0, 192.168.1.188#123, interface stats: received=0, sent=0, dropped=0, active_time=7 secs Oct 16 02:54:33 rivo ntpd[3131]: PROTO: 208.88.66.8 unlink local addr 192.168.1.188 -> Oct 16 02:54:33 rivo ntpd[3131]: PROTO: 140.245.90.15 unlink local addr 192.168.1.188 -> Oct 16 02:54:33 rivo ntpd[3131]: PROTO: 167.179.119.205 unlink local addr 192.168.1.188 -> Oct 16 02:54:33 rivo ntpd[3131]: PROTO: 139.162.81.45 unlink local addr 192.168.1.188 -> Oct 16 02:54:33 rivo ntpd[3131]: PROTO: 138.2.23.206 unlink local addr 192.168.1.188 -> Oct 16 02:54:33 rivo ntpd[3131]: PROTO: 172.105.192.74 unlink local addr 192.168.1.188 -> Oct 16 02:54:33 rivo ntpd[3131]: PROTO: 44.30.62.51 unlink local addr 192.168.1.188 -> Oct 16 02:54:34 rivo volumio[3456]: info: Reporting MCU Network Status: 0 Oct 16 02:54:34 rivo volumio[3456]: info: Volumio Network Manager: Network status updated: 0 Oct 16 02:54:50 rivo volumio[3456]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 02:54:50 rivo volumio[3456]: Error: send ENETUNREACH 255.255.255.255:3483 Oct 16 02:54:50 rivo volumio[3456]: at doSend (node:dgram:717:16) Oct 16 02:54:50 rivo volumio[3456]: at defaultTriggerAsyncIdScope (node:internal/async_hooks:464:18) Oct 16 02:54:50 rivo volumio[3456]: at afterDns (node:dgram:663:5) Oct 16 02:54:50 rivo volumio[3456]: at processTicksAndRejections (node:internal/process/task_queues:83:21) Oct 16 02:54:50 rivo volumio[3456]: at runNextTicks (node:internal/process/task_queues:64:3) Oct 16 02:54:50 rivo volumio[3456]: at listOnTimeout (node:internal/timers:540:9) Oct 16 02:54:50 rivo volumio[3456]: at process.processTimers (node:internal/timers:514:7) { Oct 16 02:54:50 rivo volumio[3456]: errno: -101, Oct 16 02:54:50 rivo volumio[3456]: code: 'ENETUNREACH', Oct 16 02:54:50 rivo volumio[3456]: syscall: 'send', Oct 16 02:54:50 rivo volumio[3456]: address: '255.255.255.255', Oct 16 02:54:50 rivo volumio[3456]: port: 3483 Oct 16 02:54:50 rivo volumio[3456]: } Oct 16 02:54:50 rivo volumio[3456]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 02:54:51 rivo sudo[11284]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-16 02:53' Oct 16 02:54:51 rivo sudo[11284]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:54:51 rivo sudo[11284]: pam_unix(sudo:session): session closed for user root Oct 16 02:54:51 rivo volumio-remote-updater[2934]: [2026-10-16 02:54:51] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Oct 16 02:54:51 rivo volumio-remote-updater[2934]: [2026-10-16 02:54:51] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Oct 16 02:54:51 rivo vtcs[21770]: [2026-10-16 02:54:51.695] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected Oct 16 02:54:51 rivo volumio5-onboarding[4826]: time=2026-10-16T02:54:51.713+09:00 level=ERROR msg="failed reading message" error="websocket: close 1006 (abnormal closure): unexpected EOF" Oct 16 02:54:51 rivo qobuz-connect[21690]: 20261016 02:54:51.749 [21690.21690] INFO SampleApp: Socket closed Oct 16 02:54:51 rivo systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 16 02:54:51 rivo sudo[4051]: pam_unix(sudo:session): session closed for user root Oct 16 02:54:51 rivo volumio5-onboarding[4826]: time=2026-10-16T02:54:51.813+09:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Oct 16 02:54:51 rivo systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 16 02:54:51 rivo systemd[1]: Started dynamicswap.service - dynamicswap service. Oct 16 02:54:52 rivo systemd[1]: dynamicswap.service: Deactivated successfully. Oct 16 02:54:52 rivo systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Oct 16 02:54:52 rivo systemd[1]: Started dynamicswap.service - dynamicswap service. Oct 16 02:54:52 rivo systemd[1]: Stopped volumio.service - Volumio Backend Module. Oct 16 02:54:52 rivo systemd[1]: Started volumio.service - Volumio Backend Module. Oct 16 02:54:52 rivo systemd[1]: dynamicswap.service: Deactivated successfully. Oct 16 02:54:52 rivo volumio5-onboarding[4826]: time=2026-10-16T02:54:52.820+09:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Oct 16 02:54:53 rivo volumio5-onboarding[4826]: time=2026-10-16T02:54:53.824+09:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Oct 16 02:54:55 rivo volumio[11305]: info: ------------------------------------------- Oct 16 02:54:55 rivo volumio[11305]: info: ----- Volumio3 ---- Oct 16 02:54:55 rivo volumio[11305]: info: ------------------------------------------- Oct 16 02:54:55 rivo volumio[11305]: info: ----- System startup ---- Oct 16 02:54:55 rivo volumio[11305]: info: ------------------------------------------- Oct 16 02:54:56 rivo volumio[11305]: info: MYVOLUMIO Environment detected Oct 16 02:54:56 rivo volumio[11305]: info: Plugin folders cleanup Oct 16 02:54:56 rivo volumio[11305]: info: Scanning into folder /volumio/app/plugins/ Oct 16 02:54:56 rivo volumio[11305]: info: Scanning category audio_interface Oct 16 02:54:56 rivo volumio[11305]: info: Scanning category miscellanea Oct 16 02:54:56 rivo volumio[11305]: info: Scanning category music_service Oct 16 02:54:56 rivo volumio[11305]: info: Scanning category plugins.json Oct 16 02:54:56 rivo volumio[11305]: info: Scanning category system_controller Oct 16 02:54:56 rivo volumio[11305]: info: Scanning category user_interface Oct 16 02:54:56 rivo volumio[11305]: info: Scanning into folder /data/plugins/ Oct 16 02:54:56 rivo volumio[11305]: info: Scanning category music_service Oct 16 02:54:56 rivo volumio[11305]: info: Plugin folders cleanup completed Oct 16 02:54:56 rivo volumio[11305]: info: ------------------------------------------- Oct 16 02:54:56 rivo volumio[11305]: info: ----- Core plugins startup ---- Oct 16 02:54:56 rivo volumio[11305]: info: ------------------------------------------- Oct 16 02:54:56 rivo volumio[11305]: info: Loading plugins from folder /volumio/app/plugins/ Oct 16 02:54:56 rivo volumio[11305]: info: Adding plugin bluetooth to MyMusic Plugins Oct 16 02:54:56 rivo volumio[11305]: info: Adding plugin multiroom to MyMusic Plugins Oct 16 02:54:56 rivo volumio[11305]: info: Adding plugin upnp to MyMusic Plugins Oct 16 02:54:56 rivo volumio[11305]: info: Adding plugin metavolumio to MyMusic Plugins Oct 16 02:54:56 rivo volumio[11305]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 16 02:54:56 rivo volumio[11305]: info: Adding plugin cd_controller to MyMusic Plugins Oct 16 02:54:56 rivo volumio[11305]: info: Adding plugin qobuzconnect to MyMusic Plugins Oct 16 02:54:56 rivo volumio[11305]: info: Adding plugin raat to MyMusic Plugins Oct 16 02:54:56 rivo volumio[11305]: info: Adding plugin smart_inputs to MyMusic Plugins Oct 16 02:54:56 rivo volumio[11305]: info: Adding plugin tidalconnect to MyMusic Plugins Oct 16 02:54:56 rivo volumio[11305]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 16 02:54:56 rivo volumio[11305]: info: Loading plugins from folder /data/plugins/ Oct 16 02:54:56 rivo volumio[11305]: info: Loading plugin "system"... Oct 16 02:54:56 rivo volumio[11305]: info: Loading plugin "appearance"... Oct 16 02:54:56 rivo volumio-remote-updater[2934]: [2026-10-16 02:54:56] [connect] Successful connection Oct 16 02:54:58 rivo volumio[11305]: info: Loading plugin "network"... Oct 16 02:54:58 rivo volumio[11305]: info: Refreshing Cached IP Addresses Oct 16 02:54:58 rivo sudo[11334]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 16 02:54:58 rivo sudo[11334]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:54:58 rivo volumio[11305]: info: Loading plugin "services"... Oct 16 02:54:58 rivo volumio[11305]: info: Loading plugin "volumio5onboarding"... Oct 16 02:54:58 rivo sudo[11336]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 02:54:58 rivo sudo[11336]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:54:58 rivo sudo[11334]: pam_unix(sudo:session): session closed for user root Oct 16 02:54:58 rivo volumio[11305]: info: Loading plugin "alsa_controller"... Oct 16 02:54:58 rivo sudo[11336]: pam_unix(sudo:session): session closed for user root Oct 16 02:54:58 rivo sudo[11343]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 16 02:54:58 rivo sudo[11343]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:54:58 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f95c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 02:54:58 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f95c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 02:54:58 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 02:54:58 rivo volumio[11305]: info: Loading plugin "wizard"... Oct 16 02:54:58 rivo volumio[11305]: info: Loading plugin "networkfs"... Oct 16 02:54:58 rivo volumio[11305]: info: Starting Udev Watcher for removable devices Oct 16 02:54:58 rivo volumio[11305]: info: Ignoring mount for partition: BOOT Oct 16 02:54:58 rivo volumio[11305]: info: Ignoring mount for partition: volumio Oct 16 02:54:58 rivo volumio[11305]: info: Ignoring mount for partition: volumio_data Oct 16 02:54:58 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 16 02:54:58 rivo volumio[11305]: info: Loading plugin "volumio_command_line_client"... Oct 16 02:54:58 rivo volumio[11305]: info: Loading plugin "upnp"... Oct 16 02:54:58 rivo volumio[11305]: info: [1792086898717] Starting Upmpd Daemon Oct 16 02:54:58 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 16 02:54:58 rivo volumio[11305]: info: Loading plugin "my_music"... Oct 16 02:54:58 rivo volumio[11305]: info: Loading plugin "mpd"... Oct 16 02:54:58 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f95c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 02:54:58 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f95c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 02:54:58 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f95c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 02:54:58 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f95c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 02:54:58 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f95c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 02:54:58 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f95c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 02:54:58 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f95c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 02:54:58 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f95c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 02:54:59 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f95c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 02:54:59 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f95c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 02:54:59 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f95c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 02:54:59 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f95c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 02:54:59 rivo volumio[11305]: info: Loading plugin "upnp_browser"... Oct 16 02:54:59 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f95c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 02:54:59 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f95c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 02:54:59 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f95c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 02:54:59 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f95c000 drv_status 0x0 e_type 69 e_states 8 Oct 16 02:55:00 rivo volumio[11305]: info: Starting UPNP Browser Oct 16 02:55:00 rivo volumio[11305]: info: Loading plugin "bluetooth"... Oct 16 02:55:01 rivo volumio[11305]: info: Applying required configuration parameters for plugin bluetooth Oct 16 02:55:01 rivo volumio[11305]: info: Applying required configuration parameters for plugin bluetooth Oct 16 02:55:01 rivo volumio[11305]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart Oct 16 02:55:01 rivo volumio[11305]: info: Loading plugin "alarm-clock"... Oct 16 02:55:01 rivo volumio[11305]: info: Loading plugin "manifestui"... Oct 16 02:55:01 rivo volumio[11305]: info: Loading plugin "metavolumio"... Oct 16 02:55:02 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04f95c000 drv_status 0x0 e_type 69 e_states 0 Oct 16 02:55:03 rivo sudo[11343]: pam_unix(sudo:session): session closed for user root Oct 16 02:55:03 rivo volumio[11305]: info: Loading plugin "airplay_emulation"... Oct 16 02:55:03 rivo volumio[11305]: info: Starting Shairport Sync Oct 16 02:55:03 rivo volumio[11305]: info: Loading plugin "cd_controller"... Oct 16 02:55:03 rivo volumio[11305]: info: Loading plugin "last_100"... Oct 16 02:55:03 rivo volumio[11305]: info: Loading plugin "qobuzconnect"... Oct 16 02:55:03 rivo volumio[11305]: info: Loading plugin "raat"... Oct 16 02:55:04 rivo volumio[11305]: info: RAAT Plugin loaded Oct 16 02:55:04 rivo volumio[11305]: info: Adding restartRAATSocket REST API Endpoint Oct 16 02:55:04 rivo volumio[11305]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat Oct 16 02:55:04 rivo volumio[11305]: info: Loading plugin "streaming_services"... Oct 16 02:55:04 rivo volumio5-onboarding[4826]: time=2026-10-16T02:55:04.826+09:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:55136->127.0.0.1:3000: i/o timeout" Oct 16 02:55:05 rivo volumio[11305]: info: Loading plugin "tidalconnect"... Oct 16 02:55:05 rivo volumio[11305]: info: Loading plugin "webradio"... Oct 16 02:55:05 rivo volumio[11305]: info: Loading plugin "i2s_dacs"... Oct 16 02:55:05 rivo volumio[11305]: info: I2S DAC not set, start Auto-detection Oct 16 02:55:05 rivo volumio[11305]: info: Loading plugin "volumiodiscovery"... Oct 16 02:55:06 rivo volumio[11305]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 16 02:55:06 rivo volumio[11305]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 02:55:06 rivo volumio[11305]: *** WARNING *** For more information see Oct 16 02:55:06 rivo volumio[11305]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 16 02:55:06 rivo volumio[11305]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 02:55:06 rivo node[11305]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 16 02:55:06 rivo volumio[11305]: *** WARNING *** For more information see Oct 16 02:55:06 rivo node[11305]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 02:55:06 rivo node[11305]: *** WARNING *** For more information see Oct 16 02:55:06 rivo node[11305]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 16 02:55:06 rivo node[11305]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 16 02:55:06 rivo node[11305]: *** WARNING *** For more information see Oct 16 02:55:06 rivo volumio[11305]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 16 02:55:06 rivo volumio[11305]: info: Discovery: Started advertising with name: Rivo Oct 16 02:55:06 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 16 02:55:06 rivo volumio[11305]: info: Loading plugin "squeezelite_mc"... Oct 16 02:55:07 rivo nmbd[3199]: [2026/10/16 02:55:07.000077, 0] ../../source3/nmbd/nmbd.c:359(reload_interfaces) Oct 16 02:55:07 rivo nmbd[3199]: reload_interfaces: No subnets to listen to. Waiting.. Oct 16 02:55:07 rivo volumio[11305]: info: Loading plugin "multiroom"... Oct 16 02:55:09 rivo volumio-remote-updater[2934]: [2026-10-16 02:55:09] [connect] Successful connection Oct 16 02:55:09 rivo volumio[11305]: info: Applying required configuration parameters for plugin multiroom Oct 16 02:55:09 rivo sudo[11397]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Oct 16 02:55:09 rivo sudo[11397]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:55:09 rivo sudo[11397]: pam_unix(sudo:session): session closed for user root Oct 16 02:55:09 rivo volumio[11305]: /usr/bin/mkdir: cannot create directory ‘/tmp/hls’: File exists Oct 16 02:55:09 rivo volumio[11305]: info: MRS: MultiRoom plugin initialized Oct 16 02:55:09 rivo volumio[11305]: info: MRS: STOPPING SNAPCLIENT Oct 16 02:55:09 rivo volumio[11305]: info: MRS: Snap server stop Oct 16 02:55:09 rivo volumio[11305]: info: MRS: STOPPING volumioStreaming Oct 16 02:55:09 rivo sudo[11414]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Oct 16 02:55:09 rivo sudo[11414]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:55:09 rivo volumio[11305]: info: Loading plugin "outputs"... Oct 16 02:55:09 rivo sudo[11415]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Oct 16 02:55:09 rivo sudo[11415]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:55:09 rivo sudo[11417]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Oct 16 02:55:09 rivo sudo[11417]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:55:09 rivo volumio[11305]: info: Loading plugin "albumart"... Oct 16 02:55:09 rivo sudo[11421]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Oct 16 02:55:09 rivo sudo[11421]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:55:09 rivo volumio[11305]: info: Plugin example_plugin is not enabled Oct 16 02:55:09 rivo volumio[11305]: info: Loading plugin "hi_res_audio"... Oct 16 02:55:09 rivo sudo[11421]: pam_unix(sudo:session): session closed for user root Oct 16 02:55:09 rivo sudo[11415]: pam_unix(sudo:session): session closed for user root Oct 16 02:55:09 rivo sudo[11414]: pam_unix(sudo:session): session closed for user root Oct 16 02:55:09 rivo sudo[11417]: pam_unix(sudo:session): session closed for user root Oct 16 02:55:10 rivo volumio[11423]: Forking 3 albumart workers Oct 16 02:55:10 rivo kernel: wl_iw_event: Link Down with ce:6a:8b:22:f0:e0, reason=1 Oct 16 02:55:10 rivo kernel: CFG80211-ERROR) wl_is_linkdown : Link down Reason : WLC_E_LINK Oct 16 02:55:10 rivo kernel: link down if wlan0 may call cfg80211_disconnected. event : 16, reason=1 from ce:6a:8b:22:f0:e0 Oct 16 02:55:10 rivo kernel: dhd_dbg_stop_pkt_monitor, 1963 Oct 16 02:55:10 rivo kernel: wl_iw_event: Link Down with ce:6a:8b:22:f0:e0, reason=2 Oct 16 02:55:10 rivo kernel: CFG80211-ERROR) wl_cfg80211_tdls_config : No change in tdls state. Do nothing. tdls_enable:1 Oct 16 02:55:10 rivo kernel: CFG80211-ERROR) wl_is_linkdown : Link down Reason : WLC_E_LINK Oct 16 02:55:10 rivo kernel: CFG80211-ERROR) wl_cfg80211_tdls_config : No change in tdls state. Do nothing. tdls_enable:1 Oct 16 02:55:10 rivo wpa_supplicant[3421]: wlan0: CTRL-EVENT-DISCONNECTED bssid=ce:6a:8b:22:f0:e0 reason=0 Oct 16 02:55:10 rivo wpa_supplicant[3421]: BSSID ce:6a:8b:22:f0:e0 ignore list count incremented to 2, ignoring for 10 seconds Oct 16 02:55:10 rivo dhcpcd[2973]: wlan0: carrier lost - roaming Oct 16 02:55:11 rivo volumio[11305]: info: Applying required configuration parameters for plugin hi_res_audio Oct 16 02:55:12 rivo volumio[11305]: info: Loading plugin "inputs"... Oct 16 02:55:12 rivo volumio[11432]: Starting albumart workers Oct 16 02:55:12 rivo volumio[11431]: Starting albumart workers Oct 16 02:55:12 rivo volumio[11433]: Starting albumart workers Oct 16 02:55:13 rivo volumio[11305]: info: Loading plugin "qobuz"... Oct 16 02:55:13 rivo volumio5-onboarding[4826]: time=2026-10-16T02:55:13.494+09:00 level=ERROR msg="failed to update discovery on Wi-Fi info change" error="failed to get system info: could not get system info: context deadline exceeded" Oct 16 02:55:15 rivo volumio[11305]: info: Loading plugin "smart_inputs"... Oct 16 02:55:15 rivo volumio[11305]: info: Loading plugin "tidal"... Oct 16 02:55:15 rivo volumio5-onboarding[4826]: time=2026-10-16T02:55:15.829+09:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:55158->127.0.0.1:3000: i/o timeout" Oct 16 02:55:16 rivo volumio[11305]: info: Loading plugin "rivocontrol"... Oct 16 02:55:17 rivo volumio[11305]: info: Adding this device properties Oct 16 02:55:17 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Oct 16 02:55:17 rivo volumio[11305]: info: Setting Additional Device Volumio Properties: [object Object] Oct 16 02:55:17 rivo volumio[11305]: info: Loading plugin "updater_comm"... Oct 16 02:55:17 rivo volumio[11305]: info: Loading plugin "cec_controller"... Oct 16 02:55:17 rivo volumio[11305]: info: Applying required configuration parameters for plugin cec_controller Oct 16 02:55:17 rivo volumio[11305]: info: Plugin mpdemulation is not enabled Oct 16 02:55:17 rivo volumio[11305]: info: Loading plugin "rest_api"... Oct 16 02:55:17 rivo volumio[11305]: info: Loading plugin "websocket"... Oct 16 02:55:17 rivo volumio[11305]: info: Starting Socket.io Server version 1.7.4 Oct 16 02:55:17 rivo volumio[11305]: info: Loading i18n strings for locale ja Oct 16 02:55:18 rivo volumio[11305]: Updating browse sources language Oct 16 02:55:18 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 02:55:18 rivo wpa_supplicant[3421]: wlan0: Trying to associate with e6:6e:3b:33:dd:f5 (SSID='Starlink wifi' freq=5220 MHz) Oct 16 02:55:18 rivo kernel: Connecting with e6:6e:3b:33:dd:f5 ssid "Starlink wifi", len (13) channel=44 Oct 16 02:55:18 rivo kernel: dhd_dbg_start_pkt_monitor, 1724 Oct 16 02:55:18 rivo kernel: wl_iw_event: Link UP with e6:6e:3b:33:dd:f5 Oct 16 02:55:18 rivo kernel: wl_bss_connect_done succeeded with e6:6e:3b:33:dd:f5 Oct 16 02:55:18 rivo kernel: CFG80211-ERROR) wl_cfg80211_scan_abort : scan abort failed Oct 16 02:55:18 rivo wpa_supplicant[3421]: wlan0: Associated with e6:6e:3b:33:dd:f5 Oct 16 02:55:18 rivo wpa_supplicant[3421]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Oct 16 02:55:18 rivo kernel: wl_bss_connect_done succeeded with e6:6e:3b:33:dd:f5 vndr_oui: 00-90-4C 00-0C-43 00-0C-E7 Oct 16 02:55:18 rivo wpa_supplicant[3421]: wlan0: WPA: Key negotiation completed with e6:6e:3b:33:dd:f5 [PTK=CCMP GTK=CCMP] Oct 16 02:55:18 rivo wpa_supplicant[3421]: wlan0: CTRL-EVENT-CONNECTED - Connection to e6:6e:3b:33:dd:f5 completed [id=1 id_str=] Oct 16 02:55:18 rivo dhcpcd[2973]: wlan0: carrier acquired Oct 16 02:55:18 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 02:55:18 rivo volumio[11305]: info: CoreCommandRouter::initPlayerControls Oct 16 02:55:18 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 02:55:18 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 02:55:18 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 02:55:18 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 02:55:18 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 02:55:18 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 02:55:18 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 02:55:18 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 02:55:18 rivo dhcpcd[2973]: wlan0: IAID 5a:6f:51:10 Oct 16 02:55:18 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 02:55:18 rivo volumio[11305]: Express server listening on port 3000 Oct 16 02:55:18 rivo volumio[11305]: [Metrics] WebUI: 24s 68.25ms Oct 16 02:55:18 rivo volumio[11305]: info: CoreStateMachine::resetVolumioState Oct 16 02:55:18 rivo volumio[11305]: info: CoreStateMachine::getcurrentVolume Oct 16 02:55:18 rivo volumio[11305]: info: CoreCommandRouter::volumioRetrievevolume Oct 16 02:55:18 rivo volumio[11305]: info: CoreStateMachine::pushState Oct 16 02:55:18 rivo volumio[11305]: info: CorePlayQueue::getTrack 0 Oct 16 02:55:18 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 02:55:18 rivo volumio[11305]: info: CoreCommandRouter::volumioPushState Oct 16 02:55:18 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 02:55:18 rivo volumio[11305]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Oct 16 02:55:18 rivo volumio[11305]: info: Completed loading Core Plugins Oct 16 02:55:18 rivo volumio[11305]: info: Preparing to generate the ALSA configuration file Oct 16 02:55:18 rivo sudo[11495]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 16 02:55:18 rivo sudo[11493]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 16 02:55:18 rivo sudo[11493]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:55:18 rivo sudo[11495]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:55:18 rivo sudo[11495]: pam_unix(sudo:session): session closed for user root Oct 16 02:55:18 rivo sudo[11493]: pam_unix(sudo:session): session closed for user root Oct 16 02:55:18 rivo volumio[11305]: info: Cannot read play queue from file Oct 16 02:55:18 rivo volumio[11305]: info: Volumio Network Manager: Network status updated: 0 Oct 16 02:55:18 rivo volumio[11305]: info: MRS: Removed streaming files Oct 16 02:55:18 rivo volumio[11305]: info: MRS: volumioStreaming STOPPED Oct 16 02:55:18 rivo volumio[11305]: info: MRS: SNAPSERVER STOPPED Oct 16 02:55:18 rivo volumio[11305]: info: MRS: SNAPCLIENT STOPPED Oct 16 02:55:18 rivo volumio[11305]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Oct 16 02:55:18 rivo volumio[11305]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Oct 16 02:55:18 rivo volumio[11305]: info: Reading ALSA contributions from plugins. Oct 16 02:55:18 rivo volumio[11305]: 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 Oct 16 02:55:19 rivo volumio[11305]: info: CoreStateMachine::setRepeat null single undefined Oct 16 02:55:19 rivo volumio[11305]: info: CoreStateMachine::pushState Oct 16 02:55:19 rivo volumio[11305]: info: CorePlayQueue::getTrack 0 Oct 16 02:55:19 rivo volumio[11305]: info: CoreCommandRouter::volumioPushState Oct 16 02:55:19 rivo volumio[11305]: info: CoreStateMachine::setRandom null Oct 16 02:55:19 rivo volumio[11305]: info: CoreStateMachine::pushState Oct 16 02:55:19 rivo volumio[11305]: info: CorePlayQueue::getTrack 0 Oct 16 02:55:19 rivo volumio[11305]: info: CoreCommandRouter::volumioPushState Oct 16 02:55:19 rivo volumio[11305]: 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: 2 Oct 16 02:55:19 rivo dhcpcd[2973]: wlan0: soliciting an IPv6 router Oct 16 02:55:19 rivo volumio[11305]: 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 Oct 16 02:55:19 rivo sudo[11523]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 16 02:55:19 rivo sudo[11523]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:55:19 rivo volumio[11305]: info: Discovery: adding 28e29ad5-824a-495b-8092-7ef54284c330 Oct 16 02:55:19 rivo volumio[11305]: info: Discovery: Found device Rivo Oct 16 02:55:19 rivo volumio[11305]: info: CoreCommandRouter::volumioGetState Oct 16 02:55:19 rivo volumio[11305]: info: CorePlayQueue::getTrack 0 Oct 16 02:55:19 rivo volumio[11305]: info: MRS: Pushing multiroomSync output for this device Oct 16 02:55:19 rivo volumio[11305]: info: MRS: Pushing multiroomSync output Oct 16 02:55:19 rivo volumio[11305]: info: Adding audio output: Oct 16 02:55:19 rivo volumio[11305]: info: Adding audio output: Oct 16 02:55:19 rivo volumio[11305]: 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 Oct 16 02:55:19 rivo volumio[11305]: info: Asound.conf file unchanged, so no further update is needed Oct 16 02:55:19 rivo volumio[11305]: info: Output device has changed, restarting MPD Oct 16 02:55:19 rivo sudo[11523]: pam_unix(sudo:session): session closed for user root Oct 16 02:55:19 rivo volumio[11305]: info: Output device has changed, restarting Shairport Sync Oct 16 02:55:19 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 02:55:19 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 02:55:19 rivo sudo[11526]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 16 02:55:19 rivo sudo[11526]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:55:19 rivo sudo[11526]: pam_unix(sudo:session): session closed for user root Oct 16 02:55:19 rivo sudo[11528]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 16 02:55:19 rivo sudo[11528]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:55:19 rivo volumio[11305]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 16 02:55:19 rivo volumio[11305]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 16 02:55:19 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 02:55:19 rivo volumio[11305]: info: ___________ START PLUGINS ___________ Oct 16 02:55:19 rivo systemd[1]: Stopping mpd.service - Music Player Daemon... Oct 16 02:55:19 rivo volumio[11305]: info: ControllerMpd::onStart: Initializing MPD Oct 16 02:55:19 rivo volumio[11305]: info: Creating MPD Configuration file Oct 16 02:55:19 rivo sudo[11537]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Oct 16 02:55:19 rivo sudo[11537]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:55:19 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 02:55:19 rivo volumio[11305]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 02:55:19 rivo volumio[11305]: info: [1792086919313] CoreMusicLibrary::Adding element DLNAサーバー Oct 16 02:55:19 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 02:55:19 rivo sudo[11539]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 16 02:55:19 rivo sudo[11539]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:55:19 rivo volumio[11305]: info: UPNP Browser: Client initialized successfully Oct 16 02:55:19 rivo sudo[11539]: pam_unix(sudo:session): session closed for user root Oct 16 02:55:19 rivo volumio[11305]: ------------------------------------ BT MESSAGE: [FUNC] onStart Oct 16 02:55:19 rivo volumio[11305]: ------------------------------------ BT MESSAGE: Starting Volumio Bluetooth Service Oct 16 02:55:19 rivo sudo[11537]: pam_unix(sudo:session): session closed for user root Oct 16 02:55:19 rivo sudo[11543]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 16 02:55:19 rivo sudo[11543]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:55:19 rivo volumio[11305]: ------------------------------------ BT MESSAGE: Boot config /etc/bluetooth/volumio.conf: cache mode = tmp Oct 16 02:55:19 rivo volumio[11305]: ------------------------------------ BT MESSAGE: [metaCache] Directory exists and is ready. Oct 16 02:55:19 rivo volumio[11305]: info: Adding METAVOLUMIO REST API Endpoints Oct 16 02:55:19 rivo volumio[11305]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Oct 16 02:55:19 rivo volumio[11305]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Oct 16 02:55:19 rivo volumio[11305]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Oct 16 02:55:19 rivo volumio[11305]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Oct 16 02:55:19 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 02:55:19 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 02:55:19 rivo volumio[11305]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 16 02:55:19 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 02:55:19 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 02:55:19 rivo bluetoothd[3292]: Path / reserved for Adv Monitor app :1.183 Oct 16 02:55:19 rivo bluetoothd[3292]: Adv Monitor app :1.183 disconnected from D-Bus Oct 16 02:55:19 rivo volumio[11305]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 16 02:55:19 rivo volumio[11305]: info: Preparing CD Folders Oct 16 02:55:19 rivo volumio[11305]: info: Adding CD REST API Endpoints Oct 16 02:55:19 rivo volumio[11305]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Oct 16 02:55:19 rivo volumio[11305]: info: Starting UDEV Watcher for CD Oct 16 02:55:19 rivo volumio[11305]: info: Detecting CD presence with UDEV Oct 16 02:55:19 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Oct 16 02:55:20 rivo dhcpcd[2973]: wlan0: soliciting a DHCP lease Oct 16 02:55:20 rivo dhcpcd[2973]: wlan0: probing address 192.168.1.188/24 Oct 16 02:55:20 rivo systemd[1]: mpd.service: Deactivated successfully. Oct 16 02:55:20 rivo systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 16 02:55:20 rivo systemd[1]: mpd.socket: Deactivated successfully. Oct 16 02:55:20 rivo systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 16 02:55:20 rivo systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 16 02:55:20 rivo dhcpcd[11556]: ps_bpf_recvmsg: Invalid argument Oct 16 02:55:20 rivo systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 16 02:55:20 rivo systemd[1]: Starting mpd.service - Music Player Daemon... Oct 16 02:55:20 rivo sudo[11562]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 16 02:55:20 rivo sudo[11562]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 16 02:55:20 rivo sudo[11562]: pam_unix(sudo:session): session closed for user root Oct 16 02:55:21 rivo volumio5-onboarding[4826]: time=2026-10-16T02:55:21.672+09:00 level=ERROR msg="failed to update discovery on Wi-Fi info change" error="failed to get system info: could not get system info: context deadline exceeded" Oct 16 02:55:21 rivo dhcpcd[11556]: ps_bpf_recvmsg: Invalid argument Oct 16 02:55:23 rivo dhcpcd[11556]: ps_bpf_recvmsg: Invalid argument Oct 16 02:55:24 rivo volumio-remote-updater[2934]: [2026-10-16 02:55:24] [connect] Successful connection Oct 16 02:55:24 rivo volumio[11305]: warn: [cd-plugin] cdspeedctl: device or media not ready Oct 16 02:55:24 rivo volumio[11305]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 02:55:24 rivo volumio[11305]: info: [1792086924602] CoreMusicLibrary::Adding element Last_100 Oct 16 02:55:24 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 02:55:24 rivo volumio[11305]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Oct 16 02:55:24 rivo volumio[11305]: info: QobuzConnect: Starting Qobuz Connect socket and service Oct 16 02:55:24 rivo volumio[11305]: info: Starting RAAT Plugin Oct 16 02:55:24 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Oct 16 02:55:24 rivo volumio[11305]: info: Additional UI Settings Added for plugin music_service/raat Oct 16 02:55:24 rivo volumio[11305]: info: Registering DSP Elements listener and retrieving current ones Oct 16 02:55:24 rivo volumio[11305]: info: Additional DSP elements updated Oct 16 02:55:24 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 02:55:24 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 02:55:24 rivo volumio[11305]: info: Updating RAAT Signal Path Oct 16 02:55:24 rivo volumio[11305]: error: Cannot write to RAAT Client: TypeError: Cannot read properties of undefined (reading 'write') Oct 16 02:55:24 rivo volumio[11305]: info: Streaming services startup Oct 16 02:55:24 rivo volumio[11305]: info: Starting Streaming Daemon Oct 16 02:55:24 rivo sudo[11571]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Oct 16 02:55:24 rivo sudo[11571]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:55:24 rivo sudo[11573]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 16 02:55:24 rivo sudo[11573]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:55:24 rivo mpd[11566]: 2026-10-16T02:55:24 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 16 02:55:24 rivo sudo[11571]: pam_unix(sudo:session): session closed for user root Oct 16 02:55:24 rivo sudo[11579]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Oct 16 02:55:24 rivo sudo[11579]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:55:24 rivo volumio[11305]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 16 02:55:24 rivo volumio[11305]: info: [1792086924766] CoreMusicLibrary::Adding element Webradio Oct 16 02:55:24 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 02:55:24 rivo systemd[1]: Started mpd.service - Music Player Daemon. Oct 16 02:55:24 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 02:55:24 rivo volumio[11305]: info: Initializing BBC Radios Oct 16 02:55:24 rivo sudo[11543]: pam_unix(sudo:session): session closed for user root Oct 16 02:55:24 rivo sudo[11528]: pam_unix(sudo:session): session closed for user root Oct 16 02:55:24 rivo sudo[11584]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 16 02:55:24 rivo sudo[11573]: pam_unix(sudo:session): session closed for user root Oct 16 02:55:24 rivo sudo[11584]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:55:24 rivo systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Oct 16 02:55:24 rivo systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Oct 16 02:55:24 rivo systemd[1]: vtcs.service: Deactivated successfully. Oct 16 02:55:24 rivo systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Oct 16 02:55:24 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 16 02:55:24 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 02:55:24 rivo qobuz-connect[21690]: 20261016 02:55:24.905 [21690.21690] INFO SampleApp: Stopping Local configuration server Oct 16 02:55:24 rivo sudo[11584]: pam_unix(sudo:session): session closed for user root Oct 16 02:55:24 rivo volumio[11305]: info: [squeezelite_mc] Starting proxy server... Oct 16 02:55:24 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Oct 16 02:55:24 rivo volumio[11305]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 16 02:55:24 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 02:55:24 rivo volumio[11305]: error: Hi Res Audio Failed Login: Missing Login Data Oct 16 02:55:24 rivo volumio[11305]: info: Adding HIGHRESAUDIO REST API Endpoints Oct 16 02:55:24 rivo volumio[11305]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Oct 16 02:55:24 rivo volumio[11305]: info: Initializing Serial Communication on port /dev/ttyS3 Oct 16 02:55:24 rivo volumio[11305]: info: Touch Event Listener Process Starting Oct 16 02:55:24 rivo kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 115200 to 115200 Oct 16 02:55:25 rivo volumio[11305]: info: Adding inputs REST Endpoints Oct 16 02:55:25 rivo volumio[11305]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Oct 16 02:55:25 rivo volumio[11305]: info: Scanning Audio Inputs Oct 16 02:55:25 rivo sudo[11603]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Oct 16 02:55:25 rivo sudo[11603]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:55:25 rivo volumio[11305]: info: Checking against Known Cards name Oct 16 02:55:25 rivo volumio[11305]: info: Checking against Known Cards name Oct 16 02:55:25 rivo volumio[11305]: info: Checking against Known Cards name Oct 16 02:55:25 rivo volumio[11305]: info: Checking against Known Cards name Oct 16 02:55:25 rivo volumio[11305]: info: Checking against Known Cards name Oct 16 02:55:25 rivo volumio[11305]: info: Adding Server instance for streaming Oct 16 02:55:25 rivo systemd[1]: qobuz-connect.service: Deactivated successfully. Oct 16 02:55:25 rivo systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Oct 16 02:55:25 rivo sudo[11608]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0 Oct 16 02:55:25 rivo sudo[11608]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:55:25 rivo systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Oct 16 02:55:25 rivo sudo[11579]: pam_unix(sudo:session): session closed for user root Oct 16 02:55:25 rivo sudo[11608]: pam_unix(sudo:session): session closed for user root Oct 16 02:55:25 rivo sudo[11617]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0 Oct 16 02:55:25 rivo sudo[11617]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:55:25 rivo sudo[11617]: pam_unix(sudo:session): session closed for user root Oct 16 02:55:25 rivo sudo[11620]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1 Oct 16 02:55:25 rivo sudo[11620]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:55:25 rivo sudo[11620]: pam_unix(sudo:session): session closed for user root Oct 16 02:55:25 rivo sudo[11623]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1 Oct 16 02:55:25 rivo sudo[11623]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:55:25 rivo sudo[11623]: pam_unix(sudo:session): session closed for user root Oct 16 02:55:25 rivo volumio[11305]: info: Apply VIM3L Onboard LEDs Settings Oct 16 02:55:25 rivo volumio[11305]: info: Turning On Onboard LEDs Oct 16 02:55:25 rivo volumio[11305]: info: Starting CEC Event listener Oct 16 02:55:25 rivo volumio[11305]: info: Volumio Calling Home Oct 16 02:55:25 rivo sudo[11627]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Oct 16 02:55:25 rivo sudo[11627]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:55:25 rivo sudo[11627]: pam_unix(sudo:session): session closed for user root Oct 16 02:55:25 rivo volumio[11305]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Oct 16 02:55:25 rivo volumio[11305]: (node:11305) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Oct 16 02:55:25 rivo volumio[11305]: (Use `node --trace-deprecation ...` to show where the warning was created) Oct 16 02:55:25 rivo sudo[11633]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Oct 16 02:55:25 rivo sudo[11633]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:55:25 rivo sudo[11633]: pam_unix(sudo:session): session closed for user root Oct 16 02:55:25 rivo volumio[11305]: info: [squeezelite_mc] Proxy server started on port 46571 Oct 16 02:55:25 rivo volumio[11305]: info: Stopping AccessToken refresher cron for QOBUZ Oct 16 02:55:25 rivo volumio[11305]: info: AccessToken refresher cron started for QOBUZ Oct 16 02:55:25 rivo volumio[11305]: info: Adding TIDAL REST API Endpoints Oct 16 02:55:25 rivo volumio[11305]: info: Adding QOBUZ REST API Endpoints Oct 16 02:55:25 rivo volumio[11305]: info: CoreCommandRouter::volumioRetrievevolume Oct 16 02:55:25 rivo volumio[11305]: info: CoreStateMachine::pushState Oct 16 02:55:25 rivo volumio[11305]: info: CorePlayQueue::getTrack 0 Oct 16 02:55:25 rivo volumio[11305]: info: CoreCommandRouter::volumioPushState Oct 16 02:55:25 rivo volumio[11305]: info: CoreCommandRouter::volumioGetState Oct 16 02:55:25 rivo volumio[11305]: info: CorePlayQueue::getTrack 0 Oct 16 02:55:25 rivo volumio[11305]: info: MRS: Pushing multiroomSync output update for this device Oct 16 02:55:25 rivo volumio[11305]: info: MRS: Pushing multiroomSync output Oct 16 02:55:25 rivo volumio[11305]: info: [squeezelite_mc] Server discovery started Oct 16 02:55:25 rivo volumio[11305]: info: [squeezelite_mc] Player finder started Oct 16 02:55:25 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 02:55:25 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 16 02:55:25 rivo volumio[11305]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 16 02:55:25 rivo volumio[11305]: info: [squeezelite_mc] Executing aplay -D hw:5 --nonblock -f MPEG /dev/zero 2>&1 || true Oct 16 02:55:25 rivo volumio[11305]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 02:55:25 rivo volumio[11305]: Error: send ENETUNREACH 255.255.255.255:3483 Oct 16 02:55:25 rivo volumio[11305]: at doSend (node:dgram:717:16) Oct 16 02:55:25 rivo volumio[11305]: at defaultTriggerAsyncIdScope (node:internal/async_hooks:464:18) Oct 16 02:55:25 rivo volumio[11305]: at afterDns (node:dgram:663:5) Oct 16 02:55:25 rivo volumio[11305]: at process.processTicksAndRejections (node:internal/process/task_queues:83:21) { Oct 16 02:55:25 rivo volumio[11305]: errno: -101, Oct 16 02:55:25 rivo volumio[11305]: code: 'ENETUNREACH', Oct 16 02:55:25 rivo volumio[11305]: syscall: 'send', Oct 16 02:55:25 rivo volumio[11305]: address: '255.255.255.255', Oct 16 02:55:25 rivo volumio[11305]: port: 3483 Oct 16 02:55:25 rivo volumio[11305]: } Oct 16 02:55:25 rivo volumio[11305]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 02:55:25 rivo dhcpcd[2973]: wlan0: leased 192.168.1.188 for 3600 seconds Oct 16 02:55:25 rivo avahi-daemon[2905]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.188. Oct 16 02:55:25 rivo avahi-daemon[2905]: New relevant interface wlan0.IPv4 for mDNS. Oct 16 02:55:25 rivo avahi-daemon[2905]: Registering new address record for 192.168.1.188 on wlan0.IPv4. Oct 16 02:55:25 rivo dhcpcd[2973]: wlan0: adding route to 192.168.1.0/24 Oct 16 02:55:25 rivo dhcpcd[2973]: wlan0: adding default route via 192.168.1.1 Oct 16 02:55:25 rivo dhcpcd[11556]: ps_bpf_recvmsg: Invalid argument Oct 16 02:55:26 rivo systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Oct 16 02:55:26 rivo systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Oct 16 02:55:26 rivo systemd[1]: welcome.service: Deactivated successfully. Oct 16 02:55:26 rivo systemd[1]: Stopped welcome.service - Show a welcome message on console. Oct 16 02:55:26 rivo systemd[1]: Stopping welcome.service - Show a welcome message on console... Oct 16 02:55:26 rivo systemd[1]: Starting welcome.service - Show a welcome message on console... Oct 16 02:55:26 rivo welcome[11653]: Resolved ip:[1] 192.168.1.188 Oct 16 02:55:26 rivo systemd[1]: Finished welcome.service - Show a welcome message on console. Oct 16 02:55:26 rivo systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Oct 16 02:55:26 rivo volumio5-onboarding[4826]: time=2026-10-16T02:55:26.833+09:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:55172->127.0.0.1:3000: i/o timeout" Oct 16 02:55:27 rivo sudo[11704]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-16 02:54' Oct 16 02:55:27 rivo sudo[11704]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 16 02:55:27 rivo ntpd[3131]: IO: Listen normally on 5 wlan0 192.168.1.188:123 Oct 16 02:55:27 rivo ntpd[3131]: IO: new interface(s) found: waking up resolver 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="8ed05bf20f96eb8557ed5652c420f84f39d66325" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0a52c1fb90959ba1872a2fb0225e56fe615b19ac" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Sep 16 16:27:36 UTC 2026" VOLUMIO_VERSION="4.208" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="be0c94671215c2b1bf2440825a1e4211"