-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Tue 2026-04-14 18:39:42 CEST. -- Apr 14 18:38:03 volumiogreen wpa_supplicant[937]: wlan0: Failed to initiate sched scan Apr 14 18:38:04 volumiogreen volumio[1164]: info: Received Get System Info Apr 14 18:38:04 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 18:38:04 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 18:38:04 volumiogreen volumio[1164]: info: Discovery: Getting this device information Apr 14 18:38:04 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioGetState Apr 14 18:38:04 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 18:38:04 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 14 18:38:04 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 14 18:38:09 volumiogreen wpa_supplicant[937]: wlan0: Failed to initiate sched scan Apr 14 18:38:09 volumiogreen volumio[1164]: info: Received Get System Info Apr 14 18:38:09 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 18:38:09 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 18:38:09 volumiogreen volumio[1164]: info: Discovery: Getting this device information Apr 14 18:38:09 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioGetState Apr 14 18:38:09 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 18:38:09 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 14 18:38:09 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 14 18:38:14 volumiogreen wpa_supplicant[937]: wlan0: Failed to initiate sched scan Apr 14 18:38:14 volumiogreen nmbd[761]: [2026/04/14 18:38:14.903396, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Apr 14 18:38:14 volumiogreen nmbd[761]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.0.101 for name WORKGROUP<1d>. Apr 14 18:38:14 volumiogreen nmbd[761]: This response was from IP 192.168.0.114, reporting an IP address of 192.168.0.114. Apr 14 18:38:15 volumiogreen volumio[1164]: info: Received Get System Info Apr 14 18:38:15 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 18:38:15 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 18:38:15 volumiogreen volumio[1164]: info: Discovery: Getting this device information Apr 14 18:38:15 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioGetState Apr 14 18:38:15 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 18:38:15 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 14 18:38:15 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 14 18:38:17 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:17+02:00" level=trace msg="sent dealer ping" Apr 14 18:38:17 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:17+02:00" level=trace msg="received dealer pong" Apr 14 18:38:20 volumiogreen wpa_supplicant[937]: wlan0: Failed to initiate sched scan Apr 14 18:38:20 volumiogreen volumio[1164]: info: Received Get System Info Apr 14 18:38:20 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 18:38:20 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 18:38:20 volumiogreen volumio[1164]: info: Discovery: Getting this device information Apr 14 18:38:20 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioGetState Apr 14 18:38:20 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 18:38:20 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 14 18:38:20 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 14 18:38:21 volumiogreen volumio[1164]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/now_playing/volumio/buster/armhf Apr 14 18:38:21 volumiogreen volumio5-onboarding[1581]: time=2026-04-14T18:38:21.105+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 14 18:38:24 volumiogreen volumio[1164]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/now_playing/volumio/buster/armhf Apr 14 18:38:24 volumiogreen volumio[1164]: info: Folder /tmp/plugins removed Apr 14 18:38:24 volumiogreen volumio5-onboarding[1581]: time=2026-04-14T18:38:24.702+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 14 18:38:26 volumiogreen wpa_supplicant[937]: wlan0: Failed to initiate sched scan Apr 14 18:38:26 volumiogreen volumio[1164]: info: Received Get System Info Apr 14 18:38:26 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 18:38:26 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 18:38:26 volumiogreen volumio[1164]: info: Discovery: Getting this device information Apr 14 18:38:26 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioGetState Apr 14 18:38:26 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 18:38:26 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 14 18:38:26 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 14 18:38:27 volumiogreen volumio5-onboarding[1581]: time=2026-04-14T18:38:27.264+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 14 18:38:27 volumiogreen volumio[1164]: info: Check plugin dependencies Apr 14 18:38:27 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 14 18:38:27 volumiogreen volumio5-onboarding[1581]: time=2026-04-14T18:38:27.405+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 14 18:38:27 volumiogreen volumio[1164]: info: Checking if plugin already exists Apr 14 18:38:27 volumiogreen volumio5-onboarding[1581]: time=2026-04-14T18:38:27.428+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 14 18:38:27 volumiogreen volumio[1164]: info: Rename folder Apr 14 18:38:27 volumiogreen volumio[1164]: info: Folder /tmp/downloaded_plugin.zip removed Apr 14 18:38:27 volumiogreen volumio5-onboarding[1581]: time=2026-04-14T18:38:27.489+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 14 18:38:27 volumiogreen volumio[1164]: info: Move to category Apr 14 18:38:28 volumiogreen volumio5-onboarding[1581]: time=2026-04-14T18:38:28.881+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 14 18:38:28 volumiogreen volumio[1164]: info: Checking if install.sh is present Apr 14 18:38:28 volumiogreen volumio[1164]: info: Executing install.sh Apr 14 18:38:29 volumiogreen sudo[2327]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/user_interface/now_playing/install.sh Apr 14 18:38:29 volumiogreen sudo[2327]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 14 18:38:29 volumiogreen volumio[1164]: info: Installing geo-tz node dependency Apr 14 18:38:29 volumiogreen volumio5-onboarding[1581]: time=2026-04-14T18:38:29.129+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 14 18:38:31 volumiogreen wpa_supplicant[937]: wlan0: Failed to initiate sched scan Apr 14 18:38:32 volumiogreen volumio[1164]: info: Received Get System Info Apr 14 18:38:32 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 18:38:32 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 18:38:32 volumiogreen volumio[1164]: info: Discovery: Getting this device information Apr 14 18:38:32 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioGetState Apr 14 18:38:32 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 18:38:32 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 14 18:38:32 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 14 18:38:37 volumiogreen wpa_supplicant[937]: wlan0: Failed to initiate sched scan Apr 14 18:38:37 volumiogreen volumio[1164]: info: Received Get System Info Apr 14 18:38:37 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 18:38:37 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 18:38:37 volumiogreen volumio[1164]: info: Discovery: Getting this device information Apr 14 18:38:37 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioGetState Apr 14 18:38:37 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 18:38:37 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 14 18:38:37 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 14 18:38:41 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:41+02:00" level=trace msg="emitting websocket event: not_playing" Apr 14 18:38:41 volumiogreen volumio[1164]: error: Failed to decode event: not_playing Apr 14 18:38:41 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:41+02:00" level=debug msg="loading track (paused: true, position: 0ms)" uri="spotify:track:4fiOTntQKr24p07FvQDHZE" Apr 14 18:38:41 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:41+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Apr 14 18:38:41 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:41+02:00" level=trace msg="emitting websocket event: will_play" Apr 14 18:38:41 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:41+02:00" level=debug msg="selected format OGG_VORBIS_320 (53ef932ff4a4e4482020d276f12910ec562f4d17)" uri="spotify:track:4fiOTntQKr24p07FvQDHZE" Apr 14 18:38:41 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:41+02:00" level=debug msg="requested aes key for file 53ef932ff4a4e4482020d276f12910ec562f4d17, gid: 4fiOTntQKr24p07FvQDHZE" Apr 14 18:38:41 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:41+02:00" level=trace msg="found 2 cdn urls" uri="spotify:track:4fiOTntQKr24p07FvQDHZE" Apr 14 18:38:41 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:41+02:00" level=debug msg="fetched first chunk of 20, total size is 10278448 bytes" uri="spotify:track:4fiOTntQKr24p07FvQDHZE" Apr 14 18:38:41 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:41+02:00" level=info msg="loaded track \"Raining Blood\" (paused: true, position: 0ms, duration: 255186ms, prefetched: false)" uri="spotify:track:4fiOTntQKr24p07FvQDHZE" Apr 14 18:38:41 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:41+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Apr 14 18:38:41 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:41+02:00" level=trace msg="emitting websocket event: metadata" Apr 14 18:38:41 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:41+02:00" level=trace msg="emitting websocket event: stopped" Apr 14 18:38:41 volumiogreen volumio[1164]: info: CoreCommandRouter::servicePushState Apr 14 18:38:41 volumiogreen volumio[1164]: info: CoreStateMachine::pushState Apr 14 18:38:41 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 18:38:41 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioPushState Apr 14 18:38:41 volumiogreen volumio[1164]: info: CorePlayQueue::getTrack 0 Apr 14 18:38:41 volumiogreen volumio[1164]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received spop Apr 14 18:38:41 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:41+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Apr 14 18:38:41 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:41+02:00" level=trace msg="emitting websocket event: paused" Apr 14 18:38:42 volumiogreen volumio[1164]: info: CoreCommandRouter::servicePushState Apr 14 18:38:42 volumiogreen volumio[1164]: info: CoreStateMachine::pushState Apr 14 18:38:42 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 18:38:42 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioPushState Apr 14 18:38:42 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:42+02:00" level=debug msg="fetched chunk 2/19, size: 524288" uri="spotify:track:4fiOTntQKr24p07FvQDHZE" Apr 14 18:38:42 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:42+02:00" level=debug msg="fetched chunk 1/19, size: 524288" uri="spotify:track:4fiOTntQKr24p07FvQDHZE" Apr 14 18:38:42 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:42+02:00" level=debug msg="fetched chunk 3/19, size: 524288" uri="spotify:track:4fiOTntQKr24p07FvQDHZE" Apr 14 18:38:42 volumiogreen wpa_supplicant[937]: wlan0: Failed to initiate sched scan Apr 14 18:38:43 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:43+02:00" level=debug msg="handling play player command from 33aae78f3ec81bd83ee7941561e95c9f44fcc21e" Apr 14 18:38:43 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:43+02:00" level=debug msg="resolved context of track" uri="spotify:search:raining+blood" Apr 14 18:38:43 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:43+02:00" level=trace msg="fetched new page 0 with 1 items (list: 1)" uri="spotify:search:raining+blood" Apr 14 18:38:43 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:43+02:00" level=debug msg="loading track (paused: false, position: 1ms)" uri="spotify:track:5ohfpKB5tt275f4Y4lQ9F7" Apr 14 18:38:43 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:43+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Apr 14 18:38:43 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:43+02:00" level=trace msg="emitting websocket event: will_play" Apr 14 18:38:43 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:43+02:00" level=debug msg="selected format OGG_VORBIS_320 (c0057eb1a410b9cfb002a136bc78e6e79dd9f357)" uri="spotify:track:5ohfpKB5tt275f4Y4lQ9F7" Apr 14 18:38:43 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:43+02:00" level=debug msg="requested aes key for file c0057eb1a410b9cfb002a136bc78e6e79dd9f357, gid: 5ohfpKB5tt275f4Y4lQ9F7" Apr 14 18:38:43 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:43+02:00" level=trace msg="found 2 cdn urls" uri="spotify:track:5ohfpKB5tt275f4Y4lQ9F7" Apr 14 18:38:43 volumiogreen volumio[1164]: info: Received Get System Info Apr 14 18:38:43 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 18:38:43 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 18:38:43 volumiogreen volumio[1164]: info: Discovery: Getting this device information Apr 14 18:38:43 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioGetState Apr 14 18:38:43 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 18:38:43 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 14 18:38:43 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 14 18:38:43 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:43+02:00" level=debug msg="fetched first chunk of 24, total size is 12397156 bytes" uri="spotify:track:5ohfpKB5tt275f4Y4lQ9F7" Apr 14 18:38:43 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:43+02:00" level=trace msg="seek to 1ms (diff: 1ms, samples: 44, bytes: 0)" uri="spotify:track:5ohfpKB5tt275f4Y4lQ9F7" Apr 14 18:38:43 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:43+02:00" level=debug msg="alsa driver configured, rate = 44100 bps, period time = 100000 us, period size = 4410 frames, buffer time = 500000 us, buffer size = 22050 frames, periods per buffer = 5 frames, PCM format = FLOAT_LE" Apr 14 18:38:43 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:43+02:00" level=info msg="loaded track \"Angel Of Death\" (paused: false, position: 1ms, duration: 291773ms, prefetched: false)" uri="spotify:track:5ohfpKB5tt275f4Y4lQ9F7" Apr 14 18:38:43 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:43+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Apr 14 18:38:43 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:43+02:00" level=trace msg="scheduling prefetch in 262s" Apr 14 18:38:43 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:43+02:00" level=trace msg="emitting websocket event: metadata" Apr 14 18:38:43 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:43+02:00" level=debug msg="sending successful reply for dealer request" Apr 14 18:38:43 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:43+02:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Apr 14 18:38:43 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:43+02:00" level=trace msg="emitting websocket event: playing" Apr 14 18:38:43 volumiogreen volumio[1164]: info: CoreCommandRouter::servicePushState Apr 14 18:38:43 volumiogreen volumio[1164]: info: CoreStateMachine::pushState Apr 14 18:38:43 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 14 18:38:43 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioPushState Apr 14 18:38:43 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:43+02:00" level=debug msg="fetched chunk 2/23, size: 524288" uri="spotify:track:5ohfpKB5tt275f4Y4lQ9F7" Apr 14 18:38:43 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:43+02:00" level=debug msg="fetched chunk 3/23, size: 524288" uri="spotify:track:5ohfpKB5tt275f4Y4lQ9F7" Apr 14 18:38:44 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:44+02:00" level=debug msg="fetched chunk 1/23, size: 524288" uri="spotify:track:5ohfpKB5tt275f4Y4lQ9F7" Apr 14 18:38:44 volumiogreen volumio[1164]: info: CoreCommandRouter::servicePushState Apr 14 18:38:44 volumiogreen volumio[1164]: info: CoreStateMachine::pushState Apr 14 18:38:44 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioPushState Apr 14 18:38:47 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:47+02:00" level=trace msg="sent dealer ping" Apr 14 18:38:47 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:47+02:00" level=trace msg="received dealer pong" Apr 14 18:38:48 volumiogreen wpa_supplicant[937]: wlan0: Failed to initiate sched scan Apr 14 18:38:49 volumiogreen volumio[1164]: info: Received Get System Info Apr 14 18:38:49 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 18:38:49 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 18:38:49 volumiogreen volumio[1164]: info: Discovery: Getting this device information Apr 14 18:38:49 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioGetState Apr 14 18:38:49 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 18:38:49 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 14 18:38:49 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 14 18:38:51 volumiogreen volumio[1164]: verbose: New Socket.io Connection to 192.168.0.101 from 192.168.0.96 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/147.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Apr 14 18:38:51 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioGetState Apr 14 18:38:51 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 14 18:38:54 volumiogreen wpa_supplicant[937]: wlan0: Failed to initiate sched scan Apr 14 18:38:54 volumiogreen volumio[1164]: info: Received Get System Info Apr 14 18:38:54 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 18:38:54 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 18:38:54 volumiogreen volumio[1164]: info: Discovery: Getting this device information Apr 14 18:38:54 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioGetState Apr 14 18:38:54 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 18:38:54 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 14 18:38:54 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 14 18:38:56 volumiogreen go-librespot[1387]: time="2026-04-14T18:38:56+02:00" level=debug msg="fetched chunk 4/23, size: 524288" uri="spotify:track:5ohfpKB5tt275f4Y4lQ9F7" Apr 14 18:38:59 volumiogreen wpa_supplicant[937]: wlan0: Failed to initiate sched scan Apr 14 18:39:00 volumiogreen volumio[1164]: info: Received Get System Info Apr 14 18:39:00 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 18:39:00 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 18:39:00 volumiogreen volumio[1164]: info: Discovery: Getting this device information Apr 14 18:39:00 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioGetState Apr 14 18:39:00 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 18:39:00 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 14 18:39:00 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 14 18:39:05 volumiogreen wpa_supplicant[937]: wlan0: Failed to initiate sched scan Apr 14 18:39:05 volumiogreen volumio[1164]: info: Received Get System Info Apr 14 18:39:05 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 18:39:05 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 18:39:05 volumiogreen volumio[1164]: info: Discovery: Getting this device information Apr 14 18:39:05 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioGetState Apr 14 18:39:05 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 18:39:05 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 14 18:39:05 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 14 18:39:08 volumiogreen go-librespot[1387]: time="2026-04-14T18:39:08+02:00" level=debug msg="fetched chunk 5/23, size: 524288" uri="spotify:track:5ohfpKB5tt275f4Y4lQ9F7" Apr 14 18:39:11 volumiogreen wpa_supplicant[937]: wlan0: Failed to initiate sched scan Apr 14 18:39:11 volumiogreen volumio[1164]: info: Received Get System Info Apr 14 18:39:11 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 18:39:11 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 18:39:11 volumiogreen volumio[1164]: info: Discovery: Getting this device information Apr 14 18:39:11 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioGetState Apr 14 18:39:11 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 18:39:11 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 14 18:39:11 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 14 18:39:12 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesYouTube Music Apr 14 18:39:12 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 14 18:39:12 volumiogreen volumio[1164]: Cannot find translation for source Spotify Apr 14 18:39:12 volumiogreen volumio[1164]: info: Disabling plugin ytmusic Apr 14 18:39:12 volumiogreen volumio[1164]: info: Done. Apr 14 18:39:14 volumiogreen volumio[1164]: info: Enabling plugin ytmusic Apr 14 18:39:14 volumiogreen volumio[1164]: info: Loading plugin "ytmusic"... Apr 14 18:39:14 volumiogreen volumio[1164]: info: PLUGIN START: ytmusic Apr 14 18:39:14 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 14 18:39:14 volumiogreen volumio[1164]: info: [1776184754940] CoreMusicLibrary::Adding element YouTube Music Apr 14 18:39:14 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 14 18:39:14 volumiogreen volumio[1164]: Cannot find translation for source Spotify Apr 14 18:39:14 volumiogreen volumio[1164]: Cannot find translation for source YouTube Music Apr 14 18:39:14 volumiogreen volumio[1164]: info: Done. Apr 14 18:39:16 volumiogreen wpa_supplicant[937]: wlan0: Failed to initiate sched scan Apr 14 18:39:17 volumiogreen volumio[1164]: info: Received Get System Info Apr 14 18:39:17 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 18:39:17 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 18:39:17 volumiogreen volumio[1164]: info: Discovery: Getting this device information Apr 14 18:39:17 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioGetState Apr 14 18:39:17 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 18:39:17 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 14 18:39:17 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 14 18:39:17 volumiogreen go-librespot[1387]: time="2026-04-14T18:39:17+02:00" level=trace msg="sent dealer ping" Apr 14 18:39:17 volumiogreen go-librespot[1387]: time="2026-04-14T18:39:17+02:00" level=trace msg="received dealer pong" Apr 14 18:39:19 volumiogreen volumio[1164]: info: Enabling plugin now_playing Apr 14 18:39:19 volumiogreen volumio[1164]: info: Loading plugin "now_playing"... Apr 14 18:39:19 volumiogreen volumio[1164]: error: !!!! WARNING !!!! Apr 14 18:39:19 volumiogreen volumio[1164]: error: The plugin user_interface/now_playing failed to load, setting it to stopped. Error: Error: Cannot find module 'geo-tz' Apr 14 18:39:19 volumiogreen volumio[1164]: Require stack: Apr 14 18:39:19 volumiogreen volumio[1164]: - /data/plugins/user_interface/now_playing/dist/index.js Apr 14 18:39:19 volumiogreen volumio[1164]: - /volumio/app/pluginmanager.js Apr 14 18:39:19 volumiogreen volumio[1164]: - /volumio/app/index.js Apr 14 18:39:19 volumiogreen volumio[1164]: - /volumio/index.js Apr 14 18:39:19 volumiogreen volumio[1164]: error: Stack trace: Error: Cannot find module 'geo-tz' Apr 14 18:39:19 volumiogreen volumio[1164]: Require stack: Apr 14 18:39:19 volumiogreen volumio[1164]: - /data/plugins/user_interface/now_playing/dist/index.js Apr 14 18:39:19 volumiogreen volumio[1164]: - /volumio/app/pluginmanager.js Apr 14 18:39:19 volumiogreen volumio[1164]: - /volumio/app/index.js Apr 14 18:39:19 volumiogreen volumio[1164]: - /volumio/index.js Apr 14 18:39:19 volumiogreen volumio[1164]: at Function.Module._resolveFilename (internal/modules/cjs/loader.js:880:15) Apr 14 18:39:19 volumiogreen volumio[1164]: at Function.Module._load (internal/modules/cjs/loader.js:725:27) Apr 14 18:39:19 volumiogreen volumio[1164]: at Module.require (internal/modules/cjs/loader.js:952:19) Apr 14 18:39:19 volumiogreen volumio[1164]: at require (internal/modules/cjs/helpers.js:88:18) Apr 14 18:39:19 volumiogreen volumio[1164]: at Object. (/data/plugins/user_interface/now_playing/dist/index.js:46:34) Apr 14 18:39:19 volumiogreen volumio[1164]: at Module._compile (internal/modules/cjs/loader.js:1063:30) Apr 14 18:39:19 volumiogreen volumio[1164]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1092:10) Apr 14 18:39:19 volumiogreen volumio[1164]: at Module.load (internal/modules/cjs/loader.js:928:32) Apr 14 18:39:19 volumiogreen volumio[1164]: at Function.Module._load (internal/modules/cjs/loader.js:769:14) Apr 14 18:39:19 volumiogreen volumio[1164]: at Module.require (internal/modules/cjs/loader.js:952:19) Apr 14 18:39:19 volumiogreen volumio[1164]: at require (internal/modules/cjs/helpers.js:88:18) Apr 14 18:39:19 volumiogreen volumio[1164]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:29) Apr 14 18:39:19 volumiogreen volumio[1164]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Apr 14 18:39:19 volumiogreen volumio[1164]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 14 18:39:19 volumiogreen volumio[1164]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Apr 14 18:39:19 volumiogreen volumio[1164]: error: !!!! WARNING !!!! Apr 14 18:39:19 volumiogreen volumio[1164]: info: Done. Apr 14 18:39:20 volumiogreen go-librespot[1387]: time="2026-04-14T18:39:20+02:00" level=debug msg="fetched chunk 6/23, size: 524288" uri="spotify:track:5ohfpKB5tt275f4Y4lQ9F7" Apr 14 18:39:22 volumiogreen wpa_supplicant[937]: wlan0: Failed to initiate sched scan Apr 14 18:39:22 volumiogreen volumio[1164]: info: Received Get System Info Apr 14 18:39:22 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 18:39:22 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 18:39:22 volumiogreen volumio[1164]: info: Discovery: Getting this device information Apr 14 18:39:22 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioGetState Apr 14 18:39:22 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 18:39:22 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 14 18:39:22 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 14 18:39:27 volumiogreen wpa_supplicant[937]: wlan0: Failed to initiate sched scan Apr 14 18:39:28 volumiogreen volumio[1164]: info: Received Get System Info Apr 14 18:39:28 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 18:39:28 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 18:39:28 volumiogreen volumio[1164]: info: Discovery: Getting this device information Apr 14 18:39:28 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioGetState Apr 14 18:39:28 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 18:39:28 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 14 18:39:28 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 14 18:39:31 volumiogreen volumio[1164]: info: Enabling plugin soundcloud Apr 14 18:39:31 volumiogreen volumio[1164]: info: Loading plugin "soundcloud"... Apr 14 18:39:31 volumiogreen volumio[1164]: info: PLUGIN START: soundcloud Apr 14 18:39:31 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 14 18:39:31 volumiogreen volumio[1164]: info: [1776184771931] CoreMusicLibrary::Adding element SoundCloud Apr 14 18:39:31 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 14 18:39:31 volumiogreen volumio[1164]: Cannot find translation for source Spotify Apr 14 18:39:31 volumiogreen volumio[1164]: Cannot find translation for source YouTube Music Apr 14 18:39:31 volumiogreen volumio[1164]: Cannot find translation for source SoundCloud Apr 14 18:39:31 volumiogreen volumio[1164]: info: Error: TypeError: Cannot read property 'broadcastMessage' of null Apr 14 18:39:32 volumiogreen volumio[1164]: info: Enabling plugin soundcloud Apr 14 18:39:32 volumiogreen volumio[1164]: info: Loading plugin "soundcloud"... Apr 14 18:39:32 volumiogreen volumio[1164]: info: PLUGIN START: soundcloud Apr 14 18:39:32 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 14 18:39:32 volumiogreen volumio[1164]: info: [1776184772748] CoreMusicLibrary::Adding element SoundCloud Apr 14 18:39:32 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 14 18:39:32 volumiogreen volumio[1164]: Cannot find translation for source Spotify Apr 14 18:39:32 volumiogreen volumio[1164]: Cannot find translation for source YouTube Music Apr 14 18:39:32 volumiogreen volumio[1164]: Cannot find translation for source SoundCloud Apr 14 18:39:32 volumiogreen volumio[1164]: info: Error: TypeError: Cannot read property 'broadcastMessage' of null Apr 14 18:39:33 volumiogreen go-librespot[1387]: time="2026-04-14T18:39:33+02:00" level=debug msg="fetched chunk 7/23, size: 524288" uri="spotify:track:5ohfpKB5tt275f4Y4lQ9F7" Apr 14 18:39:33 volumiogreen wpa_supplicant[937]: wlan0: Failed to initiate sched scan Apr 14 18:39:34 volumiogreen volumio[1164]: info: Received Get System Info Apr 14 18:39:34 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 18:39:34 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 18:39:34 volumiogreen volumio[1164]: info: Discovery: Getting this device information Apr 14 18:39:34 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioGetState Apr 14 18:39:34 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 18:39:34 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 14 18:39:34 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 14 18:39:34 volumiogreen volumio[1164]: info: Enabling plugin mixcloud Apr 14 18:39:34 volumiogreen volumio[1164]: info: Loading plugin "mixcloud"... Apr 14 18:39:34 volumiogreen volumio[1164]: info: PLUGIN START: mixcloud Apr 14 18:39:34 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 14 18:39:34 volumiogreen volumio[1164]: info: [1776184774891] CoreMusicLibrary::Adding element Mixcloud Apr 14 18:39:34 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 14 18:39:34 volumiogreen volumio[1164]: Cannot find translation for source Spotify Apr 14 18:39:34 volumiogreen volumio[1164]: Cannot find translation for source YouTube Music Apr 14 18:39:34 volumiogreen volumio[1164]: Cannot find translation for source SoundCloud Apr 14 18:39:34 volumiogreen volumio[1164]: Cannot find translation for source Mixcloud Apr 14 18:39:34 volumiogreen volumio[1164]: info: Error: TypeError: Cannot read property 'broadcastMessage' of null Apr 14 18:39:35 volumiogreen volumio[1164]: info: Enabling plugin mixcloud Apr 14 18:39:35 volumiogreen volumio[1164]: info: Loading plugin "mixcloud"... Apr 14 18:39:35 volumiogreen volumio[1164]: info: PLUGIN START: mixcloud Apr 14 18:39:35 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 14 18:39:35 volumiogreen volumio[1164]: info: [1776184775784] CoreMusicLibrary::Adding element Mixcloud Apr 14 18:39:35 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 14 18:39:35 volumiogreen volumio[1164]: Cannot find translation for source Spotify Apr 14 18:39:35 volumiogreen volumio[1164]: Cannot find translation for source YouTube Music Apr 14 18:39:35 volumiogreen volumio[1164]: Cannot find translation for source SoundCloud Apr 14 18:39:35 volumiogreen volumio[1164]: Cannot find translation for source Mixcloud Apr 14 18:39:35 volumiogreen volumio[1164]: info: Error: TypeError: Cannot read property 'broadcastMessage' of null Apr 14 18:39:39 volumiogreen wpa_supplicant[937]: wlan0: Failed to initiate sched scan Apr 14 18:39:39 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioGetVisibleSources Apr 14 18:39:39 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 14 18:39:39 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioGetQueue Apr 14 18:39:39 volumiogreen volumio[1164]: info: CoreStateMachine::getQueue Apr 14 18:39:39 volumiogreen volumio[1164]: info: CorePlayQueue::getQueue Apr 14 18:39:39 volumiogreen volumio[1164]: info: Listing playlists Apr 14 18:39:39 volumiogreen volumio[1164]: info: Received Get System Info Apr 14 18:39:39 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 14 18:39:39 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 14 18:39:39 volumiogreen volumio[1164]: info: Discovery: Getting this device information Apr 14 18:39:39 volumiogreen volumio[1164]: info: CoreCommandRouter::volumioGetState Apr 14 18:39:39 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 14 18:39:39 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 14 18:39:39 volumiogreen volumio[1164]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 14 18:39:41 volumiogreen volumio[1164]: info: + geo-tz@8.1.6 Apr 14 18:39:41 volumiogreen volumio5-onboarding[1581]: time=2026-04-14T18:39:41.386+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 14 18:39:41 volumiogreen volumio[1164]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 14 18:39:41 volumiogreen volumio[1164]: TypeError: Cannot read property 'broadcastMessage' of null Apr 14 18:39:41 volumiogreen volumio[1164]: at /volumio/app/index.js:1534:32 Apr 14 18:39:41 volumiogreen volumio[1164]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Apr 14 18:39:41 volumiogreen volumio[1164]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Apr 14 18:39:41 volumiogreen volumio[1164]: at CoreCommandRouter.broadcastMessage (/volumio/app/index.js:1532:13) Apr 14 18:39:41 volumiogreen volumio[1164]: at PluginManager.pushMessage (/volumio/app/pluginmanager.js:1594:20) Apr 14 18:39:41 volumiogreen volumio[1164]: at Tail. (/volumio/app/pluginmanager.js:860:24) Apr 14 18:39:41 volumiogreen volumio[1164]: at Tail.emit (events.js:315:20) Apr 14 18:39:41 volumiogreen volumio[1164]: at ReadStream. (/volumio/node_modules/tail/lib/tail.js:51:33) Apr 14 18:39:41 volumiogreen volumio[1164]: at ReadStream.emit (events.js:315:20) Apr 14 18:39:41 volumiogreen volumio[1164]: at addChunk (internal/streams/readable.js:309:12) Apr 14 18:39:41 volumiogreen volumio[1164]: at readableAddChunk (internal/streams/readable.js:280:11) Apr 14 18:39:41 volumiogreen volumio[1164]: at ReadStream.Readable.push (internal/streams/readable.js:223:10) Apr 14 18:39:41 volumiogreen volumio[1164]: at internal/fs/streams.js:226:14 Apr 14 18:39:41 volumiogreen volumio[1164]: at FSReqCallback.wrapper [as oncomplete] (fs.js:539:5) Apr 14 18:39:41 volumiogreen volumio[1164]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 14 18:39:42 volumiogreen sudo[2491]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-14 18:38 Apr 14 18:39:42 volumiogreen sudo[2491]: 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"