-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sun 2026-10-11 17:18:06 CEST. --
Oct 11 17:17:08 volumio volumio-remote-updater[662]: [2026-10-11 17:17:08] [connect] Successful connection
Oct 11 17:17:21 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:21.436+02:00 level=ERROR msg="failed to read message" component=conn/ws remoteAddr=192.168.178.23:47136 error="websocket: close 1001 (going away)"
Oct 11 17:17:21 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:21.437+02:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.178.23:47136
Oct 11 17:17:21 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:21.437+02:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.178.23:47136
Oct 11 17:17:23 volumio volumio-remote-updater[662]: [2026-10-11 17:17:23] [connect] Successful connection
Oct 11 17:17:24 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:24.521+02:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.178.23:40102
Oct 11 17:17:31 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:31.478+02:00 level=ERROR msg="failed to read message" component=conn/ws remoteAddr=192.168.178.23:40102 error="read tcp 192.168.178.35:7331->192.168.178.23:40102: read: connection reset by peer"
Oct 11 17:17:31 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:31.478+02:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.178.23:40102
Oct 11 17:17:31 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:31.478+02:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.178.23:40102
Oct 11 17:17:34 volumio ntpd[792]: error resolving pool 3.debian.pool.ntp.org: System error (-11)
Oct 11 17:17:38 volumio volumio-remote-updater[662]: [2026-10-11 17:17:38] [connect] Successful connection
Oct 11 17:17:53 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:53.594+02:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.178.23:34322
Oct 11 17:17:53 volumio volumio-remote-updater[662]: [2026-10-11 17:17:53] [connect] Successful connection
Oct 11 17:17:54 volumio wpa_supplicant[944]: RRM: Ignoring radio measurement request: Not RRM network
Oct 11 17:17:54 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:54.466+02:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.178.23:41962
Oct 11 17:17:54 volumio ntpd[792]: Soliciting pool server 156.106.214.52
Oct 11 17:17:54 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:54.558+02:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.178.23:39784
Oct 11 17:17:54 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:54.663+02:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.178.23:39784
Oct 11 17:17:54 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:54.663+02:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.178.23:39784
Oct 11 17:17:54 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:54.702+02:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="00:00:00:00:00:00%01 @ 0x3385440" latency=-71.240047ms timeout=20s
Oct 11 17:17:54 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:54.702+02:00 level=INFO msg="emitting device capabilities changed event" component=server peer="00:00:00:00:00:00%01 @ 0x3385440"
Oct 11 17:17:54 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:54.722+02:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.178.23:39806
Oct 11 17:17:54 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:54.944+02:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%01,192.168.178.23:39806 @ 0x3385440" latency=-69.36664ms timeout=10s
Oct 11 17:17:55 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:55.067+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%01,192.168.178.23:39806 @ 0x3385440" latency=-69.36664ms timeout=10s endpoint=http://pushupdates.volumio.org duration=121.673079ms
Oct 11 17:17:55 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:55.179+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%01,192.168.178.23:39806 @ 0x3385440" latency=-69.36664ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=234.437848ms
Oct 11 17:17:55 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:55.206+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%01,192.168.178.23:39806 @ 0x3385440" latency=-69.36664ms timeout=10s endpoint=https://www.googleapis.com duration=260.892021ms
Oct 11 17:17:55 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:55.283+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%01,192.168.178.23:39806 @ 0x3385440" latency=-69.36664ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=337.722773ms
Oct 11 17:17:55 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:55.289+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%01,192.168.178.23:39806 @ 0x3385440" latency=-69.36664ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=344.973202ms
Oct 11 17:17:55 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:55.299+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%01,192.168.178.23:39806 @ 0x3385440" latency=-69.36664ms timeout=10s endpoint=https://securetoken.googleapis.com duration=354.257991ms
Oct 11 17:17:55 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:55.323+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%01,192.168.178.23:39806 @ 0x3385440" latency=-69.36664ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=378.262139ms
Oct 11 17:17:55 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:55.360+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%01,192.168.178.23:39806 @ 0x3385440" latency=-69.36664ms timeout=10s endpoint=https://functions.volumio.cloud duration=414.293877ms
Oct 11 17:17:55 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:55.360+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%01,192.168.178.23:39806 @ 0x3385440" latency=-69.36664ms timeout=10s endpoint=https://functions.volumio.cloud duration=415.432075ms
Oct 11 17:17:55 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:55.416+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%01,192.168.178.23:39806 @ 0x3385440" latency=-69.36664ms timeout=10s endpoint=http://cddb.volumio.org duration=470.895372ms error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF"
Oct 11 17:17:55 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:55.495+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%01,192.168.178.23:39806 @ 0x3385440" latency=-69.36664ms timeout=10s endpoint=https://database.volumio.cloud duration=548.626619ms
Oct 11 17:17:55 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:55.589+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%01,192.168.178.23:39806 @ 0x3385440" latency=-69.36664ms timeout=10s endpoint=http://plugins.volumio.org duration=642.118164ms
Oct 11 17:17:55 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:55.596+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="00:00:00:00:00:00%01,192.168.178.23:39806 @ 0x3385440" latency=-69.36664ms timeout=10s endpoint=https://google.com duration=651.418287ms
Oct 11 17:17:56 volumio volumio[1045]: info: MYVOLUMIO: Adding device
Oct 11 17:17:56 volumio volumio[1045]: info: MYVOLUMIO: Evaluating Server
Oct 11 17:17:56 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:56.153+02:00 level=ERROR msg="failed reading message" error="websocket: close 1000 (normal)"
Oct 11 17:17:56 volumio volumio[1045]: info:
Oct 11 17:17:56 volumio volumio[1045]: ---------------------------- MPD announces state update: player
Oct 11 17:17:56 volumio volumio[1045]: info: ControllerMpd::getState
Oct 11 17:17:56 volumio volumio[1045]: verbose: ControllerMpd::sendMpdCommand status
Oct 11 17:17:56 volumio volumio[1045]: error: MPD error: Error: write EPIPE
Oct 11 17:17:56 volumio volumio[1045]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"}
Oct 11 17:17:56 volumio volumio[1045]: info:
Oct 11 17:17:56 volumio volumio[1045]: ---------------------------- MPD announces state update: player
Oct 11 17:17:56 volumio volumio[1045]: info: ControllerMpd::getState
Oct 11 17:17:56 volumio volumio[1045]: verbose: ControllerMpd::sendMpdCommand status
Oct 11 17:17:56 volumio volumio[1045]: error: MPD error: Error: write EPIPE
Oct 11 17:17:56 volumio volumio[1045]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"}
Oct 11 17:17:56 volumio volumio[1045]: info:
Oct 11 17:17:56 volumio volumio[1045]: ---------------------------- MPD announces state update: player
Oct 11 17:17:56 volumio volumio[1045]: info: ControllerMpd::getState
Oct 11 17:17:56 volumio volumio[1045]: verbose: ControllerMpd::sendMpdCommand status
Oct 11 17:17:56 volumio volumio[1045]: error: MPD error: Error: write EPIPE
Oct 11 17:17:56 volumio volumio[1045]: error: write EPIPE {"errno":-32,"code":"EPIPE","syscall":"write"}
Oct 11 17:17:56 volumio wpa_supplicant[944]: RRM: Ignoring radio measurement request: Not RRM network
Oct 11 17:17:56 volumio volumio[1045]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1
Oct 11 17:17:56 volumio volumio[1045]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2
Oct 11 17:17:56 volumio volumio[1045]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3
Oct 11 17:17:56 volumio volumio[1045]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4
Oct 11 17:17:56 volumio volumio-remote-updater[662]: [2026-10-11 17:17:56] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1791731873 101
Oct 11 17:17:56 volumio volumio[1045]: 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: 5
Oct 11 17:17:56 volumio dhcpcd[956]: wlan0: carrier lost
Oct 11 17:17:56 volumio wpa_supplicant[944]: wlan0: Associated with 1c:23:a2:03:c9:d3
Oct 11 17:17:56 volumio wpa_supplicant[944]: wlan0: CTRL-EVENT-CONNECTED - Connection to 1c:23:a2:03:c9:d3 completed [id=0 id_str=]
Oct 11 17:17:56 volumio wpa_supplicant[944]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0
Oct 11 17:17:56 volumio volumio[1045]: verbose: New Socket.io Connection to 192.168.178.35 from 192.168.178.23 UA: Mozilla/5.0 (Linux; Android 16; Fairphone 6 Build/FP6.QREL.16.111.0; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/153.0.8010.39 Mobile Safari/537.36 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 6
Oct 11 17:17:56 volumio volumio[1045]: verbose: New Socket.io Connection to 192.168.178.35 from 192.168.178.23 UA: Mozilla/5.0 (Linux; Android 16; Fairphone 6 Build/FP6.QREL.16.111.0; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/153.0.8010.39 Mobile Safari/537.36 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 7
Oct 11 17:17:56 volumio volumio[1045]: verbose: New Socket.io Connection to 192.168.178.35 from 192.168.178.23 UA: Mozilla/5.0 (Linux; Android 16; Fairphone 6 Build/FP6.QREL.16.111.0; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/153.0.8010.39 Mobile Safari/537.36 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 8
Oct 11 17:17:56 volumio volumio[1045]: verbose: New Socket.io Connection to 192.168.178.35 from 192.168.178.23 UA: Mozilla/5.0 (Linux; Android 16; Fairphone 6 Build/FP6.QREL.16.111.0; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/153.0.8010.39 Mobile Safari/537.36 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 9
Oct 11 17:17:56 volumio volumio[1045]: verbose: New Socket.io Connection to 192.168.178.35 from 192.168.178.23 UA: Mozilla/5.0 (Linux; Android 16; Fairphone 6 Build/FP6.QREL.16.111.0; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/153.0.8010.39 Mobile Safari/537.36 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 10
Oct 11 17:17:56 volumio volumio[1045]: verbose: New Socket.io Connection to 192.168.178.35 from 192.168.178.23 UA: Mozilla/5.0 (Linux; Android 16; Fairphone 6 Build/FP6.QREL.16.111.0; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/153.0.8010.39 Mobile Safari/537.36 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 11
Oct 11 17:17:56 volumio volumio[1045]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12
Oct 11 17:17:56 volumio volumio[1045]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13
Oct 11 17:17:56 volumio volumio[1045]: 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: 14
Oct 11 17:17:56 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 11 17:17:56 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 11 17:17:56 volumio volumio[1045]: info: Discovery: Getting this device information
Oct 11 17:17:56 volumio volumio[1045]: info: CoreCommandRouter::volumioGetState
Oct 11 17:17:56 volumio volumio[1045]: info: CorePlayQueue::getTrack 8
Oct 11 17:17:56 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 11 17:17:56 volumio volumio[1045]: info: CoreCommandRouter::volumioGetState
Oct 11 17:17:56 volumio volumio[1045]: info: CorePlayQueue::getTrack 8
Oct 11 17:17:56 volumio volumio[1045]: Upnp client error: Error: This socket has been ended by the other party
Oct 11 17:17:56 volumio volumio[1045]: Upnp client error: Error: This socket has been ended by the other party
Oct 11 17:17:56 volumio volumio[1045]: Upnp client error: Error: This socket has been ended by the other party
Oct 11 17:17:56 volumio volumio[1045]: Upnp client error: Error: This socket has been ended by the other party
Oct 11 17:17:56 volumio volumio[1045]: Upnp client error: Error: This socket has been ended by the other party
Oct 11 17:17:56 volumio volumio[1045]: Upnp client error: Error: This socket has been ended by the other party
Oct 11 17:17:56 volumio volumio[1045]: Upnp client error: Error: This socket has been ended by the other party
Oct 11 17:17:56 volumio volumio[1045]: Upnp client error: Error: This socket has been ended by the other party
Oct 11 17:17:56 volumio volumio[1045]: Upnp client error: Error: This socket has been ended by the other party
Oct 11 17:17:56 volumio volumio[1045]: Upnp client error: Error: This socket has been ended by the other party
Oct 11 17:17:56 volumio volumio[1045]: Upnp client error: Error: This socket has been ended by the other party
Oct 11 17:17:56 volumio volumio[1045]: Upnp client error: Error: This socket has been ended by the other party
Oct 11 17:17:56 volumio volumio[1045]: Upnp client error: Error: This socket has been ended by the other party
Oct 11 17:17:56 volumio volumio[1045]: Upnp client error: Error: This socket has been ended by the other party
Oct 11 17:17:56 volumio volumio[1045]: Upnp client error: Error: This socket has been ended by the other party
Oct 11 17:17:56 volumio volumio[1045]: Upnp client error: Error: This socket has been ended by the other party
Oct 11 17:17:56 volumio volumio[1045]: Upnp client error: Error: This socket has been ended by the other party
Oct 11 17:17:56 volumio volumio[1045]: Upnp client error: Error: This socket has been ended by the other party
Oct 11 17:17:56 volumio volumio[1045]: Upnp client error: Error: This socket has been ended by the other party
Oct 11 17:17:56 volumio volumio[1045]: Upnp client error: Error: This socket has been ended by the other party
Oct 11 17:17:56 volumio volumio[1045]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 15
Oct 11 17:17:56 volumio volumio[1045]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 16
Oct 11 17:17:56 volumio volumio[1045]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 17
Oct 11 17:17:56 volumio volumio[1045]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 18
Oct 11 17:17:56 volumio volumio[1045]: verbose: New Socket.io Connection to 192.168.178.35 from 192.168.178.23 UA: Mozilla/5.0 (Linux; Android 16; Fairphone 6 Build/FP6.QREL.16.111.0; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/153.0.8010.39 Mobile Safari/537.36 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 19
Oct 11 17:17:56 volumio volumio[1045]: verbose: New Socket.io Connection to 192.168.178.35 from 192.168.178.23 UA: Mozilla/5.0 (Linux; Android 16; Fairphone 6 Build/FP6.QREL.16.111.0; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/153.0.8010.39 Mobile Safari/537.36 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 20
Oct 11 17:17:56 volumio volumio[1045]: verbose: New Socket.io Connection to 192.168.178.35 from 192.168.178.23 UA: Mozilla/5.0 (Linux; Android 16; Fairphone 6 Build/FP6.QREL.16.111.0; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/153.0.8010.39 Mobile Safari/537.36 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 21
Oct 11 17:17:56 volumio volumio[1045]: verbose: New Socket.io Connection to 192.168.178.35 from 192.168.178.23 UA: Mozilla/5.0 (Linux; Android 16; Fairphone 6 Build/FP6.QREL.16.111.0; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/153.0.8010.39 Mobile Safari/537.36 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 22
Oct 11 17:17:56 volumio volumio[1045]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 23
Oct 11 17:17:56 volumio volumio[1045]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 24
Oct 11 17:17:56 volumio avahi-daemon[658]: Withdrawing address record for 192.168.178.35 on wlan0.
Oct 11 17:17:56 volumio avahi-daemon[658]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.35.
Oct 11 17:17:56 volumio volumio[1045]: 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: 24
Oct 11 17:17:56 volumio avahi-daemon[658]: Interface wlan0.IPv4 no longer relevant for mDNS.
Oct 11 17:17:56 volumio dhcpcd[956]: wlan0: deleting route to 192.168.178.0/24
Oct 11 17:17:56 volumio dhcpcd[956]: wlan0: deleting default route via 192.168.178.1
Oct 11 17:17:57 volumio dhcpcd[956]: wlan0: carrier acquired
Oct 11 17:17:57 volumio dhcpcd[956]: wlan0: IAID dd:99:17:64
Oct 11 17:17:57 volumio volumio5-onboarding[1246]: time=2026-10-11T17:17:57.532+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="00:00:00:00:00:00%01,192.168.178.23:39806 @ 0x3385440" available=true connected=true macAddress=d8:3a:dd:99:17:64 ip4Address= ip6Address= ssid=merkur
Oct 11 17:17:57 volumio dhcpcd[956]: wlan0: soliciting an IPv6 router
Oct 11 17:17:57 volumio dhcpcd[956]: wlan0: rebinding lease of 192.168.178.35
Oct 11 17:17:57 volumio dhcpcd[956]: wlan0: probing address 192.168.178.35/24
Oct 11 17:17:58 volumio ntpd[792]: Deleting interface #3 wlan0, 192.168.178.35#123, interface stats: received=54, sent=78, dropped=1, active_time=155 secs
Oct 11 17:17:58 volumio ntpd[792]: 156.106.214.52 local addr 192.168.178.35 ->
Oct 11 17:17:58 volumio ntpd[792]: 85.195.226.126 local addr 192.168.178.35 ->
Oct 11 17:17:58 volumio ntpd[792]: 84.254.99.155 local addr 192.168.178.35 ->
Oct 11 17:17:58 volumio ntpd[792]: 85.195.205.172 local addr 192.168.178.35 ->
Oct 11 17:17:58 volumio ntpd[792]: 217.147.208.1 local addr 192.168.178.35 ->
Oct 11 17:17:58 volumio ntpd[792]: 85.195.210.125 local addr 192.168.178.35 ->
Oct 11 17:17:58 volumio ntpd[792]: 185.32.222.237 local addr 192.168.178.35 ->
Oct 11 17:17:58 volumio ntpd[792]: 212.51.144.44 local addr 192.168.178.35 ->
Oct 11 17:17:58 volumio ntpd[792]: 178.194.85.120 local addr 192.168.178.35 ->
Oct 11 17:17:58 volumio ntpd[792]: 217.147.223.78 local addr 192.168.178.35 ->
Oct 11 17:18:02 volumio wpa_supplicant[944]: RRM: Ignoring radio measurement request: Not RRM network
Oct 11 17:18:03 volumio dhcpcd[956]: wlan0: leased 192.168.178.35 for 864000 seconds
Oct 11 17:18:03 volumio avahi-daemon[658]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.35.
Oct 11 17:18:03 volumio avahi-daemon[658]: New relevant interface wlan0.IPv4 for mDNS.
Oct 11 17:18:03 volumio avahi-daemon[658]: Registering new address record for 192.168.178.35 on wlan0.IPv4.
Oct 11 17:18:03 volumio dhcpcd[956]: wlan0: adding route to 192.168.178.0/24
Oct 11 17:18:03 volumio dhcpcd[956]: wlan0: adding default route via 192.168.178.1
Oct 11 17:18:04 volumio volumio5-onboarding[1246]: time=2026-10-11T17:18:04.071+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="00:00:00:00:00:00%01,192.168.178.23:39806 @ 0x3385440" available=true connected=true macAddress=d8:3a:dd:99:17:64 ip4Address=192.168.178.35/24 ip6Address= ssid=merkur
Oct 11 17:18:04 volumio wpa_supplicant[944]: RRM: Ignoring radio measurement request: Not RRM network
Oct 11 17:18:04 volumio volumio5-onboarding[1246]: time=2026-10-11T17:18:04.819+02:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.178.23:58806
Oct 11 17:18:04 volumio volumio5-onboarding[1246]: time=2026-10-11T17:18:04.839+02:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.178.23:58806 @ 0x3692390" latency=-112.361545ms timeout=10s
Oct 11 17:18:04 volumio volumio5-onboarding[1246]: time=2026-10-11T17:18:04.854+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.178.23:58806 @ 0x3692390" latency=-112.361545ms timeout=10s endpoint=http://pushupdates.volumio.org duration=13.167198ms
Oct 11 17:18:04 volumio volumio5-onboarding[1246]: time=2026-10-11T17:18:04.861+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.178.23:58806 @ 0x3692390" latency=-112.361545ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=19.881388ms
Oct 11 17:18:04 volumio volumio5-onboarding[1246]: time=2026-10-11T17:18:04.868+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.178.23:58806 @ 0x3692390" latency=-112.361545ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=28.156423ms
Oct 11 17:18:04 volumio volumio5-onboarding[1246]: time=2026-10-11T17:18:04.873+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.178.23:58806 @ 0x3692390" latency=-112.361545ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=33.540509ms
Oct 11 17:18:04 volumio volumio5-onboarding[1246]: time=2026-10-11T17:18:04.945+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.178.23:58806 @ 0x3692390" latency=-112.361545ms timeout=10s endpoint=https://www.googleapis.com duration=105.475504ms
Oct 11 17:18:04 volumio volumio5-onboarding[1246]: time=2026-10-11T17:18:04.964+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.178.23:58806 @ 0x3692390" latency=-112.361545ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=123.587104ms
Oct 11 17:18:04 volumio volumio5-onboarding[1246]: time=2026-10-11T17:18:04.978+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.178.23:58806 @ 0x3692390" latency=-112.361545ms timeout=10s endpoint=https://securetoken.googleapis.com duration=137.964129ms
Oct 11 17:18:04 volumio volumio5-onboarding[1246]: time=2026-10-11T17:18:04.986+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.178.23:58806 @ 0x3692390" latency=-112.361545ms timeout=10s endpoint=https://database.volumio.cloud duration=144.995948ms
Oct 11 17:18:04 volumio volumio5-onboarding[1246]: time=2026-10-11T17:18:04.988+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.178.23:58806 @ 0x3692390" latency=-112.361545ms timeout=10s endpoint=https://functions.volumio.cloud duration=147.454437ms
Oct 11 17:18:04 volumio volumio5-onboarding[1246]: time=2026-10-11T17:18:04.991+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.178.23:58806 @ 0x3692390" latency=-112.361545ms timeout=10s endpoint=https://functions.volumio.cloud duration=150.870309ms
Oct 11 17:18:04 volumio ntpd[792]: Listen normally on 4 wlan0 192.168.178.35:123
Oct 11 17:18:04 volumio ntpd[792]: new interface(s) found: waking up resolver
Oct 11 17:18:05 volumio volumio5-onboarding[1246]: time=2026-10-11T17:18:05.033+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.178.23:58806 @ 0x3692390" latency=-112.361545ms timeout=10s endpoint=http://cddb.volumio.org duration=192.129541ms error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF"
Oct 11 17:18:05 volumio volumio5-onboarding[1246]: time=2026-10-11T17:18:05.143+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.178.23:58806 @ 0x3692390" latency=-112.361545ms timeout=10s endpoint=http://plugins.volumio.org duration=302.651429ms
Oct 11 17:18:05 volumio volumio5-onboarding[1246]: time=2026-10-11T17:18:05.154+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.178.23:58806 @ 0x3692390" latency=-112.361545ms timeout=10s endpoint=https://google.com duration=313.998301ms
Oct 11 17:18:06 volumio volumio[1045]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 25
Oct 11 17:18:06 volumio volumio[1045]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 26
Oct 11 17:18:06 volumio volumio[1045]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 27
Oct 11 17:18:06 volumio volumio[1045]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 28
Oct 11 17:18:06 volumio volumio[1045]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 29
Oct 11 17:18:06 volumio volumio[1045]: verbose: New Socket.io Connection to 192.168.178.35:3000 from 192.168.178.23 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 30
Oct 11 17:18:06 volumio volumio[1045]: info: Listing playlists
Oct 11 17:18:06 volumio volumio[1045]: info: Listing playlists
Oct 11 17:18:06 volumio volumio[1045]: info: Discovery: A device disappeared from network
Oct 11 17:18:06 volumio volumio[1045]: info: Received Get System Info
Oct 11 17:18:06 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 11 17:18:06 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 11 17:18:06 volumio volumio[1045]: info: Discovery: Getting this device information
Oct 11 17:18:06 volumio volumio[1045]: info: CoreCommandRouter::volumioGetState
Oct 11 17:18:06 volumio volumio[1045]: info: CorePlayQueue::getTrack 8
Oct 11 17:18:06 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 11 17:18:06 volumio volumio[1045]: info: Received Get System Info
Oct 11 17:18:06 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Oct 11 17:18:06 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Oct 11 17:18:06 volumio volumio[1045]: info: Discovery: Getting this device information
Oct 11 17:18:06 volumio volumio[1045]: info: CoreCommandRouter::volumioGetState
Oct 11 17:18:06 volumio volumio[1045]: info: CorePlayQueue::getTrack 8
Oct 11 17:18:06 volumio volumio[1045]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Oct 11 17:18:06 volumio volumio5-onboarding[1246]: time=2026-10-11T17:18:06.421+02:00 level=INFO msg="emitting device name changed event" component=server peer="00:00:00:00:00:00%01 @ 0x3385440" name=Volumio
Oct 11 17:18:06 volumio volumio5-onboarding[1246]: time=2026-10-11T17:18:06.422+02:00 level=INFO msg="emitting device language changed event" component=server peer="00:00:00:00:00:00%01 @ 0x3385440" language=de
Oct 11 17:18:06 volumio volumio5-onboarding[1246]: time=2026-10-11T17:18:06.426+02:00 level=ERROR msg="failed to read message" component=conn/ws remoteAddr=192.168.178.23:39806 error="read tcp 192.168.178.35:7331->192.168.178.23:39806: read: connection reset by peer"
Oct 11 17:18:06 volumio volumio5-onboarding[1246]: time=2026-10-11T17:18:06.427+02:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.178.23:39806
Oct 11 17:18:06 volumio volumio5-onboarding[1246]: time=2026-10-11T17:18:06.427+02:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.178.23:39806
Oct 11 17:18:06 volumio volumio[1045]: info: Volumio Network Manager: Network status updated: 0
Oct 11 17:18:06 volumio volumio[1045]: error: Failed to ping endpoint au1.myvolumio.org : unknown error
Oct 11 17:18:06 volumio volumio[1045]: error: Failed to ping endpoint eu12.myvolumio.org : unknown error
Oct 11 17:18:06 volumio volumio[1045]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 11 17:18:06 volumio volumio[1045]: Error: Unable to resolve or reject the same promise twice
Oct 11 17:18:06 volumio volumio[1045]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Oct 11 17:18:06 volumio volumio[1045]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32119)
Oct 11 17:18:06 volumio volumio[1045]: at Socket.emit (events.js:327:22)
Oct 11 17:18:06 volumio volumio[1045]: at endReadableNT (internal/streams/readable.js:1327:12)
Oct 11 17:18:06 volumio volumio[1045]: at processTicksAndRejections (internal/process/task_queues.js:80:21)
Oct 11 17:18:06 volumio volumio[1045]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 11 17:18:06 volumio sudo[2423]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-11 17:17
Oct 11 17:18:06 volumio sudo[2423]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="5c0e72e4b5817fe66c91c9d15d75ff13b8e3f4ba"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon 30 Mar 2026 02:51:29 PM CEST"
VOLUMIO_VERSION="3.914"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="98fe12c88d8ff391f569279e2f874892"