-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sun 2026-10-11 14:58:51 CEST. -- Oct 11 14:57:01 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 11 14:57:01 volumio volumio[1054]: info: Oct 11 14:57:01 volumio volumio[1054]: ---------------------------- MPD announces system playlist update Oct 11 14:57:01 volumio volumio[1054]: info: Ignoring MPD Status Update Oct 11 14:57:01 volumio volumio[1054]: info: Oct 11 14:57:01 volumio volumio[1054]: ---------------------------- MPD announces state update: player Oct 11 14:57:01 volumio volumio[1054]: info: ControllerMpd::getState Oct 11 14:57:01 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Oct 11 14:57:01 volumio volumio[1054]: info: ------------------------------ 1ms Oct 11 14:57:01 volumio volumio[1054]: info: sendMpdCommand status took 1 milliseconds Oct 11 14:57:01 volumio volumio[1054]: verbose: ControllerMpd::parseState Oct 11 14:57:01 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 14:57:01 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 11 14:57:01 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo Oct 11 14:57:01 volumio volumio[1054]: info: ControllerMpd::pushState Oct 11 14:57:01 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Oct 11 14:57:01 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Oct 11 14:57:01 volumio volumio[1054]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7691,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Ron King - NEW RELEASE ","artist":"SmoothJazz.com","album":null,"uri":"https://smoothjazz.cdnstream1.com/2585_256.mp3","trackType":"mp3"} Oct 11 14:57:01 volumio volumio[1054]: verbose: CURRENT POSITION 0 Oct 11 14:57:01 volumio volumio[1054]: info: CoreStateMachine::syncState stateService play Oct 11 14:57:01 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus play Oct 11 14:57:01 volumio volumio[1054]: info: Received an update from plugin. extracting info from payload Oct 11 14:57:01 volumio volumio[1054]: info: CoreStateMachine::pushState Oct 11 14:57:01 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 14:57:01 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Oct 11 14:57:01 volumio volumio[1054]: info: CoreStateMachine::pushState Oct 11 14:57:01 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Oct 11 14:57:01 volumio volumio5-onboarding[1257]: time=2026-10-11T14:57:01.528+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.200:53393,192.168.1.200:53394 @ 0x1800f90" state=STATUS_PLAYING positionMs=7004 volume=55 Oct 11 14:57:01 volumio volumio5-onboarding[1257]: time=2026-10-11T14:57:01.528+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.200:53393,192.168.1.200:53394 @ 0x1800f90" id=https://smoothjazz.cdnstream1.com/2585_256.mp3 title="Ron King - NEW RELEASE " Oct 11 14:57:01 volumio volumio5-onboarding[1257]: time=2026-10-11T14:57:01.529+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.200:53393,192.168.1.200:53394 @ 0x1800f90" state=STATUS_PLAYING positionMs=7004 volume=55 Oct 11 14:57:01 volumio volumio5-onboarding[1257]: time=2026-10-11T14:57:01.529+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.200:53393,192.168.1.200:53394 @ 0x1800f90" id=https://smoothjazz.cdnstream1.com/2585_256.mp3 title="Ron King - NEW RELEASE " Oct 11 14:57:01 volumio volumio[1054]: info: ------------------------------ 12ms Oct 11 14:57:02 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 11 14:57:02 volumio volumio[1054]: info: Received Get System Info Oct 11 14:57:02 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 14:57:02 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 14:57:02 volumio volumio[1054]: info: Discovery: Getting this device information Oct 11 14:57:02 volumio volumio[1054]: info: CoreCommandRouter::volumioGetState Oct 11 14:57:02 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 14:57:05 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 11 14:57:10 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 11 14:57:13 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 11 14:57:14 volumio volumio[1054]: info: CoreCommandRouter::Close All Modals sent Oct 11 14:57:17 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 11 14:57:21 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 11 14:57:25 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 11 14:57:26 volumio volumio5-onboarding[1257]: time=2026-10-11T14:57:26.527+02:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:53393,192.168.1.200:53394 @ 0x1800f90" latency=19.425699ms timeout=10s Oct 11 14:57:26 volumio volumio5-onboarding[1257]: time=2026-10-11T14:57:26.534+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:53393,192.168.1.200:53394 @ 0x1800f90" latency=19.425699ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=6.720489ms Oct 11 14:57:26 volumio volumio5-onboarding[1257]: time=2026-10-11T14:57:26.545+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:53393,192.168.1.200:53394 @ 0x1800f90" latency=19.425699ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=17.78493ms Oct 11 14:57:26 volumio volumio5-onboarding[1257]: time=2026-10-11T14:57:26.553+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:53393,192.168.1.200:53394 @ 0x1800f90" latency=19.425699ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=25.729196ms Oct 11 14:57:26 volumio volumio5-onboarding[1257]: time=2026-10-11T14:57:26.558+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:53393,192.168.1.200:53394 @ 0x1800f90" latency=19.425699ms timeout=10s endpoint=http://pushupdates.volumio.org duration=26.132467ms Oct 11 14:57:26 volumio volumio5-onboarding[1257]: time=2026-10-11T14:57:26.632+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:53393,192.168.1.200:53394 @ 0x1800f90" latency=19.425699ms timeout=10s endpoint=https://www.googleapis.com duration=103.603366ms Oct 11 14:57:26 volumio volumio5-onboarding[1257]: time=2026-10-11T14:57:26.658+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:53393,192.168.1.200:53394 @ 0x1800f90" latency=19.425699ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=128.617147ms Oct 11 14:57:26 volumio volumio5-onboarding[1257]: time=2026-10-11T14:57:26.694+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:53393,192.168.1.200:53394 @ 0x1800f90" latency=19.425699ms timeout=10s endpoint=https://functions.volumio.cloud duration=161.497548ms Oct 11 14:57:26 volumio volumio5-onboarding[1257]: time=2026-10-11T14:57:26.696+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:53393,192.168.1.200:53394 @ 0x1800f90" latency=19.425699ms timeout=10s endpoint=https://functions.volumio.cloud duration=164.829275ms Oct 11 14:57:26 volumio volumio5-onboarding[1257]: time=2026-10-11T14:57:26.816+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:53393,192.168.1.200:53394 @ 0x1800f90" latency=19.425699ms timeout=10s endpoint=https://database.volumio.cloud duration=283.544316ms Oct 11 14:57:26 volumio volumio5-onboarding[1257]: time=2026-10-11T14:57:26.837+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:53393,192.168.1.200:53394 @ 0x1800f90" latency=19.425699ms timeout=10s endpoint=https://securetoken.googleapis.com duration=308.5518ms Oct 11 14:57:26 volumio volumio5-onboarding[1257]: time=2026-10-11T14:57:26.843+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:53393,192.168.1.200:53394 @ 0x1800f90" latency=19.425699ms timeout=10s endpoint=https://google.com duration=314.90148ms Oct 11 14:57:26 volumio volumio5-onboarding[1257]: time=2026-10-11T14:57:26.925+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:53393,192.168.1.200:53394 @ 0x1800f90" latency=19.425699ms timeout=10s endpoint=http://cddb.volumio.org duration=398.014959ms error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF" Oct 11 14:57:27 volumio volumio5-onboarding[1257]: time=2026-10-11T14:57:27.113+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:53393,192.168.1.200:53394 @ 0x1800f90" latency=19.425699ms timeout=10s endpoint=http://plugins.volumio.org duration=580.588126ms Oct 11 14:57:28 volumio volumio[1054]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Oct 11 14:57:28 volumio volumio[1054]: info: CoreCommandRouter::volumioGetState Oct 11 14:57:29 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 14:57:29 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 14:57:29 volumio volumio[1054]: info: Discovery: Getting this device information Oct 11 14:57:29 volumio volumio[1054]: info: CoreCommandRouter::volumioGetState Oct 11 14:57:29 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 14:57:29 volumio volumio[1054]: verbose: New Socket.io Connection to 192.168.1.85:3000 from 192.168.1.200 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 Oct 11 14:57:29 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 11 14:57:29 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 11 14:57:36 volumio volumio5-onboarding[1257]: time=2026-10-11T14:57:36.488+02:00 level=ERROR msg="failed to read message" component=conn/ws remoteAddr=192.168.1.200:53393 error="websocket: close 1006 (abnormal closure): unexpected EOF" Oct 11 14:57:36 volumio volumio5-onboarding[1257]: time=2026-10-11T14:57:36.488+02:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.1.200:53393 Oct 11 14:57:36 volumio volumio5-onboarding[1257]: time=2026-10-11T14:57:36.488+02:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.1.200:53393 Oct 11 14:57:36 volumio volumio5-onboarding[1257]: time=2026-10-11T14:57:36.490+02:00 level=ERROR msg="failed to read message" component=conn/ws remoteAddr=192.168.1.200:53394 error="websocket: close 1006 (abnormal closure): unexpected EOF" Oct 11 14:57:36 volumio volumio5-onboarding[1257]: time=2026-10-11T14:57:36.491+02:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.1.200:53394 Oct 11 14:57:36 volumio volumio5-onboarding[1257]: time=2026-10-11T14:57:36.491+02:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.1.200:53394 Oct 11 14:57:46 volumio volumio[1054]: info: Oct 11 14:57:46 volumio volumio[1054]: ---------------------------- MPD announces system playlist update Oct 11 14:57:46 volumio volumio[1054]: info: Ignoring MPD Status Update Oct 11 14:57:46 volumio volumio[1054]: info: Oct 11 14:57:46 volumio volumio[1054]: ---------------------------- MPD announces state update: player Oct 11 14:57:46 volumio volumio[1054]: info: ControllerMpd::getState Oct 11 14:57:46 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Oct 11 14:57:46 volumio volumio[1054]: info: ------------------------------ 2ms Oct 11 14:57:46 volumio volumio[1054]: info: sendMpdCommand status took 1 milliseconds Oct 11 14:57:46 volumio volumio[1054]: verbose: ControllerMpd::parseState Oct 11 14:57:46 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 14:57:46 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 11 14:57:46 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo Oct 11 14:57:46 volumio volumio[1054]: info: ControllerMpd::pushState Oct 11 14:57:46 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Oct 11 14:57:46 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Oct 11 14:57:46 volumio volumio[1054]: verbose: STATE SERVICE {"status":"play","position":0,"seek":52457,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Nills - NEW RELEASE ","artist":"SmoothJazz.com","album":null,"uri":"https://smoothjazz.cdnstream1.com/2585_256.mp3","trackType":"mp3"} Oct 11 14:57:46 volumio volumio[1054]: verbose: CURRENT POSITION 0 Oct 11 14:57:46 volumio volumio[1054]: info: CoreStateMachine::syncState stateService play Oct 11 14:57:46 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus play Oct 11 14:57:46 volumio volumio[1054]: info: Received an update from plugin. extracting info from payload Oct 11 14:57:46 volumio volumio[1054]: info: CoreStateMachine::pushState Oct 11 14:57:46 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 14:57:46 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Oct 11 14:57:46 volumio volumio[1054]: info: CoreStateMachine::pushState Oct 11 14:57:46 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Oct 11 14:57:46 volumio volumio[1054]: info: ------------------------------ 19ms Oct 11 14:58:14 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:14.744+02:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.1.200:54059 Oct 11 14:58:14 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:14.748+02:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.1.200:54060 Oct 11 14:58:14 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:14.795+02:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.1.200:54059 @ 0x1bc8c90" latency=5.751117ms timeout=20s Oct 11 14:58:14 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:14.795+02:00 level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.1.200:54059 @ 0x1bc8c90" Oct 11 14:58:14 volumio volumio[1054]: info: Received Get System Info Oct 11 14:58:14 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 14:58:14 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 14:58:14 volumio volumio[1054]: info: Discovery: Getting this device information Oct 11 14:58:14 volumio volumio[1054]: info: CoreCommandRouter::volumioGetState Oct 11 14:58:14 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 14:58:14 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:14.798+02:00 level=INFO msg="emitting device name changed event" component=server peer="192.168.1.200:54059 @ 0x1bc8c90" name=Volumio Oct 11 14:58:14 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:14.799+02:00 level=INFO msg="emitting device language changed event" component=server peer="192.168.1.200:54059 @ 0x1bc8c90" language=it Oct 11 14:58:14 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Oct 11 14:58:14 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:14.800+02:00 level=INFO msg="emitting device timezone changed event" component=server peer="192.168.1.200:54059 @ 0x1bc8c90" timezone=Europe/Rome Oct 11 14:58:14 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:14.801+02:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.1.200:54059 @ 0x1bc8c90" available=true connected=true macAddress=d8:3a:dd:1c:b6:73 ip4Address=192.168.1.85/24 ip6Address= Oct 11 14:58:14 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:14.804+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.200:54059 @ 0x1bc8c90" available=true connected=true macAddress=d8:3a:dd:1c:b6:74 ip4Address=192.168.1.185/24 ip6Address= ssid=WIFI_BOX_5_0_G Oct 11 14:58:14 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:14.804+02:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059 @ 0x1bc8c90" latency=9.472075ms timeout=10s Oct 11 14:58:14 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:14.804+02:00 level=INFO msg="emitting device setup status changed event" component=server peer="192.168.1.200:54059 @ 0x1bc8c90" setupComplete=true Oct 11 14:58:14 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Oct 11 14:58:14 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:14.808+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059 @ 0x1bc8c90" latency=9.472075ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=3.362559ms Oct 11 14:58:14 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:14.820+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059 @ 0x1bc8c90" latency=9.472075ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=15.47317ms Oct 11 14:58:14 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:14.830+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059 @ 0x1bc8c90" latency=9.472075ms timeout=10s endpoint=http://pushupdates.volumio.org duration=24.763452ms Oct 11 14:58:14 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:14.831+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059 @ 0x1bc8c90" latency=9.472075ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=26.071321ms Oct 11 14:58:14 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 11 14:58:14 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 11 14:58:14 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 11 14:58:14 volumio volumio[1054]: amixer -c 0 info | grep "bcm2835 Headphones" Oct 11 14:58:14 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:14.908+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059 @ 0x1bc8c90" latency=9.472075ms timeout=10s endpoint=https://www.googleapis.com duration=103.264355ms Oct 11 14:58:14 volumio volumio[1054]: Card hw:0 'Headphones'/'bcm2835 Headphones' Oct 11 14:58:14 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:14.937+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059 @ 0x1bc8c90" latency=9.472075ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=131.744028ms Oct 11 14:58:14 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:14.937+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059 @ 0x1bc8c90" latency=9.472075ms timeout=10s endpoint=https://securetoken.googleapis.com duration=132.042042ms Oct 11 14:58:14 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:14.958+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059 @ 0x1bc8c90" latency=9.472075ms timeout=10s endpoint=https://database.volumio.cloud duration=152.501782ms Oct 11 14:58:14 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:14.959+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059 @ 0x1bc8c90" latency=9.472075ms timeout=10s endpoint=https://functions.volumio.cloud duration=154.08335ms Oct 11 14:58:14 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:14.960+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059 @ 0x1bc8c90" latency=9.472075ms timeout=10s endpoint=https://functions.volumio.cloud duration=154.441179ms Oct 11 14:58:15 volumio volumio[1054]: amixer -c 5 info | grep "E30" Oct 11 14:58:15 volumio volumio[1054]: Card hw:5 'E30'/'Topping E30 at usb-0000:01:00.0-1.4, high speed' Oct 11 14:58:15 volumio volumio[1054]: amixer -c 5 info | grep "E30" Oct 11 14:58:15 volumio volumio[1054]: Card hw:5 'E30'/'Topping E30 at usb-0000:01:00.0-1.4, high speed' Oct 11 14:58:15 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:15.125+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059 @ 0x1bc8c90" latency=9.472075ms timeout=10s endpoint=https://google.com duration=321.048188ms Oct 11 14:58:15 volumio volumio[1054]: amixer -c 7 info | grep "Dummy" Oct 11 14:58:15 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:15.191+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059 @ 0x1bc8c90" latency=9.472075ms timeout=10s endpoint=http://cddb.volumio.org duration=386.127983ms error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF" Oct 11 14:58:15 volumio volumio[1054]: Card hw:7 'Dummy'/'Dummy 1' Oct 11 14:58:15 volumio volumio[1054]: Mixer name : 'Dummy Mixer' Oct 11 14:58:15 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:15.196+02:00 level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.1.200:54059 @ 0x1bc8c90" selectedOutputId=5 Oct 11 14:58:15 volumio volumio[1054]: info: Received Get System Info Oct 11 14:58:15 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 14:58:15 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 14:58:15 volumio volumio[1054]: info: Discovery: Getting this device information Oct 11 14:58:15 volumio volumio[1054]: info: CoreCommandRouter::volumioGetState Oct 11 14:58:15 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 14:58:15 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:15.202+02:00 level=INFO msg="emitting software info changed event" component=server peer="192.168.1.200:54059 @ 0x1bc8c90" currentVersion=3.912 latestVersion=3.912 Oct 11 14:58:15 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:15.202+02:00 level=INFO msg="emitting software update progress event" component=server peer="192.168.1.200:54059 @ 0x1bc8c90" status=UPDATE_STATUS_NONE progress=0 Oct 11 14:58:15 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:15.202+02:00 level=INFO msg="emitting user changed event" component=server peer="192.168.1.200:54059 @ 0x1bc8c90" userId= Oct 11 14:58:15 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:15.202+02:00 level=INFO msg="emitting music providers changed event" component=server peer="192.168.1.200:54059 @ 0x1bc8c90" providers=3 Oct 11 14:58:15 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:15.203+02:00 level=INFO msg="emitting plugins changed event" component=server peer="192.168.1.200:54059 @ 0x1bc8c90" plugins=65 Oct 11 14:58:15 volumio volumio[1054]: info: CoreCommandRouter::volumioGetState Oct 11 14:58:15 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:15.205+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.200:54059 @ 0x1bc8c90" state=STATUS_PLAYING positionMs=80702 volume=55 Oct 11 14:58:15 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:15.205+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.200:54059 @ 0x1bc8c90" id=https://smoothjazz.cdnstream1.com/2585_256.mp3 title="Nills - NEW RELEASE " Oct 11 14:58:15 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:15.299+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059 @ 0x1bc8c90" latency=9.472075ms timeout=10s endpoint=http://plugins.volumio.org duration=493.410203ms Oct 11 14:58:15 volumio volumio[1054]: verbose: New Socket.io Connection to 192.168.1.85 from 192.168.1.200 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 VolumioApp/6.260930.0 Engine version: 3 Transport: polling Total Clients: 9 Oct 11 14:58:15 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 11 14:58:15 volumio volumio[1054]: info: CoreCommandRouter::volumioGetVisibleSources Oct 11 14:58:15 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 11 14:58:15 volumio volumio[1054]: info: CoreCommandRouter::volumioGetState Oct 11 14:58:15 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 11 14:58:15 volumio volumio[1054]: info: CoreCommandRouter::volumioGetQueue Oct 11 14:58:15 volumio volumio[1054]: info: CoreStateMachine::getQueue Oct 11 14:58:15 volumio volumio[1054]: info: CorePlayQueue::getQueue Oct 11 14:58:15 volumio volumio[1054]: info: Listing playlists Oct 11 14:58:15 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 11 14:58:15 volumio volumio[1054]: info: Received Get System Info Oct 11 14:58:15 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 14:58:15 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 14:58:15 volumio volumio[1054]: info: Discovery: Getting this device information Oct 11 14:58:15 volumio volumio[1054]: info: CoreCommandRouter::volumioGetState Oct 11 14:58:15 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 14:58:15 volumio volumio[1054]: info: CoreCommandRouter::volumioGetState Oct 11 14:58:15 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:15.489+02:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059,192.168.1.200:54060 @ 0x1bc8c90" latency=16.233832ms timeout=10s Oct 11 14:58:15 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:15.492+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059,192.168.1.200:54060 @ 0x1bc8c90" latency=16.233832ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=3.398336ms Oct 11 14:58:15 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:15.505+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059,192.168.1.200:54060 @ 0x1bc8c90" latency=16.233832ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=15.969199ms Oct 11 14:58:15 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:15.515+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059,192.168.1.200:54060 @ 0x1bc8c90" latency=16.233832ms timeout=10s endpoint=http://pushupdates.volumio.org duration=25.835991ms Oct 11 14:58:15 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:15.517+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059,192.168.1.200:54060 @ 0x1bc8c90" latency=16.233832ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=27.762146ms Oct 11 14:58:15 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:15.592+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059,192.168.1.200:54060 @ 0x1bc8c90" latency=16.233832ms timeout=10s endpoint=https://www.googleapis.com duration=103.185523ms Oct 11 14:58:15 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 11 14:58:15 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:15.614+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059,192.168.1.200:54060 @ 0x1bc8c90" latency=16.233832ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=124.958706ms Oct 11 14:58:15 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:15.618+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059,192.168.1.200:54060 @ 0x1bc8c90" latency=16.233832ms timeout=10s endpoint=https://securetoken.googleapis.com duration=128.486874ms Oct 11 14:58:15 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:15.643+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059,192.168.1.200:54060 @ 0x1bc8c90" latency=16.233832ms timeout=10s endpoint=https://database.volumio.cloud duration=153.179513ms Oct 11 14:58:15 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:15.644+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059,192.168.1.200:54060 @ 0x1bc8c90" latency=16.233832ms timeout=10s endpoint=https://functions.volumio.cloud duration=154.308292ms Oct 11 14:58:15 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:15.646+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059,192.168.1.200:54060 @ 0x1bc8c90" latency=16.233832ms timeout=10s endpoint=https://functions.volumio.cloud duration=156.325409ms Oct 11 14:58:15 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:15.707+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059,192.168.1.200:54060 @ 0x1bc8c90" latency=16.233832ms timeout=10s endpoint=http://cddb.volumio.org duration=218.193086ms error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF" Oct 11 14:58:15 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:15.804+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059,192.168.1.200:54060 @ 0x1bc8c90" latency=16.233832ms timeout=10s endpoint=http://plugins.volumio.org duration=314.867487ms Oct 11 14:58:15 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:15.810+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54059,192.168.1.200:54060 @ 0x1bc8c90" latency=16.233832ms timeout=10s endpoint=https://google.com duration=320.5434ms Oct 11 14:58:16 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 14:58:16 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 14:58:16 volumio volumio[1054]: info: Discovery: Getting this device information Oct 11 14:58:16 volumio volumio[1054]: info: CoreCommandRouter::volumioGetState Oct 11 14:58:16 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 14:58:16 volumio volumio[1054]: verbose: New Socket.io Connection to 192.168.1.85:3000 from 192.168.1.200 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 Oct 11 14:58:16 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 11 14:58:16 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 11 14:58:18 volumio volumio[1054]: info: Disabling MyMusic plugin metavolumio Oct 11 14:58:18 volumio volumio[1054]: info: [MyVolumio PluginManager] Disabling and stopping plugin miscellanea metavolumio Oct 11 14:58:18 volumio volumio[1054]: info: Disabling plugin metavolumio Oct 11 14:58:18 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.204+02:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.1.200:54059 Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.205+02:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.1.200:54059 Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.206+02:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.1.200:54060 Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.206+02:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.1.200:54060 Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.218+02:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.1.200:54179 Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.218+02:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.1.200:54180 Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.270+02:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.1.200:54179 @ 0x1ca86f0" latency=25.560358ms timeout=20s Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.270+02:00 level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.1.200:54179 @ 0x1ca86f0" Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.271+02:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54179 @ 0x1ca86f0" latency=17.262644ms timeout=10s Oct 11 14:58:20 volumio volumio[1054]: info: Received Get System Info Oct 11 14:58:20 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 14:58:20 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 14:58:20 volumio volumio[1054]: info: Discovery: Getting this device information Oct 11 14:58:20 volumio volumio[1054]: info: CoreCommandRouter::volumioGetState Oct 11 14:58:20 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.276+02:00 level=INFO msg="emitting device name changed event" component=server peer="192.168.1.200:54179 @ 0x1ca86f0" name=Volumio Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.276+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54179 @ 0x1ca86f0" latency=17.262644ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=4.812185ms Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.277+02:00 level=INFO msg="emitting device language changed event" component=server peer="192.168.1.200:54179 @ 0x1ca86f0" language=it Oct 11 14:58:20 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.278+02:00 level=INFO msg="emitting device timezone changed event" component=server peer="192.168.1.200:54179 @ 0x1ca86f0" timezone=Europe/Rome Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.280+02:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.1.200:54179 @ 0x1ca86f0" available=true connected=true macAddress=d8:3a:dd:1c:b6:73 ip4Address=192.168.1.85/24 ip6Address= Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.282+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.200:54179 @ 0x1ca86f0" available=true connected=true macAddress=d8:3a:dd:1c:b6:74 ip4Address=192.168.1.185/24 ip6Address= ssid=WIFI_BOX_5_0_G Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.282+02:00 level=INFO msg="emitting device setup status changed event" component=server peer="192.168.1.200:54179 @ 0x1ca86f0" setupComplete=true Oct 11 14:58:20 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.292+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54179 @ 0x1ca86f0" latency=17.262644ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=16.081752ms Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.299+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54179 @ 0x1ca86f0" latency=17.262644ms timeout=10s endpoint=http://pushupdates.volumio.org duration=25.839992ms Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.301+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54179 @ 0x1ca86f0" latency=17.262644ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=26.938363ms Oct 11 14:58:20 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 11 14:58:20 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 11 14:58:20 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 11 14:58:20 volumio volumio[1054]: amixer -c 0 info | grep "bcm2835 Headphones" Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.375+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54179 @ 0x1ca86f0" latency=17.262644ms timeout=10s endpoint=https://www.googleapis.com duration=103.700644ms Oct 11 14:58:20 volumio volumio[1054]: Card hw:0 'Headphones'/'bcm2835 Headphones' Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.397+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54179 @ 0x1ca86f0" latency=17.262644ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=124.408197ms Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.415+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54179 @ 0x1ca86f0" latency=17.262644ms timeout=10s endpoint=https://securetoken.googleapis.com duration=142.98104ms Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.424+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54179 @ 0x1ca86f0" latency=17.262644ms timeout=10s endpoint=https://functions.volumio.cloud duration=151.02038ms Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.427+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54179 @ 0x1ca86f0" latency=17.262644ms timeout=10s endpoint=https://functions.volumio.cloud duration=154.340977ms Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.428+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54179 @ 0x1ca86f0" latency=17.262644ms timeout=10s endpoint=https://database.volumio.cloud duration=151.819812ms Oct 11 14:58:20 volumio volumio[1054]: info: Enabling MyMusic plugin metavolumio Oct 11 14:58:20 volumio volumio[1054]: info: [MyVolumio PluginManager] Enabling and starting plugin miscellanea metavolumio Oct 11 14:58:20 volumio volumio[1054]: info: [MyVolumio PluginManager] Plugin miscellanea metavolumio not in user plan, not enabling Oct 11 14:58:20 volumio volumio[1054]: info: Error: Plugin miscellanea metavolumio not in user plan, not enabling Oct 11 14:58:20 volumio volumio[1054]: error: Could not Enable MyMusic Plugin: Error Oct 11 14:58:20 volumio volumio[1054]: amixer -c 5 info | grep "E30" Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.503+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54179 @ 0x1ca86f0" latency=17.262644ms timeout=10s endpoint=http://cddb.volumio.org duration=225.878042ms error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF" Oct 11 14:58:20 volumio volumio[1054]: Card hw:5 'E30'/'Topping E30 at usb-0000:01:00.0-1.4, high speed' Oct 11 14:58:20 volumio volumio[1054]: amixer -c 7 info | grep "Dummy" Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.589+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54179 @ 0x1ca86f0" latency=17.262644ms timeout=10s endpoint=https://google.com duration=317.476392ms Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.594+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.1.200:54179 @ 0x1ca86f0" latency=17.262644ms timeout=10s endpoint=http://plugins.volumio.org duration=317.432263ms Oct 11 14:58:20 volumio volumio[1054]: Card hw:7 'Dummy'/'Dummy 1' Oct 11 14:58:20 volumio volumio[1054]: Mixer name : 'Dummy Mixer' Oct 11 14:58:20 volumio volumio[1054]: amixer -c 5 info | grep "E30" Oct 11 14:58:20 volumio volumio[1054]: Card hw:5 'E30'/'Topping E30 at usb-0000:01:00.0-1.4, high speed' Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.695+02:00 level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.1.200:54179 @ 0x1ca86f0" selectedOutputId=5 Oct 11 14:58:20 volumio volumio[1054]: info: Received Get System Info Oct 11 14:58:20 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 14:58:20 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 14:58:20 volumio volumio[1054]: info: Discovery: Getting this device information Oct 11 14:58:20 volumio volumio[1054]: info: CoreCommandRouter::volumioGetState Oct 11 14:58:20 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.700+02:00 level=INFO msg="emitting software info changed event" component=server peer="192.168.1.200:54179 @ 0x1ca86f0" currentVersion=3.912 latestVersion=3.912 Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.700+02:00 level=INFO msg="emitting software update progress event" component=server peer="192.168.1.200:54179 @ 0x1ca86f0" status=UPDATE_STATUS_NONE progress=0 Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.700+02:00 level=INFO msg="emitting user changed event" component=server peer="192.168.1.200:54179 @ 0x1ca86f0" userId= Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.700+02:00 level=INFO msg="emitting music providers changed event" component=server peer="192.168.1.200:54179 @ 0x1ca86f0" providers=3 Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.701+02:00 level=INFO msg="emitting plugins changed event" component=server peer="192.168.1.200:54179 @ 0x1ca86f0" plugins=65 Oct 11 14:58:20 volumio volumio[1054]: info: CoreCommandRouter::volumioGetState Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.703+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.200:54179 @ 0x1ca86f0" state=STATUS_PLAYING positionMs=86037 volume=55 Oct 11 14:58:20 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:20.703+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.200:54179 @ 0x1ca86f0" id=https://smoothjazz.cdnstream1.com/2585_256.mp3 title="Nills - NEW RELEASE " Oct 11 14:58:22 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 11 14:58:25 volumio volumio[1054]: info: Disabling MyMusic plugin cd_controller Oct 11 14:58:25 volumio volumio[1054]: info: [MyVolumio PluginManager] Disabling and stopping plugin music_service cd_controller Oct 11 14:58:25 volumio volumio[1054]: info: Disabling plugin cd_controller Oct 11 14:58:26 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 11 14:58:26 volumio volumio[1054]: info: Enabling MyMusic plugin cd_controller Oct 11 14:58:26 volumio volumio[1054]: info: [MyVolumio PluginManager] Enabling and starting plugin music_service cd_controller Oct 11 14:58:26 volumio volumio[1054]: info: [MyVolumio PluginManager] Plugin music_service cd_controller not in user plan, not enabling Oct 11 14:58:26 volumio volumio[1054]: info: Error: Plugin music_service cd_controller not in user plan, not enabling Oct 11 14:58:26 volumio volumio[1054]: error: Could not Enable MyMusic Plugin: Error Oct 11 14:58:30 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 11 14:58:31 volumio volumio[1054]: info: Disabling MyMusic plugin qobuzconnect Oct 11 14:58:31 volumio volumio[1054]: info: [MyVolumio PluginManager] Disabling and stopping plugin music_service qobuzconnect Oct 11 14:58:31 volumio volumio[1054]: info: Disabling plugin qobuzconnect Oct 11 14:58:32 volumio volumio[1054]: info: Disabling MyMusic plugin smart_inputs Oct 11 14:58:32 volumio volumio[1054]: info: [MyVolumio PluginManager] Disabling and stopping plugin music_service smart_inputs Oct 11 14:58:32 volumio volumio[1054]: info: Disabling plugin smart_inputs Oct 11 14:58:34 volumio volumio[1054]: info: Enabling MyMusic plugin smart_inputs Oct 11 14:58:34 volumio volumio[1054]: info: [MyVolumio PluginManager] Enabling and starting plugin music_service smart_inputs Oct 11 14:58:34 volumio volumio[1054]: info: [MyVolumio PluginManager] Plugin music_service smart_inputs not in user plan, not enabling Oct 11 14:58:34 volumio volumio[1054]: info: Error: Plugin music_service smart_inputs not in user plan, not enabling Oct 11 14:58:34 volumio volumio[1054]: error: Could not Enable MyMusic Plugin: Error Oct 11 14:58:34 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 11 14:58:37 volumio volumio[1054]: info: Disabling MyMusic plugin tidalconnect Oct 11 14:58:37 volumio volumio[1054]: info: [MyVolumio PluginManager] Disabling and stopping plugin music_service tidalconnect Oct 11 14:58:37 volumio volumio[1054]: info: Disabling plugin tidalconnect Oct 11 14:58:38 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 11 14:58:42 volumio volumio[1054]: info: Disabling MyMusic plugin upnp_browser Oct 11 14:58:42 volumio volumio[1054]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesServer multimediali Oct 11 14:58:42 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 11 14:58:42 volumio volumio[1054]: info: Disabling plugin upnp_browser Oct 11 14:58:42 volumio volumio[1054]: info: Done. Oct 11 14:58:42 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 11 14:58:43 volumio volumio[1054]: info: Enabling MyMusic plugin upnp_browser Oct 11 14:58:43 volumio volumio[1054]: info: Enabling plugin upnp_browser Oct 11 14:58:43 volumio volumio[1054]: info: Loading plugin "upnp_browser"... Oct 11 14:58:43 volumio volumio[1054]: info: Starting UPNP Browser Oct 11 14:58:43 volumio volumio[1054]: info: PLUGIN START: upnp_browser Oct 11 14:58:43 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 11 14:58:43 volumio volumio[1054]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 11 14:58:43 volumio volumio[1054]: info: [1791723523721] CoreMusicLibrary::Adding element Server multimediali Oct 11 14:58:43 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 11 14:58:43 volumio volumio[1054]: info: UPNP Browser: Client initialized successfully Oct 11 14:58:43 volumio volumio[1054]: info: Done. Oct 11 14:58:46 volumio volumio[1054]: info: Disabling MyMusic plugin airplay_emulation Oct 11 14:58:46 volumio volumio[1054]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesShairport-Sync Oct 11 14:58:46 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 11 14:58:46 volumio volumio[1054]: info: Disabling plugin airplay_emulation Oct 11 14:58:46 volumio volumio[1054]: info: Done. Oct 11 14:58:46 volumio sudo[24702]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Oct 11 14:58:46 volumio sudo[24702]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 14:58:46 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 11 14:58:46 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 11 14:58:46 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 11 14:58:46 volumio sudo[24702]: pam_unix(sudo:session): session closed for user root Oct 11 14:58:46 volumio volumio[1054]: info: Shairport-Sync Stopped Oct 11 14:58:46 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 11 14:58:47 volumio volumio[1054]: info: Enabling MyMusic plugin airplay_emulation Oct 11 14:58:47 volumio volumio[1054]: info: Enabling plugin airplay_emulation Oct 11 14:58:47 volumio volumio[1054]: info: Loading plugin "airplay_emulation"... Oct 11 14:58:47 volumio volumio[1054]: info: Starting Shairport Sync Oct 11 14:58:47 volumio volumio[1054]: info: PLUGIN START: airplay_emulation Oct 11 14:58:47 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 14:58:47 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 11 14:58:47 volumio volumio[1054]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 11 14:58:47 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 14:58:47 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 11 14:58:47 volumio volumio[1054]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 11 14:58:47 volumio volumio[1054]: info: Done. Oct 11 14:58:47 volumio volumio[1054]: info: Starting Shairport Sync Oct 11 14:58:47 volumio volumio[1054]: info: Starting Shairport Sync Oct 11 14:58:47 volumio sudo[24716]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 11 14:58:47 volumio sudo[24716]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 14:58:47 volumio sudo[24719]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 11 14:58:47 volumio sudo[24719]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 14:58:47 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 11 14:58:47 volumio sudo[24716]: pam_unix(sudo:session): session closed for user root Oct 11 14:58:47 volumio volumio[1054]: info: Shairport-Sync Started Oct 11 14:58:47 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 11 14:58:47 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Oct 11 14:58:47 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 11 14:58:47 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 11 14:58:47 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 11 14:58:47 volumio sudo[24719]: pam_unix(sudo:session): session closed for user root Oct 11 14:58:47 volumio volumio[1054]: info: Shairport-Sync Started Oct 11 14:58:49 volumio volumio[1054]: info: Disabling MyMusic plugin upnp Oct 11 14:58:49 volumio sudo[24730]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Oct 11 14:58:49 volumio sudo[24730]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 14:58:49 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Oct 11 14:58:49 volumio volumio[1054]: error: Upnp client error: Error: This socket has been ended by the other party Oct 11 14:58:51 volumio volumio[1054]: info: Oct 11 14:58:51 volumio volumio[1054]: ---------------------------- MPD announces system playlist update Oct 11 14:58:51 volumio volumio[1054]: info: Ignoring MPD Status Update Oct 11 14:58:51 volumio volumio[1054]: info: Oct 11 14:58:51 volumio volumio[1054]: ---------------------------- MPD announces state update: player Oct 11 14:58:51 volumio volumio[1054]: info: ControllerMpd::getState Oct 11 14:58:51 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Oct 11 14:58:51 volumio volumio[1054]: info: ------------------------------ 3ms Oct 11 14:58:51 volumio volumio[1054]: info: sendMpdCommand status took 2 milliseconds Oct 11 14:58:51 volumio volumio[1054]: verbose: ControllerMpd::parseState Oct 11 14:58:51 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 14:58:51 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 11 14:58:51 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo Oct 11 14:58:51 volumio volumio[1054]: info: ControllerMpd::pushState Oct 11 14:58:51 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Oct 11 14:58:51 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Oct 11 14:58:51 volumio volumio[1054]: verbose: STATE SERVICE {"status":"play","position":0,"seek":117570,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Craigology - Attractive (World Beat Groove) ","artist":"SmoothJazz.com","album":null,"uri":"https://smoothjazz.cdnstream1.com/2585_256.mp3","trackType":"mp3"} Oct 11 14:58:51 volumio volumio[1054]: verbose: CURRENT POSITION 0 Oct 11 14:58:51 volumio volumio[1054]: info: CoreStateMachine::syncState stateService play Oct 11 14:58:51 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus play Oct 11 14:58:51 volumio volumio[1054]: info: Received an update from plugin. extracting info from payload Oct 11 14:58:51 volumio volumio[1054]: info: CoreStateMachine::pushState Oct 11 14:58:51 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 14:58:51 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Oct 11 14:58:51 volumio volumio[1054]: info: CoreStateMachine::pushState Oct 11 14:58:51 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Oct 11 14:58:51 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:51.409+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.200:54179,192.168.1.200:54180 @ 0x1ca86f0" state=STATUS_PLAYING positionMs=116820 volume=55 Oct 11 14:58:51 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:51.410+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.200:54179,192.168.1.200:54180 @ 0x1ca86f0" id=https://smoothjazz.cdnstream1.com/2585_256.mp3 title="Craigology - Attractive (World Beat Groove) " Oct 11 14:58:51 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:51.410+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.200:54179,192.168.1.200:54180 @ 0x1ca86f0" state=STATUS_PLAYING positionMs=116820 volume=55 Oct 11 14:58:51 volumio volumio5-onboarding[1257]: time=2026-10-11T14:58:51.410+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.200:54179,192.168.1.200:54180 @ 0x1ca86f0" id=https://smoothjazz.cdnstream1.com/2585_256.mp3 title="Craigology - Attractive (World Beat Groove) " Oct 11 14:58:51 volumio volumio[1054]: info: ------------------------------ 17ms Oct 11 14:58:51 volumio volumio[1054]: info: Enabling MyMusic plugin upnp Oct 11 14:58:51 volumio volumio[1054]: info: Enabling plugin upnp Oct 11 14:58:51 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 11 14:58:51 volumio volumio[1054]: info: Loading plugin "upnp"... Oct 11 14:58:51 volumio volumio[1054]: info: [1791723531581] Starting Upmpd Daemon Oct 11 14:58:51 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 11 14:58:51 volumio volumio[1054]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 11 14:58:51 volumio volumio[1054]: Error: listen EADDRINUSE: address already in use :::6599 Oct 11 14:58:51 volumio volumio[1054]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Oct 11 14:58:51 volumio volumio[1054]: at listenInCluster (net.js:1366:12) Oct 11 14:58:51 volumio volumio[1054]: at Server.listen (net.js:1452:7) Oct 11 14:58:51 volumio volumio[1054]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Oct 11 14:58:51 volumio volumio[1054]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Oct 11 14:58:51 volumio volumio[1054]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Oct 11 14:58:51 volumio volumio[1054]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Oct 11 14:58:51 volumio volumio[1054]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Oct 11 14:58:51 volumio volumio[1054]: code: 'EADDRINUSE', Oct 11 14:58:51 volumio volumio[1054]: errno: -98, Oct 11 14:58:51 volumio volumio[1054]: syscall: 'listen', Oct 11 14:58:51 volumio volumio[1054]: address: '::', Oct 11 14:58:51 volumio volumio[1054]: port: 6599 Oct 11 14:58:51 volumio volumio[1054]: } Oct 11 14:58:51 volumio volumio[1054]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 11 14:58:51 volumio sudo[24751]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-11 14:57 Oct 11 14:58:51 volumio sudo[24751]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"