-- Logs begin at Thu 2019-02-14 10:12:04 UTC, end at Sat 2026-03-28 06:44:43 UTC. -- Mar 28 06:43:02 volumio volumio5-onboarding[1009]: time=2026-03-28T06:43:02.192Z level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.3.14:59812 Mar 28 06:43:09 volumio volumio5-onboarding[1009]: failed to bootstrap state: failed to check for software update: could not check for updates: context deadline exceeded Mar 28 06:43:09 volumio systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 28 06:43:09 volumio systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 28 06:43:09 volumio systemd[1]: volumio5-onboarding.service: Service RestartSec=100ms expired, scheduling restart. Mar 28 06:43:09 volumio systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 1. Mar 28 06:43:09 volumio systemd[1]: Stopped Volumio5 Onboarding Server. Mar 28 06:43:09 volumio systemd[1]: Started Volumio5 Onboarding Server. Mar 28 06:43:09 volumio volumio[814]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Mar 28 06:43:09 volumio volumio[814]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Mar 28 06:43:09 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 28 06:43:09 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 28 06:43:09 volumio volumio[814]: info: Starting MyVolumio Remote Streaming Endpoints Mar 28 06:43:09 volumio volumio5-onboarding[1154]: time=2026-03-28T06:43:09.726Z level=INFO msg="running volumio5-device-gateway" version=687ad144+CHANGES buildDate=2026-02-10T16:50:24Z Mar 28 06:43:10 volumio volumio[814]: info: MyVolumio not started Mar 28 06:43:10 volumio volumio[814]: info: Initializing device activation check Mar 28 06:43:10 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 28 06:43:10 volumio volumio[814]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Mar 28 06:43:10 volumio volumio[814]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Mar 28 06:43:11 volumio volumio-remote-updater[363]: [2026-03-28 06:43:11] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Mar 28 06:43:16 volumio volumio-remote-updater[363]: [2026-03-28 06:43:16] [connect] Successful connection Mar 28 06:43:19 volumio volumio5-onboarding[1154]: failed to create app: failed to initialize host: failed to create socket connection: could not connect to socket.io server: read tcp 127.0.0.1:38682->127.0.0.1:3000: i/o timeout Mar 28 06:43:19 volumio systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 28 06:43:19 volumio systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 28 06:43:20 volumio systemd[1]: volumio5-onboarding.service: Service RestartSec=100ms expired, scheduling restart. Mar 28 06:43:20 volumio systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 2. Mar 28 06:43:20 volumio systemd[1]: Stopped Volumio5 Onboarding Server. Mar 28 06:43:20 volumio systemd[1]: Started Volumio5 Onboarding Server. Mar 28 06:43:20 volumio volumio5-onboarding[1212]: time=2026-03-28T06:43:20.428Z level=INFO msg="running volumio5-device-gateway" version=687ad144+CHANGES buildDate=2026-02-10T16:50:24Z Mar 28 06:43:22 volumio volumio[989]: ............................................................................++++ Mar 28 06:43:23 volumio volumio[814]: info: Starting Streaming Service Transparent Proxy Mar 28 06:43:24 volumio volumio[814]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Mar 28 06:43:24 volumio volumio[814]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Mar 28 06:43:24 volumio volumio[814]: info: Streaming services startup Mar 28 06:43:24 volumio volumio[814]: info: Starting Streaming Daemon Mar 28 06:43:24 volumio volumio[814]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Mar 28 06:43:24 volumio sudo[1238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 28 06:43:24 volumio sudo[1238]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 06:43:25 volumio sudo[1238]: pam_unix(sudo:session): session closed for user root Mar 28 06:43:25 volumio volumio[814]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Mar 28 06:43:25 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 28 06:43:25 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 28 06:43:25 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 28 06:43:25 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 28 06:43:26 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 28 06:43:26 volumio volumio[814]: error: Cannot start Volumio Streaming Daemon Mar 28 06:43:26 volumio volumio[814]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 28 06:43:26 volumio volumio[814]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 28 06:43:27 volumio volumio[814]: 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: 1 Mar 28 06:43:28 volumio volumio[814]: 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: 1 Mar 28 06:43:28 volumio volumio[814]: info: Received Get System Info Mar 28 06:43:28 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 28 06:43:28 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 28 06:43:28 volumio volumio[814]: info: Discovery: Getting this device information Mar 28 06:43:28 volumio volumio[814]: info: CoreCommandRouter::volumioGetState Mar 28 06:43:28 volumio volumio[814]: info: CorePlayQueue::getTrack 0 Mar 28 06:43:28 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 28 06:43:28 volumio volumio5-onboarding[1212]: time=2026-03-28T06:43:28.504Z level=INFO msg="system info for 7ab9f3de9be407d45a63c21655f20afe" deviceName=Volumio deviceVariant=volumio deviceModel= softwareVersion=3.912 Mar 28 06:43:28 volumio volumio[814]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Mar 28 06:43:28 volumio volumio-remote-updater[363]: [2026-03-28 06:43:28] [connect] Successful connection Mar 28 06:43:28 volumio volumio[814]: info: Received Get System Info Mar 28 06:43:28 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 28 06:43:28 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 28 06:43:28 volumio volumio[814]: info: Discovery: Getting this device information Mar 28 06:43:28 volumio volumio[814]: info: CoreCommandRouter::volumioGetState Mar 28 06:43:28 volumio volumio[814]: info: CorePlayQueue::getTrack 0 Mar 28 06:43:28 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 28 06:43:30 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 28 06:43:30 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 28 06:43:30 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 28 06:43:30 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 28 06:43:30 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 28 06:43:30 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 28 06:43:30 volumio volumio[814]: info: CoreCommandRouter::volumioGetBrowseSources Mar 28 06:43:30 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 28 06:43:30 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 28 06:43:30 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 28 06:43:30 volumio volumio5-onboarding[1212]: time=2026-03-28T06:43:30.880Z level=INFO msg="enabling local network discovery" Mar 28 06:43:31 volumio volumio5-onboarding[1212]: time=2026-03-28T06:43:30.995Z level=INFO msg="enabling BLE discovery" Mar 28 06:43:31 volumio volumio5-onboarding[1212]: time=2026-03-28T06:43:31.326Z level=INFO msg="bootstrapping state" hasInternet=true Mar 28 06:43:31 volumio volumio[814]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 28 06:43:31 volumio volumio-remote-updater[363]: [2026-03-28 06:43:31] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1774680208 101 Mar 28 06:43:32 volumio volumio[814]: 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: 4 Mar 28 06:43:32 volumio volumio[814]: info: Received Get System Info Mar 28 06:43:32 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 28 06:43:32 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 28 06:43:32 volumio volumio[814]: info: Discovery: Getting this device information Mar 28 06:43:32 volumio volumio[814]: info: CoreCommandRouter::volumioGetState Mar 28 06:43:32 volumio volumio[814]: info: CorePlayQueue::getTrack 0 Mar 28 06:43:32 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 28 06:43:33 volumio volumio-remote-updater[363]: No test mode Mar 28 06:43:33 volumio volumio-remote-updater[363]: No alpha test mode Mar 28 06:43:33 volumio volumio[814]: info: CoreCommandRouter::volumioGetState Mar 28 06:43:33 volumio volumio[814]: info: CorePlayQueue::getTrack 0 Mar 28 06:43:34 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 28 06:43:34 volumio volumio-remote-updater[363]: No test mode Mar 28 06:43:34 volumio volumio-remote-updater[363]: No alpha test mode Mar 28 06:43:35 volumio volumio[814]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 28 06:43:35 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 28 06:43:35 volumio volumio[814]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 28 06:43:35 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 28 06:43:35 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 28 06:43:35 volumio volumio5-onboarding[1212]: time=2026-03-28T06:43:35.654Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=tidal error="could not open plugin config file for \"tidal\": open /data/configuration/music_service/tidal/config.json: no such file or directory" Mar 28 06:43:35 volumio volumio5-onboarding[1212]: time=2026-03-28T06:43:35.674Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=qobuz error="could not open plugin config file for \"qobuz\": open /data/configuration/music_service/qobuz/config.json: no such file or directory" Mar 28 06:43:35 volumio volumio5-onboarding[1212]: time=2026-03-28T06:43:35.696Z level=WARN msg="could not read username/password data for music provider" component=volumio provider=hi_res_audio error="could not open plugin config file for \"hi_res_audio\": open /data/configuration/music_service/hi_res_audio/config.json: no such file or directory" Mar 28 06:43:36 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 28 06:43:36 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 28 06:43:37 volumio volumio5-onboarding[1212]: time=2026-03-28T06:43:37.354Z level=INFO msg="service successfully established" component=discovery/localnet Mar 28 06:43:42 volumio volumio[814]: STREAMING PROXY: Starting server on port 3245 Mar 28 06:43:42 volumio volumio[814]: Node JS runtime: 14 Mar 28 06:43:44 volumio volumio5-onboarding[1212]: time=2026-03-28T06:43:44.061Z level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.3.14:53202 Mar 28 06:43:44 volumio volumio[814]: error: MyVolumio Plugin failed to authenticate in a timely fashion Mar 28 06:43:44 volumio volumio[814]: info: Completed starting MyVolumio Plugin Mar 28 06:43:44 volumio volumio[814]: [Metrics] CommandRouter: 109s 150.16ms Mar 28 06:43:44 volumio volumio[814]: info: CoreCommandRouter::volumiosetStartupVolume Mar 28 06:43:44 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 28 06:43:44 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 28 06:43:44 volumio volumio[814]: info: CoreCommandRouter::Close All Modals sent Mar 28 06:43:44 volumio volumio[814]: info: CoreCommandRouter::Close All Modals sent Mar 28 06:43:45 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 28 06:43:46 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 28 06:43:46 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 28 06:43:51 volumio volumio[814]: info: BOOT COMPLETED Mar 28 06:44:01 volumio volumio5-onboarding[1212]: time=2026-03-28T06:44:01.764Z level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.3.14:53202 @ 0x236e2a0" latency=-477.675441ms timeout=10s Mar 28 06:44:01 volumio volumio5-onboarding[1212]: time=2026-03-28T06:44:01.771Z level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.3.14:53202 @ 0x236e2a0" Mar 28 06:44:01 volumio volumio5-onboarding[1212]: time=2026-03-28T06:44:01.787Z level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.3.14:53202 @ 0x236e2a0" latency=-459.662522ms platform=PLATFORM_ANDROID version=5.260209.0 Mar 28 06:44:01 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 28 06:44:01 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 28 06:44:01 volumio volumio[814]: info: Received Get System Info Mar 28 06:44:01 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 28 06:44:01 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 28 06:44:01 volumio volumio[814]: info: Discovery: Getting this device information Mar 28 06:44:01 volumio volumio[814]: info: CoreCommandRouter::volumioGetState Mar 28 06:44:01 volumio volumio[814]: info: CorePlayQueue::getTrack 0 Mar 28 06:44:01 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 28 06:44:01 volumio volumio5-onboarding[1212]: time=2026-03-28T06:44:01.888Z level=INFO msg="emitting device name changed event" component=server peer="192.168.3.14:53202 @ 0x236e2a0" name=Volumio Mar 28 06:44:01 volumio volumio5-onboarding[1212]: time=2026-03-28T06:44:01.921Z level=INFO msg="emitting device language changed event" component=server peer="192.168.3.14:53202 @ 0x236e2a0" language=ja Mar 28 06:44:01 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Mar 28 06:44:01 volumio volumio5-onboarding[1212]: time=2026-03-28T06:44:01.959Z level=INFO msg="emitting device timezone changed event" component=server peer="192.168.3.14:53202 @ 0x236e2a0" timezone=UTC Mar 28 06:44:01 volumio volumio5-onboarding[1212]: time=2026-03-28T06:44:01.964Z level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.3.14:53202 @ 0x236e2a0" available=false connected=false macAddress= ip4Address= ip6Address= Mar 28 06:44:02 volumio volumio5-onboarding[1212]: time=2026-03-28T06:44:01.996Z level=INFO msg="emitting wifi info changed event" component=server peer="192.168.3.14:53202 @ 0x236e2a0" available=true connected=true macAddress=b8:27:eb:3c:9f:7c ip4Address=192.168.3.5/24 ip6Address= ssid=aterm-389776-g Mar 28 06:44:02 volumio volumio5-onboarding[1212]: time=2026-03-28T06:44:02.002Z level=INFO msg="emitting device setup status changed event" component=server peer="192.168.3.14:53202 @ 0x236e2a0" setupComplete=true Mar 28 06:44:02 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Mar 28 06:44:02 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 28 06:44:02 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 28 06:44:02 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 28 06:44:02 volumio volumio[814]: amixer -c 0 info | grep "bcm2835 ALSA" Mar 28 06:44:03 volumio volumio[814]: amixer -c 1 info | grep "bcm2835 Headphones" Mar 28 06:44:03 volumio volumio[814]: Card hw:1 'Headphones'/'bcm2835 Headphones' Mar 28 06:44:03 volumio volumio[814]: amixer -c 2 info | grep "snd_rpi_hifiberry_dac" Mar 28 06:44:04 volumio volumio[814]: Card hw:2 'sndrpihifiberry'/'snd_rpi_hifiberry_dac' Mar 28 06:44:04 volumio volumio[814]: amixer -c 2 info | grep "pHAT DAC" Mar 28 06:44:04 volumio volumio5-onboarding[1212]: time=2026-03-28T06:44:04.946Z level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.3.14:53202 @ 0x236e2a0" selectedOutputId=2 Mar 28 06:44:04 volumio volumio[814]: info: Received Get System Info Mar 28 06:44:04 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 28 06:44:05 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 28 06:44:05 volumio volumio[814]: info: Discovery: Getting this device information Mar 28 06:44:05 volumio volumio[814]: info: CoreCommandRouter::volumioGetState Mar 28 06:44:05 volumio volumio[814]: info: CorePlayQueue::getTrack 0 Mar 28 06:44:05 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 28 06:44:05 volumio volumio5-onboarding[1212]: time=2026-03-28T06:44:05.044Z level=INFO msg="emitting software info changed event" component=server peer="192.168.3.14:53202 @ 0x236e2a0" currentVersion=3.912 latestVersion=3.912 Mar 28 06:44:05 volumio volumio5-onboarding[1212]: time=2026-03-28T06:44:05.054Z level=INFO msg="emitting software update progress event" component=server peer="192.168.3.14:53202 @ 0x236e2a0" status=UPDATE_STATUS_NONE progress=0 Mar 28 06:44:05 volumio volumio5-onboarding[1212]: time=2026-03-28T06:44:05.061Z level=INFO msg="emitting user changed event" component=server peer="192.168.3.14:53202 @ 0x236e2a0" userId= Mar 28 06:44:05 volumio volumio5-onboarding[1212]: time=2026-03-28T06:44:05.071Z level=INFO msg="emitting music providers changed event" component=server peer="192.168.3.14:53202 @ 0x236e2a0" providers=3 Mar 28 06:44:05 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 28 06:44:05 volumio volumio5-onboarding[1212]: time=2026-03-28T06:44:05.100Z level=INFO msg="emitting plugins changed event" component=server peer="192.168.3.14:53202 @ 0x236e2a0" plugins=0 Mar 28 06:44:05 volumio volumio[814]: info: CoreCommandRouter::volumioGetState Mar 28 06:44:05 volumio volumio[814]: info: CorePlayQueue::getTrack 0 Mar 28 06:44:05 volumio volumio5-onboarding[1212]: time=2026-03-28T06:44:05.163Z level=INFO msg="emitting player state changed event" component=server peer="192.168.3.14:53202 @ 0x236e2a0" state=STATUS_STOPPED positionMs=0 volume=100 Mar 28 06:44:05 volumio volumio5-onboarding[1212]: time=2026-03-28T06:44:05.181Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.3.14:53202 @ 0x236e2a0" id="mnt/NAS/NAS_pi/Bruno Mars/24K MAGIC/01_24k Magic.mp3" title="24k Magic" Mar 28 06:44:05 volumio volumio5-onboarding[1212]: time=2026-03-28T06:44:05.251Z level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.3.14:53202 @ 0x236e2a0" latency=-489.782811ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Mar 28 06:44:07 volumio sudo[1335]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 28 06:44:07 volumio sudo[1335]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 06:44:07 volumio sudo[1337]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 06:44:07 volumio sudo[1337]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 06:44:07 volumio sudo[1337]: pam_unix(sudo:session): session closed for user root Mar 28 06:44:07 volumio sudo[1335]: pam_unix(sudo:session): session closed for user root Mar 28 06:44:07 volumio volumio[814]: verbose: New Socket.io Connection to 192.168.3.5 from 192.168.3.14 UA: Mozilla/5.0 (Linux; Android 16; SCG13 Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.119 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Mar 28 06:44:07 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 28 06:44:08 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 28 06:44:08 volumio sudo[1343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 28 06:44:08 volumio sudo[1343]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 06:44:08 volumio sudo[1345]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 28 06:44:08 volumio sudo[1345]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 28 06:44:08 volumio sudo[1345]: pam_unix(sudo:session): session closed for user root Mar 28 06:44:08 volumio sudo[1343]: pam_unix(sudo:session): session closed for user root Mar 28 06:44:08 volumio volumio[814]: verbose: New Socket.io Connection to 192.168.3.5 from 192.168.3.14 UA: Mozilla/5.0 (Linux; Android 16; SCG13 Build/BP2A.250605.031.A3; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.119 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Mar 28 06:44:09 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 28 06:44:09 volumio volumio[814]: info: CoreCommandRouter::volumioGetVisibleSources Mar 28 06:44:09 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 28 06:44:09 volumio volumio[814]: info: CoreCommandRouter::volumioGetState Mar 28 06:44:09 volumio volumio[814]: info: CorePlayQueue::getTrack 0 Mar 28 06:44:09 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 28 06:44:09 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 28 06:44:09 volumio volumio[814]: info: Received Get System Info Mar 28 06:44:09 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 28 06:44:09 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 28 06:44:09 volumio volumio[814]: info: Discovery: Getting this device information Mar 28 06:44:09 volumio volumio[814]: info: CoreCommandRouter::volumioGetState Mar 28 06:44:09 volumio volumio[814]: info: CorePlayQueue::getTrack 0 Mar 28 06:44:09 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 28 06:44:09 volumio volumio[814]: info: CoreCommandRouter::volumioGetState Mar 28 06:44:09 volumio volumio[814]: info: CorePlayQueue::getTrack 0 Mar 28 06:44:09 volumio volumio[814]: info: Listing playlists Mar 28 06:44:09 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 28 06:44:09 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 28 06:44:10 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 28 06:44:10 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 28 06:44:10 volumio volumio[814]: info: Received Get System Info Mar 28 06:44:10 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 28 06:44:10 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 28 06:44:10 volumio volumio[814]: info: Discovery: Getting this device information Mar 28 06:44:10 volumio volumio[814]: info: CoreCommandRouter::volumioGetState Mar 28 06:44:10 volumio volumio[814]: info: CorePlayQueue::getTrack 0 Mar 28 06:44:10 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 28 06:44:11 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 28 06:44:19 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 28 06:44:27 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 28 06:44:27 volumio volumio[814]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 28 06:44:27 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 28 06:44:27 volumio volumio[814]: info: Received Get System Version Mar 28 06:44:27 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 28 06:44:27 volumio volumio[814]: info: Received Get System Info Mar 28 06:44:27 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 28 06:44:27 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 28 06:44:27 volumio volumio[814]: info: Discovery: Getting this device information Mar 28 06:44:27 volumio volumio[814]: info: CoreCommandRouter::volumioGetState Mar 28 06:44:27 volumio volumio[814]: info: CorePlayQueue::getTrack 0 Mar 28 06:44:27 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 28 06:44:30 volumio volumio[814]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 28 06:44:30 volumio volumio[814]: info: Retrieving Cloud Streaming UI Mar 28 06:44:30 volumio volumio[814]: info: Getting Tidal Cloud Configuration Mar 28 06:44:30 volumio volumio[814]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 28 06:44:30 volumio volumio[814]: info: Getting Qobuz Cloud Configuration Mar 28 06:44:30 volumio volumio[814]: info: Asking plugin for UI Config Mar 28 06:44:30 volumio volumio[814]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 28 06:44:30 volumio volumio[814]: info: Getting Spotify Cloud Configuration Mar 28 06:44:30 volumio volumio[814]: info: Asking plugin for UI Config Mar 28 06:44:30 volumio volumio[814]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 28 06:44:30 volumio volumio[814]: info: Saving Spotify Acccount Mar 28 06:44:30 volumio volumio[814]: info: Got Tidal Cloud Configuration Mar 28 06:44:30 volumio volumio[814]: info: Got it Mar 28 06:44:30 volumio volumio[814]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 28 06:44:30 volumio volumio[814]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 28 06:44:30 volumio volumio[814]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 28 06:44:31 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 28 06:44:31 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 28 06:44:31 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 28 06:44:31 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 28 06:44:31 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 28 06:44:31 volumio volumio[814]: info: CoreCommandRouter::volumioGetBrowseSources Mar 28 06:44:31 volumio volumio[814]: info: CoreCommandRouter::volumioGetBrowseSources Mar 28 06:44:31 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 28 06:44:31 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 28 06:44:32 volumio volumio[989]: .............................................................................................................................................................................................++++ Mar 28 06:44:32 volumio volumio[989]: e is 65537 (0x010001) Mar 28 06:44:32 volumio volumio[989]: writing RSA key Mar 28 06:44:35 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 28 06:44:35 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Mar 28 06:44:35 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Mar 28 06:44:39 volumio volumio[814]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 28 06:44:41 volumio volumio[814]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 28 06:44:41 volumio volumio[814]: Error: dns service error: unknown Mar 28 06:44:41 volumio volumio[814]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Mar 28 06:44:41 volumio volumio[814]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Mar 28 06:44:41 volumio volumio[814]: errorCode: -65537 Mar 28 06:44:41 volumio volumio[814]: } Mar 28 06:44:41 volumio volumio[814]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 28 06:44:43 volumio sudo[1459]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-28 06:43 Mar 28 06:44:43 volumio sudo[1459]: 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"